[49.310930] Initializing watchdogs
[49.311514]   /dev/watchdog0
[49.343321] [001/142] (960s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[49.733901] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[49.842060] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[50.002627] [002/142] (959s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_mc_ccs)
[51.505345] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs
[52.028687] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs: SUCCESS (0.520s)
[52.825098] [003/142] (957s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[53.916191] Starting subtest: pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs
[53.922596] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[54.635184] [004/142] (955s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[55.487464] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[56.303516] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.815s)
[57.603825] [005/142] (952s left) gem_mmap_gtt (big-copy-odd)
[57.736805] Subtest big-copy-odd: SKIP (0.000s)
[57.774436] [006/142] (952s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[58.823292] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[58.829671] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[59.316339] [007/142] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[59.811372] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[59.818117] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[59.959274] [008/142] (950s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[61.336046] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[61.341916] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[62.343477] [009/142] (947s left) syncobj_timeline (device-submit-unordered)
[62.714542] Starting subtest: device-submit-unordered
[62.718250] Subtest device-submit-unordered: SUCCESS (0.002s)
[62.836438] [010/142] (947s left) sw_sync (sync_merge_invalid)
[63.193809] Starting subtest: sync_merge_invalid
[63.210711] Subtest sync_merge_invalid: SUCCESS (0.015s)
[63.324125] [011/142] (947s left) gem_exec_flush (basic-wb-set-default)
[63.753743] Starting subtest: basic-wb-set-default
[69.610129] Subtest basic-wb-set-default: SUCCESS (5.858s)
[69.904250] [012/142] (940s left) gem_ctx_sseu (mmap-args)
[70.293939] Subtest mmap-args: SKIP (0.000s)
[70.411093] [013/142] (940s left) kms_cursor_crc (cursor-sliding-64x64)
[71.182625] Starting subtest: cursor-sliding-64x64
[71.206496] Starting dynamic subtest: pipe-A-eDP-1
[77.278568] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.070s)
[77.367192] Starting dynamic subtest: pipe-D-eDP-1
[82.871115] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.536s)
[82.874757] Subtest cursor-sliding-64x64: SUCCESS (11.692s)
[84.042565] [014/142] (926s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25)
[84.528445] Starting subtest: plane-upscale-with-rotation-factor-0-25
[84.535841] Starting dynamic subtest: pipe-A-eDP-1
[85.492634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.958s)
[85.533680] Starting dynamic subtest: pipe-B-eDP-1
[87.789840] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.290s)
[87.832876] Starting dynamic subtest: pipe-C-eDP-1
[90.083448] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.285s)
[90.119487] Starting dynamic subtest: pipe-D-eDP-1
[92.288167] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.198s)
[92.292144] Subtest plane-upscale-with-rotation-factor-0-25: SUCCESS (7.762s)
[93.853382] [015/142] (916s left) gem_ctx_persistence (engines-cleanup)
[94.253832] Starting subtest: engines-cleanup
[94.257745] Starting dynamic subtest: rcs0
[94.315507] Dynamic subtest rcs0: SUCCESS (0.062s)
[94.351672] Starting dynamic subtest: bcs0
[94.362687] Dynamic subtest bcs0: SUCCESS (0.046s)
[94.396045] Starting dynamic subtest: vcs0
[94.415634] Dynamic subtest vcs0: SUCCESS (0.052s)
[94.450099] Starting dynamic subtest: vcs1
[94.466536] Dynamic subtest vcs1: SUCCESS (0.050s)
[94.498077] Starting dynamic subtest: vecs0
[94.513794] Dynamic subtest vecs0: SUCCESS (0.046s)
[94.547176] Starting dynamic subtest: ccs0
[94.550787] Dynamic subtest ccs0: SUCCESS (0.031s)
[94.554413] Subtest engines-cleanup: SUCCESS (0.293s)
[94.706991] [016/142] (916s left) gem_workarounds (suspend-resume-context)
[95.170360] Starting subtest: suspend-resume-context
[112.358676] Subtest suspend-resume-context: SUCCESS (17.188s)
[112.545785] [017/142] (898s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[113.051999] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[130.242753] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (17.196s)
[130.503892] [018/142] (880s left) gem_exec_parallel (userptr)
[130.924292] Starting subtest: userptr
[130.927835] Starting dynamic subtest: rcs0
[134.588429] Dynamic subtest rcs0: SUCCESS (3.667s)
[134.626562] Starting dynamic subtest: bcs0
[139.008441] Dynamic subtest bcs0: SUCCESS (4.417s)
[139.045162] Starting dynamic subtest: vcs0
[143.511943] Dynamic subtest vcs0: SUCCESS (4.500s)
[143.552658] Starting dynamic subtest: vcs1
[147.540274] Dynamic subtest vcs1: SUCCESS (4.026s)
[147.580184] Starting dynamic subtest: vecs0
[151.512988] Dynamic subtest vecs0: SUCCESS (3.970s)
[151.552054] Starting dynamic subtest: ccs0
[155.833412] Dynamic subtest ccs0: SUCCESS (4.320s)
[155.836998] Subtest userptr: SUCCESS (24.914s)
[156.160053] [019/142] (854s left) gem_tiled_fence_blits (basic)
[156.561280] Subtest basic: SKIP (0.000s)
[156.689322] [020/142] (854s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[157.205112] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[157.211766] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[157.367778] [021/142] (853s left) gem_set_tiling_vs_pwrite
[157.885870] [022/142] (853s left) prime_mmap (test_forked_cpu_write)
[158.255542] Starting subtest: test_forked_cpu_write
[158.259060] Starting dynamic subtest: test_forked_cpu_write-smem
[158.318816] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.065s)
[158.322398] Subtest test_forked_cpu_write: SUCCESS (0.067s)
[158.475240] [023/142] (852s left) kms_dp_aux_dev
[159.093530] [024/142] (852s left) v3d/v3d_get_bo_offset (get-bad-handle)
[159.569355] Subtest get-bad-handle: SKIP (0.000s)
[159.681436] [025/142] (851s left) feature_discovery (chamelium)
[160.181253] Starting subtest: chamelium
[160.187557] Subtest chamelium: SKIP (0.001s)
[160.326158] [026/142] (851s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[160.863069] Starting subtest: 4-tiled-8bpp-rotate-90
[160.923813] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.055s)
[161.101751] [027/142] (850s left) gem_eio (suspend)
[163.010869] Starting subtest: suspend
[177.397055] Subtest suspend: SUCCESS (14.385s)
[178.689927] [028/142] (833s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[179.961784] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[180.147053] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SUCCESS (0.184s)
[181.141770] [029/142] (830s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[182.169605] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[185.602220] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SUCCESS (3.433s)
[187.371579] [030/142] (824s left) perf_pmu (busy-hang)
[187.772733] Starting subtest: busy-hang
[187.776499] Starting dynamic subtest: rcs0
[190.306185] Dynamic subtest rcs0: SUCCESS (2.532s)
[190.353630] Starting dynamic subtest: bcs0
[192.741310] Dynamic subtest bcs0: SUCCESS (2.433s)
[192.787321] Starting dynamic subtest: vcs0
[197.071051] Dynamic subtest vcs0: SUCCESS (4.328s)
[197.118616] Starting dynamic subtest: vcs1
[201.031162] Dynamic subtest vcs1: SUCCESS (3.958s)
[201.076947] Starting dynamic subtest: vecs0
[205.069084] Dynamic subtest vecs0: SUCCESS (4.036s)
[205.114829] Starting dynamic subtest: ccs0
[207.365527] Dynamic subtest ccs0: SUCCESS (2.294s)
[207.369258] Subtest busy-hang: SUCCESS (19.594s)
[207.556703] [031/142] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[208.066135] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[208.072941] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[208.232428] [032/142] (803s left) gem_mmap_wc (bad-size)
[208.600129] Subtest bad-size: SKIP (0.000s)
[208.719676] [033/142] (803s left) kms_vblank (pipe-c-wait-forked-busy)
[209.191094] Starting subtest: pipe-C-wait-forked-busy
[213.266455] Subtest pipe-C-wait-forked-busy: SUCCESS (4.075s)
[214.204675] [034/142] (798s left) kms_hdmi_inject (inject-audio)
[214.978335] Starting subtest: inject-audio
[215.421773] Subtest inject-audio: SUCCESS (0.440s)
[216.378765] [035/142] (795s left) gem_userptr_blits (usage-restrictions)
[216.780166] Starting subtest: usage-restrictions
[216.783981] Subtest usage-restrictions: SUCCESS (0.000s)
[217.058759] [036/142] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[217.552758] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[227.720941] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (10.176s)
[228.003592] [037/142] (784s left) gem_ctx_freq (sysfs)
[228.414531] Starting subtest: sysfs
[228.417999] Starting dynamic subtest: gt0
[234.062157] Dynamic subtest gt0: SUCCESS (5.645s)
[234.120446] Starting dynamic subtest: gt1
[275.530083] Dynamic subtest gt1: SUCCESS (41.462s)
[275.533730] Subtest sysfs: SUCCESS (47.117s)
[275.713684] [038/142] (736s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs)
[277.016232] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs
[277.022761] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[278.101747] [039/142] (734s left) gem_exec_params (dr4-dirt)
[278.495417] Starting subtest: DR4-dirt
[278.499070] Subtest DR4-dirt: SUCCESS (0.001s)
[278.664884] [040/142] (734s left) i915_suspend (forcewake)
[279.032324] Starting subtest: forcewake
[313.288483] Subtest forcewake: SUCCESS (34.257s)
[313.450783] [041/142] (699s left) gem_flink_race (flink_close)
[313.816924] Starting subtest: flink_close
[318.895858] Subtest flink_close: SUCCESS (5.075s)
[319.073120] [042/142] (693s left) gem_userptr_blits (stress-purge)
[319.526987] Starting subtest: stress-purge
[324.925284] Subtest stress-purge: SUCCESS (5.399s)
[325.219075] [043/142] (687s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[325.883148] Starting subtest: psr-rgb565-draw-pwrite
[344.855470] Subtest psr-rgb565-draw-pwrite: SUCCESS (18.974s)
[345.138960] [044/142] (668s left) i915_pm_rpm (reg-read-ioctl)
[347.714412] Starting subtest: reg-read-ioctl
[355.330937] Subtest reg-read-ioctl: SUCCESS (7.616s)
[356.294495] [045/142] (657s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_mc_ccs)
[357.906802] Starting subtest: pipe-D-bad-rotation-90-y_tiled_gen12_mc_ccs
[357.912973] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[358.679306] [046/142] (654s left) prime_busy (after-wait)
[359.073656] Starting subtest: after-wait
[359.104469] Starting dynamic subtest: rcs0
[359.126151] Dynamic subtest rcs0: SUCCESS (0.022s)
[359.187772] Starting dynamic subtest: bcs0
[359.190958] Dynamic subtest bcs0: SUCCESS (0.047s)
[359.245469] Starting dynamic subtest: vcs0
[359.249370] Dynamic subtest vcs0: SUCCESS (0.042s)
[359.301792] Starting dynamic subtest: vcs1
[359.304807] Dynamic subtest vcs1: SUCCESS (0.023s)
[359.354142] Starting dynamic subtest: vecs0
[359.357527] Dynamic subtest vecs0: SUCCESS (0.026s)
[359.406815] Starting dynamic subtest: ccs0
[359.410322] Dynamic subtest ccs0: SUCCESS (0.024s)
[359.435519] Subtest after-wait: SUCCESS (0.363s)
[359.592560] [047/142] (653s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs)
[360.979450] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs
[360.986105] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[362.009460] [048/142] (651s left) drm_read (short-buffer-block)
[362.837647] Starting subtest: short-buffer-block
[362.841391] Subtest short-buffer-block: SUCCESS (0.000s)
[363.090672] [049/142] (650s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[363.568560] Starting subtest: primary-4-tiled-reflect-x-0
[378.508389] Subtest primary-4-tiled-reflect-x-0: SUCCESS (14.943s)
[380.090174] [050/142] (633s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[380.567960] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[380.574273] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[380.735609] [051/142] (633s left) gem_exec_balancer (smoke)
[381.155956] Starting subtest: smoke
[408.552250] Subtest smoke: SUCCESS (27.394s)
[410.294534] [052/142] (603s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[411.948415] Starting subtest: pipe-D-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[412.115864] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SUCCESS (0.168s)
[412.808232] [053/142] (601s left) kms_big_fb (linear-8bpp-rotate-0)
[413.371722] Starting subtest: linear-8bpp-rotate-0
[417.490435] Subtest linear-8bpp-rotate-0: SUCCESS (4.116s)
[417.741297] [054/142] (596s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[418.151490] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[418.157706] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[418.443541] [055/142] (595s left) gem_exec_whisper (basic-contexts-forked)
[418.869149] Starting subtest: basic-contexts-forked
[457.229259] Subtest basic-contexts-forked: SUCCESS (38.355s)
[457.494820] [056/142] (556s left) gem_pipe_control_store_loop (fresh-buffer)
[457.882189] Starting subtest: fresh-buffer
[460.046887] Subtest fresh-buffer: SUCCESS (2.163s)
[460.235798] [057/142] (554s left) gem_userptr_blits (sync-unmap)
[460.702995] Starting subtest: sync-unmap
[460.796602] Subtest sync-unmap: SUCCESS (0.093s)
[461.058195] [058/142] (553s left) kms_lease (lease_revoke)
[461.551116] Starting subtest: lease_revoke
[461.560505] Starting dynamic subtest: pipe-A-eDP-1
[461.678914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.123s)
[461.720940] Starting dynamic subtest: pipe-B-eDP-1
[461.788728] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.103s)
[461.835796] Starting dynamic subtest: pipe-C-eDP-1
[461.922564] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.127s)
[461.977449] Starting dynamic subtest: pipe-D-eDP-1
[462.039853] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.105s)
[462.044841] Subtest lease_revoke: SUCCESS (0.493s)
[462.220342] [059/142] (552s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[462.761460] Starting subtest: y-tiled-8bpp-rotate-0
[462.769748] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[462.956989] [060/142] (551s left) gem_wait (invalid-buf)
[463.348928] Starting subtest: invalid-buf
[463.352657] Subtest invalid-buf: SUCCESS (0.000s)
[463.772174] [061/142] (551s left) kms_flip (basic-flip-vs-modeset)
[464.174461] Starting subtest: basic-flip-vs-modeset
[464.209349] Starting dynamic subtest: A-eDP1
[467.552942] Dynamic subtest A-eDP1: SUCCESS (3.348s)
[467.622771] Starting dynamic subtest: B-eDP1
[470.002483] Dynamic subtest B-eDP1: SUCCESS (2.440s)
[470.053142] Starting dynamic subtest: C-eDP1
[472.450900] Dynamic subtest C-eDP1: SUCCESS (2.445s)
[472.513688] Starting dynamic subtest: D-eDP1
[474.897764] Dynamic subtest D-eDP1: SUCCESS (2.440s)
[474.917438] Subtest basic-flip-vs-modeset: SUCCESS (10.746s)
[475.872195] [062/142] (539s left) v3d/v3d_mmap (mmap-bad-handle)
[476.360148] Subtest mmap-bad-handle: SKIP (0.000s)
[476.500853] [063/142] (538s left) drm_fdinfo (isolation)
[476.886268] Starting subtest: isolation
[476.889600] Starting dynamic subtest: rcs0
[476.896325] Dynamic subtest rcs0: SKIP (0.001s)
[476.955495] Starting dynamic subtest: bcs0
[476.962272] Dynamic subtest bcs0: SKIP (0.001s)
[477.018766] Starting dynamic subtest: vcs0
[477.025199] Dynamic subtest vcs0: SKIP (0.001s)
[477.078305] Starting dynamic subtest: vcs1
[477.084739] Dynamic subtest vcs1: SKIP (0.001s)
[477.138864] Starting dynamic subtest: vecs0
[477.145508] Dynamic subtest vecs0: SKIP (0.001s)
[477.198662] Starting dynamic subtest: ccs0
[477.205218] Dynamic subtest ccs0: SKIP (0.001s)
[477.211527] Subtest isolation: SKIP (0.029s)
[477.285214] [064/142] (537s left) kms_plane_alpha_blend (alpha-7efc)
[477.722402] Starting subtest: alpha-7efc
[479.461600] Starting dynamic subtest: pipe-A-eDP-1
[480.640732] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.182s)
[480.839744] Starting dynamic subtest: pipe-D-eDP-1
[483.079432] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.291s)
[483.083496] Subtest alpha-7efc: SUCCESS (5.358s)
[484.047582] [065/142] (531s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[484.533893] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[484.549657] Starting dynamic subtest: pipe-A-default-mode
[488.174319] Dynamic subtest pipe-A-default-mode: SUCCESS (3.626s)
[488.177874] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (3.640s)
[489.136505] [066/142] (526s left) kms_getfb (getfb2-handle-protection)
[489.512509] Starting subtest: getfb2-handle-protection
[489.575954] Subtest getfb2-handle-protection: SUCCESS (0.066s)
[489.764150] [067/142] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[490.274362] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[490.281312] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[490.453301] [068/142] (525s left) gem_exec_suspend (basic-s4-devices)
[490.886298] Starting subtest: basic-S4-devices
[490.889439] Starting dynamic subtest: smem
[510.538875] Dynamic subtest smem: SUCCESS (19.649s)
[510.543187] Subtest basic-S4-devices: SUCCESS (19.654s)
[511.861417] [069/142] (504s left) vgem_basic (bad-fence)
[512.385509] Starting subtest: bad-fence
[512.388963] Subtest bad-fence: SUCCESS (0.000s)
[512.548136] [070/142] (504s left) kms_color (ctm-0-75)
[513.059174] Starting subtest: ctm-0-75
[513.062605] Starting dynamic subtest: pipe-A
[519.601106] Dynamic subtest pipe-A: SUCCESS (6.541s)
[519.651889] Starting dynamic subtest: pipe-B
[526.275337] Dynamic subtest pipe-B: SUCCESS (6.671s)
[526.330087] Starting dynamic subtest: pipe-C
[533.088158] Dynamic subtest pipe-C: SUCCESS (6.806s)
[533.138842] Starting dynamic subtest: pipe-D
[540.575660] Dynamic subtest pipe-D: SUCCESS (7.483s)
[540.578302] Subtest ctm-0-75: SUCCESS (27.518s)
[541.571298] [071/142] (475s left) gem_gpgpu_fill (basic)
[541.982917] Starting subtest: basic
[541.987237] Starting dynamic subtest: smem
[542.143876] Dynamic subtest smem: FAIL (0.097s)
[542.147078] Subtest basic: FAIL (0.103s)
[542.251442] [072/142] (474s left) syncobj_timeline (multi-wait-available-signaled)
[542.640953] Starting subtest: multi-wait-available-signaled
[542.651205] Subtest multi-wait-available-signaled: SUCCESS (0.004s)
[542.811975] [073/142] (474s left) kms_atomic_transition (modeset-transition-fencing)
[543.292339] Starting subtest: modeset-transition-fencing
[543.295885] Starting dynamic subtest: 1x-outputs
[574.865298] Dynamic subtest 1x-outputs: SUCCESS (31.570s)
[575.295817] Subtest modeset-transition-fencing: SUCCESS (32.000s)
[576.248664] [074/142] (440s left) kms_psr (no_drrs)
[576.741778] Starting subtest: no_drrs
[579.750327] Subtest no_drrs: SUCCESS (3.008s)
[580.702965] [075/142] (436s left) gem_vm_create (isolation)
[581.106623] Starting subtest: isolation
[581.134924] Subtest isolation: SUCCESS (0.028s)
[581.334533] [076/142] (435s left) gem_busy (semaphore)
[581.931779] Subtest semaphore: SKIP (0.000s)
[582.248734] [077/142] (435s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[582.796706] Starting subtest: yf-tiled-8bpp-rotate-0
[582.803301] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[582.985318] [078/142] (434s left) kms_concurrent (pipe-c)
[583.465255] Starting subtest: pipe-C
[583.473560] Starting dynamic subtest: eDP-1
[585.447750] Dynamic subtest eDP-1: SUCCESS (1.967s)
[585.451714] Subtest pipe-C: SUCCESS (1.978s)
[586.396919] [079/142] (431s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[586.911445] Starting subtest: psr-2p-primscrn-cur-indfb-move
[586.917920] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[587.104429] [080/142] (430s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[587.976835] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[588.858753] [081/142] (428s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[589.336725] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[589.344418] Starting dynamic subtest: pipe-A-default-mode
[589.818512] Dynamic subtest pipe-A-default-mode: SKIP (0.471s)
[589.825425] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.485s)
[590.710512] [082/142] (427s left) gem_exec_gttfill (basic)
[591.142308] Starting subtest: basic
[600.522606] Subtest basic: SUCCESS (9.379s)
[600.834548] [083/142] (417s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[601.369260] Starting subtest: y-tiled-to-vebox-x-tiled
[601.375720] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[601.674898] [084/142] (416s left) i915_query (engine-info-invalid)
[602.053731] Starting subtest: engine-info-invalid
[602.057375] Subtest engine-info-invalid: SUCCESS (0.001s)
[602.237716] [085/142] (415s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-5)
[602.741256] Starting subtest: plane-downscale-with-pixel-format-factor-0-5
[602.751748] Starting dynamic subtest: pipe-A-eDP-1
[602.864972] Dynamic subtest pipe-A-eDP-1: SKIP (0.110s)
[602.919473] Starting dynamic subtest: pipe-B-eDP-1
[603.073275] Dynamic subtest pipe-B-eDP-1: SKIP (0.199s)
[603.137832] Starting dynamic subtest: pipe-C-eDP-1
[603.282351] Dynamic subtest pipe-C-eDP-1: SKIP (0.194s)
[603.337959] Starting dynamic subtest: pipe-D-eDP-1
[603.489180] Dynamic subtest pipe-D-eDP-1: SKIP (0.194s)
[603.496377] Subtest plane-downscale-with-pixel-format-factor-0-5: SKIP (0.740s)
[603.684254] [086/142] (414s left) gem_exec_params (invalid-ring2)
[604.025331] Starting subtest: invalid-ring2
[604.029273] Subtest invalid-ring2: SUCCESS (0.001s)
[604.197436] [087/142] (414s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[604.693217] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[604.700034] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[604.890460] [088/142] (413s left) vgem_basic (debugfs)
[605.261327] Starting subtest: debugfs
[605.264273] Subtest debugfs: SUCCESS (0.003s)
[605.404506] [089/142] (413s left) dmabuf_sync_file (export-basic)
[605.773653] Starting subtest: export-basic
[605.783054] Subtest export-basic: SUCCESS (0.006s)
[605.916366] [090/142] (412s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[606.447309] Starting subtest: y-tiled-16bpp-rotate-90
[606.454494] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[606.609274] [091/142] (412s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[606.994852] Starting subtest: invalid-bsd2-flag-on-vebox
[606.999421] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.002s)
[607.192981] [092/142] (411s left) gem_exec_fence (syncobj-timeline-chain-engines)
[609.405239] Starting subtest: syncobj-timeline-chain-engines
[609.765837] Subtest syncobj-timeline-chain-engines: SUCCESS (0.361s)
[611.698629] [093/142] (407s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[612.101215] Starting subtest: single-wait-for-submit-available-signaled
[612.104724] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[612.297945] [094/142] (406s left) v3d/v3d_submit_csd (multi-and-single-sync)
[612.795716] Subtest multi-and-single-sync: SKIP (0.000s)
[612.949400] [095/142] (406s left) i915_pm_rpm (cursor-dpms)
[619.268329] Starting subtest: cursor-dpms
[651.518455] Subtest cursor-dpms: SUCCESS (32.248s)
[652.637628] [096/142] (366s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[659.928213] Starting subtest: overlay-plane-update-sf-dmg-area
[659.937875] Starting dynamic subtest: pipe-A-eDP-1
[666.957796] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.022s)
[666.984741] Starting dynamic subtest: pipe-B-eDP-1
[673.840361] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.875s)
[673.842832] Subtest overlay-plane-update-sf-dmg-area: SUCCESS (13.915s)
[674.835720] [097/142] (344s left) gem_eio (wait-wedge-10ms)
[676.806156] Starting subtest: wait-wedge-10ms
[679.296276] Subtest wait-wedge-10ms: SUCCESS (2.489s)
[680.693556] [098/142] (338s left) kms_flip (plain-flip-interruptible)
[681.108269] Starting subtest: plain-flip-interruptible
[681.144771] Starting dynamic subtest: A-eDP1
[683.390652] Dynamic subtest A-eDP1: SUCCESS (2.249s)
[683.447502] Starting dynamic subtest: B-eDP1
[685.484822] Dynamic subtest B-eDP1: SUCCESS (2.087s)
[685.536273] Starting dynamic subtest: C-eDP1
[687.394079] Dynamic subtest C-eDP1: SUCCESS (1.904s)
[687.443691] Starting dynamic subtest: D-eDP1
[689.286246] Dynamic subtest D-eDP1: SUCCESS (1.889s)
[689.295714] Subtest plain-flip-interruptible: SUCCESS (8.187s)
[690.746849] [099/142] (328s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[691.244643] Starting subtest: fbc-modesetfrombusy
[695.182695] Subtest fbc-modesetfrombusy: SUCCESS (3.943s)
[695.472452] [100/142] (324s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[696.423592] Starting subtest: cursor-rapid-movement-128x42
[696.459489] Starting dynamic subtest: pipe-A-eDP-1
[697.735449] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.277s)
[697.944867] Starting dynamic subtest: pipe-D-eDP-1
[700.559375] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.667s)
[700.563517] Subtest cursor-rapid-movement-128x42: SUCCESS (4.133s)
[701.553451] [101/142] (318s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[702.069202] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[702.075909] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[702.252598] [102/142] (317s left) kms_tv_load_detect (load-detect)
[702.627241] Subtest load-detect: SKIP (0.000s)
[702.759988] [103/142] (317s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_ccs)
[704.317426] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_ccs
[704.333805] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.013s)
[705.166701] [104/142] (314s left) sw_sync (alloc_fence_invalid_timeline)
[705.541771] Starting subtest: alloc_fence_invalid_timeline
[705.546452] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[705.699602] [105/142] (314s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[706.232564] Starting subtest: x-tiled-8bpp-rotate-180
[710.261300] Subtest x-tiled-8bpp-rotate-180: SUCCESS (4.026s)
[710.629137] [106/142] (309s left) sw_sync (alloc_merge_fence)
[711.002479] Starting subtest: alloc_merge_fence
[711.006049] Subtest alloc_merge_fence: SUCCESS (0.001s)
[711.150571] [107/142] (309s left) kms_chamelium_edid (dp-edid-resolution-list)
[712.040903] Subtest dp-edid-resolution-list: SKIP (0.000s)
[712.927408] [108/142] (307s left) kms_cursor_crc (cursor-onscreen-256x256)
[713.945163] Starting subtest: cursor-onscreen-256x256
[713.969313] Starting dynamic subtest: pipe-A-eDP-1
[717.925199] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.954s)
[718.099528] Starting dynamic subtest: pipe-D-eDP-1
[723.148181] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.093s)
[723.151727] Subtest cursor-onscreen-256x256: SUCCESS (9.208s)
[724.158362] [109/142] (296s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[724.658531] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[724.665195] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[724.842979] [110/142] (295s left) syncobj_timeline (invalid-transfer-bad-pad)
[725.221679] Starting subtest: invalid-transfer-bad-pad
[725.225917] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[725.386960] [111/142] (295s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[725.788402] Subtest tiled-to-untiled: SKIP (0.000s)
[725.929195] [112/142] (294s left) gem_eio (kms)
[728.095120] Starting subtest: kms
[786.722994] Subtest kms: SUCCESS (58.627s)
[788.195426] [113/142] (232s left) kms_getfb (getfb-handle-valid)
[788.570255] Starting subtest: getfb-handle-valid
[788.574107] Subtest getfb-handle-valid: SUCCESS (0.000s)
[788.755239] [114/142] (232s left) api_intel_allocator (standalone)
[789.122274] Starting subtest: standalone
[789.232479] Subtest standalone: SUCCESS (0.109s)
[789.419716] [115/142] (231s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[789.934965] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[804.529316] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (14.600s)
[804.793863] [116/142] (216s left) gem_tiled_partial_pwrite_pread (reads)
[805.189369] Subtest reads: SKIP (0.000s)
[805.327668] [117/142] (216s left) kms_atomic_interruptible (universal-setplane-primary)
[805.821204] Starting subtest: universal-setplane-primary
[805.835745] Starting dynamic subtest: eDP-1-pipe-A
[813.630467] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.796s)
[813.633841] Subtest universal-setplane-primary: SUCCESS (7.808s)
[814.600888] [118/142] (206s left) v3d/v3d_submit_csd (bad-multisync-pad)
[815.063968] Subtest bad-multisync-pad: SKIP (0.000s)
[815.213330] [119/142] (206s left) i915_hangman (engine-engine-hang)
[815.644450] Starting subtest: engine-engine-hang
[815.649489] Starting dynamic subtest: rcs0
[817.545957] Dynamic subtest rcs0: SUCCESS (1.899s)
[817.610937] Starting dynamic subtest: bcs0
[819.529913] Dynamic subtest bcs0: SUCCESS (1.979s)
[819.591502] Starting dynamic subtest: vcs0
[830.138918] Dynamic subtest vcs0: FAIL (10.516s)
[830.197286] Starting dynamic subtest: vcs1
[831.565197] Dynamic subtest vcs1: SUCCESS (1.509s)
[831.623749] Starting dynamic subtest: vecs0
[833.546128] Dynamic subtest vecs0: SUCCESS (1.979s)
[833.605344] Starting dynamic subtest: ccs0
[836.555534] Dynamic subtest ccs0: SUCCESS (3.003s)
[836.559120] Subtest engine-engine-hang: FAIL (20.912s)
[836.805738] [120/142] (184s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[837.188735] Starting subtest: multi-wait-all-for-submit-unsubmitted
[837.296971] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[837.494195] [121/142] (184s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-d)
[837.990219] Starting subtest: universal-plane-pageflip-windowed-pipe-D
[840.013337] Subtest universal-plane-pageflip-windowed-pipe-D: SUCCESS (2.021s)
[840.986837] [122/142] (180s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[841.499737] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[841.506147] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[841.690581] [123/142] (180s left) kms_flip (flip-vs-modeset-vs-hang)
[842.084343] Starting subtest: flip-vs-modeset-vs-hang
[842.098286] Starting dynamic subtest: A-eDP1
[871.473915] Dynamic subtest A-eDP1: SUCCESS (29.370s)
[871.529530] Starting dynamic subtest: D-eDP1
[911.498576] Dynamic subtest D-eDP1: SUCCESS (40.019s)
[911.509836] Subtest flip-vs-modeset-vs-hang: SUCCESS (69.429s)
[912.173075] [124/142] (109s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[912.710476] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[912.717273] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[912.879420] [125/142] (109s left) gem_exec_fair (basic-pace-solo)
[913.291617] Subtest basic-pace-solo: SKIP (0.000s)
[913.447471] [126/142] (108s left) gen3_render_tiledx_blits
[913.952726] [127/142] (108s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs)
[914.994975] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs
[915.000924] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[916.382448] [128/142] (106s left) kms_plane_scaling (planes-downscale-factor-0-25)
[916.867155] Starting subtest: planes-downscale-factor-0-25
[916.875597] Starting dynamic subtest: pipe-A-eDP-1
[916.966769] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[917.035301] Starting dynamic subtest: pipe-B-eDP-1
[917.156094] Dynamic subtest pipe-B-eDP-1: SKIP (0.179s)
[917.222780] Starting dynamic subtest: pipe-C-eDP-1
[917.346907] Dynamic subtest pipe-C-eDP-1: SKIP (0.180s)
[917.414792] Starting dynamic subtest: pipe-D-eDP-1
[917.540360] Dynamic subtest pipe-D-eDP-1: SKIP (0.182s)
[917.547183] Subtest planes-downscale-factor-0-25: SKIP (0.673s)
[917.733611] [129/142] (104s left) kms_vblank (pipe-d-ts-continuation-suspend)
[918.208834] Starting subtest: pipe-D-ts-continuation-suspend
[937.620506] Subtest pipe-D-ts-continuation-suspend: SUCCESS (19.413s)
[938.598444] [130/142] ( 84s left) vc4/vc4_tiling (get-bad-handle)
[939.080608] Subtest get-bad-handle: SKIP (0.000s)
[939.232599] [131/142] ( 83s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[939.814684] Starting subtest: cursor-vs-flip-legacy
[974.541331] Subtest cursor-vs-flip-legacy: SUCCESS (34.727s)
[975.514242] [132/142] ( 47s left) gem_pxp (reject-modify-context-protection-off-2)
[978.425899] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[978.615632] [133/142] ( 44s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[979.819297] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[979.826066] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[981.055918] [134/142] ( 42s left) i915_pm_backlight (bad-brightness)
[981.531444] Starting subtest: bad-brightness
[981.876613] Starting dynamic subtest: eDP-1
[982.331776] Dynamic subtest eDP-1: SUCCESS (0.461s)
[982.335355] Subtest bad-brightness: SUCCESS (0.806s)
[983.314815] [135/142] ( 39s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[983.843722] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[997.568192] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (13.732s)
[997.825601] [136/142] ( 25s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[998.339579] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[998.346550] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[998.526994] [137/142] ( 24s left) syncobj_wait (wait-all-delayed-signal)
[998.916817] Starting subtest: wait-all-delayed-signal
[999.018106] Subtest wait-all-delayed-signal: SUCCESS (0.105s)
[999.185173] [138/142] ( 24s left) gem_exec_schedule (u-semaphore-noskip)
[999.625620] Starting subtest: u-semaphore-noskip
[1000.471375] Subtest u-semaphore-noskip: SUCCESS (0.844s)
[1000.955221] [139/142] ( 22s left) kms_lease (lease_invalid_connector)
[1001.451394] Starting subtest: lease_invalid_connector
[1001.460646] Starting dynamic subtest: pipe-A-eDP-1
[1001.464051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[1001.527146] Starting dynamic subtest: pipe-B-eDP-1
[1001.531100] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[1001.592163] Starting dynamic subtest: pipe-C-eDP-1
[1001.595335] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[1001.654552] Starting dynamic subtest: pipe-D-eDP-1
[1001.657805] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[1001.660968] Subtest lease_invalid_connector: SUCCESS (0.036s)
[1001.740255] [140/142] ( 22s left) kms_content_protection (atomic-dpms)
[1002.430717] Starting subtest: atomic-dpms
[1006.615771] Subtest atomic-dpms: SKIP (4.186s)
[1008.187182] [141/142] ( 15s left) gem_mmap_gtt (close-race)
[1008.569831] Subtest close-race: SKIP (0.000s)
[1008.701514] [142/142] ( 15s left) gem_exec_schedule (lateslice)
[1009.131789] Starting subtest: lateslice
[1009.134796] Starting dynamic subtest: rcs0
[1009.183275] Dynamic subtest rcs0: SUCCESS (0.049s)
[1009.252066] Starting dynamic subtest: bcs0
[1009.255195] Dynamic subtest bcs0: SUCCESS (0.045s)
[1009.318332] Starting dynamic subtest: vcs0
[1009.321850] Dynamic subtest vcs0: SUCCESS (0.041s)
[1009.382508] Starting dynamic subtest: vcs1
[1009.386179] Dynamic subtest vcs1: SUCCESS (0.040s)
[1009.446631] Starting dynamic subtest: vecs0
[1009.449804] Dynamic subtest vecs0: SUCCESS (0.041s)
[1009.507928] Starting dynamic subtest: ccs0
[1009.511112] Dynamic subtest ccs0: SUCCESS (0.044s)
[1009.514118] Subtest lateslice: SUCCESS (0.284s)
[1010.696576] Closing watchdogs
Done.