[58.514472] Initializing watchdogs
[58.514527]   /dev/watchdog0
[58.528857] [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]
[58.533494] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.535625] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.538978] [001/133] (960s left) kms_prop_blob (basic)
[58.607312] Starting subtest: basic
[58.609814] Subtest basic: SUCCESS (0.000s)
[58.715830] [002/133] (960s left) kms_frontbuffer_tracking (psr-slowdraw)
[58.826530] Starting subtest: psr-slowdraw
[84.263303] Subtest psr-slowdraw: SUCCESS (25.507s)
[84.397420] [003/133] (934s left) kms_vblank (query-forked-hang)
[84.488481] Starting subtest: query-forked-hang
[84.490897] Starting dynamic subtest: pipe-A-eDP-1
[110.679997] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.184s)
[110.693779] Starting dynamic subtest: pipe-D-eDP-1
[135.651245] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.968s)
[135.653628] Subtest query-forked-hang: SUCCESS (51.156s)
[136.462123] [004/133] (882s left) syncobj_timeline (invalid-query-zero-handles)
[136.519777] Starting subtest: invalid-query-zero-handles
[136.522095] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[136.601288] [005/133] (882s left) sriov_basic (enable-vfs-autoprobe-on)
[136.649201] Starting subtest: enable-vfs-autoprobe-on
[136.651301] Starting dynamic subtest: numvfs-1
[136.727069] Dynamic subtest numvfs-1: FAIL (0.016s)
[136.739057] Starting dynamic subtest: numvfs-2
[136.811971] Dynamic subtest numvfs-2: FAIL (0.006s)
[136.821606] Starting dynamic subtest: numvfs-3
[136.894327] Dynamic subtest numvfs-3: FAIL (0.004s)
[136.902556] Starting dynamic subtest: numvfs-4
[136.974470] Dynamic subtest numvfs-4: FAIL (0.003s)
[136.982581] Starting dynamic subtest: numvfs-5
[137.055053] Dynamic subtest numvfs-5: FAIL (0.003s)
[137.064137] Starting dynamic subtest: numvfs-6
[137.136446] Dynamic subtest numvfs-6: FAIL (0.004s)
[137.144678] Starting dynamic subtest: numvfs-7
[137.214647] Dynamic subtest numvfs-7: FAIL (0.003s)
[137.221895] Starting dynamic subtest: numvfs-random
[137.290870] Dynamic subtest numvfs-random: FAIL (0.004s)
[137.298604] Starting dynamic subtest: numvfs-all
[137.368182] Dynamic subtest numvfs-all: FAIL (0.503s)
[137.370118] Subtest enable-vfs-autoprobe-on: FAIL (0.549s)
[137.407188] [006/133] (881s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[137.519053] Starting subtest: fbcpsr-rgb101010-draw-render
[144.321770] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.807s)
[144.450990] [007/133] (874s left) gem_exec_suspend (basic-s3-devices)
[144.526961] Starting subtest: basic-S3-devices
[144.529280] Starting dynamic subtest: smem
[155.862040] Dynamic subtest smem: SUCCESS (11.332s)
[155.864648] Subtest basic-S3-devices: SUCCESS (11.333s)
[156.047948] [008/133] (863s left) prime_self_import (export-vs-gem_close-race)
[156.108873] Starting subtest: export-vs-gem_close-race
[161.213023] Subtest export-vs-gem_close-race: SUCCESS (5.091s)
[161.281220] [009/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[161.391188] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[161.395609] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[161.489774] [010/133] (857s left) gem_exec_whisper (basic-contexts-all)
[161.549093] Starting subtest: basic-contexts-all
[172.891792] Subtest basic-contexts-all: SUCCESS (11.339s)
[173.085244] [011/133] (846s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[173.192398] Starting subtest: psr-rgb565-draw-mmap-wc
[180.020978] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.831s)
[180.131674] [012/133] (839s left) gem_exec_reloc (basic-write-gtt-active)
[180.200100] Subtest basic-write-gtt-active: SKIP (0.000s)
[180.266171] [013/133] (839s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[180.523428] Starting subtest: parallel-dmabuf-import-out-fence
[181.694891] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.171s)
[181.791398] [014/133] (837s left) kms_chamelium_hpd (dp-hpd-storm)
[182.180058] Subtest dp-hpd-storm: SKIP (0.000s)
[182.982821] [015/133] (836s left) prime_mmap (test_forked)
[183.032573] Starting subtest: test_forked
[183.034700] Starting dynamic subtest: test_forked-smem
[183.069546] Dynamic subtest test_forked-smem: SUCCESS (0.038s)
[183.071973] Subtest test_forked: SUCCESS (0.039s)
[183.162351] [016/133] (836s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[183.263063] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[183.267454] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[183.329891] [017/133] (836s left) gem_userptr_blits (stress-purge)
[183.399944] Starting subtest: stress-purge
[188.803491] Subtest stress-purge: SUCCESS (5.404s)
[188.930624] [018/133] (830s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[189.071197] Starting subtest: modeset-transition-nonblocking-fencing
[189.073194] Starting dynamic subtest: 1x-outputs
[200.180869] Dynamic subtest 1x-outputs: SUCCESS (11.109s)
[200.183362] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.110s)
[201.041304] [019/133] (818s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[201.179302] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[208.146023] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.969s)
[208.254446] [020/133] (811s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[208.363632] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[209.432077] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.068s)
[209.555367] [021/133] (810s left) i915_pm_freq_api (freq-suspend)
[209.613046] Starting subtest: freq-suspend
[209.615045] Starting dynamic subtest: gt0
[226.346596] Dynamic subtest gt0: SUCCESS (1.235s)
[226.371921] Starting dynamic subtest: gt1
[242.334597] Dynamic subtest gt1: SUCCESS (1.210s)
[242.337060] Subtest freq-suspend: SUCCESS (2.449s)
[243.417350] [022/133] (777s left) perf (gen12-group-exclusive-stream-ctx-handle)
[243.574493] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[243.597012] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.024s)
[243.641983] [023/133] (777s left) gem_tiled_partial_pwrite_pread (reads)
[245.178494] Subtest reads: SKIP (0.000s)
[245.246274] [024/133] (775s left) kms_frontbuffer_tracking (psr-2p-rte)
[245.353306] Starting subtest: psr-2p-rte
[245.357359] Subtest psr-2p-rte: SKIP (0.000s)
[245.451131] [025/133] (775s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[245.555783] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[245.560139] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[245.652278] [026/133] (775s left) syncobj_wait (multi-wait-submitted-signaled)
[245.710373] Starting subtest: multi-wait-submitted-signaled
[245.712692] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[245.792467] [027/133] (775s left) gem_render_copy_redux (flink)
[245.850016] Starting subtest: flink
[246.647257] Subtest flink: SUCCESS (0.822s)
[246.781173] [028/133] (774s left) gem_ctx_persistence (legacy-engines-queued)
[246.835238] Starting subtest: legacy-engines-queued
[246.837229] Starting dynamic subtest: render
[246.903883] Dynamic subtest render: SUCCESS (0.070s)
[246.915166] Starting dynamic subtest: bsd1
[248.178827] Dynamic subtest bsd1: SUCCESS (1.302s)
[248.189965] Starting dynamic subtest: bsd2
[250.211189] Dynamic subtest bsd2: SUCCESS (2.018s)
[250.222561] Starting dynamic subtest: blt
[250.224863] Dynamic subtest blt: SUCCESS (0.063s)
[250.233480] Starting dynamic subtest: vebox
[252.144336] Dynamic subtest vebox: SUCCESS (1.949s)
[252.147186] Subtest legacy-engines-queued: SUCCESS (5.413s)
[252.223654] [029/133] (768s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[252.341406] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[252.386129] [030/133] (768s left) gem_exec_reloc (basic-concurrent0)
[252.440663] Subtest basic-concurrent0: SKIP (0.000s)
[252.507765] [031/133] (768s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[252.604778] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[252.608799] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[252.701627] [032/133] (768s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[252.804444] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[252.808837] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[252.901652] [033/133] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[252.988629] Starting subtest: psr-1p-primscrn-spr-indfb-move
[260.468832] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.544s)
[260.618809] [034/133] (760s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[260.740857] Starting subtest: flip-vs-cursor-toggle
[269.630505] Subtest flip-vs-cursor-toggle: SUCCESS (8.915s)
[270.425352] [035/133] (750s left) kms_psr (psr2-primary-mmap-cpu)
[270.533070] Starting subtest: psr2-primary-mmap-cpu
[270.535444] Starting dynamic subtest: eDP-1
[272.231628] Dynamic subtest eDP-1: SUCCESS (1.700s)
[272.233788] Subtest psr2-primary-mmap-cpu: SUCCESS (1.701s)
[273.095993] [036/133] (748s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[273.194717] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[273.197001] Starting dynamic subtest: pipe-A-eDP-1
[273.221950] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[273.233458] Starting dynamic subtest: pipe-B-eDP-1
[273.256825] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[273.265727] Starting dynamic subtest: pipe-C-eDP-1
[273.288672] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[273.297528] Starting dynamic subtest: pipe-D-eDP-1
[273.321054] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[273.325068] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[275.366556] [037/133] (746s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[275.468889] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[279.630179] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.161s)
[280.787954] [038/133] (740s left) kms_frontbuffer_tracking (fbc-suspend)
[280.887054] Starting subtest: fbc-suspend
[319.732154] Subtest fbc-suspend: SUCCESS (7.466s)
[320.904313] [039/133] (700s left) kms_addfb_basic (too-high)
[321.018547] Starting subtest: too-high
[321.020793] Subtest too-high: SUCCESS (0.001s)
[321.103956] [040/133] (700s left) kms_psr (psr-sprite-plane-move)
[321.190375] Starting subtest: psr-sprite-plane-move
[321.192470] Starting dynamic subtest: eDP-1
[322.922765] Dynamic subtest eDP-1: SUCCESS (1.773s)
[322.924974] Subtest psr-sprite-plane-move: SUCCESS (1.775s)
[323.709779] [041/133] (697s left) kms_psr (fbc-psr-no-drrs)
[323.811789] Starting subtest: fbc-psr-no-drrs
[323.814063] Starting dynamic subtest: eDP-1
[323.818388] Dynamic subtest eDP-1: SKIP (0.000s)
[323.822841] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[323.895216] [042/133] (697s left) kms_cursor_crc (cursor-tearing-position-change)
[324.009252] Starting subtest: cursor-tearing-position-change
[324.011401] Starting dynamic subtest: pipe-A-eDP-1
[324.568330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[324.578254] Starting dynamic subtest: pipe-D-eDP-1
[325.810694] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[325.812558] Subtest cursor-tearing-position-change: SUCCESS (1.831s)
[326.626824] [043/133] (695s left) api_intel_allocator (standalone)
[326.688115] Starting subtest: standalone
[326.701936] Subtest standalone: SUCCESS (0.017s)
[326.818375] [044/133] (694s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[326.919202] Starting subtest: fbc-tiling-linear
[330.595175] Subtest fbc-tiling-linear: SUCCESS (3.716s)
[331.780382] [045/133] (689s left) kms_prop_blob (invalid-set-prop)
[331.835701] Starting subtest: invalid-set-prop
[331.837995] Subtest invalid-set-prop: SUCCESS (0.000s)
[331.925981] [046/133] (689s left) kms_flip (2x-flip-vs-panning)
[332.028703] Starting subtest: 2x-flip-vs-panning
[332.039658] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[332.147714] [047/133] (689s left) kms_cursor_legacy (torture-move)
[332.273872] Starting subtest: torture-move
[332.276000] Starting dynamic subtest: pipe-A
[338.088237] Dynamic subtest pipe-A: SUCCESS (5.837s)
[338.105619] Starting dynamic subtest: pipe-B
[344.602259] Dynamic subtest pipe-B: SUCCESS (6.528s)
[344.614485] Starting dynamic subtest: pipe-C
[351.400373] Dynamic subtest pipe-C: SUCCESS (6.804s)
[351.416733] Starting dynamic subtest: pipe-D
[358.652621] Dynamic subtest pipe-D: SUCCESS (7.239s)
[358.667740] Starting dynamic subtest: all-pipes
[364.448970] Dynamic subtest all-pipes: SUCCESS (5.792s)
[364.451296] Subtest torture-move: SUCCESS (32.210s)
[364.609812] [048/133] (657s left) syncobj_basic (bad-destroy)
[364.674256] Starting subtest: bad-destroy
[364.676691] Subtest bad-destroy: SUCCESS (0.000s)
[364.779298] [049/133] (657s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[364.862891] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[364.865294] Starting dynamic subtest: pipe-A-eDP-1
[364.889155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[364.901189] Starting dynamic subtest: pipe-B-eDP-1
[364.923009] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[364.933823] Starting dynamic subtest: pipe-C-eDP-1
[364.954386] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[364.965039] Starting dynamic subtest: pipe-D-eDP-1
[364.986973] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[364.991412] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[367.096982] [050/133] (654s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[367.173286] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[367.178246] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[367.357600] [051/133] (654s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[367.453982] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[367.456372] Starting dynamic subtest: pipe-A
[367.473873] Dynamic subtest pipe-A: SKIP (0.016s)
[367.483839] Starting dynamic subtest: pipe-B
[367.503973] Dynamic subtest pipe-B: SKIP (0.029s)
[367.513689] Starting dynamic subtest: pipe-C
[367.531894] Dynamic subtest pipe-C: SKIP (0.029s)
[367.545159] Starting dynamic subtest: pipe-D
[367.562419] Dynamic subtest pipe-D: SKIP (0.029s)
[367.566733] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.106s)
[367.663511] [052/133] (654s left) kms_lease (atomic-implicit-crtc)
[367.754364] Starting subtest: atomic-implicit-crtc
[367.756633] Starting dynamic subtest: pipe-A-eDP-1
[367.767443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[367.777975] Starting dynamic subtest: pipe-B-eDP-1
[367.789555] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[367.801203] Starting dynamic subtest: pipe-C-eDP-1
[367.812078] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[367.821616] Starting dynamic subtest: pipe-D-eDP-1
[367.832752] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[367.835040] Subtest atomic-implicit-crtc: SUCCESS (0.038s)
[367.896204] [053/133] (654s left) gem_mmap_wc (read-write-distinct)
[367.955011] Subtest read-write-distinct: SKIP (0.000s)
[368.027671] [054/133] (654s left) gem_ctx_shared (q-independent)
[368.101055] Starting subtest: Q-independent
[368.103331] Starting dynamic subtest: rcs0
[368.168691] Dynamic subtest rcs0: SUCCESS (0.067s)
[368.182412] Starting dynamic subtest: vcs0
[368.211137] Dynamic subtest vcs0: SUCCESS (0.042s)
[368.220990] Starting dynamic subtest: vcs1
[368.252622] Dynamic subtest vcs1: SUCCESS (0.041s)
[368.262924] Starting dynamic subtest: vecs0
[368.288731] Dynamic subtest vecs0: SUCCESS (0.035s)
[368.298449] Starting dynamic subtest: ccs0
[368.332273] Dynamic subtest ccs0: SUCCESS (0.043s)
[368.334228] Subtest Q-independent: SUCCESS (0.232s)
[369.800011] [055/133] (652s left) syncobj_timeline (host-signal-ordered)
[369.862695] Starting subtest: host-signal-ordered
[369.864988] Subtest host-signal-ordered: SUCCESS (0.001s)
[369.970500] [056/133] (652s left) i915_drm_fdinfo (busy-idle)
[370.012269] Starting subtest: busy-idle
[370.014725] Starting dynamic subtest: rcs0
[370.040699] Dynamic subtest rcs0: SKIP (0.026s)
[370.053152] Starting dynamic subtest: bcs0
[370.058175] Dynamic subtest bcs0: SKIP (0.000s)
[370.070849] Starting dynamic subtest: vcs0
[370.075191] Dynamic subtest vcs0: SKIP (0.000s)
[370.085012] Starting dynamic subtest: vcs1
[370.089409] Dynamic subtest vcs1: SKIP (0.000s)
[370.098360] Starting dynamic subtest: vecs0
[370.102764] Dynamic subtest vecs0: SKIP (0.000s)
[370.111663] Starting dynamic subtest: ccs0
[370.116041] Dynamic subtest ccs0: SKIP (0.000s)
[370.120476] Subtest busy-idle: SKIP (0.032s)
[370.156223] [057/133] (652s left) syncobj_wait (invalid-reset-one-illegal-handle)
[370.210305] Starting subtest: invalid-reset-one-illegal-handle
[370.212181] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[370.307358] [058/133] (651s left) kms_flip (2x-flip-vs-modeset)
[370.412488] Starting subtest: 2x-flip-vs-modeset
[370.419922] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[370.545569] [059/133] (651s left) kms_psr (fbc-psr2-no-drrs)
[370.635736] Starting subtest: fbc-psr2-no-drrs
[370.637967] Starting dynamic subtest: eDP-1
[370.642230] Dynamic subtest eDP-1: SKIP (0.000s)
[370.646449] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[370.705687] [060/133] (651s left) kms_pm_dc (dc5-psr)
[371.814696] Starting subtest: dc5-psr
[374.692660] Subtest dc5-psr: SUCCESS (2.878s)
[375.529809] [061/133] (646s left) syncobj_wait (single-wait-for-submit-signaled)
[375.584678] Starting subtest: single-wait-for-submit-signaled
[375.586967] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[375.695401] [062/133] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[375.816244] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[375.820384] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[375.919521] [063/133] (646s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[376.021092] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[376.029349] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[376.133643] [064/133] (646s left) kms_content_protection (content-type-change)
[376.267766] Starting subtest: content-type-change
[376.272406] Subtest content-type-change: SKIP (0.000s)
[376.385941] [065/133] (646s left) api_intel_bb (misplaced-blitter)
[376.452611] Starting subtest: misplaced-blitter
[376.458932] Subtest misplaced-blitter: SUCCESS (0.007s)
[376.570693] [066/133] (646s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[376.671160] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[383.511566] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.843s)
[383.642923] [067/133] (638s left) gem_exec_fence (syncobj-repeat)
[384.090114] Starting subtest: syncobj-repeat
[384.281422] Subtest syncobj-repeat: SUCCESS (0.190s)
[385.792186] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[385.795976] [068/133] (636s left) prime_self_import (basic-with_two_bos)
[385.841660] Starting subtest: basic-with_two_bos
[385.863368] Subtest basic-with_two_bos: SUCCESS (0.023s)
[385.980880] [069/133] (636s left) gem_mmap_gtt (hang-user)
[386.034959] Subtest hang-user: SKIP (0.000s)
[386.103112] [070/133] (636s left) kms_psr (fbc-psr-suspend)
[386.209223] Starting subtest: fbc-psr-suspend
[386.211350] Starting dynamic subtest: eDP-1
[386.215189] Dynamic subtest eDP-1: SKIP (0.000s)
[386.219154] Subtest fbc-psr-suspend: SKIP (0.001s)
[386.280808] [071/133] (636s left) i915_pm_rps (thresholds-idle)
[386.349818] Starting subtest: thresholds-idle
[386.354328] Subtest thresholds-idle: SKIP (0.000s)
[386.451297] [072/133] (636s left) gem_exec_schedule (preempt)
[386.524709] Starting subtest: preempt
[386.526673] Starting dynamic subtest: rcs0
[386.538366] Dynamic subtest rcs0: SUCCESS (0.022s)
[386.548560] Starting dynamic subtest: bcs0
[386.556921] Dynamic subtest bcs0: SUCCESS (0.018s)
[386.570713] Starting dynamic subtest: vcs0
[386.576817] Dynamic subtest vcs0: SUCCESS (0.019s)
[386.586686] Starting dynamic subtest: vcs1
[386.602343] Dynamic subtest vcs1: SUCCESS (0.024s)
[386.615774] Starting dynamic subtest: vecs0
[386.628659] Dynamic subtest vecs0: SUCCESS (0.025s)
[386.638445] Starting dynamic subtest: ccs0
[386.650519] Dynamic subtest ccs0: SUCCESS (0.021s)
[386.652866] Subtest preempt: SUCCESS (0.135s)
[387.768881] [073/133] (635s left) kms_big_fb (linear-64bpp-rotate-180)
[387.886793] Starting subtest: linear-64bpp-rotate-180
[389.442407] Subtest linear-64bpp-rotate-180: SUCCESS (1.556s)
[389.619951] [074/133] (633s left) device_reset (unbind-cold-reset-rebind)
[389.672535] Starting subtest: unbind-cold-reset-rebind
[389.677128] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[389.757016] [075/133] (633s left) kms_plane_multiple (tiling-x)
[389.850410] Starting subtest: tiling-x
[389.852330] Starting dynamic subtest: pipe-A-eDP-1
[393.507154] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.656s)
[393.517989] Starting dynamic subtest: pipe-B-eDP-1
[397.947670] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.441s)
[397.957811] Starting dynamic subtest: pipe-C-eDP-1
[402.292234] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.342s)
[402.308542] Starting dynamic subtest: pipe-D-eDP-1
[406.656371] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.364s)
[406.658714] Subtest tiling-x: SUCCESS (16.810s)
[407.458101] [076/133] (615s left) gem_exec_params (rel-constants-invalid-ring)
[407.518096] Starting subtest: rel-constants-invalid-ring
[407.520344] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[407.619983] [077/133] (615s left) syncobj_timeline (multi-wait-for-submit-signaled)
[407.679099] Starting subtest: multi-wait-for-submit-signaled
[407.681304] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[407.772323] [078/133] (615s left) kms_flip (2x-flip-vs-suspend-interruptible)
[407.860859] Starting subtest: 2x-flip-vs-suspend-interruptible
[407.872035] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[407.955556] [079/133] (615s left) syncobj_wait (wait-for-submit-delayed-submit)
[408.017555] Starting subtest: wait-for-submit-delayed-submit
[408.119573] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[408.196883] [080/133] (614s left) kms_dsc (dsc-with-bpc-formats)
[408.303919] Starting subtest: dsc-with-bpc-formats
[408.417819] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[408.460849] [081/133] (614s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[408.559812] Starting subtest: disable-crc-after-crtc
[408.562115] Starting dynamic subtest: pipe-A-eDP-1
[410.200514] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.641s)
[410.210650] Starting dynamic subtest: pipe-B-eDP-1
[412.466655] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.264s)
[412.477479] Starting dynamic subtest: pipe-C-eDP-1
[414.735025] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.268s)
[414.746079] Starting dynamic subtest: pipe-D-eDP-1
[417.003633] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.265s)
[417.005994] Subtest disable-crc-after-crtc: SUCCESS (8.445s)
[417.827015] [082/133] (605s left) syncobj_timeline (wait-any-complex)
[417.893616] Starting subtest: wait-any-complex
[417.954009] Subtest wait-any-complex: SUCCESS (0.062s)
[418.032000] [083/133] (605s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[418.140246] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[418.142456] Starting dynamic subtest: pipe-A-eDP-1
[418.240025] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[418.252751] Starting dynamic subtest: pipe-B-eDP-1
[419.402101] Dynamic subtest pipe-B-eDP-1: SKIP (1.160s)
[419.406398] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.266s)
[420.600870] [084/133] (602s left) gem_exec_reloc (basic-cpu-read-active)
[420.662822] Subtest basic-cpu-read-active: SKIP (0.000s)
[420.727106] [085/133] (602s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[420.816263] Starting subtest: fbc-rgb565-draw-mmap-cpu
[424.799218] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.984s)
[425.986235] [086/133] (597s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[426.104164] Starting subtest: short-flip-before-cursor-toggle
[427.020115] Subtest short-flip-before-cursor-toggle: SUCCESS (0.915s)
[427.819541] [087/133] (595s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[427.918972] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[427.923700] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[429.059605] [088/133] (594s left) gem_ctx_persistence (engines-persistence)
[429.115846] Starting subtest: engines-persistence
[429.118136] Starting dynamic subtest: rcs0
[429.927535] Dynamic subtest rcs0: SUCCESS (0.811s)
[429.940184] Starting dynamic subtest: bcs0
[430.670398] Dynamic subtest bcs0: SUCCESS (0.740s)
[430.681417] Starting dynamic subtest: vcs0
[431.465236] Dynamic subtest vcs0: SUCCESS (0.793s)
[431.477484] Starting dynamic subtest: vcs1
[432.253391] Dynamic subtest vcs1: SUCCESS (0.786s)
[432.265598] Starting dynamic subtest: vecs0
[432.994920] Dynamic subtest vecs0: SUCCESS (0.739s)
[433.008788] Starting dynamic subtest: ccs0
[433.764367] Dynamic subtest ccs0: SUCCESS (0.767s)
[433.766957] Subtest engines-persistence: SUCCESS (4.649s)
[433.851237] [089/133] (589s left) gem_exec_balancer (bonded-chain)
[433.915306] Starting subtest: bonded-chain
[440.933539] Subtest bonded-chain: SUCCESS (7.015s)
[441.264680] [090/133] (582s left) syncobj_timeline (32bits-limit)
[441.326998] Starting subtest: 32bits-limit
[441.329274] Subtest 32bits-limit: SUCCESS (0.001s)
[441.439942] [091/133] (582s left) gem_lmem_swapping (basic)
[441.479788] Subtest basic: SKIP (0.000s)
[441.516041] [092/133] (582s left) sw_sync (sync_busy_fork_unixsocket)
[441.552823] Starting subtest: sync_busy_fork_unixsocket
[441.557233] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[441.610888] [093/133] (582s left) perf_pmu (most-busy-idle-check-all)
[441.654968] Starting subtest: most-busy-idle-check-all
[441.657006] Starting dynamic subtest: rcs0
[443.690049] Dynamic subtest rcs0: SUCCESS (2.034s)
[443.703129] Starting dynamic subtest: bcs0
[445.672804] Dynamic subtest bcs0: SUCCESS (1.980s)
[445.685915] Starting dynamic subtest: vcs0
[447.658411] Dynamic subtest vcs0: SUCCESS (1.982s)
[447.672004] Starting dynamic subtest: vcs1
[449.705967] Dynamic subtest vcs1: SUCCESS (2.044s)
[449.718864] Starting dynamic subtest: vecs0
[451.690245] Dynamic subtest vecs0: SUCCESS (1.981s)
[451.703697] Starting dynamic subtest: ccs0
[453.674650] Dynamic subtest ccs0: SUCCESS (1.981s)
[453.677604] Subtest most-busy-idle-check-all: SUCCESS (12.021s)
[453.793168] [094/133] (569s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[453.894325] Starting subtest: x-tiled-8bpp-rotate-270
[453.915119] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[454.031202] [095/133] (569s left) kms_cursor_crc (cursor-random-128x42)
[454.245517] Starting subtest: cursor-random-128x42
[454.290652] Subtest cursor-random-128x42: SKIP (0.041s)
[454.481904] [096/133] (569s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[454.572086] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[454.576685] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[455.688645] [097/133] (568s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[456.094838] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[456.894059] [098/133] (567s left) dumb_buffer (map-valid)
[456.962256] Starting subtest: map-valid
[456.964939] Subtest map-valid: SUCCESS (0.000s)
[457.071410] [099/133] (566s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[457.176035] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[457.188683] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[457.264916] [100/133] (566s left) gem_exec_schedule (u-semaphore-user)
[457.341127] Starting subtest: u-semaphore-user
[457.389502] Subtest u-semaphore-user: SUCCESS (0.057s)
[458.707994] [101/133] (565s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[458.764253] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[458.870040] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[458.950987] [102/133] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[459.049212] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[462.640094] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.594s)
[463.850192] [103/133] (560s left) gem_exec_flush (basic-uc-pro-default)
[463.914589] Starting subtest: basic-uc-pro-default
[469.399905] Subtest basic-uc-pro-default: SUCCESS (5.457s)
[469.556403] [104/133] (554s left) kms_color (invalid-gamma-lut-sizes)
[469.655495] Starting subtest: invalid-gamma-lut-sizes
[469.657788] Starting dynamic subtest: pipe-A
[469.950819] Dynamic subtest pipe-A: SUCCESS (0.295s)
[469.960650] Starting dynamic subtest: pipe-B
[469.962995] Dynamic subtest pipe-B: SUCCESS (0.000s)
[469.972647] Starting dynamic subtest: pipe-C
[469.975054] Dynamic subtest pipe-C: SUCCESS (0.000s)
[469.986214] Starting dynamic subtest: pipe-D
[469.988128] Dynamic subtest pipe-D: SUCCESS (0.000s)
[469.990028] Subtest invalid-gamma-lut-sizes: SUCCESS (0.298s)
[470.758190] [105/133] (553s left) kms_plane (plane-position-covered)
[470.843613] Starting subtest: plane-position-covered
[471.361958] Starting dynamic subtest: pipe-A-plane-1
[472.625839] Dynamic subtest pipe-A-plane-1: SUCCESS (1.266s)
[472.637231] Starting dynamic subtest: pipe-A-plane-2
[473.868061] Dynamic subtest pipe-A-plane-2: SUCCESS (1.241s)
[473.880336] Starting dynamic subtest: pipe-A-plane-3
[475.102378] Dynamic subtest pipe-A-plane-3: SUCCESS (1.235s)
[475.115244] Starting dynamic subtest: pipe-A-plane-4
[476.338042] Dynamic subtest pipe-A-plane-4: SUCCESS (1.233s)
[476.348393] Starting dynamic subtest: pipe-A-plane-5
[476.363813] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[477.519371] Starting dynamic subtest: pipe-B-plane-1
[478.811102] Dynamic subtest pipe-B-plane-1: SUCCESS (1.302s)
[478.821854] Starting dynamic subtest: pipe-B-plane-2
[480.101059] Dynamic subtest pipe-B-plane-2: SUCCESS (1.287s)
[480.111454] Starting dynamic subtest: pipe-B-plane-3
[481.412289] Dynamic subtest pipe-B-plane-3: SUCCESS (1.311s)
[481.422271] Starting dynamic subtest: pipe-B-plane-4
[482.737785] Dynamic subtest pipe-B-plane-4: SUCCESS (1.325s)
[482.748148] Starting dynamic subtest: pipe-B-plane-5
[482.763830] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[482.766132] Subtest plane-position-covered: SUCCESS (11.922s)
[483.611057] [106/133] (540s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[483.723379] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[483.746951] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.023s)
[483.835479] [107/133] (540s left) gem_eio (in-flight-contexts-10ms)
[484.044316] Starting subtest: in-flight-contexts-10ms
[497.667221] Subtest in-flight-contexts-10ms: SUCCESS (13.623s)
[497.827162] [108/133] (526s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[497.903901] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[497.908614] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[498.085748] [109/133] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[498.186678] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[498.191300] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[498.294955] [110/133] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[498.390831] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[498.394746] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[498.494361] [111/133] (525s left) gem_mmap_offset (ptrace)
[498.548652] Starting subtest: ptrace
[498.550651] Starting dynamic subtest: smem0-wb
[498.562862] Dynamic subtest smem0-wb: SUCCESS (0.018s)
[498.573917] Starting dynamic subtest: smem0-wc
[498.584421] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[498.594655] Starting dynamic subtest: smem0-uc
[498.603009] Dynamic subtest smem0-uc: SUCCESS (0.018s)
[498.605252] Subtest ptrace: SUCCESS (0.062s)
[498.701949] [112/133] (525s left) kms_hdr (static-toggle-dpms)
[498.808798] Starting subtest: static-toggle-dpms
[498.815763] Subtest static-toggle-dpms: SKIP (0.001s)
[498.893540] [113/133] (525s left) gem_gtt_cpu_tlb
[499.017555] [114/133] (525s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[499.110129] Starting subtest: 4-tiled-8bpp-rotate-180
[500.346303] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.236s)
[500.479045] [115/133] (524s left) gem_userptr_blits (map-fixed-invalidate-busy)
[500.582466] Starting subtest: map-fixed-invalidate-busy
[500.586127] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[500.699566] [116/133] (523s left) syncobj_timeline (wait-for-submit-snapshot)
[500.770738] Starting subtest: wait-for-submit-snapshot
[500.853608] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[500.927681] [117/133] (523s left) gem_eio (wait-10ms)
[501.169370] Starting subtest: wait-10ms
[501.522538] Subtest wait-10ms: SUCCESS (0.355s)
[501.647465] [118/133] (523s left) gem_ctx_engines (independent)
[501.709975] Starting subtest: independent
[501.712333] Starting dynamic subtest: rcs0
[501.861160] Dynamic subtest rcs0: SUCCESS (0.149s)
[501.871777] Starting dynamic subtest: bcs0
[502.025081] Dynamic subtest bcs0: SUCCESS (0.162s)
[502.035929] Starting dynamic subtest: vcs0
[502.201595] Dynamic subtest vcs0: SUCCESS (0.177s)
[502.212104] Starting dynamic subtest: vcs1
[502.351902] Dynamic subtest vcs1: SUCCESS (0.148s)
[502.362372] Starting dynamic subtest: vecs0
[502.526689] Dynamic subtest vecs0: SUCCESS (0.174s)
[502.537942] Starting dynamic subtest: ccs0
[502.677786] Dynamic subtest ccs0: SUCCESS (0.151s)
[502.690648] Starting dynamic subtest: all-engines
[503.350210] Dynamic subtest all-engines: SUCCESS (0.670s)
[503.352694] Subtest independent: SUCCESS (1.642s)
[503.833574] [119/133] (520s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[503.931068] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[503.935159] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[504.031146] [120/133] (520s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[504.131851] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[508.610266] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.483s)
[509.721908] [121/133] (515s left) gem_softpin (evict-snoop)
[509.787062] Starting subtest: evict-snoop
[509.791880] Subtest evict-snoop: SKIP (0.000s)
[509.889597] [122/133] (515s left) intel_hwmon (hwmon-write)
[509.943437] Subtest hwmon-write: SKIP (0.000s)
[510.003600] [123/133] (514s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[510.072073] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[510.132749] [124/133] (514s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[510.231857] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[510.235918] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[510.316605] [125/133] (514s left) i915_pm_rps (fence-order)
[510.371951] Starting subtest: fence-order
[513.267735] Subtest fence-order: SUCCESS (2.895s)
[513.391745] [126/133] (511s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[513.490757] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[513.493043] Starting dynamic subtest: pipe-A-eDP-1
[513.502134] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[513.513515] Starting dynamic subtest: pipe-B-eDP-1
[513.522420] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[513.533134] Starting dynamic subtest: pipe-C-eDP-1
[513.541320] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[513.551018] Starting dynamic subtest: pipe-D-eDP-1
[513.559289] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[513.563410] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[515.778431] [127/133] (509s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[515.832645] Starting subtest: multi-wait-all-for-submit-signaled
[515.834753] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[515.949928] [128/133] (509s left) gen9_exec_parse (bb-start-param)
[516.006990] Subtest bb-start-param: SKIP (0.000s)
[516.065719] [129/133] (509s left) gem_userptr_blits (readonly-unsync)
[516.128846] Subtest readonly-unsync: SKIP (0.000s)
[516.246121] [130/133] (509s left) kms_busy (extended-pageflip-hang-newfb)
[516.344818] Starting subtest: extended-pageflip-hang-newfb
[516.346702] Starting dynamic subtest: pipe-A
[542.471741] Dynamic subtest pipe-A: SUCCESS (26.131s)
[542.485031] Starting dynamic subtest: pipe-D
[567.483421] Dynamic subtest pipe-D: SUCCESS (24.999s)
[567.485833] Subtest extended-pageflip-hang-newfb: SUCCESS (51.139s)
[568.335183] [131/133] (456s left) kms_cursor_crc (cursor-offscreen-256x256)
[568.578571] Starting subtest: cursor-offscreen-256x256
[568.583839] Starting dynamic subtest: pipe-A-eDP-1
[570.501253] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.919s)
[570.533125] Starting dynamic subtest: pipe-D-eDP-1
[573.146187] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[573.148176] Subtest cursor-offscreen-256x256: SUCCESS (4.564s)
[574.003787] [132/133] (451s left) gem_spin_batch (legacy-resubmit)
[574.061996] Starting subtest: legacy-resubmit
[574.064499] Starting dynamic subtest: default
[574.069995] Dynamic subtest default: SUCCESS (0.005s)
[574.081519] Starting dynamic subtest: render
[574.084071] Dynamic subtest render: SUCCESS (0.001s)
[574.094087] Starting dynamic subtest: bsd
[574.096032] Dynamic subtest bsd: SUCCESS (0.003s)
[574.105520] Starting dynamic subtest: bsd1
[574.107414] Dynamic subtest bsd1: SUCCESS (0.002s)
[574.116654] Starting dynamic subtest: bsd2
[574.118509] Dynamic subtest bsd2: SUCCESS (0.001s)
[574.127823] Starting dynamic subtest: blt
[574.129684] Dynamic subtest blt: SUCCESS (0.004s)
[574.139066] Starting dynamic subtest: vebox
[574.140944] Dynamic subtest vebox: SUCCESS (0.002s)
[574.142846] Subtest legacy-resubmit: SUCCESS (0.024s)
[574.330202] [133/133] (451s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[574.422930] Starting subtest: psr2-cursor-plane-update-sf
[574.425287] Starting dynamic subtest: pipe-A-eDP-1
[574.983251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[574.994898] Starting dynamic subtest: pipe-B-eDP-1
[576.288757] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.304s)
[576.291205] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.873s)
[577.177880] Closing watchdogs
results: parsing output: 0/ for test: kms_prop_blob
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: sriov_basic
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_suspend
results: parsing output: 7/ for test: prime_self_import
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: prime_mmap
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: kms_atomic_transition
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: i915_pm_freq_api
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: gem_render_copy_redux
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: kms_tiled_display
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: api_intel_allocator
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_prop_blob
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gem_mmap_wc
results: parsing output: 53/ for test: gem_ctx_shared
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: i915_drm_fdinfo
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_pm_dc
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: api_intel_bb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: prime_self_import
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: i915_pm_rps
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: device_reset
results: parsing output: 74/ for test: kms_plane_multiple
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_dsc
results: parsing output: 80/ for test: kms_pipe_crc_basic
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: gem_exec_balancer
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: sw_sync
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_chamelium_frames
results: parsing output: 97/ for test: dumb_buffer
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: kms_hdr
results: parsing output: 112/ for test: gem_gtt_cpu_tlb
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: gem_ctx_engines
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: intel_hwmon
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: kms_busy
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: gem_spin_batch
results: parsing output: 132/ for test: kms_psr2_sf
Done.