[89.481111] Initializing watchdogs
[89.481328]   /dev/watchdog0
[89.522422] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.537056] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.545285] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.551183] [001/133] (960s left) gem_userptr_blits (process-exit)
[89.707071] Starting subtest: process-exit
[89.731995] Subtest process-exit: SUCCESS (0.025s)
[89.917202] [002/133] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[90.092633] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[90.095998] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[90.775977] [003/133] (959s left) i915_pm_rps (waitboost)
[90.892709] Starting subtest: waitboost
[94.477458] Subtest waitboost: SUCCESS (3.578s)
[94.644596] [004/133] (955s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[94.825215] Starting subtest: flip-vs-cursor-crc-atomic
[95.743935] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.921s)
[96.033256] [005/133] (954s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[96.243092] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[99.022956] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.777s)
[99.315352] [006/133] (951s left) i915_pm_freq_api (freq-basic-api)
[99.426181] Subtest freq-basic-api: SKIP (0.000s)
[99.529671] [007/133] (951s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[99.629050] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[99.735765] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s)
[99.874261] [008/133] (950s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[100.056243] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[100.057801] Starting dynamic subtest: pipe-A-HDMI-A-1
[100.071827] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[100.101848] Starting dynamic subtest: pipe-A-HDMI-A-2
[100.117100] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[100.173256] Starting dynamic subtest: pipe-B-HDMI-A-1
[100.188607] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[100.205093] Starting dynamic subtest: pipe-B-HDMI-A-2
[100.221189] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[100.237048] Starting dynamic subtest: pipe-C-HDMI-A-1
[100.252316] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[100.269073] Starting dynamic subtest: pipe-C-HDMI-A-2
[100.283915] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[100.286917] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.018s)
[100.991805] [009/133] (949s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[101.182671] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[101.287175] [010/133] (949s left) kms_pm_rpm (modeset-non-lpsp-stress)
[103.209808] Starting subtest: modeset-non-lpsp-stress
[108.171092] Subtest modeset-non-lpsp-stress: SUCCESS (4.941s)
[108.462456] [011/133] (942s left) kms_cursor_crc (cursor-dpms)
[108.645560] Starting subtest: cursor-dpms
[108.649038] Starting dynamic subtest: pipe-A-HDMI-A-1
[110.425759] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.772s)
[110.466925] Starting dynamic subtest: pipe-C-HDMI-A-1
[111.858402] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.427s)
[111.860385] Subtest cursor-dpms: SUCCESS (3.210s)
[112.198336] [012/133] (938s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[112.413183] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[114.889981] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.477s)
[115.099589] [013/133] (935s left) kms_content_protection (uevent-hdcp14)
[115.286486] Starting subtest: uevent-hdcp14
[115.319729] Subtest uevent-hdcp14: SKIP (0.029s)
[115.480666] [014/133] (935s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[115.592453] Starting subtest: basic-gtt-wc-noreloc
[115.604028] Subtest basic-gtt-wc-noreloc: SUCCESS (0.012s)
[115.831511] [015/133] (935s left) perf_pmu (init-wait)
[115.943144] Starting subtest: init-wait
[115.944754] Starting dynamic subtest: rcs0
[115.947132] Dynamic subtest rcs0: SUCCESS (0.004s)
[115.967038] Starting dynamic subtest: bcs0
[115.968674] Dynamic subtest bcs0: SUCCESS (0.007s)
[115.985397] Starting dynamic subtest: vcs0
[115.987154] Dynamic subtest vcs0: SUCCESS (0.002s)
[116.007361] Starting dynamic subtest: vecs0
[116.009271] Dynamic subtest vecs0: SUCCESS (0.002s)
[116.011095] Subtest init-wait: SUCCESS (0.023s)
[116.115299] [016/133] (935s left) kms_addfb_basic (master-rmfb)
[116.220494] Starting subtest: master-rmfb
[116.225877] Subtest master-rmfb: SUCCESS (0.003s)
[116.467963] [017/133] (934s left) gem_userptr_blits (unsync-unmap-cycles)
[116.581596] Subtest unsync-unmap-cycles: SKIP (0.000s)
[116.767304] [018/133] (934s left) gem_mmap_gtt (zero-extend)
[116.866976] Starting subtest: zero-extend
[116.868519] Subtest zero-extend: SUCCESS (0.000s)
[117.032267] [019/133] (934s left) perf (blocking-parameterized)
[117.253635] Starting subtest: blocking-parameterized
[137.294961] Subtest blocking-parameterized: SUCCESS (20.037s)
[137.389236] [020/133] (914s left) gem_exec_reloc (basic-wc-gtt-active)
[137.500459] Starting subtest: basic-wc-gtt-active
[137.640959] Subtest basic-wc-gtt-active: SUCCESS (0.141s)
[137.899397] [021/133] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[138.093172] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[138.096151] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[138.265628] [022/133] (913s left) kms_vblank (ts-continuation-idle-hang)
[138.449547] Starting subtest: ts-continuation-idle-hang
[138.453112] Starting dynamic subtest: pipe-A-HDMI-A-1
[145.860967] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.405s)
[145.913840] Starting dynamic subtest: pipe-A-HDMI-A-2
[152.828714] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.961s)
[152.854321] Starting dynamic subtest: pipe-C-HDMI-A-1
[159.840829] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.000s)
[159.860298] Starting dynamic subtest: pipe-C-HDMI-A-2
[166.828295] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.980s)
[166.830153] Subtest ts-continuation-idle-hang: SUCCESS (28.378s)
[167.122140] [023/133] (884s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[167.230873] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[167.234674] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.004s)
[167.390663] [024/133] (884s left) kms_psr (psr-cursor-render)
[167.570678] Subtest psr-cursor-render: SKIP (0.000s)
[167.669106] [025/133] (884s left) gem_tiled_blits (interruptible)
[168.507555] Starting subtest: interruptible
[211.764141] Subtest interruptible: SUCCESS (43.255s)
[211.939252] [026/133] (840s left) kms_tiled_display (basic-test-pattern)
[212.375303] Starting subtest: basic-test-pattern
[213.759651] Subtest basic-test-pattern: FAIL (1.001s)
[213.834056] [027/133] (838s left) gem_exec_params (dr1-dirt)
[213.951412] Starting subtest: DR1-dirt
[213.953556] Subtest DR1-dirt: SUCCESS (0.000s)
[214.111585] [028/133] (838s left) gem_eio (banned)
[214.257256] Starting subtest: banned
[214.430992] Subtest banned: SUCCESS (0.186s)
[214.646603] [029/133] (837s left) syncobj_timeline (wait-all-interrupted)
[214.766440] Starting subtest: wait-all-interrupted
[214.871437] Subtest wait-all-interrupted: SUCCESS (0.104s)
[215.012937] [030/133] (837s left) gem_lmem_swapping (heavy-random)
[215.126878] Subtest heavy-random: SKIP (0.000s)
[215.227440] [031/133] (837s left) kms_atomic (crtc-invalid-params-fence)
[215.355932] Starting subtest: crtc-invalid-params-fence
[215.357677] Starting dynamic subtest: pipe-A-HDMI-A-1
[216.002355] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.642s)
[216.051216] Subtest crtc-invalid-params-fence: SUCCESS (0.648s)
[216.290209] [032/133] (836s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[216.425681] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[216.640969] Starting dynamic subtest: pipe-A-plane-0
[216.644552] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[216.665053] Starting dynamic subtest: pipe-A-plane-1
[216.667884] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[216.687640] Starting dynamic subtest: pipe-A-plane-2
[216.691326] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[216.710184] Starting dynamic subtest: pipe-A-plane-3
[216.713861] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[216.732738] Starting dynamic subtest: pipe-A-plane-4
[216.735688] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[217.035655] Starting dynamic subtest: pipe-B-plane-0
[217.038418] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[217.079254] Starting dynamic subtest: pipe-B-plane-1
[217.088551] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[217.107759] Starting dynamic subtest: pipe-B-plane-2
[217.110925] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[217.130279] Starting dynamic subtest: pipe-B-plane-3
[217.133494] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[217.152145] Starting dynamic subtest: pipe-B-plane-4
[217.155479] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[217.262065] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.840s)
[217.567233] [033/133] (835s left) gem_exec_fence (nb-await)
[217.823769] Starting subtest: nb-await
[217.825292] Starting dynamic subtest: rcs0
[217.902703] Dynamic subtest rcs0: SUCCESS (0.076s)
[217.922497] Starting dynamic subtest: bcs0
[217.971887] Dynamic subtest bcs0: SUCCESS (0.069s)
[217.993819] Starting dynamic subtest: vcs0
[218.046483] Dynamic subtest vcs0: SUCCESS (0.068s)
[218.066518] Starting dynamic subtest: vecs0
[218.113148] Dynamic subtest vecs0: SUCCESS (0.065s)
[218.115050] Subtest nb-await: SUCCESS (0.289s)
[218.942441] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[218.947845] [034/133] (833s left) syncobj_timeline (reset-signaled)
[219.048210] Starting subtest: reset-signaled
[219.049764] Subtest reset-signaled: SUCCESS (0.002s)
[219.229598] [035/133] (833s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[219.355221] Starting subtest: writes-after-reads
[222.571636] Subtest writes-after-reads: SUCCESS (3.222s)
[222.732224] [036/133] (830s left) kms_invalid_mode (bad-vsync-start)
[222.886642] Starting subtest: bad-vsync-start
[222.891388] Starting dynamic subtest: pipe-A-HDMI-A-1
[223.288690] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.422s)
[223.334417] Starting dynamic subtest: pipe-A-HDMI-A-2
[223.336212] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.021s)
[223.399498] Starting dynamic subtest: pipe-B-HDMI-A-1
[223.441914] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[223.471252] Starting dynamic subtest: pipe-B-HDMI-A-2
[223.473073] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[223.493162] Starting dynamic subtest: pipe-C-HDMI-A-1
[223.494859] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[223.514772] Starting dynamic subtest: pipe-C-HDMI-A-2
[223.516346] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[223.518114] Subtest bad-vsync-start: SUCCESS (0.474s)
[223.662920] [037/133] (829s left) gem_mmap_gtt (basic-small-bo-tiledy)
[223.770057] Starting subtest: basic-small-bo-tiledY
[223.989862] Subtest basic-small-bo-tiledY: SUCCESS (0.221s)
[224.198445] [038/133] (828s left) kms_flip (flip-vs-fences-interruptible)
[224.499486] Starting subtest: flip-vs-fences-interruptible
[224.507286] Starting dynamic subtest: A-HDMI-A1
[230.242563] Dynamic subtest A-HDMI-A1: SUCCESS (5.736s)
[230.266666] Starting dynamic subtest: B-HDMI-A1
[235.698473] Dynamic subtest B-HDMI-A1: SUCCESS (5.451s)
[235.723614] Starting dynamic subtest: C-HDMI-A1
[241.101364] Dynamic subtest C-HDMI-A1: SUCCESS (5.397s)
[241.126241] Starting dynamic subtest: A-HDMI-A2
[246.482389] Dynamic subtest A-HDMI-A2: SUCCESS (5.374s)
[246.503458] Starting dynamic subtest: B-HDMI-A2
[251.861595] Dynamic subtest B-HDMI-A2: SUCCESS (5.367s)
[251.890897] Starting dynamic subtest: C-HDMI-A2
[257.314411] Dynamic subtest C-HDMI-A2: SUCCESS (5.457s)
[257.316022] Subtest flip-vs-fences-interruptible: SUCCESS (32.814s)
[257.845677] [039/133] (795s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[257.994370] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[257.997928] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[258.163226] [040/133] (795s left) kms_flip (dpms-off-confusion)
[258.299043] Starting subtest: dpms-off-confusion
[258.306654] Starting dynamic subtest: A-HDMI-A1
[263.954336] Dynamic subtest A-HDMI-A1: SUCCESS (5.647s)
[263.977485] Starting dynamic subtest: B-HDMI-A1
[269.338316] Dynamic subtest B-HDMI-A1: SUCCESS (5.377s)
[269.359293] Starting dynamic subtest: C-HDMI-A1
[274.708671] Dynamic subtest C-HDMI-A1: SUCCESS (5.365s)
[274.729345] Starting dynamic subtest: A-HDMI-A2
[280.094867] Dynamic subtest A-HDMI-A2: SUCCESS (5.382s)
[280.115751] Starting dynamic subtest: B-HDMI-A2
[285.477685] Dynamic subtest B-HDMI-A2: SUCCESS (5.379s)
[285.498256] Starting dynamic subtest: C-HDMI-A2
[290.858390] Dynamic subtest C-HDMI-A2: SUCCESS (5.374s)
[290.860100] Subtest dpms-off-confusion: SUCCESS (32.558s)
[291.388741] [041/133] (762s left) kms_plane_alpha_blend (coverage-7efc)
[291.520961] Starting subtest: coverage-7efc
[291.720187] Starting dynamic subtest: pipe-A-HDMI-A-1
[292.666135] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.944s)
[292.765672] Starting dynamic subtest: pipe-C-HDMI-A-1
[293.634325] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.896s)
[293.637765] Subtest coverage-7efc: SUCCESS (2.113s)
[293.982574] [042/133] (759s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[294.158810] Starting subtest: 4-tiled-64bpp-rotate-0
[294.162328] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[294.332629] [043/133] (759s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[294.479940] Starting subtest: cursor-tearing-framebuffer-change
[294.486649] Starting dynamic subtest: pipe-A-HDMI-A-1
[295.327634] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.840s)
[295.421461] Starting dynamic subtest: pipe-C-HDMI-A-1
[295.899294] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.562s)
[295.901247] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.417s)
[296.252797] [044/133] (757s left) kms_plane (pixel-format-yf-tiled-modifier)
[296.383103] Starting subtest: pixel-format-yf-tiled-modifier
[296.593736] Starting dynamic subtest: pipe-A-plane-0
[297.324745] Dynamic subtest pipe-A-plane-0: SUCCESS (0.732s)
[297.350695] Starting dynamic subtest: pipe-A-plane-1
[298.010695] Dynamic subtest pipe-A-plane-1: SUCCESS (0.680s)
[298.031867] Starting dynamic subtest: pipe-A-plane-2
[298.475125] Dynamic subtest pipe-A-plane-2: SUCCESS (0.463s)
[298.501641] Starting dynamic subtest: pipe-A-plane-3
[298.943848] Dynamic subtest pipe-A-plane-3: SUCCESS (0.463s)
[298.984186] Starting dynamic subtest: pipe-A-plane-4
[298.992101] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[299.314170] Starting dynamic subtest: pipe-B-plane-0
[299.963305] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[299.984795] Starting dynamic subtest: pipe-B-plane-1
[300.612170] Dynamic subtest pipe-B-plane-1: SUCCESS (0.646s)
[300.633482] Starting dynamic subtest: pipe-B-plane-2
[301.061191] Dynamic subtest pipe-B-plane-2: SUCCESS (0.447s)
[301.085325] Starting dynamic subtest: pipe-B-plane-3
[301.528492] Dynamic subtest pipe-B-plane-3: SUCCESS (0.463s)
[301.552314] Starting dynamic subtest: pipe-B-plane-4
[301.558023] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[301.761968] Subtest pixel-format-yf-tiled-modifier: SUCCESS (5.381s)
[302.092825] [045/133] (751s left) gem_exec_balancer (bonded-true-hang)
[302.338513] Starting subtest: bonded-true-hang
[306.412974] Subtest bonded-true-hang: SUCCESS (4.073s)
[306.579374] [046/133] (747s left) gem_mmap_gtt (basic-write-read-distinct)
[306.678460] Starting subtest: basic-write-read-distinct
[306.691983] Subtest basic-write-read-distinct: SUCCESS (0.010s)
[306.862380] [047/133] (747s left) kms_pm_lpsp (screens-disabled)
[307.996221] Starting subtest: screens-disabled
[307.999180] Subtest screens-disabled: SKIP (0.000s)
[308.181102] [048/133] (745s left) gem_ctx_persistence (engines-queued)
[308.317654] Starting subtest: engines-queued
[308.319432] Starting dynamic subtest: rcs0
[308.352311] Dynamic subtest rcs0: SUCCESS (0.031s)
[308.372370] Starting dynamic subtest: bcs0
[308.495640] Dynamic subtest bcs0: SUCCESS (0.139s)
[308.516651] Starting dynamic subtest: vcs0
[308.545080] Dynamic subtest vcs0: SUCCESS (0.048s)
[308.570152] Starting dynamic subtest: vecs0
[308.594413] Dynamic subtest vecs0: SUCCESS (0.046s)
[308.597354] Subtest engines-queued: SUCCESS (0.279s)
[308.781290] [049/133] (745s left) kms_psr (psr-no-drrs)
[308.923467] Subtest psr-no-drrs: SKIP (0.000s)
[309.040619] [050/133] (745s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[309.186768] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[312.150954] Subtest fbc-2p-primscrn-spr-indfb-onoff: SUCCESS (2.965s)
[312.397209] [051/133] (742s left) gem_exec_async (concurrent-writes)
[312.526130] Starting subtest: concurrent-writes
[312.528073] Starting dynamic subtest: rcs0
[312.544048] Dynamic subtest rcs0: SUCCESS (0.016s)
[312.565640] Starting dynamic subtest: bcs0
[312.567966] Dynamic subtest bcs0: SUCCESS (0.015s)
[312.589950] Starting dynamic subtest: vcs0
[312.592520] Dynamic subtest vcs0: SUCCESS (0.016s)
[312.615514] Starting dynamic subtest: vecs0
[312.618165] Dynamic subtest vecs0: SUCCESS (0.015s)
[312.620308] Subtest concurrent-writes: SUCCESS (0.080s)
[312.897287] [052/133] (741s left) gem_flink_basic (basic)
[312.998956] Starting subtest: basic
[313.000624] Subtest basic: SUCCESS (0.000s)
[313.173347] [053/133] (741s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[313.300250] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[313.365510] Starting dynamic subtest: pipe-A-valid-mode
[314.314814] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.003s)
[314.317873] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.008s)
[314.644241] [054/133] (740s left) kms_lease (possible-crtcs-filtering)
[314.785285] Starting subtest: possible-crtcs-filtering
[314.805832] Subtest possible-crtcs-filtering: SUCCESS (0.020s)
[315.080337] [055/133] (739s left) gem_exec_parallel (userptr)
[315.232381] Starting subtest: userptr
[315.236062] Starting dynamic subtest: rcs0
[318.751037] Dynamic subtest rcs0: SUCCESS (3.516s)
[318.775144] Starting dynamic subtest: bcs0
[322.869422] Dynamic subtest bcs0: SUCCESS (4.114s)
[322.890361] Starting dynamic subtest: vcs0
[326.103881] Dynamic subtest vcs0: SUCCESS (3.232s)
[326.128904] Starting dynamic subtest: vecs0
[329.300536] Dynamic subtest vecs0: SUCCESS (3.192s)
[329.303436] Subtest userptr: SUCCESS (14.069s)
[329.585791] [056/133] (725s left) gen7_exec_parse (cmd-crossing-page)
[329.695969] Subtest cmd-crossing-page: SKIP (0.000s)
[329.809152] [057/133] (725s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[329.950680] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[329.954133] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[330.110645] [058/133] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[330.254057] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[330.259920] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[330.443946] [059/133] (724s left) kms_rotation_crc (sprite-rotation-90)
[330.591628] Starting subtest: sprite-rotation-90
[345.333774] Subtest sprite-rotation-90: SUCCESS (14.745s)
[345.612624] [060/133] (709s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[345.763055] Starting subtest: x-tiled-16bpp-rotate-90
[346.070104] Subtest x-tiled-16bpp-rotate-90: SKIP (0.308s)
[346.345272] [061/133] (709s left) kms_chamelium_color (ctm-0-75)
[346.483624] Subtest ctm-0-75: SKIP (0.000s)
[346.592900] [062/133] (709s left) gem_pxp (reject-modify-context-protection-off-2)
[349.238436] Starting subtest: reject-modify-context-protection-off-2
[349.245793] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[349.412800] [063/133] (706s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[349.558308] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[349.562286] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[349.727752] [064/133] (706s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[349.850217] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[349.958021] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[350.130846] [065/133] (705s left) gen9_exec_parse (valid-registers)
[350.249627] Starting subtest: valid-registers
[350.411140] Subtest valid-registers: SUCCESS (0.160s)
[350.695227] [066/133] (705s left) gem_eio (in-flight-internal-immediate)
[350.826119] Starting subtest: in-flight-internal-immediate
[350.907706] Subtest in-flight-internal-immediate: SUCCESS (0.080s)
[351.113440] [067/133] (704s left) gem_tiled_pread_basic (basic)
[351.214668] Starting subtest: basic
[351.529073] Subtest basic: SUCCESS (0.312s)
[351.715852] [068/133] (704s left) kms_addfb_basic (unused-handle)
[351.816262] Starting subtest: unused-handle
[351.817742] Subtest unused-handle: SUCCESS (0.000s)
[352.044984] [069/133] (704s left) kms_psr (pr-primary-blt)
[352.180672] Subtest pr-primary-blt: SKIP (0.000s)
[352.290801] [070/133] (704s left) gem_exec_schedule (pi-ringfull)
[352.563980] Starting subtest: pi-ringfull
[352.566101] Starting dynamic subtest: rcs0
[352.640184] Dynamic subtest rcs0: SUCCESS (0.067s)
[352.662206] Starting dynamic subtest: bcs0
[352.698423] Dynamic subtest bcs0: SUCCESS (0.061s)
[352.722414] Starting dynamic subtest: vcs0
[352.750453] Dynamic subtest vcs0: SUCCESS (0.052s)
[352.774718] Starting dynamic subtest: vecs0
[352.803375] Dynamic subtest vecs0: SUCCESS (0.050s)
[352.805554] Subtest pi-ringfull: SUCCESS (0.242s)
[353.075732] [071/133] (703s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[353.191966] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[353.193496] Starting dynamic subtest: smem
[353.548689] Dynamic subtest smem: SUCCESS (0.354s)
[353.550466] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.358s)
[353.851567] [072/133] (702s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[353.956578] Starting subtest: multi-wait-for-submit-submitted-signaled
[353.958197] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[354.133191] [073/133] (702s left) gem_close_race (multigpu-basic-process)
[354.264164] Starting subtest: multigpu-basic-process
[354.267477] Subtest multigpu-basic-process: SKIP (0.000s)
[354.534891] [074/133] (702s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[354.694267] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[354.929593] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.228s)
[355.196061] [075/133] (701s left) gem_softpin (overlap)
[355.314481] Starting subtest: overlap
[357.791264] Subtest overlap: SUCCESS (2.475s)
[357.972133] [076/133] (699s left) perf_pmu (interrupts-sync)
[358.080324] Starting subtest: interrupts-sync
[359.203914] Subtest interrupts-sync: SUCCESS (1.121s)
[359.369630] [077/133] (697s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[359.512670] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[359.626764] [078/133] (697s left) kms_feature_discovery (dp-mst)
[359.770200] Starting subtest: dp-mst
[359.774691] Subtest dp-mst: SKIP (0.001s)
[359.947121] [079/133] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[360.096334] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[360.099646] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[360.279338] [080/133] (697s left) syncobj_timeline (etime-single-wait-all-submitted)
[360.391258] Starting subtest: etime-single-wait-all-submitted
[360.497417] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[360.666637] [081/133] (696s left) gem_ctx_persistence (legacy-engines-mixed-process)
[360.779050] Starting subtest: legacy-engines-mixed-process
[360.788115] Starting dynamic subtest: render
[361.193068] Dynamic subtest render: SUCCESS (0.411s)
[361.251112] Starting dynamic subtest: bsd
[361.611098] Dynamic subtest bsd: SUCCESS (0.404s)
[361.640679] Starting dynamic subtest: blt
[362.015109] Dynamic subtest blt: SUCCESS (0.392s)
[362.043899] Starting dynamic subtest: vebox
[362.407920] Dynamic subtest vebox: SUCCESS (0.387s)
[362.413518] Subtest legacy-engines-mixed-process: SUCCESS (1.633s)
[362.613201] [082/133] (694s left) kms_frontbuffer_tracking (psr-suspend)
[362.763196] Starting subtest: psr-suspend
[362.766329] Subtest psr-suspend: SKIP (0.000s)
[362.946918] [083/133] (694s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[363.076931] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[363.129586] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[363.785901] [084/133] (693s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[364.321911] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[364.609245] [085/133] (693s left) gem_mmap_wc (bad-offset)
[364.719379] Starting subtest: bad-offset
[364.721016] Subtest bad-offset: SUCCESS (0.001s)
[364.885811] [086/133] (693s left) gem_exec_schedule (timeslicing)
[365.020643] Starting subtest: timeslicing
[365.022310] Starting dynamic subtest: rcs0
[365.028595] Dynamic subtest rcs0: SUCCESS (0.010s)
[365.057066] Starting dynamic subtest: bcs0
[365.058667] Dynamic subtest bcs0: SUCCESS (0.011s)
[365.081029] Starting dynamic subtest: vcs0
[365.083423] Dynamic subtest vcs0: SUCCESS (0.009s)
[365.114255] Starting dynamic subtest: vecs0
[365.116542] Dynamic subtest vecs0: SUCCESS (0.008s)
[365.119502] Subtest timeslicing: SUCCESS (0.057s)
[365.506586] [087/133] (692s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[365.708577] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[365.711868] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[365.888801] [088/133] (692s left) sysfs_heartbeat_interval (invalid)
[365.999072] Starting subtest: invalid
[366.005900] Starting dynamic subtest: vecs0
[366.007744] Dynamic subtest vecs0: SUCCESS (0.001s)
[366.031338] Starting dynamic subtest: vcs0
[366.032971] Dynamic subtest vcs0: SUCCESS (0.001s)
[366.055493] Starting dynamic subtest: bcs0
[366.057996] Dynamic subtest bcs0: SUCCESS (0.001s)
[366.099443] Starting dynamic subtest: rcs0
[366.101167] Dynamic subtest rcs0: SUCCESS (0.001s)
[366.103811] Subtest invalid: SUCCESS (0.018s)
[366.202656] [089/133] (692s left) kms_psr (fbc-pr-primary-blt)
[366.348654] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[366.463729] [090/133] (691s left) gem_exec_schedule (wide)
[366.724224] Starting subtest: wide
[366.725874] Starting dynamic subtest: rcs0
[386.382831] Dynamic subtest rcs0: SUCCESS (19.656s)
[386.441931] Starting dynamic subtest: bcs0
[406.943561] Dynamic subtest bcs0: SUCCESS (20.543s)
[407.035052] Starting dynamic subtest: vcs0
[427.552074] Dynamic subtest vcs0: SUCCESS (20.583s)
[427.602168] Starting dynamic subtest: vecs0
[447.563803] Dynamic subtest vecs0: SUCCESS (20.005s)
[447.568575] Subtest wide: SUCCESS (80.828s)
[448.545373] [091/133] (609s left) api_intel_bb (offset-control)
[448.652123] Starting subtest: offset-control
[448.665885] Subtest offset-control: SUCCESS (0.019s)
[448.846329] [092/133] (609s left) fbdev (info)
[448.943817] Starting subtest: info
[448.945787] Subtest info: SUCCESS (0.000s)
[449.109511] [093/133] (609s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[449.247824] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[449.255706] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[449.420383] [094/133] (609s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[449.928930] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[450.215983] [095/133] (608s left) gem_exec_reloc (basic-gtt)
[450.343466] Starting subtest: basic-gtt
[450.367556] Subtest basic-gtt: SUCCESS (0.021s)
[450.588994] [096/133] (608s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[450.755112] Starting subtest: y-tiled-8bpp-rotate-0
[453.953068] Subtest y-tiled-8bpp-rotate-0: SUCCESS (3.194s)
[454.292193] [097/133] (604s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[454.424328] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[454.426959] Starting dynamic subtest: pipe-A-HDMI-A-1
[454.448693] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[454.532418] Starting dynamic subtest: pipe-A-HDMI-A-2
[454.547494] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[454.583946] Starting dynamic subtest: pipe-B-HDMI-A-1
[454.598345] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[454.621497] Starting dynamic subtest: pipe-B-HDMI-A-2
[454.638418] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[454.662522] Starting dynamic subtest: pipe-C-HDMI-A-1
[454.677451] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[454.700051] Starting dynamic subtest: pipe-C-HDMI-A-2
[454.714815] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[454.717752] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.056s)
[455.466564] [098/133] (603s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[455.689439] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[455.693116] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[455.850631] [099/133] (603s left) kms_big_fb (linear-8bpp-rotate-270)
[456.010142] Starting subtest: linear-8bpp-rotate-270
[456.324719] Subtest linear-8bpp-rotate-270: SKIP (0.312s)
[456.583780] [100/133] (602s left) api_intel_bb (blit-reloc-keep-cache)
[456.690162] Starting subtest: blit-reloc-keep-cache
[456.710784] Subtest blit-reloc-keep-cache: SUCCESS (0.022s)
[456.901946] [101/133] (602s left) gem_tiled_partial_pwrite_pread (reads)
[457.011979] Starting subtest: reads
[458.263055] Subtest reads: SUCCESS (1.248s)
[458.451970] [102/133] (601s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[458.587631] Starting subtest: cursorA-vs-flipA-atomic
[469.857303] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.272s)
[470.184853] [103/133] (589s left) kms_busy (extended-modeset-hang-newfb)
[470.328110] Starting subtest: extended-modeset-hang-newfb
[470.331081] Starting dynamic subtest: pipe-A
[478.913045] Dynamic subtest pipe-A: SUCCESS (8.580s)
[478.965921] Starting dynamic subtest: pipe-C
[486.895140] Dynamic subtest pipe-C: SUCCESS (7.974s)
[486.899154] Subtest extended-modeset-hang-newfb: SUCCESS (16.572s)
[487.260042] [104/133] (572s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[487.369753] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[487.477792] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[487.644808] [105/133] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[487.795190] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[487.799304] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[487.974919] [106/133] (572s left) kms_color_pipeline (plane-ctm3x4)
[488.139506] Starting subtest: plane-ctm3x4
[489.288068] Subtest plane-ctm3x4: SKIP (1.174s)
[489.604803] [107/133] (570s left) kms_cursor_crc (cursor-random-512x170)
[489.778243] Starting subtest: cursor-random-512x170
[489.788390] Subtest cursor-random-512x170: SKIP (0.005s)
[489.955960] [108/133] (570s left) kms_plane_scaling (invalid-num-scalers)
[490.090649] Starting subtest: invalid-num-scalers
[490.135497] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[490.212666] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.078s)
[490.306177] Starting dynamic subtest: pipe-A-HDMI-A-2-invalid-num-scalers
[490.347295] Dynamic subtest pipe-A-HDMI-A-2-invalid-num-scalers: SUCCESS (0.090s)
[490.415859] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[490.449649] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.071s)
[490.504850] Starting dynamic subtest: pipe-B-HDMI-A-2-invalid-num-scalers
[490.552873] Dynamic subtest pipe-B-HDMI-A-2-invalid-num-scalers: SUCCESS (0.076s)
[490.622838] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[490.697801] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.115s)
[490.749755] Starting dynamic subtest: pipe-C-HDMI-A-2-invalid-num-scalers
[490.850454] Dynamic subtest pipe-C-HDMI-A-2-invalid-num-scalers: SUCCESS (0.120s)
[490.852213] Subtest invalid-num-scalers: SUCCESS (0.760s)
[491.072721] [109/133] (569s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[491.209693] Starting subtest: short-flip-after-cursor-atomic-transitions
[492.532349] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.324s)
[492.845657] [110/133] (567s left) gem_exec_params (invalid-bsd-ring)
[492.958785] Starting subtest: invalid-bsd-ring
[492.965430] Subtest invalid-bsd-ring: SUCCESS (0.004s)
[493.161817] [111/133] (567s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[493.325709] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[495.787923] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.461s)
[496.094588] [112/133] (564s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[496.251292] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[499.252167] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (2.998s)
[499.481502] [113/133] (561s left) dmabuf_sync_file (export-wait-after-attach)
[499.595734] Starting subtest: export-wait-after-attach
[499.597358] Subtest export-wait-after-attach: SUCCESS (0.003s)
[499.764808] [114/133] (561s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[499.894996] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[500.009181] [115/133] (560s left) gem_mmap_gtt (basic-copy)
[500.108554] Starting subtest: basic-copy
[500.883648] Subtest basic-copy: SUCCESS (0.776s)
[501.049370] [116/133] (559s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[501.174668] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[501.294754] [117/133] (559s left) drm_read (invalid-buffer)
[501.692495] Starting subtest: invalid-buffer
[501.694182] Subtest invalid-buffer: SUCCESS (0.000s)
[501.994144] [118/133] (559s left) kms_display_modes (extended-mode-basic)
[502.139126] Starting subtest: extended-mode-basic
[502.141179] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[503.079666] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.940s)
[503.108937] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2
[504.193680] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.105s)
[504.254204] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1
[505.461726] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.260s)
[505.546221] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1
[506.727727] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.235s)
[506.794243] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[507.830084] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.070s)
[507.858946] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2
[509.101839] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.264s)
[509.181226] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1
[510.385218] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.274s)
[510.442988] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1
[511.480920] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.087s)
[511.552125] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2
[512.748923] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.259s)
[512.830294] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2
[514.047538] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.290s)
[514.122419] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1
[515.218185] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.162s)
[515.274559] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1
[516.473679] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.248s)
[516.476096] Subtest extended-mode-basic: SUCCESS (14.341s)
[516.751247] [119/133] (544s left) prime_busy (hang)
[516.884885] Starting subtest: hang
[516.890042] Starting dynamic subtest: rcs0
[523.623801] Dynamic subtest rcs0: SUCCESS (6.733s)
[523.648219] Starting dynamic subtest: bcs0
[530.666921] Dynamic subtest bcs0: SUCCESS (7.037s)
[530.692025] Starting dynamic subtest: vcs0
[537.638434] Dynamic subtest vcs0: SUCCESS (6.973s)
[537.661622] Starting dynamic subtest: vecs0
[544.617869] Dynamic subtest vecs0: SUCCESS (6.975s)
[544.620506] Subtest hang: SUCCESS (27.733s)
[544.822559] [120/133] (516s left) i915_pm_rpm (gem-execbuf)
[546.651390] Starting subtest: gem-execbuf
[546.653604] Starting dynamic subtest: smem0
[548.060643] Dynamic subtest smem0: SUCCESS (1.404s)
[548.113785] Subtest gem-execbuf: SUCCESS (1.409s)
[548.438488] [121/133] (513s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[548.605399] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[551.409510] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.806s)
[551.640445] [122/133] (509s left) sw_sync (sync_busy_fork_unixsocket)
[551.741708] Starting subtest: sync_busy_fork_unixsocket
[551.770074] Subtest sync_busy_fork_unixsocket: SUCCESS (0.025s)
[551.915204] [123/133] (509s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[552.062252] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[552.065518] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[552.238768] [124/133] (509s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[552.371336] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[552.372837] Starting dynamic subtest: pipe-A
[552.710166] Dynamic subtest pipe-A: SUCCESS (0.336s)
[552.744919] Starting dynamic subtest: pipe-B
[553.125231] Dynamic subtest pipe-B: SUCCESS (0.412s)
[553.159399] Starting dynamic subtest: pipe-C
[553.210548] Dynamic subtest pipe-C: SUCCESS (0.080s)
[553.214311] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.837s)
[553.668649] [125/133] (508s left) gem_mmap_gtt (big-copy-xy)
[553.766417] Starting subtest: big-copy-XY
[564.467512] Subtest big-copy-XY: SUCCESS (10.693s)
[564.641271] [126/133] (497s left) prime_self_import (export-vs-gem_close-race)
[564.870820] Starting subtest: export-vs-gem_close-race
[569.891927] Subtest export-vs-gem_close-race: SUCCESS (5.016s)
[570.050301] [127/133] (492s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[570.227926] Starting subtest: yf-tiled-64bpp-rotate-90
[570.231881] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.001s)
[570.412750] [128/133] (491s left) gem_softpin (evict-prime)
[570.529740] Starting subtest: evict-prime
[570.531287] Starting dynamic subtest: rcs0
[571.642523] Dynamic subtest rcs0: SUCCESS (1.112s)
[571.684957] Starting dynamic subtest: bcs0
[572.767082] Dynamic subtest bcs0: SUCCESS (1.118s)
[572.811224] Starting dynamic subtest: vcs0
[573.891896] Dynamic subtest vcs0: SUCCESS (1.122s)
[573.926939] Starting dynamic subtest: vecs0
[575.013834] Dynamic subtest vecs0: SUCCESS (1.115s)
[575.076837] Starting dynamic subtest: all
[576.143558] Dynamic subtest all: SUCCESS (1.127s)
[576.148417] Subtest evict-prime: SUCCESS (5.616s)
[576.317295] [129/133] (485s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[576.451922] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[576.497857] Starting dynamic subtest: pipe-A-valid-mode
[577.069616] Dynamic subtest pipe-A-valid-mode: SKIP (0.614s)
[577.073801] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SKIP (0.619s)
[577.531062] [130/133] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[577.700193] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[577.704078] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[577.879408] [131/133] (484s left) gem_exec_fence (basic-await)
[578.134842] Starting subtest: basic-await
[578.136490] Starting dynamic subtest: rcs0
[578.254341] Dynamic subtest rcs0: SUCCESS (0.116s)
[578.277584] Starting dynamic subtest: bcs0
[578.366449] Dynamic subtest bcs0: SUCCESS (0.110s)
[578.394138] Starting dynamic subtest: vcs0
[578.495729] Dynamic subtest vcs0: SUCCESS (0.122s)
[578.519228] Starting dynamic subtest: vecs0
[578.615021] Dynamic subtest vecs0: SUCCESS (0.115s)
[578.617884] Subtest basic-await: SUCCESS (0.481s)
[579.333253] [132/133] (483s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[579.460134] Starting subtest: flip-vs-cursor-legacy
[597.288989] Subtest flip-vs-cursor-legacy: SUCCESS (17.826s)
[597.644824] [133/133] (465s left) gem_lmem_swapping (verify-random-ccs)
[597.780142] Subtest verify-random-ccs: SKIP (0.000s)
[597.888838] 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.