[53.442157] Initializing watchdogs
[53.442434]   /dev/watchdog0
[53.459312] [001/142] (960s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[53.712438] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[53.715197] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[53.903473] [002/142] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[54.210216] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[54.211757] Starting dynamic subtest: pipe-A-valid-mode
[54.642910] Dynamic subtest pipe-A-valid-mode: SKIP (0.430s)
[54.646422] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.432s)
[55.006209] [003/142] (959s left) feature_discovery (psr2)
[55.318170] Starting subtest: psr2
[55.320968] Subtest psr2: SKIP (0.000s)
[55.403177] [004/142] (958s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[55.734430] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[55.737364] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[55.836613] [005/142] (958s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_mc_ccs)
[56.310614] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_mc_ccs
[56.313302] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[56.840919] [006/142] (957s left) perf_pmu (rc6-suspend)
[57.065943] Starting subtest: rc6-suspend
[81.014238] Subtest rc6-suspend: SUCCESS (7.543s)
[82.431707] [007/142] (949s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[82.752706] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[84.597243] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SUCCESS (1.848s)
[84.733423] [008/142] (946s left) gem_exec_whisper (basic-sync-all)
[84.973030] Starting subtest: basic-sync-all
[95.627601] Subtest basic-sync-all: SUCCESS (10.654s)
[95.835140] [009/142] (935s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[96.159882] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[97.645314] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.486s)
[97.986397] [010/142] (933s left) kms_properties (plane-properties-legacy)
[98.285623] Starting subtest: plane-properties-legacy
[100.058048] Subtest plane-properties-legacy: SUCCESS (1.774s)
[100.383345] [011/142] (931s left) i915_query (hwconfig_table)
[100.583228] Starting subtest: hwconfig_table
[100.585997] Subtest hwconfig_table: SKIP (0.000s)
[100.664866] [012/142] (931s left) gem_ctx_exec (basic-invalid-context)
[100.870736] Starting subtest: basic-invalid-context
[100.877679] Subtest basic-invalid-context: SUCCESS (0.007s)
[100.981575] [013/142] (930s left) gem_ctx_param (invalid-size-get)
[101.183089] Starting subtest: invalid-size-get
[101.184676] Subtest invalid-size-get: SUCCESS (0.000s)
[101.266872] [014/142] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[101.579105] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[101.581779] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[101.681871] [015/142] (930s left) gem_ctx_bad_destroy (double-destroy)
[101.885224] Starting subtest: double-destroy
[101.886589] Subtest double-destroy: SUCCESS (0.000s)
[101.964618] [016/142] (929s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_mc_ccs)
[102.388740] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs
[102.393466] Subtest pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[102.956035] [017/142] (929s left) kms_cursor_crc (cursor-offscreen-256x256)
[103.268966] Starting subtest: cursor-offscreen-256x256
[103.279242] Starting dynamic subtest: pipe-A-DP-1
[105.766147] Dynamic subtest pipe-A-DP-1: SUCCESS (2.487s)
[105.862134] Starting dynamic subtest: pipe-C-DP-1
[108.644175] Dynamic subtest pipe-C-DP-1: SUCCESS (2.810s)
[108.645452] Subtest cursor-offscreen-256x256: SUCCESS (5.377s)
[109.002033] [018/142] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[109.303682] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[111.723971] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.423s)
[111.879166] [019/142] (920s left) kms_lease (simple_lease)
[112.172808] Starting subtest: simple_lease
[112.174076] Starting dynamic subtest: pipe-A-DP-1
[112.656621] Dynamic subtest pipe-A-DP-1: SUCCESS (0.486s)
[112.680749] Starting dynamic subtest: pipe-B-DP-1
[113.293519] Dynamic subtest pipe-B-DP-1: SUCCESS (0.634s)
[113.314935] Starting dynamic subtest: pipe-C-DP-1
[113.921794] Dynamic subtest pipe-C-DP-1: SUCCESS (0.626s)
[113.923614] Subtest simple_lease: SUCCESS (1.753s)
[114.233653] [020/142] (917s left) kms_psr2_sf (overlay-plane-update-continuous-sf)
[114.434996] Subtest overlay-plane-update-continuous-sf: SKIP (0.000s)
[114.495849] [021/142] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[114.801150] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[114.803737] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[114.897584] [022/142] (917s left) i915_pm_dc (dc6-psr)
[116.212012] Starting subtest: dc6-psr
[116.216600] Subtest dc6-psr: SKIP (0.000s)
[116.380806] [023/142] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[116.693601] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[116.696283] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[116.798784] [024/142] (915s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[117.106533] Starting subtest: psr-modesetfrombusy
[117.109069] Subtest psr-modesetfrombusy: SKIP (0.000s)
[117.214695] [025/142] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[117.526147] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[117.528777] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[117.635086] [026/142] (914s left) kms_plane_cursor (overlay)
[117.935990] Starting subtest: overlay
[117.938576] Starting dynamic subtest: pipe-A-DP-1-size-64
[120.356654] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.421s)
[120.426098] Starting dynamic subtest: pipe-A-DP-1-size-128
[122.840059] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.433s)
[122.909964] Starting dynamic subtest: pipe-A-DP-1-size-256
[125.306699] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.416s)
[125.478247] Starting dynamic subtest: pipe-B-DP-1-size-64
[128.127304] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.667s)
[128.199058] Starting dynamic subtest: pipe-B-DP-1-size-128
[130.611999] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.430s)
[130.682939] Starting dynamic subtest: pipe-B-DP-1-size-256
[133.077344] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.416s)
[133.249098] Starting dynamic subtest: pipe-C-DP-1-size-64
[135.884429] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.655s)
[135.952833] Starting dynamic subtest: pipe-C-DP-1-size-128
[138.351824] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.416s)
[138.419831] Starting dynamic subtest: pipe-C-DP-1-size-256
[140.818054] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.416s)
[140.952047] Subtest overlay: SUCCESS (23.017s)
[141.268687] [027/142] (891s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[141.662718] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[141.962940] [028/142] (890s left) gem_eio (in-flight-internal-10ms)
[142.202422] Starting subtest: in-flight-internal-10ms
[142.317999] Subtest in-flight-internal-10ms: SUCCESS (0.115s)
[142.527171] [029/142] (889s left) gem_exec_fair (basic-pace)
[142.756958] Starting subtest: basic-pace
[142.760296] Starting dynamic subtest: rcs0
[147.686109] Dynamic subtest rcs0: SUCCESS (4.924s)
[147.713789] Starting dynamic subtest: bcs0
[147.716270] Dynamic subtest bcs0: SKIP (0.009s)
[147.736265] Starting dynamic subtest: vcs0
[152.547646] Dynamic subtest vcs0: SUCCESS (4.850s)
[152.568115] Starting dynamic subtest: vecs0
[157.376303] Dynamic subtest vecs0: SUCCESS (4.827s)
[157.377879] Subtest basic-pace: SUCCESS (14.618s)
[157.576930] [030/142] (874s left) gem_exec_fence (syncobj-channel)
[158.326193] Starting subtest: syncobj-channel
[159.394173] Subtest syncobj-channel: SUCCESS (1.067s)
[159.726236] [031/142] (872s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_mc_ccs)
[160.127368] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs
[160.132109] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[160.729141] [032/142] (871s left) gem_mmap_gtt (fault-concurrent)
[160.931396] Starting subtest: fault-concurrent
[164.331689] Subtest fault-concurrent: SUCCESS (3.400s)
[164.511401] [033/142] (868s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[165.000566] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[165.003274] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[165.496008] [034/142] (867s left) sw_sync (sync_multi_timeline_wait)
[165.693029] Starting subtest: sync_multi_timeline_wait
[165.694681] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[165.761641] [035/142] (866s left) sw_sync (timeline_closed_signaled)
[165.958671] Starting subtest: timeline_closed_signaled
[165.960463] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[166.028885] [036/142] (866s left) kms_big_fb (linear-32bpp-rotate-0)
[166.343799] Starting subtest: linear-32bpp-rotate-0
[172.120279] Subtest linear-32bpp-rotate-0: SUCCESS (5.775s)
[172.646222] [037/142] (860s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[172.960344] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[172.963037] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[173.062832] [038/142] (859s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[173.382303] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[173.385541] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[173.480623] [039/142] (859s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[173.782982] Starting subtest: primary-yf-tiled-reflect-x-0
[173.785869] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.003s)
[173.878878] [040/142] (858s left) gem_exec_schedule (preempt-queue-contexts)
[174.118208] Starting subtest: preempt-queue-contexts
[174.120021] Starting dynamic subtest: rcs0
[175.159888] Dynamic subtest rcs0: SUCCESS (1.042s)
[175.186791] Starting dynamic subtest: bcs0
[176.177466] Dynamic subtest bcs0: SUCCESS (1.016s)
[176.211677] Starting dynamic subtest: vcs0
[177.223536] Dynamic subtest vcs0: SUCCESS (1.044s)
[177.249930] Starting dynamic subtest: vecs0
[178.273001] Dynamic subtest vecs0: SUCCESS (1.048s)
[178.274352] Subtest preempt-queue-contexts: SUCCESS (4.157s)
[178.662672] [041/142] (854s left) kms_cursor_crc (cursor-random-512x512)
[178.975797] Starting subtest: cursor-random-512x512
[178.982487] Subtest cursor-random-512x512: SKIP (0.003s)
[179.095851] [042/142] (853s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[179.401706] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[179.404315] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[179.495807] [043/142] (853s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[179.903754] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[180.185911] [044/142] (852s left) gem_exec_whisper (basic-queues-priority)
[180.410258] Starting subtest: basic-queues-priority
[193.560663] Subtest basic-queues-priority: SUCCESS (13.148s)
[193.770811] [045/142] (839s left) core_auth (getclient-simple)
[193.971404] Starting subtest: getclient-simple
[193.978961] Subtest getclient-simple: SUCCESS (0.006s)
[194.063879] [046/142] (839s left) kms_content_protection (lic)
[194.394628] Starting subtest: LIC
[194.423759] Starting dynamic subtest: pipe-A-DP-1
[314.744252] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[315.468874] Closing watchdogs
[315.475992] Initializing watchdogs
[315.476175]   /dev/watchdog0
[315.502427] [047/142] (717s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[315.820617] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[315.823120] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[315.933060] [048/142] (717s left) kms_psr (psr2_primary_render)
[316.134089] Subtest psr2_primary_render: SKIP (0.000s)
[316.199086] [049/142] (717s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[316.412283] Starting subtest: tiled-to-tiled
[316.530275] Subtest tiled-to-tiled: SUCCESS (0.115s)
[316.632920] [050/142] (716s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[316.932745] Starting subtest: addfb25-yf-tiled-legacy
[316.934165] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[317.049874] [051/142] (716s left) gem_mmap_gtt (medium-copy-xy)
[317.250231] Starting subtest: medium-copy-XY
[324.544256] Subtest medium-copy-XY: SUCCESS (7.294s)
[324.656923] [052/142] (708s left) gem_ctx_param (basic-default)
[324.971193] Starting subtest: basic-default
[324.972845] Subtest basic-default: SUCCESS (0.000s)
[325.066898] [053/142] (708s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs)
[325.625609] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs
[325.628370] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[326.077274] [054/142] (707s left) kms_vblank (pipe-c-ts-continuation-modeset)
[326.376826] Starting subtest: pipe-C-ts-continuation-modeset
[327.484743] Subtest pipe-C-ts-continuation-modeset: SUCCESS (1.110s)
[327.816563] [055/142] (705s left) gem_exec_reloc (basic-cpu-read-active)
[328.030477] Starting subtest: basic-cpu-read-active
[328.174074] Subtest basic-cpu-read-active: SUCCESS (0.143s)
[328.366416] [056/142] (705s left) gem_exec_params (readonly)
[328.576030] Starting subtest: readonly
[328.581143] Subtest readonly: SUCCESS (0.003s)
[328.698995] [057/142] (704s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[328.999758] Starting subtest: short-flip-before-cursor-toggle
[330.289249] Subtest short-flip-before-cursor-toggle: SUCCESS (1.285s)
[330.630943] [058/142] (703s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[330.951050] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[330.953787] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[331.061738] [059/142] (702s left) gem_ctx_persistence (process)
[331.272117] Starting subtest: process
[331.392453] Subtest process: SUCCESS (0.119s)
[331.495295] [060/142] (702s left) prime_mmap (test_correct_cpu_write)
[331.696782] Starting subtest: test_correct_cpu_write
[331.698594] Starting dynamic subtest: test_correct_cpu_write-smem
[331.700206] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.001s)
[331.701585] Subtest test_correct_cpu_write: SUCCESS (0.003s)
[331.811927] [061/142] (702s left) kms_invalid_mode (bad-vsync-start)
[332.110792] Starting subtest: bad-vsync-start
[332.112821] Starting dynamic subtest: DP-1-pipe-A
[332.206438] Dynamic subtest DP-1-pipe-A: SUCCESS (0.099s)
[332.245830] Starting dynamic subtest: DP-1-pipe-B
[332.247356] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s)
[332.279148] Starting dynamic subtest: DP-1-pipe-C
[332.281241] Dynamic subtest DP-1-pipe-C: SUCCESS (0.015s)
[332.283422] Subtest bad-vsync-start: SUCCESS (0.140s)
[332.583770] [062/142] (701s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[333.279191] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[333.605463] [063/142] (700s left) v3d/v3d_mmap (mmap-bo)
[333.877946] Subtest mmap-bo: SKIP (0.000s)
[333.955203] [064/142] (700s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs)
[334.634043] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[334.945691] [065/142] (699s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[335.151655] Starting subtest: invalid-multi-wait-all-unsubmitted
[335.152947] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[335.246009] [066/142] (698s left) kms_rotation_crc (cursor-rotation-180)
[335.541541] Starting subtest: cursor-rotation-180
[336.340166] Subtest cursor-rotation-180: SUCCESS (0.800s)
[336.755982] [067/142] (697s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs)
[337.413565] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs
[337.417365] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[337.750661] [068/142] (696s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[338.415001] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[338.725702] [069/142] (695s left) kms_flip (flip-vs-rmfb)
[339.020547] Starting subtest: flip-vs-rmfb
[339.024675] Starting dynamic subtest: A-DP1
[349.558226] Dynamic subtest A-DP1: SUCCESS (10.535s)
[349.587435] Starting dynamic subtest: B-DP1
[360.008554] Dynamic subtest B-DP1: SUCCESS (10.447s)
[360.035066] Starting dynamic subtest: C-DP1
[370.456534] Dynamic subtest C-DP1: SUCCESS (10.444s)
[370.461409] Subtest flip-vs-rmfb: SUCCESS (31.442s)
[370.901297] [070/142] (663s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[371.102723] Starting subtest: invalid-single-wait-unsubmitted
[371.104538] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[371.198421] [071/142] (663s left) kms_flip (flip-vs-modeset-vs-hang)
[371.484762] Starting subtest: flip-vs-modeset-vs-hang
[371.486078] Starting dynamic subtest: A-DP1
[385.324907] Dynamic subtest A-DP1: SUCCESS (13.837s)
[385.349217] Starting dynamic subtest: C-DP1
[399.341699] Dynamic subtest C-DP1: SUCCESS (14.013s)
[399.342997] Subtest flip-vs-modeset-vs-hang: SUCCESS (27.859s)
[399.726545] [072/142] (634s left) kms_sequence (get-forked-busy)
[400.034926] Starting subtest: get-forked-busy
[400.036247] Starting dynamic subtest: DP-1-pipe-A
[402.529559] Dynamic subtest DP-1-pipe-A: SUCCESS (2.491s)
[402.559293] Starting dynamic subtest: DP-1-pipe-B
[405.337680] Dynamic subtest DP-1-pipe-B: SUCCESS (2.803s)
[405.363936] Starting dynamic subtest: DP-1-pipe-C
[408.215913] Dynamic subtest DP-1-pipe-C: SUCCESS (2.875s)
[408.217582] Subtest get-forked-busy: SUCCESS (8.183s)
[408.547095] [073/142] (625s left) kms_cursor_edge_walk (256x256-left-edge)
[408.846910] Starting subtest: 256x256-left-edge
[408.848181] Starting dynamic subtest: pipe-A-DP-1
[412.493813] Dynamic subtest pipe-A-DP-1: SUCCESS (3.647s)
[412.521539] Starting dynamic subtest: pipe-C-DP-1
[415.983219] Dynamic subtest pipe-C-DP-1: SUCCESS (3.481s)
[415.984970] Subtest 256x256-left-edge: SUCCESS (7.139s)
[416.309781] [074/142] (618s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[416.623903] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[416.626616] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[416.724543] [075/142] (617s left) perf_pmu (busy-accuracy-2)
[416.937360] Starting subtest: busy-accuracy-2
[416.938916] Starting dynamic subtest: rcs0
[419.995078] Dynamic subtest rcs0: SUCCESS (3.055s)
[420.019195] Starting dynamic subtest: bcs0
[423.061656] Dynamic subtest bcs0: SUCCESS (3.063s)
[423.085438] Starting dynamic subtest: vcs0
[426.131393] Dynamic subtest vcs0: SUCCESS (3.067s)
[426.155186] Starting dynamic subtest: vecs0
[429.198932] Dynamic subtest vecs0: SUCCESS (3.065s)
[429.200347] Subtest busy-accuracy-2: SUCCESS (12.262s)
[429.306609] [076/142] (605s left) kms_addfb_basic (too-wide)
[429.611940] Starting subtest: too-wide
[429.613626] Subtest too-wide: SUCCESS (0.000s)
[429.724001] [077/142] (604s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[430.017243] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[430.023764] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.005s)
[430.124673] [078/142] (604s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[430.429675] Starting subtest: cursorA-vs-flipB-atomic-transitions
[430.432757] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.003s)
[430.523721] [079/142] (604s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[430.836699] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[430.839825] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[430.940843] [080/142] (603s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-75)
[431.245148] Starting subtest: plane-downscale-with-rotation-factor-0-75
[431.246697] Starting dynamic subtest: pipe-A-DP-1
[431.352436] Dynamic subtest pipe-A-DP-1: SKIP (0.105s)
[431.382312] Starting dynamic subtest: pipe-B-DP-1
[431.750586] Dynamic subtest pipe-B-DP-1: SKIP (0.389s)
[431.781082] Starting dynamic subtest: pipe-C-DP-1
[432.133489] Dynamic subtest pipe-C-DP-1: SKIP (0.376s)
[432.136763] Subtest plane-downscale-with-rotation-factor-0-75: SKIP (0.887s)
[432.536605] [081/142] (602s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[432.833598] Starting subtest: flip-vs-cursor-crc-atomic
[433.476295] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.643s)
[433.833237] [082/142] (600s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs)
[434.396945] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs
[434.927824] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.531s)
[435.450723] [083/142] (599s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[435.776007] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[437.153061] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.377s)
[437.302833] [084/142] (597s left) gem_exec_nop (basic-series)
[437.534418] Starting subtest: basic-series
[440.597878] Subtest basic-series: SUCCESS (3.062s)
[440.834204] [085/142] (594s left) gem_userptr_blits (set-cache-level)
[441.044290] Starting subtest: set-cache-level
[441.045706] Subtest set-cache-level: SUCCESS (0.001s)
[441.217364] [086/142] (593s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[441.830564] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[441.833101] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[442.225965] [087/142] (592s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[442.436003] Starting subtest: basic-gtt-cpu-noreloc
[442.447764] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.011s)
[442.642435] [088/142] (592s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[442.947518] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[442.950293] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[443.059400] [089/142] (592s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[443.378195] Starting subtest: yf-tiled-8bpp-rotate-270
[443.381196] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[443.492800] [090/142] (591s left) i915_getparams_basic (basic-subslice-total)
[443.693013] Starting subtest: basic-subslice-total
[443.696412] Subtest basic-subslice-total: SUCCESS (0.000s)
[443.792251] [091/142] (591s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[444.089849] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[444.091141] Starting dynamic subtest: pipe-A-valid-mode
[444.205671] Dynamic subtest pipe-A-valid-mode: SKIP (0.115s)
[444.208485] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.119s)
[444.557945] [092/142] (590s left) i915_pm_rpm (pm-tiling)
[446.382192] Starting subtest: pm-tiling
[448.508530] Subtest pm-tiling: SUCCESS (2.126s)
[448.733637] [093/142] (586s left) drm_fdinfo (most-busy-check-all)
[448.941683] Starting subtest: most-busy-check-all
[448.943287] Starting dynamic subtest: rcs0
[449.465253] Dynamic subtest rcs0: SUCCESS (0.522s)
[449.497701] Starting dynamic subtest: bcs0
[449.989124] Dynamic subtest bcs0: SUCCESS (0.521s)
[450.021851] Starting dynamic subtest: vcs0
[450.513129] Dynamic subtest vcs0: SUCCESS (0.521s)
[450.548107] Starting dynamic subtest: vecs0
[451.033147] Dynamic subtest vecs0: SUCCESS (0.518s)
[451.034876] Subtest most-busy-check-all: SUCCESS (2.093s)
[451.132068] [094/142] (584s left) sysfs_timeslice_duration (invalid)
[451.340144] Starting subtest: invalid
[451.344951] Starting dynamic subtest: vecs0
[451.346579] Dynamic subtest vecs0: SUCCESS (0.001s)
[451.373832] Starting dynamic subtest: vcs0
[451.375113] Dynamic subtest vcs0: SUCCESS (0.001s)
[451.398526] Starting dynamic subtest: bcs0
[451.399976] Dynamic subtest bcs0: SUCCESS (0.001s)
[451.424359] Starting dynamic subtest: rcs0
[451.425656] Dynamic subtest rcs0: SUCCESS (0.001s)
[451.426900] Subtest invalid: SUCCESS (0.017s)
[451.460643] [095/142] (583s left) kms_dsc (dsc-with-bpc-formats)
[451.765422] Subtest dsc-with-bpc-formats: SKIP (0.000s)
[451.830539] [096/142] (583s left) v3d/v3d_submit_cl (single-out-sync)
[452.086659] Subtest single-out-sync: SKIP (0.000s)
[452.164720] [097/142] (583s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[452.486297] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[454.769750] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (2.286s)
[454.915594] [098/142] (580s left) perf (invalid-remove-userspace-config)
[455.257468] Starting subtest: invalid-remove-userspace-config
[455.297256] Subtest invalid-remove-userspace-config: SUCCESS (0.039s)
[455.348723] [099/142] (580s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[455.553628] Starting subtest: multi-wait-available-submitted-signaled
[455.555004] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.002s)
[455.647863] [100/142] (579s left) gem_mmap_gtt (cpuset-big-copy-odd)
[455.847635] Starting subtest: cpuset-big-copy-odd
[479.054703] Subtest cpuset-big-copy-odd: SUCCESS (23.207s)
[479.515123] [101/142] (556s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[479.951384] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[479.953962] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[480.065909] [102/142] (555s left) syncobj_wait (wait-for-submit-complex)
[480.285570] Starting subtest: wait-for-submit-complex
[480.348522] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[480.453729] [103/142] (555s left) vc4/vc4_tiling (set-bad-modifier)
[480.721895] Subtest set-bad-modifier: SKIP (0.000s)
[480.799088] [104/142] (554s left) kms_flip (absolute-wf_vblank-interruptible)
[481.098073] Starting subtest: absolute-wf_vblank-interruptible
[481.104065] Starting dynamic subtest: A-DP1
[491.804698] Dynamic subtest A-DP1: SUCCESS (10.700s)
[491.833496] Starting dynamic subtest: B-DP1
[502.228970] Dynamic subtest B-DP1: SUCCESS (10.419s)
[502.258385] Starting dynamic subtest: C-DP1
[512.681532] Dynamic subtest C-DP1: SUCCESS (10.451s)
[512.686746] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.586s)
[513.108411] [105/142] (522s left) vc4/vc4_label_bo (set-kernel-name)
[513.360712] Subtest set-kernel-name: SKIP (0.000s)
[513.441384] [106/142] (522s left) kms_flip (wf_vblank-ts-check-interruptible)
[513.739801] Starting subtest: wf_vblank-ts-check-interruptible
[513.745048] Starting dynamic subtest: A-DP1
[524.562772] Dynamic subtest A-DP1: SUCCESS (10.815s)
[524.587987] Starting dynamic subtest: B-DP1
[535.278420] Dynamic subtest B-DP1: SUCCESS (10.716s)
[535.306001] Starting dynamic subtest: C-DP1
[546.015743] Dynamic subtest C-DP1: SUCCESS (10.734s)
[546.021501] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.279s)
[546.436151] [107/142] (489s left) kms_atomic_transition (modeset-transition-nonblocking)
[546.736527] Starting subtest: modeset-transition-nonblocking
[546.737987] Starting dynamic subtest: 1x-outputs
[551.610799] Dynamic subtest 1x-outputs: SUCCESS (4.877s)
[551.745184] Subtest modeset-transition-nonblocking: SUCCESS (5.011s)
[552.096756] [108/142] (483s left) kms_fbcon_fbt (fbc-suspend)
[552.309059] Starting subtest: fbc-suspend
[601.363380] Subtest fbc-suspend: SUCCESS (16.756s)
[602.425485] [109/142] (466s left) gem_exec_schedule (u-semaphore-user)
[602.665259] Starting subtest: u-semaphore-user
[602.685305] Subtest u-semaphore-user: SUCCESS (0.021s)
[603.044456] [110/142] (466s left) prime_busy (hang)
[603.254879] Starting subtest: hang
[603.256515] Starting dynamic subtest: rcs0
[609.622834] Dynamic subtest rcs0: SUCCESS (6.364s)
[609.647316] Starting dynamic subtest: bcs0
[616.599616] Dynamic subtest bcs0: SUCCESS (6.973s)
[616.623689] Starting dynamic subtest: vcs0
[623.575360] Dynamic subtest vcs0: SUCCESS (6.973s)
[623.599440] Starting dynamic subtest: vecs0
[630.615208] Dynamic subtest vecs0: SUCCESS (7.037s)
[630.616550] Subtest hang: SUCCESS (27.360s)
[630.710037] [111/142] (438s left) gem_pwrite (basic-exhaustion)
[630.909379] Starting subtest: basic-exhaustion
[652.100791] Subtest basic-exhaustion: SUCCESS (21.191s)
[652.214135] [112/142] (417s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[652.535308] Starting subtest: cursorA-vs-flipB-legacy
[652.537915] Subtest cursorA-vs-flipB-legacy: SKIP (0.002s)
[652.628706] [113/142] (416s left) prime_vgem (basic-fence-mmap)
[652.844926] Starting subtest: basic-fence-mmap
[652.909614] Subtest basic-fence-mmap: SUCCESS (0.064s)
[653.011468] [114/142] (416s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[653.415881] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[653.716428] [115/142] (415s left) kms_vblank (pipe-a-query-forked)
[654.027605] Starting subtest: pipe-A-query-forked
[656.394194] Subtest pipe-A-query-forked: SUCCESS (2.369s)
[656.742314] [116/142] (412s left) vc4/vc4_create_bo (create-bo-zeroed)
[657.011560] Subtest create-bo-zeroed: SKIP (0.000s)
[657.091358] [117/142] (412s left) gem_blits (basic)
[657.300201] Starting subtest: basic
[671.061809] Subtest basic: SUCCESS (13.760s)
[671.191499] [118/142] (398s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf_tiled_ccs)
[671.840600] Starting subtest: pipe-C-crc-sprite-planes-basic-yf_tiled_ccs
[671.846409] Subtest pipe-C-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.004s)
[672.186261] [119/142] (397s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[672.507539] Starting subtest: 4-tiled-32bpp-rotate-90
[672.510700] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[672.604539] [120/142] (397s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[672.912014] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[672.914974] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[673.603424] [121/142] (396s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[673.914439] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[673.916939] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[674.019527] [122/142] (395s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[675.819713] Starting subtest: dpms-mode-unset-non-lpsp
[677.421900] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.602s)
[677.907036] [123/142] (392s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[678.220469] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[678.224759] Starting dynamic subtest: pipe-A-DP-1
[678.258066] Dynamic subtest pipe-A-DP-1: SKIP (0.032s)
[678.286229] Starting dynamic subtest: pipe-B-DP-1
[678.342828] Dynamic subtest pipe-B-DP-1: SKIP (0.079s)
[678.368269] Starting dynamic subtest: pipe-C-DP-1
[678.426702] Dynamic subtest pipe-C-DP-1: SKIP (0.080s)
[678.429203] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.207s)
[678.539369] [124/142] (391s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[678.858383] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[678.861290] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[678.973266] [125/142] (391s left) kms_vblank (pipe-d-ts-continuation-dpms-rpm)
[679.284887] Subtest pipe-D-ts-continuation-dpms-rpm: SKIP (0.000s)
[679.372259] [126/142] (390s left) gem_userptr_blits (coherency-sync)
[679.614944] Starting subtest: coherency-sync
[680.009889] Subtest coherency-sync: SKIP (0.382s)
[680.168312] [127/142] (389s left) gem_exec_params (rsvd2-dirt)
[680.501063] Starting subtest: rsvd2-dirt
[680.504651] Subtest rsvd2-dirt: SKIP (0.000s)
[680.606157] [128/142] (389s left) kms_plane_scaling (plane-upscale-with-modifiers-20x20)
[680.919602] Starting subtest: plane-upscale-with-modifiers-20x20
[680.922147] Starting dynamic subtest: pipe-A-DP-1
[681.389457] Dynamic subtest pipe-A-DP-1: SUCCESS (0.471s)
[681.418752] Starting dynamic subtest: pipe-B-DP-1
[682.178539] Dynamic subtest pipe-B-DP-1: SUCCESS (0.784s)
[682.229334] Starting dynamic subtest: pipe-C-DP-1
[682.780731] Dynamic subtest pipe-C-DP-1: SUCCESS (0.597s)
[682.782246] Subtest plane-upscale-with-modifiers-20x20: SUCCESS (1.867s)
[683.200051] [129/142] (387s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[683.512369] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[683.515337] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[683.616054] [130/142] (386s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[683.842354] Starting subtest: yf-tiled-ccs-to-y-tiled
[683.844094] Starting dynamic subtest: smem
[684.161832] Dynamic subtest smem: SUCCESS (0.319s)
[684.164352] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.324s)
[684.384025] [131/142] (385s left) gem_mmap_wc (bad-object)
[684.585930] Starting subtest: bad-object
[684.587354] Subtest bad-object: SUCCESS (0.000s)
[684.699004] [132/142] (385s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[685.268511] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[685.275513] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[685.701658] [133/142] (384s left) syncobj_timeline (signal-point-0)
[685.922524] Starting subtest: signal-point-0
[685.924173] Subtest signal-point-0: SUCCESS (0.001s)
[686.018722] [134/142] (384s left) gem_workarounds (basic-read)
[686.260723] Starting subtest: basic-read
[686.283650] Subtest basic-read: SUCCESS (0.023s)
[686.385593] [135/142] (384s left) gem_exec_alignment (pi-isolated)
[686.599427] Starting subtest: pi-isolated
[699.428990] Killing the test because the kernel is tainted.
[700.645105] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         1826 [max: 8192]
 direct dependencies:                 18730 [max: 32768]
 indirect dependencies:              162588
 all direct dependencies:            363370
 dependency chains:                   27138 [max: 131072]
 dependency chain hlocks used:       118021 [max: 655360]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     250
 in-softirq chains:                     704
 in-process chains:                   26184
 stack-trace entries:                172385 [max: 1048576]
 number of stack traces:               8725
 number of stack hash chains:          6771
 combined max dependencies:       338599379
 hardirq-safe locks:                     91
 hardirq-unsafe locks:                 1077
 softirq-safe locks:                    216
 softirq-unsafe locks:                  988
 irq-safe locks:                        229
 irq-unsafe locks:                     1077
 hardirq-read-safe locks:                 4
 hardirq-read-unsafe locks:             330
 softirq-read-safe locks:                 8
 softirq-read-unsafe locks:             325
 irq-read-safe locks:                     8
 irq-read-unsafe locks:                 330
 uncategorized locks:                   305
 unused locks:                            1
 max locking depth:                      16
 max bfs queue depth:                   412
 max lock class index:                 1825
 chain lookup misses:                 27310
 chain lookup hits:               296485700
 cyclic checks:                       27681
 redundant checks:                        0
 redundant links:                         0
 find-mask forwards checks:            4719
 find-mask backwards checks:           2722
 hardirq on events:               185031643
 hardirq off events:              185031640
 redundant hardirq ons:                  44
 redundant hardirq offs:                 82
 softirq on events:                 1408411
 softirq off events:                1408411
 redundant softirq ons:                   0
 redundant softirq offs:                  0
 debug_locks:                             0

 zapped classes:                          1
 zapped lock chains:                    109
 large chain blocks:                      1

[700.647073] Closing watchdogs
Done.