[60.829331] Initializing watchdogs
[60.829377]   /dev/watchdog0
[60.843894] [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]
[60.848390] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.850632] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.852544] [001/133] (960s left) kms_plane (pixel-format-x-tiled-modifier)
[60.954920] Starting subtest: pixel-format-x-tiled-modifier
[60.993458] Starting dynamic subtest: pipe-A-plane-0
[61.633915] Dynamic subtest pipe-A-plane-0: SUCCESS (0.645s)
[61.645016] Starting dynamic subtest: pipe-A-plane-3
[62.042367] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[62.049706] Starting dynamic subtest: pipe-A-plane-5
[62.051732] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[63.117374] Starting dynamic subtest: pipe-B-plane-0
[63.740658] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[63.747539] Starting dynamic subtest: pipe-B-plane-3
[64.161536] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[64.172549] Starting dynamic subtest: pipe-B-plane-5
[64.174357] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[64.470620] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.535s)
[65.288876] [002/133] (956s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[65.683087] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[66.473413] [003/133] (954s left) gem_exec_capture (capture)
[66.531077] Starting subtest: capture
[66.532146] Starting dynamic subtest: rcs0-smem
[67.379191] Dynamic subtest rcs0-smem: SUCCESS (0.850s)
[67.391618] Starting dynamic subtest: bcs0-smem
[68.214851] Dynamic subtest bcs0-smem: SUCCESS (0.838s)
[68.224209] Starting dynamic subtest: vcs0-smem
[69.028693] Dynamic subtest vcs0-smem: SUCCESS (0.816s)
[69.036426] Starting dynamic subtest: vcs1-smem
[69.850051] Dynamic subtest vcs1-smem: SUCCESS (0.821s)
[69.856899] Starting dynamic subtest: vecs0-smem
[70.698788] Dynamic subtest vecs0-smem: FAIL (0.830s)
[70.705129] Starting dynamic subtest: ccs0-smem
[72.000656] Dynamic subtest ccs0-smem: SUCCESS (1.325s)
[72.001697] Subtest capture: FAIL (5.482s)
[72.129296] [004/133] (949s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[72.235166] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[72.237078] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[72.315909] [005/133] (949s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[72.428842] Starting subtest: 2x-flip-vs-cursor-legacy
[72.431550] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[72.579465] [006/133] (948s left) api_intel_allocator (gem-pool)
[72.633277] Starting subtest: gem-pool
[72.641578] Subtest gem-pool: SUCCESS (0.009s)
[72.798571] [007/133] (948s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[72.888065] Starting subtest: flip-primary-invalidate-overlay
[84.455637] Subtest flip-primary-invalidate-overlay: SUCCESS (11.573s)
[84.643673] [008/133] (936s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[84.744624] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[84.745608] Starting dynamic subtest: pipe-A-default-mode
[85.944856] Dynamic subtest pipe-A-default-mode: SKIP (1.199s)
[85.947034] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.200s)
[86.151100] [009/133] (935s left) sysfs_timeslice_duration (duration)
[86.218189] Starting subtest: duration
[86.219257] Starting dynamic subtest: vecs0
[99.901149] Dynamic subtest vecs0: SUCCESS (13.670s)
[99.907071] Starting dynamic subtest: ccs0
[113.066600] Dynamic subtest ccs0: SUCCESS (13.173s)
[113.075951] Starting dynamic subtest: vcs0
[126.909321] Dynamic subtest vcs0: SUCCESS (13.831s)
[126.915266] Starting dynamic subtest: bcs0
[140.041110] Dynamic subtest bcs0: SUCCESS (13.139s)
[140.051385] Starting dynamic subtest: rcs0
[153.233715] Dynamic subtest rcs0: SUCCESS (13.178s)
[153.245574] Starting dynamic subtest: vcs1
[166.908431] Dynamic subtest vcs1: SUCCESS (13.649s)
[166.909715] Subtest duration: SUCCESS (80.649s)
[166.992653] [010/133] (854s left) gem_ccs (ctrl-surf-copy)
[167.050597] Starting subtest: ctrl-surf-copy
[167.052581] Subtest ctrl-surf-copy: SKIP (0.000s)
[167.178662] [011/133] (854s left) gen9_exec_parse (batch-without-end)
[167.238351] Subtest batch-without-end: SKIP (0.000s)
[167.299633] [012/133] (854s left) gem_wait (await)
[167.363544] Starting subtest: await
[167.364500] Starting dynamic subtest: all-engines
[168.535239] Dynamic subtest all-engines: SUCCESS (1.170s)
[168.550835] Starting dynamic subtest: rcs0
[169.594726] Dynamic subtest rcs0: SUCCESS (1.058s)
[169.608270] Starting dynamic subtest: bcs0
[170.651069] Dynamic subtest bcs0: SUCCESS (1.054s)
[170.665302] Starting dynamic subtest: vcs0
[171.705887] Dynamic subtest vcs0: SUCCESS (1.053s)
[171.720623] Starting dynamic subtest: vcs1
[172.759519] Dynamic subtest vcs1: SUCCESS (1.052s)
[172.773038] Starting dynamic subtest: vecs0
[173.811600] Dynamic subtest vecs0: SUCCESS (1.050s)
[173.825484] Starting dynamic subtest: ccs0
[174.867231] Dynamic subtest ccs0: SUCCESS (1.054s)
[174.868362] Subtest await: SUCCESS (7.498s)
[175.068116] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[175.069619] [013/133] (846s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[175.110382] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[175.111497] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[175.237614] [014/133] (846s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[175.334814] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[179.229856] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.892s)
[180.351889] [015/133] (841s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[180.408194] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[180.409871] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[180.592669] [016/133] (841s left) kms_plane_scaling (planes-downscale-factor-0-5)
[180.691361] Starting subtest: planes-downscale-factor-0-5
[180.692351] Starting dynamic subtest: pipe-A
[180.710343] Dynamic subtest pipe-A: SKIP (0.018s)
[180.719616] Starting dynamic subtest: pipe-B
[180.742061] Dynamic subtest pipe-B: SKIP (0.032s)
[180.748639] Starting dynamic subtest: pipe-C
[180.778347] Dynamic subtest pipe-C: SKIP (0.036s)
[180.789669] Starting dynamic subtest: pipe-D
[180.815025] Dynamic subtest pipe-D: SKIP (0.036s)
[180.816727] Subtest planes-downscale-factor-0-5: SKIP (0.123s)
[180.948530] [017/133] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[181.044133] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[181.046062] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[181.150573] [018/133] (840s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[181.207447] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[181.209162] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[181.395539] [019/133] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[181.487992] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[181.489641] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[181.591193] [020/133] (840s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[181.683858] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[181.685938] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[181.798683] [021/133] (840s left) kms_content_protection (srm)
[181.931567] Starting subtest: srm
[181.934478] Subtest srm: SKIP (0.002s)
[182.057443] [022/133] (839s left) syncobj_wait (invalid-wait-illegal-handle)
[182.105061] Starting subtest: invalid-wait-illegal-handle
[182.106050] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[182.228325] [023/133] (839s left) gem_userptr_blits (input-checking)
[182.295123] Starting subtest: input-checking
[182.296084] Subtest input-checking: SUCCESS (0.000s)
[182.458625] [024/133] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[182.554341] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[182.555950] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[182.657730] [025/133] (839s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[182.763750] Starting subtest: psr-rgb565-draw-mmap-cpu
[189.621615] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.854s)
[189.724179] [026/133] (832s left) gem_exec_async (concurrent-writes)
[189.783944] Starting subtest: concurrent-writes
[189.785437] Starting dynamic subtest: rcs0
[189.799335] Dynamic subtest rcs0: SUCCESS (0.015s)
[189.807933] Starting dynamic subtest: bcs0
[189.808817] Dynamic subtest bcs0: SUCCESS (0.006s)
[189.815047] Starting dynamic subtest: vcs0
[189.816103] Dynamic subtest vcs0: SUCCESS (0.005s)
[189.822213] Starting dynamic subtest: vcs1
[189.823229] Dynamic subtest vcs1: SUCCESS (0.006s)
[189.829558] Starting dynamic subtest: vecs0
[189.830565] Dynamic subtest vecs0: SUCCESS (0.005s)
[189.836444] Starting dynamic subtest: ccs0
[189.837330] Dynamic subtest ccs0: SUCCESS (0.005s)
[189.838137] Subtest concurrent-writes: SUCCESS (0.044s)
[190.075755] [027/133] (832s left) gem_spin_batch (spin-all-new)
[190.139931] Starting subtest: spin-all-new
[190.153856] Subtest spin-all-new: SUCCESS (0.014s)
[191.938563] [028/133] (830s left) gem_eio (banned)
[192.144462] Starting subtest: banned
[192.748402] Subtest banned: SUCCESS (0.604s)
[192.915258] [029/133] (829s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[192.999046] Starting subtest: fbc-psr2-sprite-plane-onoff
[192.999976] Starting dynamic subtest: eDP-1
[193.001707] Dynamic subtest eDP-1: SKIP (0.000s)
[193.003539] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[193.089666] [030/133] (829s left) prime_mmap (test_map_unmap)
[193.154485] Starting subtest: test_map_unmap
[193.155460] Starting dynamic subtest: test_map_unmap-smem
[193.184770] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[193.185850] Subtest test_map_unmap: SUCCESS (0.032s)
[193.310191] [031/133] (829s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[193.417820] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[194.156599] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.527s)
[194.187011] [032/133] (828s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[194.283902] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[194.285684] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[194.413161] [033/133] (827s left) gem_ctx_persistence (many-contexts)
[194.475649] Starting subtest: many-contexts
[239.728393] Subtest many-contexts: SUCCESS (45.236s)
[239.812068] [034/133] (782s left) kms_cursor_crc (cursor-sliding-512x170)
[240.113227] Starting subtest: cursor-sliding-512x170
[240.115019] Subtest cursor-sliding-512x170: SKIP (0.001s)
[240.291341] [035/133] (782s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[240.408895] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[247.650299] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.240s)
[247.806189] [036/133] (774s left) gem_fence_thrash (bo-write-verify-threaded-x)
[247.836110] Starting subtest: bo-write-verify-threaded-x
[247.863391] Subtest bo-write-verify-threaded-x: SKIP (0.027s)
[247.930864] [037/133] (774s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[248.018395] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[254.750505] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.731s)
[254.880950] [038/133] (767s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[254.987254] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[255.932298] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.945s)
[256.113909] [039/133] (766s left) gem_exec_schedule (thriceslice)
[256.179339] Starting subtest: thriceslice
[256.180288] Starting dynamic subtest: rcs0
[256.207990] Dynamic subtest rcs0: SUCCESS (0.030s)
[256.217438] Starting dynamic subtest: bcs0
[256.235858] Dynamic subtest bcs0: SUCCESS (0.027s)
[256.242669] Starting dynamic subtest: vcs0
[256.265881] Dynamic subtest vcs0: SUCCESS (0.029s)
[256.273172] Starting dynamic subtest: vcs1
[256.316053] Dynamic subtest vcs1: SUCCESS (0.049s)
[256.326351] Starting dynamic subtest: vecs0
[256.346460] Dynamic subtest vecs0: SUCCESS (0.029s)
[256.353786] Starting dynamic subtest: ccs0
[256.377097] Dynamic subtest ccs0: SUCCESS (0.030s)
[256.378038] Subtest thriceslice: SUCCESS (0.199s)
[257.985944] [040/133] (764s left) i915_pm_rc6_residency (media-rc6-accuracy)
[258.040393] Starting subtest: media-rc6-accuracy
[258.042219] Subtest media-rc6-accuracy: SKIP (0.000s)
[258.145473] [041/133] (764s left) gem_exec_schedule (smoketest-all)
[258.201665] Starting subtest: smoketest-all
[290.557537] Subtest smoketest-all: SUCCESS (32.326s)
[291.990269] [042/133] (730s left) kms_lease (lease-invalid-crtc)
[292.089064] Starting subtest: lease-invalid-crtc
[292.089879] Starting dynamic subtest: pipe-A-eDP-1
[292.090817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[292.097841] Starting dynamic subtest: pipe-B-eDP-1
[292.098636] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[292.105125] Starting dynamic subtest: pipe-C-eDP-1
[292.105948] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[292.112372] Starting dynamic subtest: pipe-D-eDP-1
[292.113184] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[292.113927] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[292.183333] [043/133] (730s left) syncobj_timeline (single-wait-all-available-submitted)
[292.234383] Starting subtest: single-wait-all-available-submitted
[292.235333] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[292.370790] [044/133] (730s left) kms_atomic (plane-immutable-zpos)
[292.456967] Starting subtest: plane-immutable-zpos
[292.457769] Starting dynamic subtest: pipe-A-eDP-1
[293.089273] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[293.090089] Subtest plane-immutable-zpos: SUCCESS (0.633s)
[293.892536] [045/133] (728s left) gem_workarounds (basic-read-context)
[293.963428] Starting subtest: basic-read-context
[293.974047] Subtest basic-read-context: SUCCESS (0.011s)
[294.130742] [046/133] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[294.236809] Starting subtest: psr-1p-primscrn-spr-indfb-move
[301.775646] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.541s)
[301.949915] [047/133] (720s left) i915_query (query-topology-garbage-items)
[302.019552] Starting subtest: query-topology-garbage-items
[302.020602] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[302.137035] [048/133] (720s left) kms_sequence (get-busy)
[302.231380] Starting subtest: get-busy
[302.232290] Starting dynamic subtest: pipe-A-eDP-1
[304.169110] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[304.181069] Starting dynamic subtest: pipe-B-eDP-1
[306.785298] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.614s)
[306.792146] Starting dynamic subtest: pipe-C-eDP-1
[309.399419] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[309.410038] Starting dynamic subtest: pipe-D-eDP-1
[311.950174] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[311.951029] Subtest get-busy: SUCCESS (9.720s)
[312.756307] [049/133] (710s left) kms_hdr (static-swap)
[312.854300] Starting subtest: static-swap
[312.856941] Subtest static-swap: SKIP (0.000s)
[312.934728] [050/133] (710s left) kms_cursor_crc (cursor-offscreen-128x128)
[313.126387] Starting subtest: cursor-offscreen-128x128
[313.129822] Starting dynamic subtest: pipe-A-eDP-1
[315.062246] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[315.087941] Starting dynamic subtest: pipe-D-eDP-1
[317.692042] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.611s)
[317.693058] Subtest cursor-offscreen-128x128: SUCCESS (4.566s)
[318.522681] [051/133] (704s left) gem_eio (wait-wedge-immediate)
[318.771758] Starting subtest: wait-wedge-immediate
[319.974528] Subtest wait-wedge-immediate: SUCCESS (1.202s)
[320.131582] [052/133] (702s left) perf (gen8-unprivileged-single-ctx-counters)
[320.252855] Starting subtest: gen8-unprivileged-single-ctx-counters
[320.254630] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[320.294261] [053/133] (702s left) gem_exec_reloc (basic-gtt-read-noreloc)
[320.361810] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[320.438786] [054/133] (702s left) perf (per-context-mode-unprivileged)
[320.528031] Starting subtest: per-context-mode-unprivileged
[320.530261] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[320.561727] [055/133] (702s left) perf (global-sseu-config)
[320.646705] Starting subtest: global-sseu-config
[320.648568] Subtest global-sseu-config: SKIP (0.000s)
[320.683898] [056/133] (702s left) kms_flip (flip-vs-wf_vblank-interruptible)
[320.761353] Starting subtest: flip-vs-wf_vblank-interruptible
[320.763691] Starting dynamic subtest: A-eDP1
[322.660631] Dynamic subtest A-eDP1: SUCCESS (1.897s)
[322.670400] Starting dynamic subtest: B-eDP1
[324.589757] Dynamic subtest B-eDP1: SUCCESS (1.928s)
[324.602884] Starting dynamic subtest: C-eDP1
[326.514368] Dynamic subtest C-eDP1: SUCCESS (1.923s)
[326.521262] Starting dynamic subtest: D-eDP1
[328.443020] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[328.446426] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.683s)
[329.681024] [057/133] (693s left) kms_pm_rpm (system-suspend-idle)
[331.215102] Starting subtest: system-suspend-idle
[350.874050] Subtest system-suspend-idle: SUCCESS (4.817s)
[355.308464] [058/133] (672s left) gem_exec_whisper (basic-forked)
[355.385108] Starting subtest: basic-forked
[362.886968] Subtest basic-forked: SUCCESS (7.677s)
[363.076349] [059/133] (664s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[363.175696] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[363.177525] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[363.305662] [060/133] (664s left) gem_mmap_offset (open-flood)
[363.361291] Starting subtest: open-flood
[384.746732] Subtest open-flood: SUCCESS (21.490s)
[384.861584] [061/133] (642s left) gem_flink_basic (basic)
[384.923394] Starting subtest: basic
[384.924317] Subtest basic: SUCCESS (0.000s)
[385.051144] [062/133] (642s left) kms_chamelium_color (ctm-max)
[385.144815] Subtest ctm-max: SKIP (0.000s)
[385.185904] [063/133] (642s left) gem_exec_balancer (fairslice)
[385.246168] Starting subtest: fairslice
[388.256876] Subtest fairslice: SUCCESS (3.002s)
[388.858390] [064/133] (638s left) kms_psr (pr-sprite-blt)
[388.962853] Starting subtest: pr-sprite-blt
[388.965516] Subtest pr-sprite-blt: SKIP (0.000s)
[389.054049] [065/133] (638s left) gem_ctx_engines (execute-oneforall)
[389.120611] Starting subtest: execute-oneforall
[389.583278] Subtest execute-oneforall: SUCCESS (0.462s)
[390.871983] [066/133] (636s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[390.977184] Starting subtest: stress-xrgb8888-4tiled
[396.910227] Subtest stress-xrgb8888-4tiled: SUCCESS (5.933s)
[396.962130] [067/133] (630s left) kms_pm_rpm (dpms-non-lpsp)
[398.896125] Starting subtest: dpms-non-lpsp
[398.898305] Subtest dpms-non-lpsp: SKIP (0.001s)
[399.274400] [068/133] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[399.372443] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[399.374046] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[399.513732] [069/133] (628s left) kms_flip (wf_vblank-ts-check-interruptible)
[399.617822] Starting subtest: wf_vblank-ts-check-interruptible
[399.618896] Starting dynamic subtest: A-eDP1
[408.519110] Dynamic subtest A-eDP1: SUCCESS (8.879s)
[408.531962] Starting dynamic subtest: B-eDP1
[417.457945] Dynamic subtest B-eDP1: SUCCESS (8.940s)
[417.467695] Starting dynamic subtest: C-eDP1
[426.381824] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[426.390346] Starting dynamic subtest: D-eDP1
[435.275578] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[435.276513] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.670s)
[436.511161] [070/133] (591s left) syncobj_timeline (32bits-limit)
[436.570096] Starting subtest: 32bits-limit
[436.572786] Subtest 32bits-limit: SUCCESS (0.001s)
[436.698491] [071/133] (591s left) gem_mmap_gtt (medium-copy-xy)
[436.753086] Subtest medium-copy-XY: SKIP (0.000s)
[436.823310] [072/133] (591s left) kms_joiner (basic-big-joiner)
[436.922994] Starting subtest: basic-big-joiner
[436.924440] Subtest basic-big-joiner: SKIP (0.000s)
[437.001604] [073/133] (590s left) kms_dsc (dsc-with-formats)
[437.102227] Starting subtest: dsc-with-formats
[437.116817] Subtest dsc-with-formats: SKIP (0.001s)
[437.184545] [074/133] (590s left) kms_psr (psr2-primary-render)
[437.279854] Starting subtest: psr2-primary-render
[437.280733] Starting dynamic subtest: eDP-1
[438.994652] Dynamic subtest eDP-1: SUCCESS (1.715s)
[438.995485] Subtest psr2-primary-render: SUCCESS (1.716s)
[439.882230] [075/133] (588s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[439.967294] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[444.082624] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.117s)
[445.289277] [076/133] (582s left) kms_frontbuffer_tracking (fbc-stridechange)
[445.387723] Starting subtest: fbc-stridechange
[448.710877] Subtest fbc-stridechange: SUCCESS (3.332s)
[449.871711] [077/133] (578s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[450.021962] Starting subtest: flip-vs-cursor-legacy
[457.261215] Subtest flip-vs-cursor-legacy: SUCCESS (7.235s)
[458.098177] [078/133] (569s left) i915_drm_fdinfo (virtual-busy-all)
[458.140245] Starting subtest: virtual-busy-all
[458.141937] Subtest virtual-busy-all: SKIP (0.000s)
[458.220326] [079/133] (569s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[458.323424] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[458.324302] Starting dynamic subtest: pipe-A-eDP-1
[458.412385] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[458.421463] Starting dynamic subtest: pipe-B-eDP-1
[459.561691] Dynamic subtest pipe-B-eDP-1: SKIP (1.147s)
[459.563306] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.239s)
[460.762786] [080/133] (567s left) drm_read (invalid-buffer)
[460.904901] Starting subtest: invalid-buffer
[460.905999] Subtest invalid-buffer: SUCCESS (0.000s)
[461.070388] [081/133] (567s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[461.183540] Starting subtest: 4-tiled-64bpp-rotate-270
[461.202707] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[461.348639] [082/133] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[461.449694] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[468.014368] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.563s)
[468.180718] [083/133] (560s left) gem_lmem_swapping (verify)
[468.223484] Subtest verify: SKIP (0.000s)
[468.265988] [084/133] (559s left) gem_exec_flush (basic-uc-ro-default)
[468.331669] Starting subtest: basic-uc-ro-default
[473.792522] Subtest basic-uc-ro-default: SUCCESS (5.461s)
[474.000785] [085/133] (554s left) gem_ctx_param (get-priority-new-ctx)
[474.054439] Starting subtest: get-priority-new-ctx
[474.055420] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[474.183593] [086/133] (554s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[474.293293] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[474.295341] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[474.408465] [087/133] (553s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[474.452239] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[474.453176] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[474.577761] [088/133] (553s left) dumb_buffer (create-valid-dumb)
[474.621272] Starting subtest: create-valid-dumb
[474.622191] Subtest create-valid-dumb: SUCCESS (0.000s)
[474.745560] [089/133] (553s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[474.839124] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[474.840926] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[474.937994] [090/133] (553s left) kms_plane_scaling (invalid-num-scalers)
[475.022199] Starting subtest: invalid-num-scalers
[475.023081] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[475.041749] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[475.051638] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[475.077117] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[475.085391] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[475.112133] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[475.121187] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[475.148717] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[475.149568] Subtest invalid-num-scalers: SUCCESS (0.127s)
[475.268497] [091/133] (553s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[475.322700] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[475.389341] [092/133] (553s left) gem_pxp (create-valid-protected-context)
[475.493561] Starting subtest: create-valid-protected-context
[475.494600] Subtest create-valid-protected-context: SUCCESS (0.002s)
[475.610942] [093/133] (552s left) gem_lmem_evict (dontneed-evict-race)
[475.644456] Subtest dontneed-evict-race: SKIP (0.000s)
[475.679680] [094/133] (552s left) kms_psr (fbc-pr-primary-mmap-gtt)
[475.771029] Starting subtest: fbc-pr-primary-mmap-gtt
[475.772570] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[475.850240] [095/133] (552s left) perf_pmu (init-busy)
[475.884376] Starting subtest: init-busy
[475.885502] Starting dynamic subtest: rcs0
[475.886675] Dynamic subtest rcs0: SUCCESS (0.001s)
[475.896828] Starting dynamic subtest: bcs0
[475.897770] Dynamic subtest bcs0: SUCCESS (0.001s)
[475.907930] Starting dynamic subtest: vcs0
[475.908707] Dynamic subtest vcs0: SUCCESS (0.001s)
[475.916448] Starting dynamic subtest: vcs1
[475.917233] Dynamic subtest vcs1: SUCCESS (0.001s)
[475.924832] Starting dynamic subtest: vecs0
[475.925625] Dynamic subtest vecs0: SUCCESS (0.001s)
[475.933219] Starting dynamic subtest: ccs0
[475.934063] Dynamic subtest ccs0: SUCCESS (0.000s)
[475.934800] Subtest init-busy: SUCCESS (0.008s)
[475.996479] [096/133] (552s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[476.077183] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[476.078111] Starting dynamic subtest: pipe-A-eDP-1
[476.960454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.879s)
[476.971083] Starting dynamic subtest: pipe-B-eDP-1
[478.495811] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s)
[478.505418] Starting dynamic subtest: pipe-C-eDP-1
[480.015345] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s)
[480.025697] Starting dynamic subtest: pipe-D-eDP-1
[481.515855] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.500s)
[481.516738] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.436s)
[482.721253] [097/133] (545s left) gem_ctx_persistence (engines-cleanup)
[482.795445] Starting subtest: engines-cleanup
[482.796301] Starting dynamic subtest: rcs0
[482.840029] Dynamic subtest rcs0: SUCCESS (0.046s)
[482.848931] Starting dynamic subtest: bcs0
[482.943519] Dynamic subtest bcs0: SUCCESS (0.102s)
[482.956876] Starting dynamic subtest: vcs0
[483.015304] Dynamic subtest vcs0: SUCCESS (0.070s)
[483.027739] Starting dynamic subtest: vcs1
[483.078754] Dynamic subtest vcs1: SUCCESS (0.061s)
[483.090715] Starting dynamic subtest: vecs0
[483.128398] Dynamic subtest vecs0: SUCCESS (0.048s)
[483.141100] Starting dynamic subtest: ccs0
[483.150806] Dynamic subtest ccs0: SUCCESS (0.021s)
[483.151715] Subtest engines-cleanup: SUCCESS (0.357s)
[483.301015] [098/133] (545s left) syncobj_wait (invalid-signal-bad-pad)
[483.353427] Starting subtest: invalid-signal-bad-pad
[483.354333] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[483.448400] [099/133] (545s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[484.029544] Starting subtest: syncobj-stationary-timeline-chain-engines
[484.117038] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.099s)
[485.884511] [100/133] (542s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[486.005031] Starting subtest: flip-vs-cursor-crc-atomic
[486.664109] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.658s)
[487.533431] [101/133] (541s left) gem_reg_read (timestamp-moving)
[487.588077] Starting subtest: timestamp-moving
[488.595912] Subtest timestamp-moving: SUCCESS (1.001s)
[488.670715] [102/133] (540s left) kms_properties (crtc-properties-legacy)
[488.764186] Starting subtest: crtc-properties-legacy
[488.764991] Starting dynamic subtest: pipe-A-eDP-1
[489.200092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[489.211823] Starting dynamic subtest: pipe-B-eDP-1
[490.383368] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.183s)
[490.393088] Starting dynamic subtest: pipe-C-eDP-1
[491.510459] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[491.525492] Starting dynamic subtest: pipe-D-eDP-1
[492.642206] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[492.643046] Subtest crtc-properties-legacy: SUCCESS (3.879s)
[493.454725] [103/133] (535s left) syncobj_timeline (host-signal-ordered)
[493.516100] Starting subtest: host-signal-ordered
[493.517013] Subtest host-signal-ordered: SUCCESS (0.000s)
[493.632157] [104/133] (535s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[493.729421] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[493.730271] Starting dynamic subtest: pipe-A-eDP-1
[494.177454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[494.186047] Starting dynamic subtest: pipe-B-eDP-1
[495.590111] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[495.599488] Starting dynamic subtest: pipe-C-eDP-1
[496.951296] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s)
[496.959990] Starting dynamic subtest: pipe-D-eDP-1
[498.276236] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[498.277077] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.538s)
[499.518194] [105/133] (529s left) kms_color (ctm-green-to-red)
[499.609107] Starting subtest: ctm-green-to-red
[499.610010] Starting dynamic subtest: pipe-A-eDP-1
[500.283499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.675s)
[500.292133] Starting dynamic subtest: pipe-B-eDP-1
[501.712959] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.428s)
[501.723773] Starting dynamic subtest: pipe-C-eDP-1
[503.063427] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[503.071332] Starting dynamic subtest: pipe-D-eDP-1
[504.369288] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[504.370210] Subtest ctm-green-to-red: SUCCESS (4.762s)
[505.225682] [106/133] (523s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[505.326586] Starting subtest: x-tiled-64bpp-rotate-0
[506.849243] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.523s)
[507.017406] [107/133] (522s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[507.150590] Starting subtest: short-busy-flip-before-cursor-toggle
[507.152412] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[507.305369] [108/133] (521s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[507.398451] Starting subtest: addfb25-yf-tiled-legacy
[507.399407] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[507.530631] [109/133] (521s left) gem_tiling_max_stride
[507.658275] [110/133] (521s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[507.759017] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[514.439840] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.682s)
[514.596462] [111/133] (514s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[514.686918] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[514.688589] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[514.819939] [112/133] (514s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[515.034993] Starting subtest: cursor-rapid-movement-128x42
[515.081738] Subtest cursor-rapid-movement-128x42: SKIP (0.046s)
[515.315977] [113/133] (513s left) syncobj_eventfd (binary-wait)
[515.373206] Starting subtest: binary-wait
[515.383563] Subtest binary-wait: SUCCESS (0.010s)
[515.505104] [114/133] (513s left) i915_hangman (engine-engine-hang)
[515.570433] Starting subtest: engine-engine-hang
[515.571251] Starting dynamic subtest: rcs0
[516.728579] Dynamic subtest rcs0: SUCCESS (1.149s)
[516.740077] Starting dynamic subtest: bcs0
[518.712148] Dynamic subtest bcs0: SUCCESS (1.981s)
[518.723306] Starting dynamic subtest: vcs0
[520.696506] Dynamic subtest vcs0: SUCCESS (1.982s)
[520.707213] Starting dynamic subtest: vcs1
[522.745453] Dynamic subtest vcs1: SUCCESS (2.047s)
[522.765758] Starting dynamic subtest: vecs0
[524.664767] Dynamic subtest vecs0: SUCCESS (1.916s)
[524.675950] Starting dynamic subtest: ccs0
[526.712069] Dynamic subtest ccs0: SUCCESS (2.045s)
[526.713379] Subtest engine-engine-hang: SUCCESS (11.136s)
[526.792827] [115/133] (502s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[526.892982] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[526.893872] Starting dynamic subtest: pipe-A-eDP-1
[526.902560] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[526.911309] Starting dynamic subtest: pipe-B-eDP-1
[526.920227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[526.928480] Starting dynamic subtest: pipe-C-eDP-1
[526.936789] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[526.944679] Starting dynamic subtest: pipe-D-eDP-1
[526.974286] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[526.976913] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[529.214010] [116/133] (500s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[529.271936] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[529.374076] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[529.462140] [117/133] (499s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[529.508457] Starting subtest: multi-wait-all-for-submit-available-submitted
[529.509419] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[529.621870] [118/133] (499s left) kms_vblank (wait-idle)
[529.706186] Starting subtest: wait-idle
[529.707097] Starting dynamic subtest: pipe-A-eDP-1
[531.465010] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.759s)
[531.477892] Starting dynamic subtest: pipe-D-eDP-1
[533.952933] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.485s)
[533.953918] Subtest wait-idle: SUCCESS (4.247s)
[534.777785] [119/133] (494s left) gem_tiled_blits (normal)
[534.839190] Subtest normal: SKIP (0.000s)
[534.918786] [120/133] (494s left) kms_plane_multiple (tiling-y)
[535.008279] Starting subtest: tiling-y
[535.010045] Subtest tiling-y: SKIP (0.000s)
[535.093989] [121/133] (494s left) kms_chamelium_frames (dp-crc-multiple)
[535.477288] Subtest dp-crc-multiple: SKIP (0.000s)
[536.277727] [122/133] (493s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[536.364083] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[536.364959] Starting dynamic subtest: pipe-A-eDP-1
[536.372574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[536.381058] Starting dynamic subtest: pipe-B-eDP-1
[536.389150] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[536.397423] Starting dynamic subtest: pipe-C-eDP-1
[536.404948] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[536.413129] Starting dynamic subtest: pipe-D-eDP-1
[536.420279] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[536.421115] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[538.584143] [123/133] (491s left) api_intel_bb (object-noreloc-keep-cache-simple)
[538.634890] Starting subtest: object-noreloc-keep-cache-simple
[538.639329] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[538.768912] [124/133] (490s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[538.869488] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[538.871440] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[538.973817] [125/133] (490s left) kms_psr (fbc-psr2-sprite-blt)
[539.054099] Starting subtest: fbc-psr2-sprite-blt
[539.055051] Starting dynamic subtest: eDP-1
[539.056681] Dynamic subtest eDP-1: SKIP (0.000s)
[539.058320] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[539.148935] [126/133] (490s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[539.256988] Starting subtest: yf-tiled-8bpp-rotate-0
[539.258700] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[539.384513] [127/133] (490s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[539.500979] Starting subtest: cursorB-vs-flipA-legacy
[539.503736] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[539.654489] [128/133] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[539.750653] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[539.752611] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[539.874729] [129/133] (489s left) gem_exec_suspend (basic-s3-devices)
[539.933084] Starting subtest: basic-S3-devices
[539.933975] Starting dynamic subtest: smem
[551.706716] Dynamic subtest smem: SUCCESS (11.766s)
[551.708211] Subtest basic-S3-devices: SUCCESS (11.768s)
[556.947081] [130/133] (477s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[557.005836] Starting subtest: multi-wait-all-for-submit-signaled
[557.006898] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[557.127584] [131/133] (477s left) gem_exec_schedule (preemptive-hang)
[557.310689] Starting subtest: preemptive-hang
[557.311667] Starting dynamic subtest: rcs0
[566.912303] Dynamic subtest rcs0: SUCCESS (9.611s)
[566.927312] Starting dynamic subtest: bcs0
[575.930326] Dynamic subtest bcs0: SUCCESS (9.019s)
[575.939727] Starting dynamic subtest: vcs0
[584.886089] Dynamic subtest vcs0: SUCCESS (8.953s)
[584.898022] Starting dynamic subtest: vcs1
[593.914730] Dynamic subtest vcs1: SUCCESS (9.028s)
[593.923821] Starting dynamic subtest: vecs0
[602.871920] Dynamic subtest vecs0: SUCCESS (8.957s)
[602.882821] Starting dynamic subtest: ccs0
[611.899853] Dynamic subtest ccs0: SUCCESS (9.028s)
[611.901152] Subtest preemptive-hang: SUCCESS (54.603s)
[612.207094] [132/133] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[612.310576] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[612.312465] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[612.467842] [133/133] (422s left) gem_exec_fence (syncobj-unused-fence)
[612.921453] Starting subtest: syncobj-unused-fence
[612.924608] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[614.811513] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_chamelium_hpd
results: parsing output: 2/ for test: gem_exec_capture
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: api_intel_allocator
results: parsing output: 6/ for test: kms_psr_stress_test
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: sysfs_timeslice_duration
results: parsing output: 9/ for test: gem_ccs
results: parsing output: 10/ for test: gen9_exec_parse
results: parsing output: 11/ for test: gem_wait
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_content_protection
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_async
results: parsing output: 26/ for test: gem_spin_batch
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: prime_mmap
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_fence_thrash
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: i915_pm_rc6_residency
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_lease
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_atomic
results: parsing output: 44/ for test: gem_workarounds
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_sequence
results: parsing output: 48/ for test: kms_hdr
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: gem_flink_basic
results: parsing output: 61/ for test: kms_chamelium_color
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_ctx_engines
results: parsing output: 65/ for test: kms_pipe_stress
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_joiner
results: parsing output: 72/ for test: kms_dsc
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: i915_drm_fdinfo
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: drm_read
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_lmem_swapping
results: parsing output: 83/ for test: gem_exec_flush
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: dumb_buffer
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_pipe_b_c_ivb
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: gem_lmem_evict
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_reg_read
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_color
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: gem_tiling_max_stride
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: syncobj_eventfd
results: parsing output: 113/ for test: i915_hangman
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_vblank
results: parsing output: 118/ for test: gem_tiled_blits
results: parsing output: 119/ for test: kms_plane_multiple
results: parsing output: 120/ for test: kms_chamelium_frames
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_suspend
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_fence
Done.