[63.565367] Initializing watchdogs
[63.565432]   /dev/watchdog0
[63.584646] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.595203] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.599234] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.601580] [001/130] (960s left) kms_flip (modeset-vs-vblank-race-interruptible)
[63.799540] Starting subtest: modeset-vs-vblank-race-interruptible
[63.803952] Starting dynamic subtest: A-DP3
[67.006943] Dynamic subtest A-DP3: SUCCESS (3.195s)
[67.016250] Starting dynamic subtest: B-DP3
[70.237613] Dynamic subtest B-DP3: SUCCESS (3.224s)
[70.270472] Starting dynamic subtest: C-DP3
[73.400623] Dynamic subtest C-DP3: SUCCESS (3.158s)
[73.435669] Starting dynamic subtest: D-DP3
[76.593189] Dynamic subtest D-DP3: SUCCESS (3.188s)
[76.600090] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.783s)
[76.958722] [002/130] (947s left) gem_readwrite (read-bad-handle)
[77.041970] Subtest read-bad-handle: SKIP (0.000s)
[77.122762] [003/130] (947s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[77.321062] Starting subtest: x-tiled-32bpp-rotate-270
[77.395326] Subtest x-tiled-32bpp-rotate-270: SKIP (0.073s)
[77.570423] [004/130] (946s left) kms_selftest (drm_damage_helper)
[77.616563] Starting subtest: drm_damage_helper
[77.623265] Starting dynamic subtest: drm_test_damage_iter_no_damage
[77.715727] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.090s)
[77.748231] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[77.805872] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.089s)
[77.838975] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[77.892049] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.085s)
[77.901190] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[77.993967] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.099s)
[78.003490] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[78.081615] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.085s)
[78.115204] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[78.176840] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.095s)
[78.211918] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[78.263936] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.085s)
[78.298655] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[78.371510] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.103s)
[78.403602] Starting dynamic subtest: drm_test_damage_iter_single_damage
[78.472668] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.099s)
[78.504751] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[78.573121] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.099s)
[78.605180] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[78.664479] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.089s)
[78.676823] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[78.759528] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.092s)
[78.768531] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[78.849032] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.090s)
[78.886883] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[78.959705] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.106s)
[78.988697] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[79.043824] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.084s)
[79.076919] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[79.144570] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.096s)
[79.177511] Starting dynamic subtest: drm_test_damage_iter_damage
[79.237835] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.091s)
[79.269772] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[79.338585] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.099s)
[79.371878] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[79.448525] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.107s)
[79.480176] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[79.548881] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.101s)
[79.556853] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[79.642244] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.092s)
[79.643851] Subtest drm_damage_helper: SUCCESS (2.024s)
[79.869191] [005/130] (944s left) kms_invalid_mode (clock-too-high)
[80.056148] Starting subtest: clock-too-high
[80.057074] Starting dynamic subtest: pipe-A-DP-3
[80.136184] Dynamic subtest pipe-A-DP-3: SUCCESS (0.079s)
[80.146628] Starting dynamic subtest: pipe-B-DP-3
[80.148910] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[80.159472] Starting dynamic subtest: pipe-C-DP-3
[80.161458] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[80.171535] Starting dynamic subtest: pipe-D-DP-3
[80.173423] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[80.174388] Subtest clock-too-high: SUCCESS (0.088s)
[80.374115] [006/130] (944s left) gem_create (create-size-update)
[80.443177] Starting subtest: create-size-update
[80.444172] Subtest create-size-update: SUCCESS (0.000s)
[80.714317] [007/130] (943s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[80.978837] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[81.129088] [008/130] (943s left) kms_addfb_basic (bad-pitch-65536)
[81.199346] Starting subtest: bad-pitch-65536
[81.200240] Subtest bad-pitch-65536: SUCCESS (0.000s)
[81.466608] [009/130] (943s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[81.662549] Starting subtest: modeset-atomic-cursor-hotspot
[81.664423] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[81.761480] [010/130] (942s left) kms_chamelium_frames (dp-crc-single)
[82.039197] Subtest dp-crc-single: SKIP (0.000s)
[82.186501] [011/130] (942s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[82.262486] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[82.364450] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[82.509299] [012/130] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[82.698985] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[82.700631] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[82.845495] [013/130] (942s left) gen9_exec_parse (bb-start-param)
[82.930418] Subtest bb-start-param: SKIP (0.000s)
[82.988411] [014/130] (941s left) kms_addfb_basic (too-wide)
[83.175443] Starting subtest: too-wide
[83.176378] Subtest too-wide: SUCCESS (0.000s)
[83.296019] [015/130] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[83.486823] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[83.488430] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[83.617587] [016/130] (941s left) prime_mmap (test_forked_cpu_write)
[83.686053] Starting subtest: test_forked_cpu_write
[83.687034] Starting dynamic subtest: test_forked_cpu_write-smem
[83.694532] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[83.702427] Starting dynamic subtest: test_forked_cpu_write-lmem0
[83.703378] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.008s)
[83.704422] Subtest test_forked_cpu_write: SUCCESS (0.018s)
[83.810781] [017/130] (941s left) syncobj_wait (wait-all-snapshot)
[83.884430] Starting subtest: wait-all-snapshot
[83.967728] Subtest wait-all-snapshot: SUCCESS (0.082s)
[84.109092] [018/130] (941s left) kms_psr (fbc-pr-basic)
[84.297159] Subtest fbc-pr-basic: SKIP (0.000s)
[84.356508] [019/130] (940s left) syncobj_wait (invalid-reset-bad-pad)
[84.428262] Starting subtest: invalid-reset-bad-pad
[84.429202] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[84.567436] [020/130] (940s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[84.751387] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[84.752244] Starting dynamic subtest: pipe-A
[85.319380] Dynamic subtest pipe-A: SUCCESS (0.567s)
[85.335437] Starting dynamic subtest: pipe-B
[85.967973] Dynamic subtest pipe-B: SUCCESS (0.647s)
[85.985324] Starting dynamic subtest: pipe-C
[86.616770] Dynamic subtest pipe-C: SUCCESS (0.647s)
[86.634626] Starting dynamic subtest: pipe-D
[87.265832] Dynamic subtest pipe-D: SUCCESS (0.648s)
[87.266856] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.514s)
[87.593616] [021/130] (937s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[87.785875] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[87.866629] [022/130] (937s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[88.055395] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[88.056333] Starting dynamic subtest: pipe-A-DP-3
[88.064966] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[88.072642] Starting dynamic subtest: pipe-B-DP-3
[88.081055] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[88.088572] Starting dynamic subtest: pipe-C-DP-3
[88.097035] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[88.104496] Starting dynamic subtest: pipe-D-DP-3
[88.114030] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[88.116141] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[88.509593] [023/130] (937s left) kms_pm_rpm (modeset-non-lpsp)
[90.029480] Starting subtest: modeset-non-lpsp
[90.693284] Subtest modeset-non-lpsp: SUCCESS (0.661s)
[90.927869] [024/130] (934s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[91.007399] Subtest writes-after-reads: SKIP (0.000s)
[91.112683] [025/130] (934s left) kms_frontbuffer_tracking (psr-suspend)
[91.307157] Starting subtest: psr-suspend
[91.308885] Subtest psr-suspend: SKIP (0.000s)
[91.437348] [026/130] (934s left) kms_properties (get_properties-sanity-non-atomic)
[91.623396] Starting subtest: get_properties-sanity-non-atomic
[91.625533] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[91.724895] [027/130] (934s left) kms_cursor_crc (cursor-sliding-256x85)
[92.171441] Starting subtest: cursor-sliding-256x85
[92.172507] Starting dynamic subtest: pipe-A-DP-3
[96.521251] Dynamic subtest pipe-A-DP-3: SUCCESS (4.348s)
[96.570972] Starting dynamic subtest: pipe-D-DP-3
[100.937380] Dynamic subtest pipe-D-DP-3: SUCCESS (4.373s)
[100.938502] Subtest cursor-sliding-256x85: SUCCESS (8.768s)
[101.298513] [028/130] (924s left) i915_drm_fdinfo (memory-info-shared)
[101.360514] Starting subtest: memory-info-shared
[101.361456] Starting dynamic subtest: lmem0
[101.454551] Dynamic subtest lmem0: SUCCESS (0.093s)
[101.464511] Starting dynamic subtest: smem0
[101.498462] Dynamic subtest smem0: SUCCESS (0.043s)
[101.499473] Subtest memory-info-shared: SUCCESS (0.138s)
[101.627883] [029/130] (924s left) gem_render_copy (yf-tiled-to-vebox-linear)
[101.705504] Starting subtest: yf-tiled-to-vebox-linear
[101.707552] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[101.934238] [030/130] (924s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[102.326564] Starting subtest: parallel-dmabuf-import-out-fence
[104.630085] Subtest parallel-dmabuf-import-out-fence: SUCCESS (2.310s)
[104.776775] [031/130] (921s left) perf_pmu (faulting-read)
[104.839505] Starting subtest: faulting-read
[104.840451] Starting dynamic subtest: fixed
[104.841317] Dynamic subtest fixed: SUCCESS (0.001s)
[104.842219] Subtest faulting-read: SUCCESS (0.002s)
[104.989402] [032/130] (921s left) kms_rotation_crc (sprite-rotation-270)
[105.175455] Starting subtest: sprite-rotation-270
[105.177261] Subtest sprite-rotation-270: SKIP (0.001s)
[105.271656] [033/130] (920s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[105.468125] Starting subtest: y-tiled-16bpp-rotate-180
[105.469955] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[105.614457] [034/130] (920s left) gem_ctx_param (invalid-get-no-zeromap)
[105.686646] Starting subtest: invalid-get-no-zeromap
[105.688871] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[105.845847] [035/130] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[106.035995] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[106.037905] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[106.173779] [036/130] (920s left) kms_feature_discovery (psr2)
[106.362431] Starting subtest: psr2
[106.364221] Subtest psr2: SKIP (0.000s)
[106.451816] [037/130] (920s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[106.638436] Starting subtest: primary-y-tiled-reflect-x-0
[106.737729] Subtest primary-y-tiled-reflect-x-0: SKIP (0.098s)
[106.905019] [038/130] (919s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[107.098994] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[107.100787] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[107.242632] [039/130] (919s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[109.062281] Starting subtest: modeset-non-lpsp-stress-no-wait
[111.509466] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (2.448s)
[111.682867] [040/130] (915s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[111.894847] Starting subtest: extended-modeset-hang-newfb-with-reset
[111.897147] Starting dynamic subtest: pipe-A
[133.020646] Dynamic subtest pipe-A: SUCCESS (21.121s)
[133.035840] Starting dynamic subtest: pipe-D
[153.993366] Dynamic subtest pipe-D: SUCCESS (20.967s)
[153.994461] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (42.096s)
[154.269124] [041/130] (872s left) fbdev (eof)
[154.320065] Starting subtest: eof
[154.321073] Subtest eof: SUCCESS (0.000s)
[154.397749] [042/130] (872s left) gem_mmap (basic-small-bo)
[154.469429] Subtest basic-small-bo: SKIP (0.000s)
[154.542973] [043/130] (872s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[154.618608] Starting subtest: legacy-engines-hostile-preempt
[154.619493] Starting dynamic subtest: render
[154.714281] Dynamic subtest render: SUCCESS (0.095s)
[154.726273] Starting dynamic subtest: bsd1
[154.761809] Dynamic subtest bsd1: SUCCESS (0.046s)
[154.776866] Starting dynamic subtest: bsd2
[154.823679] Dynamic subtest bsd2: SUCCESS (0.058s)
[154.865842] Starting dynamic subtest: blt
[154.904992] Dynamic subtest blt: SUCCESS (0.076s)
[154.941191] Starting dynamic subtest: vebox
[154.980654] Dynamic subtest vebox: SUCCESS (0.072s)
[154.981950] Subtest legacy-engines-hostile-preempt: SUCCESS (0.363s)
[155.162044] [044/130] (871s left) kms_sequence (queue-idle)
[155.349532] Starting subtest: queue-idle
[155.352160] Starting dynamic subtest: pipe-A-DP-3
[157.742756] Dynamic subtest pipe-A-DP-3: SUCCESS (2.392s)
[157.754525] Starting dynamic subtest: pipe-B-DP-3
[160.042901] Dynamic subtest pipe-B-DP-3: SUCCESS (2.298s)
[160.054422] Starting dynamic subtest: pipe-C-DP-3
[162.331691] Dynamic subtest pipe-C-DP-3: SUCCESS (2.287s)
[162.344783] Starting dynamic subtest: pipe-D-DP-3
[164.627757] Dynamic subtest pipe-D-DP-3: SUCCESS (2.294s)
[164.628580] Subtest queue-idle: SUCCESS (9.279s)
[164.867393] [045/130] (862s left) kms_big_fb (x-tiled-addfb-size-overflow)
[165.064058] Starting subtest: x-tiled-addfb-size-overflow
[165.065029] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[165.227845] [046/130] (861s left) i915_pm_freq_api (freq-reset)
[165.307205] Starting subtest: freq-reset
[165.308303] Starting dynamic subtest: gt0
[165.746010] Dynamic subtest gt0: SUCCESS (0.437s)
[165.747330] Subtest freq-reset: SUCCESS (0.438s)
[165.833936] [047/130] (861s left) gem_exec_gttfill (engines)
[165.920760] Starting subtest: engines
[165.921740] Starting dynamic subtest: rcs0
[191.873798] Dynamic subtest rcs0: SUCCESS (25.952s)
[191.884223] Starting dynamic subtest: bcs0
[217.965380] Dynamic subtest bcs0: SUCCESS (26.089s)
[217.975789] Starting dynamic subtest: vcs0
[244.125230] Dynamic subtest vcs0: SUCCESS (26.157s)
[244.135610] Starting dynamic subtest: vcs1
[270.263561] Dynamic subtest vcs1: SUCCESS (26.136s)
[270.273823] Starting dynamic subtest: vecs0
[296.416501] Dynamic subtest vecs0: SUCCESS (26.152s)
[296.427370] Starting dynamic subtest: vecs1
[322.563861] Dynamic subtest vecs1: SUCCESS (26.146s)
[322.574187] Starting dynamic subtest: ccs0
[348.690102] Dynamic subtest ccs0: SUCCESS (26.124s)
[348.691448] Subtest engines: SUCCESS (182.764s)
[348.929017] [048/130] (678s left) kms_writeback (writeback-fb-id-xrgb2101010)
[349.164965] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[349.221628] [049/130] (678s left) core_getstats
[349.473425] [050/130] (677s left) gem_pwrite (basic-self)
[349.547339] Subtest basic-self: SKIP (0.000s)
[349.606387] [051/130] (677s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[349.803412] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[349.857414] [052/130] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[350.048969] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[350.050835] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[350.260241] [053/130] (677s left) gem_exec_schedule (smoketest)
[350.465852] Starting subtest: smoketest
[350.466814] Starting dynamic subtest: rcs0
[355.933834] Dynamic subtest rcs0: SUCCESS (5.462s)
[355.944567] Starting dynamic subtest: bcs0
[361.393873] Dynamic subtest bcs0: SUCCESS (5.458s)
[361.404938] Starting dynamic subtest: vcs0
[366.857180] Dynamic subtest vcs0: SUCCESS (5.463s)
[366.867806] Starting dynamic subtest: vcs1
[372.315425] Dynamic subtest vcs1: SUCCESS (5.456s)
[372.326289] Starting dynamic subtest: vecs0
[377.779188] Dynamic subtest vecs0: SUCCESS (5.462s)
[377.793116] Starting dynamic subtest: vecs1
[383.256687] Dynamic subtest vecs1: SUCCESS (5.478s)
[383.268183] Starting dynamic subtest: ccs0
[388.715402] Dynamic subtest ccs0: SUCCESS (5.456s)
[388.716432] Subtest smoketest: SUCCESS (38.242s)
[389.020302] [054/130] (638s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[389.204545] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[389.207171] Starting dynamic subtest: pipe-A-DP-3
[389.215939] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[389.227538] Starting dynamic subtest: pipe-B-DP-3
[389.236277] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[389.246744] Starting dynamic subtest: pipe-C-DP-3
[389.255051] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[389.265572] Starting dynamic subtest: pipe-D-DP-3
[389.275444] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[389.277567] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[389.658967] [055/130] (638s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[389.862190] Starting subtest: 4-tiled-16bpp-rotate-270
[389.918481] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.056s)
[390.089517] [056/130] (637s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[390.286898] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[391.569054] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.281s)
[391.738137] [057/130] (636s left) gem_exec_schedule (u-fairslice)
[391.821063] Starting subtest: u-fairslice
[391.822059] Starting dynamic subtest: rcs0
[393.873287] Dynamic subtest rcs0: SUCCESS (2.051s)
[393.884542] Starting dynamic subtest: bcs0
[395.893210] Dynamic subtest bcs0: SUCCESS (2.019s)
[395.904061] Starting dynamic subtest: vcs0
[397.914266] Dynamic subtest vcs0: SUCCESS (2.020s)
[397.924926] Starting dynamic subtest: vcs1
[399.934257] Dynamic subtest vcs1: SUCCESS (2.019s)
[399.945186] Starting dynamic subtest: vecs0
[401.956255] Dynamic subtest vecs0: SUCCESS (2.021s)
[401.967549] Starting dynamic subtest: vecs1
[403.976243] Dynamic subtest vecs1: SUCCESS (2.019s)
[403.987502] Starting dynamic subtest: ccs0
[405.998043] Dynamic subtest ccs0: SUCCESS (2.021s)
[405.998845] Subtest u-fairslice: SUCCESS (14.176s)
[406.368390] [058/130] (621s left) gem_mmap_gtt (cpuset-medium-copy)
[406.439291] Subtest cpuset-medium-copy: SKIP (0.000s)
[406.518416] [059/130] (621s left) perf_pmu (busy-start)
[406.582482] Starting subtest: busy-start
[406.583420] Starting dynamic subtest: rcs0
[409.160845] Dynamic subtest rcs0: SUCCESS (2.577s)
[409.175670] Starting dynamic subtest: bcs0
[411.711720] Dynamic subtest bcs0: SUCCESS (2.546s)
[411.726739] Starting dynamic subtest: vcs0
[414.262749] Dynamic subtest vcs0: SUCCESS (2.546s)
[414.277860] Starting dynamic subtest: vcs1
[416.812753] Dynamic subtest vcs1: SUCCESS (2.545s)
[416.827682] Starting dynamic subtest: vecs0
[419.363739] Dynamic subtest vecs0: SUCCESS (2.546s)
[419.378718] Starting dynamic subtest: vecs1
[421.914897] Dynamic subtest vecs1: SUCCESS (2.546s)
[421.929855] Starting dynamic subtest: ccs0
[424.465858] Dynamic subtest ccs0: SUCCESS (2.546s)
[424.470923] Subtest busy-start: SUCCESS (17.884s)
[424.614801] [060/130] (603s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[424.805293] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[424.807015] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[424.955422] [061/130] (603s left) syncobj_timeline (invalid-signal-illegal-point)
[425.025413] Starting subtest: invalid-signal-illegal-point
[425.026322] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[425.179953] [062/130] (602s left) kms_async_flips (crc)
[425.371612] Starting subtest: crc
[425.606488] Starting dynamic subtest: pipe-A-DP-3
[428.016584] Dynamic subtest pipe-A-DP-3: SUCCESS (2.410s)
[428.245636] Starting dynamic subtest: pipe-B-DP-3
[430.459602] Dynamic subtest pipe-B-DP-3: SUCCESS (2.226s)
[430.640108] Starting dynamic subtest: pipe-C-DP-3
[432.853559] Dynamic subtest pipe-C-DP-3: SUCCESS (2.223s)
[433.040511] Starting dynamic subtest: pipe-D-DP-3
[435.265394] Dynamic subtest pipe-D-DP-3: SUCCESS (2.238s)
[435.266424] Subtest crc: SUCCESS (9.894s)
[435.686198] [063/130] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[435.879127] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[435.880818] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[435.984202] [064/130] (592s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[436.182084] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[436.183896] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[436.313152] [065/130] (592s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[436.503433] Starting subtest: cursor-vs-flip-legacy
[467.232458] Subtest cursor-vs-flip-legacy: SUCCESS (30.728s)
[467.529220] [066/130] (560s left) kms_concurrent (multi-plane-atomic-lowres)
[467.720373] Starting subtest: multi-plane-atomic-lowres
[467.721251] Starting dynamic subtest: pipe-A-DP-3
[468.239240] Dynamic subtest pipe-A-DP-3: SUCCESS (0.517s)
[468.240155] Subtest multi-plane-atomic-lowres: SUCCESS (0.519s)
[468.533998] [067/130] (560s left) syncobj_timeline (wait-for-submit-snapshot)
[468.606430] Starting subtest: wait-for-submit-snapshot
[468.690270] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[468.828299] [068/130] (559s left) gem_mmap_offset (open-flood)
[468.900401] Starting subtest: open-flood
[490.385452] Subtest open-flood: SUCCESS (21.484s)
[490.525095] [069/130] (538s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[490.714165] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[490.779339] [070/130] (537s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[490.977035] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[493.307606] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.330s)
[493.495208] [071/130] (535s left) gem_partial_pwrite_pread (reads-uncached)
[493.572384] Subtest reads-uncached: SKIP (0.000s)
[493.656119] [072/130] (535s left) gem_exec_reloc (basic-wc-cpu)
[493.731450] Subtest basic-wc-cpu: SKIP (0.000s)
[493.824367] [073/130] (535s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[493.893379] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[493.894290] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[494.051441] [074/130] (534s left) gem_vm_create (execbuf)
[494.130409] Starting subtest: execbuf
[494.141052] Subtest execbuf: SUCCESS (0.011s)
[494.334355] [075/130] (534s left) gem_ringfill (legacy-basic)
[494.818594] Starting subtest: legacy-basic
[494.824186] Starting dynamic subtest: default
[494.940401] Dynamic subtest default: SUCCESS (0.120s)
[494.958863] Starting dynamic subtest: render
[494.981942] Dynamic subtest render: SUCCESS (0.040s)
[495.011199] Starting dynamic subtest: bsd
[495.027636] Dynamic subtest bsd: SUCCESS (0.044s)
[495.050576] Starting dynamic subtest: bsd1
[495.072800] Dynamic subtest bsd1: SUCCESS (0.043s)
[495.090809] Starting dynamic subtest: bsd2
[495.114555] Dynamic subtest bsd2: SUCCESS (0.040s)
[495.134244] Starting dynamic subtest: blt
[495.157587] Dynamic subtest blt: SUCCESS (0.041s)
[495.177297] Starting dynamic subtest: vebox
[495.201829] Dynamic subtest vebox: SUCCESS (0.042s)
[495.203093] Subtest legacy-basic: SUCCESS (0.385s)
[495.349844] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[495.352010] [076/130] (533s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[495.546562] Starting subtest: plane-all-transition-nonblocking-fencing
[495.548934] Starting dynamic subtest: pipe-A-DP-3
[499.307180] Dynamic subtest pipe-A-DP-3: SUCCESS (3.758s)
[499.431488] Starting dynamic subtest: pipe-B-DP-3
[503.385362] Dynamic subtest pipe-B-DP-3: SUCCESS (3.967s)
[503.491996] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.944s)
[503.750515] [077/130] (525s left) gem_exec_whisper (basic-fds-priority-all)
[503.840865] Starting subtest: basic-fds-priority-all
[526.807554] Subtest basic-fds-priority-all: SUCCESS (22.964s)
[527.068877] [078/130] (502s left) gem_ccs (block-multicopy-inplace)
[527.154353] Starting subtest: block-multicopy-inplace
[527.156824] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[527.201004] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.045s)
[527.212526] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[527.309347] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.107s)
[527.322410] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[527.324744] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[527.337765] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[527.429644] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.104s)
[527.442682] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[527.445219] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[527.458310] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[527.556634] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.110s)
[527.569836] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[527.572432] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[527.585434] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[527.685566] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.112s)
[527.686420] Subtest block-multicopy-inplace: SUCCESS (0.532s)
[527.870438] [079/130] (501s left) kms_getfb (getfb-handle-valid)
[528.066639] Starting subtest: getfb-handle-valid
[528.067551] Subtest getfb-handle-valid: SUCCESS (0.000s)
[528.213219] [080/130] (501s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[528.414252] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[528.416034] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[528.554532] [081/130] (501s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[528.748685] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[528.751245] Starting dynamic subtest: pipe-A-valid-mode
[528.839234] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[528.841140] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.090s)
[529.060908] [082/130] (500s left) sw_sync (alloc_fence_invalid_timeline)
[529.109762] Starting subtest: alloc_fence_invalid_timeline
[529.110597] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[529.184725] [083/130] (500s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[529.382141] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[529.384007] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[529.529562] [084/130] (500s left) gem_exec_fence (submit-chain)
[529.765097] Starting subtest: submit-chain
[529.827472] Subtest submit-chain: SUCCESS (0.063s)
[530.584300] [085/130] (499s left) kms_psr (pr-primary-mmap-gtt)
[530.777167] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[530.845401] [086/130] (499s left) gem_mmap_wc (invalid-flags)
[530.924286] Subtest invalid-flags: SKIP (0.000s)
[530.997620] [087/130] (499s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[531.198028] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[531.199912] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[531.367886] [088/130] (498s left) kms_psr (pr-cursor-mmap-gtt)
[531.565163] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[531.628082] [089/130] (498s left) api_intel_allocator (standalone)
[531.706524] Starting subtest: standalone
[531.749617] Subtest standalone: SUCCESS (0.043s)
[531.933142] [090/130] (498s left) kms_flip (plain-flip-fb-recreate)
[532.128938] Starting subtest: plain-flip-fb-recreate
[532.133571] Starting dynamic subtest: A-DP3
[540.267303] Dynamic subtest A-DP3: SUCCESS (8.133s)
[540.283012] Starting dynamic subtest: B-DP3
[548.322848] Dynamic subtest B-DP3: SUCCESS (8.050s)
[548.357559] Starting dynamic subtest: C-DP3
[556.386916] Dynamic subtest C-DP3: SUCCESS (8.058s)
[556.428039] Starting dynamic subtest: D-DP3
[564.473307] Dynamic subtest D-DP3: SUCCESS (8.080s)
[564.481090] Subtest plain-flip-fb-recreate: SUCCESS (32.352s)
[564.865385] [091/130] (465s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[565.066035] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[565.067878] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[565.207058] [092/130] (465s left) kms_plane_multiple (tiling-4)
[565.403500] Starting subtest: tiling-4
[565.405928] Starting dynamic subtest: pipe-A-DP-3
[566.546524] Dynamic subtest pipe-A-DP-3: SUCCESS (1.142s)
[566.562170] Starting dynamic subtest: pipe-B-DP-3
[567.607123] Dynamic subtest pipe-B-DP-3: SUCCESS (1.058s)
[567.619449] Starting dynamic subtest: pipe-C-DP-3
[568.765260] Dynamic subtest pipe-C-DP-3: SUCCESS (1.157s)
[568.778123] Starting dynamic subtest: pipe-D-DP-3
[569.828183] Dynamic subtest pipe-D-DP-3: SUCCESS (1.061s)
[569.829126] Subtest tiling-4: SUCCESS (4.425s)
[570.088569] [093/130] (460s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[570.284577] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[570.285435] Starting dynamic subtest: pipe-A
[570.400498] Dynamic subtest pipe-A: SUCCESS (0.115s)
[570.426620] Starting dynamic subtest: pipe-B
[570.616414] Dynamic subtest pipe-B: SUCCESS (0.214s)
[570.635503] Starting dynamic subtest: pipe-C
[570.832213] Dynamic subtest pipe-C: SUCCESS (0.214s)
[570.853054] Starting dynamic subtest: pipe-D
[571.047289] Dynamic subtest pipe-D: SUCCESS (0.213s)
[571.048414] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.763s)
[571.394538] [094/130] (459s left) gem_exec_suspend (basic-s4-devices)
[571.481828] Starting subtest: basic-S4-devices
[571.482796] Starting dynamic subtest: smem
[582.055116] Dynamic subtest smem: SUCCESS (10.573s)
[582.069156] Starting dynamic subtest: lmem0
[592.476653] Dynamic subtest lmem0: SUCCESS (10.421s)
[592.477714] Subtest basic-S4-devices: SUCCESS (20.995s)
[598.764561] [095/130] (437s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[598.961738] Starting subtest: fbc-dirtyfb-ioctl
[598.964440] Starting dynamic subtest: A-DP-3
[600.425512] Dynamic subtest A-DP-3: SUCCESS (1.462s)
[600.426600] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.464s)
[600.695872] [096/130] (436s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[600.892631] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[600.895121] Starting dynamic subtest: pipe-A-valid-mode
[602.696992] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.801s)
[602.698444] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.804s)
[602.969367] [097/130] (433s left) kms_cursor_crc (cursor-random-128x128)
[603.348152] Starting subtest: cursor-random-128x128
[603.353342] Starting dynamic subtest: pipe-A-DP-3
[607.886340] Dynamic subtest pipe-A-DP-3: SUCCESS (4.532s)
[607.936869] Starting dynamic subtest: pipe-D-DP-3
[612.449579] Dynamic subtest pipe-D-DP-3: SUCCESS (4.525s)
[612.450603] Subtest cursor-random-128x128: SUCCESS (9.101s)
[612.870349] [098/130] (424s left) prime_busy (hang)
[612.953171] Starting subtest: hang
[612.955427] Starting dynamic subtest: rcs0
[639.462921] Dynamic subtest rcs0: SUCCESS (26.506s)
[639.475747] Starting dynamic subtest: bcs0
[646.616182] Dynamic subtest bcs0: SUCCESS (7.152s)
[646.629136] Starting dynamic subtest: vcs0
[653.597050] Dynamic subtest vcs0: SUCCESS (6.980s)
[653.610196] Starting dynamic subtest: vcs1
[660.629696] Dynamic subtest vcs1: SUCCESS (7.033s)
[660.643112] Starting dynamic subtest: vecs0
[667.615418] Dynamic subtest vecs0: SUCCESS (6.982s)
[667.628677] Starting dynamic subtest: vecs1
[674.648175] Dynamic subtest vecs1: SUCCESS (7.032s)
[674.661528] Starting dynamic subtest: ccs0
[688.484745] Dynamic subtest ccs0: SUCCESS (13.837s)
[688.485675] Subtest hang: SUCCESS (75.531s)
[688.612137] [099/130] (348s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[688.813164] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[688.814937] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[688.951629] [100/130] (348s left) kms_lease (master-vs-lease)
[689.147533] Starting subtest: master-vs-lease
[689.150183] Subtest master-vs-lease: SUCCESS (0.002s)
[689.310424] [101/130] (347s left) kms_content_protection (type1)
[689.575392] Starting subtest: type1
[690.142278] Subtest type1: SKIP (0.564s)
[690.501633] [102/130] (346s left) i915_suspend (basic-s2idle-without-i915)
[690.550288] Starting subtest: basic-s2idle-without-i915
[709.350068] Subtest basic-s2idle-without-i915: SUCCESS (4.071s)
[709.480345] [103/130] (327s left) gem_partial_pwrite_pread (write-display)
[709.583165] Subtest write-display: SKIP (0.000s)
[709.692700] [104/130] (327s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[709.902764] Starting subtest: fbc-rgb565-draw-render
[712.667730] Subtest fbc-rgb565-draw-render: SUCCESS (2.707s)
[712.854028] [105/130] (324s left) kms_pipe_crc_basic (read-crc)
[713.054185] Starting subtest: read-crc
[713.056752] Starting dynamic subtest: pipe-A-DP-3
[713.773442] Dynamic subtest pipe-A-DP-3: SUCCESS (0.705s)
[713.800077] Starting dynamic subtest: pipe-B-DP-3
[714.382149] Dynamic subtest pipe-B-DP-3: SUCCESS (0.593s)
[714.398629] Starting dynamic subtest: pipe-C-DP-3
[714.980417] Dynamic subtest pipe-C-DP-3: SUCCESS (0.589s)
[714.997783] Starting dynamic subtest: pipe-D-DP-3
[715.584591] Dynamic subtest pipe-D-DP-3: SUCCESS (0.594s)
[715.585648] Subtest read-crc: SUCCESS (2.494s)
[715.869754] [106/130] (321s left) i915_query (engine-info-invalid)
[715.949062] Starting subtest: engine-info-invalid
[715.949965] Subtest engine-info-invalid: SUCCESS (0.000s)
[716.122521] [107/130] (321s left) gem_mmap_wc (read-write-distinct)
[716.203857] Subtest read-write-distinct: SKIP (0.000s)
[716.287268] [108/130] (321s left) prime_mmap (test_correct)
[716.370222] Starting subtest: test_correct
[716.371127] Starting dynamic subtest: test_correct-smem
[716.419904] Dynamic subtest test_correct-smem: SUCCESS (0.049s)
[716.432299] Starting dynamic subtest: test_correct-lmem0
[716.621913] Dynamic subtest test_correct-lmem0: SUCCESS (0.198s)
[716.622846] Subtest test_correct: SUCCESS (0.249s)
[716.731237] [109/130] (320s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[716.927229] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[716.929765] Starting dynamic subtest: pipe-A-DP-3
[716.951938] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[716.964134] Starting dynamic subtest: pipe-B-DP-3
[716.986981] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[716.999166] Starting dynamic subtest: pipe-C-DP-3
[717.026034] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[717.039104] Starting dynamic subtest: pipe-D-DP-3
[717.061963] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[717.063592] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.014s)
[717.381490] [110/130] (320s left) gem_exec_schedule (in-order)
[717.476392] Starting subtest: in-order
[717.477333] Starting dynamic subtest: rcs0
[717.769678] Dynamic subtest rcs0: SUCCESS (0.289s)
[717.782491] Starting dynamic subtest: bcs0
[717.977258] Dynamic subtest bcs0: SUCCESS (0.205s)
[717.990105] Starting dynamic subtest: vcs0
[718.192660] Dynamic subtest vcs0: SUCCESS (0.212s)
[718.205134] Starting dynamic subtest: vcs1
[718.406975] Dynamic subtest vcs1: SUCCESS (0.212s)
[718.419478] Starting dynamic subtest: vecs0
[718.621555] Dynamic subtest vecs0: SUCCESS (0.212s)
[718.634138] Starting dynamic subtest: vecs1
[718.836603] Dynamic subtest vecs1: SUCCESS (0.212s)
[718.849312] Starting dynamic subtest: ccs0
[719.051745] Dynamic subtest ccs0: SUCCESS (0.212s)
[719.052860] Subtest in-order: SUCCESS (1.562s)
[719.480343] [111/130] (318s left) prime_mmap (test_reprime)
[719.559014] Starting subtest: test_reprime
[719.559903] Starting dynamic subtest: test_reprime-smem
[719.607173] Dynamic subtest test_reprime-smem: SUCCESS (0.049s)
[719.621563] Starting dynamic subtest: test_reprime-lmem0
[719.810169] Dynamic subtest test_reprime-lmem0: SUCCESS (0.200s)
[719.811126] Subtest test_reprime: SUCCESS (0.251s)
[719.948219] [112/130] (317s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[720.145615] Starting subtest: short-flip-after-cursor-atomic-transitions
[721.222897] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.069s)
[721.514525] [113/130] (316s left) prime_vgem (basic-read)
[721.616831] Starting subtest: basic-read
[721.626014] Subtest basic-read: SKIP (0.009s)
[721.775240] [114/130] (316s left) kms_hdr (bpc-switch)
[721.969133] Starting subtest: bpc-switch
[725.384803] Starting dynamic subtest: pipe-A-DP-3
[726.488857] Dynamic subtest pipe-A-DP-3: SUCCESS (1.100s)
[726.490649] Subtest bpc-switch: SUCCESS (4.502s)
[726.849229] [115/130] (311s left) gem_mmap_gtt (medium-copy-xy)
[726.930942] Subtest medium-copy-XY: SKIP (0.000s)
[726.994761] [116/130] (311s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[727.187200] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[727.189737] Starting dynamic subtest: pipe-A-DP-3
[727.198423] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[727.210720] Starting dynamic subtest: pipe-B-DP-3
[727.219480] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[727.231557] Starting dynamic subtest: pipe-C-DP-3
[727.239921] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[727.252241] Starting dynamic subtest: pipe-D-DP-3
[727.263801] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[727.265709] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[727.658019] [117/130] (310s left) gem_vm_create (invalid-create)
[727.743102] Starting subtest: invalid-create
[727.747970] Subtest invalid-create: SUCCESS (0.005s)
[727.914000] [118/130] (310s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[728.110401] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[728.113823] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[728.203446] [119/130] (310s left) prime_self_import (reimport-vs-gem_close-race)
[728.252502] Starting subtest: reimport-vs-gem_close-race
[733.356833] Subtest reimport-vs-gem_close-race: SUCCESS (5.094s)
[733.463609] [120/130] (304s left) gem_exec_balancer (bonded-dual)
[733.582825] Starting subtest: bonded-dual
[733.584898] Subtest bonded-dual: SKIP (0.000s)
[733.997432] [121/130] (304s left) gem_mmap_wc (write-read)
[734.078018] Subtest write-read: SKIP (0.000s)
[734.170987] [122/130] (304s left) gem_lmem_evict (dontneed-evict-race)
[736.769584] Starting subtest: dontneed-evict-race
[738.883277] Subtest dontneed-evict-race: SUCCESS (2.112s)
[740.884262] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[740.886203] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[740.888616] [123/130] (297s left) api_intel_bb (render)
[742.424345] Starting subtest: render
[742.425133] Starting dynamic subtest: render-none-512
[742.493733] Dynamic subtest render-none-512: SUCCESS (0.069s)
[742.505739] Starting dynamic subtest: render-none-1024
[742.569060] Dynamic subtest render-none-1024: SUCCESS (0.074s)
[742.582817] Starting dynamic subtest: render-x-512
[742.590724] Dynamic subtest render-x-512: SUCCESS (0.021s)
[742.604125] Starting dynamic subtest: render-x-1024
[742.667987] Dynamic subtest render-x-1024: SUCCESS (0.076s)
[742.680076] Starting dynamic subtest: render-y-512
[742.688104] Dynamic subtest render-y-512: SUCCESS (0.019s)
[742.701570] Starting dynamic subtest: render-y-1024
[742.751652] Dynamic subtest render-y-1024: SUCCESS (0.062s)
[742.752635] Subtest render: SUCCESS (0.328s)
[742.877083] [FACT api_intel_bb (render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[742.879406] [FACT api_intel_bb (render)] new: kernel.kmod_is_loaded.i915: true
[742.882210] [124/130] (295s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[743.082701] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[743.084557] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[743.211311] [125/130] (295s left) gem_exec_reloc (basic-write-gtt-active)
[743.306966] Subtest basic-write-gtt-active: SKIP (0.000s)
[743.392700] [126/130] (295s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[743.470131] Starting subtest: etime-multi-wait-all-for-submit-submitted
[743.580670] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.109s)
[743.698458] [127/130] (295s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[743.897150] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[743.898921] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[744.214045] [128/130] (294s left) kms_properties (plane-properties-atomic)
[744.410075] Starting subtest: plane-properties-atomic
[744.412517] Starting dynamic subtest: pipe-A-DP-3
[744.941615] Dynamic subtest pipe-A-DP-3: SUCCESS (0.530s)
[744.961097] Starting dynamic subtest: pipe-B-DP-3
[745.475020] Dynamic subtest pipe-B-DP-3: SUCCESS (0.530s)
[745.492165] Starting dynamic subtest: pipe-C-DP-3
[746.002593] Dynamic subtest pipe-C-DP-3: SUCCESS (0.526s)
[746.021480] Starting dynamic subtest: pipe-D-DP-3
[746.511313] Dynamic subtest pipe-D-DP-3: SUCCESS (0.507s)
[746.512167] Subtest plane-properties-atomic: SUCCESS (2.102s)
[746.774542] [129/130] (292s left) vgem_basic (dmabuf-fence-before)
[746.837000] Starting subtest: dmabuf-fence-before
[746.837953] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[746.926064] [130/130] (292s left) kms_psr (psr-cursor-mmap-cpu)
[747.121766] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[747.203342] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_readwrite
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_selftest
results: parsing output: 4/ for test: kms_invalid_mode
results: parsing output: 5/ for test: gem_create
results: parsing output: 6/ for test: kms_chamelium_hpd
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_chamelium_frames
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: prime_mmap
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_pm_rpm
results: parsing output: 23/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_properties
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: perf_pmu
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_ctx_param
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_feature_discovery
results: parsing output: 36/ for test: kms_rotation_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_busy
results: parsing output: 40/ for test: fbdev
results: parsing output: 41/ for test: gem_mmap
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: kms_sequence
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: i915_pm_freq_api
results: parsing output: 46/ for test: gem_exec_gttfill
results: parsing output: 47/ for test: kms_writeback
results: parsing output: 48/ for test: core_getstats
results: parsing output: 49/ for test: gem_pwrite
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_concurrent
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_mmap_offset
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_partial_pwrite_pread
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_vm_create
results: parsing output: 74/ for test: gem_ringfill
results: parsing output: 75/ for test: kms_atomic_transition
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: gem_ccs
results: parsing output: 78/ for test: kms_getfb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: sw_sync
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_mmap_wc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: api_intel_allocator
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_plane_multiple
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: gem_exec_suspend
results: parsing output: 94/ for test: kms_dirtyfb
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: prime_busy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: i915_suspend
results: parsing output: 102/ for test: gem_partial_pwrite_pread
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: prime_mmap
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: prime_vgem
results: parsing output: 113/ for test: kms_hdr
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_vm_create
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: prime_self_import
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: gem_lmem_evict
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_properties
results: parsing output: 128/ for test: vgem_basic
results: parsing output: 129/ for test: kms_psr
Done.