[86.544412] Initializing watchdogs
[86.544678]   /dev/watchdog0
[86.585191] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[86.599529] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[86.605951] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.610882] [001/133] (960s left) gem_userptr_blits (process-exit)
[86.754175] Starting subtest: process-exit
[86.775248] Subtest process-exit: SUCCESS (0.024s)
[86.997611] [002/133] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[87.164829] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[87.166710] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[87.869814] [003/133] (959s left) i915_pm_rps (waitboost)
[88.074217] Starting subtest: waitboost
[91.641135] Subtest waitboost: SUCCESS (3.568s)
[91.840506] [004/133] (955s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[92.024188] Starting subtest: flip-vs-cursor-crc-atomic
[92.927512] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.921s)
[93.220912] [005/133] (954s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[93.401857] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[96.219992] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.817s)
[96.489195] [006/133] (951s left) i915_pm_freq_api (freq-basic-api)
[96.589619] Subtest freq-basic-api: SKIP (0.000s)
[96.683608] [007/133] (950s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[96.774372] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[96.885093] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.110s)
[97.038099] [008/133] (950s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[97.205820] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[97.206747] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.215202] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[97.285960] Starting dynamic subtest: pipe-A-HDMI-A-2
[97.295276] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[97.310992] Starting dynamic subtest: pipe-B-HDMI-A-1
[97.319825] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[97.335222] Starting dynamic subtest: pipe-B-HDMI-A-2
[97.343902] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[97.358891] Starting dynamic subtest: pipe-C-HDMI-A-1
[97.367596] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[97.382162] Starting dynamic subtest: pipe-C-HDMI-A-2
[97.391300] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[97.393024] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.019s)
[98.102300] [009/133] (949s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[98.270670] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[98.363536] [010/133] (949s left) kms_pm_rpm (modeset-non-lpsp-stress)
[100.235437] Starting subtest: modeset-non-lpsp-stress
[105.607671] Subtest modeset-non-lpsp-stress: SUCCESS (5.361s)
[105.896426] [011/133] (941s left) kms_cursor_crc (cursor-dpms)
[106.067283] Starting subtest: cursor-dpms
[106.068824] Starting dynamic subtest: pipe-A-HDMI-A-1
[107.735078] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.662s)
[107.751852] Starting dynamic subtest: pipe-C-HDMI-A-1
[109.053570] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.315s)
[109.057429] Subtest cursor-dpms: SUCCESS (2.986s)
[109.379410] [012/133] (938s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[109.557935] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[112.030423] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.473s)
[112.275819] [013/133] (935s left) kms_content_protection (uevent-hdcp14)
[112.471350] Starting subtest: uevent-hdcp14
[112.505130] Subtest uevent-hdcp14: SKIP (0.028s)
[112.661308] [014/133] (935s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[112.762239] Starting subtest: basic-gtt-wc-noreloc
[112.773367] Subtest basic-gtt-wc-noreloc: SUCCESS (0.010s)
[112.978456] [015/133] (935s left) perf_pmu (init-wait)
[113.080678] Starting subtest: init-wait
[113.081674] Starting dynamic subtest: rcs0
[113.082684] Dynamic subtest rcs0: SUCCESS (0.003s)
[113.099190] Starting dynamic subtest: bcs0
[113.100046] Dynamic subtest bcs0: SUCCESS (0.001s)
[113.114684] Starting dynamic subtest: vcs0
[113.115770] Dynamic subtest vcs0: SUCCESS (0.002s)
[113.130608] Starting dynamic subtest: vecs0
[113.131842] Dynamic subtest vecs0: SUCCESS (0.002s)
[113.133244] Subtest init-wait: SUCCESS (0.012s)
[113.256853] [016/133] (935s left) kms_addfb_basic (master-rmfb)
[113.353295] Starting subtest: master-rmfb
[113.354269] Subtest master-rmfb: SUCCESS (0.001s)
[113.579308] [017/133] (934s left) gem_userptr_blits (unsync-unmap-cycles)
[113.684690] Subtest unsync-unmap-cycles: SKIP (0.000s)
[113.903490] [018/133] (934s left) gem_mmap_gtt (zero-extend)
[113.993147] Starting subtest: zero-extend
[113.994133] Subtest zero-extend: SUCCESS (0.000s)
[114.166442] [019/133] (934s left) perf (blocking-parameterized)
[114.377159] Starting subtest: blocking-parameterized
[134.463336] Subtest blocking-parameterized: SUCCESS (20.082s)
[134.552739] [020/133] (914s left) gem_exec_reloc (basic-wc-gtt-active)
[134.657255] Starting subtest: basic-wc-gtt-active
[134.799366] Subtest basic-wc-gtt-active: SUCCESS (0.141s)
[135.027733] [021/133] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[135.205268] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[135.206960] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[135.344590] [022/133] (913s left) kms_vblank (ts-continuation-idle-hang)
[135.506865] Starting subtest: ts-continuation-idle-hang
[135.509808] Starting dynamic subtest: pipe-A-HDMI-A-1
[142.909594] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.400s)
[142.926477] Starting dynamic subtest: pipe-A-HDMI-A-2
[149.874921] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.963s)
[149.898770] Starting dynamic subtest: pipe-C-HDMI-A-1
[156.892568] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.008s)
[156.913339] Starting dynamic subtest: pipe-C-HDMI-A-2
[163.878448] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.982s)
[163.879362] Subtest ts-continuation-idle-hang: SUCCESS (28.374s)
[164.176639] [023/133] (884s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[164.272346] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[164.273279] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[164.430353] [024/133] (884s left) kms_psr (psr-cursor-render)
[164.599120] Subtest psr-cursor-render: SKIP (0.000s)
[164.688483] [025/133] (884s left) gem_tiled_blits (interruptible)
[165.322440] Starting subtest: interruptible
[208.873973] Subtest interruptible: SUCCESS (43.553s)
[209.070695] [026/133] (839s left) kms_tiled_display (basic-test-pattern)
[209.424948] Starting subtest: basic-test-pattern
[210.563979] Subtest basic-test-pattern: FAIL (0.929s)
[210.630574] [027/133] (838s left) gem_exec_params (dr1-dirt)
[210.735741] Starting subtest: DR1-dirt
[210.736802] Subtest DR1-dirt: SUCCESS (0.000s)
[210.903627] [028/133] (838s left) gem_eio (banned)
[211.014550] Starting subtest: banned
[211.157252] Subtest banned: SUCCESS (0.140s)
[211.371765] [029/133] (837s left) syncobj_timeline (wait-all-interrupted)
[211.469728] Starting subtest: wait-all-interrupted
[211.572991] Subtest wait-all-interrupted: SUCCESS (0.102s)
[211.726703] [030/133] (837s left) gem_lmem_swapping (heavy-random)
[211.825941] Subtest heavy-random: SKIP (0.000s)
[211.918450] [031/133] (837s left) kms_atomic (crtc-invalid-params-fence)
[212.029963] Starting subtest: crtc-invalid-params-fence
[212.033938] Starting dynamic subtest: pipe-A-HDMI-A-1
[212.612255] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.578s)
[212.616023] Subtest crtc-invalid-params-fence: SUCCESS (0.582s)
[212.906603] [032/133] (836s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[213.026896] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[213.251066] Starting dynamic subtest: pipe-A-plane-0
[213.252915] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[213.270037] Starting dynamic subtest: pipe-A-plane-1
[213.271824] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[213.289175] Starting dynamic subtest: pipe-A-plane-2
[213.290888] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[213.308704] Starting dynamic subtest: pipe-A-plane-3
[213.310468] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[213.327524] Starting dynamic subtest: pipe-A-plane-4
[213.329394] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[213.602564] Starting dynamic subtest: pipe-B-plane-0
[213.604390] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[213.621589] Starting dynamic subtest: pipe-B-plane-1
[213.623364] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[213.640363] Starting dynamic subtest: pipe-B-plane-2
[213.642155] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[213.659413] Starting dynamic subtest: pipe-B-plane-3
[213.661168] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[213.678236] Starting dynamic subtest: pipe-B-plane-4
[213.680067] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[213.783347] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.754s)
[214.072562] [033/133] (835s left) gem_exec_fence (nb-await)
[214.310324] Starting subtest: nb-await
[214.311584] Starting dynamic subtest: rcs0
[214.385256] Dynamic subtest rcs0: SUCCESS (0.074s)
[214.409898] Starting dynamic subtest: bcs0
[214.457397] Dynamic subtest bcs0: SUCCESS (0.069s)
[214.481455] Starting dynamic subtest: vcs0
[214.528895] Dynamic subtest vcs0: SUCCESS (0.069s)
[214.550974] Starting dynamic subtest: vecs0
[214.597066] Dynamic subtest vecs0: SUCCESS (0.066s)
[214.598803] Subtest nb-await: SUCCESS (0.288s)
[215.400431] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[215.404910] [034/133] (834s left) syncobj_timeline (reset-signaled)
[215.500286] Starting subtest: reset-signaled
[215.501314] Subtest reset-signaled: SUCCESS (0.001s)
[215.667492] [035/133] (834s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[215.770607] Starting subtest: writes-after-reads
[218.639909] Subtest writes-after-reads: SUCCESS (2.870s)
[218.819432] [036/133] (831s left) kms_invalid_mode (bad-vsync-start)
[218.932787] Starting subtest: bad-vsync-start
[218.937438] Starting dynamic subtest: pipe-A-HDMI-A-1
[219.313508] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.378s)
[219.334303] Starting dynamic subtest: pipe-A-HDMI-A-2
[219.335249] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[219.353873] Starting dynamic subtest: pipe-B-HDMI-A-1
[219.354803] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[219.373341] Starting dynamic subtest: pipe-B-HDMI-A-2
[219.374256] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[219.392943] Starting dynamic subtest: pipe-C-HDMI-A-1
[219.393983] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[219.414840] Starting dynamic subtest: pipe-C-HDMI-A-2
[219.415906] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.001s)
[219.416895] Subtest bad-vsync-start: SUCCESS (0.407s)
[219.651138] [037/133] (830s left) gem_mmap_gtt (basic-small-bo-tiledy)
[219.742217] Starting subtest: basic-small-bo-tiledY
[220.127850] Subtest basic-small-bo-tiledY: SUCCESS (0.385s)
[220.370148] [038/133] (829s left) kms_flip (flip-vs-fences-interruptible)
[220.615930] Starting subtest: flip-vs-fences-interruptible
[220.619348] Starting dynamic subtest: A-HDMI-A1
[226.397310] Dynamic subtest A-HDMI-A1: SUCCESS (5.778s)
[226.418881] Starting dynamic subtest: B-HDMI-A1
[231.909603] Dynamic subtest B-HDMI-A1: SUCCESS (5.510s)
[231.930329] Starting dynamic subtest: C-HDMI-A1
[237.370135] Dynamic subtest C-HDMI-A1: SUCCESS (5.459s)
[237.390502] Starting dynamic subtest: A-HDMI-A2
[242.983742] Dynamic subtest A-HDMI-A2: SUCCESS (5.610s)
[243.006095] Starting dynamic subtest: B-HDMI-A2
[248.346761] Dynamic subtest B-HDMI-A2: SUCCESS (5.360s)
[248.367359] Starting dynamic subtest: C-HDMI-A2
[253.841485] Dynamic subtest C-HDMI-A2: SUCCESS (5.493s)
[253.842460] Subtest flip-vs-fences-interruptible: SUCCESS (33.227s)
[254.353707] [039/133] (795s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[254.491688] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[254.493711] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[254.669836] [040/133] (795s left) kms_flip (dpms-off-confusion)
[254.785754] Starting subtest: dpms-off-confusion
[254.786730] Starting dynamic subtest: A-HDMI-A1
[260.403458] Dynamic subtest A-HDMI-A1: SUCCESS (5.616s)
[260.423707] Starting dynamic subtest: B-HDMI-A1
[265.783872] Dynamic subtest B-HDMI-A1: SUCCESS (5.376s)
[265.804638] Starting dynamic subtest: C-HDMI-A1
[271.157609] Dynamic subtest C-HDMI-A1: SUCCESS (5.371s)
[271.178423] Starting dynamic subtest: A-HDMI-A2
[276.552211] Dynamic subtest A-HDMI-A2: SUCCESS (5.390s)
[276.574621] Starting dynamic subtest: B-HDMI-A2
[281.928730] Dynamic subtest B-HDMI-A2: SUCCESS (5.373s)
[281.947411] Starting dynamic subtest: C-HDMI-A2
[287.305223] Dynamic subtest C-HDMI-A2: SUCCESS (5.374s)
[287.306247] Subtest dpms-off-confusion: SUCCESS (32.521s)
[287.770256] [041/133] (762s left) kms_plane_alpha_blend (coverage-7efc)
[287.899316] Starting subtest: coverage-7efc
[288.164740] Starting dynamic subtest: pipe-A-HDMI-A-1
[289.097918] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.933s)
[289.167103] Starting dynamic subtest: pipe-C-HDMI-A-1
[290.019330] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.869s)
[290.020241] Subtest coverage-7efc: SUCCESS (2.122s)
[290.367914] [042/133] (760s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[290.508655] Starting subtest: 4-tiled-64bpp-rotate-0
[290.510639] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[290.668651] [043/133] (759s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[290.786391] Starting subtest: cursor-tearing-framebuffer-change
[290.789524] Starting dynamic subtest: pipe-A-HDMI-A-1
[291.595479] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.804s)
[291.616781] Starting dynamic subtest: pipe-C-HDMI-A-1
[292.125718] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.524s)
[292.126756] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.338s)
[292.466727] [044/133] (758s left) kms_plane (pixel-format-yf-tiled-modifier)
[292.584378] Starting subtest: pixel-format-yf-tiled-modifier
[292.798311] Starting dynamic subtest: pipe-A-plane-0
[293.498159] Dynamic subtest pipe-A-plane-0: SUCCESS (0.699s)
[293.528727] Starting dynamic subtest: pipe-A-plane-1
[294.131466] Dynamic subtest pipe-A-plane-1: SUCCESS (0.630s)
[294.155137] Starting dynamic subtest: pipe-A-plane-2
[294.547960] Dynamic subtest pipe-A-plane-2: SUCCESS (0.413s)
[294.571461] Starting dynamic subtest: pipe-A-plane-3
[294.947984] Dynamic subtest pipe-A-plane-3: SUCCESS (0.397s)
[294.972538] Starting dynamic subtest: pipe-A-plane-4
[294.974513] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[295.302577] Starting dynamic subtest: pipe-B-plane-0
[295.901261] Dynamic subtest pipe-B-plane-0: SUCCESS (0.616s)
[295.922939] Starting dynamic subtest: pipe-B-plane-1
[296.518489] Dynamic subtest pipe-B-plane-1: SUCCESS (0.614s)
[296.552161] Starting dynamic subtest: pipe-B-plane-2
[296.935468] Dynamic subtest pipe-B-plane-2: SUCCESS (0.413s)
[296.957667] Starting dynamic subtest: pipe-B-plane-3
[297.368673] Dynamic subtest pipe-B-plane-3: SUCCESS (0.430s)
[297.391195] Starting dynamic subtest: pipe-B-plane-4
[297.393017] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[297.565792] Subtest pixel-format-yf-tiled-modifier: SUCCESS (4.980s)
[297.888372] [045/133] (752s left) gem_exec_balancer (bonded-true-hang)
[298.121823] Starting subtest: bonded-true-hang
[302.004690] Subtest bonded-true-hang: SUCCESS (3.885s)
[302.177626] [046/133] (748s left) gem_mmap_gtt (basic-write-read-distinct)
[302.271087] Starting subtest: basic-write-read-distinct
[302.298759] Subtest basic-write-read-distinct: SUCCESS (0.030s)
[302.489152] [047/133] (748s left) kms_pm_lpsp (screens-disabled)
[303.614676] Starting subtest: screens-disabled
[303.616924] Subtest screens-disabled: SKIP (0.000s)
[303.790665] [048/133] (747s left) gem_ctx_persistence (engines-queued)
[303.891841] Starting subtest: engines-queued
[303.892889] Starting dynamic subtest: rcs0
[303.954073] Dynamic subtest rcs0: SUCCESS (0.060s)
[303.976333] Starting dynamic subtest: bcs0
[304.086971] Dynamic subtest bcs0: SUCCESS (0.128s)
[304.108689] Starting dynamic subtest: vcs0
[304.155394] Dynamic subtest vcs0: SUCCESS (0.064s)
[304.177345] Starting dynamic subtest: vecs0
[304.220789] Dynamic subtest vecs0: SUCCESS (0.062s)
[304.224366] Subtest engines-queued: SUCCESS (0.331s)
[304.378352] [049/133] (746s left) kms_psr (psr-no-drrs)
[304.500189] Subtest psr-no-drrs: SKIP (0.000s)
[304.602296] [050/133] (746s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[304.732996] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[307.706599] Subtest fbc-2p-primscrn-spr-indfb-onoff: SUCCESS (2.973s)
[307.977314] [051/133] (743s left) gem_exec_async (concurrent-writes)
[308.091714] Starting subtest: concurrent-writes
[308.095022] Starting dynamic subtest: rcs0
[308.109481] Dynamic subtest rcs0: SUCCESS (0.016s)
[308.135752] Starting dynamic subtest: bcs0
[308.137212] Dynamic subtest bcs0: SUCCESS (0.013s)
[308.158959] Starting dynamic subtest: vcs0
[308.160960] Dynamic subtest vcs0: SUCCESS (0.013s)
[308.183368] Starting dynamic subtest: vecs0
[308.184964] Dynamic subtest vecs0: SUCCESS (0.012s)
[308.186112] Subtest concurrent-writes: SUCCESS (0.069s)
[308.482847] [052/133] (742s left) gem_flink_basic (basic)
[308.575820] Starting subtest: basic
[308.576877] Subtest basic: SUCCESS (0.000s)
[308.758421] [053/133] (742s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[308.875236] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[308.876223] Starting dynamic subtest: pipe-A-valid-mode
[309.801235] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.925s)
[309.802262] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.930s)
[310.126763] [054/133] (741s left) kms_lease (possible-crtcs-filtering)
[310.268074] Starting subtest: possible-crtcs-filtering
[310.269967] Subtest possible-crtcs-filtering: SUCCESS (0.008s)
[310.442612] [055/133] (741s left) gem_exec_parallel (userptr)
[310.558074] Starting subtest: userptr
[310.562098] Starting dynamic subtest: rcs0
[313.985743] Dynamic subtest rcs0: SUCCESS (3.426s)
[314.006952] Starting dynamic subtest: bcs0
[316.955997] Dynamic subtest bcs0: SUCCESS (2.967s)
[316.979614] Starting dynamic subtest: vcs0
[319.945953] Dynamic subtest vcs0: SUCCESS (2.987s)
[319.969145] Starting dynamic subtest: vecs0
[323.098362] Dynamic subtest vecs0: SUCCESS (3.149s)
[323.102413] Subtest userptr: SUCCESS (12.542s)
[323.379726] [056/133] (728s left) gen7_exec_parse (cmd-crossing-page)
[323.480187] Subtest cmd-crossing-page: SKIP (0.000s)
[323.587382] [057/133] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[323.715696] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[323.717546] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[323.889248] [058/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[324.018125] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[324.019996] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[324.189910] [059/133] (727s left) kms_rotation_crc (sprite-rotation-90)
[324.309552] Starting subtest: sprite-rotation-90
[339.598571] Subtest sprite-rotation-90: SUCCESS (15.292s)
[339.900758] [060/133] (712s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[340.036790] Starting subtest: x-tiled-16bpp-rotate-90
[340.331154] Subtest x-tiled-16bpp-rotate-90: SKIP (0.292s)
[340.581356] [061/133] (711s left) kms_chamelium_color (ctm-0-75)
[340.699786] Subtest ctm-0-75: SKIP (0.000s)
[340.808607] [062/133] (711s left) gem_pxp (reject-modify-context-protection-off-2)
[343.437902] Starting subtest: reject-modify-context-protection-off-2
[343.439754] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[343.603822] [063/133] (708s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[343.736573] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[343.738558] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[343.915444] [064/133] (708s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[344.018125] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[344.124966] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[344.283813] [065/133] (708s left) gen9_exec_parse (valid-registers)
[344.398874] Starting subtest: valid-registers
[344.541913] Subtest valid-registers: SUCCESS (0.143s)
[344.870150] [066/133] (707s left) gem_eio (in-flight-internal-immediate)
[344.983760] Starting subtest: in-flight-internal-immediate
[345.062092] Subtest in-flight-internal-immediate: SUCCESS (0.077s)
[345.263666] [067/133] (707s left) gem_tiled_pread_basic (basic)
[345.356372] Starting subtest: basic
[345.661662] Subtest basic: SUCCESS (0.306s)
[345.833116] [068/133] (706s left) kms_addfb_basic (unused-handle)
[345.926472] Starting subtest: unused-handle
[345.927554] Subtest unused-handle: SUCCESS (0.000s)
[346.131691] [069/133] (706s left) kms_psr (pr-primary-blt)
[346.246632] Subtest pr-primary-blt: SKIP (0.000s)
[346.345458] [070/133] (706s left) gem_exec_schedule (pi-ringfull)
[346.592447] Starting subtest: pi-ringfull
[346.593391] Starting dynamic subtest: rcs0
[346.667646] Dynamic subtest rcs0: SUCCESS (0.069s)
[346.697884] Starting dynamic subtest: bcs0
[346.751746] Dynamic subtest bcs0: SUCCESS (0.062s)
[346.770895] Starting dynamic subtest: vcs0
[346.804267] Dynamic subtest vcs0: SUCCESS (0.052s)
[346.823685] Starting dynamic subtest: vecs0
[346.836558] Dynamic subtest vecs0: SUCCESS (0.051s)
[346.837868] Subtest pi-ringfull: SUCCESS (0.245s)
[347.085414] [071/133] (705s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[347.193450] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[347.194339] Starting dynamic subtest: smem
[347.559498] Dynamic subtest smem: SUCCESS (0.367s)
[347.562929] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.370s)
[347.834636] [072/133] (705s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[347.927899] Starting subtest: multi-wait-for-submit-submitted-signaled
[347.929466] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[348.101800] [073/133] (705s left) gem_close_race (multigpu-basic-process)
[348.222369] Starting subtest: multigpu-basic-process
[348.224234] Subtest multigpu-basic-process: SKIP (0.000s)
[348.487480] [074/133] (704s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[348.623325] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[348.834924] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.211s)
[349.097947] [075/133] (704s left) gem_softpin (overlap)
[349.204279] Starting subtest: overlap
[351.463640] Subtest overlap: SUCCESS (2.260s)
[351.636542] [076/133] (701s left) perf_pmu (interrupts-sync)
[351.735461] Starting subtest: interrupts-sync
[352.867438] Subtest interrupts-sync: SUCCESS (1.132s)
[353.034425] [077/133] (700s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[353.145986] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[353.246697] [078/133] (700s left) kms_feature_discovery (dp-mst)
[353.363896] Starting subtest: dp-mst
[353.367194] Subtest dp-mst: SKIP (0.001s)
[353.531791] [079/133] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[353.665391] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[353.667940] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[353.832847] [080/133] (699s left) syncobj_timeline (etime-single-wait-all-submitted)
[353.926930] Starting subtest: etime-single-wait-all-submitted
[354.036972] Subtest etime-single-wait-all-submitted: SUCCESS (0.109s)
[354.193291] [081/133] (699s left) gem_ctx_persistence (legacy-engines-mixed-process)
[354.296706] Starting subtest: legacy-engines-mixed-process
[354.299570] Starting dynamic subtest: render
[354.726734] Dynamic subtest render: SUCCESS (0.428s)
[354.750091] Starting dynamic subtest: bsd
[355.123234] Dynamic subtest bsd: SUCCESS (0.393s)
[355.146891] Starting dynamic subtest: blt
[355.499733] Dynamic subtest blt: SUCCESS (0.372s)
[355.522804] Starting dynamic subtest: vebox
[355.894574] Dynamic subtest vebox: SUCCESS (0.391s)
[355.895653] Subtest legacy-engines-mixed-process: SUCCESS (1.600s)
[356.053735] [082/133] (697s left) kms_frontbuffer_tracking (psr-suspend)
[356.184222] Starting subtest: psr-suspend
[356.186074] Subtest psr-suspend: SKIP (0.000s)
[356.365931] [083/133] (697s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[356.483781] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[356.485621] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[357.122382] [084/133] (696s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[357.605501] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[357.845205] [085/133] (696s left) gem_mmap_wc (bad-offset)
[357.935649] Starting subtest: bad-offset
[357.936616] Subtest bad-offset: SUCCESS (0.001s)
[358.133816] [086/133] (696s left) gem_exec_schedule (timeslicing)
[358.256767] Starting subtest: timeslicing
[358.257726] Starting dynamic subtest: rcs0
[358.263925] Dynamic subtest rcs0: SUCCESS (0.009s)
[358.289383] Starting dynamic subtest: bcs0
[358.290324] Dynamic subtest bcs0: SUCCESS (0.008s)
[358.312184] Starting dynamic subtest: vcs0
[358.313424] Dynamic subtest vcs0: SUCCESS (0.007s)
[358.348817] Starting dynamic subtest: vecs0
[358.350586] Dynamic subtest vecs0: SUCCESS (0.005s)
[358.352088] Subtest timeslicing: SUCCESS (0.041s)
[358.714290] [087/133] (695s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[358.846706] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[358.848486] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[359.031462] [088/133] (695s left) sysfs_heartbeat_interval (invalid)
[359.131864] Starting subtest: invalid
[359.135272] Starting dynamic subtest: vecs0
[359.136235] Dynamic subtest vecs0: SUCCESS (0.001s)
[359.159549] Starting dynamic subtest: vcs0
[359.160902] Dynamic subtest vcs0: SUCCESS (0.001s)
[359.188439] Starting dynamic subtest: bcs0
[359.189797] Dynamic subtest bcs0: SUCCESS (0.001s)
[359.211343] Starting dynamic subtest: rcs0
[359.212703] Dynamic subtest rcs0: SUCCESS (0.001s)
[359.214060] Subtest invalid: SUCCESS (0.018s)
[359.298687] [089/133] (695s left) kms_psr (fbc-pr-primary-blt)
[359.416601] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[359.527354] [090/133] (695s left) gem_exec_schedule (wide)
[359.767337] Starting subtest: wide
[359.768403] Starting dynamic subtest: rcs0
[378.948901] Dynamic subtest rcs0: SUCCESS (19.173s)
[379.010489] Starting dynamic subtest: bcs0
[398.823876] Dynamic subtest bcs0: SUCCESS (19.870s)
[398.859046] Starting dynamic subtest: vcs0
[418.484033] Dynamic subtest vcs0: SUCCESS (19.648s)
[418.510775] Starting dynamic subtest: vecs0
[438.228969] Dynamic subtest vecs0: SUCCESS (19.748s)
[438.232629] Subtest wide: SUCCESS (78.459s)
[439.054123] [091/133] (615s left) api_intel_bb (offset-control)
[439.148022] Starting subtest: offset-control
[439.159992] Subtest offset-control: SUCCESS (0.014s)
[439.351315] [092/133] (615s left) fbdev (info)
[439.442498] Starting subtest: info
[439.443323] Subtest info: SUCCESS (0.000s)
[439.623924] [093/133] (615s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[439.753526] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[439.755581] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[439.932235] [094/133] (615s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[440.412174] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[440.651825] [095/133] (614s left) gem_exec_reloc (basic-gtt)
[440.753706] Starting subtest: basic-gtt
[440.772861] Subtest basic-gtt: SUCCESS (0.019s)
[440.939064] [096/133] (614s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[441.076079] Starting subtest: y-tiled-8bpp-rotate-0
[444.051273] Subtest y-tiled-8bpp-rotate-0: SUCCESS (2.976s)
[444.386360] [097/133] (610s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[444.504970] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[444.506148] Starting dynamic subtest: pipe-A-HDMI-A-1
[444.517582] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[444.597093] Starting dynamic subtest: pipe-A-HDMI-A-2
[444.605386] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[444.626738] Starting dynamic subtest: pipe-B-HDMI-A-1
[444.634426] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[444.654293] Starting dynamic subtest: pipe-B-HDMI-A-2
[444.662674] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[444.682932] Starting dynamic subtest: pipe-C-HDMI-A-1
[444.692520] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[444.713030] Starting dynamic subtest: pipe-C-HDMI-A-2
[444.721690] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[444.723516] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.033s)
[445.428567] [098/133] (609s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[445.555539] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[445.557356] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[445.745493] [099/133] (609s left) kms_big_fb (linear-8bpp-rotate-270)
[445.884528] Starting subtest: linear-8bpp-rotate-270
[446.159792] Subtest linear-8bpp-rotate-270: SKIP (0.275s)
[446.427670] [100/133] (609s left) api_intel_bb (blit-reloc-keep-cache)
[446.519351] Starting subtest: blit-reloc-keep-cache
[446.534503] Subtest blit-reloc-keep-cache: SUCCESS (0.016s)
[446.729252] [101/133] (608s left) gem_tiled_partial_pwrite_pread (reads)
[446.831069] Starting subtest: reads
[447.976945] Subtest reads: SUCCESS (1.146s)
[448.180901] [102/133] (607s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[448.301930] Starting subtest: cursorA-vs-flipA-atomic
[459.559980] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.257s)
[459.858514] [103/133] (595s left) kms_busy (extended-modeset-hang-newfb)
[459.990360] Starting subtest: extended-modeset-hang-newfb
[459.991372] Starting dynamic subtest: pipe-A
[467.958327] Dynamic subtest pipe-A: SUCCESS (7.966s)
[467.987366] Starting dynamic subtest: pipe-C
[475.944890] Dynamic subtest pipe-C: SUCCESS (7.976s)
[475.945885] Subtest extended-modeset-hang-newfb: SUCCESS (15.957s)
[476.285313] [104/133] (579s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[476.379602] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[476.484940] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[476.637517] [105/133] (579s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[476.767633] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[476.769392] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[476.968634] [106/133] (579s left) kms_color_pipeline (plane-ctm3x4)
[477.084296] Starting subtest: plane-ctm3x4
[478.099620] Subtest plane-ctm3x4: SKIP (1.012s)
[478.377643] [107/133] (577s left) kms_cursor_crc (cursor-random-512x170)
[478.517382] Starting subtest: cursor-random-512x170
[478.519252] Subtest cursor-random-512x170: SKIP (0.003s)
[478.711345] [108/133] (577s left) kms_plane_scaling (invalid-num-scalers)
[478.825904] Starting subtest: invalid-num-scalers
[478.849980] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[478.912188] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.060s)
[478.960589] Starting dynamic subtest: pipe-A-HDMI-A-2-invalid-num-scalers
[479.004226] Dynamic subtest pipe-A-HDMI-A-2-invalid-num-scalers: SUCCESS (0.063s)
[479.050835] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[479.093561] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.062s)
[479.146092] Starting dynamic subtest: pipe-B-HDMI-A-2-invalid-num-scalers
[479.182592] Dynamic subtest pipe-B-HDMI-A-2-invalid-num-scalers: SUCCESS (0.060s)
[479.229218] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[479.311966] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.102s)
[479.358173] Starting dynamic subtest: pipe-C-HDMI-A-2-invalid-num-scalers
[479.440226] Dynamic subtest pipe-C-HDMI-A-2-invalid-num-scalers: SUCCESS (0.103s)
[479.445351] Subtest invalid-num-scalers: SUCCESS (0.618s)
[479.644755] [109/133] (576s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[479.760836] Starting subtest: short-flip-after-cursor-atomic-transitions
[481.108315] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.346s)
[481.413371] [110/133] (575s left) gem_exec_params (invalid-bsd-ring)
[481.515663] Starting subtest: invalid-bsd-ring
[481.519614] Subtest invalid-bsd-ring: SUCCESS (0.002s)
[481.712953] [111/133] (574s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[481.843253] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[484.281505] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.439s)
[484.597943] [112/133] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[484.731236] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[487.696213] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (2.964s)
[487.953115] [113/133] (568s left) dmabuf_sync_file (export-wait-after-attach)
[488.065636] Starting subtest: export-wait-after-attach
[488.066624] Subtest export-wait-after-attach: SUCCESS (0.002s)
[488.216668] [114/133] (568s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[488.334748] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[488.442528] [115/133] (568s left) gem_mmap_gtt (basic-copy)
[488.534897] Starting subtest: basic-copy
[489.368219] Subtest basic-copy: SUCCESS (0.835s)
[489.585379] [116/133] (567s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[489.701964] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[489.809112] [117/133] (567s left) drm_read (invalid-buffer)
[490.164763] Starting subtest: invalid-buffer
[490.165846] Subtest invalid-buffer: SUCCESS (0.000s)
[490.463610] [118/133] (566s left) kms_display_modes (extended-mode-basic)
[490.579208] Starting subtest: extended-mode-basic
[490.583335] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[491.612649] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.027s)
[491.636082] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2
[492.788934] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.170s)
[492.837066] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1
[493.829170] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.034s)
[493.852598] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1
[495.028974] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.195s)
[495.052748] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[496.244165] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.210s)
[496.267945] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2
[497.308941] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.058s)
[497.356799] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1
[498.517088] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.202s)
[498.540566] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1
[499.692606] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.171s)
[499.741030] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2
[500.820939] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.122s)
[500.868726] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2
[502.028114] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.202s)
[502.078599] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1
[503.236170] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.202s)
[503.259801] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1
[504.349159] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.106s)
[504.350052] Subtest extended-mode-basic: SUCCESS (13.770s)
[504.592325] [119/133] (552s left) prime_busy (hang)
[504.717239] Starting subtest: hang
[504.720374] Starting dynamic subtest: rcs0
[511.720012] Dynamic subtest rcs0: SUCCESS (6.998s)
[511.741339] Starting dynamic subtest: bcs0
[518.695119] Dynamic subtest bcs0: SUCCESS (6.972s)
[518.715940] Starting dynamic subtest: vcs0
[525.671073] Dynamic subtest vcs0: SUCCESS (6.973s)
[525.695822] Starting dynamic subtest: vecs0
[532.710754] Dynamic subtest vecs0: SUCCESS (7.037s)
[532.711869] Subtest hang: SUCCESS (27.994s)
[532.880400] [120/133] (524s left) i915_pm_rpm (gem-execbuf)
[534.540358] Starting subtest: gem-execbuf
[534.543861] Starting dynamic subtest: smem0
[535.837659] Dynamic subtest smem0: SUCCESS (1.295s)
[535.840043] Subtest gem-execbuf: SUCCESS (1.300s)
[536.179962] [121/133] (521s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[536.321816] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[539.128103] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.804s)
[539.368908] [122/133] (518s left) sw_sync (sync_busy_fork_unixsocket)
[539.463204] Starting subtest: sync_busy_fork_unixsocket
[539.484183] Subtest sync_busy_fork_unixsocket: SUCCESS (0.022s)
[539.616518] [123/133] (518s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[539.747707] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[539.749613] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[539.912720] [124/133] (517s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[540.029873] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[540.030835] Starting dynamic subtest: pipe-A
[540.341762] Dynamic subtest pipe-A: SUCCESS (0.314s)
[540.365465] Starting dynamic subtest: pipe-B
[540.716946] Dynamic subtest pipe-B: SUCCESS (0.373s)
[540.744547] Starting dynamic subtest: pipe-C
[540.771288] Dynamic subtest pipe-C: SUCCESS (0.049s)
[540.773470] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.743s)
[541.228453] [125/133] (516s left) gem_mmap_gtt (big-copy-xy)
[541.319499] Starting subtest: big-copy-XY
[551.808336] Subtest big-copy-XY: SUCCESS (10.468s)
[552.001153] [126/133] (505s left) prime_self_import (export-vs-gem_close-race)
[552.171304] Starting subtest: export-vs-gem_close-race
[557.204056] Subtest export-vs-gem_close-race: SUCCESS (5.029s)
[557.367280] [127/133] (500s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[557.519290] Starting subtest: yf-tiled-64bpp-rotate-90
[557.521088] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.003s)
[557.678302] [128/133] (500s left) gem_softpin (evict-prime)
[557.780898] Starting subtest: evict-prime
[557.783318] Starting dynamic subtest: rcs0
[558.929787] Dynamic subtest rcs0: SUCCESS (1.147s)
[558.953902] Starting dynamic subtest: bcs0
[560.053397] Dynamic subtest bcs0: SUCCESS (1.120s)
[560.079267] Starting dynamic subtest: vcs0
[561.183687] Dynamic subtest vcs0: SUCCESS (1.126s)
[561.208137] Starting dynamic subtest: vecs0
[562.311227] Dynamic subtest vecs0: SUCCESS (1.123s)
[562.336198] Starting dynamic subtest: all
[563.444315] Dynamic subtest all: SUCCESS (1.129s)
[563.448968] Subtest evict-prime: SUCCESS (5.666s)
[563.598921] [129/133] (494s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[563.717917] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[563.722898] Starting dynamic subtest: pipe-A-valid-mode
[564.269499] Dynamic subtest pipe-A-valid-mode: SKIP (0.548s)
[564.271609] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SKIP (0.553s)
[564.732507] [130/133] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[564.861952] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[564.863865] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[565.048756] [131/133] (493s left) gem_exec_fence (basic-await)
[565.287088] Starting subtest: basic-await
[565.288132] Starting dynamic subtest: rcs0
[565.394324] Dynamic subtest rcs0: SUCCESS (0.107s)
[565.419094] Starting dynamic subtest: bcs0
[565.504903] Dynamic subtest bcs0: SUCCESS (0.106s)
[565.529254] Starting dynamic subtest: vcs0
[565.616362] Dynamic subtest vcs0: SUCCESS (0.107s)
[565.642387] Starting dynamic subtest: vecs0
[565.728431] Dynamic subtest vecs0: SUCCESS (0.108s)
[565.733254] Subtest basic-await: SUCCESS (0.446s)
[566.455944] [132/133] (491s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[566.576159] Starting subtest: flip-vs-cursor-legacy
[583.879021] Subtest flip-vs-cursor-legacy: SUCCESS (17.299s)
[584.162677] [133/133] (474s left) gem_lmem_swapping (verify-random-ccs)
[584.269894] Subtest verify-random-ccs: SKIP (0.000s)
[584.372627] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: i915_pm_rps
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_pm_freq_api
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_tiled_blits
results: parsing output: 25/ for test: kms_tiled_display
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_atomic
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 35/ for test: kms_invalid_mode
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_plane_alpha_blend
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_pm_lpsp
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_async
results: parsing output: 51/ for test: gem_flink_basic
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: gem_exec_parallel
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: gem_pxp
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: gem_tiled_pread_basic
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gem_close_race
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_feature_discovery
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_chamelium_hpd
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: sysfs_heartbeat_interval
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: api_intel_bb
results: parsing output: 91/ for test: fbdev
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_chamelium_edid
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_busy
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_color_pipeline
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: drm_read
results: parsing output: 117/ for test: kms_display_modes
results: parsing output: 118/ for test: prime_busy
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: prime_self_import
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_lmem_swapping
Done.