[89.825459] Initializing watchdogs [89.825655] /dev/watchdog0 [89.864642] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [89.880089] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [89.886884] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [89.894964] [001/131] (960s left) gem_exec_gttfill (engines) [90.055851] Starting subtest: engines [90.063095] Starting dynamic subtest: rcs0 [117.804062] Dynamic subtest rcs0: SUCCESS (27.744s) [117.824072] Starting dynamic subtest: bcs0 [147.941141] Dynamic subtest bcs0: SUCCESS (30.132s) [147.961048] Starting dynamic subtest: vcs0 [175.717634] Dynamic subtest vcs0: SUCCESS (27.774s) [175.737728] Starting dynamic subtest: vecs0 [202.632398] Dynamic subtest vecs0: SUCCESS (26.913s) [202.636460] Subtest engines: SUCCESS (112.570s) [202.932991] [002/131] (847s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [203.191737] Starting subtest: multi-wait-for-submit-available-submitted [203.196692] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s) [203.353386] [003/131] (847s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [203.463374] Starting subtest: single-wait-all-for-submit-unsubmitted [203.565146] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [203.752142] [004/131] (846s left) gem_mmap_gtt (hang) [203.860483] Starting subtest: hang [209.302525] Subtest hang: SUCCESS (5.443s) [209.470079] [005/131] (841s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [209.729039] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [209.759581] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [210.556209] [006/131] (840s left) gem_basic (create-close) [210.764748] Starting subtest: create-close [210.771196] Subtest create-close: SUCCESS (0.001s) [210.928340] [007/131] (840s left) dumb_buffer (create-clear) [211.048784] Starting subtest: create-clear [245.160434] Subtest create-clear: SUCCESS (34.111s) [245.355681] [008/131] (805s left) kms_chamelium_hpd (dp-hpd-fast) [245.929138] Subtest dp-hpd-fast: SKIP (0.000s) [246.193496] [009/131] (805s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [246.380832] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [246.384757] Starting dynamic subtest: pipe-A-HDMI-A-1 [246.515392] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [246.535339] Starting dynamic subtest: pipe-A-HDMI-A-2 [246.568405] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [246.589435] Starting dynamic subtest: pipe-B-HDMI-A-1 [246.634565] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [246.654676] Starting dynamic subtest: pipe-B-HDMI-A-2 [246.694498] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [246.715926] Starting dynamic subtest: pipe-C-HDMI-A-1 [246.750541] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [246.770918] Starting dynamic subtest: pipe-C-HDMI-A-2 [246.804281] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [246.810844] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.022s) [247.360294] [010/131] (803s left) gem_exec_flush (basic-uc-prw-default) [247.498837] Starting subtest: basic-uc-prw-default [252.931141] Subtest basic-uc-prw-default: SUCCESS (5.431s) [253.208852] [011/131] (798s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [253.419583] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [253.426107] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.002s) [253.591232] [012/131] (797s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [253.799361] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [255.540532] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.740s) [255.843278] [013/131] (795s left) gen3_mixed_blits [256.055329] [014/131] (795s left) gem_exec_params (sol-reset-invalid) [256.176502] Starting subtest: sol-reset-invalid [256.180205] Subtest sol-reset-invalid: SUCCESS (0.004s) [256.361608] [015/131] (795s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [256.550336] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [256.553539] Starting dynamic subtest: pipe-A-HDMI-A-1 [256.685343] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.004s) [256.705516] Starting dynamic subtest: pipe-A-HDMI-A-2 [256.737356] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s) [256.758094] Starting dynamic subtest: pipe-B-HDMI-A-1 [256.789242] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s) [256.809646] Starting dynamic subtest: pipe-B-HDMI-A-2 [256.841445] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s) [256.861712] Starting dynamic subtest: pipe-C-HDMI-A-1 [256.895276] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s) [256.915540] Starting dynamic subtest: pipe-C-HDMI-A-2 [256.946563] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s) [256.952864] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.037s) [257.537159] [016/131] (794s left) kms_cursor_edge_walk (256x256-right-edge) [257.724308] Starting subtest: 256x256-right-edge [257.727478] Starting dynamic subtest: pipe-A-HDMI-A-1 [261.623953] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.896s) [261.672023] Starting dynamic subtest: pipe-C-HDMI-A-1 [265.149621] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.465s) [265.192349] Subtest 256x256-right-edge: SUCCESS (7.372s) [265.409568] [017/131] (786s left) gem_exec_reloc (basic-write-read-active) [265.540149] Starting subtest: basic-write-read-active [265.675571] Subtest basic-write-read-active: SUCCESS (0.138s) [265.924278] [018/131] (786s left) kms_mmap_write_crc (main) [266.120084] Starting subtest: main [266.128161] Starting dynamic subtest: pipe-A-HDMI-A-1 [269.582495] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.457s) [269.586733] Subtest main: SUCCESS (3.461s) [269.907655] [019/131] (782s left) i915_pm_rps (min-max-config-idle) [270.043197] Starting subtest: min-max-config-idle [270.425097] Subtest min-max-config-idle: SUCCESS (0.383s) [270.588315] [020/131] (781s left) gem_partial_pwrite_pread (writes-after-reads) [270.706118] Starting subtest: writes-after-reads [291.640792] Subtest writes-after-reads: SUCCESS (20.936s) [291.836635] [021/131] (760s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [292.046127] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [292.134904] [022/131] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [292.344584] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [292.350410] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [292.503303] [023/131] (760s left) gem_exec_fence (syncobj-export) [293.781754] Starting subtest: syncobj-export [293.851841] Subtest syncobj-export: SUCCESS (0.007s) [294.317614] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true [294.324093] [024/131] (758s left) gem_exec_balancer (full-late) [294.457658] Starting subtest: full-late [299.093256] Subtest full-late: SUCCESS (4.634s) [299.397982] [025/131] (753s left) gem_exec_params (invalid-bsd2-flag-on-blt) [299.514113] Starting subtest: invalid-bsd2-flag-on-blt [299.517595] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.002s) [299.698263] [026/131] (753s left) gem_blits (basic) [299.812941] Starting subtest: basic [311.127427] Subtest basic: SUCCESS (11.316s) [311.337130] [027/131] (741s left) perf (invalid-oa-exponent) [311.625074] Starting subtest: invalid-oa-exponent [311.657721] Subtest invalid-oa-exponent: SUCCESS (0.037s) [311.779555] [028/131] (741s left) kms_chamelium_color (ctm-red-to-blue) [311.971771] Subtest ctm-red-to-blue: SKIP (0.000s) [312.095084] [029/131] (741s left) gen9_exec_parse (secure-batches) [312.228242] Starting subtest: secure-batches [312.232451] Subtest secure-batches: SUCCESS (0.000s) [312.531181] [030/131] (740s left) kms_draw_crc (draw-method-mmap-wc) [312.717930] Starting subtest: draw-method-mmap-wc [312.721129] Starting dynamic subtest: xrgb8888-untiled [313.200115] Dynamic subtest xrgb8888-untiled: SUCCESS (0.482s) [313.223420] Starting dynamic subtest: rgb565-untiled [313.464904] Dynamic subtest rgb565-untiled: SUCCESS (0.262s) [313.490830] Starting dynamic subtest: xrgb2101010-untiled [313.714929] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.249s) [313.742362] Starting dynamic subtest: xbgr16161616f-untiled [313.983167] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.266s) [314.006046] Starting dynamic subtest: xrgb8888-xtiled [314.168380] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.181s) [314.190730] Starting dynamic subtest: rgb565-xtiled [314.350118] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s) [314.372845] Starting dynamic subtest: xrgb2101010-xtiled [314.515158] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s) [314.539611] Starting dynamic subtest: xbgr16161616f-xtiled [314.685501] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.165s) [314.707847] Starting dynamic subtest: xrgb8888-ytiled [314.869787] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.184s) [314.892468] Starting dynamic subtest: rgb565-ytiled [315.051059] Dynamic subtest rgb565-ytiled: SUCCESS (0.180s) [315.073744] Starting dynamic subtest: xrgb2101010-ytiled [315.216348] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.164s) [315.239588] Starting dynamic subtest: xbgr16161616f-ytiled [315.382200] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.165s) [315.410847] Subtest draw-method-mmap-wc: SUCCESS (2.667s) [315.676588] [031/131] (737s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [315.865071] Starting subtest: plane-downscale-factor-0-75-with-rotation [315.869721] Starting dynamic subtest: pipe-A [320.149959] Dynamic subtest pipe-A: SKIP (4.276s) [320.173640] Starting dynamic subtest: pipe-B [324.479648] Dynamic subtest pipe-B: SKIP (4.326s) [324.576051] Starting dynamic subtest: pipe-C [329.020740] Dynamic subtest pipe-C: SKIP (4.535s) [329.028192] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (13.143s) [329.553681] [032/131] (724s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [329.802778] Starting subtest: flip-vs-cursor-varying-size [354.238934] Subtest flip-vs-cursor-varying-size: SUCCESS (24.438s) [354.567887] [033/131] (699s left) kms_async_flips (crc) [354.763452] Starting subtest: crc [355.363275] Starting dynamic subtest: pipe-A-HDMI-A-1 [357.643515] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.281s) [358.012679] Starting dynamic subtest: pipe-A-HDMI-A-2 [360.275022] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.284s) [360.644884] Starting dynamic subtest: pipe-B-HDMI-A-1 [362.876040] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.254s) [363.222039] Starting dynamic subtest: pipe-B-HDMI-A-2 [365.483247] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.282s) [365.835070] Starting dynamic subtest: pipe-C-HDMI-A-1 [368.065076] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.253s) [368.454381] Starting dynamic subtest: pipe-C-HDMI-A-2 [370.646683] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.243s) [370.650782] Subtest crc: SUCCESS (15.889s) [371.313728] [034/131] (682s left) kms_concurrent (multi-plane-atomic-lowres) [371.511979] Starting subtest: multi-plane-atomic-lowres [371.515649] Starting dynamic subtest: pipe-A-HDMI-A-1 [372.562660] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.045s) [372.593720] Starting dynamic subtest: pipe-A-HDMI-A-2 [373.290179] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.717s) [373.294384] Subtest multi-plane-atomic-lowres: SUCCESS (1.776s) [373.643326] [035/131] (680s left) i915_suspend (basic-s3-without-i915) [373.756321] Starting subtest: basic-s3-without-i915 [395.439968] Subtest basic-s3-without-i915: SUCCESS (5.488s) [401.635500] [036/131] (658s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [401.931815] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [401.944862] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.004s) [402.144118] [037/131] (658s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [402.560048] Starting subtest: cursorA-vs-flipA-varying-size [413.840697] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.481s) [414.182315] [038/131] (646s left) syncobj_timeline (invalid-signal-zero-handles) [414.313070] Starting subtest: invalid-signal-zero-handles [414.316418] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [414.505808] [039/131] (646s left) syncobj_wait (multi-wait-for-submit-submitted) [414.620234] Starting subtest: multi-wait-for-submit-submitted [414.724857] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s) [414.912049] [040/131] (645s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [415.151532] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [415.158031] Starting dynamic subtest: pipe-A-valid-mode [416.107587] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.997s) [416.111685] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.003s) [416.455362] [041/131] (644s left) sriov_basic (bind-unbind-vf) [416.606797] Subtest bind-unbind-vf: SKIP (0.000s) [416.738037] [042/131] (644s left) i915_drm_fdinfo (memory-info-active) [416.862359] Starting subtest: memory-info-active [416.866399] Starting dynamic subtest: smem0 [417.935515] Dynamic subtest smem0: SUCCESS (1.075s) [417.939464] Subtest memory-info-active: SUCCESS (1.079s) [418.131736] [043/131] (642s left) perf_pmu (render-node-busy) [418.259065] Starting subtest: render-node-busy [418.262739] Starting dynamic subtest: rcs0 [418.793612] Dynamic subtest rcs0: SUCCESS (0.526s) [418.820127] Starting dynamic subtest: bcs0 [419.332518] Dynamic subtest bcs0: SUCCESS (0.537s) [419.359180] Starting dynamic subtest: vcs0 [419.863198] Dynamic subtest vcs0: SUCCESS (0.527s) [419.890173] Starting dynamic subtest: vecs0 [420.386896] Dynamic subtest vecs0: SUCCESS (0.527s) [420.390261] Subtest render-node-busy: SUCCESS (2.131s) [420.586903] [044/131] (640s left) kms_pm_dc (dc3co-vpb-simulation) [421.798166] Starting subtest: dc3co-vpb-simulation [421.805106] Subtest dc3co-vpb-simulation: SKIP (0.001s) [421.993564] [045/131] (639s left) gem_render_copy_redux (normal) [422.117835] Starting subtest: normal [423.532101] Subtest normal: SUCCESS (1.414s) [423.723065] [046/131] (637s left) kms_rotation_crc (sprite-rotation-180) [423.906151] Starting subtest: sprite-rotation-180 [435.062192] Subtest sprite-rotation-180: SUCCESS (11.158s) [435.455935] [047/131] (626s left) gem_eio (in-flight-1us) [436.093342] Starting subtest: in-flight-1us [436.877157] Subtest in-flight-1us: SUCCESS (0.923s) [437.036586] [048/131] (624s left) gem_exec_schedule (implicit-boths) [437.185414] Starting subtest: implicit-boths [437.188837] Starting dynamic subtest: rcs0 [437.317258] Dynamic subtest rcs0: SUCCESS (0.132s) [437.352180] Starting dynamic subtest: bcs0 [437.462346] Dynamic subtest bcs0: SUCCESS (0.138s) [437.505206] Starting dynamic subtest: vcs0 [437.600890] Dynamic subtest vcs0: SUCCESS (0.128s) [437.629453] Starting dynamic subtest: vecs0 [437.737505] Dynamic subtest vecs0: SUCCESS (0.131s) [437.742073] Subtest implicit-boths: SUCCESS (0.557s) [438.184403] [049/131] (623s left) sysfs_heartbeat_interval (invalid) [438.307465] Starting subtest: invalid [438.317060] Starting dynamic subtest: vecs0 [438.321332] Dynamic subtest vecs0: SUCCESS (0.001s) [438.349343] Starting dynamic subtest: vcs0 [438.352945] Dynamic subtest vcs0: SUCCESS (0.001s) [438.380883] Starting dynamic subtest: bcs0 [438.385365] Dynamic subtest bcs0: SUCCESS (0.001s) [438.413259] Starting dynamic subtest: rcs0 [438.416337] Dynamic subtest rcs0: SUCCESS (0.001s) [438.419524] Subtest invalid: SUCCESS (0.022s) [438.522857] [050/131] (623s left) gem_spin_batch (legacy) [438.653929] Starting subtest: legacy [438.658003] Starting dynamic subtest: default [441.893033] Dynamic subtest default: SUCCESS (3.232s) [441.922203] Starting dynamic subtest: render [445.124356] Dynamic subtest render: SUCCESS (3.228s) [445.153132] Starting dynamic subtest: bsd [448.360626] Dynamic subtest bsd: SUCCESS (3.230s) [448.389309] Starting dynamic subtest: bsd1 [451.592311] Dynamic subtest bsd1: SUCCESS (3.229s) [451.620622] Starting dynamic subtest: blt [454.831860] Dynamic subtest blt: SUCCESS (3.232s) [454.860758] Starting dynamic subtest: vebox [458.063730] Dynamic subtest vebox: SUCCESS (3.230s) [458.068190] Subtest legacy: SUCCESS (19.408s) [458.368664] [051/131] (603s left) gem_ctx_create (basic-files) [458.499230] Starting subtest: basic-files [460.528427] Subtest basic-files: SUCCESS (2.027s) [460.852476] [052/131] (601s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [461.045164] Starting subtest: primary-x-tiled-reflect-x-180 [461.052007] Subtest primary-x-tiled-reflect-x-180: SKIP (0.003s) [461.236007] [053/131] (600s left) gem_reg_read (bad-register) [461.349989] Starting subtest: bad-register [461.353700] Subtest bad-register: SUCCESS (0.000s) [461.534898] [054/131] (600s left) kms_psr (fbc-pr-no-drrs) [461.732698] Subtest fbc-pr-no-drrs: SKIP (0.000s) [461.861407] [055/131] (600s left) gem_pxp (create-regular-context-2) [464.517409] Starting subtest: create-regular-context-2 [464.525404] Subtest create-regular-context-2: SKIP (0.000s) [464.702643] [056/131] (597s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [464.844889] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [464.853293] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [465.153531] [057/131] (597s left) gem_render_copy (linear-to-vebox-yf-tiled) [465.278917] Starting subtest: linear-to-vebox-yf-tiled [465.287262] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [465.587195] [058/131] (597s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [465.793525] Starting subtest: psr-2p-scndscrn-spr-indfb-move [465.799908] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [466.001345] [059/131] (596s left) gem_ctx_param (set-priority-invalid-size) [466.114521] Starting subtest: set-priority-invalid-size [466.118860] Subtest set-priority-invalid-size: SUCCESS (0.000s) [466.302301] [060/131] (596s left) kms_rotation_crc (primary-rotation-270) [466.491757] Starting subtest: primary-rotation-270 [482.380338] Subtest primary-rotation-270: SUCCESS (15.894s) [482.689704] [061/131] (580s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [482.892210] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [482.898650] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [483.086518] [062/131] (580s left) kms_big_fb (x-tiled-64bpp-rotate-90) [483.286649] Starting subtest: x-tiled-64bpp-rotate-90 [483.600739] Subtest x-tiled-64bpp-rotate-90: SKIP (0.309s) [483.890477] [063/131] (579s left) api_intel_bb (bb-with-allocator) [484.006932] Starting subtest: bb-with-allocator [484.020972] Subtest bb-with-allocator: SUCCESS (0.013s) [484.219808] [064/131] (579s left) gem_wait (wait) [484.367274] Starting subtest: wait [484.370394] Starting dynamic subtest: all-engines [485.403006] Dynamic subtest all-engines: SUCCESS (1.039s) [485.433004] Starting dynamic subtest: rcs0 [486.431877] Dynamic subtest rcs0: SUCCESS (1.023s) [486.460071] Starting dynamic subtest: bcs0 [487.467246] Dynamic subtest bcs0: SUCCESS (1.032s) [487.496914] Starting dynamic subtest: vcs0 [488.497653] Dynamic subtest vcs0: SUCCESS (1.026s) [488.527348] Starting dynamic subtest: vecs0 [489.525750] Dynamic subtest vecs0: SUCCESS (1.026s) [489.530339] Subtest wait: SUCCESS (5.164s) [489.895142] [065/131] (573s left) kms_pm_rpm (pm-caching) [491.821205] Starting subtest: pm-caching [493.184020] Subtest pm-caching: SUCCESS (1.362s) [493.704314] [066/131] (570s left) kms_plane_scaling (invalid-parameters) [493.942809] Starting subtest: invalid-parameters [493.946359] Starting dynamic subtest: less-than-1-height-src [494.002971] Dynamic subtest less-than-1-height-src: SUCCESS (0.051s) [494.062172] Starting dynamic subtest: less-than-1-width-src [494.065714] Dynamic subtest less-than-1-width-src: SUCCESS (0.052s) [494.069653] Subtest invalid-parameters: SUCCESS (0.109s) [494.355660] [067/131] (569s left) gem_mmap_gtt (pf-nonblock) [494.565123] Starting subtest: pf-nonblock [494.578820] Subtest pf-nonblock: SUCCESS (0.016s) [494.795946] [068/131] (569s left) gem_exec_schedule (submit-golden-slice) [494.941247] Starting subtest: submit-golden-slice [494.944810] Starting dynamic subtest: rcs0 [494.987735] Dynamic subtest rcs0: SUCCESS (0.045s) [495.018850] Starting dynamic subtest: bcs0 [495.042495] Dynamic subtest bcs0: SUCCESS (0.050s) [495.074031] Starting dynamic subtest: vcs0 [495.098070] Dynamic subtest vcs0: SUCCESS (0.054s) [495.127648] Starting dynamic subtest: vecs0 [495.146183] Dynamic subtest vecs0: SUCCESS (0.045s) [495.149549] Subtest submit-golden-slice: SUCCESS (0.208s) [495.577900] [069/131] (568s left) gem_ctx_exec (basic-nohangcheck) [495.689653] Starting subtest: basic-nohangcheck [495.978752] Subtest basic-nohangcheck: SUCCESS (0.294s) [496.180079] [070/131] (568s left) kms_vrr (flip-basic-fastset) [496.369400] Starting subtest: flip-basic-fastset [496.383100] Subtest flip-basic-fastset: SKIP (0.000s) [496.548918] [071/131] (567s left) gem_exec_balancer (parallel-out-fence) [496.797014] Subtest parallel-out-fence: SKIP (0.000s) [497.019297] [072/131] (567s left) kms_cursor_crc (cursor-rapid-movement-32x32) [497.221165] Starting subtest: cursor-rapid-movement-32x32 [497.391038] Subtest cursor-rapid-movement-32x32: SKIP (0.166s) [497.599264] [073/131] (567s left) kms_async_flips (test-time-stamp-atomic) [497.802619] Starting subtest: test-time-stamp-atomic [498.400503] Starting dynamic subtest: pipe-A-HDMI-A-1 [498.614944] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.209s) [498.993646] Starting dynamic subtest: pipe-A-HDMI-A-2 [499.178146] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.210s) [499.555463] Starting dynamic subtest: pipe-B-HDMI-A-1 [499.742208] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.211s) [500.203754] Starting dynamic subtest: pipe-B-HDMI-A-2 [500.406205] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.207s) [500.707179] Starting dynamic subtest: pipe-C-HDMI-A-1 [500.973232] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.242s) [501.337755] Starting dynamic subtest: pipe-C-HDMI-A-2 [501.347472] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.206s) [501.350687] Subtest test-time-stamp-atomic: SUCCESS (3.539s) [502.015265] [074/131] (562s left) kms_plane_cursor (primary) [502.212861] Starting subtest: primary [502.242293] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [504.810877] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.597s) [504.883966] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [507.294502] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.430s) [507.371611] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [509.776108] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.430s) [510.079809] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64 [512.546849] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.513s) [512.607373] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128 [515.017898] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.432s) [515.077541] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256 [517.466821] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.415s) [517.755388] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [520.207892] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.506s) [520.265947] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [522.675309] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.432s) [522.732626] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [525.141843] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.432s) [525.383549] Subtest primary: SUCCESS (23.172s) [525.719409] [075/131] (539s left) gem_softpin (noreloc) [525.851030] Starting subtest: noreloc [531.375375] Subtest noreloc: SUCCESS (5.518s) [531.579985] [076/131] (533s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [531.793186] Starting subtest: fbcpsr-farfromfence-mmap-gtt [531.799557] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [531.983663] [077/131] (533s left) gem_lmem_evict (dontneed-evict-race) [532.103641] Subtest dontneed-evict-race: SKIP (0.000s) [532.231877] [078/131] (533s left) gem_userptr_blits (dmabuf-unsync) [532.357887] Subtest dmabuf-unsync: SKIP (0.000s) [532.582961] [079/131] (532s left) i915_hangman (gt-engine-hang) [532.728832] Starting subtest: gt-engine-hang [532.732659] Starting dynamic subtest: rcs0 [533.315057] Dynamic subtest rcs0: SUCCESS (0.586s) [533.344089] Starting dynamic subtest: bcs0 [533.899557] Dynamic subtest bcs0: SUCCESS (0.581s) [533.927706] Starting dynamic subtest: vcs0 [534.497159] Dynamic subtest vcs0: SUCCESS (0.594s) [534.530736] Starting dynamic subtest: vecs0 [535.087425] Dynamic subtest vecs0: SUCCESS (0.585s) [535.090705] Subtest gt-engine-hang: SUCCESS (2.364s) [535.283395] [080/131] (530s left) kms_psr (psr2-primary-render) [535.478733] Subtest psr2-primary-render: SKIP (0.000s) [535.596863] [081/131] (529s left) gem_shrink (reclaim) [535.724892] Starting subtest: reclaim [537.967740] Subtest reclaim: SUCCESS (2.245s) [538.264842] [082/131] (527s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [538.690538] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [538.759880] Starting dynamic subtest: pipe-A-valid-mode [539.036429] Dynamic subtest pipe-A-valid-mode: SKIP (0.384s) [539.175873] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.389s) [539.743498] [083/131] (526s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [539.953709] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [541.960340] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.013s) [542.295941] [084/131] (524s left) gem_exec_suspend (basic-s3) [542.426311] Starting subtest: basic-S3 [542.429716] Starting dynamic subtest: smem