[62.327710] Initializing watchdogs
[62.327754]   /dev/watchdog0
[62.342956] [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]
[62.347689] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.350070] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.352114] [001/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[62.456674] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[62.469418] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[62.547207] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[62.629724] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[62.631415] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[62.733028] [003/133] (960s left) perf_pmu (init-busy)
[62.776611] Starting subtest: init-busy
[62.777530] Starting dynamic subtest: rcs0
[62.778406] Dynamic subtest rcs0: SUCCESS (0.002s)
[62.783886] Starting dynamic subtest: bcs0
[62.784809] Dynamic subtest bcs0: SUCCESS (0.001s)
[62.790098] Starting dynamic subtest: vcs0
[62.790999] Dynamic subtest vcs0: SUCCESS (0.001s)
[62.796565] Starting dynamic subtest: vcs1
[62.797538] Dynamic subtest vcs1: SUCCESS (0.000s)
[62.803297] Starting dynamic subtest: vecs0
[62.804253] Dynamic subtest vecs0: SUCCESS (0.001s)
[62.809645] Starting dynamic subtest: ccs0
[62.810639] Dynamic subtest ccs0: SUCCESS (0.000s)
[62.811579] Subtest init-busy: SUCCESS (0.005s)
[62.892913] [004/133] (960s left) kms_flip (flip-vs-rmfb)
[62.986792] Starting subtest: flip-vs-rmfb
[62.989126] Starting dynamic subtest: A-eDP1
[71.703870] Dynamic subtest A-eDP1: SUCCESS (8.715s)
[71.716846] Starting dynamic subtest: B-eDP1
[80.330869] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[80.339394] Starting dynamic subtest: C-eDP1
[88.949994] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[88.958594] Starting dynamic subtest: D-eDP1
[97.580694] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[97.583366] Subtest flip-vs-rmfb: SUCCESS (34.596s)
[98.761058] [005/133] (924s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[98.857561] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[98.858467] Starting dynamic subtest: pipe-A-eDP-1
[98.867221] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.873219] Starting dynamic subtest: pipe-B-eDP-1
[98.881596] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.887429] Starting dynamic subtest: pipe-C-eDP-1
[98.895446] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.901070] Starting dynamic subtest: pipe-D-eDP-1
[98.909355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.910965] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[101.127496] [006/133] (921s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[101.178508] Starting subtest: x-tiled-to-vebox-y-tiled
[101.180254] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[101.352529] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[101.437395] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[101.439118] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[101.529946] [008/133] (921s left) gem_ctx_persistence (legacy-engines-mixed-process)
[101.579402] Starting subtest: legacy-engines-mixed-process
[101.580336] Starting dynamic subtest: render
[102.877350] Dynamic subtest render: SUCCESS (1.297s)
[102.886655] Starting dynamic subtest: bsd1
[104.933482] Dynamic subtest bsd1: SUCCESS (2.054s)
[104.943546] Starting dynamic subtest: bsd2
[106.854940] Dynamic subtest bsd2: SUCCESS (1.919s)
[106.865707] Starting dynamic subtest: blt
[108.893566] Dynamic subtest blt: SUCCESS (2.036s)
[108.902465] Starting dynamic subtest: vebox
[110.883032] Dynamic subtest vebox: SUCCESS (1.988s)
[110.884518] Subtest legacy-engines-mixed-process: SUCCESS (9.304s)
[110.960420] [009/133] (912s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[111.008058] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[111.061754] [010/133] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[111.151077] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[117.976917] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.826s)
[118.130181] [011/133] (905s left) gem_exec_fence (basic-await)
[118.313964] Starting subtest: basic-await
[118.315271] Starting dynamic subtest: rcs0
[118.383620] Dynamic subtest rcs0: SUCCESS (0.076s)
[118.393597] Starting dynamic subtest: bcs0
[118.456417] Dynamic subtest bcs0: SUCCESS (0.071s)
[118.466960] Starting dynamic subtest: vcs0
[118.529895] Dynamic subtest vcs0: SUCCESS (0.071s)
[118.541058] Starting dynamic subtest: vcs1
[118.603124] Dynamic subtest vcs1: SUCCESS (0.072s)
[118.610608] Starting dynamic subtest: vecs0
[118.676318] Dynamic subtest vecs0: SUCCESS (0.071s)
[118.686642] Starting dynamic subtest: ccs0
[118.749939] Dynamic subtest ccs0: SUCCESS (0.072s)
[118.751567] Subtest basic-await: SUCCESS (0.444s)
[120.969716] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[120.971660] [012/133] (902s left) kms_vblank (query-forked)
[121.075339] Starting subtest: query-forked
[121.076332] Starting dynamic subtest: pipe-A-eDP-1
[122.889296] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[122.898766] Starting dynamic subtest: pipe-D-eDP-1
[125.392176] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.502s)
[125.392996] Subtest query-forked: SUCCESS (4.317s)
[126.245655] [013/133] (897s left) gem_create (hog-create)
[126.303490] Starting subtest: hog-create
[126.304423] Starting dynamic subtest: smem0
[158.940685] Dynamic subtest smem0: SUCCESS (32.627s)
[158.941980] Subtest hog-create: SUCCESS (32.629s)
[159.130839] [014/133] (864s left) syncobj_wait (single-wait-all-for-submit-signaled)
[159.179249] Starting subtest: single-wait-all-for-submit-signaled
[159.180137] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[159.270059] [015/133] (864s left) gem_exec_balancer (hang)
[159.541817] Starting subtest: hang
[161.318587] Subtest hang: SUCCESS (1.788s)
[161.435930] [016/133] (861s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[161.534083] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[161.535036] Starting dynamic subtest: pipe-A-eDP-1
[161.538280] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.544710] Starting dynamic subtest: pipe-B-eDP-1
[161.548015] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.554269] Starting dynamic subtest: pipe-C-eDP-1
[161.557481] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.563640] Starting dynamic subtest: pipe-D-eDP-1
[161.567070] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.568720] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[163.809673] [017/133] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[163.909932] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[163.911703] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[164.017683] [018/133] (859s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[164.397433] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[165.213464] [019/133] (858s left) vgem_basic (bad-flag)
[165.249314] Starting subtest: bad-flag
[165.250183] Subtest bad-flag: SUCCESS (0.000s)
[165.303297] [020/133] (858s left) kms_flip (flip-vs-panning)
[165.393104] Starting subtest: flip-vs-panning
[165.395094] Starting dynamic subtest: A-eDP1
[174.156032] Dynamic subtest A-eDP1: SUCCESS (8.761s)
[174.164873] Starting dynamic subtest: B-eDP1
[182.893711] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[182.902626] Starting dynamic subtest: C-eDP1
[191.610039] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[191.617609] Starting dynamic subtest: D-eDP1
[200.352167] Dynamic subtest D-eDP1: SUCCESS (8.741s)
[200.355473] Subtest flip-vs-panning: SUCCESS (34.962s)
[201.510259] [021/133] (822s left) kms_setmode (invalid-clone-exclusive-crtc)
[201.561553] Starting subtest: invalid-clone-exclusive-crtc
[201.564137] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[201.651760] [022/133] (821s left) gem_exec_reloc (basic-softpin)
[201.716312] Subtest basic-softpin: SKIP (0.000s)
[201.788118] [023/133] (821s left) gen9_exec_parse (unaligned-access)
[201.839986] Subtest unaligned-access: SKIP (0.000s)
[201.902316] [024/133] (821s left) kms_rotation_crc (primary-rotation-180)
[202.001426] Starting subtest: primary-rotation-180
[208.903049] Subtest primary-rotation-180: SUCCESS (6.903s)
[210.071307] [025/133] (813s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[210.174244] Starting subtest: y-tiled-8bpp-rotate-0
[210.176092] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[210.261121] [026/133] (813s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[212.083950] Starting subtest: modeset-lpsp-stress-no-wait
[221.978918] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.898s)
[222.049358] [027/133] (801s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[222.138507] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[222.140155] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[222.254385] [028/133] (801s left) prime_vgem (busy)
[222.332682] Starting subtest: busy
[222.333757] Starting dynamic subtest: rcs0
[222.409935] Dynamic subtest rcs0: SUCCESS (0.077s)
[222.418841] Starting dynamic subtest: bcs0
[222.457134] Dynamic subtest bcs0: SUCCESS (0.046s)
[222.463742] Starting dynamic subtest: vcs0
[222.503716] Dynamic subtest vcs0: SUCCESS (0.046s)
[222.510916] Starting dynamic subtest: vcs1
[222.549790] Dynamic subtest vcs1: SUCCESS (0.045s)
[222.556633] Starting dynamic subtest: vecs0
[222.597442] Dynamic subtest vecs0: SUCCESS (0.047s)
[222.604263] Starting dynamic subtest: ccs0
[222.643858] Dynamic subtest ccs0: SUCCESS (0.045s)
[222.644811] Subtest busy: SUCCESS (0.312s)
[222.753560] [029/133] (801s left) gem_ctx_param (basic)
[222.808661] Starting subtest: basic
[222.809630] Subtest basic: SUCCESS (0.001s)
[222.927965] [030/133] (800s left) syncobj_timeline (multi-wait-signaled)
[222.978842] Starting subtest: multi-wait-signaled
[222.979792] Subtest multi-wait-signaled: SUCCESS (0.001s)
[223.098977] [031/133] (800s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[223.156568] Starting subtest: invalid-bsd1-flag-on-blt
[223.157441] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[223.258955] [032/133] (800s left) i915_query (test-query-geometry-subslices)
[223.321481] Starting subtest: test-query-geometry-subslices
[223.322442] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[223.396790] [033/133] (800s left) kms_psr2_su (frontbuffer-xrgb8888)
[223.458605] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[223.524395] [034/133] (800s left) kms_color (ctm-negative)
[223.615609] Starting subtest: ctm-negative
[223.616533] Starting dynamic subtest: pipe-A-eDP-1
[224.327356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[224.334204] Starting dynamic subtest: pipe-B-eDP-1
[225.762561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s)
[225.769361] Starting dynamic subtest: pipe-C-eDP-1
[227.134616] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[227.141545] Starting dynamic subtest: pipe-D-eDP-1
[228.463434] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[228.464366] Subtest ctm-negative: SUCCESS (4.849s)
[229.256455] [035/133] (794s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[229.354604] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[229.356465] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[229.428731] [036/133] (794s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[229.476483] Subtest no-spare-fences-busy: SKIP (0.000s)
[229.541083] [037/133] (794s left) gem_exec_schedule (independent)
[229.615477] Starting subtest: independent
[229.616432] Starting dynamic subtest: rcs0
[230.945467] Dynamic subtest rcs0: SUCCESS (1.321s)
[230.955503] Starting dynamic subtest: vcs0
[232.938510] Dynamic subtest vcs0: SUCCESS (1.990s)
[232.949223] Starting dynamic subtest: vcs1
[234.924961] Dynamic subtest vcs1: SUCCESS (1.985s)
[234.933880] Starting dynamic subtest: vecs0
[236.904729] Dynamic subtest vecs0: SUCCESS (1.977s)
[236.914842] Starting dynamic subtest: ccs0
[238.945063] Dynamic subtest ccs0: SUCCESS (2.038s)
[238.946465] Subtest independent: SUCCESS (9.322s)
[239.233662] [038/133] (784s left) kms_cursor_crc (cursor-alpha-opaque)
[239.326350] Starting subtest: cursor-alpha-opaque
[239.327302] Starting dynamic subtest: pipe-A-eDP-1
[239.935443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[239.942342] Starting dynamic subtest: pipe-D-eDP-1
[241.277131] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[241.277961] Subtest cursor-alpha-opaque: SUCCESS (1.952s)
[242.113609] [039/133] (782s left) gem_mmap_gtt (basic-write-read)
[242.165067] Subtest basic-write-read: SKIP (0.000s)
[242.214820] [040/133] (781s left) gen9_exec_parse (bb-secure)
[242.278940] Subtest bb-secure: SKIP (0.000s)
[242.330241] [041/133] (781s left) api_intel_bb (lot-of-buffers)
[242.381035] Starting subtest: lot-of-buffers
[243.511385] Subtest lot-of-buffers: SUCCESS (1.122s)
[243.957674] [042/133] (780s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[243.993077] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[244.031571] [043/133] (780s left) gem_exec_params (invalid-fence-in)
[244.080355] Starting subtest: invalid-fence-in
[244.081241] Subtest invalid-fence-in: SUCCESS (0.000s)
[244.172342] [044/133] (780s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[244.271567] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[251.238609] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.968s)
[251.383461] [045/133] (772s left) gem_mmap_gtt (big-bo-tiledy)
[251.430578] Subtest big-bo-tiledY: SKIP (0.000s)
[251.482433] [046/133] (772s left) gem_softpin (evict-single-offset)
[251.526672] Starting subtest: evict-single-offset
[275.939424] Subtest evict-single-offset: SUCCESS (24.402s)
[276.014516] [047/133] (748s left) syncobj_wait (invalid-signal-illegal-handle)
[276.131211] Starting subtest: invalid-signal-illegal-handle
[276.132091] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[276.264902] [048/133] (748s left) kms_addfb_basic (master-rmfb)
[276.315213] Starting subtest: master-rmfb
[276.316103] Subtest master-rmfb: SUCCESS (0.001s)
[276.475571] [049/133] (748s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[276.572318] Starting subtest: plane-use-after-nonblocking-unbind
[276.573120] Starting dynamic subtest: pipe-A-eDP-1
[276.643738] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[276.963650] Starting dynamic subtest: pipe-B-eDP-1
[277.754211] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.796s)
[278.039242] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.466s)
[278.911978] [050/133] (745s left) i915_pm_rpm (debugfs-forcewake-user)
[281.066988] Starting subtest: debugfs-forcewake-user
[292.454720] Subtest debugfs-forcewake-user: SUCCESS (11.389s)
[292.862133] [051/133] (731s left) kms_pm_dc (dc5-dpms-negative)
[293.956508] Starting subtest: dc5-dpms-negative
[293.958257] Subtest dc5-dpms-negative: SKIP (0.000s)
[294.029852] [052/133] (730s left) gem_ctx_sseu (engines)
[294.096681] Subtest engines: SKIP (0.000s)
[294.164289] [053/133] (730s left) kms_flip (2x-busy-flip)
[294.260769] Starting subtest: 2x-busy-flip
[294.273325] Subtest 2x-busy-flip: SKIP (0.012s)
[294.349321] [054/133] (730s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[294.453867] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[294.455584] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[294.559206] [055/133] (730s left) kms_content_protection (suspend-resume)
[294.710736] Starting subtest: suspend-resume
[294.712739] Subtest suspend-resume: SKIP (0.000s)
[294.841396] [056/133] (729s left) gem_busy (busy)
[294.893399] Starting subtest: busy
[294.894377] Starting dynamic subtest: all-engines
[294.945520] Dynamic subtest all-engines: SUCCESS (0.052s)
[294.955423] Starting dynamic subtest: rcs0
[296.934227] Dynamic subtest rcs0: SUCCESS (1.981s)
[296.941352] Starting dynamic subtest: bcs0
[296.978868] Dynamic subtest bcs0: SUCCESS (0.048s)
[296.988319] Starting dynamic subtest: vcs0
[297.019363] Dynamic subtest vcs0: SUCCESS (0.039s)
[297.026924] Starting dynamic subtest: vcs1
[298.919040] Dynamic subtest vcs1: SUCCESS (1.888s)
[298.932465] Starting dynamic subtest: vecs0
[300.902222] Dynamic subtest vecs0: SUCCESS (1.982s)
[300.911472] Starting dynamic subtest: ccs0
[302.949534] Dynamic subtest ccs0: SUCCESS (2.046s)
[302.950676] Subtest busy: SUCCESS (8.046s)
[303.298776] [057/133] (721s left) kms_chamelium_frames (dp-crc-multiple)
[303.672580] Subtest dp-crc-multiple: SKIP (0.000s)
[304.436882] [058/133] (720s left) gem_userptr_blits (nohangcheck)
[304.504713] Starting subtest: nohangcheck
[304.725586] Subtest nohangcheck: SUCCESS (0.219s)
[304.852228] [059/133] (720s left) kms_invalid_mode (bad-vtotal)
[304.933336] Starting subtest: bad-vtotal
[304.934285] Starting dynamic subtest: pipe-A-eDP-1
[305.236092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s)
[305.243137] Starting dynamic subtest: pipe-B-eDP-1
[305.244096] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[305.251629] Starting dynamic subtest: pipe-C-eDP-1
[305.252514] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[305.259529] Starting dynamic subtest: pipe-D-eDP-1
[305.260420] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[305.261249] Subtest bad-vtotal: SUCCESS (0.312s)
[306.089800] [060/133] (718s left) gem_partial_pwrite_pread (write-uncached)
[306.156952] Subtest write-uncached: SKIP (0.000s)
[306.218810] [061/133] (718s left) gem_mmap_gtt (bad-object)
[306.274308] Subtest bad-object: SKIP (0.000s)
[306.332124] [062/133] (718s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[306.422361] Starting subtest: psr-rgb565-draw-mmap-cpu
[313.271937] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.850s)
[313.381299] [063/133] (711s left) kms_big_fb (yf-tiled-addfb)
[313.495100] Starting subtest: yf-tiled-addfb
[313.496894] Subtest yf-tiled-addfb: SKIP (0.000s)
[313.610852] [064/133] (711s left) gem_exec_reloc (basic-write-read-active)
[313.660976] Subtest basic-write-read-active: SKIP (0.000s)
[313.724946] [065/133] (711s left) kms_lease (setcrtc-implicit-plane)
[313.819365] Starting subtest: setcrtc-implicit-plane
[313.820292] Starting dynamic subtest: pipe-A-eDP-1
[314.288329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s)
[314.299092] Starting dynamic subtest: pipe-B-eDP-1
[315.449273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s)
[315.456386] Starting dynamic subtest: pipe-C-eDP-1
[316.551682] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.101s)
[316.559125] Starting dynamic subtest: pipe-D-eDP-1
[317.674025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[317.674893] Subtest setcrtc-implicit-plane: SUCCESS (3.855s)
[318.516899] [066/133] (706s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[318.610693] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[319.611387] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.001s)
[319.732343] [067/133] (705s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[319.832026] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[319.833449] Starting dynamic subtest: pipe-A-eDP-1
[319.843123] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.854441] Starting dynamic subtest: pipe-B-eDP-1
[319.863922] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.872185] Starting dynamic subtest: pipe-C-eDP-1
[319.880656] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.887836] Starting dynamic subtest: pipe-D-eDP-1
[319.896569] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.898270] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[322.090044] [068/133] (703s left) kms_chamelium_audio (hdmi-audio-edid)
[322.457070] Subtest hdmi-audio-edid: SKIP (0.000s)
[323.311391] [069/133] (701s left) vgem_basic (sysfs)
[323.354258] Starting subtest: sysfs
[323.355254] Subtest sysfs: SUCCESS (0.000s)
[323.408549] [070/133] (701s left) kms_vrr (negative-basic)
[323.487452] Starting subtest: negative-basic
[323.490284] Starting dynamic subtest: pipe-A-eDP-1
[328.956024] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.419s)
[329.215740] Subtest negative-basic: SUCCESS (5.728s)
[330.054840] [071/133] (695s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[330.146346] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[330.148032] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[331.267568] [072/133] (694s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[331.361573] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[331.373481] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[331.467533] [073/133] (693s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[331.549713] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[331.551872] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[331.623738] [074/133] (693s left) gem_exec_whisper (basic-forked)
[331.687416] Starting subtest: basic-forked
[339.711175] Subtest basic-forked: SUCCESS (8.022s)
[339.894642] [075/133] (685s left) gem_exec_reloc (basic-write-read-noreloc)
[339.967191] Subtest basic-write-read-noreloc: SKIP (0.000s)
[340.036252] [076/133] (685s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[340.123079] Starting subtest: multiplane-rotation-cropping-top
[357.517227] Subtest multiplane-rotation-cropping-top: SUCCESS (17.394s)
[357.618698] [077/133] (667s left) gen3_mixed_blits
[357.730824] [078/133] (667s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[357.840311] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[364.632758] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.792s)
[364.775731] [079/133] (660s left) kms_hdmi_inject (inject-audio)
[365.115973] Starting subtest: inject-audio
[365.394527] Subtest inject-audio: SUCCESS (0.280s)
[366.022360] [080/133] (659s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[366.105030] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[366.106718] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[366.198169] [081/133] (659s left) gem_mmap_gtt (hang-user)
[366.245818] Subtest hang-user: SKIP (0.000s)
[366.302288] [082/133] (659s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[366.356077] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[366.461201] [083/133] (659s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[366.542513] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[366.543372] Starting dynamic subtest: pipe-A
[366.562138] Dynamic subtest pipe-A: SKIP (0.018s)
[366.575659] Starting dynamic subtest: pipe-B
[366.598656] Dynamic subtest pipe-B: SKIP (0.035s)
[366.610444] Starting dynamic subtest: pipe-C
[366.631939] Dynamic subtest pipe-C: SKIP (0.033s)
[366.639417] Starting dynamic subtest: pipe-D
[366.669764] Dynamic subtest pipe-D: SKIP (0.037s)
[366.671187] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.127s)
[366.765480] [084/133] (659s left) kms_hdr (static-swap)
[366.859501] Starting subtest: static-swap
[366.861800] Subtest static-swap: SKIP (0.000s)
[366.933835] [085/133] (658s left) gem_exec_fence (syncobj-timeline-repeat)
[367.512964] Starting subtest: syncobj-timeline-repeat
[367.772394] Subtest syncobj-timeline-repeat: SUCCESS (0.259s)
[369.003822] [086/133] (656s left) gem_ctx_isolation (preservation-reset)
[369.184694] Starting subtest: preservation-reset
[369.185910] Starting dynamic subtest: rcs0
[369.478999] Dynamic subtest rcs0: SUCCESS (0.302s)
[369.490103] Starting dynamic subtest: bcs0
[369.837424] Dynamic subtest bcs0: SUCCESS (0.357s)
[369.846086] Starting dynamic subtest: vcs0
[370.175035] Dynamic subtest vcs0: SUCCESS (0.337s)
[370.183048] Starting dynamic subtest: vcs1
[372.260328] Dynamic subtest vcs1: SUCCESS (2.083s)
[372.274302] Starting dynamic subtest: vecs0
[374.213522] Dynamic subtest vecs0: SUCCESS (1.953s)
[374.222329] Starting dynamic subtest: ccs0
[376.210794] Dynamic subtest ccs0: SUCCESS (1.996s)
[376.212332] Subtest preservation-reset: SUCCESS (7.036s)
[376.344240] [087/133] (649s left) kms_async_flips (crc-atomic)
[376.443197] Starting subtest: crc-atomic
[376.825103] Starting dynamic subtest: pipe-A-eDP-1
[379.704971] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.880s)
[380.087857] Starting dynamic subtest: pipe-B-eDP-1
[382.979251] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.898s)
[383.379044] Starting dynamic subtest: pipe-C-eDP-1
[386.266411] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.895s)
[386.642599] Starting dynamic subtest: pipe-D-eDP-1
[389.571102] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.936s)
[389.571993] Subtest crc-atomic: SUCCESS (13.128s)
[390.787215] [088/133] (635s left) kms_cursor_legacy (forked-bo)
[390.906461] Starting subtest: forked-bo
[390.907316] Starting dynamic subtest: pipe-A
[396.416849] Dynamic subtest pipe-A: SUCCESS (5.464s)
[396.427856] Starting dynamic subtest: pipe-B
[401.897036] Dynamic subtest pipe-B: SUCCESS (5.477s)
[401.908488] Starting dynamic subtest: pipe-C
[407.380315] Dynamic subtest pipe-C: SUCCESS (5.480s)
[407.391380] Starting dynamic subtest: pipe-D
[412.859944] Dynamic subtest pipe-D: SUCCESS (5.478s)
[412.874220] Starting dynamic subtest: all-pipes
[418.370415] Dynamic subtest all-pipes: SUCCESS (5.507s)
[418.372057] Subtest forked-bo: SUCCESS (27.418s)
[418.471098] [089/133] (607s left) syncobj_eventfd (timeline-wait-signaled)
[418.537758] Starting subtest: timeline-wait-signaled
[418.538674] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[418.630223] [090/133] (607s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[418.723411] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[426.131586] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.409s)
[426.251121] [091/133] (599s left) syncobj_timeline (invalid-transfer-non-existent-point)
[426.297671] Starting subtest: invalid-transfer-non-existent-point
[426.298614] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[426.388794] [092/133] (599s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[426.526084] Starting subtest: cursorB-vs-flipA-atomic-transitions
[426.527710] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[426.665154] [093/133] (599s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[426.754044] Starting subtest: x-tiled-32bpp-rotate-90
[426.774387] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[426.888034] [094/133] (599s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[426.975763] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[427.003243] Starting dynamic subtest: pipe-A-plane-0
[427.669642] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s)
[427.678222] Starting dynamic subtest: pipe-A-plane-3
[428.092336] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[429.244020] Starting dynamic subtest: pipe-B-plane-0
[429.891673] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[429.900058] Starting dynamic subtest: pipe-B-plane-3
[430.336051] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[430.662234] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.687s)
[431.482069] [095/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[431.580699] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[431.582725] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[431.672928] [096/133] (594s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[431.715278] Starting subtest: single-wait-for-submit-available-signaled
[431.716084] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[431.836637] [097/133] (594s left) gem_exec_flush (basic-batch-kernel-default-uc)
[431.897702] Starting subtest: basic-batch-kernel-default-uc
[439.010719] Subtest basic-batch-kernel-default-uc: SUCCESS (7.113s)
[439.195332] [098/133] (587s left) gem_fence_thrash (bo-write-verify-threaded-y)
[439.228115] Starting subtest: bo-write-verify-threaded-y
[439.243489] Subtest bo-write-verify-threaded-y: SKIP (0.015s)
[439.300253] [099/133] (587s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[439.388616] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[439.390241] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[439.481355] [100/133] (586s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[439.571688] Starting subtest: psr2-cursor-plane-update-sf
[439.572596] Starting dynamic subtest: pipe-A-eDP-1
[440.143917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[440.152251] Starting dynamic subtest: pipe-B-eDP-1
[441.444188] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.298s)
[441.445252] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.873s)
[442.282311] [101/133] (584s left) kms_cursor_crc (cursor-random-256x85)
[442.540215] Starting subtest: cursor-random-256x85
[442.592835] Subtest cursor-random-256x85: SKIP (0.045s)
[442.749015] [102/133] (583s left) gem_mmap_offset (ptrace)
[442.793764] Starting subtest: ptrace
[442.795418] Starting dynamic subtest: smem0-wb
[442.810706] Dynamic subtest smem0-wb: SUCCESS (0.015s)
[442.820768] Starting dynamic subtest: smem0-wc
[442.832076] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[442.839722] Starting dynamic subtest: smem0-uc
[442.853058] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[442.853870] Subtest ptrace: SUCCESS (0.061s)
[442.963138] [103/133] (583s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[443.044438] Starting subtest: compare-crc-sanitycheck-xr24
[443.045341] Starting dynamic subtest: pipe-A-eDP-1
[443.701382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.655s)
[443.709681] Starting dynamic subtest: pipe-B-eDP-1
[444.950490] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.247s)
[444.961869] Starting dynamic subtest: pipe-C-eDP-1
[446.166302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[446.174421] Starting dynamic subtest: pipe-D-eDP-1
[447.401092] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[447.402077] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.357s)
[448.200444] [104/133] (578s left) kms_force_connector_basic (prune-stale-modes)
[448.273363] Starting subtest: prune-stale-modes
[448.715261] Subtest prune-stale-modes: SUCCESS (0.442s)
[448.847965] [105/133] (577s left) kms_psr (psr-cursor-plane-move)
[448.946225] Starting subtest: psr-cursor-plane-move
[448.947048] Starting dynamic subtest: eDP-1
[450.648672] Dynamic subtest eDP-1: SUCCESS (1.701s)
[450.649582] Subtest psr-cursor-plane-move: SUCCESS (1.702s)
[451.479790] [106/133] (575s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[451.578258] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[451.580273] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[451.672219] [107/133] (574s left) kms_big_fb (linear-8bpp-rotate-270)
[451.767459] Starting subtest: linear-8bpp-rotate-270
[451.790172] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[451.888949] [108/133] (574s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[451.943581] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[452.009426] [109/133] (574s left) gem_exec_schedule (fairslice-all)
[452.072981] Starting subtest: fairslice-all
[454.134229] Subtest fairslice-all: SUCCESS (2.061s)
[454.434389] [110/133] (572s left) kms_psr (pr-no-drrs)
[454.523929] Starting subtest: pr-no-drrs
[454.525505] Subtest pr-no-drrs: SKIP (0.000s)
[454.591270] [111/133] (572s left) gem_exec_reloc (basic-wc-gtt)
[454.640595] Subtest basic-wc-gtt: SKIP (0.000s)
[454.704686] [112/133] (572s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[454.792115] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[454.793838] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[454.873692] [113/133] (571s left) kms_dsc (dsc-with-bpc)
[454.978302] Starting subtest: dsc-with-bpc
[454.989489] Subtest dsc-with-bpc: SKIP (0.001s)
[455.058942] [114/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[455.152476] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[455.153948] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.239902] [115/133] (571s left) i915_module_load (reload-no-display)
[455.278049] Starting subtest: reload-no-display
[459.659515] Subtest reload-no-display: SUCCESS (4.374s)
[459.681633] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[459.682392] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[459.684155] [116/133] (567s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[461.234407] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[461.339667] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[461.386516] [FACT syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[461.387838] [FACT syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)] new: kernel.kmod_is_loaded.i915: true
[461.391288] [117/133] (565s left) dmabuf (all-tests)
[461.429032] Starting subtest: all-tests
[461.429980] Starting dynamic subtest: sanitycheck
[461.514942] Dynamic subtest sanitycheck: SUCCESS (0.085s)
[461.527438] Starting dynamic subtest: dma_fence
[461.734195] Dynamic subtest dma_fence: SUCCESS (0.217s)
[461.746903] Starting dynamic subtest: dma_fence_chain
[471.770149] Dynamic subtest dma_fence_chain: SUCCESS (10.024s)
[471.779183] Starting dynamic subtest: dma_fence_unwrap
[471.831932] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s)
[471.843081] Starting dynamic subtest: dma_resv
[471.918635] Dynamic subtest dma_resv: SUCCESS (0.085s)
[471.919941] Subtest all-tests: SUCCESS (10.491s)
[472.019409] [118/133] (554s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[472.070600] Starting subtest: single-wait-all-for-submit-unsubmitted
[472.171936] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[472.244909] [119/133] (554s left) api_intel_allocator (simple-allocator)
[472.301889] Starting subtest: simple-allocator
[472.302871] Starting dynamic subtest: basic
[472.312389] Dynamic subtest basic: SUCCESS (0.011s)
[472.321404] Starting dynamic subtest: parallel-one
[472.504339] Dynamic subtest parallel-one: SUCCESS (0.182s)
[472.510910] Starting dynamic subtest: print
[472.511710] Dynamic subtest print: SUCCESS (0.000s)
[472.522358] Starting dynamic subtest: reuse
[472.523231] Dynamic subtest reuse: SUCCESS (0.000s)
[472.529865] Starting dynamic subtest: reserve
[472.530765] Dynamic subtest reserve: SUCCESS (0.000s)
[472.540303] Starting dynamic subtest: fork-reopen-allocator
[472.541278] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[472.542252] Subtest simple-allocator: SUCCESS (0.213s)
[472.623228] [120/133] (554s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[472.723614] Starting subtest: yf-tiled-16bpp-rotate-180
[472.725209] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[472.801499] [121/133] (554s left) gem_exec_schedule (u-independent)
[472.853750] Starting subtest: u-independent
[472.854656] Starting dynamic subtest: rcs0
[474.915821] Dynamic subtest rcs0: SUCCESS (2.052s)
[474.924989] Starting dynamic subtest: vcs0
[476.914590] Dynamic subtest vcs0: SUCCESS (1.996s)
[476.924675] Starting dynamic subtest: vcs1
[478.958499] Dynamic subtest vcs1: SUCCESS (2.042s)
[478.968890] Starting dynamic subtest: vecs0
[480.929855] Dynamic subtest vecs0: SUCCESS (1.969s)
[480.939967] Starting dynamic subtest: ccs0
[482.914048] Dynamic subtest ccs0: SUCCESS (1.981s)
[482.915670] Subtest u-independent: SUCCESS (10.052s)
[483.205614] [122/133] (543s left) gem_exec_params (sol-reset-not-gen7)
[483.265572] Starting subtest: sol-reset-not-gen7
[483.272110] Subtest sol-reset-not-gen7: SUCCESS (0.006s)
[483.405542] [123/133] (543s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[483.454935] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[483.456953] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[483.634198] [124/133] (543s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[483.724694] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[490.794679] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.070s)
[490.894062] [125/133] (536s left) kms_cursor_crc (cursor-suspend)
[491.027023] Starting subtest: cursor-suspend
[491.028121] Starting dynamic subtest: pipe-A-eDP-1
[524.777643] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.059s)
[524.787278] Starting dynamic subtest: pipe-D-eDP-1
[559.816414] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.604s)
[559.817309] Subtest cursor-suspend: SUCCESS (8.666s)
[566.682078] [126/133] (466s left) gem_userptr_blits (sync-unmap-after-close)
[566.742129] Starting subtest: sync-unmap-after-close
[566.756556] Subtest sync-unmap-after-close: SUCCESS (0.014s)
[566.876500] [127/133] (466s left) kms_vblank (ts-continuation-modeset-rpm)
[566.963905] Starting subtest: ts-continuation-modeset-rpm
[566.964760] Starting dynamic subtest: pipe-A-eDP-1
[569.515599] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.548s)
[569.525080] Starting dynamic subtest: pipe-D-eDP-1
[571.759090] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s)
[571.760081] Subtest ts-continuation-modeset-rpm: SUCCESS (4.789s)
[572.548787] [128/133] (460s left) gem_userptr_blits (create-destroy-sync)
[572.614393] Starting subtest: create-destroy-sync
[577.676647] Subtest create-destroy-sync: SUCCESS (5.012s)
[577.744648] [129/133] (455s left) gem_sync (basic-many-each)
[577.815907] Starting subtest: basic-many-each
[580.122182] Subtest basic-many-each: SUCCESS (2.304s)
[580.305356] [130/133] (453s left) kms_psr (fbc-psr2-no-drrs)
[580.395795] Starting subtest: fbc-psr2-no-drrs
[580.396685] Starting dynamic subtest: eDP-1
[580.398533] Dynamic subtest eDP-1: SKIP (0.000s)
[580.400164] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[580.466338] [131/133] (453s left) kms_plane (plane-position-covered)
[580.548317] Starting subtest: plane-position-covered
[581.085226] Starting dynamic subtest: pipe-A-plane-1
[582.348360] Dynamic subtest pipe-A-plane-1: SUCCESS (1.262s)
[582.357348] Starting dynamic subtest: pipe-A-plane-2
[583.629993] Dynamic subtest pipe-A-plane-2: SUCCESS (1.280s)
[583.638439] Starting dynamic subtest: pipe-A-plane-3
[584.942695] Dynamic subtest pipe-A-plane-3: SUCCESS (1.312s)
[584.952550] Starting dynamic subtest: pipe-A-plane-4
[586.289472] Dynamic subtest pipe-A-plane-4: SUCCESS (1.346s)
[586.298243] Starting dynamic subtest: pipe-A-plane-5
[586.314938] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[587.531319] Starting dynamic subtest: pipe-B-plane-1
[588.858146] Dynamic subtest pipe-B-plane-1: SUCCESS (1.333s)
[588.866784] Starting dynamic subtest: pipe-B-plane-2
[590.204371] Dynamic subtest pipe-B-plane-2: SUCCESS (1.346s)
[590.215320] Starting dynamic subtest: pipe-B-plane-3
[591.511972] Dynamic subtest pipe-B-plane-3: SUCCESS (1.306s)
[591.520438] Starting dynamic subtest: pipe-B-plane-4
[592.756400] Dynamic subtest pipe-B-plane-4: SUCCESS (1.243s)
[592.765104] Starting dynamic subtest: pipe-B-plane-5
[592.780243] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[592.781051] Subtest plane-position-covered: SUCCESS (12.228s)
[593.632696] [132/133] (439s left) kms_psr (fbc-psr-sprite-render)
[593.737121] Starting subtest: fbc-psr-sprite-render
[593.738072] Starting dynamic subtest: eDP-1
[593.740353] Dynamic subtest eDP-1: SKIP (0.000s)
[593.742221] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[593.805992] [133/133] (439s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[593.892310] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[593.894024] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[593.983407] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: kms_pipe_b_c_ivb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: vgem_basic
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: kms_rotation_crc
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: kms_psr2_su
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: gem_fenced_exec_thrash
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: api_intel_bb
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: gem_softpin
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: kms_atomic_transition
results: parsing output: 49/ for test: i915_pm_rpm
results: parsing output: 50/ for test: kms_pm_dc
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: gem_busy
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_invalid_mode
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_vrr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: gen3_mixed_blits
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_hdmi_inject
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: gem_ctx_isolation
results: parsing output: 86/ for test: kms_async_flips
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: syncobj_eventfd
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_exec_flush
results: parsing output: 97/ for test: gem_fence_thrash
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: kms_pipe_crc_basic
results: parsing output: 103/ for test: kms_force_connector_basic
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_dsc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: i915_module_load
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: dmabuf
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: api_intel_allocator
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: gem_sync
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.