[56.696931] Initializing watchdogs
[56.696977]   /dev/watchdog0
[56.710507] [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]
[56.714644] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.716774] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.720065] [001/132] (960s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[56.853533] Starting subtest: 4-tiled-addfb-size-offset-overflow
[56.855707] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[56.969092] [002/132] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[57.075152] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[57.077318] Starting dynamic subtest: pipe-A-eDP-1
[57.198028] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[57.207063] Starting dynamic subtest: pipe-B-eDP-1
[58.373462] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s)
[58.378617] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.301s)
[59.565871] [003/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[59.674805] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[59.679095] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[59.794089] [004/132] (957s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[60.029602] Starting subtest: cursor-rapid-movement-256x256
[60.034586] Starting dynamic subtest: pipe-A-eDP-1
[60.589086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[60.616713] Starting dynamic subtest: pipe-D-eDP-1
[61.755238] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[61.757694] Subtest cursor-rapid-movement-256x256: SUCCESS (1.724s)
[62.621985] [005/132] (954s left) syncobj_wait (wait-delayed-signal)
[62.683174] Starting subtest: wait-delayed-signal
[62.787747] Subtest wait-delayed-signal: SUCCESS (0.102s)
[62.873010] [006/132] (954s left) gem_ctx_param (root-set)
[62.930778] Starting subtest: root-set
[62.933214] Subtest root-set: SUCCESS (0.001s)
[63.053594] [007/132] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[63.105977] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[63.110640] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[63.291259] [008/132] (954s left) i915_query (query-regions-garbage-items)
[63.348442] Starting subtest: query-regions-garbage-items
[63.350610] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[63.451954] [009/132] (954s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[63.547178] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[63.549639] Starting dynamic subtest: pipe-A-default-mode
[66.236459] Dynamic subtest pipe-A-default-mode: SUCCESS (2.685s)
[66.238514] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.686s)
[67.163984] [010/132] (950s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[67.345073] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[67.347358] Starting dynamic subtest: pipe-A
[67.414394] Dynamic subtest pipe-A: SUCCESS (0.071s)
[67.422863] Starting dynamic subtest: pipe-B
[68.536450] Dynamic subtest pipe-B: SUCCESS (1.121s)
[68.546385] Starting dynamic subtest: pipe-C
[69.649758] Dynamic subtest pipe-C: SUCCESS (1.112s)
[69.656472] Starting dynamic subtest: pipe-D
[70.780744] Dynamic subtest pipe-D: SUCCESS (1.129s)
[70.783137] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.437s)
[71.957561] [011/132] (945s left) kms_psr (fbc-psr2-primary-blt)
[72.049233] Starting subtest: fbc-psr2-primary-blt
[72.051184] Starting dynamic subtest: eDP-1
[72.055372] Dynamic subtest eDP-1: SKIP (0.000s)
[72.059727] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[72.129845] [012/132] (945s left) kms_pm_lpsp (kms-lpsp)
[73.233142] Starting subtest: kms-lpsp
[73.235283] Starting dynamic subtest: pipe-A-eDP-1
[73.382821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[73.677124] Subtest kms-lpsp: SUCCESS (0.445s)
[74.484958] [013/132] (943s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[74.559060] Starting subtest: multi-wait-available-unsubmitted-submitted
[74.561512] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[74.691998] [014/132] (943s left) kms_atomic_interruptible (universal-setplane-primary)
[74.792164] Starting subtest: universal-setplane-primary
[74.794471] Starting dynamic subtest: pipe-A-eDP-1
[82.206489] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.411s)
[82.208654] Subtest universal-setplane-primary: SUCCESS (7.412s)
[83.043749] [015/132] (934s left) api_intel_allocator (two-level-inception-interruptible)
[83.103770] Starting subtest: two-level-inception-interruptible
[88.511655] Subtest two-level-inception-interruptible: SUCCESS (5.407s)
[88.656720] [016/132] (929s left) kms_joiner (basic-force-ultra-joiner)
[88.769535] Starting subtest: basic-force-ultra-joiner
[88.773818] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[88.861919] [017/132] (928s left) kms_getfb (getfb-handle-zero)
[88.964968] Starting subtest: getfb-handle-zero
[88.967321] Subtest getfb-handle-zero: SUCCESS (0.000s)
[89.099530] [018/132] (928s left) kms_fbcon_fbt (psr)
[89.160407] Starting subtest: psr
[96.427063] Subtest psr: SUCCESS (7.264s)
[96.528083] [019/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[96.651456] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[96.655807] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[96.761229] [020/132] (921s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[97.149255] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[97.956917] [021/132] (920s left) gem_exec_whisper (basic-sync-all)
[98.023858] Starting subtest: basic-sync-all
[104.674242] Subtest basic-sync-all: SUCCESS (6.648s)
[104.874858] [022/132] (913s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[105.009778] Starting subtest: x-tiled-32bpp-rotate-90
[105.030249] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[105.174524] [023/132] (912s left) kms_psr (fbc-pr-basic)
[105.262048] Starting subtest: fbc-pr-basic
[105.266275] Subtest fbc-pr-basic: SKIP (0.000s)
[105.345216] [024/132] (912s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[105.448727] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[105.452944] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[105.563942] [025/132] (912s left) perf_pmu (init-wait)
[105.601058] Starting subtest: init-wait
[105.603289] Starting dynamic subtest: rcs0
[105.605999] Dynamic subtest rcs0: SUCCESS (0.002s)
[105.615183] Starting dynamic subtest: bcs0
[105.616988] Dynamic subtest bcs0: SUCCESS (0.000s)
[105.623601] Starting dynamic subtest: vcs0
[105.625514] Dynamic subtest vcs0: SUCCESS (0.001s)
[105.631923] Starting dynamic subtest: vcs1
[105.633882] Dynamic subtest vcs1: SUCCESS (0.001s)
[105.640691] Starting dynamic subtest: vecs0
[105.643033] Dynamic subtest vecs0: SUCCESS (0.001s)
[105.649762] Starting dynamic subtest: ccs0
[105.652166] Dynamic subtest ccs0: SUCCESS (0.000s)
[105.654754] Subtest init-wait: SUCCESS (0.006s)
[105.725902] [026/132] (912s left) kms_legacy_colorkey (invalid-plane)
[105.813842] Starting subtest: invalid-plane
[105.815865] Starting dynamic subtest: zero-id
[105.817822] Dynamic subtest zero-id: SUCCESS (0.000s)
[105.825543] Starting dynamic subtest: outrange-id
[105.827130] Dynamic subtest outrange-id: SUCCESS (0.000s)
[105.829089] Subtest invalid-plane: SUCCESS (0.001s)
[105.907066] [027/132] (912s left) kms_vblank (wait-busy-hang)
[105.994194] Starting subtest: wait-busy-hang
[105.995867] Starting dynamic subtest: pipe-A-eDP-1
[132.690773] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.693s)
[132.704877] Starting dynamic subtest: pipe-D-eDP-1
[157.649264] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.953s)
[157.651444] Subtest wait-busy-hang: SUCCESS (51.650s)
[158.555129] [028/132] (859s left) syncobj_eventfd (binary-wait)
[158.620784] Starting subtest: binary-wait
[158.631493] Subtest binary-wait: SUCCESS (0.011s)
[158.759970] [029/132] (859s left) gem_mmap_gtt (basic-read-write)
[158.821136] Subtest basic-read-write: SKIP (0.000s)
[158.881890] [030/132] (859s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[159.007284] Starting subtest: basic-busy-flip-before-cursor-varying-size
[159.011779] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[159.162274] [031/132] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[159.267511] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[163.669657] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.407s)
[164.841594] [032/132] (853s left) gem_exec_fence (syncobj-repeat)
[165.288892] Starting subtest: syncobj-repeat
[165.459080] Subtest syncobj-repeat: SUCCESS (0.169s)
[167.029394] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[167.032404] [033/132] (851s left) gem_mmap_gtt (basic-wc)
[167.105930] Subtest basic-wc: SKIP (0.000s)
[167.174274] [034/132] (851s left) kms_atomic (test-only)
[167.262042] Starting subtest: test-only
[167.308857] Starting dynamic subtest: pipe-A-eDP-1
[169.851067] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.541s)
[169.853089] Subtest test-only: SUCCESS (2.588s)
[170.721036] [035/132] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[170.816159] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[170.820153] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[170.944409] [036/132] (847s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[171.067277] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[172.474451] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.408s)
[173.279331] [037/132] (845s left) kms_vrr (seamless-rr-switch-drrs)
[173.396132] Starting subtest: seamless-rr-switch-drrs
[173.402418] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[173.505887] [038/132] (845s left) kms_content_protection (content-type-change)
[173.654590] Starting subtest: content-type-change
[173.659077] Subtest content-type-change: SKIP (0.000s)
[173.805893] [039/132] (844s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[173.908038] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[173.912409] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[173.989860] [040/132] (844s left) i915_pm_rpm (system-suspend-devices)
[176.016824] Starting subtest: system-suspend-devices
[183.795572] Subtest system-suspend-devices: SUCCESS (7.778s)
[184.200619] [041/132] (834s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[184.323448] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[185.256864] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.934s)
[185.422305] [042/132] (833s left) gem_mmap_gtt (basic-write-read-distinct)
[185.479756] Subtest basic-write-read-distinct: SKIP (0.000s)
[185.557262] [043/132] (833s left) gem_ctx_shared (q-in-order)
[185.608981] Starting subtest: Q-in-order
[185.611086] Starting dynamic subtest: rcs0
[185.708508] Dynamic subtest rcs0: SUCCESS (0.099s)
[185.724061] Starting dynamic subtest: vcs0
[185.788684] Dynamic subtest vcs0: SUCCESS (0.080s)
[185.804723] Starting dynamic subtest: vcs1
[185.862693] Dynamic subtest vcs1: SUCCESS (0.074s)
[185.878437] Starting dynamic subtest: vecs0
[185.935618] Dynamic subtest vecs0: SUCCESS (0.072s)
[185.950272] Starting dynamic subtest: ccs0
[186.003915] Dynamic subtest ccs0: SUCCESS (0.068s)
[186.006115] Subtest Q-in-order: SUCCESS (0.395s)
[187.041773] [044/132] (831s left) syncobj_timeline (wait-all-complex)
[187.109175] Starting subtest: wait-all-complex
[187.322594] Subtest wait-all-complex: SUCCESS (0.212s)
[187.422035] [045/132] (831s left) kms_async_flips (alternate-sync-async-flip-atomic)
[187.513396] Starting subtest: alternate-sync-async-flip-atomic
[187.890072] Starting dynamic subtest: pipe-A-eDP-1
[190.654972] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.767s)
[191.045034] Starting dynamic subtest: pipe-B-eDP-1
[193.783567] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.750s)
[194.158818] Starting dynamic subtest: pipe-C-eDP-1
[196.908182] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.757s)
[197.274579] Starting dynamic subtest: pipe-D-eDP-1
[200.043835] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[200.045755] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.531s)
[201.233903] [046/132] (817s left) gem_ctx_create (basic-files)
[201.290413] Starting subtest: basic-files
[203.304421] Subtest basic-files: SUCCESS (2.014s)
[204.936341] [047/132] (814s left) gem_tiling_max_stride
[205.045144] [048/132] (814s left) i915_drm_fdinfo (virtual-idle)
[205.078670] Starting subtest: virtual-idle
[208.130977] Subtest virtual-idle: SUCCESS (3.048s)
[208.212580] [049/132] (810s left) kms_chamelium_edid (dp-edid-read)
[208.617318] Subtest dp-edid-read: SKIP (0.000s)
[209.435272] [050/132] (809s left) gem_ctx_persistence (process)
[209.497515] Starting subtest: process
[209.672872] Subtest process: SUCCESS (0.175s)
[209.765868] [051/132] (809s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[209.856710] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[209.859037] Starting dynamic subtest: pipe-A-eDP-1
[209.868768] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[209.882164] Starting dynamic subtest: pipe-B-eDP-1
[209.891193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.903760] Starting dynamic subtest: pipe-C-eDP-1
[209.912273] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.920145] Starting dynamic subtest: pipe-D-eDP-1
[209.928709] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.932963] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[212.063995] [052/132] (807s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[212.174015] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[212.176187] Starting dynamic subtest: A-eDP1
[215.760991] Dynamic subtest A-eDP1: SUCCESS (3.586s)
[215.779382] Starting dynamic subtest: B-eDP1
[218.944535] Dynamic subtest B-eDP1: SUCCESS (3.181s)
[218.954269] Starting dynamic subtest: C-eDP1
[222.050090] Dynamic subtest C-eDP1: SUCCESS (3.105s)
[222.067909] Starting dynamic subtest: D-eDP1
[225.164440] Dynamic subtest D-eDP1: SUCCESS (3.113s)
[225.169241] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.994s)
[225.978259] [053/132] (793s left) core_setmaster (master-drop-set-shared-fd)
[226.063796] Starting subtest: master-drop-set-shared-fd
[226.070725] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[226.109887] [054/132] (793s left) api_intel_bb (simple-bb)
[226.162353] Starting subtest: simple-bb
[226.169750] Subtest simple-bb: SUCCESS (0.010s)
[226.330544] [055/132] (793s left) gem_exec_suspend (basic-s3-devices)
[226.402953] Starting subtest: basic-S3-devices
[226.405297] Starting dynamic subtest: smem
[237.908455] Dynamic subtest smem: SUCCESS (11.506s)
[237.911251] Subtest basic-S3-devices: SUCCESS (11.508s)
[238.105039] [056/132] (781s left) gem_exec_reloc (basic-write-gtt-active)
[238.177503] Subtest basic-write-gtt-active: SKIP (0.000s)
[238.251844] [057/132] (781s left) syncobj_wait (single-wait-all-submitted)
[238.307406] Starting subtest: single-wait-all-submitted
[238.408621] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[238.497044] [058/132] (781s left) gem_exec_schedule (submit-late-slice)
[238.582416] Starting subtest: submit-late-slice
[238.584364] Starting dynamic subtest: rcs0
[238.618740] Dynamic subtest rcs0: SUCCESS (0.045s)
[238.629291] Starting dynamic subtest: bcs0
[238.650405] Dynamic subtest bcs0: SUCCESS (0.032s)
[238.660421] Starting dynamic subtest: vcs0
[238.683510] Dynamic subtest vcs0: SUCCESS (0.032s)
[238.694960] Starting dynamic subtest: vcs1
[238.719030] Dynamic subtest vcs1: SUCCESS (0.034s)
[238.728394] Starting dynamic subtest: vecs0
[238.759048] Dynamic subtest vecs0: SUCCESS (0.039s)
[238.769118] Starting dynamic subtest: ccs0
[238.787535] Dynamic subtest ccs0: SUCCESS (0.028s)
[238.789886] Subtest submit-late-slice: SUCCESS (0.215s)
[240.031767] [059/132] (779s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[240.134836] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[240.145905] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[240.282088] [060/132] (779s left) gem_pxp (create-valid-protected-context)
[240.412600] Starting subtest: create-valid-protected-context
[240.415140] Subtest create-valid-protected-context: SUCCESS (0.002s)
[240.551583] [061/132] (779s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[240.654361] Starting subtest: fbcpsr-tiling-linear
[247.263555] Subtest fbcpsr-tiling-linear: SUCCESS (6.612s)
[247.447395] [062/132] (772s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[247.553440] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[247.555543] Starting dynamic subtest: pipe-A-eDP-1
[247.627273] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[247.636643] Starting dynamic subtest: pipe-B-eDP-1
[248.750649] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[248.754826] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.202s)
[250.041875] [063/132] (769s left) gem_ctx_persistence (engines-mixed-process)
[250.102188] Starting subtest: engines-mixed-process
[250.104490] Starting dynamic subtest: rcs0
[251.920754] Dynamic subtest rcs0: SUCCESS (1.818s)
[251.930179] Starting dynamic subtest: bcs0
[253.917157] Dynamic subtest bcs0: SUCCESS (1.995s)
[253.928839] Starting dynamic subtest: vcs0
[255.889914] Dynamic subtest vcs0: SUCCESS (1.972s)
[255.901065] Starting dynamic subtest: vcs1
[257.888831] Dynamic subtest vcs1: SUCCESS (1.998s)
[257.899323] Starting dynamic subtest: vecs0
[259.923663] Dynamic subtest vecs0: SUCCESS (2.033s)
[259.934916] Starting dynamic subtest: ccs0
[261.917805] Dynamic subtest ccs0: SUCCESS (1.993s)
[261.920271] Subtest engines-mixed-process: SUCCESS (11.816s)
[262.010464] [064/132] (757s left) gem_ccs (block-copy-compressed)
[262.070702] Starting subtest: block-copy-compressed
[262.075699] Subtest block-copy-compressed: SKIP (0.000s)
[262.199481] [065/132] (757s left) gem_eio (unwedge-stress)
[262.453315] Starting subtest: unwedge-stress
[262.455582] Starting dynamic subtest: render
[267.619613] Dynamic subtest render: SUCCESS (5.162s)
[267.634314] Starting dynamic subtest: bsd1
[287.443684] Dynamic subtest bsd1: SUCCESS (19.823s)
[287.459860] Starting dynamic subtest: bsd2
[305.404300] Dynamic subtest bsd2: SUCCESS (17.959s)
[305.420968] Starting dynamic subtest: blt
[305.425235] Dynamic subtest blt: SKIP (0.000s)
[305.434076] Starting dynamic subtest: vebox
[323.400894] Dynamic subtest vebox: SUCCESS (17.994s)
[323.403586] Subtest unwedge-stress: SUCCESS (60.943s)
[324.962857] [066/132] (694s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[325.029063] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[325.099977] [067/132] (694s left) kms_flip (busy-flip)
[325.193903] Starting subtest: busy-flip
[325.195735] Starting dynamic subtest: A-eDP1
[326.841274] Dynamic subtest A-eDP1: SUCCESS (1.649s)
[326.852709] Starting dynamic subtest: B-eDP1
[328.473103] Dynamic subtest B-eDP1: SUCCESS (1.630s)
[328.482540] Starting dynamic subtest: C-eDP1
[330.102482] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[330.113023] Starting dynamic subtest: D-eDP1
[331.749445] Dynamic subtest D-eDP1: SUCCESS (1.645s)
[331.751785] Subtest busy-flip: SUCCESS (6.561s)
[333.015175] [068/132] (686s left) i915_drm_fdinfo (virtual-busy-hang)
[333.063551] Starting subtest: virtual-busy-hang
[333.068055] Subtest virtual-busy-hang: SKIP (0.000s)
[333.139825] [069/132] (686s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[333.254221] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[333.258606] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[333.337123] [070/132] (686s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[333.428035] Starting subtest: invalidate-primary-flip-overlay
[344.218988] Subtest invalidate-primary-flip-overlay: SUCCESS (10.793s)
[344.381980] [071/132] (675s left) kms_pm_rpm (system-suspend-idle)
[346.120889] Starting subtest: system-suspend-idle
[365.459408] Subtest system-suspend-idle: SUCCESS (4.610s)
[365.858897] [072/132] (654s left) gem_ccs (suspend-resume)
[365.934114] Starting subtest: suspend-resume
[365.938443] Subtest suspend-resume: SKIP (0.000s)
[366.035124] [073/132] (654s left) kms_big_fb (linear-16bpp-rotate-180)
[366.143130] Starting subtest: linear-16bpp-rotate-180
[367.603075] Subtest linear-16bpp-rotate-180: SUCCESS (1.456s)
[367.754383] [074/132] (652s left) kms_plane_lowres (tiling-x)
[367.843517] Starting subtest: tiling-x
[367.845235] Starting dynamic subtest: pipe-A-eDP-1
[367.848839] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[368.146964] Starting dynamic subtest: pipe-B-eDP-1
[368.160622] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[368.174513] Starting dynamic subtest: pipe-C-eDP-1
[368.178819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[368.187418] Starting dynamic subtest: pipe-D-eDP-1
[368.191629] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[368.195921] Subtest tiling-x: SKIP (0.296s)
[368.967514] [075/132] (651s left) gem_close_race (basic-threads)
[369.030521] Starting subtest: basic-threads
[370.481570] Subtest basic-threads: SUCCESS (1.450s)
[370.695116] [076/132] (649s left) kms_getfb (getfb-handle-protection)
[370.788358] Starting subtest: getfb-handle-protection
[370.812472] Subtest getfb-handle-protection: SUCCESS (0.025s)
[370.958040] [077/132] (649s left) kms_feature_discovery (display)
[371.053639] Starting subtest: display
[371.055928] Subtest display: SUCCESS (0.000s)
[371.140625] [078/132] (649s left) kms_chamelium_color (ctm-0-25)
[371.235918] Subtest ctm-0-25: SKIP (0.000s)
[371.281333] [079/132] (649s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[371.389103] Starting subtest: y-tiled-8bpp-rotate-180
[371.393549] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[371.510864] [080/132] (648s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[371.631660] Starting subtest: flip-vs-cursor-crc-atomic
[372.282889] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.647s)
[373.107292] [081/132] (647s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[373.203560] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[380.597398] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.389s)
[380.781199] [082/132] (639s left) kms_frontbuffer_tracking (psr-1p-rte)
[380.878054] Starting subtest: psr-1p-rte
[386.262883] Subtest psr-1p-rte: SUCCESS (5.385s)
[386.433126] [083/132] (634s left) gem_wait (write-wait)
[386.499590] Starting subtest: write-wait
[386.502022] Starting dynamic subtest: all-engines
[387.636670] Dynamic subtest all-engines: SUCCESS (1.136s)
[387.655157] Starting dynamic subtest: rcs0
[388.698061] Dynamic subtest rcs0: SUCCESS (1.056s)
[388.713654] Starting dynamic subtest: bcs0
[389.755810] Dynamic subtest bcs0: SUCCESS (1.057s)
[389.772548] Starting dynamic subtest: vcs0
[390.810513] Dynamic subtest vcs0: SUCCESS (1.052s)
[390.827161] Starting dynamic subtest: vcs1
[391.864633] Dynamic subtest vcs1: SUCCESS (1.051s)
[391.880768] Starting dynamic subtest: vecs0
[392.918139] Dynamic subtest vecs0: SUCCESS (1.050s)
[392.934206] Starting dynamic subtest: ccs0
[393.975875] Dynamic subtest ccs0: SUCCESS (1.055s)
[393.978455] Subtest write-wait: SUCCESS (7.472s)
[394.189209] [084/132] (626s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[394.284627] Starting subtest: bad-pixel-format-y-tiled-ccs
[394.287041] Starting dynamic subtest: pipe-A-eDP-1
[394.310204] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[394.319732] Starting dynamic subtest: pipe-B-eDP-1
[394.341494] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[394.350225] Starting dynamic subtest: pipe-C-eDP-1
[394.372106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[394.381025] Starting dynamic subtest: pipe-D-eDP-1
[394.402949] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[394.407401] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[396.568471] [085/132] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[396.670522] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[396.674506] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[396.800496] [086/132] (623s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[396.906036] Starting subtest: fbc-shrfb-scaledprimary
[399.992044] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.087s)
[401.168190] [087/132] (619s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[401.273706] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[401.276051] Starting dynamic subtest: pipe-A-eDP-1
[401.299815] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[401.310086] Starting dynamic subtest: pipe-B-eDP-1
[401.330672] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[401.339153] Starting dynamic subtest: pipe-C-eDP-1
[401.359566] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.367815] Starting dynamic subtest: pipe-D-eDP-1
[401.388643] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.392849] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[403.433745] [088/132] (617s left) gen9_exec_parse (bb-large)
[403.497936] Subtest bb-large: SKIP (0.000s)
[403.590144] [089/132] (617s left) perf (i915-ref-count)
[403.667131] Starting subtest: i915-ref-count
[403.733964] Subtest i915-ref-count: SUCCESS (0.068s)
[403.789447] [090/132] (617s left) sw_sync (alloc_fence_invalid_timeline)
[403.826036] Starting subtest: alloc_fence_invalid_timeline
[403.828010] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[403.909016] [091/132] (617s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[404.015092] Starting subtest: psr-modesetfrombusy
[410.207809] Subtest psr-modesetfrombusy: SUCCESS (6.194s)
[410.385499] [092/132] (610s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[410.489933] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[410.493344] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[410.631944] [093/132] (610s left) gem_softpin (allocator-basic)
[410.704746] Starting subtest: allocator-basic
[410.772827] Subtest allocator-basic: SUCCESS (0.068s)
[410.924801] [094/132] (610s left) gem_render_copy (linear-to-vebox-y-tiled)
[410.994677] Starting subtest: linear-to-vebox-y-tiled
[410.998331] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[411.186193] [095/132] (609s left) gem_mmap_gtt (hang)
[411.242176] Subtest hang: SKIP (0.000s)
[411.311453] [096/132] (609s left) gem_exec_schedule (out-order)
[411.388498] Starting subtest: out-order
[411.390449] Starting dynamic subtest: rcs0
[411.483111] Dynamic subtest rcs0: SUCCESS (0.099s)
[411.495386] Starting dynamic subtest: vcs0
[411.562321] Dynamic subtest vcs0: SUCCESS (0.078s)
[411.574287] Starting dynamic subtest: vcs1
[411.665299] Dynamic subtest vcs1: SUCCESS (0.102s)
[411.676170] Starting dynamic subtest: vecs0
[411.742959] Dynamic subtest vecs0: SUCCESS (0.075s)
[411.753637] Starting dynamic subtest: ccs0
[411.831969] Dynamic subtest ccs0: SUCCESS (0.088s)
[411.834205] Subtest out-order: SUCCESS (0.449s)
[412.749522] [097/132] (608s left) gem_exec_reloc (basic-scanout)
[412.819348] Subtest basic-scanout: SKIP (0.000s)
[412.907210] [098/132] (608s left) kms_psr (fbc-psr-primary-render)
[413.016040] Starting subtest: fbc-psr-primary-render
[413.018155] Starting dynamic subtest: eDP-1
[413.022025] Dynamic subtest eDP-1: SKIP (0.000s)
[413.025966] Subtest fbc-psr-primary-render: SKIP (0.001s)
[413.101541] [099/132] (608s left) prime_mmap (test_correct_cpu_write)
[413.161923] Starting subtest: test_correct_cpu_write
[413.164125] Starting dynamic subtest: test_correct_cpu_write-smem
[413.166033] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[413.167976] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[413.302758] [100/132] (607s left) syncobj_timeline (invalid-signal-zero-handles)
[413.372093] Starting subtest: invalid-signal-zero-handles
[413.374091] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[413.495601] [101/132] (607s left) kms_cursor_legacy (torture-bo)
[413.620815] Starting subtest: torture-bo
[413.623052] Starting dynamic subtest: pipe-A
[419.443811] Dynamic subtest pipe-A: SUCCESS (5.816s)
[419.457773] Starting dynamic subtest: pipe-B
[427.922315] Dynamic subtest pipe-B: SUCCESS (8.473s)
[427.935349] Starting dynamic subtest: pipe-C
[435.634429] Dynamic subtest pipe-C: SUCCESS (7.705s)
[435.651158] Starting dynamic subtest: pipe-D
[443.588710] Dynamic subtest pipe-D: SUCCESS (7.950s)
[443.603230] Starting dynamic subtest: all-pipes
[451.618562] Dynamic subtest all-pipes: SUCCESS (8.022s)
[451.621376] Subtest torture-bo: SUCCESS (37.978s)
[451.801195] [102/132] (569s left) kms_cursor_crc (cursor-onscreen-32x10)
[451.967227] Starting subtest: cursor-onscreen-32x10
[452.011344] Subtest cursor-onscreen-32x10: SKIP (0.040s)
[452.307681] [103/132] (569s left) gem_mmap_offset (partial-mmap)
[452.357929] Starting subtest: partial-mmap
[452.360348] Starting dynamic subtest: smem0
[452.362848] Dynamic subtest smem0: SUCCESS (0.004s)
[452.365194] Subtest partial-mmap: SUCCESS (0.004s)
[452.506049] [104/132] (568s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[452.598641] Starting subtest: plane-lut1d-ctm3x4-lut1d
[452.616525] Starting dynamic subtest: pipe-A-eDP-1
[453.313165] Dynamic subtest pipe-A-eDP-1: FAIL (0.312s)
[453.995485] Starting dynamic subtest: pipe-B-eDP-1
[454.817888] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[455.312564] Starting dynamic subtest: pipe-C-eDP-1
[456.119871] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[456.632539] Starting dynamic subtest: pipe-D-eDP-1
[457.480262] Dynamic subtest pipe-D-eDP-1: FAIL (0.258s)
[457.482923] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.575s)
[458.018547] [105/132] (563s left) gem_userptr_blits (unsync-overlap)
[458.098524] Subtest unsync-overlap: SKIP (0.000s)
[458.258956] [106/132] (563s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[458.360325] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[458.364792] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[458.490742] [107/132] (563s left) kms_selftest (drm_damage_helper)
[458.530387] Starting subtest: drm_damage_helper
[458.568180] Starting dynamic subtest: drm_test_damage_iter_no_damage
[458.721514] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.152s)
[458.730867] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[458.853332] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.131s)
[458.863336] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[458.975079] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.121s)
[458.985765] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[459.123622] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.148s)
[459.132414] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[459.265038] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.140s)
[459.274036] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[459.418448] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.154s)
[459.426948] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[459.558513] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.137s)
[459.568897] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[459.697678] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.140s)
[459.706697] Starting dynamic subtest: drm_test_damage_iter_single_damage
[459.844693] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.145s)
[459.853583] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[459.982895] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.138s)
[459.991267] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[460.110664] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.127s)
[460.119053] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[460.247232] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.135s)
[460.257975] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[460.385187] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.137s)
[460.394004] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[460.525731] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.140s)
[460.534760] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[460.678174] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.151s)
[460.688385] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[460.818210] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.140s)
[460.828981] Starting dynamic subtest: drm_test_damage_iter_damage
[460.947800] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.130s)
[460.958515] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[461.080160] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.131s)
[461.090417] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[461.246727] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.165s)
[461.257522] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[461.400572] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.155s)
[461.411488] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[461.523418] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.119s)
[461.525461] Subtest drm_damage_helper: SUCCESS (2.992s)
[461.742050] [108/132] (559s left) gem_exec_capture (capture-recoverable)
[461.808014] Starting subtest: capture-recoverable
[461.810009] Subtest capture-recoverable: SUCCESS (0.004s)
[461.952659] [109/132] (559s left) gem_tiled_swapping (non-threaded)
[462.010530] Subtest non-threaded: SKIP (0.000s)
[462.103561] [110/132] (559s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[462.201274] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[462.203620] Starting dynamic subtest: pipe-A-eDP-1
[462.979878] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.773s)
[462.991673] Starting dynamic subtest: pipe-B-eDP-1
[464.506835] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.525s)
[464.516986] Starting dynamic subtest: pipe-C-eDP-1
[466.023314] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.516s)
[466.032933] Starting dynamic subtest: pipe-D-eDP-1
[467.541851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.519s)
[467.544174] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.339s)
[468.730576] [111/132] (553s left) gem_exec_balancer (full-pulse)
[468.806710] Starting subtest: full-pulse
[473.516974] Subtest full-pulse: SUCCESS (4.714s)
[473.840624] [112/132] (547s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[473.942441] Starting subtest: fbc-rgb565-draw-render
[478.133965] Subtest fbc-rgb565-draw-render: SUCCESS (4.197s)
[479.338020] [113/132] (542s left) kms_flip (flip-vs-panning-vs-hang)
[479.443591] Starting subtest: flip-vs-panning-vs-hang
[479.445541] Starting dynamic subtest: A-eDP1
[519.103649] Dynamic subtest A-eDP1: SUCCESS (39.668s)
[519.118357] Starting dynamic subtest: D-eDP1
[569.093078] Dynamic subtest D-eDP1: SUCCESS (49.978s)
[569.095886] Subtest flip-vs-panning-vs-hang: SUCCESS (89.650s)
[570.291052] [114/132] (451s left) kms_addfb_basic (clobberred-modifier)
[570.348184] Starting subtest: clobberred-modifier
[570.352882] Subtest clobberred-modifier: SKIP (0.000s)
[570.513055] [115/132] (451s left) gem_lmem_swapping (smem-oom)
[570.561663] Subtest smem-oom: SKIP (0.000s)
[570.611372] [116/132] (451s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[570.703732] Starting subtest: coverage-vs-premult-vs-constant
[570.988109] Starting dynamic subtest: pipe-A-eDP-1
[571.544451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[571.554552] Starting dynamic subtest: pipe-D-eDP-1
[572.886956] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[572.889113] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.183s)
[573.748777] [117/132] (448s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[573.857209] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[573.861768] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[573.979583] [118/132] (448s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[574.037123] Starting subtest: etime-single-wait-for-submit-submitted
[574.140996] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[574.235599] [119/132] (447s left) gem_softpin (noreloc)
[574.299408] Starting subtest: noreloc
[579.722979] Subtest noreloc: SUCCESS (5.423s)
[579.878235] [120/132] (442s left) gem_render_tiled_blits (basic)
[579.946300] Subtest basic: SKIP (0.000s)
[580.033045] [121/132] (442s left) kms_psr (pr-suspend)
[580.133438] Starting subtest: pr-suspend
[580.137869] Subtest pr-suspend: SKIP (0.000s)
[580.229398] [122/132] (441s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[580.291420] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[580.397090] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[580.485379] [123/132] (441s left) kms_psr (psr-cursor-blt)
[580.572773] Starting subtest: psr-cursor-blt
[580.575185] Starting dynamic subtest: eDP-1
[582.346428] Dynamic subtest eDP-1: SUCCESS (1.773s)
[582.348779] Subtest psr-cursor-blt: SUCCESS (1.774s)
[583.212281] [124/132] (439s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[583.310763] Starting subtest: fbc-rgb565-draw-mmap-gtt
[583.314678] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[583.424737] [125/132] (438s left) gem_exec_params (sol-reset-not-gen7)
[583.482319] Starting subtest: sol-reset-not-gen7
[583.488220] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[583.636967] [126/132] (438s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[583.753838] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[583.757864] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[583.882391] [127/132] (438s left) kms_plane (planar-pixel-format-settings)
[583.995975] Starting subtest: planar-pixel-format-settings
[584.071085] Subtest planar-pixel-format-settings: SUCCESS (0.076s)
[584.224945] [128/132] (438s left) gem_exec_whisper (basic-fds-priority-all)
[584.305601] Starting subtest: basic-fds-priority-all
[606.207550] Subtest basic-fds-priority-all: SUCCESS (21.904s)
[606.402696] [129/132] (416s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[606.459683] Starting subtest: invalid-single-wait-all-unsubmitted
[606.461539] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[606.581480] [130/132] (415s left) kms_flip (2x-flip-vs-expired-vblank)
[606.683466] Starting subtest: 2x-flip-vs-expired-vblank
[606.692077] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[606.781057] [131/132] (415s left) gem_exec_flush (basic-batch-kernel-default-uc)
[606.843072] Starting subtest: basic-batch-kernel-default-uc
[614.070751] Subtest basic-batch-kernel-default-uc: SUCCESS (7.229s)
[614.272055] [132/132] (408s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[614.379700] Starting subtest: fbcpsr-modesetfrombusy
[620.571761] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.197s)
[620.756383] 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.