[56.985273] Initializing watchdogs
[56.985346]   /dev/watchdog0
[56.999769] [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]
[57.004380] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.006631] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.010080] [001/132] (960s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[57.137509] Starting subtest: 4-tiled-addfb-size-offset-overflow
[57.139774] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[57.260132] [002/132] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[57.373808] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[57.376172] Starting dynamic subtest: pipe-A-eDP-1
[57.494102] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[57.502842] Starting dynamic subtest: pipe-B-eDP-1
[58.703663] Dynamic subtest pipe-B-eDP-1: SKIP (1.208s)
[58.708058] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.335s)
[59.999576] [003/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[60.101445] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[60.105579] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[60.211590] [004/132] (957s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[60.451648] Starting subtest: cursor-rapid-movement-256x256
[60.453895] Starting dynamic subtest: pipe-A-eDP-1
[61.017829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[61.049364] Starting dynamic subtest: pipe-D-eDP-1
[62.205998] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.161s)
[62.208044] Subtest cursor-rapid-movement-256x256: SUCCESS (1.755s)
[63.078960] [005/132] (954s left) syncobj_wait (wait-delayed-signal)
[63.140733] Starting subtest: wait-delayed-signal
[63.244645] Subtest wait-delayed-signal: SUCCESS (0.102s)
[63.327610] [006/132] (954s left) gem_ctx_param (root-set)
[63.375648] Starting subtest: root-set
[63.378057] Subtest root-set: SUCCESS (0.001s)
[63.490246] [007/132] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[63.552964] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[63.557347] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[63.741219] [008/132] (954s left) i915_query (query-regions-garbage-items)
[63.801105] Starting subtest: query-regions-garbage-items
[63.803551] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[63.895195] [009/132] (953s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[63.990378] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[63.992667] Starting dynamic subtest: pipe-A-default-mode
[66.713781] Dynamic subtest pipe-A-default-mode: SUCCESS (2.721s)
[66.716233] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.722s)
[67.592355] [010/132] (950s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[67.744058] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[67.746401] Starting dynamic subtest: pipe-A
[67.807250] Dynamic subtest pipe-A: SUCCESS (0.065s)
[67.816768] Starting dynamic subtest: pipe-B
[68.993356] Dynamic subtest pipe-B: SUCCESS (1.186s)
[69.001265] Starting dynamic subtest: pipe-C
[70.091946] Dynamic subtest pipe-C: SUCCESS (1.098s)
[70.098766] Starting dynamic subtest: pipe-D
[71.231627] Dynamic subtest pipe-D: SUCCESS (1.139s)
[71.233957] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.490s)
[72.409279] [011/132] (945s left) kms_psr (fbc-psr2-primary-blt)
[72.513940] Starting subtest: fbc-psr2-primary-blt
[72.515973] Starting dynamic subtest: eDP-1
[72.520171] Dynamic subtest eDP-1: SKIP (0.000s)
[72.524392] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[72.596215] [012/132] (945s left) kms_pm_lpsp (kms-lpsp)
[73.711655] Starting subtest: kms-lpsp
[73.714053] Starting dynamic subtest: pipe-A-eDP-1
[73.856117] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[74.162796] Subtest kms-lpsp: SUCCESS (0.454s)
[75.021462] [013/132] (942s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[75.077092] Starting subtest: multi-wait-available-unsubmitted-submitted
[75.079135] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[75.182083] [014/132] (942s left) kms_atomic_interruptible (universal-setplane-primary)
[75.282061] Starting subtest: universal-setplane-primary
[75.284402] Starting dynamic subtest: pipe-A-eDP-1
[82.742240] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.460s)
[82.744678] Subtest universal-setplane-primary: SUCCESS (7.461s)
[83.573913] [015/132] (934s left) api_intel_allocator (two-level-inception-interruptible)
[83.622529] Starting subtest: two-level-inception-interruptible
[89.029710] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[89.164837] [016/132] (928s left) kms_joiner (basic-force-ultra-joiner)
[89.282249] Starting subtest: basic-force-ultra-joiner
[89.286460] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[89.364209] [017/132] (928s left) kms_getfb (getfb-handle-zero)
[89.476545] Starting subtest: getfb-handle-zero
[89.478863] Subtest getfb-handle-zero: SUCCESS (0.000s)
[89.617355] [018/132] (928s left) kms_fbcon_fbt (psr)
[89.693055] Starting subtest: psr
[96.971810] Subtest psr: SUCCESS (7.276s)
[97.043970] [019/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[97.153212] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[97.157229] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[97.285836] [020/132] (920s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[97.714867] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[98.501909] [021/132] (919s left) gem_exec_whisper (basic-sync-all)
[98.560981] Starting subtest: basic-sync-all
[105.308643] Subtest basic-sync-all: SUCCESS (6.746s)
[105.511605] [022/132] (912s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[105.617866] Starting subtest: x-tiled-32bpp-rotate-90
[105.637597] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[105.759675] [023/132] (912s left) kms_psr (fbc-pr-basic)
[105.854104] Starting subtest: fbc-pr-basic
[105.858425] Subtest fbc-pr-basic: SKIP (0.000s)
[105.939049] [024/132] (912s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[106.037162] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[106.041409] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[106.146139] [025/132] (912s left) perf_pmu (init-wait)
[106.185932] Starting subtest: init-wait
[106.188400] Starting dynamic subtest: rcs0
[106.190770] Dynamic subtest rcs0: SUCCESS (0.002s)
[106.200726] Starting dynamic subtest: bcs0
[106.202602] Dynamic subtest bcs0: SUCCESS (0.001s)
[106.209402] Starting dynamic subtest: vcs0
[106.211267] Dynamic subtest vcs0: SUCCESS (0.001s)
[106.218085] Starting dynamic subtest: vcs1
[106.219946] Dynamic subtest vcs1: SUCCESS (0.001s)
[106.227169] Starting dynamic subtest: vecs0
[106.229333] Dynamic subtest vecs0: SUCCESS (0.001s)
[106.236377] Starting dynamic subtest: ccs0
[106.238710] Dynamic subtest ccs0: SUCCESS (0.001s)
[106.241199] Subtest init-wait: SUCCESS (0.009s)
[106.318953] [026/132] (912s left) kms_legacy_colorkey (invalid-plane)
[106.413695] Starting subtest: invalid-plane
[106.415936] Starting dynamic subtest: zero-id
[106.418206] Dynamic subtest zero-id: SUCCESS (0.000s)
[106.425589] Starting dynamic subtest: outrange-id
[106.427475] Dynamic subtest outrange-id: SUCCESS (0.000s)
[106.429371] Subtest invalid-plane: SUCCESS (0.001s)
[106.490929] [027/132] (912s left) kms_vblank (wait-busy-hang)
[106.577410] Starting subtest: wait-busy-hang
[106.579207] Starting dynamic subtest: pipe-A-eDP-1
[132.693266] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.116s)
[132.707232] Starting dynamic subtest: pipe-D-eDP-1
[157.666569] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.967s)
[157.668754] Subtest wait-busy-hang: SUCCESS (51.087s)
[158.491375] [028/132] (860s left) syncobj_eventfd (binary-wait)
[158.556966] Starting subtest: binary-wait
[158.566069] Subtest binary-wait: SUCCESS (0.010s)
[158.687609] [029/132] (859s left) gem_mmap_gtt (basic-read-write)
[158.741830] Subtest basic-read-write: SKIP (0.000s)
[158.809270] [030/132] (859s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[158.935126] Starting subtest: basic-busy-flip-before-cursor-varying-size
[158.939393] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[159.117245] [031/132] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[159.232737] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[163.729074] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.500s)
[164.890885] [032/132] (853s left) gem_exec_fence (syncobj-repeat)
[165.334222] Starting subtest: syncobj-repeat
[165.506028] Subtest syncobj-repeat: SUCCESS (0.173s)
[167.016993] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[167.020383] [033/132] (851s left) gem_mmap_gtt (basic-wc)
[167.086354] Subtest basic-wc: SKIP (0.000s)
[167.156909] [034/132] (851s left) kms_atomic (test-only)
[167.263937] Starting subtest: test-only
[167.316765] Starting dynamic subtest: pipe-A-eDP-1
[169.800196] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.484s)
[169.802513] Subtest test-only: SUCCESS (2.538s)
[170.689920] [035/132] (848s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[170.792698] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[170.797187] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[170.929067] [036/132] (847s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[171.047284] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[172.447570] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.400s)
[173.326870] [037/132] (845s left) kms_vrr (seamless-rr-switch-drrs)
[173.431194] Starting subtest: seamless-rr-switch-drrs
[173.437314] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[173.514980] [038/132] (845s left) kms_content_protection (content-type-change)
[173.674104] Starting subtest: content-type-change
[173.678662] Subtest content-type-change: SKIP (0.000s)
[173.832495] [039/132] (845s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[173.939953] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[173.944310] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[174.032282] [040/132] (845s left) i915_pm_rpm (system-suspend-devices)
[176.062764] Starting subtest: system-suspend-devices
[183.865058] Subtest system-suspend-devices: SUCCESS (7.805s)
[184.249972] [041/132] (834s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[184.364824] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[185.365662] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.001s)
[185.540625] [042/132] (833s left) gem_mmap_gtt (basic-write-read-distinct)
[185.600026] Subtest basic-write-read-distinct: SKIP (0.000s)
[185.663772] [043/132] (833s left) gem_ctx_shared (q-in-order)
[185.725071] Starting subtest: Q-in-order
[185.727158] Starting dynamic subtest: rcs0
[185.828765] Dynamic subtest rcs0: SUCCESS (0.103s)
[185.845979] Starting dynamic subtest: vcs0
[185.907867] Dynamic subtest vcs0: SUCCESS (0.078s)
[185.923572] Starting dynamic subtest: vcs1
[185.982656] Dynamic subtest vcs1: SUCCESS (0.074s)
[185.997924] Starting dynamic subtest: vecs0
[186.052811] Dynamic subtest vecs0: SUCCESS (0.070s)
[186.067700] Starting dynamic subtest: ccs0
[186.127395] Dynamic subtest ccs0: SUCCESS (0.075s)
[186.129430] Subtest Q-in-order: SUCCESS (0.402s)
[187.021720] [044/132] (832s left) syncobj_timeline (wait-all-complex)
[187.082465] Starting subtest: wait-all-complex
[187.295511] Subtest wait-all-complex: SUCCESS (0.213s)
[187.400440] [045/132] (831s left) kms_async_flips (alternate-sync-async-flip-atomic)
[187.493258] Starting subtest: alternate-sync-async-flip-atomic
[187.866138] Starting dynamic subtest: pipe-A-eDP-1
[190.610973] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.744s)
[191.002184] Starting dynamic subtest: pipe-B-eDP-1
[193.751470] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[194.131232] Starting dynamic subtest: pipe-C-eDP-1
[196.879150] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.755s)
[197.252905] Starting dynamic subtest: pipe-D-eDP-1
[200.011752] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[200.013760] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.518s)
[201.203216] [046/132] (818s left) gem_ctx_create (basic-files)
[201.286643] Starting subtest: basic-files
[203.296530] Subtest basic-files: SUCCESS (2.010s)
[204.946909] [047/132] (814s left) gem_tiling_max_stride
[205.083095] [048/132] (814s left) i915_drm_fdinfo (virtual-idle)
[205.120936] Starting subtest: virtual-idle
[208.196071] Subtest virtual-idle: SUCCESS (3.075s)
[208.285016] [049/132] (811s left) kms_chamelium_edid (dp-edid-read)
[208.673407] Subtest dp-edid-read: SKIP (0.000s)
[209.490278] [050/132] (810s left) gem_ctx_persistence (process)
[209.549718] Starting subtest: process
[209.737687] Subtest process: SUCCESS (0.190s)
[209.879174] [051/132] (809s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[209.982282] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[209.984574] Starting dynamic subtest: pipe-A-eDP-1
[209.993800] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.004236] Starting dynamic subtest: pipe-B-eDP-1
[210.013254] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.022511] Starting dynamic subtest: pipe-C-eDP-1
[210.031244] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.039937] Starting dynamic subtest: pipe-D-eDP-1
[210.048452] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.052894] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[212.201552] [052/132] (807s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[212.303387] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[212.305738] Starting dynamic subtest: A-eDP1
[215.923568] Dynamic subtest A-eDP1: SUCCESS (3.615s)
[215.933916] Starting dynamic subtest: B-eDP1
[219.137041] Dynamic subtest B-eDP1: SUCCESS (3.213s)
[219.146747] Starting dynamic subtest: C-eDP1
[222.231096] Dynamic subtest C-eDP1: SUCCESS (3.092s)
[222.244623] Starting dynamic subtest: D-eDP1
[225.331904] Dynamic subtest D-eDP1: SUCCESS (3.102s)
[225.334706] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.031s)
[226.137801] [053/132] (793s left) core_setmaster (master-drop-set-shared-fd)
[226.221857] Starting subtest: master-drop-set-shared-fd
[226.229115] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[226.269214] [054/132] (793s left) api_intel_bb (simple-bb)
[226.324048] Starting subtest: simple-bb
[226.328851] Subtest simple-bb: SUCCESS (0.006s)
[226.490524] [055/132] (793s left) gem_exec_suspend (basic-s3-devices)
[226.559411] Starting subtest: basic-S3-devices
[226.561752] Starting dynamic subtest: smem
[237.909050] Dynamic subtest smem: SUCCESS (11.347s)
[237.912076] Subtest basic-S3-devices: SUCCESS (11.349s)
[238.106759] [056/132] (781s left) gem_exec_reloc (basic-write-gtt-active)
[238.187393] Subtest basic-write-gtt-active: SKIP (0.000s)
[238.287325] [057/132] (781s left) syncobj_wait (single-wait-all-submitted)
[238.355402] Starting subtest: single-wait-all-submitted
[238.457485] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[238.545160] [058/132] (781s left) gem_exec_schedule (submit-late-slice)
[238.624096] Starting subtest: submit-late-slice
[238.626482] Starting dynamic subtest: rcs0
[238.655374] Dynamic subtest rcs0: SUCCESS (0.039s)
[238.667028] Starting dynamic subtest: bcs0
[238.686141] Dynamic subtest bcs0: SUCCESS (0.030s)
[238.698266] Starting dynamic subtest: vcs0
[238.718648] Dynamic subtest vcs0: SUCCESS (0.032s)
[238.727857] Starting dynamic subtest: vcs1
[238.749785] Dynamic subtest vcs1: SUCCESS (0.030s)
[238.761770] Starting dynamic subtest: vecs0
[238.776631] Dynamic subtest vecs0: SUCCESS (0.026s)
[238.785352] Starting dynamic subtest: ccs0
[238.804741] Dynamic subtest ccs0: SUCCESS (0.027s)
[238.807071] Subtest submit-late-slice: SUCCESS (0.189s)
[240.025556] [059/132] (779s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[240.127534] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[240.140923] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.012s)
[240.230633] [060/132] (779s left) gem_pxp (create-valid-protected-context)
[240.364478] Starting subtest: create-valid-protected-context
[240.366920] Subtest create-valid-protected-context: SUCCESS (0.002s)
[240.501702] [061/132] (779s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[240.609706] Starting subtest: fbcpsr-tiling-linear
[247.339304] Subtest fbcpsr-tiling-linear: SUCCESS (6.732s)
[247.501818] [062/132] (772s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[247.603809] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[247.606158] Starting dynamic subtest: pipe-A-eDP-1
[247.682455] Dynamic subtest pipe-A-eDP-1: SKIP (0.080s)
[247.692339] Starting dynamic subtest: pipe-B-eDP-1
[248.846531] Dynamic subtest pipe-B-eDP-1: SKIP (1.162s)
[248.851177] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.245s)
[250.143362] [063/132] (769s left) gem_ctx_persistence (engines-mixed-process)
[250.208676] Starting subtest: engines-mixed-process
[250.211239] Starting dynamic subtest: rcs0
[251.878402] Dynamic subtest rcs0: SUCCESS (1.669s)
[251.890348] Starting dynamic subtest: bcs0
[253.915236] Dynamic subtest bcs0: SUCCESS (2.036s)
[253.934312] Starting dynamic subtest: vcs0
[255.905220] Dynamic subtest vcs0: SUCCESS (1.987s)
[255.916332] Starting dynamic subtest: vcs1
[257.973901] Dynamic subtest vcs1: SUCCESS (2.066s)
[257.985553] Starting dynamic subtest: vecs0
[259.947047] Dynamic subtest vecs0: SUCCESS (1.971s)
[259.966260] Starting dynamic subtest: ccs0
[261.841479] Dynamic subtest ccs0: SUCCESS (1.892s)
[261.843965] Subtest engines-mixed-process: SUCCESS (11.633s)
[261.954274] [064/132] (758s left) gem_ccs (block-copy-compressed)
[262.011263] Starting subtest: block-copy-compressed
[262.015826] Subtest block-copy-compressed: SKIP (0.000s)
[262.141199] [065/132] (758s left) gem_eio (unwedge-stress)
[262.376259] Starting subtest: unwedge-stress
[262.378886] Starting dynamic subtest: render
[267.520867] Dynamic subtest render: SUCCESS (5.142s)
[267.537826] Starting dynamic subtest: bsd1
[285.400401] Dynamic subtest bsd1: SUCCESS (17.878s)
[285.417871] Starting dynamic subtest: bsd2
[305.479060] Dynamic subtest bsd2: SUCCESS (20.077s)
[305.495050] Starting dynamic subtest: blt
[305.499287] Dynamic subtest blt: SKIP (0.000s)
[305.508316] Starting dynamic subtest: vebox
[323.360478] Dynamic subtest vebox: SUCCESS (17.880s)
[323.362339] Subtest unwedge-stress: SUCCESS (60.982s)
[324.935363] [066/132] (695s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[324.989984] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[325.061466] [067/132] (695s left) kms_flip (busy-flip)
[325.167920] Starting subtest: busy-flip
[325.170309] Starting dynamic subtest: A-eDP1
[326.832735] Dynamic subtest A-eDP1: SUCCESS (1.663s)
[326.847523] Starting dynamic subtest: B-eDP1
[328.561725] Dynamic subtest B-eDP1: SUCCESS (1.727s)
[328.572758] Starting dynamic subtest: C-eDP1
[330.190034] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[330.200413] Starting dynamic subtest: D-eDP1
[331.821089] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[331.826600] Subtest busy-flip: SUCCESS (6.659s)
[333.100361] [068/132] (687s left) i915_drm_fdinfo (virtual-busy-hang)
[333.156813] Starting subtest: virtual-busy-hang
[333.161441] Subtest virtual-busy-hang: SKIP (0.000s)
[333.241465] [069/132] (687s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[333.331194] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[333.335475] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[333.416645] [070/132] (686s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[333.507056] Starting subtest: invalidate-primary-flip-overlay
[344.315167] Subtest invalidate-primary-flip-overlay: SUCCESS (10.810s)
[344.465573] [071/132] (675s left) kms_pm_rpm (system-suspend-idle)
[345.979117] Starting subtest: system-suspend-idle
[366.004753] Subtest system-suspend-idle: SUCCESS (4.611s)
[366.388526] [072/132] (654s left) gem_ccs (suspend-resume)
[366.450872] Starting subtest: suspend-resume
[366.455340] Subtest suspend-resume: SKIP (0.000s)
[366.582533] [073/132] (653s left) kms_big_fb (linear-16bpp-rotate-180)
[366.682201] Starting subtest: linear-16bpp-rotate-180
[368.105701] Subtest linear-16bpp-rotate-180: SUCCESS (1.423s)
[368.254243] [074/132] (652s left) kms_plane_lowres (tiling-x)
[368.358915] Starting subtest: tiling-x
[368.360768] Starting dynamic subtest: pipe-A-eDP-1
[368.364480] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[368.664309] Starting dynamic subtest: pipe-B-eDP-1
[368.668914] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[368.678201] Starting dynamic subtest: pipe-C-eDP-1
[368.682749] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[368.691756] Starting dynamic subtest: pipe-D-eDP-1
[368.695869] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[368.699951] Subtest tiling-x: SKIP (0.308s)
[369.506659] [075/132] (651s left) gem_close_race (basic-threads)
[369.586441] Starting subtest: basic-threads
[370.974926] Subtest basic-threads: SUCCESS (1.389s)
[371.181409] [076/132] (649s left) kms_getfb (getfb-handle-protection)
[371.275328] Starting subtest: getfb-handle-protection
[371.297024] Subtest getfb-handle-protection: SUCCESS (0.022s)
[371.450346] [077/132] (649s left) kms_feature_discovery (display)
[371.538957] Starting subtest: display
[371.541274] Subtest display: SUCCESS (0.000s)
[371.624127] [078/132] (649s left) kms_chamelium_color (ctm-0-25)
[371.723476] Subtest ctm-0-25: SKIP (0.000s)
[371.770658] [079/132] (648s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[371.879219] Starting subtest: y-tiled-8bpp-rotate-180
[371.883450] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[372.030150] [080/132] (648s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[372.150821] Starting subtest: flip-vs-cursor-crc-atomic
[372.815456] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.665s)
[373.643204] [081/132] (647s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[373.747953] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[381.096633] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.347s)
[381.246011] [082/132] (639s left) kms_frontbuffer_tracking (psr-1p-rte)
[381.346943] Starting subtest: psr-1p-rte
[386.745592] Subtest psr-1p-rte: SUCCESS (5.400s)
[386.913325] [083/132] (633s left) gem_wait (write-wait)
[386.980610] Starting subtest: write-wait
[386.983019] Starting dynamic subtest: all-engines
[388.108940] Dynamic subtest all-engines: SUCCESS (1.128s)
[388.126395] Starting dynamic subtest: rcs0
[389.166734] Dynamic subtest rcs0: SUCCESS (1.055s)
[389.184731] Starting dynamic subtest: bcs0
[390.224497] Dynamic subtest bcs0: SUCCESS (1.055s)
[390.242266] Starting dynamic subtest: vcs0
[391.277433] Dynamic subtest vcs0: SUCCESS (1.050s)
[391.292905] Starting dynamic subtest: vcs1
[392.332634] Dynamic subtest vcs1: SUCCESS (1.053s)
[392.350745] Starting dynamic subtest: vecs0
[393.387776] Dynamic subtest vecs0: SUCCESS (1.052s)
[393.405128] Starting dynamic subtest: ccs0
[394.444447] Dynamic subtest ccs0: SUCCESS (1.054s)
[394.447011] Subtest write-wait: SUCCESS (7.463s)
[394.652933] [084/132] (626s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[394.756436] Starting subtest: bad-pixel-format-y-tiled-ccs
[394.758678] Starting dynamic subtest: pipe-A-eDP-1
[394.780380] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[394.790655] Starting dynamic subtest: pipe-B-eDP-1
[394.812122] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[394.821363] Starting dynamic subtest: pipe-C-eDP-1
[394.841534] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[394.851400] Starting dynamic subtest: pipe-D-eDP-1
[394.872383] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[394.876383] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.006s)
[397.037068] [085/132] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[397.144437] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[397.148714] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[397.277082] [086/132] (623s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[397.375739] Starting subtest: fbc-shrfb-scaledprimary
[400.336964] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.965s)
[401.543561] [087/132] (619s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[401.641121] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[401.643365] Starting dynamic subtest: pipe-A-eDP-1
[401.665239] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[401.675324] Starting dynamic subtest: pipe-B-eDP-1
[401.695441] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[401.704499] Starting dynamic subtest: pipe-C-eDP-1
[401.724641] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.733626] Starting dynamic subtest: pipe-D-eDP-1
[401.755158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.759440] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[403.886774] [088/132] (617s left) gen9_exec_parse (bb-large)
[403.952576] Subtest bb-large: SKIP (0.000s)
[404.042820] [089/132] (617s left) perf (i915-ref-count)
[404.119755] Starting subtest: i915-ref-count
[404.186333] Subtest i915-ref-count: SUCCESS (0.067s)
[404.240939] [090/132] (616s left) sw_sync (alloc_fence_invalid_timeline)
[404.277580] Starting subtest: alloc_fence_invalid_timeline
[404.279413] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[404.354875] [091/132] (616s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[404.458746] Starting subtest: psr-modesetfrombusy
[410.733774] Subtest psr-modesetfrombusy: SUCCESS (6.280s)
[410.918257] [092/132] (610s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[411.031136] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[411.034772] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[411.160188] [093/132] (610s left) gem_softpin (allocator-basic)
[411.223800] Starting subtest: allocator-basic
[411.294023] Subtest allocator-basic: SUCCESS (0.070s)
[411.436963] [094/132] (609s left) gem_render_copy (linear-to-vebox-y-tiled)
[411.490193] Starting subtest: linear-to-vebox-y-tiled
[411.494093] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[411.688980] [095/132] (609s left) gem_mmap_gtt (hang)
[411.741102] Subtest hang: SKIP (0.000s)
[411.804821] [096/132] (609s left) gem_exec_schedule (out-order)
[411.877534] Starting subtest: out-order
[411.879837] Starting dynamic subtest: rcs0
[411.972565] Dynamic subtest rcs0: SUCCESS (0.103s)
[411.985199] Starting dynamic subtest: vcs0
[412.051175] Dynamic subtest vcs0: SUCCESS (0.078s)
[412.063251] Starting dynamic subtest: vcs1
[412.126323] Dynamic subtest vcs1: SUCCESS (0.075s)
[412.138378] Starting dynamic subtest: vecs0
[412.201427] Dynamic subtest vecs0: SUCCESS (0.074s)
[412.213542] Starting dynamic subtest: ccs0
[412.282836] Dynamic subtest ccs0: SUCCESS (0.080s)
[412.285917] Subtest out-order: SUCCESS (0.414s)
[413.448645] [097/132] (608s left) gem_exec_reloc (basic-scanout)
[413.522003] Subtest basic-scanout: SKIP (0.000s)
[413.606020] [098/132] (607s left) kms_psr (fbc-psr-primary-render)
[413.704987] Starting subtest: fbc-psr-primary-render
[413.707075] Starting dynamic subtest: eDP-1
[413.710910] Dynamic subtest eDP-1: SKIP (0.000s)
[413.714772] Subtest fbc-psr-primary-render: SKIP (0.001s)
[413.793978] [099/132] (607s left) prime_mmap (test_correct_cpu_write)
[413.852885] Starting subtest: test_correct_cpu_write
[413.855314] Starting dynamic subtest: test_correct_cpu_write-smem
[413.857656] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[413.859641] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[413.994242] [100/132] (607s left) syncobj_timeline (invalid-signal-zero-handles)
[414.055869] Starting subtest: invalid-signal-zero-handles
[414.058239] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[414.177850] [101/132] (607s left) kms_cursor_legacy (torture-bo)
[414.296131] Starting subtest: torture-bo
[414.298412] Starting dynamic subtest: pipe-A
[420.609947] Dynamic subtest pipe-A: SUCCESS (6.312s)
[420.623049] Starting dynamic subtest: pipe-B
[426.958043] Dynamic subtest pipe-B: SUCCESS (6.346s)
[426.969669] Starting dynamic subtest: pipe-C
[433.205740] Dynamic subtest pipe-C: SUCCESS (6.245s)
[433.215988] Starting dynamic subtest: pipe-D
[439.688219] Dynamic subtest pipe-D: SUCCESS (6.481s)
[439.704999] Starting dynamic subtest: all-pipes
[445.708551] Dynamic subtest all-pipes: SUCCESS (6.018s)
[445.711077] Subtest torture-bo: SUCCESS (31.410s)
[445.941486] [102/132] (575s left) kms_cursor_crc (cursor-onscreen-32x10)
[446.107802] Starting subtest: cursor-onscreen-32x10
[446.164510] Subtest cursor-onscreen-32x10: SKIP (0.050s)
[446.491905] [103/132] (575s left) gem_mmap_offset (partial-mmap)
[446.560147] Starting subtest: partial-mmap
[446.562482] Starting dynamic subtest: smem0
[446.564735] Dynamic subtest smem0: SUCCESS (0.003s)
[446.567053] Subtest partial-mmap: SUCCESS (0.004s)
[446.714143] [104/132] (575s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[446.802836] Starting subtest: plane-lut1d-ctm3x4-lut1d
[446.818715] Starting dynamic subtest: pipe-A-eDP-1
[447.471973] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[448.205541] Starting dynamic subtest: pipe-B-eDP-1
[449.016857] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[449.547917] Starting dynamic subtest: pipe-C-eDP-1
[450.380261] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[450.890403] Starting dynamic subtest: pipe-D-eDP-1
[451.731197] Dynamic subtest pipe-D-eDP-1: FAIL (0.276s)
[451.733240] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.677s)
[452.293652] [105/132] (569s left) gem_userptr_blits (unsync-overlap)
[452.374129] Subtest unsync-overlap: SKIP (0.000s)
[452.516441] [106/132] (569s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[452.621910] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[452.626495] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[452.739690] [107/132] (569s left) kms_selftest (drm_damage_helper)
[452.773079] Starting subtest: drm_damage_helper
[452.827454] Starting dynamic subtest: drm_test_damage_iter_no_damage
[452.984341] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.161s)
[452.993473] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[453.112294] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.126s)
[453.123875] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[453.237894] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.125s)
[453.247102] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[453.379569] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.140s)
[453.390628] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[453.516794] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.137s)
[453.526165] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[453.677013] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.161s)
[453.687259] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[453.803119] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.124s)
[453.812538] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[453.942687] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.138s)
[453.959271] Starting dynamic subtest: drm_test_damage_iter_single_damage
[454.072475] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.126s)
[454.083225] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[454.179572] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.106s)
[454.194969] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[454.299915] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.117s)
[454.309342] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[454.412887] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.112s)
[454.422202] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[454.542915] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.129s)
[454.553190] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[454.660901] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.117s)
[454.672142] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[454.804952] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.141s)
[454.814334] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[454.920949] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.114s)
[454.930499] Starting dynamic subtest: drm_test_damage_iter_damage
[455.076034] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.153s)
[455.095476] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[455.212605] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.138s)
[455.224310] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[455.339262] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.126s)
[455.349451] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[455.428516] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.089s)
[455.437942] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[455.553327] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.122s)
[455.555611] Subtest drm_damage_helper: SUCCESS (2.777s)
[455.769734] [108/132] (566s left) gem_exec_capture (capture-recoverable)
[455.841555] Starting subtest: capture-recoverable
[455.846940] Subtest capture-recoverable: SUCCESS (0.004s)
[456.010853] [109/132] (566s left) gem_tiled_swapping (non-threaded)
[456.064813] Subtest non-threaded: SKIP (0.000s)
[456.130211] [110/132] (565s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[456.229345] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[456.231525] Starting dynamic subtest: pipe-A-eDP-1
[457.067327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.832s)
[457.082399] Starting dynamic subtest: pipe-B-eDP-1
[458.649031] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.577s)
[458.659324] Starting dynamic subtest: pipe-C-eDP-1
[460.192935] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.541s)
[460.203395] Starting dynamic subtest: pipe-D-eDP-1
[461.704812] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.512s)
[461.707186] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.468s)
[462.903632] [111/132] (559s left) gem_exec_balancer (full-pulse)
[462.978765] Starting subtest: full-pulse
[468.200163] Subtest full-pulse: SUCCESS (5.225s)
[468.538707] [112/132] (553s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[468.649666] Starting subtest: fbc-rgb565-draw-render
[472.913856] Subtest fbc-rgb565-draw-render: SUCCESS (4.267s)
[474.108572] [113/132] (548s left) kms_flip (flip-vs-panning-vs-hang)
[474.202977] Starting subtest: flip-vs-panning-vs-hang
[474.205236] Starting dynamic subtest: A-eDP1
[513.843511] Dynamic subtest A-eDP1: SUCCESS (39.642s)
[513.853645] Starting dynamic subtest: D-eDP1
[563.825803] Dynamic subtest D-eDP1: SUCCESS (49.975s)
[563.830807] Subtest flip-vs-panning-vs-hang: SUCCESS (89.623s)
[564.995901] [114/132] (457s left) kms_addfb_basic (clobberred-modifier)
[565.059760] Starting subtest: clobberred-modifier
[565.063896] Subtest clobberred-modifier: SKIP (0.000s)
[565.224912] [115/132] (457s left) gem_lmem_swapping (smem-oom)
[565.261568] Subtest smem-oom: SKIP (0.000s)
[565.308243] [116/132] (457s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[565.415184] Starting subtest: coverage-vs-premult-vs-constant
[565.704362] Starting dynamic subtest: pipe-A-eDP-1
[566.287206] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s)
[566.297419] Starting dynamic subtest: pipe-D-eDP-1
[567.581065] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[567.583521] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.169s)
[568.476406] [117/132] (453s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[568.592591] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[568.596867] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[568.720949] [118/132] (453s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[568.786222] Starting subtest: etime-single-wait-for-submit-submitted
[568.890087] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s)
[568.989889] [119/132] (453s left) gem_softpin (noreloc)
[569.042534] Starting subtest: noreloc
[574.437551] Subtest noreloc: SUCCESS (5.393s)
[574.598318] [120/132] (447s left) gem_render_tiled_blits (basic)
[574.662886] Subtest basic: SKIP (0.000s)
[574.764012] [121/132] (447s left) kms_psr (pr-suspend)
[574.866054] Starting subtest: pr-suspend
[574.870412] Subtest pr-suspend: SKIP (0.000s)
[574.950756] [122/132] (447s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[575.015698] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[575.121380] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[575.209665] [123/132] (447s left) kms_psr (psr-cursor-blt)
[575.302337] Starting subtest: psr-cursor-blt
[575.304474] Starting dynamic subtest: eDP-1
[577.033081] Dynamic subtest eDP-1: SUCCESS (1.730s)
[577.035380] Subtest psr-cursor-blt: SUCCESS (1.731s)
[577.912722] [124/132] (444s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[578.013766] Starting subtest: fbc-rgb565-draw-mmap-gtt
[578.017873] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[578.129554] [125/132] (444s left) gem_exec_params (sol-reset-not-gen7)
[578.194449] Starting subtest: sol-reset-not-gen7
[578.196689] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[578.336803] [126/132] (444s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[578.444955] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[578.449116] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[578.564102] [127/132] (444s left) kms_plane (planar-pixel-format-settings)
[578.659016] Starting subtest: planar-pixel-format-settings
[578.723296] Subtest planar-pixel-format-settings: SUCCESS (0.066s)
[578.855078] [128/132] (444s left) gem_exec_whisper (basic-fds-priority-all)
[578.921544] Starting subtest: basic-fds-priority-all
[600.691009] Subtest basic-fds-priority-all: SUCCESS (21.763s)
[600.896141] [129/132] (422s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[600.954461] Starting subtest: invalid-single-wait-all-unsubmitted
[600.956709] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[601.096903] [130/132] (421s left) kms_flip (2x-flip-vs-expired-vblank)
[601.201528] Starting subtest: 2x-flip-vs-expired-vblank
[601.210664] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[601.306872] [131/132] (421s left) gem_exec_flush (basic-batch-kernel-default-uc)
[601.374232] Starting subtest: basic-batch-kernel-default-uc
[608.294692] Subtest basic-batch-kernel-default-uc: SUCCESS (6.921s)
[608.506812] [132/132] (414s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[608.618068] Starting subtest: fbcpsr-modesetfrombusy
[614.862579] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.249s)
[615.067525] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: i915_query
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_pm_lpsp
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_atomic_interruptible
results: parsing output: 14/ for test: api_intel_allocator
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: kms_fbcon_fbt
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_legacy_colorkey
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: syncobj_eventfd
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_atomic
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_vrr
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: i915_pm_rpm
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: gem_ctx_shared
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: gem_ctx_create
results: parsing output: 46/ for test: gem_tiling_max_stride
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: kms_chamelium_edid
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: core_setmaster
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: gem_exec_suspend
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: gem_ccs
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_pipe_b_c_ivb
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_psr_stress_test
results: parsing output: 70/ for test: kms_pm_rpm
results: parsing output: 71/ for test: gem_ccs
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_plane_lowres
results: parsing output: 74/ for test: gem_close_race
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: kms_feature_discovery
results: parsing output: 77/ for test: kms_chamelium_color
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_mmap_offset
results: parsing output: 103/ for test: kms_color_pipeline
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_selftest
results: parsing output: 107/ for test: gem_exec_capture
results: parsing output: 108/ for test: gem_tiled_swapping
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: gem_lmem_swapping
results: parsing output: 115/ for test: kms_plane_alpha_blend
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_softpin
results: parsing output: 119/ for test: gem_render_tiled_blits
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_exec_flush
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.