[63.550077] Initializing watchdogs
[63.550430]   /dev/watchdog0
[63.566661] [001/137] (960s left) gem_pxp (reject-modify-context-protection-off-1)
[66.320861] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[66.402978] [002/137] (957s left) kms_cursor_crc (cursor-onscreen-32x10)
[66.715910] Starting subtest: cursor-onscreen-32x10
[66.835334] Subtest cursor-onscreen-32x10: SKIP (0.116s)
[66.951606] [003/137] (957s left) gem_exec_reloc (basic-write-cpu)
[67.177377] Starting subtest: basic-write-cpu
[67.202760] Subtest basic-write-cpu: SUCCESS (0.025s)
[67.384905] [004/137] (956s left) gem_mmap_gtt (isolation)
[67.594504] Starting subtest: isolation
[67.600691] Subtest isolation: SUCCESS (0.004s)
[67.684832] [005/137] (956s left) syncobj_wait (wait-all-interrupted)
[67.892432] Starting subtest: wait-all-interrupted
[67.999720] Subtest wait-all-interrupted: SUCCESS (0.106s)
[68.084602] [006/137] (956s left) kms_selftest (all-tests)
[68.290897] Starting subtest: all-tests
[68.294948] Subtest all-tests: SKIP (0.000s)
[68.350728] [007/137] (955s left) i915_pm_rc6_residency (rc6-idle)
[68.553823] Starting subtest: rc6-idle
[68.562281] Starting dynamic subtest: rcs0
[80.834187] Dynamic subtest rcs0: SUCCESS (12.272s)
[80.847957] Starting dynamic subtest: bcs0
[93.103237] Dynamic subtest bcs0: SUCCESS (12.269s)
[93.116930] Starting dynamic subtest: vcs0
[105.373997] Dynamic subtest vcs0: SUCCESS (12.270s)
[105.388175] Starting dynamic subtest: vecs0
[117.642535] Dynamic subtest vecs0: SUCCESS (12.268s)
[117.644787] Subtest rc6-idle: SUCCESS (49.090s)
[117.935919] [008/137] (906s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[118.159760] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[118.162436] Starting dynamic subtest: smem
[118.586360] Dynamic subtest smem: SUCCESS (0.426s)
[118.588862] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.427s)
[118.786705] [009/137] (905s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-fully-sf)
[118.993818] Subtest overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[119.036337] [010/137] (905s left) kms_psr (psr2_dpms)
[119.241279] Subtest psr2_dpms: SKIP (0.000s)
[119.284547] [011/137] (905s left) gem_eio (in-flight-suspend)
[119.517853] Starting subtest: in-flight-suspend
[158.593337] Subtest in-flight-suspend: SUCCESS (8.019s)
[163.805857] [012/137] (896s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[164.214116] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[164.486708] [013/137] (896s left) gem_mmap_gtt (cpuset-big-copy-odd)
[164.685018] Starting subtest: cpuset-big-copy-odd
[188.414914] Subtest cpuset-big-copy-odd: SUCCESS (23.731s)
[188.854348] [014/137] (871s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-0-25)
[189.283245] Starting subtest: planes-downscale-factor-0-5-upscale-0-25
[189.285388] Starting dynamic subtest: pipe-A-DP-1
[189.616546] Dynamic subtest pipe-A-DP-1: SUCCESS (0.320s)
[189.649887] Starting dynamic subtest: pipe-B-DP-1
[189.977725] Dynamic subtest pipe-B-DP-1: SUCCESS (0.370s)
[190.009326] Starting dynamic subtest: pipe-C-DP-1
[190.095713] Dynamic subtest pipe-C-DP-1: SKIP (0.106s)
[190.098023] Subtest planes-downscale-factor-0-5-upscale-0-25: SUCCESS (0.815s)
[190.510479] [015/137] (870s left) gem_userptr_blits (stress-mm-invalidate-close)
[190.773784] Starting subtest: stress-mm-invalidate-close
[192.923499] Subtest stress-mm-invalidate-close: SUCCESS (2.149s)
[193.052774] [016/137] (867s left) kms_rotation_crc (primary-rotation-90)
[193.354680] Starting subtest: primary-rotation-90
[199.490383] Subtest primary-rotation-90: SUCCESS (6.138s)
[199.899821] [017/137] (860s left) gem_ctx_persistence (legacy-engines-cleanup)
[200.114530] Starting subtest: legacy-engines-cleanup
[200.116978] Starting dynamic subtest: render
[200.155428] Dynamic subtest render: SUCCESS (0.040s)
[200.180336] Starting dynamic subtest: bsd
[200.188441] Dynamic subtest bsd: SUCCESS (0.032s)
[200.217146] Starting dynamic subtest: blt
[200.222297] Dynamic subtest blt: SUCCESS (0.032s)
[200.244704] Starting dynamic subtest: vebox
[200.246770] Dynamic subtest vebox: SUCCESS (0.024s)
[200.249181] Subtest legacy-engines-cleanup: SUCCESS (0.132s)
[200.331819] [018/137] (860s left) drm_buddy (all-tests)
[200.550694] Starting subtest: all-tests
[200.555136] Subtest all-tests: SKIP (0.000s)
[200.614287] [019/137] (860s left) kms_plane_cursor (viewport)
[200.914567] Starting subtest: viewport
[200.918967] Starting dynamic subtest: pipe-A-DP-1-size-64
[203.338445] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.421s)
[203.410957] Starting dynamic subtest: pipe-A-DP-1-size-128
[205.821848] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.433s)
[205.894035] Starting dynamic subtest: pipe-A-DP-1-size-256
[208.304703] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.432s)
[208.462056] Starting dynamic subtest: pipe-B-DP-1-size-64
[211.086261] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.645s)
[211.156068] Starting dynamic subtest: pipe-B-DP-1-size-128
[213.568935] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.433s)
[213.640183] Starting dynamic subtest: pipe-B-DP-1-size-256
[216.037024] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.416s)
[216.237077] Starting dynamic subtest: pipe-C-DP-1-size-64
[218.915458] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.698s)
[218.992922] Starting dynamic subtest: pipe-C-DP-1-size-128
[221.398551] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.430s)
[221.476142] Starting dynamic subtest: pipe-C-DP-1-size-256
[223.865092] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.415s)
[223.996926] Subtest viewport: SUCCESS (23.082s)
[224.313499] [020/137] (836s left) kms_cursor_crc (cursor-offscreen-32x10)
[224.629066] Starting subtest: cursor-offscreen-32x10
[224.739024] Subtest cursor-offscreen-32x10: SKIP (0.105s)
[224.848909] [021/137] (836s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[225.053205] Starting subtest: multi-wait-all-for-submit-signaled
[225.055333] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.002s)
[225.147429] [022/137] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[225.455083] Starting subtest: fbcpsr-2p-rte
[225.459001] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[225.546566] [023/137] (835s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[225.850544] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[228.026349] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (2.179s)
[228.514710] [024/137] (832s left) kms_vblank (pipe-b-ts-continuation-modeset)
[228.815584] Starting subtest: pipe-B-ts-continuation-modeset
[229.810164] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.996s)
[230.133152] [025/137] (830s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[230.346196] Starting subtest: tiled-to-untiled
[230.461023] Subtest tiled-to-untiled: SUCCESS (0.112s)
[230.583826] [026/137] (830s left) gem_exec_whisper (basic-contexts-forked)
[230.809444] Starting subtest: basic-contexts-forked
[247.666015] Subtest basic-contexts-forked: SUCCESS (16.854s)
[247.867354] [027/137] (813s left) gem_exec_reloc (basic-range-active)
[248.085421] Starting subtest: basic-range-active
[248.177059] Subtest basic-range-active: SUCCESS (0.092s)
[248.367422] [028/137] (812s left) sw_sync (sync_merge_same)
[248.567811] Starting subtest: sync_merge_same
[248.570110] Subtest sync_merge_same: SUCCESS (0.000s)
[248.633239] [029/137] (812s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[248.870166] Starting subtest: stress-mm-invalidate-close-overlap
[251.019508] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.149s)
[251.168033] [030/137] (810s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[251.479220] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[251.483272] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[251.592563] [031/137] (809s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[251.898270] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[251.901133] Starting dynamic subtest: pipe-A-valid-mode
[251.991843] Dynamic subtest pipe-A-valid-mode: SKIP (0.091s)
[251.997550] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.094s)
[252.303410] [032/137] (809s left) syncobj_timeline (single-wait-all-available-signaled)
[252.504438] Starting subtest: single-wait-all-available-signaled
[252.506736] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[252.602540] [033/137] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[252.924096] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[252.928412] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[253.021552] [034/137] (808s left) kms_vblank (pipe-b-wait-idle)
[253.326072] Starting subtest: pipe-B-wait-idle
[255.985593] Subtest pipe-B-wait-idle: SUCCESS (2.662s)
[256.326381] [035/137] (805s left) gem_eio (wait-10ms)
[256.546914] Starting subtest: wait-10ms
[256.632448] Subtest wait-10ms: SUCCESS (0.089s)
[256.807836] [036/137] (804s left) api_intel_bb (render-ccs)
[257.007875] Starting subtest: render-ccs
[257.333912] Subtest render-ccs: SUCCESS (0.326s)
[257.458461] [037/137] (804s left) kms_chamelium_audio (dp-audio)
[257.851232] Subtest dp-audio: SKIP (0.000s)
[258.147617] [038/137] (803s left) kms_cursor_crc (cursor-sliding-256x85)
[258.452217] Starting subtest: cursor-sliding-256x85
[258.466889] Starting dynamic subtest: pipe-A-DP-1
[262.299627] Dynamic subtest pipe-A-DP-1: SUCCESS (3.834s)
[262.380111] Starting dynamic subtest: pipe-C-DP-1
[266.342420] Dynamic subtest pipe-C-DP-1: SUCCESS (3.982s)
[266.344589] Subtest cursor-sliding-256x85: SUCCESS (7.889s)
[266.695235] [039/137] (794s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[267.018261] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[267.027389] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.004s)
[267.109601] [040/137] (794s left) gem_exec_params (invalid-ring2)
[267.317745] Starting subtest: invalid-ring2
[267.320365] Subtest invalid-ring2: SUCCESS (0.001s)
[267.426234] [041/137] (794s left) perf (gen8-unprivileged-single-ctx-counters)
[267.776090] Starting subtest: gen8-unprivileged-single-ctx-counters
[267.989700] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.213s)
[268.043872] [042/137] (793s left) gem_exec_schedule (out-order)
[268.279076] Starting subtest: out-order
[268.281737] Starting dynamic subtest: rcs0
[268.421447] Dynamic subtest rcs0: SUCCESS (0.140s)
[268.449631] Starting dynamic subtest: bcs0
[268.572913] Dynamic subtest bcs0: SUCCESS (0.151s)
[268.599409] Starting dynamic subtest: vcs0
[268.703257] Dynamic subtest vcs0: SUCCESS (0.130s)
[268.728890] Starting dynamic subtest: vecs0
[268.838180] Dynamic subtest vecs0: SUCCESS (0.134s)
[268.840509] Subtest out-order: SUCCESS (0.559s)
[269.193032] [043/137] (792s left) gem_mmap (basic-small-bo)
[269.392697] Starting subtest: basic-small-bo
[270.500416] Subtest basic-small-bo: SUCCESS (1.108s)
[270.620871] [044/137] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[271.061206] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[271.065058] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[271.159843] [045/137] (790s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[271.483166] Starting subtest: 4-tiled-8bpp-rotate-180
[271.487424] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[271.595223] [046/137] (790s left) gem_render_copy_redux (flink-interruptible)
[271.824266] Starting subtest: flink-interruptible
[276.528167] Subtest flink-interruptible: SUCCESS (4.704s)
[276.643831] [047/137] (785s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[276.942739] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[276.945078] Starting dynamic subtest: pipe-A-DP-1
[277.581691] Dynamic subtest pipe-A-DP-1: SUCCESS (0.637s)
[277.613866] Starting dynamic subtest: pipe-B-DP-1
[278.506248] Dynamic subtest pipe-B-DP-1: SUCCESS (0.921s)
[278.531067] Starting dynamic subtest: pipe-C-DP-1
[278.861175] Dynamic subtest pipe-C-DP-1: SUCCESS (0.351s)
[278.863612] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (1.921s)
[279.264394] [048/137] (782s left) prime_mmap (test_correct)
[279.503416] Starting subtest: test_correct
[279.505536] Starting dynamic subtest: test_correct-smem
[279.510897] Dynamic subtest test_correct-smem: SUCCESS (0.008s)
[279.513142] Subtest test_correct: SUCCESS (0.009s)
[279.612292] [049/137] (782s left) i915_module_load (reload)
[279.806886] Starting subtest: reload
[283.154537] Subtest reload: SUCCESS (3.348s)
[283.206634] [050/137] (778s left) prime_busy (hang)
[283.578028] Starting subtest: hang
[283.584048] Starting dynamic subtest: rcs0
[289.959531] Dynamic subtest rcs0: SUCCESS (6.376s)
[289.984132] Starting dynamic subtest: bcs0
[296.933717] Dynamic subtest bcs0: SUCCESS (6.972s)
[296.955121] Starting dynamic subtest: vcs0
[303.972711] Dynamic subtest vcs0: SUCCESS (7.037s)
[303.994041] Starting dynamic subtest: vecs0
[310.949992] Dynamic subtest vecs0: SUCCESS (6.975s)
[310.952409] Subtest hang: SUCCESS (27.370s)
[311.032138] [051/137] (751s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[311.475101] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[311.479701] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[312.069411] [052/137] (750s left) gem_mmap_gtt (basic-wc)
[312.273870] Starting subtest: basic-wc
[312.903087] Subtest basic-wc: SUCCESS (0.631s)
[313.018630] [053/137] (749s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[313.334754] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[315.978065] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.647s)
[316.102430] [054/137] (746s left) gem_ctx_shared (detached-shared-gtt)
[316.333540] Starting subtest: detached-shared-gtt
[318.488480] Subtest detached-shared-gtt: SUCCESS (2.152s)
[318.838353] [055/137] (743s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs)
[319.472068] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs
[319.476116] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[319.849621] [056/137] (742s left) v3d/v3d_wait_bo (used-bo-1ns)
[320.109103] Subtest used-bo-1ns: SKIP (0.000s)
[320.182683] [057/137] (742s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_ccs)
[320.699331] Starting subtest: pipe-B-bad-rotation-90-y_tiled_ccs
[321.331072] Subtest pipe-B-bad-rotation-90-y_tiled_ccs: SUCCESS (0.631s)
[321.960537] [058/137] (740s left) gem_softpin (allocator-evict)
[322.177110] Starting subtest: allocator-evict
[322.179356] Starting dynamic subtest: rcs0
[356.998411] Dynamic subtest rcs0: SUCCESS (34.820s)
[357.021471] Starting dynamic subtest: bcs0
[393.663385] Dynamic subtest bcs0: SUCCESS (36.661s)
[393.685873] Starting dynamic subtest: vcs0
[430.126370] Dynamic subtest vcs0: SUCCESS (36.464s)
[430.151078] Starting dynamic subtest: vecs0
[466.793759] Dynamic subtest vecs0: SUCCESS (36.664s)
[466.796126] Subtest allocator-evict: SUCCESS (144.615s)
[466.881093] [059/137] (595s left) kms_addfb_basic (clobberred-modifier)
[467.183987] Starting subtest: clobberred-modifier
[467.187628] Subtest clobberred-modifier: SUCCESS (0.001s)
[467.426909] [060/137] (595s left) gem_exec_capture (pi)
[467.639774] Starting subtest: pi
[467.642971] Starting dynamic subtest: rcs0
[498.535733] Dynamic subtest rcs0: SUCCESS (30.897s)
[498.559559] Starting dynamic subtest: bcs0
[528.042061] Dynamic subtest bcs0: SUCCESS (29.505s)
[528.065824] Starting dynamic subtest: vcs0
[557.502172] Dynamic subtest vcs0: SUCCESS (29.460s)
[557.526431] Starting dynamic subtest: vecs0
[586.921679] Dynamic subtest vecs0: SUCCESS (29.418s)
[586.924236] Subtest pi: SUCCESS (119.284s)
[587.014379] [061/137] (475s left) v3d/v3d_get_bo_offset (create-get-offsets)
[587.401738] Subtest create-get-offsets: SKIP (0.000s)
[587.477064] [062/137] (475s left) i915_pm_rpm (pm-caching)
[589.534778] Starting subtest: pm-caching
[591.240087] Subtest pm-caching: SUCCESS (1.705s)
[591.687808] [063/137] (471s left) gem_exec_fence (long-history)
[592.342327] Starting subtest: long-history
[598.075267] Subtest long-history: SUCCESS (5.733s)
[598.747413] [064/137] (464s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[599.074111] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[600.552738] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.476s)
[600.736352] [065/137] (462s left) v3d/v3d_submit_csd (bad-multisync-in-sync)
[601.004650] Subtest bad-multisync-in-sync: SKIP (0.000s)
[601.079204] [066/137] (461s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[601.390972] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[603.784256] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.398s)
[603.913428] [067/137] (458s left) drm_mm (all-tests)
[604.111301] Starting subtest: all-tests
[604.115822] Subtest all-tests: SKIP (0.000s)
[604.180386] [068/137] (458s left) kms_atomic (plane-cursor-legacy)
[604.595364] Starting subtest: plane-cursor-legacy
[604.661717] Subtest plane-cursor-legacy: SUCCESS (0.067s)
[605.087904] [069/137] (457s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[605.308237] Starting subtest: y-tiled-ccs-to-x-tiled
[605.313640] Starting dynamic subtest: smem
[605.599840] Dynamic subtest smem: SUCCESS (0.288s)
[605.602164] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.291s)
[605.804832] [070/137] (457s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf_tiled_ccs)
[606.527695] Subtest pipe-D-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[606.831049] [071/137] (456s left) kms_frontbuffer_tracking (psr-1p-rte)
[607.176772] Starting subtest: psr-1p-rte
[607.180809] Subtest psr-1p-rte: SKIP (0.000s)
[607.281171] [072/137] (455s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[607.576873] Starting subtest: 2x-flip-vs-cursor-legacy
[607.581158] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.005s)
[607.664739] [073/137] (455s left) vgem_basic (second-client)
[607.869891] Starting subtest: second-client
[607.918382] Subtest second-client: SUCCESS (0.049s)
[607.997540] [074/137] (455s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[608.293414] Starting subtest: cursorB-vs-flipB-atomic
[608.297531] Subtest cursorB-vs-flipB-atomic: SKIP (0.003s)
[608.380920] [075/137] (454s left) kms_lease (multimaster-lease)
[608.684971] Starting subtest: multimaster-lease
[608.691977] Subtest multimaster-lease: SUCCESS (0.008s)
[608.781043] [076/137] (454s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[608.984929] Starting subtest: etime-multi-wait-for-submit-submitted
[609.089212] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[609.181610] [077/137] (454s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs)
[609.789095] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs
[610.313167] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.524s)
[610.866202] [078/137] (452s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[611.181129] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[611.185082] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[611.283202] [079/137] (452s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[611.604374] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[611.609212] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[611.716444] [080/137] (451s left) gen9_exec_parse (bb-start-param)
[611.939485] Starting subtest: bb-start-param
[611.946167] Subtest bb-start-param: SUCCESS (0.006s)
[612.184998] [081/137] (451s left) gem_eio (in-flight-internal-10ms)
[612.420056] Starting subtest: in-flight-internal-10ms
[612.530891] Subtest in-flight-internal-10ms: SUCCESS (0.112s)
[612.715323] [082/137] (450s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[613.028858] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[613.032861] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[613.133329] [083/137] (450s left) gem_spin_batch (resubmit-new-all)
[613.354704] Starting subtest: resubmit-new-all
[613.357155] Starting dynamic subtest: rcs0
[613.373284] Dynamic subtest rcs0: SUCCESS (0.016s)
[613.406912] Starting dynamic subtest: bcs0
[613.409148] Dynamic subtest bcs0: SUCCESS (0.018s)
[613.435705] Starting dynamic subtest: vcs0
[613.437753] Dynamic subtest vcs0: SUCCESS (0.013s)
[613.462379] Starting dynamic subtest: vecs0
[613.464495] Dynamic subtest vecs0: SUCCESS (0.013s)
[613.466527] Subtest resubmit-new-all: SUCCESS (0.066s)
[613.650870] [084/137] (450s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[613.991618] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[613.995708] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[614.100113] [085/137] (449s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[614.427424] Starting subtest: y-tiled-32bpp-rotate-270
[619.354826] Subtest y-tiled-32bpp-rotate-270: SUCCESS (4.926s)
[619.887997] [086/137] (443s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[620.206369] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[620.210357] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[620.416745] [087/137] (443s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[620.736659] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[620.740702] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[620.900251] [088/137] (442s left) kms_async_flips (async-flip-with-page-flip-events)
[621.199994] Starting subtest: async-flip-with-page-flip-events
[621.202062] Starting dynamic subtest: pipe-A-DP-1
[623.956781] Dynamic subtest pipe-A-DP-1: SUCCESS (2.758s)
[623.983831] Starting dynamic subtest: pipe-B-DP-1
[626.647279] Dynamic subtest pipe-B-DP-1: SUCCESS (2.687s)
[626.672717] Starting dynamic subtest: pipe-C-DP-1
[629.266608] Dynamic subtest pipe-C-DP-1: SUCCESS (2.616s)
[629.268838] Subtest async-flip-with-page-flip-events: SUCCESS (8.071s)
[629.863607] [089/137] (434s left) api_intel_allocator (reopen-fork)
[630.067106] Starting subtest: reopen-fork
[633.347089] Subtest reopen-fork: SUCCESS (3.281s)
[633.447071] [090/137] (430s left) vc4/vc4_wait_bo (bad-pad)
[633.703748] Subtest bad-pad: SKIP (0.000s)
[633.780864] [091/137] (430s left) gem_workarounds (suspend-resume-context)
[634.009442] Starting subtest: suspend-resume-context
[651.532185] Subtest suspend-resume-context: SUCCESS (1.246s)
[657.684780] [092/137] (428s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[658.080083] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[658.371627] [093/137] (427s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[658.667938] Starting subtest: basic-flip-after-cursor-varying-size
[659.717793] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.055s)
[660.063754] [094/137] (426s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[660.357987] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[679.999481] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (19.643s)
[680.349817] [095/137] (406s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[680.663652] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[680.667626] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[680.763441] [096/137] (405s left) perf (invalid-remove-userspace-config)
[681.106713] Starting subtest: invalid-remove-userspace-config
[681.145635] Subtest invalid-remove-userspace-config: SUCCESS (0.038s)
[681.196781] [097/137] (405s left) gem_exec_balancer (parallel-bb-first)
[685.187023] Subtest parallel-bb-first: SKIP (0.000s)
[685.297395] [098/137] (401s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[685.499486] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[685.562838] [099/137] (401s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[685.872608] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[685.876515] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[685.980425] [100/137] (400s left) kms_flip (flip-vs-suspend-interruptible)
[686.278902] Starting subtest: flip-vs-suspend-interruptible
[686.285402] Starting dynamic subtest: A-DP1
[739.592447] Dynamic subtest A-DP1: SUCCESS (3.987s)
[739.621095] Starting dynamic subtest: B-DP1
[791.560338] Dynamic subtest B-DP1: SUCCESS (3.976s)
[791.613406] Starting dynamic subtest: C-DP1
[843.557749] Dynamic subtest C-DP1: SUCCESS (3.921s)
[843.559862] Subtest flip-vs-suspend-interruptible: SUCCESS (11.903s)
[850.643921] [101/137] (388s left) i915_pm_rps (min-max-config-loaded)
[850.864242] Starting subtest: min-max-config-loaded
[851.240395] Subtest min-max-config-loaded: SUCCESS (0.378s)
[851.344449] [102/137] (387s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[851.992058] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[851.996241] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[852.363333] [103/137] (386s left) gem_exec_schedule (u-submit-late-slice)
[852.591581] Starting subtest: u-submit-late-slice
[852.593872] Starting dynamic subtest: rcs0
[852.653497] Dynamic subtest rcs0: SUCCESS (0.060s)
[852.686128] Starting dynamic subtest: bcs0
[852.709533] Dynamic subtest bcs0: SUCCESS (0.054s)
[852.742463] Starting dynamic subtest: vcs0
[852.763408] Dynamic subtest vcs0: SUCCESS (0.053s)
[852.796875] Starting dynamic subtest: vecs0
[852.814586] Dynamic subtest vecs0: SUCCESS (0.051s)
[852.816833] Subtest u-submit-late-slice: SUCCESS (0.223s)
[853.164353] [104/137] (385s left) gem_wait (write-busy)
[853.400858] Starting subtest: write-busy
[853.403309] Starting dynamic subtest: all-engines
[853.930137] Dynamic subtest all-engines: SUCCESS (0.528s)
[853.960214] Starting dynamic subtest: rcs0
[854.448957] Dynamic subtest rcs0: SUCCESS (0.517s)
[854.478111] Starting dynamic subtest: bcs0
[854.972045] Dynamic subtest bcs0: SUCCESS (0.523s)
[855.001169] Starting dynamic subtest: vcs0
[855.491966] Dynamic subtest vcs0: SUCCESS (0.519s)
[855.520830] Starting dynamic subtest: vecs0
[856.011703] Dynamic subtest vecs0: SUCCESS (0.519s)
[856.013727] Subtest write-busy: SUCCESS (2.611s)
[856.264741] [105/137] (382s left) gem_pread (display)
[856.467803] Starting subtest: display
[861.296813] Subtest display: SUCCESS (4.829s)
[861.414010] [106/137] (377s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[861.740849] Starting subtest: yf-tiled-16bpp-rotate-0
[865.615270] Subtest yf-tiled-16bpp-rotate-0: SUCCESS (3.875s)
[865.948989] [107/137] (373s left) gem_exec_async (forked-writes)
[866.182991] Starting subtest: forked-writes
[866.185399] Starting dynamic subtest: rcs0
[866.264417] Dynamic subtest rcs0: SUCCESS (0.079s)
[866.295252] Starting dynamic subtest: bcs0
[866.342267] Dynamic subtest bcs0: SUCCESS (0.077s)
[866.371293] Starting dynamic subtest: vcs0
[866.423246] Dynamic subtest vcs0: SUCCESS (0.079s)
[866.451749] Starting dynamic subtest: vecs0
[866.498207] Dynamic subtest vecs0: SUCCESS (0.073s)
[866.501654] Subtest forked-writes: SUCCESS (0.315s)
[866.731358] [108/137] (372s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[867.288116] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[867.297603] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[867.790223] [109/137] (371s left) sysfs_heartbeat_interval (invalid)
[868.002230] Starting subtest: invalid
[868.008302] Starting dynamic subtest: vecs0
[868.010778] Dynamic subtest vecs0: SUCCESS (0.001s)
[868.037111] Starting dynamic subtest: vcs0
[868.039292] Dynamic subtest vcs0: SUCCESS (0.001s)
[868.065331] Starting dynamic subtest: bcs0
[868.067481] Dynamic subtest bcs0: SUCCESS (0.001s)
[868.093841] Starting dynamic subtest: rcs0
[868.095843] Dynamic subtest rcs0: SUCCESS (0.001s)
[868.097792] Subtest invalid: SUCCESS (0.011s)
[868.134112] [110/137] (371s left) perf (non-zero-reason)
[868.429740] Starting subtest: non-zero-reason
[868.432263] Starting dynamic subtest: 0-rcs0
[903.259444] Dynamic subtest 0-rcs0: SUCCESS (34.827s)
[903.261542] Subtest non-zero-reason: SUCCESS (34.828s)
[903.325906] [111/137] (335s left) kms_vblank (pipe-d-ts-continuation-idle)
[903.627240] Subtest pipe-D-ts-continuation-idle: SKIP (0.000s)
[903.724103] [112/137] (335s left) kms_atomic_transition (plane-all-transition)
[904.016948] Starting subtest: plane-all-transition
[904.026481] Starting dynamic subtest: pipe-A-DP-1
[907.974858] Dynamic subtest pipe-A-DP-1: SUCCESS (3.954s)
[908.132182] Starting dynamic subtest: pipe-B-DP-1
[912.441408] Dynamic subtest pipe-B-DP-1: SUCCESS (4.346s)
[912.545791] Subtest plane-all-transition: SUCCESS (8.523s)
[912.879497] [113/137] (326s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[913.629190] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[913.919600] [114/137] (325s left) perf_pmu (most-busy-idle-check-all)
[914.126472] Starting subtest: most-busy-idle-check-all
[914.128660] Starting dynamic subtest: rcs0
[914.752805] Dynamic subtest rcs0: SUCCESS (0.625s)
[914.783174] Starting dynamic subtest: bcs0
[915.380742] Dynamic subtest bcs0: SUCCESS (0.624s)
[915.411183] Starting dynamic subtest: vcs0
[916.014799] Dynamic subtest vcs0: SUCCESS (0.633s)
[916.045305] Starting dynamic subtest: vecs0
[916.649437] Dynamic subtest vecs0: SUCCESS (0.633s)
[916.652268] Subtest most-busy-idle-check-all: SUCCESS (2.521s)
[916.752441] [115/137] (322s left) gem_create (create-size-update)
[916.951564] Starting subtest: create-size-update
[916.953974] Subtest create-size-update: SUCCESS (0.000s)
[917.186783] [116/137] (322s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[917.487166] Starting subtest: primary-y-tiled-reflect-x-270
[917.491273] Subtest primary-y-tiled-reflect-x-270: SKIP (0.003s)
[917.586196] [117/137] (321s left) gem_exercise_blt (fast-copy-emit)
[917.794230] Starting subtest: fast-copy-emit
[917.797036] Starting dynamic subtest: linear-smem-smem-emit
[917.854122] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.057s)
[917.879561] Starting dynamic subtest: ymajor-smem-smem-emit
[917.906513] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.050s)
[917.931965] Starting dynamic subtest: yfmajor-smem-smem-emit
[917.954714] Dynamic subtest yfmajor-smem-smem-emit: SUCCESS (0.048s)
[917.980729] Starting dynamic subtest: tile64-smem-smem-emit
[918.008468] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.049s)
[918.010794] Subtest fast-copy-emit: SUCCESS (0.212s)
[918.120623] [118/137] (321s left) gem_ctx_isolation (preservation-s3)
[918.349332] Starting subtest: preservation-S3
[918.351558] Starting dynamic subtest: rcs0
[937.044621] Dynamic subtest rcs0: SUCCESS (2.363s)
[937.071719] Starting dynamic subtest: bcs0
[956.107245] Dynamic subtest bcs0: SUCCESS (2.587s)
[956.134367] Starting dynamic subtest: vcs0
[974.976931] Dynamic subtest vcs0: SUCCESS (2.196s)
[975.005534] Starting dynamic subtest: vecs0
[993.974333] Dynamic subtest vecs0: SUCCESS (2.418s)
[993.976396] Subtest preservation-S3: SUCCESS (9.572s)
[998.295601] [119/137] (311s left) kms_flip (dpms-off-confusion)
[998.587918] Starting subtest: dpms-off-confusion
[998.590111] Starting dynamic subtest: A-DP1
[1009.134339] Dynamic subtest A-DP1: SUCCESS (10.546s)
[1009.162614] Starting dynamic subtest: B-DP1
[1019.594088] Dynamic subtest B-DP1: SUCCESS (10.457s)
[1019.622346] Starting dynamic subtest: C-DP1
[1030.054747] Dynamic subtest C-DP1: SUCCESS (10.458s)
[1030.056879] Subtest dpms-off-confusion: SUCCESS (31.471s)
[1030.479456] [120/137] (279s left) syncobj_wait (invalid-reset-zero-handles)
[1030.687470] Starting subtest: invalid-reset-zero-handles
[1030.689926] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[1030.775655] [121/137] (279s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[1030.976874] Starting subtest: single-wait-for-submit-unsubmitted
[1031.082062] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[1031.176188] [122/137] (278s left) kms_cursor_legacy (forked-move)
[1031.486897] Starting subtest: forked-move
[1031.489225] Starting dynamic subtest: pipe-A
[1053.049117] Dynamic subtest pipe-A: SUCCESS (21.561s)
[1053.079024] Starting dynamic subtest: pipe-B
[1074.617287] Dynamic subtest pipe-B: SUCCESS (21.567s)
[1074.644290] Starting dynamic subtest: pipe-C
[1096.192935] Dynamic subtest pipe-C: SUCCESS (21.573s)
[1096.221445] Starting dynamic subtest: all-pipes
[1117.757130] Dynamic subtest all-pipes: SUCCESS (21.564s)
[1117.759324] Subtest forked-move: SUCCESS (86.270s)
[1117.861610] [123/137] (192s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted)
[1118.063944] Starting subtest: invalid-multi-wait-available-unsubmitted
[1118.066605] Subtest invalid-multi-wait-available-unsubmitted: SUCCESS (0.000s)
[1118.158420] [124/137] (191s left) gem_softpin (evict-snoop-interruptible)
[1118.367636] Starting subtest: evict-snoop-interruptible
[1118.371917] Subtest evict-snoop-interruptible: SKIP (0.000s)
[1118.458376] [125/137] (191s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[1118.714664] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[1118.792944] [126/137] (191s left) kms_getfb (getfb2-handle-protection)
[1118.995240] Starting subtest: getfb2-handle-protection
[1119.027084] Subtest getfb2-handle-protection: SUCCESS (0.033s)
[1119.142368] [127/137] (190s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[1119.444306] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[1120.565007] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.124s)
[1120.907806] [128/137] (189s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[1121.227661] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[1121.235719] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.004s)
[1121.355665] [129/137] (188s left) kms_addfb_basic (bo-too-small)
[1121.668439] Starting subtest: bo-too-small
[1121.670576] Subtest bo-too-small: SUCCESS (0.001s)
[1121.772776] [130/137] (188s left) kms_flip (busy-flip)
[1122.061766] Starting subtest: busy-flip
[1122.064179] Starting dynamic subtest: A-DP1
[1123.092070] Dynamic subtest A-DP1: SUCCESS (1.029s)
[1123.120846] Starting dynamic subtest: B-DP1
[1124.084768] Dynamic subtest B-DP1: SUCCESS (0.988s)
[1124.111600] Starting dynamic subtest: C-DP1
[1125.073388] Dynamic subtest C-DP1: SUCCESS (0.986s)
[1125.075537] Subtest busy-flip: SUCCESS (3.014s)
[1125.490898] [131/137] (184s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[1125.965358] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[1125.970249] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[1126.511655] [132/137] (183s left) kms_chamelium_hpd (hdmi-hpd)
[1126.932280] Subtest hdmi-hpd: SKIP (0.000s)
[1127.224528] [133/137] (183s left) kms_flip (dpms-vs-vblank-race)
[1127.514688] Starting subtest: dpms-vs-vblank-race
[1127.517118] Starting dynamic subtest: A-DP1
[1131.758099] Dynamic subtest A-DP1: SUCCESS (4.241s)
[1131.786317] Starting dynamic subtest: B-DP1
[1135.974400] Dynamic subtest B-DP1: SUCCESS (4.217s)
[1136.005566] Starting dynamic subtest: C-DP1
[1140.221730] Dynamic subtest C-DP1: SUCCESS (4.240s)
[1140.223823] Subtest dpms-vs-vblank-race: SUCCESS (12.709s)
[1140.587337] [134/137] (169s left) gem_exec_parallel (userptr)
[1140.823485] Starting subtest: userptr
[1140.826466] Starting dynamic subtest: rcs0
[1144.424650] Dynamic subtest rcs0: SUCCESS (3.600s)
[1144.453411] Starting dynamic subtest: bcs0
[1148.188632] Dynamic subtest bcs0: SUCCESS (3.762s)
[1148.215677] Starting dynamic subtest: vcs0
[1151.920437] Dynamic subtest vcs0: SUCCESS (3.731s)
[1151.947496] Starting dynamic subtest: vecs0
[1155.382110] Dynamic subtest vecs0: SUCCESS (3.460s)
[1155.384094] Subtest userptr: SUCCESS (14.559s)
[1155.587215] [135/137] (154s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[1155.894978] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[1155.899011] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[1156.003246] [136/137] (154s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[1156.389976] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[1156.394928] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[1157.036971] [137/137] (153s left) kms_plane_scaling (invalid-num-scalers)
[1157.341636] Starting subtest: invalid-num-scalers
[1157.343824] Starting dynamic subtest: pipe-A-DP-1-invalid-num-scalers
[1157.348163] Dynamic subtest pipe-A-DP-1-invalid-num-scalers: SKIP (0.002s)
[1157.376107] Starting dynamic subtest: pipe-B-DP-1-invalid-num-scalers
[1157.380172] Dynamic subtest pipe-B-DP-1-invalid-num-scalers: SKIP (0.002s)
[1157.406183] Starting dynamic subtest: pipe-C-DP-1-invalid-num-scalers
[1157.410108] Dynamic subtest pipe-C-DP-1-invalid-num-scalers: SKIP (0.001s)
[1157.414001] Subtest invalid-num-scalers: SKIP (0.019s)
[1157.465775] Closing watchdogs
Done.