[59.979687] Initializing watchdogs
[59.979733]   /dev/watchdog0
[59.993241] [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]
[59.997440] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.999813] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.003156] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[60.125694] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[60.130062] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[60.232419] [002/134] (960s left) kms_hdr (bpc-switch)
[60.325385] Starting subtest: bpc-switch
[61.360527] Starting dynamic subtest: pipe-A-eDP-1
[64.762085] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.402s)
[64.764524] Subtest bpc-switch: SUCCESS (4.438s)
[64.908487] [003/134] (955s left) i915_module_load (reload)
[64.943441] Starting subtest: reload
[68.422552] Subtest reload: SUCCESS (3.479s)
[68.457370] [004/134] (952s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[74.835169] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[74.839767] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[75.721524] [005/134] (944s left) kms_pm_rpm (cursor)
[77.246316] Starting subtest: cursor
[77.251174] Subtest cursor: SKIP (0.000s)
[77.977568] [006/134] (942s left) kms_rotation_crc (cursor-rotation-180)
[78.066623] Starting subtest: cursor-rotation-180
[79.518476] Subtest cursor-rotation-180: SUCCESS (1.452s)
[80.734230] [007/134] (939s left) vgem_basic (bad-pad)
[80.814550] Starting subtest: bad-pad
[80.816728] Subtest bad-pad: SUCCESS (0.000s)
[80.892603] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[80.895562] [008/134] (939s left) kms_addfb_basic (invalid-get-prop)
[80.954617] Starting subtest: invalid-get-prop
[80.957043] Subtest invalid-get-prop: SUCCESS (0.000s)
[81.130553] [009/134] (939s left) gem_mmap_gtt (hang-busy)
[81.197661] Subtest hang-busy: SKIP (0.000s)
[81.263572] [010/134] (939s left) gem_eio (in-flight-1us)
[81.449984] Starting subtest: in-flight-1us
[89.337060] Subtest in-flight-1us: SUCCESS (7.888s)
[89.528279] [011/134] (931s left) gem_ctx_shared (disjoint-timelines)
[89.599319] Starting subtest: disjoint-timelines
[89.614115] Subtest disjoint-timelines: SUCCESS (0.016s)
[89.892550] [012/134] (931s left) kms_rotation_crc (bad-tiling)
[89.985877] Starting subtest: bad-tiling
[89.990244] Subtest bad-tiling: SKIP (0.001s)
[90.080177] [013/134] (930s left) gem_exec_fence (syncobj-channel)
[90.491432] Starting subtest: syncobj-channel
[91.509745] Subtest syncobj-channel: SUCCESS (1.014s)
[92.018624] [014/134] (928s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[92.130904] Starting subtest: y-tiled-64bpp-rotate-270
[92.135082] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[92.269218] [015/134] (928s left) kms_psr (psr2-cursor-plane-move)
[92.355388] Starting subtest: psr2-cursor-plane-move
[92.357677] Starting dynamic subtest: eDP-1
[94.084223] Dynamic subtest eDP-1: SUCCESS (1.728s)
[94.086425] Subtest psr2-cursor-plane-move: SUCCESS (1.728s)
[94.903194] [016/134] (926s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[95.011321] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[95.015978] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[95.159368] [017/134] (925s left) i915_pm_rpm (gem-execbuf)
[97.102719] Starting subtest: gem-execbuf
[97.104943] Starting dynamic subtest: smem0
[98.814496] Dynamic subtest smem0: SUCCESS (1.714s)
[98.816865] Subtest gem-execbuf: SUCCESS (1.715s)
[98.922794] [018/134] (922s left) syncobj_timeline (wait-zero-handles)
[98.984054] Starting subtest: wait-zero-handles
[98.986370] Subtest wait-zero-handles: SUCCESS (0.000s)
[99.115617] [019/134] (922s left) kms_pm_rpm (dpms-non-lpsp)
[101.043661] Starting subtest: dpms-non-lpsp
[101.048874] Subtest dpms-non-lpsp: SKIP (0.001s)
[101.453386] [020/134] (919s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[101.551659] Starting subtest: yf-tiled-addfb-size-offset-overflow
[101.556057] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[101.679192] [021/134] (919s left) gem_render_copy (linear)
[101.749676] Starting subtest: linear
[101.752113] Starting dynamic subtest: smem
[101.790935] Dynamic subtest smem: SUCCESS (0.041s)
[101.793887] Subtest linear: SUCCESS (0.041s)
[101.997415] [022/134] (919s left) i915_drm_fdinfo (basics)
[102.038300] Starting subtest: basics
[102.040584] Subtest basics: SUCCESS (0.000s)
[102.128368] [023/134] (919s left) kms_cursor_edge_walk (64x64-top-bottom)
[102.228059] Starting subtest: 64x64-top-bottom
[102.230467] Starting dynamic subtest: pipe-A-eDP-1
[105.681165] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[105.690513] Starting dynamic subtest: pipe-D-eDP-1
[108.800817] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[108.803176] Subtest 64x64-top-bottom: SUCCESS (6.574s)
[109.631514] [024/134] (911s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[109.737442] Starting subtest: 4-tiled-addfb-size-offset-overflow
[109.739647] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[109.854522] [025/134] (911s left) kms_psr (fbc-pr-primary-blt)
[109.954946] Starting subtest: fbc-pr-primary-blt
[109.959460] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[110.048888] [026/134] (911s left) kms_cursor_crc (cursor-size-hints)
[110.175804] Starting subtest: cursor-size-hints
[110.178111] Starting dynamic subtest: pipe-A-eDP-1
[110.794574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s)
[110.802806] Starting dynamic subtest: pipe-D-eDP-1
[112.067021] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.271s)
[112.069257] Subtest cursor-size-hints: SUCCESS (1.891s)
[112.885725] [027/134] (908s left) kms_color (ctm-green-to-red)
[112.990045] Starting subtest: ctm-green-to-red
[112.991990] Starting dynamic subtest: pipe-A-eDP-1
[113.677354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[113.686497] Starting dynamic subtest: pipe-B-eDP-1
[115.037784] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.359s)
[115.046623] Starting dynamic subtest: pipe-C-eDP-1
[116.397380] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[116.406838] Starting dynamic subtest: pipe-D-eDP-1
[117.712716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[117.714880] Subtest ctm-green-to-red: SUCCESS (4.723s)
[118.609786] [028/134] (902s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[118.745205] Starting subtest: 2x-flip-vs-cursor-atomic
[118.749729] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[118.911286] [029/134] (902s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[119.009828] Starting subtest: fbc-psr2-sprite-mmap-gtt
[119.011686] Starting dynamic subtest: eDP-1
[119.015675] Dynamic subtest eDP-1: SKIP (0.000s)
[119.019676] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[119.103084] [030/134] (902s left) gem_create (create-clear)
[119.161235] Starting subtest: create-clear
[119.163262] Starting dynamic subtest: smem0
[152.072271] Dynamic subtest smem0: SUCCESS (32.908s)
[152.074494] Subtest create-clear: SUCCESS (32.909s)
[152.287244] [031/134] (869s left) kms_chamelium_hpd (hdmi-hpd)
[152.689385] Subtest hdmi-hpd: SKIP (0.000s)
[153.488120] [032/134] (868s left) i915_suspend (fence-restore-untiled)
[153.552903] Starting subtest: fence-restore-untiled
[153.557039] Subtest fence-restore-untiled: SKIP (0.000s)
[153.675676] [033/134] (868s left) gem_sync (basic-each)
[153.759537] Starting subtest: basic-each
[156.321049] Subtest basic-each: SUCCESS (2.574s)
[156.531498] [034/134] (865s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu)
[156.650289] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu
[156.654674] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[156.782817] [035/134] (865s left) gem_userptr_blits (map-fixed-invalidate)
[156.855984] Starting subtest: map-fixed-invalidate
[156.860298] Subtest map-fixed-invalidate: SKIP (0.000s)
[157.037886] [036/134] (864s left) api_intel_allocator (reloc-allocator)
[157.101161] Starting subtest: reloc-allocator
[157.103601] Starting dynamic subtest: basic
[157.105840] Dynamic subtest basic: SUCCESS (0.004s)
[157.116154] Starting dynamic subtest: parallel-one
[157.118417] Dynamic subtest parallel-one: SUCCESS (0.007s)
[157.126541] Starting dynamic subtest: print
[157.128392] Dynamic subtest print: SUCCESS (0.000s)
[157.135766] Starting dynamic subtest: reuse
[157.137656] Dynamic subtest reuse: SUCCESS (0.000s)
[157.145240] Starting dynamic subtest: fork-reopen-allocator
[157.147130] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[157.148973] Subtest reloc-allocator: SUCCESS (0.024s)
[157.287295] [037/134] (864s left) kms_flip (2x-flip-vs-fences)
[157.383896] Starting subtest: 2x-flip-vs-fences
[157.388259] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[157.520815] [038/134] (864s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[157.639373] Starting subtest: 2x-cursor-vs-flip-legacy
[157.643174] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[157.805494] [039/134] (864s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[157.899362] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[157.901768] Starting dynamic subtest: pipe-A-default-mode
[159.068208] Dynamic subtest pipe-A-default-mode: SKIP (1.165s)
[159.072665] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.166s)
[159.260010] [040/134] (862s left) gem_exec_params (cliprects-invalid)
[159.318315] Starting subtest: cliprects-invalid
[159.320704] Subtest cliprects-invalid: SUCCESS (0.000s)
[159.453461] [041/134] (862s left) gem_mmap (pf-nonblock)
[159.510763] Subtest pf-nonblock: SKIP (0.000s)
[159.575202] [042/134] (862s left) kms_atomic_transition (modeset-transition)
[159.672218] Starting subtest: modeset-transition
[159.674138] Starting dynamic subtest: 1x-outputs
[170.489510] Dynamic subtest 1x-outputs: SUCCESS (10.817s)
[170.491947] Subtest modeset-transition: SUCCESS (10.818s)
[171.367774] [043/134] (850s left) sw_sync (sync_expired_merge)
[171.406578] Starting subtest: sync_expired_merge
[172.480390] Subtest sync_expired_merge: SUCCESS (1.074s)
[172.563248] [044/134] (849s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[172.630407] Starting subtest: invalid-signal-one-illegal-handle
[172.632484] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[172.761973] [045/134] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[172.856659] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[180.210339] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.356s)
[180.379568] [046/134] (841s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[180.453560] Subtest no-spare-fences-busy: SKIP (0.000s)
[180.545496] [047/134] (841s left) syncobj_wait (wait-all-delayed-signal)
[180.595280] Starting subtest: wait-all-delayed-signal
[180.696351] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[180.799808] [048/134] (841s left) gem_exec_reloc (basic-concurrent16)
[180.870963] Subtest basic-concurrent16: SKIP (0.000s)
[180.952552] [049/134] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[181.062338] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[181.066604] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[181.211484] [050/134] (841s left) kms_big_fb (x-tiled-addfb)
[181.319261] Starting subtest: x-tiled-addfb
[181.321223] Subtest x-tiled-addfb: SUCCESS (0.000s)
[181.458330] [051/134] (841s left) perf_pmu (semaphore-wait)
[181.503829] Starting subtest: semaphore-wait
[181.506138] Starting dynamic subtest: rcs0
[182.016854] Dynamic subtest rcs0: SUCCESS (0.512s)
[182.028306] Starting dynamic subtest: bcs0
[182.529067] Dynamic subtest bcs0: SUCCESS (0.511s)
[182.538951] Starting dynamic subtest: vcs0
[183.041400] Dynamic subtest vcs0: SUCCESS (0.511s)
[183.052982] Starting dynamic subtest: vcs1
[183.554838] Dynamic subtest vcs1: SUCCESS (0.510s)
[183.565866] Starting dynamic subtest: vecs0
[184.068369] Dynamic subtest vecs0: SUCCESS (0.511s)
[184.079920] Starting dynamic subtest: ccs0
[184.585594] Dynamic subtest ccs0: SUCCESS (0.513s)
[184.588566] Subtest semaphore-wait: SUCCESS (3.084s)
[185.974503] [052/134] (836s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[186.074090] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[186.076353] Starting dynamic subtest: pipe-A-eDP-1
[186.803288] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[186.813770] Starting dynamic subtest: pipe-B-eDP-1
[188.550743] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.747s)
[188.560811] Starting dynamic subtest: pipe-C-eDP-1
[190.285962] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.734s)
[190.294461] Starting dynamic subtest: pipe-D-eDP-1
[192.038988] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.752s)
[192.041389] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.958s)
[193.204546] [053/134] (829s left) syncobj_timeline (multi-wait-for-submit-signaled)
[193.266890] Starting subtest: multi-wait-for-submit-signaled
[193.269360] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[193.403702] [054/134] (829s left) gem_userptr_blits (invalid-null-pointer)
[193.470635] Starting subtest: invalid-null-pointer
[193.472589] Subtest invalid-null-pointer: SUCCESS (0.001s)
[193.642851] [055/134] (829s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[193.706164] Starting subtest: y-tiled-to-vebox-y-tiled
[193.710728] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[193.919204] [056/134] (828s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[194.018523] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[194.022900] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[194.127285] [057/134] (828s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[194.226251] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[200.829690] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.606s)
[200.982949] [058/134] (821s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[201.086118] Starting subtest: bad-aux-stride-y-tiled-ccs
[201.088401] Starting dynamic subtest: pipe-A-eDP-1
[201.111149] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[201.121693] Starting dynamic subtest: pipe-B-eDP-1
[201.143316] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[201.151904] Starting dynamic subtest: pipe-C-eDP-1
[201.174431] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[201.183764] Starting dynamic subtest: pipe-D-eDP-1
[201.205687] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[201.209968] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[203.395550] [059/134] (819s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[203.454485] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[203.456823] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[203.586794] [060/134] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[203.693443] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[211.035047] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.344s)
[211.230199] [061/134] (811s left) kms_sequence (get-forked)
[211.330192] Starting subtest: get-forked
[211.332160] Starting dynamic subtest: pipe-A-eDP-1
[213.189356] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.859s)
[213.198696] Starting dynamic subtest: pipe-B-eDP-1
[215.726493] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.535s)
[215.736556] Starting dynamic subtest: pipe-C-eDP-1
[218.244735] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.517s)
[218.254205] Starting dynamic subtest: pipe-D-eDP-1
[220.757739] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.514s)
[220.760118] Subtest get-forked: SUCCESS (9.429s)
[221.625756] [062/134] (801s left) gen3_render_tiledy_blits
[221.762556] [063/134] (801s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[221.822144] Starting subtest: etime-single-wait-for-submit-submitted
[221.929288] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[222.027569] [064/134] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[222.121826] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[222.126403] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[222.267719] [065/134] (800s left) kms_feature_discovery (display-3x)
[222.365948] Starting subtest: display-3x
[222.370608] Subtest display-3x: SKIP (0.000s)
[222.462949] [066/134] (800s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[222.563452] Starting subtest: fbc-rgb101010-draw-mmap-wc
[227.216254] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.656s)
[228.435543] [067/134] (794s left) gem_exec_balancer (full-pulse)
[228.496447] Starting subtest: full-pulse
[232.745395] Subtest full-pulse: SUCCESS (4.249s)
[233.112869] [068/134] (790s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[233.223939] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[233.226297] Starting dynamic subtest: pipe-A-default-mode
[233.537139] Dynamic subtest pipe-A-default-mode: SKIP (0.312s)
[233.541708] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.314s)
[234.349051] [069/134] (788s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[234.457435] Starting subtest: yf-tiled-32bpp-rotate-270
[234.461665] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[234.595665] [070/134] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[234.698497] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[234.702610] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[234.812351] [071/134] (788s left) gem_fence_thrash (bo-write-verify-threaded-none)
[234.847611] Starting subtest: bo-write-verify-threaded-none
[234.867659] Subtest bo-write-verify-threaded-none: SKIP (0.022s)
[234.931569] [072/134] (788s left) gem_ctx_persistence (engines-hang)
[234.998142] Starting subtest: engines-hang
[235.000452] Starting dynamic subtest: rcs0
[235.121334] Dynamic subtest rcs0: SUCCESS (0.122s)
[235.133460] Starting dynamic subtest: bcs0
[235.241574] Dynamic subtest bcs0: SUCCESS (0.119s)
[235.252155] Starting dynamic subtest: vcs0
[235.356269] Dynamic subtest vcs0: SUCCESS (0.113s)
[235.366485] Starting dynamic subtest: vcs1
[235.487758] Dynamic subtest vcs1: SUCCESS (0.129s)
[235.498793] Starting dynamic subtest: vecs0
[235.568548] Dynamic subtest vecs0: SUCCESS (0.079s)
[235.579663] Starting dynamic subtest: ccs0
[235.723126] Dynamic subtest ccs0: SUCCESS (0.153s)
[235.725067] Subtest engines-hang: SUCCESS (0.726s)
[235.825769] [073/134] (787s left) kms_plane_lowres (tiling-4)
[235.930988] Starting subtest: tiling-4
[235.932782] Starting dynamic subtest: pipe-A-eDP-1
[235.936452] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.233688] Starting dynamic subtest: pipe-B-eDP-1
[236.238079] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.246181] Starting dynamic subtest: pipe-C-eDP-1
[236.250646] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[236.258710] Starting dynamic subtest: pipe-D-eDP-1
[236.263187] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[236.267357] Subtest tiling-4: SKIP (0.301s)
[237.076523] [074/134] (786s left) gem_exercise_blt (fast-copy)
[237.152308] Starting subtest: fast-copy
[237.154192] Starting dynamic subtest: linear-smem-smem
[237.176893] Dynamic subtest linear-smem-smem: SUCCESS (0.026s)
[237.186563] Starting dynamic subtest: xmajor-smem-smem
[237.194156] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s)
[237.202816] Starting dynamic subtest: tile4-smem-smem
[237.210747] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[237.219609] Starting dynamic subtest: tile64-smem-smem
[237.228138] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[237.230369] Subtest fast-copy: SUCCESS (0.077s)
[237.383075] [075/134] (786s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[237.475051] Starting subtest: compare-crc-sanitycheck-xr24
[237.477470] Starting dynamic subtest: pipe-A-eDP-1
[238.107657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[238.119270] Starting dynamic subtest: pipe-B-eDP-1
[239.425696] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s)
[239.435171] Starting dynamic subtest: pipe-C-eDP-1
[240.647473] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.221s)
[240.657068] Starting dynamic subtest: pipe-D-eDP-1
[241.840679] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.191s)
[241.842919] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.366s)
[242.698388] [076/134] (780s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[242.763088] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[242.873568] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s)
[242.979744] [077/134] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[243.083205] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[243.087626] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[243.219022] [078/134] (780s left) gem_exec_reloc (basic-cpu)
[243.287197] Subtest basic-cpu: SKIP (0.000s)
[243.375148] [079/134] (780s left) syncobj_timeline (reset-unsignaled)
[243.426732] Starting subtest: reset-unsignaled
[243.429163] Subtest reset-unsignaled: SUCCESS (0.000s)
[243.568430] [080/134] (780s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[243.654067] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[243.656284] Starting dynamic subtest: pipe-A-eDP-1
[243.677949] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[243.688990] Starting dynamic subtest: pipe-B-eDP-1
[243.710099] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[243.719791] Starting dynamic subtest: pipe-C-eDP-1
[243.740280] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[243.748251] Starting dynamic subtest: pipe-D-eDP-1
[243.769574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[243.773871] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[245.996477] [081/134] (777s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[246.104352] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[253.524166] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.422s)
[253.708232] [082/134] (770s left) kms_psr (psr-cursor-plane-move)
[253.815033] Starting subtest: psr-cursor-plane-move
[253.817348] Starting dynamic subtest: eDP-1
[255.556510] Dynamic subtest eDP-1: SUCCESS (1.742s)
[255.558792] Subtest psr-cursor-plane-move: SUCCESS (1.743s)
[256.447347] [083/134] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[256.554532] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[256.559179] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[256.689523] [084/134] (767s left) gem_wait (write-wait)
[256.755234] Starting subtest: write-wait
[256.757537] Starting dynamic subtest: all-engines
[257.884211] Dynamic subtest all-engines: SUCCESS (1.128s)
[257.900649] Starting dynamic subtest: rcs0
[258.944636] Dynamic subtest rcs0: SUCCESS (1.059s)
[258.960904] Starting dynamic subtest: bcs0
[260.001859] Dynamic subtest bcs0: SUCCESS (1.055s)
[260.018068] Starting dynamic subtest: vcs0
[261.057172] Dynamic subtest vcs0: SUCCESS (1.053s)
[261.073355] Starting dynamic subtest: vcs1
[262.110497] Dynamic subtest vcs1: SUCCESS (1.051s)
[262.126836] Starting dynamic subtest: vecs0
[263.164165] Dynamic subtest vecs0: SUCCESS (1.051s)
[263.179970] Starting dynamic subtest: ccs0
[264.222333] Dynamic subtest ccs0: SUCCESS (1.056s)
[264.224993] Subtest write-wait: SUCCESS (7.468s)
[264.445194] [085/134] (759s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[264.567771] Starting subtest: cursorB-vs-flipA-varying-size
[264.572039] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[264.751438] [086/134] (759s left) perf (blocking-parameterized)
[264.903239] Starting subtest: blocking-parameterized
[284.925348] Subtest blocking-parameterized: SUCCESS (20.021s)
[284.972832] [087/134] (739s left) kms_chamelium_edid (hdmi-edid-read)
[285.388683] Subtest hdmi-edid-read: SKIP (0.000s)
[286.231272] [088/134] (737s left) prime_mmap (test_errors)
[286.294172] Starting subtest: test_errors
[286.296369] Starting dynamic subtest: test_errors-smem
[286.385478] Dynamic subtest test_errors-smem: SUCCESS (0.093s)
[286.387951] Subtest test_errors: SUCCESS (0.093s)
[286.527679] [089/134] (737s left) fbdev (pan)
[286.558229] Starting subtest: pan
[286.587413] Subtest pan: SUCCESS (0.030s)
[286.683278] [090/134] (737s left) kms_invalid_mode (zero-clock)
[286.775503] Starting subtest: zero-clock
[286.777810] Starting dynamic subtest: pipe-A-eDP-1
[287.061747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[287.071538] Starting dynamic subtest: pipe-B-eDP-1
[287.073579] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[287.081860] Starting dynamic subtest: pipe-C-eDP-1
[287.084258] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[287.092717] Starting dynamic subtest: pipe-D-eDP-1
[287.095072] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[287.097414] Subtest zero-clock: SUCCESS (0.291s)
[287.905621] [091/134] (736s left) kms_atomic_transition (plane-all-transition-nonblocking)
[288.008842] Starting subtest: plane-all-transition-nonblocking
[288.011184] Starting dynamic subtest: pipe-A-eDP-1
[290.501086] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[290.829063] Starting dynamic subtest: pipe-B-eDP-1
[294.030628] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.212s)
[294.339751] Subtest plane-all-transition-nonblocking: SUCCESS (6.332s)
[295.185941] [092/134] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[295.291391] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[295.295241] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[295.430142] [093/134] (728s left) gem_pxp (regular-baseline-src-copy-readible)
[295.552042] Starting subtest: regular-baseline-src-copy-readible
[295.632375] Subtest regular-baseline-src-copy-readible: SUCCESS (0.082s)
[295.806256] [094/134] (728s left) kms_plane_scaling (planes-downscale-factor-0-5)
[295.905728] Starting subtest: planes-downscale-factor-0-5
[295.908357] Starting dynamic subtest: pipe-A
[295.928593] Dynamic subtest pipe-A: SKIP (0.018s)
[295.937796] Starting dynamic subtest: pipe-B
[295.958316] Dynamic subtest pipe-B: SKIP (0.031s)
[295.967656] Starting dynamic subtest: pipe-C
[295.990973] Dynamic subtest pipe-C: SKIP (0.030s)
[295.999990] Starting dynamic subtest: pipe-D
[296.019551] Dynamic subtest pipe-D: SKIP (0.030s)
[296.023331] Subtest planes-downscale-factor-0-5: SKIP (0.111s)
[296.151022] [095/134] (728s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[296.257079] Starting subtest: fbc-pr-cursor-mmap-gtt
[296.260307] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[296.366525] [096/134] (728s left) kms_content_protection (legacy-hdcp14)
[296.509347] Starting subtest: legacy-hdcp14
[296.512938] Subtest legacy-hdcp14: SKIP (0.000s)
[296.650551] [097/134] (727s left) gem_caching (writes)
[296.711605] Subtest writes: SKIP (0.000s)
[296.799185] [098/134] (727s left) kms_cursor_crc (cursor-onscreen-128x42)
[297.019175] Starting subtest: cursor-onscreen-128x42
[297.070068] Subtest cursor-onscreen-128x42: SKIP (0.047s)
[297.326169] [099/134] (727s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[297.434071] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[301.975356] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.543s)
[303.182315] [100/134] (721s left) core_auth (getclient-master-drop)
[303.221641] Starting subtest: getclient-master-drop
[303.251441] Subtest getclient-master-drop: SUCCESS (0.030s)
[303.386093] [101/134] (721s left) gem_lmem_swapping (random)
[303.424691] Subtest random: SKIP (0.000s)
[303.470072] [102/134] (721s left) kms_psr (pr-cursor-blt)
[303.567890] Starting subtest: pr-cursor-blt
[303.572120] Subtest pr-cursor-blt: SKIP (0.000s)
[303.663680] [103/134] (720s left) kms_async_flips (alternate-sync-async-flip)
[303.755246] Starting subtest: alternate-sync-async-flip
[304.127462] Starting dynamic subtest: pipe-A-eDP-1
[306.940197] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.813s)
[307.333619] Starting dynamic subtest: pipe-B-eDP-1
[310.077067] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[310.454279] Starting dynamic subtest: pipe-C-eDP-1
[313.198507] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.753s)
[313.571907] Starting dynamic subtest: pipe-D-eDP-1
[316.329583] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[316.331530] Subtest alternate-sync-async-flip: SUCCESS (12.578s)
[317.514232] [104/134] (707s left) gem_exec_whisper (basic-contexts-all)
[317.579500] Starting subtest: basic-contexts-all
[328.820680] Subtest basic-contexts-all: SUCCESS (11.237s)
[329.027353] [105/134] (695s left) syncobj_wait (wait-any-interrupted)
[329.096960] Starting subtest: wait-any-interrupted
[329.197649] Subtest wait-any-interrupted: SUCCESS (0.101s)
[329.299905] [106/134] (695s left) kms_rotation_crc (bad-pixel-format)
[329.408054] Starting subtest: bad-pixel-format
[329.412506] Subtest bad-pixel-format: SKIP (0.001s)
[329.513225] [107/134] (695s left) kms_addfb_basic (too-wide)
[329.607039] Starting subtest: too-wide
[329.609434] Subtest too-wide: SUCCESS (0.000s)
[329.745178] [108/134] (695s left) gem_spin_batch (legacy-resubmit-new)
[329.800987] Starting subtest: legacy-resubmit-new
[329.803592] Starting dynamic subtest: default
[329.810618] Dynamic subtest default: SUCCESS (0.008s)
[329.820379] Starting dynamic subtest: render
[329.822663] Dynamic subtest render: SUCCESS (0.003s)
[329.831253] Starting dynamic subtest: bsd
[329.833142] Dynamic subtest bsd: SUCCESS (0.005s)
[329.841778] Starting dynamic subtest: bsd1
[329.843994] Dynamic subtest bsd1: SUCCESS (0.003s)
[329.852565] Starting dynamic subtest: bsd2
[329.854781] Dynamic subtest bsd2: SUCCESS (0.005s)
[329.863427] Starting dynamic subtest: blt
[329.865635] Dynamic subtest blt: SUCCESS (0.004s)
[329.874274] Starting dynamic subtest: vebox
[329.876543] Dynamic subtest vebox: SUCCESS (0.004s)
[329.878745] Subtest legacy-resubmit-new: SUCCESS (0.039s)
[330.963415] [109/134] (693s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[331.059598] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[331.061785] Starting dynamic subtest: pipe-A-default-mode
[331.348527] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[331.353056] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.287s)
[332.243925] [110/134] (692s left) gem_exec_balancer (parallel-keep-submit-fence)
[332.515779] Starting subtest: parallel-keep-submit-fence
[333.997587] Subtest parallel-keep-submit-fence: SUCCESS (1.482s)
[334.122936] [111/134] (690s left) perf (non-system-wide-paranoid)
[334.234603] Starting subtest: non-system-wide-paranoid
[334.259602] Subtest non-system-wide-paranoid: SUCCESS (0.025s)
[334.298118] [112/134] (690s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[334.420397] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[334.424787] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[334.590602] [113/134] (690s left) kms_busy (basic)
[334.696863] Starting subtest: basic
[334.699060] Starting dynamic subtest: flip
[335.291615] Dynamic subtest flip: SUCCESS (0.594s)
[335.301408] Starting dynamic subtest: modeset
[338.982343] Dynamic subtest modeset: SUCCESS (3.690s)
[338.984557] Subtest basic: SUCCESS (4.288s)
[339.807352] [114/134] (685s left) kms_plane (plane-panning-bottom-right-suspend)
[339.909772] Starting subtest: plane-panning-bottom-right-suspend
[339.911983] Starting dynamic subtest: pipe-A
[357.375951] Dynamic subtest pipe-A: SUCCESS (2.956s)
[357.387171] Starting dynamic subtest: pipe-B
[375.379146] Dynamic subtest pipe-B: SUCCESS (3.503s)
[375.381421] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.462s)
[376.197269] [115/134] (648s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[376.261743] Starting subtest: invalid-multi-wait-all-unsubmitted
[376.263718] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[376.386876] [116/134] (648s left) kms_big_fb (linear-64bpp-rotate-180)
[376.496801] Starting subtest: linear-64bpp-rotate-180
[378.044132] Subtest linear-64bpp-rotate-180: SUCCESS (1.545s)
[378.235386] [117/134] (647s left) perf (invalid-oa-metric-set-id)
[378.346255] Starting subtest: invalid-oa-metric-set-id
[378.353139] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[378.399779] [118/134] (646s left) gen7_exec_parse (batch-without-end)
[378.461892] Subtest batch-without-end: SKIP (0.000s)
[378.529986] [119/134] (646s left) perf_pmu (most-busy-idle-check-all)
[378.564224] Starting subtest: most-busy-idle-check-all
[378.565757] Starting dynamic subtest: rcs0
[379.267808] Dynamic subtest rcs0: FAIL (0.644s)
[379.279802] Starting dynamic subtest: bcs0
[379.929926] Dynamic subtest bcs0: SUCCESS (0.717s)
[379.941803] Starting dynamic subtest: vcs0
[381.914323] Dynamic subtest vcs0: SUCCESS (1.978s)
[381.927238] Starting dynamic subtest: vcs1
[383.899574] Dynamic subtest vcs1: SUCCESS (1.979s)
[383.913399] Starting dynamic subtest: vecs0
[385.881915] Dynamic subtest vecs0: SUCCESS (1.977s)
[385.894429] Starting dynamic subtest: ccs0
[387.867766] Dynamic subtest ccs0: SUCCESS (1.980s)
[387.870815] Subtest most-busy-idle-check-all: FAIL (9.290s)
[388.002171] [120/134] (637s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[388.101185] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[388.105780] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[389.238689] [121/134] (636s left) perf_pmu (all-busy-idle-check-all)
[389.276352] Starting subtest: all-busy-idle-check-all
[390.875195] Subtest all-busy-idle-check-all: SUCCESS (1.596s)
[390.994628] [122/134] (634s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[391.098357] Starting subtest: primary-x-tiled-reflect-x-0
[398.037029] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.934s)
[399.294601] [123/134] (626s left) syncobj_wait (multi-wait-submitted)
[399.357129] Starting subtest: multi-wait-submitted
[399.463053] Subtest multi-wait-submitted: SUCCESS (0.105s)
[399.569104] [124/134] (625s left) dmabuf_sync_file (export-before-signal)
[399.615560] Starting subtest: export-before-signal
[399.617477] Subtest export-before-signal: SUCCESS (0.001s)
[399.696623] [125/134] (625s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[399.794131] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[399.795933] Starting dynamic subtest: pipe-A-eDP-1
[401.939101] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.144s)
[401.948560] Starting dynamic subtest: pipe-B-eDP-1
[404.278444] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.337s)
[404.288390] Starting dynamic subtest: pipe-C-eDP-1
[406.310239] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.030s)
[406.320636] Starting dynamic subtest: pipe-D-eDP-1
[408.351557] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.038s)
[408.353867] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.554s)
[409.605949] [126/134] (616s left) kms_prop_blob (blob-prop-validate)
[409.686248] Starting subtest: blob-prop-validate
[409.688659] Subtest blob-prop-validate: SUCCESS (0.000s)
[409.822165] [127/134] (615s left) kms_vblank (query-busy-hang)
[409.911082] Starting subtest: query-busy-hang
[409.912952] Starting dynamic subtest: pipe-A-eDP-1
[436.713289] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.788s)
[436.729362] Starting dynamic subtest: pipe-D-eDP-1
[451.683071] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.960s)
[451.685397] Subtest query-busy-hang: SUCCESS (41.753s)
[452.586854] [128/134] (573s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[452.689412] Starting subtest: psr-2p-primscrn-cur-indfb-move
[452.693290] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[452.816241] [129/134] (572s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-wc)
[452.918924] Starting subtest: fbc-abgr161616f-draw-mmap-wc
[452.923367] Subtest fbc-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[453.055249] [130/134] (572s left) gem_exec_schedule (promotion)
[453.135681] Starting subtest: promotion
[453.137926] Starting dynamic subtest: rcs0
[453.249059] Dynamic subtest rcs0: SUCCESS (0.121s)
[453.261707] Starting dynamic subtest: vcs0
[453.342827] Dynamic subtest vcs0: SUCCESS (0.093s)
[453.354178] Starting dynamic subtest: vcs1
[453.422704] Dynamic subtest vcs1: SUCCESS (0.079s)
[453.435720] Starting dynamic subtest: vecs0
[453.502269] Dynamic subtest vecs0: SUCCESS (0.079s)
[453.513590] Starting dynamic subtest: ccs0
[453.584765] Dynamic subtest ccs0: SUCCESS (0.082s)
[453.586863] Subtest promotion: SUCCESS (0.457s)
[455.013395] [131/134] (570s left) gem_ctx_persistence (legacy-engines-queued)
[455.078729] Starting subtest: legacy-engines-queued
[455.081155] Starting dynamic subtest: render
[455.154956] Dynamic subtest render: SUCCESS (0.079s)
[455.167082] Starting dynamic subtest: bsd1
[456.891625] Dynamic subtest bsd1: SUCCESS (1.732s)
[456.904414] Starting dynamic subtest: bsd2
[458.873344] Dynamic subtest bsd2: SUCCESS (1.977s)
[458.886466] Starting dynamic subtest: blt
[458.963145] Dynamic subtest blt: SUCCESS (0.088s)
[458.974673] Starting dynamic subtest: vebox
[460.857375] Dynamic subtest vebox: SUCCESS (1.889s)
[460.860045] Subtest legacy-engines-queued: SUCCESS (5.780s)
[460.968317] [132/134] (564s left) gem_readwrite (new-obj)
[461.035087] Subtest new-obj: SKIP (0.000s)
[461.104924] [133/134] (564s left) gem_exec_reloc (basic-cpu-read-noreloc)
[461.166781] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[461.248142] [134/134] (564s left) gem_exec_schedule (preemptive-hang)
[461.430780] Starting subtest: preemptive-hang
[461.433435] Starting dynamic subtest: rcs0
[471.050030] Dynamic subtest rcs0: SUCCESS (9.614s)
[471.059924] Starting dynamic subtest: bcs0
[480.003192] Dynamic subtest bcs0: SUCCESS (8.959s)
[480.015637] Starting dynamic subtest: vcs0
[489.029271] Dynamic subtest vcs0: SUCCESS (9.025s)
[489.040983] Starting dynamic subtest: vcs1
[498.051727] Dynamic subtest vcs1: SUCCESS (9.026s)
[498.064538] Starting dynamic subtest: vecs0
[507.007763] Dynamic subtest vecs0: SUCCESS (8.956s)
[507.019558] Starting dynamic subtest: ccs0
[516.037455] Dynamic subtest ccs0: SUCCESS (9.027s)
[516.039948] Subtest preemptive-hang: SUCCESS (54.620s)
[516.321549] 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.