[91.419406] Initializing watchdogs [91.419574] /dev/watchdog0 [91.464778] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [91.479546] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [91.487061] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [91.495161] [001/134] (960s left) kms_frontbuffer_tracking (psr-2p-rte) [91.743952] Starting subtest: psr-2p-rte [91.750561] Subtest psr-2p-rte: SKIP (0.000s) [91.907513] [002/134] (960s left) kms_cursor_legacy (single-bo) [92.112315] Starting subtest: single-bo [92.115546] Starting dynamic subtest: pipe-A [97.517359] Dynamic subtest pipe-A: SUCCESS (5.402s) [97.542827] Starting dynamic subtest: pipe-B [102.919035] Dynamic subtest pipe-B: SUCCESS (5.404s) [102.936440] Starting dynamic subtest: pipe-C [108.328309] Dynamic subtest pipe-C: SUCCESS (5.407s) [108.433852] Starting dynamic subtest: all-pipes [113.734984] Dynamic subtest all-pipes: SUCCESS (5.404s) [113.742245] Subtest single-bo: SUCCESS (21.620s) [113.915592] [003/134] (938s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [114.112918] Starting subtest: cursorA-vs-flipA-legacy [125.442774] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.333s) [125.746646] [004/134] (926s left) kms_cursor_crc (cursor-alpha-transparent) [125.928096] Starting subtest: cursor-alpha-transparent [125.931509] Starting dynamic subtest: pipe-A-HDMI-A-1 [126.836109] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.902s) [126.853970] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.421994] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.584s) [127.425963] Subtest cursor-alpha-transparent: SUCCESS (1.494s) [127.739905] [005/134] (924s left) gem_exec_schedule (pi-common) [128.016267] Starting subtest: pi-common [128.019913] Starting dynamic subtest: rcs0 [128.139371] Dynamic subtest rcs0: SUCCESS (0.119s) [128.161191] Starting dynamic subtest: bcs0 [128.191913] Dynamic subtest bcs0: SUCCESS (0.050s) [128.212077] Starting dynamic subtest: vcs0 [128.236328] Dynamic subtest vcs0: SUCCESS (0.047s) [128.256024] Starting dynamic subtest: vecs0 [128.281836] Dynamic subtest vecs0: SUCCESS (0.046s) [128.285550] Subtest pi-common: SUCCESS (0.266s) [128.540590] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true [128.547345] [006/134] (923s left) kms_flip (absolute-wf_vblank) [128.728433] Starting subtest: absolute-wf_vblank [128.731885] Starting dynamic subtest: A-HDMI-A1 [134.367252] Dynamic subtest A-HDMI-A1: SUCCESS (5.637s) [134.386299] Starting dynamic subtest: B-HDMI-A1 [139.737408] Dynamic subtest B-HDMI-A1: SUCCESS (5.368s) [139.756676] Starting dynamic subtest: C-HDMI-A1 [145.110262] Dynamic subtest C-HDMI-A1: SUCCESS (5.370s) [145.129243] Starting dynamic subtest: A-HDMI-A2 [150.501346] Dynamic subtest A-HDMI-A2: SUCCESS (5.390s) [150.521911] Starting dynamic subtest: B-HDMI-A2 [155.870780] Dynamic subtest B-HDMI-A2: SUCCESS (5.370s) [155.896087] Starting dynamic subtest: C-HDMI-A2 [161.234284] Dynamic subtest C-HDMI-A2: SUCCESS (5.356s) [161.237851] Subtest absolute-wf_vblank: SUCCESS (32.508s) [161.736406] [007/134] (890s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [161.849345] Starting subtest: multi-wait-for-submit-submitted-signaled [161.852582] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.002s) [162.031989] [008/134] (890s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [162.148353] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [162.266816] [009/134] (890s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [162.470375] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [162.698152] Starting dynamic subtest: pipe-A-plane-0 [162.704613] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [162.726035] Starting dynamic subtest: pipe-A-plane-1 [162.732178] Dynamic subtest pipe-A-plane-1: SKIP (0.000s) [162.784605] Starting dynamic subtest: pipe-A-plane-2 [162.792130] Dynamic subtest pipe-A-plane-2: SKIP (0.000s) [162.811520] Starting dynamic subtest: pipe-A-plane-3 [162.820268] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [162.839076] Starting dynamic subtest: pipe-A-plane-4 [162.847050] Dynamic subtest pipe-A-plane-4: SKIP (0.000s) [163.110064] Starting dynamic subtest: pipe-B-plane-0 [163.116332] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [163.175568] Starting dynamic subtest: pipe-B-plane-1 [163.199314] Dynamic subtest pipe-B-plane-1: SKIP (0.000s) [163.220038] Starting dynamic subtest: pipe-B-plane-2 [163.226515] Dynamic subtest pipe-B-plane-2: SKIP (0.000s) [163.244977] Starting dynamic subtest: pipe-B-plane-3 [163.251426] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [163.270699] Starting dynamic subtest: pipe-B-plane-4 [163.277379] Dynamic subtest pipe-B-plane-4: SKIP (0.000s) [163.439471] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.915s) [163.709883] [010/134] (889s left) gem_madvise (dontneed-before-mmap) [163.817590] Starting subtest: dontneed-before-mmap [163.834754] Subtest dontneed-before-mmap: SUCCESS (0.019s) [163.993531] [011/134] (889s left) api_intel_bb (intel-bb-blit-x) [164.105467] Starting subtest: intel-bb-blit-x [167.332631] Subtest intel-bb-blit-x: SUCCESS (3.232s) [167.541206] [012/134] (885s left) kms_psr (psr-cursor-mmap-gtt) [167.737137] Subtest psr-cursor-mmap-gtt: SKIP (0.000s) [167.861793] [013/134] (885s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [168.479931] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [168.753523] [014/134] (884s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [168.994995] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [169.090789] [015/134] (884s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [169.202190] Starting subtest: invalid-multi-wait-unsubmitted-submitted [169.206644] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s) [169.374890] [016/134] (884s left) prime_mmap (test_errors) [169.545123] Starting subtest: test_errors [169.548405] Starting dynamic subtest: test_errors-smem [169.551593] Dynamic subtest test_errors-smem: SUCCESS (0.034s) [169.555667] Subtest test_errors: SUCCESS (0.038s) [169.727552] [017/134] (883s left) gem_reg_read (timestamp-moving) [169.837526] Starting subtest: timestamp-moving [170.838442] Subtest timestamp-moving: SUCCESS (1.001s) [171.004056] [018/134] (882s left) kms_atomic (plane-primary-legacy) [171.190094] Starting subtest: plane-primary-legacy [171.193522] Starting dynamic subtest: pipe-A-HDMI-A-1 [171.850483] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.657s) [171.855185] Subtest plane-primary-legacy: SUCCESS (0.661s) [172.194726] [019/134] (881s left) kms_psr (psr-sprite-plane-onoff) [172.388460] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [172.508697] [020/134] (881s left) syncobj_timeline (single-wait-for-submit-signaled) [172.632984] Starting subtest: single-wait-for-submit-signaled [172.636310] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s) [172.808367] [021/134] (881s left) perf_pmu (semaphore-wait) [172.923772] Starting subtest: semaphore-wait [172.927722] Starting dynamic subtest: rcs0 [173.445336] Dynamic subtest rcs0: SUCCESS (0.518s) [173.465619] Starting dynamic subtest: bcs0 [173.965380] Dynamic subtest bcs0: SUCCESS (0.520s) [173.987389] Starting dynamic subtest: vcs0 [174.487205] Dynamic subtest vcs0: SUCCESS (0.520s) [174.507316] Starting dynamic subtest: vecs0 [175.006949] Dynamic subtest vecs0: SUCCESS (0.516s) [175.011111] Subtest semaphore-wait: SUCCESS (2.082s) [175.183059] [022/134] (879s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [175.382309] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [175.390957] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [175.573995] [023/134] (878s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [175.793400] Starting subtest: fbc-1p-primscrn-spr-indfb-move [179.037074] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.246s) [179.352512] [024/134] (875s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [179.464660] Starting subtest: etime-multi-wait-all-for-submit-submitted [179.568892] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s) [179.749084] [025/134] (874s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [179.955898] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [180.054581] [026/134] (874s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [180.241460] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [180.244814] Starting dynamic subtest: pipe-A-HDMI-A-1 [180.340835] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s) [180.381132] Starting dynamic subtest: pipe-A-HDMI-A-2 [180.411538] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s) [180.432509] Starting dynamic subtest: pipe-B-HDMI-A-1 [180.462471] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s) [180.484304] Starting dynamic subtest: pipe-B-HDMI-A-2 [180.512641] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [180.533237] Starting dynamic subtest: pipe-C-HDMI-A-1 [180.567478] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [180.589038] Starting dynamic subtest: pipe-C-HDMI-A-2 [180.621331] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [180.624471] Subtest ccs-on-another-bo-yf-tiled-ccs: SUCCESS (0.031s) [181.231650] [027/134] (873s left) gem_lmem_swapping (heavy-random) [181.351759] Subtest heavy-random: SKIP (0.000s) [181.462336] [028/134] (873s left) kms_lease (lease-unleased-connector) [181.643877] Starting subtest: lease-unleased-connector [181.646792] Starting dynamic subtest: pipe-A-HDMI-A-1 [181.722201] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.065s) [181.748055] Starting dynamic subtest: pipe-A-HDMI-A-2 [181.794591] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.080s) [181.830137] Starting dynamic subtest: pipe-B-HDMI-A-1 [181.867913] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.073s) [181.906736] Starting dynamic subtest: pipe-B-HDMI-A-2 [181.959236] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.076s) [182.014232] Starting dynamic subtest: pipe-C-HDMI-A-1 [182.054532] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.062s) [182.091705] Starting dynamic subtest: pipe-C-HDMI-A-2 [182.095906] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.062s) [182.101061] Subtest lease-unleased-connector: SUCCESS (0.450s) [182.264219] [029/134] (872s left) gen9_exec_parse (valid-registers) [182.398470] Starting subtest: valid-registers [182.603325] Subtest valid-registers: SUCCESS (0.207s) [182.881029] [030/134] (872s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [183.427608] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [183.707152] [031/134] (871s left) gem_mmap_offset (open-flood) [183.818028] Starting subtest: open-flood [205.418669] Subtest open-flood: SUCCESS (21.604s) [205.620956] [032/134] (849s left) gem_ctx_isolation (nonpriv) [205.749089] Starting subtest: nonpriv [205.753094] Starting dynamic subtest: rcs0 [206.558607] Dynamic subtest rcs0: SUCCESS (0.754s) [206.630139] Starting dynamic subtest: bcs0 [207.772259] Dynamic subtest bcs0: SUCCESS (1.263s) [207.797816] Starting dynamic subtest: vcs0 [208.520587] Dynamic subtest vcs0: SUCCESS (0.748s) [208.542119] Starting dynamic subtest: vecs0 [209.290643] Dynamic subtest vecs0: SUCCESS (0.768s) [209.294591] Subtest nonpriv: SUCCESS (3.541s) [209.581714] [033/134] (845s left) gem_create (create-size-update) [209.689138] Starting subtest: create-size-update [209.692302] Subtest create-size-update: SUCCESS (0.000s) [209.997273] [034/134] (845s left) fbdev (unaligned-write) [210.111574] Starting subtest: unaligned-write [210.319675] Subtest unaligned-write: SUCCESS (0.209s) [210.482402] [035/134] (845s left) gem_exec_whisper (basic-fds-all) [210.612980] Starting subtest: basic-fds-all [225.725111] Subtest basic-fds-all: SUCCESS (15.110s) [226.000318] [036/134] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [226.198788] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [226.206351] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [226.389978] [037/134] (829s left) kms_psr (fbc-pr-sprite-plane-move) [226.579144] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [226.698870] [038/134] (829s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [226.884706] Starting subtest: planes-downscale-factor-0-75-unity-scaling [226.890191] Starting dynamic subtest: pipe-A [227.185071] Dynamic subtest pipe-A: SUCCESS (0.303s) [227.210287] Starting dynamic subtest: pipe-B [227.578985] Dynamic subtest pipe-B: SUCCESS (0.392s) [227.601658] Starting dynamic subtest: pipe-C [227.666202] Dynamic subtest pipe-C: SUCCESS (0.081s) [227.670369] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.782s) [228.139354] [039/134] (827s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [228.246808] Starting subtest: invalid-smem-bo-on-discrete [228.255027] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [228.508198] [040/134] (827s left) gem_pxp (reject-modify-context-protection-off-3) [231.155259] Starting subtest: reject-modify-context-protection-off-3 [231.164136] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [231.322670] [041/134] (824s left) gem_exec_create (forked) [231.446626] Starting subtest: forked [231.450503] Starting dynamic subtest: smem [251.503212] Dynamic subtest smem: SUCCESS (20.058s) [251.507598] Subtest forked: SUCCESS (20.059s) [251.774516] [042/134] (804s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [251.890996] Starting subtest: invalid-bsd2-flag-on-vebox [251.894166] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s) [252.091059] [043/134] (804s left) kms_hdr (static-toggle-suspend) [252.270888] Starting subtest: static-toggle-suspend [252.284759] Subtest static-toggle-suspend: SKIP (0.001s) [252.440595] [044/134] (804s left) kms_busy (extended-modeset-hang-oldfb) [252.627817] Starting subtest: extended-modeset-hang-oldfb [252.631348] Starting dynamic subtest: pipe-A [257.147095] Dynamic subtest pipe-A: SUCCESS (4.513s) [257.174201] Starting dynamic subtest: pipe-C [261.143902] Dynamic subtest pipe-C: SUCCESS (3.988s) [261.148150] Subtest extended-modeset-hang-oldfb: SUCCESS (8.519s) [261.523269] [045/134] (795s left) gem_vm_create (invalid-create) [261.641373] Starting subtest: invalid-create [261.644973] Subtest invalid-create: SUCCESS (0.001s) [261.833326] [046/134] (794s left) gem_ringfill (engines-basic) [262.184393] Starting subtest: engines-basic [262.187613] Starting dynamic subtest: rcs0 [262.205172] Dynamic subtest rcs0: SUCCESS (0.022s) [262.229182] Starting dynamic subtest: bcs0 [262.238715] Dynamic subtest bcs0: SUCCESS (0.031s) [262.262269] Starting dynamic subtest: vcs0 [262.265846] Dynamic subtest vcs0: SUCCESS (0.024s) [262.287778] Starting dynamic subtest: vecs0 [262.292059] Dynamic subtest vecs0: SUCCESS (0.020s) [262.297184] Subtest engines-basic: SUCCESS (0.106s) [262.469193] [047/134] (794s left) prime_vgem (fence-read-hang) [262.595071] Subtest fence-read-hang: SKIP (0.000s) [262.754489] [048/134] (794s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [262.958532] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [266.463168] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.503s) [266.684746] [049/134] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [266.888389] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [269.625366] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.737s) [269.904525] [050/134] (787s left) kms_feature_discovery (display) [270.084212] Starting subtest: display [270.087343] Subtest display: SUCCESS (0.000s) [270.267510] [051/134] (786s left) gem_ctx_persistence (idempotent) [270.386318] Starting subtest: idempotent [270.390722] Subtest idempotent: SUCCESS (0.000s) [270.569485] [052/134] (786s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [270.756808] Starting subtest: 2x-cursor-vs-flip-legacy [299.455787] Subtest 2x-cursor-vs-flip-legacy: SUCCESS (28.696s) [299.812566] [053/134] (757s left) kms_big_fb (linear-64bpp-rotate-90) [300.036292] Starting subtest: linear-64bpp-rotate-90 [300.530202] Subtest linear-64bpp-rotate-90: SKIP (0.288s) [301.078780] [054/134] (756s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [301.568761] Starting subtest: multi-wait-for-submit-unsubmitted [301.638939] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [301.848915] [055/134] (756s left) gem_exec_fence (syncobj-export) [302.393606] Starting subtest: syncobj-export [302.397598] Subtest syncobj-export: SUCCESS (0.007s) [302.821584] [056/134] (755s left) kms_atomic_interruptible (atomic-setmode) [303.050261] Starting subtest: atomic-setmode [303.055316] Starting dynamic subtest: pipe-A-HDMI-A-1 [309.796835] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.785s) [309.800403] Subtest atomic-setmode: SUCCESS (6.790s) [310.125223] [057/134] (748s left) prime_vgem (basic-gtt) [310.261696] Starting subtest: basic-gtt [310.291275] Subtest basic-gtt: SUCCESS (0.030s) [310.472828] [058/134] (747s left) i915_pm_rpm (debugfs-forcewake-user) [312.373571] Starting subtest: debugfs-forcewake-user [323.114340] Subtest debugfs-forcewake-user: SUCCESS (10.743s) [323.492482] [059/134] (735s left) kms_cursor_crc (cursor-sliding-32x10) [323.698043] Starting subtest: cursor-sliding-32x10 [323.856358] Subtest cursor-sliding-32x10: SKIP (0.154s) [324.058795] [060/134] (734s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [324.249425] Starting subtest: plane-lut1d-pre-ctm3x4 [325.354730] Subtest plane-lut1d-pre-ctm3x4: SKIP (1.053s) [325.627777] [061/134] (733s left) dmabuf_sync_file (export-multiwait) [325.749541] Starting subtest: export-multiwait [325.753097] Subtest export-multiwait: SUCCESS (0.002s) [325.908788] [062/134] (732s left) gem_mmap_gtt (basic-write-read-distinct) [326.024365] Starting subtest: basic-write-read-distinct [326.036687] Subtest basic-write-read-distinct: SUCCESS (0.014s) [326.208543] [063/134] (732s left) kms_pipe_stress (stress-xrgb8888-yftiled) [326.399372] Starting subtest: stress-xrgb8888-yftiled [336.312994] Subtest stress-xrgb8888-yftiled: SUCCESS (9.915s) [336.850064] [064/134] (722s left) perf (invalid-create-userspace-config) [337.118690] Starting subtest: invalid-create-userspace-config [337.122989] Subtest invalid-create-userspace-config: SUCCESS (0.006s) [337.238804] [065/134] (721s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [337.418129] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [337.423276] Starting dynamic subtest: pipe-A-valid-mode [338.337737] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.915s) [338.340954] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SUCCESS (0.920s) [338.673360] [066/134] (720s left) kms_prime (d3hot) [338.901541] Subtest D3hot: SKIP (0.000s) [339.101240] [067/134] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [339.311483] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [339.318586] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [339.503975] [068/134] (719s left) gem_softpin (noreloc) [339.628983] Starting subtest: noreloc [345.144242] Subtest noreloc: SUCCESS (5.514s) [345.337230] [069/134] (714s left) kms_psr (fbc-psr-cursor-render) [345.547961] Subtest fbc-psr-cursor-render: SKIP (0.000s) [345.671118] [070/134] (714s left) kms_properties (get_properties-sanity-non-atomic) [345.855748] Starting subtest: get_properties-sanity-non-atomic [345.859248] Subtest get_properties-sanity-non-atomic: SUCCESS (0.003s) [346.039869] [071/134] (713s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [346.229896] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [346.233431] Starting dynamic subtest: pipe-A-HDMI-A-1 [346.359418] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [346.381602] Starting dynamic subtest: pipe-A-HDMI-A-2 [346.420290] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [346.442185] Starting dynamic subtest: pipe-B-HDMI-A-1 [346.477491] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [346.498957] Starting dynamic subtest: pipe-B-HDMI-A-2 [346.536364] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [346.558984] Starting dynamic subtest: pipe-C-HDMI-A-1 [346.593810] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [346.615486] Starting dynamic subtest: pipe-C-HDMI-A-2 [346.650444] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [346.656801] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.032s) [347.203459] [072/134] (712s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [347.388282] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [347.391426] Starting dynamic subtest: pipe-A-HDMI-A-1 [347.589654] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.011s) [347.613144] Starting dynamic subtest: pipe-A-HDMI-A-2 [347.755146] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.011s) [347.776787] Starting dynamic subtest: pipe-B-HDMI-A-1 [347.987447] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.011s) [348.027234] Starting dynamic subtest: pipe-B-HDMI-A-2 [348.159228] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.011s) [348.187670] Starting dynamic subtest: pipe-C-HDMI-A-1 [348.318507] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s) [348.339518] Starting dynamic subtest: pipe-C-HDMI-A-2 [348.459508] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s) [348.466049] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.094s) [348.619316] [073/134] (711s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [348.815426] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [348.821600] Starting dynamic subtest: pipe-A [349.723257] Dynamic subtest pipe-A: SUCCESS (0.915s) [349.747431] Starting dynamic subtest: pipe-B [350.550951] Dynamic subtest pipe-B: SUCCESS (0.822s) [350.575574] Starting dynamic subtest: pipe-C [351.418966] Dynamic subtest pipe-C: SUCCESS (0.864s) [351.425094] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.617s) [351.945261] [074/134] (708s left) syncobj_timeline (multi-wait-submitted-signaled) [352.054881] Starting subtest: multi-wait-submitted-signaled [352.059946] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s) [352.226086] [075/134] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [352.425137] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [352.433846] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [352.596346] [076/134] (707s left) kms_fence_pin_leak [356.276069] [077/134] (704s left) vgem_basic (bad-handle) [356.397658] Starting subtest: bad-handle [356.402406] Subtest bad-handle: SUCCESS (0.000s) [356.556770] [078/134] (703s left) gen7_exec_parse (basic-offset) [356.676536] Subtest basic-offset: SKIP (0.000s) [356.790316] [079/134] (703s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [356.902334] Starting subtest: multi-wait-all-for-submit-available-signaled [356.907231] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s) [357.080885] [080/134] (703s left) gem_pxp (create-regular-context-2) [359.731275] Starting subtest: create-regular-context-2 [359.741105] Subtest create-regular-context-2: SKIP (0.000s) [359.913703] [081/134] (700s left) kms_pm_rpm (legacy-planes-dpms) [361.807115] Starting subtest: legacy-planes-dpms [361.811523] Starting dynamic subtest: plane-44 [363.420149] Dynamic subtest plane-44: SUCCESS (1.611s) [363.446146] Starting dynamic subtest: plane-53 [365.018114] Dynamic subtest plane-53: SUCCESS (1.593s) [365.044031] Starting dynamic subtest: plane-62 [366.528355] Dynamic subtest plane-62: SUCCESS (1.505s) [366.532055] Subtest legacy-planes-dpms: SUCCESS (4.724s) [366.925751] [082/134] (694s left) kms_flip (bo-too-big) [367.127900] Starting subtest: bo-too-big [367.131819] Starting dynamic subtest: A-HDMI-A1 [368.195341] Dynamic subtest A-HDMI-A1: SUCCESS (1.062s) [368.219596] Starting dynamic subtest: B-HDMI-A1 [369.018172] Dynamic subtest B-HDMI-A1: SUCCESS (0.811s) [369.042155] Starting dynamic subtest: C-HDMI-A1 [369.800749] Dynamic subtest C-HDMI-A1: SUCCESS (0.785s) [369.825038] Starting dynamic subtest: A-HDMI-A2 [370.622116] Dynamic subtest A-HDMI-A2: SUCCESS (0.815s) [370.645716] Starting dynamic subtest: B-HDMI-A2 [371.419837] Dynamic subtest B-HDMI-A2: SUCCESS (0.794s) [371.443335] Starting dynamic subtest: C-HDMI-A2 [372.221260] Dynamic subtest C-HDMI-A2: SUCCESS (0.798s) [372.227364] Subtest bo-too-big: SUCCESS (5.098s) [372.737961] [083/134] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [372.950993] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [375.438176] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.488s) [375.687253] [084/134] (685s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [375.877036] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [375.880440] Starting dynamic subtest: pipe-A-valid-mode [376.271553] Dynamic subtest pipe-A-valid-mode: SKIP (0.383s) [376.322197] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.390s) [376.566464] [085/134] (684s left) gem_exec_async (forked-writes) [376.707833] Starting subtest: forked-writes [376.711233] Starting dynamic subtest: rcs0 [376.769486] Dynamic subtest rcs0: SUCCESS (0.066s) [376.803782] Starting dynamic subtest: bcs0 [376.836348] Dynamic subtest bcs0: SUCCESS (0.061s) [376.864205] Starting dynamic subtest: vcs0 [376.908324] Dynamic subtest vcs0: SUCCESS (0.064s) [376.930621] Starting dynamic subtest: vecs0 [376.975719] Dynamic subtest vecs0: SUCCESS (0.064s) [376.979130] Subtest forked-writes: SUCCESS (0.275s) [377.282288] [086/134] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [377.489254] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [377.495643] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [377.666206] [087/134] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [377.860965] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [377.869787] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [378.048832] [088/134] (683s left) syncobj_eventfd (binary-wait-before-signal) [378.157552] Starting subtest: binary-wait-before-signal [378.191049] Subtest binary-wait-before-signal: SUCCESS (0.034s) [378.348282] [089/134] (683s left) vgem_basic (dmabuf-fence) [378.478246] Starting subtest: dmabuf-fence [378.482056] Subtest dmabuf-fence: SUCCESS (0.002s) [378.617172] [090/134] (683s left) gem_exec_gttfill (basic) [378.750223] Starting subtest: basic [389.058517] Subtest basic: SUCCESS (10.310s) [389.356147] [091/134] (672s left) gem_softpin (allocator-basic) [389.611314] Starting subtest: allocator-basic [389.835942] Subtest allocator-basic: SUCCESS (0.222s) [390.012962] [092/134] (672s left) gem_exec_fence (syncobj-timeline-signal) [390.662089] Starting subtest: syncobj-timeline-signal [390.673177] Subtest syncobj-timeline-signal: SUCCESS (0.012s) [390.984357] [093/134] (671s left) syncobj_wait (multi-wait-all-submitted) [391.119598] Starting subtest: multi-wait-all-submitted [391.218203] Subtest multi-wait-all-submitted: SUCCESS (0.104s) [391.384255] [094/134] (670s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [391.615197] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [394.168991] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.554s) [394.416533] [095/134] (667s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [394.627277] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [394.634271] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [394.798664] [096/134] (667s left) kms_plane_multiple (2x-tiling-none) [394.993476] Starting subtest: 2x-tiling-none [394.997498] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2 [395.931500] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.932s) [396.011044] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2 [396.945820] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (0.977s) [397.024548] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1 [398.128728] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.161s) [398.187162] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1 [399.162563] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.996s) [399.272266] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2 [400.376370] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.193s) [400.445778] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2 [401.344234] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (0.930s) [401.443211] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1 [402.504341] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.120s) [402.546859] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1 [403.488973] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.962s) [403.569192] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2 [404.465746] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.938s) [404.545809] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2 [405.448252] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.961s) [405.543077] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1 [406.650018] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.162s) [406.742465] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1 [407.665257] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (0.977s) [407.685817] Subtest 2x-tiling-none: SUCCESS (12.690s) [408.731787] [097/134] (654s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [409.589573] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [409.598964] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.001s) [409.700521] [098/134] (653s left) gem_ctx_shared (q-out-order) [409.827795] Starting subtest: Q-out-order [409.831947] Starting dynamic subtest: rcs0 [409.915433] Dynamic subtest rcs0: SUCCESS (0.086s) [409.945170] Starting dynamic subtest: bcs0 [410.016028] Dynamic subtest bcs0: SUCCESS (0.097s) [410.041163] Starting dynamic subtest: vcs0 [410.107772] Dynamic subtest vcs0: SUCCESS (0.087s) [410.136503] Starting dynamic subtest: vecs0 [410.194808] Dynamic subtest vecs0: SUCCESS (0.085s) [410.200204] Subtest Q-out-order: SUCCESS (0.372s) [410.502854] [099/134] (652s left) kms_big_fb (4-tiled-32bpp-rotate-180) [410.708985] Starting subtest: 4-tiled-32bpp-rotate-180 [410.715561] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s) [410.898819] [100/134] (652s left) kms_psr (fbc-pr-cursor-plane-onoff) [411.087953] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [411.214214] [101/134] (652s left) kms_properties (crtc-properties-atomic) [411.398678] Starting subtest: crtc-properties-atomic [411.403796] Starting dynamic subtest: pipe-A-HDMI-A-1 [412.019876] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.613s) [412.083313] Starting dynamic subtest: pipe-B-HDMI-A-2 [412.444874] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.424s) [412.488529] Starting dynamic subtest: pipe-C-HDMI-A-1 [412.887515] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.434s) [412.894750] Subtest crtc-properties-atomic: SUCCESS (1.492s) [413.196405] [102/134] (650s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [413.403158] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [413.409868] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [413.594418] [103/134] (649s left) gem_lmem_swapping (verify-random-ccs) [413.720083] Subtest verify-random-ccs: SKIP (0.000s) [413.838463] [104/134] (649s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [414.022434] Starting subtest: crc-primary-suspend-y-tiled-ccs [414.026374] Starting dynamic subtest: pipe-A-HDMI-A-1 [430.679631] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.621s) [430.848310] Starting dynamic subtest: pipe-A-HDMI-A-2