[57.186524] Initializing watchdogs [57.186592] /dev/watchdog0 [57.217305] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [57.228236] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [57.232146] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.234446] [001/132] (960s left) gem_spin_batch (spin-each) [57.319273] Starting subtest: spin-each [60.747753] Subtest spin-each: SUCCESS (3.427s) [61.075242] [002/132] (956s left) kms_joiner (basic-ultra-joiner) [61.261891] Subtest basic-ultra-joiner: SKIP (0.000s) [61.371551] [003/132] (956s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [61.560679] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [61.562396] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [61.734662] [004/132] (956s left) gem_exec_schedule (preempt-queue) [61.817473] Subtest preempt-queue: SKIP (0.000s) [62.185495] [005/132] (955s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [62.366495] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [62.367438] Starting dynamic subtest: pipe-A-DP-3 [62.375926] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [62.383789] Starting dynamic subtest: pipe-B-DP-3 [62.392506] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [62.400270] Starting dynamic subtest: pipe-C-DP-3 [62.408691] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [62.416379] Starting dynamic subtest: pipe-D-DP-3 [62.425963] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [62.427964] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [62.823759] [006/132] (955s left) syncobj_timeline (invalid-signal-bad-pad) [62.896891] Starting subtest: invalid-signal-bad-pad [62.897797] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [63.031077] [007/132] (955s left) gem_exec_store (dword) [63.107530] Starting subtest: dword [63.108464] Starting dynamic subtest: rcs0 [63.192599] Dynamic subtest rcs0: SUCCESS (0.085s) [63.204660] Starting dynamic subtest: bcs0 [63.234693] Dynamic subtest bcs0: SUCCESS (0.041s) [63.246631] Starting dynamic subtest: vcs0 [63.278584] Dynamic subtest vcs0: SUCCESS (0.044s) [63.291820] Starting dynamic subtest: vcs1 [63.321206] Dynamic subtest vcs1: SUCCESS (0.042s) [63.352569] Starting dynamic subtest: vecs0 [63.370226] Dynamic subtest vecs0: SUCCESS (0.048s) [63.388575] Starting dynamic subtest: vecs1 [63.415955] Dynamic subtest vecs1: SUCCESS (0.045s) [63.431347] Starting dynamic subtest: ccs0 [63.460227] Dynamic subtest ccs0: SUCCESS (0.044s) [63.461581] Subtest dword: SUCCESS (0.353s) [63.756612] [008/132] (954s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [63.937459] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [63.939196] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [64.121594] [009/132] (954s left) kms_chamelium_hpd (vga-hpd-after-suspend) [64.392513] Subtest vga-hpd-after-suspend: SKIP (0.000s) [64.542664] [010/132] (953s left) gem_exec_reloc (basic-wc-gtt-noreloc) [64.616714] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [64.706218] [011/132] (953s left) kms_big_fb (x-tiled-16bpp-rotate-180) [64.902520] Starting subtest: x-tiled-16bpp-rotate-180 [66.690263] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.788s) [67.020845] [012/132] (951s left) api_intel_bb (blit-reloc-purge-cache) [67.364764] Starting subtest: blit-reloc-purge-cache [67.366686] Subtest blit-reloc-purge-cache: SKIP (0.001s) [67.710674] [013/132] (950s left) gen9_exec_parse (bb-start-param) [67.856152] Subtest bb-start-param: SKIP (0.000s) [67.999237] [014/132] (950s left) kms_flip (2x-flip-vs-suspend-interruptible) [68.187856] Starting subtest: 2x-flip-vs-suspend-interruptible [68.203260] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.015s) [68.363403] [015/132] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [68.546774] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [68.548385] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [68.708942] [016/132] (950s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [68.780914] Starting subtest: invalid-multi-wait-unsubmitted-submitted [68.782104] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [68.965140] [017/132] (949s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [69.144917] Starting subtest: bad-aux-stride-y-tiled-ccs [69.145908] Starting dynamic subtest: pipe-A-DP-3 [69.154276] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [69.162309] Starting dynamic subtest: pipe-B-DP-3 [69.170906] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [69.178825] Starting dynamic subtest: pipe-C-DP-3 [69.187120] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [69.195190] Starting dynamic subtest: pipe-D-DP-3 [69.204986] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [69.207055] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s) [69.602702] [018/132] (949s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [69.790552] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [69.893137] [019/132] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [70.078504] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [70.080236] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [70.241554] [020/132] (948s left) gem_mmap_wc (write-read-distinct) [70.313164] Subtest write-read-distinct: SKIP (0.000s) [70.379463] [021/132] (948s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [70.572687] Starting subtest: psr-rgb565-draw-mmap-wc [70.574321] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s) [70.748213] [022/132] (948s left) gem_exec_params (invalid-fence-in-submit) [70.822812] Starting subtest: invalid-fence-in-submit [70.826571] Subtest invalid-fence-in-submit: SUCCESS (0.003s) [71.017085] [023/132] (948s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [71.087165] Starting subtest: etime-multi-wait-all-submitted-signaled [71.189232] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s) [71.370399] [024/132] (948s left) vgem_basic (setversion) [71.475249] Starting subtest: setversion [71.477180] Subtest setversion: SUCCESS (0.000s) [71.608898] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true [71.610655] [025/132] (947s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [71.689083] Starting subtest: invalid-multi-wait-all-unsubmitted [71.690173] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [71.836394] [026/132] (947s left) kms_cursor_edge_walk (128x128-right-edge) [72.028425] Starting subtest: 128x128-right-edge [72.030357] Starting dynamic subtest: pipe-A-DP-3 [75.514180] Dynamic subtest pipe-A-DP-3: SUCCESS (3.477s) [75.524668] Starting dynamic subtest: pipe-D-DP-3 [78.819282] Dynamic subtest pipe-D-DP-3: SUCCESS (3.311s) [78.820229] Subtest 128x128-right-edge: SUCCESS (6.791s) [79.123536] [027/132] (940s left) prime_vgem (basic-fence-read) [79.212846] Starting subtest: basic-fence-read [79.219650] Subtest basic-fence-read: SKIP (0.006s) [79.404212] [028/132] (940s left) gem_ctx_engines (execute-one) [79.495448] Starting subtest: execute-one [82.893952] Subtest execute-one: SUCCESS (3.398s) [83.195116] [029/132] (936s left) gem_mmap (basic) [83.273124] Subtest basic: SKIP (0.000s) [83.356182] [030/132] (936s left) kms_lease (lease-invalid-crtc) [83.543886] Starting subtest: lease-invalid-crtc [83.544773] Starting dynamic subtest: pipe-A-DP-3 [83.545629] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s) [83.553976] Starting dynamic subtest: pipe-B-DP-3 [83.555150] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s) [83.563873] Starting dynamic subtest: pipe-C-DP-3 [83.565073] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s) [83.573201] Starting dynamic subtest: pipe-D-DP-3 [83.574490] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s) [83.575586] Subtest lease-invalid-crtc: SUCCESS (0.003s) [83.698375] [031/132] (936s left) kms_draw_crc (draw-method-mmap-gtt) [83.891891] Starting subtest: draw-method-mmap-gtt [83.893514] Subtest draw-method-mmap-gtt: SKIP (0.000s) [84.062876] [032/132] (935s left) kms_psr (fbc-psr-primary-mmap-cpu) [84.256757] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s) [84.313917] [033/132] (935s left) kms_flip (bo-too-big-interruptible) [84.506531] Starting subtest: bo-too-big-interruptible [84.511104] Starting dynamic subtest: A-DP3 [84.818360] Dynamic subtest A-DP3: SUCCESS (0.306s) [84.854879] Starting dynamic subtest: B-DP3 [85.059805] Dynamic subtest B-DP3: SUCCESS (0.240s) [85.084234] Starting dynamic subtest: C-DP3 [85.286069] Dynamic subtest C-DP3: SUCCESS (0.225s) [85.321294] Starting dynamic subtest: D-DP3 [85.529811] Dynamic subtest D-DP3: SUCCESS (0.242s) [85.534502] Subtest bo-too-big-interruptible: SUCCESS (1.027s) [85.959268] [034/132] (934s left) gem_softpin (evict-active-interruptible) [86.057985] Starting subtest: evict-active-interruptible [86.077936] Subtest evict-active-interruptible: SUCCESS (0.020s) [86.252110] [035/132] (933s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [86.442951] Starting subtest: cursorB-vs-flipB-varying-size [86.444770] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [86.576682] [036/132] (933s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [86.774430] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [86.832622] [037/132] (933s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [87.029755] Starting subtest: psr-rgb101010-draw-mmap-cpu [87.031395] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [87.193990] [038/132] (933s left) gem_exec_async (concurrent-writes) [87.281049] Starting subtest: concurrent-writes [87.282069] Starting dynamic subtest: rcs0 [87.324359] Dynamic subtest rcs0: SUCCESS (0.043s) [87.335039] Starting dynamic subtest: bcs0 [87.338599] Dynamic subtest bcs0: SUCCESS (0.014s) [87.347351] Starting dynamic subtest: vcs0 [87.349649] Dynamic subtest vcs0: SUCCESS (0.011s) [87.358381] Starting dynamic subtest: vcs1 [87.360776] Dynamic subtest vcs1: SUCCESS (0.011s) [87.369502] Starting dynamic subtest: vecs0 [87.371425] Dynamic subtest vecs0: SUCCESS (0.010s) [87.380138] Starting dynamic subtest: vecs1 [87.382167] Dynamic subtest vecs1: SUCCESS (0.010s) [87.391377] Starting dynamic subtest: ccs0 [87.393356] Dynamic subtest ccs0: SUCCESS (0.011s) [87.394516] Subtest concurrent-writes: SUCCESS (0.112s) [87.687493] [039/132] (932s left) kms_cursor_crc (cursor-rapid-movement-256x85) [88.131953] Starting subtest: cursor-rapid-movement-256x85 [88.134919] Starting dynamic subtest: pipe-A-DP-3 [88.604317] Dynamic subtest pipe-A-DP-3: SUCCESS (0.468s) [88.652416] Starting dynamic subtest: pipe-D-DP-3 [89.050889] Dynamic subtest pipe-D-DP-3: SUCCESS (0.406s) [89.052023] Subtest cursor-rapid-movement-256x85: SUCCESS (0.920s) [89.464372] [040/132] (931s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [89.655930] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [91.682105] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (2.027s) [91.925634] [041/132] (928s left) gem_exec_schedule (semaphore-noskip) [92.017864] Starting subtest: semaphore-noskip [92.893465] Subtest semaphore-noskip: SUCCESS (0.875s) [93.322259] [042/132] (927s left) gem_pread (snoop) [93.400196] Subtest snoop: SKIP (0.000s) [93.468025] [043/132] (927s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [93.662566] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [93.664263] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [93.857582] [044/132] (926s left) gem_ccs (block-multicopy-compressed) [93.940481] Starting subtest: block-multicopy-compressed [93.941425] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy [93.984045] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.043s) [93.992815] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy [94.073545] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.089s) [94.082328] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy [94.091151] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s) [94.100057] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy [94.181612] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.090s) [94.190446] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy [94.199900] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.018s) [94.209420] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy [94.292049] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.092s) [94.300996] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy [94.309967] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s) [94.318858] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy [94.401359] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.091s) [94.402289] Subtest block-multicopy-compressed: SUCCESS (0.461s) [94.574794] [045/132] (926s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [94.766023] Starting subtest: short-busy-flip-before-cursor-toggle [94.767697] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [94.930780] [046/132] (926s left) gem_ctx_persistence (engines-cleanup) [95.014380] Starting subtest: engines-cleanup [95.015341] Starting dynamic subtest: rcs0 [95.113424] Dynamic subtest rcs0: SUCCESS (0.099s) [95.126252] Starting dynamic subtest: bcs0 [95.161171] Dynamic subtest bcs0: SUCCESS (0.046s) [95.197344] Starting dynamic subtest: vcs0 [95.214361] Dynamic subtest vcs0: SUCCESS (0.052s) [95.226468] Starting dynamic subtest: vcs1 [95.232211] Dynamic subtest vcs1: SUCCESS (0.017s) [95.241226] Starting dynamic subtest: vecs0 [95.315200] Dynamic subtest vecs0: SUCCESS (0.082s) [95.351596] Starting dynamic subtest: vecs1 [95.362522] Dynamic subtest vecs1: SUCCESS (0.046s) [95.381957] Starting dynamic subtest: ccs0 [95.389233] Dynamic subtest ccs0: SUCCESS (0.026s) [95.390392] Subtest engines-cleanup: SUCCESS (0.375s) [95.592418] [047/132] (925s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [95.786302] Starting subtest: fbcpsr-rgb101010-draw-pwrite [95.788127] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s) [95.941696] [048/132] (925s left) gem_pxp (create-regular-buffer) [98.551352] Starting subtest: create-regular-buffer [98.553400] Subtest create-regular-buffer: SKIP (0.000s) [98.688522] [049/132] (922s left) kms_plane_scaling (planes-scaler-unity-scaling) [98.878654] Starting subtest: planes-scaler-unity-scaling [98.879466] Starting dynamic subtest: pipe-A [98.960649] Dynamic subtest pipe-A: SUCCESS (0.082s) [98.973868] Starting dynamic subtest: pipe-B [99.191985] Dynamic subtest pipe-B: SUCCESS (0.231s) [99.204806] Starting dynamic subtest: pipe-C [99.409571] Dynamic subtest pipe-C: SUCCESS (0.217s) [99.429183] Starting dynamic subtest: pipe-D [99.625260] Dynamic subtest pipe-D: SUCCESS (0.215s) [99.626283] Subtest planes-scaler-unity-scaling: SUCCESS (0.747s) [99.986500] [050/132] (921s left) kms_psr (pr-primary-mmap-cpu) [100.183926] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [100.249756] [051/132] (921s left) api_intel_bb (simple-bb-ctx) [100.331006] Starting subtest: simple-bb-ctx [100.365966] Subtest simple-bb-ctx: SUCCESS (0.036s) [100.551761] [052/132] (920s left) kms_vblank (wait-idle-hang) [100.748746] Starting subtest: wait-idle-hang [100.750890] Starting dynamic subtest: pipe-A-DP-3 [127.550433] Dynamic subtest pipe-A-DP-3: SUCCESS (26.800s) [127.561141] Starting dynamic subtest: pipe-D-DP-3 [152.541801] Dynamic subtest pipe-D-DP-3: SUCCESS (24.988s) [152.542876] Subtest wait-idle-hang: SUCCESS (51.793s) [152.770249] [053/132] (868s left) gem_pxp (reject-modify-context-protection-off-3) [155.373225] Starting subtest: reject-modify-context-protection-off-3 [155.375770] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [155.492971] [054/132] (865s left) kms_big_fb (y-tiled-64bpp-rotate-270) [155.694500] Starting subtest: y-tiled-64bpp-rotate-270 [155.696279] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [155.862020] [055/132] (865s left) gem_exec_fence (parallel) [156.064267] Starting subtest: parallel [156.065270] Starting dynamic subtest: rcs0 [158.220867] Dynamic subtest rcs0: SUCCESS (2.157s) [158.230032] Starting dynamic subtest: bcs0 [160.375264] Dynamic subtest bcs0: SUCCESS (2.154s) [160.384444] Starting dynamic subtest: vcs0 [162.524355] Dynamic subtest vcs0: SUCCESS (2.149s) [162.533417] Starting dynamic subtest: vcs1 [164.680407] Dynamic subtest vcs1: SUCCESS (2.156s) [164.689443] Starting dynamic subtest: vecs0 [166.830338] Dynamic subtest vecs0: SUCCESS (2.150s) [166.839361] Starting dynamic subtest: vecs1 [168.981760] Dynamic subtest vecs1: SUCCESS (2.151s) [168.990810] Starting dynamic subtest: ccs0 [171.133019] Dynamic subtest ccs0: SUCCESS (2.151s) [171.133953] Subtest parallel: SUCCESS (15.069s) [171.907778] [056/132] (849s left) kms_psr (fbc-pr-dpms) [172.099600] Subtest fbc-pr-dpms: SKIP (0.000s) [172.150614] [057/132] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [172.344644] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [172.346396] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [172.521178] [058/132] (849s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [172.712253] Starting subtest: nonblocking-crc-frame-sequence [172.713184] Starting dynamic subtest: pipe-A-DP-3 [173.467802] Dynamic subtest pipe-A-DP-3: SUCCESS (0.755s) [173.479250] Starting dynamic subtest: pipe-B-DP-3 [174.095513] Dynamic subtest pipe-B-DP-3: SUCCESS (0.623s) [174.107473] Starting dynamic subtest: pipe-C-DP-3 [174.687176] Dynamic subtest pipe-C-DP-3: SUCCESS (0.592s) [174.703215] Starting dynamic subtest: pipe-D-DP-3 [175.367662] Dynamic subtest pipe-D-DP-3: SUCCESS (0.678s) [175.368558] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.656s) [175.698297] [059/132] (846s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [175.895530] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [175.896419] Starting dynamic subtest: pipe-A-DP-3 [175.904179] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s) [175.913282] Starting dynamic subtest: pipe-B-DP-3 [175.920892] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s) [175.929787] Starting dynamic subtest: pipe-C-DP-3 [175.937504] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s) [175.946284] Starting dynamic subtest: pipe-D-DP-3 [175.953742] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s) [175.954529] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.014s) [176.413252] [060/132] (845s left) core_hotunplug (unbind-rebind) [176.549497] Starting subtest: unbind-rebind [180.274204] Subtest unbind-rebind: SUCCESS (3.723s) [180.320892] [061/132] (841s left) syncobj_wait (wait-all-snapshot) [180.486791] Starting subtest: wait-all-snapshot [180.570523] Subtest wait-all-snapshot: SUCCESS (0.084s) [180.740727] [062/132] (841s left) i915_drm_fdinfo (context-close-stress) [180.814808] Starting subtest: context-close-stress [191.562261] Subtest context-close-stress: SUCCESS (10.747s) [191.754961] [063/132] (830s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [192.282446] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [192.297605] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.015s) [192.425023] [064/132] (829s left) gem_mmap_gtt (big-copy-xy) [192.513152] Subtest big-copy-XY: SKIP (0.000s) [192.585559] [065/132] (829s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [192.783978] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [192.785807] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [192.964854] [066/132] (829s left) gem_wait (wait) [193.057457] Starting subtest: wait [193.058432] Starting dynamic subtest: all-engines [194.146318] Dynamic subtest all-engines: SUCCESS (1.088s) [194.159235] Starting dynamic subtest: rcs0 [195.200288] Dynamic subtest rcs0: SUCCESS (1.052s) [195.213931] Starting dynamic subtest: bcs0 [196.256687] Dynamic subtest bcs0: SUCCESS (1.054s) [196.273960] Starting dynamic subtest: vcs0 [197.314484] Dynamic subtest vcs0: SUCCESS (1.055s) [197.328027] Starting dynamic subtest: vcs1 [198.370619] Dynamic subtest vcs1: SUCCESS (1.053s) [198.412409] Starting dynamic subtest: vecs0 [199.429319] Dynamic subtest vecs0: SUCCESS (1.056s) [199.472073] Starting dynamic subtest: vecs1 [200.488701] Dynamic subtest vecs1: SUCCESS (1.057s) [200.529427] Starting dynamic subtest: ccs0 [201.547477] Dynamic subtest ccs0: SUCCESS (1.056s) [201.549212] Subtest wait: SUCCESS (8.491s) [201.856013] [067/132] (820s left) gem_lmem_swapping (smem-oom) [204.599789] Starting subtest: smem-oom [204.602037] Starting dynamic subtest: lmem0 [231.785894] Dynamic subtest lmem0: SUCCESS (27.185s) [231.787512] Subtest smem-oom: SUCCESS (27.186s) [232.982204] [FACT gem_lmem_swapping (smem-oom)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [232.984378] [FACT gem_lmem_swapping (smem-oom)] deleted: kernel.kmod_is_loaded.i915: true [232.987685] [068/132] (789s left) gem_exec_suspend (basic-s3) [234.724287] Starting subtest: basic-S3 [234.725264] Starting dynamic subtest: smem [257.321079] Dynamic subtest smem: SUCCESS (7.289s) [257.336904] Starting dynamic subtest: lmem0 [279.455057] Dynamic subtest lmem0: SUCCESS (7.116s) [279.455953] Subtest basic-S3: SUCCESS (14.407s) [279.663890] [FACT gem_exec_suspend (basic-s3)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [279.666482] [FACT gem_exec_suspend (basic-s3)] new: kernel.kmod_is_loaded.i915: true [279.668910] [069/132] (742s left) gem_exec_flush (basic-batch-kernel-default-cmd) [279.752610] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [279.887471] [070/132] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [280.093702] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [280.095540] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [280.272593] [071/132] (742s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [280.468147] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [280.469872] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [280.659162] [072/132] (742s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [280.856566] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [280.858359] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [281.044963] [073/132] (741s left) kms_pm_dc (dc5-dpms-negative) [282.243553] Starting subtest: dc5-dpms-negative [286.469779] Subtest dc5-dpms-negative: SUCCESS (4.226s) [286.610747] [074/132] (736s left) kms_content_protection (atomic) [286.875333] Starting subtest: atomic [286.909059] Starting dynamic subtest: pipe-A-DP-3 [408.105585] Dynamic subtest pipe-A-DP-3: FAIL (121.006s) [408.106628] Subtest atomic: FAIL (121.135s) [408.348725] [075/132] (614s left) perf_pmu (busy-idle) [408.421129] Starting subtest: busy-idle [408.422001] Starting dynamic subtest: rcs0 [409.150920] Dynamic subtest rcs0: SUCCESS (0.728s) [409.169625] Starting dynamic subtest: bcs0 [409.820866] Dynamic subtest bcs0: SUCCESS (0.666s) [409.839240] Starting dynamic subtest: vcs0 [410.486878] Dynamic subtest vcs0: SUCCESS (0.662s) [410.507697] Starting dynamic subtest: vcs1 [411.157000] Dynamic subtest vcs1: SUCCESS (0.667s) [411.177781] Starting dynamic subtest: vecs0 [411.828146] Dynamic subtest vecs0: SUCCESS (0.668s) [411.848959] Starting dynamic subtest: vecs1 [412.490918] Dynamic subtest vecs1: SUCCESS (0.659s) [412.511792] Starting dynamic subtest: ccs0 [413.161989] Dynamic subtest ccs0: SUCCESS (0.667s) [413.164097] Subtest busy-idle: SUCCESS (4.742s) [413.376852] [076/132] (609s left) kms_addfb_basic (basic) [413.457801] Starting subtest: basic [413.458771] Subtest basic: SUCCESS (0.000s) [413.726238] [077/132] (609s left) kms_chamelium_edid (dp-edid-resolution-list) [414.008842] Subtest dp-edid-resolution-list: SKIP (0.000s) [414.171279] [078/132] (608s left) template (b) [414.252967] Starting subtest: B [414.253892] Subtest B: SUCCESS (0.000s) [414.403061] [079/132] (608s left) syncobj_wait (signal) [414.482580] Starting subtest: signal [414.483647] Subtest signal: SUCCESS (0.000s) [414.663279] [080/132] (608s left) kms_flip (wf_vblank-ts-check-interruptible) [414.861570] Starting subtest: wf_vblank-ts-check-interruptible [414.866249] Starting dynamic subtest: A-DP3 [422.982272] Dynamic subtest A-DP3: SUCCESS (8.116s) [422.999595] Starting dynamic subtest: B-DP3 [431.018405] Dynamic subtest B-DP3: SUCCESS (8.035s) [431.034154] Starting dynamic subtest: C-DP3 [439.057014] Dynamic subtest C-DP3: SUCCESS (8.038s) [439.072272] Starting dynamic subtest: D-DP3 [447.097111] Dynamic subtest D-DP3: SUCCESS (8.039s) [447.099413] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.237s) [447.436760] [081/132] (575s left) kms_cursor_crc (cursor-alpha-opaque) [447.632298] Starting subtest: cursor-alpha-opaque [447.634692] Starting dynamic subtest: pipe-A-DP-3 [448.225283] Dynamic subtest pipe-A-DP-3: SUCCESS (0.591s) [448.250169] Starting dynamic subtest: pipe-D-DP-3 [448.791214] Dynamic subtest pipe-D-DP-3: SUCCESS (0.562s) [448.792291] Subtest cursor-alpha-opaque: SUCCESS (1.158s) [449.445915] [082/132] (573s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [449.636788] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [460.634428] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.998s) [460.945247] [083/132] (562s left) i915_pm_rpm (system-suspend-devices) [463.389313] Starting subtest: system-suspend-devices [471.119716] Subtest system-suspend-devices: SUCCESS (7.732s) [471.568318] [084/132] (552s left) prime_mmap (test_forked) [471.653291] Starting subtest: test_forked [471.654224] Starting dynamic subtest: test_forked-smem [471.709045] Dynamic subtest test_forked-smem: SUCCESS (0.055s) [471.724641] Starting dynamic subtest: test_forked-lmem0 [471.910351] Dynamic subtest test_forked-lmem0: SUCCESS (0.200s) [471.911344] Subtest test_forked: SUCCESS (0.257s) [472.063986] [085/132] (551s left) gem_mmap (basic-small-bo) [472.140681] Subtest basic-small-bo: SKIP (0.000s) [472.216366] [086/132] (551s left) syncobj_timeline (signal) [472.292879] Starting subtest: signal [472.293816] Subtest signal: SUCCESS (0.000s) [472.484923] [087/132] (551s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [472.561750] Starting subtest: invalid-single-wait-all-unsubmitted [472.562721] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [472.732179] [088/132] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [472.820948] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [472.931080] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s) [473.105961] [089/132] (550s left) i915_selftest (live) [474.304214] Starting subtest: live [474.305137] Starting dynamic subtest: sanitycheck [476.026263] Dynamic subtest sanitycheck: SUCCESS (1.721s) [476.037941] Starting dynamic subtest: uncore [477.679293] Dynamic subtest uncore: SUCCESS (1.652s) [477.693062] Starting dynamic subtest: workarounds [494.539279] Dynamic subtest workarounds: FAIL (16.618s) [494.550268] Starting dynamic subtest: gt_engines [496.726254] Dynamic subtest gt_engines: SUCCESS (2.426s) [496.738658] Starting dynamic subtest: gt_timelines [516.858299] Dynamic subtest gt_timelines: SUCCESS (20.130s) [516.870662] Starting dynamic subtest: gt_contexts [518.607596] Dynamic subtest gt_contexts: SUCCESS (1.748s) [518.621565] Starting dynamic subtest: gt_lrc [525.060767] Dynamic subtest gt_lrc: SUCCESS (6.451s) [525.074624] Starting dynamic subtest: gt_mocs [528.068670] Dynamic subtest gt_mocs: SUCCESS (3.006s) [528.082477] Starting dynamic subtest: gt_pm [532.367658] Dynamic subtest gt_pm: SUCCESS (4.297s) [532.379652] Starting dynamic subtest: gt_heartbeat [534.085446] Dynamic subtest gt_heartbeat: SUCCESS (1.716s) [534.099141] Starting dynamic subtest: gt_tlb [546.839575] Dynamic subtest gt_tlb: SUCCESS (12.752s) [546.860953] Starting dynamic subtest: requests [560.377523] Dynamic subtest requests: SUCCESS (13.536s) [560.396664] Starting dynamic subtest: migrate [565.930322] Dynamic subtest migrate: SUCCESS (5.551s) [565.942793] Starting dynamic subtest: active [567.598436] Dynamic subtest active: SUCCESS (1.667s) [567.610682] Starting dynamic subtest: objects [569.977320] Dynamic subtest objects: SUCCESS (2.378s) [569.995001] Starting dynamic subtest: mman [576.708279] Dynamic subtest mman: SUCCESS (6.730s) [576.720643] Starting dynamic subtest: dmabuf [578.478639] Dynamic subtest dmabuf: SUCCESS (1.769s) [578.493073] Starting dynamic subtest: vma [580.117416] Dynamic subtest vma: SUCCESS (1.637s) [580.129940] Starting dynamic subtest: coherency [584.783731] Dynamic subtest coherency: SUCCESS (4.665s) [584.798030] Starting dynamic subtest: gtt [595.065417] Dynamic subtest gtt: SUCCESS (10.280s) [595.077743] Starting dynamic subtest: gem [596.954302] Dynamic subtest gem: SUCCESS (1.888s) [596.967316] Starting dynamic subtest: evict [600.004478] Dynamic subtest evict: SUCCESS (3.049s) [600.019517] Starting dynamic subtest: hugepages [618.511850] Dynamic subtest hugepages: SUCCESS (18.506s) [618.526164] Starting dynamic subtest: gem_contexts [651.893516] Dynamic subtest gem_contexts: SUCCESS (33.380s) [651.908138] Starting dynamic subtest: client [653.619397] Dynamic subtest client: SUCCESS (1.724s) [653.631826] Starting dynamic subtest: gem_migrate [657.228704] Dynamic subtest gem_migrate: SUCCESS (3.608s) [657.251428] Starting dynamic subtest: reset [659.028588] Dynamic subtest reset: SUCCESS (1.798s) [659.041342] Starting dynamic subtest: memory_region [662.297862] Dynamic subtest memory_region: SUCCESS (3.268s) [662.310569] Starting dynamic subtest: hangcheck [692.772611] Dynamic subtest hangcheck: SUCCESS (30.473s) [692.787622] Starting dynamic subtest: execlists [694.406589] Dynamic subtest execlists: SUCCESS (1.632s) [694.419800] Starting dynamic subtest: ring_submission [696.063736] Dynamic subtest ring_submission: SUCCESS (1.656s) [696.076810] Starting dynamic subtest: perf [697.893476] Dynamic subtest perf: SUCCESS (1.828s) [697.906529] Starting dynamic subtest: slpc [705.406623] Dynamic subtest slpc: SUCCESS (7.512s) [705.419410] Starting dynamic subtest: guc [708.330417] Dynamic subtest guc: SUCCESS (2.922s) [708.344067] Starting dynamic subtest: guc_multi_lrc [710.069689] Dynamic subtest guc_multi_lrc: SUCCESS (1.738s) [710.082649] Starting dynamic subtest: guc_hang [712.578518] Dynamic subtest guc_hang: SUCCESS (2.507s) [712.591677] Starting dynamic subtest: late_gt_pm [714.315602] Dynamic subtest late_gt_pm: SUCCESS (1.736s) [714.316584] Subtest live: FAIL (240.010s) [714.349993] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [714.350981] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [714.352858] [090/132] (309s left) kms_atomic_transition (modeset-transition) [716.076706] Starting subtest: modeset-transition [716.077620] Starting dynamic subtest: 1x-outputs [718.694726] Dynamic subtest 1x-outputs: SUCCESS (2.617s) [718.699549] Subtest modeset-transition: SUCCESS (2.620s) [718.970727] [FACT kms_atomic_transition (modeset-transition)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [718.973230] [FACT kms_atomic_transition (modeset-transition)] new: kernel.kmod_is_loaded.i915: true [718.976008] [091/132] (305s left) syncobj_wait (wait-for-submit-complex) [719.053661] Starting subtest: wait-for-submit-complex [719.116240] Subtest wait-for-submit-complex: SUCCESS (0.062s) [719.307716] [092/132] (304s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [719.512900] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [720.754631] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.240s) [720.992718] [093/132] (303s left) syncobj_timeline (wait-all-for-submit-snapshot) [721.071896] Starting subtest: wait-all-for-submit-snapshot [721.155483] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s) [721.325218] [094/132] (303s left) gem_sync (basic-each) [721.420854] Starting subtest: basic-each [723.559043] Subtest basic-each: SUCCESS (2.138s) [723.808900] [095/132] (300s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [724.074689] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [724.077901] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [724.514590] [096/132] (299s left) gem_mmap_offset (clear-via-pagefault) [724.671514] Starting subtest: clear-via-pagefault [724.672579] Starting dynamic subtest: lmem0 [750.002982] Dynamic subtest lmem0: SUCCESS (25.333s) [750.018530] Starting dynamic subtest: smem0 [774.688399] Dynamic subtest smem0: SUCCESS (24.684s) [774.689356] Subtest clear-via-pagefault: SUCCESS (50.020s) [774.906165] [097/132] (249s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [775.107694] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [775.109485] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [775.307748] [098/132] (249s left) gem_partial_pwrite_pread (write-display) [775.391775] Subtest write-display: SKIP (0.000s) [775.485897] [099/132] (249s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [775.686508] Starting subtest: yf-tiled-16bpp-rotate-90 [775.688392] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [775.868611] [100/132] (248s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [776.065811] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [776.067646] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [776.417439] [101/132] (248s left) gem_ctx_param (invalid-size-set) [776.495200] Starting subtest: invalid-size-set [776.497544] Subtest invalid-size-set: SUCCESS (0.001s) [776.676306] [102/132] (248s left) kms_flip (dpms-off-confusion-interruptible) [776.868016] Starting subtest: dpms-off-confusion-interruptible [776.872805] Starting dynamic subtest: A-DP3 [784.684876] Dynamic subtest A-DP3: SUCCESS (7.812s) [784.706877] Starting dynamic subtest: B-DP3 [792.443753] Dynamic subtest B-DP3: SUCCESS (7.757s) [792.461530] Starting dynamic subtest: C-DP3 [800.196283] Dynamic subtest C-DP3: SUCCESS (7.750s) [800.215076] Starting dynamic subtest: D-DP3 [807.944167] Dynamic subtest D-DP3: SUCCESS (7.743s) [807.948973] Subtest dpms-off-confusion-interruptible: SUCCESS (31.081s) [808.319265] [103/132] (216s left) gem_mmap (short-mmap) [808.400631] Subtest short-mmap: SKIP (0.000s) [808.476012] [104/132] (216s left) kms_sequence (queue-busy) [808.663795] Starting subtest: queue-busy [808.664683] Starting dynamic subtest: pipe-A-DP-3 [811.237998] Dynamic subtest pipe-A-DP-3: SUCCESS (2.572s) [811.257534] Starting dynamic subtest: pipe-B-DP-3 [813.732669] Dynamic subtest pipe-B-DP-3: SUCCESS (2.493s) [813.755535] Starting dynamic subtest: pipe-C-DP-3 [816.211563] Dynamic subtest pipe-C-DP-3: SUCCESS (2.476s) [816.227528] Starting dynamic subtest: pipe-D-DP-3 [818.692304] Dynamic subtest pipe-D-DP-3: SUCCESS (2.478s) [818.693418] Subtest queue-busy: SUCCESS (10.029s) [818.997683] [105/132] (206s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [819.199883] Starting subtest: fbcpsr-stridechange [819.201634] Subtest fbcpsr-stridechange: SKIP (0.000s) [819.396615] [106/132] (205s left) kms_big_fb (4-tiled-16bpp-rotate-270) [819.595955] Starting subtest: 4-tiled-16bpp-rotate-270 [819.659310] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.063s) [819.895416] [107/132] (205s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [820.089800] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [820.091533] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [820.299479] [108/132] (205s left) kms_psr (fbc-psr2-no-drrs) [820.491541] Subtest fbc-psr2-no-drrs: SKIP (0.000s) [820.556438] [109/132] (204s left) sysfs_timeslice_duration (timeout) [820.643616] Starting subtest: timeout [820.646197] Starting dynamic subtest: vecs0 [822.556660] Dynamic subtest vecs0: SUCCESS (1.911s) [822.571821] Starting dynamic subtest: ccs0 [824.345665] Dynamic subtest ccs0: SUCCESS (1.788s) [824.363938] Starting dynamic subtest: vcs0 [826.035547] Dynamic subtest vcs0: SUCCESS (1.688s) [826.050513] Starting dynamic subtest: bcs0 [827.138532] Dynamic subtest bcs0: SUCCESS (1.102s) [827.153958] Starting dynamic subtest: vecs1 [828.864678] Dynamic subtest vecs1: SUCCESS (1.725s) [828.879784] Starting dynamic subtest: rcs0 [830.556548] Dynamic subtest rcs0: SUCCESS (1.691s) [830.574476] Starting dynamic subtest: vcs1 [832.210665] Dynamic subtest vcs1: SUCCESS (1.653s) [832.211617] Subtest timeout: SUCCESS (11.567s) [832.440596] [110/132] (193s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [832.523174] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [832.525062] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [832.801439] [111/132] (192s left) kms_psr (psr-primary-mmap-gtt) [832.997824] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [833.057091] [112/132] (192s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [833.249634] Starting subtest: addfb25-y-tiled-small-legacy [833.251506] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [833.446129] [113/132] (192s left) kms_prime (basic-modeset-hybrid) [833.639941] Subtest basic-modeset-hybrid: SKIP (0.000s) [833.843385] [114/132] (192s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [834.038825] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [834.040541] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [834.189779] [115/132] (191s left) gem_mmap_gtt (coherency) [834.268745] Subtest coherency: SKIP (0.000s) [834.346843] [116/132] (191s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [834.548432] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [836.910130] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.362s) [837.127107] [117/132] (188s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [837.319741] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [837.320508] Starting dynamic subtest: pipe-A [839.375548] Dynamic subtest pipe-A: SUCCESS (2.056s) [839.401636] Starting dynamic subtest: pipe-B [841.591659] Dynamic subtest pipe-B: SUCCESS (2.215s) [841.618406] Starting dynamic subtest: pipe-C [841.908953] Dynamic subtest pipe-C: SUCCESS (0.315s) [841.943773] Starting dynamic subtest: pipe-D [842.224704] Dynamic subtest pipe-D: SUCCESS (0.313s) [842.225837] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (4.907s) [842.597419] [118/132] (183s left) sriov_basic (enable-vfs-autoprobe-off) [842.677639] Subtest enable-vfs-autoprobe-off: SKIP (0.000s) [842.757279] [119/132] (183s left) kms_vblank (wait-forked) [842.948975] Starting subtest: wait-forked [842.951564] Starting dynamic subtest: pipe-A-DP-3 [845.331934] Dynamic subtest pipe-A-DP-3: SUCCESS (2.380s) [845.365582] Starting dynamic subtest: pipe-D-DP-3 [847.658597] Dynamic subtest pipe-D-DP-3: SUCCESS (2.316s) [847.659692] Subtest wait-forked: SUCCESS (4.710s) [847.967073] [120/132] (178s left) kms_chamelium_audio (dp-audio-edid) [848.258519] Subtest dp-audio-edid: SKIP (0.000s) [848.426192] [121/132] (177s left) gem_ctx_persistence (process) [848.510854] Starting subtest: process [848.759065] Subtest process: SUCCESS (0.248s) [848.945907] [122/132] (177s left) gem_lmem_swapping (heavy-multi) [851.753033] Starting subtest: heavy-multi [851.753882] Starting dynamic subtest: lmem0 [857.582677] Dynamic subtest lmem0: SUCCESS (5.830s) [857.583507] Subtest heavy-multi: SUCCESS (5.832s) [859.732492] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [859.733657] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true [859.735807] [123/132] (166s left) syncobj_wait (single-wait-signaled) [861.407903] Starting subtest: single-wait-signaled [861.408974] Subtest single-wait-signaled: SUCCESS (0.000s) [861.463929] [FACT syncobj_wait (single-wait-signaled)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [861.466368] [FACT syncobj_wait (single-wait-signaled)] new: kernel.kmod_is_loaded.i915: true [861.469737] [124/132] (165s left) i915_pm_freq_api (freq-reset-multiple) [861.598617] Starting subtest: freq-reset-multiple [861.599565] Starting dynamic subtest: gt0 [878.957754] Dynamic subtest gt0: SUCCESS (17.357s) [878.958658] Subtest freq-reset-multiple: SUCCESS (17.359s) [879.070083] [125/132] (147s left) kms_plane_cursor (overlay) [879.266351] Starting subtest: overlay [879.268166] Starting dynamic subtest: pipe-A-DP-3-size-64 [882.781687] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.513s) [882.883006] Starting dynamic subtest: pipe-A-DP-3-size-128 [886.363930] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.515s) [886.448587] Starting dynamic subtest: pipe-A-DP-3-size-256 [889.897330] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.465s) [890.077281] Starting dynamic subtest: pipe-B-DP-3-size-64 [893.645632] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.592s) [893.714484] Starting dynamic subtest: pipe-B-DP-3-size-128 [897.195657] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.498s) [897.296090] Starting dynamic subtest: pipe-B-DP-3-size-256 [900.795756] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.548s) [900.959759] Starting dynamic subtest: pipe-C-DP-3-size-64 [904.565014] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.624s) [904.634019] Starting dynamic subtest: pipe-C-DP-3-size-128 [908.114949] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.498s) [908.210905] Starting dynamic subtest: pipe-C-DP-3-size-256 [911.681789] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.514s) [911.847775] Starting dynamic subtest: pipe-D-DP-3-size-64 [915.439447] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.611s) [915.537105] Starting dynamic subtest: pipe-D-DP-3-size-128 [919.006195] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.514s) [919.074506] Starting dynamic subtest: pipe-D-DP-3-size-256 [922.556277] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.499s) [922.669040] Subtest overlay: SUCCESS (43.402s) [923.017176] [126/132] (103s left) gem_exec_balancer (parallel-contexts) [923.377208] Starting subtest: parallel-contexts [930.064743] Subtest parallel-contexts: SUCCESS (6.699s) [930.265532] [127/132] ( 96s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [930.460355] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [930.462802] Starting dynamic subtest: pipe-A-valid-mode [932.233988] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.769s) [932.235362] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.772s) [932.541892] [128/132] ( 94s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [932.738825] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [935.755207] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (3.017s) [935.940832] [129/132] ( 91s left) gem_exec_balancer (individual) [936.028541] Starting subtest: individual [938.041129] Subtest individual: SUCCESS (2.012s) [938.506352] [130/132] ( 88s left) perf (non-zero-reason) [938.962320] Starting subtest: non-zero-reason [938.963273] Starting dynamic subtest: 0-rcs0 [942.062471] Dynamic subtest 0-rcs0: FAIL (2.767s) [942.064037] Subtest non-zero-reason: FAIL (2.768s) [942.142850] [131/132] ( 84s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [942.348841] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [942.349775] Starting dynamic subtest: pipe-A-DP-3 [945.508235] Dynamic subtest pipe-A-DP-3: SUCCESS (3.143s) [945.529564] Starting dynamic subtest: pipe-B-DP-3 [946.073690] Dynamic subtest pipe-B-DP-3: SUCCESS (0.557s) [946.106988] Starting dynamic subtest: pipe-C-DP-3 [946.656295] Dynamic subtest pipe-C-DP-3: SUCCESS (0.575s) [946.689231] Starting dynamic subtest: pipe-D-DP-3 [947.246960] Dynamic subtest pipe-D-DP-3: SUCCESS (0.574s) [947.248334] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (4.877s) [947.638049] [132/132] ( 79s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [947.719818] Subtest invalidate-primary-flip-overlay: SKIP (0.000s) [947.806455] Closing watchdogs results: parsing output: 0/ for test: gem_spin_batch results: parsing output: 1/ for test: kms_joiner results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_exec_schedule results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: gem_exec_store results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_chamelium_hpd results: parsing output: 9/ for test: gem_exec_reloc results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: api_intel_bb results: parsing output: 12/ for test: gen9_exec_parse results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: kms_ccs results: parsing output: 17/ for test: kms_psr2_sf results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_mmap_wc results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_exec_params results: parsing output: 22/ for test: syncobj_timeline results: parsing output: 23/ for test: vgem_basic results: parsing output: 24/ for test: syncobj_wait results: parsing output: 25/ for test: kms_cursor_edge_walk results: parsing output: 26/ for test: prime_vgem results: parsing output: 27/ for test: gem_ctx_engines results: parsing output: 28/ for test: gem_mmap results: parsing output: 29/ for test: kms_lease results: parsing output: 30/ for test: kms_draw_crc results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_flip results: parsing output: 33/ for test: gem_softpin results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: kms_psr2_sf results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_exec_async results: parsing output: 38/ for test: kms_cursor_crc results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: gem_pread results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_ccs results: parsing output: 44/ for test: kms_cursor_legacy results: parsing output: 45/ for test: gem_ctx_persistence results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_pxp results: parsing output: 48/ for test: kms_plane_scaling results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: api_intel_bb results: parsing output: 51/ for test: kms_vblank results: parsing output: 52/ for test: gem_pxp results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: gem_exec_fence results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_pipe_crc_basic results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: core_hotunplug results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: i915_drm_fdinfo results: parsing output: 62/ for test: kms_flip results: parsing output: 63/ for test: gem_mmap_gtt results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_wait results: parsing output: 66/ for test: gem_lmem_swapping results: parsing output: 67/ for test: gem_exec_suspend results: parsing output: 68/ for test: gem_exec_flush results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_pm_dc results: parsing output: 73/ for test: kms_content_protection results: parsing output: 74/ for test: perf_pmu results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_chamelium_edid results: parsing output: 77/ for test: template results: parsing output: 78/ for test: syncobj_wait results: parsing output: 79/ for test: kms_flip results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: kms_cursor_legacy results: parsing output: 82/ for test: i915_pm_rpm results: parsing output: 83/ for test: prime_mmap results: parsing output: 84/ for test: gem_mmap results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: i915_selftest results: parsing output: 89/ for test: kms_atomic_transition results: parsing output: 90/ for test: syncobj_wait results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: gem_sync results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: gem_mmap_offset results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_partial_pwrite_pread results: parsing output: 98/ for test: kms_big_fb results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: gem_ctx_param results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: gem_mmap results: parsing output: 103/ for test: kms_sequence results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: sysfs_timeslice_duration results: parsing output: 109/ for test: gem_render_copy results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: kms_addfb_basic results: parsing output: 112/ for test: kms_prime results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_mmap_gtt results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_plane_scaling results: parsing output: 117/ for test: sriov_basic results: parsing output: 118/ for test: kms_vblank results: parsing output: 119/ for test: kms_chamelium_audio results: parsing output: 120/ for test: gem_ctx_persistence results: parsing output: 121/ for test: gem_lmem_swapping results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: i915_pm_freq_api results: parsing output: 124/ for test: kms_plane_cursor results: parsing output: 125/ for test: gem_exec_balancer results: parsing output: 126/ for test: kms_flip_scaled_crc results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_exec_balancer results: parsing output: 129/ for test: perf results: parsing output: 130/ for test: kms_ccs results: parsing output: 131/ for test: kms_psr_stress_test Done.