[61.074469] Initializing watchdogs [61.074534] /dev/watchdog0 [61.092575] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [61.102424] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [61.105739] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.109184] [001/130] (960s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [61.436762] Starting subtest: fbc-rgb101010-draw-pwrite [64.377871] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.948s) [64.535985] [002/130] (957s left) kms_flip (2x-plain-flip-ts-check) [64.738119] Starting subtest: 2x-plain-flip-ts-check [64.752501] Subtest 2x-plain-flip-ts-check: SKIP (0.014s) [64.860809] [003/130] (956s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [65.064449] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [65.108060] [004/130] (956s left) kms_flip (2x-flip-vs-suspend-interruptible) [65.312176] Starting subtest: 2x-flip-vs-suspend-interruptible [65.327259] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.014s) [65.434137] [005/130] (956s left) kms_flip (2x-nonexisting-fb-interruptible) [65.641134] Starting subtest: 2x-nonexisting-fb-interruptible [65.656375] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.014s) [65.758720] [006/130] (956s left) kms_flip (2x-plain-flip) [65.959068] Starting subtest: 2x-plain-flip [65.973516] Subtest 2x-plain-flip: SKIP (0.014s) [66.067402] [007/130] (955s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [66.270194] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [66.271149] Starting dynamic subtest: pipe-A-DP-3 [66.278769] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s) [66.286166] Starting dynamic subtest: pipe-B-DP-3 [66.295443] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s) [66.302547] Starting dynamic subtest: pipe-C-DP-3 [66.310509] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s) [66.318280] Starting dynamic subtest: pipe-D-DP-3 [66.325895] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s) [66.326780] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.012s) [66.723991] [008/130] (955s left) syncobj_wait (wait-all-for-submit-complex) [66.886375] Starting subtest: wait-all-for-submit-complex [67.101043] Subtest wait-all-for-submit-complex: SUCCESS (0.215s) [67.219344] [009/130] (954s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [67.638951] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [67.736598] [010/130] (954s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [68.046737] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [68.048380] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [68.172970] [011/130] (953s left) kms_dirtyfb (default-dirtyfb-ioctl) [68.386257] Starting subtest: default-dirtyfb-ioctl [68.387202] Starting dynamic subtest: A-DP-3 [69.832750] Dynamic subtest A-DP-3: SUCCESS (1.447s) [69.833671] Subtest default-dirtyfb-ioctl: SUCCESS (1.448s) [70.087390] [012/130] (952s left) gem_mmap_gtt (cpuset-big-copy-xy) [70.156992] Subtest cpuset-big-copy-XY: SKIP (0.000s) [70.213919] [013/130] (952s left) prime_vgem (basic-fence-mmap) [70.348512] Starting subtest: basic-fence-mmap [70.350544] Subtest basic-fence-mmap: SKIP (0.000s) [70.476404] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true [70.478310] [014/130] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [70.698686] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [70.700435] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [70.834654] [015/130] (951s left) i915_hangman (engine-engine-error) [70.925126] Starting subtest: engine-engine-error [70.926054] Starting dynamic subtest: rcs0 [71.731710] Dynamic subtest rcs0: SUCCESS (0.807s) [71.741473] Starting dynamic subtest: bcs0 [72.535494] Dynamic subtest bcs0: SUCCESS (0.804s) [72.543234] Starting dynamic subtest: vcs0 [73.336397] Dynamic subtest vcs0: SUCCESS (0.801s) [73.344501] Starting dynamic subtest: vcs1 [74.186872] Dynamic subtest vcs1: SUCCESS (0.850s) [74.196862] Starting dynamic subtest: vecs0 [74.989498] Dynamic subtest vecs0: SUCCESS (0.803s) [74.997344] Starting dynamic subtest: vecs1 [75.829741] Dynamic subtest vecs1: SUCCESS (0.840s) [75.839989] Starting dynamic subtest: ccs0 [76.677645] Dynamic subtest ccs0: SUCCESS (0.848s) [76.678760] Subtest engine-engine-error: SUCCESS (5.756s) [76.838800] [016/130] (945s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [77.048364] Starting subtest: plane-all-modeset-transition-fencing [77.050254] Starting dynamic subtest: pipe-A-DP-3 [109.146993] Dynamic subtest pipe-A-DP-3: SUCCESS (32.095s) [109.247591] Starting dynamic subtest: pipe-B-DP-3 [137.855910] Dynamic subtest pipe-B-DP-3: SUCCESS (28.635s) [137.908748] Subtest plane-all-modeset-transition-fencing: SUCCESS (60.858s) [138.139343] [017/130] (884s left) kms_big_fb (x-tiled-32bpp-rotate-90) [138.357208] Starting subtest: x-tiled-32bpp-rotate-90 [138.413589] Subtest x-tiled-32bpp-rotate-90: SKIP (0.056s) [138.595598] [018/130] (883s left) gem_create (create-ext-set-pat) [138.788664] Starting subtest: create-ext-set-pat [138.790497] Subtest create-ext-set-pat: SKIP (0.000s) [138.906618] [019/130] (883s left) syncobj_timeline (invalid-query-bad-pad) [138.983504] Starting subtest: invalid-query-bad-pad [138.984451] Subtest invalid-query-bad-pad: SUCCESS (0.000s) [139.147166] [020/130] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [139.359600] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [139.361341] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [139.500657] [021/130] (883s left) gem_exec_async (concurrent-writes) [139.592451] Starting subtest: concurrent-writes [139.593458] Starting dynamic subtest: rcs0 [139.632384] Dynamic subtest rcs0: SUCCESS (0.040s) [139.640681] Starting dynamic subtest: bcs0 [139.642860] Dynamic subtest bcs0: SUCCESS (0.010s) [139.651175] Starting dynamic subtest: vcs0 [139.653193] Dynamic subtest vcs0: SUCCESS (0.010s) [139.660867] Starting dynamic subtest: vcs1 [139.663034] Dynamic subtest vcs1: SUCCESS (0.009s) [139.670583] Starting dynamic subtest: vecs0 [139.671480] Dynamic subtest vecs0: SUCCESS (0.009s) [139.679117] Starting dynamic subtest: vecs1 [139.680040] Dynamic subtest vecs1: SUCCESS (0.008s) [139.688565] Starting dynamic subtest: ccs0 [139.689456] Dynamic subtest ccs0: SUCCESS (0.008s) [139.690269] Subtest concurrent-writes: SUCCESS (0.096s) [139.959754] [022/130] (882s left) i915_suspend (forcewake) [140.051056] Starting subtest: forcewake [179.493301] Subtest forcewake: SUCCESS (7.243s) [179.585558] [023/130] (875s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [179.791124] Starting subtest: random-ccs-data-yf-tiled-ccs [179.792070] Starting dynamic subtest: pipe-A-DP-3 [179.801820] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [179.811148] Starting dynamic subtest: pipe-B-DP-3 [179.820827] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [179.829919] Starting dynamic subtest: pipe-C-DP-3 [179.839195] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [179.848325] Starting dynamic subtest: pipe-D-DP-3 [179.860279] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [179.862285] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s) [180.237741] [024/130] (874s left) kms_dp_linktrain_fallback (dsc-fallback) [180.445396] Starting subtest: dsc-fallback [180.448111] Subtest dsc-fallback: SKIP (0.000s) [180.533823] [025/130] (874s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [180.740223] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [180.741154] Starting dynamic subtest: pipe-A-valid-mode [180.812342] Dynamic subtest pipe-A-valid-mode: SKIP (0.071s) [180.814094] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.071s) [181.023719] [026/130] (874s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [181.237157] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [181.237967] Starting dynamic subtest: pipe-A [183.269803] Dynamic subtest pipe-A: SUCCESS (2.032s) [183.288201] Starting dynamic subtest: pipe-B [185.493824] Dynamic subtest pipe-B: SUCCESS (2.223s) [185.512376] Starting dynamic subtest: pipe-C [185.814025] Dynamic subtest pipe-C: SUCCESS (0.319s) [185.842143] Starting dynamic subtest: pipe-D [186.136791] Dynamic subtest pipe-D: SUCCESS (0.322s) [186.138045] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (4.899s) [186.479073] [027/130] (868s left) perf (gen12-group-exclusive-stream-ctx-handle) [186.843401] Starting subtest: gen12-group-exclusive-stream-ctx-handle [186.869188] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s) [186.926494] [028/130] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [187.216230] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [187.218134] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [187.352609] [029/130] (868s left) gem_exec_reloc (basic-range-active) [187.440500] Subtest basic-range-active: SKIP (0.000s) [187.526055] [030/130] (867s left) gem_exec_gttfill (engines) [187.615908] Starting subtest: engines [187.616882] Starting dynamic subtest: rcs0 [213.251510] Dynamic subtest rcs0: SUCCESS (25.633s) [213.261427] Starting dynamic subtest: bcs0 [238.954036] Dynamic subtest bcs0: SUCCESS (25.703s) [238.964237] Starting dynamic subtest: vcs0 [264.638981] Dynamic subtest vcs0: SUCCESS (25.685s) [264.648849] Starting dynamic subtest: vcs1 [290.330488] Dynamic subtest vcs1: SUCCESS (25.691s) [290.340672] Starting dynamic subtest: vecs0 [316.004319] Dynamic subtest vecs0: SUCCESS (25.673s) [316.015056] Starting dynamic subtest: vecs1 [341.800915] Dynamic subtest vecs1: SUCCESS (25.796s) [341.811110] Starting dynamic subtest: ccs0 [367.485470] Dynamic subtest ccs0: SUCCESS (25.683s) [367.486432] Subtest engines: SUCCESS (179.868s) [367.725115] [031/130] (687s left) kms_cursor_crc (cursor-offscreen-64x64) [368.099226] Starting subtest: cursor-offscreen-64x64 [368.103388] Starting dynamic subtest: pipe-A-DP-3 [370.570002] Dynamic subtest pipe-A-DP-3: SUCCESS (2.467s) [370.619449] Starting dynamic subtest: pipe-D-DP-3 [373.106635] Dynamic subtest pipe-D-DP-3: SUCCESS (2.497s) [373.107604] Subtest cursor-offscreen-64x64: SUCCESS (5.006s) [373.554007] [032/130] (682s left) gem_ccs (block-multicopy-compressed) [373.642098] Starting subtest: block-multicopy-compressed [373.643080] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy [373.682282] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.039s) [373.692234] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy [373.782887] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.100s) [373.792871] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy [373.800232] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s) [373.810200] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy [373.900321] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.100s) [373.910478] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy [373.925329] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s) [373.935521] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy [374.021509] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.103s) [374.031439] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy [374.037233] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s) [374.047198] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy [374.138553] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s) [374.139459] Subtest block-multicopy-compressed: SUCCESS (0.497s) [374.271221] [033/130] (681s left) kms_chamelium_color (ctm-negative) [374.480264] Subtest ctm-negative: SKIP (0.000s) [374.540388] [034/130] (681s left) kms_cursor_crc (cursor-rapid-movement-256x256) [374.912967] Starting subtest: cursor-rapid-movement-256x256 [374.917407] Starting dynamic subtest: pipe-A-DP-3 [375.364207] Dynamic subtest pipe-A-DP-3: SUCCESS (0.446s) [375.414773] Starting dynamic subtest: pipe-D-DP-3 [375.783414] Dynamic subtest pipe-D-DP-3: SUCCESS (0.379s) [375.784436] Subtest cursor-rapid-movement-256x256: SUCCESS (0.871s) [376.140271] [035/130] (679s left) sw_sync (timeline_closed_signaled) [376.198229] Starting subtest: timeline_closed_signaled [376.199194] Subtest timeline_closed_signaled: SUCCESS (0.000s) [376.265341] [036/130] (679s left) gem_exec_params (invalid-fence-in) [376.357480] Starting subtest: invalid-fence-in [376.358456] Subtest invalid-fence-in: SUCCESS (0.000s) [376.555349] [037/130] (679s left) gem_ctx_param (invalid-set-ringsize) [376.635421] Starting subtest: invalid-set-ringsize [376.636329] Subtest invalid-set-ringsize: SUCCESS (0.000s) [376.739802] [038/130] (679s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [376.944256] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [376.945194] Starting dynamic subtest: pipe-A-DP-3 [376.953951] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [376.963921] Starting dynamic subtest: pipe-B-DP-3 [376.972819] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [376.982519] Starting dynamic subtest: pipe-C-DP-3 [376.991091] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [377.000732] Starting dynamic subtest: pipe-D-DP-3 [377.012073] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [377.014527] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.004s) [377.385920] [039/130] (678s left) kms_chamelium_frames (hdmi-crc-multiple) [377.672330] Subtest hdmi-crc-multiple: SKIP (0.000s) [377.853736] [040/130] (678s left) kms_getfb (getfb2-handle-zero) [377.937123] Starting subtest: getfb2-handle-zero [377.938096] Subtest getfb2-handle-zero: SUCCESS (0.000s) [378.073762] [041/130] (678s left) gem_softpin (evict-active) [378.159020] Starting subtest: evict-active [378.181143] Subtest evict-active: SUCCESS (0.022s) [378.323507] [042/130] (677s left) kms_color (gamma) [378.531216] Starting subtest: gamma [378.532163] Starting dynamic subtest: pipe-A-DP-3 [379.166224] Dynamic subtest pipe-A-DP-3: SUCCESS (0.633s) [379.182350] Starting dynamic subtest: pipe-B-DP-3 [379.732620] Dynamic subtest pipe-B-DP-3: SUCCESS (0.567s) [379.744511] Starting dynamic subtest: pipe-C-DP-3 [380.330385] Dynamic subtest pipe-C-DP-3: SUCCESS (0.597s) [380.342485] Starting dynamic subtest: pipe-D-DP-3 [380.930617] Dynamic subtest pipe-D-DP-3: SUCCESS (0.599s) [380.931533] Subtest gamma: SUCCESS (2.399s) [381.216844] [043/130] (675s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [381.428664] Starting subtest: cursorB-vs-flipA-legacy [381.431510] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s) [381.526753] [044/130] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [381.750339] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [381.752500] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [381.871199] [045/130] (674s left) dmabuf_sync_file (import-multiple-read-only) [381.939930] Starting subtest: import-multiple-read-only [381.943390] Subtest import-multiple-read-only: SUCCESS (0.004s) [382.032408] [046/130] (674s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [382.247475] Starting subtest: primary-y-tiled-reflect-x-180 [382.340185] Subtest primary-y-tiled-reflect-x-180: SKIP (0.091s) [382.560904] [047/130] (674s left) api_intel_allocator (reopen) [382.638195] Starting subtest: reopen [382.660186] Subtest reopen: SUCCESS (0.022s) [382.856473] [048/130] (673s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [382.939379] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [383.013801] [049/130] (673s left) gem_wait (write-busy) [383.105449] Starting subtest: write-busy [383.106389] Starting dynamic subtest: all-engines [383.724336] Dynamic subtest all-engines: SUCCESS (0.618s) [383.739839] Starting dynamic subtest: rcs0 [384.281055] Dynamic subtest rcs0: SUCCESS (0.556s) [384.292060] Starting dynamic subtest: bcs0 [384.827312] Dynamic subtest bcs0: SUCCESS (0.546s) [384.838089] Starting dynamic subtest: vcs0 [385.370043] Dynamic subtest vcs0: SUCCESS (0.542s) [385.380772] Starting dynamic subtest: vcs1 [385.912322] Dynamic subtest vcs1: SUCCESS (0.542s) [385.922797] Starting dynamic subtest: vecs0 [386.453127] Dynamic subtest vecs0: SUCCESS (0.540s) [386.463729] Starting dynamic subtest: vecs1 [386.994232] Dynamic subtest vecs1: SUCCESS (0.541s) [387.004747] Starting dynamic subtest: ccs0 [387.535310] Dynamic subtest ccs0: SUCCESS (0.540s) [387.536235] Subtest write-busy: SUCCESS (4.430s) [387.810881] [050/130] (669s left) kms_big_fb (linear-32bpp-rotate-0) [388.032274] Starting subtest: linear-32bpp-rotate-0 [389.941051] Subtest linear-32bpp-rotate-0: SUCCESS (1.908s) [390.141884] [051/130] (666s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [390.358072] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [390.359788] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [390.494864] [052/130] (666s left) gem_exec_schedule (noreorder-corked) [390.741241] Starting subtest: noreorder-corked [390.742765] Starting dynamic subtest: rcs0 [391.873429] Dynamic subtest rcs0: SUCCESS (1.132s) [391.884337] Starting dynamic subtest: bcs0 [393.006385] Dynamic subtest bcs0: SUCCESS (1.132s) [393.017452] Starting dynamic subtest: vcs0 [394.129211] Dynamic subtest vcs0: SUCCESS (1.122s) [394.139667] Starting dynamic subtest: vcs1 [395.230347] Dynamic subtest vcs1: SUCCESS (1.101s) [395.240740] Starting dynamic subtest: vecs0 [396.357229] Dynamic subtest vecs0: SUCCESS (1.126s) [396.368129] Starting dynamic subtest: vecs1 [397.487275] Dynamic subtest vecs1: SUCCESS (1.129s) [397.498149] Starting dynamic subtest: ccs0 [398.627511] Dynamic subtest ccs0: SUCCESS (1.140s) [398.628738] Subtest noreorder-corked: SUCCESS (7.887s) [398.872320] [053/130] (658s left) syncobj_timeline (invalid-single-wait-unsubmitted) [398.949612] Starting subtest: invalid-single-wait-unsubmitted [398.950512] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [399.093704] [054/130] (658s left) kms_psr (pr-primary-mmap-cpu) [399.306606] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [399.363420] [055/130] (657s left) syncobj_eventfd (timeline-wait-before-signal) [399.444532] Starting subtest: timeline-wait-before-signal [399.475792] Subtest timeline-wait-before-signal: SUCCESS (0.031s) [399.619269] [056/130] (657s left) gem_exec_balancer (individual) [399.710427] Starting subtest: individual [401.425505] Subtest individual: SUCCESS (1.715s) [401.820303] [057/130] (655s left) kms_pm_dc (dc5-dpms) [403.048222] Starting subtest: dc5-dpms [404.359006] Subtest dc5-dpms: SUCCESS (1.310s) [404.461879] [058/130] (652s left) kms_big_fb (x-tiled-8bpp-rotate-180) [404.676093] Starting subtest: x-tiled-8bpp-rotate-180 [406.088189] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.412s) [406.303462] [059/130] (651s left) i915_pm_freq_api (freq-basic-api) [406.394481] Starting subtest: freq-basic-api [406.395678] Starting dynamic subtest: gt0 [406.398481] Dynamic subtest gt0: SUCCESS (0.004s) [406.399386] Subtest freq-basic-api: SUCCESS (0.004s) [406.538853] [060/130] (650s left) gem_userptr_blits (usage-restrictions) [406.625236] Starting subtest: usage-restrictions [406.626162] Subtest usage-restrictions: SUCCESS (0.000s) [406.790107] [061/130] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [407.006097] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [409.389469] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.385s) [409.590892] [062/130] (648s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [409.811695] Starting subtest: plane-use-after-nonblocking-unbind-fencing [409.814005] Starting dynamic subtest: pipe-A-DP-3 [409.888632] Dynamic subtest pipe-A-DP-3: SUCCESS (0.075s) [410.001938] Starting dynamic subtest: pipe-B-DP-3 [410.113446] Dynamic subtest pipe-B-DP-3: SUCCESS (0.146s) [410.164755] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.352s) [410.439898] [063/130] (647s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [410.516013] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [410.618541] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.102s) [410.768547] [064/130] (647s left) gem_exec_schedule (u-submit-late-slice) [410.858392] Starting subtest: u-submit-late-slice [410.859375] Starting dynamic subtest: rcs0 [410.926524] Dynamic subtest rcs0: SUCCESS (0.068s) [410.937639] Starting dynamic subtest: bcs0 [410.967725] Dynamic subtest bcs0: SUCCESS (0.041s) [410.978870] Starting dynamic subtest: vcs0 [411.012135] Dynamic subtest vcs0: SUCCESS (0.044s) [411.023231] Starting dynamic subtest: vcs1 [411.050691] Dynamic subtest vcs1: SUCCESS (0.038s) [411.062102] Starting dynamic subtest: vecs0 [411.094118] Dynamic subtest vecs0: SUCCESS (0.043s) [411.105492] Starting dynamic subtest: vecs1 [411.134299] Dynamic subtest vecs1: SUCCESS (0.040s) [411.146091] Starting dynamic subtest: ccs0 [411.180024] Dynamic subtest ccs0: SUCCESS (0.045s) [411.180973] Subtest u-submit-late-slice: SUCCESS (0.322s) [411.655599] [065/130] (646s left) sysfs_timeslice_duration (invalid) [411.736466] Starting subtest: invalid [411.737390] Starting dynamic subtest: vecs0 [411.738297] Dynamic subtest vecs0: SUCCESS (0.000s) [411.749556] Starting dynamic subtest: ccs0 [411.750745] Dynamic subtest ccs0: SUCCESS (0.000s) [411.761724] Starting dynamic subtest: vcs0 [411.762899] Dynamic subtest vcs0: SUCCESS (0.000s) [411.773831] Starting dynamic subtest: bcs0 [411.775184] Dynamic subtest bcs0: SUCCESS (0.000s) [411.786087] Starting dynamic subtest: vecs1 [411.787704] Dynamic subtest vecs1: SUCCESS (0.000s) [411.807513] Starting dynamic subtest: rcs0 [411.808470] Dynamic subtest rcs0: SUCCESS (0.000s) [411.819171] Starting dynamic subtest: vcs1 [411.820431] Dynamic subtest vcs1: SUCCESS (0.000s) [411.821755] Subtest invalid: SUCCESS (0.007s) [411.863464] [066/130] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [412.076932] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [412.078710] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [412.203823] [067/130] (645s left) kms_plane (plane-position-hole-dpms) [412.412310] Starting subtest: plane-position-hole-dpms [412.832817] Starting dynamic subtest: pipe-A-plane-1 [413.482266] Dynamic subtest pipe-A-plane-1: SUCCESS (0.650s) [413.499383] Starting dynamic subtest: pipe-A-plane-2 [414.196116] Dynamic subtest pipe-A-plane-2: SUCCESS (0.714s) [414.210376] Starting dynamic subtest: pipe-A-plane-3 [414.895072] Dynamic subtest pipe-A-plane-3: SUCCESS (0.698s) [414.917597] Starting dynamic subtest: pipe-A-plane-4 [415.570237] Dynamic subtest pipe-A-plane-4: SUCCESS (0.673s) [415.587022] Starting dynamic subtest: pipe-A-plane-5 [415.592000] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s) [415.940112] Starting dynamic subtest: pipe-B-plane-1 [416.546751] Dynamic subtest pipe-B-plane-1: SUCCESS (0.619s) [416.558464] Starting dynamic subtest: pipe-B-plane-2 [417.185412] Dynamic subtest pipe-B-plane-2: SUCCESS (0.638s) [417.196899] Starting dynamic subtest: pipe-B-plane-3 [417.819424] Dynamic subtest pipe-B-plane-3: SUCCESS (0.633s) [417.831349] Starting dynamic subtest: pipe-B-plane-4 [418.459387] Dynamic subtest pipe-B-plane-4: SUCCESS (0.639s) [418.471166] Starting dynamic subtest: pipe-B-plane-5 [418.480408] Dynamic subtest pipe-B-plane-5: SUCCESS (0.018s) [418.481371] Subtest plane-position-hole-dpms: SUCCESS (6.066s) [418.760797] [068/130] (639s left) kms_psr (psr-sprite-plane-onoff) [418.969293] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [419.046385] [069/130] (639s left) gem_partial_pwrite_pread (write-snoop) [419.130155] Subtest write-snoop: SKIP (0.000s) [419.232547] [070/130] (638s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [419.453302] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [419.455173] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [419.619746] [071/130] (638s left) gem_softpin (allocator-fork) [419.704979] Starting subtest: allocator-fork [421.981038] Subtest allocator-fork: SUCCESS (2.276s) [422.163473] [072/130] (636s left) gem_ctx_param (root-set) [422.241835] Starting subtest: root-set [422.242796] Subtest root-set: SUCCESS (0.001s) [422.391085] [073/130] (636s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [422.603454] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [422.605650] Starting dynamic subtest: pipe-A-DP-3 [442.092680] Dynamic subtest pipe-A-DP-3: SUCCESS (4.156s) [442.135748] Starting dynamic subtest: pipe-B-DP-3 [461.430027] Dynamic subtest pipe-B-DP-3: SUCCESS (3.893s) [461.441890] Starting dynamic subtest: pipe-C-DP-3 [480.840149] Dynamic subtest pipe-C-DP-3: SUCCESS (3.668s) [480.852025] Starting dynamic subtest: pipe-D-DP-3 [500.227388] Dynamic subtest pipe-D-DP-3: SUCCESS (3.709s) [500.228355] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SUCCESS (15.437s) [500.553668] [074/130] (620s left) gem_exec_whisper (basic-queues-priority-all) [500.648442] Starting subtest: basic-queues-priority-all [522.654836] Subtest basic-queues-priority-all: SUCCESS (22.005s) [522.911916] [075/130] (597s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [523.132698] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [523.134440] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [523.274369] [076/130] (597s left) gem_mmap (pf-nonblock) [523.362324] Subtest pf-nonblock: SKIP (0.000s) [523.457677] [077/130] (597s left) kms_sequence (get-idle) [523.669685] Starting subtest: get-idle [523.672095] Starting dynamic subtest: pipe-A-DP-3 [526.056364] Dynamic subtest pipe-A-DP-3: SUCCESS (2.385s) [526.070447] Starting dynamic subtest: pipe-B-DP-3 [528.358050] Dynamic subtest pipe-B-DP-3: SUCCESS (2.300s) [528.372060] Starting dynamic subtest: pipe-C-DP-3 [530.671459] Dynamic subtest pipe-C-DP-3: SUCCESS (2.312s) [530.687013] Starting dynamic subtest: pipe-D-DP-3 [532.990142] Dynamic subtest pipe-D-DP-3: SUCCESS (2.313s) [532.991037] Subtest get-idle: SUCCESS (9.317s) [533.273655] [078/130] (587s left) kms_psr (fbc-pr-sprite-mmap-cpu) [533.490591] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [533.554005] [079/130] (587s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [533.776227] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [533.778139] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [533.929783] [080/130] (587s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [534.138726] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [534.141166] Starting dynamic subtest: pipe-A-DP-3 [534.144823] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [534.156992] Starting dynamic subtest: pipe-B-DP-3 [534.160585] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [534.172523] Starting dynamic subtest: pipe-C-DP-3 [534.176155] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [534.187954] Starting dynamic subtest: pipe-D-DP-3 [534.191461] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [534.193462] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.007s) [534.581494] [081/130] (586s left) gem_pxp (fail-invalid-protected-context) [537.190782] Starting subtest: fail-invalid-protected-context [537.192877] Subtest fail-invalid-protected-context: SKIP (0.000s) [537.295259] [082/130] (583s left) kms_vblank (wait-forked) [537.512711] Starting subtest: wait-forked [537.515116] Starting dynamic subtest: pipe-A-DP-3 [539.889464] Dynamic subtest pipe-A-DP-3: SUCCESS (2.373s) [539.922063] Starting dynamic subtest: pipe-D-DP-3 [542.215392] Dynamic subtest pipe-D-DP-3: SUCCESS (2.312s) [542.216726] Subtest wait-forked: SUCCESS (4.700s) [542.475579] [083/130] (578s left) kms_hdmi_inject (inject-4k) [542.636344] Starting subtest: inject-4k [542.811168] Subtest inject-4k: SUCCESS (0.176s) [543.191317] [084/130] (578s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [543.402229] Starting subtest: fbcpsr-indfb-scaledprimary [543.404084] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s) [543.572718] [085/130] (577s left) gem_exec_big (single) [543.664551] Starting subtest: single [548.901531] Subtest single: SUCCESS (5.235s) [549.569516] [086/130] (572s left) api_intel_bb (render-ccs) [549.683618] Starting subtest: render-ccs [549.771751] Subtest render-ccs: SUCCESS (0.088s) [549.914814] [087/130] (571s left) gem_spin_batch (spin-each) [550.008015] Starting subtest: spin-each [553.423697] Subtest spin-each: SUCCESS (3.414s) [553.752942] [088/130] (567s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [553.982233] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [553.984114] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [554.125705] [089/130] (567s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [554.332782] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [554.335162] Starting dynamic subtest: pipe-A-valid-mode [556.094590] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.760s) [556.095569] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (1.761s) [556.371839] [090/130] (565s left) syncobj_timeline (wait-for-submit-complex) [556.464439] Starting subtest: wait-for-submit-complex [556.527924] Subtest wait-for-submit-complex: SUCCESS (0.063s) [556.670129] [091/130] (565s left) gem_userptr_blits (unsync-unmap-cycles) [556.766139] Subtest unsync-unmap-cycles: SKIP (0.000s) [556.953637] [092/130] (565s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [557.176892] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [557.178626] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [557.323795] [093/130] (564s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [557.532424] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s) [557.590570] [094/130] (564s left) kms_joiner (basic-max-non-joiner) [557.809774] Starting subtest: basic-max-non-joiner [557.811575] Subtest basic-max-non-joiner: SKIP (0.000s) [557.898785] [095/130] (564s left) gem_exec_schedule (preempt-user) [557.994473] Starting subtest: preempt-user [557.995404] Starting dynamic subtest: rcs0 [558.052074] Dynamic subtest rcs0: SUCCESS (0.057s) [558.066182] Starting dynamic subtest: bcs0 [558.083812] Dynamic subtest bcs0: SUCCESS (0.030s) [558.096483] Starting dynamic subtest: vcs0 [558.116250] Dynamic subtest vcs0: SUCCESS (0.031s) [558.130478] Starting dynamic subtest: vcs1 [558.145684] Dynamic subtest vcs1: SUCCESS (0.028s) [558.159686] Starting dynamic subtest: vecs0 [558.174201] Dynamic subtest vecs0: SUCCESS (0.027s) [558.188542] Starting dynamic subtest: vecs1 [558.203003] Dynamic subtest vecs1: SUCCESS (0.028s) [558.217325] Starting dynamic subtest: ccs0 [558.234962] Dynamic subtest ccs0: SUCCESS (0.031s) [558.235833] Subtest preempt-user: SUCCESS (0.241s) [558.675330] [096/130] (563s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [558.889913] Starting subtest: basic-max-pipe-crc-check [558.892102] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [558.958417] [097/130] (563s left) kms_pm_rpm (fences) [561.422041] Starting subtest: fences [561.424837] Subtest fences: SKIP (0.000s) [561.801803] [098/130] (560s left) kms_addfb_basic (bo-too-small) [562.010818] Starting subtest: bo-too-small [562.011728] Subtest bo-too-small: SUCCESS (0.000s) [562.163710] [099/130] (560s left) gem_exec_params (invalid-bsd2-flag-on-blt) [562.260900] Starting subtest: invalid-bsd2-flag-on-blt [562.262070] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [562.440746] [100/130] (560s left) syncobj_timeline (reset-during-wait-for-submit) [562.521318] Starting subtest: reset-during-wait-for-submit [562.625966] Subtest reset-during-wait-for-submit: SUCCESS (0.104s) [562.734777] [101/130] (559s left) kms_async_flips (crc-atomic) [562.950201] Starting subtest: crc-atomic [563.180561] Starting dynamic subtest: pipe-A-DP-3 [565.563591] Dynamic subtest pipe-A-DP-3: SUCCESS (2.382s) [565.780745] Starting dynamic subtest: pipe-B-DP-3 [568.008441] Dynamic subtest pipe-B-DP-3: SUCCESS (2.241s) [568.186962] Starting dynamic subtest: pipe-C-DP-3 [570.423541] Dynamic subtest pipe-C-DP-3: SUCCESS (2.248s) [570.611988] Starting dynamic subtest: pipe-D-DP-3 [572.830799] Dynamic subtest pipe-D-DP-3: SUCCESS (2.234s) [572.832122] Subtest crc-atomic: SUCCESS (9.880s) [573.293599] [102/130] (549s left) syncobj_wait (invalid-reset-one-illegal-handle) [573.373715] Starting subtest: invalid-reset-one-illegal-handle [573.374786] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [573.517093] [103/130] (549s left) core_getstats [573.766203] [104/130] (549s left) perf (polling) [573.978210] Starting subtest: polling [573.979220] Starting dynamic subtest: 0-rcs0 [584.002535] Dynamic subtest 0-rcs0: SUCCESS (10.023s) [584.003547] Subtest polling: SUCCESS (10.024s) [584.068112] [105/130] (538s left) gem_userptr_blits (map-fixed-invalidate-busy) [584.167504] Starting subtest: map-fixed-invalidate-busy [584.169542] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [584.344415] [106/130] (538s left) gem_mmap_gtt (big-copy-xy) [584.423772] Subtest big-copy-XY: SKIP (0.000s) [584.498972] [107/130] (538s left) kms_big_fb (4-tiled-64bpp-rotate-270) [584.719468] Starting subtest: 4-tiled-64bpp-rotate-270 [584.773641] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.052s) [584.952103] [108/130] (538s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [585.175071] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [585.231151] [109/130] (537s left) fbdev (eof) [585.288758] Starting subtest: eof [585.289689] Subtest eof: SUCCESS (0.000s) [585.378116] [110/130] (537s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [585.589477] Starting subtest: 2x-wf_vblank-ts-check-interruptible [585.604600] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.014s) [585.712161] [111/130] (537s left) gem_exec_reloc (basic-gtt-active) [585.796614] Subtest basic-gtt-active: SKIP (0.000s) [585.885920] [112/130] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [586.097209] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [586.098936] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [586.254592] [113/130] (537s left) kms_frontbuffer_tracking (psr-suspend) [586.463075] Starting subtest: psr-suspend [586.464833] Subtest psr-suspend: SKIP (0.000s) [586.589632] [114/130] (536s left) gem_exercise_blt (fast-copy-emit) [586.674827] Starting subtest: fast-copy-emit [586.675750] Starting dynamic subtest: linear-smem-smem-emit [586.714466] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.039s) [586.727025] Starting dynamic subtest: linear-smem-lmem0-emit [586.730360] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s) [586.743095] Starting dynamic subtest: linear-lmem0-smem-emit [586.830557] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.099s) [586.842998] Starting dynamic subtest: linear-lmem0-lmem0-emit [586.928799] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.097s) [586.940884] Starting dynamic subtest: xmajor-smem-smem-emit [586.943608] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.014s) [586.957494] Starting dynamic subtest: xmajor-smem-lmem0-emit [586.958436] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.014s) [586.972452] Starting dynamic subtest: xmajor-lmem0-smem-emit [587.065668] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.106s) [587.078665] Starting dynamic subtest: xmajor-lmem0-lmem0-emit [587.165771] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.099s) [587.178378] Starting dynamic subtest: tile4-smem-smem-emit [587.182591] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [587.197217] Starting dynamic subtest: tile4-smem-lmem0-emit [587.198214] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.013s) [587.210707] Starting dynamic subtest: tile4-lmem0-smem-emit [587.301970] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.104s) [587.314391] Starting dynamic subtest: tile4-lmem0-lmem0-emit [587.403240] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.100s) [587.415758] Starting dynamic subtest: tile64-smem-smem-emit [587.418415] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.014s) [587.432218] Starting dynamic subtest: tile64-smem-lmem0-emit [587.433233] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.013s) [587.445928] Starting dynamic subtest: tile64-lmem0-smem-emit [587.540044] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.099s) [587.552555] Starting dynamic subtest: tile64-lmem0-lmem0-emit [587.639117] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.105s) [587.640045] Subtest fast-copy-emit: SUCCESS (0.965s) [587.835723] [115/130] (535s left) kms_content_protection (dp-mst-type-0) [588.099747] Starting subtest: dp-mst-type-0 [588.101599] Subtest dp-mst-type-0: SKIP (0.000s) [588.286714] [116/130] (535s left) prime_busy (hang) [588.370855] Starting subtest: hang [588.373488] Starting dynamic subtest: rcs0 [614.943491] Dynamic subtest rcs0: SUCCESS (26.568s) [614.956028] Starting dynamic subtest: bcs0 [622.063469] Dynamic subtest bcs0: SUCCESS (7.118s) [622.076347] Starting dynamic subtest: vcs0 [629.046396] Dynamic subtest vcs0: SUCCESS (6.982s) [629.059315] Starting dynamic subtest: vcs1 [636.009795] Dynamic subtest vcs1: SUCCESS (6.962s) [636.022742] Starting dynamic subtest: vecs0 [643.077038] Dynamic subtest vecs0: SUCCESS (7.054s) [643.089672] Starting dynamic subtest: vecs1 [650.025970] Dynamic subtest vecs1: SUCCESS (6.960s) [650.038849] Starting dynamic subtest: ccs0 [663.924886] Dynamic subtest ccs0: SUCCESS (13.898s) [663.925978] Subtest hang: SUCCESS (75.551s) [664.074331] [117/130] (459s left) perf (gen12-unprivileged-single-ctx-counters) [664.248679] Starting subtest: gen12-unprivileged-single-ctx-counters [664.249659] Starting dynamic subtest: rcs0 [664.337853] Dynamic subtest rcs0: SUCCESS (0.088s) [664.338762] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.090s) [664.390098] [118/130] (459s left) prime_self_import (export-vs-gem_close-race) [664.442338] Starting subtest: export-vs-gem_close-race [669.540342] Subtest export-vs-gem_close-race: SUCCESS (5.099s) [669.626954] [119/130] (454s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [669.858694] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [669.860430] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [670.037657] [120/130] (453s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [670.259224] Starting subtest: fbcpsr-slowdraw [670.260936] Subtest fbcpsr-slowdraw: SKIP (0.000s) [670.396275] [121/130] (453s left) kms_psr (pr-sprite-render) [670.604433] Subtest pr-sprite-render: SKIP (0.000s) [670.669810] [122/130] (453s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [673.273075] Starting subtest: verify-pxp-stale-buf-optout-execution [673.275040] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s) [673.391226] [123/130] (450s left) gem_ctx_persistence (legacy-engines-hostile) [673.475293] Starting subtest: legacy-engines-hostile [673.476348] Starting dynamic subtest: render [673.568450] Dynamic subtest render: SUCCESS (0.092s) [673.583873] Starting dynamic subtest: bsd1 [673.636654] Dynamic subtest bsd1: SUCCESS (0.066s) [673.669351] Starting dynamic subtest: bsd2 [673.702571] Dynamic subtest bsd2: SUCCESS (0.064s) [673.731779] Starting dynamic subtest: blt [673.752743] Dynamic subtest blt: SUCCESS (0.048s) [673.783399] Starting dynamic subtest: vebox [673.850393] Dynamic subtest vebox: SUCCESS (0.094s) [673.856362] Subtest legacy-engines-hostile: SUCCESS (0.376s) [674.043532] [124/130] (450s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc) [674.255400] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc [674.257236] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s) [674.407187] [125/130] (449s left) prime_mmap (test_map_unmap) [674.486649] Starting subtest: test_map_unmap [674.487600] Starting dynamic subtest: test_map_unmap-smem [674.534730] Dynamic subtest test_map_unmap-smem: SUCCESS (0.047s) [674.549582] Starting dynamic subtest: test_map_unmap-lmem0 [674.739069] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.203s) [674.740728] Subtest test_map_unmap: SUCCESS (0.253s) [674.899791] [126/130] (449s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [674.987549] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [675.086921] [127/130] (449s left) sw_sync (alloc_fence_invalid_timeline) [675.139119] Starting subtest: alloc_fence_invalid_timeline [675.140088] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [675.208629] [128/130] (449s left) gem_exec_flush (basic-uc-ro-default) [675.303620] Subtest basic-uc-ro-default: SKIP (0.000s) [675.389362] [129/130] (449s left) i915_pm_rpm (gem-execbuf-stress-pc8) [677.537241] Starting subtest: gem-execbuf-stress-pc8 [677.646496] Subtest gem-execbuf-stress-pc8: SKIP (0.109s) [677.933889] [130/130] (446s left) kms_plane_cursor (primary) [678.137675] Starting subtest: primary [678.139567] Starting dynamic subtest: pipe-A-DP-3-size-64 [681.523996] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.385s) [681.610682] Starting dynamic subtest: pipe-A-DP-3-size-128 [685.040535] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.466s) [685.107879] Starting dynamic subtest: pipe-A-DP-3-size-256 [688.557665] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.464s) [688.685358] Starting dynamic subtest: pipe-B-DP-3-size-64 [692.174659] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.506s) [692.222079] Starting dynamic subtest: pipe-B-DP-3-size-128 [695.674574] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.466s) [695.720698] Starting dynamic subtest: pipe-B-DP-3-size-256 [699.158060] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.450s) [699.268282] Starting dynamic subtest: pipe-C-DP-3-size-64 [702.822144] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.570s) [702.870387] Starting dynamic subtest: pipe-C-DP-3-size-128 [706.189254] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.333s) [706.236733] Starting dynamic subtest: pipe-C-DP-3-size-256 [709.672365] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.449s) [709.787636] Starting dynamic subtest: pipe-D-DP-3-size-64 [713.229086] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.460s) [713.274711] Starting dynamic subtest: pipe-D-DP-3-size-128 [716.696139] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.433s) [716.743715] Starting dynamic subtest: pipe-D-DP-3-size-256 [720.045696] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.316s) [720.141643] Subtest primary: SUCCESS (42.003s) [720.462023] Closing watchdogs Done.