[45.289929] Initializing watchdogs
[45.290038]   /dev/watchdog0
[45.296727] [001/130] (960s left) kms_hdmi_inject (inject-audio)
[46.505822] Starting subtest: inject-audio
[46.508959] Subtest inject-audio: SKIP (0.000s)
[46.789071] [002/130] (959s left) syncobj_wait (wait-all-for-submit-snapshot)
[46.828934] Starting subtest: wait-all-for-submit-snapshot
[46.912784] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[46.961378] [003/130] (958s left) syncobj_wait (wait-all-for-submit-complex)
[47.006544] Starting subtest: wait-all-for-submit-complex
[47.223521] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[47.272787] [004/130] (958s left) kms_plane (plane-position-hole-dpms)
[47.355630] Starting subtest: plane-position-hole-dpms
[47.851301] Starting dynamic subtest: pipe-A-plane-1
[50.347408] Dynamic subtest pipe-A-plane-1: SUCCESS (2.497s)
[50.353615] Starting dynamic subtest: pipe-A-plane-2
[52.837870] Dynamic subtest pipe-A-plane-2: SUCCESS (2.492s)
[52.842401] Starting dynamic subtest: pipe-A-plane-3
[55.334742] Dynamic subtest pipe-A-plane-3: SUCCESS (2.497s)
[55.340039] Starting dynamic subtest: pipe-A-plane-4
[57.833387] Dynamic subtest pipe-A-plane-4: SUCCESS (2.500s)
[57.839433] Starting dynamic subtest: pipe-A-plane-5
[57.853663] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[59.088450] Starting dynamic subtest: pipe-B-plane-1
[61.610080] Dynamic subtest pipe-B-plane-1: SUCCESS (2.526s)
[61.615570] Starting dynamic subtest: pipe-B-plane-2
[64.106894] Dynamic subtest pipe-B-plane-2: SUCCESS (2.497s)
[64.113603] Starting dynamic subtest: pipe-B-plane-3
[66.601690] Dynamic subtest pipe-B-plane-3: SUCCESS (2.496s)
[66.606160] Starting dynamic subtest: pipe-B-plane-4
[69.086255] Dynamic subtest pipe-B-plane-4: SUCCESS (2.485s)
[69.090560] Starting dynamic subtest: pipe-B-plane-5
[69.112170] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[69.113585] Subtest plane-position-hole-dpms: SUCCESS (21.762s)
[69.949512] [005/130] (935s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[70.049902] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[74.361966] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.312s)
[74.457481] [006/130] (931s left) kms_rotation_crc (sprite-rotation-180)
[74.536496] Starting subtest: sprite-rotation-180
[79.924633] Subtest sprite-rotation-180: SUCCESS (5.388s)
[81.172232] [007/130] (924s left) kms_psr (fbc-psr-sprite-blt)
[81.252615] Starting subtest: fbc-psr-sprite-blt
[81.253547] Starting dynamic subtest: eDP-1
[81.255284] Dynamic subtest eDP-1: SKIP (0.000s)
[81.257025] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[81.299515] [008/130] (924s left) gem_exec_capture (capture)
[81.348921] Starting subtest: capture
[81.350190] Starting dynamic subtest: rcs0-smem
[82.179982] Dynamic subtest rcs0-smem: SUCCESS (0.830s)
[82.186463] Starting dynamic subtest: bcs0-smem
[83.001970] Dynamic subtest bcs0-smem: SUCCESS (0.822s)
[83.008300] Starting dynamic subtest: vcs0-smem
[83.825036] Dynamic subtest vcs0-smem: SUCCESS (0.823s)
[83.831612] Starting dynamic subtest: vcs1-smem
[84.672292] Dynamic subtest vcs1-smem: SUCCESS (0.848s)
[84.678829] Starting dynamic subtest: vecs0-smem
[85.521754] Dynamic subtest vecs0-smem: FAIL (0.825s)
[85.526425] Starting dynamic subtest: ccs0-smem
[86.822986] Dynamic subtest ccs0-smem: SUCCESS (1.325s)
[86.824063] Subtest capture: FAIL (5.473s)
[86.945730] [009/130] (918s left) gem_ctx_persistence (hostile)
[86.988725] Starting subtest: hostile
[88.492646] Subtest hostile: FAIL (1.483s)
[88.576766] [010/130] (917s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[88.656398] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[93.475474] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.821s)
[93.549211] [011/130] (912s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[93.633105] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[96.137262] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.505s)
[96.250147] [012/130] (909s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[96.306462] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[96.343615] [013/130] (909s left) prime_vgem (fence-flip-hang)
[96.437445] Subtest fence-flip-hang: SKIP (0.000s)
[96.514313] [014/130] (909s left) i915_pm_rps (thresholds)
[96.559777] Starting subtest: thresholds
[96.561727] Subtest thresholds: SKIP (0.000s)
[96.582649] [015/130] (909s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[96.668134] Starting subtest: y-tiled-64bpp-rotate-0
[96.669923] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[96.725652] [016/130] (909s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[96.803580] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[96.804572] Starting dynamic subtest: pipe-A-default-mode
[97.099394] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[97.101446] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.294s)
[98.006834] [017/130] (907s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[98.091645] Starting subtest: fbc-pr-sprite-mmap-cpu
[98.093829] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[98.137659] [018/130] (907s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[98.246828] Starting subtest: cursorB-vs-flipA-toggle
[98.249755] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[98.344499] [019/130] (907s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[98.438029] Starting subtest: yf-tiled-32bpp-rotate-90
[98.439962] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[98.502550] [020/130] (907s left) gem_ccs (suspend-resume)
[98.543177] Starting subtest: suspend-resume
[98.545217] Subtest suspend-resume: SKIP (0.000s)
[98.616271] [021/130] (907s left) syncobj_timeline (32bits-limit)
[98.664534] Starting subtest: 32bits-limit
[98.665601] Subtest 32bits-limit: SUCCESS (0.001s)
[98.715820] [022/130] (907s left) kms_psr (psr-cursor-blt)
[98.802588] Starting subtest: psr-cursor-blt
[98.803604] Starting dynamic subtest: eDP-1
[100.609314] Dynamic subtest eDP-1: SUCCESS (1.805s)
[100.610658] Subtest psr-cursor-blt: SUCCESS (1.806s)
[101.524194] [023/130] (904s left) kms_cursor_crc (cursor-onscreen-128x128)
[101.684516] Starting subtest: cursor-onscreen-128x128
[101.687244] Starting dynamic subtest: pipe-A-eDP-1
[103.761063] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.073s)
[103.783138] Starting dynamic subtest: pipe-D-eDP-1
[106.601968] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.821s)
[106.603191] Subtest cursor-onscreen-128x128: SUCCESS (4.916s)
[107.462118] [024/130] (898s left) syncobj_wait (multi-wait-submitted-signaled)
[107.498922] Starting subtest: multi-wait-submitted-signaled
[107.499834] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[107.559562] [025/130] (898s left) gem_tiled_blits (normal)
[107.610094] Subtest normal: SKIP (0.000s)
[107.651637] [026/130] (898s left) api_intel_bb (intel-bb-blit-none)
[107.698031] Starting subtest: intel-bb-blit-none
[112.303089] Subtest intel-bb-blit-none: SUCCESS (4.605s)
[112.400641] [027/130] (893s left) syncobj_wait (signal)
[112.445227] Starting subtest: signal
[112.446203] Subtest signal: SUCCESS (0.000s)
[112.496073] [028/130] (893s left) prime_mmap (test_reprime)
[112.547269] Starting subtest: test_reprime
[112.548083] Starting dynamic subtest: test_reprime-smem
[112.571481] Dynamic subtest test_reprime-smem: SUCCESS (0.025s)
[112.572658] Subtest test_reprime: SUCCESS (0.025s)
[112.634448] [029/130] (893s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[112.732044] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[112.733731] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[112.797780] [030/130] (893s left) kms_chamelium_hpd (vga-hpd-fast)
[113.175329] Subtest vga-hpd-fast: SKIP (0.000s)
[114.046114] [031/130] (892s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[114.154967] Starting subtest: basic-flip-before-cursor-atomic
[115.070030] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.914s)
[115.925269] [032/130] (890s left) prime_mmap_kms (buffer-sharing)
[116.012972] Starting subtest: buffer-sharing
[116.420890] Subtest buffer-sharing: SUCCESS (0.406s)
[117.338965] [033/130] (888s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[122.507918] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[122.511344] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[123.419765] [034/130] (882s left) kms_vblank (query-forked-hang)
[123.505538] Starting subtest: query-forked-hang
[123.507870] Starting dynamic subtest: pipe-A-eDP-1
[150.117511] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.612s)
[150.124659] Starting dynamic subtest: pipe-D-eDP-1
[165.160806] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.041s)
[165.161904] Subtest query-forked-hang: SUCCESS (41.658s)
[166.038816] [035/130] (840s left) gem_bad_reloc (negative-reloc-bltcopy)
[166.096154] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[166.151822] [036/130] (839s left) gem_userptr_blits (create-destroy-unsync)
[166.195025] Subtest create-destroy-unsync: SKIP (0.000s)
[166.308452] [037/130] (839s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[171.422523] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[171.426607] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[172.310774] [038/130] (833s left) fbdev (nullptr)
[172.343450] Starting subtest: nullptr
[172.344742] Subtest nullptr: SUCCESS (0.000s)
[172.372349] [039/130] (833s left) kms_psr (fbc-psr2-cursor-blt)
[172.458394] Starting subtest: fbc-psr2-cursor-blt
[172.459743] Starting dynamic subtest: eDP-1
[172.461826] Dynamic subtest eDP-1: SKIP (0.000s)
[172.463823] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[172.507148] [040/130] (833s left) core_setmaster (master-drop-set-root)
[172.994892] Starting subtest: master-drop-set-root
[173.007073] Subtest master-drop-set-root: SUCCESS (0.012s)
[173.034774] [041/130] (833s left) i915_pm_rpm (system-suspend-devices)
[174.546786] Starting subtest: system-suspend-devices
[182.058872] Subtest system-suspend-devices: SUCCESS (7.512s)
[182.384587] [042/130] (823s left) kms_feature_discovery (display-1x)
[182.462551] Starting subtest: display-1x
[182.463578] Subtest display-1x: SUCCESS (0.000s)
[182.510838] [043/130] (823s left) dmabuf_sync_file (export-multiwait)
[182.543970] Starting subtest: export-multiwait
[182.545221] Subtest export-multiwait: SUCCESS (0.001s)
[182.575193] [044/130] (823s left) vgem_basic (create)
[182.609321] Starting subtest: create
[182.610263] Subtest create: SUCCESS (0.000s)
[182.642640] [045/130] (823s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[182.737307] Starting subtest: psr-2p-primscrn-cur-indfb-move
[182.739101] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[182.804125] [046/130] (823s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[182.894425] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[182.896304] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[182.965112] [047/130] (823s left) gem_sync (basic-all)
[183.013279] Starting subtest: basic-all
[186.423182] Subtest basic-all: SUCCESS (3.411s)
[186.581168] [048/130] (819s left) kms_joiner (basic-big-joiner)
[186.670240] Starting subtest: basic-big-joiner
[186.671981] Subtest basic-big-joiner: SKIP (0.000s)
[186.717561] [049/130] (819s left) kms_cursor_crc (cursor-random-32x10)
[186.834979] Starting subtest: cursor-random-32x10
[186.867533] Subtest cursor-random-32x10: SKIP (0.031s)
[187.064290] [050/130] (819s left) syncobj_timeline (wait-all-interrupted)
[187.111244] Starting subtest: wait-all-interrupted
[187.219514] Subtest wait-all-interrupted: SUCCESS (0.107s)
[187.270280] [051/130] (819s left) syncobj_timeline (wait-for-submit-complex)
[187.313885] Starting subtest: wait-for-submit-complex
[187.375080] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[187.423696] [052/130] (818s left) kms_plane_scaling (planes-downscale-factor-0-75)
[187.502746] Starting subtest: planes-downscale-factor-0-75
[187.503894] Starting dynamic subtest: pipe-A
[187.517751] Dynamic subtest pipe-A: SKIP (0.013s)
[187.522592] Starting dynamic subtest: pipe-B
[187.541779] Dynamic subtest pipe-B: SKIP (0.023s)
[187.546927] Starting dynamic subtest: pipe-C
[187.566385] Dynamic subtest pipe-C: SKIP (0.024s)
[187.571103] Starting dynamic subtest: pipe-D
[187.590493] Dynamic subtest pipe-D: SKIP (0.024s)
[187.592134] Subtest planes-downscale-factor-0-75: SKIP (0.086s)
[187.650326] [053/130] (818s left) kms_async_flips (alternate-sync-async-flip)
[187.738254] Starting subtest: alternate-sync-async-flip
[188.097700] Starting dynamic subtest: pipe-A-eDP-1
[190.936466] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.838s)
[191.285122] Starting dynamic subtest: pipe-B-eDP-1
[194.137438] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.856s)
[194.498742] Starting dynamic subtest: pipe-C-eDP-1
[197.338880] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.843s)
[197.685029] Starting dynamic subtest: pipe-D-eDP-1
[200.537720] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.857s)
[200.539244] Subtest alternate-sync-async-flip: SUCCESS (12.801s)
[201.749935] [054/130] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[201.845839] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[201.847567] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[201.915865] [055/130] (804s left) kms_hdr (static-swap)
[202.004516] Starting subtest: static-swap
[202.007393] Subtest static-swap: SKIP (0.000s)
[202.052756] [056/130] (804s left) gem_ppgtt (shrink-vs-evict-any)
[202.104269] Starting subtest: shrink-vs-evict-any
[207.382539] Subtest shrink-vs-evict-any: SUCCESS (5.275s)
[207.455688] [057/130] (798s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[207.542875] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[208.453503] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (0.911s)
[208.551890] [058/130] (797s left) gem_mmap_gtt (bad-object)
[208.596203] Subtest bad-object: SKIP (0.000s)
[208.638787] [059/130] (797s left) kms_cursor_edge_walk (128x128-right-edge)
[208.719629] Starting subtest: 128x128-right-edge
[208.720689] Starting dynamic subtest: pipe-A-eDP-1
[212.229538] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[212.236162] Starting dynamic subtest: pipe-D-eDP-1
[215.472813] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.243s)
[215.473853] Subtest 128x128-right-edge: SUCCESS (6.753s)
[216.341211] [060/130] (790s left) gen3_render_tiledx_blits
[216.402953] [061/130] (790s left) gem_spin_batch (user-each)
[216.451899] Starting subtest: user-each
[219.706292] Subtest user-each: SUCCESS (3.250s)
[220.481289] [062/130] (785s left) gem_exec_schedule (implicit-write-read)
[220.538739] Starting subtest: implicit-write-read
[220.539550] Starting dynamic subtest: rcs0
[220.694274] Dynamic subtest rcs0: SUCCESS (0.157s)
[220.701937] Starting dynamic subtest: vcs0
[220.785151] Dynamic subtest vcs0: SUCCESS (0.090s)
[220.792433] Starting dynamic subtest: vcs1
[220.875685] Dynamic subtest vcs1: SUCCESS (0.090s)
[220.883839] Starting dynamic subtest: vecs0
[220.968509] Dynamic subtest vecs0: SUCCESS (0.093s)
[220.976522] Starting dynamic subtest: ccs0
[221.112940] Dynamic subtest ccs0: SUCCESS (0.144s)
[221.114502] Subtest implicit-write-read: SUCCESS (0.576s)
[222.473983] [063/130] (783s left) gem_ctx_isolation (dirty-create)
[222.528843] Starting subtest: dirty-create
[222.530032] Starting dynamic subtest: rcs0
[222.722025] Dynamic subtest rcs0: SUCCESS (0.193s)
[222.729066] Starting dynamic subtest: bcs0
[222.951677] Dynamic subtest bcs0: SUCCESS (0.229s)
[222.958979] Starting dynamic subtest: vcs0
[223.173700] Dynamic subtest vcs0: SUCCESS (0.221s)
[223.181223] Starting dynamic subtest: vcs1
[224.547726] Dynamic subtest vcs1: SUCCESS (1.373s)
[224.555480] Starting dynamic subtest: vecs0
[226.586491] Dynamic subtest vecs0: SUCCESS (2.039s)
[226.593613] Starting dynamic subtest: ccs0
[228.595803] Dynamic subtest ccs0: SUCCESS (2.009s)
[228.596923] Subtest dirty-create: SUCCESS (6.067s)
[228.797107] [064/130] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[228.889540] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[228.891423] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.956793] [065/130] (777s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[229.041899] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[229.042796] Starting dynamic subtest: pipe-A-default-mode
[229.327268] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[229.329744] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.284s)
[230.229681] [066/130] (776s left) kms_chamelium_edid (dp-edid-resolution-list)
[230.614434] Subtest dp-edid-resolution-list: SKIP (0.000s)
[231.488621] [067/130] (775s left) kms_psr (pr-sprite-render)
[231.566800] Starting subtest: pr-sprite-render
[231.568776] Subtest pr-sprite-render: SKIP (0.000s)
[231.610212] [068/130] (774s left) syncobj_wait (invalid-reset-bad-pad)
[231.652104] Starting subtest: invalid-reset-bad-pad
[231.653438] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[231.711032] [069/130] (774s left) i915_hangman (error-state-basic)
[231.762555] Starting subtest: error-state-basic
[231.912068] Subtest error-state-basic: SUCCESS (0.147s)
[231.959862] [070/130] (774s left) perf_pmu (render-node-busy)
[232.026730] Starting subtest: render-node-busy
[232.027799] Starting dynamic subtest: rcs0
[232.623839] Dynamic subtest rcs0: SUCCESS (0.596s)
[232.632264] Starting dynamic subtest: bcs0
[233.185207] Dynamic subtest bcs0: SUCCESS (0.560s)
[233.195310] Starting dynamic subtest: vcs0
[234.358607] Dynamic subtest vcs0: SUCCESS (1.170s)
[234.366999] Starting dynamic subtest: vcs1
[236.406657] Dynamic subtest vcs1: SUCCESS (2.047s)
[236.414978] Starting dynamic subtest: vecs0
[238.390959] Dynamic subtest vecs0: SUCCESS (1.983s)
[238.400190] Starting dynamic subtest: ccs0
[238.947877] Dynamic subtest ccs0: SUCCESS (0.558s)
[238.949457] Subtest render-node-busy: SUCCESS (6.921s)
[238.998932] [071/130] (767s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[239.079829] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[240.004548] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.924s)
[240.101203] [072/130] (766s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[240.180824] Starting subtest: 4-tiled-32bpp-rotate-180
[241.480551] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.300s)
[241.577608] [073/130] (764s left) kms_flip (2x-plain-flip)
[241.663420] Starting subtest: 2x-plain-flip
[241.678090] Subtest 2x-plain-flip: SKIP (0.014s)
[241.739871] [074/130] (764s left) gem_mmap_gtt (basic-copy)
[241.790087] Subtest basic-copy: SKIP (0.000s)
[241.818748] [075/130] (764s left) gem_exec_schedule (preempt-user)
[241.867484] Starting subtest: preempt-user
[241.868675] Starting dynamic subtest: rcs0
[241.884730] Dynamic subtest rcs0: SUCCESS (0.017s)
[241.892439] Starting dynamic subtest: bcs0
[241.898586] Dynamic subtest bcs0: SUCCESS (0.014s)
[241.904047] Starting dynamic subtest: vcs0
[241.913344] Dynamic subtest vcs0: SUCCESS (0.014s)
[241.918763] Starting dynamic subtest: vcs1
[241.927255] Dynamic subtest vcs1: SUCCESS (0.014s)
[241.935867] Starting dynamic subtest: vecs0
[241.939587] Dynamic subtest vecs0: SUCCESS (0.012s)
[241.944959] Starting dynamic subtest: ccs0
[241.955071] Dynamic subtest ccs0: SUCCESS (0.015s)
[241.956091] Subtest preempt-user: SUCCESS (0.088s)
[243.450631] [076/130] (763s left) gem_exec_balancer (full-late)
[243.500482] Starting subtest: full-late
[247.913621] Subtest full-late: SUCCESS (4.413s)
[248.179216] [077/130] (758s left) gem_exec_reloc (basic-gtt-cpu-active)
[248.222459] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[248.265233] [078/130] (758s left) core_auth (basic-auth)
[248.309321] Starting subtest: basic-auth
[248.310320] Subtest basic-auth: SUCCESS (0.001s)
[248.404946] [079/130] (758s left) gem_workarounds (suspend-resume-fd)
[248.471644] Starting subtest: suspend-resume-fd
[267.118705] Subtest suspend-resume-fd: SUCCESS (3.359s)
[275.212329] [080/130] (754s left) gem_render_copy_redux (normal)
[275.259930] Starting subtest: normal
[275.645990] Subtest normal: SUCCESS (0.386s)
[275.715103] [081/130] (754s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[275.806465] Starting subtest: compare-crc-sanitycheck-xr24
[275.807343] Starting dynamic subtest: pipe-A-eDP-1
[276.394948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[276.401240] Starting dynamic subtest: pipe-B-eDP-1
[277.700309] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.305s)
[277.706745] Starting dynamic subtest: pipe-C-eDP-1
[278.997087] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s)
[279.003549] Starting dynamic subtest: pipe-D-eDP-1
[280.280016] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s)
[280.281303] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.473s)
[281.166593] [082/130] (748s left) gem_tiled_partial_pwrite_pread (reads)
[281.228680] Subtest reads: SKIP (0.000s)
[281.274207] [083/130] (748s left) gem_exec_params (dr1-dirt)
[281.312750] Starting subtest: DR1-dirt
[281.313912] Subtest DR1-dirt: SUCCESS (0.000s)
[281.401544] [084/130] (748s left) gen7_exec_parse (cmd-crossing-page)
[281.452851] Subtest cmd-crossing-page: SKIP (0.000s)
[281.474684] [085/130] (748s left) kms_cdclk (mode-transition)
[281.552463] Starting subtest: mode-transition
[281.553469] Starting dynamic subtest: pipe-A-eDP-1
[281.840100] Dynamic subtest pipe-A-eDP-1: SKIP (0.285s)
[281.846275] Starting dynamic subtest: pipe-B-eDP-1
[281.848214] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[281.853617] Starting dynamic subtest: pipe-C-eDP-1
[281.855583] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[281.860970] Starting dynamic subtest: pipe-D-eDP-1
[281.862855] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[281.864712] Subtest mode-transition: SKIP (0.291s)
[282.701123] [086/130] (747s left) gem_exec_whisper (basic-fds-forked)
[282.748131] Starting subtest: basic-fds-forked
[303.209316] Subtest basic-fds-forked: SUCCESS (20.459s)
[303.371109] [087/130] (726s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[303.467971] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[303.469613] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[303.526525] [088/130] (726s left) gem_exec_balancer (bonded-false-hang)
[303.731735] Starting subtest: bonded-false-hang
[303.733374] Subtest bonded-false-hang: SKIP (0.000s)
[303.797956] [089/130] (726s left) gem_exec_fence (basic-busy)
[303.955853] Starting subtest: basic-busy
[303.957308] Starting dynamic subtest: rcs0
[304.017675] Dynamic subtest rcs0: SUCCESS (0.062s)
[304.026734] Starting dynamic subtest: bcs0
[304.067376] Dynamic subtest bcs0: SUCCESS (0.049s)
[304.074788] Starting dynamic subtest: vcs0
[304.122147] Dynamic subtest vcs0: SUCCESS (0.054s)
[304.130884] Starting dynamic subtest: vcs1
[304.180538] Dynamic subtest vcs1: SUCCESS (0.057s)
[304.188067] Starting dynamic subtest: vecs0
[304.238762] Dynamic subtest vecs0: SUCCESS (0.057s)
[304.246929] Starting dynamic subtest: ccs0
[304.292594] Dynamic subtest ccs0: SUCCESS (0.053s)
[304.293883] Subtest basic-busy: SUCCESS (0.338s)
[305.787556] [090/130] (724s left) gem_reg_read (bad-register)
[305.833956] Starting subtest: bad-register
[305.835467] Subtest bad-register: SUCCESS (0.000s)
[305.897280] [091/130] (724s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[305.977568] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[305.980075] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[306.046200] [092/130] (724s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[306.132790] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[306.133813] Starting dynamic subtest: pipe-A-default-mode
[306.435791] Dynamic subtest pipe-A-default-mode: SKIP (0.301s)
[306.437720] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.302s)
[307.276538] [093/130] (722s left) perf (create-destroy-userspace-config)
[307.366402] Starting subtest: create-destroy-userspace-config
[307.381957] Subtest create-destroy-userspace-config: SUCCESS (0.015s)
[307.398266] [094/130] (722s left) kms_pm_backlight (fade-with-dpms)
[307.489545] Starting subtest: fade-with-dpms
[309.655037] Starting dynamic subtest: eDP-1
[312.328439] Dynamic subtest eDP-1: SUCCESS (2.672s)
[312.329395] Subtest fade-with-dpms: SUCCESS (4.838s)
[313.233349] [095/130] (716s left) gem_spin_batch (engines)
[313.281966] Starting subtest: engines
[313.283109] Starting dynamic subtest: rcs0
[316.527570] Dynamic subtest rcs0: SUCCESS (3.241s)
[316.536002] Starting dynamic subtest: bcs0
[319.768013] Dynamic subtest bcs0: SUCCESS (3.239s)
[319.774977] Starting dynamic subtest: vcs0
[323.010695] Dynamic subtest vcs0: SUCCESS (3.242s)
[323.017964] Starting dynamic subtest: vcs1
[326.247080] Dynamic subtest vcs1: SUCCESS (3.236s)
[326.254293] Starting dynamic subtest: vecs0
[329.487714] Dynamic subtest vecs0: SUCCESS (3.240s)
[329.494926] Starting dynamic subtest: ccs0
[332.728769] Dynamic subtest ccs0: SUCCESS (3.240s)
[332.730290] Subtest engines: SUCCESS (19.444s)
[332.953379] [096/130] (697s left) kms_vrr (flip-basic)
[333.048474] Starting subtest: flip-basic
[333.051334] Subtest flip-basic: SKIP (0.000s)
[333.096788] [097/130] (697s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[333.203781] Starting subtest: short-busy-flip-before-cursor-toggle
[333.205590] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[333.289779] [098/130] (696s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[333.393502] Starting subtest: cursorA-vs-flipA-legacy
[344.507525] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.114s)
[345.421128] [099/130] (684s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[345.464888] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[345.467092] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[345.625971] [100/130] (684s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[345.705386] Starting subtest: crc-primary-basic-y-tiled-ccs
[345.706224] Starting dynamic subtest: pipe-A-eDP-1
[345.716866] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[345.723546] Starting dynamic subtest: pipe-B-eDP-1
[345.731482] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[345.736944] Starting dynamic subtest: pipe-C-eDP-1
[345.745022] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[345.750656] Starting dynamic subtest: pipe-D-eDP-1
[345.759053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[345.760629] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s)
[345.769605] [101/130] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[345.857768] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[345.859541] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[345.926194] [102/130] (684s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[346.017847] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[346.861365] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.844s)
[346.972888] [103/130] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[347.064011] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[347.065855] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[347.148341] [104/130] (683s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[347.229045] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[347.230244] Starting dynamic subtest: pipe-A-eDP-1
[347.254492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.025s)
[347.260960] Starting dynamic subtest: pipe-B-eDP-1
[347.276224] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[347.282144] Starting dynamic subtest: pipe-C-eDP-1
[347.299241] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[347.305662] Starting dynamic subtest: pipe-D-eDP-1
[347.320856] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[347.321887] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[347.388019] [105/130] (682s left) perf_pmu (busy-double-start)
[347.417261] Starting subtest: busy-double-start
[347.418607] Starting dynamic subtest: rcs0
[351.003827] Dynamic subtest rcs0: FAIL (3.564s)
[351.011633] Starting dynamic subtest: bcs0
[354.571842] Dynamic subtest bcs0: FAIL (3.559s)
[354.578431] Starting dynamic subtest: vcs0
[358.195755] Dynamic subtest vcs0: SUCCESS (3.654s)
[358.203589] Starting dynamic subtest: vcs1
[362.230480] Dynamic subtest vcs1: SUCCESS (4.034s)
[362.238343] Starting dynamic subtest: vecs0
[366.207863] Dynamic subtest vecs0: SUCCESS (3.976s)
[366.217407] Starting dynamic subtest: ccs0
[369.796224] Dynamic subtest ccs0: FAIL (3.564s)
[369.797153] Subtest busy-double-start: FAIL (22.356s)
[369.867040] [106/130] (660s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[369.952464] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[369.953462] Starting dynamic subtest: pipe-A-eDP-1
[369.977497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[369.985252] Starting dynamic subtest: pipe-B-eDP-1
[370.000056] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[370.006145] Starting dynamic subtest: pipe-C-eDP-1
[370.022243] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[370.027988] Starting dynamic subtest: pipe-D-eDP-1
[370.045789] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[370.046632] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[370.119122] [107/130] (660s left) gem_mmap_gtt (basic)
[370.160063] Subtest basic: SKIP (0.000s)
[370.203163] [108/130] (660s left) gem_exec_params (sol-reset-not-gen7)
[370.258386] Starting subtest: sol-reset-not-gen7
[370.260613] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[370.360495] [109/130] (659s left) kms_prop_blob (basic)
[370.401665] Starting subtest: basic
[370.402522] Subtest basic: SUCCESS (0.000s)
[370.458332] [110/130] (659s left) perf_pmu (semaphore-wait-idle)
[370.483345] Starting subtest: semaphore-wait-idle
[370.484493] Starting dynamic subtest: rcs0
[370.997670] Dynamic subtest rcs0: SUCCESS (0.513s)
[371.005982] Starting dynamic subtest: bcs0
[371.511052] Dynamic subtest bcs0: SUCCESS (0.511s)
[371.519794] Starting dynamic subtest: vcs0
[372.023124] Dynamic subtest vcs0: SUCCESS (0.511s)
[372.031940] Starting dynamic subtest: vcs1
[372.535210] Dynamic subtest vcs1: SUCCESS (0.511s)
[372.543708] Starting dynamic subtest: vecs0
[373.045381] Dynamic subtest vecs0: SUCCESS (0.511s)
[373.055050] Starting dynamic subtest: ccs0
[373.564422] Dynamic subtest ccs0: SUCCESS (0.516s)
[373.566220] Subtest semaphore-wait-idle: SUCCESS (3.079s)
[374.690448] [111/130] (655s left) gem_exec_fence (syncobj-timeline-signal)
[375.202699] Starting subtest: syncobj-timeline-signal
[375.212174] Subtest syncobj-timeline-signal: SUCCESS (0.011s)
[376.749207] [112/130] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[376.846331] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[376.848261] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[376.918818] [113/130] (653s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[376.998760] Starting subtest: sprite-rotation-90-pos-100-0
[377.001263] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[377.048169] [114/130] (653s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[379.620395] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[379.670501] [115/130] (650s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[379.757970] Starting subtest: multiplane-rotation-cropping-bottom
[386.940044] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.182s)
[387.040349] [116/130] (643s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[387.087388] Starting subtest: invalid-single-wait-unsubmitted
[387.088488] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[387.140301] [117/130] (643s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[387.223985] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[391.545784] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.323s)
[391.654727] [118/130] (638s left) syncobj_timeline (multi-wait-all-signaled)
[391.703439] Starting subtest: multi-wait-all-signaled
[391.704730] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[391.770840] [119/130] (638s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[391.876397] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[399.492478] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (7.614s)
[400.399305] [120/130] (630s left) kms_flip (basic-flip-vs-modeset)
[400.494459] Starting subtest: basic-flip-vs-modeset
[400.495402] Starting dynamic subtest: A-eDP1
[403.143868] Dynamic subtest A-eDP1: SUCCESS (2.647s)
[403.151840] Starting dynamic subtest: B-eDP1
[405.446438] Dynamic subtest B-eDP1: SUCCESS (2.302s)
[405.453632] Starting dynamic subtest: C-eDP1
[407.689940] Dynamic subtest C-eDP1: SUCCESS (2.243s)
[407.699631] Starting dynamic subtest: D-eDP1
[409.928205] Dynamic subtest D-eDP1: SUCCESS (2.238s)
[409.930941] Subtest basic-flip-vs-modeset: SUCCESS (9.437s)
[410.834121] [121/130] (619s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[410.938568] Starting subtest: flip-vs-cursor-crc-atomic
[411.553014] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.614s)
[412.429140] [122/130] (618s left) gem_exec_whisper (basic-queues-all)
[412.482742] Starting subtest: basic-queues-all
[421.936426] Subtest basic-queues-all: SUCCESS (9.452s)
[422.098097] [123/130] (608s left) prime_mmap (test_forked_cpu_write)
[422.148668] Starting subtest: test_forked_cpu_write
[422.149714] Starting dynamic subtest: test_forked_cpu_write-smem
[422.154064] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s)
[422.154910] Subtest test_forked_cpu_write: SUCCESS (0.006s)
[422.241589] [124/130] (608s left) kms_color (invalid-ctm-matrix-sizes)
[422.314500] Starting subtest: invalid-ctm-matrix-sizes
[422.315517] Starting dynamic subtest: pipe-A
[422.317671] Dynamic subtest pipe-A: SUCCESS (0.002s)
[422.323931] Starting dynamic subtest: pipe-B
[422.324930] Dynamic subtest pipe-B: SUCCESS (0.002s)
[422.330716] Starting dynamic subtest: pipe-C
[422.331694] Dynamic subtest pipe-C: SUCCESS (0.003s)
[422.337261] Starting dynamic subtest: pipe-D
[422.338197] Dynamic subtest pipe-D: SUCCESS (0.003s)
[422.339145] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.012s)
[422.373001] [125/130] (608s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[422.467342] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[422.469113] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[422.535954] [126/130] (607s left) kms_pm_backlight (basic-brightness)
[422.612816] Starting subtest: basic-brightness
[422.663141] Starting dynamic subtest: eDP-1
[423.165729] Dynamic subtest eDP-1: SUCCESS (0.501s)
[423.166928] Subtest basic-brightness: SUCCESS (0.551s)
[424.078347] [127/130] (606s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[424.170567] Starting subtest: extended-pageflip-modeset-hang-oldfb
[424.173027] Starting dynamic subtest: pipe-A
[432.054197] Dynamic subtest pipe-A: SUCCESS (7.882s)
[432.064032] Starting dynamic subtest: pipe-D
[440.714574] Dynamic subtest pipe-D: SUCCESS (8.659s)
[440.715681] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.545s)
[441.616998] [128/130] (588s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[441.712198] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[447.017152] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (5.306s)
[447.138171] [129/130] (583s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[447.183877] Starting subtest: etime-single-wait-all-available-unsubmitted
[447.290496] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.104s)
[447.339017] [130/130] (583s left) gem_ctx_persistence (engines-hostile-preempt)
[447.388228] Starting subtest: engines-hostile-preempt
[447.389452] Starting dynamic subtest: rcs0
[447.461570] Dynamic subtest rcs0: SUCCESS (0.073s)
[447.468720] Starting dynamic subtest: bcs0
[447.525507] Dynamic subtest bcs0: SUCCESS (0.063s)
[447.534512] Starting dynamic subtest: vcs0
[448.664710] Dynamic subtest vcs0: SUCCESS (1.136s)
[448.673354] Starting dynamic subtest: vcs1
[450.676804] Dynamic subtest vcs1: SUCCESS (2.011s)
[450.685081] Starting dynamic subtest: vecs0
[452.635046] Dynamic subtest vecs0: SUCCESS (1.959s)
[452.643601] Starting dynamic subtest: ccs0
[452.695605] Dynamic subtest ccs0: SUCCESS (0.060s)
[452.697880] Subtest engines-hostile-preempt: SUCCESS (5.307s)
[452.807171] Closing watchdogs
Done.