[60.219475] Initializing watchdogs
[60.219518]   /dev/watchdog0
[60.234124] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[60.237958] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.239913] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.243207] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[60.346427] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[60.350351] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[60.461689] [002/133] (960s left) syncobj_wait (reset-multiple-signaled)
[60.513104] Starting subtest: reset-multiple-signaled
[60.515597] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[60.638665] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[60.726879] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[60.731200] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[60.845865] [004/133] (960s left) gem_wait (invalid-flags)
[60.906333] Starting subtest: invalid-flags
[60.908783] Subtest invalid-flags: SUCCESS (0.000s)
[61.143984] [005/133] (959s left) kms_flip (blocking-wf_vblank)
[61.221774] Starting subtest: blocking-wf_vblank
[61.224196] Starting dynamic subtest: A-eDP1
[70.180365] Dynamic subtest A-eDP1: SUCCESS (8.945s)
[70.188746] Starting dynamic subtest: B-eDP1
[79.106823] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[79.117648] Starting dynamic subtest: C-eDP1
[88.033639] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[88.040407] Starting dynamic subtest: D-eDP1
[96.972793] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[96.975440] Subtest blocking-wf_vblank: SUCCESS (35.733s)
[98.211182] [006/133] (922s left) gem_pxp (create-protected-buffer)
[98.353273] Starting subtest: create-protected-buffer
[98.355693] Subtest create-protected-buffer: SUCCESS (0.000s)
[98.464023] [007/133] (922s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[98.560094] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[98.564061] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[98.665404] [008/133] (922s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[99.038055] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[99.815812] [009/133] (921s left) syncobj_wait (wait-any-interrupted)
[99.874815] Starting subtest: wait-any-interrupted
[99.975940] Subtest wait-any-interrupted: SUCCESS (0.101s)
[100.059977] [010/133] (921s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[100.142647] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[101.176606] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.034s)
[101.405761] [011/133] (919s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[101.499879] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[101.503208] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[101.609265] [012/133] (919s left) gem_ctx_persistence (heartbeat-close)
[101.669179] Starting subtest: heartbeat-close
[101.672969] Subtest heartbeat-close: SKIP (0.000s)
[101.807155] [013/133] (919s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[101.878044] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[101.881491] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[101.987809] [014/133] (919s left) perf (whitelisted-registers-userspace-config)
[102.105871] Starting subtest: whitelisted-registers-userspace-config
[102.107528] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[102.141703] [015/133] (919s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[102.241773] Starting subtest: basic-flip-before-cursor-legacy
[103.176329] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.933s)
[103.983194] [016/133] (917s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[104.045581] Starting subtest: single-wait-for-submit-unsubmitted
[104.149619] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[104.231815] [017/133] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[104.316320] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[104.320557] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[104.429377] [018/133] (916s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[104.507909] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[108.942270] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.440s)
[110.093055] [019/133] (911s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[110.182616] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[110.208591] Starting dynamic subtest: pipe-A-plane-0
[110.213340] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[110.222685] Starting dynamic subtest: pipe-A-plane-3
[110.227336] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[110.234534] Starting dynamic subtest: pipe-A-plane-5
[110.239157] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[111.364374] Starting dynamic subtest: pipe-B-plane-0
[111.368596] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[111.375759] Starting dynamic subtest: pipe-B-plane-3
[111.380397] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[111.387454] Starting dynamic subtest: pipe-B-plane-5
[111.392193] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[111.677639] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (1.494s)
[112.553369] [020/133] (908s left) kms_flip (2x-busy-flip)
[112.643490] Starting subtest: 2x-busy-flip
[112.650431] Subtest 2x-busy-flip: SKIP (0.007s)
[112.796300] [021/133] (908s left) kms_psr (fbc-pr-sprite-plane-move)
[112.871868] Starting subtest: fbc-pr-sprite-plane-move
[112.875996] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[112.985901] [022/133] (908s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[113.073481] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[121.477792] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.407s)
[121.600104] [023/133] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[121.687040] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[121.691172] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[121.805583] [024/133] (899s left) i915_drm_fdinfo (memory-info-resident)
[121.851833] Starting subtest: memory-info-resident
[121.854227] Starting dynamic subtest: smem0
[125.208412] Dynamic subtest smem0: SUCCESS (3.357s)
[125.210434] Subtest memory-info-resident: SUCCESS (3.357s)
[125.291590] [025/133] (896s left) dmabuf_sync_file (export-wait-after-attach)
[125.369928] Starting subtest: export-wait-after-attach
[125.372265] Subtest export-wait-after-attach: SUCCESS (0.004s)
[125.435432] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[125.438394] [026/133] (896s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[125.496051] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[125.498235] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[125.600402] [027/133] (896s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[125.693242] Starting subtest: flip-vs-cursor-legacy
[132.656406] Subtest flip-vs-cursor-legacy: SUCCESS (6.960s)
[133.502505] [028/133] (888s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[133.570930] Starting subtest: yf-tiled-ccs-to-x-tiled
[133.575179] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[133.759062] [029/133] (888s left) kms_lease (lease-again)
[133.837683] Starting subtest: lease-again
[133.839924] Starting dynamic subtest: pipe-A-eDP-1
[133.842112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[133.849686] Starting dynamic subtest: pipe-B-eDP-1
[133.851819] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[133.858675] Starting dynamic subtest: pipe-C-eDP-1
[133.860782] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[133.867402] Starting dynamic subtest: pipe-D-eDP-1
[133.869585] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[133.871686] Subtest lease-again: SUCCESS (0.011s)
[133.958823] [030/133] (887s left) kms_chamelium_audio (dp-audio)
[134.348568] Subtest dp-audio: SKIP (0.000s)
[135.112506] [031/133] (886s left) prime_vgem (basic-read)
[135.202708] Starting subtest: basic-read
[135.207409] Subtest basic-read: SKIP (0.005s)
[135.302310] [032/133] (886s left) perf (create-destroy-userspace-config)
[135.401446] Starting subtest: create-destroy-userspace-config
[135.424990] Subtest create-destroy-userspace-config: SUCCESS (0.022s)
[135.467870] [033/133] (886s left) kms_sequence (get-busy)
[135.543382] Starting subtest: get-busy
[135.545629] Starting dynamic subtest: pipe-A-eDP-1
[137.479553] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[137.488950] Starting dynamic subtest: pipe-B-eDP-1
[140.031699] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.550s)
[140.041570] Starting dynamic subtest: pipe-C-eDP-1
[142.643669] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[142.653504] Starting dynamic subtest: pipe-D-eDP-1
[145.179169] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[145.181056] Subtest get-busy: SUCCESS (9.635s)
[145.986850] [034/133] (875s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[146.067906] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[146.070162] Starting dynamic subtest: pipe-A-eDP-1
[146.092015] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.101635] Starting dynamic subtest: pipe-B-eDP-1
[146.122087] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.129543] Starting dynamic subtest: pipe-C-eDP-1
[146.150644] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[146.158274] Starting dynamic subtest: pipe-D-eDP-1
[146.180489] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[146.184636] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[148.273564] [035/133] (873s left) gem_exec_reloc (basic-gtt-wc)
[148.335415] Subtest basic-gtt-wc: SKIP (0.000s)
[148.398531] [036/133] (873s left) i915_pm_rps (thresholds-idle-park)
[148.466852] Starting subtest: thresholds-idle-park
[148.471512] Subtest thresholds-idle-park: SKIP (0.001s)
[148.589397] [037/133] (873s left) perf (non-sampling-read-error)
[148.686716] Starting subtest: non-sampling-read-error
[148.696469] Subtest non-sampling-read-error: SUCCESS (0.008s)
[148.736523] [038/133] (873s left) perf (low-oa-exponent-permissions)
[148.837392] Starting subtest: low-oa-exponent-permissions
[148.874420] Subtest low-oa-exponent-permissions: SUCCESS (0.037s)
[148.917128] [039/133] (873s left) kms_atomic (plane-cursor-legacy)
[148.997939] Starting subtest: plane-cursor-legacy
[149.000294] Starting dynamic subtest: pipe-A-eDP-1
[149.375106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[149.377480] Subtest plane-cursor-legacy: SUCCESS (0.379s)
[150.202226] [040/133] (871s left) kms_frontbuffer_tracking (psr-slowdraw)
[150.301313] Starting subtest: psr-slowdraw
[175.436500] Subtest psr-slowdraw: SUCCESS (25.136s)
[175.587241] [041/133] (846s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[175.672814] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[176.274983] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[176.479816] [042/133] (845s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[176.562921] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[176.565113] Starting dynamic subtest: pipe-A-eDP-1
[176.649579] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[176.657486] Starting dynamic subtest: pipe-B-eDP-1
[177.812148] Dynamic subtest pipe-B-eDP-1: SKIP (1.163s)
[177.816814] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.253s)
[179.026281] [043/133] (843s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[179.104721] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[179.106892] Starting dynamic subtest: pipe-A-eDP-1
[179.177974] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[179.190130] Starting dynamic subtest: pipe-B-eDP-1
[180.289670] Dynamic subtest pipe-B-eDP-1: SKIP (1.109s)
[180.293972] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.188s)
[181.492702] [044/133] (840s left) kms_pm_rpm (modeset-non-lpsp)
[183.087327] Starting subtest: modeset-non-lpsp
[184.232872] Subtest modeset-non-lpsp: SKIP (1.142s)
[184.621633] [045/133] (837s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[184.698220] Starting subtest: plane-all-modeset-transition-fencing
[184.702579] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[184.781900] [046/133] (837s left) i915_drm_fdinfo (virtual-busy-idle-all)
[184.819078] Starting subtest: virtual-busy-idle-all
[184.823059] Subtest virtual-busy-idle-all: SKIP (0.000s)
[184.888976] [047/133] (837s left) kms_addfb_basic (legacy-format)
[184.950341] Starting subtest: legacy-format
[184.974635] Subtest legacy-format: SUCCESS (0.021s)
[185.108369] [048/133] (837s left) gem_exec_schedule (implicit-read-write)
[185.187072] Starting subtest: implicit-read-write
[185.188945] Starting dynamic subtest: rcs0
[185.291675] Dynamic subtest rcs0: SUCCESS (0.113s)
[185.299317] Starting dynamic subtest: vcs0
[185.380168] Dynamic subtest vcs0: SUCCESS (0.087s)
[185.391878] Starting dynamic subtest: vcs1
[185.459793] Dynamic subtest vcs1: SUCCESS (0.079s)
[185.468858] Starting dynamic subtest: vecs0
[185.538770] Dynamic subtest vecs0: SUCCESS (0.078s)
[185.547853] Starting dynamic subtest: ccs0
[185.657484] Dynamic subtest ccs0: SUCCESS (0.117s)
[185.659560] Subtest implicit-read-write: SUCCESS (0.480s)
[186.972951] [049/133] (835s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[187.059686] Starting subtest: plane-upscale-factor-0-25-with-rotation
[187.062082] Starting dynamic subtest: pipe-A
[187.285317] Dynamic subtest pipe-A: SUCCESS (0.227s)
[187.293585] Starting dynamic subtest: pipe-B
[188.576384] Dynamic subtest pipe-B: SUCCESS (1.290s)
[188.585384] Starting dynamic subtest: pipe-C
[189.913561] Dynamic subtest pipe-C: SUCCESS (1.336s)
[189.922325] Starting dynamic subtest: pipe-D
[191.244189] Dynamic subtest pipe-D: SUCCESS (1.330s)
[191.246531] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.186s)
[192.435113] [050/133] (830s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[192.522067] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[196.857585] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.339s)
[198.044457] [051/133] (824s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[198.126085] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[198.130608] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[198.231773] [052/133] (824s left) sysfs_timeslice_duration (invalid)
[198.298750] Starting subtest: invalid
[198.301090] Starting dynamic subtest: vecs0
[198.303367] Dynamic subtest vecs0: SUCCESS (0.000s)
[198.311504] Starting dynamic subtest: ccs0
[198.313577] Dynamic subtest ccs0: SUCCESS (0.000s)
[198.321247] Starting dynamic subtest: vcs0
[198.323662] Dynamic subtest vcs0: SUCCESS (0.000s)
[198.330662] Starting dynamic subtest: bcs0
[198.332932] Dynamic subtest bcs0: SUCCESS (0.001s)
[198.340202] Starting dynamic subtest: rcs0
[198.342391] Dynamic subtest rcs0: SUCCESS (0.000s)
[198.349629] Starting dynamic subtest: vcs1
[198.351890] Dynamic subtest vcs1: SUCCESS (0.000s)
[198.354129] Subtest invalid: SUCCESS (0.008s)
[198.402891] [053/133] (824s left) perf (stress-open-close)
[198.501567] Starting subtest: stress-open-close
[198.503978] Starting dynamic subtest: 0-rcs0
[200.666457] Dynamic subtest 0-rcs0: SUCCESS (2.165s)
[200.674831] Starting dynamic subtest: 1-vcs1
[202.830223] Dynamic subtest 1-vcs1: SUCCESS (2.163s)
[202.832066] Subtest stress-open-close: SUCCESS (4.329s)
[202.870416] [054/133] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[202.969124] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[225.289359] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.322s)
[225.437397] [055/133] (797s left) gem_eio (in-flight-10ms)
[225.655109] Starting subtest: in-flight-10ms
[233.957690] Subtest in-flight-10ms: SUCCESS (8.301s)
[234.120585] [056/133] (788s left) gem_ctx_engines (none)
[234.178701] Starting subtest: none
[234.181065] Subtest none: SUCCESS (0.001s)
[234.380289] [057/133] (788s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[234.463634] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[234.467722] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[234.593990] [058/133] (788s left) gem_eio (create)
[234.814242] Starting subtest: create
[235.148961] Subtest create: SUCCESS (0.334s)
[235.323779] [059/133] (787s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[235.848806] Starting subtest: syncobj-timeline-invalid-flags
[235.851644] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[236.900057] [060/133] (786s left) gem_exec_fence (syncobj-timeline-unused-fence)
[237.432263] Starting subtest: syncobj-timeline-unused-fence
[237.438310] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[238.985501] [061/133] (784s left) syncobj_timeline (wait-any-interrupted)
[239.044042] Starting subtest: wait-any-interrupted
[239.144329] Subtest wait-any-interrupted: SUCCESS (0.101s)
[239.236335] [062/133] (783s left) syncobj_timeline (invalid-query-bad-pad)
[239.301612] Starting subtest: invalid-query-bad-pad
[239.303983] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[239.421898] [063/133] (783s left) gem_partial_pwrite_pread (reads-uncached)
[239.480310] Subtest reads-uncached: SKIP (0.000s)
[239.564665] [064/133] (783s left) kms_cursor_crc (cursor-onscreen-128x42)
[239.790730] Starting subtest: cursor-onscreen-128x42
[239.834958] Subtest cursor-onscreen-128x42: SKIP (0.039s)
[240.077021] [065/133] (783s left) kms_fbcon_fbt (fbc-suspend)
[240.141069] Starting subtest: fbc-suspend
[289.106531] Subtest fbc-suspend: SUCCESS (19.181s)
[290.416000] [066/133] (732s left) kms_plane_alpha_blend (alpha-7efc)
[290.513917] Starting subtest: alpha-7efc
[290.801313] Starting dynamic subtest: pipe-A-eDP-1
[291.396013] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[291.420714] Starting dynamic subtest: pipe-D-eDP-1
[292.762396] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[292.764714] Subtest alpha-7efc: SUCCESS (2.230s)
[293.630239] [067/133] (729s left) gem_exec_whisper (basic-normal-all)
[293.695409] Starting subtest: basic-normal-all
[295.825969] Subtest basic-normal-all: SUCCESS (2.120s)
[296.025369] [068/133] (727s left) gem_spin_batch (spin-all)
[296.093850] Starting subtest: spin-all
[296.118918] Subtest spin-all: SUCCESS (0.024s)
[297.509797] [069/133] (725s left) kms_pwrite_crc
[299.085104] [070/133] (724s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[299.168016] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[299.170273] Starting dynamic subtest: pipe-A-eDP-1
[299.193043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[299.203693] Starting dynamic subtest: pipe-B-eDP-1
[299.225186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.234937] Starting dynamic subtest: pipe-C-eDP-1
[299.257268] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[299.267701] Starting dynamic subtest: pipe-D-eDP-1
[299.289531] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[299.293585] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[301.360743] [071/133] (722s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[301.448563] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[301.452767] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[301.531925] [072/133] (721s left) api_intel_bb (render)
[301.603046] Starting subtest: render
[301.605314] Starting dynamic subtest: render-none-512
[301.700075] Dynamic subtest render-none-512: SUCCESS (0.097s)
[301.711911] Starting dynamic subtest: render-none-1024
[302.062390] Dynamic subtest render-none-1024: SUCCESS (0.359s)
[302.074575] Starting dynamic subtest: render-x-512
[302.144898] Dynamic subtest render-x-512: SUCCESS (0.083s)
[302.156911] Starting dynamic subtest: render-x-1024
[302.471615] Dynamic subtest render-x-1024: SUCCESS (0.324s)
[302.486574] Starting dynamic subtest: render-y-512
[302.571834] Dynamic subtest render-y-512: SUCCESS (0.100s)
[302.582655] Starting dynamic subtest: render-y-1024
[302.941239] Dynamic subtest render-y-1024: SUCCESS (0.366s)
[302.943792] Subtest render: SUCCESS (1.336s)
[303.108439] [073/133] (720s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[303.190422] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[303.194404] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[303.310438] [074/133] (720s left) gem_render_copy (y-tiled-to-vebox-linear)
[303.374999] Starting subtest: y-tiled-to-vebox-linear
[303.379550] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[303.572700] [075/133] (720s left) syncobj_timeline (etime-single-wait-submitted)
[303.630611] Starting subtest: etime-single-wait-submitted
[303.733314] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[303.820463] [076/133] (719s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[303.900362] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[307.853952] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.950s)
[309.058007] [077/133] (714s left) syncobj_wait (reset-during-wait-for-submit)
[309.126651] Starting subtest: reset-during-wait-for-submit
[309.228230] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[309.321190] [078/133] (714s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[309.402497] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[309.404742] Starting dynamic subtest: pipe-A-eDP-1
[309.413664] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.424381] Starting dynamic subtest: pipe-B-eDP-1
[309.433161] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.442057] Starting dynamic subtest: pipe-C-eDP-1
[309.450195] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.458994] Starting dynamic subtest: pipe-D-eDP-1
[309.467440] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.471665] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[311.639240] [079/133] (712s left) syncobj_timeline (32bits-limit)
[311.695731] Starting subtest: 32bits-limit
[311.698051] Subtest 32bits-limit: SUCCESS (0.001s)
[311.829353] [080/133] (712s left) gem_exec_fence (basic-await)
[312.008782] Starting subtest: basic-await
[312.011344] Starting dynamic subtest: rcs0
[312.085363] Dynamic subtest rcs0: SUCCESS (0.080s)
[312.098262] Starting dynamic subtest: bcs0
[312.173857] Dynamic subtest bcs0: SUCCESS (0.085s)
[312.185792] Starting dynamic subtest: vcs0
[312.248864] Dynamic subtest vcs0: SUCCESS (0.073s)
[312.259278] Starting dynamic subtest: vcs1
[312.323315] Dynamic subtest vcs1: SUCCESS (0.073s)
[312.333695] Starting dynamic subtest: vecs0
[312.397283] Dynamic subtest vecs0: SUCCESS (0.072s)
[312.408372] Starting dynamic subtest: ccs0
[312.478020] Dynamic subtest ccs0: SUCCESS (0.078s)
[312.480777] Subtest basic-await: SUCCESS (0.474s)
[314.490031] [081/133] (709s left) gem_mmap_offset (perf)
[314.544111] Starting subtest: perf
[314.546393] Starting dynamic subtest: smem0
[314.905735] Dynamic subtest smem0: SUCCESS (0.360s)
[314.908375] Subtest perf: SUCCESS (0.361s)
[315.037915] [082/133] (708s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[315.118830] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[321.781457] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.662s)
[321.922790] [083/133] (702s left) gen9_exec_parse (basic-rejected)
[321.998096] Subtest basic-rejected: SKIP (0.000s)
[322.085786] [084/133] (701s left) kms_cursor_crc (cursor-sliding-64x21)
[322.265349] Starting subtest: cursor-sliding-64x21
[322.307836] Subtest cursor-sliding-64x21: SKIP (0.038s)
[322.549359] [085/133] (701s left) kms_content_protection (atomic-hdcp14)
[322.681254] Starting subtest: atomic-hdcp14
[322.685804] Subtest atomic-hdcp14: SKIP (0.000s)
[322.834579] [086/133] (701s left) vgem_basic (dmabuf-mmap)
[322.881053] Starting subtest: dmabuf-mmap
[322.888894] Subtest dmabuf-mmap: SUCCESS (0.009s)
[322.973384] [087/133] (701s left) kms_invalid_mode (zero-hdisplay)
[323.044019] Starting subtest: zero-hdisplay
[323.045868] Starting dynamic subtest: pipe-A-eDP-1
[323.330351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[323.340456] Starting dynamic subtest: pipe-B-eDP-1
[323.342648] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[323.351563] Starting dynamic subtest: pipe-C-eDP-1
[323.353445] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[323.361865] Starting dynamic subtest: pipe-D-eDP-1
[323.363757] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[323.365650] Subtest zero-hdisplay: SUCCESS (0.291s)
[324.181388] [088/133] (699s left) kms_pm_rpm (basic-rte)
[324.221075] Starting subtest: basic-rte
[327.142470] Subtest basic-rte: SUCCESS (2.920s)
[328.606091] [089/133] (695s left) gem_exec_whisper (basic-queues-all)
[328.667826] Starting subtest: basic-queues-all
[338.558841] Subtest basic-queues-all: SUCCESS (9.885s)
[338.768257] [090/133] (685s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[338.875905] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[345.707073] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.832s)
[345.890593] [091/133] (678s left) gem_busy (parallel)
[346.083659] Starting subtest: parallel
[346.086200] Starting dynamic subtest: rcs0
[347.442562] Dynamic subtest rcs0: SUCCESS (1.357s)
[347.454896] Starting dynamic subtest: bcs0
[349.431110] Dynamic subtest bcs0: SUCCESS (1.980s)
[349.444608] Starting dynamic subtest: vcs0
[351.473855] Dynamic subtest vcs0: SUCCESS (2.045s)
[351.487357] Starting dynamic subtest: vcs1
[353.458406] Dynamic subtest vcs1: SUCCESS (1.981s)
[353.471780] Starting dynamic subtest: vecs0
[355.442051] Dynamic subtest vecs0: SUCCESS (1.980s)
[355.455371] Starting dynamic subtest: ccs0
[357.426367] Dynamic subtest ccs0: SUCCESS (1.981s)
[357.429329] Subtest parallel: SUCCESS (11.339s)
[357.694366] [092/133] (666s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[357.749150] Starting subtest: invalid-bsd2-flag-on-vebox
[357.751449] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[357.871259] [093/133] (666s left) kms_psr (fbc-pr-cursor-render)
[357.955867] Starting subtest: fbc-pr-cursor-render
[357.959942] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[358.037649] [094/133] (666s left) kms_psr (pr-sprite-mmap-cpu)
[358.110834] Starting subtest: pr-sprite-mmap-cpu
[358.115212] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[358.191535] [095/133] (666s left) perf_pmu (init-sema)
[358.232307] Starting subtest: init-sema
[358.234447] Starting dynamic subtest: rcs0
[358.236690] Dynamic subtest rcs0: SUCCESS (0.003s)
[358.247197] Starting dynamic subtest: bcs0
[358.248964] Dynamic subtest bcs0: SUCCESS (0.000s)
[358.257806] Starting dynamic subtest: vcs0
[358.259593] Dynamic subtest vcs0: SUCCESS (0.001s)
[358.268317] Starting dynamic subtest: vcs1
[358.270164] Dynamic subtest vcs1: SUCCESS (0.001s)
[358.278713] Starting dynamic subtest: vecs0
[358.280605] Dynamic subtest vecs0: SUCCESS (0.000s)
[358.289327] Starting dynamic subtest: ccs0
[358.291206] Dynamic subtest ccs0: SUCCESS (0.000s)
[358.293023] Subtest init-sema: SUCCESS (0.008s)
[358.370106] [096/133] (666s left) gem_exec_flush (basic-uc-ro-default)
[358.441784] Starting subtest: basic-uc-ro-default
[363.902947] Subtest basic-uc-ro-default: SUCCESS (5.462s)
[364.101496] [097/133] (660s left) kms_flip (flip-vs-expired-vblank-interruptible)
[364.178170] Starting subtest: flip-vs-expired-vblank-interruptible
[364.180504] Starting dynamic subtest: A-eDP1
[372.828270] Dynamic subtest A-eDP1: SUCCESS (8.644s)
[372.853478] Starting dynamic subtest: B-eDP1
[381.468308] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[381.484908] Starting dynamic subtest: C-eDP1
[390.099747] Dynamic subtest C-eDP1: SUCCESS (8.631s)
[390.114361] Starting dynamic subtest: D-eDP1
[398.720782] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[398.723078] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.542s)
[399.886354] [098/133] (624s left) i915_pm_rpm (debugfs-read)
[401.581333] Starting subtest: debugfs-read
[402.728318] Subtest debugfs-read: SUCCESS (1.146s)
[403.106112] [099/133] (621s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[403.185813] Starting subtest: plane-lut1d-pre-ctm3x4
[403.202698] Starting dynamic subtest: pipe-A-eDP-1
[403.918880] Dynamic subtest pipe-A-eDP-1: FAIL (0.339s)
[404.582854] Starting dynamic subtest: pipe-B-eDP-1
[405.376353] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[405.907836] Starting dynamic subtest: pipe-C-eDP-1
[406.740117] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[407.247873] Starting dynamic subtest: pipe-D-eDP-1
[408.066234] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[408.068507] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.591s)
[408.650709] [100/133] (615s left) gem_exec_params (invalid-ring2)
[408.706125] Starting subtest: invalid-ring2
[408.708305] Subtest invalid-ring2: SUCCESS (0.000s)
[408.827131] [101/133] (615s left) gem_mmap_gtt (close-race)
[408.882590] Subtest close-race: SKIP (0.000s)
[408.937397] [102/133] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[409.020634] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[409.024798] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[409.137797] [103/133] (615s left) prime_mmap (test_forked)
[409.195952] Starting subtest: test_forked
[409.197831] Starting dynamic subtest: test_forked-smem
[409.247625] Dynamic subtest test_forked-smem: SUCCESS (0.053s)
[409.249797] Subtest test_forked: SUCCESS (0.055s)
[409.381327] [104/133] (615s left) kms_cursor_crc (cursor-random-256x85)
[409.608537] Starting subtest: cursor-random-256x85
[409.654432] Subtest cursor-random-256x85: SKIP (0.041s)
[409.862880] [105/133] (614s left) kms_draw_crc (draw-method-mmap-gtt)
[409.950083] Starting subtest: draw-method-mmap-gtt
[409.953663] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[410.091696] [106/133] (614s left) gem_ctx_create (basic-files)
[410.163492] Starting subtest: basic-files
[412.169898] Subtest basic-files: SUCCESS (2.008s)
[413.573407] [107/133] (611s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[413.667548] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[413.669736] Starting dynamic subtest: pipe-A
[414.005963] Dynamic subtest pipe-A: SUCCESS (0.339s)
[414.021747] Starting dynamic subtest: pipe-B
[415.421852] Dynamic subtest pipe-B: SUCCESS (1.416s)
[415.432212] Starting dynamic subtest: pipe-C
[416.850517] Dynamic subtest pipe-C: SUCCESS (1.427s)
[416.861466] Starting dynamic subtest: pipe-D
[418.279938] Dynamic subtest pipe-D: SUCCESS (1.428s)
[418.282155] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.614s)
[419.459421] [108/133] (605s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[419.545016] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[419.547366] Starting dynamic subtest: pipe-A-eDP-1
[419.570848] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[419.580789] Starting dynamic subtest: pipe-B-eDP-1
[419.602717] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[419.612042] Starting dynamic subtest: pipe-C-eDP-1
[419.633966] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[419.643259] Starting dynamic subtest: pipe-D-eDP-1
[419.665290] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[419.669269] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[421.731956] [109/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[421.816379] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[421.820443] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[421.963013] [110/133] (603s left) gem_ctx_param (invalid-get-engines)
[422.018849] Starting subtest: invalid-get-engines
[422.021231] Subtest invalid-get-engines: SUCCESS (0.001s)
[422.141889] [111/133] (602s left) gem_exec_schedule (u-fairslice-all)
[422.202688] Starting subtest: u-fairslice-all
[424.254048] Subtest u-fairslice-all: SUCCESS (2.061s)
[425.515520] [112/133] (599s left) api_intel_bb (blit-reloc-purge-cache)
[425.595678] Starting subtest: blit-reloc-purge-cache
[425.600102] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[425.748532] [113/133] (599s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[425.840533] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[426.597898] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.759s)
[426.803807] [114/133] (598s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[427.176539] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[427.933071] [115/133] (597s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[428.026551] Starting subtest: fbcpsr-stridechange
[434.268213] Subtest fbcpsr-stridechange: SUCCESS (6.250s)
[434.427376] [116/133] (590s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[434.498208] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[434.524452] Starting dynamic subtest: pipe-A-plane-0
[434.528957] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[434.539882] Starting dynamic subtest: pipe-A-plane-3
[434.544360] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[434.555740] Starting dynamic subtest: pipe-A-plane-5
[434.560299] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[435.668845] Starting dynamic subtest: pipe-B-plane-0
[435.673563] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[435.684675] Starting dynamic subtest: pipe-B-plane-3
[435.689245] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[435.700659] Starting dynamic subtest: pipe-B-plane-5
[435.704462] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[435.981557] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (1.481s)
[436.846412] [117/133] (588s left) gem_exec_balancer (nop)
[436.910550] Starting subtest: nop
[483.633717] Subtest nop: SUCCESS (46.711s)
[484.010147] [118/133] (541s left) gem_mmap_gtt (big-bo-tiledy)
[484.078969] Subtest big-bo-tiledY: SKIP (0.000s)
[484.135435] [119/133] (541s left) gem_pread (uncached)
[484.196197] Subtest uncached: SKIP (0.000s)
[484.266646] [120/133] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[484.352740] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[484.356912] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[484.472759] [121/133] (541s left) kms_dp_link_training (non-uhbr-sst)
[484.554791] Starting subtest: non-uhbr-sst
[484.563336] Subtest non-uhbr-sst: SKIP (0.000s)
[484.639148] [122/133] (540s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[484.718606] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[491.449466] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.733s)
[491.584978] [123/133] (534s left) gem_mmap_gtt (basic-read)
[491.649528] Subtest basic-read: SKIP (0.000s)
[491.717829] [124/133] (533s left) syncobj_wait (multi-wait-all-submitted-signaled)
[491.775560] Starting subtest: multi-wait-all-submitted-signaled
[491.876468] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[491.964018] [125/133] (533s left) kms_psr (fbc-psr2-suspend)
[492.045754] Starting subtest: fbc-psr2-suspend
[492.048087] Starting dynamic subtest: eDP-1
[492.052442] Dynamic subtest eDP-1: SKIP (0.000s)
[492.056795] Subtest fbc-psr2-suspend: SKIP (0.001s)
[492.156651] [126/133] (533s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[492.236503] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[492.240560] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[492.359067] [127/133] (533s left) gem_mmap_gtt (basic-small-copy-odd)
[492.416814] Subtest basic-small-copy-odd: SKIP (0.000s)
[492.480076] [128/133] (533s left) perf_pmu (busy)
[492.517035] Starting subtest: busy
[492.518757] Starting dynamic subtest: rcs0
[493.137310] Dynamic subtest rcs0: SUCCESS (0.621s)
[493.150659] Starting dynamic subtest: bcs0
[493.707847] Dynamic subtest bcs0: SUCCESS (0.569s)
[493.719279] Starting dynamic subtest: vcs0
[495.474134] Dynamic subtest vcs0: SUCCESS (1.762s)
[495.487154] Starting dynamic subtest: vcs1
[497.457409] Dynamic subtest vcs1: SUCCESS (1.980s)
[497.470720] Starting dynamic subtest: vecs0
[499.441448] Dynamic subtest vecs0: SUCCESS (1.981s)
[499.454425] Starting dynamic subtest: ccs0
[500.017315] Dynamic subtest ccs0: SUCCESS (0.575s)
[500.019722] Subtest busy: SUCCESS (7.501s)
[500.162402] [129/133] (525s left) kms_psr (psr2-primary-mmap-cpu)
[500.248837] Starting subtest: psr2-primary-mmap-cpu
[500.251244] Starting dynamic subtest: eDP-1
[501.935295] Dynamic subtest eDP-1: SUCCESS (1.685s)
[501.937572] Subtest psr2-primary-mmap-cpu: SUCCESS (1.687s)
[502.818795] [130/133] (523s left) kms_vblank (wait-idle-hang)
[502.893784] Starting subtest: wait-idle-hang
[502.896092] Starting dynamic subtest: pipe-A-eDP-1
[529.280837] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.389s)
[529.295978] Starting dynamic subtest: pipe-D-eDP-1
[554.239646] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.958s)
[554.241904] Subtest wait-idle-hang: SUCCESS (51.352s)
[555.068116] [131/133] (470s left) kms_scaling_modes (scaling-mode-full)
[555.166323] Starting subtest: scaling-mode-full
[555.168719] Starting dynamic subtest: pipe-A-eDP-1
[555.260625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[555.270516] Starting dynamic subtest: pipe-B-eDP-1
[556.483510] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s)
[556.494497] Starting dynamic subtest: pipe-C-eDP-1
[557.591138] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[557.603929] Starting dynamic subtest: pipe-D-eDP-1
[558.716352] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[558.718705] Subtest scaling-mode-full: SUCCESS (3.552s)
[559.893488] [132/133] (466s left) gem_wait (write-busy)
[559.969507] Starting subtest: write-busy
[559.971901] Starting dynamic subtest: all-engines
[560.563279] Dynamic subtest all-engines: SUCCESS (0.593s)
[560.582426] Starting dynamic subtest: rcs0
[561.117953] Dynamic subtest rcs0: SUCCESS (0.553s)
[561.135681] Starting dynamic subtest: bcs0
[561.667902] Dynamic subtest bcs0: SUCCESS (0.549s)
[561.684765] Starting dynamic subtest: vcs0
[563.441845] Dynamic subtest vcs0: SUCCESS (1.771s)
[563.459674] Starting dynamic subtest: vcs1
[565.425324] Dynamic subtest vcs1: SUCCESS (1.981s)
[565.442192] Starting dynamic subtest: vecs0
[567.473404] Dynamic subtest vecs0: SUCCESS (2.046s)
[567.490019] Starting dynamic subtest: ccs0
[568.024753] Dynamic subtest ccs0: SUCCESS (0.551s)
[568.027216] Subtest write-busy: SUCCESS (8.056s)
[568.238424] [133/133] (457s left) gem_exec_flush (basic-wb-rw-before-default)
[568.305615] Starting subtest: basic-wb-rw-before-default
[573.800949] Subtest basic-wb-rw-before-default: SUCCESS (5.495s)
[573.994781] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: gem_pxp
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_chamelium_edid
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: dmabuf_sync_file
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: kms_chamelium_audio
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_sequence
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: i915_pm_rps
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_atomic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: kms_atomic_transition
results: parsing output: 45/ for test: i915_drm_fdinfo
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: sysfs_timeslice_duration
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: gem_ctx_engines
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_partial_pwrite_pread
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_fbcon_fbt
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: gem_exec_whisper
results: parsing output: 67/ for test: gem_spin_batch
results: parsing output: 68/ for test: kms_pwrite_crc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gen9_exec_parse
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: vgem_basic
results: parsing output: 86/ for test: kms_invalid_mode
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_busy
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: i915_pm_rpm
results: parsing output: 98/ for test: kms_color_pipeline
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: prime_mmap
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_draw_crc
results: parsing output: 105/ for test: gem_ctx_create
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ctx_param
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_pread
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_dp_link_training
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: kms_scaling_modes
results: parsing output: 131/ for test: gem_wait
results: parsing output: 132/ for test: gem_exec_flush
Done.