[53.832395] Initializing watchdogs
[53.832870]   /dev/watchdog0
[53.866876] [001/142] (960s left) v3d/v3d_wait_bo (map-bo-0ns)
[54.406659] Subtest map-bo-0ns: SKIP (0.000s)
[54.531943] [002/142] (959s left) vgem_basic (bad-flag)
[55.045501] Starting subtest: bad-flag
[55.049532] Subtest bad-flag: SUCCESS (0.000s)
[55.165271] [003/142] (959s left) perf_pmu (rc6-all-gts)
[55.573514] Starting subtest: rc6-all-gts
[61.918443] Subtest rc6-all-gts: SUCCESS (6.345s)
[62.085924] [004/142] (952s left) kms_vblank (pipe-c-wait-busy)
[62.571608] Starting subtest: pipe-C-wait-busy
[65.974486] Subtest pipe-C-wait-busy: SUCCESS (3.401s)
[66.917844] [005/142] (947s left) i915_suspend (fence-restore-tiled2untiled)
[67.276152] Starting subtest: fence-restore-tiled2untiled
[67.283224] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[67.394728] [006/142] (947s left) prime_vgem (fence-flip-hang)
[67.819559] Subtest fence-flip-hang: SKIP (0.000s)
[67.970085] [007/142] (946s left) gem_exec_schedule (u-submit-late-slice)
[68.413315] Starting subtest: u-submit-late-slice
[68.417171] Starting dynamic subtest: rcs0
[68.606180] Dynamic subtest rcs0: SUCCESS (0.190s)
[68.639180] Starting dynamic subtest: bcs0
[68.737763] Dynamic subtest bcs0: SUCCESS (0.131s)
[68.768119] Starting dynamic subtest: vcs0
[68.860373] Dynamic subtest vcs0: SUCCESS (0.122s)
[68.890659] Starting dynamic subtest: vcs1
[68.987342] Dynamic subtest vcs1: SUCCESS (0.127s)
[69.006580] Starting dynamic subtest: vecs0
[69.088669] Dynamic subtest vecs0: SUCCESS (0.100s)
[69.114915] Starting dynamic subtest: ccs0
[69.201273] Dynamic subtest ccs0: SUCCESS (0.112s)
[69.204156] Subtest u-submit-late-slice: SUCCESS (0.787s)
[70.711107] [008/142] (944s left) i915_pm_rpm (i2c)
[77.053864] Starting subtest: i2c
[83.525928] Subtest i2c: SUCCESS (6.475s)
[83.718922] [009/142] (931s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[84.290175] Starting subtest: extended-modeset-hang-newfb-with-reset
[84.300973] Starting dynamic subtest: pipe-A
[91.780096] Dynamic subtest pipe-A: SUCCESS (7.474s)
[91.834267] Starting dynamic subtest: pipe-D
[98.826763] Dynamic subtest pipe-D: SUCCESS (7.034s)
[98.830668] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (14.538s)
[99.759600] [010/142] (915s left) gem_exec_capture (capture-invisible)
[100.152304] Starting subtest: capture-invisible
[100.156125] Starting dynamic subtest: smem0
[100.161941] Dynamic subtest smem0: SKIP (0.000s)
[100.167924] Subtest capture-invisible: SKIP (0.001s)
[100.315760] [011/142] (914s left) perf (gen12-invalid-class-instance)
[101.231265] Starting subtest: gen12-invalid-class-instance
[101.274912] Subtest gen12-invalid-class-instance: SUCCESS (0.043s)
[101.376526] [012/142] (913s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[101.875458] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[119.217135] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (17.343s)
[119.480748] [013/142] (895s left) kms_psr (suspend)
[119.956687] Starting subtest: suspend
[139.004559] Subtest suspend: SUCCESS (19.046s)
[139.940740] [014/142] (875s left) i915_pm_lpsp (kms-lpsp)
[141.422765] Starting subtest: kms-lpsp
[141.426440] Starting dynamic subtest: kms-lpsp-eDP
[141.906583] Dynamic subtest kms-lpsp-eDP: SUCCESS (0.481s)
[142.295906] Subtest kms-lpsp: SUCCESS (0.872s)
[143.256302] [015/142] (872s left) syncobj_timeline (single-wait-for-submit-signaled)
[143.626944] Starting subtest: single-wait-for-submit-signaled
[143.630582] Subtest single-wait-for-submit-signaled: SUCCESS (0.002s)
[143.777213] [016/142] (871s left) kms_vrr (negative-basic)
[144.250567] Starting subtest: negative-basic
[144.254165] Starting dynamic subtest: pipe-A-eDP-1
[150.452415] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.197s)
[150.455872] Subtest negative-basic: SUCCESS (6.204s)
[151.404724] [017/142] (864s left) gem_ctx_param (invalid-get-engines)
[151.789801] Starting subtest: invalid-get-engines
[151.793482] Subtest invalid-get-engines: SUCCESS (0.002s)
[151.931499] [018/142] (863s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[152.470655] Starting subtest: 4-tiled-32bpp-rotate-180
[157.220172] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (4.747s)
[157.801308] [019/142] (857s left) gem_close_race (multigpu-basic-threads)
[158.244530] Starting subtest: multigpu-basic-threads
[158.251253] Subtest multigpu-basic-threads: SKIP (0.000s)
[158.538959] [020/142] (857s left) kms_big_fb (linear-64bpp-rotate-180)
[159.084447] Starting subtest: linear-64bpp-rotate-180
[165.830397] Subtest linear-64bpp-rotate-180: SUCCESS (6.742s)
[166.495057] [021/142] (849s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[167.001058] Starting subtest: psr-indfb-scaledprimary
[174.385350] Subtest psr-indfb-scaledprimary: SUCCESS (7.388s)
[174.638438] [022/142] (841s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[176.279277] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[176.285120] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[176.993782] [023/142] (839s left) gem_exec_balancer (full)
[177.420254] Starting subtest: full
[186.956829] Subtest full: SUCCESS (9.536s)
[187.936802] [024/142] (828s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[188.449701] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[188.456178] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[188.623476] [025/142] (827s left) kms_flip (nonexisting-fb-interruptible)
[189.040898] Starting subtest: nonexisting-fb-interruptible
[189.067637] Starting dynamic subtest: A-eDP1
[190.812894] Dynamic subtest A-eDP1: SUCCESS (1.745s)
[190.853134] Starting dynamic subtest: B-eDP1
[192.397396] Dynamic subtest B-eDP1: SUCCESS (1.580s)
[192.437156] Starting dynamic subtest: C-eDP1
[193.972394] Dynamic subtest C-eDP1: SUCCESS (1.570s)
[194.012557] Starting dynamic subtest: D-eDP1
[195.544344] Dynamic subtest D-eDP1: SUCCESS (1.570s)
[195.573164] Subtest nonexisting-fb-interruptible: SUCCESS (6.536s)
[197.095788] [026/142] (819s left) kms_cursor_crc (cursor-random-max-size)
[198.422561] Starting subtest: cursor-random-max-size
[198.432309] Subtest cursor-random-max-size: SKIP (0.000s)
[198.686377] [027/142] (817s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[199.253200] Starting subtest: cursorA-vs-flipB-atomic
[199.265833] Subtest cursorA-vs-flipB-atomic: SKIP (0.009s)
[199.625464] [028/142] (816s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[200.565434] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[201.904834] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SUCCESS (1.339s)
[203.724926] [029/142] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[204.237809] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[216.949813] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (12.713s)
[217.200562] [030/142] (799s left) gem_exec_reloc (basic-softpin)
[217.605852] Subtest basic-softpin: SKIP (0.000s)
[217.737741] [031/142] (799s left) syncobj_wait (invalid-reset-one-illegal-handle)
[218.108826] Starting subtest: invalid-reset-one-illegal-handle
[218.112613] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.001s)
[218.260347] [032/142] (798s left) kms_flip (dpms-off-confusion)
[218.659469] Starting subtest: dpms-off-confusion
[218.692380] Starting dynamic subtest: A-eDP1
[228.000499] Dynamic subtest A-eDP1: SUCCESS (9.313s)
[228.048377] Starting dynamic subtest: B-eDP1
[237.105575] Dynamic subtest B-eDP1: SUCCESS (9.099s)
[237.149987] Starting dynamic subtest: C-eDP1
[246.189456] Dynamic subtest C-eDP1: SUCCESS (9.078s)
[246.245924] Starting dynamic subtest: D-eDP1
[255.262619] Dynamic subtest D-eDP1: SUCCESS (9.067s)
[255.288170] Subtest dpms-off-confusion: SUCCESS (36.635s)
[256.876866] [033/142] (760s left) gem_vm_create (invalid-destroy)
[257.278438] Starting subtest: invalid-destroy
[257.282285] Subtest invalid-destroy: SUCCESS (0.005s)
[257.457870] [034/142] (759s left) kms_plane_scaling (planes-downscale-factor-0-75)
[257.936232] Starting subtest: planes-downscale-factor-0-75
[257.940657] Starting dynamic subtest: pipe-A-eDP-1
[258.068623] Dynamic subtest pipe-A-eDP-1: SKIP (0.120s)
[258.113140] Starting dynamic subtest: pipe-B-eDP-1
[258.303154] Dynamic subtest pipe-B-eDP-1: SKIP (0.224s)
[258.353813] Starting dynamic subtest: pipe-C-eDP-1
[258.541964] Dynamic subtest pipe-C-eDP-1: SKIP (0.230s)
[258.591440] Starting dynamic subtest: pipe-D-eDP-1
[258.785428] Dynamic subtest pipe-D-eDP-1: SKIP (0.232s)
[258.792176] Subtest planes-downscale-factor-0-75: SKIP (0.852s)
[258.965422] [035/142] (758s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[260.478157] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[260.484729] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[261.370112] [036/142] (755s left) gem_ctx_bad_destroy (double-destroy)
[261.737833] Starting subtest: double-destroy
[261.741551] Subtest double-destroy: SUCCESS (0.000s)
[261.881666] [037/142] (755s left) kms_vblank (pipe-b-wait-forked-busy-hang)
[262.365267] Starting subtest: pipe-B-wait-forked-busy-hang
[277.785391] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (15.420s)
[278.738635] [038/142] (738s left) i915_pm_rpm (universal-planes)
[284.825423] Starting subtest: universal-planes
[284.829280] Starting dynamic subtest: plane-31
[309.688722] Dynamic subtest plane-31: SUCCESS (24.860s)
[309.737692] Starting dynamic subtest: plane-40
[338.197346] Dynamic subtest plane-40: SUCCESS (28.505s)
[338.249212] Starting dynamic subtest: plane-49
[362.861179] Dynamic subtest plane-49: SUCCESS (24.658s)
[362.916681] Starting dynamic subtest: plane-58
[391.240922] Dynamic subtest plane-58: SUCCESS (28.375s)
[391.297260] Starting dynamic subtest: plane-67
[416.094285] Dynamic subtest plane-67: SUCCESS (24.848s)
[416.147226] Starting dynamic subtest: plane-76
[444.457700] Dynamic subtest plane-76: SUCCESS (28.359s)
[444.462372] Subtest universal-planes: SUCCESS (159.637s)
[445.411935] [039/142] (572s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[447.236786] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[450.418886] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SUCCESS (3.182s)
[451.847180] [040/142] (565s left) kms_flip (modeset-vs-vblank-race-interruptible)
[452.268602] Starting subtest: modeset-vs-vblank-race-interruptible
[452.301327] Starting dynamic subtest: A-eDP1
[457.864457] Dynamic subtest A-eDP1: SUCCESS (5.563s)
[457.913223] Starting dynamic subtest: B-eDP1
[463.326661] Dynamic subtest B-eDP1: SUCCESS (5.457s)
[463.379317] Starting dynamic subtest: C-eDP1
[468.711323] Dynamic subtest C-eDP1: SUCCESS (5.379s)
[468.762458] Starting dynamic subtest: D-eDP1
[474.097877] Dynamic subtest D-eDP1: SUCCESS (5.381s)
[474.125906] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (21.857s)
[475.691741] [041/142] (541s left) i915_hangman (gt-engine-hang)
[476.154676] Starting subtest: gt-engine-hang
[476.159084] Starting dynamic subtest: rcs0
[477.545441] Dynamic subtest rcs0: SUCCESS (1.389s)
[477.590050] Starting dynamic subtest: bcs0
[479.529553] Dynamic subtest bcs0: SUCCESS (1.979s)
[479.577161] Starting dynamic subtest: vcs0
[481.515089] Dynamic subtest vcs0: SUCCESS (1.979s)
[481.563145] Starting dynamic subtest: vcs1
[483.497439] Dynamic subtest vcs1: SUCCESS (1.979s)
[483.545643] Starting dynamic subtest: vecs0
[486.504149] Dynamic subtest vecs0: SUCCESS (3.002s)
[486.550783] Starting dynamic subtest: ccs0
[489.512894] Dynamic subtest ccs0: SUCCESS (3.004s)
[489.516730] Subtest gt-engine-hang: SUCCESS (13.361s)
[489.747179] [042/142] (527s left) gem_softpin (evict-active)
[490.148359] Starting subtest: evict-active
[490.178582] Subtest evict-active: SUCCESS (0.030s)
[490.389537] [043/142] (527s left) kms_chamelium_hpd (vga-hpd-fast)
[491.277215] Subtest vga-hpd-fast: SKIP (0.000s)
[492.151513] [044/142] (525s left) kms_selftest (framebuffer)
[492.513460] Starting subtest: framebuffer
[492.526304] Subtest framebuffer: SKIP (0.008s)
[492.661738] [045/142] (525s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[493.154473] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[493.162654] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[493.330051] [046/142] (524s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[493.901812] Starting subtest: basic-busy-flip-before-cursor-atomic
[493.909284] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[494.236478] [047/142] (523s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[494.710055] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[494.721475] Starting dynamic subtest: pipe-A-default-mode
[495.132292] Dynamic subtest pipe-A-default-mode: SKIP (0.407s)
[495.139617] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.421s)
[496.078970] [048/142] (522s left) gem_lmem_evict (dontneed-evict-race)
[496.469410] Subtest dontneed-evict-race: SKIP (0.000s)
[496.590638] [049/142] (521s left) gem_exec_fence (syncobj-signal)
[498.629603] Starting subtest: syncobj-signal
[498.645834] Subtest syncobj-signal: SUCCESS (0.015s)
[499.076932] [050/142] (519s left) gem_pxp (reject-modify-context-protection-off-3)
[501.983923] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[502.161280] [051/142] (516s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs)
[503.153449] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs
[503.163379] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[504.559438] [052/142] (514s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[505.094949] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[507.980832] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (2.885s)
[508.257891] [053/142] (510s left) kms_content_protection (mei_interface)
[508.830230] Starting subtest: mei_interface
[508.839352] Subtest mei_interface: SKIP (0.002s)
[509.007669] [054/142] (509s left) syncobj_wait (multi-wait-for-submit-submitted)
[509.381372] Starting subtest: multi-wait-for-submit-submitted
[509.486869] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[509.639093] [055/142] (509s left) gem_exec_schedule (preempt-contexts)
[510.071679] Starting subtest: preempt-contexts
[510.076514] Starting dynamic subtest: rcs0
[510.293263] Dynamic subtest rcs0: SUCCESS (0.220s)
[510.347359] Starting dynamic subtest: bcs0
[510.517588] Dynamic subtest bcs0: SUCCESS (0.219s)
[510.572154] Starting dynamic subtest: vcs0
[510.732567] Dynamic subtest vcs0: SUCCESS (0.210s)
[510.792994] Starting dynamic subtest: vcs1
[510.941474] Dynamic subtest vcs1: SUCCESS (0.204s)
[510.993172] Starting dynamic subtest: vecs0
[511.144483] Dynamic subtest vecs0: SUCCESS (0.199s)
[511.198377] Starting dynamic subtest: ccs0
[511.357613] Dynamic subtest ccs0: SUCCESS (0.209s)
[511.360977] Subtest preempt-contexts: SUCCESS (1.289s)
[512.795830] [056/142] (506s left) gem_exec_params (no-blt)
[513.196698] Starting subtest: no-blt
[513.205419] Subtest no-blt: SUCCESS (0.006s)
[513.413953] [057/142] (505s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[513.912813] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[513.919162] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[515.838592] [058/142] (503s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_ccs)
[517.570788] Starting subtest: pipe-D-ccs-on-another-bo-y_tiled_ccs
[517.577137] Subtest pipe-D-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[518.205846] [059/142] (500s left) kms_chamelium_frames (dp-crc-single)
[519.110989] Subtest dp-crc-single: SKIP (0.000s)
[519.977774] [060/142] (499s left) kms_lease (lessee_list)
[520.452169] Starting subtest: lessee_list
[520.455965] Starting dynamic subtest: pipe-A-eDP-1
[520.465443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[520.509805] Starting dynamic subtest: pipe-B-eDP-1
[520.513037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[520.562413] Starting dynamic subtest: pipe-C-eDP-1
[520.566167] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[520.612065] Starting dynamic subtest: pipe-D-eDP-1
[520.615122] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.003s)
[520.618251] Subtest lessee_list: SUCCESS (0.049s)
[520.690242] [061/142] (498s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[521.156965] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[521.296352] [062/142] (498s left) kms_vblank (pipe-b-ts-continuation-idle)
[521.787192] Starting subtest: pipe-B-ts-continuation-idle
[523.560071] Subtest pipe-B-ts-continuation-idle: SUCCESS (1.772s)
[524.509586] [063/142] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[525.025229] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[525.032282] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[525.200096] [064/142] (494s left) gem_exec_fair (basic-flow)
[525.607880] Subtest basic-flow: SKIP (0.000s)
[525.741640] [065/142] (494s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice)
[526.206555] Subtest mark-unpurgeable-twice: SKIP (0.000s)
[526.338588] [066/142] (493s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[526.712357] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[526.822706] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.110s)
[526.974693] [067/142] (492s left) kms_plane_lowres (tiling-yf)
[527.455133] Starting subtest: tiling-yf
[527.461929] Subtest tiling-yf: SKIP (0.000s)
[527.611245] [068/142] (492s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[528.183047] Starting subtest: basic-busy-flip-before-cursor-varying-size
[528.190429] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[528.509445] [069/142] (491s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[529.022350] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[546.122153] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (17.104s)
[546.400196] [070/142] (473s left) kms_invalid_mode (zero-vdisplay)
[546.879462] Starting subtest: zero-vdisplay
[546.889376] Starting dynamic subtest: eDP-1-pipe-A
[547.300987] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.412s)
[547.356349] Starting dynamic subtest: eDP-1-pipe-B
[547.360127] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.041s)
[547.408394] Starting dynamic subtest: eDP-1-pipe-C
[547.412140] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.041s)
[547.459973] Starting dynamic subtest: eDP-1-pipe-D
[547.463487] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.041s)
[547.466777] Subtest zero-vdisplay: SUCCESS (0.573s)
[548.224881] [071/142] (472s left) sw_sync (sync_multi_consumer)
[548.593364] Starting subtest: sync_multi_consumer
[551.078573] Subtest sync_multi_consumer: SUCCESS (2.488s)
[551.194356] [072/142] (469s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[551.740334] Starting subtest: y-tiled-64bpp-rotate-180
[551.747351] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[551.915330] [073/142] (468s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[553.238942] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[553.251536] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.015s)
[554.327776] [074/142] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[554.835362] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[566.827152] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (11.998s)
[567.118919] [075/142] (453s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[568.694323] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[571.185948] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (2.497s)
[572.522102] [076/142] (448s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[572.996815] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[573.005989] Starting dynamic subtest: pipe-A-eDP-1
[573.257304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.252s)
[573.700821] Starting dynamic subtest: pipe-B-eDP-1
[574.661086] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.006s)
[575.052699] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (2.052s)
[576.007170] [077/142] (444s left) gem_softpin (safe-alignment)
[576.398898] Starting subtest: safe-alignment
[576.494677] Subtest safe-alignment: SUCCESS (0.096s)
[577.660773] [078/142] (443s left) drm_fdinfo (all-busy-check-all)
[578.047708] Starting subtest: all-busy-check-all
[578.063084] Subtest all-busy-check-all: SKIP (0.012s)
[578.212361] [079/142] (442s left) kms_cursor_crc (cursor-onscreen-max-size)
[579.562995] Starting subtest: cursor-onscreen-max-size
[579.572673] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[579.832175] [080/142] (441s left) kms_vblank (pipe-a-ts-continuation-dpms-suspend)
[580.316045] Starting subtest: pipe-A-ts-continuation-dpms-suspend
[598.077527] Subtest pipe-A-ts-continuation-dpms-suspend: SUCCESS (17.764s)
[599.038491] [081/142] (422s left) kms_rmfb (close-fd)
[599.537360] Starting subtest: close-fd
[599.541356] Starting dynamic subtest: pipe-A-eDP-1
[599.879581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.336s)
[599.933707] Starting dynamic subtest: pipe-B-eDP-1
[601.521421] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.635s)
[601.574250] Starting dynamic subtest: pipe-C-eDP-1
[603.204456] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.672s)
[603.254860] Starting dynamic subtest: pipe-D-eDP-1
[604.881952] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.667s)
[604.885811] Subtest close-fd: SUCCESS (5.347s)
[606.385565] [082/142] (414s left) core_setmaster (master-drop-set-user)
[610.229086] Starting subtest: master-drop-set-user
[610.323262] Subtest master-drop-set-user: SUCCESS (0.096s)
[610.418578] [083/142] (410s left) gem_exec_suspend (basic-s3)
[610.851586] Starting subtest: basic-S3
[610.854650] Starting dynamic subtest: smem
[637.480668] Dynamic subtest smem: SUCCESS (26.630s)
[637.484502] Subtest basic-S3: SUCCESS (26.635s)
[637.798961] [084/142] (383s left) kms_prime (d3hot)
[638.364971] Subtest D3hot: SKIP (0.000s)
[638.533866] [085/142] (383s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[638.948340] Starting subtest: yf-tiled-ccs-to-yf-tiled
[638.954840] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[639.231164] [086/142] (382s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[639.732792] Starting subtest: fbcpsr-tiling-y
[639.739586] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[639.919166] [087/142] (381s left) gem_userptr_blits (unsync-overlap)
[640.329329] Subtest unsync-overlap: SKIP (0.000s)
[640.610183] [088/142] (381s left) kms_concurrent (pipe-b)
[641.097271] Starting subtest: pipe-B
[641.102319] Starting dynamic subtest: eDP-1
[643.148653] Dynamic subtest eDP-1: SUCCESS (2.046s)
[643.152364] Subtest pipe-B: SUCCESS (2.056s)
[644.109096] [089/142] (377s left) kms_chamelium_color (degamma)
[644.592968] Subtest degamma: SKIP (0.000s)
[644.719181] [090/142] (377s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[645.230882] Starting subtest: fbc-shrfb-scaledprimary
[651.385736] Subtest fbc-shrfb-scaledprimary: SUCCESS (6.157s)
[651.683281] [091/142] (370s left) kms_draw_crc (draw-method-render)
[652.150941] Starting subtest: draw-method-render
[652.155190] Starting dynamic subtest: xrgb8888-untiled
[652.770104] Dynamic subtest xrgb8888-untiled: SUCCESS (0.616s)
[652.816343] Starting dynamic subtest: rgb565-untiled
[653.325455] Dynamic subtest rgb565-untiled: SUCCESS (0.552s)
[653.380756] Starting dynamic subtest: xrgb2101010-untiled
[653.958738] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.629s)
[654.004744] Starting dynamic subtest: xrgb8888-xtiled
[654.325070] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.362s)
[654.369322] Starting dynamic subtest: rgb565-xtiled
[654.582241] Dynamic subtest rgb565-xtiled: SUCCESS (0.252s)
[654.634297] Starting dynamic subtest: xrgb2101010-xtiled
[654.837608] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.252s)
[654.878075] Starting dynamic subtest: xrgb8888-4tiled
[655.217503] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.373s)
[655.273872] Starting dynamic subtest: rgb565-4tiled
[655.580345] Dynamic subtest rgb565-4tiled: SUCCESS (0.364s)
[655.629713] Starting dynamic subtest: xrgb2101010-4tiled
[655.914520] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.332s)
[655.918529] Subtest draw-method-render: SUCCESS (3.766s)
[656.104841] [092/142] (366s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[656.619932] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[667.680187] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (11.060s)
[667.920912] [093/142] (354s left) gem_eio (in-flight-immediate)
[669.918810] Starting subtest: in-flight-immediate
[707.987253] Subtest in-flight-immediate: SUCCESS (38.071s)
[709.627798] [094/142] (312s left) gem_exec_whisper (basic-forked-all)
[710.053154] Starting subtest: basic-forked-all
[731.977657] Subtest basic-forked-all: FAIL (21.912s)
[733.769747] [095/142] (288s left) gem_ctx_param (invalid-param-get)
[734.163670] Starting subtest: invalid-param-get
[734.167381] Subtest invalid-param-get: SUCCESS (0.001s)
[734.350521] [096/142] (288s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[734.884793] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[734.891814] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[735.066517] [097/142] (287s left) api_intel_allocator (reserve-simple)
[735.448865] Starting subtest: reserve-simple
[735.452376] Subtest reserve-simple: SUCCESS (0.007s)
[735.636715] [098/142] (287s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[736.131239] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[736.137844] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[736.307733] [099/142] (286s left) gen9_exec_parse (bb-secure)
[736.703768] Subtest bb-secure: SKIP (0.000s)
[736.828569] [100/142] (286s left) kms_vblank (pipe-c-wait-idle)
[737.300446] Starting subtest: pipe-C-wait-idle
[740.716296] Subtest pipe-C-wait-idle: SUCCESS (3.414s)
[741.670212] [101/142] (281s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[742.180071] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[754.453155] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (12.277s)
[754.738369] [102/142] (268s left) syncobj_basic (bad-destroy)
[755.108447] Starting subtest: bad-destroy
[755.112109] Subtest bad-destroy: SUCCESS (0.000s)
[755.253919] [103/142] (268s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs)
[756.943328] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs
[756.950842] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[757.360429] [104/142] (266s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[757.864096] Starting subtest: fbc-rgb101010-draw-pwrite
[763.187910] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.331s)
[763.460632] [105/142] (260s left) gem_exec_params (mmapped)
[763.854648] Starting subtest: mmapped
[763.864346] Subtest mmapped: SUCCESS (0.010s)
[764.050146] [106/142] (259s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[764.523381] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[764.530202] Starting dynamic subtest: pipe-A-default-mode
[765.015726] Dynamic subtest pipe-A-default-mode: SKIP (0.481s)
[765.023694] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.495s)
[765.884310] [107/142] (257s left) kms_vblank (crtc-id)
[766.365448] Starting subtest: crtc-id
[766.988192] Subtest crtc-id: SUCCESS (0.626s)
[767.942895] [108/142] (255s left) gem_exec_create (madvise)
[768.365650] Starting subtest: madvise
[768.368692] Starting dynamic subtest: smem
[789.561724] Dynamic subtest smem: SUCCESS (21.192s)
[789.566113] Subtest madvise: SUCCESS (21.196s)
[790.402153] [109/142] (233s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[790.791843] Starting subtest: multi-wait-all-for-submit-signaled
[790.796129] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.002s)
[790.985903] [110/142] (232s left) gem_userptr_blits (stress-mm)
[791.438163] Starting subtest: stress-mm
[796.810628] Subtest stress-mm: SUCCESS (5.372s)
[797.018466] [111/142] (227s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[797.565613] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[801.347124] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (3.781s)
[801.977290] [112/142] (222s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[802.483591] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[802.490274] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[802.666652] [113/142] (221s left) syncobj_timeline (invalid-signal-illegal-point)
[803.049477] Starting subtest: invalid-signal-illegal-point
[803.053168] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[803.197659] [114/142] (221s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[804.200734] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[804.207943] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[804.910630] [115/142] (219s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[805.431614] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[805.439851] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[805.586620] [116/142] (218s left) gem_lmem_swapping (verify)
[805.984147] Subtest verify: SKIP (0.000s)
[806.111711] [117/142] (218s left) syncobj_timeline (multi-wait-all-available-submitted)
[806.497808] Starting subtest: multi-wait-all-available-submitted
[806.502144] Subtest multi-wait-all-available-submitted: SUCCESS (0.003s)
[806.655042] [118/142] (218s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs)
[807.588838] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs
[807.596076] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[808.447685] [119/142] (216s left) perf (invalid-oa-format-id)
[809.099748] Starting subtest: invalid-oa-format-id
[809.129878] Subtest invalid-oa-format-id: SUCCESS (0.032s)
[809.251333] [120/142] (215s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[809.600963] Starting subtest: invalid-bsd1-flag-on-vebox
[809.604814] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.001s)
[809.768595] [121/142] (215s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[809.987157] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[809.990386] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[810.112883] [122/142] (214s left) gem_mmap_offset (bad-flags)
[810.485952] Starting subtest: bad-flags
[810.490189] Subtest bad-flags: SUCCESS (0.001s)
[810.636929] [123/142] (214s left) gem_ctx_persistence (legacy-engines-cleanup)
[811.042197] Starting subtest: legacy-engines-cleanup
[811.046430] Starting dynamic subtest: render
[811.103724] Dynamic subtest render: SUCCESS (0.059s)
[811.166197] Starting dynamic subtest: bsd1
[811.169788] Dynamic subtest bsd1: SUCCESS (0.054s)
[811.217685] Starting dynamic subtest: bsd2
[811.221363] Dynamic subtest bsd2: SUCCESS (0.044s)
[811.269781] Starting dynamic subtest: blt
[811.273325] Dynamic subtest blt: SUCCESS (0.029s)
[811.327841] Starting dynamic subtest: vebox
[811.330904] Dynamic subtest vebox: SUCCESS (0.042s)
[811.333909] Subtest legacy-engines-cleanup: SUCCESS (0.252s)
[811.478780] [124/142] (213s left) dumb_buffer (map-invalid-size)
[811.857789] Starting subtest: map-invalid-size
[811.861494] Subtest map-invalid-size: SUCCESS (0.001s)
[812.054335] [125/142] (213s left) kms_psr (psr2_cursor_mmap_cpu)
[812.552158] Starting subtest: psr2_cursor_mmap_cpu
[814.512567] Subtest psr2_cursor_mmap_cpu: SUCCESS (1.959s)
[815.470687] [126/142] (209s left) gem_userptr_blits (forbidden-operations)
[815.697545] Starting subtest: forbidden-operations
[815.702218] Subtest forbidden-operations: SKIP (0.000s)
[815.869077] [127/142] (209s left) kms_plane_scaling (intel-max-src-size)
[816.041408] Starting subtest: intel-max-src-size
[816.047321] Subtest intel-max-src-size: SKIP (0.000s)
[816.155578] [128/142] (209s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[816.338319] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[827.357976] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (11.025s)
[827.513244] [129/142] (197s left) kms_sequence (get-idle)
[827.689828] Starting subtest: get-idle
[827.692327] Starting dynamic subtest: eDP-1-pipe-A
[829.646808] Dynamic subtest eDP-1-pipe-A: SUCCESS (1.955s)
[829.712798] Starting dynamic subtest: eDP-1-pipe-B
[832.471611] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.809s)
[832.533472] Starting dynamic subtest: eDP-1-pipe-C
[835.538576] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.055s)
[835.598693] Starting dynamic subtest: eDP-1-pipe-D
[838.986271] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.441s)
[838.989969] Subtest get-idle: SUCCESS (11.299s)
[839.944308] [130/142] (185s left) gem_ctx_shared (q-out-order)
[840.366900] Starting subtest: Q-out-order
[840.370758] Starting dynamic subtest: rcs0
[840.707848] Dynamic subtest rcs0: SUCCESS (0.339s)
[840.773234] Starting dynamic subtest: bcs0
[840.946880] Dynamic subtest bcs0: SUCCESS (0.236s)
[841.015284] Starting dynamic subtest: vcs0
[841.172309] Dynamic subtest vcs0: SUCCESS (0.222s)
[841.239815] Starting dynamic subtest: vcs1
[841.402846] Dynamic subtest vcs1: SUCCESS (0.228s)
[841.471382] Starting dynamic subtest: vecs0
[841.637896] Dynamic subtest vecs0: SUCCESS (0.231s)
[841.708150] Starting dynamic subtest: ccs0
[841.906424] Dynamic subtest ccs0: SUCCESS (0.265s)
[841.910392] Subtest Q-out-order: SUCCESS (1.540s)
[842.761492] [131/142] (182s left) gem_caching (read-writes)
[843.163765] Subtest read-writes: SKIP (0.000s)
[843.311221] [132/142] (182s left) v3d/v3d_submit_cl (bad-pad)
[843.796763] Subtest bad-pad: SKIP (0.000s)
[843.946715] [133/142] (181s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[844.513671] Starting subtest: yf-tiled-16bpp-rotate-270
[844.520846] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[844.683512] [134/142] (181s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[845.196332] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[845.203414] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[845.372668] [135/142] (180s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[845.785518] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[845.792453] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[846.073205] [136/142] (180s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[846.579796] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[846.586609] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[846.760571] [137/142] (179s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[847.270185] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[847.277298] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[847.447511] [138/142] (178s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[848.436512] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs
[848.443479] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[849.612662] [139/142] (176s left) v3d/v3d_create_bo (create-bo-0)
[850.087830] Subtest create-bo-0: SKIP (0.000s)
[850.231231] [140/142] (176s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted)
[850.609506] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted
[850.612956] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.003s)
[850.770801] [141/142] (175s left) kms_addfb_basic (too-high)
[851.244450] Starting subtest: too-high
[851.248144] Subtest too-high: SUCCESS (0.004s)
[851.431534] [142/142] (175s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[852.599292] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[852.605890] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.003s)
[853.796581] Closing watchdogs
Done.