[47.694131] Initializing watchdogs
[47.694350]   /dev/watchdog0
[47.727751] [001/142] (960s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[48.098116] Starting subtest: basic-flip-before-cursor-legacy
[49.461980] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.375s)
[49.829128] [002/142] (958s left) kms_chamelium_frames (dp-crc-fast)
[50.241102] Subtest dp-crc-fast: SKIP (0.000s)
[50.547390] [003/142] (957s left) gem_exec_schedule (u-semaphore-noskip)
[50.952440] Starting subtest: u-semaphore-noskip
[51.056896] Subtest u-semaphore-noskip: SUCCESS (0.262s)
[51.438829] [004/142] (957s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[51.674569] Starting subtest: single-wait-all-for-submit-signaled
[51.695477] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[51.775293] [005/142] (956s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[52.061284] Starting subtest: primary-yf-tiled-reflect-x-180
[52.103479] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.002s)
[52.189238] [006/142] (956s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs)
[52.747670] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[53.071562] [007/142] (955s left) syncobj_basic (bad-pad-handle-to-fd)
[53.299833] Starting subtest: bad-pad-handle-to-fd
[53.319868] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[53.406290] [008/142] (955s left) i915_pm_freq_mult (media-freq)
[53.637841] Starting subtest: media-freq
[53.660273] Starting dynamic subtest: gt0
[53.700732] Dynamic subtest gt0: SKIP (0.000s)
[53.738182] Subtest media-freq: SKIP (0.001s)
[53.821270] [009/142] (955s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[54.110462] Starting subtest: cursorB-vs-flipA-atomic
[54.151412] Subtest cursorB-vs-flipA-atomic: SKIP (0.004s)
[54.231405] [010/142] (954s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[54.617311] Starting subtest: psr-rgb565-draw-pwrite
[54.654691] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[54.737512] [011/142] (954s left) kms_fbcon_fbt (fbc)
[54.951609] Starting subtest: fbc
[58.859126] Subtest fbc: SUCCESS (3.902s)
[58.940532] [012/142] (950s left) kms_cursor_crc (cursor-alpha-transparent)
[59.266055] Starting subtest: cursor-alpha-transparent
[59.286880] Starting dynamic subtest: pipe-A-DP-1
[59.806633] Dynamic subtest pipe-A-DP-1: SUCCESS (0.547s)
[59.848932] Starting dynamic subtest: pipe-C-DP-1
[60.454769] Dynamic subtest pipe-C-DP-1: SUCCESS (0.641s)
[60.480936] Subtest cursor-alpha-transparent: SUCCESS (1.194s)
[60.849149] [013/142] (948s left) gem_flink_basic (basic)
[61.112117] Starting subtest: basic
[61.136118] Subtest basic: SUCCESS (0.001s)
[61.244819] [014/142] (948s left) sw_sync (sync_multi_consumer)
[61.487304] Starting subtest: sync_multi_consumer
[62.661364] Subtest sync_multi_consumer: SUCCESS (1.195s)
[62.755213] [015/142] (946s left) gem_exec_whisper (basic-fds-all)
[63.035380] Starting subtest: basic-fds-all
[80.625114] Subtest basic-fds-all: SUCCESS (17.627s)
[80.842363] [016/142] (928s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[81.185302] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[82.310180] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.149s)
[82.671209] [017/142] (926s left) kms_cdclk (plane-scaling)
[82.923941] Subtest plane-scaling: SKIP (0.000s)
[83.007349] [018/142] (926s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[83.373770] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[83.411115] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[83.502965] [019/142] (926s left) kms_rotation_crc (cursor-rotation-180)
[83.791887] Starting subtest: cursor-rotation-180
[84.606107] Subtest cursor-rotation-180: SUCCESS (0.815s)
[85.053567] [020/142] (924s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[85.353875] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[85.372711] Starting dynamic subtest: pipe-A-DP-1
[85.679687] Dynamic subtest pipe-A-DP-1: SUCCESS (0.318s)
[85.718916] Starting dynamic subtest: pipe-B-DP-1
[86.072739] Dynamic subtest pipe-B-DP-1: SUCCESS (0.385s)
[86.113077] Starting dynamic subtest: pipe-C-DP-1
[86.178677] Dynamic subtest pipe-C-DP-1: SKIP (0.096s)
[86.198839] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.808s)
[86.574711] [021/142] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[86.950453] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[86.990689] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[87.072520] [022/142] (922s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[87.431672] Starting subtest: yf-tiled-8bpp-rotate-0
[87.469709] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[87.553559] [023/142] (922s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[87.987211] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[88.030112] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[88.435169] [024/142] (921s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[88.661123] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[88.682331] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[88.766597] [025/142] (921s left) perf_pmu (busy-accuracy-98)
[89.000985] Starting subtest: busy-accuracy-98
[89.020853] Starting dynamic subtest: rcs0
[92.051967] Dynamic subtest rcs0: SUCCESS (3.058s)
[92.086845] Starting dynamic subtest: bcs0
[95.111555] Dynamic subtest bcs0: SUCCESS (3.061s)
[95.146629] Starting dynamic subtest: vcs0
[98.163120] Dynamic subtest vcs0: SUCCESS (3.054s)
[98.198652] Starting dynamic subtest: vecs0
[101.218744] Dynamic subtest vecs0: SUCCESS (3.056s)
[101.239060] Subtest busy-accuracy-98: SUCCESS (12.230s)
[101.347587] [026/142] (908s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[101.571809] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[101.644139] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[101.745770] [027/142] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[102.117244] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[102.154586] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[102.242459] [028/142] (908s left) kms_plane (plane-position-hole-dpms)
[102.539148] Starting subtest: plane-position-hole-dpms
[102.558805] Starting dynamic subtest: pipe-A-planes
[104.660580] Dynamic subtest pipe-A-planes: SUCCESS (2.107s)
[104.700789] Starting dynamic subtest: pipe-B-planes
[107.013213] Dynamic subtest pipe-B-planes: SUCCESS (2.330s)
[107.039333] Subtest plane-position-hole-dpms: SUCCESS (4.443s)
[107.369627] [029/142] (903s left) gem_exec_balancer (nohangcheck)
[111.642937] Starting subtest: nohangcheck
[115.360711] Subtest nohangcheck: SUCCESS (3.719s)
[115.458479] [030/142] (895s left) i915_power (sanity)
[115.698210] Starting subtest: sanity
[119.723286] Subtest sanity: SUCCESS (4.022s)
[119.825631] [031/142] (890s left) syncobj_timeline (multi-wait-for-submit-signaled)
[120.060675] Starting subtest: multi-wait-for-submit-signaled
[120.085891] Subtest multi-wait-for-submit-signaled: SUCCESS (0.002s)
[120.187151] [032/142] (890s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[120.527443] Starting subtest: y-tiled-64bpp-rotate-0
[128.279270] Subtest y-tiled-64bpp-rotate-0: SUCCESS (7.774s)
[129.231369] [033/142] (881s left) api_intel_bb (object-noreloc-keep-cache-simple)
[129.468377] Starting subtest: object-noreloc-keep-cache-simple
[129.489402] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.009s)
[129.573785] [034/142] (881s left) gem_unfence_active_buffers
[130.074117] [035/142] (881s left) gem_basic (create-fd-close)
[130.298697] Starting subtest: create-fd-close
[130.342088] Subtest create-fd-close: SUCCESS (0.000s)
[130.428179] [036/142] (880s left) api_intel_bb (simple-bb)
[130.658254] Starting subtest: simple-bb
[130.679049] Subtest simple-bb: SUCCESS (0.010s)
[130.768658] [037/142] (880s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[131.058701] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[131.081662] Starting dynamic subtest: pipe-A-DP-1
[131.381081] Dynamic subtest pipe-A-DP-1: SUCCESS (0.303s)
[131.419350] Starting dynamic subtest: pipe-B-DP-1
[131.743134] Dynamic subtest pipe-B-DP-1: SUCCESS (0.375s)
[131.777461] Starting dynamic subtest: pipe-C-DP-1
[131.862431] Dynamic subtest pipe-C-DP-1: SKIP (0.093s)
[131.884202] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.780s)
[132.274754] [038/142] (879s left) kms_vblank (pipe-c-ts-continuation-modeset-rpm)
[132.576054] Starting subtest: pipe-C-ts-continuation-modeset-rpm
[134.743702] Subtest pipe-C-ts-continuation-modeset-rpm: SUCCESS (2.172s)
[135.166187] [039/142] (876s left) gem_unref_active_buffers
[135.641918] [040/142] (875s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[135.939427] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[135.961666] Starting dynamic subtest: pipe-A-valid-mode
[136.068427] Dynamic subtest pipe-A-valid-mode: SKIP (0.105s)
[136.106908] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.108s)
[136.415759] [041/142] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[136.786282] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[136.829487] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[136.916939] [042/142] (874s left) kms_flip (flip-vs-rmfb)
[137.217388] Starting subtest: flip-vs-rmfb
[137.236107] Starting dynamic subtest: A-DP1
[147.712688] Dynamic subtest A-DP1: SUCCESS (10.513s)
[147.748595] Starting dynamic subtest: B-DP1
[158.163432] Dynamic subtest B-DP1: SUCCESS (10.437s)
[158.206704] Starting dynamic subtest: C-DP1
[168.584550] Dynamic subtest C-DP1: SUCCESS (10.426s)
[168.605153] Subtest flip-vs-rmfb: SUCCESS (31.388s)
[169.041842] [043/142] (842s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[169.346499] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[169.374570] Starting dynamic subtest: pipe-A-valid-mode
[169.487621] Dynamic subtest pipe-A-valid-mode: SKIP (0.100s)
[169.529096] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.104s)
[169.789899] [044/142] (842s left) gem_wait (invalid-buf)
[170.023055] Starting subtest: invalid-buf
[170.044646] Subtest invalid-buf: SUCCESS (0.000s)
[170.301680] [045/142] (841s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[170.663454] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[170.703357] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[170.790567] [046/142] (841s left) gen9_exec_parse (bb-secure)
[171.026871] Starting subtest: bb-secure
[171.045761] Subtest bb-secure: SUCCESS (0.003s)
[171.271576] [047/142] (840s left) gem_create (create-ext-placement-all)
[171.624110] Starting subtest: create-ext-placement-all
[171.643113] Subtest create-ext-placement-all: SUCCESS (0.000s)
[171.758228] [048/142] (840s left) drm_fdinfo (idle)
[171.996607] Starting subtest: idle
[172.016670] Starting dynamic subtest: rcs0
[172.480558] Dynamic subtest rcs0: SUCCESS (0.504s)
[172.515895] Starting dynamic subtest: bcs0
[173.003202] Dynamic subtest bcs0: SUCCESS (0.504s)
[173.036581] Starting dynamic subtest: vcs0
[173.491831] Dynamic subtest vcs0: SUCCESS (0.504s)
[173.527859] Starting dynamic subtest: vecs0
[173.998520] Dynamic subtest vecs0: SUCCESS (0.505s)
[174.017500] Subtest idle: SUCCESS (2.025s)
[174.103401] [049/142] (838s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[174.421722] Starting subtest: cursor-rapid-movement-512x170
[174.462408] Subtest cursor-rapid-movement-512x170: SKIP (0.003s)
[174.548977] [050/142] (837s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[174.785124] Starting subtest: multi-wait-all-for-submit-unsubmitted
[174.860030] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[174.973967] [051/142] (837s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[175.200581] Starting subtest: multi-wait-for-submit-unsubmitted
[175.278802] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[175.384824] [052/142] (837s left) kms_lease (lease_again)
[175.689635] Starting subtest: lease_again
[175.711721] Starting dynamic subtest: pipe-A-DP-1
[175.733232] Dynamic subtest pipe-A-DP-1: SUCCESS (0.004s)
[175.769112] Starting dynamic subtest: pipe-B-DP-1
[175.789291] Dynamic subtest pipe-B-DP-1: SUCCESS (0.003s)
[175.823082] Starting dynamic subtest: pipe-C-DP-1
[175.842027] Dynamic subtest pipe-C-DP-1: SUCCESS (0.003s)
[175.860688] Subtest lease_again: SUCCESS (0.021s)
[175.953912] [053/142] (836s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[176.305926] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[176.344821] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[176.438392] [054/142] (836s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[176.744253] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[176.781916] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.003s)
[176.873936] [055/142] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[177.247962] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[177.292473] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[177.384957] [056/142] (835s left) kms_vblank (pipe-d-accuracy-idle)
[177.699447] Subtest pipe-D-accuracy-idle: SKIP (0.000s)
[177.870697] [057/142] (835s left) perf (create-destroy-userspace-config)
[178.270880] Starting subtest: create-destroy-userspace-config
[178.362491] Subtest create-destroy-userspace-config: SUCCESS (0.093s)
[178.452118] [058/142] (834s left) gem_exec_fence (syncobj-channel)
[179.202660] Starting subtest: syncobj-channel
[180.291836] Subtest syncobj-channel: SUCCESS (1.069s)
[180.636236] [059/142] (832s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[181.017968] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[181.057586] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[181.142710] [060/142] (832s left) kms_concurrent (pipe-b)
[181.445203] Starting subtest: pipe-B
[181.466899] Starting dynamic subtest: DP-1
[182.313585] Dynamic subtest DP-1: SUCCESS (0.837s)
[182.333065] Subtest pipe-B: SUCCESS (0.841s)
[182.638211] [061/142] (830s left) kms_pm_lpsp (screens-disabled)
[183.968528] Starting subtest: screens-disabled
[184.005730] Subtest screens-disabled: SKIP (0.000s)
[184.148356] [062/142] (829s left) gem_linear_blits (basic)
[185.645357] Starting subtest: basic
[185.665165] Subtest basic: SUCCESS (0.018s)
[185.832239] [063/142] (827s left) kms_color (ctm-0-75)
[186.373084] Starting subtest: ctm-0-75
[186.397028] Starting dynamic subtest: pipe-A
[188.880431] Dynamic subtest pipe-A: SUCCESS (2.495s)
[188.928612] Starting dynamic subtest: pipe-B
[191.575584] Dynamic subtest pipe-B: SUCCESS (2.682s)
[191.628817] Starting dynamic subtest: pipe-C
[194.171735] Dynamic subtest pipe-C: SUCCESS (2.609s)
[194.191539] Subtest ctm-0-75: SUCCESS (7.794s)
[194.531510] [064/142] (819s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[194.844458] Starting subtest: cursor-vs-flip-varying-size
[236.439651] Subtest cursor-vs-flip-varying-size: SUCCESS (41.588s)
[236.772247] [065/142] (776s left) gem_exec_fence (parallel)
[237.134990] Starting subtest: parallel
[237.153699] Starting dynamic subtest: rcs0
[239.470176] Dynamic subtest rcs0: SUCCESS (2.156s)
[239.508132] Starting dynamic subtest: bcs0
[241.455427] Dynamic subtest bcs0: SUCCESS (2.160s)
[241.494457] Starting dynamic subtest: vcs0
[243.611702] Dynamic subtest vcs0: SUCCESS (2.150s)
[243.650990] Starting dynamic subtest: vecs0
[245.938198] Dynamic subtest vecs0: SUCCESS (2.153s)
[245.956892] Subtest parallel: SUCCESS (8.630s)
[246.469660] [066/142] (767s left) kms_psr (sprite_blt)
[246.728599] Subtest sprite_blt: SKIP (0.000s)
[246.823270] [067/142] (767s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[247.054263] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[247.096356] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[247.270087] [068/142] (766s left) kms_cursor_crc (cursor-sliding-512x512)
[247.598483] Starting subtest: cursor-sliding-512x512
[247.639161] Subtest cursor-sliding-512x512: SKIP (0.003s)
[247.727076] [069/142] (766s left) gem_ctx_persistence (engines-mixed-process)
[247.968615] Starting subtest: engines-mixed-process
[247.987828] Starting dynamic subtest: rcs0
[248.323442] Dynamic subtest rcs0: SUCCESS (0.369s)
[248.361516] Starting dynamic subtest: bcs0
[248.697523] Dynamic subtest bcs0: SUCCESS (0.357s)
[248.736049] Starting dynamic subtest: vcs0
[249.064959] Dynamic subtest vcs0: SUCCESS (0.363s)
[249.104428] Starting dynamic subtest: vecs0
[250.244533] Dynamic subtest vecs0: SUCCESS (1.176s)
[250.265835] Subtest engines-mixed-process: SUCCESS (2.276s)
[250.355674] [070/142] (763s left) kms_atomic (crtc-invalid-params-fence)
[250.769578] Starting subtest: crtc-invalid-params-fence
[250.953152] Subtest crtc-invalid-params-fence: SUCCESS (0.183s)
[251.398734] [071/142] (762s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[251.765399] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[251.803854] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[251.898746] [072/142] (762s left) kms_vblank (pipe-d-wait-idle)
[252.224101] Subtest pipe-D-wait-idle: SKIP (0.000s)
[252.392645] [073/142] (761s left) v3d/v3d_submit_cl (bad-bo)
[252.717626] Subtest bad-bo: SKIP (0.000s)
[252.831888] [074/142] (761s left) kms_getfb (getfb-handle-not-fb)
[253.073897] Starting subtest: getfb-handle-not-fb
[253.136325] Subtest getfb-handle-not-fb: SUCCESS (0.093s)
[253.278748] [075/142] (761s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_mc_ccs)
[253.784113] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs
[253.825707] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[254.171528] [076/142] (760s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[254.669819] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[254.712503] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[255.046551] [077/142] (759s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs)
[255.600493] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[255.931902] [078/142] (758s left) kms_vblank (pipe-c-query-forked)
[256.231435] Starting subtest: pipe-C-query-forked
[258.895905] Subtest pipe-C-query-forked: SUCCESS (2.656s)
[259.245501] [079/142] (755s left) kms_hdr (bpc-switch)
[259.549498] Starting subtest: bpc-switch
[261.845990] Starting dynamic subtest: pipe-A-DP-1
[262.967864] Dynamic subtest pipe-A-DP-1: SUCCESS (1.117s)
[262.989019] Subtest bpc-switch: SUCCESS (3.420s)
[263.346796] [080/142] (751s left) gem_exec_flush (basic-wb-prw-default)
[263.626177] Starting subtest: basic-wb-prw-default
[269.226667] Subtest basic-wb-prw-default: SUCCESS (5.480s)
[269.339625] [081/142] (745s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[269.620484] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[269.707880] [082/142] (745s left) gem_eio (wait-wedge-1us)
[269.990205] Starting subtest: wait-wedge-1us
[270.036284] Subtest wait-wedge-1us: SUCCESS (0.086s)
[270.244734] [083/142] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[270.630825] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[270.668239] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[270.765907] [084/142] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[271.119876] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[271.161600] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[271.257662] [085/142] (744s left) gen7_exec_parse (oacontrol-tracking)
[271.513958] Subtest oacontrol-tracking: SKIP (0.000s)
[271.602515] [086/142] (743s left) gem_pipe_control_store_loop (reused-buffer)
[271.839617] Starting subtest: reused-buffer
[274.142757] Subtest reused-buffer: SUCCESS (2.156s)
[274.236631] [087/142] (741s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[274.665141] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[274.708801] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.005s)
[275.133407] [088/142] (740s left) kms_psr (psr2_primary_mmap_gtt)
[275.377816] Subtest psr2_primary_mmap_gtt: SKIP (0.000s)
[275.471894] [089/142] (740s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[275.687654] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[275.709847] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[275.801269] [090/142] (740s left) gem_lmem_swapping (massive)
[276.054089] Subtest massive: SKIP (0.000s)
[276.140922] [091/142] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[276.523856] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[276.561375] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[276.654786] [092/142] (739s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[277.049566] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[277.098069] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[277.209980] [093/142] (739s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[277.687610] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[277.743814] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[278.103916] [094/142] (738s left) kms_flip (plain-flip-ts-check-interruptible)
[278.434510] Starting subtest: plain-flip-ts-check-interruptible
[278.455352] Starting dynamic subtest: A-DP1
[289.388319] Dynamic subtest A-DP1: SUCCESS (10.794s)
[289.429022] Starting dynamic subtest: B-DP1
[299.932413] Dynamic subtest B-DP1: SUCCESS (10.710s)
[299.973193] Starting dynamic subtest: C-DP1
[310.848998] Dynamic subtest C-DP1: SUCCESS (10.729s)
[310.869777] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.247s)
[311.081682] [095/142] (705s left) kms_getfb (getfb-handle-zero)
[311.308034] Starting subtest: getfb-handle-zero
[311.329665] Subtest getfb-handle-zero: SUCCESS (0.000s)
[311.421883] [096/142] (705s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs)
[311.969262] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[312.307399] [097/142] (704s left) kms_psr (psr2_cursor_plane_onoff)
[312.554785] Subtest psr2_cursor_plane_onoff: SKIP (0.000s)
[312.650977] [098/142] (704s left) gem_mmap_gtt (cpuset-big-copy-odd)
[312.881431] Starting subtest: cpuset-big-copy-odd
[336.253321] Subtest cpuset-big-copy-odd: SUCCESS (23.387s)
[336.376874] [099/142] (680s left) kms_color (ctm-blue-to-red)
[336.864897] Starting subtest: ctm-blue-to-red
[336.883830] Starting dynamic subtest: pipe-A
[337.403411] Dynamic subtest pipe-A: SUCCESS (0.544s)
[337.441903] Starting dynamic subtest: pipe-B
[338.116968] Dynamic subtest pipe-B: SUCCESS (0.692s)
[338.157588] Starting dynamic subtest: pipe-C
[338.834489] Dynamic subtest pipe-C: SUCCESS (0.717s)
[338.857404] Subtest ctm-blue-to-red: SUCCESS (1.960s)
[339.199864] [100/142] (677s left) gem_exec_schedule (preempt-contexts)
[339.626280] Starting subtest: preempt-contexts
[339.645288] Starting dynamic subtest: rcs0
[339.664291] Dynamic subtest rcs0: SUCCESS (0.127s)
[339.704650] Starting dynamic subtest: bcs0
[339.766383] Dynamic subtest bcs0: SUCCESS (0.148s)
[339.811636] Starting dynamic subtest: vcs0
[339.878455] Dynamic subtest vcs0: SUCCESS (0.119s)
[339.917249] Starting dynamic subtest: vecs0
[340.001127] Dynamic subtest vecs0: SUCCESS (0.120s)
[340.022481] Subtest preempt-contexts: SUCCESS (0.525s)
[340.393925] [101/142] (676s left) kms_vblank (pipe-a-wait-busy-hang)
[340.702719] Starting subtest: pipe-A-wait-busy-hang
[347.621115] Subtest pipe-A-wait-busy-hang: SUCCESS (6.797s)
[347.862592] [102/142] (669s left) sw_sync (alloc_fence)
[348.076141] Starting subtest: alloc_fence
[348.096811] Subtest alloc_fence: SUCCESS (0.000s)
[348.189294] [103/142] (668s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[348.713412] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[348.754609] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[349.077552] [104/142] (668s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[349.442781] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[349.483356] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[349.580522] [105/142] (667s left) gem_exec_balancer (parallel-contexts)
[353.848854] Subtest parallel-contexts: SKIP (0.000s)
[353.939147] [106/142] (663s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[354.307725] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[355.588744] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.320s)
[355.862282] [107/142] (661s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[356.102686] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[356.121698] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[356.209629] [108/142] (661s left) gem_mmap (basic-small-bo)
[356.450972] Starting subtest: basic-small-bo
[357.505926] Subtest basic-small-bo: SUCCESS (1.090s)
[357.660129] [109/142] (660s left) kms_ccs (pipe-a-bad-pixel-format-yf_tiled_ccs)
[358.143302] Starting subtest: pipe-A-bad-pixel-format-yf_tiled_ccs
[358.169707] Subtest pipe-A-bad-pixel-format-yf_tiled_ccs: SUCCESS (0.001s)
[358.728672] [110/142] (659s left) vc4/vc4_wait_bo (used-bo)
[359.034979] Subtest used-bo: SKIP (0.000s)
[359.122777] [111/142] (658s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[359.545541] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[359.593146] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[360.005741] [112/142] (657s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[360.333951] Starting subtest: addfb25-y-tiled-small-legacy
[360.358176] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[360.468222] [113/142] (657s left) kms_flip (2x-plain-flip-ts-check)
[360.783093] Starting subtest: 2x-plain-flip-ts-check
[360.822279] Subtest 2x-plain-flip-ts-check: SKIP (0.003s)
[360.913647] [114/142] (657s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[361.240699] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[361.281790] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s)
[361.369580] [115/142] (656s left) perf (invalid-open-flags)
[361.735515] Starting subtest: invalid-open-flags
[361.754467] Subtest invalid-open-flags: SUCCESS (0.001s)
[361.869306] [116/142] (656s left) gem_mmap_offset (clear)
[362.107174] Starting subtest: clear
[362.132131] Starting dynamic subtest: smem0
[385.568389] Dynamic subtest smem0: SUCCESS (23.455s)
[385.587295] Subtest clear: SUCCESS (23.458s)
[386.369881] [117/142] (632s left) gem_pxp (reject-modify-context-protection-off-2)
[389.281350] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[389.435331] [118/142] (629s left) gem_vm_create (create-ext)
[389.668878] Starting subtest: create-ext
[389.690233] Subtest create-ext: SUCCESS (0.005s)
[389.784477] [119/142] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[390.173605] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[390.213382] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[390.302821] [120/142] (628s left) kms_cursor_legacy (single-move)
[390.601459] Starting subtest: single-move
[390.623099] Starting dynamic subtest: pipe-A
[396.197303] Dynamic subtest pipe-A: SUCCESS (5.408s)
[396.237721] Starting dynamic subtest: pipe-B
[401.436774] Dynamic subtest pipe-B: SUCCESS (5.406s)
[401.477023] Starting dynamic subtest: pipe-C
[406.844617] Dynamic subtest pipe-C: SUCCESS (5.406s)
[406.886799] Starting dynamic subtest: all-pipes
[412.249687] Dynamic subtest all-pipes: SUCCESS (5.408s)
[412.268654] Subtest single-move: SUCCESS (21.638s)
[412.363912] [121/142] (606s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_mc_ccs)
[412.917551] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[413.250277] [122/142] (605s left) gem_softpin (allocator-fork)
[413.493673] Starting subtest: allocator-fork
[416.014608] Subtest allocator-fork: SUCCESS (2.377s)
[416.109171] [123/142] (602s left) gem_mmap_gtt (basic)
[416.341822] Starting subtest: basic
[416.363307] Subtest basic: SUCCESS (0.001s)
[416.459256] [124/142] (602s left) kms_plane_alpha_blend (alpha-transparent-fb)
[416.762790] Starting subtest: alpha-transparent-fb
[417.108256] Starting dynamic subtest: pipe-A-DP-1
[422.829844] Dynamic subtest pipe-A-DP-1: FAIL (4.354s)
[422.875737] Starting dynamic subtest: pipe-C-DP-1
[428.787651] Dynamic subtest pipe-C-DP-1: FAIL (5.047s)
[428.806508] Subtest alpha-transparent-fb: FAIL (9.761s)
[428.905433] [125/142] (590s left) gem_mmap_gtt (basic-small-copy-odd)
[429.132478] Starting subtest: basic-small-copy-odd
[432.309915] Subtest basic-small-copy-odd: SUCCESS (3.208s)
[432.426242] [126/142] (586s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[432.962764] Starting subtest: x-tiled-8bpp-rotate-270
[433.070034] Subtest x-tiled-8bpp-rotate-270: SKIP (0.085s)
[433.170841] [127/142] (586s left) v3d/v3d_perfmon (create-perfmon-0)
[433.477154] Subtest create-perfmon-0: SKIP (0.000s)
[433.585104] [128/142] (585s left) gem_ctx_sseu (invalid-sseu)
[433.837938] Subtest invalid-sseu: SKIP (0.000s)
[433.954251] [129/142] (585s left) gem_ppgtt (flink-and-close-vma-leak)
[434.197702] Starting subtest: flink-and-close-vma-leak
[434.218763] Subtest flink-and-close-vma-leak: SUCCESS (0.010s)
[434.317564] [130/142] (585s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[434.624709] Starting subtest: flip-vs-cursor-crc-legacy
[435.473661] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.844s)
[435.842876] [131/142] (583s left) gem_ctx_persistence (engines-hang)
[436.073938] Starting subtest: engines-hang
[436.095652] Starting dynamic subtest: rcs0
[436.117300] Dynamic subtest rcs0: SUCCESS (0.043s)
[436.158283] Starting dynamic subtest: bcs0
[436.198133] Dynamic subtest bcs0: SKIP (0.004s)
[436.236966] Starting dynamic subtest: vcs0
[436.255518] Dynamic subtest vcs0: SUCCESS (0.048s)
[436.294098] Starting dynamic subtest: vecs0
[436.315454] Dynamic subtest vecs0: SUCCESS (0.036s)
[436.336825] Subtest engines-hang: SUCCESS (0.144s)
[436.431629] [132/142] (583s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[436.709468] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[436.798690] [133/142] (583s left) perf_pmu (most-busy-idle-check-all)
[437.021500] Starting subtest: most-busy-idle-check-all
[437.040286] Starting dynamic subtest: rcs0
[437.634496] Dynamic subtest rcs0: SUCCESS (0.633s)
[437.680114] Starting dynamic subtest: bcs0
[438.264084] Dynamic subtest bcs0: SUCCESS (0.627s)
[438.305828] Starting dynamic subtest: vcs0
[438.894582] Dynamic subtest vcs0: SUCCESS (0.630s)
[438.939647] Starting dynamic subtest: vecs0
[439.528196] Dynamic subtest vecs0: SUCCESS (0.619s)
[439.547309] Subtest most-busy-idle-check-all: SUCCESS (2.519s)
[439.660657] [134/142] (580s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[440.031675] Starting subtest: fbcpsr-tiling-4
[440.072479] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[440.171129] [135/142] (580s left) gem_render_copy_redux (normal)
[440.424320] Starting subtest: normal
[442.887560] Subtest normal: SUCCESS (2.324s)
[442.977537] [136/142] (577s left) i915_pm_rpm (i2c)
[444.775196] Starting subtest: i2c
[446.358565] Subtest i2c: SUCCESS (1.573s)
[446.565108] [137/142] (573s left) sysfs_preempt_timeout (timeout)
[446.812589] Starting subtest: timeout
[446.832812] Starting dynamic subtest: vecs0
[447.708926] Dynamic subtest vecs0: SUCCESS (0.887s)
[447.751375] Starting dynamic subtest: vcs0
[448.616510] Dynamic subtest vcs0: SUCCESS (0.898s)
[448.656896] Starting dynamic subtest: bcs0
[449.483724] Dynamic subtest bcs0: SUCCESS (0.876s)
[449.525027] Starting dynamic subtest: rcs0
[450.378130] Dynamic subtest rcs0: SUCCESS (0.892s)
[450.399698] Subtest timeout: SUCCESS (3.566s)
[450.496638] [138/142] (569s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[450.971312] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[451.014261] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[451.391946] [139/142] (569s left) kms_vblank (pipe-b-ts-continuation-modeset)
[451.701633] Starting subtest: pipe-B-ts-continuation-modeset
[452.649870] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.934s)
[452.976840] [140/142] (567s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[453.427062] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[453.467714] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[453.861242] [141/142] (566s left) gem_ccs (block-copy-compressed)
[454.116050] Subtest block-copy-compressed: SKIP (0.000s)
[454.213454] [142/142] (566s left) gem_exec_schedule (lateslice)
[454.610131] Starting subtest: lateslice
[454.631845] Starting dynamic subtest: rcs0
[454.652583] Dynamic subtest rcs0: SUCCESS (0.028s)
[454.694113] Starting dynamic subtest: bcs0
[454.712981] Dynamic subtest bcs0: SUCCESS (0.028s)
[454.751642] Starting dynamic subtest: vcs0
[454.770389] Dynamic subtest vcs0: SUCCESS (0.025s)
[454.808850] Starting dynamic subtest: vecs0
[454.830489] Dynamic subtest vecs0: SUCCESS (0.025s)
[454.852092] Subtest lateslice: SUCCESS (0.119s)
[454.938378] Closing watchdogs
Done.