[63.295433] Initializing watchdogs [63.295499] /dev/watchdog0 [63.314729] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [63.325826] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [63.329623] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.331959] [001/133] (960s left) syncobj_wait (wait-all-for-submit-snapshot) [63.403456] Starting subtest: wait-all-for-submit-snapshot [63.486304] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [63.626690] [002/133] (960s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [65.128139] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [65.128984] Starting dynamic subtest: pipe-A-HDMI-A-3 [65.137245] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [65.144275] Starting dynamic subtest: pipe-B-HDMI-A-3 [65.152734] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [65.159528] Starting dynamic subtest: pipe-C-HDMI-A-3 [65.167832] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [65.174362] Starting dynamic subtest: pipe-D-HDMI-A-3 [65.183269] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [65.185031] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s) [65.425651] [003/133] (958s left) gem_ctx_sseu (invalid-sseu) [65.504984] Subtest invalid-sseu: SKIP (0.000s) [65.549325] [004/133] (958s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [67.091031] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [68.465043] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.373s) [68.730513] [005/133] (955s left) kms_dp_linktrain_fallback (dsc-fallback) [70.236381] Starting subtest: dsc-fallback [70.238949] Subtest dsc-fallback: SKIP (0.000s) [70.361818] [006/133] (953s left) api_intel_bb (destroy-bb) [70.463968] Starting subtest: destroy-bb [70.500963] Subtest destroy-bb: SUCCESS (0.038s) [70.699535] [007/133] (953s left) gem_mmap_offset (partial-mmap) [70.766964] Starting subtest: partial-mmap [70.767896] Starting dynamic subtest: lmem0 [70.773217] Dynamic subtest lmem0: SUCCESS (0.006s) [70.780843] Starting dynamic subtest: smem0 [70.781899] Dynamic subtest smem0: SUCCESS (0.004s) [70.783085] Subtest partial-mmap: SUCCESS (0.011s) [70.966356] [008/133] (953s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [72.473401] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [72.475152] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [72.697197] [009/133] (951s left) gem_ccs (block-copy-uncompressed) [72.784865] Starting subtest: block-copy-uncompressed [72.785797] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [72.831398] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.046s) [72.838382] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0 [72.846959] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s) [72.854206] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem [72.944944] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.098s) [72.952187] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0 [73.042412] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.097s) [73.049554] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [73.057368] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.014s) [73.064512] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0 [73.072016] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s) [73.079295] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem [73.174623] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.102s) [73.181809] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0 [73.273109] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.098s) [73.280219] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [73.289250] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s) [73.296409] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0 [73.304160] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s) [73.311293] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem [73.409042] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.105s) [73.416232] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0 [73.506381] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.097s) [73.513469] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [73.521272] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.014s) [73.528411] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0 [73.535931] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s) [73.543059] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem [73.624206] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.088s) [73.631382] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0 [73.717045] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.093s) [73.717903] Subtest block-copy-uncompressed: SUCCESS (0.932s) [73.886543] [010/133] (950s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [75.385970] Starting subtest: compare-crc-sanitycheck-xr24 [75.386836] Starting dynamic subtest: pipe-A-HDMI-A-3 [75.907436] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.520s) [75.917448] Starting dynamic subtest: pipe-B-HDMI-A-3 [76.295607] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.386s) [76.304041] Starting dynamic subtest: pipe-C-HDMI-A-3 [76.682445] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.385s) [76.690509] Starting dynamic subtest: pipe-D-HDMI-A-3 [77.053184] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.370s) [77.053996] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.667s) [77.239944] [011/133] (947s left) gem_exec_flush (basic-wb-set-default) [77.313970] Subtest basic-wb-set-default: SKIP (0.000s) [77.382644] [012/133] (947s left) kms_cursor_crc (cursor-rapid-movement-256x85) [79.142541] Starting subtest: cursor-rapid-movement-256x85 [79.147329] Starting dynamic subtest: pipe-A-HDMI-A-3 [79.586072] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.439s) [79.618428] Starting dynamic subtest: pipe-D-HDMI-A-3 [79.913977] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.302s) [79.914932] Subtest cursor-rapid-movement-256x85: SUCCESS (0.771s) [80.273630] [013/133] (944s left) gem_ctx_isolation (preservation) [80.348451] Starting subtest: preservation [80.349380] Starting dynamic subtest: rcs0 [80.767165] Dynamic subtest rcs0: SUCCESS (0.411s) [80.774982] Starting dynamic subtest: bcs0 [81.205282] Dynamic subtest bcs0: SUCCESS (0.433s) [81.212604] Starting dynamic subtest: vcs0 [81.614833] Dynamic subtest vcs0: SUCCESS (0.417s) [81.622177] Starting dynamic subtest: vcs1 [82.061868] Dynamic subtest vcs1: SUCCESS (0.447s) [82.069287] Starting dynamic subtest: vecs0 [82.522488] Dynamic subtest vecs0: SUCCESS (0.465s) [82.529899] Starting dynamic subtest: vecs1 [82.946538] Dynamic subtest vecs1: SUCCESS (0.424s) [82.954305] Starting dynamic subtest: ccs0 [83.366581] Dynamic subtest ccs0: SUCCESS (0.420s) [83.367493] Subtest preservation: SUCCESS (3.017s) [83.646888] [014/133] (941s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [85.152223] Starting subtest: cursorA-vs-flipB-varying-size [85.154068] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [85.285725] [015/133] (939s left) gem_mmap_wc (pf-nonblock) [85.406362] Subtest pf-nonblock: SKIP (0.000s) [85.523640] [016/133] (939s left) perf (sysctl-defaults) [85.664909] Starting subtest: sysctl-defaults [85.666199] Subtest sysctl-defaults: SUCCESS (0.000s) [86.009670] [017/133] (938s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [87.516689] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [87.518260] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [87.729664] [018/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [89.248493] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [89.250081] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [89.461490] [019/133] (935s left) gem_unfence_active_buffers [89.693822] [020/133] (935s left) kms_frontbuffer_tracking (psr-2p-rte) [91.199844] Starting subtest: psr-2p-rte [91.201517] Subtest psr-2p-rte: SKIP (0.000s) [91.410135] [021/133] (933s left) gem_lmem_swapping (verify-random) [95.976092] Starting subtest: verify-random [95.977928] Starting dynamic subtest: lmem0 [104.109367] Dynamic subtest lmem0: SUCCESS (8.132s) [104.110335] Subtest verify-random: SUCCESS (8.132s) [105.070725] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true [105.072256] [022/133] (920s left) gem_exec_schedule (submit-late-slice) [108.695948] Starting subtest: submit-late-slice [108.698134] Starting dynamic subtest: rcs0 [108.787334] Dynamic subtest rcs0: SUCCESS (0.091s) [108.794766] Starting dynamic subtest: bcs0 [108.840162] Dynamic subtest bcs0: SUCCESS (0.053s) [108.847972] Starting dynamic subtest: vcs0 [108.890656] Dynamic subtest vcs0: SUCCESS (0.050s) [108.898437] Starting dynamic subtest: vcs1 [108.943659] Dynamic subtest vcs1: SUCCESS (0.053s) [108.951394] Starting dynamic subtest: vecs0 [108.994185] Dynamic subtest vecs0: SUCCESS (0.050s) [109.001796] Starting dynamic subtest: vecs1 [109.045556] Dynamic subtest vecs1: SUCCESS (0.051s) [109.053171] Starting dynamic subtest: ccs0 [109.096430] Dynamic subtest ccs0: SUCCESS (0.051s) [109.097357] Subtest submit-late-slice: SUCCESS (0.401s) [109.507702] [FACT gem_exec_schedule (submit-late-slice)] new: kernel.kmod_is_loaded.i915: true [109.510155] [023/133] (915s left) sw_sync (timeline_closed) [109.553505] Starting subtest: timeline_closed [109.554419] Subtest timeline_closed: SUCCESS (0.000s) [109.697580] [024/133] (915s left) gem_exec_params (rel-constants-invalid-rel-gen5) [109.771373] Starting subtest: rel-constants-invalid-rel-gen5 [109.772298] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [109.934007] [025/133] (915s left) kms_flip (2x-blocking-absolute-wf_vblank) [111.438914] Starting subtest: 2x-blocking-absolute-wf_vblank [111.451984] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s) [111.628698] [026/133] (913s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [113.160840] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [113.162454] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [113.354345] [027/133] (912s left) perf_pmu (rc6) [113.431043] Starting subtest: rc6 [113.431998] Starting dynamic subtest: gt0 [119.796060] Dynamic subtest gt0: SUCCESS (6.363s) [119.808169] Starting dynamic subtest: runtime-pm-gt0 [127.868489] Dynamic subtest runtime-pm-gt0: SUCCESS (8.071s) [127.876826] Starting dynamic subtest: runtime-pm-long-gt0 [140.556679] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.686s) [140.565259] Starting dynamic subtest: other-idle-gt0 [140.567037] Dynamic subtest other-idle-gt0: SKIP (0.000s) [140.567951] Subtest rc6: SUCCESS (27.123s) [141.227883] [028/133] (884s left) gem_exercise_blt (fast-copy) [141.302206] Starting subtest: fast-copy [141.303153] Starting dynamic subtest: linear-smem-smem [141.350986] Dynamic subtest linear-smem-smem: SUCCESS (0.049s) [141.359780] Starting dynamic subtest: linear-smem-lmem0 [141.367333] Dynamic subtest linear-smem-lmem0: SUCCESS (0.016s) [141.375971] Starting dynamic subtest: linear-lmem0-smem [141.467224] Dynamic subtest linear-lmem0-smem: SUCCESS (0.100s) [141.475866] Starting dynamic subtest: linear-lmem0-lmem0 [141.566680] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.099s) [141.575326] Starting dynamic subtest: xmajor-smem-smem [141.582383] Dynamic subtest xmajor-smem-smem: SUCCESS (0.015s) [141.591092] Starting dynamic subtest: xmajor-smem-lmem0 [141.598355] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.016s) [141.607080] Starting dynamic subtest: xmajor-lmem0-smem [141.708504] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.110s) [141.717156] Starting dynamic subtest: xmajor-lmem0-lmem0 [141.806646] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.098s) [141.815206] Starting dynamic subtest: tile4-smem-smem [141.823376] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s) [141.832045] Starting dynamic subtest: tile4-smem-lmem0 [141.839133] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.015s) [141.847856] Starting dynamic subtest: tile4-lmem0-smem [141.946040] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.107s) [141.954586] Starting dynamic subtest: tile4-lmem0-lmem0 [142.044710] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.098s) [142.053244] Starting dynamic subtest: tile64-smem-smem [142.060553] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s) [142.069176] Starting dynamic subtest: tile64-smem-lmem0 [142.076330] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.015s) [142.084951] Starting dynamic subtest: tile64-lmem0-smem [142.176500] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.100s) [142.185135] Starting dynamic subtest: tile64-lmem0-lmem0 [142.282065] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.105s) [142.283066] Subtest fast-copy: SUCCESS (0.980s) [142.392320] [029/133] (883s left) gem_exec_reloc (basic-wc-active) [142.470437] Subtest basic-wc-active: SKIP (0.000s) [142.550938] [030/133] (883s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [144.064595] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [144.066241] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [144.127773] [031/133] (881s left) kms_plane_scaling (planes-scaler-unity-scaling) [145.636153] Starting subtest: planes-scaler-unity-scaling [145.637024] Starting dynamic subtest: pipe-A [145.736250] Dynamic subtest pipe-A: SUCCESS (0.100s) [145.747817] Starting dynamic subtest: pipe-B [145.900744] Dynamic subtest pipe-B: SUCCESS (0.164s) [145.916196] Starting dynamic subtest: pipe-C [146.042549] Dynamic subtest pipe-C: SUCCESS (0.141s) [146.052021] Starting dynamic subtest: pipe-D [146.169166] Dynamic subtest pipe-D: SUCCESS (0.126s) [146.170132] Subtest planes-scaler-unity-scaling: SUCCESS (0.534s) [146.304939] [032/133] (879s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [147.827702] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [147.829232] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [147.904972] [033/133] (878s left) kms_rotation_crc (sprite-rotation-270) [149.423517] Starting subtest: sprite-rotation-270 [149.425195] Subtest sprite-rotation-270: SKIP (0.001s) [149.468541] [034/133] (876s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [149.539012] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [149.614058] [035/133] (876s left) gem_render_copy_redux (interruptible) [149.689061] Starting subtest: interruptible [150.434375] Subtest interruptible: SUCCESS (0.745s) [150.541580] [036/133] (875s left) kms_psr (fbc-pr-primary-page-flip) [152.043911] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [152.100083] [037/133] (874s left) gem_mmap_wc (read-write) [152.170921] Subtest read-write: SKIP (0.000s) [152.241989] [038/133] (873s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [153.748440] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [153.749334] Starting dynamic subtest: pipe-A-valid-mode [155.277496] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.528s) [155.278493] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (1.529s) [155.398551] [039/133] (870s left) perf_pmu (enable-race) [155.458563] Starting subtest: enable-race [155.459457] Starting dynamic subtest: rcs0 [168.236397] Dynamic subtest rcs0: SUCCESS (12.777s) [168.245101] Starting dynamic subtest: bcs0 [180.976548] Dynamic subtest bcs0: SUCCESS (12.739s) [180.985570] Starting dynamic subtest: vcs0 [193.717336] Dynamic subtest vcs0: SUCCESS (12.740s) [193.726186] Starting dynamic subtest: vcs1 [206.457628] Dynamic subtest vcs1: SUCCESS (12.739s) [206.466463] Starting dynamic subtest: vecs0 [219.198480] Dynamic subtest vecs0: SUCCESS (12.740s) [219.207459] Starting dynamic subtest: vecs1 [231.938480] Dynamic subtest vecs1: SUCCESS (12.739s) [231.947599] Starting dynamic subtest: ccs0 [244.679492] Dynamic subtest ccs0: SUCCESS (12.741s) [244.680411] Subtest enable-race: SUCCESS (89.218s) [244.793224] [040/133] (781s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [246.307161] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [246.993349] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.687s) [247.192177] [041/133] (779s left) gen7_exec_parse (load-register-reg) [247.268158] Subtest load-register-reg: SKIP (0.000s) [247.335017] [042/133] (779s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [247.404907] Starting subtest: multi-wait-all-available-submitted-signaled [247.405750] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s) [247.513733] [043/133] (779s left) syncobj_timeline (wait-delayed-signal) [247.581883] Starting subtest: wait-delayed-signal [247.682490] Subtest wait-delayed-signal: SUCCESS (0.101s) [247.740385] [044/133] (778s left) kms_content_protection (suspend-resume) [249.313968] Starting subtest: suspend-resume [249.320191] Subtest suspend-resume: SKIP (0.006s) [249.438024] [045/133] (777s left) kms_vblank (query-idle-hang) [250.951148] Starting subtest: query-idle-hang [250.952111] Starting dynamic subtest: pipe-A-HDMI-A-3 [277.534274] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.582s) [277.544887] Starting dynamic subtest: pipe-D-HDMI-A-3 [302.540506] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.004s) [302.541410] Subtest query-idle-hang: SUCCESS (51.591s) [302.663315] [046/133] (724s left) kms_chamelium_audio (hdmi-audio) [304.228090] Subtest hdmi-audio: SKIP (0.000s) [304.325785] [047/133] (722s left) kms_cursor_crc (cursor-suspend) [305.910377] Starting subtest: cursor-suspend [305.912279] Starting dynamic subtest: pipe-A-HDMI-A-3 [345.611946] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (7.834s) [345.630704] Starting dynamic subtest: pipe-D-HDMI-A-3 [385.589581] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (7.372s) [385.590548] Subtest cursor-suspend: SUCCESS (15.210s) [396.031079] [048/133] (640s left) gem_exec_flush (basic-wb-ro-default) [396.112558] Subtest basic-wb-ro-default: SKIP (0.000s) [396.175789] [049/133] (640s left) gem_exec_schedule (pi-ringfull) [396.376209] Starting subtest: pi-ringfull [396.377154] Starting dynamic subtest: rcs0 [396.460437] Dynamic subtest rcs0: SUCCESS (0.084s) [396.472293] Starting dynamic subtest: bcs0 [396.490661] Dynamic subtest bcs0: SUCCESS (0.030s) [396.501956] Starting dynamic subtest: vcs0 [396.520745] Dynamic subtest vcs0: SUCCESS (0.029s) [396.532286] Starting dynamic subtest: vcs1 [396.550848] Dynamic subtest vcs1: SUCCESS (0.030s) [396.562382] Starting dynamic subtest: vecs0 [396.582078] Dynamic subtest vecs0: SUCCESS (0.031s) [396.593835] Starting dynamic subtest: vecs1 [396.613008] Dynamic subtest vecs1: SUCCESS (0.030s) [396.624319] Starting dynamic subtest: ccs0 [396.645115] Dynamic subtest ccs0: SUCCESS (0.031s) [396.646056] Subtest pi-ringfull: SUCCESS (0.270s) [396.925582] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true [396.927462] [050/133] (640s left) i915_hangman (error-state-basic) [397.020548] Starting subtest: error-state-basic [397.232503] Subtest error-state-basic: SUCCESS (0.212s) [397.321447] [051/133] (639s left) kms_draw_crc (draw-method-pwrite) [398.833684] Starting subtest: draw-method-pwrite [398.834601] Starting dynamic subtest: xrgb8888-untiled [399.301849] Dynamic subtest xrgb8888-untiled: SUCCESS (0.468s) [399.314523] Starting dynamic subtest: rgb565-untiled [399.702470] Dynamic subtest rgb565-untiled: SUCCESS (0.399s) [399.717683] Starting dynamic subtest: xrgb2101010-untiled [400.069032] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.365s) [400.083266] Starting dynamic subtest: xbgr16161616f-untiled [400.434805] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.365s) [400.447010] Starting dynamic subtest: xrgb8888-xtiled [400.968502] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.533s) [400.982544] Starting dynamic subtest: rgb565-xtiled [401.535198] Dynamic subtest rgb565-xtiled: SUCCESS (0.566s) [401.548179] Starting dynamic subtest: xrgb2101010-xtiled [402.052425] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.516s) [402.067154] Starting dynamic subtest: xbgr16161616f-xtiled [402.651533] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.598s) [402.664130] Starting dynamic subtest: xrgb8888-4tiled [403.068647] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.416s) [403.088232] Starting dynamic subtest: rgb565-4tiled [403.402082] Dynamic subtest rgb565-4tiled: SUCCESS (0.332s) [403.415650] Starting dynamic subtest: xrgb2101010-4tiled [403.802114] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.399s) [403.817293] Starting dynamic subtest: xbgr16161616f-4tiled [404.418311] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.615s) [404.419237] Subtest draw-method-pwrite: SUCCESS (5.585s) [404.535503] [052/133] (632s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [404.618423] Subtest writes-after-reads-snoop: SKIP (0.000s) [404.679943] [053/133] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [406.213177] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [406.215000] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [406.307646] [054/133] (630s left) prime_vgem (basic-fence-blt) [406.431762] Starting subtest: basic-fence-blt [406.537373] Subtest basic-fence-blt: SUCCESS (0.105s) [406.692969] [055/133] (630s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [406.768581] Starting subtest: etime-single-wait-all-for-submit-submitted [406.874964] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s) [406.939405] [056/133] (630s left) kms_psr (fbc-psr-cursor-plane-move) [408.456041] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [408.513487] [057/133] (628s left) kms_prop_blob (blob-prop-lifetime) [408.592357] Starting subtest: blob-prop-lifetime [408.608326] Subtest blob-prop-lifetime: SUCCESS (0.016s) [408.683217] [058/133] (628s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [410.194558] Starting subtest: multiplane-rotation-cropping-bottom [438.555283] Subtest multiplane-rotation-cropping-bottom: SUCCESS (28.361s) [438.712042] [059/133] (598s left) kms_big_fb (x-tiled-addfb-size-overflow) [440.240517] Starting subtest: x-tiled-addfb-size-overflow [440.243360] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s) [440.347071] [060/133] (597s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [441.879270] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [441.884424] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [441.934788] [061/133] (595s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [443.447583] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [443.448466] Starting dynamic subtest: pipe-A-HDMI-A-3 [443.456789] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [443.468352] Starting dynamic subtest: pipe-B-HDMI-A-3 [443.476735] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [443.488237] Starting dynamic subtest: pipe-C-HDMI-A-3 [443.496414] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [443.507764] Starting dynamic subtest: pipe-D-HDMI-A-3 [443.518543] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [443.520420] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s) [443.675756] [062/133] (593s left) gem_ppgtt (blt-vs-render-ctxn) [443.760151] Starting subtest: blt-vs-render-ctxN [476.764515] Subtest blt-vs-render-ctxN: SUCCESS (33.002s) [476.926123] [063/133] (560s left) gem_exec_fence (syncobj-timeline-signal) [477.624928] Starting subtest: syncobj-timeline-signal [477.657621] Subtest syncobj-timeline-signal: SUCCESS (0.033s) [477.873398] [064/133] (559s left) prime_vgem (coherency-gtt) [477.978383] Starting subtest: coherency-gtt [477.980349] Subtest coherency-gtt: SKIP (0.000s) [478.061902] [065/133] (559s left) prime_mmap_kms (buffer-sharing) [479.580313] Starting subtest: buffer-sharing [479.915578] Subtest buffer-sharing: SUCCESS (0.335s) [480.092400] [066/133] (557s left) kms_flip (flip-vs-wf_vblank-interruptible) [481.614584] Starting subtest: flip-vs-wf_vblank-interruptible [481.620883] Starting dynamic subtest: A-HDMI-A3 [482.663152] Dynamic subtest A-HDMI-A3: SUCCESS (1.042s) [482.679372] Starting dynamic subtest: B-HDMI-A3 [483.616322] Dynamic subtest B-HDMI-A3: SUCCESS (0.951s) [483.634189] Starting dynamic subtest: C-HDMI-A3 [484.568698] Dynamic subtest C-HDMI-A3: SUCCESS (0.951s) [484.583311] Starting dynamic subtest: D-HDMI-A3 [485.521449] Dynamic subtest D-HDMI-A3: SUCCESS (0.951s) [485.522358] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (3.907s) [485.698868] [067/133] (552s left) syncobj_basic (illegal-fd-to-handle) [485.781939] Starting subtest: illegal-fd-to-handle [485.782873] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [485.844318] [068/133] (552s left) kms_cursor_crc (cursor-alpha-transparent) [487.356568] Starting subtest: cursor-alpha-transparent [487.357424] Starting dynamic subtest: pipe-A-HDMI-A-3 [487.971736] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.613s) [487.989345] Starting dynamic subtest: pipe-D-HDMI-A-3 [488.377688] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.404s) [488.378526] Subtest cursor-alpha-transparent: SUCCESS (1.022s) [488.896487] [069/133] (549s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [488.979617] Starting subtest: yf-tiled-to-vebox-x-tiled [488.981654] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [489.202706] [070/133] (548s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [490.714338] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [490.715242] Starting dynamic subtest: pipe-A-HDMI-A-3 [490.723900] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [490.736571] Starting dynamic subtest: pipe-B-HDMI-A-3 [490.745129] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [490.757473] Starting dynamic subtest: pipe-C-HDMI-A-3 [490.765734] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [490.777650] Starting dynamic subtest: pipe-D-HDMI-A-3 [490.786119] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [490.787859] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.010s) [490.938554] [071/133] (547s left) kms_psr (psr-cursor-render) [492.456335] Subtest psr-cursor-render: SKIP (0.000s) [492.508148] [072/133] (545s left) kms_flip (flip-vs-panning) [494.026421] Starting subtest: flip-vs-panning [494.031172] Starting dynamic subtest: A-HDMI-A3 [501.799501] Dynamic subtest A-HDMI-A3: SUCCESS (7.768s) [501.815914] Starting dynamic subtest: B-HDMI-A3 [509.503905] Dynamic subtest B-HDMI-A3: SUCCESS (7.702s) [509.542004] Starting dynamic subtest: C-HDMI-A3 [517.223889] Dynamic subtest C-HDMI-A3: SUCCESS (7.716s) [517.238988] Starting dynamic subtest: D-HDMI-A3 [524.927484] Dynamic subtest D-HDMI-A3: SUCCESS (7.702s) [524.928414] Subtest flip-vs-panning: SUCCESS (30.902s) [525.121395] [073/133] (513s left) kms_chamelium_hpd (hdmi-hpd-fast) [526.677971] Subtest hdmi-hpd-fast: SKIP (0.000s) [526.792375] [074/133] (511s left) gem_exec_whisper (basic-contexts-all) [526.889731] Starting subtest: basic-contexts-all [548.921324] Subtest basic-contexts-all: SUCCESS (22.033s) [549.097067] [075/133] (489s left) gem_exec_reloc (basic-wc-read-active) [549.180352] Subtest basic-wc-read-active: SKIP (0.000s) [549.258698] [076/133] (489s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [550.780352] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [550.782095] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [550.843768] [077/133] (487s left) kms_psr (pr-no-drrs) [552.357727] Subtest pr-no-drrs: SKIP (0.000s) [552.423790] [078/133] (486s left) gem_exec_balancer (nop) [552.516463] Starting subtest: nop [601.875830] Subtest nop: SUCCESS (49.364s) [602.224278] [079/133] (436s left) kms_frontbuffer_tracking (fbc-tiling-y) [603.751076] Starting subtest: fbc-tiling-y [603.752723] Subtest fbc-tiling-y: SKIP (0.000s) [603.847676] [080/133] (434s left) i915_pm_rpm (gem-idle) [607.509570] Starting subtest: gem-idle [613.638702] Subtest gem-idle: SUCCESS (6.129s) [613.745041] [081/133] (424s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [615.851130] Starting subtest: yf-tiled-64bpp-rotate-270 [615.852722] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [615.948800] [082/133] (422s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [616.053823] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [616.169997] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s) [616.263017] [083/133] (422s left) api_intel_allocator (standalone) [616.336597] Starting subtest: standalone [616.379653] Subtest standalone: SUCCESS (0.043s) [616.487196] [084/133] (422s left) prime_mmap (test_aperture_limit) [616.567718] Starting subtest: test_aperture_limit [616.568599] Starting dynamic subtest: test_aperture_limit-smem [616.582514] Dynamic subtest test_aperture_limit-smem: SKIP (0.013s) [616.584370] Subtest test_aperture_limit: SKIP (0.015s) [616.641242] [085/133] (422s left) kms_psr (fbc-pr-dpms) [618.159364] Subtest fbc-pr-dpms: SKIP (0.000s) [618.222200] [086/133] (420s left) perf_pmu (busy-double-start) [618.294918] Starting subtest: busy-double-start [618.295798] Starting dynamic subtest: rcs0 [621.892033] Dynamic subtest rcs0: SUCCESS (3.596s) [621.908373] Starting dynamic subtest: bcs0 [625.502249] Dynamic subtest bcs0: SUCCESS (3.606s) [625.518538] Starting dynamic subtest: vcs0 [629.123951] Dynamic subtest vcs0: FAIL (3.598s) [629.146780] Starting dynamic subtest: vcs1 [632.695025] Dynamic subtest vcs1: FAIL (3.566s) [632.709866] Starting dynamic subtest: vecs0 [636.260187] Dynamic subtest vecs0: FAIL (3.565s) [636.274637] Starting dynamic subtest: vecs1 [639.826164] Dynamic subtest vecs1: FAIL (3.565s) [639.840896] Starting dynamic subtest: ccs0 [643.412457] Dynamic subtest ccs0: SUCCESS (3.608s) [643.417121] Subtest busy-double-start: FAIL (25.120s) [643.509881] [087/133] (395s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [645.032085] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [645.033735] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [645.136832] [088/133] (394s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [646.672079] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [646.673816] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [646.740988] [089/133] (392s left) gem_pxp (verify-pxp-stale-ctx-execution) [649.353535] Starting subtest: verify-pxp-stale-ctx-execution [649.355346] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s) [649.407390] [090/133] (389s left) gem_create (create-ext-set-pat) [649.599139] Starting subtest: create-ext-set-pat [649.601804] Subtest create-ext-set-pat: SKIP (0.000s) [649.699056] [091/133] (389s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [651.217240] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [654.977215] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.760s) [655.176920] [092/133] (384s left) kms_chamelium_frames (dp-frame-dump) [656.736389] Subtest dp-frame-dump: SKIP (0.000s) [656.840153] [093/133] (382s left) kms_hdr (static-swap) [658.361358] Starting subtest: static-swap [658.364044] Subtest static-swap: SKIP (0.000s) [658.421126] [094/133] (381s left) kms_invalid_mode (bad-vtotal) [659.941263] Starting subtest: bad-vtotal [659.942235] Starting dynamic subtest: pipe-A-HDMI-A-3 [659.995029] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.054s) [660.009962] Starting dynamic subtest: pipe-B-HDMI-A-3 [660.011062] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [660.024354] Starting dynamic subtest: pipe-C-HDMI-A-3 [660.025482] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [660.038466] Starting dynamic subtest: pipe-D-HDMI-A-3 [660.039382] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [660.040317] Subtest bad-vtotal: SUCCESS (0.063s) [660.135521] [095/133] (379s left) gem_userptr_blits (set-cache-level) [660.221095] Starting subtest: set-cache-level [660.222018] Subtest set-cache-level: SUCCESS (0.000s) [660.368974] [096/133] (379s left) kms_force_connector_basic (force-load-detect) [660.520651] Starting subtest: force-load-detect [660.522390] Subtest force-load-detect: SKIP (0.000s) [661.392218] [097/133] (378s left) kms_async_flips (async-flip-with-page-flip-events-linear) [662.906112] Starting subtest: async-flip-with-page-flip-events-linear [663.132130] Starting dynamic subtest: pipe-A-HDMI-A-3 [665.378859] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.246s) [665.579593] Starting dynamic subtest: pipe-B-HDMI-A-3 [667.636639] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.068s) [667.832561] Starting dynamic subtest: pipe-C-HDMI-A-3 [669.881705] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.060s) [670.073637] Starting dynamic subtest: pipe-D-HDMI-A-3 [672.130606] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.068s) [672.132243] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.225s) [672.432430] [098/133] (367s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [673.966336] Starting subtest: flip-vs-cursor-crc-legacy [674.505937] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.540s) [674.676439] [099/133] (365s left) gem_spin_batch (resubmit) [674.766004] Starting subtest: resubmit [674.766944] Starting dynamic subtest: rcs0 [674.797269] Dynamic subtest rcs0: SUCCESS (0.031s) [674.812596] Starting dynamic subtest: bcs0 [674.813419] Dynamic subtest bcs0: SUCCESS (0.002s) [674.826742] Starting dynamic subtest: vcs0 [674.827741] Dynamic subtest vcs0: SUCCESS (0.002s) [674.840534] Starting dynamic subtest: vcs1 [674.841439] Dynamic subtest vcs1: SUCCESS (0.002s) [674.853751] Starting dynamic subtest: vecs0 [674.854676] Dynamic subtest vecs0: SUCCESS (0.002s) [674.867171] Starting dynamic subtest: vecs1 [674.868171] Dynamic subtest vecs1: SUCCESS (0.002s) [674.880705] Starting dynamic subtest: ccs0 [674.881822] Dynamic subtest ccs0: SUCCESS (0.002s) [674.882917] Subtest resubmit: SUCCESS (0.050s) [675.072517] [100/133] (364s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [676.596295] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [676.598083] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [676.676149] [101/133] (363s left) kms_big_fb (x-tiled-64bpp-rotate-180) [678.202823] Starting subtest: x-tiled-64bpp-rotate-180 [680.143781] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.940s) [680.302039] [102/133] (359s left) kms_color (deep-color) [681.813369] Starting subtest: deep-color [681.822205] Subtest deep-color: SKIP (0.003s) [681.875775] [103/133] (358s left) sw_sync (sync_busy_fork) [681.923130] Starting subtest: sync_busy_fork [682.935572] Subtest sync_busy_fork: SUCCESS (1.012s) [682.985320] [104/133] (357s left) prime_mmap (test_forked_cpu_write) [683.068539] Starting subtest: test_forked_cpu_write [683.069423] Starting dynamic subtest: test_forked_cpu_write-smem [683.071513] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [683.084659] Starting dynamic subtest: test_forked_cpu_write-lmem0 [683.085712] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.008s) [683.086687] Subtest test_forked_cpu_write: SUCCESS (0.019s) [683.162481] [105/133] (356s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [684.680102] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [687.035785] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.348s) [687.149389] [106/133] (353s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [688.661757] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [688.664281] Starting dynamic subtest: pipe-A-HDMI-A-3 [688.687419] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s) [688.701074] Starting dynamic subtest: pipe-B-HDMI-A-3 [688.723302] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s) [688.736457] Starting dynamic subtest: pipe-C-HDMI-A-3 [688.759919] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s) [688.773118] Starting dynamic subtest: pipe-D-HDMI-A-3 [688.795059] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s) [688.796729] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.015s) [688.901179] [107/133] (351s left) kms_atomic (plane-primary-overlay-mutable-zpos) [690.419389] Starting subtest: plane-primary-overlay-mutable-zpos [692.279185] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.858s) [692.468084] [108/133] (347s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [693.983357] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [693.985132] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [694.097743] [109/133] (346s left) i915_selftest (perf) [695.250927] Starting subtest: perf [695.252149] Starting dynamic subtest: engine_cs [697.006143] Dynamic subtest engine_cs: SUCCESS (1.754s) [697.015807] Starting dynamic subtest: request [701.810176] Dynamic subtest request: SUCCESS (4.802s) [701.822632] Starting dynamic subtest: migrate [703.562381] Dynamic subtest migrate: SUCCESS (1.750s) [703.573005] Starting dynamic subtest: region [731.861185] Dynamic subtest region: SUCCESS (28.295s) [731.862195] Subtest perf: SUCCESS (36.608s) [731.893524] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [731.894502] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [731.896454] [110/133] (308s left) kms_pm_rpm (legacy-planes) [739.483754] Starting subtest: legacy-planes [739.485193] Starting dynamic subtest: plane-64 [747.373727] Dynamic subtest plane-64: SUCCESS (7.888s) [747.414709] Starting dynamic subtest: plane-94 [754.329013] Dynamic subtest plane-94: SUCCESS (6.951s) [754.371508] Starting dynamic subtest: plane-124 [761.311650] Dynamic subtest plane-124: SUCCESS (6.978s) [761.353894] Starting dynamic subtest: plane-134 [768.282474] Dynamic subtest plane-134: SUCCESS (6.967s) [768.286963] Subtest legacy-planes: SUCCESS (28.799s) [768.605106] [FACT kms_pm_rpm (legacy-planes)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [768.607785] [FACT kms_pm_rpm (legacy-planes)] new: kernel.kmod_is_loaded.i915: true [768.610523] [111/133] (271s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [770.658126] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [770.659753] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [770.743567] [112/133] (269s left) syncobj_timeline (reset-multiple-signaled) [770.832518] Starting subtest: reset-multiple-signaled [770.833422] Subtest reset-multiple-signaled: SUCCESS (0.000s) [770.939525] [113/133] (269s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [772.449315] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [772.450171] Starting dynamic subtest: pipe-A-HDMI-A-3 [772.458562] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [772.469712] Starting dynamic subtest: pipe-B-HDMI-A-3 [772.477954] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [772.489280] Starting dynamic subtest: pipe-C-HDMI-A-3 [772.497637] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [772.508500] Starting dynamic subtest: pipe-D-HDMI-A-3 [772.517315] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [772.519110] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s) [772.670661] [114/133] (267s left) kms_universal_plane (disable-primary-vs-flip) [774.183289] Starting subtest: disable-primary-vs-flip [774.184251] Starting dynamic subtest: pipe-A-HDMI-A-3 [774.653030] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.470s) [774.673481] Starting dynamic subtest: pipe-B-HDMI-A-3 [774.944609] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.290s) [774.957653] Starting dynamic subtest: pipe-C-HDMI-A-3 [775.229154] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.282s) [775.242663] Starting dynamic subtest: pipe-D-HDMI-A-3 [775.520568] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.290s) [775.521398] Subtest disable-primary-vs-flip: SUCCESS (1.339s) [775.647784] [115/133] (265s left) kms_addfb_basic (bad-pitch-32) [775.727441] Starting subtest: bad-pitch-32 [775.728341] Subtest bad-pitch-32: SUCCESS (0.000s) [777.251913] [116/133] (263s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [778.785166] Starting subtest: fbc-1p-primscrn-cur-indfb-move [781.982667] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.197s) [782.168146] [117/133] (258s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [782.256236] Starting subtest: invalid-bsd1-flag-on-vebox [782.257195] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [782.392500] [118/133] (258s left) gem_ctx_param (set-priority-invalid-size) [782.469858] Starting subtest: set-priority-invalid-size [782.470717] Subtest set-priority-invalid-size: SUCCESS (0.000s) [782.529490] [119/133] (258s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [784.052925] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [784.110416] [120/133] (256s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [785.622331] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [785.649171] Starting dynamic subtest: pipe-A-plane-0 [786.749395] Dynamic subtest pipe-A-plane-0: SUCCESS (1.100s) [786.787488] Starting dynamic subtest: pipe-A-plane-3 [787.381891] Dynamic subtest pipe-A-plane-3: SUCCESS (0.630s) [787.536019] Starting dynamic subtest: pipe-B-plane-0 [788.457539] Dynamic subtest pipe-B-plane-0: SUCCESS (0.933s) [788.487719] Starting dynamic subtest: pipe-B-plane-3 [789.123694] Dynamic subtest pipe-B-plane-3: SUCCESS (0.664s) [789.199576] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.575s) [789.395608] [121/133] (251s left) gem_caching (writes) [789.479278] Starting subtest: writes [793.747179] Subtest writes: SUCCESS (4.268s) [793.853921] [122/133] (247s left) kms_lease (lease-uevent) [795.368331] Starting subtest: lease-uevent [796.387307] Subtest lease-uevent: SUCCESS (1.019s) [796.465256] [123/133] (244s left) i915_drm_fdinfo (memory-info-resident) [796.537729] Starting subtest: memory-info-resident [796.538591] Starting dynamic subtest: lmem0 [799.783968] Dynamic subtest lmem0: SUCCESS (3.245s) [799.824720] Starting dynamic subtest: smem0 [803.966743] Dynamic subtest smem0: SUCCESS (4.179s) [803.967656] Subtest memory-info-resident: SUCCESS (7.429s) [804.029042] [124/133] (237s left) gem_exec_capture (capture-recoverable) [804.116045] Starting subtest: capture-recoverable [804.119757] Subtest capture-recoverable: SUCCESS (0.004s) [804.235877] [125/133] (237s left) gem_mmap_gtt (big-bo) [804.315322] Subtest big-bo: SKIP (0.000s) [804.396439] [126/133] (236s left) gem_fenced_exec_thrash (too-many-fences) [804.478150] Subtest too-many-fences: SKIP (0.000s) [804.558768] [127/133] (236s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [804.647396] Starting subtest: legacy-engines-hostile-preempt [804.648331] Starting dynamic subtest: render [804.778726] Dynamic subtest render: SUCCESS (0.130s) [804.796331] Starting dynamic subtest: bsd1 [804.829363] Dynamic subtest bsd1: SUCCESS (0.049s) [804.848896] Starting dynamic subtest: bsd2 [804.876405] Dynamic subtest bsd2: SUCCESS (0.045s) [804.893231] Starting dynamic subtest: blt [804.922462] Dynamic subtest blt: SUCCESS (0.044s) [804.941321] Starting dynamic subtest: vebox [804.968760] Dynamic subtest vebox: SUCCESS (0.044s) [804.969852] Subtest legacy-engines-hostile-preempt: SUCCESS (0.322s) [805.120230] [128/133] (236s left) gem_exec_fence (invalid-timeline-fence-array) [805.770063] Starting subtest: invalid-timeline-fence-array [805.777101] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [805.979905] [129/133] (235s left) core_setmaster (master-drop-set-root) [806.042346] Starting subtest: master-drop-set-root [806.062896] Subtest master-drop-set-root: SUCCESS (0.021s) [806.145145] [130/133] (235s left) kms_plane (plane-position-covered) [807.654356] Starting subtest: plane-position-covered [808.056589] Starting dynamic subtest: pipe-A-plane-1 [808.447036] Dynamic subtest pipe-A-plane-1: SUCCESS (0.390s) [808.459371] Starting dynamic subtest: pipe-A-plane-2 [808.833113] Dynamic subtest pipe-A-plane-2: SUCCESS (0.385s) [808.845485] Starting dynamic subtest: pipe-A-plane-3 [809.183572] Dynamic subtest pipe-A-plane-3: SUCCESS (0.349s) [809.195679] Starting dynamic subtest: pipe-A-plane-4 [809.566870] Dynamic subtest pipe-A-plane-4: SUCCESS (0.383s) [809.579671] Starting dynamic subtest: pipe-A-plane-5 [809.586148] Dynamic subtest pipe-A-plane-5: SUCCESS (0.018s) [809.864327] Starting dynamic subtest: pipe-B-plane-1 [810.219897] Dynamic subtest pipe-B-plane-1: SUCCESS (0.368s) [810.232375] Starting dynamic subtest: pipe-B-plane-2 [810.588812] Dynamic subtest pipe-B-plane-2: SUCCESS (0.368s) [810.601304] Starting dynamic subtest: pipe-B-plane-3 [810.959722] Dynamic subtest pipe-B-plane-3: SUCCESS (0.370s) [810.972270] Starting dynamic subtest: pipe-B-plane-4 [811.327167] Dynamic subtest pipe-B-plane-4: SUCCESS (0.366s) [811.339672] Starting dynamic subtest: pipe-B-plane-5 [811.346119] Dynamic subtest pipe-B-plane-5: SUCCESS (0.018s) [811.347029] Subtest plane-position-covered: SUCCESS (3.692s) [811.491997] [131/133] (230s left) kms_pm_backlight (fade-with-suspend) [813.010388] Subtest fade-with-suspend: SKIP (0.000s) [813.071943] [132/133] (228s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [814.593454] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [814.595206] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [814.675793] [133/133] (227s left) syncobj_timeline (signal-point-0) [814.762441] Starting subtest: signal-point-0 [814.763410] Subtest signal-point-0: SUCCESS (0.000s) [814.858218] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: gem_ctx_sseu results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_dp_linktrain_fallback results: parsing output: 5/ for test: api_intel_bb results: parsing output: 6/ for test: gem_mmap_offset results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_ccs results: parsing output: 9/ for test: kms_pipe_crc_basic results: parsing output: 10/ for test: gem_exec_flush results: parsing output: 11/ for test: kms_cursor_crc results: parsing output: 12/ for test: gem_ctx_isolation results: parsing output: 13/ for test: kms_cursor_legacy results: parsing output: 14/ for test: gem_mmap_wc results: parsing output: 15/ for test: perf results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_unfence_active_buffers results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: gem_lmem_swapping results: parsing output: 21/ for test: gem_exec_schedule results: parsing output: 22/ for test: sw_sync results: parsing output: 23/ for test: gem_exec_params results: parsing output: 24/ for test: kms_flip results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: perf_pmu results: parsing output: 27/ for test: gem_exercise_blt results: parsing output: 28/ for test: gem_exec_reloc results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_plane_scaling results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: kms_rotation_crc results: parsing output: 33/ for test: kms_pipe_b_c_ivb results: parsing output: 34/ for test: gem_render_copy_redux results: parsing output: 35/ for test: kms_psr results: parsing output: 36/ for test: gem_mmap_wc results: parsing output: 37/ for test: kms_flip_scaled_crc results: parsing output: 38/ for test: perf_pmu results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: gen7_exec_parse results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: kms_content_protection results: parsing output: 44/ for test: kms_vblank results: parsing output: 45/ for test: kms_chamelium_audio results: parsing output: 46/ for test: kms_cursor_crc results: parsing output: 47/ for test: gem_exec_flush results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: i915_hangman results: parsing output: 50/ for test: kms_draw_crc results: parsing output: 51/ for test: gem_partial_pwrite_pread results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: prime_vgem results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: kms_prop_blob results: parsing output: 57/ for test: kms_rotation_crc results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: kms_plane results: parsing output: 60/ for test: kms_ccs results: parsing output: 61/ for test: gem_ppgtt results: parsing output: 62/ for test: gem_exec_fence results: parsing output: 63/ for test: prime_vgem results: parsing output: 64/ for test: prime_mmap_kms results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: syncobj_basic results: parsing output: 67/ for test: kms_cursor_crc results: parsing output: 68/ for test: gem_render_copy results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_flip results: parsing output: 72/ for test: kms_chamelium_hpd results: parsing output: 73/ for test: gem_exec_whisper results: parsing output: 74/ for test: gem_exec_reloc results: parsing output: 75/ for test: kms_flip_scaled_crc results: parsing output: 76/ for test: kms_psr results: parsing output: 77/ for test: gem_exec_balancer results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: i915_pm_rpm results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: api_intel_allocator results: parsing output: 83/ for test: prime_mmap results: parsing output: 84/ for test: kms_psr results: parsing output: 85/ for test: perf_pmu results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_pxp results: parsing output: 89/ for test: gem_create results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_chamelium_frames results: parsing output: 92/ for test: kms_hdr results: parsing output: 93/ for test: kms_invalid_mode results: parsing output: 94/ for test: gem_userptr_blits results: parsing output: 95/ for test: kms_force_connector_basic results: parsing output: 96/ for test: kms_async_flips results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: gem_spin_batch results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: kms_color results: parsing output: 102/ for test: sw_sync results: parsing output: 103/ for test: prime_mmap results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: kms_atomic results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: i915_selftest results: parsing output: 109/ for test: kms_pm_rpm results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_universal_plane results: parsing output: 114/ for test: kms_addfb_basic results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_exec_params results: parsing output: 117/ for test: gem_ctx_param results: parsing output: 118/ for test: kms_psr2_sf results: parsing output: 119/ for test: kms_plane results: parsing output: 120/ for test: gem_caching results: parsing output: 121/ for test: kms_lease results: parsing output: 122/ for test: i915_drm_fdinfo results: parsing output: 123/ for test: gem_exec_capture results: parsing output: 124/ for test: gem_mmap_gtt results: parsing output: 125/ for test: gem_fenced_exec_thrash results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: gem_exec_fence results: parsing output: 128/ for test: core_setmaster results: parsing output: 129/ for test: kms_plane results: parsing output: 130/ for test: kms_pm_backlight results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: syncobj_timeline Done.