[64.289824] Initializing watchdogs
[64.289870]   /dev/watchdog0
[64.304250] [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]
[64.308992] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.311297] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.314630] [001/133] (960s left) kms_plane (pixel-format-x-tiled-modifier)
[64.444548] Starting subtest: pixel-format-x-tiled-modifier
[64.482458] Starting dynamic subtest: pipe-A-plane-0
[65.105589] Dynamic subtest pipe-A-plane-0: SUCCESS (0.623s)
[65.112565] Starting dynamic subtest: pipe-A-plane-3
[65.568436] Dynamic subtest pipe-A-plane-3: SUCCESS (0.466s)
[65.576479] Starting dynamic subtest: pipe-A-plane-5
[65.580024] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[66.701802] Starting dynamic subtest: pipe-B-plane-0
[67.459873] Dynamic subtest pipe-B-plane-0: SUCCESS (0.767s)
[67.470483] Starting dynamic subtest: pipe-B-plane-3
[67.958945] Dynamic subtest pipe-B-plane-3: SUCCESS (0.499s)
[67.968063] Starting dynamic subtest: pipe-B-plane-5
[67.971769] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[68.268443] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.833s)
[69.099249] [002/133] (955s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[69.487328] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[70.276771] [003/133] (954s left) gem_exec_capture (capture)
[70.351311] Starting subtest: capture
[70.353693] Starting dynamic subtest: rcs0-smem
[71.191779] Dynamic subtest rcs0-smem: SUCCESS (0.839s)
[71.198564] Starting dynamic subtest: bcs0-smem
[72.172413] Dynamic subtest bcs0-smem: SUCCESS (0.981s)
[72.181484] Starting dynamic subtest: vcs0-smem
[72.988024] Dynamic subtest vcs0-smem: SUCCESS (0.818s)
[72.997876] Starting dynamic subtest: vcs1-smem
[73.808093] Dynamic subtest vcs1-smem: SUCCESS (0.820s)
[73.817598] Starting dynamic subtest: vecs0-smem
[75.215635] Dynamic subtest vecs0-smem: FAIL (1.349s)
[75.224428] Starting dynamic subtest: ccs0-smem
[76.481852] Dynamic subtest ccs0-smem: SUCCESS (1.324s)
[76.484060] Subtest capture: FAIL (6.133s)
[76.617339] [004/133] (948s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[76.730837] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[76.735116] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[76.805198] [005/133] (948s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[76.922913] Starting subtest: 2x-flip-vs-cursor-legacy
[76.928691] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[77.079632] [006/133] (947s left) api_intel_allocator (gem-pool)
[77.142037] Starting subtest: gem-pool
[77.148479] Subtest gem-pool: SUCCESS (0.008s)
[77.304007] [007/133] (947s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[77.408830] Starting subtest: flip-primary-invalidate-overlay
[88.959097] Subtest flip-primary-invalidate-overlay: SUCCESS (11.551s)
[89.126156] [008/133] (935s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[89.228034] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[89.229972] Starting dynamic subtest: pipe-A-default-mode
[90.349479] Dynamic subtest pipe-A-default-mode: SKIP (1.115s)
[90.353597] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.118s)
[90.503111] [009/133] (934s left) sysfs_timeslice_duration (duration)
[90.567715] Starting subtest: duration
[90.569883] Starting dynamic subtest: vecs0
[104.820799] Dynamic subtest vecs0: SUCCESS (14.252s)
[104.831893] Starting dynamic subtest: ccs0
[118.007855] Dynamic subtest ccs0: SUCCESS (13.186s)
[118.023274] Starting dynamic subtest: vcs0
[131.892175] Dynamic subtest vcs0: SUCCESS (13.881s)
[131.907292] Starting dynamic subtest: bcs0
[145.020230] Dynamic subtest bcs0: SUCCESS (13.128s)
[145.028049] Starting dynamic subtest: rcs0
[158.177133] Dynamic subtest rcs0: SUCCESS (13.154s)
[158.187540] Starting dynamic subtest: vcs1
[171.827702] Dynamic subtest vcs1: SUCCESS (13.647s)
[171.830625] Subtest duration: SUCCESS (81.257s)
[171.925088] [010/133] (853s left) gem_ccs (ctrl-surf-copy)
[171.994450] Starting subtest: ctrl-surf-copy
[171.998957] Subtest ctrl-surf-copy: SKIP (0.000s)
[172.129959] [011/133] (853s left) gen9_exec_parse (batch-without-end)
[172.198645] Subtest batch-without-end: SKIP (0.000s)
[172.261971] [012/133] (852s left) gem_wait (await)
[172.325387] Starting subtest: await
[172.327704] Starting dynamic subtest: all-engines
[173.511026] Dynamic subtest all-engines: SUCCESS (1.185s)
[173.529144] Starting dynamic subtest: rcs0
[174.566887] Dynamic subtest rcs0: SUCCESS (1.056s)
[174.580515] Starting dynamic subtest: bcs0
[175.623946] Dynamic subtest bcs0: SUCCESS (1.056s)
[175.638130] Starting dynamic subtest: vcs0
[176.678649] Dynamic subtest vcs0: SUCCESS (1.053s)
[176.692295] Starting dynamic subtest: vcs1
[177.731058] Dynamic subtest vcs1: SUCCESS (1.051s)
[177.748762] Starting dynamic subtest: vecs0
[178.784884] Dynamic subtest vecs0: SUCCESS (1.053s)
[178.800265] Starting dynamic subtest: ccs0
[179.841076] Dynamic subtest ccs0: SUCCESS (1.056s)
[179.843561] Subtest await: SUCCESS (7.516s)
[180.048857] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[180.051937] [013/133] (845s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[180.116117] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[180.118474] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[180.245493] [014/133] (845s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[180.363280] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[184.559821] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (4.199s)
[185.746327] [015/133] (839s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[185.822769] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[185.827305] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[186.015622] [016/133] (839s left) kms_plane_scaling (planes-downscale-factor-0-5)
[186.118944] Starting subtest: planes-downscale-factor-0-5
[186.121353] Starting dynamic subtest: pipe-A
[186.139384] Dynamic subtest pipe-A: SKIP (0.017s)
[186.148826] Starting dynamic subtest: pipe-B
[186.172250] Dynamic subtest pipe-B: SKIP (0.031s)
[186.180047] Starting dynamic subtest: pipe-C
[186.206132] Dynamic subtest pipe-C: SKIP (0.035s)
[186.213801] Starting dynamic subtest: pipe-D
[186.243507] Dynamic subtest pipe-D: SKIP (0.037s)
[186.247254] Subtest planes-downscale-factor-0-5: SKIP (0.122s)
[186.378257] [017/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[186.489239] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[186.493303] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[186.602565] [018/133] (838s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[186.676588] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[186.681266] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[186.869233] [019/133] (838s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[186.984723] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[186.988791] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[187.110971] [020/133] (838s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[187.219595] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[187.223609] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[187.349236] [021/133] (838s left) kms_content_protection (srm)
[187.485890] Starting subtest: srm
[187.492828] Subtest srm: SKIP (0.002s)
[187.648481] [022/133] (837s left) syncobj_wait (invalid-wait-illegal-handle)
[187.703027] Starting subtest: invalid-wait-illegal-handle
[187.705037] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[187.812010] [023/133] (837s left) gem_userptr_blits (input-checking)
[187.884753] Starting subtest: input-checking
[187.886605] Subtest input-checking: SUCCESS (0.000s)
[188.056769] [024/133] (837s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[188.154212] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[188.157878] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[188.278584] [025/133] (837s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[188.386272] Starting subtest: psr-rgb565-draw-mmap-cpu
[195.274758] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.892s)
[195.421648] [026/133] (830s left) gem_exec_async (concurrent-writes)
[195.494730] Starting subtest: concurrent-writes
[195.497127] Starting dynamic subtest: rcs0
[195.510041] Dynamic subtest rcs0: SUCCESS (0.015s)
[195.520325] Starting dynamic subtest: bcs0
[195.522465] Dynamic subtest bcs0: SUCCESS (0.006s)
[195.530097] Starting dynamic subtest: vcs0
[195.532019] Dynamic subtest vcs0: SUCCESS (0.005s)
[195.539668] Starting dynamic subtest: vcs1
[195.542012] Dynamic subtest vcs1: SUCCESS (0.005s)
[195.549566] Starting dynamic subtest: vecs0
[195.551781] Dynamic subtest vecs0: SUCCESS (0.006s)
[195.559115] Starting dynamic subtest: ccs0
[195.561232] Dynamic subtest ccs0: SUCCESS (0.005s)
[195.563357] Subtest concurrent-writes: SUCCESS (0.045s)
[195.816734] [027/133] (830s left) gem_spin_batch (spin-all-new)
[195.876377] Starting subtest: spin-all-new
[195.889388] Subtest spin-all-new: SUCCESS (0.014s)
[197.975848] [028/133] (827s left) gem_eio (banned)
[198.203711] Starting subtest: banned
[198.824031] Subtest banned: SUCCESS (0.621s)
[199.034855] [029/133] (826s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[199.133300] Starting subtest: fbc-psr2-sprite-plane-onoff
[199.134923] Starting dynamic subtest: eDP-1
[199.138444] Dynamic subtest eDP-1: SKIP (0.000s)
[199.141849] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[199.215634] [030/133] (826s left) prime_mmap (test_map_unmap)
[199.279368] Starting subtest: test_map_unmap
[199.281020] Starting dynamic subtest: test_map_unmap-smem
[199.311939] Dynamic subtest test_map_unmap-smem: SUCCESS (0.034s)
[199.314067] Subtest test_map_unmap: SUCCESS (0.034s)
[199.437518] [031/133] (826s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[199.550940] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[200.660918] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.518s)
[200.728449] [032/133] (825s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[200.838180] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[200.841514] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[200.938537] [033/133] (825s left) gem_ctx_persistence (many-contexts)
[201.005646] Starting subtest: many-contexts
[246.245274] Subtest many-contexts: SUCCESS (45.237s)
[246.324526] [034/133] (779s left) kms_cursor_crc (cursor-sliding-512x170)
[246.618759] Starting subtest: cursor-sliding-512x170
[246.623301] Subtest cursor-sliding-512x170: SKIP (0.001s)
[246.814760] [035/133] (779s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[246.929140] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[254.136544] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.211s)
[254.296378] [036/133] (771s left) gem_fence_thrash (bo-write-verify-threaded-x)
[254.330205] Starting subtest: bo-write-verify-threaded-x
[254.358232] Subtest bo-write-verify-threaded-x: SKIP (0.023s)
[254.428253] [037/133] (771s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[254.532429] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[261.242096] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.713s)
[261.378857] [038/133] (764s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[261.483947] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[262.474602] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.990s)
[262.620046] [039/133] (763s left) gem_exec_schedule (thriceslice)
[262.696132] Starting subtest: thriceslice
[262.698360] Starting dynamic subtest: rcs0
[262.714432] Dynamic subtest rcs0: SUCCESS (0.029s)
[262.725246] Starting dynamic subtest: bcs0
[262.761742] Dynamic subtest bcs0: SUCCESS (0.047s)
[262.772618] Starting dynamic subtest: vcs0
[262.790852] Dynamic subtest vcs0: SUCCESS (0.028s)
[262.798513] Starting dynamic subtest: vcs1
[262.841721] Dynamic subtest vcs1: SUCCESS (0.049s)
[262.852471] Starting dynamic subtest: vecs0
[262.870090] Dynamic subtest vecs0: SUCCESS (0.028s)
[262.878364] Starting dynamic subtest: ccs0
[262.900579] Dynamic subtest ccs0: SUCCESS (0.030s)
[262.902503] Subtest thriceslice: SUCCESS (0.216s)
[263.212084] [040/133] (763s left) i915_pm_rc6_residency (media-rc6-accuracy)
[263.279677] Starting subtest: media-rc6-accuracy
[263.284193] Subtest media-rc6-accuracy: SKIP (0.000s)
[263.415121] [041/133] (763s left) gem_exec_schedule (smoketest-all)
[263.499685] Starting subtest: smoketest-all
[295.880160] Subtest smoketest-all: SUCCESS (32.335s)
[296.974027] [042/133] (729s left) kms_lease (lease-invalid-crtc)
[297.076349] Starting subtest: lease-invalid-crtc
[297.078687] Starting dynamic subtest: pipe-A-eDP-1
[297.080970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[297.090074] Starting dynamic subtest: pipe-B-eDP-1
[297.092601] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[297.100687] Starting dynamic subtest: pipe-C-eDP-1
[297.102824] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[297.110581] Starting dynamic subtest: pipe-D-eDP-1
[297.112432] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[297.114281] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[297.158693] [043/133] (729s left) syncobj_timeline (single-wait-all-available-submitted)
[297.217097] Starting subtest: single-wait-all-available-submitted
[297.219490] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[297.343936] [044/133] (729s left) kms_atomic (plane-immutable-zpos)
[297.435759] Starting subtest: plane-immutable-zpos
[297.438051] Starting dynamic subtest: pipe-A-eDP-1
[298.078937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[298.081274] Subtest plane-immutable-zpos: SUCCESS (0.644s)
[298.892165] [045/133] (727s left) gem_workarounds (basic-read-context)
[298.967090] Starting subtest: basic-read-context
[298.977615] Subtest basic-read-context: SUCCESS (0.010s)
[299.149481] [046/133] (727s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[299.253635] Starting subtest: psr-1p-primscrn-spr-indfb-move
[306.859383] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.610s)
[307.019474] [047/133] (719s left) i915_query (query-topology-garbage-items)
[307.087272] Starting subtest: query-topology-garbage-items
[307.089673] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[307.199837] [048/133] (719s left) kms_sequence (get-busy)
[307.291129] Starting subtest: get-busy
[307.293072] Starting dynamic subtest: pipe-A-eDP-1
[309.234958] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[309.244801] Starting dynamic subtest: pipe-B-eDP-1
[311.822054] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.586s)
[311.830298] Starting dynamic subtest: pipe-C-eDP-1
[314.414754] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.594s)
[314.424820] Starting dynamic subtest: pipe-D-eDP-1
[316.970437] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.552s)
[316.972742] Subtest get-busy: SUCCESS (9.679s)
[317.781815] [049/133] (709s left) kms_hdr (static-swap)
[317.893664] Starting subtest: static-swap
[317.900093] Subtest static-swap: SKIP (0.000s)
[317.977704] [050/133] (708s left) kms_cursor_crc (cursor-offscreen-128x128)
[318.202329] Starting subtest: cursor-offscreen-128x128
[318.207117] Starting dynamic subtest: pipe-A-eDP-1
[320.149300] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[320.177129] Starting dynamic subtest: pipe-D-eDP-1
[322.770494] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[322.772390] Subtest cursor-offscreen-128x128: SUCCESS (4.566s)
[323.654413] [051/133] (703s left) gem_eio (wait-wedge-immediate)
[323.916509] Starting subtest: wait-wedge-immediate
[324.966916] Subtest wait-wedge-immediate: SUCCESS (1.051s)
[325.140798] [052/133] (701s left) perf (gen8-unprivileged-single-ctx-counters)
[325.273302] Starting subtest: gen8-unprivileged-single-ctx-counters
[325.277302] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[325.314554] [053/133] (701s left) gem_exec_reloc (basic-gtt-read-noreloc)
[325.389231] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[325.486934] [054/133] (701s left) perf (per-context-mode-unprivileged)
[325.588050] Starting subtest: per-context-mode-unprivileged
[325.592612] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[325.631536] [055/133] (701s left) perf (global-sseu-config)
[325.717290] Starting subtest: global-sseu-config
[325.721863] Subtest global-sseu-config: SKIP (0.000s)
[325.763799] [056/133] (701s left) kms_flip (flip-vs-wf_vblank-interruptible)
[325.865449] Starting subtest: flip-vs-wf_vblank-interruptible
[325.867455] Starting dynamic subtest: A-eDP1
[327.790221] Dynamic subtest A-eDP1: SUCCESS (1.924s)
[327.800950] Starting dynamic subtest: B-eDP1
[329.715399] Dynamic subtest B-eDP1: SUCCESS (1.924s)
[329.723955] Starting dynamic subtest: C-eDP1
[331.637691] Dynamic subtest C-eDP1: SUCCESS (1.921s)
[331.647326] Starting dynamic subtest: D-eDP1
[333.476770] Dynamic subtest D-eDP1: SUCCESS (1.838s)
[333.479066] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.615s)
[334.718614] [057/133] (692s left) kms_pm_rpm (system-suspend-idle)
[336.244946] Starting subtest: system-suspend-idle
[356.233095] Subtest system-suspend-idle: SUCCESS (5.115s)
[361.652992] [058/133] (670s left) gem_exec_whisper (basic-forked)
[361.733925] Starting subtest: basic-forked
[369.440360] Subtest basic-forked: SUCCESS (7.847s)
[369.637164] [059/133] (662s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[369.736984] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[369.741391] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[369.856099] [060/133] (662s left) gem_mmap_offset (open-flood)
[369.912623] Starting subtest: open-flood
[391.327886] Subtest open-flood: SUCCESS (21.490s)
[391.469989] [061/133] (640s left) gem_flink_basic (basic)
[391.535133] Starting subtest: basic
[391.537171] Subtest basic: SUCCESS (0.000s)
[391.650088] [062/133] (640s left) kms_chamelium_color (ctm-max)
[391.753825] Subtest ctm-max: SKIP (0.000s)
[391.798210] [063/133] (640s left) gem_exec_balancer (fairslice)
[391.850240] Starting subtest: fairslice
[394.749335] Subtest fairslice: SUCCESS (2.896s)
[395.873090] [064/133] (636s left) kms_psr (pr-sprite-blt)
[395.977232] Starting subtest: pr-sprite-blt
[395.981555] Subtest pr-sprite-blt: SKIP (0.000s)
[396.061404] [065/133] (636s left) gem_ctx_engines (execute-oneforall)
[396.127837] Starting subtest: execute-oneforall
[396.605009] Subtest execute-oneforall: SUCCESS (0.477s)
[397.962319] [066/133] (634s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[398.067601] Starting subtest: stress-xrgb8888-4tiled
[403.896145] Subtest stress-xrgb8888-4tiled: SUCCESS (5.830s)
[403.945134] [067/133] (628s left) kms_pm_rpm (dpms-non-lpsp)
[405.970737] Starting subtest: dpms-non-lpsp
[405.976462] Subtest dpms-non-lpsp: SKIP (0.001s)
[406.372088] [068/133] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[406.479917] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[406.483972] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[406.594573] [069/133] (626s left) kms_flip (wf_vblank-ts-check-interruptible)
[406.688073] Starting subtest: wf_vblank-ts-check-interruptible
[406.690447] Starting dynamic subtest: A-eDP1
[415.574777] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[415.586218] Starting dynamic subtest: B-eDP1
[424.501236] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[424.513028] Starting dynamic subtest: C-eDP1
[433.419598] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[433.429355] Starting dynamic subtest: D-eDP1
[442.268015] Dynamic subtest D-eDP1: SUCCESS (8.850s)
[442.270386] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.596s)
[443.520328] [070/133] (589s left) syncobj_timeline (32bits-limit)
[443.575747] Starting subtest: 32bits-limit
[443.578027] Subtest 32bits-limit: SUCCESS (0.001s)
[443.690669] [071/133] (589s left) gem_mmap_gtt (medium-copy-xy)
[443.757040] Subtest medium-copy-XY: SKIP (0.000s)
[443.828456] [072/133] (588s left) kms_joiner (basic-big-joiner)
[443.930897] Starting subtest: basic-big-joiner
[443.934965] Subtest basic-big-joiner: SKIP (0.000s)
[444.014417] [073/133] (588s left) kms_dsc (dsc-with-formats)
[444.122577] Starting subtest: dsc-with-formats
[444.160837] Subtest dsc-with-formats: SKIP (0.001s)
[444.206176] [074/133] (588s left) kms_psr (psr2-primary-render)
[444.295942] Starting subtest: psr2-primary-render
[444.298120] Starting dynamic subtest: eDP-1
[445.976918] Dynamic subtest eDP-1: SUCCESS (1.681s)
[445.979092] Subtest psr2-primary-render: SUCCESS (1.682s)
[446.868837] [075/133] (586s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[446.979924] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[450.941678] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.970s)
[452.088728] [076/133] (580s left) kms_frontbuffer_tracking (fbc-stridechange)
[452.183733] Starting subtest: fbc-stridechange
[455.517541] Subtest fbc-stridechange: SUCCESS (3.334s)
[456.704068] [077/133] (576s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[456.825706] Starting subtest: flip-vs-cursor-legacy
[463.929986] Subtest flip-vs-cursor-legacy: SUCCESS (7.102s)
[464.817345] [078/133] (568s left) i915_drm_fdinfo (virtual-busy-all)
[464.862005] Starting subtest: virtual-busy-all
[464.866469] Subtest virtual-busy-all: SKIP (0.000s)
[464.939158] [079/133] (568s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[465.053629] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[465.055955] Starting dynamic subtest: pipe-A-eDP-1
[465.149910] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[465.160704] Starting dynamic subtest: pipe-B-eDP-1
[466.279773] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[466.284211] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.230s)
[467.574442] [080/133] (565s left) drm_read (invalid-buffer)
[467.727246] Starting subtest: invalid-buffer
[467.729320] Subtest invalid-buffer: SUCCESS (0.000s)
[467.887910] [081/133] (565s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[467.994578] Starting subtest: 4-tiled-64bpp-rotate-270
[468.013586] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.018s)
[468.164829] [082/133] (565s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[468.273619] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[474.824409] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.552s)
[474.951120] [083/133] (558s left) gem_lmem_swapping (verify)
[474.997483] Subtest verify: SKIP (0.000s)
[475.047673] [084/133] (558s left) gem_exec_flush (basic-uc-ro-default)
[475.114528] Starting subtest: basic-uc-ro-default
[480.567162] Subtest basic-uc-ro-default: SUCCESS (5.451s)
[480.762307] [085/133] (552s left) gem_ctx_param (get-priority-new-ctx)
[480.823119] Starting subtest: get-priority-new-ctx
[480.825254] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[480.964165] [086/133] (552s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[481.076985] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[481.081373] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[481.206414] [087/133] (552s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[481.260599] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[481.262489] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[481.372598] [088/133] (552s left) dumb_buffer (create-valid-dumb)
[481.425529] Starting subtest: create-valid-dumb
[481.427397] Subtest create-valid-dumb: SUCCESS (0.000s)
[481.532660] [089/133] (551s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[481.627067] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[481.631421] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[481.711961] [090/133] (551s left) kms_plane_scaling (invalid-num-scalers)
[481.815820] Starting subtest: invalid-num-scalers
[481.817728] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[481.835152] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[481.844229] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[481.876836] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.041s)
[481.885795] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[481.918447] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.039s)
[481.929457] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[481.955718] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[481.957485] Subtest invalid-num-scalers: SUCCESS (0.142s)
[482.076430] [091/133] (551s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[482.144652] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[482.200868] [092/133] (551s left) gem_pxp (create-valid-protected-context)
[482.321290] Starting subtest: create-valid-protected-context
[482.323263] Subtest create-valid-protected-context: SUCCESS (0.002s)
[482.459601] [093/133] (551s left) gem_lmem_evict (dontneed-evict-race)
[482.499249] Subtest dontneed-evict-race: SKIP (0.000s)
[482.542849] [094/133] (551s left) kms_psr (fbc-pr-primary-mmap-gtt)
[482.627527] Starting subtest: fbc-pr-primary-mmap-gtt
[482.630973] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[482.709978] [095/133] (551s left) perf_pmu (init-busy)
[482.746547] Starting subtest: init-busy
[482.748435] Starting dynamic subtest: rcs0
[482.750364] Dynamic subtest rcs0: SUCCESS (0.001s)
[482.762192] Starting dynamic subtest: bcs0
[482.763874] Dynamic subtest bcs0: SUCCESS (0.000s)
[482.772775] Starting dynamic subtest: vcs0
[482.774386] Dynamic subtest vcs0: SUCCESS (0.001s)
[482.782998] Starting dynamic subtest: vcs1
[482.784605] Dynamic subtest vcs1: SUCCESS (0.001s)
[482.793252] Starting dynamic subtest: vecs0
[482.794894] Dynamic subtest vecs0: SUCCESS (0.001s)
[482.803342] Starting dynamic subtest: ccs0
[482.804927] Dynamic subtest ccs0: SUCCESS (0.000s)
[482.806499] Subtest init-busy: SUCCESS (0.007s)
[482.921675] [096/133] (550s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[483.010347] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[483.012313] Starting dynamic subtest: pipe-A-eDP-1
[483.813833] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[483.828442] Starting dynamic subtest: pipe-B-eDP-1
[485.415928] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.600s)
[485.427748] Starting dynamic subtest: pipe-C-eDP-1
[486.910994] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.491s)
[486.921341] Starting dynamic subtest: pipe-D-eDP-1
[488.436904] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[488.439224] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.419s)
[489.628791] [097/133] (544s left) gem_ctx_persistence (engines-cleanup)
[489.692736] Starting subtest: engines-cleanup
[489.695128] Starting dynamic subtest: rcs0
[489.792175] Dynamic subtest rcs0: SUCCESS (0.099s)
[489.804719] Starting dynamic subtest: bcs0
[489.843845] Dynamic subtest bcs0: SUCCESS (0.050s)
[489.855402] Starting dynamic subtest: vcs0
[489.862909] Dynamic subtest vcs0: SUCCESS (0.017s)
[489.872213] Starting dynamic subtest: vcs1
[489.962864] Dynamic subtest vcs1: SUCCESS (0.099s)
[489.975028] Starting dynamic subtest: vecs0
[489.986501] Dynamic subtest vecs0: SUCCESS (0.022s)
[489.995894] Starting dynamic subtest: ccs0
[490.082501] Dynamic subtest ccs0: SUCCESS (0.094s)
[490.085159] Subtest engines-cleanup: SUCCESS (0.390s)
[490.185721] [098/133] (543s left) syncobj_wait (invalid-signal-bad-pad)
[490.240685] Starting subtest: invalid-signal-bad-pad
[490.242938] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[490.382510] [099/133] (543s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[490.935848] Starting subtest: syncobj-stationary-timeline-chain-engines
[491.036011] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.101s)
[491.883886] [100/133] (542s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[491.990903] Starting subtest: flip-vs-cursor-crc-atomic
[492.680564] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.690s)
[493.569160] [101/133] (540s left) gem_reg_read (timestamp-moving)
[493.624393] Starting subtest: timestamp-moving
[494.626306] Subtest timestamp-moving: SUCCESS (1.001s)
[494.713870] [102/133] (539s left) kms_properties (crtc-properties-legacy)
[494.811471] Starting subtest: crtc-properties-legacy
[494.813820] Starting dynamic subtest: pipe-A-eDP-1
[495.255436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[495.266465] Starting dynamic subtest: pipe-B-eDP-1
[496.410713] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s)
[496.423888] Starting dynamic subtest: pipe-C-eDP-1
[497.538777] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[497.550008] Starting dynamic subtest: pipe-D-eDP-1
[498.668461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[498.670618] Subtest crtc-properties-legacy: SUCCESS (3.857s)
[499.503698] [103/133] (534s left) syncobj_timeline (host-signal-ordered)
[499.566649] Starting subtest: host-signal-ordered
[499.568990] Subtest host-signal-ordered: SUCCESS (0.000s)
[499.684480] [104/133] (534s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[499.772495] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[499.774725] Starting dynamic subtest: pipe-A-eDP-1
[500.316121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.515s)
[500.328133] Starting dynamic subtest: pipe-B-eDP-1
[501.728096] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.411s)
[501.738420] Starting dynamic subtest: pipe-C-eDP-1
[503.088887] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[503.100284] Starting dynamic subtest: pipe-D-eDP-1
[504.420939] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[504.423137] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.623s)
[505.642570] [105/133] (528s left) kms_color (ctm-green-to-red)
[505.743515] Starting subtest: ctm-green-to-red
[505.745403] Starting dynamic subtest: pipe-A-eDP-1
[506.422056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.681s)
[506.432190] Starting dynamic subtest: pipe-B-eDP-1
[507.781616] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.358s)
[507.792221] Starting dynamic subtest: pipe-C-eDP-1
[509.077292] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s)
[509.087652] Starting dynamic subtest: pipe-D-eDP-1
[510.410947] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[510.413070] Subtest ctm-green-to-red: SUCCESS (4.669s)
[511.244014] [106/133] (522s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[511.351434] Starting subtest: x-tiled-64bpp-rotate-0
[512.882802] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.536s)
[513.073786] [107/133] (521s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[513.195352] Starting subtest: short-busy-flip-before-cursor-toggle
[513.199660] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[513.349624] [108/133] (520s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[513.462470] Starting subtest: addfb25-yf-tiled-legacy
[513.464759] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[513.593630] [109/133] (520s left) gem_tiling_max_stride
[513.719526] [110/133] (520s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[513.823023] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[520.411361] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.592s)
[520.560527] [111/133] (513s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[520.658834] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[520.662881] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[520.774868] [112/133] (513s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[520.999078] Starting subtest: cursor-rapid-movement-128x42
[521.048224] Subtest cursor-rapid-movement-128x42: SKIP (0.046s)
[521.287125] [113/133] (513s left) syncobj_eventfd (binary-wait)
[521.348686] Starting subtest: binary-wait
[521.358776] Subtest binary-wait: SUCCESS (0.010s)
[521.466185] [114/133] (513s left) i915_hangman (engine-engine-hang)
[521.528189] Starting subtest: engine-engine-hang
[521.530115] Starting dynamic subtest: rcs0
[522.769304] Dynamic subtest rcs0: SUCCESS (1.240s)
[522.782471] Starting dynamic subtest: bcs0
[524.753172] Dynamic subtest bcs0: SUCCESS (1.981s)
[524.765965] Starting dynamic subtest: vcs0
[526.736358] Dynamic subtest vcs0: SUCCESS (1.981s)
[526.753262] Starting dynamic subtest: vcs1
[528.721307] Dynamic subtest vcs1: SUCCESS (1.983s)
[528.737265] Starting dynamic subtest: vecs0
[530.704968] Dynamic subtest vecs0: SUCCESS (1.981s)
[530.717206] Starting dynamic subtest: ccs0
[532.754320] Dynamic subtest ccs0: SUCCESS (2.047s)
[532.757192] Subtest engine-engine-hang: SUCCESS (11.229s)
[532.850317] [115/133] (501s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[532.949527] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[532.951789] Starting dynamic subtest: pipe-A-eDP-1
[532.974413] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[532.984969] Starting dynamic subtest: pipe-B-eDP-1
[533.006295] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[533.015210] Starting dynamic subtest: pipe-C-eDP-1
[533.036658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[533.045763] Starting dynamic subtest: pipe-D-eDP-1
[533.067355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[533.071395] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[535.134988] [116/133] (499s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[535.204691] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[535.310857] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[535.401371] [117/133] (499s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[535.472865] Starting subtest: multi-wait-all-for-submit-available-submitted
[535.475115] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[535.594805] [118/133] (499s left) kms_vblank (wait-idle)
[535.693560] Starting subtest: wait-idle
[535.695586] Starting dynamic subtest: pipe-A-eDP-1
[537.458562] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.766s)
[537.477935] Starting dynamic subtest: pipe-D-eDP-1
[539.873952] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.413s)
[539.876256] Subtest wait-idle: SUCCESS (4.183s)
[540.711845] [119/133] (494s left) gem_tiled_blits (normal)
[540.779000] Subtest normal: SKIP (0.000s)
[540.862586] [120/133] (493s left) kms_plane_multiple (tiling-y)
[540.965296] Starting subtest: tiling-y
[540.969644] Subtest tiling-y: SKIP (0.000s)
[541.052118] [121/133] (493s left) kms_chamelium_frames (dp-crc-multiple)
[541.455206] Subtest dp-crc-multiple: SKIP (0.000s)
[542.315987] [122/133] (492s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[542.415830] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[542.417934] Starting dynamic subtest: pipe-A-eDP-1
[542.438756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[542.450429] Starting dynamic subtest: pipe-B-eDP-1
[542.470000] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[542.479858] Starting dynamic subtest: pipe-C-eDP-1
[542.499461] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[542.509197] Starting dynamic subtest: pipe-D-eDP-1
[542.528456] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[542.530623] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.008s)
[544.717273] [123/133] (490s left) api_intel_bb (object-noreloc-keep-cache-simple)
[544.786317] Starting subtest: object-noreloc-keep-cache-simple
[544.791114] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[544.963807] [124/133] (489s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[545.076180] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[545.080357] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[545.200998] [125/133] (489s left) kms_psr (fbc-psr2-sprite-blt)
[545.301416] Starting subtest: fbc-psr2-sprite-blt
[545.303679] Starting dynamic subtest: eDP-1
[545.307944] Dynamic subtest eDP-1: SKIP (0.000s)
[545.312226] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[545.390267] [126/133] (489s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[545.500350] Starting subtest: yf-tiled-8bpp-rotate-0
[545.504292] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[545.622100] [127/133] (489s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[545.746230] Starting subtest: cursorB-vs-flipA-legacy
[545.749668] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[545.901241] [128/133] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[546.001793] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[546.005047] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[546.123370] [129/133] (489s left) gem_exec_suspend (basic-s3-devices)
[546.192198] Starting subtest: basic-S3-devices
[546.194024] Starting dynamic subtest: smem
[557.744940] Dynamic subtest smem: SUCCESS (11.555s)
[557.747349] Subtest basic-S3-devices: SUCCESS (11.556s)
[565.962123] [130/133] (477s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[566.039109] Starting subtest: multi-wait-all-for-submit-signaled
[566.041505] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[566.173912] [131/133] (477s left) gem_exec_schedule (preemptive-hang)
[566.353413] Starting subtest: preemptive-hang
[566.355763] Starting dynamic subtest: rcs0
[575.965791] Dynamic subtest rcs0: SUCCESS (9.616s)
[575.977994] Starting dynamic subtest: bcs0
[584.925044] Dynamic subtest bcs0: SUCCESS (8.956s)
[584.935056] Starting dynamic subtest: vcs0
[593.948054] Dynamic subtest vcs0: SUCCESS (9.020s)
[593.958312] Starting dynamic subtest: vcs1
[602.970240] Dynamic subtest vcs1: SUCCESS (9.024s)
[602.982323] Starting dynamic subtest: vecs0
[611.926771] Dynamic subtest vecs0: SUCCESS (8.955s)
[611.940302] Starting dynamic subtest: ccs0
[620.956351] Dynamic subtest ccs0: SUCCESS (9.028s)
[620.959046] Subtest preemptive-hang: SUCCESS (54.609s)
[621.242647] [132/133] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[621.355717] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[621.359555] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[621.461443] [133/133] (421s left) gem_exec_fence (syncobj-unused-fence)
[621.929009] Starting subtest: syncobj-unused-fence
[621.934973] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[623.827031] 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.