[51.861804] Initializing watchdogs
[51.862366]   /dev/watchdog0
[51.895642] [001/142] (960s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[52.439144] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[65.990562] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (13.556s)
[66.252654] [002/142] (946s left) gem_exec_reloc (basic-gtt-wc)
[66.678304] Subtest basic-gtt-wc: SKIP (0.000s)
[66.808301] [003/142] (945s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs)
[68.168963] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs
[68.176218] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[69.152440] [004/142] (943s left) gem_reg_read (timestamp-monotonic)
[69.525995] Starting subtest: timestamp-monotonic
[74.307343] Subtest timestamp-monotonic: SUCCESS (4.782s)
[74.462567] [005/142] (938s left) kms_pipe_crc_basic (suspend-read-crc)
[74.953615] Starting subtest: suspend-read-crc
[74.960886] Starting dynamic subtest: pipe-A-eDP-1
[94.575886] Dynamic subtest pipe-A-eDP-1: SUCCESS (19.614s)
[94.610428] Starting dynamic subtest: pipe-B-eDP-1
[114.646945] Dynamic subtest pipe-B-eDP-1: SUCCESS (20.066s)
[114.688169] Starting dynamic subtest: pipe-C-eDP-1
[134.617561] Dynamic subtest pipe-C-eDP-1: SUCCESS (19.959s)
[134.657840] Starting dynamic subtest: pipe-D-eDP-1
[154.342962] Dynamic subtest pipe-D-eDP-1: SUCCESS (19.718s)
[154.348737] Subtest suspend-read-crc: SUCCESS (79.389s)
[155.283173] [006/142] (857s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[156.240115] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[157.582885] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.343s)
[159.447961] [007/142] (853s left) i915_pm_rpm (i2c)
[165.771493] Starting subtest: i2c
[172.024857] Subtest i2c: SUCCESS (6.254s)
[172.228113] [008/142] (840s left) kms_rotation_crc (primary-rotation-90)
[172.703886] Starting subtest: primary-rotation-90
[172.710310] Subtest primary-rotation-90: SKIP (0.007s)
[172.848985] [009/142] (840s left) gem_sync (basic-store-all)
[173.270764] Starting subtest: basic-store-all
[178.528935] Subtest basic-store-all: SUCCESS (5.256s)
[178.826716] [010/142] (834s left) gem_exec_reloc (basic-gtt-read-active)
[179.225606] Subtest basic-gtt-read-active: SKIP (0.000s)
[179.370585] [011/142] (833s left) gem_ctx_param (invalid-set-no-zeromap)
[179.740800] Starting subtest: invalid-set-no-zeromap
[179.747081] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[179.930424] [012/142] (833s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[180.343829] Starting subtest: yf-tiled-to-vebox-y-tiled
[180.350429] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[180.638960] [013/142] (832s left) feature_discovery (display)
[181.122883] Starting subtest: display
[181.126474] Subtest display: SUCCESS (0.000s)
[181.281710] [014/142] (832s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[182.422105] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[182.427886] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[183.662908] [015/142] (829s left) gem_mmap_gtt (basic-small-bo-tiledy)
[184.041233] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[184.150339] [016/142] (829s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_mc_ccs)
[185.182041] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_mc_ccs
[185.690366] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_mc_ccs: SUCCESS (0.508s)
[187.020107] [017/142] (826s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[187.569634] Starting subtest: yf-tiled-16bpp-rotate-270
[187.576624] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[187.727586] [018/142] (825s left) perf_pmu (semaphore-wait-idle)
[188.120302] Starting subtest: semaphore-wait-idle
[188.123859] Starting dynamic subtest: rcs0
[188.654448] Dynamic subtest rcs0: SUCCESS (0.532s)
[188.698065] Starting dynamic subtest: bcs0
[189.175563] Dynamic subtest bcs0: SUCCESS (0.518s)
[189.218506] Starting dynamic subtest: vcs0
[189.697117] Dynamic subtest vcs0: SUCCESS (0.519s)
[189.737186] Starting dynamic subtest: vcs1
[190.215169] Dynamic subtest vcs1: SUCCESS (0.516s)
[190.256239] Starting dynamic subtest: vecs0
[190.734722] Dynamic subtest vecs0: SUCCESS (0.518s)
[190.775508] Starting dynamic subtest: ccs0
[191.257423] Dynamic subtest ccs0: SUCCESS (0.519s)
[191.261134] Subtest semaphore-wait-idle: SUCCESS (3.138s)
[192.647665] [019/142] (821s left) kms_vblank (pipe-d-ts-continuation-idle-hang)
[193.146956] Starting subtest: pipe-D-ts-continuation-idle-hang
[209.842862] Subtest pipe-D-ts-continuation-idle-hang: SUCCESS (16.694s)
[210.785227] [020/142] (803s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[211.185594] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[211.347794] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.160s)
[211.541572] [021/142] (802s left) gem_set_tiling_vs_gtt
[212.061475] [022/142] (801s left) kms_plane (plane-panning-top-left)
[212.557899] Starting subtest: plane-panning-top-left
[212.565744] Starting dynamic subtest: pipe-A-planes
[214.875220] Dynamic subtest pipe-A-planes: SUCCESS (2.308s)
[214.915478] Starting dynamic subtest: pipe-B-planes
[217.835175] Dynamic subtest pipe-B-planes: SUCCESS (2.953s)
[217.838573] Subtest plane-panning-top-left: SUCCESS (5.280s)
[218.783966] [023/142] (795s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[219.850883] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[219.866838] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.013s)
[221.142466] [024/142] (793s left) i915_module_load (reload)
[221.499899] Starting subtest: reload
[227.778709] Subtest reload: SUCCESS (6.279s)
[227.878455] [025/142] (786s left) gem_pxp (reject-modify-context-protection-off-1)
[232.035495] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[232.221335] [026/142] (782s left) gem_mmap_gtt (hang-user)
[232.601147] Subtest hang-user: SKIP (0.000s)
[232.729909] [027/142] (781s left) kms_vblank (pipe-a-ts-continuation-modeset-hang)
[233.224714] Starting subtest: pipe-A-ts-continuation-modeset-hang
[247.842976] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (14.623s)
[248.798126] [028/142] (765s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[249.313803] Starting subtest: fbc-rgb565-draw-mmap-cpu
[262.924230] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (13.608s)
[263.242208] [029/142] (751s left) gem_exec_flush (basic-wb-rw-default)
[263.670544] Starting subtest: basic-wb-rw-default
[269.577217] Subtest basic-wb-rw-default: SUCCESS (5.906s)
[269.886070] [030/142] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[270.402471] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[270.409213] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[270.575889] [031/142] (744s left) kms_prop_blob (blob-prop-core)
[270.955320] Starting subtest: blob-prop-core
[270.958787] Subtest blob-prop-core: SUCCESS (0.000s)
[271.102192] [032/142] (743s left) kms_flip (flip-vs-expired-vblank)
[271.496590] Starting subtest: flip-vs-expired-vblank
[271.525206] Starting dynamic subtest: A-eDP1
[280.806970] Dynamic subtest A-eDP1: SUCCESS (9.282s)
[280.859250] Starting dynamic subtest: B-eDP1
[289.894409] Dynamic subtest B-eDP1: SUCCESS (9.081s)
[289.947248] Starting dynamic subtest: C-eDP1
[298.987288] Dynamic subtest C-eDP1: SUCCESS (9.084s)
[299.038067] Starting dynamic subtest: D-eDP1
[308.067290] Dynamic subtest D-eDP1: SUCCESS (9.075s)
[308.094821] Subtest flip-vs-expired-vblank: SUCCESS (36.603s)
[309.671531] [033/142] (705s left) syncobj_basic (illegal-fd-to-handle)
[310.050120] Starting subtest: illegal-fd-to-handle
[310.054427] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[310.200102] [034/142] (704s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[310.704854] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[310.711913] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[310.878952] [035/142] (704s left) vc4/vc4_perfmon (create-perfmon-exceed)
[311.372377] Subtest create-perfmon-exceed: SKIP (0.000s)
[311.506921] [036/142] (703s left) kms_addfb_basic (bad-pitch-63)
[311.891785] Starting subtest: bad-pitch-63
[311.895279] Subtest bad-pitch-63: SUCCESS (0.000s)
[312.168817] [037/142] (703s left) kms_scaling_modes (scaling-mode-none)
[312.658049] Starting subtest: scaling-mode-none
[312.667369] Starting dynamic subtest: eDP-1-pipe-A
[312.956693] Dynamic subtest eDP-1-pipe-A: SKIP (0.291s)
[313.003641] Starting dynamic subtest: eDP-1-pipe-B
[313.131960] Dynamic subtest eDP-1-pipe-B: SKIP (0.166s)
[313.183205] Starting dynamic subtest: eDP-1-pipe-C
[313.309591] Dynamic subtest eDP-1-pipe-C: SKIP (0.169s)
[313.365070] Starting dynamic subtest: eDP-1-pipe-D
[313.495070] Dynamic subtest eDP-1-pipe-D: SKIP (0.173s)
[313.502840] Subtest scaling-mode-none: SKIP (0.839s)
[313.703918] [038/142] (701s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[314.103471] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[314.225433] [039/142] (701s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[314.615354] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[314.725544] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.109s)
[314.874483] [040/142] (700s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[316.636361] Starting subtest: pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[316.643041] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[317.273322] [041/142] (698s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[318.141285] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[318.981481] [042/142] (696s left) api_intel_bb (object-reloc-purge-cache)
[319.345132] Starting subtest: object-reloc-purge-cache
[319.358812] Subtest object-reloc-purge-cache: SKIP (0.010s)
[319.532474] [043/142] (696s left) kms_big_fb (4-tiled-addfb-size-overflow)
[320.082536] Starting subtest: 4-tiled-addfb-size-overflow
[320.086143] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.002s)
[320.241987] [044/142] (695s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[320.748379] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[335.241631] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (14.501s)
[335.485298] [045/142] (680s left) gem_exec_reloc (basic-wc-cpu-active)
[335.891497] Subtest basic-wc-cpu-active: SKIP (0.000s)
[336.047207] [046/142] (679s left) kms_cursor_crc (cursor-sliding-128x128)
[336.561939] Starting subtest: cursor-sliding-128x128
[336.576748] Starting dynamic subtest: pipe-A-eDP-1
[342.202547] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.623s)
[342.390369] Starting dynamic subtest: pipe-D-eDP-1
[349.350776] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.002s)
[349.354527] Subtest cursor-sliding-128x128: SUCCESS (12.786s)
[350.455188] [047/142] (665s left) gem_userptr_blits (process-exit-busy)
[350.920358] Starting subtest: process-exit-busy
[351.010868] Subtest process-exit-busy: SUCCESS (0.091s)
[351.239109] [048/142] (664s left) gem_workarounds (suspend-resume)
[351.693647] Starting subtest: suspend-resume
[368.283884] Subtest suspend-resume: SUCCESS (16.591s)
[368.484697] [049/142] (647s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[369.019095] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[369.026293] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[369.191840] [050/142] (647s left) kms_tv_load_detect (load-detect)
[369.576573] Subtest load-detect: SKIP (0.000s)
[369.695323] [051/142] (646s left) gem_exec_fence (submit3)
[370.292849] Starting subtest: submit3
[370.300241] Subtest submit3: SKIP (0.000s)
[372.708496] [052/142] (643s left) drm_fdinfo (busy-idle)
[373.100601] Starting subtest: busy-idle
[373.104740] Starting dynamic subtest: rcs0
[373.111646] Dynamic subtest rcs0: SKIP (0.001s)
[373.159600] Starting dynamic subtest: bcs0
[373.165912] Dynamic subtest bcs0: SKIP (0.001s)
[373.213792] Starting dynamic subtest: vcs0
[373.220750] Dynamic subtest vcs0: SKIP (0.001s)
[373.266800] Starting dynamic subtest: vcs1
[373.273825] Dynamic subtest vcs1: SKIP (0.001s)
[373.319698] Starting dynamic subtest: vecs0
[373.326500] Dynamic subtest vecs0: SKIP (0.001s)
[373.372852] Starting dynamic subtest: ccs0
[373.379748] Dynamic subtest ccs0: SKIP (0.001s)
[373.386414] Subtest busy-idle: SKIP (0.029s)
[373.453680] [053/142] (643s left) sysfs_heartbeat_interval (mixed)
[373.810638] Starting subtest: mixed
[373.819943] Starting dynamic subtest: vecs0
[379.163174] Dynamic subtest vecs0: SUCCESS (5.342s)
[379.209496] Starting dynamic subtest: ccs0
[384.373818] Dynamic subtest ccs0: SUCCESS (5.211s)
[384.426071] Starting dynamic subtest: vcs0
[389.841053] Dynamic subtest vcs0: SUCCESS (5.458s)
[389.884628] Starting dynamic subtest: bcs0
[395.548442] Dynamic subtest bcs0: SUCCESS (5.703s)
[395.594097] Starting dynamic subtest: rcs0
[400.824176] Dynamic subtest rcs0: SUCCESS (5.275s)
[400.875485] Starting dynamic subtest: vcs1
[406.193821] Dynamic subtest vcs1: SUCCESS (5.361s)
[406.197399] Subtest mixed: SUCCESS (32.381s)
[406.374392] [054/142] (610s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs)
[407.823561] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs
[407.832938] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[408.734883] [055/142] (608s left) gem_exec_balancer (hang)
[409.981382] Starting subtest: hang
[415.974431] Subtest hang: SUCCESS (5.994s)
[416.186616] [056/142] (600s left) kms_cursor_edge_walk (128x128-right-edge)
[416.682598] Starting subtest: 128x128-right-edge
[416.692944] Starting dynamic subtest: pipe-A-eDP-1
[420.575697] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.879s)
[420.631349] Starting dynamic subtest: pipe-D-eDP-1
[424.019629] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.438s)
[424.023313] Subtest 128x128-right-edge: SUCCESS (7.339s)
[424.970289] [057/142] (592s left) kms_psr (primary_render)
[425.463999] Starting subtest: primary_render
[428.462601] Subtest primary_render: SUCCESS (2.999s)
[429.421728] [058/142] (587s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs)
[430.967924] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs
[430.971736] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.004s)
[431.824222] [059/142] (585s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[432.321729] Starting subtest: fbcpsr-1p-rte
[442.779930] Subtest fbcpsr-1p-rte: SUCCESS (10.465s)
[443.058975] [060/142] (574s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[443.573123] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[443.580165] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[443.735927] [061/142] (573s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[444.240130] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[444.247068] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[444.408611] [062/142] (573s left) kms_lease (lease_unleased_connector)
[444.904905] Starting subtest: lease_unleased_connector
[444.914567] Starting dynamic subtest: pipe-A-eDP-1
[444.942481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[444.976552] Starting dynamic subtest: pipe-B-eDP-1
[444.980276] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[445.014950] Starting dynamic subtest: pipe-C-eDP-1
[445.020447] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[445.047742] Starting dynamic subtest: pipe-D-eDP-1
[445.051278] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[445.054841] Subtest lease_unleased_connector: SUCCESS (0.147s)
[445.202247] [063/142] (572s left) kms_psr (psr2_primary_blt)
[445.698710] Starting subtest: psr2_primary_blt
[448.770476] Subtest psr2_primary_blt: SUCCESS (3.071s)
[449.759880] [064/142] (567s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[450.268821] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[456.335329] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (6.069s)
[456.608770] [065/142] (561s left) gem_userptr_blits (stress-purge)
[457.068443] Starting subtest: stress-purge
[462.703799] Subtest stress-purge: SUCCESS (5.634s)
[463.001716] [066/142] (554s left) v3d/v3d_submit_csd (multiple-job-submission)
[463.695247] Subtest multiple-job-submission: SKIP (0.000s)
[463.840227] [067/142] (554s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[464.427936] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[464.434767] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.001s)
[464.578738] [068/142] (553s left) kms_rotation_crc (sprite-rotation-180)
[465.057423] Starting subtest: sprite-rotation-180
[476.409587] Subtest sprite-rotation-180: SUCCESS (11.354s)
[477.992605] [069/142] (540s left) gem_set_tiling_vs_pwrite
[478.524948] [070/142] (539s left) gem_exec_store (pages)
[478.947964] Starting subtest: pages
[478.951422] Starting dynamic subtest: rcs0
[479.192667] Dynamic subtest rcs0: SUCCESS (0.244s)
[479.249253] Starting dynamic subtest: bcs0
[479.415355] Dynamic subtest bcs0: SUCCESS (0.217s)
[479.471527] Starting dynamic subtest: vcs0
[480.479460] Dynamic subtest vcs0: SUCCESS (1.059s)
[480.529595] Starting dynamic subtest: vcs1
[482.527663] Dynamic subtest vcs1: SUCCESS (2.043s)
[482.577892] Starting dynamic subtest: vecs0
[484.511962] Dynamic subtest vecs0: SUCCESS (1.980s)
[484.562473] Starting dynamic subtest: ccs0
[484.738512] Dynamic subtest ccs0: SUCCESS (0.224s)
[484.742077] Subtest pages: SUCCESS (5.793s)
[485.037591] [071/142] (533s left) kms_big_fb (linear-addfb)
[485.596853] Starting subtest: linear-addfb
[485.600711] Subtest linear-addfb: SUCCESS (0.001s)
[485.784897] [072/142] (532s left) gem_exec_balancer (parallel-out-fence)
[487.059920] Starting subtest: parallel-out-fence
[494.958561] Subtest parallel-out-fence: SUCCESS (7.905s)
[495.100226] [073/142] (523s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[495.620837] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[495.627378] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[495.791243] [074/142] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[496.297535] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[496.303909] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[496.475108] [075/142] (522s left) gem_exec_alignment (single)
[496.867374] Starting subtest: single
[496.895488] Subtest single: SUCCESS (0.028s)
[497.078675] [076/142] (521s left) gem_unfence_active_buffers
[497.669672] [077/142] (521s left) gem_wait (write-wait)
[498.113374] Starting subtest: write-wait
[498.117185] Starting dynamic subtest: all-engines
[499.234999] Dynamic subtest all-engines: SUCCESS (1.119s)
[499.305875] Starting dynamic subtest: rcs0
[500.318191] Dynamic subtest rcs0: SUCCESS (1.078s)
[500.385634] Starting dynamic subtest: bcs0
[501.403928] Dynamic subtest bcs0: SUCCESS (1.081s)
[501.477900] Starting dynamic subtest: vcs0
[502.469345] Dynamic subtest vcs0: SUCCESS (1.058s)
[502.542335] Starting dynamic subtest: vcs1
[503.532963] Dynamic subtest vcs1: SUCCESS (1.059s)
[503.604118] Starting dynamic subtest: vecs0
[504.593859] Dynamic subtest vecs0: SUCCESS (1.057s)
[504.664653] Starting dynamic subtest: ccs0
[505.680318] Dynamic subtest ccs0: SUCCESS (1.082s)
[505.684109] Subtest write-wait: SUCCESS (7.569s)
[506.081199] [078/142] (512s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[506.597402] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[516.929355] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (10.337s)
[517.214183] [079/142] (501s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[517.734907] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[517.741833] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[517.904472] [080/142] (501s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[518.286922] Starting subtest: etime-multi-wait-for-submit-submitted
[518.389500] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[518.555698] [081/142] (500s left) gem_mmap_wc (write-wc-read-gtt)
[518.937808] Subtest write-wc-read-gtt: SKIP (0.000s)
[519.062884] [082/142] (500s left) syncobj_wait (invalid-reset-illegal-handle)
[519.446573] Starting subtest: invalid-reset-illegal-handle
[519.450809] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[519.607273] [083/142] (499s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[519.997356] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[520.128086] [084/142] (499s left) syncobj_timeline (invalid-transfer-illegal-handle)
[520.510145] Starting subtest: invalid-transfer-illegal-handle
[520.513700] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[520.665276] [085/142] (498s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_mc_ccs)
[522.019571] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs
[522.026267] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[523.016746] [086/142] (496s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[523.554979] Starting subtest: x-tiled-64bpp-rotate-180
[530.243043] Subtest x-tiled-64bpp-rotate-180: SUCCESS (6.687s)
[530.953229] [087/142] (488s left) gem_mmap_wc (read-write)
[531.319790] Subtest read-write: SKIP (0.000s)
[531.438425] [088/142] (488s left) v3d/v3d_submit_cl (valid-submission)
[531.908839] Subtest valid-submission: SKIP (0.000s)
[532.046637] [089/142] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[532.545729] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[547.872801] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (15.333s)
[548.042589] [090/142] (471s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[548.381908] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[548.385841] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.003s)
[548.536905] [091/142] (471s left) perf (gen12-mi-rpc)
[549.435416] Starting subtest: gen12-mi-rpc
[549.438935] Starting dynamic subtest: rcs0
[549.515824] Dynamic subtest rcs0: SUCCESS (0.077s)
[549.519913] Subtest gen12-mi-rpc: SUCCESS (0.082s)
[549.633439] [092/142] (470s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[550.053523] Starting subtest: y-tiled-to-vebox-x-tiled
[550.060478] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[550.332673] [093/142] (469s left) kms_invalid_mode (bad-htotal)
[550.823291] Starting subtest: bad-htotal
[550.826805] Starting dynamic subtest: eDP-1-pipe-A
[551.250571] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.420s)
[551.310452] Starting dynamic subtest: eDP-1-pipe-B
[551.314281] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.041s)
[551.366178] Starting dynamic subtest: eDP-1-pipe-C
[551.370059] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.040s)
[551.421221] Starting dynamic subtest: eDP-1-pipe-D
[551.425057] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.040s)
[551.428672] Subtest bad-htotal: SUCCESS (0.579s)
[552.175300] [094/142] (468s left) syncobj_timeline (wait-all-interrupted)
[552.547666] Starting subtest: wait-all-interrupted
[552.653398] Subtest wait-all-interrupted: SUCCESS (0.105s)
[552.808711] [095/142] (467s left) gen9_exec_parse (bb-large)
[553.209912] Subtest bb-large: SKIP (0.000s)
[553.337259] [096/142] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[553.837515] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[553.844576] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[554.011597] [097/142] (466s left) v3d/v3d_submit_cl (bad-extension)
[554.494188] Subtest bad-extension: SKIP (0.000s)
[554.624567] [098/142] (466s left) i915_pm_rps (waitboost)
[554.969405] Starting subtest: waitboost
[555.090649] Subtest waitboost: FAIL (0.080s)
[555.182338] [099/142] (465s left) kms_chamelium_edid (dp-edid-resolution-list)
[556.006272] Subtest dp-edid-resolution-list: SKIP (0.000s)
[556.905360] [100/142] (464s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[557.381818] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[557.391220] Starting dynamic subtest: pipe-A-default-mode
[560.919760] Dynamic subtest pipe-A-default-mode: SUCCESS (3.527s)
[560.923348] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (3.541s)
[561.877628] [101/142] (459s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[562.256712] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[562.379475] [102/142] (458s left) gem_ctx_shared (disjoint-timelines)
[562.799817] Starting subtest: disjoint-timelines
[562.847111] Subtest disjoint-timelines: SUCCESS (0.047s)
[563.172295] [103/142] (458s left) gem_exec_schedule (lateslice)
[563.619586] Starting subtest: lateslice
[563.623831] Starting dynamic subtest: rcs0
[563.674215] Dynamic subtest rcs0: SUCCESS (0.053s)
[563.734544] Starting dynamic subtest: bcs0
[563.737725] Dynamic subtest bcs0: SUCCESS (0.041s)
[563.789114] Starting dynamic subtest: vcs0
[563.792836] Dynamic subtest vcs0: SUCCESS (0.045s)
[563.845843] Starting dynamic subtest: vcs1
[563.849271] Dynamic subtest vcs1: SUCCESS (0.044s)
[563.902184] Starting dynamic subtest: vecs0
[563.905976] Dynamic subtest vecs0: SUCCESS (0.040s)
[563.957736] Starting dynamic subtest: ccs0
[563.960914] Dynamic subtest ccs0: SUCCESS (0.042s)
[563.964096] Subtest lateslice: SUCCESS (0.290s)
[565.694186] [104/142] (455s left) kms_atomic (crtc-invalid-params)
[566.506211] Starting subtest: crtc-invalid-params
[566.636983] Subtest crtc-invalid-params: SUCCESS (0.137s)
[567.995420] [105/142] (453s left) sw_sync (sync_multi_consumer)
[568.377276] Starting subtest: sync_multi_consumer
[571.008566] Subtest sync_multi_consumer: SUCCESS (2.630s)
[571.177088] [106/142] (450s left) drm_read (short-buffer-nonblock)
[572.008520] Starting subtest: short-buffer-nonblock
[572.012311] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[572.256487] [107/142] (449s left) gem_linear_blits (interruptible)
[573.559358] Starting subtest: interruptible
[588.249375] Subtest interruptible: SUCCESS (14.694s)
[588.460555] [108/142] (433s left) kms_content_protection (atomic-dpms)
[589.331999] Starting subtest: atomic-dpms
[593.516122] Subtest atomic-dpms: SKIP (4.180s)
[595.046981] [109/142] (426s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[595.562207] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[610.252432] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (14.695s)
[610.473423] [110/142] (411s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[610.996216] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[611.003214] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[611.187915] [111/142] (410s left) kms_sequence (queue-idle)
[611.686823] Starting subtest: queue-idle
[611.690604] Starting dynamic subtest: eDP-1-pipe-A
[613.891791] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.197s)
[613.925307] Starting dynamic subtest: eDP-1-pipe-B
[616.690384] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.786s)
[616.743757] Starting dynamic subtest: eDP-1-pipe-C
[619.797202] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.099s)
[619.858268] Starting dynamic subtest: eDP-1-pipe-D
[623.147431] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.345s)
[623.150998] Subtest queue-idle: SUCCESS (11.467s)
[624.113453] [112/142] (397s left) gem_ctx_persistence (file)
[624.528246] Starting subtest: file
[624.627898] Subtest file: SUCCESS (0.099s)
[624.823703] [113/142] (397s left) gem_bad_reloc (negative-reloc-bltcopy)
[625.216541] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[625.360766] [114/142] (396s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[626.519296] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[626.526282] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.002s)
[627.768997] [115/142] (394s left) kms_chamelium_hpd (dp-hpd-fast)
[628.642325] Subtest dp-hpd-fast: SKIP (0.000s)
[629.524125] [116/142] (392s left) gem_exec_reloc (basic-write-cpu)
[629.922053] Subtest basic-write-cpu: SKIP (0.000s)
[630.055691] [117/142] (392s left) i915_pm_freq_api (freq-reset)
[630.472778] Starting subtest: freq-reset
[630.476437] Starting dynamic subtest: gt0
[631.407386] Dynamic subtest gt0: SUCCESS (0.929s)
[631.465403] Starting dynamic subtest: gt1
[632.178869] Dynamic subtest gt1: SUCCESS (0.766s)
[632.182993] Subtest freq-reset: SUCCESS (1.704s)
[632.343706] [118/142] (390s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[632.855468] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[632.862306] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[633.023758] [119/142] (389s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[634.599446] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[634.611211] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.014s)
[635.455389] [120/142] (387s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_mc_ccs)
[636.356413] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs
[636.363215] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[637.831487] [121/142] (385s left) vc4/vc4_tiling (set-bad-handle)
[638.324310] Subtest set-bad-handle: SKIP (0.000s)
[638.467490] [122/142] (384s left) gem_mmap_wc (write-read-distinct)
[638.853373] Subtest write-read-distinct: SKIP (0.000s)
[638.977762] [123/142] (384s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[640.612719] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[640.618526] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[641.329784] [124/142] (381s left) sw_sync (sync_busy_fork_unixsocket)
[641.708752] Starting subtest: sync_busy_fork_unixsocket
[641.772150] Subtest sync_busy_fork_unixsocket: SUCCESS (0.064s)
[641.926406] [125/142] (381s left) gem_create (busy-create)
[642.325844] Starting subtest: busy-create
[642.329879] Starting dynamic subtest: smem0
[675.523184] Dynamic subtest smem0: SUCCESS (33.194s)
[675.526971] Subtest busy-create: SUCCESS (33.199s)
[675.847122] [126/142] (347s left) prime_self_import (reimport-vs-gem_close-race)
[676.206619] Starting subtest: reimport-vs-gem_close-race
[681.272753] Subtest reimport-vs-gem_close-race: SUCCESS (5.063s)
[681.465649] [127/142] (342s left) gem_exec_reloc (basic-active)
[681.864567] Subtest basic-active: SKIP (0.000s)
[682.019570] [128/142] (341s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[682.517819] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[682.528296] Starting dynamic subtest: pipe-A-eDP-1
[682.619488] Dynamic subtest pipe-A-eDP-1: SKIP (0.091s)
[682.684778] Starting dynamic subtest: pipe-B-eDP-1
[682.820980] Dynamic subtest pipe-B-eDP-1: SKIP (0.188s)
[682.886289] Starting dynamic subtest: pipe-C-eDP-1
[683.033612] Dynamic subtest pipe-C-eDP-1: SKIP (0.200s)
[683.089357] Starting dynamic subtest: pipe-D-eDP-1
[683.249848] Dynamic subtest pipe-D-eDP-1: SKIP (0.209s)
[683.256996] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.729s)
[683.440704] [129/142] (340s left) gem_exec_fence (basic-wait-all)
[683.878638] Starting subtest: basic-wait-all
[683.969243] Subtest basic-wait-all: SUCCESS (0.090s)
[685.923224] [130/142] (337s left) kms_cursor_crc (cursor-offscreen-256x85)
[687.004524] Starting subtest: cursor-offscreen-256x85
[687.039971] Starting dynamic subtest: pipe-A-eDP-1
[689.630867] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.589s)
[689.742184] Starting dynamic subtest: pipe-D-eDP-1
[692.589708] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.900s)
[692.592303] Subtest cursor-offscreen-256x85: SUCCESS (5.586s)
[693.549591] [131/142] (330s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[695.337892] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[698.364645] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (3.027s)
[699.713306] [132/142] (324s left) gem_exec_schedule (timeslicing)
[700.148045] Starting subtest: timeslicing
[700.151137] Starting dynamic subtest: rcs0
[700.178959] Dynamic subtest rcs0: SUCCESS (0.029s)
[700.237481] Starting dynamic subtest: bcs0
[700.241274] Dynamic subtest bcs0: SUCCESS (0.030s)
[700.300602] Starting dynamic subtest: vcs0
[700.303814] Dynamic subtest vcs0: SUCCESS (0.020s)
[700.360071] Starting dynamic subtest: vcs1
[700.363756] Dynamic subtest vcs1: SUCCESS (0.029s)
[700.419950] Starting dynamic subtest: vecs0
[700.423486] Dynamic subtest vecs0: SUCCESS (0.031s)
[700.478828] Starting dynamic subtest: ccs0
[700.482513] Dynamic subtest ccs0: SUCCESS (0.033s)
[700.485829] Subtest timeslicing: SUCCESS (0.197s)
[701.625763] [133/142] (322s left) i915_selftest (mock)
[706.669152] Starting subtest: mock
[706.673381] Starting dynamic subtest: sanitycheck
[708.407493] Dynamic subtest sanitycheck: SUCCESS (1.737s)
[708.445520] Starting dynamic subtest: shmem
[709.300308] Dynamic subtest shmem: SUCCESS (0.890s)
[709.344724] Starting dynamic subtest: fence
[717.617153] Dynamic subtest fence: SUCCESS (8.312s)
[717.655334] Starting dynamic subtest: scatterlist
[719.360793] Dynamic subtest scatterlist: SUCCESS (1.739s)
[719.400879] Starting dynamic subtest: syncmap
[722.261756] Dynamic subtest syncmap: SUCCESS (2.897s)
[722.301144] Starting dynamic subtest: uncore
[723.012784] Dynamic subtest uncore: SUCCESS (0.747s)
[723.052129] Starting dynamic subtest: ring
[723.760492] Dynamic subtest ring: SUCCESS (0.743s)
[723.796890] Starting dynamic subtest: engine
[724.511211] Dynamic subtest engine: SUCCESS (0.746s)
[724.547964] Starting dynamic subtest: timelines
[744.023374] Dynamic subtest timelines: SUCCESS (19.508s)
[744.060952] Starting dynamic subtest: requests
[755.517862] Dynamic subtest requests: SUCCESS (11.490s)
[755.557148] Starting dynamic subtest: objects
[756.555170] Dynamic subtest objects: SUCCESS (1.033s)
[756.591795] Starting dynamic subtest: phys
[757.569700] Dynamic subtest phys: SUCCESS (1.011s)
[757.607734] Starting dynamic subtest: dmabuf
[758.627811] Dynamic subtest dmabuf: SUCCESS (1.053s)
[758.664370] Starting dynamic subtest: vma
[772.959581] Dynamic subtest vma: SUCCESS (14.329s)
[772.993245] Starting dynamic subtest: evict
[780.412933] Dynamic subtest evict: FAIL (7.411s)
[780.417913] Subtest mock: FAIL (73.726s)
[780.619541] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         1659 [max: 8192]
 direct dependencies:                 17412 [max: 32768]
 indirect dependencies:              104376
 all direct dependencies:            320728
 dependency chains:                   24175 [max: 131072]
 dependency chain hlocks used:        98453 [max: 655360]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     192
 in-softirq chains:                     578
 in-process chains:                   23405
 stack-trace entries:                229303 [max: 1048576]
 number of stack traces:              11315
 number of stack hash chains:          8152
 combined max dependencies:      2615550282
 hardirq-safe locks:                     96
 hardirq-unsafe locks:                  988
 softirq-safe locks:                    188
 softirq-unsafe locks:                  899
 irq-safe locks:                        211
 irq-unsafe locks:                      988
 hardirq-read-safe locks:                 3
 hardirq-read-unsafe locks:             303
 softirq-read-safe locks:                 7
 softirq-read-unsafe locks:             298
 irq-read-safe locks:                     7
 irq-read-unsafe locks:                 303
 uncategorized locks:                   270
 unused locks:                            1
 max locking depth:                      16
 max bfs queue depth:                   438
 max lock class index:                 1855
 chain lookup misses:                 37163
 chain lookup hits:               382888241
 cyclic checks:                       37429
 redundant checks:                        0
 redundant links:                         0
 find-mask forwards checks:            6394
 find-mask backwards checks:           3362
 hardirq on events:               215783003
 hardirq off events:              215782981
 redundant hardirq ons:                  98
 redundant hardirq offs:                 25
 softirq on events:                 1365132
 softirq off events:                1365132
 redundant softirq ons:                   0
 redundant softirq offs:                  0
 debug_locks:                             0

 zapped classes:                        668
 zapped lock chains:                  12505
 large chain blocks:                      1

[780.623958] Closing watchdogs
Done.