[60.051784] Initializing watchdogs
[60.051832]   /dev/watchdog0
[60.065547] [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]
[60.069863] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.072145] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.075456] [001/131] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[60.195504] Starting subtest: psr-rgb565-draw-mmap-wc
[67.190863] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.998s)
[67.505786] [002/131] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[67.670056] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[75.058937] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.393s)
[75.251537] [003/131] (945s left) i915_drm_fdinfo (virtual-busy-all)
[75.302231] Starting subtest: virtual-busy-all
[75.306741] Subtest virtual-busy-all: SKIP (0.000s)
[75.396577] [004/131] (945s left) kms_addfb_basic (bad-pitch-1024)
[75.457859] Starting subtest: bad-pitch-1024
[75.459842] Subtest bad-pitch-1024: SUCCESS (0.000s)
[75.611891] [005/131] (945s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[75.729939] Starting subtest: cursorA-vs-flipB-varying-size
[75.734590] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[75.894818] [006/131] (944s left) kms_vrr (flip-suspend)
[75.997770] Starting subtest: flip-suspend
[76.002812] Subtest flip-suspend: SKIP (0.000s)
[76.092938] [007/131] (944s left) i915_suspend (basic-s2idle-without-i915)
[76.127105] Starting subtest: basic-s2idle-without-i915
[95.816094] Subtest basic-s2idle-without-i915: SUCCESS (7.816s)
[95.957405] [008/131] (924s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[96.030715] Subtest no-spare-fences-busy: SKIP (0.000s)
[96.103989] [009/131] (924s left) gem_tiled_wc
[96.220072] [010/131] (924s left) perf_pmu (gt-awake)
[96.261166] Starting subtest: gt-awake
[104.762089] Subtest gt-awake: SUCCESS (8.497s)
[104.905918] [011/131] (916s left) gem_ctx_persistence (heartbeat-many)
[104.978994] Starting subtest: heartbeat-many
[104.984249] Subtest heartbeat-many: SKIP (0.000s)
[105.164698] [012/131] (915s left) kms_psr (fbc-psr-cursor-plane-onoff)
[105.263068] Starting subtest: fbc-psr-cursor-plane-onoff
[105.265474] Starting dynamic subtest: eDP-1
[105.269893] Dynamic subtest eDP-1: SKIP (0.000s)
[105.274308] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[105.355403] [013/131] (915s left) api_intel_bb (object-noreloc-keep-cache-simple)
[105.410786] Starting subtest: object-noreloc-keep-cache-simple
[105.415364] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[105.581537] [014/131] (915s left) kms_chamelium_frames (hdmi-crc-fast)
[105.968153] Subtest hdmi-crc-fast: SKIP (0.000s)
[106.760679] [015/131] (914s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[106.878550] Starting subtest: 4-tiled-64bpp-rotate-270
[106.897987] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[107.055544] [016/131] (914s left) kms_setmode (invalid-clone-single-crtc-stealing)
[107.118216] Starting subtest: invalid-clone-single-crtc-stealing
[107.125070] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[107.245417] [017/131] (913s left) gem_ctx_param (invalid-ctx-set)
[107.306894] Starting subtest: invalid-ctx-set
[107.309260] Subtest invalid-ctx-set: SUCCESS (0.001s)
[107.446642] [018/131] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[107.550542] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[107.554595] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[107.673432] [019/131] (913s left) kms_flip (plain-flip-fb-recreate-interruptible)
[107.768678] Starting subtest: plain-flip-fb-recreate-interruptible
[107.770681] Starting dynamic subtest: A-eDP1
[116.672831] Dynamic subtest A-eDP1: SUCCESS (8.903s)
[116.683014] Starting dynamic subtest: B-eDP1
[125.500304] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[125.510864] Starting dynamic subtest: C-eDP1
[134.320245] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[134.330544] Starting dynamic subtest: D-eDP1
[143.143445] Dynamic subtest D-eDP1: SUCCESS (8.822s)
[143.148122] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.379s)
[144.338829] [020/131] (877s left) gem_busy (parallel)
[144.519098] Starting subtest: parallel
[144.521802] Starting dynamic subtest: rcs0
[145.783949] Dynamic subtest rcs0: SUCCESS (1.263s)
[145.795860] Starting dynamic subtest: bcs0
[147.767610] Dynamic subtest bcs0: SUCCESS (1.982s)
[147.780490] Starting dynamic subtest: vcs0
[149.815711] Dynamic subtest vcs0: SUCCESS (2.046s)
[149.829369] Starting dynamic subtest: vcs1
[151.799636] Dynamic subtest vcs1: SUCCESS (1.982s)
[151.814495] Starting dynamic subtest: vecs0
[153.784430] Dynamic subtest vecs0: SUCCESS (1.982s)
[153.795585] Starting dynamic subtest: ccs0
[155.767415] Dynamic subtest ccs0: SUCCESS (1.982s)
[155.770238] Subtest parallel: SUCCESS (11.247s)
[156.058800] [021/131] (865s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[156.161654] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[160.458646] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.300s)
[161.633517] [022/131] (859s left) gem_exec_schedule (preempt-queue)
[161.703987] Subtest preempt-queue: SKIP (0.000s)
[162.013356] [023/131] (859s left) kms_psr (psr-sprite-plane-move)
[162.111472] Starting subtest: psr-sprite-plane-move
[162.113724] Starting dynamic subtest: eDP-1
[163.843826] Dynamic subtest eDP-1: SUCCESS (1.733s)
[163.846228] Subtest psr-sprite-plane-move: SUCCESS (1.734s)
[164.687142] [024/131] (856s left) gem_ctx_isolation (preservation-s3)
[164.763138] Starting subtest: preservation-S3
[164.765601] Starting dynamic subtest: rcs0
[181.502623] Dynamic subtest rcs0: SUCCESS (1.396s)
[181.511705] Starting dynamic subtest: bcs0
[197.497117] Dynamic subtest bcs0: SUCCESS (1.407s)
[197.507744] Starting dynamic subtest: vcs0
[213.459739] Dynamic subtest vcs0: SUCCESS (2.275s)
[213.468506] Starting dynamic subtest: vcs1
[231.483828] Dynamic subtest vcs1: SUCCESS (5.006s)
[231.493273] Starting dynamic subtest: vecs0
[249.459839] Dynamic subtest vecs0: SUCCESS (4.974s)
[249.468940] Starting dynamic subtest: ccs0
[267.461444] Dynamic subtest ccs0: SUCCESS (3.182s)
[267.464207] Subtest preservation-S3: SUCCESS (18.242s)
[267.729233] [025/131] (753s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[267.831850] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[274.507474] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.666s)
[274.645853] [026/131] (746s left) gem_mmap_wc (write)
[274.709878] Subtest write: SKIP (0.000s)
[274.767675] [027/131] (746s left) kms_plane_scaling (planes-downscale-factor-0-5)
[274.866243] Starting subtest: planes-downscale-factor-0-5
[274.868994] Starting dynamic subtest: pipe-A
[274.889814] Dynamic subtest pipe-A: SKIP (0.016s)
[274.899434] Starting dynamic subtest: pipe-B
[274.917388] Dynamic subtest pipe-B: SKIP (0.028s)
[274.926450] Starting dynamic subtest: pipe-C
[274.947318] Dynamic subtest pipe-C: SKIP (0.028s)
[274.955905] Starting dynamic subtest: pipe-D
[274.973282] Dynamic subtest pipe-D: SKIP (0.028s)
[274.977765] Subtest planes-downscale-factor-0-5: SKIP (0.103s)
[275.109707] [028/131] (746s left) kms_invalid_mode (bad-vsync-start)
[275.213010] Starting subtest: bad-vsync-start
[275.215428] Starting dynamic subtest: pipe-A-eDP-1
[275.503216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[275.513292] Starting dynamic subtest: pipe-B-eDP-1
[275.516212] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[275.524782] Starting dynamic subtest: pipe-C-eDP-1
[275.527182] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[275.535303] Starting dynamic subtest: pipe-D-eDP-1
[275.537763] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[275.540139] Subtest bad-vsync-start: SUCCESS (0.296s)
[276.311307] [029/131] (745s left) kms_cursor_crc (cursor-random-128x128)
[276.532660] Starting subtest: cursor-random-128x128
[276.534921] Starting dynamic subtest: pipe-A-eDP-1
[279.890366] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.352s)
[279.920178] Starting dynamic subtest: pipe-D-eDP-1
[283.946088] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.031s)
[283.948524] Subtest cursor-random-128x128: SUCCESS (7.408s)
[284.782156] [030/131] (736s left) kms_properties (get_properties-sanity-non-atomic)
[284.888940] Starting subtest: get_properties-sanity-non-atomic
[284.891284] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[284.987874] [031/131] (736s left) gem_madvise (dontneed-before-mmap)
[285.027156] Starting subtest: dontneed-before-mmap
[285.050230] Subtest dontneed-before-mmap: SUCCESS (0.021s)
[285.179031] [032/131] (736s left) gem_exec_reloc (basic-write-read-noreloc)
[285.234264] Subtest basic-write-read-noreloc: SKIP (0.000s)
[285.316862] [033/131] (736s left) kms_plane_multiple (tiling-yf)
[285.407200] Starting subtest: tiling-yf
[285.412337] Subtest tiling-yf: SKIP (0.000s)
[285.499359] [034/131] (736s left) gem_exec_reloc (basic-wc-gtt-active)
[285.562245] Subtest basic-wc-gtt-active: SKIP (0.000s)
[285.641290] [035/131] (736s left) i915_hangman (gt-error-state-capture)
[285.712955] Starting subtest: gt-error-state-capture
[285.715209] Starting dynamic subtest: rcs0
[297.211181] Dynamic subtest rcs0: SUCCESS (11.492s)
[297.222826] Starting dynamic subtest: bcs0
[308.218682] Dynamic subtest bcs0: SUCCESS (11.000s)
[308.231959] Starting dynamic subtest: vcs0
[320.123036] Dynamic subtest vcs0: SUCCESS (11.897s)
[320.135578] Starting dynamic subtest: vcs1
[331.130403] Dynamic subtest vcs1: SUCCESS (11.000s)
[331.141717] Starting dynamic subtest: vecs0
[341.179132] Dynamic subtest vecs0: SUCCESS (10.041s)
[341.192327] Starting dynamic subtest: ccs0
[353.210706] Dynamic subtest ccs0: SUCCESS (12.024s)
[353.213655] Subtest gt-error-state-capture: SUCCESS (67.468s)
[353.318841] [036/131] (668s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[353.380565] Subtest tiled-to-untiled: SKIP (0.000s)
[353.456519] [037/131] (668s left) kms_async_flips (invalid-async-flip)
[353.558328] Starting subtest: invalid-async-flip
[353.935225] Starting dynamic subtest: pipe-A-eDP-1
[354.712415] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.779s)
[355.068536] Starting dynamic subtest: pipe-B-eDP-1
[355.845524] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s)
[356.202337] Starting dynamic subtest: pipe-C-eDP-1
[356.963240] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[357.317358] Starting dynamic subtest: pipe-D-eDP-1
[358.095852] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.786s)
[358.098267] Subtest invalid-async-flip: SUCCESS (4.537s)
[359.284973] [038/131] (662s left) syncobj_timeline (etime-single-wait-submitted)
[359.345708] Starting subtest: etime-single-wait-submitted
[359.447032] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[359.546864] [039/131] (662s left) gem_tiled_partial_pwrite_pread (writes)
[359.604832] Subtest writes: SKIP (0.000s)
[359.670311] [040/131] (662s left) gem_eio (in-flight-internal-immediate)
[359.845362] Starting subtest: in-flight-internal-immediate
[361.300310] Subtest in-flight-internal-immediate: SUCCESS (1.455s)
[361.476681] [041/131] (660s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[361.583599] Starting subtest: x-tiled-16bpp-rotate-180
[362.868684] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.289s)
[363.027771] [042/131] (659s left) kms_chamelium_color (ctm-0-25)
[363.127727] Subtest ctm-0-25: SKIP (0.000s)
[363.171480] [043/131] (659s left) kms_dp_linktrain_fallback (dsc-fallback)
[363.269193] Starting subtest: dsc-fallback
[363.276010] Subtest dsc-fallback: SKIP (0.000s)
[363.371194] [044/131] (658s left) gem_mmap (pf-nonblock)
[363.429749] Subtest pf-nonblock: SKIP (0.000s)
[363.498723] [045/131] (658s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[363.593389] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[363.595528] Starting dynamic subtest: pipe-A-eDP-1
[363.616869] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.628581] Starting dynamic subtest: pipe-B-eDP-1
[363.654775] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.674870] Starting dynamic subtest: pipe-C-eDP-1
[363.697974] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.708190] Starting dynamic subtest: pipe-D-eDP-1
[363.730213] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.734097] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[365.851680] [046/131] (656s left) gem_pxp (reject-modify-context-protection-on)
[365.987270] Starting subtest: reject-modify-context-protection-on
[365.990439] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[366.113723] [047/131] (656s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[371.126057] Starting subtest: pr-overlay-plane-move-continuous-sf
[371.131250] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[371.989696] [048/131] (650s left) gem_render_copy_redux (interruptible)
[372.057875] Starting subtest: interruptible
[372.374684] Subtest interruptible: SUCCESS (0.317s)
[372.540852] [049/131] (649s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[372.646286] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[372.651188] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[372.781072] [050/131] (649s left) prime_mmap (test_aperture_limit)
[372.837577] Starting subtest: test_aperture_limit
[372.839445] Starting dynamic subtest: test_aperture_limit-smem
[372.846708] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[372.851603] Subtest test_aperture_limit: SKIP (0.008s)
[372.987785] [051/131] (649s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[373.086531] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[373.088355] Starting dynamic subtest: pipe-A-default-mode
[373.375688] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[373.380273] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.287s)
[374.214403] [052/131] (648s left) api_intel_allocator (two-level-inception-interruptible)
[374.277886] Starting subtest: two-level-inception-interruptible
[379.676888] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[379.830809] [053/131] (642s left) gem_mmap_offset (mmap-boundaries)
[379.907399] Starting subtest: mmap-boundaries
[379.909977] Starting dynamic subtest: smem0
[380.187550] Dynamic subtest smem0: SUCCESS (0.281s)
[380.190293] Subtest mmap-boundaries: SUCCESS (0.282s)
[380.351367] [054/131] (642s left) gem_readwrite (read-write)
[380.429186] Subtest read-write: SKIP (0.000s)
[380.496790] [055/131] (642s left) syncobj_wait (invalid-signal-zero-handles)
[380.572077] Starting subtest: invalid-signal-zero-handles
[380.574667] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[380.715430] [056/131] (642s left) kms_pm_backlight (brightness-with-dpms)
[380.834848] Starting subtest: brightness-with-dpms
[380.885284] Starting dynamic subtest: eDP-1
[383.286301] Dynamic subtest eDP-1: SUCCESS (2.405s)
[383.289075] Subtest brightness-with-dpms: SUCCESS (2.455s)
[384.178154] [057/131] (638s left) kms_big_fb (linear-64bpp-rotate-270)
[384.290941] Starting subtest: linear-64bpp-rotate-270
[384.309313] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[384.479681] [058/131] (638s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[384.579223] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[384.584184] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[384.711234] [059/131] (638s left) sriov_basic (bind-unbind-vf)
[384.773702] Starting subtest: bind-unbind-vf
[384.776222] Starting dynamic subtest: vf-1
[384.846294] Dynamic subtest vf-1: FAIL (0.029s)
[384.854526] Starting dynamic subtest: vf-2
[384.913805] Dynamic subtest vf-2: FAIL (0.003s)
[384.922271] Starting dynamic subtest: vf-3
[384.988197] Dynamic subtest vf-3: FAIL (0.003s)
[384.996616] Starting dynamic subtest: vf-4
[385.073650] Dynamic subtest vf-4: FAIL (0.003s)
[385.082804] Starting dynamic subtest: vf-5
[385.154251] Dynamic subtest vf-5: FAIL (0.003s)
[385.164125] Starting dynamic subtest: vf-6
[385.238261] Dynamic subtest vf-6: FAIL (0.004s)
[385.249238] Starting dynamic subtest: vf-7
[385.326870] Dynamic subtest vf-7: FAIL (0.003s)
[385.336193] Starting dynamic subtest: vf-random
[385.412979] Dynamic subtest vf-random: FAIL (0.003s)
[385.423166] Starting dynamic subtest: vf-last
[385.497264] Dynamic subtest vf-last: FAIL (0.489s)
[385.499721] Subtest bind-unbind-vf: FAIL (0.549s)
[385.535088] [060/131] (637s left) gem_lmem_swapping (verify-random-ccs)
[385.577620] Subtest verify-random-ccs: SKIP (0.000s)
[385.622848] [061/131] (637s left) gem_exec_fence (syncobj-timeline-repeat)
[386.247943] Starting subtest: syncobj-timeline-repeat
[386.465925] Subtest syncobj-timeline-repeat: SUCCESS (0.218s)
[387.249417] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[387.253171] [062/131] (635s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[387.311127] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[387.313907] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[387.454592] [063/131] (635s left) kms_psr (fbc-pr-primary-mmap-cpu)
[387.559026] Starting subtest: fbc-pr-primary-mmap-cpu
[387.563869] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[387.655944] [064/131] (635s left) kms_hdmi_inject (inject-4k)
[388.005022] Starting subtest: inject-4k
[388.315084] Subtest inject-4k: SUCCESS (0.314s)
[388.846263] [065/131] (634s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[388.945076] Starting subtest: fbcpsr-rgb565-draw-render
[395.937256] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.999s)
[396.096782] [066/131] (627s left) gem_exec_schedule (u-semaphore-codependency)
[396.178387] Starting subtest: u-semaphore-codependency
[396.183272] Subtest u-semaphore-codependency: SUCCESS (0.015s)
[396.552790] [067/131] (626s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[396.657190] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[396.662075] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[396.771005] [068/131] (626s left) sysfs_preempt_timeout (idempotent)
[396.828568] Starting subtest: idempotent
[396.831396] Starting dynamic subtest: vecs0
[396.834154] Dynamic subtest vecs0: SUCCESS (0.000s)
[396.844208] Starting dynamic subtest: ccs0
[396.846441] Dynamic subtest ccs0: SUCCESS (0.000s)
[396.856397] Starting dynamic subtest: vcs0
[396.859377] Dynamic subtest vcs0: SUCCESS (0.000s)
[396.869577] Starting dynamic subtest: bcs0
[396.871891] Dynamic subtest bcs0: SUCCESS (0.000s)
[396.880927] Starting dynamic subtest: rcs0
[396.883125] Dynamic subtest rcs0: SUCCESS (0.000s)
[396.891903] Starting dynamic subtest: vcs1
[396.894129] Dynamic subtest vcs1: SUCCESS (0.000s)
[396.896198] Subtest idempotent: SUCCESS (0.006s)
[396.933863] [069/131] (626s left) gem_spin_batch (spin-all)
[396.989156] Starting subtest: spin-all
[397.006424] Subtest spin-all: SUCCESS (0.016s)
[398.301831] [070/131] (625s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[398.404931] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[398.407296] Starting dynamic subtest: pipe-A-eDP-1
[398.416718] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[398.425877] Starting dynamic subtest: pipe-B-eDP-1
[398.435203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[398.444063] Starting dynamic subtest: pipe-C-eDP-1
[398.455081] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[398.464170] Starting dynamic subtest: pipe-D-eDP-1
[398.474518] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[398.479790] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[400.704785] [071/131] (622s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[400.796065] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[400.798331] Starting dynamic subtest: pipe-A-eDP-1
[400.821434] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[400.831613] Starting dynamic subtest: pipe-B-eDP-1
[400.855214] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[400.863952] Starting dynamic subtest: pipe-C-eDP-1
[400.888418] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[400.897803] Starting dynamic subtest: pipe-D-eDP-1
[400.923874] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[400.928969] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[403.089169] [072/131] (620s left) core_getversion (basic)
[403.126148] Starting subtest: basic
[403.131626] Subtest basic: SUCCESS (0.000s)
[403.215705] [073/131] (620s left) kms_concurrent (multi-plane-atomic-lowres)
[403.316415] Starting subtest: multi-plane-atomic-lowres
[403.319042] Starting dynamic subtest: pipe-A-eDP-1
[403.817615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.500s)
[403.820562] Subtest multi-plane-atomic-lowres: SUCCESS (0.501s)
[404.713747] [074/131] (618s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[404.811106] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[404.816120] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[404.953823] [075/131] (618s left) gem_wait (wait)
[405.026707] Starting subtest: wait
[405.029225] Starting dynamic subtest: all-engines
[406.236069] Dynamic subtest all-engines: SUCCESS (1.208s)
[406.249414] Starting dynamic subtest: rcs0
[407.284975] Dynamic subtest rcs0: SUCCESS (1.048s)
[407.297236] Starting dynamic subtest: bcs0
[408.338398] Dynamic subtest bcs0: SUCCESS (1.051s)
[408.350301] Starting dynamic subtest: vcs0
[409.387966] Dynamic subtest vcs0: SUCCESS (1.048s)
[409.400436] Starting dynamic subtest: vcs1
[410.438657] Dynamic subtest vcs1: SUCCESS (1.048s)
[410.451624] Starting dynamic subtest: vecs0
[411.488697] Dynamic subtest vecs0: SUCCESS (1.048s)
[411.501702] Starting dynamic subtest: ccs0
[412.541793] Dynamic subtest ccs0: SUCCESS (1.051s)
[412.544376] Subtest wait: SUCCESS (7.518s)
[412.769300] [076/131] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[412.873319] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[412.878003] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[413.007242] [077/131] (610s left) syncobj_timeline (wait-all-for-submit-complex)
[413.065836] Starting subtest: wait-all-for-submit-complex
[413.279363] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[413.381954] [078/131] (610s left) gen9_exec_parse (bb-start-cmd)
[413.446319] Subtest bb-start-cmd: SKIP (0.000s)
[413.527607] [079/131] (610s left) syncobj_wait (wait-all-delayed-signal)
[413.581317] Starting subtest: wait-all-delayed-signal
[413.682369] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[413.790009] [080/131] (610s left) perf (oa-exponents)
[413.924482] Starting subtest: oa-exponents
[413.927287] Starting dynamic subtest: 0-rcs0
[415.689636] Dynamic subtest 0-rcs0: SUCCESS (1.766s)
[415.703079] Starting dynamic subtest: 1-vcs1
[417.520676] Dynamic subtest 1-vcs1: SUCCESS (1.830s)
[417.523597] Subtest oa-exponents: SUCCESS (3.598s)
[417.571873] [081/131] (606s left) gem_tiled_partial_pwrite_pread (reads)
[417.645319] Subtest reads: SKIP (0.000s)
[417.732984] [082/131] (606s left) kms_properties (get_properties-sanity-atomic)
[417.832333] Starting subtest: get_properties-sanity-atomic
[417.835296] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[417.930245] [083/131] (606s left) syncobj_wait (invalid-reset-bad-pad)
[417.996044] Starting subtest: invalid-reset-bad-pad
[417.998670] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[418.133784] [084/131] (605s left) gem_lmem_swapping (massive)
[418.178917] Subtest massive: SKIP (0.000s)
[418.245832] [085/131] (605s left) kms_pipe_crc_basic (read-crc)
[418.349833] Starting subtest: read-crc
[418.352044] Starting dynamic subtest: pipe-A-eDP-1
[419.049526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[419.059971] Starting dynamic subtest: pipe-B-eDP-1
[420.415061] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.364s)
[420.425281] Starting dynamic subtest: pipe-C-eDP-1
[421.763382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s)
[421.774081] Starting dynamic subtest: pipe-D-eDP-1
[423.080476] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[423.083398] Subtest read-crc: SUCCESS (4.732s)
[423.900667] [086/131] (600s left) gem_exec_balancer (hog)
[423.973196] Starting subtest: hog
[423.978405] Subtest hog: SKIP (0.000s)
[424.289330] [087/131] (599s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[424.343075] Starting subtest: multi-wait-all-for-submit-available-submitted
[424.345758] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[424.478879] [088/131] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[424.572009] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[424.577027] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[424.690097] [089/131] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[424.785206] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[424.790103] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[424.908612] [090/131] (599s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[425.023093] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[426.032709] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.012s)
[426.204913] [091/131] (598s left) kms_flip (flip-vs-wf_vblank-interruptible)
[426.304643] Starting subtest: flip-vs-wf_vblank-interruptible
[426.306658] Starting dynamic subtest: A-eDP1
[428.178083] Dynamic subtest A-eDP1: SUCCESS (1.872s)
[428.188535] Starting dynamic subtest: B-eDP1
[430.082097] Dynamic subtest B-eDP1: SUCCESS (1.901s)
[430.092177] Starting dynamic subtest: C-eDP1
[431.977305] Dynamic subtest C-eDP1: SUCCESS (1.894s)
[431.991352] Starting dynamic subtest: D-eDP1
[433.870999] Dynamic subtest D-eDP1: SUCCESS (1.892s)
[433.877003] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.571s)
[435.094853] [092/131] (589s left) kms_prime (basic-modeset-hybrid)
[435.181433] Subtest basic-modeset-hybrid: SKIP (0.000s)
[435.300761] [093/131] (589s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[435.398652] Starting subtest: y-tiled-32bpp-rotate-90
[435.403543] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[435.525068] [094/131] (588s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[435.621640] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[439.761952] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.145s)
[440.904748] [095/131] (583s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[441.006144] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[445.554847] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.555s)
[446.701722] [096/131] (577s left) gem_exec_endless (dispatch)
[446.772657] Starting subtest: dispatch
[446.775685] Starting dynamic subtest: rcs0
[446.784706] Dynamic subtest rcs0: SUCCESS (0.007s)
[446.796058] Starting dynamic subtest: bcs0
[446.801508] Dynamic subtest bcs0: SUCCESS (0.004s)
[446.812459] Starting dynamic subtest: vcs0
[446.817405] Dynamic subtest vcs0: SUCCESS (0.005s)
[446.827239] Starting dynamic subtest: vcs1
[446.832391] Dynamic subtest vcs1: SUCCESS (0.004s)
[446.842000] Starting dynamic subtest: vecs0
[446.847022] Dynamic subtest vecs0: SUCCESS (0.005s)
[446.856915] Starting dynamic subtest: ccs0
[446.862194] Dynamic subtest ccs0: SUCCESS (0.005s)
[446.865260] Subtest dispatch: SUCCESS (0.033s)
[448.286883] [097/131] (576s left) kms_cursor_crc (cursor-size-hints)
[448.437983] Starting subtest: cursor-size-hints
[448.440501] Starting dynamic subtest: pipe-A-eDP-1
[449.050360] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[449.062599] Starting dynamic subtest: pipe-D-eDP-1
[450.290979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[450.293393] Subtest cursor-size-hints: SUCCESS (1.853s)
[451.194864] [098/131] (573s left) gem_exec_async (concurrent-writes)
[451.278808] Starting subtest: concurrent-writes
[451.281169] Starting dynamic subtest: rcs0
[451.295442] Dynamic subtest rcs0: SUCCESS (0.016s)
[451.306701] Starting dynamic subtest: bcs0
[451.309050] Dynamic subtest bcs0: SUCCESS (0.006s)
[451.320198] Starting dynamic subtest: vcs0
[451.322812] Dynamic subtest vcs0: SUCCESS (0.005s)
[451.332199] Starting dynamic subtest: vcs1
[451.334954] Dynamic subtest vcs1: SUCCESS (0.006s)
[451.344195] Starting dynamic subtest: vecs0
[451.346706] Dynamic subtest vecs0: SUCCESS (0.007s)
[451.355942] Starting dynamic subtest: ccs0
[451.358296] Dynamic subtest ccs0: SUCCESS (0.006s)
[451.361036] Subtest concurrent-writes: SUCCESS (0.050s)
[451.580780] [099/131] (573s left) kms_psr (psr-primary-mmap-cpu)
[451.675742] Starting subtest: psr-primary-mmap-cpu
[451.678079] Starting dynamic subtest: eDP-1
[453.428726] Dynamic subtest eDP-1: SUCCESS (1.751s)
[453.431237] Subtest psr-primary-mmap-cpu: SUCCESS (1.752s)
[454.285862] [100/131] (570s left) gem_exec_flush (basic-wb-rw-default)
[454.343757] Starting subtest: basic-wb-rw-default
[459.823895] Subtest basic-wb-rw-default: SUCCESS (5.480s)
[460.042697] [101/131] (564s left) kms_psr (psr2-cursor-blt)
[460.130408] Starting subtest: psr2-cursor-blt
[460.133175] Starting dynamic subtest: eDP-1
[461.805663] Dynamic subtest eDP-1: SUCCESS (1.673s)
[461.808061] Subtest psr2-cursor-blt: SUCCESS (1.674s)
[462.694060] [102/131] (562s left) kms_atomic_transition (plane-toggle-modeset-transition)
[462.787236] Starting subtest: plane-toggle-modeset-transition
[462.789871] Starting dynamic subtest: pipe-A-eDP-1
[475.971379] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.184s)
[475.986164] Starting dynamic subtest: pipe-B-eDP-1
[488.885091] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.910s)
[488.888161] Subtest plane-toggle-modeset-transition: SUCCESS (26.101s)
[489.781441] [103/131] (535s left) gem_cs_tlb (engines)
[489.848384] Starting subtest: engines
[489.851159] Starting dynamic subtest: rcs0
[492.002016] Dynamic subtest rcs0: SUCCESS (2.152s)
[492.012030] Starting dynamic subtest: bcs0
[494.155378] Dynamic subtest bcs0: SUCCESS (2.152s)
[494.165140] Starting dynamic subtest: vcs0
[496.309026] Dynamic subtest vcs0: SUCCESS (2.152s)
[496.319791] Starting dynamic subtest: vcs1
[498.461245] Dynamic subtest vcs1: SUCCESS (2.152s)
[498.473366] Starting dynamic subtest: vecs0
[500.614968] Dynamic subtest vecs0: SUCCESS (2.152s)
[500.627047] Starting dynamic subtest: ccs0
[502.771372] Dynamic subtest ccs0: SUCCESS (2.156s)
[502.774137] Subtest engines: SUCCESS (12.921s)
[502.943077] [104/131] (521s left) kms_pm_rpm (legacy-planes)
[504.479308] Starting subtest: legacy-planes
[504.482271] Starting dynamic subtest: plane-63
[512.881559] Dynamic subtest plane-63: SUCCESS (8.406s)
[512.894531] Starting dynamic subtest: plane-93
[521.454567] Dynamic subtest plane-93: SUCCESS (8.571s)
[521.466689] Starting dynamic subtest: plane-123
[530.060006] Dynamic subtest plane-123: SUCCESS (8.602s)
[530.073074] Starting dynamic subtest: plane-133
[538.386650] Dynamic subtest plane-133: SUCCESS (8.324s)
[538.389198] Subtest legacy-planes: SUCCESS (33.913s)
[538.788866] [105/131] (486s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[538.892431] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[538.897359] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[539.036928] [106/131] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[539.133909] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[542.875949] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.747s)
[544.089959] [107/131] (480s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[544.188644] Starting subtest: fbc-psr2-sprite-mmap-cpu
[544.191369] Starting dynamic subtest: eDP-1
[544.197317] Dynamic subtest eDP-1: SKIP (0.000s)
[544.202448] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[544.287713] [108/131] (480s left) kms_flip (absolute-wf_vblank-interruptible)
[544.374814] Starting subtest: absolute-wf_vblank-interruptible
[544.377415] Starting dynamic subtest: A-eDP1
[553.102819] Dynamic subtest A-eDP1: SUCCESS (8.713s)
[553.114693] Starting dynamic subtest: B-eDP1
[561.776616] Dynamic subtest B-eDP1: SUCCESS (8.687s)
[561.791062] Starting dynamic subtest: C-eDP1
[570.475507] Dynamic subtest C-eDP1: SUCCESS (8.697s)
[570.486855] Starting dynamic subtest: D-eDP1
[579.166439] Dynamic subtest D-eDP1: SUCCESS (8.688s)
[579.169282] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.795s)
[580.384688] [109/131] (444s left) kms_sequence (get-forked)
[580.487391] Starting subtest: get-forked
[580.490178] Starting dynamic subtest: pipe-A-eDP-1
[582.347630] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.861s)
[582.360950] Starting dynamic subtest: pipe-B-eDP-1
[584.852682] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.504s)
[584.863261] Starting dynamic subtest: pipe-C-eDP-1
[587.371823] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.516s)
[587.388392] Starting dynamic subtest: pipe-D-eDP-1
[589.941112] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.569s)
[589.943853] Subtest get-forked: SUCCESS (9.455s)
[590.766723] [110/131] (434s left) gem_render_copy_redux (normal)
[590.829184] Starting subtest: normal
[591.126026] Subtest normal: SUCCESS (0.296s)
[591.291009] [111/131] (433s left) perf (global-sseu-config)
[591.397162] Starting subtest: global-sseu-config
[591.402938] Subtest global-sseu-config: SKIP (0.000s)
[591.463651] [112/131] (433s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[596.537317] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[596.543387] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[597.387621] [113/131] (427s left) gem_linear_blits (interruptible)
[597.771031] Starting subtest: interruptible
[602.413157] Subtest interruptible: SUCCESS (4.641s)
[602.713754] [114/131] (422s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[602.822125] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[602.827528] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[603.034913] [115/131] (422s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[603.154218] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[609.535133] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.384s)
[609.673201] [116/131] (415s left) gem_workarounds (suspend-resume-context)
[609.754936] Starting subtest: suspend-resume-context
[625.414515] Subtest suspend-resume-context: SUCCESS (1.234s)
[625.579324] [117/131] (399s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[625.695204] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[625.700462] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[625.831839] [118/131] (399s left) intel_hwmon (hwmon-write)
[625.895419] Subtest hwmon-write: SKIP (0.000s)
[625.963430] [119/131] (399s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[626.062482] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[626.065132] Starting dynamic subtest: pipe-A-default-mode
[628.716659] Dynamic subtest pipe-A-default-mode: SUCCESS (2.652s)
[628.719672] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.653s)
[629.580062] [120/131] (396s left) kms_addfb_basic (invalid-get-prop-any)
[629.645483] Starting subtest: invalid-get-prop-any
[629.647891] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[629.800733] [121/131] (395s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[629.896492] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[629.899153] Starting dynamic subtest: pipe-A-eDP-1
[629.969346] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[629.980852] Starting dynamic subtest: pipe-B-eDP-1
[630.051392] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[630.063246] Starting dynamic subtest: pipe-C-eDP-1
[630.131155] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[630.142544] Starting dynamic subtest: pipe-D-eDP-1
[630.214460] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[630.219634] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[632.172101] [122/131] (393s left) gem_exec_fence (long-history)
[632.625859] Starting subtest: long-history
[639.464378] Subtest long-history: SUCCESS (6.836s)
[640.344942] [123/131] (385s left) gem_exec_whisper (basic-contexts-priority)
[640.415807] Starting subtest: basic-contexts-priority
[664.211356] Subtest basic-contexts-priority: SUCCESS (23.788s)
[664.421667] [124/131] (361s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[664.535588] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[664.540845] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[664.674933] [125/131] (361s left) kms_lease (lease-get)
[664.771452] Starting subtest: lease-get
[664.774278] Starting dynamic subtest: pipe-A-eDP-1
[664.777121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[664.788126] Starting dynamic subtest: pipe-B-eDP-1
[664.790356] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[664.800487] Starting dynamic subtest: pipe-C-eDP-1
[664.802996] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[664.812887] Starting dynamic subtest: pipe-D-eDP-1
[664.814958] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[664.817017] Subtest lease-get: SUCCESS (0.009s)
[664.927217] [126/131] (361s left) kms_content_protection (type1)
[665.079905] Starting subtest: type1
[665.085168] Subtest type1: SKIP (0.000s)
[665.248960] [127/131] (360s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[665.311640] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[665.418433] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[665.522743] [128/131] (360s left) i915_pm_rps (engine-order)
[665.586624] Starting subtest: engine-order
[670.467444] Subtest engine-order: SUCCESS (4.880s)
[670.619739] [129/131] (355s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[670.713261] Starting subtest: fbc-dirtyfb-ioctl
[670.716012] Starting dynamic subtest: A-eDP-1
[673.284665] Dynamic subtest A-eDP-1: SUCCESS (2.570s)
[673.287612] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.571s)
[674.172818] [130/131] (351s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[674.577243] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[675.436216] [131/131] (350s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[675.495641] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[675.498537] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[675.622783] 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.