[55.673111] Initializing watchdogs
[55.673160]   /dev/watchdog0
[55.686781] [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]
[55.691718] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.693978] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.697579] [001/131] (960s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[55.783122] Starting subtest: single-wait-all-for-submit-available-signaled
[55.785569] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[55.891823] [002/131] (960s left) kms_psr (psr-cursor-plane-move)
[55.988862] Starting subtest: psr-cursor-plane-move
[55.991155] Starting dynamic subtest: eDP-1
[57.654149] Dynamic subtest eDP-1: SUCCESS (1.664s)
[57.656436] Subtest psr-cursor-plane-move: SUCCESS (1.664s)
[58.540479] [003/131] (957s left) kms_plane_cursor (primary)
[58.633240] Starting subtest: primary
[58.637685] Starting dynamic subtest: pipe-A-eDP-1-size-64
[61.275618] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.641s)
[61.298679] Starting dynamic subtest: pipe-A-eDP-1-size-128
[63.964703] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.671s)
[63.989770] Starting dynamic subtest: pipe-A-eDP-1-size-256
[66.657710] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.671s)
[66.972812] Starting dynamic subtest: pipe-B-eDP-1-size-64
[70.315169] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.352s)
[70.337263] Starting dynamic subtest: pipe-B-eDP-1-size-128
[73.082952] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.749s)
[73.106079] Starting dynamic subtest: pipe-B-eDP-1-size-256
[75.731708] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.627s)
[76.044691] Starting dynamic subtest: pipe-C-eDP-1-size-64
[79.030065] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.994s)
[79.056609] Starting dynamic subtest: pipe-C-eDP-1-size-128
[81.286385] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[81.309610] Starting dynamic subtest: pipe-C-eDP-1-size-256
[83.453722] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.146s)
[83.769302] Starting dynamic subtest: pipe-D-eDP-1-size-64
[86.738613] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.979s)
[86.761765] Starting dynamic subtest: pipe-D-eDP-1-size-128
[89.004139] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.247s)
[89.029329] Starting dynamic subtest: pipe-D-eDP-1-size-256
[91.259836] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.235s)
[91.565427] Subtest primary: SUCCESS (32.926s)
[92.376431] [004/131] (923s left) kms_atomic_transition (plane-all-transition-fencing)
[92.487152] Starting subtest: plane-all-transition-fencing
[92.489483] Starting dynamic subtest: pipe-A-eDP-1
[94.988504] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[95.310189] Starting dynamic subtest: pipe-B-eDP-1
[98.504088] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.208s)
[98.803341] Subtest plane-all-transition-fencing: SUCCESS (6.314s)
[99.633496] [005/131] (916s left) gem_exec_async (concurrent-writes)
[99.702168] Starting subtest: concurrent-writes
[99.704584] Starting dynamic subtest: rcs0
[99.716497] Dynamic subtest rcs0: SUCCESS (0.014s)
[99.727240] Starting dynamic subtest: bcs0
[99.729246] Dynamic subtest bcs0: SUCCESS (0.006s)
[99.736304] Starting dynamic subtest: vcs0
[99.738540] Dynamic subtest vcs0: SUCCESS (0.006s)
[99.745445] Starting dynamic subtest: vcs1
[99.747812] Dynamic subtest vcs1: SUCCESS (0.006s)
[99.754624] Starting dynamic subtest: vecs0
[99.756875] Dynamic subtest vecs0: SUCCESS (0.006s)
[99.763685] Starting dynamic subtest: ccs0
[99.765922] Dynamic subtest ccs0: SUCCESS (0.005s)
[99.768224] Subtest concurrent-writes: SUCCESS (0.045s)
[100.002538] [006/131] (916s left) gen9_exec_parse (bb-large)
[100.072977] Subtest bb-large: SKIP (0.000s)
[100.146879] [007/131] (916s left) perf_pmu (busy-accuracy-50)
[100.186875] Starting subtest: busy-accuracy-50
[100.189100] Starting dynamic subtest: rcs0
[101.721086] Dynamic subtest rcs0: SUCCESS (1.533s)
[101.727969] Starting dynamic subtest: bcs0
[103.262457] Dynamic subtest bcs0: SUCCESS (1.541s)
[103.269704] Starting dynamic subtest: vcs0
[104.803687] Dynamic subtest vcs0: SUCCESS (1.539s)
[104.811784] Starting dynamic subtest: vcs1
[106.343895] Dynamic subtest vcs1: SUCCESS (1.539s)
[106.351457] Starting dynamic subtest: vecs0
[107.883928] Dynamic subtest vecs0: SUCCESS (1.538s)
[107.892315] Starting dynamic subtest: ccs0
[109.430389] Dynamic subtest ccs0: SUCCESS (1.544s)
[109.432783] Subtest busy-accuracy-50: SUCCESS (9.243s)
[109.556099] [008/131] (906s left) gem_ctx_param (basic-default)
[109.613434] Starting subtest: basic-default
[109.616033] Subtest basic-default: SUCCESS (0.000s)
[109.697638] [009/131] (906s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[109.797913] Starting subtest: bad-aux-stride-yf-tiled-ccs
[109.800180] Starting dynamic subtest: pipe-A-eDP-1
[109.822361] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[109.831143] Starting dynamic subtest: pipe-B-eDP-1
[109.852262] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[109.859233] Starting dynamic subtest: pipe-C-eDP-1
[109.880472] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[109.887658] Starting dynamic subtest: pipe-D-eDP-1
[109.910108] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[109.914241] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[112.019350] [010/131] (904s left) gem_mmap_wc (pf-nonblock)
[112.081510] Subtest pf-nonblock: SKIP (0.000s)
[112.141732] [011/131] (904s left) kms_vblank (wait-forked)
[112.241242] Starting subtest: wait-forked
[112.243462] Starting dynamic subtest: pipe-A-eDP-1
[114.049237] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[114.062650] Starting dynamic subtest: pipe-D-eDP-1
[116.497824] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.446s)
[116.500259] Subtest wait-forked: SUCCESS (4.257s)
[117.385272] [012/131] (899s left) gem_exec_schedule (semaphore-resolve)
[117.465513] Starting subtest: semaphore-resolve
[117.502766] Subtest semaphore-resolve: SUCCESS (0.049s)
[117.871185] [013/131] (898s left) kms_prop_blob (blob-multiple)
[117.934767] Starting subtest: blob-multiple
[117.937072] Subtest blob-multiple: SUCCESS (0.002s)
[118.046064] [014/131] (898s left) gem_ctx_persistence (hang)
[118.108591] Starting subtest: hang
[118.113279] Subtest hang: SKIP (0.000s)
[118.217418] [015/131] (898s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[118.321258] Starting subtest: random-ccs-data-yf-tiled-ccs
[118.323475] Starting dynamic subtest: pipe-A-eDP-1
[118.347444] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[118.355143] Starting dynamic subtest: pipe-B-eDP-1
[118.377965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[118.385102] Starting dynamic subtest: pipe-C-eDP-1
[118.407837] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[118.414898] Starting dynamic subtest: pipe-D-eDP-1
[118.439972] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[118.444210] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[120.484113] [016/131] (896s left) gem_softpin (overlap)
[120.550044] Starting subtest: overlap
[121.391942] Subtest overlap: SUCCESS (0.841s)
[121.550261] [017/131] (895s left) api_intel_bb (lot-of-buffers)
[121.592397] Starting subtest: lot-of-buffers
[122.602085] Subtest lot-of-buffers: SUCCESS (1.011s)
[123.009182] [018/131] (893s left) kms_flip (flip-vs-rmfb-interruptible)
[123.095977] Starting subtest: flip-vs-rmfb-interruptible
[123.098345] Starting dynamic subtest: A-eDP1
[131.763085] Dynamic subtest A-eDP1: SUCCESS (8.666s)
[131.770391] Starting dynamic subtest: B-eDP1
[140.393390] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[140.400896] Starting dynamic subtest: C-eDP1
[149.012287] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[149.023064] Starting dynamic subtest: D-eDP1
[157.649244] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[157.653834] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.555s)
[158.843238] [019/131] (858s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[158.949532] Starting subtest: flip-vs-cursor-crc-atomic
[159.598791] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.647s)
[160.468622] [020/131] (856s left) prime_mmap (test_correct)
[160.521707] Starting subtest: test_correct
[160.524164] Starting dynamic subtest: test_correct-smem
[160.554956] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[160.557439] Subtest test_correct: SUCCESS (0.034s)
[160.702210] [021/131] (856s left) kms_lease (possible-crtcs-filtering)
[160.801153] Starting subtest: possible-crtcs-filtering
[160.806033] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[160.942855] [022/131] (856s left) gem_tiled_fence_blits (normal)
[161.005660] Subtest normal: SKIP (0.000s)
[161.093304] [023/131] (855s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[161.153233] Starting subtest: multi-wait-available-submitted-signaled
[161.155699] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[161.256324] [024/131] (855s left) kms_async_flips (async-flip-hang)
[161.347087] Starting subtest: async-flip-hang
[161.722914] Starting dynamic subtest: pipe-A-eDP-1
[177.394911] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.672s)
[177.777078] Starting dynamic subtest: pipe-B-eDP-1
[193.390599] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.618s)
[193.755630] Starting dynamic subtest: pipe-C-eDP-1
[209.390334] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.641s)
[209.764936] Starting dynamic subtest: pipe-D-eDP-1
[225.385238] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.624s)
[225.387661] Subtest async-flip-hang: SUCCESS (64.037s)
[226.589160] [025/131] (790s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[226.691706] Starting subtest: fbc-rgb101010-draw-blt
[231.315251] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.627s)
[232.518250] [026/131] (784s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[232.621253] Starting subtest: x-tiled-16bpp-rotate-90
[232.642101] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[232.800540] [027/131] (784s left) kms_psr (fbc-psr2-no-drrs)
[232.898056] Starting subtest: fbc-psr2-no-drrs
[232.900396] Starting dynamic subtest: eDP-1
[232.904751] Dynamic subtest eDP-1: SKIP (0.000s)
[232.909141] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[232.981381] [028/131] (784s left) gem_exec_reloc (basic-softpin)
[233.043982] Subtest basic-softpin: SKIP (0.000s)
[233.133705] [029/131] (784s left) kms_psr (fbc-psr-cursor-render)
[233.227136] Starting subtest: fbc-psr-cursor-render
[233.229437] Starting dynamic subtest: eDP-1
[233.233800] Dynamic subtest eDP-1: SKIP (0.000s)
[233.238253] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[233.320668] [030/131] (783s left) kms_pm_backlight (fade-with-suspend)
[233.413665] Starting subtest: fade-with-suspend
[249.962083] Starting dynamic subtest: eDP-1
[252.633532] Dynamic subtest eDP-1: SUCCESS (2.667s)
[252.635959] Subtest fade-with-suspend: SUCCESS (4.188s)
[253.496404] [031/131] (763s left) kms_color (invalid-degamma-lut-sizes)
[253.607251] Starting subtest: invalid-degamma-lut-sizes
[253.609511] Starting dynamic subtest: pipe-A
[253.895888] Dynamic subtest pipe-A: SUCCESS (0.286s)
[253.905972] Starting dynamic subtest: pipe-B
[253.908292] Dynamic subtest pipe-B: SUCCESS (0.001s)
[253.916341] Starting dynamic subtest: pipe-C
[253.918575] Dynamic subtest pipe-C: SUCCESS (0.001s)
[253.926746] Starting dynamic subtest: pipe-D
[253.928963] Dynamic subtest pipe-D: SUCCESS (0.001s)
[253.931199] Subtest invalid-degamma-lut-sizes: SUCCESS (0.289s)
[254.737001] [032/131] (762s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[255.306627] Starting subtest: syncobj-timeline-invalid-wait
[255.309480] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[257.026473] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[257.030153] [033/131] (760s left) gem_userptr_blits (map-fixed-invalidate-busy)
[257.104964] Starting subtest: map-fixed-invalidate-busy
[257.109547] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[257.258851] [034/131] (760s left) gem_exec_whisper (basic-forked-all)
[257.320332] Starting subtest: basic-forked-all
[270.919299] Subtest basic-forked-all: SUCCESS (13.584s)
[271.113559] [035/131] (746s left) perf (non-sampling-read-error)
[271.234850] Starting subtest: non-sampling-read-error
[271.245329] Subtest non-sampling-read-error: SUCCESS (0.012s)
[271.287657] [036/131] (746s left) i915_query (query-garbage)
[271.344988] Starting subtest: query-garbage
[271.347342] Subtest query-garbage: SUCCESS (0.000s)
[271.477038] [037/131] (746s left) kms_flip (flip-vs-dpms-on-nop)
[271.577367] Starting subtest: flip-vs-dpms-on-nop
[271.579602] Starting dynamic subtest: A-eDP1
[273.423607] Dynamic subtest A-eDP1: SUCCESS (1.847s)
[273.434076] Starting dynamic subtest: B-eDP1
[275.255704] Dynamic subtest B-eDP1: SUCCESS (1.830s)
[275.265228] Starting dynamic subtest: C-eDP1
[277.074361] Dynamic subtest C-eDP1: SUCCESS (1.817s)
[277.084090] Starting dynamic subtest: D-eDP1
[278.895889] Dynamic subtest D-eDP1: SUCCESS (1.820s)
[278.901492] Subtest flip-vs-dpms-on-nop: SUCCESS (7.323s)
[280.100584] [038/131] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[280.202935] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[280.207064] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[280.324391] [039/131] (737s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[280.425112] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[280.429284] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[280.557383] [040/131] (737s left) gem_exec_schedule (preempt-contexts)
[280.631724] Starting subtest: preempt-contexts
[280.633873] Starting dynamic subtest: rcs0
[280.685867] Dynamic subtest rcs0: SUCCESS (0.060s)
[280.694339] Starting dynamic subtest: bcs0
[280.741171] Dynamic subtest bcs0: SUCCESS (0.054s)
[280.749609] Starting dynamic subtest: vcs0
[280.791009] Dynamic subtest vcs0: SUCCESS (0.049s)
[280.800321] Starting dynamic subtest: vcs1
[280.839250] Dynamic subtest vcs1: SUCCESS (0.047s)
[280.848141] Starting dynamic subtest: vecs0
[280.880831] Dynamic subtest vecs0: SUCCESS (0.039s)
[280.892209] Starting dynamic subtest: ccs0
[280.927840] Dynamic subtest ccs0: SUCCESS (0.046s)
[280.929738] Subtest preempt-contexts: SUCCESS (0.301s)
[282.067473] [041/131] (735s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[282.451317] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[283.298678] [042/131] (734s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[283.387558] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[283.389896] Starting dynamic subtest: pipe-A-eDP-1
[283.410718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[283.421512] Starting dynamic subtest: pipe-B-eDP-1
[283.440865] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[283.449250] Starting dynamic subtest: pipe-C-eDP-1
[283.468829] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[283.476698] Starting dynamic subtest: pipe-D-eDP-1
[283.497094] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[283.499049] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[285.616664] [043/131] (732s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[285.706282] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[285.708553] Starting dynamic subtest: pipe-A-default-mode
[288.466584] Dynamic subtest pipe-A-default-mode: SUCCESS (2.762s)
[288.468877] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.763s)
[289.336670] [044/131] (728s left) gem_fence_thrash (bo-write-verify-x)
[289.374893] Starting subtest: bo-write-verify-x
[289.400890] Subtest bo-write-verify-x: SKIP (0.023s)
[289.470079] [045/131] (728s left) perf_pmu (most-busy-check-all)
[289.506797] Starting subtest: most-busy-check-all
[289.508963] Starting dynamic subtest: rcs0
[290.886762] Dynamic subtest rcs0: SUCCESS (1.379s)
[290.898887] Starting dynamic subtest: bcs0
[292.934858] Dynamic subtest bcs0: SUCCESS (2.043s)
[292.946918] Starting dynamic subtest: vcs0
[294.918070] Dynamic subtest vcs0: SUCCESS (1.980s)
[294.929540] Starting dynamic subtest: vcs1
[296.901320] Dynamic subtest vcs1: SUCCESS (1.980s)
[296.912934] Starting dynamic subtest: vecs0
[298.950599] Dynamic subtest vecs0: SUCCESS (2.046s)
[298.961537] Starting dynamic subtest: ccs0
[300.934595] Dynamic subtest ccs0: SUCCESS (1.981s)
[300.937349] Subtest most-busy-check-all: SUCCESS (11.426s)
[301.068674] [046/131] (716s left) gem_ctx_isolation (clean)
[301.134950] Starting subtest: clean
[301.137166] Starting dynamic subtest: rcs0
[301.184382] Dynamic subtest rcs0: SUCCESS (0.049s)
[301.195868] Starting dynamic subtest: bcs0
[301.287287] Dynamic subtest bcs0: SUCCESS (0.101s)
[301.295441] Starting dynamic subtest: vcs0
[301.377320] Dynamic subtest vcs0: SUCCESS (0.090s)
[301.386451] Starting dynamic subtest: vcs1
[302.958483] Dynamic subtest vcs1: SUCCESS (1.579s)
[302.967477] Starting dynamic subtest: vecs0
[304.988580] Dynamic subtest vecs0: SUCCESS (2.027s)
[304.996749] Starting dynamic subtest: ccs0
[306.974981] Dynamic subtest ccs0: SUCCESS (1.985s)
[306.977458] Subtest clean: SUCCESS (5.838s)
[307.239155] [047/131] (710s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[312.307494] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[312.309750] Starting dynamic subtest: pipe-A-eDP-1
[313.122616] Dynamic subtest pipe-A-eDP-1: SKIP (0.810s)
[313.131945] Starting dynamic subtest: pipe-B-eDP-1
[314.263765] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[314.267995] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.952s)
[315.473203] [048/131] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[315.578031] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[337.569816] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (21.988s)
[337.742337] [049/131] (680s left) gem_fenced_exec_thrash (no-spare-fences)
[337.807860] Subtest no-spare-fences: SKIP (0.000s)
[337.889303] [050/131] (680s left) perf_pmu (frequency)
[337.923624] Starting subtest: frequency
[337.928631] Starting dynamic subtest: gt0
[340.140174] Dynamic subtest gt0: SUCCESS (2.207s)
[340.148434] Starting dynamic subtest: idle-gt0
[340.645036] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[340.653986] Starting dynamic subtest: gt1
[344.952413] Dynamic subtest gt1: SUCCESS (4.302s)
[344.960670] Starting dynamic subtest: idle-gt1
[345.499976] Dynamic subtest idle-gt1: SUCCESS (0.546s)
[345.502764] Subtest frequency: SUCCESS (7.575s)
[345.630342] [051/131] (672s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[345.736102] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[345.740493] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[345.839243] [052/131] (672s left) gem_softpin (evict-prime)
[345.896196] Starting subtest: evict-prime
[345.898501] Starting dynamic subtest: rcs0
[347.077452] Dynamic subtest rcs0: SUCCESS (1.181s)
[347.088544] Starting dynamic subtest: bcs0
[348.226117] Dynamic subtest bcs0: SUCCESS (1.147s)
[348.235914] Starting dynamic subtest: vcs0
[349.924793] Dynamic subtest vcs0: SUCCESS (1.696s)
[349.936585] Starting dynamic subtest: vcs1
[351.987537] Dynamic subtest vcs1: SUCCESS (2.062s)
[352.000246] Starting dynamic subtest: vecs0
[353.948530] Dynamic subtest vecs0: SUCCESS (1.961s)
[353.959702] Starting dynamic subtest: ccs0
[355.095871] Dynamic subtest ccs0: SUCCESS (1.147s)
[355.107450] Starting dynamic subtest: all
[356.946910] Dynamic subtest all: SUCCESS (1.849s)
[356.949560] Subtest evict-prime: SUCCESS (11.057s)
[357.042817] [053/131] (661s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[357.132730] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[357.135039] Starting dynamic subtest: pipe-A-default-mode
[357.434607] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[357.439023] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.300s)
[358.332006] [054/131] (659s left) kms_cursor_crc (cursor-offscreen-128x42)
[358.538985] Starting subtest: cursor-offscreen-128x42
[358.585178] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[358.796176] [055/131] (659s left) gem_gpgpu_fill (basic)
[358.861857] Starting subtest: basic
[358.863836] Starting dynamic subtest: smem
[358.868641] Dynamic subtest smem: SUCCESS (0.008s)
[358.870923] Subtest basic: SUCCESS (0.008s)
[359.008224] [056/131] (659s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[359.116700] Starting subtest: cursorA-vs-flipB-atomic-transitions
[359.121071] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[359.273984] [057/131] (659s left) i915_hangman (engine-error-state-capture)
[359.343581] Starting subtest: engine-error-state-capture
[359.345465] Starting dynamic subtest: rcs0
[362.916784] Dynamic subtest rcs0: SUCCESS (3.574s)
[362.927810] Starting dynamic subtest: bcs0
[368.868319] Dynamic subtest bcs0: SUCCESS (5.951s)
[368.881028] Starting dynamic subtest: vcs0
[374.882571] Dynamic subtest vcs0: SUCCESS (6.014s)
[374.894418] Starting dynamic subtest: vcs1
[380.900939] Dynamic subtest vcs1: SUCCESS (6.016s)
[380.911911] Starting dynamic subtest: vecs0
[386.915580] Dynamic subtest vecs0: SUCCESS (6.013s)
[386.930394] Starting dynamic subtest: ccs0
[392.931632] Dynamic subtest ccs0: SUCCESS (6.014s)
[392.934351] Subtest engine-error-state-capture: SUCCESS (33.595s)
[393.083578] [058/131] (625s left) kms_cursor_crc (cursor-sliding-256x256)
[393.303546] Starting subtest: cursor-sliding-256x256
[393.308447] Starting dynamic subtest: pipe-A-eDP-1
[396.516692] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.209s)
[396.543668] Starting dynamic subtest: pipe-D-eDP-1
[400.374061] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.838s)
[400.376495] Subtest cursor-sliding-256x256: SUCCESS (7.070s)
[401.188344] [059/131] (617s left) gem_exec_balancer (individual)
[401.256119] Starting subtest: individual
[402.921728] Subtest individual: SUCCESS (1.664s)
[403.237719] [060/131] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[403.337798] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[403.341868] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[403.462317] [061/131] (615s left) sysfs_defaults (readonly)
[403.533054] Starting subtest: readonly
[403.535501] Starting dynamic subtest: vecs0
[403.537806] Dynamic subtest vecs0: SUCCESS (0.000s)
[403.547956] Starting dynamic subtest: ccs0
[403.550052] Dynamic subtest ccs0: SUCCESS (0.000s)
[403.558442] Starting dynamic subtest: vcs0
[403.560747] Dynamic subtest vcs0: SUCCESS (0.000s)
[403.570362] Starting dynamic subtest: bcs0
[403.572558] Dynamic subtest bcs0: SUCCESS (0.000s)
[403.580535] Starting dynamic subtest: rcs0
[403.582754] Dynamic subtest rcs0: SUCCESS (0.000s)
[403.590854] Starting dynamic subtest: vcs1
[403.592728] Dynamic subtest vcs1: SUCCESS (0.000s)
[403.594615] Subtest readonly: SUCCESS (0.005s)
[403.657574] [062/131] (614s left) gem_exec_balancer (parallel-contexts)
[403.906579] Starting subtest: parallel-contexts
[406.463574] Subtest parallel-contexts: SUCCESS (2.556s)
[406.592700] [063/131] (611s left) kms_cursor_crc (cursor-random-128x42)
[406.820761] Starting subtest: cursor-random-128x42
[406.864547] Subtest cursor-random-128x42: SKIP (0.039s)
[407.096818] [064/131] (611s left) syncobj_wait (single-wait-for-submit-submitted)
[407.144297] Starting subtest: single-wait-for-submit-submitted
[407.249318] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[407.350246] [065/131] (611s left) kms_addfb_basic (too-wide)
[407.448716] Starting subtest: too-wide
[407.450940] Subtest too-wide: SUCCESS (0.000s)
[407.574488] [066/131] (611s left) gem_ctx_engines (execute-one)
[407.633688] Starting subtest: execute-one
[409.791225] Subtest execute-one: SUCCESS (2.158s)
[409.984249] [067/131] (608s left) gem_spin_batch (user-each)
[410.049009] Starting subtest: user-each
[413.412984] Subtest user-each: SUCCESS (3.363s)
[414.009322] [068/131] (604s left) kms_plane (plane-panning-top-left)
[414.112328] Starting subtest: plane-panning-top-left
[414.114406] Starting dynamic subtest: pipe-A
[415.750252] Dynamic subtest pipe-A: SUCCESS (1.637s)
[415.760476] Starting dynamic subtest: pipe-B
[418.016316] Dynamic subtest pipe-B: SUCCESS (2.267s)
[418.018706] Subtest plane-panning-top-left: SUCCESS (3.906s)
[418.847808] [069/131] (599s left) kms_getfb (getfb-handle-protection)
[418.935557] Starting subtest: getfb-handle-protection
[418.960881] Subtest getfb-handle-protection: SUCCESS (0.027s)
[419.097307] [070/131] (599s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[419.188515] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[420.178177] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.990s)
[420.357251] [071/131] (598s left) perf (blocking)
[420.456420] Starting subtest: blocking
[420.458480] Starting dynamic subtest: 0-rcs0
[430.474337] Dynamic subtest 0-rcs0: SUCCESS (10.014s)
[430.483932] Starting dynamic subtest: 1-vcs0
[440.493853] Dynamic subtest 1-vcs0: SUCCESS (10.017s)
[440.496192] Subtest blocking: SUCCESS (20.033s)
[440.541411] [072/131] (578s left) i915_pm_rps (engine-order)
[440.612334] Starting subtest: engine-order
[445.693984] Subtest engine-order: SUCCESS (5.079s)
[445.773541] [073/131] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[445.908588] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[450.376717] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.473s)
[451.561662] [074/131] (567s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[451.619735] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[451.722580] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[451.820965] [075/131] (567s left) core_sysfs (read-all-entries)
[451.870898] Starting subtest: read-all-entries
[451.877622] Subtest read-all-entries: SUCCESS (0.008s)
[452.010507] [076/131] (567s left) kms_psr (psr2-primary-mmap-cpu)
[452.100483] Starting subtest: psr2-primary-mmap-cpu
[452.102858] Starting dynamic subtest: eDP-1
[453.815096] Dynamic subtest eDP-1: SUCCESS (1.713s)
[453.817354] Subtest psr2-primary-mmap-cpu: SUCCESS (1.714s)
[454.725699] [077/131] (564s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[454.817501] Starting subtest: primary-4-tiled-reflect-x-0
[461.812688] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.994s)
[463.069682] [078/131] (556s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[463.169379] Starting subtest: fbc-tiling-linear
[466.918824] Subtest fbc-tiling-linear: SUCCESS (3.752s)
[468.081036] [079/131] (551s left) kms_pipe_crc_basic (suspend-read-crc)
[468.171396] Starting subtest: suspend-read-crc
[468.173706] Starting dynamic subtest: pipe-A-eDP-1
[485.781612] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.613s)
[485.796495] Starting dynamic subtest: pipe-B-eDP-1
[503.352734] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.782s)
[503.361503] Starting dynamic subtest: pipe-C-eDP-1
[521.301958] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.689s)
[521.312671] Starting dynamic subtest: pipe-D-eDP-1
[539.299535] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.712s)
[539.301747] Subtest suspend-read-crc: SUCCESS (10.803s)
[540.193880] [080/131] (479s left) kms_debugfs (display-off-read-all)
[540.300869] Starting subtest: display-off-read-all
[540.586686] Subtest display-off-read-all: SUCCESS (0.287s)
[541.447702] [081/131] (477s left) gem_mmap_offset (bad-flags)
[541.508071] Starting subtest: bad-flags
[541.510464] Subtest bad-flags: SUCCESS (0.000s)
[541.629389] [082/131] (477s left) gem_fence_thrash (bo-write-verify-y)
[541.663337] Starting subtest: bo-write-verify-y
[541.690951] Subtest bo-write-verify-y: SKIP (0.024s)
[541.755124] [083/131] (477s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[541.847785] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[541.852085] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[541.950994] [084/131] (477s left) gen9_exec_parse (valid-registers)
[542.009724] Subtest valid-registers: SKIP (0.000s)
[542.090519] [085/131] (477s left) kms_pm_dc (dc5-psr)
[543.197280] Starting subtest: dc5-psr
[547.303519] Subtest dc5-psr: FAIL (3.949s)
[547.345207] [086/131] (472s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[547.400796] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[547.402731] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[547.509939] [087/131] (472s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[547.578950] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[547.583559] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[547.785722] [088/131] (471s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[547.880946] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[547.883390] Starting dynamic subtest: pipe-A-eDP-1
[547.892627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[547.902384] Starting dynamic subtest: pipe-B-eDP-1
[547.911204] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[547.920293] Starting dynamic subtest: pipe-C-eDP-1
[547.928482] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[547.937424] Starting dynamic subtest: pipe-D-eDP-1
[547.945906] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[547.950101] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[550.202843] [089/131] (469s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[550.304958] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[550.309136] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[550.430210] [090/131] (469s left) prime_vgem (shrink)
[550.516458] Starting subtest: shrink
[550.535810] Subtest shrink: SUCCESS (0.020s)
[550.666975] [091/131] (469s left) gem_pxp (hw-rejects-pxp-context)
[550.791304] Starting subtest: hw-rejects-pxp-context
[550.796396] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[550.937932] [092/131] (468s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[551.048492] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[552.137676] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.089s)
[552.298839] [093/131] (467s left) i915_query (query-topology-matches-eu-total)
[552.361340] Starting subtest: query-topology-matches-eu-total
[552.363471] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[552.492062] [094/131] (467s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[552.580637] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[552.582383] Starting dynamic subtest: pipe-A-eDP-1
[552.601946] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[552.613771] Starting dynamic subtest: pipe-B-eDP-1
[552.632757] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[552.641201] Starting dynamic subtest: pipe-C-eDP-1
[552.659255] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[552.667253] Starting dynamic subtest: pipe-D-eDP-1
[552.686385] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[552.690367] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[554.769694] [095/131] (465s left) kms_dsc (dsc-basic)
[554.862386] Starting subtest: dsc-basic
[554.875658] Subtest dsc-basic: SKIP (0.000s)
[554.961203] [096/131] (464s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[555.063601] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[555.067874] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[555.195236] [097/131] (464s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[555.296031] Starting subtest: fbcpsr-rgb565-draw-blt
[562.243408] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.945s)
[562.402858] [098/131] (457s left) gem_exec_reloc (basic-active)
[562.459668] Subtest basic-active: SKIP (0.000s)
[562.520596] [099/131] (457s left) gem_bad_reloc (negative-reloc-lut)
[562.587480] Subtest negative-reloc-lut: SKIP (0.000s)
[562.671974] [100/131] (457s left) kms_big_fb (y-tiled-addfb)
[562.771012] Starting subtest: y-tiled-addfb
[562.774921] Subtest y-tiled-addfb: SKIP (0.000s)
[562.885721] [101/131] (457s left) gem_mmap_gtt (big-copy-odd)
[562.951123] Subtest big-copy-odd: SKIP (0.000s)
[563.015248] [102/131] (457s left) kms_invalid_mode (zero-clock)
[563.095705] Starting subtest: zero-clock
[563.097926] Starting dynamic subtest: pipe-A-eDP-1
[563.387483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[563.397278] Starting dynamic subtest: pipe-B-eDP-1
[563.399598] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[563.407916] Starting dynamic subtest: pipe-C-eDP-1
[563.410256] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[563.418494] Starting dynamic subtest: pipe-D-eDP-1
[563.420390] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[563.422270] Subtest zero-clock: SUCCESS (0.296s)
[564.243227] [103/131] (455s left) i915_pm_rps (thresholds)
[564.301054] Starting subtest: thresholds
[564.305672] Subtest thresholds: SKIP (0.001s)
[564.382281] [104/131] (455s left) kms_flip (2x-blocking-absolute-wf_vblank)
[564.478260] Starting subtest: 2x-blocking-absolute-wf_vblank
[564.487048] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[564.577907] [105/131] (455s left) gem_mmap_gtt (cpuset-big-copy-xy)
[564.633271] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[564.691867] [106/131] (455s left) perf (whitelisted-registers-userspace-config)
[564.791129] Starting subtest: whitelisted-registers-userspace-config
[564.793648] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[564.838384] [107/131] (455s left) prime_mmap (test_forked_cpu_write)
[564.901349] Starting subtest: test_forked_cpu_write
[564.903352] Starting dynamic subtest: test_forked_cpu_write-smem
[564.908277] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[564.910621] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[565.049149] [108/131] (455s left) gem_exec_params (rsvd2-dirt)
[565.106263] Starting subtest: rsvd2-dirt
[565.110930] Subtest rsvd2-dirt: SKIP (0.000s)
[565.219690] [109/131] (455s left) api_intel_allocator (reopen-fork)
[565.265379] Starting subtest: reopen-fork
[568.823728] Subtest reopen-fork: SUCCESS (3.556s)
[568.912911] [110/131] (451s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[569.023372] Starting subtest: basic-flip-after-cursor-atomic
[569.936538] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.913s)
[570.762364] [111/131] (449s left) kms_async_flips (invalid-async-flip-atomic)
[570.851091] Starting subtest: invalid-async-flip-atomic
[571.227988] Starting dynamic subtest: pipe-A-eDP-1
[572.075609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s)
[572.432478] Starting dynamic subtest: pipe-B-eDP-1
[573.210955] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.788s)
[573.566500] Starting dynamic subtest: pipe-C-eDP-1
[574.322733] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[574.682398] Starting dynamic subtest: pipe-D-eDP-1
[575.455149] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[575.457329] Subtest invalid-async-flip-atomic: SUCCESS (4.606s)
[576.618472] [112/131] (443s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[576.997032] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[577.815672] [113/131] (442s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[577.920663] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[577.924623] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[578.045107] [114/131] (442s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[578.144470] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[578.934632] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.792s)
[579.127188] [115/131] (441s left) syncobj_timeline (multi-wait-all-available-signaled)
[579.191730] Starting subtest: multi-wait-all-available-signaled
[579.194130] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[579.315810] [116/131] (441s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[579.408906] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[579.413025] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[579.532417] [117/131] (441s left) gem_tiled_partial_pwrite_pread (reads)
[579.590974] Subtest reads: SKIP (0.000s)
[579.660079] [118/131] (441s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[584.634970] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[584.637390] Starting dynamic subtest: pipe-A-eDP-1
[596.055560] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.419s)
[596.066268] Starting dynamic subtest: pipe-B-eDP-1
[607.488948] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.425s)
[607.491378] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.850s)
[608.366848] [119/131] (412s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[608.488818] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[609.473379] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.984s)
[610.293389] [120/131] (410s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[610.383999] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[610.394947] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[610.526157] [121/131] (410s left) kms_psr (fbc-pr-sprite-plane-onoff)
[610.621532] Starting subtest: fbc-pr-sprite-plane-onoff
[610.625472] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[610.706780] [122/131] (410s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[610.754096] Starting subtest: invalid-bsd2-flag-on-blt
[610.756412] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[610.861931] [123/131] (410s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[610.950248] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[610.952400] Starting dynamic subtest: pipe-A-eDP-1
[610.972731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[610.983289] Starting dynamic subtest: pipe-B-eDP-1
[611.001439] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[611.010132] Starting dynamic subtest: pipe-C-eDP-1
[611.028706] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[611.038066] Starting dynamic subtest: pipe-D-eDP-1
[611.058170] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[611.060207] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[613.170492] [124/131] (407s left) syncobj_wait (invalid-reset-one-illegal-handle)
[613.226770] Starting subtest: invalid-reset-one-illegal-handle
[613.229124] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[613.353459] [125/131] (407s left) prime_udl
[613.437718] [126/131] (407s left) prime_self_import (basic-with_one_bo_two_files)
[613.469964] Starting subtest: basic-with_one_bo_two_files
[613.488781] Subtest basic-with_one_bo_two_files: SUCCESS (0.023s)
[613.605141] [127/131] (407s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[613.701186] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[620.844957] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.144s)
[621.003848] [128/131] (400s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[621.105979] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[621.110196] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[621.234429] [129/131] (400s left) kms_vblank (query-idle)
[621.318368] Starting subtest: query-idle
[621.320535] Starting dynamic subtest: pipe-A-eDP-1
[623.064937] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.745s)
[623.079536] Starting dynamic subtest: pipe-D-eDP-1
[625.529753] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.464s)
[625.532089] Subtest query-idle: SUCCESS (4.212s)
[626.375264] [130/131] (394s left) kms_frontbuffer_tracking (fbc-stridechange)
[626.475948] Starting subtest: fbc-stridechange
[629.817401] Subtest fbc-stridechange: SUCCESS (3.341s)
[630.971069] [131/131] (390s left) gem_exec_reloc (basic-gtt-read-active)
[631.025291] Subtest basic-gtt-read-active: SKIP (0.000s)
[631.102135] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_plane_cursor
results: parsing output: 3/ for test: kms_atomic_transition
results: parsing output: 4/ for test: gem_exec_async
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: gem_ctx_param
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_prop_blob
results: parsing output: 13/ for test: gem_ctx_persistence
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: prime_mmap
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_tiled_fence_blits
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: kms_color
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: i915_query
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_chamelium_edid
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: gem_fence_thrash
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: gem_ctx_isolation
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_fenced_exec_thrash
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: gem_gpgpu_fill
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: i915_hangman
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: sysfs_defaults
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: gem_spin_batch
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_getfb
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: i915_pm_rps
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: core_sysfs
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_pipe_crc_basic
results: parsing output: 79/ for test: kms_debugfs
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: gem_fence_thrash
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gen9_exec_parse
results: parsing output: 84/ for test: kms_pm_dc
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: gem_pxp
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: i915_query
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_dsc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: gem_bad_reloc
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_invalid_mode
results: parsing output: 102/ for test: i915_pm_rps
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: prime_mmap
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: api_intel_allocator
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: prime_udl
results: parsing output: 125/ for test: prime_self_import
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_reloc
Done.