[40.249488] Initializing watchdogs
[40.249559]   /dev/watchdog0
[40.255581] [001/142] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[42.221147] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[42.222873] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[42.281594] [002/142] (958s left) gem_exec_params (invalid-bsd2-flag-on-render)
[42.369580] Starting subtest: invalid-bsd2-flag-on-render
[42.370617] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[42.465922] [003/142] (958s left) gem_basic (bad-close)
[42.561274] Starting subtest: bad-close
[42.562993] Subtest bad-close: SUCCESS (0.000s)
[42.614424] [004/142] (958s left) kms_atomic_interruptible (legacy-pageflip)
[44.576198] Starting subtest: legacy-pageflip
[44.577122] Starting dynamic subtest: HDMI-A-3-pipe-A
[50.784436] Dynamic subtest HDMI-A-3-pipe-A: SUCCESS (6.207s)
[50.785340] Subtest legacy-pageflip: SUCCESS (6.208s)
[50.882138] [005/142] (949s left) gem_exec_schedule (semaphore-user)
[50.957268] Starting subtest: semaphore-user
[51.031098] Subtest semaphore-user: SUCCESS (0.074s)
[51.396331] [006/142] (949s left) gem_lmem_swapping (heavy-multi)
[55.744103] Starting subtest: heavy-multi
[55.744857] Starting dynamic subtest: lmem0
[59.439730] Dynamic subtest lmem0: SUCCESS (3.661s)
[59.440662] Subtest heavy-multi: SUCCESS (3.661s)
[60.984282] [007/142] (939s left) drm_fdinfo (virtual-busy-idle)
[63.444709] Starting subtest: virtual-busy-idle
[63.446108] Subtest virtual-busy-idle: SKIP (0.000s)
[64.431562] [008/142] (936s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[66.380409] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[66.382061] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[66.446465] [009/142] (934s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_mc_ccs)
[68.564025] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_mc_ccs
[68.565693] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[68.675600] [010/142] (932s left) vgem_basic (bad-flag)
[68.780892] Starting subtest: bad-flag
[68.781731] Subtest bad-flag: SUCCESS (0.000s)
[68.825222] [011/142] (932s left) gem_exec_fair (basic-sync)
[68.897259] Subtest basic-sync: SKIP (0.000s)
[68.919657] [012/142] (932s left) gem_vm_create (create-ext)
[68.993394] Starting subtest: create-ext
[68.999396] Subtest create-ext: SUCCESS (0.008s)
[69.112806] [013/142] (931s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[71.083919] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[71.085553] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[71.159926] [014/142] (929s left) api_intel_allocator (fork-simple-once)
[71.255600] Starting subtest: fork-simple-once
[71.305348] Subtest fork-simple-once: SUCCESS (0.051s)
[71.394400] [015/142] (929s left) kms_vblank (pipe-a-wait-busy-hang)
[73.384104] Starting subtest: pipe-A-wait-busy-hang
[87.037312] Subtest pipe-A-wait-busy-hang: SUCCESS (13.653s)
[87.141254] [016/142] (913s left) kms_chamelium_color (ctm-blue-to-red)
[89.100373] Subtest ctm-blue-to-red: SKIP (0.000s)
[89.118915] [017/142] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[91.079636] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[91.081245] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[91.158355] [018/142] (909s left) kms_vblank (pipe-a-query-idle)
[93.164217] Starting subtest: pipe-A-query-idle
[95.385281] Subtest pipe-A-query-idle: SUCCESS (2.221s)
[95.493048] [019/142] (905s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[97.524683] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[101.739565] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SUCCESS (4.215s)
[101.948342] [020/142] (899s left) kms_invalid_mode (zero-vdisplay)
[103.906908] Starting subtest: zero-vdisplay
[103.907695] Starting dynamic subtest: HDMI-A-3-pipe-A
[103.945783] Dynamic subtest HDMI-A-3-pipe-A: SUCCESS (0.039s)
[103.950884] Starting dynamic subtest: HDMI-A-3-pipe-B
[103.954148] Dynamic subtest HDMI-A-3-pipe-B: SUCCESS (0.008s)
[103.959200] Starting dynamic subtest: HDMI-A-3-pipe-C
[103.962207] Dynamic subtest HDMI-A-3-pipe-C: SUCCESS (0.007s)
[103.967258] Starting dynamic subtest: HDMI-A-3-pipe-D
[103.969561] Dynamic subtest HDMI-A-3-pipe-D: SUCCESS (0.007s)
[103.970486] Subtest zero-vdisplay: SUCCESS (0.064s)
[104.076779] [021/142] (896s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[106.029272] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[106.031011] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[106.093837] [022/142] (894s left) gem_exec_gttfill (engines)
[106.197947] Starting subtest: engines
[106.199247] Starting dynamic subtest: rcs0
[131.431865] Dynamic subtest rcs0: SUCCESS (25.225s)
[131.437258] Starting dynamic subtest: bcs0
[156.724361] Dynamic subtest bcs0: SUCCESS (25.292s)
[156.729829] Starting dynamic subtest: vcs0
[182.045812] Dynamic subtest vcs0: SUCCESS (25.321s)
[182.051228] Starting dynamic subtest: vcs1
[207.357908] Dynamic subtest vcs1: SUCCESS (25.312s)
[207.363348] Starting dynamic subtest: vecs0
[232.656747] Dynamic subtest vecs0: SUCCESS (25.299s)
[232.662137] Starting dynamic subtest: vecs1
[257.937860] Dynamic subtest vecs1: SUCCESS (25.281s)
[257.943284] Starting dynamic subtest: ccs0
[283.235963] Dynamic subtest ccs0: SUCCESS (25.298s)
[283.241486] Starting dynamic subtest: ccs1
[308.516108] Dynamic subtest ccs1: SUCCESS (25.280s)
[308.521497] Starting dynamic subtest: ccs2
[333.815729] Dynamic subtest ccs2: SUCCESS (25.299s)
[333.821086] Starting dynamic subtest: ccs3
[359.092848] Dynamic subtest ccs3: SUCCESS (25.277s)
[359.093767] Subtest engines: SUCCESS (252.887s)
[359.353243] [023/142] (641s left) api_intel_bb (simple-bb)
[359.449913] Starting subtest: simple-bb
[359.473281] Subtest simple-bb: SUCCESS (0.024s)
[359.567249] [024/142] (641s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[361.637412] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[365.803970] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SUCCESS (4.167s)
[365.982885] [025/142] (635s left) gem_ctx_persistence (legacy-engines-hostile)
[366.048011] Starting subtest: legacy-engines-hostile
[366.048936] Starting dynamic subtest: render
[366.090219] Dynamic subtest render: SUCCESS (0.042s)
[366.095797] Starting dynamic subtest: bsd1
[366.198880] Dynamic subtest bsd1: SUCCESS (0.108s)
[366.207178] Starting dynamic subtest: bsd2
[366.266576] Dynamic subtest bsd2: SUCCESS (0.067s)
[366.282459] Starting dynamic subtest: blt
[366.316893] Dynamic subtest blt: SUCCESS (0.050s)
[366.326195] Starting dynamic subtest: vebox
[366.399318] Dynamic subtest vebox: SUCCESS (0.082s)
[366.400414] Subtest legacy-engines-hostile: SUCCESS (0.351s)
[366.516590] [026/142] (634s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[366.582306] Starting subtest: etime-single-wait-all-for-submit-submitted
[366.684573] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[366.766555] [027/142] (634s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[368.724211] Starting subtest: 4-tiled-32bpp-rotate-180
[370.302810] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.578s)
[370.429479] [028/142] (630s left) kms_color (ctm-0-50)
[372.389156] Starting subtest: ctm-0-50
[372.390117] Starting dynamic subtest: pipe-A
[373.760235] Dynamic subtest pipe-A: SUCCESS (1.371s)
[373.765827] Starting dynamic subtest: pipe-B
[374.949435] Dynamic subtest pipe-B: SUCCESS (1.189s)
[374.957831] Starting dynamic subtest: pipe-C
[376.163267] Dynamic subtest pipe-C: SUCCESS (1.215s)
[376.170138] Starting dynamic subtest: pipe-D
[377.481709] Dynamic subtest pipe-D: SUCCESS (1.317s)
[377.482579] Subtest ctm-0-50: SUCCESS (5.092s)
[377.596699] [029/142] (623s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[379.596913] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[379.910779] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.314s)
[380.203878] [030/142] (620s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[382.161057] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[382.161996] Starting dynamic subtest: pipe-A-HDMI-A-3
[382.240384] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.080s)
[382.246953] Starting dynamic subtest: pipe-B-HDMI-A-3
[382.347085] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.106s)
[382.353516] Starting dynamic subtest: pipe-C-HDMI-A-3
[382.455203] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.107s)
[382.461998] Starting dynamic subtest: pipe-D-HDMI-A-3
[382.561854] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.105s)
[382.562805] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.402s)
[382.664524] [031/142] (618s left) gem_softpin (softpin)
[382.731026] Starting subtest: softpin
[415.074066] Subtest softpin: SUCCESS (32.334s)
[415.161681] [032/142] (586s left) kms_cursor_crc (cursor-onscreen-64x64)
[417.195232] Starting subtest: cursor-onscreen-64x64
[417.200056] Starting dynamic subtest: pipe-A-HDMI-A-3
[419.874452] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.675s)
[419.904080] Starting dynamic subtest: pipe-D-HDMI-A-3
[422.557603] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.658s)
[422.558627] Subtest cursor-onscreen-64x64: SUCCESS (5.362s)
[422.832876] [033/142] (578s left) gem_exec_reloc (basic-cpu-read-noreloc)
[422.897379] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[422.925539] [034/142] (578s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[424.882870] Starting subtest: short-flip-after-cursor-atomic-transitions
[425.893539] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.011s)
[426.013173] [035/142] (575s left) gem_exec_whisper (basic-contexts)
[426.082173] Starting subtest: basic-contexts
[435.631920] Subtest basic-contexts: SUCCESS (9.539s)
[435.809281] [036/142] (565s left) perf (short-reads)
[436.147815] Starting subtest: short-reads
[436.166896] Subtest short-reads: SUCCESS (0.020s)
[436.195248] [037/142] (565s left) kms_vblank (pipe-d-wait-forked)
[438.152979] Starting subtest: pipe-D-wait-forked
[440.663934] Subtest pipe-D-wait-forked: SUCCESS (2.512s)
[440.775613] [038/142] (560s left) gem_mmap_wc (write)
[440.836814] Subtest write: SKIP (0.000s)
[440.852038] [039/142] (560s left) gem_exec_schedule (manyslice)
[440.921582] Starting subtest: manyslice
[440.922439] Starting dynamic subtest: rcs0
[444.445561] Dynamic subtest rcs0: SUCCESS (3.490s)
[444.451441] Starting dynamic subtest: bcs0
[448.871777] Dynamic subtest bcs0: SUCCESS (4.425s)
[448.877698] Starting dynamic subtest: vcs0
[453.511938] Dynamic subtest vcs0: SUCCESS (4.639s)
[453.517812] Starting dynamic subtest: vcs1
[458.150202] Dynamic subtest vcs1: SUCCESS (4.637s)
[458.156059] Starting dynamic subtest: vecs0
[462.277802] Dynamic subtest vecs0: SUCCESS (4.126s)
[462.283861] Starting dynamic subtest: vecs1
[466.406914] Dynamic subtest vecs1: SUCCESS (4.128s)
[466.412787] Starting dynamic subtest: ccs0
[470.869300] Dynamic subtest ccs0: SUCCESS (4.461s)
[470.875453] Starting dynamic subtest: ccs1
[475.326553] Dynamic subtest ccs1: SUCCESS (4.456s)
[475.336061] Starting dynamic subtest: ccs2
[479.803726] Dynamic subtest ccs2: SUCCESS (4.476s)
[479.809525] Starting dynamic subtest: ccs3
[484.269597] Dynamic subtest ccs3: SUCCESS (4.464s)
[484.270667] Subtest manyslice: SUCCESS (43.315s)
[484.547118] [040/142] (516s left) gem_softpin (32b-excludes-last-page)
[484.610524] Starting subtest: 32b-excludes-last-page
[484.614381] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[484.702186] [041/142] (516s left) perf (i915-ref-count)
[484.811459] Starting subtest: i915-ref-count
[484.883639] Subtest i915-ref-count: SUCCESS (0.072s)
[484.941950] [042/142] (516s left) i915_module_load (reload-with-fault-injection)
[485.001156] Starting subtest: reload-with-fault-injection
[502.104332] Subtest reload-with-fault-injection: SUCCESS (17.094s)
[502.118897] [043/142] (499s left) syncobj_wait (invalid-signal-illegal-handle)
[505.158897] Starting subtest: invalid-signal-illegal-handle
[505.159606] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[506.137240] [044/142] (495s left) gem_ctx_engines (none)
[506.212516] Starting subtest: none
[506.214540] Subtest none: SUCCESS (0.001s)
[506.402198] [045/142] (495s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[508.410298] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[509.600492] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.190s)
[509.723751] [046/142] (491s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[511.788655] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[511.791501] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[511.962952] [047/142] (489s left) kms_busy (extended-pageflip-hang-oldfb)
[513.921945] Starting subtest: extended-pageflip-hang-oldfb
[513.922790] Starting dynamic subtest: pipe-A
[514.109194] Dynamic subtest pipe-A: SUCCESS (0.186s)
[514.121138] Starting dynamic subtest: pipe-D
[514.264067] Dynamic subtest pipe-D: SUCCESS (0.150s)
[514.264975] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.343s)
[514.391667] [048/142] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[516.356324] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[516.357986] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[516.425388] [049/142] (485s left) kms_vblank (pipe-a-ts-continuation-dpms-rpm)
[518.405048] Starting subtest: pipe-A-ts-continuation-dpms-rpm
[521.666931] Subtest pipe-A-ts-continuation-dpms-rpm: SUCCESS (3.263s)
[522.833848] [050/142] (478s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[524.853149] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[524.855885] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[525.046205] [051/142] (476s left) gem_exec_big (single)
[525.111410] Starting subtest: single
[529.792533] Subtest single: SUCCESS (4.647s)
[530.573239] [052/142] (470s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[530.673419] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[530.780291] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[530.845773] [053/142] (470s left) syncobj_timeline (multi-wait-submitted-signaled)
[530.907579] Starting subtest: multi-wait-submitted-signaled
[530.908419] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[530.961832] [054/142] (470s left) prime_busy (after)
[531.043410] Starting subtest: after
[531.047552] Starting dynamic subtest: rcs0
[531.136904] Dynamic subtest rcs0: SUCCESS (0.089s)
[531.143039] Starting dynamic subtest: bcs0
[531.228239] Dynamic subtest bcs0: SUCCESS (0.091s)
[531.234184] Starting dynamic subtest: vcs0
[531.266903] Dynamic subtest vcs0: SUCCESS (0.038s)
[531.272986] Starting dynamic subtest: vcs1
[531.335129] Dynamic subtest vcs1: SUCCESS (0.067s)
[531.341054] Starting dynamic subtest: vecs0
[531.373803] Dynamic subtest vecs0: SUCCESS (0.038s)
[531.379856] Starting dynamic subtest: vecs1
[531.442792] Dynamic subtest vecs1: SUCCESS (0.068s)
[531.448708] Starting dynamic subtest: ccs0
[531.492802] Dynamic subtest ccs0: SUCCESS (0.049s)
[531.498750] Starting dynamic subtest: ccs1
[531.530511] Dynamic subtest ccs1: SUCCESS (0.037s)
[531.536435] Starting dynamic subtest: ccs2
[531.569433] Dynamic subtest ccs2: SUCCESS (0.038s)
[531.575446] Starting dynamic subtest: ccs3
[531.655305] Dynamic subtest ccs3: SUCCESS (0.085s)
[531.759145] Subtest after: SUCCESS (0.716s)
[531.895672] [055/142] (469s left) gem_busy (semaphore)
[532.096154] Subtest semaphore: SKIP (0.000s)
[532.346553] [056/142] (469s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[534.308158] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[534.309105] Starting dynamic subtest: pipe-A-valid-mode
[534.358522] Dynamic subtest pipe-A-valid-mode: SKIP (0.049s)
[534.360357] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.050s)
[534.446878] [057/142] (467s left) gem_mmap (big-bo)
[534.508207] Subtest big-bo: SKIP (0.000s)
[534.523872] [058/142] (467s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[536.486178] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[536.487866] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[536.564135] [059/142] (465s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_mc_ccs)
[538.698181] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs
[542.965864] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs: SUCCESS (4.270s)
[543.145278] [060/142] (458s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[545.235523] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[545.238527] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.002s)
[545.361651] [061/142] (456s left) kms_plane_multiple (tiling-y)
[547.315576] Starting subtest: tiling-y
[547.317434] Subtest tiling-y: SKIP (0.000s)
[547.378024] [062/142] (454s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[549.529600] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[549.531523] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[549.624555] [063/142] (452s left) gem_fence_thrash (bo-write-verify-x)
[549.682194] Starting subtest: bo-write-verify-x
[549.685045] Subtest bo-write-verify-x: SKIP (0.001s)
[549.702212] [064/142] (451s left) api_intel_bb (add-remove-objects)
[549.762761] Starting subtest: add-remove-objects
[549.787660] Subtest add-remove-objects: SUCCESS (0.025s)
[549.888174] [065/142] (451s left) drm_read (invalid-buffer)
[551.945287] Starting subtest: invalid-buffer
[551.946224] Subtest invalid-buffer: SUCCESS (0.000s)
[552.080171] [066/142] (449s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs)
[554.202409] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs
[555.583077] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SUCCESS (1.372s)
[555.764961] [067/142] (445s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[557.723312] Starting subtest: fbc-1p-pri-indfb-multidraw
[565.800974] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.078s)
[565.927584] [068/142] (435s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[567.888823] Starting subtest: psr-rgb565-draw-render
[567.890380] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[567.964601] [069/142] (433s left) gem_exec_reloc (basic-softpin)
[568.066290] Subtest basic-softpin: SKIP (0.000s)
[568.113343] [070/142] (433s left) gem_exec_reloc (basic-write-read-noreloc)
[568.213038] Subtest basic-write-read-noreloc: SKIP (0.000s)
[568.259905] [071/142] (433s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[570.235466] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[570.850759] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.615s)
[570.971570] [072/142] (430s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[572.932381] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[572.933296] Starting dynamic subtest: pipe-A-valid-mode
[572.975597] Dynamic subtest pipe-A-valid-mode: SKIP (0.042s)
[572.977287] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.043s)
[573.061942] [073/142] (428s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[575.085568] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[575.087363] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[575.274770] [074/142] (426s left) kms_getfb (getfb-handle-not-fb)
[575.334564] Starting subtest: getfb-handle-not-fb
[577.228466] Subtest getfb-handle-not-fb: SUCCESS (1.895s)
[577.327628] [075/142] (424s left) dumb_buffer (map-uaf)
[577.438033] Starting subtest: map-uaf
[577.455131] Subtest map-uaf: SUCCESS (0.017s)
[577.555921] [076/142] (424s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[579.552218] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[579.554068] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[579.643269] [077/142] (422s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[579.757195] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[579.790093] [078/142] (422s left) i915_pm_rps (reset)
[579.873884] Starting subtest: reset
[583.638900] Subtest reset: SUCCESS (3.760s)
[583.710940] [079/142] (418s left) kms_flip (2x-flip-vs-fences)
[584.732120] Starting subtest: 2x-flip-vs-fences
[584.733725] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[584.828464] [080/142] (417s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[586.842265] Starting subtest: short-busy-flip-before-cursor-toggle
[586.843891] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[586.891769] [081/142] (415s left) prime_self_import (basic-with_one_bo)
[586.959224] Starting subtest: basic-with_one_bo
[586.962549] Subtest basic-with_one_bo: SUCCESS (0.004s)
[587.022269] [082/142] (414s left) kms_selftest (drm_format)
[587.105651] Starting subtest: drm_format
[587.107318] Subtest drm_format: SKIP (0.001s)
[587.142814] [083/142] (414s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[589.113054] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[589.114741] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[589.192629] [084/142] (412s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[589.281495] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[589.303139] [085/142] (412s left) kms_psr (sprite_plane_move)
[589.363962] Subtest sprite_plane_move: SKIP (0.000s)
[589.385756] [086/142] (412s left) kms_lease (master-vs-lease)
[591.345219] Starting subtest: master-vs-lease
[591.346199] Subtest master-vs-lease: SUCCESS (0.001s)
[591.408544] [087/142] (410s left) kms_ccs (pipe-d-missing-ccs-buffer-yf_tiled_ccs)
[593.550580] Starting subtest: pipe-D-missing-ccs-buffer-yf_tiled_ccs
[593.552280] Subtest pipe-D-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[593.653458] [088/142] (408s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[593.715164] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[593.716144] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[593.769723] [089/142] (408s left) gem_ctx_shared (single-timeline)
[593.837536] Starting subtest: single-timeline
[593.864929] Subtest single-timeline: SUCCESS (0.024s)
[594.094809] [090/142] (408s left) sysfs_heartbeat_interval (nopreempt)
[594.193186] Starting subtest: nopreempt
[594.194138] Starting dynamic subtest: ccs2
[598.384934] Dynamic subtest ccs2: SUCCESS (4.191s)
[598.391927] Starting dynamic subtest: vecs0
[602.464344] Dynamic subtest vecs0: SUCCESS (4.079s)
[602.472398] Starting dynamic subtest: ccs0
[606.589707] Dynamic subtest ccs0: SUCCESS (4.124s)
[606.596796] Starting dynamic subtest: vcs0
[610.667732] Dynamic subtest vcs0: SUCCESS (4.077s)
[610.674766] Starting dynamic subtest: bcs0
[614.747344] Dynamic subtest bcs0: SUCCESS (4.078s)
[614.754259] Starting dynamic subtest: ccs3
[618.901382] Dynamic subtest ccs3: SUCCESS (4.153s)
[618.908167] Starting dynamic subtest: vecs1
[622.998807] Dynamic subtest vecs1: SUCCESS (4.097s)
[623.005559] Starting dynamic subtest: ccs1
[627.116162] Dynamic subtest ccs1: SUCCESS (4.116s)
[627.122913] Starting dynamic subtest: rcs0
[631.213411] Dynamic subtest rcs0: SUCCESS (4.097s)
[631.220346] Starting dynamic subtest: vcs1
[635.293438] Dynamic subtest vcs1: SUCCESS (4.079s)
[635.294433] Subtest nopreempt: SUCCESS (41.101s)
[635.402548] [091/142] (366s left) kms_psr2_su (page_flip-p010)
[635.464278] Subtest page_flip-P010: SKIP (0.000s)
[635.481754] [092/142] (366s left) gen3_mixed_blits
[635.565534] [093/142] (366s left) kms_getfb (getfb2-into-addfb2)
[635.622693] Starting subtest: getfb2-into-addfb2
[635.623574] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[635.712879] [094/142] (366s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[637.690460] Starting subtest: flip-vs-cursor-legacy
[645.446247] Subtest flip-vs-cursor-legacy: SUCCESS (7.755s)
[645.574798] [095/142] (356s left) kms_chamelium_hpd (dp-hpd-storm)
[647.567687] Subtest dp-hpd-storm: SKIP (0.000s)
[647.621197] [096/142] (354s left) gem_userptr_blits (access-control)
[647.700854] Starting subtest: access-control
[647.702667] Subtest access-control: SKIP (0.000s)
[647.791360] [097/142] (354s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[647.856560] Subtest no-spare-fences-busy: SKIP (0.000s)
[647.885782] [098/142] (354s left) kms_content_protection (content_type_change)
[649.888733] Starting subtest: content_type_change
[650.148600] Subtest content_type_change: SKIP (0.258s)
[650.283412] [099/142] (351s left) kms_rotation_crc (sprite-rotation-270)
[652.237256] Starting subtest: sprite-rotation-270
[652.238994] Subtest sprite-rotation-270: SKIP (0.001s)
[652.299828] [100/142] (349s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[652.402827] Subtest get-values-invalid-pointer: SKIP (0.000s)
[652.455913] [101/142] (349s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[654.433114] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[654.434892] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[654.518223] [102/142] (347s left) gem_exec_balancer (hog)
[654.626682] Starting subtest: hog
[654.628589] Subtest hog: SKIP (0.000s)
[654.917416] [103/142] (347s left) gem_exec_flush (basic-uc-ro-default)
[654.986087] Subtest basic-uc-ro-default: SKIP (0.000s)
[655.029843] [104/142] (347s left) i915_suspend (forcewake)
[655.111846] Starting subtest: forcewake
[692.717710] Subtest forcewake: SUCCESS (6.709s)
[695.846245] [105/142] (340s left) v3d/v3d_submit_cl (bad-multisync-extension)
[695.955112] Subtest bad-multisync-extension: SKIP (0.000s)
[696.036185] [106/142] (340s left) kms_cursor_legacy (torture-move)
[698.039136] Starting subtest: torture-move
[698.040066] Starting dynamic subtest: pipe-A
[703.705168] Dynamic subtest pipe-A: SUCCESS (5.631s)
[703.713402] Starting dynamic subtest: pipe-B
[709.255924] Dynamic subtest pipe-B: SUCCESS (5.574s)
[709.264266] Starting dynamic subtest: pipe-C
[714.753069] Dynamic subtest pipe-C: SUCCESS (5.505s)
[714.762651] Starting dynamic subtest: pipe-D
[720.191590] Dynamic subtest pipe-D: SUCCESS (5.437s)
[720.207352] Starting dynamic subtest: all-pipes
[725.679266] Dynamic subtest all-pipes: SUCCESS (5.489s)
[725.680189] Subtest torture-move: SUCCESS (27.640s)
[725.741062] [107/142] (310s left) gem_wait (invalid-buf)
[725.846315] Starting subtest: invalid-buf
[725.847384] Subtest invalid-buf: SUCCESS (0.000s)
[726.103900] [108/142] (310s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[728.092808] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[728.094523] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[728.172846] [109/142] (308s left) gem_pxp (protected-raw-src-copy-not-readible)
[730.843382] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[730.889639] [110/142] (305s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[732.922229] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[732.923910] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[733.101115] [111/142] (303s left) gen9_exec_parse (batch-invalid-length)
[733.166926] Subtest batch-invalid-length: SKIP (0.000s)
[733.195179] [112/142] (303s left) kms_ccs (pipe-a-ccs-on-another-bo-yf_tiled_ccs)
[735.211090] Starting subtest: pipe-A-ccs-on-another-bo-yf_tiled_ccs
[735.212822] Subtest pipe-A-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[735.411828] [113/142] (301s left) gen7_exec_parse (basic-allocation)
[735.476045] Subtest basic-allocation: SKIP (0.000s)
[735.505561] [114/142] (301s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[737.459087] Starting subtest: cursor-vs-flip-toggle
[766.869285] Subtest cursor-vs-flip-toggle: SUCCESS (29.410s)
[766.990725] [115/142] (269s left) kms_vblank (pipe-b-ts-continuation-idle-hang)
[768.943904] Starting subtest: pipe-B-ts-continuation-idle-hang
[782.888111] Subtest pipe-B-ts-continuation-idle-hang: SUCCESS (13.945s)
[783.005965] [116/142] (253s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[784.971906] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[786.840795] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.871s)
[786.975594] [117/142] (249s left) i915_query (query-topology-known-pci-ids)
[787.036295] Starting subtest: query-topology-known-pci-ids
[787.037902] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[787.089370] [118/142] (249s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[789.049905] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[789.051506] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[789.141420] [119/142] (247s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[791.144507] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[791.146369] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[791.223823] [120/142] (245s left) kms_hdmi_inject (inject-audio)
[791.352598] Starting subtest: inject-audio
[791.451646] Subtest inject-audio: SUCCESS (0.099s)
[792.555305] [121/142] (244s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[794.526116] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[794.528880] Starting dynamic subtest: pipe-A-HDMI-A-3
[794.605434] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.078s)
[794.653083] Starting dynamic subtest: pipe-B-HDMI-A-3
[794.792131] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.147s)
[794.813865] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.288s)
[794.929379] [122/142] (241s left) vc4/vc4_perfmon (get-values-valid-perfmon)
[795.013064] Subtest get-values-valid-perfmon: SKIP (0.000s)
[795.062485] [123/142] (241s left) perf_pmu (busy-idle)
[795.126494] Starting subtest: busy-idle
[795.127472] Starting dynamic subtest: rcs0
[795.806901] Dynamic subtest rcs0: SUCCESS (0.679s)
[795.822547] Starting dynamic subtest: bcs0
[796.471238] Dynamic subtest bcs0: SUCCESS (0.662s)
[796.485657] Starting dynamic subtest: vcs0
[797.138410] Dynamic subtest vcs0: SUCCESS (0.664s)
[797.152894] Starting dynamic subtest: vcs1
[797.805225] Dynamic subtest vcs1: SUCCESS (0.664s)
[797.819675] Starting dynamic subtest: vecs0
[798.472229] Dynamic subtest vecs0: SUCCESS (0.664s)
[798.486568] Starting dynamic subtest: vecs1
[799.138433] Dynamic subtest vecs1: SUCCESS (0.664s)
[799.152841] Starting dynamic subtest: ccs0
[799.804373] Dynamic subtest ccs0: SUCCESS (0.663s)
[799.818849] Starting dynamic subtest: ccs1
[800.472234] Dynamic subtest ccs1: SUCCESS (0.665s)
[800.486455] Starting dynamic subtest: ccs2
[801.133198] Dynamic subtest ccs2: SUCCESS (0.658s)
[801.147827] Starting dynamic subtest: ccs3
[801.801350] Dynamic subtest ccs3: SUCCESS (0.665s)
[801.802959] Subtest busy-idle: SUCCESS (6.676s)
[801.871507] [124/142] (234s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[803.826038] Starting subtest: flip-vs-cursor-crc-legacy
[804.352897] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.526s)
[804.484247] [125/142] (232s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[806.441236] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[806.443805] Starting dynamic subtest: pipe-A-HDMI-A-3
[835.567578] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (29.125s)
[835.578327] Starting dynamic subtest: pipe-B-HDMI-A-3
[863.976113] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (28.407s)
[863.987116] Starting dynamic subtest: pipe-C-HDMI-A-3
[864.198746] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.221s)
[864.209410] Starting dynamic subtest: pipe-D-HDMI-A-3
[864.438280] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.238s)
[864.439122] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (57.998s)
[864.596722] [126/142] (172s left) gem_mmap_offset (perf)
[864.657521] Starting subtest: perf
[864.658346] Starting dynamic subtest: lmem0
[864.934182] Dynamic subtest lmem0: SUCCESS (0.276s)
[864.943731] Starting dynamic subtest: smem0
[864.948318] Dynamic subtest smem0: SUCCESS (0.002s)
[864.949181] Subtest perf: SUCCESS (0.280s)
[865.031296] [127/142] (171s left) i915_pm_rpm (gem-execbuf-stress)
[869.462797] Starting subtest: gem-execbuf-stress
[869.463880] Starting dynamic subtest: lmem0
[881.895355] Dynamic subtest lmem0: SUCCESS (12.434s)
[881.907439] Starting dynamic subtest: extra-wait-lmem0
[941.716252] Dynamic subtest extra-wait-lmem0: SUCCESS (59.784s)
[941.726501] Starting dynamic subtest: smem0
[956.177327] Dynamic subtest smem0: SUCCESS (14.494s)
[956.199812] Starting dynamic subtest: extra-wait-smem0
[1018.546151] Dynamic subtest extra-wait-smem0: SUCCESS (62.331s)
[1018.547932] Subtest gem-execbuf-stress: SUCCESS (149.051s)
[1019.611390] [128/142] ( 17s left) gem_exec_reloc (basic-write-wc-active)
[1019.677563] Subtest basic-write-wc-active: SKIP (0.000s)
[1019.722435] [129/142] ( 17s left) i915_pm_rpm (basic-rte)
[1019.785068] Starting subtest: basic-rte
[1026.688608] Subtest basic-rte: SUCCESS (6.902s)
[1030.266588] [130/142] (  6s left) gem_exec_params (sol-reset-not-gen7)
[1030.346513] Starting subtest: sol-reset-not-gen7
[1030.348580] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[1030.476602] [131/142] (  6s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[1032.468757] Starting subtest: yf-tiled-32bpp-rotate-90
[1032.470667] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[1032.551789] [132/142] (  4s left) v3d/v3d_wait_bo (used-bo-1ns)
[1032.682732] Subtest used-bo-1ns: SKIP (0.000s)
[1032.734518] [133/142] (  4s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[1034.708702] Starting subtest: fbc-rgb565-draw-mmap-gtt
[1034.710214] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[1034.783328] [134/142] (  2s left) kms_vblank (pipe-b-query-busy)
[1036.771787] Starting subtest: pipe-B-query-busy
[1039.305521] Subtest pipe-B-query-busy: SUCCESS (2.534s)
[1039.405786] Overall timeout time exceeded, stopping.
[1039.405983] Closing watchdogs
Done.