[57.960873] Initializing watchdogs
[57.960972]   /dev/watchdog0
[57.986936] [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]
[57.991268] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.994028] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.997615] [001/132] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[58.121613] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[58.126158] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[58.230088] [002/132] (960s left) kms_feature_discovery (psr1)
[58.321974] Starting subtest: psr1
[58.324067] Subtest psr1: SUCCESS (0.000s)
[58.402968] [003/132] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[58.460047] Starting subtest: multi-wait-for-submit-unsubmitted
[58.569138] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[58.640986] [004/132] (959s left) perf_pmu (all-busy-check-all)
[58.687830] Starting subtest: all-busy-check-all
[59.926795] Subtest all-busy-check-all: SUCCESS (1.238s)
[60.021193] [005/132] (958s left) kms_prop_blob (blob-multiple)
[60.073809] Starting subtest: blob-multiple
[60.076537] Subtest blob-multiple: SUCCESS (0.005s)
[60.182007] [006/132] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[60.286267] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[60.290367] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.372666] [007/132] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[60.475445] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[64.183823] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.708s)
[65.305519] [008/132] (953s left) kms_properties (plane-properties-legacy)
[65.408996] Starting subtest: plane-properties-legacy
[65.411405] Starting dynamic subtest: pipe-A-eDP-1
[66.001433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[66.010350] Starting dynamic subtest: pipe-B-eDP-1
[67.276581] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s)
[67.284223] Starting dynamic subtest: pipe-C-eDP-1
[68.517615] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[68.526224] Starting dynamic subtest: pipe-D-eDP-1
[69.756881] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[69.759472] Subtest plane-properties-legacy: SUCCESS (4.346s)
[70.568667] [009/132] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[70.677581] Starting subtest: fbcpsr-2p-rte
[70.682273] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[70.778231] [010/132] (948s left) syncobj_wait (multi-wait-submitted-signaled)
[70.849244] Starting subtest: multi-wait-submitted-signaled
[70.851693] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[70.956866] [011/132] (947s left) gem_ccs (ctrl-surf-copy-new-ctx)
[71.024990] Starting subtest: ctrl-surf-copy-new-ctx
[71.029330] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[71.117845] [012/132] (947s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[71.215985] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[71.220589] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[71.297787] [013/132] (947s left) kms_rotation_crc (primary-rotation-270)
[71.382353] Starting subtest: primary-rotation-270
[71.386755] Subtest primary-rotation-270: SKIP (0.001s)
[71.462269] [014/132] (947s left) perf (gen12-oa-tlb-invalidate)
[71.578968] Starting subtest: gen12-oa-tlb-invalidate
[71.581062] Starting dynamic subtest: 0-rcs0
[81.624654] Dynamic subtest 0-rcs0: SUCCESS (10.040s)
[81.632869] Starting dynamic subtest: 1-vecs0
[91.725444] Dynamic subtest 1-vecs0: SUCCESS (10.047s)
[91.728052] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.088s)
[91.791141] [015/132] (927s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[91.890644] Starting subtest: fbcpsr-rgb101010-draw-render
[98.595881] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.710s)
[98.727964] [016/132] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[98.830378] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[98.834534] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[98.911461] [017/132] (920s left) gem_userptr_blits (relocations)
[98.974876] Starting subtest: relocations
[98.979379] Subtest relocations: SKIP (0.001s)
[99.087871] [018/132] (920s left) kms_invalid_mode (clock-too-high)
[99.182407] Starting subtest: clock-too-high
[99.184833] Starting dynamic subtest: pipe-A-eDP-1
[99.189391] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.198638] Starting dynamic subtest: pipe-B-eDP-1
[99.202743] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.210138] Starting dynamic subtest: pipe-C-eDP-1
[99.214429] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.221709] Starting dynamic subtest: pipe-D-eDP-1
[99.226196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.230659] Subtest clock-too-high: SKIP (0.003s)
[99.263751] [019/132] (919s left) syncobj_wait (multi-wait-submitted)
[99.320451] Starting subtest: multi-wait-submitted
[99.424936] Subtest multi-wait-submitted: SUCCESS (0.103s)
[99.508101] [020/132] (919s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[99.604677] Starting subtest: psr-2p-primscrn-cur-indfb-move
[99.608755] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[99.714046] [021/132] (919s left) kms_flip (2x-flip-vs-suspend)
[99.815429] Starting subtest: 2x-flip-vs-suspend
[99.826039] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[99.910232] [022/132] (919s left) gem_pread (self)
[99.964540] Subtest self: SKIP (0.000s)
[100.036716] [023/132] (919s left) gem_eio (unwedge-stress)
[100.237634] Starting subtest: unwedge-stress
[100.240060] Starting dynamic subtest: render
[104.343882] Dynamic subtest render: SUCCESS (4.105s)
[104.358783] Starting dynamic subtest: bsd1
[122.347154] Dynamic subtest bsd1: SUCCESS (18.000s)
[122.363843] Starting dynamic subtest: bsd2
[140.345510] Dynamic subtest bsd2: SUCCESS (17.995s)
[140.361222] Starting dynamic subtest: blt
[140.365432] Dynamic subtest blt: SKIP (0.000s)
[140.373320] Starting dynamic subtest: vebox
[158.328401] Dynamic subtest vebox: SUCCESS (17.979s)
[158.330619] Subtest unwedge-stress: SUCCESS (58.082s)
[159.940070] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[159.943303] [024/132] (859s left) gem_pwrite_snooped
[160.067259] [025/132] (859s left) kms_psr (psr-sprite-plane-onoff)
[160.157037] Starting subtest: psr-sprite-plane-onoff
[160.159334] Starting dynamic subtest: eDP-1
[161.924308] Dynamic subtest eDP-1: SUCCESS (1.766s)
[161.926228] Subtest psr-sprite-plane-onoff: SUCCESS (1.767s)
[162.738426] [026/132] (856s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[162.829310] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[162.833682] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[162.900863] [027/132] (856s left) kms_cursor_crc (cursor-offscreen-max-size)
[163.239811] Starting subtest: cursor-offscreen-max-size
[163.246478] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[163.377841] [028/132] (856s left) gem_basic (bad-close)
[163.426571] Starting subtest: bad-close
[163.430781] Subtest bad-close: SUCCESS (0.000s)
[163.513197] [029/132] (856s left) gem_exec_schedule (implicit-read-write)
[163.589300] Starting subtest: implicit-read-write
[163.591136] Starting dynamic subtest: rcs0
[163.705510] Dynamic subtest rcs0: SUCCESS (0.121s)
[163.716088] Starting dynamic subtest: vcs0
[163.798595] Dynamic subtest vcs0: SUCCESS (0.092s)
[163.810344] Starting dynamic subtest: vcs1
[163.877962] Dynamic subtest vcs1: SUCCESS (0.079s)
[163.889456] Starting dynamic subtest: vecs0
[163.960273] Dynamic subtest vecs0: SUCCESS (0.082s)
[163.971083] Starting dynamic subtest: ccs0
[164.047838] Dynamic subtest ccs0: SUCCESS (0.087s)
[164.050373] Subtest implicit-read-write: SUCCESS (0.463s)
[164.983057] [030/132] (854s left) gem_mmap_gtt (big-copy-xy)
[165.041819] Subtest big-copy-XY: SKIP (0.000s)
[165.107645] [031/132] (854s left) gem_exec_fence (syncobj-channel)
[165.542568] Starting subtest: syncobj-channel
[166.564904] Subtest syncobj-channel: SUCCESS (1.020s)
[167.024494] [032/132] (852s left) kms_chamelium_edid (hdmi-mode-timings)
[167.416536] Subtest hdmi-mode-timings: SKIP (0.000s)
[168.246169] [033/132] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[168.347917] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[168.352496] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[168.438560] [034/132] (851s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[168.543154] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[168.547119] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[168.618582] [035/132] (851s left) kms_atomic_transition (plane-all-modeset-transition)
[168.711436] Starting subtest: plane-all-modeset-transition
[168.716082] Subtest plane-all-modeset-transition: SKIP (0.000s)
[168.785488] [036/132] (851s left) drm_read (empty-block)
[168.941990] Starting subtest: empty-block
[169.942060] Subtest empty-block: SUCCESS (1.000s)
[170.075885] [037/132] (849s left) gem_exec_balancer (fairslice)
[170.142869] Starting subtest: fairslice
[173.082210] Subtest fairslice: SUCCESS (2.937s)
[173.408200] [038/132] (846s left) api_intel_bb (reset-flags)
[173.465631] Starting subtest: reset-flags
[173.475456] Subtest reset-flags: SUCCESS (0.013s)
[173.591648] [039/132] (846s left) kms_rotation_crc (bad-pixel-format)
[173.691025] Starting subtest: bad-pixel-format
[173.695392] Subtest bad-pixel-format: SKIP (0.001s)
[173.763834] [040/132] (846s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[174.086923] Starting subtest: cursor-rapid-movement-512x512
[174.091871] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[174.244480] [041/132] (845s left) kms_pm_dc (dc3co-vpb-simulation)
[175.347593] Starting subtest: dc3co-vpb-simulation
[183.760261] Subtest dc3co-vpb-simulation: SKIP (8.409s)
[183.905334] [042/132] (836s left) syncobj_timeline (wait-all-for-submit-snapshot)
[183.961161] Starting subtest: wait-all-for-submit-snapshot
[184.043090] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[184.178905] [043/132] (836s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[184.289027] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[184.291345] Starting dynamic subtest: pipe-A-eDP-1
[184.313652] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[184.322869] Starting dynamic subtest: pipe-B-eDP-1
[184.344180] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[184.352276] Starting dynamic subtest: pipe-C-eDP-1
[184.373225] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[184.380734] Starting dynamic subtest: pipe-D-eDP-1
[184.401451] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[184.405590] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.012s)
[186.628888] [044/132] (833s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[186.726262] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[186.730545] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[186.829150] [045/132] (833s left) gem_exec_reloc (basic-concurrent0)
[186.892594] Subtest basic-concurrent0: SKIP (0.000s)
[186.987737] [046/132] (833s left) gem_pxp (reject-modify-context-protection-off-2)
[187.113805] Starting subtest: reject-modify-context-protection-off-2
[187.116349] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[187.221089] [047/132] (833s left) kms_chamelium_hpd (hdmi-hpd-storm)
[187.619428] Subtest hdmi-hpd-storm: SKIP (0.000s)
[188.446530] [048/132] (832s left) i915_drm_fdinfo (basics)
[188.490314] Starting subtest: basics
[188.492193] Subtest basics: SUCCESS (0.000s)
[188.553886] [049/132] (831s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[188.639057] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[188.641323] Starting dynamic subtest: pipe-A-eDP-1
[188.662302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[188.672243] Starting dynamic subtest: pipe-B-eDP-1
[188.691615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[188.700153] Starting dynamic subtest: pipe-C-eDP-1
[188.719544] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[188.727459] Starting dynamic subtest: pipe-D-eDP-1
[188.747936] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[188.750244] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[190.949716] [050/132] (829s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[191.010540] Starting subtest: yf-tiled-to-vebox-y-tiled
[191.014880] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[191.190676] [051/132] (829s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[191.286138] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[191.288503] Starting dynamic subtest: pipe-A
[192.484947] Dynamic subtest pipe-A: SUCCESS (1.201s)
[192.493263] Starting dynamic subtest: pipe-B
[194.807362] Dynamic subtest pipe-B: SUCCESS (2.321s)
[194.815838] Starting dynamic subtest: pipe-C
[196.041508] Dynamic subtest pipe-C: SUCCESS (1.232s)
[196.053789] Starting dynamic subtest: pipe-D
[197.196513] Dynamic subtest pipe-D: SUCCESS (1.154s)
[197.198823] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.913s)
[198.386887] [052/132] (822s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[198.494252] Starting subtest: y-tiled-32bpp-rotate-180
[198.498807] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[198.589192] [053/132] (822s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[198.689592] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[198.694054] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[198.783167] [054/132] (821s left) kms_flip (dpms-vs-vblank-race-interruptible)
[198.886301] Starting subtest: dpms-vs-vblank-race-interruptible
[198.888632] Starting dynamic subtest: A-eDP1
[202.775356] Dynamic subtest A-eDP1: SUCCESS (3.887s)
[202.784568] Starting dynamic subtest: B-eDP1
[207.408517] Dynamic subtest B-eDP1: SUCCESS (4.631s)
[207.426219] Starting dynamic subtest: C-eDP1
[211.961595] Dynamic subtest C-eDP1: SUCCESS (4.552s)
[211.971685] Starting dynamic subtest: D-eDP1
[216.506206] Dynamic subtest D-eDP1: SUCCESS (4.544s)
[216.511122] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.623s)
[217.392439] [055/132] (803s left) i915_query (query-topology-garbage-items)
[217.457621] Starting subtest: query-topology-garbage-items
[217.459898] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[217.549999] [056/132] (803s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[217.638827] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[217.641125] Starting dynamic subtest: pipe-A-eDP-1
[217.700676] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[217.717987] Starting dynamic subtest: pipe-B-eDP-1
[217.776492] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[217.786582] Starting dynamic subtest: pipe-C-eDP-1
[217.843832] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[217.855999] Starting dynamic subtest: pipe-D-eDP-1
[217.913091] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[217.917558] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[219.937319] [057/132] (800s left) gen9_exec_parse (allowed-single)
[220.005163] Subtest allowed-single: SKIP (0.000s)
[220.067411] [058/132] (800s left) gem_exec_params (invalid-ring)
[220.136229] Starting subtest: invalid-ring
[220.138645] Subtest invalid-ring: SUCCESS (0.000s)
[220.235359] [059/132] (800s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[220.281627] Starting subtest: etime-single-wait-all-for-submit-submitted
[220.385146] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[220.460283] [060/132] (800s left) kms_hdr (invalid-hdr)
[220.550223] Starting subtest: invalid-hdr
[222.641055] Starting dynamic subtest: pipe-A-eDP-1
[225.620534] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.980s)
[225.622860] Subtest invalid-hdr: SUCCESS (5.070s)
[225.751951] [061/132] (795s left) kms_big_fb (linear-32bpp-rotate-0)
[225.853066] Starting subtest: linear-32bpp-rotate-0
[228.590176] Subtest linear-32bpp-rotate-0: SUCCESS (2.737s)
[228.735766] [062/132] (792s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[228.829093] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[228.832657] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[228.938248] [063/132] (792s left) gem_userptr_blits (dmabuf-sync)
[229.004580] Starting subtest: dmabuf-sync
[229.008525] Subtest dmabuf-sync: SKIP (0.002s)
[229.135912] [064/132] (791s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[229.218622] Starting subtest: bad-rotation-90-y-tiled-ccs
[229.220542] Starting dynamic subtest: pipe-A-eDP-1
[229.238974] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[229.248752] Starting dynamic subtest: pipe-B-eDP-1
[229.266019] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[229.274070] Starting dynamic subtest: pipe-C-eDP-1
[229.291156] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[229.299387] Starting dynamic subtest: pipe-D-eDP-1
[229.316458] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[229.319662] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[231.384629] [065/132] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[231.484694] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[231.489144] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[231.577970] [066/132] (789s left) kms_psr (fbc-psr-primary-mmap-gtt)
[231.680201] Starting subtest: fbc-psr-primary-mmap-gtt
[231.682069] Starting dynamic subtest: eDP-1
[231.686086] Dynamic subtest eDP-1: SKIP (0.000s)
[231.690073] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[231.751410] [067/132] (789s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[231.846932] Starting subtest: primary-yf-tiled-reflect-x-0
[231.906076] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[232.007644] [068/132] (789s left) kms_flip (flip-vs-panning-interruptible)
[232.110725] Starting subtest: flip-vs-panning-interruptible
[232.113060] Starting dynamic subtest: A-eDP1
[240.802789] Dynamic subtest A-eDP1: SUCCESS (8.691s)
[240.813516] Starting dynamic subtest: B-eDP1
[249.520312] Dynamic subtest B-eDP1: SUCCESS (8.715s)
[249.534202] Starting dynamic subtest: C-eDP1
[258.237782] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[258.246233] Starting dynamic subtest: D-eDP1
[266.965437] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[266.969529] Subtest flip-vs-panning-interruptible: SUCCESS (34.857s)
[268.119317] [069/132] (753s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[268.212649] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[268.217127] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[268.305567] [070/132] (753s left) perf_pmu (busy-idle-no-semaphores)
[268.348404] Starting subtest: busy-idle-no-semaphores
[268.350276] Starting dynamic subtest: rcs0
[268.999940] Dynamic subtest rcs0: SUCCESS (0.653s)
[269.011208] Starting dynamic subtest: bcs0
[269.651215] Dynamic subtest bcs0: SUCCESS (0.649s)
[269.662836] Starting dynamic subtest: vcs0
[270.302916] Dynamic subtest vcs0: SUCCESS (0.650s)
[270.313883] Starting dynamic subtest: vcs1
[271.548286] Dynamic subtest vcs1: SUCCESS (1.243s)
[271.559377] Starting dynamic subtest: vecs0
[273.534639] Dynamic subtest vecs0: SUCCESS (1.983s)
[273.544603] Starting dynamic subtest: ccs0
[275.517634] Dynamic subtest ccs0: SUCCESS (1.981s)
[275.520247] Subtest busy-idle-no-semaphores: SUCCESS (7.172s)
[275.632847] [071/132] (745s left) kms_chamelium_color (ctm-0-50)
[275.725229] Subtest ctm-0-50: SKIP (0.000s)
[275.773567] [072/132] (745s left) syncobj_wait (multi-wait-all-signaled)
[275.821096] Starting subtest: multi-wait-all-signaled
[275.823369] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[275.915526] [073/132] (745s left) kms_vblank (query-idle)
[275.997172] Starting subtest: query-idle
[275.999417] Starting dynamic subtest: pipe-A-eDP-1
[277.748370] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.748s)
[277.762601] Starting dynamic subtest: pipe-D-eDP-1
[280.159904] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.411s)
[280.162249] Subtest query-idle: SUCCESS (4.162s)
[280.992525] [074/132] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[281.106757] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[281.110817] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[281.195994] [075/132] (740s left) i915_pm_rpm (gem-pread)
[283.024607] Starting subtest: gem-pread
[285.111578] Subtest gem-pread: SUCCESS (2.090s)
[285.205867] [076/132] (736s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[285.301519] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[285.306326] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[285.405889] [077/132] (736s left) api_intel_allocator (open-vm)
[285.454053] Starting subtest: open-vm
[285.456320] Subtest open-vm: SUCCESS (0.003s)
[285.576139] [078/132] (736s left) gem_fence_thrash (bo-write-verify-y)
[285.610465] Starting subtest: bo-write-verify-y
[285.640388] Subtest bo-write-verify-y: SKIP (0.028s)
[285.707437] [079/132] (735s left) kms_async_flips (invalid-async-flip-atomic)
[285.799032] Starting subtest: invalid-async-flip-atomic
[286.173083] Starting dynamic subtest: pipe-A-eDP-1
[286.988651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s)
[287.352816] Starting dynamic subtest: pipe-B-eDP-1
[288.125991] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[288.482824] Starting dynamic subtest: pipe-C-eDP-1
[289.253209] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[289.612964] Starting dynamic subtest: pipe-D-eDP-1
[290.368797] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.763s)
[290.370956] Subtest invalid-async-flip-atomic: SUCCESS (4.571s)
[291.532646] [080/132] (730s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[291.601170] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[291.705386] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[291.781362] [081/132] (730s left) i915_query (query-garbage)
[291.836237] Starting subtest: query-garbage
[291.838160] Subtest query-garbage: SUCCESS (0.000s)
[291.952346] [082/132] (729s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[292.000163] Starting subtest: legacy-engines-hostile-preempt
[292.002494] Starting dynamic subtest: render
[292.066704] Dynamic subtest render: SUCCESS (0.064s)
[292.078377] Starting dynamic subtest: bsd1
[293.904449] Dynamic subtest bsd1: SUCCESS (1.836s)
[293.917176] Starting dynamic subtest: bsd2
[295.888043] Dynamic subtest bsd2: SUCCESS (1.981s)
[295.899993] Starting dynamic subtest: blt
[295.916286] Dynamic subtest blt: SUCCESS (0.027s)
[295.924874] Starting dynamic subtest: vebox
[297.867387] Dynamic subtest vebox: SUCCESS (1.948s)
[297.870242] Subtest legacy-engines-hostile-preempt: SUCCESS (5.867s)
[297.946966] [083/132] (723s left) perf_pmu (semaphore-wait)
[297.983945] Starting subtest: semaphore-wait
[297.986241] Starting dynamic subtest: rcs0
[298.499494] Dynamic subtest rcs0: SUCCESS (0.513s)
[298.511839] Starting dynamic subtest: bcs0
[299.020244] Dynamic subtest bcs0: SUCCESS (0.518s)
[299.031925] Starting dynamic subtest: vcs0
[299.535463] Dynamic subtest vcs0: SUCCESS (0.512s)
[299.547787] Starting dynamic subtest: vcs1
[300.052093] Dynamic subtest vcs1: SUCCESS (0.513s)
[300.062325] Starting dynamic subtest: vecs0
[300.568143] Dynamic subtest vecs0: SUCCESS (0.512s)
[300.579271] Starting dynamic subtest: ccs0
[301.083411] Dynamic subtest ccs0: SUCCESS (0.513s)
[301.086596] Subtest semaphore-wait: SUCCESS (3.100s)
[301.244150] [084/132] (720s left) gem_ctx_param (invalid-ctx-set)
[301.302874] Starting subtest: invalid-ctx-set
[301.305265] Subtest invalid-ctx-set: SUCCESS (0.001s)
[301.422642] [085/132] (720s left) gem_exec_whisper (basic-sync)
[301.486768] Starting subtest: basic-sync
[312.150193] Subtest basic-sync: SUCCESS (10.639s)
[312.310274] [086/132] (709s left) gem_exec_reloc (basic-write-wc)
[312.391296] Subtest basic-write-wc: SKIP (0.000s)
[312.463160] [087/132] (709s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[312.512960] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[312.515226] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[312.618250] [088/132] (709s left) kms_plane_alpha_blend (constant-alpha-min)
[312.713082] Starting subtest: constant-alpha-min
[313.002727] Starting dynamic subtest: pipe-A-eDP-1
[313.707294] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s)
[313.717334] Starting dynamic subtest: pipe-D-eDP-1
[315.212388] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s)
[315.214660] Subtest constant-alpha-min: SUCCESS (2.502s)
[316.095611] [089/132] (706s left) kms_psr2_su (page_flip-xrgb8888)
[316.164195] Subtest page_flip-XRGB8888: SKIP (0.000s)
[316.228604] [090/132] (705s left) kms_prime (basic-crc-vgem)
[316.308156] Starting subtest: basic-crc-vgem
[316.310434] Starting dynamic subtest: second-to-first
[317.236868] Dynamic subtest second-to-first: SUCCESS (0.933s)
[317.238772] Subtest basic-crc-vgem: SUCCESS (0.933s)
[317.330137] [091/132] (704s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[317.450833] Starting subtest: psr-1p-pri-indfb-multidraw
[339.738111] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.290s)
[339.855412] [092/132] (682s left) gem_exec_schedule (semaphore-codependency)
[339.926080] Starting subtest: semaphore-codependency
[339.933899] Subtest semaphore-codependency: SUCCESS (0.013s)
[340.280899] [093/132] (682s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[340.379057] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[341.338607] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.958s)
[341.462178] [094/132] (680s left) kms_psr (pr-no-drrs)
[341.558523] Starting subtest: pr-no-drrs
[341.562755] Subtest pr-no-drrs: SKIP (0.000s)
[341.630825] [095/132] (680s left) kms_joiner (invalid-modeset-ultra-joiner)
[341.731252] Starting subtest: invalid-modeset-ultra-joiner
[341.734761] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[341.798403] [096/132] (680s left) syncobj_timeline (wait-for-submit-complex)
[341.854052] Starting subtest: wait-for-submit-complex
[341.914626] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[341.990034] [097/132] (680s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[342.082668] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[342.084711] Starting dynamic subtest: pipe-A
[342.104868] Dynamic subtest pipe-A: SKIP (0.017s)
[342.115413] Starting dynamic subtest: pipe-B
[342.133222] Dynamic subtest pipe-B: SKIP (0.029s)
[342.142430] Starting dynamic subtest: pipe-C
[342.162913] Dynamic subtest pipe-C: SKIP (0.029s)
[342.171393] Starting dynamic subtest: pipe-D
[342.191362] Dynamic subtest pipe-D: SKIP (0.029s)
[342.194937] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.106s)
[342.316251] [098/132] (680s left) kms_addfb_basic (bad-pitch-128)
[342.379898] Starting subtest: bad-pitch-128
[342.382181] Subtest bad-pitch-128: SUCCESS (0.000s)
[342.516459] [099/132] (680s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[342.599316] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[342.692140] [100/132] (679s left) kms_plane (pixel-format-linear-modifier)
[342.792270] Starting subtest: pixel-format-linear-modifier
[342.819487] Starting dynamic subtest: pipe-A-plane-0
[346.474668] Dynamic subtest pipe-A-plane-0: SUCCESS (3.655s)
[346.483119] Starting dynamic subtest: pipe-A-plane-3
[348.286269] Dynamic subtest pipe-A-plane-3: SUCCESS (1.810s)
[348.300583] Starting dynamic subtest: pipe-A-plane-5
[348.497047] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[349.633336] Starting dynamic subtest: pipe-B-plane-0
[353.459098] Dynamic subtest pipe-B-plane-0: SUCCESS (3.833s)
[353.467367] Starting dynamic subtest: pipe-B-plane-3
[355.193113] Dynamic subtest pipe-B-plane-3: SUCCESS (1.732s)
[355.206455] Starting dynamic subtest: pipe-B-plane-5
[355.403611] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[355.724686] Subtest pixel-format-linear-modifier: SUCCESS (12.932s)
[356.525850] [101/132] (666s left) gem_workarounds (suspend-resume-fd)
[356.593225] Starting subtest: suspend-resume-fd
[373.141330] Subtest suspend-resume-fd: SUCCESS (1.266s)
[373.273139] [102/132] (649s left) syncobj_wait (wait-all-complex)
[373.344670] Starting subtest: wait-all-complex
[373.558581] Subtest wait-all-complex: SUCCESS (0.214s)
[373.634499] [103/132] (649s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[373.693992] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[373.696175] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[373.784699] [104/132] (648s left) gem_render_copy_redux (flink)
[373.843199] Starting subtest: flink
[374.640289] Subtest flink: SUCCESS (0.792s)
[374.798036] [105/132] (648s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[374.895578] Starting subtest: 2x-flip-vs-rmfb-interruptible
[374.908238] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[374.998085] [106/132] (647s left) gem_mmap_gtt (isolation)
[375.056632] Subtest isolation: SKIP (0.000s)
[375.134402] [107/132] (647s left) gem_ctx_isolation (dirty-switch)
[375.195596] Starting subtest: dirty-switch
[375.197446] Starting dynamic subtest: rcs0
[375.386558] Dynamic subtest rcs0: SUCCESS (0.191s)
[375.398901] Starting dynamic subtest: bcs0
[375.601377] Dynamic subtest bcs0: SUCCESS (0.212s)
[375.613218] Starting dynamic subtest: vcs0
[375.816397] Dynamic subtest vcs0: SUCCESS (0.213s)
[375.827967] Starting dynamic subtest: vcs1
[377.332632] Dynamic subtest vcs1: SUCCESS (1.507s)
[377.343416] Starting dynamic subtest: vecs0
[379.432069] Dynamic subtest vecs0: SUCCESS (2.090s)
[379.443602] Starting dynamic subtest: ccs0
[381.410637] Dynamic subtest ccs0: SUCCESS (1.971s)
[381.412931] Subtest dirty-switch: SUCCESS (6.191s)
[381.629934] [108/132] (641s left) gem_eio (wait-10ms)
[381.886401] Starting subtest: wait-10ms
[382.257113] Subtest wait-10ms: SUCCESS (0.370s)
[382.392236] [109/132] (640s left) gem_lmem_swapping (random)
[382.429984] Subtest random: SKIP (0.000s)
[382.474724] [110/132] (640s left) kms_psr (fbc-pr-primary-render)
[382.562282] Starting subtest: fbc-pr-primary-render
[382.565939] Subtest fbc-pr-primary-render: SKIP (0.000s)
[382.636054] [111/132] (640s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[382.747569] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[382.751306] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[382.844405] [112/132] (640s left) gen7_exec_parse (basic-allocation)
[382.906972] Subtest basic-allocation: SKIP (0.000s)
[382.968245] [113/132] (640s left) gem_cs_tlb (engines)
[383.027598] Starting subtest: engines
[383.029531] Starting dynamic subtest: rcs0
[385.187773] Dynamic subtest rcs0: SUCCESS (2.152s)
[385.199069] Starting dynamic subtest: bcs0
[387.397837] Dynamic subtest bcs0: SUCCESS (2.151s)
[387.410991] Starting dynamic subtest: vcs0
[389.554177] Dynamic subtest vcs0: SUCCESS (2.153s)
[389.565343] Starting dynamic subtest: vcs1
[391.710434] Dynamic subtest vcs1: SUCCESS (2.152s)
[391.722530] Starting dynamic subtest: vecs0
[393.866432] Dynamic subtest vecs0: SUCCESS (2.152s)
[393.879286] Starting dynamic subtest: ccs0
[396.020980] Dynamic subtest ccs0: SUCCESS (2.153s)
[396.023455] Subtest engines: SUCCESS (12.921s)
[396.096091] [114/132] (627s left) kms_cursor_edge_walk (64x64-top-edge)
[396.204797] Starting subtest: 64x64-top-edge
[396.207155] Starting dynamic subtest: pipe-A-eDP-1
[399.654210] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[399.664762] Starting dynamic subtest: pipe-D-eDP-1
[402.768227] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.108s)
[402.770526] Subtest 64x64-top-edge: SUCCESS (6.560s)
[403.585986] [115/132] (619s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[403.693808] Starting subtest: 4-tiled-64bpp-rotate-270
[403.713533] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[403.843105] [116/132] (619s left) kms_async_flips (async-flip-dpms)
[403.934644] Starting subtest: async-flip-dpms
[404.307062] Starting dynamic subtest: pipe-A-eDP-1
[408.094307] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.785s)
[408.473983] Starting dynamic subtest: pipe-B-eDP-1
[411.262511] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.793s)
[411.650233] Starting dynamic subtest: pipe-C-eDP-1
[414.427354] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.783s)
[414.805287] Starting dynamic subtest: pipe-D-eDP-1
[417.604076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.804s)
[417.606563] Subtest async-flip-dpms: SUCCESS (13.664s)
[418.795139] [117/132] (604s left) gem_softpin (allocator-nopin)
[418.846513] Starting subtest: allocator-nopin
[418.947715] Subtest allocator-nopin: SUCCESS (0.103s)
[419.075964] [118/132] (604s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[419.187322] Starting subtest: cursorA-vs-flipA-toggle
[430.332957] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.139s)
[431.148395] [119/132] (592s left) dmabuf_sync_file (import-multiple-read-only)
[431.198011] Starting subtest: import-multiple-read-only
[431.200342] Subtest import-multiple-read-only: SUCCESS (0.003s)
[431.257017] [120/132] (592s left) gem_exec_whisper (basic-contexts-priority-all)
[431.317367] Starting subtest: basic-contexts-priority-all
[454.282722] Subtest basic-contexts-priority-all: SUCCESS (22.949s)
[454.464924] [121/132] (569s left) kms_color (gamma)
[454.556680] Starting subtest: gamma
[454.558545] Starting dynamic subtest: pipe-A-eDP-1
[455.290340] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[455.300414] Starting dynamic subtest: pipe-B-eDP-1
[456.663078] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.371s)
[456.676195] Starting dynamic subtest: pipe-C-eDP-1
[458.060373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[458.070860] Starting dynamic subtest: pipe-D-eDP-1
[459.380021] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[459.382233] Subtest gamma: SUCCESS (4.823s)
[460.188416] [122/132] (563s left) syncobj_timeline (invalid-signal-illegal-handle)
[460.243083] Starting subtest: invalid-signal-illegal-handle
[460.245230] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[460.341710] [123/132] (563s left) kms_sequence (queue-busy)
[460.425675] Starting subtest: queue-busy
[460.427990] Starting dynamic subtest: pipe-A-eDP-1
[462.366637] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[462.377948] Starting dynamic subtest: pipe-B-eDP-1
[465.002441] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.631s)
[465.012998] Starting dynamic subtest: pipe-C-eDP-1
[467.615854] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[467.626275] Starting dynamic subtest: pipe-D-eDP-1
[470.154657] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[470.157041] Subtest queue-busy: SUCCESS (9.729s)
[470.977780] [124/132] (552s left) gem_exec_balancer (sliced)
[471.044989] Starting subtest: sliced
[471.049763] Subtest sliced: SKIP (0.000s)
[471.362455] [125/132] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[471.466995] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[478.989491] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.532s)
[479.125025] [126/132] (544s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[479.218187] Starting subtest: fbc-psr2-cursor-plane-update-sf
[479.220562] Starting dynamic subtest: pipe-A-eDP-1
[479.301426] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[479.311767] Starting dynamic subtest: pipe-B-eDP-1
[480.446663] Dynamic subtest pipe-B-eDP-1: SKIP (1.142s)
[480.451025] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.234s)
[481.647424] [127/132] (542s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[481.749380] Starting subtest: x-tiled-16bpp-rotate-90
[481.773318] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[481.882294] [128/132] (541s left) kms_properties (invalid-properties-legacy)
[481.968664] Starting subtest: invalid-properties-legacy
[482.072562] Subtest invalid-properties-legacy: SUCCESS (0.104s)
[482.158677] [129/132] (541s left) kms_content_protection (atomic-hdcp14)
[482.307325] Starting subtest: atomic-hdcp14
[482.311601] Subtest atomic-hdcp14: SKIP (0.000s)
[482.419823] [130/132] (541s left) i915_hangman (engine-engine-error)
[482.492057] Starting subtest: engine-engine-error
[482.494120] Starting dynamic subtest: rcs0
[484.131002] Dynamic subtest rcs0: SUCCESS (1.641s)
[484.145704] Starting dynamic subtest: bcs0
[486.177957] Dynamic subtest bcs0: SUCCESS (2.045s)
[486.191953] Starting dynamic subtest: vcs0
[488.163093] Dynamic subtest vcs0: SUCCESS (1.983s)
[488.175731] Starting dynamic subtest: vcs1
[490.146698] Dynamic subtest vcs1: SUCCESS (1.981s)
[490.159852] Starting dynamic subtest: vecs0
[492.130981] Dynamic subtest vecs0: SUCCESS (1.982s)
[492.147213] Starting dynamic subtest: ccs0
[494.179161] Dynamic subtest ccs0: SUCCESS (2.046s)
[494.182055] Subtest engine-engine-error: SUCCESS (11.695s)
[494.308267] [131/132] (529s left) kms_psr (psr-basic)
[494.422563] Starting subtest: psr-basic
[494.424905] Starting dynamic subtest: eDP-1
[496.005179] Dynamic subtest eDP-1: SUCCESS (1.582s)
[496.007359] Subtest psr-basic: SUCCESS (1.583s)
[496.880754] [132/132] (527s left) kms_dp_link_training (non-uhbr-sst)
[496.976704] Starting subtest: non-uhbr-sst
[496.985566] Subtest non-uhbr-sst: SKIP (0.000s)
[497.057672] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_feature_discovery
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_prop_blob
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_properties
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: gem_ccs
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: kms_rotation_crc
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: kms_invalid_mode
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_pread
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: gem_pwrite_snooped
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_basic
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: drm_read
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: api_intel_bb
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: kms_pm_dc
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_reloc
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: i915_drm_fdinfo
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_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_hdr
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_rotation_crc
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_chamelium_color
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: api_intel_allocator
results: parsing output: 77/ for test: gem_fence_thrash
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: i915_query
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_plane_alpha_blend
results: parsing output: 88/ for test: kms_psr2_su
results: parsing output: 89/ for test: kms_prime
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_joiner
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: gem_workarounds
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: gem_render_copy_redux
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: gem_ctx_isolation
results: parsing output: 107/ for test: gem_eio
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gen7_exec_parse
results: parsing output: 112/ for test: gem_cs_tlb
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: dmabuf_sync_file
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: kms_color
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_sequence
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_properties
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: i915_hangman
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_dp_link_training
Done.