[61.874220] Initializing watchdogs
[61.874264]   /dev/watchdog0
[61.888393] [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]
[61.892756] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.894826] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.896862] [001/131] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[61.997739] Starting subtest: psr-rgb565-draw-mmap-wc
[68.706439] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.710s)
[68.844589] [002/131] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[68.950460] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[76.253429] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.304s)
[76.433834] [003/131] (946s left) i915_drm_fdinfo (virtual-busy-all)
[76.474888] Starting subtest: virtual-busy-all
[76.477027] Subtest virtual-busy-all: SKIP (0.000s)
[76.556271] [004/131] (945s left) kms_addfb_basic (bad-pitch-1024)
[76.613850] Starting subtest: bad-pitch-1024
[76.615036] Subtest bad-pitch-1024: SUCCESS (0.000s)
[76.789484] [005/131] (945s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[76.912855] Starting subtest: cursorA-vs-flipB-varying-size
[76.914521] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[77.068128] [006/131] (945s left) kms_vrr (flip-suspend)
[77.151696] Starting subtest: flip-suspend
[77.154315] Subtest flip-suspend: SKIP (0.000s)
[77.261383] [007/131] (945s left) i915_suspend (basic-s2idle-without-i915)
[77.289487] Starting subtest: basic-s2idle-without-i915
[98.057524] Subtest basic-s2idle-without-i915: SUCCESS (9.750s)
[103.188511] [008/131] (924s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[103.254395] Subtest no-spare-fences-busy: SKIP (0.000s)
[103.330170] [009/131] (924s left) gem_tiled_wc
[103.451350] [010/131] (924s left) perf_pmu (gt-awake)
[103.491860] Starting subtest: gt-awake
[111.908907] Subtest gt-awake: SUCCESS (8.411s)
[112.046216] [011/131] (915s left) gem_ctx_persistence (heartbeat-many)
[112.123618] Starting subtest: heartbeat-many
[112.125713] Subtest heartbeat-many: SKIP (0.000s)
[112.255969] [012/131] (915s left) kms_psr (fbc-psr-cursor-plane-onoff)
[112.352363] Starting subtest: fbc-psr-cursor-plane-onoff
[112.353384] Starting dynamic subtest: eDP-1
[112.355322] Dynamic subtest eDP-1: SKIP (0.000s)
[112.357332] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[112.440153] [013/131] (915s left) api_intel_bb (object-noreloc-keep-cache-simple)
[112.497182] Starting subtest: object-noreloc-keep-cache-simple
[112.502969] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[112.602270] [014/131] (915s left) kms_chamelium_frames (hdmi-crc-fast)
[112.982244] Subtest hdmi-crc-fast: SKIP (0.000s)
[113.746067] [015/131] (914s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[113.851633] Starting subtest: 4-tiled-64bpp-rotate-270
[113.871075] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[114.044590] [016/131] (913s left) kms_setmode (invalid-clone-single-crtc-stealing)
[114.100013] Starting subtest: invalid-clone-single-crtc-stealing
[114.102624] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[114.225202] [017/131] (913s left) gem_ctx_param (invalid-ctx-set)
[114.275403] Starting subtest: invalid-ctx-set
[114.277841] Subtest invalid-ctx-set: SUCCESS (0.002s)
[114.401338] [018/131] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[114.493843] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[114.495601] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[114.629259] [019/131] (913s left) kms_flip (plain-flip-fb-recreate-interruptible)
[114.723921] Starting subtest: plain-flip-fb-recreate-interruptible
[114.728184] Starting dynamic subtest: A-eDP1
[123.583159] Dynamic subtest A-eDP1: SUCCESS (8.854s)
[123.591977] Starting dynamic subtest: B-eDP1
[132.402722] Dynamic subtest B-eDP1: SUCCESS (8.818s)
[132.410825] Starting dynamic subtest: C-eDP1
[141.234715] Dynamic subtest C-eDP1: SUCCESS (8.832s)
[141.243993] Starting dynamic subtest: D-eDP1
[150.063703] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[150.065984] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.342s)
[151.258031] [020/131] (876s left) gem_busy (parallel)
[151.434223] Starting subtest: parallel
[151.435310] Starting dynamic subtest: rcs0
[152.929452] Dynamic subtest rcs0: SUCCESS (1.492s)
[152.939546] Starting dynamic subtest: bcs0
[154.913760] Dynamic subtest bcs0: SUCCESS (1.983s)
[154.923138] Starting dynamic subtest: vcs0
[156.899842] Dynamic subtest vcs0: SUCCESS (1.985s)
[156.909690] Starting dynamic subtest: vcs1
[158.944592] Dynamic subtest vcs1: SUCCESS (2.044s)
[158.953980] Starting dynamic subtest: vecs0
[160.932373] Dynamic subtest vecs0: SUCCESS (1.986s)
[160.942443] Starting dynamic subtest: ccs0
[162.914408] Dynamic subtest ccs0: SUCCESS (1.980s)
[162.915766] Subtest parallel: SUCCESS (11.479s)
[163.179512] [021/131] (864s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[163.280474] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[167.641968] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.362s)
[168.855851] [022/131] (859s left) gem_exec_schedule (preempt-queue)
[168.921551] Subtest preempt-queue: SKIP (0.000s)
[169.230012] [023/131] (858s left) kms_psr (psr-sprite-plane-move)
[169.343738] Starting subtest: psr-sprite-plane-move
[169.344813] Starting dynamic subtest: eDP-1
[171.161974] Dynamic subtest eDP-1: SUCCESS (1.817s)
[171.162865] Subtest psr-sprite-plane-move: SUCCESS (1.819s)
[172.011562] [024/131] (856s left) gem_ctx_isolation (preservation-s3)
[172.080607] Starting subtest: preservation-S3
[172.081754] Starting dynamic subtest: rcs0
[188.702391] Dynamic subtest rcs0: SUCCESS (1.752s)
[188.711851] Starting dynamic subtest: bcs0
[205.698179] Dynamic subtest bcs0: SUCCESS (1.743s)
[205.707606] Starting dynamic subtest: vcs0
[222.697413] Dynamic subtest vcs0: SUCCESS (2.806s)
[222.704690] Starting dynamic subtest: vcs1
[240.701897] Dynamic subtest vcs1: SUCCESS (3.982s)
[240.709525] Starting dynamic subtest: vecs0
[258.699440] Dynamic subtest vecs0: SUCCESS (5.054s)
[258.707563] Starting dynamic subtest: ccs0
[276.695671] Dynamic subtest ccs0: SUCCESS (3.118s)
[276.696909] Subtest preservation-S3: SUCCESS (18.457s)
[282.992581] [025/131] (751s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[283.095729] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[289.872882] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.777s)
[290.002332] [026/131] (744s left) gem_mmap_wc (write)
[290.054060] Subtest write: SKIP (0.000s)
[290.107575] [027/131] (744s left) kms_plane_scaling (planes-downscale-factor-0-5)
[290.201586] Starting subtest: planes-downscale-factor-0-5
[290.202729] Starting dynamic subtest: pipe-A
[290.218743] Dynamic subtest pipe-A: SKIP (0.015s)
[290.226178] Starting dynamic subtest: pipe-B
[290.246196] Dynamic subtest pipe-B: SKIP (0.026s)
[290.252889] Starting dynamic subtest: pipe-C
[290.273473] Dynamic subtest pipe-C: SKIP (0.026s)
[290.280282] Starting dynamic subtest: pipe-D
[290.298082] Dynamic subtest pipe-D: SKIP (0.026s)
[290.300198] Subtest planes-downscale-factor-0-5: SKIP (0.096s)
[290.420401] [028/131] (743s left) kms_invalid_mode (bad-vsync-start)
[290.513932] Starting subtest: bad-vsync-start
[290.515204] Starting dynamic subtest: pipe-A-eDP-1
[290.801457] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[290.809103] Starting dynamic subtest: pipe-B-eDP-1
[290.810278] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[290.817165] Starting dynamic subtest: pipe-C-eDP-1
[290.818366] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[290.825448] Starting dynamic subtest: pipe-D-eDP-1
[290.826776] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[290.827871] Subtest bad-vsync-start: SUCCESS (0.292s)
[291.688662] [029/131] (742s left) kms_cursor_crc (cursor-random-128x128)
[291.904876] Starting subtest: cursor-random-128x128
[291.908582] Starting dynamic subtest: pipe-A-eDP-1
[295.340176] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.432s)
[295.365972] Starting dynamic subtest: pipe-D-eDP-1
[299.412003] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.052s)
[299.413338] Subtest cursor-random-128x128: SUCCESS (7.506s)
[300.255908] [030/131] (734s left) kms_properties (get_properties-sanity-non-atomic)
[300.358118] Starting subtest: get_properties-sanity-non-atomic
[300.359545] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[300.446216] [031/131] (733s left) gem_madvise (dontneed-before-mmap)
[300.483286] Starting subtest: dontneed-before-mmap
[300.508886] Subtest dontneed-before-mmap: SUCCESS (0.027s)
[300.636803] [032/131] (733s left) gem_exec_reloc (basic-write-read-noreloc)
[300.704855] Subtest basic-write-read-noreloc: SKIP (0.000s)
[300.786244] [033/131] (733s left) kms_plane_multiple (tiling-yf)
[300.869292] Starting subtest: tiling-yf
[300.871695] Subtest tiling-yf: SKIP (0.000s)
[300.992558] [034/131] (733s left) gem_exec_reloc (basic-wc-gtt-active)
[301.060229] Subtest basic-wc-gtt-active: SKIP (0.000s)
[301.123729] [035/131] (733s left) i915_hangman (gt-error-state-capture)
[301.190792] Starting subtest: gt-error-state-capture
[301.192115] Starting dynamic subtest: rcs0
[313.037116] Dynamic subtest rcs0: SUCCESS (11.842s)
[313.048085] Starting dynamic subtest: bcs0
[324.045985] Dynamic subtest bcs0: SUCCESS (11.006s)
[324.056178] Starting dynamic subtest: vcs0
[335.055016] Dynamic subtest vcs0: SUCCESS (11.006s)
[335.065824] Starting dynamic subtest: vcs1
[347.021174] Dynamic subtest vcs1: SUCCESS (11.963s)
[347.032001] Starting dynamic subtest: vecs0
[358.989042] Dynamic subtest vecs0: SUCCESS (11.965s)
[358.999787] Starting dynamic subtest: ccs0
[369.038063] Dynamic subtest ccs0: SUCCESS (10.046s)
[369.039737] Subtest gt-error-state-capture: SUCCESS (67.842s)
[369.136927] [036/131] (665s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[369.200636] Subtest tiled-to-untiled: SKIP (0.000s)
[369.267231] [037/131] (665s left) kms_async_flips (invalid-async-flip)
[369.357710] Starting subtest: invalid-async-flip
[369.718563] Starting dynamic subtest: pipe-A-eDP-1
[370.571306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s)
[370.933559] Starting dynamic subtest: pipe-B-eDP-1
[371.713933] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[372.072703] Starting dynamic subtest: pipe-C-eDP-1
[372.824909] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.758s)
[373.177545] Starting dynamic subtest: pipe-D-eDP-1
[373.953013] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s)
[373.954258] Subtest invalid-async-flip: SUCCESS (4.595s)
[375.131605] [038/131] (659s left) syncobj_timeline (etime-single-wait-submitted)
[375.193004] Starting subtest: etime-single-wait-submitted
[375.299142] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[375.392357] [039/131] (659s left) gem_tiled_partial_pwrite_pread (writes)
[375.448381] Subtest writes: SKIP (0.000s)
[375.496366] [040/131] (659s left) gem_eio (in-flight-internal-immediate)
[375.670751] Starting subtest: in-flight-internal-immediate
[377.122968] Subtest in-flight-internal-immediate: SUCCESS (1.451s)
[377.307067] [041/131] (657s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[377.419264] Starting subtest: x-tiled-16bpp-rotate-180
[378.653924] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.235s)
[378.827611] [042/131] (655s left) kms_chamelium_color (ctm-0-25)
[378.925972] Subtest ctm-0-25: SKIP (0.000s)
[378.969648] [043/131] (655s left) kms_dp_linktrain_fallback (dsc-fallback)
[379.062001] Starting subtest: dsc-fallback
[379.065546] Subtest dsc-fallback: SKIP (0.000s)
[379.153701] [044/131] (655s left) gem_mmap (pf-nonblock)
[379.206982] Subtest pf-nonblock: SKIP (0.000s)
[379.270755] [045/131] (655s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[379.362603] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[379.363890] Starting dynamic subtest: pipe-A-eDP-1
[379.374971] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[379.382767] Starting dynamic subtest: pipe-B-eDP-1
[379.393523] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[379.401281] Starting dynamic subtest: pipe-C-eDP-1
[379.416633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[379.423842] Starting dynamic subtest: pipe-D-eDP-1
[379.433573] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[379.435530] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[381.601093] [046/131] (653s left) gem_pxp (reject-modify-context-protection-on)
[381.715822] Starting subtest: reject-modify-context-protection-on
[381.717051] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[381.857845] [047/131] (653s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[386.859761] Starting subtest: pr-overlay-plane-move-continuous-sf
[386.862635] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[387.731544] [048/131] (647s left) gem_render_copy_redux (interruptible)
[387.788709] Starting subtest: interruptible
[388.106463] Subtest interruptible: SUCCESS (0.318s)
[388.263648] [049/131] (646s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[388.355443] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[388.357224] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[388.466539] [050/131] (646s left) prime_mmap (test_aperture_limit)
[388.525862] Starting subtest: test_aperture_limit
[388.527044] Starting dynamic subtest: test_aperture_limit-smem
[388.535219] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[388.537547] Subtest test_aperture_limit: SKIP (0.009s)
[388.656648] [051/131] (646s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[388.747876] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[388.748840] Starting dynamic subtest: pipe-A-default-mode
[389.043021] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[389.044850] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.296s)
[389.864676] [052/131] (645s left) api_intel_allocator (two-level-inception-interruptible)
[389.918564] Starting subtest: two-level-inception-interruptible
[395.327910] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[395.426098] [053/131] (639s left) gem_mmap_offset (mmap-boundaries)
[395.483860] Starting subtest: mmap-boundaries
[395.485127] Starting dynamic subtest: smem0
[395.770043] Dynamic subtest smem0: SUCCESS (0.286s)
[395.771513] Subtest mmap-boundaries: SUCCESS (0.287s)
[395.932379] [054/131] (639s left) gem_readwrite (read-write)
[395.988851] Subtest read-write: SKIP (0.000s)
[396.046874] [055/131] (639s left) syncobj_wait (invalid-signal-zero-handles)
[396.097328] Starting subtest: invalid-signal-zero-handles
[396.098646] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[396.224932] [056/131] (638s left) kms_pm_backlight (brightness-with-dpms)
[396.329816] Starting subtest: brightness-with-dpms
[396.385879] Starting dynamic subtest: eDP-1
[398.789551] Dynamic subtest eDP-1: SUCCESS (2.404s)
[398.790756] Subtest brightness-with-dpms: SUCCESS (2.460s)
[399.677210] [057/131] (635s left) kms_big_fb (linear-64bpp-rotate-270)
[399.780184] Starting subtest: linear-64bpp-rotate-270
[399.801991] Subtest linear-64bpp-rotate-270: SKIP (0.021s)
[399.954986] [058/131] (635s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[400.047569] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[400.049548] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[400.161148] [059/131] (635s left) sriov_basic (bind-unbind-vf)
[400.228099] Starting subtest: bind-unbind-vf
[400.229287] Starting dynamic subtest: vf-1
[400.261827] Dynamic subtest vf-1: FAIL (0.009s)
[400.270281] Starting dynamic subtest: vf-2
[400.301095] Dynamic subtest vf-2: FAIL (0.003s)
[400.309293] Starting dynamic subtest: vf-3
[400.341086] Dynamic subtest vf-3: FAIL (0.003s)
[400.348952] Starting dynamic subtest: vf-4
[400.382575] Dynamic subtest vf-4: FAIL (0.003s)
[400.390578] Starting dynamic subtest: vf-5
[400.416275] Dynamic subtest vf-5: FAIL (0.004s)
[400.423120] Starting dynamic subtest: vf-6
[400.448709] Dynamic subtest vf-6: FAIL (0.003s)
[400.455781] Starting dynamic subtest: vf-7
[400.484896] Dynamic subtest vf-7: FAIL (0.004s)
[400.492432] Starting dynamic subtest: vf-random
[400.522561] Dynamic subtest vf-random: FAIL (0.003s)
[400.530171] Starting dynamic subtest: vf-last
[400.561669] Dynamic subtest vf-last: FAIL (0.004s)
[400.562948] Subtest bind-unbind-vf: FAIL (0.043s)
[400.593086] [060/131] (634s left) gem_lmem_swapping (verify-random-ccs)
[400.627479] Subtest verify-random-ccs: SKIP (0.000s)
[400.666979] [061/131] (634s left) gem_exec_fence (syncobj-timeline-repeat)
[401.241282] Starting subtest: syncobj-timeline-repeat
[401.469668] Subtest syncobj-timeline-repeat: SUCCESS (0.228s)
[403.131281] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[403.133730] [062/131] (632s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[403.183938] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[403.185269] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[403.317548] [063/131] (632s left) kms_psr (fbc-pr-primary-mmap-cpu)
[403.404991] Starting subtest: fbc-pr-primary-mmap-cpu
[403.407297] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[403.492615] [064/131] (631s left) kms_hdmi_inject (inject-4k)
[403.837952] Starting subtest: inject-4k
[404.153442] Subtest inject-4k: SUCCESS (0.315s)
[404.747052] [065/131] (630s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[404.838810] Starting subtest: fbcpsr-rgb565-draw-render
[411.848931] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.010s)
[412.006957] [066/131] (623s left) gem_exec_schedule (u-semaphore-codependency)
[412.070903] Starting subtest: u-semaphore-codependency
[412.086304] Subtest u-semaphore-codependency: SUCCESS (0.017s)
[412.458642] [067/131] (623s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[412.559891] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[412.562105] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[412.689499] [068/131] (622s left) sysfs_preempt_timeout (idempotent)
[412.743932] Starting subtest: idempotent
[412.745030] Starting dynamic subtest: vecs0
[412.746024] Dynamic subtest vecs0: SUCCESS (0.001s)
[412.756537] Starting dynamic subtest: ccs0
[412.758091] Dynamic subtest ccs0: SUCCESS (0.000s)
[412.767495] Starting dynamic subtest: vcs0
[412.768614] Dynamic subtest vcs0: SUCCESS (0.001s)
[412.776312] Starting dynamic subtest: bcs0
[412.777149] Dynamic subtest bcs0: SUCCESS (0.001s)
[412.784837] Starting dynamic subtest: rcs0
[412.785775] Dynamic subtest rcs0: SUCCESS (0.001s)
[412.793536] Starting dynamic subtest: vcs1
[412.794665] Dynamic subtest vcs1: SUCCESS (0.001s)
[412.796003] Subtest idempotent: SUCCESS (0.010s)
[412.893681] [069/131] (622s left) gem_spin_batch (spin-all)
[412.961706] Starting subtest: spin-all
[412.975002] Subtest spin-all: SUCCESS (0.015s)
[414.121947] [070/131] (621s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[414.219415] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[414.220316] Starting dynamic subtest: pipe-A-eDP-1
[414.224287] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[414.235589] Starting dynamic subtest: pipe-B-eDP-1
[414.240865] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[414.261090] Starting dynamic subtest: pipe-C-eDP-1
[414.266826] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[414.276151] Starting dynamic subtest: pipe-D-eDP-1
[414.280285] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[414.282015] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[416.517941] [071/131] (619s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[416.610503] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[416.611313] Starting dynamic subtest: pipe-A-eDP-1
[416.619140] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.626987] Starting dynamic subtest: pipe-B-eDP-1
[416.634957] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.643182] Starting dynamic subtest: pipe-C-eDP-1
[416.651646] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[416.659044] Starting dynamic subtest: pipe-D-eDP-1
[416.667342] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.668927] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[418.816474] [072/131] (616s left) core_getversion (basic)
[418.848751] Starting subtest: basic
[418.850950] Subtest basic: SUCCESS (0.000s)
[418.926651] [073/131] (616s left) kms_concurrent (multi-plane-atomic-lowres)
[419.020809] Starting subtest: multi-plane-atomic-lowres
[419.021891] Starting dynamic subtest: pipe-A-eDP-1
[419.529557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[419.530745] Subtest multi-plane-atomic-lowres: SUCCESS (0.510s)
[420.414091] [074/131] (615s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[420.502228] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[420.504204] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[420.627055] [075/131] (615s left) gem_wait (wait)
[420.679484] Starting subtest: wait
[420.680814] Starting dynamic subtest: all-engines
[422.063626] Dynamic subtest all-engines: SUCCESS (1.381s)
[422.074307] Starting dynamic subtest: rcs0
[423.115299] Dynamic subtest rcs0: SUCCESS (1.050s)
[423.127603] Starting dynamic subtest: bcs0
[424.168328] Dynamic subtest bcs0: SUCCESS (1.051s)
[424.180270] Starting dynamic subtest: vcs0
[425.218970] Dynamic subtest vcs0: SUCCESS (1.048s)
[425.232390] Starting dynamic subtest: vcs1
[426.269104] Dynamic subtest vcs1: SUCCESS (1.047s)
[426.280397] Starting dynamic subtest: vecs0
[427.318051] Dynamic subtest vecs0: SUCCESS (1.047s)
[427.330220] Starting dynamic subtest: ccs0
[428.368010] Dynamic subtest ccs0: SUCCESS (1.048s)
[428.369609] Subtest wait: SUCCESS (7.689s)
[428.585870] [076/131] (607s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[428.681692] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[428.684090] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[428.798988] [077/131] (607s left) syncobj_timeline (wait-all-for-submit-complex)
[428.849855] Starting subtest: wait-all-for-submit-complex
[429.066723] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[429.161048] [078/131] (606s left) gen9_exec_parse (bb-start-cmd)
[429.218619] Subtest bb-start-cmd: SKIP (0.000s)
[429.312584] [079/131] (606s left) syncobj_wait (wait-all-delayed-signal)
[429.356605] Starting subtest: wait-all-delayed-signal
[429.461030] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[429.554679] [080/131] (606s left) perf (oa-exponents)
[429.685104] Starting subtest: oa-exponents
[429.686653] Starting dynamic subtest: 0-rcs0
[431.475811] Dynamic subtest 0-rcs0: SUCCESS (1.788s)
[431.485305] Starting dynamic subtest: 1-vcs0
[433.306548] Dynamic subtest 1-vcs0: SUCCESS (1.829s)
[433.308013] Subtest oa-exponents: SUCCESS (3.619s)
[433.378261] [081/131] (602s left) gem_tiled_partial_pwrite_pread (reads)
[433.443153] Subtest reads: SKIP (0.000s)
[433.516425] [082/131] (602s left) kms_properties (get_properties-sanity-atomic)
[433.602972] Starting subtest: get_properties-sanity-atomic
[433.604212] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[433.697413] [083/131] (602s left) syncobj_wait (invalid-reset-bad-pad)
[433.749942] Starting subtest: invalid-reset-bad-pad
[433.751280] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[433.893075] [084/131] (602s left) gem_lmem_swapping (massive)
[433.934814] Subtest massive: SKIP (0.000s)
[433.971515] [085/131] (602s left) kms_pipe_crc_basic (read-crc)
[434.065298] Starting subtest: read-crc
[434.066110] Starting dynamic subtest: pipe-A-eDP-1
[434.764040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[434.778060] Starting dynamic subtest: pipe-B-eDP-1
[436.119981] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.356s)
[436.131687] Starting dynamic subtest: pipe-C-eDP-1
[437.473567] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.352s)
[437.486488] Starting dynamic subtest: pipe-D-eDP-1
[438.790185] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[438.791571] Subtest read-crc: SUCCESS (4.724s)
[439.618525] [086/131] (596s left) gem_exec_balancer (hog)
[439.707125] Starting subtest: hog
[439.710467] Subtest hog: SKIP (0.000s)
[440.035624] [087/131] (596s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[440.089225] Starting subtest: multi-wait-all-for-submit-available-submitted
[440.090741] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[440.216272] [088/131] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[440.315695] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[440.317746] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[440.468577] [089/131] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[440.552729] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[440.554617] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[440.667065] [090/131] (595s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[440.764528] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[441.743272] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.979s)
[441.909961] [091/131] (594s left) kms_flip (flip-vs-wf_vblank-interruptible)
[442.001198] Starting subtest: flip-vs-wf_vblank-interruptible
[442.003705] Starting dynamic subtest: A-eDP1
[443.917920] Dynamic subtest A-eDP1: SUCCESS (1.914s)
[443.929020] Starting dynamic subtest: B-eDP1
[445.806303] Dynamic subtest B-eDP1: SUCCESS (1.887s)
[445.816024] Starting dynamic subtest: C-eDP1
[447.698683] Dynamic subtest C-eDP1: SUCCESS (1.891s)
[447.708273] Starting dynamic subtest: D-eDP1
[449.605884] Dynamic subtest D-eDP1: SUCCESS (1.906s)
[449.609742] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.606s)
[450.807947] [092/131] (585s left) kms_prime (basic-modeset-hybrid)
[450.894005] Subtest basic-modeset-hybrid: SKIP (0.000s)
[450.995608] [093/131] (585s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[451.101395] Starting subtest: y-tiled-32bpp-rotate-90
[451.103372] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[451.230387] [094/131] (585s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[451.328231] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[455.553741] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.227s)
[456.736893] [095/131] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[456.827160] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[461.249280] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.422s)
[462.429247] [096/131] (574s left) gem_exec_endless (dispatch)
[462.500138] Starting subtest: dispatch
[462.501670] Starting dynamic subtest: rcs0
[462.504638] Dynamic subtest rcs0: SUCCESS (0.006s)
[462.514014] Starting dynamic subtest: bcs0
[462.516965] Dynamic subtest bcs0: SUCCESS (0.005s)
[462.526031] Starting dynamic subtest: vcs0
[462.529143] Dynamic subtest vcs0: SUCCESS (0.004s)
[462.538226] Starting dynamic subtest: vcs1
[462.540643] Dynamic subtest vcs1: SUCCESS (0.004s)
[462.549177] Starting dynamic subtest: vecs0
[462.551499] Dynamic subtest vecs0: SUCCESS (0.004s)
[462.559594] Starting dynamic subtest: ccs0
[462.561726] Dynamic subtest ccs0: SUCCESS (0.005s)
[462.562980] Subtest dispatch: SUCCESS (0.032s)
[464.166957] [097/131] (572s left) kms_cursor_crc (cursor-size-hints)
[464.306991] Starting subtest: cursor-size-hints
[464.308050] Starting dynamic subtest: pipe-A-eDP-1
[464.901445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[464.909985] Starting dynamic subtest: pipe-D-eDP-1
[466.134188] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[466.135615] Subtest cursor-size-hints: SUCCESS (1.829s)
[467.016429] [098/131] (569s left) gem_exec_async (concurrent-writes)
[467.086580] Starting subtest: concurrent-writes
[467.087933] Starting dynamic subtest: rcs0
[467.105059] Dynamic subtest rcs0: SUCCESS (0.018s)
[467.115553] Starting dynamic subtest: bcs0
[467.116793] Dynamic subtest bcs0: SUCCESS (0.007s)
[467.126128] Starting dynamic subtest: vcs0
[467.127667] Dynamic subtest vcs0: SUCCESS (0.006s)
[467.136257] Starting dynamic subtest: vcs1
[467.137817] Dynamic subtest vcs1: SUCCESS (0.007s)
[467.146580] Starting dynamic subtest: vecs0
[467.147946] Dynamic subtest vecs0: SUCCESS (0.007s)
[467.156324] Starting dynamic subtest: ccs0
[467.157561] Dynamic subtest ccs0: SUCCESS (0.007s)
[467.158698] Subtest concurrent-writes: SUCCESS (0.056s)
[467.406150] [099/131] (569s left) kms_psr (psr-primary-mmap-cpu)
[467.501621] Starting subtest: psr-primary-mmap-cpu
[467.502687] Starting dynamic subtest: eDP-1
[469.253624] Dynamic subtest eDP-1: SUCCESS (1.751s)
[469.254501] Subtest psr-primary-mmap-cpu: SUCCESS (1.753s)
[470.114022] [100/131] (566s left) gem_exec_flush (basic-wb-rw-default)
[470.178184] Starting subtest: basic-wb-rw-default
[475.638108] Subtest basic-wb-rw-default: SUCCESS (5.459s)
[475.868220] [101/131] (560s left) kms_psr (psr2-cursor-blt)
[475.964448] Starting subtest: psr2-cursor-blt
[475.965830] Starting dynamic subtest: eDP-1
[477.629492] Dynamic subtest eDP-1: SUCCESS (1.666s)
[477.630481] Subtest psr2-cursor-blt: SUCCESS (1.667s)
[478.518271] [102/131] (558s left) kms_atomic_transition (plane-toggle-modeset-transition)
[478.608537] Starting subtest: plane-toggle-modeset-transition
[478.609457] Starting dynamic subtest: pipe-A-eDP-1
[491.814231] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.204s)
[491.825633] Starting dynamic subtest: pipe-B-eDP-1
[504.599202] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.781s)
[504.602905] Subtest plane-toggle-modeset-transition: SUCCESS (25.991s)
[505.412213] [103/131] (531s left) gem_cs_tlb (engines)
[505.459165] Starting subtest: engines
[505.460146] Starting dynamic subtest: rcs0
[507.614846] Dynamic subtest rcs0: SUCCESS (2.152s)
[507.623109] Starting dynamic subtest: bcs0
[509.768998] Dynamic subtest bcs0: SUCCESS (2.152s)
[509.779913] Starting dynamic subtest: vcs0
[511.921535] Dynamic subtest vcs0: SUCCESS (2.154s)
[511.931032] Starting dynamic subtest: vcs1
[514.076859] Dynamic subtest vcs1: SUCCESS (2.152s)
[514.085851] Starting dynamic subtest: vecs0
[516.230274] Dynamic subtest vecs0: SUCCESS (2.153s)
[516.239070] Starting dynamic subtest: ccs0
[518.383868] Dynamic subtest ccs0: SUCCESS (2.155s)
[518.384713] Subtest engines: SUCCESS (12.923s)
[518.548584] [104/131] (518s left) kms_pm_rpm (legacy-planes)
[520.269119] Starting subtest: legacy-planes
[520.270701] Starting dynamic subtest: plane-63
[528.875041] Dynamic subtest plane-63: SUCCESS (8.607s)
[528.887975] Starting dynamic subtest: plane-93
[537.483156] Dynamic subtest plane-93: SUCCESS (8.605s)
[537.495722] Starting dynamic subtest: plane-123
[546.052151] Dynamic subtest plane-123: SUCCESS (8.566s)
[546.066052] Starting dynamic subtest: plane-133
[554.640016] Dynamic subtest plane-133: SUCCESS (8.585s)
[554.641609] Subtest legacy-planes: SUCCESS (34.375s)
[555.017462] [105/131] (481s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[555.110806] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[555.112739] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[555.229792] [106/131] (481s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[555.314080] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[559.004600] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.691s)
[560.216170] [107/131] (476s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[560.309295] Starting subtest: fbc-psr2-sprite-mmap-cpu
[560.310645] Starting dynamic subtest: eDP-1
[560.312602] Dynamic subtest eDP-1: SKIP (0.000s)
[560.314483] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.003s)
[560.412619] [108/131] (476s left) kms_flip (absolute-wf_vblank-interruptible)
[560.503562] Starting subtest: absolute-wf_vblank-interruptible
[560.507620] Starting dynamic subtest: A-eDP1
[569.208603] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[569.217514] Starting dynamic subtest: B-eDP1
[577.912799] Dynamic subtest B-eDP1: SUCCESS (8.703s)
[577.923302] Starting dynamic subtest: C-eDP1
[586.603218] Dynamic subtest C-eDP1: SUCCESS (8.688s)
[586.611466] Starting dynamic subtest: D-eDP1
[595.300809] Dynamic subtest D-eDP1: SUCCESS (8.696s)
[595.303794] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.798s)
[596.504401] [109/131] (440s left) kms_sequence (get-forked)
[596.606628] Starting subtest: get-forked
[596.607692] Starting dynamic subtest: pipe-A-eDP-1
[598.473290] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.866s)
[598.481993] Starting dynamic subtest: pipe-B-eDP-1
[601.034286] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s)
[601.042932] Starting dynamic subtest: pipe-C-eDP-1
[603.584418] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.549s)
[603.593263] Starting dynamic subtest: pipe-D-eDP-1
[606.124054] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[606.125499] Subtest get-forked: SUCCESS (9.517s)
[607.013750] [110/131] (430s left) gem_render_copy_redux (normal)
[607.070852] Starting subtest: normal
[607.389895] Subtest normal: SUCCESS (0.319s)
[607.546834] [111/131] (429s left) perf (global-sseu-config)
[607.650553] Starting subtest: global-sseu-config
[607.652889] Subtest global-sseu-config: SKIP (0.000s)
[607.686660] [112/131] (429s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[612.763785] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[612.766972] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[613.600984] [113/131] (423s left) gem_linear_blits (interruptible)
[614.059620] Starting subtest: interruptible
[619.304934] Subtest interruptible: SUCCESS (5.243s)
[619.500641] [114/131] (417s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[619.597520] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[619.600100] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[619.810294] [115/131] (417s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[619.909727] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[626.215143] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.306s)
[626.357498] [116/131] (410s left) gem_workarounds (suspend-resume-context)
[626.426755] Starting subtest: suspend-resume-context
[642.656786] Subtest suspend-resume-context: SUCCESS (1.597s)
[648.813022] [117/131] (394s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[648.914520] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[648.917355] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[649.029097] [118/131] (394s left) intel_hwmon (hwmon-write)
[649.090626] Subtest hwmon-write: SKIP (0.000s)
[649.155069] [119/131] (394s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[649.244176] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[649.245187] Starting dynamic subtest: pipe-A-default-mode
[651.937834] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s)
[651.939324] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.692s)
[652.792720] [120/131] (390s left) kms_addfb_basic (invalid-get-prop-any)
[652.845902] Starting subtest: invalid-get-prop-any
[652.847190] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[653.012193] [121/131] (390s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[653.104222] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[653.105037] Starting dynamic subtest: pipe-A-eDP-1
[653.126988] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[653.136175] Starting dynamic subtest: pipe-B-eDP-1
[653.160120] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[653.168302] Starting dynamic subtest: pipe-C-eDP-1
[653.188474] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[653.196098] Starting dynamic subtest: pipe-D-eDP-1
[653.223129] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[653.225045] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[655.381999] [122/131] (388s left) gem_exec_fence (long-history)
[655.883326] Starting subtest: long-history
[663.454071] Subtest long-history: SUCCESS (7.565s)
[663.921815] [123/131] (379s left) gem_exec_whisper (basic-contexts-priority)
[663.986510] Starting subtest: basic-contexts-priority
[687.426296] Subtest basic-contexts-priority: SUCCESS (23.430s)
[687.631350] [124/131] (356s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[687.741678] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[687.743879] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[687.880369] [125/131] (355s left) kms_lease (lease-get)
[687.971405] Starting subtest: lease-get
[687.972729] Starting dynamic subtest: pipe-A-eDP-1
[687.974123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[687.985162] Starting dynamic subtest: pipe-B-eDP-1
[687.986210] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[687.995412] Starting dynamic subtest: pipe-C-eDP-1
[687.996892] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[688.006393] Starting dynamic subtest: pipe-D-eDP-1
[688.007753] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[688.008945] Subtest lease-get: SUCCESS (0.009s)
[688.093969] [126/131] (355s left) kms_content_protection (type1)
[688.237967] Starting subtest: type1
[688.240565] Subtest type1: SKIP (0.000s)
[688.397763] [127/131] (355s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[688.461268] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[688.570097] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[688.665611] [128/131] (355s left) i915_pm_rps (engine-order)
[688.721367] Starting subtest: engine-order
[694.347576] Subtest engine-order: SUCCESS (5.624s)
[694.500776] [129/131] (349s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[694.584931] Starting subtest: fbc-dirtyfb-ioctl
[694.586254] Starting dynamic subtest: A-eDP-1
[697.223381] Dynamic subtest A-eDP-1: SUCCESS (2.637s)
[697.224448] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.639s)
[698.096701] [130/131] (345s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[698.459545] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[699.244896] [131/131] (344s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[699.297224] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[699.298535] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[699.421971] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: i915_drm_fdinfo
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_vrr
results: parsing output: 6/ for test: i915_suspend
results: parsing output: 7/ for test: gem_fenced_exec_thrash
results: parsing output: 8/ for test: gem_tiled_wc
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: gem_ctx_persistence
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: api_intel_bb
results: parsing output: 13/ for test: kms_chamelium_frames
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_setmode
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_busy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_ctx_isolation
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_mmap_wc
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: kms_invalid_mode
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_properties
results: parsing output: 30/ for test: gem_madvise
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_plane_multiple
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: i915_hangman
results: parsing output: 35/ for test: gem_set_tiling_vs_blt
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_chamelium_color
results: parsing output: 42/ for test: kms_dp_linktrain_fallback
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: gem_render_copy_redux
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: prime_mmap
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: gem_mmap_offset
results: parsing output: 53/ for test: gem_readwrite
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_pm_backlight
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: sriov_basic
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_hdmi_inject
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: sysfs_preempt_timeout
results: parsing output: 68/ for test: gem_spin_batch
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: core_getversion
results: parsing output: 72/ for test: kms_concurrent
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_wait
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gen9_exec_parse
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 81/ for test: kms_properties
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: kms_pipe_crc_basic
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_prime
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_endless
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_exec_async
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: gem_cs_tlb
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_sequence
results: parsing output: 109/ for test: gem_render_copy_redux
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_linear_blits
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_workarounds
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: intel_hwmon
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: kms_content_protection
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: i915_pm_rps
results: parsing output: 128/ for test: kms_dirtyfb
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: syncobj_timeline
Done.