[60.245198] Initializing watchdogs
[60.245265]   /dev/watchdog0
[60.258785] [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.263179] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.265320] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.268664] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[60.390451] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[60.394718] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.477846] [002/133] (960s left) gem_pread (self)
[60.538803] Subtest self: SKIP (0.000s)
[60.593015] [003/133] (960s left) gem_flink_race (flink_close)
[60.628341] Starting subtest: flink_close
[65.757558] Subtest flink_close: SUCCESS (5.135s)
[65.843463] [004/133] (955s left) kms_cursor_crc (cursor-offscreen-32x10)
[66.010582] Starting subtest: cursor-offscreen-32x10
[66.057743] Subtest cursor-offscreen-32x10: SKIP (0.044s)
[66.319311] [005/133] (954s left) gem_exec_balancer (fairslice)
[66.386507] Starting subtest: fairslice
[69.325338] Subtest fairslice: SUCCESS (2.938s)
[69.634916] [006/133] (951s left) syncobj_timeline (invalid-signal-bad-pad)
[69.688456] Starting subtest: invalid-signal-bad-pad
[69.690638] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[69.772891] [007/133] (951s left) kms_lease (lease-invalid-crtc)
[69.869086] Starting subtest: lease-invalid-crtc
[69.871448] Starting dynamic subtest: pipe-A-eDP-1
[69.873609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[69.883020] Starting dynamic subtest: pipe-B-eDP-1
[69.885250] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[69.891768] Starting dynamic subtest: pipe-C-eDP-1
[69.894080] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[69.900596] Starting dynamic subtest: pipe-D-eDP-1
[69.902785] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[69.904975] Subtest lease-invalid-crtc: SUCCESS (0.002s)
[69.937819] [008/133] (951s left) syncobj_wait (multi-wait-all-submitted-signaled)
[69.991384] Starting subtest: multi-wait-all-submitted-signaled
[70.097434] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[70.168705] [009/133] (950s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[70.268407] Starting subtest: 4-tiled-16bpp-rotate-0
[71.500188] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.233s)
[71.629302] [010/133] (949s left) i915_pm_rc6_residency (media-rc6-accuracy)
[71.693563] Starting subtest: media-rc6-accuracy
[71.696672] Subtest media-rc6-accuracy: SKIP (0.000s)
[71.785823] [011/133] (949s left) kms_universal_plane (disable-primary-vs-flip)
[71.882048] Starting subtest: disable-primary-vs-flip
[71.884363] Starting dynamic subtest: pipe-A-eDP-1
[73.382566] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.500s)
[73.392564] Starting dynamic subtest: pipe-B-eDP-1
[75.540272] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.157s)
[75.549569] Starting dynamic subtest: pipe-C-eDP-1
[77.710770] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.171s)
[77.720189] Starting dynamic subtest: pipe-D-eDP-1
[79.867876] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.155s)
[79.870204] Subtest disable-primary-vs-flip: SUCCESS (7.986s)
[80.659847] [012/133] (940s left) prime_mmap (test_dup)
[80.723920] Starting subtest: test_dup
[80.726252] Starting dynamic subtest: test_dup-smem
[80.755678] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[80.758141] Subtest test_dup: SUCCESS (0.034s)
[80.830027] [013/133] (940s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[80.877480] Starting subtest: single-wait-for-submit-available-submitted
[80.879891] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[80.974999] [014/133] (940s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[81.076338] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[81.080674] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[81.178895] [015/133] (940s left) vgem_basic (dmabuf-mmap)
[81.252917] Starting subtest: dmabuf-mmap
[81.257717] Subtest dmabuf-mmap: SUCCESS (0.007s)
[81.304142] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[81.307216] [016/133] (940s left) gen9_exec_parse (batch-invalid-length)
[81.371324] Subtest batch-invalid-length: SKIP (0.000s)
[81.429562] [017/133] (939s left) gem_exec_params (invalid-ring)
[81.486044] Starting subtest: invalid-ring
[81.488468] Subtest invalid-ring: SUCCESS (0.000s)
[81.580715] [018/133] (939s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[81.668060] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[81.669942] Starting dynamic subtest: pipe-A-eDP-1
[83.793569] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.126s)
[83.801922] Starting dynamic subtest: pipe-B-eDP-1
[85.995608] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.200s)
[86.004015] Starting dynamic subtest: pipe-C-eDP-1
[88.015080] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.018s)
[88.023720] Starting dynamic subtest: pipe-D-eDP-1
[90.058828] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.042s)
[90.061187] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.390s)
[91.297141] [019/133] (930s left) kms_flip (modeset-vs-vblank-race)
[91.391790] Starting subtest: modeset-vs-vblank-race
[91.394135] Starting dynamic subtest: A-eDP1
[96.110621] Dynamic subtest A-eDP1: SUCCESS (4.719s)
[96.123929] Starting dynamic subtest: B-eDP1
[100.825623] Dynamic subtest B-eDP1: SUCCESS (4.710s)
[100.838046] Starting dynamic subtest: C-eDP1
[105.449549] Dynamic subtest C-eDP1: SUCCESS (4.625s)
[105.459151] Starting dynamic subtest: D-eDP1
[110.079203] Dynamic subtest D-eDP1: SUCCESS (4.629s)
[110.083936] Subtest modeset-vs-vblank-race: SUCCESS (18.694s)
[111.228883] [020/133] (910s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[111.286310] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[111.288322] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[111.397561] [021/133] (910s left) gem_mmap_gtt (isolation)
[111.447675] Subtest isolation: SKIP (0.000s)
[111.504554] [022/133] (910s left) perf_pmu (render-node-busy-idle)
[111.580514] Starting subtest: render-node-busy-idle
[111.583019] Starting dynamic subtest: rcs0
[112.244853] Dynamic subtest rcs0: SUCCESS (0.664s)
[112.255489] Starting dynamic subtest: bcs0
[112.913454] Dynamic subtest bcs0: SUCCESS (0.665s)
[112.923309] Starting dynamic subtest: vcs0
[114.901483] Dynamic subtest vcs0: SUCCESS (1.985s)
[114.910733] Starting dynamic subtest: vcs1
[116.884692] Dynamic subtest vcs1: SUCCESS (1.981s)
[116.895500] Starting dynamic subtest: vecs0
[118.933446] Dynamic subtest vecs0: SUCCESS (2.046s)
[118.944802] Starting dynamic subtest: ccs0
[119.596400] Dynamic subtest ccs0: SUCCESS (0.661s)
[119.599195] Subtest render-node-busy-idle: SUCCESS (8.016s)
[119.673554] [023/133] (901s left) api_intel_bb (object-reloc-purge-cache)
[119.730015] Starting subtest: object-reloc-purge-cache
[119.736907] Subtest object-reloc-purge-cache: SKIP (0.006s)
[119.851794] [024/133] (901s left) kms_scaling_modes (scaling-mode-none)
[119.941017] Starting subtest: scaling-mode-none
[119.943352] Starting dynamic subtest: pipe-A-eDP-1
[120.033743] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[120.043734] Starting dynamic subtest: pipe-B-eDP-1
[120.070457] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[120.078464] Starting dynamic subtest: pipe-C-eDP-1
[120.102414] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s)
[120.110223] Starting dynamic subtest: pipe-D-eDP-1
[120.139070] Dynamic subtest pipe-D-eDP-1: SKIP (0.035s)
[120.143215] Subtest scaling-mode-none: SKIP (0.199s)
[120.260877] [025/133] (901s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[120.355081] Starting subtest: fbcpsr-tiling-linear
[126.898994] Subtest fbcpsr-tiling-linear: SUCCESS (6.546s)
[127.036685] [026/133] (894s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[127.128835] Starting subtest: plane-all-transition-nonblocking-fencing
[127.131161] Starting dynamic subtest: pipe-A-eDP-1
[129.622562] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[129.941365] Starting dynamic subtest: pipe-B-eDP-1
[133.203699] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.271s)
[133.516886] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.387s)
[134.325889] [027/133] (887s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[134.384047] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[134.488953] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[134.564682] [028/133] (887s left) kms_flip (dpms-off-confusion)
[134.662513] Starting subtest: dpms-off-confusion
[134.664791] Starting dynamic subtest: A-eDP1
[143.331812] Dynamic subtest A-eDP1: SUCCESS (8.670s)
[143.342386] Starting dynamic subtest: B-eDP1
[151.967071] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[151.976533] Starting dynamic subtest: C-eDP1
[160.589781] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[160.601922] Starting dynamic subtest: D-eDP1
[169.232645] Dynamic subtest D-eDP1: SUCCESS (8.640s)
[169.237659] Subtest dpms-off-confusion: SUCCESS (34.576s)
[170.402420] [029/133] (851s left) perf_pmu (all-busy-idle-check-all)
[170.449608] Starting subtest: all-busy-idle-check-all
[171.925646] Subtest all-busy-idle-check-all: SUCCESS (1.476s)
[172.035303] [030/133] (849s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[172.126033] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[173.090271] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.965s)
[173.211326] [031/133] (848s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[173.314488] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[177.708905] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.398s)
[178.890617] [032/133] (843s left) kms_color (degamma)
[178.986953] Starting subtest: degamma
[178.989211] Starting dynamic subtest: pipe-A-eDP-1
[179.700647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[179.710136] Starting dynamic subtest: pipe-B-eDP-1
[181.086204] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s)
[181.094262] Starting dynamic subtest: pipe-C-eDP-1
[182.464468] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[182.473376] Starting dynamic subtest: pipe-D-eDP-1
[183.813735] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[183.815924] Subtest degamma: SUCCESS (4.826s)
[184.612542] [033/133] (837s left) kms_plane_alpha_blend (coverage-7efc)
[184.699137] Starting subtest: coverage-7efc
[184.978558] Starting dynamic subtest: pipe-A-eDP-1
[185.530527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[185.555897] Starting dynamic subtest: pipe-D-eDP-1
[186.818634] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.268s)
[186.820779] Subtest coverage-7efc: SUCCESS (2.121s)
[187.684353] [034/133] (834s left) i915_drm_fdinfo (virtual-busy-all)
[187.731414] Starting subtest: virtual-busy-all
[187.735504] Subtest virtual-busy-all: SKIP (0.000s)
[187.801368] [035/133] (834s left) kms_psr (pr-sprite-blt)
[187.889699] Starting subtest: pr-sprite-blt
[187.894259] Subtest pr-sprite-blt: SKIP (0.000s)
[187.973234] [036/133] (834s left) kms_addfb_basic (too-wide)
[188.071192] Starting subtest: too-wide
[188.073082] Subtest too-wide: SUCCESS (0.000s)
[188.186698] [037/133] (833s left) kms_chamelium_color (ctm-max)
[188.280972] Subtest ctm-max: SKIP (0.000s)
[188.325672] [038/133] (833s left) kms_chamelium_frames (dp-frame-dump)
[188.717704] Subtest dp-frame-dump: SKIP (0.000s)
[189.573470] [039/133] (832s left) kms_psr (fbc-psr2-cursor-plane-move)
[189.657633] Starting subtest: fbc-psr2-cursor-plane-move
[189.659807] Starting dynamic subtest: eDP-1
[189.663760] Dynamic subtest eDP-1: SKIP (0.000s)
[189.667748] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[189.729436] [040/133] (832s left) prime_vgem (fence-read-hang)
[189.807622] Subtest fence-read-hang: SKIP (0.000s)
[189.896484] [041/133] (832s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[189.989661] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[189.993753] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[190.060529] [042/133] (832s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[190.144851] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[190.147113] Starting dynamic subtest: pipe-A-default-mode
[191.263378] Dynamic subtest pipe-A-default-mode: SKIP (1.114s)
[191.267786] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.115s)
[191.432529] [043/133] (830s left) gem_exec_alignment (forked)
[191.485629] Starting subtest: forked
[228.389619] Subtest forked: SUCCESS (36.902s)
[229.312881] [044/133] (793s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[229.442806] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[229.444968] Starting dynamic subtest: pipe-A-eDP-1
[229.617034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.164s)
[229.628087] Starting dynamic subtest: pipe-B-eDP-1
[229.648339] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[229.656604] Starting dynamic subtest: pipe-C-eDP-1
[229.676230] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[229.684359] Starting dynamic subtest: pipe-D-eDP-1
[229.705347] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[229.707722] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.173s)
[231.902163] [045/133] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[232.006334] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[237.303802] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.300s)
[238.496663] [046/133] (784s left) gem_exec_capture (capture)
[238.561026] Starting subtest: capture
[238.563099] Starting dynamic subtest: rcs0-smem
[239.408362] Dynamic subtest rcs0-smem: SUCCESS (0.847s)
[239.420061] Starting dynamic subtest: bcs0-smem
[240.727478] Dynamic subtest bcs0-smem: SUCCESS (1.318s)
[240.737507] Starting dynamic subtest: vcs0-smem
[241.548375] Dynamic subtest vcs0-smem: SUCCESS (0.820s)
[241.558713] Starting dynamic subtest: vcs1-smem
[242.866018] Dynamic subtest vcs1-smem: SUCCESS (1.320s)
[242.874245] Starting dynamic subtest: vecs0-smem
[243.759607] Dynamic subtest vecs0-smem: FAIL (0.833s)
[243.768716] Starting dynamic subtest: ccs0-smem
[245.020833] Dynamic subtest ccs0-smem: SUCCESS (1.316s)
[245.023089] Subtest capture: FAIL (6.458s)
[245.137846] [047/133] (777s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[245.230578] Starting subtest: fbc-modesetfrombusy
[248.946986] Subtest fbc-modesetfrombusy: SUCCESS (3.721s)
[250.150511] [048/133] (772s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[250.255659] Starting subtest: fbcpsr-rgb101010-draw-blt
[256.955058] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.702s)
[257.078158] [049/133] (765s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[257.262922] Starting subtest: cursor-rapid-movement-64x64
[257.267598] Starting dynamic subtest: pipe-A-eDP-1
[257.817357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[257.852539] Starting dynamic subtest: pipe-D-eDP-1
[259.141438] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[259.143697] Subtest cursor-rapid-movement-64x64: SUCCESS (1.876s)
[260.003651] [050/133] (762s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[260.096719] Starting subtest: plane-primary-toggle-with-vblank-wait
[260.099042] Starting dynamic subtest: pipe-A-eDP-1
[260.270224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[260.581065] Starting dynamic subtest: pipe-B-eDP-1
[261.500682] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.928s)
[261.800796] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.705s)
[262.658811] [051/133] (760s left) perf_pmu (busy-accuracy-98)
[262.707107] Starting subtest: busy-accuracy-98
[262.709422] Starting dynamic subtest: rcs0
[265.745264] Dynamic subtest rcs0: SUCCESS (3.037s)
[265.754582] Starting dynamic subtest: bcs0
[268.793812] Dynamic subtest bcs0: SUCCESS (3.046s)
[268.802732] Starting dynamic subtest: vcs0
[271.832581] Dynamic subtest vcs0: SUCCESS (3.036s)
[271.841080] Starting dynamic subtest: vcs1
[274.874963] Dynamic subtest vcs1: SUCCESS (3.039s)
[274.885920] Starting dynamic subtest: vecs0
[277.919489] Dynamic subtest vecs0: SUCCESS (3.039s)
[277.928209] Starting dynamic subtest: ccs0
[280.968860] Dynamic subtest ccs0: SUCCESS (3.049s)
[280.971406] Subtest busy-accuracy-98: SUCCESS (18.262s)
[281.087515] [052/133] (741s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[281.167515] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[281.169834] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[281.247969] [053/133] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[281.343863] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[281.347755] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[281.449526] [054/133] (741s left) kms_big_fb (4-tiled-addfb-size-overflow)
[281.554639] Starting subtest: 4-tiled-addfb-size-overflow
[281.556917] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[281.653798] [055/133] (741s left) gem_ctx_bad_destroy (invalid-default-ctx)
[281.705310] Starting subtest: invalid-default-ctx
[281.707584] Subtest invalid-default-ctx: SUCCESS (0.000s)
[281.783209] [056/133] (741s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[281.870076] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[281.872341] Starting dynamic subtest: pipe-A-eDP-1
[281.895051] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.905280] Starting dynamic subtest: pipe-B-eDP-1
[281.926584] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.934646] Starting dynamic subtest: pipe-C-eDP-1
[281.956066] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.963935] Starting dynamic subtest: pipe-D-eDP-1
[281.984666] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.988534] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[284.120746] [057/133] (738s left) i915_module_load (resize-bar)
[284.159981] Starting subtest: resize-bar
[284.174098] Subtest resize-bar: SKIP (0.013s)
[284.220753] [058/133] (738s left) gem_bad_reloc (negative-reloc)
[284.279685] Subtest negative-reloc: SKIP (0.000s)
[284.344927] [059/133] (738s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[284.438278] Starting subtest: fbc-1p-pri-indfb-multidraw
[297.259642] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.824s)
[298.661029] [060/133] (724s left) kms_pm_backlight (fade)
[298.771918] Starting subtest: fade
[298.824194] Starting dynamic subtest: eDP-1
[301.313351] Dynamic subtest eDP-1: SUCCESS (2.490s)
[301.315693] Subtest fade: SUCCESS (2.541s)
[302.178014] [061/133] (720s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[302.295470] Starting subtest: cursor-vs-flip-legacy
[331.536505] Subtest cursor-vs-flip-legacy: SUCCESS (29.238s)
[332.410183] [062/133] (690s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[332.517814] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[332.520055] Starting dynamic subtest: pipe-A
[332.539269] Dynamic subtest pipe-A: SKIP (0.016s)
[332.548600] Starting dynamic subtest: pipe-B
[332.568534] Dynamic subtest pipe-B: SKIP (0.030s)
[332.577587] Starting dynamic subtest: pipe-C
[332.597711] Dynamic subtest pipe-C: SKIP (0.029s)
[332.606392] Starting dynamic subtest: pipe-D
[332.627366] Dynamic subtest pipe-D: SKIP (0.029s)
[332.631703] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.107s)
[332.727775] [063/133] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[332.842996] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[332.847106] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[332.955993] [064/133] (690s left) gem_exec_fence (long-history)
[333.418583] Starting subtest: long-history
[340.670036] Subtest long-history: SUCCESS (7.252s)
[341.125950] [065/133] (682s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[341.249536] Starting subtest: cursorA-vs-flipA-atomic
[352.374714] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.121s)
[353.235390] [066/133] (670s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[353.335627] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[359.933590] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.600s)
[360.049110] [067/133] (663s left) perf (i915-ref-count)
[360.130299] Starting subtest: i915-ref-count
[360.213417] Subtest i915-ref-count: SUCCESS (0.081s)
[360.270353] [068/133] (663s left) kms_psr (psr-basic)
[360.364268] Starting subtest: psr-basic
[360.366563] Starting dynamic subtest: eDP-1
[362.018749] Dynamic subtest eDP-1: SUCCESS (1.654s)
[362.020923] Subtest psr-basic: SUCCESS (1.655s)
[362.905882] [069/133] (660s left) gem_softpin (evict-prime)
[362.967240] Starting subtest: evict-prime
[362.969650] Starting dynamic subtest: rcs0
[364.119338] Dynamic subtest rcs0: SUCCESS (1.151s)
[364.135705] Starting dynamic subtest: bcs0
[365.246292] Dynamic subtest bcs0: SUCCESS (1.124s)
[365.257711] Starting dynamic subtest: vcs0
[366.870527] Dynamic subtest vcs0: SUCCESS (1.621s)
[366.882817] Starting dynamic subtest: vcs1
[368.857456] Dynamic subtest vcs1: SUCCESS (1.985s)
[368.869587] Starting dynamic subtest: vecs0
[370.839534] Dynamic subtest vecs0: SUCCESS (1.980s)
[370.851186] Starting dynamic subtest: ccs0
[371.959711] Dynamic subtest ccs0: SUCCESS (1.119s)
[371.970872] Starting dynamic subtest: all
[373.844626] Dynamic subtest all: SUCCESS (1.882s)
[373.847543] Subtest evict-prime: SUCCESS (10.876s)
[373.923850] [070/133] (649s left) gem_ctx_persistence (saturated-hostile)
[373.976838] Starting subtest: saturated-hostile
[373.979139] Starting dynamic subtest: rcs0
[374.798559] Dynamic subtest rcs0: SUCCESS (0.821s)
[374.811370] Starting dynamic subtest: bcs0
[375.596635] Dynamic subtest bcs0: SUCCESS (0.796s)
[375.609123] Starting dynamic subtest: vcs0
[376.390073] Dynamic subtest vcs0: SUCCESS (0.792s)
[376.401732] Starting dynamic subtest: vcs1
[377.202071] Dynamic subtest vcs1: SUCCESS (0.810s)
[377.211572] Starting dynamic subtest: vecs0
[377.994335] Dynamic subtest vecs0: SUCCESS (0.791s)
[378.004800] Starting dynamic subtest: ccs0
[378.821678] Dynamic subtest ccs0: SUCCESS (0.826s)
[378.824323] Subtest saturated-hostile: SUCCESS (4.845s)
[378.901582] [071/133] (644s left) kms_invalid_mode (bad-hsync-start)
[379.026510] Starting subtest: bad-hsync-start
[379.028797] Starting dynamic subtest: pipe-A-eDP-1
[379.306870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[379.316057] Starting dynamic subtest: pipe-B-eDP-1
[379.317970] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[379.326059] Starting dynamic subtest: pipe-C-eDP-1
[379.327988] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[379.336510] Starting dynamic subtest: pipe-D-eDP-1
[379.338718] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[379.341005] Subtest bad-hsync-start: SUCCESS (0.289s)
[380.136438] [072/133] (643s left) sw_sync (timeline_closed)
[380.180692] Starting subtest: timeline_closed
[380.183107] Subtest timeline_closed: SUCCESS (0.000s)
[380.234197] [073/133] (643s left) gem_create (create-ext-set-pat)
[380.415897] Starting subtest: create-ext-set-pat
[380.418551] Subtest create-ext-set-pat: SUCCESS (0.001s)
[380.519244] [074/133] (643s left) kms_dsc (dsc-with-bpc-formats)
[380.601843] Starting subtest: dsc-with-bpc-formats
[380.713083] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[380.753731] [075/133] (642s left) gem_vm_create (execbuf)
[380.816962] Starting subtest: execbuf
[380.822357] Subtest execbuf: SUCCESS (0.008s)
[380.944119] [076/133] (642s left) gem_ctx_param (invalid-param-get)
[381.001880] Starting subtest: invalid-param-get
[381.004221] Subtest invalid-param-get: SUCCESS (0.001s)
[381.103427] [077/133] (642s left) gem_sync (basic-store-all)
[381.166460] Starting subtest: basic-store-all
[384.293631] Subtest basic-store-all: SUCCESS (3.138s)
[384.482961] [078/133] (639s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[384.591232] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[391.871331] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.284s)
[392.001503] [079/133] (631s left) gem_close_race (basic-threads)
[392.058375] Starting subtest: basic-threads
[393.471926] Subtest basic-threads: SUCCESS (1.413s)
[393.658611] [080/133] (630s left) kms_cursor_crc (cursor-tearing-position-change)
[393.774058] Starting subtest: cursor-tearing-position-change
[393.776289] Starting dynamic subtest: pipe-A-eDP-1
[394.350407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[394.361609] Starting dynamic subtest: pipe-D-eDP-1
[395.601594] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[395.603508] Subtest cursor-tearing-position-change: SUCCESS (1.827s)
[396.429056] [081/133] (627s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[396.557149] Starting subtest: modeset-atomic-cursor-hotspot
[396.561488] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[396.703247] [082/133] (627s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[396.796861] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[396.801147] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[396.886885] [083/133] (627s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[397.272682] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[398.056562] [084/133] (625s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[398.175317] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[398.179289] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[398.268979] [085/133] (625s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[398.360284] Starting subtest: x-tiled-16bpp-rotate-0
[399.583030] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.222s)
[399.744862] [086/133] (624s left) i915_suspend (sysfs-reader)
[399.798308] Starting subtest: sysfs-reader
[418.209013] Subtest sysfs-reader: SUCCESS (4.032s)
[418.300313] [087/133] (605s left) gem_lmem_swapping (random)
[418.364396] Subtest random: SKIP (0.000s)
[418.408776] [088/133] (605s left) gem_exec_fence (syncobj-timeline-wait)
[419.000474] Starting subtest: syncobj-timeline-wait
[420.323845] Subtest syncobj-timeline-wait: SUCCESS (1.327s)
[422.348192] [089/133] (601s left) gem_mmap_wc (invalid-flags)
[422.423133] Subtest invalid-flags: SKIP (0.000s)
[422.481098] [090/133] (601s left) gem_exec_flush (basic-wb-rw-before-default)
[422.549099] Starting subtest: basic-wb-rw-before-default
[428.015206] Subtest basic-wb-rw-before-default: SUCCESS (5.481s)
[428.203436] [091/133] (596s left) i915_query (query-topology-coherent-slice-mask)
[428.259810] Starting subtest: query-topology-coherent-slice-mask
[428.264167] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[428.373920] [092/133] (596s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[428.462536] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[428.464820] Starting dynamic subtest: pipe-A-eDP-1
[428.473799] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.484904] Starting dynamic subtest: pipe-B-eDP-1
[428.494305] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.506851] Starting dynamic subtest: pipe-C-eDP-1
[428.515393] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.524929] Starting dynamic subtest: pipe-D-eDP-1
[428.533555] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.537853] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[430.693918] [093/133] (593s left) kms_big_fb (linear-32bpp-rotate-180)
[430.791443] Starting subtest: linear-32bpp-rotate-180
[432.234787] Subtest linear-32bpp-rotate-180: SUCCESS (1.446s)
[432.356870] [094/133] (592s left) prime_busy (after-wait)
[432.413173] Starting subtest: after-wait
[432.417580] Starting dynamic subtest: rcs0
[432.441425] Dynamic subtest rcs0: SUCCESS (0.025s)
[432.453209] Starting dynamic subtest: bcs0
[432.488650] Dynamic subtest bcs0: SUCCESS (0.047s)
[432.501663] Starting dynamic subtest: vcs0
[432.529384] Dynamic subtest vcs0: SUCCESS (0.039s)
[432.539314] Starting dynamic subtest: vcs1
[432.571403] Dynamic subtest vcs1: SUCCESS (0.041s)
[432.581604] Starting dynamic subtest: vecs0
[432.611874] Dynamic subtest vecs0: SUCCESS (0.040s)
[432.621847] Starting dynamic subtest: ccs0
[432.652376] Dynamic subtest ccs0: SUCCESS (0.040s)
[432.762940] Subtest after-wait: SUCCESS (0.347s)
[432.854396] [095/133] (591s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[432.959295] Starting subtest: y-tiled-64bpp-rotate-0
[432.963619] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[433.062719] [096/133] (591s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[433.148733] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[439.732697] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.594s)
[439.847517] [097/133] (584s left) gem_pxp (reject-modify-context-protection-off-2)
[439.968456] Starting subtest: reject-modify-context-protection-off-2
[439.971071] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[440.076399] [098/133] (584s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[440.167460] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[440.171499] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[440.258652] [099/133] (584s left) gem_ctx_persistence (engines-hostile-preempt)
[440.319893] Starting subtest: engines-hostile-preempt
[440.322138] Starting dynamic subtest: rcs0
[440.412175] Dynamic subtest rcs0: SUCCESS (0.091s)
[440.427856] Starting dynamic subtest: bcs0
[440.458981] Dynamic subtest bcs0: SUCCESS (0.045s)
[440.473767] Starting dynamic subtest: vcs0
[442.243737] Dynamic subtest vcs0: SUCCESS (1.782s)
[442.259758] Starting dynamic subtest: vcs1
[444.223764] Dynamic subtest vcs1: SUCCESS (1.979s)
[444.242308] Starting dynamic subtest: vecs0
[446.271859] Dynamic subtest vecs0: SUCCESS (2.047s)
[446.284791] Starting dynamic subtest: ccs0
[446.338584] Dynamic subtest ccs0: SUCCESS (0.065s)
[446.341481] Subtest engines-hostile-preempt: SUCCESS (6.024s)
[446.431770] [100/133] (578s left) gem_ctx_param (non-root-set)
[446.491533] Starting subtest: non-root-set
[446.512905] Subtest non-root-set: SUCCESS (0.022s)
[446.619816] [101/133] (578s left) kms_pm_rpm (i2c)
[448.455406] Starting subtest: i2c
[453.589147] Subtest i2c: SUCCESS (5.138s)
[453.678158] [102/133] (571s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[453.743144] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[453.813385] [103/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[453.916980] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[461.520701] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.610s)
[461.635468] [104/133] (563s left) kms_psr (fbc-pr-primary-blt)
[461.736134] Starting subtest: fbc-pr-primary-blt
[461.740327] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[461.810652] [105/133] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[461.908020] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[461.912207] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[462.007984] [106/133] (563s left) kms_vblank (query-idle)
[462.103489] Starting subtest: query-idle
[462.105737] Starting dynamic subtest: pipe-A-eDP-1
[463.850776] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.748s)
[463.866090] Starting dynamic subtest: pipe-D-eDP-1
[466.321201] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.469s)
[466.323520] Subtest query-idle: SUCCESS (4.220s)
[467.146481] [107/133] (557s left) kms_async_flips (crc)
[467.244065] Starting subtest: crc
[467.612163] Starting dynamic subtest: pipe-A-eDP-1
[470.580592] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.968s)
[470.961911] Starting dynamic subtest: pipe-B-eDP-1
[473.893083] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.943s)
[474.271538] Starting dynamic subtest: pipe-C-eDP-1
[477.209929] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.948s)
[477.581193] Starting dynamic subtest: pipe-D-eDP-1
[480.427144] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.858s)
[480.429404] Subtest crc: SUCCESS (13.191s)
[481.589694] [108/133] (543s left) gem_exec_whisper (basic-queues-forked-all)
[481.660729] Starting subtest: basic-queues-forked-all
[501.433666] Subtest basic-queues-forked-all: SUCCESS (19.780s)
[501.626719] [109/133] (523s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[501.728191] Starting subtest: yf-tiled-8bpp-rotate-270
[501.732674] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[501.841156] [110/133] (523s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[501.941888] Starting subtest: psr-rgb565-draw-pwrite
[508.974800] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.040s)
[509.087371] [111/133] (516s left) vgem_basic (busy-fence)
[509.130978] Starting subtest: busy-fence
[509.133344] Subtest busy-fence: SUCCESS (0.000s)
[509.190624] [112/133] (516s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[509.281565] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[509.308752] Starting dynamic subtest: pipe-A-plane-0
[509.596815] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[509.608185] Starting dynamic subtest: pipe-A-plane-3
[509.830212] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[510.890950] Starting dynamic subtest: pipe-B-plane-0
[511.181593] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[511.193563] Starting dynamic subtest: pipe-B-plane-3
[511.415269] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[511.728493] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.447s)
[512.555269] [113/133] (512s left) kms_content_protection (atomic-hdcp14)
[512.697528] Starting subtest: atomic-hdcp14
[512.702186] Subtest atomic-hdcp14: SKIP (0.000s)
[512.831392] [114/133] (512s left) kms_flip (plain-flip-ts-check-interruptible)
[512.920658] Starting subtest: plain-flip-ts-check-interruptible
[512.923021] Starting dynamic subtest: A-eDP1
[521.766239] Dynamic subtest A-eDP1: SUCCESS (8.849s)
[521.780301] Starting dynamic subtest: B-eDP1
[530.595189] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[530.608886] Starting dynamic subtest: C-eDP1
[539.416785] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[539.429581] Starting dynamic subtest: D-eDP1
[548.248155] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[548.250618] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.348s)
[549.427362] [115/133] (475s left) kms_flip (basic-plain-flip)
[549.514722] Starting subtest: basic-plain-flip
[549.517143] Starting dynamic subtest: A-eDP1
[551.238151] Dynamic subtest A-eDP1: SUCCESS (1.723s)
[551.254188] Starting dynamic subtest: B-eDP1
[552.876678] Dynamic subtest B-eDP1: SUCCESS (1.636s)
[552.891931] Starting dynamic subtest: C-eDP1
[554.603748] Dynamic subtest C-eDP1: SUCCESS (1.725s)
[554.615698] Starting dynamic subtest: D-eDP1
[556.235714] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[556.240703] Subtest basic-plain-flip: SUCCESS (6.731s)
[557.420169] [116/133] (468s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[557.531335] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[557.535720] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[557.635804] [117/133] (467s left) gem_exec_schedule (preempt-hang)
[557.809859] Starting subtest: preempt-hang
[557.812819] Starting dynamic subtest: rcs0
[558.051369] Dynamic subtest rcs0: SUCCESS (0.241s)
[558.062176] Starting dynamic subtest: bcs0
[558.287660] Dynamic subtest bcs0: SUCCESS (0.236s)
[558.300996] Starting dynamic subtest: vcs0
[558.516763] Dynamic subtest vcs0: SUCCESS (0.227s)
[558.531518] Starting dynamic subtest: vcs1
[558.758452] Dynamic subtest vcs1: SUCCESS (0.240s)
[558.770573] Starting dynamic subtest: vecs0
[558.978825] Dynamic subtest vecs0: SUCCESS (0.221s)
[558.988847] Starting dynamic subtest: ccs0
[559.206233] Dynamic subtest ccs0: SUCCESS (0.227s)
[559.208139] Subtest preempt-hang: SUCCESS (1.398s)
[560.404695] [118/133] (465s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[560.515141] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[560.517437] Starting dynamic subtest: pipe-A-eDP-1
[560.587928] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[560.598476] Starting dynamic subtest: pipe-B-eDP-1
[561.689701] Dynamic subtest pipe-B-eDP-1: SKIP (1.100s)
[561.694138] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.179s)
[562.872410] [119/133] (462s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[562.961199] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[567.511871] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.557s)
[568.678880] [120/133] (456s left) gem_exec_schedule (u-semaphore-user)
[568.753686] Starting subtest: u-semaphore-user
[568.804332] Subtest u-semaphore-user: SUCCESS (0.059s)
[570.284700] [121/133] (455s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[570.345610] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[570.408049] [122/133] (455s left) gem_fence_thrash (bo-copy)
[570.447594] Starting subtest: bo-copy
[570.469640] Subtest bo-copy: SKIP (0.020s)
[570.537198] [123/133] (455s left) sw_sync (alloc_fence)
[570.576314] Starting subtest: alloc_fence
[570.578403] Subtest alloc_fence: SUCCESS (0.000s)
[570.663733] [124/133] (455s left) gem_exec_store (cachelines)
[570.728098] Starting subtest: cachelines
[570.730301] Starting dynamic subtest: rcs0
[570.791561] Dynamic subtest rcs0: SUCCESS (0.063s)
[570.803283] Starting dynamic subtest: bcs0
[570.848893] Dynamic subtest bcs0: SUCCESS (0.056s)
[570.862407] Starting dynamic subtest: vcs0
[570.914745] Dynamic subtest vcs0: SUCCESS (0.063s)
[570.928128] Starting dynamic subtest: vcs1
[570.975735] Dynamic subtest vcs1: SUCCESS (0.059s)
[570.987894] Starting dynamic subtest: vecs0
[571.040109] Dynamic subtest vecs0: SUCCESS (0.062s)
[571.053429] Starting dynamic subtest: ccs0
[571.101011] Dynamic subtest ccs0: SUCCESS (0.059s)
[571.103414] Subtest cachelines: SUCCESS (0.374s)
[571.294291] [125/133] (454s left) gem_mmap_wc (write-cpu-read-wc)
[571.344085] Subtest write-cpu-read-wc: SKIP (0.000s)
[571.406669] [126/133] (454s left) gem_render_copy (yf-tiled-to-vebox-linear)
[571.466264] Starting subtest: yf-tiled-to-vebox-linear
[571.469657] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[571.665475] [127/133] (454s left) kms_plane_cursor (viewport)
[571.763238] Starting subtest: viewport
[571.767579] Starting dynamic subtest: pipe-A-eDP-1-size-64
[574.302708] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.541s)
[574.366377] Starting dynamic subtest: pipe-A-eDP-1-size-128
[576.769868] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.415s)
[576.834239] Starting dynamic subtest: pipe-A-eDP-1-size-256
[579.235963] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.415s)
[579.596845] Starting dynamic subtest: pipe-B-eDP-1-size-64
[582.666096] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.081s)
[582.728384] Starting dynamic subtest: pipe-B-eDP-1-size-128
[585.086107] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.370s)
[585.154194] Starting dynamic subtest: pipe-B-eDP-1-size-256
[587.677747] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.540s)
[588.043370] Starting dynamic subtest: pipe-C-eDP-1-size-64
[590.812833] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.781s)
[590.853672] Starting dynamic subtest: pipe-C-eDP-1-size-128
[592.912257] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.069s)
[592.952301] Starting dynamic subtest: pipe-C-eDP-1-size-256
[595.078558] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.136s)
[595.416325] Starting dynamic subtest: pipe-D-eDP-1-size-64
[598.198648] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.796s)
[598.239268] Starting dynamic subtest: pipe-D-eDP-1-size-128
[600.308422] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.080s)
[600.353243] Starting dynamic subtest: pipe-D-eDP-1-size-256
[602.418925] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.080s)
[602.735918] Subtest viewport: SUCCESS (30.988s)
[603.593457] [128/133] (422s left) gem_eio (wait-wedge-10ms)
[603.824570] Starting subtest: wait-wedge-10ms
[605.389138] Subtest wait-wedge-10ms: SUCCESS (1.565s)
[605.525749] [129/133] (420s left) core_sysfs (read-all-entries)
[605.579649] Starting subtest: read-all-entries
[605.584614] Subtest read-all-entries: SUCCESS (0.007s)
[605.682827] [130/133] (420s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[605.778869] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[605.781146] Starting dynamic subtest: pipe-A-eDP-1
[605.897651] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[605.908975] Starting dynamic subtest: pipe-B-eDP-1
[607.050781] Dynamic subtest pipe-B-eDP-1: SKIP (1.152s)
[607.054888] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.276s)
[608.243516] [131/133] (417s left) kms_plane_scaling (invalid-parameters)
[608.340499] Starting subtest: invalid-parameters
[608.342792] Starting dynamic subtest: less-than-1-height-src
[608.353111] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[608.364055] Starting dynamic subtest: less-than-1-width-src
[608.369140] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s)
[608.370993] Subtest invalid-parameters: SUCCESS (0.028s)
[608.469203] [132/133] (417s left) kms_psr (fbc-psr2-suspend)
[608.561375] Starting subtest: fbc-psr2-suspend
[608.563651] Starting dynamic subtest: eDP-1
[608.567956] Dynamic subtest eDP-1: SKIP (0.000s)
[608.572292] Subtest fbc-psr2-suspend: SKIP (0.001s)
[608.636827] [133/133] (417s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[608.731950] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[616.225186] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.425s)
[616.362686] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_pread
results: parsing output: 2/ for test: gem_flink_race
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: i915_pm_rc6_residency
results: parsing output: 10/ for test: kms_universal_plane
results: parsing output: 11/ for test: prime_mmap
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: gen9_exec_parse
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: kms_scaling_modes
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_atomic_transition
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: i915_drm_fdinfo
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: prime_vgem
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: gem_exec_alignment
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_capture
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_cursor_crc
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_ctx_bad_destroy
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: i915_module_load
results: parsing output: 57/ for test: gem_bad_reloc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_pm_backlight
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: sw_sync
results: parsing output: 72/ for test: gem_create
results: parsing output: 73/ for test: kms_dsc
results: parsing output: 74/ for test: gem_vm_create
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: gem_sync
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_close_race
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_suspend
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: gem_exec_flush
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: prime_busy
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: gem_ctx_param
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: vgem_basic
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: gem_fenced_exec_thrash
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: gem_exec_store
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: kms_plane_cursor
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: core_sysfs
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.