[58.878604] Initializing watchdogs
[58.878648]   /dev/watchdog0
[58.892143] [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.896462] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.898785] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.902093] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[59.026946] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[65.897373] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.852s)
[66.008821] [002/132] (953s left) gem_ctx_param (invalid-get-engines)
[66.067108] Starting subtest: invalid-get-engines
[66.069471] Subtest invalid-get-engines: SUCCESS (0.001s)
[66.183868] [003/132] (953s left) gen9_exec_parse (bb-oversize)
[66.244106] Subtest bb-oversize: SKIP (0.000s)
[66.321496] [004/132] (953s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[66.391682] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[66.501966] [005/132] (953s left) gem_tiled_partial_pwrite_pread (reads)
[66.568279] Subtest reads: SKIP (0.000s)
[66.634025] [006/132] (952s left) kms_color (invalid-degamma-lut-sizes)
[66.794801] Starting subtest: invalid-degamma-lut-sizes
[66.797673] Starting dynamic subtest: pipe-A
[67.094389] Dynamic subtest pipe-A: SUCCESS (0.297s)
[67.103070] Starting dynamic subtest: pipe-B
[67.105872] Dynamic subtest pipe-B: SUCCESS (0.002s)
[67.115544] Starting dynamic subtest: pipe-C
[67.118123] Dynamic subtest pipe-C: SUCCESS (0.001s)
[67.127171] Starting dynamic subtest: pipe-D
[67.130016] Dynamic subtest pipe-D: SUCCESS (0.001s)
[67.132464] Subtest invalid-degamma-lut-sizes: SUCCESS (0.304s)
[67.927123] [007/132] (951s left) kms_content_protection (atomic)
[68.128713] Starting subtest: atomic
[68.133255] Subtest atomic: SKIP (0.000s)
[68.232143] [008/132] (951s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[68.320681] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[68.332113] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[68.401551] [009/132] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[68.497582] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[76.202804] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.705s)
[76.338623] [010/132] (943s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[76.440752] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[76.445210] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[76.505966] [011/132] (943s left) gem_readwrite (beyond-eob)
[76.559096] Subtest beyond-EOB: SKIP (0.000s)
[76.612479] [012/132] (943s left) i915_hangman (engine-error-state-capture)
[76.689121] Starting subtest: engine-error-state-capture
[76.691053] Starting dynamic subtest: rcs0
[81.843836] Dynamic subtest rcs0: SUCCESS (5.151s)
[81.856601] Starting dynamic subtest: bcs0
[87.859431] Dynamic subtest bcs0: SUCCESS (6.012s)
[87.869898] Starting dynamic subtest: vcs0
[93.813284] Dynamic subtest vcs0: SUCCESS (5.951s)
[93.822695] Starting dynamic subtest: vcs1
[98.804051] Dynamic subtest vcs1: SUCCESS (4.988s)
[98.814315] Starting dynamic subtest: vecs0
[103.796429] Dynamic subtest vecs0: SUCCESS (4.990s)
[103.805445] Starting dynamic subtest: ccs0
[109.875601] Dynamic subtest ccs0: SUCCESS (6.077s)
[109.878552] Subtest engine-error-state-capture: SUCCESS (33.177s)
[109.952552] [013/132] (909s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[110.063811] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[110.068534] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[110.178847] [014/132] (909s left) kms_flip (2x-flip-vs-panning)
[110.274834] Starting subtest: 2x-flip-vs-panning
[110.283394] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[110.361336] [015/132] (909s left) gem_ctx_sseu (invalid-args)
[110.415767] Subtest invalid-args: SKIP (0.000s)
[110.485242] [016/132] (909s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[110.571059] Starting subtest: disable-crc-after-crtc
[110.573218] Starting dynamic subtest: pipe-A-eDP-1
[112.286825] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.716s)
[112.296091] Starting dynamic subtest: pipe-B-eDP-1
[114.657073] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.370s)
[114.665629] Starting dynamic subtest: pipe-C-eDP-1
[116.881156] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.222s)
[116.888660] Starting dynamic subtest: pipe-D-eDP-1
[119.150141] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.269s)
[119.152476] Subtest disable-crc-after-crtc: SUCCESS (8.581s)
[119.972924] [017/132] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[120.081976] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[120.086581] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[120.177663] [018/132] (899s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[120.244032] Starting subtest: yf-tiled-to-vebox-yf-tiled
[120.248244] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[120.421240] [019/132] (899s left) kms_cursor_edge_walk (256x256-left-edge)
[120.514264] Starting subtest: 256x256-left-edge
[120.516598] Starting dynamic subtest: pipe-A-eDP-1
[123.953898] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s)
[123.964553] Starting dynamic subtest: pipe-D-eDP-1
[127.075454] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[127.077655] Subtest 256x256-left-edge: SUCCESS (6.559s)
[127.879230] [020/132] (892s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[127.977177] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[127.979471] Starting dynamic subtest: pipe-A-eDP-1
[128.002380] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[128.011626] Starting dynamic subtest: pipe-B-eDP-1
[128.032859] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[128.040290] Starting dynamic subtest: pipe-C-eDP-1
[128.061813] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[128.069772] Starting dynamic subtest: pipe-D-eDP-1
[128.091196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[128.095455] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[130.244162] [021/132] (889s left) kms_flip (flip-vs-suspend-interruptible)
[130.351800] Starting subtest: flip-vs-suspend-interruptible
[130.354156] Starting dynamic subtest: A-eDP1
[179.505749] Dynamic subtest A-eDP1: SUCCESS (4.740s)
[179.514685] Starting dynamic subtest: B-eDP1
[228.513543] Dynamic subtest B-eDP1: SUCCESS (4.429s)
[228.522094] Starting dynamic subtest: C-eDP1
[277.513314] Dynamic subtest C-eDP1: SUCCESS (4.547s)
[277.526549] Starting dynamic subtest: D-eDP1
[326.506900] Dynamic subtest D-eDP1: SUCCESS (4.489s)
[326.512543] Subtest flip-vs-suspend-interruptible: SUCCESS (18.213s)
[327.700146] [022/132] (692s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[327.810940] Starting subtest: fbcpsr-rgb565-draw-render
[334.831404] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.986s)
[334.971004] [023/132] (685s left) gem_fence_thrash (bo-copy)
[335.021240] Starting subtest: bo-copy
[335.041296] Subtest bo-copy: SKIP (0.019s)
[335.104822] [024/132] (685s left) kms_psr (fbc-psr-basic)
[335.204281] Starting subtest: fbc-psr-basic
[335.206674] Starting dynamic subtest: eDP-1
[335.211404] Dynamic subtest eDP-1: SKIP (0.000s)
[335.216120] Subtest fbc-psr-basic: SKIP (0.001s)
[335.277102] [025/132] (685s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[335.335449] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[335.436665] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s)
[335.515325] [026/132] (684s left) gem_exec_reloc (basic-cpu)
[335.578516] Subtest basic-cpu: SKIP (0.000s)
[335.658191] [027/132] (684s left) gem_workarounds (suspend-resume)
[335.721795] Starting subtest: suspend-resume
[351.486182] Subtest suspend-resume: SUCCESS (1.185s)
[351.617551] [028/132] (668s left) api_intel_bb (offset-control)
[351.678400] Starting subtest: offset-control
[351.683470] Subtest offset-control: SUCCESS (0.007s)
[351.794878] [029/132] (668s left) kms_chamelium_frames (hdmi-frame-dump)
[352.190842] Subtest hdmi-frame-dump: SKIP (0.000s)
[352.993688] [030/132] (667s left) kms_plane_multiple (2x-tiling-y)
[353.088476] Starting subtest: 2x-tiling-y
[353.093029] Subtest 2x-tiling-y: SKIP (0.000s)
[353.157718] [031/132] (667s left) core_hotunplug (unbind-rebind)
[353.249635] Starting subtest: unbind-rebind
[359.116466] Subtest unbind-rebind: SUCCESS (5.779s)
[359.152779] [032/132] (661s left) kms_fbcon_fbt (fbc)
[360.152500] Starting subtest: fbc
[366.520057] Subtest fbc: SUCCESS (6.327s)
[367.618121] [033/132] (653s left) perf (create-destroy-userspace-config)
[367.732318] Starting subtest: create-destroy-userspace-config
[367.750220] Subtest create-destroy-userspace-config: SUCCESS (0.017s)
[367.786765] [034/132] (652s left) gem_pxp (verify-pxp-stale-buf-execution)
[367.917867] Starting subtest: verify-pxp-stale-buf-execution
[368.983288] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[369.096160] [035/132] (651s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[369.208041] Starting subtest: short-flip-before-cursor-atomic-transitions
[370.182842] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.973s)
[370.981083] [036/132] (649s left) gem_exec_params (invalid-ring2)
[371.042417] Starting subtest: invalid-ring2
[371.044758] Subtest invalid-ring2: SUCCESS (0.000s)
[371.158069] [037/132] (649s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[371.247015] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[371.249169] Starting dynamic subtest: pipe-A-eDP-1
[371.271071] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[371.280122] Starting dynamic subtest: pipe-B-eDP-1
[371.300606] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[371.308909] Starting dynamic subtest: pipe-C-eDP-1
[371.329547] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[371.340061] Starting dynamic subtest: pipe-D-eDP-1
[371.362430] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[371.366467] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[373.562838] [038/132] (647s left) gem_mmap_gtt (isolation)
[373.622496] Subtest isolation: SKIP (0.000s)
[373.683666] [039/132] (647s left) kms_prop_blob (blob-prop-validate)
[373.750314] Starting subtest: blob-prop-validate
[373.752594] Subtest blob-prop-validate: SUCCESS (0.000s)
[373.849388] [040/132] (647s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[373.953634] Starting subtest: psr-2p-pri-indfb-multidraw
[373.957968] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[374.041875] [041/132] (646s left) gem_userptr_blits (create-destroy-unsync)
[374.101780] Subtest create-destroy-unsync: SKIP (0.000s)
[374.223080] [042/132] (646s left) perf (per-context-mode-unprivileged)
[374.312458] Starting subtest: per-context-mode-unprivileged
[374.317086] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[374.355316] [043/132] (646s left) prime_vgem (busy)
[374.440601] Starting subtest: busy
[374.442904] Starting dynamic subtest: rcs0
[374.472338] Dynamic subtest rcs0: SUCCESS (0.031s)
[374.480833] Starting dynamic subtest: bcs0
[374.516974] Dynamic subtest bcs0: SUCCESS (0.044s)
[374.525652] Starting dynamic subtest: vcs0
[374.562965] Dynamic subtest vcs0: SUCCESS (0.045s)
[374.571138] Starting dynamic subtest: vcs1
[374.606330] Dynamic subtest vcs1: SUCCESS (0.042s)
[374.614293] Starting dynamic subtest: vecs0
[374.653376] Dynamic subtest vecs0: SUCCESS (0.046s)
[374.661414] Starting dynamic subtest: ccs0
[374.697557] Dynamic subtest ccs0: SUCCESS (0.043s)
[374.699630] Subtest busy: SUCCESS (0.258s)
[374.816518] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[374.819407] [044/132] (646s left) kms_psr (fbc-pr-sprite-plane-move)
[374.922510] Starting subtest: fbc-pr-sprite-plane-move
[374.925998] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[374.993322] [045/132] (646s left) kms_joiner (basic-big-joiner)
[375.085498] Starting subtest: basic-big-joiner
[375.088787] Subtest basic-big-joiner: SKIP (0.000s)
[375.152178] [046/132] (645s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[375.257484] Starting subtest: x-tiled-8bpp-rotate-90
[375.278846] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[375.394857] [047/132] (645s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[375.490172] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[375.493597] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[375.571536] [048/132] (645s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[375.670771] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[379.363870] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.692s)
[380.550946] [049/132] (640s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[380.653131] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[380.657408] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[380.746897] [050/132] (640s left) gem_exec_balancer (hog)
[380.812179] Starting subtest: hog
[380.816516] Subtest hog: SKIP (0.000s)
[381.121606] [051/132] (640s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[381.209464] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[381.237446] Starting dynamic subtest: pipe-A-plane-0
[381.915918] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[381.924987] Starting dynamic subtest: pipe-A-plane-3
[382.317097] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[383.437654] Starting dynamic subtest: pipe-B-plane-0
[384.118693] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[384.128154] Starting dynamic subtest: pipe-B-plane-3
[384.551810] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[384.878606] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.663s)
[385.717634] [052/132] (635s left) kms_vrr (negative-basic)
[385.828078] Starting subtest: negative-basic
[385.834974] Starting dynamic subtest: pipe-A-eDP-1
[391.305283] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[391.566834] Subtest negative-basic: SUCCESS (5.739s)
[392.376836] [053/132] (629s left) gem_create (create-ext-placement-sanity-check)
[392.559209] Starting subtest: create-ext-placement-sanity-check
[392.561864] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[392.679976] [054/132] (628s left) perf_pmu (render-node-busy-idle)
[392.746354] Starting subtest: render-node-busy-idle
[392.748837] Starting dynamic subtest: rcs0
[393.444314] Dynamic subtest rcs0: SUCCESS (0.697s)
[393.457229] Starting dynamic subtest: bcs0
[394.108327] Dynamic subtest bcs0: SUCCESS (0.661s)
[394.122738] Starting dynamic subtest: vcs0
[396.210693] Dynamic subtest vcs0: SUCCESS (2.098s)
[396.223354] Starting dynamic subtest: vcs1
[398.194768] Dynamic subtest vcs1: SUCCESS (1.980s)
[398.206952] Starting dynamic subtest: vecs0
[400.178589] Dynamic subtest vecs0: SUCCESS (1.980s)
[400.191071] Starting dynamic subtest: ccs0
[400.842444] Dynamic subtest ccs0: SUCCESS (0.662s)
[400.845088] Subtest render-node-busy-idle: SUCCESS (8.096s)
[400.920447] [055/132] (620s left) kms_plane (planar-pixel-format-settings)
[401.014282] Starting subtest: planar-pixel-format-settings
[401.080550] Subtest planar-pixel-format-settings: SUCCESS (0.067s)
[401.175473] [056/132] (620s left) gem_basic (create-fd-close)
[401.230324] Starting subtest: create-fd-close
[401.234035] Subtest create-fd-close: SUCCESS (0.000s)
[401.314200] [057/132] (620s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[401.366351] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[401.420014] [058/132] (620s left) gem_lmem_swapping (parallel-random)
[401.465579] Subtest parallel-random: SKIP (0.000s)
[401.511422] [059/132] (620s left) gem_exec_capture (userptr)
[401.582801] Starting subtest: userptr
[402.401187] Subtest userptr: SUCCESS (0.818s)
[402.525431] [060/132] (619s left) gem_pwrite (basic-random)
[402.585318] Subtest basic-random: SKIP (0.000s)
[402.654609] [061/132] (619s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[402.747023] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[403.537645] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s)
[403.714723] [062/132] (618s left) fbdev (nullptr)
[403.761697] Starting subtest: nullptr
[403.763753] Subtest nullptr: SUCCESS (0.000s)
[403.858423] [063/132] (618s left) gem_exec_fence (basic-busy)
[404.064343] Starting subtest: basic-busy
[404.066867] Starting dynamic subtest: rcs0
[404.139362] Dynamic subtest rcs0: SUCCESS (0.078s)
[404.148413] Starting dynamic subtest: bcs0
[404.193476] Dynamic subtest bcs0: SUCCESS (0.053s)
[404.205465] Starting dynamic subtest: vcs0
[404.256287] Dynamic subtest vcs0: SUCCESS (0.061s)
[404.267802] Starting dynamic subtest: vcs1
[404.310171] Dynamic subtest vcs1: SUCCESS (0.052s)
[404.321605] Starting dynamic subtest: vecs0
[404.375199] Dynamic subtest vecs0: SUCCESS (0.063s)
[404.386070] Starting dynamic subtest: ccs0
[404.438422] Dynamic subtest ccs0: SUCCESS (0.061s)
[404.441182] Subtest basic-busy: SUCCESS (0.379s)
[406.264905] [064/132] (615s left) kms_cursor_crc (cursor-offscreen-512x170)
[406.571083] Starting subtest: cursor-offscreen-512x170
[406.575365] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[406.732635] [065/132] (615s left) kms_atomic_transition (modeset-transition-fencing)
[406.825673] Starting subtest: modeset-transition-fencing
[406.827836] Starting dynamic subtest: 1x-outputs
[417.673135] Dynamic subtest 1x-outputs: SUCCESS (10.845s)
[417.675524] Subtest modeset-transition-fencing: SUCCESS (10.847s)
[418.527534] [066/132] (603s left) gem_flink_basic (basic)
[418.580304] Starting subtest: basic
[418.582108] Subtest basic: SUCCESS (0.000s)
[418.678404] [067/132] (603s left) kms_psr (pr-no-drrs)
[418.769344] Starting subtest: pr-no-drrs
[418.773793] Subtest pr-no-drrs: SKIP (0.000s)
[418.855378] [068/132] (603s left) i915_pm_rps (min-max-config-loaded)
[418.918711] Starting subtest: min-max-config-loaded
[418.923328] Subtest min-max-config-loaded: SKIP (0.000s)
[419.034177] [069/132] (603s left) gem_exec_fence (invalid-fence-array)
[419.437765] Starting subtest: invalid-fence-array
[419.440283] Subtest invalid-fence-array: SUCCESS (0.002s)
[421.243997] [070/132] (600s left) gem_exec_params (no-blt)
[421.306802] Starting subtest: no-blt
[421.311745] Subtest no-blt: SUCCESS (0.005s)
[421.454267] [071/132] (600s left) gem_spin_batch (resubmit-new-all)
[421.522121] Starting subtest: resubmit-new-all
[421.524551] Starting dynamic subtest: rcs0
[421.545693] Dynamic subtest rcs0: SUCCESS (0.023s)
[421.555237] Starting dynamic subtest: bcs0
[421.566426] Dynamic subtest bcs0: SUCCESS (0.020s)
[421.577550] Starting dynamic subtest: vcs0
[421.583573] Dynamic subtest vcs0: SUCCESS (0.016s)
[421.592475] Starting dynamic subtest: vcs1
[421.597077] Dynamic subtest vcs1: SUCCESS (0.013s)
[421.608601] Starting dynamic subtest: vecs0
[421.614365] Dynamic subtest vecs0: SUCCESS (0.014s)
[421.623724] Starting dynamic subtest: ccs0
[421.629035] Dynamic subtest ccs0: SUCCESS (0.015s)
[421.631225] Subtest resubmit-new-all: SUCCESS (0.108s)
[423.262089] [072/132] (598s left) kms_rmfb (rmfb-ioctl)
[423.360061] Starting subtest: rmfb-ioctl
[423.361933] Starting dynamic subtest: pipe-A-eDP-1
[423.464674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[423.475773] Starting dynamic subtest: pipe-B-eDP-1
[424.699121] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.232s)
[424.710879] Starting dynamic subtest: pipe-C-eDP-1
[425.819795] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[425.829874] Starting dynamic subtest: pipe-D-eDP-1
[426.950432] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[426.952847] Subtest rmfb-ioctl: SUCCESS (3.591s)
[428.168411] [073/132] (594s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[428.272929] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[428.275102] Starting dynamic subtest: pipe-A-eDP-1
[428.297710] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.308045] Starting dynamic subtest: pipe-B-eDP-1
[428.329459] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.338150] Starting dynamic subtest: pipe-C-eDP-1
[428.359137] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.368053] Starting dynamic subtest: pipe-D-eDP-1
[428.389418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.393397] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[430.540985] [074/132] (591s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[430.651810] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[431.036999] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[433.818628] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.780s)
[433.828133] Starting dynamic subtest: pipe-A-eDP-1-4
[435.996279] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[436.011155] Starting dynamic subtest: pipe-A-eDP-1-4
[438.005706] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[438.014860] Starting dynamic subtest: pipe-A-eDP-1-x
[440.207051] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.198s)
[440.589916] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[443.417323] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.779s)
[443.429581] Starting dynamic subtest: pipe-B-eDP-1-4
[445.540081] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.172s)
[445.552208] Starting dynamic subtest: pipe-B-eDP-1-4
[447.548919] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[447.561203] Starting dynamic subtest: pipe-B-eDP-1-x
[449.763447] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.212s)
[450.127621] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[452.885857] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.766s)
[452.903781] Starting dynamic subtest: pipe-C-eDP-1-4
[455.060472] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[455.071748] Starting dynamic subtest: pipe-C-eDP-1-4
[457.069283] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[457.082116] Starting dynamic subtest: pipe-C-eDP-1-x
[459.259888] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.187s)
[459.620762] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[462.407272] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[462.420853] Starting dynamic subtest: pipe-D-eDP-1-4
[464.579864] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[464.589316] Starting dynamic subtest: pipe-D-eDP-1-4
[466.590981] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[466.602513] Starting dynamic subtest: pipe-D-eDP-1-x
[468.793815] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s)
[468.796476] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.140s)
[469.996697] [075/132] (552s left) syncobj_timeline (single-wait-all-available-submitted)
[470.056981] Starting subtest: single-wait-all-available-submitted
[470.059209] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[470.154152] [076/132] (552s left) kms_feature_discovery (chamelium)
[470.257273] Starting subtest: chamelium
[470.261699] Subtest chamelium: SKIP (0.000s)
[470.329232] [077/132] (552s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[470.417931] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[470.420121] Starting dynamic subtest: pipe-A-default-mode
[473.118082] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[473.120480] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.701s)
[473.981131] [078/132] (548s left) kms_chamelium_hpd (dp-hpd)
[474.367112] Subtest dp-hpd: SKIP (0.000s)
[475.184409] [079/132] (547s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[475.291374] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[475.295735] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[475.390000] [080/132] (547s left) gem_mmap_gtt (basic-small-bo-tiledx)
[475.450097] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[475.509596] [081/132] (547s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[475.566422] Starting subtest: multi-wait-available-unsubmitted-signaled
[475.568295] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[475.652640] [082/132] (547s left) api_intel_bb (add-remove-objects)
[475.702727] Starting subtest: add-remove-objects
[475.707886] Subtest add-remove-objects: SUCCESS (0.007s)
[475.832545] [083/132] (546s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[475.921015] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[475.923217] Starting dynamic subtest: pipe-A-eDP-1
[475.944897] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[475.956190] Starting dynamic subtest: pipe-B-eDP-1
[475.976496] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[475.985204] Starting dynamic subtest: pipe-C-eDP-1
[476.005898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[476.014733] Starting dynamic subtest: pipe-D-eDP-1
[476.036421] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[476.040739] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[478.083746] [084/132] (544s left) gem_exec_reloc (basic-gtt-read-active)
[478.141915] Subtest basic-gtt-read-active: SKIP (0.000s)
[478.217635] [085/132] (544s left) kms_big_fb (linear-64bpp-rotate-180)
[478.314475] Starting subtest: linear-64bpp-rotate-180
[479.905336] Subtest linear-64bpp-rotate-180: SUCCESS (1.591s)
[480.081124] [086/132] (542s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[480.176482] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[480.180772] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[480.272947] [087/132] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[480.363696] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[487.106809] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.745s)
[487.253198] [088/132] (535s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[487.375266] Starting subtest: modeset-atomic-cursor-hotspot
[487.379656] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[487.518653] [089/132] (535s left) gem_ctx_persistence (heartbeat-many)
[487.588706] Starting subtest: heartbeat-many
[487.593475] Subtest heartbeat-many: SKIP (0.000s)
[487.689831] [090/132] (535s left) kms_cursor_crc (cursor-random-512x512)
[488.007107] Starting subtest: cursor-random-512x512
[488.011592] Subtest cursor-random-512x512: SKIP (0.001s)
[488.178854] [091/132] (534s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[488.280971] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[488.284227] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.386870] [092/132] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[488.487328] Starting subtest: fbcpsr-2p-rte
[488.490865] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[488.582733] [093/132] (534s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[488.679388] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[492.971986] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.294s)
[494.109778] [094/132] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[494.204466] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[494.208502] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[494.320538] [095/132] (528s left) gem_ctx_param (root-set)
[494.377090] Starting subtest: root-set
[494.379465] Subtest root-set: SUCCESS (0.001s)
[494.485149] [096/132] (528s left) i915_pm_rps (thresholds)
[494.555863] Starting subtest: thresholds
[494.560850] Subtest thresholds: SKIP (0.000s)
[494.657433] [097/132] (528s left) syncobj_basic (bad-fd-to-handle)
[494.709910] Starting subtest: bad-fd-to-handle
[494.711915] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[494.806499] [098/132] (528s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[494.893981] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[494.896187] Starting dynamic subtest: pipe-A-eDP-1
[494.920093] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[494.934585] Starting dynamic subtest: pipe-B-eDP-1
[494.957379] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[494.966374] Starting dynamic subtest: pipe-C-eDP-1
[494.989209] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[494.997842] Starting dynamic subtest: pipe-D-eDP-1
[495.021767] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[495.026085] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[497.076031] [099/132] (526s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[497.186664] Starting subtest: cursorA-vs-flipB-toggle
[497.191122] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[497.348760] [100/132] (526s left) kms_sequence (get-idle)
[497.429256] Starting subtest: get-idle
[497.431555] Starting dynamic subtest: pipe-A-eDP-1
[499.250938] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s)
[499.261889] Starting dynamic subtest: pipe-B-eDP-1
[501.746771] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.494s)
[501.758145] Starting dynamic subtest: pipe-C-eDP-1
[504.180577] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.431s)
[504.191207] Starting dynamic subtest: pipe-D-eDP-1
[506.598969] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.417s)
[506.601290] Subtest get-idle: SUCCESS (9.169s)
[507.421459] [101/132] (516s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[507.523228] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[507.532563] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[507.626927] [102/132] (515s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[507.678663] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[507.782095] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[507.872059] [103/132] (515s left) gem_render_linear_blits (basic)
[507.923036] Starting subtest: basic
[507.946007] Subtest basic: SUCCESS (0.022s)
[508.036100] [104/132] (515s left) gem_userptr_blits (forbidden-operations)
[508.107829] Starting subtest: forbidden-operations
[508.111918] Subtest forbidden-operations: SKIP (0.000s)
[508.235387] [105/132] (515s left) i915_drm_fdinfo (memory-info-resident)
[508.282808] Starting subtest: memory-info-resident
[508.285152] Starting dynamic subtest: smem0
[510.831330] Dynamic subtest smem0: SUCCESS (2.548s)
[510.833830] Subtest memory-info-resident: SUCCESS (2.550s)
[510.908355] [106/132] (512s left) gem_exec_suspend (basic)
[510.974569] Starting subtest: basic
[510.976569] Starting dynamic subtest: smem
[512.178764] Dynamic subtest smem: SUCCESS (1.200s)
[512.181368] Subtest basic: SUCCESS (1.203s)
[512.371616] [107/132] (511s left) gem_exec_schedule (semaphore-user)
[512.441861] Starting subtest: semaphore-user
[512.495882] Subtest semaphore-user: SUCCESS (0.062s)
[514.272701] [108/132] (509s left) kms_psr (fbc-pr-no-drrs)
[514.374077] Starting subtest: fbc-pr-no-drrs
[514.378403] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[514.446547] [109/132] (509s left) gem_userptr_blits (usage-restrictions)
[514.509548] Starting subtest: usage-restrictions
[514.511858] Subtest usage-restrictions: SUCCESS (0.000s)
[514.644550] [110/132] (509s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[514.738783] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[514.741077] Starting dynamic subtest: pipe-A
[514.758872] Dynamic subtest pipe-A: SKIP (0.018s)
[514.769420] Starting dynamic subtest: pipe-B
[514.792495] Dynamic subtest pipe-B: SKIP (0.032s)
[514.802842] Starting dynamic subtest: pipe-C
[514.826415] Dynamic subtest pipe-C: SKIP (0.032s)
[514.835924] Starting dynamic subtest: pipe-D
[514.856239] Dynamic subtest pipe-D: SKIP (0.031s)
[514.860582] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.115s)
[514.964872] [111/132] (508s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[515.058450] Starting subtest: fbcpsr-suspend
[555.199845] Subtest fbcpsr-suspend: SUCCESS (10.072s)
[555.361257] [112/132] (468s left) kms_atomic_interruptible (universal-setplane-cursor)
[555.465940] Starting subtest: universal-setplane-cursor
[555.468254] Starting dynamic subtest: pipe-A-eDP-1
[562.932472] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.376s)
[562.934706] Subtest universal-setplane-cursor: SUCCESS (7.378s)
[563.760476] [113/132] (460s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[563.838701] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[563.908240] [114/132] (460s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[563.969799] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[564.030869] [115/132] (460s left) kms_lease (master-vs-lease)
[564.135857] Starting subtest: master-vs-lease
[564.138195] Subtest master-vs-lease: SUCCESS (0.002s)
[564.246145] [116/132] (459s left) kms_pm_rpm (fences)
[566.374290] Starting subtest: fences
[566.380075] Subtest fences: SKIP (0.000s)
[566.746206] [117/132] (457s left) gem_exec_whisper (basic-contexts-all)
[566.816434] Starting subtest: basic-contexts-all
[578.162841] Subtest basic-contexts-all: SUCCESS (11.314s)
[578.350980] [118/132] (445s left) kms_flip (flip-vs-panning-interruptible)
[578.451921] Starting subtest: flip-vs-panning-interruptible
[578.454324] Starting dynamic subtest: A-eDP1
[587.174688] Dynamic subtest A-eDP1: SUCCESS (8.721s)
[587.187259] Starting dynamic subtest: B-eDP1
[595.897801] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[595.909115] Starting dynamic subtest: C-eDP1
[604.614061] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[604.626696] Starting dynamic subtest: D-eDP1
[613.336754] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[613.340842] Subtest flip-vs-panning-interruptible: SUCCESS (34.891s)
[614.503640] [119/132] (409s left) gem_exec_parallel (contexts)
[614.574806] Starting subtest: contexts
[614.577092] Starting dynamic subtest: rcs0
[617.526786] Dynamic subtest rcs0: SUCCESS (2.949s)
[617.538616] Starting dynamic subtest: bcs0
[621.060578] Dynamic subtest bcs0: SUCCESS (3.531s)
[621.072341] Starting dynamic subtest: vcs0
[625.558362] Dynamic subtest vcs0: SUCCESS (4.494s)
[625.570995] Starting dynamic subtest: vcs1
[629.657227] Dynamic subtest vcs1: SUCCESS (4.095s)
[629.667000] Starting dynamic subtest: vecs0
[633.673270] Dynamic subtest vecs0: SUCCESS (4.013s)
[633.683422] Starting dynamic subtest: ccs0
[637.238366] Dynamic subtest ccs0: SUCCESS (3.561s)
[637.240812] Subtest contexts: SUCCESS (22.656s)
[637.439014] [120/132] (386s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[637.548038] Starting subtest: 4-tiled-8bpp-rotate-180
[638.761715] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.213s)
[638.887709] [121/132] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[638.979731] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[638.983325] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[639.087454] [122/132] (385s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[639.197828] Starting subtest: y-tiled-64bpp-rotate-0
[639.201723] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[639.290237] [123/132] (385s left) gem_exec_reloc (basic-active)
[639.346943] Subtest basic-active: SKIP (0.000s)
[639.410284] [124/132] (385s left) kms_psr (psr-basic)
[639.490971] Starting subtest: psr-basic
[639.492837] Starting dynamic subtest: eDP-1
[641.080685] Dynamic subtest eDP-1: SUCCESS (1.588s)
[641.082865] Subtest psr-basic: SUCCESS (1.589s)
[641.968545] [125/132] (382s left) sysfs_heartbeat_interval (invalid)
[642.021531] Starting subtest: invalid
[642.023860] Starting dynamic subtest: vecs0
[642.026265] Dynamic subtest vecs0: SUCCESS (0.000s)
[642.038665] Starting dynamic subtest: ccs0
[642.040502] Dynamic subtest ccs0: SUCCESS (0.000s)
[642.049481] Starting dynamic subtest: vcs0
[642.051369] Dynamic subtest vcs0: SUCCESS (0.000s)
[642.060077] Starting dynamic subtest: bcs0
[642.061927] Dynamic subtest bcs0: SUCCESS (0.000s)
[642.071158] Starting dynamic subtest: rcs0
[642.073026] Dynamic subtest rcs0: SUCCESS (0.000s)
[642.082245] Starting dynamic subtest: vcs1
[642.084378] Dynamic subtest vcs1: SUCCESS (0.000s)
[642.086464] Subtest invalid: SUCCESS (0.005s)
[642.142139] [126/132] (382s left) syncobj_timeline (invalid-query-illegal-handle)
[642.192644] Starting subtest: invalid-query-illegal-handle
[642.194931] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[642.286356] [127/132] (382s left) gem_ctx_bad_destroy (double-destroy)
[642.339649] Starting subtest: double-destroy
[642.341926] Subtest double-destroy: SUCCESS (0.000s)
[642.412287] [128/132] (382s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[642.500466] Starting subtest: 2x-plain-flip-ts-check-interruptible
[642.510430] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[642.626558] [129/132] (382s left) gem_exec_schedule (preempt-contexts)
[642.702516] Starting subtest: preempt-contexts
[642.704476] Starting dynamic subtest: rcs0
[642.759949] Dynamic subtest rcs0: SUCCESS (0.061s)
[642.771793] Starting dynamic subtest: bcs0
[642.814130] Dynamic subtest bcs0: SUCCESS (0.054s)
[642.824245] Starting dynamic subtest: vcs0
[642.862337] Dynamic subtest vcs0: SUCCESS (0.046s)
[642.874295] Starting dynamic subtest: vcs1
[642.904977] Dynamic subtest vcs1: SUCCESS (0.043s)
[642.914711] Starting dynamic subtest: vecs0
[642.947526] Dynamic subtest vecs0: SUCCESS (0.043s)
[642.957139] Starting dynamic subtest: ccs0
[642.998286] Dynamic subtest ccs0: SUCCESS (0.050s)
[643.000203] Subtest preempt-contexts: SUCCESS (0.301s)
[644.279199] [130/132] (380s left) kms_vblank (wait-busy-hang)
[644.378737] Starting subtest: wait-busy-hang
[644.380992] Starting dynamic subtest: pipe-A-eDP-1
[650.585514] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.204s)
[650.601321] Starting dynamic subtest: pipe-D-eDP-1
[656.665619] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.082s)
[656.668078] Subtest wait-busy-hang: SUCCESS (12.291s)
[657.531400] [131/132] (367s left) kms_psr (psr-sprite-plane-onoff)
[657.629699] Starting subtest: psr-sprite-plane-onoff
[657.632046] Starting dynamic subtest: eDP-1
[659.382372] Dynamic subtest eDP-1: SUCCESS (1.754s)
[659.384739] Subtest psr-sprite-plane-onoff: SUCCESS (1.755s)
[660.189383] [132/132] (364s left) gem_softpin (softpin)
[660.255908] Starting subtest: softpin
[692.556767] Subtest softpin: SUCCESS (32.299s)
[692.688893] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ctx_param
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: gem_readwrite
results: parsing output: 11/ for test: i915_hangman
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_ctx_sseu
results: parsing output: 15/ for test: kms_pipe_crc_basic
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_cursor_edge_walk
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_fence_thrash
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: gem_workarounds
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: kms_chamelium_frames
results: parsing output: 29/ for test: kms_plane_multiple
results: parsing output: 30/ for test: core_hotunplug
results: parsing output: 31/ for test: kms_fbcon_fbt
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: gem_exec_params
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_prop_blob
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_joiner
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: kms_vrr
results: parsing output: 52/ for test: gem_create
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: gem_basic
results: parsing output: 56/ for test: kms_pipe_b_c_ivb
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: gem_exec_capture
results: parsing output: 59/ for test: gem_pwrite
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: fbdev
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_atomic_transition
results: parsing output: 65/ for test: gem_flink_basic
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: i915_pm_rps
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: gem_spin_batch
results: parsing output: 71/ for test: kms_rmfb
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_async_flips
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_feature_discovery
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_ctx_param
results: parsing output: 95/ for test: i915_pm_rps
results: parsing output: 96/ for test: syncobj_basic
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_sequence
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_render_linear_blits
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_suspend
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_atomic_interruptible
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_lease
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: gem_exec_parallel
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: sysfs_heartbeat_interval
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_ctx_bad_destroy
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_softpin
Done.