[43.645632] Initializing watchdogs [43.645765] /dev/watchdog0 [43.659910] [001/143] (960s left) kms_dsc (dsc-basic) [43.730187] Subtest dsc-basic: SKIP (0.000s) [43.749862] [002/143] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [43.824207] Starting subtest: fbcpsr-rgb565-draw-blt [48.842529] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (5.022s) [48.979511] [003/143] (955s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [49.082226] Starting subtest: yf-tiled-addfb-size-offset-overflow [49.086051] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [49.168844] [004/143] (955s left) prime_mmap (test_refcounting) [49.234594] Starting subtest: test_refcounting [49.237165] Starting dynamic subtest: test_refcounting-smem [49.257624] Dynamic subtest test_refcounting-smem: SUCCESS (0.026s) [49.260191] Subtest test_refcounting: SUCCESS (0.026s) [49.330448] [005/143] (954s left) drm_fdinfo (idle) [49.396577] Starting subtest: idle [49.399328] Starting dynamic subtest: rcs0 [49.914206] Dynamic subtest rcs0: SUCCESS (0.517s) [49.927273] Starting dynamic subtest: bcs0 [50.418664] Dynamic subtest bcs0: SUCCESS (0.502s) [50.431448] Starting dynamic subtest: vcs0 [50.923987] Dynamic subtest vcs0: SUCCESS (0.503s) [50.936794] Starting dynamic subtest: vcs1 [51.425137] Dynamic subtest vcs1: SUCCESS (0.503s) [51.438865] Starting dynamic subtest: vecs0 [51.928449] Dynamic subtest vecs0: SUCCESS (0.503s) [51.941861] Starting dynamic subtest: ccs0 [52.431203] Dynamic subtest ccs0: SUCCESS (0.502s) [52.434407] Subtest idle: SUCCESS (3.033s) [52.498647] [006/143] (951s left) vc4/vc4_wait_bo (bad-pad) [52.600849] Subtest bad-pad: SKIP (0.000s) [52.646541] [007/143] (951s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [53.032324] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs-cc [53.035302] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [53.884681] [008/143] (950s left) kms_flip (flip-vs-panning) [53.951252] Starting subtest: flip-vs-panning [53.953622] Starting dynamic subtest: A-eDP1 [62.861139] Dynamic subtest A-eDP1: SUCCESS (8.912s) [62.874349] Starting dynamic subtest: B-eDP1 [71.693536] Dynamic subtest B-eDP1: SUCCESS (8.831s) [71.707694] Starting dynamic subtest: C-eDP1 [80.512522] Dynamic subtest C-eDP1: SUCCESS (8.819s) [80.525615] Starting dynamic subtest: D-eDP1 [89.347229] Dynamic subtest D-eDP1: SUCCESS (8.833s) [89.354943] Subtest flip-vs-panning: SUCCESS (35.408s) [90.629629] [009/143] (913s left) gem_exec_fence (syncobj-timeline-chain-engines) [91.208488] Starting subtest: syncobj-timeline-chain-engines [91.326222] Subtest syncobj-timeline-chain-engines: SUCCESS (0.117s) [92.575982] [010/143] (911s left) kms_ccs (pipe-b-ccs-on-another-bo-4-tiled-mtl-rc-ccs) [92.970960] Starting subtest: pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs [92.973771] Subtest pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.000s) [93.808068] [011/143] (910s left) syncobj_timeline (wait-for-submit-delayed-submit) [93.874343] Starting subtest: wait-for-submit-delayed-submit [93.976247] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [94.046903] [012/143] (910s left) kms_cursor_legacy (torture-bo) [94.140149] Starting subtest: torture-bo [94.142602] Starting dynamic subtest: pipe-A [100.909772] Dynamic subtest pipe-A: SUCCESS (6.764s) [100.924509] Starting dynamic subtest: pipe-B [107.778081] Dynamic subtest pipe-B: SUCCESS (6.872s) [107.792677] Starting dynamic subtest: pipe-C [114.321344] Dynamic subtest pipe-C: SUCCESS (6.541s) [114.333806] Starting dynamic subtest: pipe-D [120.525749] Dynamic subtest pipe-D: SUCCESS (6.202s) [120.540753] Starting dynamic subtest: all-pipes [127.195259] Dynamic subtest all-pipes: SUCCESS (6.671s) [127.198124] Subtest torture-bo: SUCCESS (33.052s) [127.355185] [013/143] (877s left) v3d/v3d_submit_csd (bad-flag) [127.434882] Subtest bad-flag: SKIP (0.000s) [127.485466] [014/143] (877s left) vc4/vc4_label_bo (set-label) [127.600838] Subtest set-label: SKIP (0.000s) [127.647975] [015/143] (876s left) gem_exec_schedule (out-order) [127.710915] Starting subtest: out-order [127.713658] Starting dynamic subtest: rcs0 [127.794201] Dynamic subtest rcs0: SUCCESS (0.099s) [127.803664] Starting dynamic subtest: vcs0 [127.878548] Dynamic subtest vcs0: SUCCESS (0.084s) [127.892272] Starting dynamic subtest: vcs1 [127.948918] Dynamic subtest vcs1: SUCCESS (0.070s) [127.962627] Starting dynamic subtest: vecs0 [128.020725] Dynamic subtest vecs0: SUCCESS (0.072s) [128.034786] Starting dynamic subtest: ccs0 [128.107659] Dynamic subtest ccs0: SUCCESS (0.086s) [128.110668] Subtest out-order: SUCCESS (0.412s) [129.496599] [016/143] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [129.578702] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [134.166492] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.587s) [134.286488] [017/143] (870s left) kms_chamelium_frames (hdmi-crc-fast) [134.676224] Subtest hdmi-crc-fast: SKIP (0.000s) [135.522275] [018/143] (869s left) sw_sync (timeline_closed) [135.588817] Starting subtest: timeline_closed [135.591156] Subtest timeline_closed: SUCCESS (0.000s) [135.643089] [019/143] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [135.728026] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [135.732269] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [135.813713] [020/143] (868s left) kms_getfb (getfb2-accept-ccs) [135.868453] Starting subtest: getfb2-accept-ccs [135.870625] Subtest getfb2-accept-ccs: SUCCESS (0.000s) [135.936654] [021/143] (868s left) kms_vblank (query-forked-busy) [136.022547] Starting subtest: query-forked-busy [136.024586] Starting dynamic subtest: pipe-A-eDP-1 [137.912070] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s) [137.928319] Starting dynamic subtest: pipe-D-eDP-1 [140.581851] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s) [140.584516] Subtest query-forked-busy: SUCCESS (4.560s) [141.505207] [022/143] (863s left) kms_big_fb (x-tiled-64bpp-rotate-270) [141.568168] Starting subtest: x-tiled-64bpp-rotate-270 [141.585829] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [141.682893] [023/143] (863s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [141.775099] Starting subtest: psr-rgb101010-draw-mmap-wc [146.630995] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.861s) [146.725893] [024/143] (858s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [147.127578] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [148.212323] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.085s) [149.441715] [025/143] (855s left) gem_fence_thrash (bo-write-verify-none) [149.490350] Starting subtest: bo-write-verify-none [149.496992] Subtest bo-write-verify-none: SKIP (0.001s) [149.520045] [026/143] (855s left) gem_exec_reloc (basic-cpu-gtt-active) [149.582914] Subtest basic-cpu-gtt-active: SKIP (0.000s) [149.643377] [027/143] (855s left) prime_busy (hang) [149.699802] Starting subtest: hang [149.702083] Starting dynamic subtest: rcs0 [162.968066] Dynamic subtest rcs0: SUCCESS (13.266s) [162.981969] Starting dynamic subtest: bcs0 [170.124055] Dynamic subtest bcs0: SUCCESS (7.156s) [170.135438] Starting dynamic subtest: vcs0 [177.128549] Dynamic subtest vcs0: SUCCESS (7.005s) [177.134406] Starting dynamic subtest: vcs1 [184.160844] Dynamic subtest vcs1: SUCCESS (7.034s) [184.166478] Starting dynamic subtest: vecs0 [191.130255] Dynamic subtest vecs0: SUCCESS (6.969s) [191.145058] Starting dynamic subtest: ccs0 [204.972517] Dynamic subtest ccs0: SUCCESS (13.841s) [204.974964] Subtest hang: SUCCESS (55.272s) [205.066048] [028/143] (799s left) prime_vgem (fence-write-hang) [205.127278] Subtest fence-write-hang: SKIP (0.000s) [205.212278] [029/143] (799s left) kms_getfb (getfb-addfb-different-handles) [205.275793] Starting subtest: getfb-addfb-different-handles [205.278606] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [205.369904] [030/143] (799s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [205.470158] Starting subtest: cursorA-vs-flipA-legacy [216.636872] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.164s) [217.541454] [031/143] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [217.614057] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [217.618139] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [217.682105] [032/143] (787s left) kms_prime (basic-crc-hybrid) [218.192401] Subtest basic-crc-hybrid: SKIP (0.000s) [218.255457] [033/143] (786s left) api_intel_bb (intel-bb-blit-none) [218.312019] Starting subtest: intel-bb-blit-none [222.282996] Subtest intel-bb-blit-none: SUCCESS (3.975s) [222.394066] [034/143] (782s left) gem_ctx_persistence (engines-hostile) [222.457567] Starting subtest: engines-hostile [222.460124] Starting dynamic subtest: rcs0 [222.561190] Dynamic subtest rcs0: SUCCESS (0.105s) [222.575927] Starting dynamic subtest: bcs0 [222.649386] Dynamic subtest bcs0: SUCCESS (0.088s) [222.664191] Starting dynamic subtest: vcs0 [222.735177] Dynamic subtest vcs0: SUCCESS (0.084s) [222.749699] Starting dynamic subtest: vcs1 [222.807479] Dynamic subtest vcs1: SUCCESS (0.072s) [222.822635] Starting dynamic subtest: vecs0 [222.920086] Dynamic subtest vecs0: SUCCESS (0.111s) [222.935133] Starting dynamic subtest: ccs0 [223.009051] Dynamic subtest ccs0: SUCCESS (0.088s) [223.011677] Subtest engines-hostile: SUCCESS (0.554s) [223.085487] [035/143] (781s left) gem_mmap (bad-offset) [223.147263] Subtest bad-offset: SKIP (0.000s) [223.174338] [036/143] (781s left) kms_force_connector_basic (force-edid) [223.247443] Starting subtest: force-edid [223.579175] Subtest force-edid: SUCCESS (0.332s) [223.678154] [037/143] (781s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [223.730676] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [224.466222] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.737s) [224.702777] [038/143] (780s left) kms_ccs (pipe-d-bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [225.171885] Starting subtest: pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs-cc [225.174768] Subtest pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [226.048162] [039/143] (779s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [226.122904] Starting subtest: fbc-psr2-cursor-mmap-gtt [226.125716] Starting dynamic subtest: eDP-1 [226.131153] Dynamic subtest eDP-1: SKIP (0.000s) [226.136526] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s) [226.248695] [040/143] (778s left) perf (i915-ref-count) [226.343963] Starting subtest: i915-ref-count [226.433423] Subtest i915-ref-count: SUCCESS (0.088s) [226.472912] [041/143] (778s left) gen7_exec_parse (basic-rejected) [226.534333] Subtest basic-rejected: SKIP (0.000s) [226.560223] [042/143] (778s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [226.651658] Starting subtest: plane-scaler-unity-scaling-with-modifiers [226.654143] Starting dynamic subtest: pipe-A-eDP-1 [227.414836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.763s) [227.433944] Starting dynamic subtest: pipe-B-eDP-1 [229.329151] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.910s) [229.344470] Starting dynamic subtest: pipe-C-eDP-1 [231.238779] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.908s) [231.256870] Starting dynamic subtest: pipe-D-eDP-1 [233.135473] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.894s) [233.137915] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (6.487s) [234.370203] [043/143] (770s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [234.466556] Starting subtest: fbc-1p-primscrn-cur-indfb-move [237.470345] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.010s) [237.614413] [044/143] (767s left) gem_mmap_offset (blt-coherency) [237.658253] Starting subtest: blt-coherency [237.660800] Subtest blt-coherency: SUCCESS (0.009s) [237.763537] [045/143] (767s left) gem_mmap (big-bo) [237.823473] Subtest big-bo: SKIP (0.000s) [237.844887] [046/143] (767s left) kms_big_fb (y-tiled-8bpp-rotate-0) [237.905910] Starting subtest: y-tiled-8bpp-rotate-0 [237.910908] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [237.974022] [047/143] (767s left) syncobj_basic (bad-destroy-pad) [238.037054] Starting subtest: bad-destroy-pad [238.038940] Subtest bad-destroy-pad: SUCCESS (0.000s) [238.098298] [048/143] (767s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [238.154599] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [238.260041] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [238.330775] [049/143] (767s left) api_intel_bb (delta-check) [238.391858] Starting subtest: delta-check [238.400053] Subtest delta-check: SUCCESS (0.011s) [238.500174] [050/143] (766s left) kms_addfb_basic (unused-handle) [238.541624] Starting subtest: unused-handle [238.544163] Subtest unused-handle: SUCCESS (0.000s) [238.624066] [051/143] (766s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [238.706615] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [238.711178] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [238.798890] [052/143] (766s left) gem_exec_suspend (basic) [238.863635] Starting subtest: basic [238.865890] Starting dynamic subtest: smem [240.455903] Dynamic subtest smem: SUCCESS (1.594s) [240.459066] Subtest basic: SUCCESS (1.595s) [240.632018] [053/143] (764s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-dg2-rc-ccs) [241.030300] Starting subtest: pipe-B-random-ccs-data-4-tiled-dg2-rc-ccs [241.038696] Subtest pipe-B-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s) [241.921828] [054/143] (763s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-mc-ccs) [242.296253] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-mc-ccs [242.304296] Subtest pipe-A-random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s) [243.202123] [055/143] (762s left) kms_big_fb (4-tiled-64bpp-rotate-270) [243.300029] Starting subtest: 4-tiled-64bpp-rotate-270 [243.323407] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.025s) [243.435251] [056/143] (762s left) kms_psr2_su (page_flip-nv12) [243.494348] Subtest page_flip-NV12: SKIP (0.000s) [243.529591] [057/143] (762s left) v3d/v3d_submit_cl (bad-multisync-extension) [243.583426] Subtest bad-multisync-extension: SKIP (0.000s) [243.629810] [058/143] (762s left) kms_pm_backlight (fade-with-suspend) [243.721871] Starting subtest: fade-with-suspend [260.985925] Starting dynamic subtest: eDP-1 [263.653055] Dynamic subtest eDP-1: SUCCESS (2.666s) [263.655917] Subtest fade-with-suspend: SUCCESS (3.939s) [264.576471] [059/143] (757s left) gem_tiling_max_stride [264.669335] [060/143] (757s left) v3d/v3d_mmap (mmap-bo) [264.767789] Subtest mmap-bo: SKIP (0.000s) [264.817928] [061/143] (756s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [265.227877] Starting subtest: pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc [266.057164] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.827s) [267.247375] [062/143] (754s left) gem_exec_fence (syncobj-invalid-flags) [267.704034] Starting subtest: syncobj-invalid-flags [267.706689] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [269.510786] [063/143] (752s left) kms_pipe_crc_basic (read-crc) [269.600506] Starting subtest: read-crc [269.603213] Starting dynamic subtest: pipe-A-eDP-1 [270.356447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.759s) [270.371273] Starting dynamic subtest: pipe-B-eDP-1 [271.845987] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s) [271.868957] Starting dynamic subtest: pipe-C-eDP-1 [273.309712] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.460s) [273.325128] Starting dynamic subtest: pipe-D-eDP-1 [274.738968] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.422s) [274.741563] Subtest read-crc: SUCCESS (5.139s) [275.637693] [064/143] (746s left) gem_pxp (regular-baseline-src-copy-readible) [278.230648] Subtest regular-baseline-src-copy-readible: SKIP (0.000s) [278.298822] [065/143] (743s left) kms_psr2_sf (plane-move-sf-dmg-area) [283.587915] Starting subtest: plane-move-sf-dmg-area [283.590394] Starting dynamic subtest: pipe-A-eDP-1 [289.038272] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.447s) [289.059126] Starting dynamic subtest: pipe-B-eDP-1 [294.487455] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.445s) [294.490089] Subtest plane-move-sf-dmg-area: SUCCESS (10.900s) [295.423569] [066/143] (726s left) kms_addfb_basic (size-max) [295.507001] Starting subtest: size-max [295.509220] Subtest size-max: SUCCESS (0.000s) [295.588549] [067/143] (726s left) gem_exec_flush (basic-wb-prw-default) [295.649152] Starting subtest: basic-wb-prw-default [301.103108] Subtest basic-wb-prw-default: SUCCESS (5.458s) [301.292745] [068/143] (720s left) gem_basic (multigpu-create-close) [301.352926] Starting subtest: multigpu-create-close [301.357816] Subtest multigpu-create-close: SKIP (0.000s) [301.423550] [069/143] (720s left) gem_userptr_blits (stress-purge) [301.503933] Starting subtest: stress-purge [306.870228] Subtest stress-purge: SUCCESS (5.370s) [306.997374] [070/143] (715s left) gem_exec_reloc (basic-write-gtt) [307.093825] Subtest basic-write-gtt: SKIP (0.000s) [307.139016] [071/143] (714s left) kms_psr (psr2-primary-mmap-cpu) [307.224955] Starting subtest: psr2-primary-mmap-cpu [307.226931] Starting dynamic subtest: eDP-1 [309.042726] Dynamic subtest eDP-1: SUCCESS (1.811s) [309.045856] Subtest psr2-primary-mmap-cpu: SUCCESS (1.812s) [309.940890] [072/143] (712s left) kms_psr (psr2-sprite-render) [310.019424] Starting subtest: psr2-sprite-render [310.021923] Starting dynamic subtest: eDP-1 [311.866835] Dynamic subtest eDP-1: SUCCESS (1.846s) [311.869809] Subtest psr2-sprite-render: SUCCESS (1.849s) [312.770966] [073/143] (709s left) kms_cursor_crc (cursor-rapid-movement-512x512) [313.015916] Starting subtest: cursor-rapid-movement-512x512 [313.020765] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [313.138636] [074/143] (709s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [313.230240] Starting subtest: flip-vs-cursor-atomic-transitions [319.480738] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (6.249s) [320.377023] [075/143] (701s left) gem_ctx_persistence (hostile) [320.451193] Starting subtest: hostile [329.285797] Subtest hostile: SUCCESS (8.833s) [329.392290] [076/143] (692s left) kms_addfb_basic (invalid-get-prop-any) [329.450478] Starting subtest: invalid-get-prop-any [329.452975] Subtest invalid-get-prop-any: SUCCESS (0.000s) [329.574954] [077/143] (692s left) kms_force_connector_basic (force-load-detect) [329.635947] Starting subtest: force-load-detect [329.641480] Subtest force-load-detect: SKIP (0.000s) [329.755194] [078/143] (692s left) kms_flip (flip-vs-modeset-vs-hang) [329.859288] Starting subtest: flip-vs-modeset-vs-hang [329.861939] Starting dynamic subtest: A-eDP1 [368.054421] Dynamic subtest A-eDP1: SUCCESS (38.193s) [368.064835] Starting dynamic subtest: D-eDP1 [418.101085] Dynamic subtest D-eDP1: SUCCESS (50.045s) [418.103838] Subtest flip-vs-modeset-vs-hang: SUCCESS (88.247s) [418.484467] [079/143] (603s left) syncobj_timeline (multi-wait-all-signaled) [418.548566] Starting subtest: multi-wait-all-signaled [418.551287] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [418.617073] [080/143] (603s left) syncobj_timeline (etime-multi-wait-submitted) [418.676088] Starting subtest: etime-multi-wait-submitted [418.781771] Subtest etime-multi-wait-submitted: SUCCESS (0.104s) [418.860975] [081/143] (603s left) kms_cursor_crc (cursor-onscreen-32x10) [419.010818] Starting subtest: cursor-onscreen-32x10 [419.064600] Subtest cursor-onscreen-32x10: SKIP (0.048s) [419.282216] [082/143] (603s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [419.333941] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [419.336430] Starting dynamic subtest: pipe-A-default-mode [422.253223] Dynamic subtest pipe-A-default-mode: SUCCESS (2.918s) [422.256106] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.919s) [423.169567] [083/143] (599s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [423.632693] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [423.638554] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.001s) [424.513471] [084/143] (597s left) kms_ccs (pipe-d-bad-rotation-90-y-tiled-ccs) [424.964761] Starting subtest: pipe-D-bad-rotation-90-y-tiled-ccs [424.970801] Subtest pipe-D-bad-rotation-90-y-tiled-ccs: SKIP (0.000s) [425.798151] [085/143] (596s left) kms_big_fb (linear-64bpp-rotate-180) [425.898479] Starting subtest: linear-64bpp-rotate-180 [427.585640] Subtest linear-64bpp-rotate-180: SUCCESS (1.689s) [427.776295] [086/143] (594s left) perf (global-sseu-config) [427.893243] Subtest global-sseu-config: SKIP (0.000s) [427.925735] [087/143] (594s left) kms_chamelium_audio (hdmi-audio) [428.294930] Subtest hdmi-audio: SKIP (0.000s) [429.149143] [088/143] (593s left) kms_frontbuffer_tracking (psr-2p-rte) [429.237082] Starting subtest: psr-2p-rte [429.241191] Subtest psr-2p-rte: SKIP (0.000s) [429.333368] [089/143] (593s left) kms_psr (psr-suspend) [429.401931] Starting subtest: psr-suspend [429.404198] Starting dynamic subtest: eDP-1 [447.461420] Dynamic subtest eDP-1: SUCCESS (3.049s) [447.464041] Subtest psr-suspend: SUCCESS (3.050s) [448.344644] [090/143] (589s left) i915_pipe_stress (stress-xrgb8888-ytiled) [448.444578] Starting subtest: stress-xrgb8888-ytiled [448.449271] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [448.467105] [091/143] (589s left) kms_addfb_basic (bo-too-small) [448.538779] Starting subtest: bo-too-small [448.541169] Subtest bo-too-small: SUCCESS (0.000s) [448.625466] [092/143] (589s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [448.674278] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [448.679048] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [448.755368] [093/143] (588s left) kms_big_fb (y-tiled-32bpp-rotate-0) [448.827482] Starting subtest: y-tiled-32bpp-rotate-0 [448.832297] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [448.887665] [094/143] (588s left) kms_flip (2x-flip-vs-panning-interruptible) [448.955759] Starting subtest: 2x-flip-vs-panning-interruptible [448.970245] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.013s) [449.046134] [095/143] (588s left) sw_sync (sync_busy_fork_unixsocket) [449.096298] Starting subtest: sync_busy_fork_unixsocket [449.110006] Subtest sync_busy_fork_unixsocket: SUCCESS (0.015s) [449.168490] [096/143] (588s left) gem_softpin (noreloc) [449.223487] Starting subtest: noreloc [454.622188] Subtest noreloc: SUCCESS (5.402s) [454.728066] [097/143] (583s left) kms_rotation_crc (sprite-rotation-270) [454.823587] Starting subtest: sprite-rotation-270 [454.828446] Subtest sprite-rotation-270: SKIP (0.002s) [454.899800] [098/143] (582s left) gem_cs_tlb (engines) [454.960682] Starting subtest: engines [454.963301] Starting dynamic subtest: rcs0 [457.117085] Dynamic subtest rcs0: SUCCESS (2.153s) [457.127662] Starting dynamic subtest: bcs0 [459.269420] Dynamic subtest bcs0: SUCCESS (2.152s) [459.288044] Starting dynamic subtest: vcs0 [461.424043] Dynamic subtest vcs0: SUCCESS (2.152s) [461.432482] Starting dynamic subtest: vcs1 [463.577295] Dynamic subtest vcs1: SUCCESS (2.154s) [463.595348] Starting dynamic subtest: vecs0 [465.729612] Dynamic subtest vecs0: SUCCESS (2.152s) [465.741445] Starting dynamic subtest: ccs0 [467.883912] Dynamic subtest ccs0: SUCCESS (2.153s) [467.886189] Subtest engines: SUCCESS (12.920s) [467.983843] [099/143] (569s left) kms_plane (plane-position-hole) [468.106198] Starting subtest: plane-position-hole [468.109046] Starting dynamic subtest: pipe-A [474.296369] Dynamic subtest pipe-A: SUCCESS (6.192s) [474.309636] Starting dynamic subtest: pipe-B [481.269995] Dynamic subtest pipe-B: SUCCESS (6.972s) [481.272608] Subtest plane-position-hole: SUCCESS (13.167s) [482.126819] [100/143] (555s left) gem_softpin (evict-active) [482.172046] Starting subtest: evict-active [482.177073] Subtest evict-active: SUCCESS (0.007s) [482.285121] [101/143] (555s left) gem_exec_balancer (parallel-keep-in-fence) [482.536716] Starting subtest: parallel-keep-in-fence [483.401098] Subtest parallel-keep-in-fence: SUCCESS (0.864s) [483.468257] [102/143] (554s left) gem_ctx_sseu (mmap-args) [483.530419] Subtest mmap-args: SKIP (0.000s) [483.573332] [103/143] (554s left) kms_ccs (pipe-a-ccs-on-another-bo-4-tiled-mtl-rc-ccs) [483.959121] Starting subtest: pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs [483.961899] Subtest pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.000s) [484.831102] [104/143] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [484.940975] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [484.945319] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [485.031083] [105/143] (553s left) kms_vrr (seamless-rr-switch-drrs) [485.097146] Starting subtest: seamless-rr-switch-drrs [485.103115] Subtest seamless-rr-switch-drrs: SKIP (0.000s) [485.152349] [106/143] (552s left) gem_exec_balancer (waits) [485.201653] Starting subtest: waits [491.322056] Subtest waits: SUCCESS (6.120s) [491.565351] [107/143] (546s left) kms_async_flips (test-cursor) [491.663297] Starting subtest: test-cursor [491.667623] Subtest test-cursor: SKIP (0.000s) [492.961667] [108/143] (545s left) template (b) [493.024755] Starting subtest: B [493.027026] Subtest B: SUCCESS (0.000s) [493.078990] [109/143] (545s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [493.122876] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [493.150653] [110/143] (545s left) kms_psr (pr-cursor-render) [493.216271] Starting subtest: pr-cursor-render [493.221175] Subtest pr-cursor-render: SKIP (0.000s) [493.314349] [111/143] (544s left) kms_color (ctm-0-75) [493.412444] Starting subtest: ctm-0-75 [493.414394] Starting dynamic subtest: pipe-A [498.613962] Dynamic subtest pipe-A: SUCCESS (5.201s) [498.634570] Starting dynamic subtest: pipe-B [504.703343] Dynamic subtest pipe-B: SUCCESS (6.088s) [504.717084] Starting dynamic subtest: pipe-C [510.461922] Dynamic subtest pipe-C: SUCCESS (5.757s) [510.479723] Starting dynamic subtest: pipe-D [516.222087] Dynamic subtest pipe-D: SUCCESS (5.759s) [516.225101] Subtest ctm-0-75: SUCCESS (22.810s) [517.152357] [112/143] (521s left) kms_setmode (invalid-clone-single-crtc) [517.208837] Starting subtest: invalid-clone-single-crtc [517.215427] Subtest invalid-clone-single-crtc: SKIP (0.000s) [517.261668] [113/143] (521s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-mc-ccs) [517.636263] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs [517.641626] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s) [518.559165] [114/143] (519s left) kms_invalid_mode (int-max-clock) [518.633375] Starting subtest: int-max-clock [518.635886] Starting dynamic subtest: pipe-A-eDP-1 [518.927071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [518.947323] Starting dynamic subtest: pipe-B-eDP-1 [518.949984] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [518.964555] Starting dynamic subtest: pipe-C-eDP-1 [518.967413] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [518.978413] Starting dynamic subtest: pipe-D-eDP-1 [518.981272] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [518.984110] Subtest int-max-clock: SUCCESS (0.308s) [519.844852] [115/143] (518s left) kms_pm_rpm (fences-dpms) [521.600835] Starting subtest: fences-dpms [521.606380] Subtest fences-dpms: SKIP (0.000s) [522.189870] [116/143] (516s left) syncobj_wait (wait-all-for-submit-complex) [522.243182] Starting subtest: wait-all-for-submit-complex [522.459653] Subtest wait-all-for-submit-complex: SUCCESS (0.216s) [522.530311] [117/143] (515s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [522.616729] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [522.619401] Starting dynamic subtest: pipe-A-default-mode [522.915634] Dynamic subtest pipe-A-default-mode: SKIP (0.290s) [522.921411] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.294s) [523.811455] [118/143] (514s left) gem_mmap_gtt (big-bo) [523.875350] Subtest big-bo: SKIP (0.000s) [523.902969] [119/143] (514s left) drm_fdinfo (virtual-busy) [523.955628] Starting subtest: virtual-busy [523.960476] Subtest virtual-busy: SKIP (0.000s) [524.004859] [120/143] (514s left) kms_color (legacy-gamma) [524.069757] Starting subtest: legacy-gamma [524.072207] Starting dynamic subtest: pipe-A [524.829751] Dynamic subtest pipe-A: SUCCESS (0.759s) [524.848566] Starting dynamic subtest: pipe-B [526.384042] Dynamic subtest pipe-B: SUCCESS (1.550s) [526.396933] Starting dynamic subtest: pipe-C [527.836664] Dynamic subtest pipe-C: SUCCESS (1.455s) [527.854684] Starting dynamic subtest: pipe-D [529.298015] Dynamic subtest pipe-D: SUCCESS (1.459s) [529.300677] Subtest legacy-gamma: SUCCESS (5.228s) [530.211276] [121/143] (508s left) gem_render_copy (y-tiled) [530.283083] Starting subtest: y-tiled [530.287840] Subtest y-tiled: SKIP (0.000s) [530.465463] [122/143] (508s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [530.529820] Starting subtest: multi-wait-for-submit-submitted-signaled [530.532623] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [530.591584] [123/143] (508s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [530.645255] Starting subtest: y-tiled-to-vebox-x-tiled [530.650115] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [530.830960] [124/143] (507s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [531.231293] Starting subtest: pipe-D-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [531.236169] Subtest pipe-D-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s) [532.054022] [125/143] (506s left) gem_mmap_wc (bad-size) [532.109560] Subtest bad-size: SKIP (0.000s) [532.129074] [126/143] (506s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [532.180386] Starting subtest: extended-modeset-hang-oldfb-with-reset [532.182849] Starting dynamic subtest: pipe-A [535.393520] Dynamic subtest pipe-A: SUCCESS (3.213s) [535.411809] Starting dynamic subtest: pipe-D [539.124516] Dynamic subtest pipe-D: SUCCESS (3.721s) [539.127150] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (6.945s) [539.998088] [127/143] (498s left) kms_cdclk (mode-transition-all-outputs) [540.053274] Starting subtest: mode-transition-all-outputs [540.342995] Subtest mode-transition-all-outputs: SKIP (0.290s) [541.282124] [128/143] (497s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [541.353433] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [541.357448] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [541.452026] [129/143] (497s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [541.540998] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [541.543420] Starting dynamic subtest: pipe-A-default-mode [542.759561] Dynamic subtest pipe-A-default-mode: SKIP (1.213s) [542.764569] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.217s) [542.900169] [130/143] (495s left) syncobj_timeline (invalid-query-zero-handles) [542.957545] Starting subtest: invalid-query-zero-handles [542.960017] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [543.023271] [131/143] (495s left) i915_selftest (mock) [544.604355] Starting subtest: mock [544.607219] Starting dynamic subtest: sanitycheck [544.913298] Dynamic subtest sanitycheck: SUCCESS (0.309s) [544.925901] Starting dynamic subtest: shmem [545.105909] Dynamic subtest shmem: SUCCESS (0.190s) [545.115516] Starting dynamic subtest: fence [552.540040] Dynamic subtest fence: SUCCESS (7.432s) [552.554862] Starting dynamic subtest: scatterlist [553.770194] Dynamic subtest scatterlist: SUCCESS (1.229s) [553.784974] Starting dynamic subtest: syncmap [556.469265] Dynamic subtest syncmap: SUCCESS (2.697s) [556.482681] Starting dynamic subtest: uncore [556.663389] Dynamic subtest uncore: SUCCESS (0.195s) [556.676127] Starting dynamic subtest: ring [556.853700] Dynamic subtest ring: SUCCESS (0.189s) [556.866818] Starting dynamic subtest: engine [557.047967] Dynamic subtest engine: SUCCESS (0.193s) [557.060641] Starting dynamic subtest: timelines [560.359802] Dynamic subtest timelines: SUCCESS (3.308s) [560.372975] Starting dynamic subtest: requests [563.611504] Dynamic subtest requests: SUCCESS (3.251s) [563.624362] Starting dynamic subtest: objects [563.912180] Dynamic subtest objects: SUCCESS (0.299s) [563.925002] Starting dynamic subtest: phys [564.241326] Dynamic subtest phys: SUCCESS (0.327s) [564.254011] Starting dynamic subtest: dmabuf [564.530269] Dynamic subtest dmabuf: SUCCESS (0.288s) [564.543074] Starting dynamic subtest: vma [570.022044] Dynamic subtest vma: SUCCESS (5.489s) [570.035916] Starting dynamic subtest: evict [572.267122] Dynamic subtest evict: FAIL (2.206s) [572.271088] Subtest mock: FAIL (27.642s) [572.292020] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1685 [max: 8192] direct dependencies: 17298 [max: 32768] indirect dependencies: 104638 all direct dependencies: 326970 dependency chains: 24415 [max: 131072] dependency chain hlocks used: 101412 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 201 in-softirq chains: 572 in-process chains: 23642 stack-trace entries: 208747 [max: 1048576] number of stack traces: 10388 number of stack hash chains: 7740 combined max dependencies: 2736582678 hardirq-safe locks: 95 hardirq-unsafe locks: 1012 softirq-safe locks: 194 softirq-unsafe locks: 922 irq-safe locks: 211 irq-unsafe locks: 1012 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 299 softirq-read-safe locks: 7 softirq-read-unsafe locks: 294 irq-read-safe locks: 7 irq-read-unsafe locks: 299 uncategorized locks: 278 unused locks: 1 max locking depth: 17 max bfs queue depth: 443 max lock class index: 1875 chain lookup misses: 33013 chain lookup hits: 700876663 cyclic checks: 33098 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5394 find-mask backwards checks: 3139 hardirq on events: 540266112 hardirq off events: 540266090 redundant hardirq ons: 56 redundant hardirq offs: 31 softirq on events: 726950 softirq off events: 726950 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 485 zapped lock chains: 8115 large chain blocks: 1 [572.295297] Closing watchdogs Done.