[89.914638] Initializing watchdogs [89.914810] /dev/watchdog0 [89.953659] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [89.968431] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [89.975791] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [89.984287] [001/134] (960s left) kms_frontbuffer_tracking (psr-2p-rte) [90.211750] Starting subtest: psr-2p-rte [90.219645] Subtest psr-2p-rte: SKIP (0.000s) [90.350561] [002/134] (960s left) kms_cursor_legacy (single-bo) [90.548129] Starting subtest: single-bo [90.551324] Starting dynamic subtest: pipe-A [95.952106] Dynamic subtest pipe-A: SUCCESS (5.402s) [95.973104] Starting dynamic subtest: pipe-B [101.359703] Dynamic subtest pipe-B: SUCCESS (5.407s) [101.376658] Starting dynamic subtest: pipe-C [106.765625] Dynamic subtest pipe-C: SUCCESS (5.403s) [106.785127] Starting dynamic subtest: all-pipes [112.174393] Dynamic subtest all-pipes: SUCCESS (5.403s) [112.177851] Subtest single-bo: SUCCESS (21.618s) [112.336646] [003/134] (938s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [112.523355] Starting subtest: cursorA-vs-flipA-legacy [123.911294] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.381s) [124.218541] [004/134] (926s left) kms_cursor_crc (cursor-alpha-transparent) [124.398058] Starting subtest: cursor-alpha-transparent [124.401139] Starting dynamic subtest: pipe-A-HDMI-A-1 [125.292335] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.881s) [125.311204] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.890509] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.593s) [125.893920] Subtest cursor-alpha-transparent: SUCCESS (1.487s) [126.223585] [005/134] (924s left) gem_exec_schedule (pi-common) [126.503140] Starting subtest: pi-common [126.507900] Starting dynamic subtest: rcs0 [126.625808] Dynamic subtest rcs0: SUCCESS (0.121s) [126.645483] Starting dynamic subtest: bcs0 [126.680324] Dynamic subtest bcs0: SUCCESS (0.048s) [126.699118] Starting dynamic subtest: vcs0 [126.722049] Dynamic subtest vcs0: SUCCESS (0.047s) [126.743117] Starting dynamic subtest: vecs0 [126.768146] Dynamic subtest vecs0: SUCCESS (0.048s) [126.771770] Subtest pi-common: SUCCESS (0.268s) [127.024102] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true [127.030641] [006/134] (923s left) kms_flip (absolute-wf_vblank) [127.217186] Starting subtest: absolute-wf_vblank [127.221462] Starting dynamic subtest: A-HDMI-A1 [132.862936] Dynamic subtest A-HDMI-A1: SUCCESS (5.641s) [132.881834] Starting dynamic subtest: B-HDMI-A1 [138.400762] Dynamic subtest B-HDMI-A1: SUCCESS (5.535s) [138.421989] Starting dynamic subtest: C-HDMI-A1 [143.794787] Dynamic subtest C-HDMI-A1: SUCCESS (5.391s) [143.814670] Starting dynamic subtest: A-HDMI-A2 [149.186714] Dynamic subtest A-HDMI-A2: SUCCESS (5.388s) [149.205601] Starting dynamic subtest: B-HDMI-A2 [154.564090] Dynamic subtest B-HDMI-A2: SUCCESS (5.371s) [154.582489] Starting dynamic subtest: C-HDMI-A2 [159.939793] Dynamic subtest C-HDMI-A2: SUCCESS (5.374s) [159.943196] Subtest absolute-wf_vblank: SUCCESS (32.721s) [160.442864] [007/134] (890s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [160.549105] Starting subtest: multi-wait-for-submit-submitted-signaled [160.553284] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.002s) [160.726229] [008/134] (890s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [160.833986] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [160.938153] [009/134] (890s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [161.118589] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [161.331455] Starting dynamic subtest: pipe-A-plane-0 [161.337866] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [161.356650] Starting dynamic subtest: pipe-A-plane-1 [161.364077] Dynamic subtest pipe-A-plane-1: SKIP (0.000s) [161.396875] Starting dynamic subtest: pipe-A-plane-2 [161.403148] Dynamic subtest pipe-A-plane-2: SKIP (0.000s) [161.425567] Starting dynamic subtest: pipe-A-plane-3 [161.432350] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [161.451441] Starting dynamic subtest: pipe-A-plane-4 [161.457919] Dynamic subtest pipe-A-plane-4: SKIP (0.000s) [161.718013] Starting dynamic subtest: pipe-B-plane-0 [161.726077] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [161.749702] Starting dynamic subtest: pipe-B-plane-1 [161.756578] Dynamic subtest pipe-B-plane-1: SKIP (0.000s) [161.776183] Starting dynamic subtest: pipe-B-plane-2 [161.782513] Dynamic subtest pipe-B-plane-2: SKIP (0.000s) [161.801750] Starting dynamic subtest: pipe-B-plane-3 [161.808368] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [161.826297] Starting dynamic subtest: pipe-B-plane-4 [161.832838] Dynamic subtest pipe-B-plane-4: SKIP (0.000s) [161.957795] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.798s) [162.214040] [010/134] (889s left) gem_madvise (dontneed-before-mmap) [162.357713] Starting subtest: dontneed-before-mmap [162.374422] Subtest dontneed-before-mmap: SUCCESS (0.018s) [162.560753] [011/134] (888s left) api_intel_bb (intel-bb-blit-x) [162.669789] Starting subtest: intel-bb-blit-x [165.864821] Subtest intel-bb-blit-x: SUCCESS (3.201s) [166.062902] [012/134] (885s left) kms_psr (psr-cursor-mmap-gtt) [166.250153] Subtest psr-cursor-mmap-gtt: SKIP (0.000s) [166.361364] [013/134] (885s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [166.910879] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [167.170637] [014/134] (884s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [167.384095] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [167.478666] [015/134] (884s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [167.589759] Starting subtest: invalid-multi-wait-unsubmitted-submitted [167.593202] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s) [167.766495] [016/134] (884s left) prime_mmap (test_errors) [167.874940] Starting subtest: test_errors [167.878970] Starting dynamic subtest: test_errors-smem [167.897381] Dynamic subtest test_errors-smem: SUCCESS (0.028s) [167.901115] Subtest test_errors: SUCCESS (0.028s) [168.082328] [017/134] (883s left) gem_reg_read (timestamp-moving) [168.187942] Starting subtest: timestamp-moving [169.187198] Subtest timestamp-moving: SUCCESS (1.002s) [169.362639] [018/134] (882s left) kms_atomic (plane-primary-legacy) [169.541730] Starting subtest: plane-primary-legacy [169.544903] Starting dynamic subtest: pipe-A-HDMI-A-1 [170.162520] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.618s) [170.166558] Subtest plane-primary-legacy: SUCCESS (0.622s) [170.503272] [019/134] (881s left) kms_psr (psr-sprite-plane-onoff) [170.687050] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [170.798997] [020/134] (881s left) syncobj_timeline (single-wait-for-submit-signaled) [170.907719] Starting subtest: single-wait-for-submit-signaled [170.911492] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s) [171.068145] [021/134] (881s left) perf_pmu (semaphore-wait) [171.179296] Starting subtest: semaphore-wait [171.183851] Starting dynamic subtest: rcs0 [171.703505] Dynamic subtest rcs0: SUCCESS (0.516s) [171.723778] Starting dynamic subtest: bcs0 [172.215649] Dynamic subtest bcs0: SUCCESS (0.516s) [172.235571] Starting dynamic subtest: vcs0 [172.731086] Dynamic subtest vcs0: SUCCESS (0.514s) [172.751310] Starting dynamic subtest: vecs0 [173.248132] Dynamic subtest vecs0: SUCCESS (0.514s) [173.252282] Subtest semaphore-wait: SUCCESS (2.068s) [173.435070] [022/134] (879s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [173.638451] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [173.645245] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.001s) [173.817278] [023/134] (878s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [174.017932] Starting subtest: fbc-1p-primscrn-spr-indfb-move [177.275698] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.262s) [177.584513] [024/134] (875s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [177.695535] Starting subtest: etime-multi-wait-all-for-submit-submitted [177.802041] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.110s) [177.983365] [025/134] (874s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [178.193236] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [178.292708] [026/134] (874s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [178.482917] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [178.487642] Starting dynamic subtest: pipe-A-HDMI-A-1 [178.602256] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s) [178.623046] Starting dynamic subtest: pipe-A-HDMI-A-2 [178.653436] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s) [178.676335] Starting dynamic subtest: pipe-B-HDMI-A-1 [178.705524] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s) [178.725139] Starting dynamic subtest: pipe-B-HDMI-A-2 [178.754098] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [178.773411] Starting dynamic subtest: pipe-C-HDMI-A-1 [178.807592] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [178.827340] Starting dynamic subtest: pipe-C-HDMI-A-2 [178.859253] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [178.862554] Subtest ccs-on-another-bo-yf-tiled-ccs: SUCCESS (0.027s) [179.431257] [027/134] (873s left) gem_lmem_swapping (heavy-random) [179.553452] Subtest heavy-random: SKIP (0.000s) [179.672982] [028/134] (873s left) kms_lease (lease-unleased-connector) [179.855238] Starting subtest: lease-unleased-connector [179.858286] Starting dynamic subtest: pipe-A-HDMI-A-1 [179.936104] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.074s) [179.980130] Starting dynamic subtest: pipe-A-HDMI-A-2 [180.055323] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.099s) [180.096773] Starting dynamic subtest: pipe-B-HDMI-A-1 [180.139657] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.081s) [180.175297] Starting dynamic subtest: pipe-B-HDMI-A-2 [180.213497] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.070s) [180.241045] Starting dynamic subtest: pipe-C-HDMI-A-1 [180.299490] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.071s) [180.335277] Starting dynamic subtest: pipe-C-HDMI-A-2 [180.373011] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.071s) [180.385751] Subtest lease-unleased-connector: SUCCESS (0.530s) [180.549152] [029/134] (872s left) gen9_exec_parse (valid-registers) [180.685375] Starting subtest: valid-registers [180.880881] Subtest valid-registers: SUCCESS (0.193s) [181.181192] [030/134] (872s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [181.749793] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [182.020552] [031/134] (871s left) gem_mmap_offset (open-flood) [182.134257] Starting subtest: open-flood [203.722070] Subtest open-flood: SUCCESS (21.592s) [203.911545] [032/134] (849s left) gem_ctx_isolation (nonpriv) [204.039083] Starting subtest: nonpriv [204.043052] Starting dynamic subtest: rcs0 [204.888769] Dynamic subtest rcs0: SUCCESS (0.777s) [204.959604] Starting dynamic subtest: bcs0 [206.164319] Dynamic subtest bcs0: SUCCESS (1.288s) [206.233717] Starting dynamic subtest: vcs0 [206.937905] Dynamic subtest vcs0: SUCCESS (0.774s) [207.004610] Starting dynamic subtest: vecs0 [207.662619] Dynamic subtest vecs0: SUCCESS (0.771s) [207.667331] Subtest nonpriv: SUCCESS (3.621s) [207.947162] [033/134] (845s left) gem_create (create-size-update) [208.051328] Starting subtest: create-size-update [208.054673] Subtest create-size-update: SUCCESS (0.000s) [208.349997] [034/134] (845s left) fbdev (unaligned-write) [208.471552] Starting subtest: unaligned-write [208.689467] Subtest unaligned-write: SUCCESS (0.219s) [208.860549] [035/134] (844s left) gem_exec_whisper (basic-fds-all) [208.988886] Starting subtest: basic-fds-all [222.947530] Subtest basic-fds-all: SUCCESS (13.958s) [223.268678] [036/134] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [223.466890] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [223.474133] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [223.628966] [037/134] (830s left) kms_psr (fbc-pr-sprite-plane-move) [223.806925] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [223.927086] [038/134] (830s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [224.115466] Starting subtest: planes-downscale-factor-0-75-unity-scaling [224.118540] Starting dynamic subtest: pipe-A [224.415226] Dynamic subtest pipe-A: SUCCESS (0.307s) [224.447239] Starting dynamic subtest: pipe-B [224.812478] Dynamic subtest pipe-B: SUCCESS (0.395s) [224.846274] Starting dynamic subtest: pipe-C [224.897762] Dynamic subtest pipe-C: SUCCESS (0.080s) [224.901646] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.788s) [225.342459] [039/134] (828s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [225.445463] Starting subtest: invalid-smem-bo-on-discrete [225.452927] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [225.709762] [040/134] (828s left) gem_pxp (reject-modify-context-protection-off-3) [228.356264] Starting subtest: reject-modify-context-protection-off-3 [228.363703] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [228.536652] [041/134] (825s left) gem_exec_create (forked) [228.665068] Starting subtest: forked [228.668497] Starting dynamic subtest: smem [248.718971] Dynamic subtest smem: SUCCESS (20.055s) [248.723447] Subtest forked: SUCCESS (20.057s) [248.991475] [042/134] (805s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [249.102312] Starting subtest: invalid-bsd2-flag-on-vebox [249.105881] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s) [249.311596] [043/134] (805s left) kms_hdr (static-toggle-suspend) [249.489458] Starting subtest: static-toggle-suspend [249.504487] Subtest static-toggle-suspend: SKIP (0.001s) [249.653736] [044/134] (805s left) kms_busy (extended-modeset-hang-oldfb) [249.850854] Starting subtest: extended-modeset-hang-oldfb [249.855581] Starting dynamic subtest: pipe-A [254.200238] Dynamic subtest pipe-A: SUCCESS (4.340s) [254.221476] Starting dynamic subtest: pipe-C [258.141562] Dynamic subtest pipe-C: SUCCESS (3.938s) [258.146278] Subtest extended-modeset-hang-oldfb: SUCCESS (8.291s) [258.581816] [045/134] (796s left) gem_vm_create (invalid-create) [258.703066] Starting subtest: invalid-create [258.707135] Subtest invalid-create: SUCCESS (0.001s) [258.863298] [046/134] (796s left) gem_ringfill (engines-basic) [259.222510] Starting subtest: engines-basic [259.225748] Starting dynamic subtest: rcs0 [259.242686] Dynamic subtest rcs0: SUCCESS (0.019s) [259.265697] Starting dynamic subtest: bcs0 [259.275628] Dynamic subtest bcs0: SUCCESS (0.028s) [259.299982] Starting dynamic subtest: vcs0 [259.303646] Dynamic subtest vcs0: SUCCESS (0.026s) [259.328050] Starting dynamic subtest: vecs0 [259.331611] Dynamic subtest vecs0: SUCCESS (0.026s) [259.335280] Subtest engines-basic: SUCCESS (0.109s) [259.497640] [047/134] (795s left) prime_vgem (fence-read-hang) [259.623953] Subtest fence-read-hang: SKIP (0.000s) [259.796795] [048/134] (795s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [259.992439] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [263.557447] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.565s) [263.783638] [049/134] (791s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [264.003128] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [266.769870] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.779s) [267.046694] [050/134] (788s left) kms_feature_discovery (display) [267.234045] Starting subtest: display [267.237391] Subtest display: SUCCESS (0.000s) [267.416479] [051/134] (788s left) gem_ctx_persistence (idempotent) [267.533094] Starting subtest: idempotent [267.537075] Subtest idempotent: SUCCESS (0.000s) [267.717677] [052/134] (787s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [267.901306] Starting subtest: 2x-cursor-vs-flip-legacy [296.808942] Subtest 2x-cursor-vs-flip-legacy: SUCCESS (28.906s) [297.132425] [053/134] (758s left) kms_big_fb (linear-64bpp-rotate-90) [297.351271] Starting subtest: linear-64bpp-rotate-90 [297.665819] Subtest linear-64bpp-rotate-90: SKIP (0.308s) [297.948181] [054/134] (757s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [298.059501] Starting subtest: multi-wait-for-submit-unsubmitted [298.163320] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [298.344742] [055/134] (757s left) gem_exec_fence (syncobj-export) [298.893104] Starting subtest: syncobj-export [298.897591] Subtest syncobj-export: SUCCESS (0.008s) [299.328610] [056/134] (756s left) kms_atomic_interruptible (atomic-setmode) [299.559238] Starting subtest: atomic-setmode [299.566346] Starting dynamic subtest: pipe-A-HDMI-A-1 [306.299740] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.785s) [306.312511] Subtest atomic-setmode: SUCCESS (6.790s) [306.599356] [057/134] (749s left) prime_vgem (basic-gtt) [306.734932] Starting subtest: basic-gtt [306.766412] Subtest basic-gtt: SUCCESS (0.031s) [306.939124] [058/134] (749s left) i915_pm_rpm (debugfs-forcewake-user) [308.724080] Starting subtest: debugfs-forcewake-user [319.256643] Subtest debugfs-forcewake-user: SUCCESS (10.529s) [319.666362] [059/134] (736s left) kms_cursor_crc (cursor-sliding-32x10) [319.855562] Starting subtest: cursor-sliding-32x10 [320.005091] Subtest cursor-sliding-32x10: SKIP (0.144s) [320.199915] [060/134] (736s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [320.387361] Starting subtest: plane-lut1d-pre-ctm3x4 [321.443772] Subtest plane-lut1d-pre-ctm3x4: SKIP (1.004s) [321.690031] [061/134] (734s left) dmabuf_sync_file (export-multiwait) [321.814177] Starting subtest: export-multiwait [321.818113] Subtest export-multiwait: SUCCESS (0.002s) [321.957367] [062/134] (734s left) gem_mmap_gtt (basic-write-read-distinct) [322.066938] Starting subtest: basic-write-read-distinct [322.078638] Subtest basic-write-read-distinct: SUCCESS (0.011s) [322.272432] [063/134] (734s left) kms_pipe_stress (stress-xrgb8888-yftiled) [322.474320] Starting subtest: stress-xrgb8888-yftiled [331.646587] Subtest stress-xrgb8888-yftiled: SUCCESS (9.173s) [332.190653] [064/134] (724s left) perf (invalid-create-userspace-config) [332.453139] Starting subtest: invalid-create-userspace-config [332.456630] Subtest invalid-create-userspace-config: SUCCESS (0.004s) [332.573514] [065/134] (724s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [332.804397] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [332.811300] Starting dynamic subtest: pipe-A-valid-mode [333.772823] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.006s) [333.778232] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SUCCESS (1.012s) [334.106177] [066/134] (723s left) kms_prime (d3hot) [334.343918] Subtest D3hot: SKIP (0.000s) [334.550729] [067/134] (722s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [334.763872] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [334.771331] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [334.936831] [068/134] (722s left) gem_softpin (noreloc) [335.052140] Starting subtest: noreloc [340.464523] Subtest noreloc: SUCCESS (5.406s) [340.655907] [069/134] (716s left) kms_psr (fbc-psr-cursor-render) [340.850081] Subtest fbc-psr-cursor-render: SKIP (0.000s) [340.967603] [070/134] (716s left) kms_properties (get_properties-sanity-non-atomic) [341.159045] Starting subtest: get_properties-sanity-non-atomic [341.162349] Subtest get_properties-sanity-non-atomic: SUCCESS (0.004s) [341.352311] [071/134] (716s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [341.537647] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [341.542587] Starting dynamic subtest: pipe-A-HDMI-A-1 [341.666049] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [341.688217] Starting dynamic subtest: pipe-A-HDMI-A-2 [341.723555] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [341.745538] Starting dynamic subtest: pipe-B-HDMI-A-1 [341.780575] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [341.801896] Starting dynamic subtest: pipe-B-HDMI-A-2 [341.837106] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [341.861999] Starting dynamic subtest: pipe-C-HDMI-A-1 [341.896798] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [341.918378] Starting dynamic subtest: pipe-C-HDMI-A-2 [341.952392] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [341.958809] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.033s) [342.548510] [072/134] (715s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [342.742464] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [342.745831] Starting dynamic subtest: pipe-A-HDMI-A-1 [342.977339] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.013s) [343.000266] Starting dynamic subtest: pipe-A-HDMI-A-2 [343.155023] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.013s) [343.176527] Starting dynamic subtest: pipe-B-HDMI-A-1 [343.423914] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.013s) [343.448062] Starting dynamic subtest: pipe-B-HDMI-A-2 [343.581944] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.013s) [343.603675] Starting dynamic subtest: pipe-C-HDMI-A-1 [343.737721] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.012s) [343.758448] Starting dynamic subtest: pipe-C-HDMI-A-2 [343.911149] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.012s) [343.919323] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.112s) [344.042110] [073/134] (713s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [344.232730] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [344.236573] Starting dynamic subtest: pipe-A [345.062593] Dynamic subtest pipe-A: SUCCESS (0.834s) [345.087211] Starting dynamic subtest: pipe-B [345.890234] Dynamic subtest pipe-B: SUCCESS (0.823s) [345.914367] Starting dynamic subtest: pipe-C [346.739248] Dynamic subtest pipe-C: SUCCESS (0.844s) [346.743196] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.513s) [347.300847] [074/134] (710s left) syncobj_timeline (multi-wait-submitted-signaled) [347.420768] Starting subtest: multi-wait-submitted-signaled [347.424154] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s) [347.598697] [075/134] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [347.800433] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [347.807279] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [347.983821] [076/134] (710s left) kms_fence_pin_leak [352.377411] [077/134] (705s left) vgem_basic (bad-handle) [352.506585] Starting subtest: bad-handle [352.511220] Subtest bad-handle: SUCCESS (0.000s) [352.675413] [078/134] (705s left) gen7_exec_parse (basic-offset) [352.792332] Subtest basic-offset: SKIP (0.000s) [352.926860] [079/134] (705s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [353.033840] Starting subtest: multi-wait-all-for-submit-available-signaled [353.038346] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.003s) [353.225890] [080/134] (705s left) gem_pxp (create-regular-context-2) [355.887496] Starting subtest: create-regular-context-2 [355.897639] Subtest create-regular-context-2: SKIP (0.001s) [356.042992] [081/134] (702s left) kms_pm_rpm (legacy-planes-dpms) [357.935579] Starting subtest: legacy-planes-dpms [357.939815] Starting dynamic subtest: plane-44 [359.533864] Dynamic subtest plane-44: SUCCESS (1.596s) [359.564801] Starting dynamic subtest: plane-53 [361.138258] Dynamic subtest plane-53: SUCCESS (1.596s) [361.229704] Starting dynamic subtest: plane-62 [363.084130] Dynamic subtest plane-62: SUCCESS (1.937s) [363.090113] Subtest legacy-planes-dpms: SUCCESS (5.149s) [363.557411] [082/134] (695s left) kms_flip (bo-too-big) [363.762504] Starting subtest: bo-too-big [363.765942] Starting dynamic subtest: A-HDMI-A1 [364.853356] Dynamic subtest A-HDMI-A1: SUCCESS (1.074s) [364.890394] Starting dynamic subtest: B-HDMI-A1 [365.679059] Dynamic subtest B-HDMI-A1: SUCCESS (0.831s) [365.704047] Starting dynamic subtest: C-HDMI-A1 [366.483300] Dynamic subtest C-HDMI-A1: SUCCESS (0.799s) [366.506392] Starting dynamic subtest: A-HDMI-A2 [367.388626] Dynamic subtest A-HDMI-A2: SUCCESS (0.899s) [367.415042] Starting dynamic subtest: B-HDMI-A2 [368.332320] Dynamic subtest B-HDMI-A2: SUCCESS (0.941s) [368.370269] Starting dynamic subtest: C-HDMI-A2 [369.294568] Dynamic subtest C-HDMI-A2: SUCCESS (0.945s) [369.299221] Subtest bo-too-big: SUCCESS (5.527s) [369.867413] [083/134] (689s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [370.084894] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [372.529052] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.454s) [372.781486] [084/134] (686s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [372.984135] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [373.032353] Starting dynamic subtest: pipe-A-valid-mode [373.374101] Dynamic subtest pipe-A-valid-mode: SKIP (0.379s) [373.381811] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.384s) [373.683552] [085/134] (685s left) gem_exec_async (forked-writes) [373.886069] Starting subtest: forked-writes [373.891060] Starting dynamic subtest: rcs0 [374.000693] Dynamic subtest rcs0: SUCCESS (0.113s) [374.042397] Starting dynamic subtest: bcs0 [374.100673] Dynamic subtest bcs0: SUCCESS (0.089s) [374.122607] Starting dynamic subtest: vcs0 [374.168082] Dynamic subtest vcs0: SUCCESS (0.063s) [374.195142] Starting dynamic subtest: vecs0 [374.248085] Dynamic subtest vecs0: SUCCESS (0.076s) [374.252475] Subtest forked-writes: SUCCESS (0.363s) [374.533994] [086/134] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [374.756390] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [374.762785] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [374.941146] [087/134] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [375.185134] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [375.191090] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [375.406860] [088/134] (684s left) syncobj_eventfd (binary-wait-before-signal) [375.529111] Starting subtest: binary-wait-before-signal [375.558103] Subtest binary-wait-before-signal: SUCCESS (0.032s) [375.736293] [089/134] (683s left) vgem_basic (dmabuf-fence) [375.868094] Starting subtest: dmabuf-fence [375.872399] Subtest dmabuf-fence: SUCCESS (0.002s) [376.018594] [090/134] (683s left) gem_exec_gttfill (basic) [376.165842] Starting subtest: basic [386.395585] Subtest basic: SUCCESS (10.236s) [386.675624] [091/134] (673s left) gem_softpin (allocator-basic) [386.928273] Starting subtest: allocator-basic [387.157939] Subtest allocator-basic: SUCCESS (0.223s) [387.352487] [092/134] (672s left) gem_exec_fence (syncobj-timeline-signal) [388.016536] Starting subtest: syncobj-timeline-signal [388.027610] Subtest syncobj-timeline-signal: SUCCESS (0.010s) [388.320259] [093/134] (671s left) syncobj_wait (multi-wait-all-submitted) [388.449940] Starting subtest: multi-wait-all-submitted [388.558084] Subtest multi-wait-all-submitted: SUCCESS (0.108s) [388.719200] [094/134] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [388.948457] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [391.473108] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.530s) [391.720283] [095/134] (668s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [391.924958] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [391.933318] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [392.106639] [096/134] (668s left) kms_plane_multiple (2x-tiling-none) [392.294712] Starting subtest: 2x-tiling-none [392.301525] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2 [393.301531] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.006s) [393.381886] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2 [394.303420] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (0.981s) [394.363474] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1 [395.468953] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.126s) [395.551489] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1 [396.448075] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.938s) [396.568994] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2 [397.642323] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.172s) [397.720960] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2 [398.655848] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (0.975s) [398.754458] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1 [399.803404] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.125s) [399.848384] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1 [400.802942] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.975s) [400.881440] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2 [401.802748] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.979s) [401.845034] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2 [402.819646] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.994s) [402.915776] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1 [403.983289] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.144s) [404.065887] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1 [404.984948] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (0.958s) [405.006050] Subtest 2x-tiling-none: SUCCESS (12.713s) [405.772987] [097/134] (654s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [405.991578] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [405.997980] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [406.171602] [098/134] (654s left) gem_ctx_shared (q-out-order) [406.300738] Starting subtest: Q-out-order [406.304819] Starting dynamic subtest: rcs0 [406.393921] Dynamic subtest rcs0: SUCCESS (0.091s) [406.419866] Starting dynamic subtest: bcs0 [406.507368] Dynamic subtest bcs0: SUCCESS (0.107s) [406.536064] Starting dynamic subtest: vcs0 [406.598718] Dynamic subtest vcs0: SUCCESS (0.087s) [406.629728] Starting dynamic subtest: vecs0 [406.686660] Dynamic subtest vecs0: SUCCESS (0.084s) [406.690393] Subtest Q-out-order: SUCCESS (0.385s) [406.990224] [099/134] (653s left) kms_big_fb (4-tiled-32bpp-rotate-180) [407.200122] Starting subtest: 4-tiled-32bpp-rotate-180 [407.207629] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s) [407.389247] [100/134] (653s left) kms_psr (fbc-pr-cursor-plane-onoff) [407.592490] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [407.709980] [101/134] (653s left) kms_properties (crtc-properties-atomic) [407.891683] Starting subtest: crtc-properties-atomic [407.895196] Starting dynamic subtest: pipe-A-HDMI-A-1 [408.511292] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.612s) [408.538064] Starting dynamic subtest: pipe-B-HDMI-A-2 [408.973595] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.457s) [409.027042] Starting dynamic subtest: pipe-C-HDMI-A-1 [409.420287] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.435s) [409.424190] Subtest crtc-properties-atomic: SUCCESS (1.525s) [409.740027] [102/134] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [409.954831] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [409.961348] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [410.135130] [103/134] (650s left) gem_lmem_swapping (verify-random-ccs) [410.257464] Subtest verify-random-ccs: SKIP (0.000s) [410.385124] [104/134] (650s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [410.561064] Starting subtest: crc-primary-suspend-y-tiled-ccs [410.564579] Starting dynamic subtest: pipe-A-HDMI-A-1 [426.678874] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.706s) [426.744238] Starting dynamic subtest: pipe-A-HDMI-A-2