[60.381061] Initializing watchdogs
[60.381110]   /dev/watchdog0
[60.396486] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.401070] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.403402] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.406697] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[60.532459] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[60.536520] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[60.667601] [002/134] (960s left) kms_hdr (bpc-switch)
[60.754967] Starting subtest: bpc-switch
[61.788973] Starting dynamic subtest: pipe-A-eDP-1
[65.191012] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.404s)
[65.193425] Subtest bpc-switch: SUCCESS (4.438s)
[65.338434] [003/134] (955s left) i915_module_load (reload)
[65.382407] Starting subtest: reload
[70.441215] Subtest reload: SUCCESS (5.059s)
[70.482398] [004/134] (950s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[76.834172] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[76.838829] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[77.707025] [005/134] (943s left) kms_pm_rpm (cursor)
[79.236631] Starting subtest: cursor
[79.241529] Subtest cursor: SKIP (0.000s)
[79.957872] [006/134] (941s left) kms_rotation_crc (cursor-rotation-180)
[80.054234] Starting subtest: cursor-rotation-180
[81.584947] Subtest cursor-rotation-180: SUCCESS (1.533s)
[82.826197] [007/134] (938s left) vgem_basic (bad-pad)
[82.922450] Starting subtest: bad-pad
[82.924392] Subtest bad-pad: SUCCESS (0.000s)
[83.002767] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[83.005906] [008/134] (938s left) kms_addfb_basic (invalid-get-prop)
[83.062844] Starting subtest: invalid-get-prop
[83.064748] Subtest invalid-get-prop: SUCCESS (0.000s)
[83.244847] [009/134] (938s left) gem_mmap_gtt (hang-busy)
[83.319505] Subtest hang-busy: SKIP (0.000s)
[83.390225] [010/134] (937s left) gem_eio (in-flight-1us)
[83.585962] Starting subtest: in-flight-1us
[91.415907] Subtest in-flight-1us: SUCCESS (7.829s)
[91.627758] [011/134] (929s left) gem_ctx_shared (disjoint-timelines)
[91.700409] Starting subtest: disjoint-timelines
[91.717935] Subtest disjoint-timelines: SUCCESS (0.017s)
[91.995133] [012/134] (929s left) kms_rotation_crc (bad-tiling)
[92.091621] Starting subtest: bad-tiling
[92.095875] Subtest bad-tiling: SKIP (0.001s)
[92.203181] [013/134] (929s left) gem_exec_fence (syncobj-channel)
[92.617585] Starting subtest: syncobj-channel
[93.638989] Subtest syncobj-channel: SUCCESS (1.017s)
[94.045098] [014/134] (927s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[94.155660] Starting subtest: y-tiled-64bpp-rotate-270
[94.160185] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[94.285976] [015/134] (927s left) kms_psr (psr2-cursor-plane-move)
[94.406960] Starting subtest: psr2-cursor-plane-move
[94.409320] Starting dynamic subtest: eDP-1
[96.149164] Dynamic subtest eDP-1: SUCCESS (1.743s)
[96.151533] Subtest psr2-cursor-plane-move: SUCCESS (1.744s)
[96.979645] [016/134] (924s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[97.083805] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[97.088252] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[97.208694] [017/134] (924s left) i915_pm_rpm (gem-execbuf)
[99.038456] Starting subtest: gem-execbuf
[99.041062] Starting dynamic subtest: smem0
[100.853846] Dynamic subtest smem0: SUCCESS (1.814s)
[100.856267] Subtest gem-execbuf: SUCCESS (1.815s)
[100.998200] [018/134] (920s left) syncobj_timeline (wait-zero-handles)
[101.064901] Starting subtest: wait-zero-handles
[101.067411] Subtest wait-zero-handles: SUCCESS (0.000s)
[101.186609] [019/134] (920s left) kms_pm_rpm (dpms-non-lpsp)
[103.116805] Starting subtest: dpms-non-lpsp
[103.121823] Subtest dpms-non-lpsp: SKIP (0.001s)
[103.482774] [020/134] (918s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[103.588523] Starting subtest: yf-tiled-addfb-size-offset-overflow
[103.592844] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[103.707352] [021/134] (918s left) gem_render_copy (linear)
[103.759092] Starting subtest: linear
[103.761270] Starting dynamic subtest: smem
[103.800049] Dynamic subtest smem: SUCCESS (0.041s)
[103.802260] Subtest linear: SUCCESS (0.041s)
[104.072393] [022/134] (917s left) i915_drm_fdinfo (basics)
[104.110682] Starting subtest: basics
[104.112980] Subtest basics: SUCCESS (0.000s)
[104.195586] [023/134] (917s left) kms_cursor_edge_walk (64x64-top-bottom)
[104.298753] Starting subtest: 64x64-top-bottom
[104.300987] Starting dynamic subtest: pipe-A-eDP-1
[107.749080] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s)
[107.758599] Starting dynamic subtest: pipe-D-eDP-1
[110.868085] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[110.870373] Subtest 64x64-top-bottom: SUCCESS (6.570s)
[111.706914] [024/134] (910s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[111.815608] Starting subtest: 4-tiled-addfb-size-offset-overflow
[111.817603] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[111.950363] [025/134] (909s left) kms_psr (fbc-pr-primary-blt)
[112.036915] Starting subtest: fbc-pr-primary-blt
[112.041097] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[112.134635] [026/134] (909s left) kms_cursor_crc (cursor-size-hints)
[112.253718] Starting subtest: cursor-size-hints
[112.256042] Starting dynamic subtest: pipe-A-eDP-1
[112.863383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[112.873633] Starting dynamic subtest: pipe-D-eDP-1
[114.157468] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s)
[114.159912] Subtest cursor-size-hints: SUCCESS (1.902s)
[114.967572] [027/134] (907s left) kms_color (ctm-green-to-red)
[115.077116] Starting subtest: ctm-green-to-red
[115.079411] Starting dynamic subtest: pipe-A-eDP-1
[115.766998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[115.777363] Starting dynamic subtest: pipe-B-eDP-1
[117.159036] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[117.168078] Starting dynamic subtest: pipe-C-eDP-1
[118.500243] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s)
[118.514420] Starting dynamic subtest: pipe-D-eDP-1
[119.837461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[119.839889] Subtest ctm-green-to-red: SUCCESS (4.762s)
[120.681180] [028/134] (901s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[120.805830] Starting subtest: 2x-flip-vs-cursor-atomic
[120.810194] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[120.971838] [029/134] (901s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[121.069564] Starting subtest: fbc-psr2-sprite-mmap-gtt
[121.071834] Starting dynamic subtest: eDP-1
[121.076252] Dynamic subtest eDP-1: SKIP (0.000s)
[121.080665] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[121.163754] [030/134] (900s left) gem_create (create-clear)
[121.226215] Starting subtest: create-clear
[121.228578] Starting dynamic subtest: smem0
[154.089736] Dynamic subtest smem0: SUCCESS (32.862s)
[154.091749] Subtest create-clear: SUCCESS (32.862s)
[154.303790] [031/134] (867s left) kms_chamelium_hpd (hdmi-hpd)
[154.703548] Subtest hdmi-hpd: SKIP (0.000s)
[155.563564] [032/134] (866s left) i915_suspend (fence-restore-untiled)
[155.629112] Starting subtest: fence-restore-untiled
[155.633746] Subtest fence-restore-untiled: SKIP (0.000s)
[155.786206] [033/134] (866s left) gem_sync (basic-each)
[155.863070] Starting subtest: basic-each
[158.633051] Subtest basic-each: SUCCESS (2.775s)
[158.844935] [034/134] (863s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu)
[158.954061] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu
[158.958595] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[159.103231] [035/134] (863s left) gem_userptr_blits (map-fixed-invalidate)
[159.177766] Starting subtest: map-fixed-invalidate
[159.182054] Subtest map-fixed-invalidate: SKIP (0.000s)
[159.331754] [036/134] (863s left) api_intel_allocator (reloc-allocator)
[159.388789] Starting subtest: reloc-allocator
[159.391210] Starting dynamic subtest: basic
[159.393688] Dynamic subtest basic: SUCCESS (0.003s)
[159.406670] Starting dynamic subtest: parallel-one
[159.408912] Dynamic subtest parallel-one: SUCCESS (0.006s)
[159.422016] Starting dynamic subtest: print
[159.423972] Dynamic subtest print: SUCCESS (0.000s)
[159.436487] Starting dynamic subtest: reuse
[159.438416] Dynamic subtest reuse: SUCCESS (0.000s)
[159.447210] Starting dynamic subtest: fork-reopen-allocator
[159.449108] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[159.450969] Subtest reloc-allocator: SUCCESS (0.023s)
[159.581740] [037/134] (862s left) kms_flip (2x-flip-vs-fences)
[159.686130] Starting subtest: 2x-flip-vs-fences
[159.690314] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[159.825891] [038/134] (862s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[159.951083] Starting subtest: 2x-cursor-vs-flip-legacy
[159.954938] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[160.118453] [039/134] (862s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[160.210037] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[160.212068] Starting dynamic subtest: pipe-A-default-mode
[161.334052] Dynamic subtest pipe-A-default-mode: SKIP (1.119s)
[161.338414] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.120s)
[161.552816] [040/134] (861s left) gem_exec_params (cliprects-invalid)
[161.621575] Starting subtest: cliprects-invalid
[161.623917] Subtest cliprects-invalid: SUCCESS (0.000s)
[161.770817] [041/134] (860s left) gem_mmap (pf-nonblock)
[161.835308] Subtest pf-nonblock: SKIP (0.000s)
[161.905185] [042/134] (860s left) kms_atomic_transition (modeset-transition)
[161.991083] Starting subtest: modeset-transition
[161.992968] Starting dynamic subtest: 1x-outputs
[172.987746] Dynamic subtest 1x-outputs: SUCCESS (10.997s)
[172.990490] Subtest modeset-transition: SUCCESS (10.998s)
[173.868904] [043/134] (848s left) sw_sync (sync_expired_merge)
[173.906605] Starting subtest: sync_expired_merge
[174.980106] Subtest sync_expired_merge: SUCCESS (1.074s)
[175.062357] [044/134] (847s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[175.113433] Starting subtest: invalid-signal-one-illegal-handle
[175.115779] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s)
[175.259513] [045/134] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[175.363678] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[182.676174] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.316s)
[182.835321] [046/134] (839s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[182.904278] Subtest no-spare-fences-busy: SKIP (0.000s)
[182.970735] [047/134] (839s left) syncobj_wait (wait-all-delayed-signal)
[183.032258] Starting subtest: wait-all-delayed-signal
[183.133917] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[183.232669] [048/134] (839s left) gem_exec_reloc (basic-concurrent16)
[183.297200] Subtest basic-concurrent16: SKIP (0.000s)
[183.384479] [049/134] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[183.487839] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[183.492260] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[183.618424] [050/134] (839s left) kms_big_fb (x-tiled-addfb)
[183.734090] Starting subtest: x-tiled-addfb
[183.736075] Subtest x-tiled-addfb: SUCCESS (0.000s)
[183.870354] [051/134] (839s left) perf_pmu (semaphore-wait)
[183.907439] Starting subtest: semaphore-wait
[183.909180] Starting dynamic subtest: rcs0
[184.420988] Dynamic subtest rcs0: SUCCESS (0.512s)
[184.432498] Starting dynamic subtest: bcs0
[184.934075] Dynamic subtest bcs0: SUCCESS (0.511s)
[184.946069] Starting dynamic subtest: vcs0
[185.447052] Dynamic subtest vcs0: SUCCESS (0.511s)
[185.459044] Starting dynamic subtest: vcs1
[185.959085] Dynamic subtest vcs1: SUCCESS (0.510s)
[185.970267] Starting dynamic subtest: vecs0
[186.484974] Dynamic subtest vecs0: SUCCESS (0.509s)
[186.497897] Starting dynamic subtest: ccs0
[186.984099] Dynamic subtest ccs0: SUCCESS (0.512s)
[186.986983] Subtest semaphore-wait: SUCCESS (3.077s)
[187.123538] [052/134] (835s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[187.230053] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[187.232345] Starting dynamic subtest: pipe-A-eDP-1
[187.979791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[187.990345] Starting dynamic subtest: pipe-B-eDP-1
[189.808039] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.827s)
[189.818442] Starting dynamic subtest: pipe-C-eDP-1
[191.631807] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.823s)
[191.641564] Starting dynamic subtest: pipe-D-eDP-1
[193.464496] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.832s)
[193.466541] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.227s)
[194.721894] [053/134] (828s left) syncobj_timeline (multi-wait-for-submit-signaled)
[194.794576] Starting subtest: multi-wait-for-submit-signaled
[194.797059] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[194.942694] [054/134] (828s left) gem_userptr_blits (invalid-null-pointer)
[195.008128] Starting subtest: invalid-null-pointer
[195.010405] Subtest invalid-null-pointer: SUCCESS (0.001s)
[195.172334] [055/134] (828s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[195.243378] Starting subtest: y-tiled-to-vebox-y-tiled
[195.248020] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[195.451485] [056/134] (827s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[195.555685] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[195.559830] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[195.686966] [057/134] (827s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[195.800599] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[202.396401] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.597s)
[202.560381] [058/134] (820s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[202.658946] Starting subtest: bad-aux-stride-y-tiled-ccs
[202.661237] Starting dynamic subtest: pipe-A-eDP-1
[202.683035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[202.693518] Starting dynamic subtest: pipe-B-eDP-1
[202.714145] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[202.722962] Starting dynamic subtest: pipe-C-eDP-1
[202.743712] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[202.751908] Starting dynamic subtest: pipe-D-eDP-1
[202.773143] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[202.777397] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[205.005309] [059/134] (818s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[205.066226] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[205.068110] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[205.201965] [060/134] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[205.294505] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[212.582504] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.290s)
[212.750280] [061/134] (810s left) kms_sequence (get-forked)
[212.854708] Starting subtest: get-forked
[212.856655] Starting dynamic subtest: pipe-A-eDP-1
[214.733329] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[214.743129] Starting dynamic subtest: pipe-B-eDP-1
[217.255437] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.521s)
[217.264797] Starting dynamic subtest: pipe-C-eDP-1
[219.769946] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.513s)
[219.780240] Starting dynamic subtest: pipe-D-eDP-1
[222.285936] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.514s)
[222.288457] Subtest get-forked: SUCCESS (9.431s)
[223.146348] [062/134] (800s left) gen3_render_tiledy_blits
[223.277755] [063/134] (800s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[223.337374] Starting subtest: etime-single-wait-for-submit-submitted
[223.439040] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.103s)
[223.542501] [064/134] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[223.655759] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[223.659812] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[223.784911] [065/134] (799s left) kms_feature_discovery (display-3x)
[223.877713] Starting subtest: display-3x
[223.882095] Subtest display-3x: SKIP (0.000s)
[223.982382] [066/134] (799s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[224.093292] Starting subtest: fbc-rgb101010-draw-mmap-wc
[228.720309] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.632s)
[229.849707] [067/134] (793s left) gem_exec_balancer (full-pulse)
[229.911551] Starting subtest: full-pulse
[234.787547] Subtest full-pulse: SUCCESS (4.876s)
[235.173454] [068/134] (788s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[235.280596] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[235.282985] Starting dynamic subtest: pipe-A-default-mode
[235.593565] Dynamic subtest pipe-A-default-mode: SKIP (0.312s)
[235.597682] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.314s)
[236.472687] [069/134] (787s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[236.570251] Starting subtest: yf-tiled-32bpp-rotate-270
[236.574736] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[236.714452] [070/134] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[236.814617] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[236.818986] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[236.933129] [071/134] (786s left) gem_fence_thrash (bo-write-verify-threaded-none)
[236.970824] Starting subtest: bo-write-verify-threaded-none
[236.994592] Subtest bo-write-verify-threaded-none: SKIP (0.022s)
[237.052671] [072/134] (786s left) gem_ctx_persistence (engines-hang)
[237.120334] Starting subtest: engines-hang
[237.122671] Starting dynamic subtest: rcs0
[237.233934] Dynamic subtest rcs0: SUCCESS (0.113s)
[237.246105] Starting dynamic subtest: bcs0
[237.321139] Dynamic subtest bcs0: SUCCESS (0.085s)
[237.332628] Starting dynamic subtest: vcs0
[237.438568] Dynamic subtest vcs0: SUCCESS (0.116s)
[237.449472] Starting dynamic subtest: vcs1
[237.553551] Dynamic subtest vcs1: SUCCESS (0.113s)
[237.564693] Starting dynamic subtest: vecs0
[237.631229] Dynamic subtest vecs0: SUCCESS (0.076s)
[237.641409] Starting dynamic subtest: ccs0
[237.780546] Dynamic subtest ccs0: SUCCESS (0.147s)
[237.782797] Subtest engines-hang: SUCCESS (0.662s)
[237.884388] [073/134] (786s left) kms_plane_lowres (tiling-4)
[237.981324] Starting subtest: tiling-4
[237.983247] Starting dynamic subtest: pipe-A-eDP-1
[237.986948] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[238.279272] Starting dynamic subtest: pipe-B-eDP-1
[238.284081] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[238.294757] Starting dynamic subtest: pipe-C-eDP-1
[238.299321] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[238.308178] Starting dynamic subtest: pipe-D-eDP-1
[238.312589] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[238.316980] Subtest tiling-4: SKIP (0.293s)
[239.099645] [074/134] (784s left) gem_exercise_blt (fast-copy)
[239.161095] Starting subtest: fast-copy
[239.163025] Starting dynamic subtest: linear-smem-smem
[239.182621] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[239.194083] Starting dynamic subtest: xmajor-smem-smem
[239.201095] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[239.209948] Starting dynamic subtest: tile4-smem-smem
[239.217962] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[239.227303] Starting dynamic subtest: tile64-smem-smem
[239.235717] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[239.237978] Subtest fast-copy: SUCCESS (0.078s)
[239.401936] [075/134] (784s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[239.501144] Starting subtest: compare-crc-sanitycheck-xr24
[239.503477] Starting dynamic subtest: pipe-A-eDP-1
[240.132119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[240.141463] Starting dynamic subtest: pipe-B-eDP-1
[241.455218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s)
[241.464819] Starting dynamic subtest: pipe-C-eDP-1
[242.732932] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[242.745474] Starting dynamic subtest: pipe-D-eDP-1
[243.973946] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[243.976266] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.474s)
[244.808334] [076/134] (779s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[244.871846] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[244.976555] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.105s)
[245.074273] [077/134] (779s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[245.175469] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[245.179583] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[245.323586] [078/134] (778s left) gem_exec_reloc (basic-cpu)
[245.385020] Subtest basic-cpu: SKIP (0.000s)
[245.465692] [079/134] (778s left) syncobj_timeline (reset-unsignaled)
[245.528959] Starting subtest: reset-unsignaled
[245.531568] Subtest reset-unsignaled: SUCCESS (0.000s)
[245.663419] [080/134] (778s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[245.751389] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[245.753675] Starting dynamic subtest: pipe-A-eDP-1
[245.776863] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.788251] Starting dynamic subtest: pipe-B-eDP-1
[245.809834] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[245.818430] Starting dynamic subtest: pipe-C-eDP-1
[245.839810] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.848114] Starting dynamic subtest: pipe-D-eDP-1
[245.870372] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.874402] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[247.997089] [081/134] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[248.111817] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[255.447182] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.337s)
[255.606803] [082/134] (768s left) kms_psr (psr-cursor-plane-move)
[255.704768] Starting subtest: psr-cursor-plane-move
[255.706989] Starting dynamic subtest: eDP-1
[257.398580] Dynamic subtest eDP-1: SUCCESS (1.693s)
[257.400890] Subtest psr-cursor-plane-move: SUCCESS (1.694s)
[258.296386] [083/134] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[258.408113] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[258.412223] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[258.548700] [084/134] (765s left) gem_wait (write-wait)
[258.613779] Starting subtest: write-wait
[258.616108] Starting dynamic subtest: all-engines
[259.744925] Dynamic subtest all-engines: SUCCESS (1.130s)
[259.759780] Starting dynamic subtest: rcs0
[260.803579] Dynamic subtest rcs0: SUCCESS (1.056s)
[260.820276] Starting dynamic subtest: bcs0
[261.861311] Dynamic subtest bcs0: SUCCESS (1.056s)
[261.877719] Starting dynamic subtest: vcs0
[262.917592] Dynamic subtest vcs0: SUCCESS (1.054s)
[262.934557] Starting dynamic subtest: vcs1
[263.970576] Dynamic subtest vcs1: SUCCESS (1.051s)
[263.986981] Starting dynamic subtest: vecs0
[265.025740] Dynamic subtest vecs0: SUCCESS (1.053s)
[265.042078] Starting dynamic subtest: ccs0
[266.082214] Dynamic subtest ccs0: SUCCESS (1.054s)
[266.084764] Subtest write-wait: SUCCESS (7.469s)
[266.307731] [085/134] (758s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[266.422519] Starting subtest: cursorB-vs-flipA-varying-size
[266.427050] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[266.595424] [086/134] (757s left) perf (blocking-parameterized)
[266.735831] Starting subtest: blocking-parameterized
[286.759126] Subtest blocking-parameterized: SUCCESS (20.021s)
[286.808705] [087/134] (737s left) kms_chamelium_edid (hdmi-edid-read)
[287.198698] Subtest hdmi-edid-read: SKIP (0.000s)
[287.982403] [088/134] (736s left) prime_mmap (test_errors)
[288.048735] Starting subtest: test_errors
[288.050767] Starting dynamic subtest: test_errors-smem
[288.141984] Dynamic subtest test_errors-smem: SUCCESS (0.094s)
[288.144959] Subtest test_errors: SUCCESS (0.095s)
[288.279507] [089/134] (736s left) fbdev (pan)
[288.319268] Starting subtest: pan
[288.345570] Subtest pan: SUCCESS (0.033s)
[288.443339] [090/134] (736s left) kms_invalid_mode (zero-clock)
[288.544100] Starting subtest: zero-clock
[288.546665] Starting dynamic subtest: pipe-A-eDP-1
[288.827939] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[288.837248] Starting dynamic subtest: pipe-B-eDP-1
[288.839481] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[288.848635] Starting dynamic subtest: pipe-C-eDP-1
[288.850549] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[288.858891] Starting dynamic subtest: pipe-D-eDP-1
[288.860783] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[288.862690] Subtest zero-clock: SUCCESS (0.288s)
[289.651369] [091/134] (735s left) kms_atomic_transition (plane-all-transition-nonblocking)
[289.751485] Starting subtest: plane-all-transition-nonblocking
[289.753726] Starting dynamic subtest: pipe-A-eDP-1
[292.245838] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[292.566970] Starting dynamic subtest: pipe-B-eDP-1
[295.766038] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.209s)
[296.076526] Subtest plane-all-transition-nonblocking: SUCCESS (6.323s)
[296.926275] [092/134] (727s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[297.026369] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[297.030704] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[297.155346] [093/134] (727s left) gem_pxp (regular-baseline-src-copy-readible)
[297.281577] Starting subtest: regular-baseline-src-copy-readible
[297.339560] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[297.493919] [094/134] (727s left) kms_plane_scaling (planes-downscale-factor-0-5)
[297.583243] Starting subtest: planes-downscale-factor-0-5
[297.585517] Starting dynamic subtest: pipe-A
[297.605862] Dynamic subtest pipe-A: SKIP (0.018s)
[297.615646] Starting dynamic subtest: pipe-B
[297.637987] Dynamic subtest pipe-B: SKIP (0.032s)
[297.647562] Starting dynamic subtest: pipe-C
[297.671748] Dynamic subtest pipe-C: SKIP (0.032s)
[297.683073] Starting dynamic subtest: pipe-D
[297.705086] Dynamic subtest pipe-D: SKIP (0.035s)
[297.708849] Subtest planes-downscale-factor-0-5: SKIP (0.120s)
[297.842083] [095/134] (727s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[297.932412] Starting subtest: fbc-pr-cursor-mmap-gtt
[297.936157] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[298.040461] [096/134] (726s left) kms_content_protection (legacy-hdcp14)
[298.186793] Starting subtest: legacy-hdcp14
[298.190823] Subtest legacy-hdcp14: SKIP (0.000s)
[298.350610] [097/134] (726s left) gem_caching (writes)
[298.420182] Subtest writes: SKIP (0.000s)
[298.485898] [098/134] (726s left) kms_cursor_crc (cursor-onscreen-128x42)
[298.709589] Starting subtest: cursor-onscreen-128x42
[298.757325] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[299.015154] [099/134] (726s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[299.115260] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[303.617289] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.506s)
[304.849924] [100/134] (720s left) core_auth (getclient-master-drop)
[304.884896] Starting subtest: getclient-master-drop
[304.906086] Subtest getclient-master-drop: SUCCESS (0.021s)
[305.037777] [101/134] (720s left) gem_lmem_swapping (random)
[305.079781] Subtest random: SKIP (0.000s)
[305.131439] [102/134] (720s left) kms_psr (pr-cursor-blt)
[305.220477] Starting subtest: pr-cursor-blt
[305.224813] Subtest pr-cursor-blt: SKIP (0.000s)
[305.315911] [103/134] (719s left) kms_async_flips (alternate-sync-async-flip)
[305.418709] Starting subtest: alternate-sync-async-flip
[305.801560] Starting dynamic subtest: pipe-A-eDP-1
[308.616431] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.815s)
[308.994092] Starting dynamic subtest: pipe-B-eDP-1
[311.740357] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.753s)
[312.130895] Starting dynamic subtest: pipe-C-eDP-1
[314.881133] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s)
[315.262750] Starting dynamic subtest: pipe-D-eDP-1
[318.012660] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.757s)
[318.014842] Subtest alternate-sync-async-flip: SUCCESS (12.597s)
[319.210371] [104/134] (706s left) gem_exec_whisper (basic-contexts-all)
[319.288830] Starting subtest: basic-contexts-all
[330.255999] Subtest basic-contexts-all: SUCCESS (10.963s)
[330.464420] [105/134] (694s left) syncobj_wait (wait-any-interrupted)
[330.524646] Starting subtest: wait-any-interrupted
[330.626393] Subtest wait-any-interrupted: SUCCESS (0.102s)
[330.720033] [106/134] (694s left) kms_rotation_crc (bad-pixel-format)
[330.824852] Starting subtest: bad-pixel-format
[330.829276] Subtest bad-pixel-format: SKIP (0.001s)
[330.921804] [107/134] (694s left) kms_addfb_basic (too-wide)
[331.010938] Starting subtest: too-wide
[331.013266] Subtest too-wide: SUCCESS (0.000s)
[331.130711] [108/134] (694s left) gem_spin_batch (legacy-resubmit-new)
[331.198621] Starting subtest: legacy-resubmit-new
[331.200991] Starting dynamic subtest: default
[331.208124] Dynamic subtest default: SUCCESS (0.009s)
[331.220681] Starting dynamic subtest: render
[331.223259] Dynamic subtest render: SUCCESS (0.004s)
[331.232920] Starting dynamic subtest: bsd
[331.235670] Dynamic subtest bsd: SUCCESS (0.005s)
[331.244863] Starting dynamic subtest: bsd1
[331.246773] Dynamic subtest bsd1: SUCCESS (0.004s)
[331.255433] Starting dynamic subtest: bsd2
[331.257287] Dynamic subtest bsd2: SUCCESS (0.003s)
[331.265787] Starting dynamic subtest: blt
[331.267657] Dynamic subtest blt: SUCCESS (0.004s)
[331.276242] Starting dynamic subtest: vebox
[331.278066] Dynamic subtest vebox: SUCCESS (0.005s)
[331.279898] Subtest legacy-resubmit-new: SUCCESS (0.039s)
[332.947778] [109/134] (692s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[333.055330] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[333.057651] Starting dynamic subtest: pipe-A-default-mode
[333.347353] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[333.351986] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.290s)
[334.237632] [110/134] (691s left) gem_exec_balancer (parallel-keep-submit-fence)
[334.499828] Starting subtest: parallel-keep-submit-fence
[335.716942] Subtest parallel-keep-submit-fence: SUCCESS (1.217s)
[335.856157] [111/134] (689s left) perf (non-system-wide-paranoid)
[335.967200] Starting subtest: non-system-wide-paranoid
[335.994370] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[336.042871] [112/134] (689s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[336.150435] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[336.154971] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[336.322256] [113/134] (689s left) kms_busy (basic)
[336.425754] Starting subtest: basic
[336.428141] Starting dynamic subtest: flip
[337.015714] Dynamic subtest flip: SUCCESS (0.591s)
[337.028734] Starting dynamic subtest: modeset
[340.421519] Dynamic subtest modeset: SUCCESS (3.405s)
[340.423832] Subtest basic: SUCCESS (3.999s)
[341.250285] [114/134] (684s left) kms_plane (plane-panning-bottom-right-suspend)
[341.350949] Starting subtest: plane-panning-bottom-right-suspend
[341.353178] Starting dynamic subtest: pipe-A
[358.901624] Dynamic subtest pipe-A: SUCCESS (2.989s)
[358.912010] Starting dynamic subtest: pipe-B
[377.938820] Dynamic subtest pipe-B: SUCCESS (3.560s)
[377.941622] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.552s)
[378.801353] [115/134] (646s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[378.864114] Starting subtest: invalid-multi-wait-all-unsubmitted
[378.866536] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[378.987245] [116/134] (646s left) kms_big_fb (linear-64bpp-rotate-180)
[379.094885] Starting subtest: linear-64bpp-rotate-180
[380.709039] Subtest linear-64bpp-rotate-180: SUCCESS (1.612s)
[380.926368] [117/134] (644s left) perf (invalid-oa-metric-set-id)
[381.026651] Starting subtest: invalid-oa-metric-set-id
[381.035672] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[381.076786] [118/134] (644s left) gen7_exec_parse (batch-without-end)
[381.151681] Subtest batch-without-end: SKIP (0.000s)
[381.236693] [119/134] (644s left) perf_pmu (most-busy-idle-check-all)
[381.282786] Starting subtest: most-busy-idle-check-all
[381.285173] Starting dynamic subtest: rcs0
[381.996555] Dynamic subtest rcs0: FAIL (0.642s)
[382.006662] Starting dynamic subtest: bcs0
[382.944232] Dynamic subtest bcs0: SUCCESS (1.017s)
[382.958356] Starting dynamic subtest: vcs0
[384.928249] Dynamic subtest vcs0: SUCCESS (1.979s)
[384.942381] Starting dynamic subtest: vcs1
[386.912225] Dynamic subtest vcs1: SUCCESS (1.980s)
[386.925905] Starting dynamic subtest: vecs0
[388.960239] Dynamic subtest vecs0: SUCCESS (2.044s)
[388.974496] Starting dynamic subtest: ccs0
[390.944646] Dynamic subtest ccs0: SUCCESS (1.980s)
[390.947695] Subtest most-busy-idle-check-all: FAIL (9.656s)
[391.076346] [120/134] (634s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[391.177440] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[391.182080] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[392.337173] [121/134] (633s left) perf_pmu (all-busy-idle-check-all)
[392.383529] Starting subtest: all-busy-idle-check-all
[393.953111] Subtest all-busy-idle-check-all: SUCCESS (1.569s)
[394.085584] [122/134] (631s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[394.182569] Starting subtest: primary-x-tiled-reflect-x-0
[401.181349] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.996s)
[402.415821] [123/134] (623s left) syncobj_wait (multi-wait-submitted)
[402.473811] Starting subtest: multi-wait-submitted
[402.581138] Subtest multi-wait-submitted: SUCCESS (0.107s)
[402.683685] [124/134] (623s left) dmabuf_sync_file (export-before-signal)
[402.732765] Starting subtest: export-before-signal
[402.735429] Subtest export-before-signal: SUCCESS (0.001s)
[402.819469] [125/134] (623s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[402.916142] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[402.918668] Starting dynamic subtest: pipe-A-eDP-1
[405.119607] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.203s)
[405.129758] Starting dynamic subtest: pipe-B-eDP-1
[407.579123] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[407.591409] Starting dynamic subtest: pipe-C-eDP-1
[409.770794] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.191s)
[409.781330] Starting dynamic subtest: pipe-D-eDP-1
[411.868100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.095s)
[411.870346] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.951s)
[413.069422] [126/134] (613s left) kms_prop_blob (blob-prop-validate)
[413.138470] Starting subtest: blob-prop-validate
[413.140633] Subtest blob-prop-validate: SUCCESS (0.000s)
[413.269724] [127/134] (613s left) kms_vblank (query-busy-hang)
[413.364716] Starting subtest: query-busy-hang
[413.367220] Starting dynamic subtest: pipe-A-eDP-1
[439.723805] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.346s)
[439.741593] Starting dynamic subtest: pipe-D-eDP-1
[464.687783] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.955s)
[464.690886] Subtest query-busy-hang: SUCCESS (51.306s)
[465.551669] [128/134] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[465.661438] Starting subtest: psr-2p-primscrn-cur-indfb-move
[465.665919] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[465.790765] [129/134] (560s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-wc)
[465.898743] Starting subtest: fbc-abgr161616f-draw-mmap-wc
[465.903647] Subtest fbc-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[466.033982] [130/134] (560s left) gem_exec_schedule (promotion)
[466.107284] Starting subtest: promotion
[466.109673] Starting dynamic subtest: rcs0
[466.220679] Dynamic subtest rcs0: SUCCESS (0.123s)
[466.233404] Starting dynamic subtest: vcs0
[466.308812] Dynamic subtest vcs0: SUCCESS (0.088s)
[466.322347] Starting dynamic subtest: vcs1
[466.390463] Dynamic subtest vcs1: SUCCESS (0.079s)
[466.403821] Starting dynamic subtest: vecs0
[466.471346] Dynamic subtest vecs0: SUCCESS (0.080s)
[466.483411] Starting dynamic subtest: ccs0
[466.560197] Dynamic subtest ccs0: SUCCESS (0.088s)
[466.562547] Subtest promotion: SUCCESS (0.464s)
[468.071085] [131/134] (558s left) gem_ctx_persistence (legacy-engines-queued)
[468.141450] Starting subtest: legacy-engines-queued
[468.143886] Starting dynamic subtest: render
[468.252416] Dynamic subtest render: SUCCESS (0.114s)
[468.268276] Starting dynamic subtest: bsd1
[469.887703] Dynamic subtest bsd1: SUCCESS (1.630s)
[469.901589] Starting dynamic subtest: bsd2
[471.933362] Dynamic subtest bsd2: SUCCESS (2.041s)
[471.945964] Starting dynamic subtest: blt
[472.020927] Dynamic subtest blt: SUCCESS (0.085s)
[472.038758] Starting dynamic subtest: vebox
[473.918044] Dynamic subtest vebox: SUCCESS (1.893s)
[473.920856] Subtest legacy-engines-queued: SUCCESS (5.779s)
[474.024714] [132/134] (552s left) gem_readwrite (new-obj)
[474.090014] Subtest new-obj: SKIP (0.000s)
[474.177163] [133/134] (552s left) gem_exec_reloc (basic-cpu-read-noreloc)
[474.234326] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[474.309165] [134/134] (552s left) gem_exec_schedule (preemptive-hang)
[474.507135] Starting subtest: preemptive-hang
[474.510031] Starting dynamic subtest: rcs0
[484.050889] Dynamic subtest rcs0: SUCCESS (9.547s)
[484.063430] Starting dynamic subtest: bcs0
[493.068483] Dynamic subtest bcs0: SUCCESS (9.023s)
[493.082004] Starting dynamic subtest: vcs0
[502.025029] Dynamic subtest vcs0: SUCCESS (8.956s)
[502.037814] Starting dynamic subtest: vcs1
[511.048669] Dynamic subtest vcs1: SUCCESS (9.024s)
[511.061205] Starting dynamic subtest: vecs0
[520.071253] Dynamic subtest vecs0: SUCCESS (9.021s)
[520.085156] Starting dynamic subtest: ccs0
[529.033295] Dynamic subtest ccs0: SUCCESS (8.960s)
[529.036266] Subtest preemptive-hang: SUCCESS (54.543s)
[529.326181] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_hdr
results: parsing output: 2/ for test: i915_module_load
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: vgem_basic
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_pm_rpm
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_pm_rpm
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_create
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: i915_suspend
results: parsing output: 32/ for test: gem_sync
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: gem_mmap
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_fenced_exec_thrash
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: gen3_render_tiledy_blits
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_feature_discovery
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_fence_thrash
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_plane_lowres
results: parsing output: 73/ for test: gem_exercise_blt
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_wait
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_chamelium_edid
results: parsing output: 87/ for test: prime_mmap
results: parsing output: 88/ for test: fbdev
results: parsing output: 89/ for test: kms_invalid_mode
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: gem_caching
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: core_auth
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: gem_spin_batch
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_busy
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: gen7_exec_parse
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: dmabuf_sync_file
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_prop_blob
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: gem_readwrite
results: parsing output: 132/ for test: gem_exec_reloc
results: parsing output: 133/ for test: gem_exec_schedule
Done.