[50.477613] Initializing watchdogs
[50.477806]   /dev/watchdog0
[50.494415] [001/142] (960s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[50.783470] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[50.789462] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[50.868636] [002/142] (960s left) gem_exec_reloc (basic-gtt-wc)
[51.047922] Starting subtest: basic-gtt-wc
[51.068620] Subtest basic-gtt-wc: SUCCESS (0.021s)
[51.235947] [003/142] (959s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs)
[51.964660] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs
[51.971117] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[52.248888] [004/142] (958s left) gem_reg_read (timestamp-monotonic)
[52.404991] Starting subtest: timestamp-monotonic
[56.990530] Subtest timestamp-monotonic: SUCCESS (4.588s)
[57.066515] [005/142] (954s left) kms_pipe_crc_basic (suspend-read-crc)
[57.300810] Starting subtest: suspend-read-crc
[57.304196] Starting dynamic subtest: pipe-A-HDMI-A-1
[75.077478] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.634s)
[75.099639] Starting dynamic subtest: pipe-B-HDMI-A-2
[94.172175] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.396s)
[94.190765] Starting dynamic subtest: pipe-C-HDMI-A-1
[113.347237] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.914s)
[113.350568] Subtest suspend-read-crc: SUCCESS (7.955s)
[117.593229] [006/142] (945s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[118.244683] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[118.250928] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[118.611809] [007/142] (944s left) i915_pm_rpm (i2c)
[120.842471] Starting subtest: i2c
[122.455207] Subtest i2c: SUCCESS (1.615s)
[122.733095] [008/142] (940s left) kms_rotation_crc (primary-rotation-90)
[122.966793] Starting subtest: primary-rotation-90
[138.376634] Subtest primary-rotation-90: SUCCESS (15.409s)
[138.574734] [009/142] (924s left) gem_sync (basic-store-all)
[138.763610] Starting subtest: basic-store-all
[141.190657] Subtest basic-store-all: SUCCESS (2.435s)
[141.392514] [010/142] (922s left) gem_exec_reloc (basic-gtt-read-active)
[141.547136] Starting subtest: basic-gtt-read-active
[141.674997] Subtest basic-gtt-read-active: SUCCESS (0.129s)
[141.841978] [011/142] (921s left) gem_ctx_param (invalid-set-no-zeromap)
[141.999277] Starting subtest: invalid-set-no-zeromap
[142.002496] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[142.074826] [012/142] (921s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[142.241821] Starting subtest: yf-tiled-to-vebox-y-tiled
[142.250073] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[142.441909] [013/142] (921s left) feature_discovery (display)
[142.673494] Starting subtest: display
[142.676795] Subtest display: SUCCESS (0.000s)
[142.758278] [014/142] (920s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[143.419509] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[143.425705] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[143.766961] [015/142] (919s left) gem_mmap_gtt (basic-small-bo-tiledy)
[143.918541] Starting subtest: basic-small-bo-tiledY
[144.863687] Subtest basic-small-bo-tiledY: SUCCESS (0.940s)
[144.990193] [016/142] (918s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_mc_ccs)
[145.771331] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_mc_ccs
[145.777709] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[146.106780] [017/142] (917s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[146.357453] Starting subtest: yf-tiled-16bpp-rotate-270
[146.674175] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.313s)
[146.873430] [018/142] (916s left) perf_pmu (semaphore-wait-idle)
[147.034667] Starting subtest: semaphore-wait-idle
[147.038200] Starting dynamic subtest: rcs0
[147.561633] Dynamic subtest rcs0: SUCCESS (0.516s)
[147.577077] Starting dynamic subtest: bcs0
[148.081573] Dynamic subtest bcs0: SUCCESS (0.513s)
[148.096946] Starting dynamic subtest: vcs0
[148.591637] Dynamic subtest vcs0: SUCCESS (0.512s)
[148.607069] Starting dynamic subtest: vecs0
[149.097923] Dynamic subtest vecs0: SUCCESS (0.513s)
[149.101142] Subtest semaphore-wait-idle: SUCCESS (2.057s)
[149.189632] [019/142] (914s left) kms_vblank (pipe-d-ts-continuation-idle-hang)
[149.425951] Subtest pipe-D-ts-continuation-idle-hang: SKIP (0.000s)
[149.506630] [020/142] (914s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[149.726721] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[149.730085] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[152.303939] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.570s)
[152.329535] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[154.323823] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (2.013s)
[154.354491] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[156.291060] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.842s)
[156.361128] Subtest 2x-flip-vs-dpms-off-vs-modeset: SUCCESS (6.449s)
[156.675745] [021/142] (907s left) gem_set_tiling_vs_gtt
[157.362197] [022/142] (906s left) kms_plane (plane-panning-top-left)
[157.600754] Starting subtest: plane-panning-top-left
[157.604227] Starting dynamic subtest: pipe-A-planes
[158.756716] Dynamic subtest pipe-A-planes: SUCCESS (1.149s)
[158.786186] Starting dynamic subtest: pipe-B-planes
[159.939535] Dynamic subtest pipe-B-planes: SUCCESS (1.166s)
[159.949915] Subtest plane-panning-top-left: SUCCESS (2.339s)
[160.178394] [023/142] (903s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[160.892063] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[160.902709] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.007s)
[161.281514] [024/142] (902s left) i915_module_load (reload)
[161.433432] Starting subtest: reload
[164.513704] Subtest reload: SUCCESS (3.081s)
[164.628466] [025/142] (899s left) gem_pxp (reject-modify-context-protection-off-1)
[167.545820] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[167.634107] [026/142] (896s left) gem_mmap_gtt (hang-user)
[167.789387] Starting subtest: hang-user
[182.649160] Subtest hang-user: SUCCESS (14.861s)
[182.751069] [027/142] (881s left) kms_vblank (pipe-a-ts-continuation-modeset-hang)
[182.992073] Starting subtest: pipe-A-ts-continuation-modeset-hang
[197.545911] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (14.550s)
[197.842073] [028/142] (866s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[198.118123] Starting subtest: fbc-rgb565-draw-mmap-cpu
[200.488153] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.380s)
[200.746087] [029/142] (863s left) gem_exec_flush (basic-wb-rw-default)
[200.927450] Starting subtest: basic-wb-rw-default
[206.363568] Subtest basic-wb-rw-default: SUCCESS (5.436s)
[206.564299] [030/142] (857s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[206.823044] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[206.829848] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[206.949359] [031/142] (857s left) kms_prop_blob (blob-prop-core)
[207.168124] Starting subtest: blob-prop-core
[207.171789] Subtest blob-prop-core: SUCCESS (0.000s)
[207.274871] [032/142] (857s left) kms_flip (flip-vs-expired-vblank)
[207.653927] Starting subtest: flip-vs-expired-vblank
[207.664489] Starting dynamic subtest: A-HDMI-A1
[213.550350] Dynamic subtest A-HDMI-A1: SUCCESS (5.879s)
[213.567179] Starting dynamic subtest: B-HDMI-A1
[218.982593] Dynamic subtest B-HDMI-A1: SUCCESS (5.427s)
[218.999179] Starting dynamic subtest: C-HDMI-A1
[224.414138] Dynamic subtest C-HDMI-A1: SUCCESS (5.434s)
[224.442884] Starting dynamic subtest: A-HDMI-A2
[229.852447] Dynamic subtest A-HDMI-A2: SUCCESS (5.428s)
[229.870699] Starting dynamic subtest: B-HDMI-A2
[235.270668] Dynamic subtest B-HDMI-A2: SUCCESS (5.421s)
[235.297813] Starting dynamic subtest: C-HDMI-A2
[240.714528] Dynamic subtest C-HDMI-A2: SUCCESS (5.425s)
[240.717633] Subtest flip-vs-expired-vblank: SUCCESS (33.062s)
[241.141138] [033/142] (823s left) syncobj_basic (illegal-fd-to-handle)
[241.295853] Starting subtest: illegal-fd-to-handle
[241.299308] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[241.384726] [034/142] (823s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[241.641716] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[241.647795] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[241.733984] [035/142] (822s left) vc4/vc4_perfmon (create-perfmon-exceed)
[241.949287] Subtest create-perfmon-exceed: SKIP (0.000s)
[242.022537] [036/142] (822s left) kms_addfb_basic (bad-pitch-63)
[242.174416] Starting subtest: bad-pitch-63
[242.177798] Subtest bad-pitch-63: SUCCESS (0.000s)
[242.367935] [037/142] (822s left) kms_scaling_modes (scaling-mode-none)
[242.610981] Starting subtest: scaling-mode-none
[242.617432] Subtest scaling-mode-none: SKIP (0.004s)
[242.706169] [038/142] (822s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[242.871897] Starting subtest: basic-wc-cpu-noreloc
[242.883460] Subtest basic-wc-cpu-noreloc: SUCCESS (0.011s)
[243.072428] [039/142] (821s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[243.235904] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[243.340925] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[243.433819] [040/142] (821s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[244.259120] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[244.543190] [041/142] (820s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[245.220449] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[245.492145] [042/142] (819s left) api_intel_bb (object-reloc-purge-cache)
[245.649938] Starting subtest: object-reloc-purge-cache
[245.664711] Subtest object-reloc-purge-cache: SUCCESS (0.015s)
[245.771213] [043/142] (819s left) kms_big_fb (4-tiled-addfb-size-overflow)
[246.024889] Starting subtest: 4-tiled-addfb-size-overflow
[246.031605] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[246.110689] [044/142] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[246.373952] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[246.380439] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[246.460979] [045/142] (818s left) gem_exec_reloc (basic-wc-cpu-active)
[246.625083] Starting subtest: basic-wc-cpu-active
[246.758370] Subtest basic-wc-cpu-active: SUCCESS (0.133s)
[246.944385] [046/142] (818s left) kms_cursor_crc (cursor-sliding-128x128)
[247.207744] Starting subtest: cursor-sliding-128x128
[247.274148] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.292542] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.012s)
[251.396345] Starting dynamic subtest: pipe-C-HDMI-A-1
[255.393244] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.028s)
[255.396865] Subtest cursor-sliding-128x128: SUCCESS (8.188s)
[255.688699] [047/142] (809s left) gem_userptr_blits (process-exit-busy)
[255.883869] Starting subtest: process-exit-busy
[255.921411] Subtest process-exit-busy: SUCCESS (0.041s)
[256.048681] [048/142] (809s left) gem_workarounds (suspend-resume)
[256.219951] Starting subtest: suspend-resume
[272.545932] Subtest suspend-resume: SUCCESS (1.088s)
[278.599709] [049/142] (807s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[278.858311] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[278.871391] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[278.957118] [050/142] (807s left) kms_tv_load_detect (load-detect)
[279.113527] Subtest load-detect: SKIP (0.000s)
[279.172080] [051/142] (807s left) gem_exec_fence (submit3)
[279.466297] Starting subtest: submit3
[279.469558] Starting dynamic subtest: rcs0
[279.478041] Dynamic subtest rcs0: SUCCESS (0.011s)
[279.495678] Starting dynamic subtest: bcs0
[279.503498] Dynamic subtest bcs0: SUCCESS (0.021s)
[279.523358] Starting dynamic subtest: vcs0
[279.526495] Dynamic subtest vcs0: SUCCESS (0.017s)
[279.547980] Starting dynamic subtest: vecs0
[279.551404] Dynamic subtest vecs0: SUCCESS (0.012s)
[279.554981] Subtest submit3: SUCCESS (0.073s)
[280.192625] [052/142] (806s left) drm_fdinfo (busy-idle)
[280.354729] Starting subtest: busy-idle
[280.358376] Starting dynamic subtest: rcs0
[280.979315] Dynamic subtest rcs0: SUCCESS (0.622s)
[280.999805] Starting dynamic subtest: bcs0
[281.607781] Dynamic subtest bcs0: SUCCESS (0.625s)
[281.628547] Starting dynamic subtest: vcs0
[282.229985] Dynamic subtest vcs0: SUCCESS (0.619s)
[282.248658] Starting dynamic subtest: vecs0
[282.854249] Dynamic subtest vecs0: SUCCESS (0.624s)
[282.857745] Subtest busy-idle: SUCCESS (2.500s)
[282.940541] [053/142] (803s left) sysfs_heartbeat_interval (mixed)
[283.098931] Starting subtest: mixed
[283.102543] Starting dynamic subtest: vecs0
[288.314272] Dynamic subtest vecs0: SUCCESS (5.210s)
[288.339309] Starting dynamic subtest: vcs0
[293.521571] Dynamic subtest vcs0: SUCCESS (5.206s)
[293.551751] Starting dynamic subtest: bcs0
[298.731499] Dynamic subtest bcs0: SUCCESS (5.208s)
[298.759723] Starting dynamic subtest: rcs0
[303.922961] Dynamic subtest rcs0: SUCCESS (5.186s)
[303.926379] Subtest mixed: SUCCESS (20.822s)
[304.008491] [054/142] (782s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs)
[304.822499] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs
[305.029047] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[305.687353] [055/142] (781s left) gem_exec_balancer (hang)
[309.032787] Starting subtest: hang
[311.845450] Subtest hang: SUCCESS (2.813s)
[311.947462] [056/142] (774s left) kms_cursor_edge_walk (128x128-right-edge)
[312.186045] Starting subtest: 128x128-right-edge
[312.193741] Starting dynamic subtest: pipe-A-HDMI-A-1
[316.191405] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.999s)
[316.224269] Starting dynamic subtest: pipe-C-HDMI-A-1
[319.648552] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.450s)
[319.652766] Subtest 128x128-right-edge: SUCCESS (7.464s)
[319.882364] [057/142] (766s left) kms_psr (primary_render)
[320.041139] Subtest primary_render: SKIP (0.000s)
[320.099552] [058/142] (766s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs)
[320.910796] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs
[320.917137] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[321.161283] [059/142] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[321.432967] Starting subtest: fbcpsr-1p-rte
[321.438982] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[321.523265] [060/142] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[321.786215] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[321.792527] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[321.878569] [061/142] (765s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[322.148439] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[324.254807] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SUCCESS (2.113s)
[324.410107] [062/142] (762s left) kms_lease (lease_unleased_connector)
[324.655953] Starting subtest: lease_unleased_connector
[324.659383] Starting dynamic subtest: pipe-A-HDMI-A-1
[324.744311] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.079s)
[324.774194] Starting dynamic subtest: pipe-A-HDMI-A-2
[324.847183] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.086s)
[324.867127] Starting dynamic subtest: pipe-B-HDMI-A-1
[324.938774] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.089s)
[324.961224] Starting dynamic subtest: pipe-B-HDMI-A-2
[325.029753] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.087s)
[325.050772] Starting dynamic subtest: pipe-C-HDMI-A-1
[325.121936] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.087s)
[325.142786] Starting dynamic subtest: pipe-C-HDMI-A-2
[325.211022] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.085s)
[325.213971] Subtest lease_unleased_connector: SUCCESS (0.553s)
[325.307060] [063/142] (761s left) kms_psr (psr2_primary_blt)
[325.464984] Subtest psr2_primary_blt: SKIP (0.000s)
[325.525532] [064/142] (761s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[325.794732] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[328.467672] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.682s)
[328.727026] [065/142] (758s left) gem_userptr_blits (stress-purge)
[328.916000] Starting subtest: stress-purge
[334.371843] Subtest stress-purge: SUCCESS (5.456s)
[334.527810] [066/142] (752s left) v3d/v3d_submit_csd (multiple-job-submission)
[334.856030] Subtest multiple-job-submission: SKIP (0.000s)
[334.928714] [067/142] (752s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[335.188507] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[335.195450] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.001s)
[335.292203] [068/142] (752s left) kms_rotation_crc (sprite-rotation-180)
[335.541865] Starting subtest: sprite-rotation-180
[344.640169] Subtest sprite-rotation-180: SUCCESS (9.099s)
[344.847430] [069/142] (742s left) gem_set_tiling_vs_pwrite
[345.162710] [070/142] (742s left) gem_exec_store (pages)
[345.332441] Starting subtest: pages
[345.336351] Starting dynamic subtest: rcs0
[345.407847] Dynamic subtest rcs0: SUCCESS (0.073s)
[345.430874] Starting dynamic subtest: bcs0
[345.486329] Dynamic subtest bcs0: SUCCESS (0.073s)
[345.504597] Starting dynamic subtest: vcs0
[345.560858] Dynamic subtest vcs0: SUCCESS (0.069s)
[345.579042] Starting dynamic subtest: vecs0
[345.634156] Dynamic subtest vecs0: SUCCESS (0.072s)
[345.638287] Subtest pages: SUCCESS (0.298s)
[345.827028] [071/142] (741s left) kms_big_fb (linear-addfb)
[346.081986] Starting subtest: linear-addfb
[346.085408] Subtest linear-addfb: SUCCESS (0.000s)
[346.178845] [072/142] (741s left) gem_exec_balancer (parallel-out-fence)
[349.304127] Subtest parallel-out-fence: SKIP (0.000s)
[349.396486] [073/142] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[349.646841] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[349.653305] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[349.727931] [074/142] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[349.980496] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[349.986866] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[350.060258] [075/142] (737s left) gem_exec_alignment (single)
[350.226004] Starting subtest: single
[350.235393] Subtest single: SUCCESS (0.009s)
[350.345420] [076/142] (737s left) gem_unfence_active_buffers
[350.727609] [077/142] (736s left) gem_wait (write-wait)
[350.904880] Starting subtest: write-wait
[350.908199] Starting dynamic subtest: all-engines
[351.948439] Dynamic subtest all-engines: SUCCESS (1.043s)
[351.971965] Starting dynamic subtest: rcs0
[352.986563] Dynamic subtest rcs0: SUCCESS (1.035s)
[353.008498] Starting dynamic subtest: bcs0
[354.025122] Dynamic subtest bcs0: SUCCESS (1.036s)
[354.045909] Starting dynamic subtest: vcs0
[355.061722] Dynamic subtest vcs0: SUCCESS (1.034s)
[355.084610] Starting dynamic subtest: vecs0
[356.098132] Dynamic subtest vecs0: SUCCESS (1.032s)
[356.101410] Subtest write-wait: SUCCESS (5.193s)
[356.345743] [078/142] (731s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[356.597491] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[359.005960] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.416s)
[359.248429] [079/142] (728s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[359.517914] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[361.426032] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.915s)
[361.598159] [080/142] (726s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[361.774780] Starting subtest: etime-multi-wait-for-submit-submitted
[361.877799] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[361.982217] [081/142] (725s left) gem_mmap_wc (write-wc-read-gtt)
[362.142390] Starting subtest: write-wc-read-gtt
[362.636883] Subtest write-wc-read-gtt: SUCCESS (0.497s)
[362.730330] [082/142] (725s left) syncobj_wait (invalid-reset-illegal-handle)
[362.884827] Starting subtest: invalid-reset-illegal-handle
[362.888582] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[362.962629] [083/142] (724s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[363.125962] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[363.181695] [084/142] (724s left) syncobj_timeline (invalid-transfer-illegal-handle)
[363.333716] Starting subtest: invalid-transfer-illegal-handle
[363.337403] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[363.413838] [085/142] (724s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_mc_ccs)
[364.200442] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs
[364.206912] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[364.555105] [086/142] (723s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[364.817484] Starting subtest: x-tiled-64bpp-rotate-180
[372.099209] Subtest x-tiled-64bpp-rotate-180: SUCCESS (7.281s)
[372.776780] [087/142] (715s left) gem_mmap_wc (read-write)
[372.928187] Starting subtest: read-write
[372.939913] Subtest read-write: SUCCESS (0.006s)
[373.025089] [088/142] (715s left) v3d/v3d_submit_cl (valid-submission)
[373.237085] Subtest valid-submission: SKIP (0.000s)
[373.308731] [089/142] (714s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[373.564302] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[373.570643] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[373.658753] [090/142] (714s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[373.819683] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[373.822902] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[373.908268] [091/142] (714s left) perf (gen12-mi-rpc)
[374.180427] Subtest gen12-mi-rpc: SKIP (0.000s)
[374.226695] [092/142] (714s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[374.389951] Starting subtest: y-tiled-to-vebox-x-tiled
[374.396696] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[374.592642] [093/142] (713s left) kms_invalid_mode (bad-htotal)
[374.831873] Starting subtest: bad-htotal
[374.835770] Starting dynamic subtest: HDMI-A-1-pipe-A
[375.307179] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.475s)
[375.342143] Starting dynamic subtest: HDMI-A-2-pipe-A
[375.357046] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (0.042s)
[375.386212] Starting dynamic subtest: HDMI-A-1-pipe-B
[375.396128] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.035s)
[375.426659] Starting dynamic subtest: HDMI-A-2-pipe-B
[375.436728] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (0.036s)
[375.466448] Starting dynamic subtest: HDMI-A-1-pipe-C
[375.475778] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.035s)
[375.505391] Starting dynamic subtest: HDMI-A-2-pipe-C
[375.515797] Dynamic subtest HDMI-A-2-pipe-C: SUCCESS (0.035s)
[375.519602] Subtest bad-htotal: SUCCESS (0.687s)
[375.789552] [094/142] (712s left) syncobj_timeline (wait-all-interrupted)
[375.951360] Starting subtest: wait-all-interrupted
[376.053400] Subtest wait-all-interrupted: SUCCESS (0.105s)
[376.146936] [095/142] (712s left) gen9_exec_parse (bb-large)
[376.321363] Starting subtest: bb-large
[419.890252] Subtest bb-large: SUCCESS (43.569s)
[420.140034] [096/142] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[420.505107] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[420.511338] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[420.597710] [097/142] (667s left) v3d/v3d_submit_cl (bad-extension)
[420.827351] Subtest bad-extension: SKIP (0.000s)
[420.897215] [098/142] (667s left) i915_pm_rps (waitboost)
[421.054917] Starting subtest: waitboost
[423.615818] Subtest waitboost: SUCCESS (2.561s)
[423.725526] [099/142] (664s left) kms_chamelium_edid (dp-edid-resolution-list)
[424.400668] Subtest dp-edid-resolution-list: SKIP (0.000s)
[424.678414] [100/142] (663s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[424.929633] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[424.932990] Starting dynamic subtest: pipe-A-valid-mode
[425.380842] Dynamic subtest pipe-A-valid-mode: SKIP (0.445s)
[425.387978] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.450s)
[425.680279] [101/142] (662s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[425.841967] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[425.897449] [102/142] (662s left) gem_ctx_shared (disjoint-timelines)
[426.069051] Starting subtest: disjoint-timelines
[426.086305] Subtest disjoint-timelines: SUCCESS (0.017s)
[426.312275] [103/142] (662s left) gem_exec_schedule (lateslice)
[426.493998] Starting subtest: lateslice
[426.497147] Starting dynamic subtest: rcs0
[426.525209] Dynamic subtest rcs0: SUCCESS (0.031s)
[426.562884] Starting dynamic subtest: bcs0
[426.579241] Dynamic subtest bcs0: SUCCESS (0.048s)
[426.617740] Starting dynamic subtest: vcs0
[426.630853] Dynamic subtest vcs0: SUCCESS (0.044s)
[426.666200] Starting dynamic subtest: vecs0
[426.677444] Dynamic subtest vecs0: SUCCESS (0.045s)
[426.680724] Subtest lateslice: SUCCESS (0.187s)
[427.013526] [104/142] (661s left) kms_atomic (crtc-invalid-params)
[427.516336] Starting subtest: crtc-invalid-params
[427.782600] Subtest crtc-invalid-params: SUCCESS (0.266s)
[428.330882] [105/142] (660s left) sw_sync (sync_multi_consumer)
[428.484930] Starting subtest: sync_multi_consumer
[429.250196] Subtest sync_multi_consumer: SUCCESS (0.754s)
[429.318780] [106/142] (659s left) drm_read (short-buffer-nonblock)
[429.860264] Starting subtest: short-buffer-nonblock
[429.863475] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[430.100014] [107/142] (658s left) gem_linear_blits (interruptible)
[430.441156] Starting subtest: interruptible
[450.900927] Subtest interruptible: SUCCESS (20.459s)
[451.002617] [108/142] (637s left) kms_content_protection (atomic-dpms)
[451.376550] Starting subtest: atomic-dpms
[453.277382] Subtest atomic-dpms: SKIP (1.883s)
[453.765375] [109/142] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[454.038307] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[454.044803] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[454.131195] [110/142] (634s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[454.392418] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[456.791407] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.406s)
[456.967966] [111/142] (632s left) kms_sequence (queue-idle)
[457.214391] Starting subtest: queue-idle
[457.217726] Starting dynamic subtest: HDMI-A-1-pipe-A
[459.908980] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (2.690s)
[459.942400] Starting dynamic subtest: HDMI-A-2-pipe-A
[462.399882] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (2.487s)
[462.431680] Starting dynamic subtest: HDMI-A-1-pipe-B
[465.071136] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (2.668s)
[465.108098] Starting dynamic subtest: HDMI-A-2-pipe-B
[467.782710] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (2.703s)
[467.817260] Starting dynamic subtest: HDMI-A-1-pipe-C
[470.694673] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (2.907s)
[470.728382] Starting dynamic subtest: HDMI-A-2-pipe-C
[473.560900] Dynamic subtest HDMI-A-2-pipe-C: SUCCESS (2.864s)
[473.564398] Subtest queue-idle: SUCCESS (16.349s)
[473.842874] [112/142] (615s left) gem_ctx_persistence (file)
[474.010616] Starting subtest: file
[474.081996] Subtest file: SUCCESS (0.070s)
[474.175524] [113/142] (614s left) gem_bad_reloc (negative-reloc-bltcopy)
[474.345876] Starting subtest: negative-reloc-bltcopy
[476.938108] Subtest negative-reloc-bltcopy: SUCCESS (2.594s)
[477.245429] [114/142] (611s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[477.961680] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[477.968299] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[478.289627] [115/142] (610s left) kms_chamelium_hpd (dp-hpd-fast)
[478.959743] Subtest dp-hpd-fast: SKIP (0.000s)
[479.217462] [116/142] (610s left) gem_exec_reloc (basic-write-cpu)
[479.380366] Starting subtest: basic-write-cpu
[479.395022] Subtest basic-write-cpu: SUCCESS (0.014s)
[479.588845] [117/142] (609s left) i915_pm_freq_api (freq-reset)
[479.749341] Subtest freq-reset: SKIP (0.000s)
[479.807966] [118/142] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[480.069706] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[482.493378] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.431s)
[482.653553] [119/142] (606s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[483.475259] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[483.486298] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.008s)
[483.775790] [120/142] (605s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_mc_ccs)
[484.437323] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs
[484.443829] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[484.823789] [121/142] (604s left) vc4/vc4_tiling (set-bad-handle)
[485.052843] Subtest set-bad-handle: SKIP (0.000s)
[485.122685] [122/142] (604s left) gem_mmap_wc (write-read-distinct)
[485.271927] Starting subtest: write-read-distinct
[485.282910] Subtest write-read-distinct: SUCCESS (0.006s)
[485.372732] [123/142] (604s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[486.185475] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[486.404503] [124/142] (603s left) sw_sync (sync_busy_fork_unixsocket)
[486.556046] Starting subtest: sync_busy_fork_unixsocket
[486.585064] Subtest sync_busy_fork_unixsocket: SUCCESS (0.025s)
[486.653778] [125/142] (602s left) gem_create (busy-create)
[486.818174] Starting subtest: busy-create
[486.821449] Starting dynamic subtest: smem0
[519.077695] Dynamic subtest smem0: SUCCESS (32.257s)
[519.083010] Subtest busy-create: SUCCESS (32.260s)
[519.287486] [126/142] (570s left) prime_self_import (reimport-vs-gem_close-race)
[519.438477] Starting subtest: reimport-vs-gem_close-race
[524.454532] Subtest reimport-vs-gem_close-race: SUCCESS (5.018s)
[524.548617] [127/142] (565s left) gem_exec_reloc (basic-active)
[524.708726] Starting subtest: basic-active
[524.711941] Starting dynamic subtest: all-engines
[524.953589] Dynamic subtest all-engines: SUCCESS (0.248s)
[524.979403] Starting dynamic subtest: rcs0
[525.132312] Dynamic subtest rcs0: SUCCESS (0.177s)
[525.157134] Starting dynamic subtest: bcs0
[525.403551] Dynamic subtest bcs0: SUCCESS (0.269s)
[525.430597] Starting dynamic subtest: vcs0
[525.576572] Dynamic subtest vcs0: SUCCESS (0.167s)
[525.600962] Starting dynamic subtest: vecs0
[525.745090] Dynamic subtest vecs0: SUCCESS (0.166s)
[525.748894] Subtest basic-active: SUCCESS (1.040s)
[525.930834] [128/142] (563s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[526.174528] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[526.183562] Starting dynamic subtest: pipe-A-HDMI-A-1
[526.248937] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.063s)
[526.285051] Starting dynamic subtest: pipe-B-HDMI-A-1
[526.309726] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.039s)
[526.344922] Starting dynamic subtest: pipe-C-HDMI-A-1
[526.374586] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.075s)
[526.380867] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.195s)
[526.470244] [129/142] (563s left) gem_exec_fence (basic-wait-all)
[526.643336] Starting subtest: basic-wait-all
[526.668398] Subtest basic-wait-all: SUCCESS (0.025s)
[527.414211] [130/142] (562s left) kms_cursor_crc (cursor-offscreen-256x85)
[527.672736] Starting subtest: cursor-offscreen-256x85
[527.726809] Starting dynamic subtest: pipe-A-HDMI-A-1
[530.751835] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.025s)
[530.873417] Starting dynamic subtest: pipe-C-HDMI-A-1
[533.953594] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.108s)
[533.961291] Subtest cursor-offscreen-256x85: SUCCESS (6.281s)
[534.253157] [131/142] (555s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[535.060873] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[535.333609] [132/142] (554s left) gem_exec_schedule (timeslicing)
[535.518638] Starting subtest: timeslicing
[535.522026] Starting dynamic subtest: rcs0
[535.525560] Dynamic subtest rcs0: SUCCESS (0.006s)
[535.548529] Starting dynamic subtest: bcs0
[535.551662] Dynamic subtest bcs0: SUCCESS (0.016s)
[535.577271] Starting dynamic subtest: vcs0
[535.580385] Dynamic subtest vcs0: SUCCESS (0.006s)
[535.598736] Starting dynamic subtest: vecs0
[535.601819] Dynamic subtest vecs0: SUCCESS (0.012s)
[535.604916] Subtest timeslicing: SUCCESS (0.053s)
[535.912025] [133/142] (554s left) i915_selftest (mock)
[537.511007] Starting subtest: mock
[537.515638] Starting dynamic subtest: sanitycheck
[538.402497] Dynamic subtest sanitycheck: SUCCESS (0.889s)
[538.419893] Starting dynamic subtest: shmem
[538.761194] Dynamic subtest shmem: SUCCESS (0.354s)
[538.777253] Starting dynamic subtest: fence
[545.877494] Dynamic subtest fence: SUCCESS (7.115s)
[545.897445] Starting dynamic subtest: scatterlist
[547.187299] Dynamic subtest scatterlist: SUCCESS (1.307s)
[547.205780] Starting dynamic subtest: syncmap
[549.660573] Dynamic subtest syncmap: SUCCESS (2.470s)
[549.678642] Starting dynamic subtest: uncore
[549.972253] Dynamic subtest uncore: SUCCESS (0.308s)
[549.988358] Starting dynamic subtest: ring
[550.284245] Dynamic subtest ring: SUCCESS (0.310s)
[550.299904] Starting dynamic subtest: engine
[550.605840] Dynamic subtest engine: SUCCESS (0.314s)
[550.622390] Starting dynamic subtest: timelines
[558.297924] Dynamic subtest timelines: SUCCESS (7.691s)
[558.316740] Starting dynamic subtest: requests
[560.665926] Dynamic subtest requests: SUCCESS (2.365s)
[560.683964] Starting dynamic subtest: objects
[561.081856] Dynamic subtest objects: SUCCESS (0.401s)
[561.099051] Starting dynamic subtest: phys
[561.466893] Dynamic subtest phys: SUCCESS (0.394s)
[561.485324] Starting dynamic subtest: dmabuf
[561.881884] Dynamic subtest dmabuf: SUCCESS (0.412s)
[561.900480] Starting dynamic subtest: vma
[583.598750] Dynamic subtest vma: SUCCESS (21.714s)
[583.616609] Starting dynamic subtest: evict
[585.991650] Dynamic subtest evict: FAIL (2.342s)
[585.998274] Subtest mock: FAIL (48.433s)
[586.059762] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         1725 [max: 8192]
 direct dependencies:                 17674 [max: 32768]
 indirect dependencies:              122670
 all direct dependencies:            321962
 dependency chains:                   24318 [max: 131072]
 dependency chain hlocks used:        99858 [max: 655360]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     157
 in-softirq chains:                     710
 in-process chains:                   23451
 stack-trace entries:                219211 [max: 1048576]
 number of stack traces:              10841
 number of stack hash chains:          7965
 combined max dependencies:      2634550776
 hardirq-safe locks:                     79
 hardirq-unsafe locks:                 1028
 softirq-safe locks:                    201
 softirq-unsafe locks:                  938
 irq-safe locks:                        217
 irq-unsafe locks:                     1028
 hardirq-read-safe locks:                 3
 hardirq-read-unsafe locks:             302
 softirq-read-safe locks:                 7
 softirq-read-unsafe locks:             297
 irq-read-safe locks:                     7
 irq-read-unsafe locks:                 302
 uncategorized locks:                   293
 unused locks:                            1
 max locking depth:                      16
 max bfs queue depth:                   467
 max lock class index:                 1891
 chain lookup misses:                 34690
 chain lookup hits:               279108131
 cyclic checks:                       35131
 redundant checks:                        0
 redundant links:                         0
 find-mask forwards checks:            6321
 find-mask backwards checks:           3347
 hardirq on events:               168375000
 hardirq off events:              168374998
 redundant hardirq ons:                  32
 redundant hardirq offs:                 62
 softirq on events:                  947329
 softirq off events:                 947329
 redundant softirq ons:                   0
 redundant softirq offs:                  0
 debug_locks:                             0

 zapped classes:                        605
 zapped lock chains:                  10303
 large chain blocks:                      1

[586.063708] Closing watchdogs
Done.