[24.547696] Initializing watchdogs
[24.547763]   /dev/watchdog0
[24.552302] [001/142] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[24.658869] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[24.660275] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[24.714207] [002/142] (960s left) gem_exec_params (invalid-bsd2-flag-on-render)
[24.764574] Starting subtest: invalid-bsd2-flag-on-render
[24.765433] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[24.826904] [003/142] (960s left) gem_basic (bad-close)
[24.886213] Starting subtest: bad-close
[24.887842] Subtest bad-close: SUCCESS (0.000s)
[24.920625] [004/142] (960s left) kms_atomic_interruptible (legacy-pageflip)
[25.017642] Starting subtest: legacy-pageflip
[25.019069] Starting dynamic subtest: HDMI-A-1-pipe-A
[31.246962] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (6.227s)
[31.247674] Subtest legacy-pageflip: SUCCESS (6.229s)
[31.351530] [005/142] (953s left) gem_exec_schedule (semaphore-user)
[31.408808] Starting subtest: semaphore-user
[31.416186] Subtest semaphore-user: SUCCESS (0.007s)
[31.661854] [006/142] (953s left) gem_lmem_swapping (heavy-multi)
[31.717808] Subtest heavy-multi: SKIP (0.000s)
[31.735740] [007/142] (953s left) drm_fdinfo (virtual-busy-idle)
[31.782441] Starting subtest: virtual-busy-idle
[34.934851] Subtest virtual-busy-idle: SUCCESS (3.152s)
[34.977368] [008/142] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[35.080523] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[35.082150] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[35.128231] [009/142] (950s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_mc_ccs)
[35.463649] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_mc_ccs
[35.465556] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[35.586423] [010/142] (949s left) vgem_basic (bad-flag)
[35.666524] Starting subtest: bad-flag
[35.667310] Subtest bad-flag: SUCCESS (0.000s)
[35.694120] [011/142] (949s left) gem_exec_fair (basic-sync)
[35.750299] Starting subtest: basic-sync
[35.751078] Starting dynamic subtest: rcs0
[42.623648] Dynamic subtest rcs0: SUCCESS (6.866s)
[42.624450] Subtest basic-sync: SUCCESS (6.866s)
[42.773059] [012/142] (942s left) gem_vm_create (create-ext)
[42.835573] Starting subtest: create-ext
[42.837226] Subtest create-ext: SUCCESS (0.002s)
[42.919628] [013/142] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[43.038817] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[43.040209] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[43.108500] [014/142] (942s left) api_intel_allocator (fork-simple-once)
[43.155028] Starting subtest: fork-simple-once
[43.167498] Subtest fork-simple-once: SUCCESS (0.013s)
[43.209367] [015/142] (942s left) kms_vblank (pipe-a-wait-busy-hang)
[43.315352] Starting subtest: pipe-A-wait-busy-hang
[56.811237] Subtest pipe-A-wait-busy-hang: SUCCESS (13.495s)
[56.913864] [016/142] (928s left) kms_chamelium_color (ctm-blue-to-red)
[57.011502] Subtest ctm-blue-to-red: SKIP (0.000s)
[57.031466] [017/142] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[57.132888] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[57.134297] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[57.180172] [018/142] (928s left) kms_vblank (pipe-a-query-idle)
[57.278547] Starting subtest: pipe-A-query-idle
[58.425284] Subtest pipe-A-query-idle: SUCCESS (1.147s)
[58.519763] [019/142] (926s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[58.717437] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[58.718997] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[58.963047] [020/142] (926s left) kms_invalid_mode (zero-vdisplay)
[59.060922] Starting subtest: zero-vdisplay
[59.061740] Starting dynamic subtest: HDMI-A-1-pipe-A
[59.115815] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.054s)
[59.119480] Starting dynamic subtest: HDMI-A-1-pipe-B
[59.120211] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.001s)
[59.123756] Starting dynamic subtest: HDMI-A-1-pipe-C
[59.124446] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.001s)
[59.127796] Starting dynamic subtest: HDMI-A-1-pipe-D
[59.128487] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (0.001s)
[59.129179] Subtest zero-vdisplay: SUCCESS (0.059s)
[59.209475] [021/142] (926s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[59.310719] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[59.312100] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[59.359487] [022/142] (925s left) gem_exec_gttfill (engines)
[59.413912] Starting subtest: engines
[59.414696] Starting dynamic subtest: rcs0
[82.287271] Dynamic subtest rcs0: SUCCESS (22.873s)
[82.292497] Starting dynamic subtest: bcs0
[105.071223] Dynamic subtest bcs0: SUCCESS (22.784s)
[105.076374] Starting dynamic subtest: vcs0
[127.613235] Dynamic subtest vcs0: SUCCESS (22.542s)
[127.618884] Starting dynamic subtest: vcs1
[150.294259] Dynamic subtest vcs1: SUCCESS (22.681s)
[150.299376] Starting dynamic subtest: vecs0
[172.860328] Dynamic subtest vecs0: SUCCESS (22.566s)
[172.861126] Subtest engines: SUCCESS (113.446s)
[173.011283] [023/142] (812s left) api_intel_bb (simple-bb)
[173.104047] Starting subtest: simple-bb
[173.105747] Subtest simple-bb: SUCCESS (0.002s)
[173.174567] [024/142] (812s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[173.450706] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[173.452183] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[173.627357] [025/142] (811s left) gem_ctx_persistence (legacy-engines-hostile)
[173.676727] Starting subtest: legacy-engines-hostile
[173.677478] Starting dynamic subtest: render
[173.716057] Dynamic subtest render: SUCCESS (0.039s)
[173.720487] Starting dynamic subtest: bsd1
[173.799075] Dynamic subtest bsd1: SUCCESS (0.083s)
[173.803179] Starting dynamic subtest: bsd2
[173.876209] Dynamic subtest bsd2: SUCCESS (0.077s)
[173.880251] Starting dynamic subtest: blt
[173.957741] Dynamic subtest blt: SUCCESS (0.081s)
[173.964378] Starting dynamic subtest: vebox
[174.041876] Dynamic subtest vebox: SUCCESS (0.083s)
[174.043307] Subtest legacy-engines-hostile: SUCCESS (0.365s)
[174.085470] [026/142] (811s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[174.142818] Starting subtest: etime-single-wait-all-for-submit-submitted
[174.247991] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[174.294297] [027/142] (811s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[174.411979] Starting subtest: 4-tiled-32bpp-rotate-180
[174.413518] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[174.469296] [028/142] (810s left) kms_color (ctm-0-50)
[174.565058] Starting subtest: ctm-0-50
[174.565887] Starting dynamic subtest: pipe-A
[175.323901] Dynamic subtest pipe-A: SUCCESS (0.761s)
[175.328019] Starting dynamic subtest: pipe-B
[176.108011] Dynamic subtest pipe-B: SUCCESS (0.784s)
[176.112037] Starting dynamic subtest: pipe-C
[176.859261] Dynamic subtest pipe-C: SUCCESS (0.751s)
[176.864938] Starting dynamic subtest: pipe-D
[177.544235] Dynamic subtest pipe-D: SUCCESS (0.685s)
[177.545015] Subtest ctm-0-50: SUCCESS (2.981s)
[177.634828] [029/142] (807s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[177.787431] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[177.788976] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[178.082793] [030/142] (807s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[178.178374] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[178.179132] Starting dynamic subtest: pipe-A-HDMI-A-1
[178.235999] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.057s)
[178.242246] Starting dynamic subtest: pipe-B-HDMI-A-1
[178.353374] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.116s)
[178.359516] Starting dynamic subtest: pipe-C-HDMI-A-1
[178.461159] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.106s)
[178.467469] Starting dynamic subtest: pipe-D-HDMI-A-1
[178.577414] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.115s)
[178.578212] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.400s)
[178.706882] [031/142] (806s left) gem_softpin (softpin)
[178.762857] Starting subtest: softpin
[211.039904] Subtest softpin: SUCCESS (32.268s)
[211.103961] [032/142] (774s left) kms_cursor_crc (cursor-onscreen-64x64)
[211.210955] Starting subtest: cursor-onscreen-64x64
[211.216336] Starting dynamic subtest: pipe-A-HDMI-A-1
[212.432010] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.216s)
[212.456797] Starting dynamic subtest: pipe-D-HDMI-A-1
[213.588054] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.137s)
[213.588855] Subtest cursor-onscreen-64x64: SUCCESS (2.378s)
[213.690910] [033/142] (771s left) gem_exec_reloc (basic-cpu-read-noreloc)
[213.740228] Starting subtest: basic-cpu-read-noreloc
[213.742492] Subtest basic-cpu-read-noreloc: SUCCESS (0.002s)
[213.837051] [034/142] (771s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[213.935525] Starting subtest: short-flip-after-cursor-atomic-transitions
[214.473636] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.538s)
[214.568207] [035/142] (770s left) gem_exec_whisper (basic-contexts)
[214.643676] Starting subtest: basic-contexts
[216.777168] Subtest basic-contexts: SUCCESS (2.133s)
[216.934936] [036/142] (768s left) perf (short-reads)
[217.035345] Starting subtest: short-reads
[217.044681] Subtest short-reads: SUCCESS (0.012s)
[217.063405] [037/142] (768s left) kms_vblank (pipe-d-wait-forked)
[217.162526] Starting subtest: pipe-D-wait-forked
[218.441162] Subtest pipe-D-wait-forked: SUCCESS (1.278s)
[218.534988] [038/142] (766s left) gem_mmap_wc (write)
[218.583564] Starting subtest: write
[218.622970] Subtest write: SUCCESS (0.040s)
[218.675848] [039/142] (766s left) gem_exec_schedule (manyslice)
[218.730154] Starting subtest: manyslice
[218.730857] Starting dynamic subtest: rcs0
[219.197018] Dynamic subtest rcs0: SUCCESS (0.459s)
[219.202881] Starting dynamic subtest: bcs0
[219.485062] Dynamic subtest bcs0: SUCCESS (0.288s)
[219.491147] Starting dynamic subtest: vcs0
[219.782897] Dynamic subtest vcs0: SUCCESS (0.297s)
[219.788909] Starting dynamic subtest: vcs1
[220.082162] Dynamic subtest vcs1: SUCCESS (0.299s)
[220.087737] Starting dynamic subtest: vecs0
[220.416203] Dynamic subtest vecs0: SUCCESS (0.334s)
[220.417046] Subtest manyslice: SUCCESS (1.678s)
[220.676213] [040/142] (764s left) gem_softpin (32b-excludes-last-page)
[220.736105] Starting subtest: 32b-excludes-last-page
[220.737888] Subtest 32b-excludes-last-page: SUCCESS (0.001s)
[220.817918] [041/142] (764s left) perf (i915-ref-count)
[220.900343] Starting subtest: i915-ref-count
[220.913479] Subtest i915-ref-count: SUCCESS (0.013s)
[220.932431] [042/142] (764s left) i915_module_load (reload-with-fault-injection)
[220.981491] Starting subtest: reload-with-fault-injection
[224.003764] Subtest reload-with-fault-injection: SUCCESS (3.014s)
[224.012325] [043/142] (761s left) syncobj_wait (invalid-signal-illegal-handle)
[224.974874] Starting subtest: invalid-signal-illegal-handle
[224.975693] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[225.032732] [044/142] (760s left) gem_ctx_engines (none)
[225.087292] Starting subtest: none
[225.088936] Subtest none: SUCCESS (0.001s)
[225.227232] [045/142] (760s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[225.330462] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[225.923807] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.593s)
[226.021943] [046/142] (759s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[226.216065] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[226.218138] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[226.358082] [047/142] (759s left) kms_busy (extended-pageflip-hang-oldfb)
[226.461812] Starting subtest: extended-pageflip-hang-oldfb
[226.462565] Starting dynamic subtest: pipe-A
[226.587398] Dynamic subtest pipe-A: SUCCESS (0.128s)
[226.594842] Starting dynamic subtest: pipe-D
[226.717359] Dynamic subtest pipe-D: SUCCESS (0.125s)
[226.718280] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.259s)
[226.830404] [048/142] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[226.932086] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[226.933552] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[226.989201] [049/142] (758s left) kms_vblank (pipe-a-ts-continuation-dpms-rpm)
[227.091174] Starting subtest: pipe-A-ts-continuation-dpms-rpm
[238.709196] Subtest pipe-A-ts-continuation-dpms-rpm: SUCCESS (11.622s)
[238.798653] [050/142] (746s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[238.994549] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[238.997357] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[239.266578] [051/142] (746s left) gem_exec_big (single)
[239.318456] Starting subtest: single
[241.623844] Subtest single: SUCCESS (2.296s)
[242.036653] [052/142] (743s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[242.134656] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[242.239952] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[242.282158] [053/142] (743s left) syncobj_timeline (multi-wait-submitted-signaled)
[242.338842] Starting subtest: multi-wait-submitted-signaled
[242.339639] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[242.374418] [054/142] (743s left) prime_busy (after)
[242.433359] Starting subtest: after
[242.437891] Starting dynamic subtest: rcs0
[242.458504] Dynamic subtest rcs0: SUCCESS (0.020s)
[242.464702] Starting dynamic subtest: bcs0
[242.479695] Dynamic subtest bcs0: SUCCESS (0.020s)
[242.489264] Starting dynamic subtest: vcs0
[242.500997] Dynamic subtest vcs0: SUCCESS (0.020s)
[242.511035] Starting dynamic subtest: vcs1
[242.515301] Dynamic subtest vcs1: SUCCESS (0.013s)
[242.521674] Starting dynamic subtest: vecs0
[242.528968] Dynamic subtest vecs0: SUCCESS (0.013s)
[242.639504] Subtest after: SUCCESS (0.205s)
[242.685722] [055/142] (743s left) gem_busy (semaphore)
[242.879728] Starting subtest: semaphore
[242.881075] Starting dynamic subtest: rcs0
[242.902523] Dynamic subtest rcs0: SUCCESS (0.031s)
[242.911703] Starting dynamic subtest: bcs0
[242.925761] Dynamic subtest bcs0: SUCCESS (0.022s)
[242.935690] Starting dynamic subtest: vcs0
[242.945518] Dynamic subtest vcs0: SUCCESS (0.019s)
[242.954837] Starting dynamic subtest: vcs1
[242.966521] Dynamic subtest vcs1: SUCCESS (0.020s)
[242.975851] Starting dynamic subtest: vecs0
[242.988082] Dynamic subtest vecs0: SUCCESS (0.019s)
[242.989066] Subtest semaphore: SUCCESS (0.116s)
[243.165602] [056/142] (742s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[243.264670] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[243.265374] Starting dynamic subtest: pipe-A-valid-mode
[243.311028] Dynamic subtest pipe-A-valid-mode: SKIP (0.045s)
[243.312443] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.047s)
[243.383300] [057/142] (742s left) gem_mmap (big-bo)
[243.430024] Starting subtest: big-bo
[243.520156] Subtest big-bo: SUCCESS (0.090s)
[243.577716] [058/142] (742s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[243.712442] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[243.713911] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[243.766664] [059/142] (742s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_mc_ccs)
[244.107197] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs
[244.108775] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[244.230157] [060/142] (741s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[244.577668] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[244.580504] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.002s)
[244.723153] [061/142] (741s left) kms_plane_multiple (tiling-y)
[244.819092] Starting subtest: tiling-y
[244.820790] Starting dynamic subtest: pipe-A-HDMI-A-1
[245.397136] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.577s)
[245.403952] Starting dynamic subtest: pipe-B-HDMI-A-1
[245.955068] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.556s)
[245.962835] Starting dynamic subtest: pipe-C-HDMI-A-1
[246.508077] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.551s)
[246.513861] Starting dynamic subtest: pipe-D-HDMI-A-1
[247.079091] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.570s)
[247.079912] Subtest tiling-y: SUCCESS (2.261s)
[247.192310] [062/142] (738s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[247.590074] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[247.590950] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.001s)
[247.702149] [063/142] (738s left) gem_fence_thrash (bo-write-verify-x)
[247.748538] Starting subtest: bo-write-verify-x
[248.866449] Subtest bo-write-verify-x: SUCCESS (1.109s)
[248.918567] [064/142] (736s left) api_intel_bb (add-remove-objects)
[248.966041] Starting subtest: add-remove-objects
[248.970624] Subtest add-remove-objects: SUCCESS (0.005s)
[249.043492] [065/142] (736s left) drm_read (invalid-buffer)
[249.231569] Starting subtest: invalid-buffer
[249.232451] Subtest invalid-buffer: SUCCESS (0.000s)
[249.310798] [066/142] (736s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs)
[249.582583] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs
[249.584148] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[249.774383] [067/142] (736s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[249.876163] Starting subtest: fbc-1p-pri-indfb-multidraw
[257.662557] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (7.788s)
[257.759308] [068/142] (728s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[257.871211] Starting subtest: psr-rgb565-draw-render
[257.872636] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[257.925607] [069/142] (727s left) gem_exec_reloc (basic-softpin)
[257.976417] Starting subtest: basic-softpin
[257.978419] Subtest basic-softpin: SUCCESS (0.002s)
[258.067280] [070/142] (727s left) gem_exec_reloc (basic-write-read-noreloc)
[258.117472] Starting subtest: basic-write-read-noreloc
[258.119456] Subtest basic-write-read-noreloc: SUCCESS (0.002s)
[258.209264] [071/142] (727s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[258.311293] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[258.312809] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[258.367250] [072/142] (727s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[258.461966] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[258.462796] Starting dynamic subtest: pipe-A-valid-mode
[259.121936] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.659s)
[259.122762] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.661s)
[259.223553] [073/142] (726s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[259.421543] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[259.422376] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[259.686902] [074/142] (726s left) kms_getfb (getfb-handle-not-fb)
[259.737007] Starting subtest: getfb-handle-not-fb
[259.784969] Subtest getfb-handle-not-fb: SUCCESS (0.048s)
[259.845200] [075/142] (726s left) dumb_buffer (map-uaf)
[259.897685] Starting subtest: map-uaf
[259.899509] Subtest map-uaf: SUCCESS (0.003s)
[259.961908] [076/142] (726s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[260.065484] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[260.066994] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[260.111785] [077/142] (725s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[260.163218] Starting subtest: cpuset-basic-small-copy-odd
[263.679756] Subtest cpuset-basic-small-copy-odd: SUCCESS (3.517s)
[263.721431] [078/142] (722s left) i915_pm_rps (reset)
[263.811945] Starting subtest: reset
[267.366637] Subtest reset: SUCCESS (3.523s)
[267.407545] [079/142] (718s left) kms_flip (2x-flip-vs-fences)
[267.494853] Starting subtest: 2x-flip-vs-fences
[267.515782] Subtest 2x-flip-vs-fences: SKIP (0.020s)
[267.561239] [080/142] (718s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[267.659630] Starting subtest: short-busy-flip-before-cursor-toggle
[267.661204] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[267.694546] [081/142] (718s left) prime_self_import (basic-with_one_bo)
[267.741391] Starting subtest: basic-with_one_bo
[267.744228] Subtest basic-with_one_bo: SUCCESS (0.003s)
[267.770191] [082/142] (718s left) kms_selftest (drm_format)
[267.814968] Starting subtest: drm_format
[267.822155] Subtest drm_format: SKIP (0.006s)
[267.852331] [083/142] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[267.958338] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[267.959765] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[268.019696] [084/142] (718s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[268.068995] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[268.086756] [085/142] (718s left) kms_psr (sprite_plane_move)
[268.138039] Subtest sprite_plane_move: SKIP (0.000s)
[268.153455] [086/142] (717s left) kms_lease (master-vs-lease)
[268.250141] Starting subtest: master-vs-lease
[268.251391] Subtest master-vs-lease: SUCCESS (0.001s)
[268.286849] [087/142] (717s left) kms_ccs (pipe-d-missing-ccs-buffer-yf_tiled_ccs)
[268.653693] Starting subtest: pipe-D-missing-ccs-buffer-yf_tiled_ccs
[268.655315] Subtest pipe-D-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[268.755705] [088/142] (717s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[268.804083] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[268.804812] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[268.838388] [089/142] (717s left) gem_ctx_shared (single-timeline)
[268.891555] Starting subtest: single-timeline
[268.896978] Subtest single-timeline: SUCCESS (0.003s)
[269.055925] [090/142] (717s left) sysfs_heartbeat_interval (nopreempt)
[269.114059] Starting subtest: nopreempt
[269.115040] Starting dynamic subtest: vecs0
[272.569665] Dynamic subtest vecs0: SUCCESS (3.455s)
[272.574770] Starting dynamic subtest: vcs0
[276.039944] Dynamic subtest vcs0: SUCCESS (3.456s)
[276.044713] Starting dynamic subtest: bcs0
[279.486029] Dynamic subtest bcs0: SUCCESS (3.445s)
[279.490951] Starting dynamic subtest: rcs0
[282.959557] Dynamic subtest rcs0: SUCCESS (3.476s)
[282.964391] Starting dynamic subtest: vcs1
[286.414270] Dynamic subtest vcs1: SUCCESS (3.455s)
[286.415017] Subtest nopreempt: SUCCESS (17.292s)
[286.440303] [091/142] (699s left) kms_psr2_su (page_flip-p010)
[286.488457] Subtest page_flip-P010: SKIP (0.000s)
[286.508340] [092/142] (699s left) gen3_mixed_blits
[286.580526] [093/142] (699s left) kms_getfb (getfb2-into-addfb2)
[286.628814] Starting subtest: getfb2-into-addfb2
[286.629607] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[286.688327] [094/142] (699s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[286.795133] Starting subtest: flip-vs-cursor-legacy
[291.702892] Subtest flip-vs-cursor-legacy: SUCCESS (4.908s)
[291.803171] [095/142] (694s left) kms_chamelium_hpd (dp-hpd-storm)
[291.947682] Subtest dp-hpd-storm: SKIP (0.000s)
[292.006443] [096/142] (694s left) gem_userptr_blits (access-control)
[292.073261] Starting subtest: access-control
[292.074931] Subtest access-control: SKIP (0.000s)
[292.135766] [097/142] (694s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[292.183960] Starting subtest: no-spare-fences-busy
[294.356272] Subtest no-spare-fences-busy: SUCCESS (2.171s)
[294.455711] [098/142] (691s left) kms_content_protection (content_type_change)
[294.560672] Starting subtest: content_type_change
[294.851467] Subtest content_type_change: SKIP (0.288s)
[294.979216] [099/142] (691s left) kms_rotation_crc (sprite-rotation-270)
[295.078072] Starting subtest: sprite-rotation-270
[298.619201] Subtest sprite-rotation-270: SUCCESS (3.541s)
[298.757298] [100/142] (687s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[298.825244] Subtest get-values-invalid-pointer: SKIP (0.000s)
[298.854893] [101/142] (687s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[298.953795] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[298.955225] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[299.021892] [102/142] (687s left) gem_exec_balancer (hog)
[299.075091] Starting subtest: hog
[299.925510] Subtest hog: SUCCESS (0.842s)
[300.147749] [103/142] (686s left) gem_exec_flush (basic-uc-ro-default)
[300.199909] Starting subtest: basic-uc-ro-default
[305.617475] Subtest basic-uc-ro-default: SUCCESS (5.417s)
[305.781221] [104/142] (680s left) i915_suspend (forcewake)
[305.858835] Starting subtest: forcewake
[338.026868] Subtest forcewake: SUCCESS (2.307s)
[344.117899] [105/142] (678s left) v3d/v3d_submit_cl (bad-multisync-extension)
[344.196286] Subtest bad-multisync-extension: SKIP (0.000s)
[344.228176] [106/142] (678s left) kms_cursor_legacy (torture-move)
[344.329197] Starting subtest: torture-move
[344.330129] Starting dynamic subtest: pipe-A
[349.780669] Dynamic subtest pipe-A: SUCCESS (5.451s)
[349.786396] Starting dynamic subtest: pipe-B
[355.256234] Dynamic subtest pipe-B: SUCCESS (5.475s)
[355.262081] Starting dynamic subtest: pipe-C
[360.731051] Dynamic subtest pipe-C: SUCCESS (5.474s)
[360.736993] Starting dynamic subtest: pipe-D
[366.199850] Dynamic subtest pipe-D: SUCCESS (5.468s)
[366.208736] Starting dynamic subtest: all-pipes
[371.679361] Dynamic subtest all-pipes: SUCCESS (5.479s)
[371.680160] Subtest torture-move: SUCCESS (27.350s)
[371.716855] [107/142] (650s left) gem_wait (invalid-buf)
[371.795255] Starting subtest: invalid-buf
[371.796067] Subtest invalid-buf: SUCCESS (0.000s)
[371.979790] [108/142] (650s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[372.089404] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[372.091084] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[372.146909] [109/142] (650s left) gem_pxp (protected-raw-src-copy-not-readible)
[374.711887] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[374.753101] [110/142] (647s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[374.976027] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[374.977617] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[375.222177] [111/142] (647s left) gen9_exec_parse (batch-invalid-length)
[375.274901] Subtest batch-invalid-length: SKIP (0.000s)
[375.298423] [112/142] (647s left) kms_ccs (pipe-a-ccs-on-another-bo-yf_tiled_ccs)
[375.486428] Starting subtest: pipe-A-ccs-on-another-bo-yf_tiled_ccs
[375.488186] Subtest pipe-A-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[375.781907] [113/142] (646s left) gen7_exec_parse (basic-allocation)
[375.834451] Subtest basic-allocation: SKIP (0.000s)
[375.857976] [114/142] (646s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[375.953214] Starting subtest: cursor-vs-flip-toggle
[404.836958] Subtest cursor-vs-flip-toggle: SUCCESS (28.884s)
[404.937916] [115/142] (617s left) kms_vblank (pipe-b-ts-continuation-idle-hang)
[405.034283] Starting subtest: pipe-B-ts-continuation-idle-hang
[418.947220] Subtest pipe-B-ts-continuation-idle-hang: SUCCESS (13.914s)
[419.052781] [116/142] (603s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[419.153425] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[419.972222] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (0.820s)
[420.054787] [117/142] (602s left) i915_query (query-topology-known-pci-ids)
[420.109157] Starting subtest: query-topology-known-pci-ids
[420.110564] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[420.143532] [118/142] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[420.252009] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[420.253462] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[420.310920] [119/142] (602s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[420.412373] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[420.654782] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.242s)
[420.759351] [120/142] (601s left) kms_hdmi_inject (inject-audio)
[420.874201] Starting subtest: inject-audio
[420.875922] Subtest inject-audio: SKIP (0.000s)
[420.948117] [121/142] (601s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[421.047248] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[421.048021] Starting dynamic subtest: pipe-A-HDMI-A-1
[421.108048] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.060s)
[421.172910] Starting dynamic subtest: pipe-B-HDMI-A-1
[421.299507] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.131s)
[421.341365] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.295s)
[421.431626] [122/142] (601s left) vc4/vc4_perfmon (get-values-valid-perfmon)
[421.500570] Subtest get-values-valid-perfmon: SKIP (0.000s)
[421.531112] [123/142] (600s left) perf_pmu (busy-idle)
[421.580689] Starting subtest: busy-idle
[421.581489] Starting dynamic subtest: rcs0
[422.218496] Dynamic subtest rcs0: SUCCESS (0.637s)
[422.224197] Starting dynamic subtest: bcs0
[422.855273] Dynamic subtest bcs0: SUCCESS (0.636s)
[422.864784] Starting dynamic subtest: vcs0
[423.491249] Dynamic subtest vcs0: SUCCESS (0.634s)
[423.499983] Starting dynamic subtest: vcs1
[424.127291] Dynamic subtest vcs1: SUCCESS (0.634s)
[424.136684] Starting dynamic subtest: vecs0
[424.761451] Dynamic subtest vecs0: SUCCESS (0.633s)
[424.763028] Subtest busy-idle: SUCCESS (3.181s)
[424.813097] [124/142] (597s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[424.910818] Starting subtest: flip-vs-cursor-crc-legacy
[425.215568] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.305s)
[425.300495] [125/142] (597s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[425.397765] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[425.399558] Starting dynamic subtest: pipe-A-HDMI-A-1
[432.844956] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.446s)
[432.852409] Starting dynamic subtest: pipe-B-HDMI-A-1
[440.321724] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.475s)
[440.328478] Starting dynamic subtest: pipe-C-HDMI-A-1
[440.505980] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.182s)
[440.512763] Starting dynamic subtest: pipe-D-HDMI-A-1
[440.690746] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.183s)
[440.691545] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (15.294s)
[440.826807] [126/142] (581s left) gem_mmap_offset (perf)
[440.878130] Starting subtest: perf
[440.878933] Starting dynamic subtest: smem0
[441.081119] Dynamic subtest smem0: SUCCESS (0.203s)
[441.081947] Subtest perf: SUCCESS (0.204s)
[441.138825] [127/142] (581s left) i915_pm_rpm (gem-execbuf-stress)
[452.690323] Starting subtest: gem-execbuf-stress
[452.691707] Starting dynamic subtest: smem0
[463.664784] Dynamic subtest smem0: FAIL (10.955s)
[463.675072] Starting dynamic subtest: extra-wait-smem0
[474.676742] Dynamic subtest extra-wait-smem0: FAIL (11.015s)
[474.677472] Subtest gem-execbuf-stress: FAIL (21.972s)
[474.806289] [128/142] (547s left) gem_exec_reloc (basic-write-wc-active)
[474.858190] Starting subtest: basic-write-wc-active
[474.980752] Subtest basic-write-wc-active: SUCCESS (0.113s)
[475.063908] [129/142] (547s left) i915_pm_rpm (basic-rte)
[475.110281] Starting subtest: basic-rte
[497.551915] Subtest basic-rte: FAIL (22.368s)
[508.440555] [130/142] (514s left) gem_exec_params (sol-reset-not-gen7)
[508.488616] Starting subtest: sol-reset-not-gen7
[508.490523] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[508.552287] [131/142] (514s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[508.652352] Starting subtest: yf-tiled-32bpp-rotate-90
[508.653789] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[508.718470] [132/142] (513s left) v3d/v3d_wait_bo (used-bo-1ns)
[508.788935] Subtest used-bo-1ns: SKIP (0.000s)
[508.820353] [133/142] (513s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[508.931153] Starting subtest: fbc-rgb565-draw-mmap-gtt
[509.963533] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.034s)
[510.058711] [134/142] (512s left) kms_vblank (pipe-b-query-busy)
[510.164134] Starting subtest: pipe-B-query-busy
[511.752742] Subtest pipe-B-query-busy: SUCCESS (1.588s)
[511.842394] [135/142] (510s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[511.893188] Starting subtest: single-wait-all-for-submit-signaled
[511.893997] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[511.932186] [136/142] (510s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[511.984026] Starting subtest: mixed-tiled-to-y-tiled-ccs
[511.984780] Starting dynamic subtest: smem
[512.092567] Dynamic subtest smem: SUCCESS (0.108s)
[512.093433] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.109s)
[512.248677] [137/142] (510s left) gem_exec_fence (syncobj-timeline-chain-engines)
[512.700617] Starting subtest: syncobj-timeline-chain-engines
[512.764648] Subtest syncobj-timeline-chain-engines: SUCCESS (0.065s)
[512.918685] [138/142] (509s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[513.024994] Starting subtest: x-tiled-64bpp-rotate-270
[513.058670] Subtest x-tiled-64bpp-rotate-270: SKIP (0.033s)
[513.134801] [139/142] (509s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[513.235123] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[513.803863] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.569s)
[513.877870] [140/142] (508s left) kms_cursor_crc (cursor-sliding-32x10)
[513.975843] Starting subtest: cursor-sliding-32x10
[514.018024] Subtest cursor-sliding-32x10: SKIP (0.041s)
[514.078654] [141/142] (508s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[514.177958] Starting subtest: cursorB-vs-flipA-toggle
[514.180604] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[514.219482] [142/142] (508s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[514.319389] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[514.320806] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[514.359390] Closing watchdogs
Done.