[56.582245] Initializing watchdogs
[56.582292]   /dev/watchdog0
[56.598017] [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.602470] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.605773] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.609762] [001/132] (960s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[56.734865] Starting subtest: 4-tiled-addfb-size-offset-overflow
[56.737093] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[56.838731] [002/132] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[56.944288] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[56.946445] Starting dynamic subtest: pipe-A-eDP-1
[57.065366] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[57.072319] Starting dynamic subtest: pipe-B-eDP-1
[58.191322] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[58.196263] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.251s)
[59.391509] [003/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[59.496595] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[59.500753] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[59.611078] [004/132] (957s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[59.849662] Starting subtest: cursor-rapid-movement-256x256
[59.854422] Starting dynamic subtest: pipe-A-eDP-1
[60.421207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[60.451688] Starting dynamic subtest: pipe-D-eDP-1
[61.611676] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.164s)
[61.614239] Subtest cursor-rapid-movement-256x256: SUCCESS (1.761s)
[62.459779] [005/132] (954s left) syncobj_wait (wait-delayed-signal)
[62.517080] Starting subtest: wait-delayed-signal
[62.618080] Subtest wait-delayed-signal: SUCCESS (0.102s)
[62.708864] [006/132] (954s left) gem_ctx_param (root-set)
[62.757625] Starting subtest: root-set
[62.759963] Subtest root-set: SUCCESS (0.001s)
[62.874694] [007/132] (954s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[62.935619] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[62.940047] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[63.125853] [008/132] (954s left) i915_query (query-regions-garbage-items)
[63.188240] Starting subtest: query-regions-garbage-items
[63.190519] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[63.314471] [009/132] (954s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[63.417025] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[63.419749] Starting dynamic subtest: pipe-A-default-mode
[66.191754] Dynamic subtest pipe-A-default-mode: SUCCESS (2.781s)
[66.194392] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.782s)
[67.104602] [010/132] (950s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[67.299366] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[67.301795] Starting dynamic subtest: pipe-A
[67.364795] Dynamic subtest pipe-A: SUCCESS (0.065s)
[67.374733] Starting dynamic subtest: pipe-B
[68.488458] Dynamic subtest pipe-B: SUCCESS (1.123s)
[68.498089] Starting dynamic subtest: pipe-C
[69.589654] Dynamic subtest pipe-C: SUCCESS (1.101s)
[69.598554] Starting dynamic subtest: pipe-D
[70.707327] Dynamic subtest pipe-D: SUCCESS (1.117s)
[70.709758] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.409s)
[71.882951] [011/132] (945s left) kms_psr (fbc-psr2-primary-blt)
[71.992081] Starting subtest: fbc-psr2-primary-blt
[71.994027] Starting dynamic subtest: eDP-1
[71.998157] Dynamic subtest eDP-1: SKIP (0.000s)
[72.002306] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[72.071717] [012/132] (945s left) kms_pm_lpsp (kms-lpsp)
[73.176547] Starting subtest: kms-lpsp
[73.179055] Starting dynamic subtest: pipe-A-eDP-1
[73.325016] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[73.623142] Subtest kms-lpsp: SUCCESS (0.446s)
[74.522616] [013/132] (943s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[74.589253] Starting subtest: multi-wait-available-unsubmitted-submitted
[74.591689] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[74.694910] [014/132] (942s left) kms_atomic_interruptible (universal-setplane-primary)
[74.793984] Starting subtest: universal-setplane-primary
[74.796385] Starting dynamic subtest: pipe-A-eDP-1
[82.254264] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.462s)
[82.256675] Subtest universal-setplane-primary: SUCCESS (7.463s)
[83.073159] [015/132] (934s left) api_intel_allocator (two-level-inception-interruptible)
[83.133856] Starting subtest: two-level-inception-interruptible
[88.542796] Subtest two-level-inception-interruptible: SUCCESS (5.409s)
[88.677718] [016/132] (929s left) kms_joiner (basic-force-ultra-joiner)
[88.805353] Starting subtest: basic-force-ultra-joiner
[88.809465] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[88.883970] [017/132] (928s left) kms_getfb (getfb-handle-zero)
[88.987644] Starting subtest: getfb-handle-zero
[88.989896] Subtest getfb-handle-zero: SUCCESS (0.000s)
[89.120483] [018/132] (928s left) kms_fbcon_fbt (psr)
[89.185731] Starting subtest: psr
[96.508337] Subtest psr: SUCCESS (7.320s)
[96.583287] [019/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[96.686789] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[96.691406] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[96.804302] [020/132] (921s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[97.185598] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[98.029699] [021/132] (919s left) gem_exec_whisper (basic-sync-all)
[98.091425] Starting subtest: basic-sync-all
[104.764495] Subtest basic-sync-all: SUCCESS (6.671s)
[104.958435] [022/132] (912s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[105.074402] Starting subtest: x-tiled-32bpp-rotate-90
[105.093635] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[105.228190] [023/132] (912s left) kms_psr (fbc-pr-basic)
[105.315487] Starting subtest: fbc-pr-basic
[105.319668] Subtest fbc-pr-basic: SKIP (0.000s)
[105.398218] [024/132] (912s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[105.495395] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[105.499538] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[105.608205] [025/132] (912s left) perf_pmu (init-wait)
[105.649226] Starting subtest: init-wait
[105.651530] Starting dynamic subtest: rcs0
[105.653864] Dynamic subtest rcs0: SUCCESS (0.002s)
[105.662546] Starting dynamic subtest: bcs0
[105.664414] Dynamic subtest bcs0: SUCCESS (0.000s)
[105.671485] Starting dynamic subtest: vcs0
[105.673400] Dynamic subtest vcs0: SUCCESS (0.001s)
[105.680103] Starting dynamic subtest: vcs1
[105.681951] Dynamic subtest vcs1: SUCCESS (0.000s)
[105.688648] Starting dynamic subtest: vecs0
[105.690545] Dynamic subtest vecs0: SUCCESS (0.000s)
[105.696959] Starting dynamic subtest: ccs0
[105.698874] Dynamic subtest ccs0: SUCCESS (0.000s)
[105.700765] Subtest init-wait: SUCCESS (0.006s)
[105.795527] [026/132] (912s left) kms_legacy_colorkey (invalid-plane)
[105.894361] Starting subtest: invalid-plane
[105.895950] Starting dynamic subtest: zero-id
[105.897576] Dynamic subtest zero-id: SUCCESS (0.000s)
[105.906709] Starting dynamic subtest: outrange-id
[105.908499] Dynamic subtest outrange-id: SUCCESS (0.000s)
[105.910270] Subtest invalid-plane: SUCCESS (0.001s)
[105.973187] [027/132] (912s left) kms_vblank (wait-busy-hang)
[106.067491] Starting subtest: wait-busy-hang
[106.069127] Starting dynamic subtest: pipe-A-eDP-1
[132.698800] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.629s)
[132.714272] Starting dynamic subtest: pipe-D-eDP-1
[147.746065] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.046s)
[147.748371] Subtest wait-busy-hang: SUCCESS (41.679s)
[148.645879] [028/132] (869s left) syncobj_eventfd (binary-wait)
[148.712107] Starting subtest: binary-wait
[148.720805] Subtest binary-wait: SUCCESS (0.010s)
[148.836472] [029/132] (869s left) gem_mmap_gtt (basic-read-write)
[148.898634] Subtest basic-read-write: SKIP (0.000s)
[148.966828] [030/132] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[149.107260] Starting subtest: basic-busy-flip-before-cursor-varying-size
[149.111847] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[149.272442] [031/132] (868s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[149.377564] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[153.840132] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.466s)
[154.972235] [032/132] (863s left) gem_exec_fence (syncobj-repeat)
[155.428128] Starting subtest: syncobj-repeat
[155.602140] Subtest syncobj-repeat: SUCCESS (0.175s)
[156.950843] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[156.953866] [033/132] (861s left) gem_mmap_gtt (basic-wc)
[157.018845] Subtest basic-wc: SKIP (0.000s)
[157.092723] [034/132] (861s left) kms_atomic (test-only)
[157.187056] Starting subtest: test-only
[157.236961] Starting dynamic subtest: pipe-A-eDP-1
[159.763551] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.527s)
[159.765784] Subtest test-only: SUCCESS (2.577s)
[160.642712] [035/132] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[160.740968] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[160.745014] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[160.886119] [036/132] (857s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[161.016047] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[162.402740] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.387s)
[163.226823] [037/132] (855s left) kms_vrr (seamless-rr-switch-drrs)
[163.324101] Starting subtest: seamless-rr-switch-drrs
[163.330387] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[163.404236] [038/132] (855s left) kms_content_protection (content-type-change)
[163.554776] Starting subtest: content-type-change
[163.559234] Subtest content-type-change: SKIP (0.000s)
[163.700969] [039/132] (854s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[163.800191] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[163.804304] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[163.903284] [040/132] (854s left) i915_pm_rpm (system-suspend-devices)
[166.037547] Starting subtest: system-suspend-devices
[173.818836] Subtest system-suspend-devices: SUCCESS (7.780s)
[174.205609] [041/132] (844s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[174.330991] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[175.309702] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.978s)
[175.471652] [042/132] (843s left) gem_mmap_gtt (basic-write-read-distinct)
[175.533383] Subtest basic-write-read-distinct: SKIP (0.000s)
[175.591936] [043/132] (843s left) gem_ctx_shared (q-in-order)
[175.643523] Starting subtest: Q-in-order
[175.645583] Starting dynamic subtest: rcs0
[175.741842] Dynamic subtest rcs0: SUCCESS (0.097s)
[175.757410] Starting dynamic subtest: vcs0
[175.819197] Dynamic subtest vcs0: SUCCESS (0.077s)
[175.834491] Starting dynamic subtest: vcs1
[175.891691] Dynamic subtest vcs1: SUCCESS (0.072s)
[175.908107] Starting dynamic subtest: vecs0
[175.965314] Dynamic subtest vecs0: SUCCESS (0.073s)
[175.981181] Starting dynamic subtest: ccs0
[176.036050] Dynamic subtest ccs0: SUCCESS (0.070s)
[176.038479] Subtest Q-in-order: SUCCESS (0.392s)
[177.043791] [044/132] (841s left) syncobj_timeline (wait-all-complex)
[177.105627] Starting subtest: wait-all-complex
[177.319898] Subtest wait-all-complex: SUCCESS (0.213s)
[177.419086] [045/132] (841s left) kms_async_flips (alternate-sync-async-flip-atomic)
[177.514828] Starting subtest: alternate-sync-async-flip-atomic
[177.886164] Starting dynamic subtest: pipe-A-eDP-1
[180.670268] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.785s)
[181.049232] Starting dynamic subtest: pipe-B-eDP-1
[183.797168] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[184.190580] Starting dynamic subtest: pipe-C-eDP-1
[186.937280] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.754s)
[187.307771] Starting dynamic subtest: pipe-D-eDP-1
[190.072883] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[190.074795] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.559s)
[191.260781] [046/132] (827s left) gem_ctx_create (basic-files)
[191.333591] Starting subtest: basic-files
[193.339071] Subtest basic-files: SUCCESS (2.008s)
[194.961780] [047/132] (823s left) gem_tiling_max_stride
[195.084363] [048/132] (823s left) i915_drm_fdinfo (virtual-idle)
[195.126517] Starting subtest: virtual-idle
[198.219775] Subtest virtual-idle: SUCCESS (3.088s)
[198.338678] [049/132] (820s left) kms_chamelium_edid (dp-edid-read)
[198.742729] Subtest dp-edid-read: SKIP (0.000s)
[199.589464] [050/132] (819s left) gem_ctx_persistence (process)
[199.671828] Starting subtest: process
[199.917286] Subtest process: SUCCESS (0.245s)
[200.008301] [051/132] (819s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[200.101792] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[200.104105] Starting dynamic subtest: pipe-A-eDP-1
[200.113671] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[200.123428] Starting dynamic subtest: pipe-B-eDP-1
[200.132641] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[200.141396] Starting dynamic subtest: pipe-C-eDP-1
[200.150193] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[200.158466] Starting dynamic subtest: pipe-D-eDP-1
[200.167195] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[200.171563] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[202.257249] [052/132] (816s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[202.347482] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[202.349867] Starting dynamic subtest: A-eDP1
[205.954622] Dynamic subtest A-eDP1: SUCCESS (3.607s)
[205.964257] Starting dynamic subtest: B-eDP1
[209.162551] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[209.172053] Starting dynamic subtest: C-eDP1
[212.268023] Dynamic subtest C-eDP1: SUCCESS (3.104s)
[212.277621] Starting dynamic subtest: D-eDP1
[215.340512] Dynamic subtest D-eDP1: SUCCESS (3.071s)
[215.342778] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.995s)
[216.154166] [053/132] (803s left) core_setmaster (master-drop-set-shared-fd)
[216.251543] Starting subtest: master-drop-set-shared-fd
[216.270332] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[216.309877] [054/132] (802s left) api_intel_bb (simple-bb)
[216.363768] Starting subtest: simple-bb
[216.366304] Subtest simple-bb: SUCCESS (0.006s)
[216.477014] [055/132] (802s left) gem_exec_suspend (basic-s3-devices)
[216.544726] Starting subtest: basic-S3-devices
[216.547027] Starting dynamic subtest: smem
[227.861483] Dynamic subtest smem: SUCCESS (11.314s)
[227.864128] Subtest basic-S3-devices: SUCCESS (11.316s)
[228.046901] [056/132] (791s left) gem_exec_reloc (basic-write-gtt-active)
[228.116697] Subtest basic-write-gtt-active: SKIP (0.000s)
[228.174971] [057/132] (791s left) syncobj_wait (single-wait-all-submitted)
[228.237424] Starting subtest: single-wait-all-submitted
[228.345675] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[228.421820] [058/132] (791s left) gem_exec_schedule (submit-late-slice)
[228.501764] Starting subtest: submit-late-slice
[228.504175] Starting dynamic subtest: rcs0
[228.541206] Dynamic subtest rcs0: SUCCESS (0.047s)
[228.551091] Starting dynamic subtest: bcs0
[228.572198] Dynamic subtest bcs0: SUCCESS (0.030s)
[228.586048] Starting dynamic subtest: vcs0
[228.607632] Dynamic subtest vcs0: SUCCESS (0.035s)
[228.617402] Starting dynamic subtest: vcs1
[228.643719] Dynamic subtest vcs1: SUCCESS (0.035s)
[228.652458] Starting dynamic subtest: vecs0
[228.673720] Dynamic subtest vecs0: SUCCESS (0.029s)
[228.682356] Starting dynamic subtest: ccs0
[228.708247] Dynamic subtest ccs0: SUCCESS (0.034s)
[228.710576] Subtest submit-late-slice: SUCCESS (0.215s)
[229.966470] [059/132] (789s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[230.074281] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[230.089133] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.014s)
[230.217612] [060/132] (789s left) gem_pxp (create-valid-protected-context)
[230.350054] Starting subtest: create-valid-protected-context
[230.352737] Subtest create-valid-protected-context: SUCCESS (0.002s)
[230.492019] [061/132] (789s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[230.598364] Starting subtest: fbcpsr-tiling-linear
[237.253589] Subtest fbcpsr-tiling-linear: SUCCESS (6.661s)
[237.434445] [062/132] (782s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[237.539670] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[237.541868] Starting dynamic subtest: pipe-A-eDP-1
[237.612907] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[237.622527] Starting dynamic subtest: pipe-B-eDP-1
[238.721322] Dynamic subtest pipe-B-eDP-1: SKIP (1.106s)
[238.725679] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.186s)
[240.018635] [063/132] (779s left) gem_ctx_persistence (engines-mixed-process)
[240.085684] Starting subtest: engines-mixed-process
[240.088165] Starting dynamic subtest: rcs0
[241.972297] Dynamic subtest rcs0: SUCCESS (1.886s)
[241.984301] Starting dynamic subtest: bcs0
[243.888870] Dynamic subtest bcs0: SUCCESS (1.915s)
[243.900524] Starting dynamic subtest: vcs0
[245.890116] Dynamic subtest vcs0: SUCCESS (1.999s)
[245.901249] Starting dynamic subtest: vcs1
[247.905850] Dynamic subtest vcs1: SUCCESS (2.015s)
[247.916624] Starting dynamic subtest: vecs0
[249.875633] Dynamic subtest vecs0: SUCCESS (1.968s)
[249.886760] Starting dynamic subtest: ccs0
[251.950924] Dynamic subtest ccs0: SUCCESS (2.073s)
[251.953443] Subtest engines-mixed-process: SUCCESS (11.866s)
[252.053115] [064/132] (767s left) gem_ccs (block-copy-compressed)
[252.129839] Starting subtest: block-copy-compressed
[252.134414] Subtest block-copy-compressed: SKIP (0.000s)
[252.255855] [065/132] (767s left) gem_eio (unwedge-stress)
[252.495297] Starting subtest: unwedge-stress
[252.497587] Starting dynamic subtest: render
[257.674191] Dynamic subtest render: SUCCESS (5.177s)
[257.690214] Starting dynamic subtest: bsd1
[275.441487] Dynamic subtest bsd1: SUCCESS (17.765s)
[275.458044] Starting dynamic subtest: bsd2
[293.442494] Dynamic subtest bsd2: SUCCESS (18.000s)
[293.458195] Starting dynamic subtest: blt
[293.462339] Dynamic subtest blt: SKIP (0.000s)
[293.470787] Starting dynamic subtest: vebox
[311.478454] Dynamic subtest vebox: SUCCESS (18.034s)
[311.480500] Subtest unwedge-stress: SUCCESS (58.981s)
[312.992639] [066/132] (706s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[313.051296] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[313.118985] [067/132] (706s left) kms_flip (busy-flip)
[313.208265] Starting subtest: busy-flip
[313.210460] Starting dynamic subtest: A-eDP1
[314.906203] Dynamic subtest A-eDP1: SUCCESS (1.697s)
[314.917464] Starting dynamic subtest: B-eDP1
[316.632916] Dynamic subtest B-eDP1: SUCCESS (1.725s)
[316.642175] Starting dynamic subtest: C-eDP1
[318.255094] Dynamic subtest C-eDP1: SUCCESS (1.621s)
[318.265666] Starting dynamic subtest: D-eDP1
[319.893173] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[319.899412] Subtest busy-flip: SUCCESS (6.689s)
[321.175063] [068/132] (698s left) i915_drm_fdinfo (virtual-busy-hang)
[321.216657] Starting subtest: virtual-busy-hang
[321.220641] Subtest virtual-busy-hang: SKIP (0.000s)
[321.295397] [069/132] (698s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[321.393064] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[321.397073] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[321.481642] [070/132] (698s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[321.571064] Starting subtest: invalidate-primary-flip-overlay
[332.393143] Subtest invalidate-primary-flip-overlay: SUCCESS (10.824s)
[332.531023] [071/132] (687s left) kms_pm_rpm (system-suspend-idle)
[334.053669] Starting subtest: system-suspend-idle
[354.330420] Subtest system-suspend-idle: SUCCESS (4.646s)
[354.738978] [072/132] (665s left) gem_ccs (suspend-resume)
[354.803766] Starting subtest: suspend-resume
[354.807929] Subtest suspend-resume: SKIP (0.000s)
[354.928379] [073/132] (665s left) kms_big_fb (linear-16bpp-rotate-180)
[355.030201] Starting subtest: linear-16bpp-rotate-180
[356.497677] Subtest linear-16bpp-rotate-180: SUCCESS (1.468s)
[356.655291] [074/132] (663s left) kms_plane_lowres (tiling-x)
[356.751101] Starting subtest: tiling-x
[356.753004] Starting dynamic subtest: pipe-A-eDP-1
[356.756925] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.045303] Starting dynamic subtest: pipe-B-eDP-1
[357.050197] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.059455] Starting dynamic subtest: pipe-C-eDP-1
[357.064156] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.073391] Starting dynamic subtest: pipe-D-eDP-1
[357.077670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.081910] Subtest tiling-x: SKIP (0.293s)
[357.847485] [075/132] (662s left) gem_close_race (basic-threads)
[357.927662] Starting subtest: basic-threads
[359.388013] Subtest basic-threads: SUCCESS (1.461s)
[359.588200] [076/132] (660s left) kms_getfb (getfb-handle-protection)
[359.685161] Starting subtest: getfb-handle-protection
[359.705527] Subtest getfb-handle-protection: SUCCESS (0.022s)
[359.853630] [077/132] (660s left) kms_feature_discovery (display)
[359.943959] Starting subtest: display
[359.946100] Subtest display: SUCCESS (0.000s)
[360.027423] [078/132] (660s left) kms_chamelium_color (ctm-0-25)
[360.114410] Subtest ctm-0-25: SKIP (0.000s)
[360.168208] [079/132] (660s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[360.264754] Starting subtest: y-tiled-8bpp-rotate-180
[360.269077] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[360.396004] [080/132] (659s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[360.523933] Starting subtest: flip-vs-cursor-crc-atomic
[361.208193] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.683s)
[362.072141] [081/132] (658s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[362.176919] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[369.573196] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.401s)
[369.732492] [082/132] (650s left) kms_frontbuffer_tracking (psr-1p-rte)
[369.842437] Starting subtest: psr-1p-rte
[375.338217] Subtest psr-1p-rte: SUCCESS (5.500s)
[375.464524] [083/132] (645s left) gem_wait (write-wait)
[375.542924] Starting subtest: write-wait
[375.545342] Starting dynamic subtest: all-engines
[376.683503] Dynamic subtest all-engines: SUCCESS (1.140s)
[376.701476] Starting dynamic subtest: rcs0
[377.742483] Dynamic subtest rcs0: SUCCESS (1.057s)
[377.759815] Starting dynamic subtest: bcs0
[378.805030] Dynamic subtest bcs0: SUCCESS (1.060s)
[378.822729] Starting dynamic subtest: vcs0
[379.860535] Dynamic subtest vcs0: SUCCESS (1.053s)
[379.877649] Starting dynamic subtest: vcs1
[380.914225] Dynamic subtest vcs1: SUCCESS (1.052s)
[380.931144] Starting dynamic subtest: vecs0
[381.967526] Dynamic subtest vecs0: SUCCESS (1.051s)
[381.984653] Starting dynamic subtest: ccs0
[383.024009] Dynamic subtest ccs0: SUCCESS (1.054s)
[383.026551] Subtest write-wait: SUCCESS (7.484s)
[383.234175] [084/132] (637s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[383.351136] Starting subtest: bad-pixel-format-y-tiled-ccs
[383.353381] Starting dynamic subtest: pipe-A-eDP-1
[383.376545] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[383.387821] Starting dynamic subtest: pipe-B-eDP-1
[383.409211] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[383.418588] Starting dynamic subtest: pipe-C-eDP-1
[383.440319] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[383.450680] Starting dynamic subtest: pipe-D-eDP-1
[383.472545] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[383.476631] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[385.696072] [085/132] (634s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[385.808293] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[385.812388] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[385.942788] [086/132] (634s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[386.049432] Starting subtest: fbc-shrfb-scaledprimary
[389.120818] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.074s)
[390.312351] [087/132] (630s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[390.417196] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[390.419445] Starting dynamic subtest: pipe-A-eDP-1
[390.443170] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[390.455325] Starting dynamic subtest: pipe-B-eDP-1
[390.476589] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[390.485908] Starting dynamic subtest: pipe-C-eDP-1
[390.507880] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[390.518024] Starting dynamic subtest: pipe-D-eDP-1
[390.539944] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[390.543988] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[392.661676] [088/132] (628s left) gen9_exec_parse (bb-large)
[392.730524] Subtest bb-large: SKIP (0.000s)
[392.819718] [089/132] (627s left) perf (i915-ref-count)
[392.902638] Starting subtest: i915-ref-count
[392.973513] Subtest i915-ref-count: SUCCESS (0.069s)
[393.031771] [090/132] (627s left) sw_sync (alloc_fence_invalid_timeline)
[393.068165] Starting subtest: alloc_fence_invalid_timeline
[393.070309] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[393.143383] [091/132] (627s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[393.247063] Starting subtest: psr-modesetfrombusy
[399.398877] Subtest psr-modesetfrombusy: SUCCESS (6.155s)
[399.564370] [092/132] (621s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[399.672775] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[399.676012] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[399.794738] [093/132] (621s left) gem_softpin (allocator-basic)
[399.862632] Starting subtest: allocator-basic
[399.933910] Subtest allocator-basic: SUCCESS (0.071s)
[400.086381] [094/132] (620s left) gem_render_copy (linear-to-vebox-y-tiled)
[400.157765] Starting subtest: linear-to-vebox-y-tiled
[400.161739] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[400.367612] [095/132] (620s left) gem_mmap_gtt (hang)
[400.431923] Subtest hang: SKIP (0.000s)
[400.502990] [096/132] (620s left) gem_exec_schedule (out-order)
[400.575801] Starting subtest: out-order
[400.577760] Starting dynamic subtest: rcs0
[400.669104] Dynamic subtest rcs0: SUCCESS (0.099s)
[400.680906] Starting dynamic subtest: vcs0
[400.754048] Dynamic subtest vcs0: SUCCESS (0.084s)
[400.765560] Starting dynamic subtest: vcs1
[400.839726] Dynamic subtest vcs1: SUCCESS (0.085s)
[400.851694] Starting dynamic subtest: vecs0
[400.915463] Dynamic subtest vecs0: SUCCESS (0.075s)
[400.928201] Starting dynamic subtest: ccs0
[400.996302] Dynamic subtest ccs0: SUCCESS (0.080s)
[400.998766] Subtest out-order: SUCCESS (0.427s)
[402.688985] [097/132] (618s left) gem_exec_reloc (basic-scanout)
[402.751259] Subtest basic-scanout: SKIP (0.000s)
[402.818900] [098/132] (618s left) kms_psr (fbc-psr-primary-render)
[402.919820] Starting subtest: fbc-psr-primary-render
[402.922042] Starting dynamic subtest: eDP-1
[402.926024] Dynamic subtest eDP-1: SKIP (0.000s)
[402.929995] Subtest fbc-psr-primary-render: SKIP (0.001s)
[403.006029] [099/132] (618s left) prime_mmap (test_correct_cpu_write)
[403.058217] Starting subtest: test_correct_cpu_write
[403.060638] Starting dynamic subtest: test_correct_cpu_write-smem
[403.063065] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[403.065407] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[403.192889] [100/132] (618s left) syncobj_timeline (invalid-signal-zero-handles)
[403.248741] Starting subtest: invalid-signal-zero-handles
[403.250952] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[403.392210] [101/132] (617s left) kms_cursor_legacy (torture-bo)
[403.522289] Starting subtest: torture-bo
[403.524457] Starting dynamic subtest: pipe-A
[409.380340] Dynamic subtest pipe-A: SUCCESS (5.854s)
[409.395884] Starting dynamic subtest: pipe-B
[415.878811] Dynamic subtest pipe-B: SUCCESS (6.498s)
[415.889954] Starting dynamic subtest: pipe-C
[423.507186] Dynamic subtest pipe-C: SUCCESS (7.627s)
[423.520282] Starting dynamic subtest: pipe-D
[430.514914] Dynamic subtest pipe-D: SUCCESS (7.006s)
[430.524694] Starting dynamic subtest: all-pipes
[437.083536] Dynamic subtest all-pipes: SUCCESS (6.564s)
[437.086092] Subtest torture-bo: SUCCESS (33.559s)
[437.267153] [102/132] (584s left) kms_cursor_crc (cursor-onscreen-32x10)
[437.424273] Starting subtest: cursor-onscreen-32x10
[437.470019] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[437.751183] [103/132] (583s left) gem_mmap_offset (partial-mmap)
[437.812298] Starting subtest: partial-mmap
[437.814671] Starting dynamic subtest: smem0
[437.817027] Dynamic subtest smem0: SUCCESS (0.003s)
[437.818968] Subtest partial-mmap: SUCCESS (0.004s)
[437.963897] [104/132] (583s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[438.068082] Starting subtest: plane-lut1d-ctm3x4-lut1d
[438.080776] Starting dynamic subtest: pipe-A-eDP-1
[438.733053] Dynamic subtest pipe-A-eDP-1: FAIL (0.318s)
[439.473545] Starting dynamic subtest: pipe-B-eDP-1
[440.302436] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[440.812261] Starting dynamic subtest: pipe-C-eDP-1
[441.676243] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s)
[442.135904] Starting dynamic subtest: pipe-D-eDP-1
[442.939730] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[442.941613] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.575s)
[443.521320] [105/132] (577s left) gem_userptr_blits (unsync-overlap)
[443.600147] Subtest unsync-overlap: SKIP (0.000s)
[443.744381] [106/132] (577s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[443.849336] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[443.853444] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[443.972924] [107/132] (577s left) kms_selftest (drm_damage_helper)
[444.005578] Starting subtest: drm_damage_helper
[444.045242] Starting dynamic subtest: drm_test_damage_iter_no_damage
[444.182330] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.136s)
[444.198435] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[444.314069] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.132s)
[444.325151] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[444.448402] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.133s)
[444.458601] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[444.572803] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.123s)
[444.583585] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[444.689937] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.116s)
[444.699010] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[444.823520] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.132s)
[444.842160] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[444.931449] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.107s)
[444.941577] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[445.074495] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.144s)
[445.083468] Starting dynamic subtest: drm_test_damage_iter_single_damage
[445.217720] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.142s)
[445.226721] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[445.339201] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.121s)
[445.348424] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[445.436877] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.097s)
[445.446268] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[445.588291] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.151s)
[445.597463] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[445.728436] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.137s)
[445.737620] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[445.885813] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.157s)
[445.894881] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[445.988209] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.102s)
[445.997056] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[446.133898] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.143s)
[446.145044] Starting dynamic subtest: drm_test_damage_iter_damage
[446.222584] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.089s)
[446.231695] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[446.368648] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.146s)
[446.377621] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[446.467358] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.097s)
[446.476282] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[446.613931] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.144s)
[446.624958] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[446.751528] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.137s)
[446.753472] Subtest drm_damage_helper: SUCCESS (2.745s)
[446.953065] [108/132] (574s left) gem_exec_capture (capture-recoverable)
[447.018457] Starting subtest: capture-recoverable
[447.023626] Subtest capture-recoverable: SUCCESS (0.005s)
[447.166726] [109/132] (574s left) gem_tiled_swapping (non-threaded)
[447.223122] Subtest non-threaded: SKIP (0.000s)
[447.284558] [110/132] (574s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[447.383687] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[447.385997] Starting dynamic subtest: pipe-A-eDP-1
[448.210451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s)
[448.220514] Starting dynamic subtest: pipe-B-eDP-1
[449.785195] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.572s)
[449.795613] Starting dynamic subtest: pipe-C-eDP-1
[451.325430] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.539s)
[451.336615] Starting dynamic subtest: pipe-D-eDP-1
[452.886098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.559s)
[452.888071] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.495s)
[454.143846] [111/132] (567s left) gem_exec_balancer (full-pulse)
[454.210713] Starting subtest: full-pulse
[458.452305] Subtest full-pulse: SUCCESS (4.241s)
[458.801291] [112/132] (562s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[458.910341] Starting subtest: fbc-rgb565-draw-render
[463.200277] Subtest fbc-rgb565-draw-render: SUCCESS (4.292s)
[464.346850] [113/132] (557s left) kms_flip (flip-vs-panning-vs-hang)
[464.450454] Starting subtest: flip-vs-panning-vs-hang
[464.452527] Starting dynamic subtest: A-eDP1
[504.023744] Dynamic subtest A-eDP1: SUCCESS (39.574s)
[504.040383] Starting dynamic subtest: D-eDP1
[544.026659] Dynamic subtest D-eDP1: SUCCESS (40.001s)
[544.029070] Subtest flip-vs-panning-vs-hang: SUCCESS (79.582s)
[545.222076] [114/132] (476s left) kms_addfb_basic (clobberred-modifier)
[545.290580] Starting subtest: clobberred-modifier
[545.295167] Subtest clobberred-modifier: SKIP (0.000s)
[545.452242] [115/132] (476s left) gem_lmem_swapping (smem-oom)
[545.498303] Subtest smem-oom: SKIP (0.000s)
[545.546982] [116/132] (476s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[545.642176] Starting subtest: coverage-vs-premult-vs-constant
[545.930852] Starting dynamic subtest: pipe-A-eDP-1
[546.532374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[546.542642] Starting dynamic subtest: pipe-D-eDP-1
[547.856964] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[547.859255] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.215s)
[548.708756] [117/132] (473s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[548.821382] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[548.825209] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[548.927355] [118/132] (473s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[548.978912] Starting subtest: etime-single-wait-for-submit-submitted
[549.081916] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.102s)
[549.175824] [119/132] (472s left) gem_softpin (noreloc)
[549.241737] Starting subtest: noreloc
[554.647564] Subtest noreloc: SUCCESS (5.405s)
[554.800461] [120/132] (467s left) gem_render_tiled_blits (basic)
[554.865918] Subtest basic: SKIP (0.000s)
[554.942188] [121/132] (467s left) kms_psr (pr-suspend)
[555.049758] Starting subtest: pr-suspend
[555.054152] Subtest pr-suspend: SKIP (0.000s)
[555.136199] [122/132] (466s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[555.191371] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[555.297303] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[555.392675] [123/132] (466s left) kms_psr (psr-cursor-blt)
[555.491115] Starting subtest: psr-cursor-blt
[555.493408] Starting dynamic subtest: eDP-1
[557.173565] Dynamic subtest eDP-1: SUCCESS (1.683s)
[557.175940] Subtest psr-cursor-blt: SUCCESS (1.684s)
[558.050814] [124/132] (464s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[558.164986] Starting subtest: fbc-rgb565-draw-mmap-gtt
[558.168965] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[558.294178] [125/132] (463s left) gem_exec_params (sol-reset-not-gen7)
[558.346202] Starting subtest: sol-reset-not-gen7
[558.351376] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[558.502759] [126/132] (463s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[558.605131] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[558.609600] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[558.711368] [127/132] (463s left) kms_plane (planar-pixel-format-settings)
[558.815099] Starting subtest: planar-pixel-format-settings
[558.885243] Subtest planar-pixel-format-settings: SUCCESS (0.072s)
[559.010885] [128/132] (463s left) gem_exec_whisper (basic-fds-priority-all)
[559.072621] Starting subtest: basic-fds-priority-all
[581.080884] Subtest basic-fds-priority-all: SUCCESS (22.003s)
[581.276363] [129/132] (441s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[581.340373] Starting subtest: invalid-single-wait-all-unsubmitted
[581.342627] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[581.489752] [130/132] (440s left) kms_flip (2x-flip-vs-expired-vblank)
[581.587316] Starting subtest: 2x-flip-vs-expired-vblank
[581.596315] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[581.703104] [131/132] (440s left) gem_exec_flush (basic-batch-kernel-default-uc)
[581.778355] Starting subtest: basic-batch-kernel-default-uc
[589.122065] Subtest basic-batch-kernel-default-uc: SUCCESS (7.343s)
[589.325473] [132/132] (433s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[589.444098] Starting subtest: fbcpsr-modesetfrombusy
[595.704670] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.265s)
[595.871766] 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.