[58.828701] Initializing watchdogs
[58.828747]   /dev/watchdog0
[58.843636] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.848433] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.850942] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.853217] [001/133] (960s left) kms_psr (psr-primary-blt)
[58.956423] Starting subtest: psr-primary-blt
[58.957473] Starting dynamic subtest: eDP-1
[60.694832] Dynamic subtest eDP-1: SUCCESS (1.731s)
[60.695690] Subtest psr-primary-blt: SUCCESS (1.732s)
[61.563062] [002/133] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[61.654185] Starting subtest: fbc-rgb101010-draw-render
[66.294032] Subtest fbc-rgb101010-draw-render: SUCCESS (4.628s)
[67.515335] [003/133] (951s left) prime_vgem (fence-read-hang)
[67.754851] Subtest fence-read-hang: SKIP (0.000s)
[67.915214] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[67.917381] [004/133] (951s left) gem_ctx_persistence (engines-persistence)
[67.997601] Starting subtest: engines-persistence
[67.998913] Starting dynamic subtest: rcs0
[68.902594] Dynamic subtest rcs0: SUCCESS (0.904s)
[68.913419] Starting dynamic subtest: bcs0
[69.632555] Dynamic subtest bcs0: SUCCESS (0.728s)
[69.641528] Starting dynamic subtest: vcs0
[70.420859] Dynamic subtest vcs0: SUCCESS (0.786s)
[70.429762] Starting dynamic subtest: vcs1
[71.185697] Dynamic subtest vcs1: SUCCESS (0.763s)
[71.194338] Starting dynamic subtest: vecs0
[71.960834] Dynamic subtest vecs0: SUCCESS (0.773s)
[71.969460] Starting dynamic subtest: ccs0
[72.728680] Dynamic subtest ccs0: SUCCESS (0.766s)
[72.730069] Subtest engines-persistence: SUCCESS (4.727s)
[72.803675] [005/133] (946s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[72.897599] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[72.899378] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[72.963518] [006/133] (946s left) kms_flip (2x-absolute-wf_vblank)
[73.062026] Starting subtest: 2x-absolute-wf_vblank
[73.072407] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[73.150914] [007/133] (946s left) gem_exec_flush (basic-wb-ro-default)
[73.199559] Starting subtest: basic-wb-ro-default
[78.659414] Subtest basic-wb-ro-default: SUCCESS (5.457s)
[78.845105] [008/133] (940s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[78.944024] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[78.945143] Starting dynamic subtest: pipe-A-default-mode
[81.726242] Dynamic subtest pipe-A-default-mode: SUCCESS (2.780s)
[81.727106] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.781s)
[82.582156] [009/133] (937s left) kms_cdclk (mode-transition-all-outputs)
[82.662070] Starting subtest: mode-transition-all-outputs
[82.962250] Subtest mode-transition-all-outputs: SKIP (0.300s)
[83.819648] [010/133] (935s left) kms_addfb_basic (master-rmfb)
[83.858131] Starting subtest: master-rmfb
[83.859404] Subtest master-rmfb: SUCCESS (0.001s)
[83.993448] [011/133] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[84.098266] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[84.100123] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[84.186341] [012/133] (935s left) i915_pm_freq_api (freq-suspend)
[84.239503] Starting subtest: freq-suspend
[84.240489] Starting dynamic subtest: gt0
[100.883841] Dynamic subtest gt0: SUCCESS (1.762s)
[100.893810] Starting dynamic subtest: gt1
[117.888902] Dynamic subtest gt1: SUCCESS (1.621s)
[117.889753] Subtest freq-suspend: SUCCESS (3.384s)
[123.989070] [013/133] (901s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[124.094812] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[131.764875] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.567s)
[131.869854] [014/133] (893s left) gem_exec_whisper (basic-contexts-priority)
[131.922799] Starting subtest: basic-contexts-priority
[156.709767] Subtest basic-contexts-priority: SUCCESS (24.678s)
[156.858679] [015/133] (869s left) kms_plane (plane-position-hole-dpms)
[156.954656] Starting subtest: plane-position-hole-dpms
[157.488828] Starting dynamic subtest: pipe-A-plane-1
[159.831674] Dynamic subtest pipe-A-plane-1: SUCCESS (2.341s)
[159.839818] Starting dynamic subtest: pipe-A-plane-2
[162.225365] Dynamic subtest pipe-A-plane-2: SUCCESS (2.393s)
[162.233145] Starting dynamic subtest: pipe-A-plane-3
[164.627788] Dynamic subtest pipe-A-plane-3: SUCCESS (2.402s)
[164.635954] Starting dynamic subtest: pipe-A-plane-4
[167.090494] Dynamic subtest pipe-A-plane-4: SUCCESS (2.461s)
[167.098706] Starting dynamic subtest: pipe-A-plane-5
[167.118689] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[168.353880] Starting dynamic subtest: pipe-B-plane-1
[170.791189] Dynamic subtest pipe-B-plane-1: SUCCESS (2.444s)
[170.798537] Starting dynamic subtest: pipe-B-plane-2
[173.222393] Dynamic subtest pipe-B-plane-2: SUCCESS (2.430s)
[173.229997] Starting dynamic subtest: pipe-B-plane-3
[175.597104] Dynamic subtest pipe-B-plane-3: SUCCESS (2.372s)
[175.604712] Starting dynamic subtest: pipe-B-plane-4
[177.987218] Dynamic subtest pipe-B-plane-4: SUCCESS (2.389s)
[177.995050] Starting dynamic subtest: pipe-B-plane-5
[178.019110] Dynamic subtest pipe-B-plane-5: SUCCESS (0.030s)
[178.020128] Subtest plane-position-hole-dpms: SUCCESS (21.055s)
[178.864506] [016/133] (847s left) kms_pm_dc (dc6-dpms)
[179.966351] Starting subtest: dc6-dpms
[182.061711] Subtest dc6-dpms: SUCCESS (2.085s)
[182.130274] [017/133] (843s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[182.222080] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[182.223023] Starting dynamic subtest: pipe-A-eDP-1
[183.154839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.929s)
[183.162422] Starting dynamic subtest: pipe-B-eDP-1
[184.879014] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.722s)
[184.886464] Starting dynamic subtest: pipe-C-eDP-1
[186.379611] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.499s)
[186.387798] Starting dynamic subtest: pipe-D-eDP-1
[187.890403] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.509s)
[187.891283] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.664s)
[189.054680] [018/133] (836s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[189.149779] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[193.596156] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.444s)
[194.780676] [019/133] (831s left) kms_chamelium_edid (dp-edid-read)
[195.167035] Subtest dp-edid-read: SKIP (0.000s)
[195.967945] [020/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[196.057606] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[196.059485] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[196.152657] [021/133] (829s left) kms_invalid_mode (bad-vsync-start)
[196.242921] Starting subtest: bad-vsync-start
[196.243716] Starting dynamic subtest: pipe-A-eDP-1
[196.527202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[196.534559] Starting dynamic subtest: pipe-B-eDP-1
[196.535423] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[196.542288] Starting dynamic subtest: pipe-C-eDP-1
[196.543119] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[196.550071] Starting dynamic subtest: pipe-D-eDP-1
[196.550889] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[196.551666] Subtest bad-vsync-start: SUCCESS (0.290s)
[197.314058] [022/133] (828s left) gem_softpin (softpin)
[197.361001] Starting subtest: softpin
[229.694936] Subtest softpin: SUCCESS (32.320s)
[229.790678] [023/133] (796s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[229.874804] Starting subtest: compare-crc-sanitycheck-xr24
[229.875688] Starting dynamic subtest: pipe-A-eDP-1
[230.531044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.656s)
[230.539867] Starting dynamic subtest: pipe-B-eDP-1
[231.829178] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.296s)
[231.838365] Starting dynamic subtest: pipe-C-eDP-1
[233.110720] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.281s)
[233.118867] Starting dynamic subtest: pipe-D-eDP-1
[234.334117] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[234.334934] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.460s)
[235.168890] [024/133] (791s left) gem_exec_balancer (hog)
[235.242451] Starting subtest: hog
[235.244304] Subtest hog: SKIP (0.000s)
[235.549094] [025/133] (790s left) gem_exec_schedule (preempt-engines)
[235.607883] Starting subtest: preempt-engines
[235.608770] Starting dynamic subtest: rcs0
[237.926756] Dynamic subtest rcs0: SUCCESS (2.310s)
[237.938241] Starting dynamic subtest: bcs0
[240.261613] Dynamic subtest bcs0: SUCCESS (2.296s)
[240.271935] Starting dynamic subtest: vcs0
[242.539372] Dynamic subtest vcs0: SUCCESS (2.276s)
[242.550035] Starting dynamic subtest: vcs1
[244.830315] Dynamic subtest vcs1: SUCCESS (2.289s)
[244.840382] Starting dynamic subtest: vecs0
[247.118577] Dynamic subtest vecs0: SUCCESS (2.286s)
[247.128562] Starting dynamic subtest: ccs0
[249.416749] Dynamic subtest ccs0: SUCCESS (2.296s)
[249.418304] Subtest preempt-engines: SUCCESS (13.764s)
[249.669119] [026/133] (776s left) gem_userptr_blits (huge-split)
[249.733007] Starting subtest: huge-split
[249.744488] Subtest huge-split: SUCCESS (0.011s)
[249.858421] [027/133] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[249.952840] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[257.288623] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.336s)
[257.432290] [028/133] (768s left) perf (invalid-remove-userspace-config)
[257.555320] Starting subtest: invalid-remove-userspace-config
[257.562972] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[257.610532] [029/133] (768s left) gem_exec_balancer (waits)
[257.666359] Starting subtest: waits
[264.228485] Subtest waits: SUCCESS (6.516s)
[264.467594] [030/133] (761s left) syncobj_wait (multi-wait-signaled)
[264.517858] Starting subtest: multi-wait-signaled
[264.518750] Subtest multi-wait-signaled: SUCCESS (0.000s)
[264.613666] [031/133] (761s left) gem_softpin (reverse)
[264.669109] Starting subtest: reverse
[264.676195] Subtest reverse: SUCCESS (0.008s)
[264.786602] [032/133] (761s left) perf (gen12-group-exclusive-stream-ctx-handle)
[264.872557] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[264.901953] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.028s)
[264.944205] [033/133] (761s left) i915_suspend (basic-s2idle-without-i915)
[264.972637] Starting subtest: basic-s2idle-without-i915
[287.378893] Subtest basic-s2idle-without-i915: SUCCESS (7.343s)
[292.555090] [034/133] (739s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[292.646081] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[292.647122] Starting dynamic subtest: pipe-A-eDP-1
[292.655962] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[292.667145] Starting dynamic subtest: pipe-B-eDP-1
[292.677227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[292.687471] Starting dynamic subtest: pipe-C-eDP-1
[292.695520] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[292.701908] Starting dynamic subtest: pipe-D-eDP-1
[292.710516] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[292.712153] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[294.981670] [035/133] (736s left) gem_ctx_shared (disjoint-timelines)
[295.047802] Starting subtest: disjoint-timelines
[295.070515] Subtest disjoint-timelines: SUCCESS (0.022s)
[295.303110] [036/133] (736s left) fbdev (unaligned-write)
[295.349926] Starting subtest: unaligned-write
[295.456025] Subtest unaligned-write: SUCCESS (0.103s)
[295.515991] [037/133] (736s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[295.571206] Starting subtest: y-tiled-ccs-to-y-tiled
[295.573158] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[295.752408] [038/133] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[295.854484] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[299.881248] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.979s)
[301.067095] [039/133] (730s left) gem_ctx_persistence (heartbeat-close)
[301.121107] Starting subtest: heartbeat-close
[301.123391] Subtest heartbeat-close: SKIP (0.000s)
[301.226485] [040/133] (730s left) gem_eio (execbuf)
[301.362452] Starting subtest: execbuf
[301.530116] Subtest execbuf: SUCCESS (0.166s)
[301.648887] [041/133] (730s left) kms_flip (plain-flip-ts-check-interruptible)
[301.739649] Starting subtest: plain-flip-ts-check-interruptible
[301.741133] Starting dynamic subtest: A-eDP1
[310.712603] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[310.722087] Starting dynamic subtest: B-eDP1
[319.571389] Dynamic subtest B-eDP1: SUCCESS (8.842s)
[319.581370] Starting dynamic subtest: C-eDP1
[328.419629] Dynamic subtest C-eDP1: SUCCESS (8.830s)
[328.429325] Starting dynamic subtest: D-eDP1
[337.251579] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[337.252714] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.422s)
[338.383688] [042/133] (693s left) gem_mmap_gtt (bad-object)
[338.438749] Subtest bad-object: SKIP (0.000s)
[338.496990] [043/133] (693s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[338.582835] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[338.584653] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[339.720179] [044/133] (692s left) kms_psr (pr-dpms)
[339.812050] Starting subtest: pr-dpms
[339.813675] Subtest pr-dpms: SKIP (0.000s)
[339.879384] [045/133] (692s left) syncobj_eventfd (binary-wait-signaled)
[339.944644] Starting subtest: binary-wait-signaled
[339.945649] Subtest binary-wait-signaled: SUCCESS (0.000s)
[340.038021] [046/133] (691s left) perf (create-destroy-userspace-config)
[340.163203] Starting subtest: create-destroy-userspace-config
[340.180148] Subtest create-destroy-userspace-config: SUCCESS (0.016s)
[340.212567] [047/133] (691s left) i915_pm_rps (reset)
[340.276319] Starting subtest: reset
[348.697150] Subtest reset: SUCCESS (8.415s)
[348.819882] [048/133] (683s left) perf_pmu (semaphore-wait-idle)
[348.855323] Starting subtest: semaphore-wait-idle
[348.856397] Starting dynamic subtest: rcs0
[349.380207] Dynamic subtest rcs0: SUCCESS (0.515s)
[349.390936] Starting dynamic subtest: bcs0
[349.895500] Dynamic subtest bcs0: SUCCESS (0.512s)
[349.905761] Starting dynamic subtest: vcs0
[350.411758] Dynamic subtest vcs0: SUCCESS (0.513s)
[350.421725] Starting dynamic subtest: vcs1
[350.927191] Dynamic subtest vcs1: SUCCESS (0.512s)
[350.937161] Starting dynamic subtest: vecs0
[351.443347] Dynamic subtest vecs0: SUCCESS (0.513s)
[351.453294] Starting dynamic subtest: ccs0
[351.959273] Dynamic subtest ccs0: SUCCESS (0.512s)
[351.960681] Subtest semaphore-wait-idle: SUCCESS (3.095s)
[353.260738] [049/133] (678s left) kms_psr (psr2-sprite-mmap-gtt)
[353.351842] Starting subtest: psr2-sprite-mmap-gtt
[353.352700] Starting dynamic subtest: eDP-1
[354.832207] Dynamic subtest eDP-1: SKIP (1.469s)
[354.834191] Subtest psr2-sprite-mmap-gtt: SKIP (1.471s)
[354.976115] [050/133] (677s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[355.017919] Starting subtest: invalid-multi-wait-unsubmitted
[355.018802] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[355.109961] [051/133] (677s left) sysfs_preempt_timeout (idempotent)
[355.165075] Starting subtest: idempotent
[355.166201] Starting dynamic subtest: vecs0
[355.167147] Dynamic subtest vecs0: SUCCESS (0.000s)
[355.176321] Starting dynamic subtest: ccs0
[355.177203] Dynamic subtest ccs0: SUCCESS (0.000s)
[355.184594] Starting dynamic subtest: vcs0
[355.185466] Dynamic subtest vcs0: SUCCESS (0.000s)
[355.193102] Starting dynamic subtest: bcs0
[355.193987] Dynamic subtest bcs0: SUCCESS (0.000s)
[355.201728] Starting dynamic subtest: rcs0
[355.202594] Dynamic subtest rcs0: SUCCESS (0.000s)
[355.210153] Starting dynamic subtest: vcs1
[355.211025] Dynamic subtest vcs1: SUCCESS (0.000s)
[355.211893] Subtest idempotent: SUCCESS (0.007s)
[355.266560] [052/133] (676s left) gen9_exec_parse (allowed-all)
[355.323427] Subtest allowed-all: SKIP (0.000s)
[355.397505] [053/133] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[355.497202] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[355.498767] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[355.626377] [054/133] (676s left) gem_render_copy (linear)
[355.690259] Starting subtest: linear
[355.691244] Starting dynamic subtest: smem
[355.739520] Dynamic subtest smem: SUCCESS (0.049s)
[355.742157] Subtest linear: SUCCESS (0.050s)
[355.968191] [055/133] (676s left) gem_eio (reset-stress)
[356.175939] Starting subtest: reset-stress
[356.177040] Starting dynamic subtest: render
[360.777376] Dynamic subtest render: SUCCESS (4.598s)
[360.787284] Starting dynamic subtest: bsd1
[378.693996] Dynamic subtest bsd1: SUCCESS (17.908s)
[378.709317] Starting dynamic subtest: bsd2
[396.737266] Dynamic subtest bsd2: SUCCESS (18.041s)
[396.752229] Starting dynamic subtest: blt
[396.753909] Dynamic subtest blt: SKIP (0.000s)
[396.761333] Starting dynamic subtest: vebox
[414.751868] Dynamic subtest vebox: SUCCESS (18.016s)
[414.753013] Subtest reset-stress: SUCCESS (58.568s)
[416.278387] [056/133] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[416.362724] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[416.364566] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[416.456410] [057/133] (615s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[416.542158] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[416.543072] Starting dynamic subtest: pipe-A-eDP-1
[416.551788] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.560257] Starting dynamic subtest: pipe-B-eDP-1
[416.569092] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.577515] Starting dynamic subtest: pipe-C-eDP-1
[416.585609] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[416.593472] Starting dynamic subtest: pipe-D-eDP-1
[416.601831] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.603422] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[418.829464] [058/133] (613s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[418.878099] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[418.879022] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[418.962598] [059/133] (613s left) kms_cursor_crc (cursor-onscreen-512x512)
[419.274992] Starting subtest: cursor-onscreen-512x512
[419.276718] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[419.433266] [060/133] (613s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[419.545281] Starting subtest: flip-vs-cursor-busy-crc-legacy
[420.361713] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.815s)
[421.149596] [061/133] (611s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[421.234493] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[421.236154] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[421.335061] [062/133] (611s left) gem_exec_schedule (preempt-user)
[421.392911] Starting subtest: preempt-user
[421.393738] Starting dynamic subtest: rcs0
[421.416714] Dynamic subtest rcs0: SUCCESS (0.023s)
[421.426506] Starting dynamic subtest: bcs0
[421.439380] Dynamic subtest bcs0: SUCCESS (0.022s)
[421.448466] Starting dynamic subtest: vcs0
[421.460396] Dynamic subtest vcs0: SUCCESS (0.020s)
[421.471958] Starting dynamic subtest: vcs1
[421.480973] Dynamic subtest vcs1: SUCCESS (0.020s)
[421.488861] Starting dynamic subtest: vecs0
[421.502089] Dynamic subtest vecs0: SUCCESS (0.020s)
[421.510042] Starting dynamic subtest: ccs0
[421.531547] Dynamic subtest ccs0: SUCCESS (0.029s)
[421.532397] Subtest preempt-user: SUCCESS (0.139s)
[423.273831] [063/133] (609s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[423.367950] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[423.369607] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[423.486514] [064/133] (609s left) kms_color (degamma)
[423.578349] Starting subtest: degamma
[423.579287] Starting dynamic subtest: pipe-A-eDP-1
[424.300079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[424.308314] Starting dynamic subtest: pipe-B-eDP-1
[425.702377] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[425.710883] Starting dynamic subtest: pipe-C-eDP-1
[427.068166] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[427.076469] Starting dynamic subtest: pipe-D-eDP-1
[428.405467] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[428.406316] Subtest degamma: SUCCESS (4.828s)
[429.205808] [065/133] (603s left) gem_exec_reloc (basic-cpu-read-noreloc)
[429.259791] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[429.318178] [066/133] (603s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[429.373684] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[429.439548] [067/133] (603s left) syncobj_wait (wait-all-snapshot)
[429.484854] Starting subtest: wait-all-snapshot
[429.567502] Subtest wait-all-snapshot: SUCCESS (0.082s)
[429.635855] [068/133] (603s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[429.757424] Starting subtest: cursor-vs-flip-toggle
[460.867899] Subtest cursor-vs-flip-toggle: SUCCESS (31.107s)
[461.725336] [069/133] (571s left) gem_set_tiling_vs_pwrite
[461.869930] [070/133] (571s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[462.266225] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[463.041435] [071/133] (569s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[463.126080] Starting subtest: fbc-psr-cursor-mmap-cpu
[463.127058] Starting dynamic subtest: eDP-1
[463.128945] Dynamic subtest eDP-1: SKIP (0.000s)
[463.130729] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[463.207508] [072/133] (569s left) kms_addfb_basic (bad-pitch-32)
[463.266414] Starting subtest: bad-pitch-32
[463.267325] Subtest bad-pitch-32: SUCCESS (0.000s)
[463.389901] [073/133] (569s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[463.488033] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[463.489613] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[463.594059] [074/133] (569s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[463.691783] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[463.692634] Starting dynamic subtest: pipe-A-eDP-1
[463.792413] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[463.802124] Starting dynamic subtest: pipe-B-eDP-1
[464.950338] Dynamic subtest pipe-B-eDP-1: SKIP (1.157s)
[464.951994] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.260s)
[466.149019] [075/133] (566s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[466.201081] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[466.202849] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[466.373287] [076/133] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[466.456308] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[466.458185] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.546833] [077/133] (566s left) gem_basic (create-fd-close)
[466.588656] Starting subtest: create-fd-close
[466.590434] Subtest create-fd-close: SUCCESS (0.000s)
[466.690628] [078/133] (566s left) kms_pm_rpm (system-suspend-idle)
[468.418257] Starting subtest: system-suspend-idle
[488.435182] Subtest system-suspend-idle: SUCCESS (4.999s)
[492.871012] [079/133] (544s left) perf_pmu (busy-idle-check-all)
[492.921599] Starting subtest: busy-idle-check-all
[492.922568] Starting dynamic subtest: rcs0
[493.597354] Dynamic subtest rcs0: SUCCESS (0.661s)
[493.610689] Starting dynamic subtest: bcs0
[494.261375] Dynamic subtest bcs0: FAIL (0.625s)
[494.269888] Starting dynamic subtest: vcs0
[496.280492] Dynamic subtest vcs0: SUCCESS (1.997s)
[496.291361] Starting dynamic subtest: vcs1
[498.264802] Dynamic subtest vcs1: SUCCESS (1.955s)
[498.276116] Starting dynamic subtest: vecs0
[500.247658] Dynamic subtest vecs0: SUCCESS (1.959s)
[500.258921] Starting dynamic subtest: ccs0
[500.902330] Dynamic subtest ccs0: SUCCESS (0.655s)
[500.903827] Subtest busy-idle-check-all: FAIL (7.866s)
[500.992086] [080/133] (536s left) gem_exec_fence (syncobj-timeline-signal)
[501.557588] Starting subtest: syncobj-timeline-signal
[501.562405] Subtest syncobj-timeline-signal: SUCCESS (0.014s)
[503.300073] [081/133] (534s left) dmabuf_sync_file (export-basic)
[503.335243] Starting subtest: export-basic
[503.336229] Subtest export-basic: SUCCESS (0.001s)
[503.388530] [082/133] (533s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[503.494328] Starting subtest: 2x-flip-vs-cursor-atomic
[503.496874] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[503.647423] [083/133] (533s left) gem_exec_parallel (fds)
[503.698390] Starting subtest: fds
[503.699124] Starting dynamic subtest: rcs0
[506.227721] Dynamic subtest rcs0: SUCCESS (2.508s)
[506.236796] Starting dynamic subtest: bcs0
[509.507202] Dynamic subtest bcs0: SUCCESS (3.265s)
[509.515779] Starting dynamic subtest: vcs0
[513.628199] Dynamic subtest vcs0: SUCCESS (4.108s)
[513.636637] Starting dynamic subtest: vcs1
[517.509688] Dynamic subtest vcs1: SUCCESS (3.871s)
[517.518426] Starting dynamic subtest: vecs0
[521.526375] Dynamic subtest vecs0: SUCCESS (4.013s)
[521.537649] Starting dynamic subtest: ccs0
[525.118212] Dynamic subtest ccs0: SUCCESS (3.591s)
[525.119574] Subtest fds: SUCCESS (21.370s)
[525.301261] [084/133] (512s left) sw_sync (alloc_timeline)
[525.339355] Starting subtest: alloc_timeline
[525.340461] Subtest alloc_timeline: SUCCESS (0.000s)
[525.390004] [085/133] (512s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[525.495094] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[525.496953] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[525.582331] [086/133] (511s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[525.661679] Starting subtest: dsc-fractional-bpp-with-bpc
[525.674250] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[525.730517] [087/133] (511s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[525.798186] Starting subtest: single-wait-all-for-submit-signaled
[525.799332] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[525.913068] [088/133] (511s left) gem_pxp (verify-pxp-stale-buf-execution)
[526.025740] Starting subtest: verify-pxp-stale-buf-execution
[527.087872] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[527.215027] [089/133] (510s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[527.304869] Starting subtest: x-tiled-8bpp-rotate-0
[528.519739] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.215s)
[528.650026] [090/133] (508s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[528.767020] Starting subtest: cursorA-vs-flipB-toggle
[528.768781] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[528.918668] [091/133] (508s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[528.980617] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[529.051537] [092/133] (508s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[529.107399] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[529.247671] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.139s)
[529.380863] [093/133] (508s left) gem_exec_reloc (basic-cpu)
[529.427332] Subtest basic-cpu: SKIP (0.000s)
[529.496375] [094/133] (508s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[529.579528] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[529.580408] Starting dynamic subtest: pipe-A-eDP-1
[529.646424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.068s)
[529.656978] Starting dynamic subtest: pipe-B-eDP-1
[529.712100] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.064s)
[529.722430] Starting dynamic subtest: pipe-C-eDP-1
[529.776134] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.063s)
[529.787213] Starting dynamic subtest: pipe-D-eDP-1
[529.842820] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.066s)
[529.843621] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.265s)
[532.161439] [095/133] (505s left) gem_exec_fence (syncobj-export)
[532.647853] Starting subtest: syncobj-export
[532.652598] Subtest syncobj-export: SUCCESS (0.006s)
[534.359253] [096/133] (503s left) kms_big_fb (linear-16bpp-rotate-0)
[534.467413] Starting subtest: linear-16bpp-rotate-0
[535.924821] Subtest linear-16bpp-rotate-0: SUCCESS (1.457s)
[536.033305] [097/133] (501s left) kms_big_fb (4-tiled-addfb-size-overflow)
[536.129286] Starting subtest: 4-tiled-addfb-size-overflow
[536.130374] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[536.220961] [098/133] (501s left) sw_sync (alloc_fence)
[536.256342] Starting subtest: alloc_fence
[536.257278] Subtest alloc_fence: SUCCESS (0.000s)
[536.311145] [099/133] (501s left) gem_ctx_engines (execute-oneforall)
[536.364474] Starting subtest: execute-oneforall
[536.935866] Subtest execute-oneforall: SUCCESS (0.571s)
[538.315190] [100/133] (499s left) gem_mmap_gtt (big-copy-xy)
[538.363033] Subtest big-copy-XY: SKIP (0.000s)
[538.426953] [101/133] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[538.509264] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[538.510840] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[538.590900] [102/133] (499s left) kms_cursor_edge_walk (128x128-top-edge)
[538.672427] Starting subtest: 128x128-top-edge
[538.673224] Starting dynamic subtest: pipe-A-eDP-1
[542.110372] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[542.119936] Starting dynamic subtest: pipe-D-eDP-1
[545.242281] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[545.243110] Subtest 128x128-top-edge: SUCCESS (6.568s)
[546.042623] [103/133] (492s left) gem_mmap_offset (bad-object)
[546.087621] Starting subtest: bad-object
[546.088499] Subtest bad-object: SUCCESS (0.001s)
[546.168207] [104/133] (491s left) gem_userptr_blits (sync-unmap-cycles)
[546.229378] Starting subtest: sync-unmap-cycles
[551.609468] Subtest sync-unmap-cycles: SUCCESS (5.377s)
[551.736011] [105/133] (486s left) kms_lease (atomic-implicit-crtc)
[551.825995] Starting subtest: atomic-implicit-crtc
[551.826799] Starting dynamic subtest: pipe-A-eDP-1
[551.831913] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[551.843098] Starting dynamic subtest: pipe-B-eDP-1
[551.847852] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[551.856669] Starting dynamic subtest: pipe-C-eDP-1
[551.861117] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[551.870182] Starting dynamic subtest: pipe-D-eDP-1
[551.875027] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[551.875913] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[551.929341] [106/133] (486s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[551.979384] Starting subtest: multi-wait-available-unsubmitted-signaled
[551.980436] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[552.065501] [107/133] (486s left) kms_content_protection (atomic-dpms-hdcp14)
[552.209748] Starting subtest: atomic-dpms-hdcp14
[552.211612] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[552.336263] [108/133] (485s left) gem_ctx_bad_destroy (double-destroy)
[552.391950] Starting subtest: double-destroy
[552.392986] Subtest double-destroy: SUCCESS (0.000s)
[552.461646] [109/133] (485s left) api_intel_bb (destroy-bb)
[552.507213] Starting subtest: destroy-bb
[552.513909] Subtest destroy-bb: SUCCESS (0.007s)
[552.625613] [110/133] (485s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[552.716833] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[559.845102] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.127s)
[559.970297] [111/133] (478s left) kms_selftest (drm_plane_helper)
[560.007687] Starting subtest: drm_plane_helper
[560.052374] Starting dynamic subtest: drm_test_check_plane_state
[560.148022] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.096s)
[560.156658] Starting dynamic subtest: drm_test_check_invalid_plane_state
[560.256280] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.106s)
[560.257208] Subtest drm_plane_helper: SUCCESS (0.250s)
[560.397776] [112/133] (478s left) kms_vblank (ts-continuation-modeset-hang)
[560.493613] Starting subtest: ts-continuation-modeset-hang
[560.494767] Starting dynamic subtest: pipe-A-eDP-1
[587.023807] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.521s)
[587.033999] Starting dynamic subtest: pipe-D-eDP-1
[613.018639] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.994s)
[613.019515] Subtest ts-continuation-modeset-hang: SUCCESS (52.519s)
[613.869789] [113/133] (424s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[613.965608] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[613.967273] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[614.038765] [114/133] (424s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[614.128170] Starting subtest: yf-tiled-16bpp-rotate-180
[614.130225] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[614.213652] [115/133] (424s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[614.324508] Starting subtest: cursorA-vs-flipA-atomic
[625.441021] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.114s)
[626.300364] [116/133] (412s left) kms_flip (2x-flip-vs-panning-interruptible)
[626.396591] Starting subtest: 2x-flip-vs-panning-interruptible
[626.410222] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.013s)
[626.489889] [117/133] (412s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[626.578329] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[626.579260] Starting dynamic subtest: pipe-A-eDP-1
[627.953993] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.366s)
[628.237829] Starting dynamic subtest: pipe-B-eDP-1
[629.288686] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.051s)
[629.548085] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.967s)
[630.392747] [118/133] (408s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[630.486131] Starting subtest: psr2-overlay-plane-update-continuous-sf
[630.487050] Starting dynamic subtest: pipe-A-eDP-1
[631.609748] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.122s)
[631.630507] Starting dynamic subtest: pipe-B-eDP-1
[633.362433] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.752s)
[633.363254] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.877s)
[634.168809] [119/133] (404s left) gen9_exec_parse (unaligned-access)
[634.224340] Subtest unaligned-access: SKIP (0.000s)
[634.307113] [120/133] (404s left) kms_cursor_crc (cursor-random-256x85)
[634.555320] Starting subtest: cursor-random-256x85
[634.602621] Subtest cursor-random-256x85: SKIP (0.046s)
[634.778186] [121/133] (403s left) gem_lmem_swapping (massive)
[634.817700] Subtest massive: SKIP (0.000s)
[634.863960] [122/133] (403s left) kms_cursor_legacy (torture-move)
[634.979636] Starting subtest: torture-move
[634.980471] Starting dynamic subtest: pipe-A
[640.933881] Dynamic subtest pipe-A: SUCCESS (5.941s)
[640.947574] Starting dynamic subtest: pipe-B
[647.377742] Dynamic subtest pipe-B: SUCCESS (6.440s)
[647.400943] Starting dynamic subtest: pipe-C
[653.774617] Dynamic subtest pipe-C: SUCCESS (6.402s)
[653.784099] Starting dynamic subtest: pipe-D
[660.324238] Dynamic subtest pipe-D: SUCCESS (6.546s)
[660.333304] Starting dynamic subtest: all-pipes
[666.863098] Dynamic subtest all-pipes: SUCCESS (6.525s)
[666.864443] Subtest torture-move: SUCCESS (31.865s)
[667.010782] [123/133] (371s left) kms_async_flips (test-time-stamp-atomic)
[667.102542] Starting subtest: test-time-stamp-atomic
[667.489874] Starting dynamic subtest: pipe-A-eDP-1
[668.273211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.782s)
[668.670398] Starting dynamic subtest: pipe-B-eDP-1
[669.416732] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s)
[669.806466] Starting dynamic subtest: pipe-C-eDP-1
[670.562663] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[670.929808] Starting dynamic subtest: pipe-D-eDP-1
[671.698675] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s)
[671.699649] Subtest test-time-stamp-atomic: SUCCESS (4.595s)
[672.862760] [124/133] (365s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[672.965162] Starting subtest: y-tiled-32bpp-rotate-180
[672.966655] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[673.077382] [125/133] (365s left) perf_pmu (invalid-init)
[673.108701] Starting subtest: invalid-init
[673.109645] Subtest invalid-init: SUCCESS (0.000s)
[673.203455] [126/133] (365s left) kms_plane_multiple (tiling-none)
[673.284398] Starting subtest: tiling-none
[673.285315] Starting dynamic subtest: pipe-A-eDP-1
[677.020790] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.734s)
[677.029610] Starting dynamic subtest: pipe-B-eDP-1
[681.361321] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.338s)
[681.370208] Starting dynamic subtest: pipe-C-eDP-1
[685.688343] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.323s)
[685.700039] Starting dynamic subtest: pipe-D-eDP-1
[690.038713] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.349s)
[690.039643] Subtest tiling-none: SUCCESS (16.749s)
[690.837600] [127/133] (348s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[690.939914] Starting subtest: fbc-pr-sprite-mmap-gtt
[690.941873] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[691.010504] [128/133] (347s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[691.102498] Starting subtest: yf-tiled-8bpp-rotate-270
[691.104489] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[691.195001] [129/133] (347s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[691.274731] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[691.276575] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[691.360308] [130/133] (347s left) kms_getfb (getfb2-handle-zero)
[691.445855] Starting subtest: getfb2-handle-zero
[691.446783] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[691.527495] [131/133] (347s left) sw_sync (alloc_merge_fence)
[691.560031] Starting subtest: alloc_merge_fence
[691.560929] Subtest alloc_merge_fence: SUCCESS (0.000s)
[691.614942] [132/133] (347s left) kms_plane_scaling (planes-scaler-unity-scaling)
[691.702844] Starting subtest: planes-scaler-unity-scaling
[691.703971] Starting dynamic subtest: pipe-A
[691.764442] Dynamic subtest pipe-A: SUCCESS (0.064s)
[691.781765] Starting dynamic subtest: pipe-B
[692.868422] Dynamic subtest pipe-B: SUCCESS (1.102s)
[692.880636] Starting dynamic subtest: pipe-C
[693.981672] Dynamic subtest pipe-C: SUCCESS (1.111s)
[693.991023] Starting dynamic subtest: pipe-D
[695.110003] Dynamic subtest pipe-D: SUCCESS (1.127s)
[695.110901] Subtest planes-scaler-unity-scaling: SUCCESS (3.410s)
[696.273884] [133/133] (342s left) prime_self_import (basic-with_one_bo)
[696.303833] Starting subtest: basic-with_one_bo
[696.325206] Subtest basic-with_one_bo: SUCCESS (0.022s)
[696.434343] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: prime_vgem
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_exec_flush
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_cdclk
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: i915_pm_freq_api
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: kms_pm_dc
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_chamelium_edid
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_invalid_mode
results: parsing output: 21/ for test: gem_softpin
results: parsing output: 22/ for test: kms_pipe_crc_basic
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_softpin
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: i915_suspend
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_ctx_shared
results: parsing output: 35/ for test: fbdev
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: syncobj_eventfd
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: i915_pm_rps
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: sysfs_preempt_timeout
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_color
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_pipe_b_c_ivb
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_basic
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: dmabuf_sync_file
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_exec_parallel
results: parsing output: 83/ for test: sw_sync
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: kms_dsc
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: gem_ctx_engines
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_edge_walk
results: parsing output: 102/ for test: gem_mmap_offset
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: kms_lease
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: gem_ctx_bad_destroy
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_selftest
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_atomic_transition
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_lmem_swapping
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_async_flips
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: prime_self_import
Done.