[58.173320] Initializing watchdogs
[58.173364]   /dev/watchdog0
[58.186750] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.191104] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.193253] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.196341] [001/133] (960s left) kms_flip (wf_vblank-ts-check)
[58.314958] Starting subtest: wf_vblank-ts-check
[58.317422] Starting dynamic subtest: A-eDP1
[67.307991] Dynamic subtest A-eDP1: SUCCESS (8.965s)
[67.319413] Starting dynamic subtest: B-eDP1
[76.238342] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[76.245261] Starting dynamic subtest: C-eDP1
[85.165200] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[85.172361] Starting dynamic subtest: D-eDP1
[94.097716] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[94.103156] Subtest wf_vblank-ts-check: SUCCESS (35.748s)
[95.325033] [002/133] (923s left) kms_cursor_crc (cursor-onscreen-256x256)
[95.561396] Starting subtest: cursor-onscreen-256x256
[95.576947] Starting dynamic subtest: pipe-A-eDP-1
[97.712279] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.136s)
[97.740543] Starting dynamic subtest: pipe-D-eDP-1
[100.537525] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.802s)
[100.539793] Subtest cursor-onscreen-256x256: SUCCESS (4.974s)
[101.397340] [003/133] (917s left) gem_mmap_gtt (big-copy-odd)
[101.454990] Subtest big-copy-odd: SKIP (0.000s)
[101.509612] [004/133] (917s left) i915_pm_rpm (sysfs-read)
[103.148080] Starting subtest: sysfs-read
[104.292767] Subtest sysfs-read: SUCCESS (1.147s)
[104.661051] [005/133] (914s left) kms_universal_plane (disable-primary-vs-flip)
[104.752067] Starting subtest: disable-primary-vs-flip
[104.754211] Starting dynamic subtest: pipe-A-eDP-1
[106.353225] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.601s)
[106.360230] Starting dynamic subtest: pipe-B-eDP-1
[108.622074] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.268s)
[108.630550] Starting dynamic subtest: pipe-C-eDP-1
[110.853451] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.227s)
[110.862534] Starting dynamic subtest: pipe-D-eDP-1
[113.037198] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.182s)
[113.039384] Subtest disable-primary-vs-flip: SUCCESS (8.283s)
[113.841765] [006/133] (905s left) perf (gen12-group-exclusive-stream-ctx-handle)
[113.982794] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[114.006069] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[114.043405] [007/133] (904s left) kms_flip_event_leak (basic)
[115.935397] Starting subtest: basic
[115.937408] Starting dynamic subtest: pipe-A-eDP-1
[116.363347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[116.376169] Starting dynamic subtest: pipe-B-eDP-1
[117.469814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.105s)
[117.478183] Starting dynamic subtest: pipe-C-eDP-1
[118.569699] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s)
[118.578516] Starting dynamic subtest: pipe-D-eDP-1
[119.703071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[119.705069] Subtest basic: SUCCESS (3.768s)
[120.557530] [008/133] (898s left) gem_exec_fence (syncobj-wait)
[121.020786] Starting subtest: syncobj-wait
[122.916391] Subtest syncobj-wait: SUCCESS (1.897s)
[123.257726] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[123.260541] [009/133] (895s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[123.353998] Starting subtest: primary-y-tiled-reflect-x-90
[123.358352] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[123.426996] [010/133] (895s left) kms_psr (fbc-psr-no-drrs)
[123.524992] Starting subtest: fbc-psr-no-drrs
[123.526939] Starting dynamic subtest: eDP-1
[123.531105] Dynamic subtest eDP-1: SKIP (0.000s)
[123.535220] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[123.595836] [011/133] (895s left) kms_chamelium_edid (hdmi-mode-timings)
[123.974282] Subtest hdmi-mode-timings: SKIP (0.000s)
[124.776886] [012/133] (894s left) gem_exec_flush (basic-wb-ro-before-default)
[124.849607] Starting subtest: basic-wb-ro-before-default
[130.300326] Subtest basic-wb-ro-before-default: SUCCESS (5.453s)
[130.498316] [013/133] (888s left) gem_ccs (block-multicopy-inplace)
[130.555939] Starting subtest: block-multicopy-inplace
[130.560657] Subtest block-multicopy-inplace: SKIP (0.000s)
[130.665631] [014/133] (888s left) kms_invalid_mode (clock-too-high)
[130.771107] Starting subtest: clock-too-high
[130.773427] Starting dynamic subtest: pipe-A-eDP-1
[130.777668] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[130.786828] Starting dynamic subtest: pipe-B-eDP-1
[130.790784] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[130.798906] Starting dynamic subtest: pipe-C-eDP-1
[130.803120] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[130.810557] Starting dynamic subtest: pipe-D-eDP-1
[130.814690] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[130.818812] Subtest clock-too-high: SKIP (0.003s)
[130.853145] [015/133] (888s left) perf (invalid-remove-userspace-config)
[130.959586] Starting subtest: invalid-remove-userspace-config
[130.969748] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[131.011404] [016/133] (888s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[131.107322] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[131.111644] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[131.186177] [017/133] (888s left) gem_pxp (hw-rejects-pxp-buffer)
[131.310872] Starting subtest: hw-rejects-pxp-buffer
[131.315501] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[131.441649] [018/133] (887s left) vgem_basic (dmabuf-fence)
[131.481513] Starting subtest: dmabuf-fence
[131.483436] Subtest dmabuf-fence: SUCCESS (0.001s)
[131.550224] [019/133] (887s left) core_getclient (basic)
[131.595292] Starting subtest: basic
[131.597102] Subtest basic: SUCCESS (0.000s)
[131.675138] [020/133] (887s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[131.774237] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[131.777939] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[131.855412] [021/133] (887s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[131.941520] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[131.943445] Starting dynamic subtest: pipe-A-default-mode
[134.668603] Dynamic subtest pipe-A-default-mode: SUCCESS (2.726s)
[134.670560] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.727s)
[135.510429] [022/133] (884s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[135.558748] Starting subtest: invalid-signal-one-illegal-handle
[135.560671] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[135.654455] [023/133] (883s left) kms_getfb (getfb-handle-not-fb)
[135.744401] Starting subtest: getfb-handle-not-fb
[135.746624] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[135.859799] [024/133] (883s left) kms_color (invalid-ctm-matrix-sizes)
[135.962873] Starting subtest: invalid-ctm-matrix-sizes
[135.964994] Starting dynamic subtest: pipe-A
[135.967256] Dynamic subtest pipe-A: SUCCESS (0.002s)
[135.975278] Starting dynamic subtest: pipe-B
[135.977092] Dynamic subtest pipe-B: SUCCESS (0.002s)
[135.984150] Starting dynamic subtest: pipe-C
[135.986407] Dynamic subtest pipe-C: SUCCESS (0.003s)
[135.993554] Starting dynamic subtest: pipe-D
[135.995648] Dynamic subtest pipe-D: SUCCESS (0.003s)
[135.997748] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[136.042253] [025/133] (883s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[136.129776] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[136.131976] Starting dynamic subtest: pipe-A-eDP-1
[138.288134] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.159s)
[138.295937] Starting dynamic subtest: pipe-B-eDP-1
[140.512202] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.222s)
[140.521082] Starting dynamic subtest: pipe-C-eDP-1
[142.572930] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.060s)
[142.585784] Starting dynamic subtest: pipe-D-eDP-1
[144.566367] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.992s)
[144.568551] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.438s)
[145.712112] [026/133] (873s left) i915_drm_fdinfo (memory-info-resident)
[145.757080] Starting subtest: memory-info-resident
[145.759374] Starting dynamic subtest: smem0
[148.518900] Dynamic subtest smem0: SUCCESS (2.761s)
[148.521540] Subtest memory-info-resident: SUCCESS (2.762s)
[148.591740] [027/133] (871s left) gem_pipe_control_store_loop (reused-buffer)
[148.648247] Starting subtest: reused-buffer
[150.804967] Subtest reused-buffer: SUCCESS (2.154s)
[150.925577] [028/133] (868s left) device_reset (unbind-reset-rebind)
[150.975689] Starting subtest: unbind-reset-rebind
[154.028938] Subtest unbind-reset-rebind: SUCCESS (3.050s)
[154.073352] [029/133] (865s left) kms_content_protection (lic-type-1)
[154.201793] Starting subtest: lic-type-1
[154.206420] Subtest lic-type-1: SKIP (0.000s)
[154.334367] [030/133] (865s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[154.428569] Starting subtest: 4-tiled-8bpp-rotate-90
[154.465779] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.037s)
[154.583720] [031/133] (865s left) kms_rotation_crc (primary-rotation-270)
[154.686028] Starting subtest: primary-rotation-270
[154.690561] Subtest primary-rotation-270: SKIP (0.002s)
[154.772430] [032/133] (865s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[157.008938] Starting subtest: modeset-non-lpsp-stress-no-wait
[157.052421] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.043s)
[157.382569] [033/133] (862s left) kms_async_flips (async-flip-hang)
[157.480037] Starting subtest: async-flip-hang
[157.851699] Starting dynamic subtest: pipe-A-eDP-1
[184.370192] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.517s)
[184.741074] Starting dynamic subtest: pipe-B-eDP-1
[200.369716] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.633s)
[200.739657] Starting dynamic subtest: pipe-C-eDP-1
[216.366058] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.629s)
[216.745197] Starting dynamic subtest: pipe-D-eDP-1
[232.368834] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.626s)
[232.371429] Subtest async-flip-hang: SUCCESS (74.884s)
[233.525970] [034/133] (786s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[233.636335] Starting subtest: cursorB-vs-flipB-legacy
[233.640788] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[233.780372] [035/133] (786s left) kms_lease (master-vs-lease)
[233.883150] Starting subtest: master-vs-lease
[233.885274] Subtest master-vs-lease: SUCCESS (0.002s)
[233.987418] [036/133] (786s left) kms_plane_multiple (tiling-y)
[234.079871] Starting subtest: tiling-y
[234.084169] Subtest tiling-y: SKIP (0.000s)
[234.155494] [037/133] (785s left) i915_hangman (engine-engine-hang)
[234.214445] Starting subtest: engine-engine-hang
[234.216787] Starting dynamic subtest: rcs0
[235.892439] Dynamic subtest rcs0: SUCCESS (1.676s)
[235.904787] Starting dynamic subtest: bcs0
[237.875050] Dynamic subtest bcs0: SUCCESS (1.979s)
[237.886874] Starting dynamic subtest: vcs0
[239.860192] Dynamic subtest vcs0: SUCCESS (1.983s)
[239.871733] Starting dynamic subtest: vcs1
[241.907835] Dynamic subtest vcs1: SUCCESS (2.043s)
[241.919272] Starting dynamic subtest: vecs0
[243.890521] Dynamic subtest vecs0: SUCCESS (1.983s)
[243.905104] Starting dynamic subtest: ccs0
[245.875999] Dynamic subtest ccs0: SUCCESS (1.982s)
[245.878680] Subtest engine-engine-hang: SUCCESS (11.661s)
[245.980015] [038/133] (774s left) gem_media_fill (media-fill)
[246.033787] Subtest media-fill: SKIP (0.000s)
[246.145110] [039/133] (774s left) kms_flip (2x-busy-flip)
[246.238880] Starting subtest: 2x-busy-flip
[246.249056] Subtest 2x-busy-flip: SKIP (0.010s)
[246.328799] [040/133] (773s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[246.435333] Starting subtest: yf-tiled-16bpp-rotate-90
[246.439650] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[246.534220] [041/133] (773s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[246.911904] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[247.737144] [042/133] (772s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[248.295802] Starting subtest: syncobj-timeline-invalid-wait
[248.298840] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[250.030061] [043/133] (770s left) gem_workarounds (basic-read)
[250.096629] Starting subtest: basic-read
[250.105509] Subtest basic-read: SUCCESS (0.011s)
[250.283082] [044/133] (770s left) syncobj_eventfd (invalid-illegal-eventfd)
[250.338438] Starting subtest: invalid-illegal-eventfd
[250.340845] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[250.479526] [045/133] (770s left) kms_plane_alpha_blend (alpha-7efc)
[250.594413] Starting subtest: alpha-7efc
[250.879425] Starting dynamic subtest: pipe-A-eDP-1
[251.485734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[251.512232] Starting dynamic subtest: pipe-D-eDP-1
[252.753585] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s)
[252.756030] Subtest alpha-7efc: SUCCESS (2.160s)
[253.618235] [046/133] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[253.718978] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[260.469490] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.753s)
[260.615982] [047/133] (760s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[260.716258] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[260.718503] Starting dynamic subtest: pipe-A-eDP-1
[260.777805] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[260.788124] Starting dynamic subtest: pipe-B-eDP-1
[260.845781] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[260.855080] Starting dynamic subtest: pipe-C-eDP-1
[260.912356] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[260.921436] Starting dynamic subtest: pipe-D-eDP-1
[260.979293] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[260.983591] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[262.943521] [048/133] (757s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[263.051641] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[263.054062] Starting dynamic subtest: A-eDP1
[266.654870] Dynamic subtest A-eDP1: SUCCESS (3.601s)
[266.664115] Starting dynamic subtest: B-eDP1
[269.851965] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[269.860747] Starting dynamic subtest: C-eDP1
[272.962372] Dynamic subtest C-eDP1: SUCCESS (3.111s)
[272.970928] Starting dynamic subtest: D-eDP1
[276.059229] Dynamic subtest D-eDP1: SUCCESS (3.096s)
[276.061633] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.009s)
[276.864486] [049/133] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[276.970636] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[276.975081] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[277.072420] [050/133] (743s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[277.175646] Starting subtest: fb-8bpc-vs-panel-8bpc
[277.178046] Starting dynamic subtest: pipe-A-eDP-1
[278.547058] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.371s)
[278.549193] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.373s)
[279.414432] [051/133] (741s left) gem_pxp (fail-invalid-protected-context)
[279.543854] Starting subtest: fail-invalid-protected-context
[279.546432] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[279.672361] [052/133] (741s left) kms_force_connector_basic (prune-stale-modes)
[279.745531] Starting subtest: prune-stale-modes
[280.191880] Subtest prune-stale-modes: SUCCESS (0.446s)
[280.328543] [053/133] (740s left) gem_render_copy_redux (interruptible)
[280.390932] Starting subtest: interruptible
[280.653559] Subtest interruptible: SUCCESS (0.265s)
[280.766159] [054/133] (740s left) perf_pmu (faulting-read)
[280.805046] Starting subtest: faulting-read
[280.807183] Starting dynamic subtest: wb
[280.809185] Dynamic subtest wb: SUCCESS (0.001s)
[280.818425] Starting dynamic subtest: wc
[280.820262] Dynamic subtest wc: SUCCESS (0.000s)
[280.828788] Starting dynamic subtest: uc
[280.830613] Dynamic subtest uc: SUCCESS (0.000s)
[280.832389] Subtest faulting-read: SUCCESS (0.003s)
[280.915392] [055/133] (740s left) gem_ctx_isolation (clean)
[280.968438] Starting subtest: clean
[280.970323] Starting dynamic subtest: rcs0
[281.021747] Dynamic subtest rcs0: SUCCESS (0.053s)
[281.032600] Starting dynamic subtest: bcs0
[281.100712] Dynamic subtest bcs0: SUCCESS (0.078s)
[281.108956] Starting dynamic subtest: vcs0
[281.152949] Dynamic subtest vcs0: SUCCESS (0.051s)
[281.163290] Starting dynamic subtest: vcs1
[282.904591] Dynamic subtest vcs1: SUCCESS (1.750s)
[282.916057] Starting dynamic subtest: vecs0
[284.902253] Dynamic subtest vecs0: SUCCESS (1.995s)
[284.913696] Starting dynamic subtest: ccs0
[286.966744] Dynamic subtest ccs0: SUCCESS (2.063s)
[286.969250] Subtest clean: SUCCESS (5.998s)
[287.205115] [056/133] (733s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[287.325473] Starting subtest: flip-vs-cursor-busy-crc-atomic
[288.155250] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.829s)
[288.961265] [057/133] (732s left) gem_mmap_gtt (isolation)
[289.023178] Subtest isolation: SKIP (0.000s)
[289.090330] [058/133] (732s left) prime_busy (hang)
[289.140742] Starting subtest: hang
[289.143063] Starting dynamic subtest: rcs0
[315.438284] Dynamic subtest rcs0: SUCCESS (26.291s)
[315.446482] Starting dynamic subtest: bcs0
[322.592913] Dynamic subtest bcs0: SUCCESS (7.157s)
[322.602083] Starting dynamic subtest: vcs0
[329.570695] Dynamic subtest vcs0: SUCCESS (6.972s)
[329.581482] Starting dynamic subtest: vcs1
[336.548084] Dynamic subtest vcs1: SUCCESS (6.976s)
[336.558489] Starting dynamic subtest: vecs0
[343.582107] Dynamic subtest vecs0: SUCCESS (7.036s)
[343.591839] Starting dynamic subtest: ccs0
[357.423118] Dynamic subtest ccs0: SUCCESS (13.837s)
[357.425590] Subtest hang: SUCCESS (68.277s)
[357.529341] [059/133] (663s left) kms_cursor_crc (cursor-sliding-512x512)
[357.793286] Starting subtest: cursor-sliding-512x512
[357.798143] Subtest cursor-sliding-512x512: SKIP (0.001s)
[357.953679] [060/133] (663s left) gem_exec_balancer (sequential)
[358.017264] Starting subtest: sequential
[361.866352] Subtest sequential: SUCCESS (3.824s)
[362.154710] [061/133] (659s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[362.248354] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[369.174384] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.929s)
[369.295866] [062/133] (651s left) gem_softpin (full)
[369.339483] Starting subtest: full
[369.349514] Subtest full: SUCCESS (0.010s)
[369.480861] [063/133] (651s left) kms_psr (pr-sprite-plane-move)
[369.589157] Starting subtest: pr-sprite-plane-move
[369.593672] Subtest pr-sprite-plane-move: SKIP (0.000s)
[369.668952] [064/133] (651s left) gem_ctx_shared (q-in-order)
[369.754269] Starting subtest: Q-in-order
[369.756596] Starting dynamic subtest: rcs0
[369.853900] Dynamic subtest rcs0: SUCCESS (0.098s)
[369.870814] Starting dynamic subtest: vcs0
[369.941846] Dynamic subtest vcs0: SUCCESS (0.087s)
[369.959076] Starting dynamic subtest: vcs1
[370.014750] Dynamic subtest vcs1: SUCCESS (0.072s)
[370.030934] Starting dynamic subtest: vecs0
[370.085043] Dynamic subtest vecs0: SUCCESS (0.070s)
[370.100923] Starting dynamic subtest: ccs0
[370.165308] Dynamic subtest ccs0: SUCCESS (0.080s)
[370.169806] Subtest Q-in-order: SUCCESS (0.413s)
[372.029195] [065/133] (649s left) kms_chamelium_audio (hdmi-audio)
[372.408308] Subtest hdmi-audio: SKIP (0.000s)
[373.217747] [066/133] (648s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[373.260503] Starting subtest: single-wait-all-for-submit-available-submitted
[373.262548] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[373.358773] [067/133] (648s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[373.645902] Starting subtest: cursor-rapid-movement-512x170
[373.650187] Subtest cursor-rapid-movement-512x170: SKIP (0.002s)
[373.796890] [068/133] (647s left) kms_big_fb (linear-64bpp-rotate-270)
[373.895259] Starting subtest: linear-64bpp-rotate-270
[373.913832] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[374.017392] [069/133] (647s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[374.137576] Starting subtest: flip-vs-cursor-atomic
[381.183313] Subtest flip-vs-cursor-atomic: SUCCESS (7.047s)
[382.025175] [070/133] (639s left) gem_exec_schedule (semaphore-power)
[382.213779] Subtest semaphore-power: SKIP (0.000s)
[382.389947] [071/133] (639s left) gem_ctx_persistence (legacy-engines-hang)
[382.473677] Starting subtest: legacy-engines-hang
[382.475683] Starting dynamic subtest: render
[382.535713] Dynamic subtest render: SUCCESS (0.064s)
[382.551234] Starting dynamic subtest: bsd1
[382.662759] Dynamic subtest bsd1: SUCCESS (0.125s)
[382.673513] Starting dynamic subtest: bsd2
[382.763746] Dynamic subtest bsd2: SUCCESS (0.098s)
[382.774434] Starting dynamic subtest: blt
[382.862821] Dynamic subtest blt: SUCCESS (0.096s)
[382.877364] Starting dynamic subtest: vebox
[382.952605] Dynamic subtest vebox: SUCCESS (0.087s)
[382.955063] Subtest legacy-engines-hang: SUCCESS (0.483s)
[383.044567] [072/133] (638s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[383.130956] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[383.133211] Starting dynamic subtest: pipe-A
[383.194116] Dynamic subtest pipe-A: SUCCESS (0.065s)
[383.203250] Starting dynamic subtest: pipe-B
[384.318802] Dynamic subtest pipe-B: SUCCESS (1.124s)
[384.331289] Starting dynamic subtest: pipe-C
[385.402518] Dynamic subtest pipe-C: SUCCESS (1.083s)
[385.415973] Starting dynamic subtest: pipe-D
[386.503265] Dynamic subtest pipe-D: SUCCESS (1.100s)
[386.505599] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.375s)
[387.626954] [073/133] (634s left) syncobj_timeline (multi-wait-for-submit-signaled)
[387.696081] Starting subtest: multi-wait-for-submit-signaled
[387.698385] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[387.803077] [074/133] (633s left) kms_atomic_interruptible (legacy-dpms)
[387.898168] Starting subtest: legacy-dpms
[387.900383] Starting dynamic subtest: pipe-A-eDP-1
[395.317489] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.419s)
[395.319811] Subtest legacy-dpms: SUCCESS (7.421s)
[396.133258] [075/133] (625s left) syncobj_basic (bad-pad-handle-to-fd)
[396.192935] Starting subtest: bad-pad-handle-to-fd
[396.195145] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[396.315807] [076/133] (625s left) drm_read (short-buffer-nonblock)
[396.470183] Starting subtest: short-buffer-nonblock
[396.472029] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[396.583350] [077/133] (625s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[396.700224] Starting subtest: cursorB-vs-flipB-varying-size
[396.704498] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[396.859184] [078/133] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[396.968754] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[396.973121] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[397.091360] [079/133] (624s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[397.195125] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[398.285088] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.088s)
[398.408504] [080/133] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[398.506198] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[403.073422] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.570s)
[404.235730] [081/133] (617s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[404.332894] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[404.337094] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[404.405225] [082/133] (617s left) kms_atomic (crtc-invalid-params)
[404.495277] Starting subtest: crtc-invalid-params
[404.497508] Starting dynamic subtest: pipe-A-eDP-1
[404.869763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[404.871859] Subtest crtc-invalid-params: SUCCESS (0.374s)
[405.727713] [083/133] (616s left) kms_flip (busy-flip)
[405.828378] Starting subtest: busy-flip
[405.830657] Starting dynamic subtest: A-eDP1
[407.511573] Dynamic subtest A-eDP1: SUCCESS (1.685s)
[407.523228] Starting dynamic subtest: B-eDP1
[409.216344] Dynamic subtest B-eDP1: SUCCESS (1.702s)
[409.227465] Starting dynamic subtest: C-eDP1
[410.891916] Dynamic subtest C-eDP1: SUCCESS (1.674s)
[410.906306] Starting dynamic subtest: D-eDP1
[412.601047] Dynamic subtest D-eDP1: SUCCESS (1.708s)
[412.606267] Subtest busy-flip: SUCCESS (6.779s)
[413.830268] [084/133] (608s left) gem_exec_params (cliprects-invalid)
[413.910243] Starting subtest: cliprects-invalid
[413.912501] Subtest cliprects-invalid: SUCCESS (0.000s)
[414.028644] [085/133] (608s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[414.127837] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[418.870743] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.746s)
[420.045353] [086/133] (602s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[420.106231] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[420.108479] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[420.209966] [087/133] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[420.306606] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[420.310817] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[420.408925] [088/133] (601s left) syncobj_timeline (wait-zero-handles)
[420.458914] Starting subtest: wait-zero-handles
[420.461251] Subtest wait-zero-handles: SUCCESS (0.000s)
[420.554770] [089/133] (601s left) kms_psr (fbc-pr-sprite-plane-onoff)
[420.637201] Starting subtest: fbc-pr-sprite-plane-onoff
[420.641523] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[420.724438] [090/133] (601s left) gen9_exec_parse (batch-without-end)
[420.786425] Subtest batch-without-end: SKIP (0.000s)
[420.853868] [091/133] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[420.952829] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[420.957089] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[421.033371] [092/133] (601s left) syncobj_wait (wait-for-submit-snapshot)
[421.083846] Starting subtest: wait-for-submit-snapshot
[421.166659] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[421.241418] [093/133] (601s left) gem_exec_suspend (basic-s0)
[421.307043] Starting subtest: basic-S0
[421.309150] Starting dynamic subtest: smem
[441.042337] Dynamic subtest smem: SUCCESS (6.583s)
[441.045452] Subtest basic-S0: SUCCESS (6.585s)
[441.234076] [094/133] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[441.367866] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[441.372034] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[441.480846] [095/133] (581s left) perf (invalid-open-flags)
[441.605452] Starting subtest: invalid-open-flags
[441.607872] Subtest invalid-open-flags: SUCCESS (0.000s)
[441.647234] [096/133] (581s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[441.743627] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[441.748213] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[441.864647] [097/133] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[441.963916] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[441.968192] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[442.070747] [098/133] (580s left) kms_addfb_basic (unused-modifier)
[442.128732] Starting subtest: unused-modifier
[442.131472] Subtest unused-modifier: SUCCESS (0.000s)
[442.291344] [099/133] (580s left) perf (enable-disable)
[442.391175] Starting subtest: enable-disable
[442.393146] Starting dynamic subtest: 0-rcs0
[444.631254] Dynamic subtest 0-rcs0: SUCCESS (2.201s)
[444.644275] Starting dynamic subtest: 1-vcs1
[449.160049] Dynamic subtest 1-vcs1: SUCCESS (4.478s)
[449.162523] Subtest enable-disable: SUCCESS (6.680s)
[449.211463] [100/133] (573s left) gem_exec_whisper (basic-queues-forked-all)
[449.269629] Starting subtest: basic-queues-forked-all
[469.378197] Subtest basic-queues-forked-all: SUCCESS (20.043s)
[469.565640] [101/133] (553s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[469.631513] Starting subtest: y-tiled-to-vebox-yf-tiled
[469.636067] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[469.833284] [102/133] (553s left) kms_addfb_basic (bad-pitch-0)
[469.886568] Starting subtest: bad-pitch-0
[469.888952] Subtest bad-pitch-0: SUCCESS (0.000s)
[470.011864] [103/133] (552s left) gem_ctx_engines (execute-one)
[470.072607] Starting subtest: execute-one
[472.312132] Subtest execute-one: SUCCESS (2.240s)
[472.492028] [104/133] (550s left) gem_wait (invalid-buf)
[472.548297] Starting subtest: invalid-buf
[472.550595] Subtest invalid-buf: SUCCESS (0.000s)
[472.750191] [105/133] (550s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[472.847588] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[472.849850] Starting dynamic subtest: pipe-A-eDP-1
[472.943428] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[472.954641] Starting dynamic subtest: pipe-B-eDP-1
[474.068616] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[474.072997] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.226s)
[475.330853] [106/133] (547s left) kms_pm_dc (dc3co-vpb-simulation)
[476.425005] Starting subtest: dc3co-vpb-simulation
[484.904922] Subtest dc3co-vpb-simulation: SKIP (8.475s)
[485.037694] [107/133] (538s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[485.136388] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[488.654042] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.520s)
[489.851401] [108/133] (533s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[489.951784] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[489.956084] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[490.052906] [109/133] (533s left) kms_plane_scaling (invalid-parameters)
[490.155070] Starting subtest: invalid-parameters
[490.157346] Starting dynamic subtest: less-than-1-height-src
[490.168136] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[490.178630] Starting dynamic subtest: less-than-1-width-src
[490.180920] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[490.183229] Subtest invalid-parameters: SUCCESS (0.027s)
[490.286917] [110/133] (532s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[490.383085] Starting subtest: yf-tiled-8bpp-rotate-0
[490.387557] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[490.480074] [111/133] (532s left) kms_psr (psr-cursor-plane-move)
[490.584171] Starting subtest: psr-cursor-plane-move
[490.586425] Starting dynamic subtest: eDP-1
[492.310257] Dynamic subtest eDP-1: SUCCESS (1.726s)
[492.312614] Subtest psr-cursor-plane-move: SUCCESS (1.727s)
[493.129432] [112/133] (530s left) i915_suspend (basic-s3-without-i915)
[493.165242] Starting subtest: basic-s3-without-i915
[496.448550] Subtest basic-s3-without-i915: SKIP (3.276s)
[498.037584] [113/133] (525s left) gem_exec_schedule (noreorder)
[498.229997] Starting subtest: noreorder
[498.232309] Starting dynamic subtest: rcs0
[498.301899] Dynamic subtest rcs0: SUCCESS (0.075s)
[498.313036] Starting dynamic subtest: vcs0
[500.057423] Dynamic subtest vcs0: SUCCESS (1.752s)
[500.068833] Starting dynamic subtest: vcs1
[502.033321] Dynamic subtest vcs1: SUCCESS (1.972s)
[502.044211] Starting dynamic subtest: vecs0
[504.015208] Dynamic subtest vecs0: SUCCESS (1.979s)
[504.026960] Starting dynamic subtest: ccs0
[504.093260] Dynamic subtest ccs0: SUCCESS (0.076s)
[504.096125] Subtest noreorder: SUCCESS (5.864s)
[504.275649] [114/133] (519s left) gem_wait (await)
[504.347006] Starting subtest: await
[504.349084] Starting dynamic subtest: all-engines
[505.444874] Dynamic subtest all-engines: SUCCESS (1.099s)
[505.462185] Starting dynamic subtest: rcs0
[506.503963] Dynamic subtest rcs0: SUCCESS (1.056s)
[506.521992] Starting dynamic subtest: bcs0
[507.563201] Dynamic subtest bcs0: SUCCESS (1.057s)
[507.578755] Starting dynamic subtest: vcs0
[508.616386] Dynamic subtest vcs0: SUCCESS (1.050s)
[508.631828] Starting dynamic subtest: vcs1
[509.668118] Dynamic subtest vcs1: SUCCESS (1.049s)
[509.683707] Starting dynamic subtest: vecs0
[510.721477] Dynamic subtest vecs0: SUCCESS (1.051s)
[510.738639] Starting dynamic subtest: ccs0
[511.781277] Dynamic subtest ccs0: SUCCESS (1.057s)
[511.783705] Subtest await: SUCCESS (7.435s)
[511.997753] [115/133] (511s left) kms_getfb (getfb2-handle-protection)
[512.102701] Starting subtest: getfb2-handle-protection
[512.119554] Subtest getfb2-handle-protection: SUCCESS (0.018s)
[512.245685] [116/133] (511s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[512.339915] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[512.344385] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[512.438677] [117/133] (511s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[512.484890] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[512.560356] [118/133] (511s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[512.607908] Starting subtest: etime-multi-wait-for-submit-submitted
[512.709493] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[512.820695] [119/133] (510s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[512.904590] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[512.906826] Starting dynamic subtest: pipe-A-eDP-1
[512.930304] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[512.942753] Starting dynamic subtest: pipe-B-eDP-1
[512.964515] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[512.972606] Starting dynamic subtest: pipe-C-eDP-1
[512.994366] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[513.002181] Starting dynamic subtest: pipe-D-eDP-1
[513.024307] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[513.028500] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[515.169351] [120/133] (508s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[515.279020] Starting subtest: extended-pageflip-modeset-hang-oldfb
[515.280969] Starting dynamic subtest: pipe-A
[523.191685] Dynamic subtest pipe-A: SUCCESS (7.907s)
[523.202245] Starting dynamic subtest: pipe-D
[531.796551] Dynamic subtest pipe-D: SUCCESS (8.601s)
[531.798899] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.513s)
[532.651844] [121/133] (491s left) gem_exec_reloc (basic-write-read-active)
[532.709057] Subtest basic-write-read-active: SKIP (0.000s)
[532.773809] [122/133] (490s left) gem_exec_balancer (bonded-true-hang)
[533.028590] Starting subtest: bonded-true-hang
[533.033769] Subtest bonded-true-hang: SKIP (0.000s)
[533.131412] [123/133] (490s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[533.231487] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[533.233983] Starting dynamic subtest: pipe-A-eDP-1
[539.123080] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.900s)
[539.137788] Starting dynamic subtest: pipe-B-eDP-1
[545.677664] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.554s)
[545.680021] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.457s)
[546.567050] [124/133] (477s left) prime_vgem (fence-write-hang)
[546.643531] Subtest fence-write-hang: SKIP (0.000s)
[546.746875] [125/133] (477s left) kms_fb_coherency (memset-crc)
[546.829954] Starting subtest: memset-crc
[546.832225] Starting dynamic subtest: mmap-offset-wc
[547.207807] Dynamic subtest mmap-offset-wc: SUCCESS (0.378s)
[547.515185] Starting dynamic subtest: mmap-offset-uc
[553.664816] Dynamic subtest mmap-offset-uc: SUCCESS (6.158s)
[553.950501] Subtest memset-crc: SUCCESS (7.123s)
[554.809085] [126/133] (469s left) kms_vblank (wait-forked-busy-hang)
[554.917174] Starting subtest: wait-forked-busy-hang
[554.919379] Starting dynamic subtest: pipe-A-eDP-1
[581.832300] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.911s)
[581.846828] Starting dynamic subtest: pipe-D-eDP-1
[596.811041] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.972s)
[596.813326] Subtest wait-forked-busy-hang: SUCCESS (41.890s)
[597.669899] [127/133] (426s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[597.762750] Starting subtest: multiplane-rotation-cropping-bottom
[615.179689] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.415s)
[615.270953] [128/133] (408s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[615.377819] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[615.381245] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[615.478926] [129/133] (408s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[615.568328] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[615.570092] Starting dynamic subtest: pipe-A-eDP-1
[615.588049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[615.597988] Starting dynamic subtest: pipe-B-eDP-1
[615.614244] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[615.623007] Starting dynamic subtest: pipe-C-eDP-1
[615.638498] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[615.646424] Starting dynamic subtest: pipe-D-eDP-1
[615.662174] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[615.663970] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[617.751271] [130/133] (406s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[617.847054] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[617.874491] Starting dynamic subtest: pipe-A-plane-0
[618.305692] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[618.317333] Starting dynamic subtest: pipe-A-plane-3
[618.572732] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[619.640074] Starting dynamic subtest: pipe-B-plane-0
[620.088125] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[620.102887] Starting dynamic subtest: pipe-B-plane-3
[620.344345] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[620.664238] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.817s)
[621.514627] [131/133] (402s left) gem_exec_reloc (basic-cpu-gtt)
[621.569982] Subtest basic-cpu-gtt: SKIP (0.000s)
[621.644173] [132/133] (402s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[621.738031] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[628.556475] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.819s)
[628.686557] [133/133] (395s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[628.740267] Starting subtest: multi-wait-all-for-submit-submitted
[628.846218] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[628.931164] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: i915_pm_rpm
results: parsing output: 4/ for test: kms_universal_plane
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: kms_flip_event_leak
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_chamelium_edid
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: gem_ccs
results: parsing output: 13/ for test: kms_invalid_mode
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: vgem_basic
results: parsing output: 18/ for test: core_getclient
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_getfb
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: gem_pipe_control_store_loop
results: parsing output: 27/ for test: device_reset
results: parsing output: 28/ for test: kms_content_protection
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_async_flips
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: kms_plane_multiple
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: gem_media_fill
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: gem_workarounds
results: parsing output: 43/ for test: syncobj_eventfd
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_dither
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: kms_force_connector_basic
results: parsing output: 52/ for test: gem_render_copy_redux
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: gem_ctx_isolation
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: prime_busy
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_ctx_shared
results: parsing output: 64/ for test: kms_chamelium_audio
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_atomic_interruptible
results: parsing output: 74/ for test: syncobj_basic
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_exec_suspend
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: gem_ctx_engines
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_pm_dc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: i915_suspend
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: gem_wait
results: parsing output: 114/ for test: kms_getfb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_busy
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: kms_fb_coherency
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_rotation_crc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_wait
Done.