[51.791066] Initializing watchdogs
[51.791487]   /dev/watchdog0
[51.822695] [001/142] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[52.409577] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[55.654895] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (3.245s)
[55.970634] [002/142] (956s left) kms_lease (simple_lease)
[56.455412] Starting subtest: simple_lease
[56.458887] Starting dynamic subtest: pipe-A-eDP-1
[57.678102] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.217s)
[57.708750] Starting dynamic subtest: pipe-B-eDP-1
[59.822613] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.139s)
[59.856176] Starting dynamic subtest: pipe-C-eDP-1
[61.991444] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.164s)
[62.013189] Starting dynamic subtest: pipe-D-eDP-1
[64.173701] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.176s)
[64.177574] Subtest simple_lease: SUCCESS (7.718s)
[65.129472] [003/142] (947s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[65.650729] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[65.657650] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[65.808668] [004/142] (946s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[66.354614] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[69.592104] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (3.239s)
[70.090573] [005/142] (942s left) gem_exec_balancer (parallel-keep-submit-fence)
[71.363698] Starting subtest: parallel-keep-submit-fence
[77.594684] Subtest parallel-keep-submit-fence: SUCCESS (6.233s)
[77.725246] [006/142] (934s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[78.678521] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[80.014748] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.336s)
[81.788453] [007/142] (930s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[82.367426] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[82.385529] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.016s)
[82.702426] [008/142] (930s left) prime_mmap (test_reprime)
[83.075075] Starting subtest: test_reprime
[83.078143] Starting dynamic subtest: test_reprime-smem
[83.595659] Dynamic subtest test_reprime-smem: SUCCESS (0.521s)
[83.599371] Subtest test_reprime: SUCCESS (0.522s)
[83.741400] [009/142] (929s left) v3d/v3d_submit_cl (bad-multisync-pad)
[84.219373] Subtest bad-multisync-pad: SKIP (0.000s)
[84.327150] [010/142] (928s left) gem_lmem_swapping (verify)
[84.729404] Subtest verify: SKIP (0.000s)
[84.830555] [011/142] (928s left) syncobj_timeline (device-signal-unordered)
[85.211273] Starting subtest: device-signal-unordered
[85.218990] Subtest device-signal-unordered: SUCCESS (0.005s)
[85.331944] [012/142] (927s left) perf_pmu (idle-no-semaphores)
[85.736561] Starting subtest: idle-no-semaphores
[85.739805] Starting dynamic subtest: rcs0
[86.272126] Dynamic subtest rcs0: SUCCESS (0.538s)
[86.306848] Starting dynamic subtest: bcs0
[86.796283] Dynamic subtest bcs0: SUCCESS (0.523s)
[86.829763] Starting dynamic subtest: vcs0
[87.325943] Dynamic subtest vcs0: SUCCESS (0.529s)
[87.359441] Starting dynamic subtest: vcs1
[87.842557] Dynamic subtest vcs1: SUCCESS (0.516s)
[87.875415] Starting dynamic subtest: vecs0
[88.356933] Dynamic subtest vecs0: SUCCESS (0.513s)
[88.390836] Starting dynamic subtest: ccs0
[88.878796] Dynamic subtest ccs0: SUCCESS (0.521s)
[88.882346] Subtest idle-no-semaphores: SUCCESS (3.145s)
[89.051738] [013/142] (924s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[89.566259] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[89.572957] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[89.716992] [014/142] (923s left) syncobj_basic (bad-flags-handle-to-fd)
[90.091857] Starting subtest: bad-flags-handle-to-fd
[90.095353] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[90.218939] [015/142] (923s left) syncobj_wait (multi-wait-all-submitted)
[90.594632] Starting subtest: multi-wait-all-submitted
[90.696792] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[90.826128] [016/142] (922s left) syncobj_timeline (wait-for-submit-complex)
[91.204465] Starting subtest: wait-for-submit-complex
[91.269849] Subtest wait-for-submit-complex: SUCCESS (0.065s)
[91.398788] [017/142] (922s left) kms_cursor_crc (cursor-offscreen-64x21)
[92.217645] Starting subtest: cursor-offscreen-64x21
[92.249588] Starting dynamic subtest: pipe-A-eDP-1
[95.050097] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.801s)
[95.238780] Starting dynamic subtest: pipe-D-eDP-1
[99.238965] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.040s)
[99.242675] Subtest cursor-offscreen-64x21: SUCCESS (7.021s)
[100.396450] [018/142] (913s left) vc4/vc4_label_bo (set-label)
[100.861612] Subtest set-label: SKIP (0.000s)
[100.973210] [019/142] (912s left) kms_invalid_mode (bad-vsync-start)
[101.449757] Starting subtest: bad-vsync-start
[101.453417] Starting dynamic subtest: eDP-1-pipe-A
[101.865727] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.414s)
[101.904816] Starting dynamic subtest: eDP-1-pipe-B
[101.915682] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.040s)
[101.950996] Starting dynamic subtest: eDP-1-pipe-C
[101.964402] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.043s)
[101.997637] Starting dynamic subtest: eDP-1-pipe-D
[102.009841] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.041s)
[102.013438] Subtest bad-vsync-start: SUCCESS (0.562s)
[102.779857] [020/142] (910s left) gem_fenced_exec_thrash (no-spare-fences)
[103.165837] Subtest no-spare-fences: SKIP (0.000s)
[103.268451] [021/142] (910s left) api_intel_bb (misplaced-blitter)
[103.646341] Starting subtest: misplaced-blitter
[103.668503] Subtest misplaced-blitter: SUCCESS (0.027s)
[103.843661] [022/142] (909s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[104.369127] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[104.375804] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[104.527874] [023/142] (909s left) i915_pm_rpm (debugfs-read)
[110.720438] Starting subtest: debugfs-read
[231.992656] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[234.050352] Closing watchdogs
[234.065397] Initializing watchdogs
[234.065748]   /dev/watchdog0
[234.110736] [024/142] (779s left) gem_lmem_swapping (heavy-verify-random-ccs)
[234.512262] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[234.627496] [025/142] (779s left) i915_pm_dc (dc3co-vpb-simulation)
[236.112549] Starting subtest: dc3co-vpb-simulation
[244.977714] Subtest dc3co-vpb-simulation: SKIP (8.860s)
[245.230116] [026/142] (768s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[245.735317] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[245.742199] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[245.898207] [027/142] (768s left) kms_flip (flip-vs-fences-interruptible)
[246.310301] Starting subtest: flip-vs-fences-interruptible
[246.317145] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[246.473551] [028/142] (767s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice)
[246.930351] Subtest mark-unpurgeable-twice: SKIP (0.000s)
[247.038671] [029/142] (767s left) gem_exec_fair (basic-none-share)
[247.437182] Subtest basic-none-share: SKIP (0.000s)
[247.559265] [030/142] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[248.064267] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[262.148870] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (14.090s)
[262.408823] [031/142] (752s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[262.969261] Starting subtest: cursorB-vs-flipA-legacy
[262.987434] Subtest cursorB-vs-flipA-legacy: SKIP (0.016s)
[263.308719] [032/142] (751s left) gem_userptr_blits (sync-overlap)
[263.758773] Starting subtest: sync-overlap
[263.762741] Subtest sync-overlap: SUCCESS (0.001s)
[263.978825] [033/142] (750s left) gem_ctx_isolation (nonpriv-switch)
[264.401391] Starting subtest: nonpriv-switch
[264.404712] Starting dynamic subtest: rcs0
[265.683343] Dynamic subtest rcs0: SUCCESS (1.280s)
[265.727989] Starting dynamic subtest: bcs0
[266.910448] Dynamic subtest bcs0: SUCCESS (1.224s)
[266.943184] Starting dynamic subtest: vcs0
[268.207363] Dynamic subtest vcs0: SUCCESS (1.294s)
[268.244408] Starting dynamic subtest: vcs1
[269.846807] Dynamic subtest vcs1: SUCCESS (1.635s)
[269.883520] Starting dynamic subtest: vecs0
[271.509094] Dynamic subtest vecs0: SUCCESS (1.659s)
[271.545904] Starting dynamic subtest: ccs0
[273.555734] Dynamic subtest ccs0: SUCCESS (2.045s)
[273.559547] Subtest nonpriv-switch: SUCCESS (9.156s)
[273.940712] [034/142] (740s left) kms_addfb_basic (bad-pitch-65536)
[274.329139] Starting subtest: bad-pitch-65536
[274.332339] Subtest bad-pitch-65536: SUCCESS (0.001s)
[274.602801] [035/142] (740s left) gem_exec_flush (basic-batch-kernel-default-wb)
[275.020708] Starting subtest: basic-batch-kernel-default-wb
[283.462078] Subtest basic-batch-kernel-default-wb: SUCCESS (8.440s)
[283.711996] [036/142] (731s left) gem_mmap_gtt (ptrace)
[284.099092] Subtest ptrace: SKIP (0.000s)
[284.226401] [037/142] (730s left) drm_buddy (drm_buddy_test)
[284.586533] Starting subtest: drm_buddy_test
[284.599646] Subtest drm_buddy_test: SKIP (0.009s)
[284.732835] [038/142] (730s left) vc4/vc4_wait_seqno (bad-seqno-0ns)
[285.196432] Subtest bad-seqno-0ns: SKIP (0.000s)
[285.328949] [039/142] (729s left) perf (invalid-remove-userspace-config)
[286.235267] Starting subtest: invalid-remove-userspace-config
[286.290218] Subtest invalid-remove-userspace-config: SUCCESS (0.055s)
[286.405709] [040/142] (728s left) gem_eio (create)
[288.219318] Starting subtest: create
[290.980359] Subtest create: SUCCESS (2.759s)
[292.674137] [041/142] (722s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[293.160382] Starting subtest: universal-plane-pipe-B-sanity
[295.290438] Subtest universal-plane-pipe-B-sanity: SUCCESS (2.129s)
[296.237554] [042/142] (719s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[296.724292] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[296.728404] Starting dynamic subtest: pipe-A-eDP-1
[298.969626] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.242s)
[299.017276] Starting dynamic subtest: pipe-B-eDP-1
[302.577196] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.597s)
[302.629803] Starting dynamic subtest: pipe-C-eDP-1
[306.127556] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.536s)
[306.180584] Starting dynamic subtest: pipe-D-eDP-1
[309.593237] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.455s)
[309.596426] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (12.876s)
[311.112458] [043/142] (704s left) gem_eio (in-flight-internal-immediate)
[312.979409] Starting subtest: in-flight-internal-immediate
[316.239588] Subtest in-flight-internal-immediate: SUCCESS (3.260s)
[317.640716] [044/142] (697s left) gem_exec_flush (basic-uc-set-default)
[318.071443] Starting subtest: basic-uc-set-default
[323.983248] Subtest basic-uc-set-default: SUCCESS (5.911s)
[324.286414] [045/142] (691s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[324.770320] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[324.778842] Starting dynamic subtest: pipe-A-eDP-1
[324.882046] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[324.919592] Starting dynamic subtest: pipe-B-eDP-1
[325.091827] Dynamic subtest pipe-B-eDP-1: SKIP (0.200s)
[325.139822] Starting dynamic subtest: pipe-C-eDP-1
[325.327528] Dynamic subtest pipe-C-eDP-1: SKIP (0.225s)
[325.375314] Starting dynamic subtest: pipe-D-eDP-1
[325.568947] Dynamic subtest pipe-D-eDP-1: SKIP (0.227s)
[325.575652] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.796s)
[325.734851] [046/142] (690s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[326.303577] Starting subtest: 4-tiled-addfb-size-offset-overflow
[326.307337] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[326.467475] [047/142] (689s left) kms_big_fb (linear-64bpp-rotate-270)
[327.021144] Starting subtest: linear-64bpp-rotate-270
[327.090400] Subtest linear-64bpp-rotate-270: SKIP (0.060s)
[327.283580] [048/142] (688s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[328.184832] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[329.056188] [049/142] (686s left) gem_exec_reloc (basic-write-read-noreloc)
[329.447787] Subtest basic-write-read-noreloc: SKIP (0.000s)
[329.602445] [050/142] (686s left) kms_color (legacy-gamma)
[330.091398] Starting subtest: legacy-gamma
[330.094517] Starting dynamic subtest: pipe-A
[331.622129] Dynamic subtest pipe-A: SUCCESS (1.528s)
[331.661893] Starting dynamic subtest: pipe-B
[333.902643] Dynamic subtest pipe-B: SUCCESS (2.278s)
[333.940931] Starting dynamic subtest: pipe-C
[336.297676] Dynamic subtest pipe-C: SUCCESS (2.391s)
[336.334634] Starting dynamic subtest: pipe-D
[338.059684] Dynamic subtest pipe-D: SUCCESS (1.756s)
[338.064122] Subtest legacy-gamma: SUCCESS (7.968s)
[339.004674] [051/142] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[339.520553] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[339.527965] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[339.685810] [052/142] (676s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs)
[340.995396] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs
[341.002138] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[342.084945] [053/142] (674s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[342.619955] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[342.626772] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[342.769821] [054/142] (673s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[344.288404] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[344.292166] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.003s)
[345.164340] [055/142] (671s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[345.652408] Starting subtest: primary-y-tiled-reflect-x-0
[345.801168] Subtest primary-y-tiled-reflect-x-0: SKIP (0.146s)
[346.053547] [056/142] (670s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[347.180905] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[347.187188] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[348.418470] [057/142] (668s left) kms_psr2_sf (cursor-plane-update-sf)
[355.831140] Starting subtest: cursor-plane-update-sf
[355.834524] Starting dynamic subtest: pipe-A-eDP-1
[357.316529] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.475s)
[357.365563] Starting dynamic subtest: pipe-B-eDP-1
[358.801502] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.477s)
[358.805634] Subtest cursor-plane-update-sf: SUCCESS (2.975s)
[359.754369] [058/142] (657s left) kms_ccs (pipe-b-crc-primary-rotation-180-yf_tiled_ccs)
[360.964232] Starting subtest: pipe-B-crc-primary-rotation-180-yf_tiled_ccs
[360.971091] Subtest pipe-B-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.002s)
[362.190650] [059/142] (654s left) syncobj_wait (single-wait-all-submitted)
[362.568940] Starting subtest: single-wait-all-submitted
[362.673391] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[362.819490] [060/142] (654s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[363.224707] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[363.231234] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[363.498771] [061/142] (653s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[365.146518] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[365.152180] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.002s)
[365.859236] [062/142] (651s left) kms_chamelium_color (ctm-0-50)
[366.351059] Subtest ctm-0-50: SKIP (0.000s)
[366.467205] [063/142] (650s left) kms_getfb (getfb2-into-addfb2)
[366.850141] Starting subtest: getfb2-into-addfb2
[366.853950] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[367.024550] [064/142] (650s left) kms_psr2_su (page_flip-p010)
[367.406949] Subtest page_flip-P010: SKIP (0.000s)
[367.520918] [065/142] (649s left) kms_plane_cursor (viewport)
[368.004810] Starting subtest: viewport
[368.017252] Starting dynamic subtest: pipe-A-eDP-1-size-64
[375.431181] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (7.416s)
[375.536524] Starting dynamic subtest: pipe-A-eDP-1-size-128
[382.765127] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (7.260s)
[382.879145] Starting dynamic subtest: pipe-A-eDP-1-size-256
[387.979631] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (5.138s)
[388.474923] Starting dynamic subtest: pipe-B-eDP-1-size-64
[396.505958] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (8.069s)
[396.595552] Starting dynamic subtest: pipe-B-eDP-1-size-128
[400.995896] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (4.439s)
[401.102193] Starting dynamic subtest: pipe-B-eDP-1-size-256
[408.437170] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (7.371s)
[408.946306] Starting dynamic subtest: pipe-C-eDP-1-size-64
[414.340146] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (5.428s)
[414.427096] Starting dynamic subtest: pipe-C-eDP-1-size-128
[421.300380] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (6.910s)
[421.400980] Starting dynamic subtest: pipe-C-eDP-1-size-256
[427.302879] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (5.939s)
[427.809365] Starting dynamic subtest: pipe-D-eDP-1-size-64
[435.339697] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (7.573s)
[435.446242] Starting dynamic subtest: pipe-D-eDP-1-size-128
[442.332951] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (6.929s)
[442.435556] Starting dynamic subtest: pipe-D-eDP-1-size-256
[449.378355] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (6.981s)
[449.824410] Subtest viewport: SUCCESS (81.818s)
[450.700270] [066/142] (566s left) gem_pxp (regular-baseline-src-copy-readible)
[453.635962] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[453.805590] [067/142] (563s left) gem_spin_batch (resubmit)
[454.232748] Starting subtest: resubmit
[454.236043] Starting dynamic subtest: rcs0
[454.253673] Dynamic subtest rcs0: SUCCESS (0.019s)
[454.304144] Starting dynamic subtest: bcs0
[454.308062] Dynamic subtest bcs0: SUCCESS (0.011s)
[454.348936] Starting dynamic subtest: vcs0
[454.352140] Dynamic subtest vcs0: SUCCESS (0.007s)
[454.391957] Starting dynamic subtest: vcs1
[454.395146] Dynamic subtest vcs1: SUCCESS (0.008s)
[454.437628] Starting dynamic subtest: vecs0
[454.441194] Dynamic subtest vecs0: SUCCESS (0.008s)
[454.481973] Starting dynamic subtest: ccs0
[454.485141] Dynamic subtest ccs0: SUCCESS (0.009s)
[454.488486] Subtest resubmit: SUCCESS (0.088s)
[455.716941] [068/142] (561s left) kms_vblank (pipe-c-query-idle)
[456.235266] Starting subtest: pipe-C-query-idle
[459.803330] Subtest pipe-C-query-idle: SUCCESS (3.573s)
[460.744426] [069/142] (556s left) kms_flip (nonblocking-read)
[461.143667] Starting subtest: nonblocking-read
[461.146698] Subtest nonblocking-read: SUCCESS (0.000s)
[461.341454] [070/142] (556s left) prime_mmap (test_invalid_sync_flags)
[461.727990] Starting subtest: test_invalid_sync_flags
[461.731584] Starting dynamic subtest: test_invalid_sync_flags-smem
[461.735050] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[461.738561] Subtest test_invalid_sync_flags: SUCCESS (0.005s)
[461.876748] [071/142] (556s left) kms_psr (no_drrs)
[462.367948] Starting subtest: no_drrs
[465.565781] Subtest no_drrs: SUCCESS (3.195s)
[466.514667] [072/142] (551s left) gem_flink_basic (basic)
[466.902378] Starting subtest: basic
[466.906050] Subtest basic: SUCCESS (0.000s)
[467.064878] [073/142] (550s left) kms_display_modes (extended-mode-basic)
[467.546339] Starting subtest: extended-mode-basic
[467.553143] Subtest extended-mode-basic: SKIP (0.003s)
[467.670394] [074/142] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[468.166560] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[468.173665] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[468.288214] [075/142] (549s left) kms_flip (dpms-vs-vblank-race-interruptible)
[468.721730] Starting subtest: dpms-vs-vblank-race-interruptible
[468.755471] Starting dynamic subtest: A-eDP1
[473.591816] Dynamic subtest A-eDP1: SUCCESS (4.833s)
[473.628366] Starting dynamic subtest: B-eDP1
[477.329164] Dynamic subtest B-eDP1: SUCCESS (3.730s)
[477.367156] Starting dynamic subtest: C-eDP1
[481.307580] Dynamic subtest C-eDP1: SUCCESS (3.976s)
[481.342500] Starting dynamic subtest: D-eDP1
[485.331554] Dynamic subtest D-eDP1: SUCCESS (4.019s)
[485.356959] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.636s)
[486.268700] [076/142] (532s left) gem_exec_schedule (preempt-queue)
[486.717812] Subtest preempt-queue: SKIP (0.000s)
[487.142530] [077/142] (531s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs)
[488.903408] Starting subtest: pipe-D-bad-aux-stride-y_tiled_ccs
[488.910126] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[489.512957] [078/142] (528s left) syncobj_wait (wait-all-for-submit-snapshot)
[489.891476] Starting subtest: wait-all-for-submit-snapshot
[489.975891] Subtest wait-all-for-submit-snapshot: SUCCESS (0.084s)
[490.123246] [079/142] (528s left) gem_tiling_max_stride
[490.626847] [080/142] (528s left) kms_vblank (pipe-d-wait-forked-busy-hang)
[491.123758] Starting subtest: pipe-D-wait-forked-busy-hang
[507.816549] Subtest pipe-D-wait-forked-busy-hang: SUCCESS (16.695s)
[508.768167] [081/142] (509s left) vgem_basic (create)
[509.281499] Starting subtest: create
[509.285468] Subtest create: SUCCESS (0.001s)
[509.411855] [082/142] (509s left) kms_vblank (pipe-d-query-forked-busy)
[509.895152] Starting subtest: pipe-D-query-forked-busy
[514.270279] Subtest pipe-D-query-forked-busy: SUCCESS (4.373s)
[515.222128] [083/142] (503s left) gem_caching (writes)
[515.618863] Subtest writes: SKIP (0.000s)
[515.734140] [084/142] (503s left) gem_render_copy (linear)
[516.130914] Starting subtest: linear
[516.134210] Starting dynamic subtest: smem
[516.475766] Dynamic subtest smem: SUCCESS (0.342s)
[516.478851] Subtest linear: SUCCESS (0.346s)
[516.703029] [085/142] (502s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[518.035087] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[518.499801] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.461s)
[519.955295] [086/142] (499s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_mc_ccs)
[521.577198] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_mc_ccs
[524.686320] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_mc_ccs: SUCCESS (3.103s)
[526.125496] [087/142] (493s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[526.646147] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[538.608334] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (11.968s)
[538.795403] [088/142] (480s left) kms_flip (2x-flip-vs-fences)
[539.146903] Starting subtest: 2x-flip-vs-fences
[539.153682] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[539.352128] [089/142] (480s left) feature_discovery (display-2x)
[539.841219] Starting subtest: display-2x
[539.847970] Subtest display-2x: SKIP (0.000s)
[539.994635] [090/142] (479s left) kms_flip (2x-flip-vs-dpms)
[540.406868] Starting subtest: 2x-flip-vs-dpms
[540.565909] Subtest 2x-flip-vs-dpms: SKIP (0.160s)
[540.764314] [091/142] (478s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[541.333588] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[548.000431] Subtest flip-vs-cursor-atomic-transitions-varying-size: FAIL (5.904s)
[548.079524] [092/142] (471s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[548.566284] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[548.572927] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[550.459631] [093/142] (469s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[550.839448] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[550.945655] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[551.088854] [094/142] (468s left) i915_pm_rpm (sysfs-read)
[553.730514] Starting subtest: sysfs-read
[557.315810] Subtest sysfs-read: SUCCESS (3.572s)
[558.192850] [095/142] (461s left) gem_exec_whisper (basic-contexts-forked)
[558.625613] Starting subtest: basic-contexts-forked
[597.487939] Subtest basic-contexts-forked: SUCCESS (38.857s)
[597.776410] [096/142] (422s left) gen7_exec_parse (batch-without-end)
[598.194909] Subtest batch-without-end: SKIP (0.000s)
[598.332970] [097/142] (421s left) kms_cursor_crc (cursor-sliding-max-size)
[599.587737] Starting subtest: cursor-sliding-max-size
[599.597346] Subtest cursor-sliding-max-size: SKIP (0.000s)
[599.852949] [098/142] (420s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[600.368799] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[600.375407] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[600.528959] [099/142] (419s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[601.035872] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[601.042573] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[601.204410] [100/142] (419s left) gem_ctx_shared (single-timeline)
[601.629637] Starting subtest: single-timeline
[601.666866] Subtest single-timeline: SUCCESS (0.030s)
[601.978847] [101/142] (418s left) i915_pm_rps (thresholds)
[602.383415] Starting subtest: thresholds
[602.387160] Starting dynamic subtest: gt0
[602.399677] Dynamic subtest gt0: SKIP (0.011s)
[602.440409] Starting dynamic subtest: gt1
[602.446844] Dynamic subtest gt1: SKIP (0.002s)
[602.453442] Subtest thresholds: SKIP (0.023s)
[602.544092] [102/142] (417s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[603.088134] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[614.689709] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (11.605s)
[614.967220] [103/142] (405s left) gem_render_copy_redux (normal)
[615.408417] Starting subtest: normal
[618.400229] Subtest normal: SUCCESS (2.992s)
[618.590105] [104/142] (402s left) gem_exec_params (readonly)
[618.997401] Starting subtest: readonly
[619.006239] Subtest readonly: SUCCESS (0.008s)
[619.217600] [105/142] (401s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[620.710728] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[620.716857] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[621.610864] [106/142] (399s left) syncobj_timeline (invalid-transfer-illegal-handle)
[621.999600] Starting subtest: invalid-transfer-illegal-handle
[622.003379] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[622.148757] [107/142] (398s left) gem_exec_schedule (submit-golden-slice)
[622.593172] Starting subtest: submit-golden-slice
[622.596925] Starting dynamic subtest: rcs0
[622.729928] Dynamic subtest rcs0: SUCCESS (0.134s)
[622.779662] Starting dynamic subtest: bcs0
[622.854095] Dynamic subtest bcs0: SUCCESS (0.121s)
[622.900649] Starting dynamic subtest: vcs0
[622.962167] Dynamic subtest vcs0: SUCCESS (0.103s)
[623.011326] Starting dynamic subtest: vcs1
[623.091792] Dynamic subtest vcs1: SUCCESS (0.125s)
[623.148396] Starting dynamic subtest: vecs0
[623.222764] Dynamic subtest vecs0: SUCCESS (0.126s)
[623.268813] Starting dynamic subtest: ccs0
[623.355893] Dynamic subtest ccs0: SUCCESS (0.128s)
[623.359889] Subtest submit-golden-slice: SUCCESS (0.764s)
[624.694517] [108/142] (396s left) kms_atomic (atomic-invalid-params)
[625.511060] Starting subtest: atomic-invalid-params
[625.611187] Subtest atomic-invalid-params: SUCCESS (0.100s)
[626.963360] [109/142] (394s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs)
[627.946787] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs
[629.152426] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (1.206s)
[630.925403] [110/142] (390s left) gem_ctx_persistence (hang)
[631.338525] Starting subtest: hang
[631.345306] Subtest hang: SKIP (0.001s)
[631.515692] [111/142] (389s left) kms_addfb_basic (clobberred-modifier)
[631.896536] Starting subtest: clobberred-modifier
[631.903624] Subtest clobberred-modifier: SKIP (0.000s)
[632.170448] [112/142] (389s left) kms_big_joiner (2x-modeset)
[632.664283] Subtest 2x-modeset: SKIP (0.000s)
[632.783316] [113/142] (388s left) perf (unprivileged-single-ctx-counters)
[633.439499] Starting subtest: unprivileged-single-ctx-counters
[633.446953] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[633.539633] [114/142] (387s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[634.058353] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[634.065185] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[634.226692] [115/142] (387s left) gem_render_copy (yf-tiled-ccs-to-linear)
[634.645163] Starting subtest: yf-tiled-ccs-to-linear
[634.651195] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[634.918529] [116/142] (386s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[635.481349] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[635.493998] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.008s)
[635.830844] [117/142] (385s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[636.230148] Starting subtest: wait-all-for-submit-delayed-submit
[636.335407] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.106s)
[636.487649] [118/142] (385s left) i915_selftest (mock)
[640.407416] Starting subtest: mock
[640.411159] Starting dynamic subtest: sanitycheck
[641.376981] Dynamic subtest sanitycheck: SUCCESS (0.970s)
[641.403801] Starting dynamic subtest: shmem
[642.140148] Dynamic subtest shmem: SUCCESS (0.759s)
[642.169196] Starting dynamic subtest: fence
[650.656205] Dynamic subtest fence: SUCCESS (8.511s)
[650.683503] Starting dynamic subtest: scatterlist
[652.420353] Dynamic subtest scatterlist: SUCCESS (1.761s)
[652.456647] Starting dynamic subtest: syncmap
[655.320160] Dynamic subtest syncmap: SUCCESS (2.895s)
[655.347498] Starting dynamic subtest: uncore
[656.075469] Dynamic subtest uncore: SUCCESS (0.752s)
[656.105378] Starting dynamic subtest: ring
[656.850596] Dynamic subtest ring: SUCCESS (0.771s)
[656.878289] Starting dynamic subtest: engine
[657.610920] Dynamic subtest engine: SUCCESS (0.756s)
[657.637789] Starting dynamic subtest: timelines
[677.676679] Dynamic subtest timelines: SUCCESS (20.062s)
[677.703803] Starting dynamic subtest: requests
[689.893345] Dynamic subtest requests: SUCCESS (12.212s)
[689.919937] Starting dynamic subtest: objects
[690.932428] Dynamic subtest objects: SUCCESS (1.035s)
[690.959963] Starting dynamic subtest: phys
[691.978484] Dynamic subtest phys: SUCCESS (1.042s)
[692.005471] Starting dynamic subtest: dmabuf
[693.034936] Dynamic subtest dmabuf: SUCCESS (1.053s)
[693.061090] Starting dynamic subtest: vma
[710.093945] Dynamic subtest vma: SUCCESS (17.055s)
[710.122595] Starting dynamic subtest: evict
[716.693661] Dynamic subtest evict: FAIL (6.553s)
[716.698580] Subtest mock: FAIL (76.253s)
[716.862402] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         1629 [max: 8192]
 direct dependencies:                 15616 [max: 32768]
 indirect dependencies:               84060
 all direct dependencies:            293084
 dependency chains:                   21223 [max: 131072]
 dependency chain hlocks used:        84215 [max: 655360]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     175
 in-softirq chains:                     533
 in-process chains:                   20515
 stack-trace entries:                193517 [max: 1048576]
 number of stack traces:               9593
 number of stack hash chains:          7271
 combined max dependencies:      1928175744
 hardirq-safe locks:                     88
 hardirq-unsafe locks:                  977
 softirq-safe locks:                    179
 softirq-unsafe locks:                  890
 irq-safe locks:                        196
 irq-unsafe locks:                      977
 hardirq-read-safe locks:                 3
 hardirq-read-unsafe locks:             297
 softirq-read-safe locks:                 7
 softirq-read-unsafe locks:             292
 irq-read-safe locks:                     7
 irq-read-unsafe locks:                 297
 uncategorized locks:                   269
 unused locks:                            1
 max locking depth:                      16
 max bfs queue depth:                   405
 max lock class index:                 1815
 chain lookup misses:                 29239
 chain lookup hits:               392991042
 cyclic checks:                       28856
 redundant checks:                        0
 redundant links:                         0
 find-mask forwards checks:            4798
 find-mask backwards checks:           3064
 hardirq on events:               225699121
 hardirq off events:              225699099
 redundant hardirq ons:                 116
 redundant hardirq offs:                 29
 softirq on events:                 1174453
 softirq off events:                1174453
 redundant softirq ons:                   0
 redundant softirq offs:                  0
 debug_locks:                             0

 zapped classes:                        482
 zapped lock chains:                   7533
 large chain blocks:                      1

[716.867250] Closing watchdogs
Done.