[68.338081] Initializing watchdogs [68.338153] /dev/watchdog0 [68.358423] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [68.369560] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [68.373215] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [68.375665] [001/132] (960s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [68.645862] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [68.810666] [002/132] (960s left) gem_exec_create (basic) [68.897409] Starting subtest: basic [68.898344] Starting dynamic subtest: smem [71.000027] Dynamic subtest smem: SUCCESS (2.102s) [71.008382] Starting dynamic subtest: lmem0 [73.103452] Dynamic subtest lmem0: SUCCESS (2.103s) [73.104545] Subtest basic: SUCCESS (4.206s) [73.349414] [003/132] (955s left) gen9_exec_parse (bb-chained) [73.426489] Subtest bb-chained: SKIP (0.000s) [73.497837] [004/132] (955s left) kms_addfb_basic (bad-pitch-128) [73.567864] Starting subtest: bad-pitch-128 [73.568733] Subtest bad-pitch-128: SUCCESS (0.000s) [73.870231] [005/132] (955s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [74.055137] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [74.056054] Starting dynamic subtest: pipe-A-DP-3 [74.064481] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [74.072213] Starting dynamic subtest: pipe-B-DP-3 [74.080546] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [74.088056] Starting dynamic subtest: pipe-C-DP-3 [74.096291] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [74.103744] Starting dynamic subtest: pipe-D-DP-3 [74.112958] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [74.114886] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.004s) [74.504654] [006/132] (954s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [74.575289] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [74.576245] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [74.731789] [007/132] (954s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [74.920948] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [74.922687] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [75.098484] [008/132] (954s left) gem_exec_balancer (nop) [75.183364] Starting subtest: nop [124.558206] Subtest nop: SUCCESS (49.375s) [125.009691] [009/132] (904s left) gem_exec_params (rel-constants-invalid-ring) [125.083639] Starting subtest: rel-constants-invalid-ring [125.084561] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [125.243721] [010/132] (904s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [125.422563] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [125.423490] Starting dynamic subtest: pipe-A-valid-mode [127.768494] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.343s) [127.770098] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.345s) [128.081597] [011/132] (901s left) kms_addfb_basic (unused-modifier) [128.151028] Starting subtest: unused-modifier [128.151954] Subtest unused-modifier: SUCCESS (0.000s) [128.463008] [012/132] (901s left) kms_plane_scaling (2x-scaler-multi-pipe) [128.654956] Starting subtest: 2x-scaler-multi-pipe [128.658036] Subtest 2x-scaler-multi-pipe: SKIP (0.002s) [128.817362] [013/132] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [129.005911] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [129.007670] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [129.163015] [014/132] (900s left) gem_exec_fence (submit) [129.362343] Starting subtest: submit [129.364437] Subtest submit: SKIP (0.000s) [130.177136] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true [130.178827] [015/132] (899s left) device_reset (unbind-cold-reset-rebind) [130.266897] Starting subtest: unbind-cold-reset-rebind [130.269029] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [130.440241] [016/132] (899s left) syncobj_basic (bad-destroy-pad) [130.518055] Starting subtest: bad-destroy-pad [130.519162] Subtest bad-destroy-pad: SUCCESS (0.000s) [130.677723] [017/132] (899s left) gem_exercise_blt (fast-copy) [130.759104] Starting subtest: fast-copy [130.760009] Starting dynamic subtest: linear-smem-smem [130.811409] Dynamic subtest linear-smem-smem: SUCCESS (0.052s) [130.819602] Starting dynamic subtest: linear-smem-lmem0 [130.828125] Dynamic subtest linear-smem-lmem0: SUCCESS (0.016s) [130.836481] Starting dynamic subtest: linear-lmem0-smem [130.924451] Dynamic subtest linear-lmem0-smem: SUCCESS (0.096s) [130.932535] Starting dynamic subtest: linear-lmem0-lmem0 [131.016823] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.092s) [131.025241] Starting dynamic subtest: xmajor-smem-smem [131.034906] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s) [131.043310] Starting dynamic subtest: xmajor-smem-lmem0 [131.051431] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.016s) [131.059829] Starting dynamic subtest: xmajor-lmem0-smem [131.155449] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.104s) [131.163824] Starting dynamic subtest: xmajor-lmem0-lmem0 [131.255240] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.100s) [131.263603] Starting dynamic subtest: tile4-smem-smem [131.271552] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s) [131.280041] Starting dynamic subtest: tile4-smem-lmem0 [131.287988] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.016s) [131.296444] Starting dynamic subtest: tile4-lmem0-smem [131.396366] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.108s) [131.404744] Starting dynamic subtest: tile4-lmem0-lmem0 [131.497397] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.101s) [131.505597] Starting dynamic subtest: tile64-smem-smem [131.515358] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s) [131.523614] Starting dynamic subtest: tile64-smem-lmem0 [131.531827] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.016s) [131.540167] Starting dynamic subtest: tile64-lmem0-smem [131.623026] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.091s) [131.631385] Starting dynamic subtest: tile64-lmem0-lmem0 [131.715963] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.093s) [131.716998] Subtest fast-copy: SUCCESS (0.957s) [131.866982] [018/132] (898s left) kms_big_fb (x-tiled-8bpp-rotate-90) [132.071312] Starting subtest: x-tiled-8bpp-rotate-90 [132.134401] Subtest x-tiled-8bpp-rotate-90: SKIP (0.063s) [132.363615] [019/132] (897s left) gem_mmap_offset (partial-unmap) [132.440086] Starting subtest: partial-unmap [132.440947] Starting dynamic subtest: lmem0 [132.451269] Dynamic subtest lmem0: SUCCESS (0.011s) [132.460618] Starting dynamic subtest: smem0 [132.461471] Dynamic subtest smem0: SUCCESS (0.004s) [132.462563] Subtest partial-unmap: SUCCESS (0.016s) [132.649724] [020/132] (897s left) kms_content_protection (atomic-dpms) [132.906338] Starting subtest: atomic-dpms [132.933340] Starting dynamic subtest: pipe-A-DP-3 [254.273260] Dynamic subtest pipe-A-DP-3: FAIL (121.174s) [254.274679] Subtest atomic-dpms: FAIL (121.306s) [254.531814] [021/132] (775s left) kms_pipe_stress (stress-xrgb8888-yftiled) [254.729465] Starting subtest: stress-xrgb8888-yftiled [254.731191] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [254.839665] [022/132] (775s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [255.031006] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [255.046053] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.015s) [255.244577] [023/132] (775s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [255.332489] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [255.334479] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [255.594157] [024/132] (774s left) sw_sync (sync_multi_timeline_wait) [255.641581] Starting subtest: sync_multi_timeline_wait [255.642478] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [255.755104] [025/132] (774s left) gem_madvise (dontneed-before-pwrite) [255.802437] Starting subtest: dontneed-before-pwrite [255.833818] Subtest dontneed-before-pwrite: SKIP (0.031s) [255.913919] [026/132] (774s left) kms_addfb_basic (addfb25-y-tiled-legacy) [256.103535] Starting subtest: addfb25-y-tiled-legacy [256.104421] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [256.301919] [027/132] (774s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [256.493560] Starting subtest: primary-x-tiled-reflect-x-180 [266.842796] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.348s) [267.176697] [028/132] (763s left) gem_mmap_wc (read) [267.251998] Subtest read: SKIP (0.000s) [267.315992] [029/132] (763s left) kms_invalid_mode (bad-vtotal) [267.510596] Starting subtest: bad-vtotal [267.511483] Starting dynamic subtest: pipe-A-DP-3 [267.599446] Dynamic subtest pipe-A-DP-3: SUCCESS (0.089s) [267.613755] Starting dynamic subtest: pipe-B-DP-3 [267.614982] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s) [267.627743] Starting dynamic subtest: pipe-C-DP-3 [267.628696] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s) [267.640834] Starting dynamic subtest: pipe-D-DP-3 [267.641800] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s) [267.642677] Subtest bad-vtotal: SUCCESS (0.097s) [267.875513] [030/132] (763s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [268.067494] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [268.068438] Starting dynamic subtest: pipe-A-valid-mode [269.872445] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.803s) [269.873362] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.804s) [270.191264] [031/132] (760s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [270.474712] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [270.629117] [032/132] (760s left) gem_ppgtt (shrink-vs-evict-pinned) [270.715320] Starting subtest: shrink-vs-evict-pinned [275.946107] Subtest shrink-vs-evict-pinned: SUCCESS (5.228s) [276.072197] [033/132] (755s left) kms_dp_link_training (uhbr-sst) [276.274197] Starting subtest: uhbr-sst [276.275936] Subtest uhbr-sst: SKIP (0.000s) [276.443970] [034/132] (754s left) kms_flip (basic-flip-vs-dpms) [276.635136] Starting subtest: basic-flip-vs-dpms [276.639241] Starting dynamic subtest: A-DP3 [277.683407] Dynamic subtest A-DP3: SUCCESS (1.042s) [277.702498] Starting dynamic subtest: B-DP3 [278.458296] Dynamic subtest B-DP3: SUCCESS (0.774s) [278.471301] Starting dynamic subtest: C-DP3 [279.264053] Dynamic subtest C-DP3: SUCCESS (0.806s) [279.276237] Starting dynamic subtest: D-DP3 [280.054309] Dynamic subtest D-DP3: SUCCESS (0.788s) [280.057416] Subtest basic-flip-vs-dpms: SUCCESS (3.422s) [280.409779] [035/132] (750s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [280.605840] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [280.606740] Starting dynamic subtest: pipe-A-DP-3 [280.615075] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [280.624174] Starting dynamic subtest: pipe-B-DP-3 [280.632744] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [280.641617] Starting dynamic subtest: pipe-C-DP-3 [280.650122] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [280.658956] Starting dynamic subtest: pipe-D-DP-3 [280.668644] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [280.670680] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.008s) [281.108326] [036/132] (750s left) gem_mmap_wc (coherency) [281.187158] Subtest coherency: SKIP (0.000s) [281.253130] [037/132] (750s left) i915_drm_fdinfo (virtual-idle) [281.323052] Starting subtest: virtual-idle [284.940163] Subtest virtual-idle: SUCCESS (3.614s) [285.055112] [038/132] (746s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [285.253977] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [285.255616] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [285.443755] [039/132] (746s left) sw_sync (timeline_closed) [285.491432] Starting subtest: timeline_closed [285.492308] Subtest timeline_closed: SUCCESS (0.000s) [285.643767] [040/132] (745s left) gem_exec_schedule (pi-shared-iova) [285.853289] Starting subtest: pi-shared-iova [285.854235] Starting dynamic subtest: rcs0 [286.119337] Dynamic subtest rcs0: SUCCESS (0.266s) [286.128573] Starting dynamic subtest: bcs0 [286.293446] Dynamic subtest bcs0: SUCCESS (0.173s) [286.302747] Starting dynamic subtest: vcs0 [286.476218] Dynamic subtest vcs0: SUCCESS (0.182s) [286.485526] Starting dynamic subtest: vcs1 [286.666751] Dynamic subtest vcs1: SUCCESS (0.190s) [286.676027] Starting dynamic subtest: vecs0 [286.851916] Dynamic subtest vecs0: SUCCESS (0.185s) [286.861279] Starting dynamic subtest: vecs1 [287.034607] Dynamic subtest vecs1: SUCCESS (0.182s) [287.043994] Starting dynamic subtest: ccs0 [287.223945] Dynamic subtest ccs0: SUCCESS (0.189s) [287.225206] Subtest pi-shared-iova: SUCCESS (1.371s) [287.662776] [041/132] (744s left) api_intel_bb (object-noreloc-purge-cache-simple) [287.741332] Starting subtest: object-noreloc-purge-cache-simple [287.772571] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.031s) [287.973993] [042/132] (743s left) kms_cursor_crc (cursor-rapid-movement-32x32) [288.255188] Starting subtest: cursor-rapid-movement-32x32 [288.305341] Subtest cursor-rapid-movement-32x32: SKIP (0.049s) [288.739358] [043/132] (743s left) i915_drm_fdinfo (most-busy-check-all) [288.810151] Starting subtest: most-busy-check-all [288.811094] Starting dynamic subtest: rcs0 [288.838574] Dynamic subtest rcs0: SKIP (0.027s) [288.848234] Starting dynamic subtest: bcs0 [288.850630] Dynamic subtest bcs0: SKIP (0.000s) [288.859680] Starting dynamic subtest: vcs0 [288.861541] Dynamic subtest vcs0: SKIP (0.000s) [288.870672] Starting dynamic subtest: vcs1 [288.873035] Dynamic subtest vcs1: SKIP (0.000s) [288.881960] Starting dynamic subtest: vecs0 [288.884171] Dynamic subtest vecs0: SKIP (0.000s) [288.892898] Starting dynamic subtest: vecs1 [288.895058] Dynamic subtest vecs1: SKIP (0.000s) [288.903901] Starting dynamic subtest: ccs0 [288.906151] Dynamic subtest ccs0: SKIP (0.000s) [288.908166] Subtest most-busy-check-all: SKIP (0.033s) [288.958231] [044/132] (742s left) syncobj_wait (multi-wait-all-signaled) [289.068318] Starting subtest: multi-wait-all-signaled [289.069353] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [289.223842] [045/132] (742s left) gem_softpin (softpin) [289.310374] Starting subtest: softpin [321.703435] Subtest softpin: SUCCESS (32.391s) [321.876813] [046/132] (710s left) kms_cursor_crc (cursor-onscreen-256x85) [322.315362] Starting subtest: cursor-onscreen-256x85 [322.319761] Starting dynamic subtest: pipe-A-DP-3 [325.044589] Dynamic subtest pipe-A-DP-3: SUCCESS (2.724s) [325.092715] Starting dynamic subtest: pipe-D-DP-3 [327.864294] Dynamic subtest pipe-D-DP-3: SUCCESS (2.778s) [327.865536] Subtest cursor-onscreen-256x85: SUCCESS (5.547s) [328.273097] [047/132] (703s left) gem_exec_schedule (u-submit-late-slice) [328.366988] Starting subtest: u-submit-late-slice [328.367986] Starting dynamic subtest: rcs0 [328.446683] Dynamic subtest rcs0: SUCCESS (0.079s) [328.456325] Starting dynamic subtest: bcs0 [328.496342] Dynamic subtest bcs0: SUCCESS (0.049s) [328.505765] Starting dynamic subtest: vcs0 [328.546235] Dynamic subtest vcs0: SUCCESS (0.049s) [328.556010] Starting dynamic subtest: vcs1 [328.594469] Dynamic subtest vcs1: SUCCESS (0.048s) [328.604529] Starting dynamic subtest: vecs0 [328.646263] Dynamic subtest vecs0: SUCCESS (0.051s) [328.655882] Starting dynamic subtest: vecs1 [328.694040] Dynamic subtest vecs1: SUCCESS (0.047s) [328.703466] Starting dynamic subtest: ccs0 [328.745525] Dynamic subtest ccs0: SUCCESS (0.051s) [328.746414] Subtest u-submit-late-slice: SUCCESS (0.379s) [329.247351] [048/132] (702s left) syncobj_wait (wait-any-interrupted) [329.325220] Starting subtest: wait-any-interrupted [329.427476] Subtest wait-any-interrupted: SUCCESS (0.101s) [329.617874] [049/132] (702s left) syncobj_timeline (reset-during-wait-for-submit) [329.696460] Starting subtest: reset-during-wait-for-submit [329.800760] Subtest reset-during-wait-for-submit: SUCCESS (0.104s) [329.923680] [050/132] (702s left) kms_async_flips (invalid-async-flip) [330.112797] Starting subtest: invalid-async-flip [330.339637] Starting dynamic subtest: pipe-A-DP-3 [330.750361] Dynamic subtest pipe-A-DP-3: SUCCESS (0.411s) [330.951781] Starting dynamic subtest: pipe-B-DP-3 [331.104908] Dynamic subtest pipe-B-DP-3: SUCCESS (0.162s) [331.306013] Starting dynamic subtest: pipe-C-DP-3 [331.466673] Dynamic subtest pipe-C-DP-3: SUCCESS (0.170s) [331.630802] Starting dynamic subtest: pipe-D-DP-3 [331.782719] Dynamic subtest pipe-D-DP-3: SUCCESS (0.163s) [331.783785] Subtest invalid-async-flip: SUCCESS (1.670s) [332.281834] [051/132] (700s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [332.362408] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [332.476651] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s) [332.590180] [052/132] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [332.786074] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [332.787855] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [332.947494] [053/132] (699s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [333.137970] Starting subtest: short-flip-after-cursor-atomic-transitions [334.235011] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.097s) [334.571282] [054/132] (697s left) kms_psr (fbc-pr-dpms) [334.765604] Subtest fbc-pr-dpms: SKIP (0.000s) [334.833472] [055/132] (697s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [334.913407] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [335.023630] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [335.188732] [056/132] (697s left) gem_bad_reloc (negative-reloc-lut) [335.276591] Subtest negative-reloc-lut: SKIP (0.000s) [335.348352] [057/132] (697s left) gem_exec_gttfill (multigpu-basic) [335.553175] Starting subtest: multigpu-basic [355.159290] Subtest multigpu-basic: SUCCESS (19.609s) [355.323226] [058/132] (677s left) gem_exec_params (invalid-bsd1-flag-on-blt) [355.442478] Starting subtest: invalid-bsd1-flag-on-blt [355.443407] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [355.572471] [059/132] (677s left) kms_psr (psr2-sprite-plane-move) [355.771490] Subtest psr2-sprite-plane-move: SKIP (0.000s) [355.833827] [060/132] (677s left) gem_exec_endless (dispatch) [355.933929] Starting subtest: dispatch [355.934846] Starting dynamic subtest: rcs0 [355.941747] Dynamic subtest rcs0: SUCCESS (0.008s) [355.951580] Starting dynamic subtest: bcs0 [355.953310] Dynamic subtest bcs0: SUCCESS (0.006s) [355.963228] Starting dynamic subtest: vcs0 [355.965069] Dynamic subtest vcs0: SUCCESS (0.008s) [355.974960] Starting dynamic subtest: vcs1 [355.976823] Dynamic subtest vcs1: SUCCESS (0.009s) [355.986460] Starting dynamic subtest: vecs0 [536.634985] Per-test timeout exceeded. Killing the current test with SIGQUIT. [656.996581] Timeout. Killing the current test with SIGKILL. [657.020754] Closing watchdogs [657.024522] Initializing watchdogs [657.024567] /dev/watchdog0 [657.046242] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [657.060096] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [657.062346] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [657.062930] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [657.065312] [061/132] (375s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [657.264121] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [657.265875] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [657.455534] [062/132] (375s left) kms_psr (fbc-psr-cursor-plane-move) [657.652253] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [657.718112] [063/132] (375s left) vgem_basic (dmabuf-mmap) [657.773909] Starting subtest: dmabuf-mmap [657.796492] Subtest dmabuf-mmap: SUCCESS (0.023s) [657.962999] [064/132] (375s left) kms_big_fb (linear-8bpp-rotate-180) [658.164174] Starting subtest: linear-8bpp-rotate-180 [659.724877] Subtest linear-8bpp-rotate-180: SUCCESS (1.560s) [659.938044] [065/132] (373s left) gem_flink_basic (bad-open) [660.015281] Starting subtest: bad-open [660.016262] Subtest bad-open: SUCCESS (0.000s) [660.217010] [066/132] (373s left) kms_vrr (flip-dpms) [660.410521] Starting subtest: flip-dpms [660.413288] Subtest flip-dpms: SKIP (0.000s) [660.576837] [067/132] (372s left) gem_ctx_persistence (process) [660.663654] Starting subtest: process [660.868287] Subtest process: SUCCESS (0.204s) [661.059353] [068/132] (372s left) i915_pm_rpm (gem-evict-pwrite) [663.089724] Starting subtest: gem-evict-pwrite [663.093246] Subtest gem-evict-pwrite: SKIP (0.000s) [663.511383] [069/132] (370s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [663.712913] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [663.765032] [070/132] (369s left) gem_wait (invalid-buf) [663.852157] Starting subtest: invalid-buf [663.853163] Subtest invalid-buf: SUCCESS (0.000s) [664.166539] [071/132] (369s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [664.359127] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [667.389105] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.031s) [667.620792] [072/132] (366s left) gem_lmem_swapping (parallel-random-verify) [670.546335] Starting subtest: parallel-random-verify [670.547390] Starting dynamic subtest: lmem0 [727.625491] Dynamic subtest lmem0: SUCCESS (57.080s) [727.626441] Subtest parallel-random-verify: SUCCESS (57.082s) [728.746653] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [728.747668] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true [728.749801] [073/132] (305s left) prime_vgem (fence-flip-hang) [730.410347] Subtest fence-flip-hang: SKIP (0.000s) [730.523845] [FACT prime_vgem (fence-flip-hang)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [730.526266] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.i915: true [730.528840] [074/132] (303s left) gem_exec_reloc (basic-range-active) [730.619497] Subtest basic-range-active: SKIP (0.000s) [730.702113] [075/132] (303s left) kms_cdclk (plane-scaling) [730.896443] Starting subtest: plane-scaling [730.897431] Starting dynamic subtest: pipe-A-DP-3 [730.979372] Dynamic subtest pipe-A-DP-3: SKIP (0.081s) [730.991064] Starting dynamic subtest: pipe-B-DP-3 [730.993078] Dynamic subtest pipe-B-DP-3: SKIP (0.003s) [731.003071] Starting dynamic subtest: pipe-C-DP-3 [731.004941] Dynamic subtest pipe-C-DP-3: SKIP (0.003s) [731.014487] Starting dynamic subtest: pipe-D-DP-3 [731.016315] Dynamic subtest pipe-D-DP-3: SKIP (0.003s) [731.018154] Subtest plane-scaling: SKIP (0.095s) [731.246820] [076/132] (302s left) kms_psr (fbc-psr2-primary-page-flip) [731.438424] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [731.506058] [077/132] (302s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [731.709263] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [731.710963] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [731.896829] [078/132] (302s left) gem_ccs (suspend-resume) [731.983487] Starting subtest: suspend-resume [731.984439] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [750.220353] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (4.036s) [750.231726] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [768.303104] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.844s) [768.315394] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [786.183518] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.715s) [786.194866] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [804.268844] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.693s) [804.281573] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [822.230219] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.650s) [822.242825] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [840.210388] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.609s) [840.223502] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [858.129553] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.554s) [858.142694] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [876.239408] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.624s) [876.240316] Subtest suspend-resume: SUCCESS (29.735s) [876.456844] [079/132] (157s left) gem_ctx_isolation (preservation-s3) [876.552100] Starting subtest: preservation-S3 [876.552967] Starting dynamic subtest: rcs0 [896.268492] Dynamic subtest rcs0: SUCCESS (3.875s) [896.283949] Starting dynamic subtest: bcs0 [915.505205] Dynamic subtest bcs0: SUCCESS (3.857s) [915.519940] Starting dynamic subtest: vcs0 [934.705183] Dynamic subtest vcs0: SUCCESS (4.006s) [934.718884] Starting dynamic subtest: vcs1 [953.865016] Dynamic subtest vcs1: SUCCESS (3.962s) [953.879441] Starting dynamic subtest: vecs0 [973.138197] Dynamic subtest vecs0: SUCCESS (3.871s) [973.153048] Starting dynamic subtest: vecs1 [992.312173] Dynamic subtest vecs1: SUCCESS (3.893s) [992.324703] Starting dynamic subtest: ccs0 [1011.545855] Dynamic subtest ccs0: SUCCESS (3.899s) [1011.546769] Subtest preservation-S3: SUCCESS (27.372s) [1011.888226] [080/132] ( 22s left) kms_sequence (queue-idle) [1012.084737] Starting subtest: queue-idle [1012.085643] Starting dynamic subtest: pipe-A-DP-3 [1014.487537] Dynamic subtest pipe-A-DP-3: SUCCESS (2.400s) [1014.502693] Starting dynamic subtest: pipe-B-DP-3 [1016.794818] Dynamic subtest pipe-B-DP-3: SUCCESS (2.304s) [1016.811372] Starting dynamic subtest: pipe-C-DP-3 [1019.090147] Dynamic subtest pipe-C-DP-3: SUCCESS (2.293s) [1019.104405] Starting dynamic subtest: pipe-D-DP-3 [1021.387513] Dynamic subtest pipe-D-DP-3: SUCCESS (2.294s) [1021.388501] Subtest queue-idle: SUCCESS (9.299s) [1021.701053] [081/132] ( 12s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [1021.899785] Starting subtest: yf-tiled-64bpp-rotate-180 [1021.901600] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [1022.105249] [082/132] ( 12s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [1022.302381] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [1022.304174] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [1022.501921] [083/132] ( 12s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [1022.698601] Starting subtest: fbc-rgb565-draw-mmap-cpu [1025.202201] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.503s) [1025.430669] [084/132] ( 9s left) gem_exec_schedule (promotion) [1025.520519] Starting subtest: promotion [1025.521521] Starting dynamic subtest: rcs0 [1025.815276] Dynamic subtest rcs0: SUCCESS (0.294s) [1025.827923] Starting dynamic subtest: bcs0 [1026.027178] Dynamic subtest bcs0: SUCCESS (0.211s) [1026.039444] Starting dynamic subtest: vcs0 [1026.244495] Dynamic subtest vcs0: SUCCESS (0.216s) [1026.257647] Starting dynamic subtest: vcs1 [1026.462242] Dynamic subtest vcs1: SUCCESS (0.217s) [1026.474851] Starting dynamic subtest: vecs0 [1026.683070] Dynamic subtest vecs0: SUCCESS (0.220s) [1026.695395] Starting dynamic subtest: vecs1 [1026.902527] Dynamic subtest vecs1: SUCCESS (0.218s) [1026.915082] Starting dynamic subtest: ccs0 [1027.152256] Dynamic subtest ccs0: SUCCESS (0.248s) [1027.153182] Subtest promotion: SUCCESS (1.631s) [1027.687781] [085/132] ( 7s left) kms_lease (lessee-list) [1027.876898] Starting subtest: lessee-list [1027.879388] Starting dynamic subtest: pipe-A-DP-3 [1027.880322] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s) [1027.894819] Starting dynamic subtest: pipe-B-DP-3 [1027.895734] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s) [1027.908548] Starting dynamic subtest: pipe-C-DP-3 [1027.909601] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s) [1027.922096] Starting dynamic subtest: pipe-D-DP-3 [1027.923125] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s) [1027.924148] Subtest lessee-list: SUCCESS (0.015s) [1028.042832] [086/132] ( 6s left) kms_flip (2x-modeset-vs-vblank-race) [1028.237781] Starting subtest: 2x-modeset-vs-vblank-race [1028.249229] Subtest 2x-modeset-vs-vblank-race: SKIP (0.015s) [1028.437474] [087/132] ( 6s left) gem_render_copy (linear-to-vebox-yf-tiled) [1028.521166] Starting subtest: linear-to-vebox-yf-tiled [1028.523507] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [1028.788825] [088/132] ( 6s left) perf_pmu (busy-hang) [1028.861384] Starting subtest: busy-hang [1028.862270] Starting dynamic subtest: rcs0 [1030.168126] Dynamic subtest rcs0: SUCCESS (1.306s) [1030.184304] Starting dynamic subtest: bcs0 [1031.418165] Dynamic subtest bcs0: SUCCESS (1.244s) [1031.463800] Starting dynamic subtest: vcs0 [1032.689288] Dynamic subtest vcs0: SUCCESS (1.267s) [1032.702975] Starting dynamic subtest: vcs1 [1033.943961] Dynamic subtest vcs1: SUCCESS (1.250s) [1033.957609] Starting dynamic subtest: vecs0 [1035.196505] Dynamic subtest vecs0: SUCCESS (1.248s) [1035.210001] Starting dynamic subtest: vecs1 [1036.448441] Dynamic subtest vecs1: SUCCESS (1.247s) [1036.461827] Starting dynamic subtest: ccs0 [1037.699005] Dynamic subtest ccs0: SUCCESS (1.249s) [1037.701903] Subtest busy-hang: SUCCESS (8.835s) [1037.844592] Overall timeout time exceeded, stopping. [1037.873578] Closing watchdogs results: parsing output: 0/ for test: kms_chamelium_hpd results: parsing output: 1/ for test: gem_exec_create results: parsing output: 2/ for test: gen9_exec_parse results: parsing output: 3/ for test: kms_addfb_basic results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: gem_exec_balancer results: parsing output: 8/ for test: gem_exec_params results: parsing output: 9/ for test: kms_flip_scaled_crc results: parsing output: 10/ for test: kms_addfb_basic results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_exec_fence results: parsing output: 14/ for test: device_reset results: parsing output: 15/ for test: syncobj_basic results: parsing output: 16/ for test: gem_exercise_blt results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: gem_mmap_offset results: parsing output: 19/ for test: kms_content_protection results: parsing output: 20/ for test: kms_pipe_stress results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: gem_render_copy results: parsing output: 23/ for test: sw_sync results: parsing output: 24/ for test: gem_madvise results: parsing output: 25/ for test: kms_addfb_basic results: parsing output: 26/ for test: kms_rotation_crc results: parsing output: 27/ for test: gem_mmap_wc results: parsing output: 28/ for test: kms_invalid_mode results: parsing output: 29/ for test: kms_flip_scaled_crc results: parsing output: 30/ for test: kms_chamelium_edid results: parsing output: 31/ for test: gem_ppgtt results: parsing output: 32/ for test: kms_dp_link_training results: parsing output: 33/ for test: kms_flip results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: gem_mmap_wc results: parsing output: 36/ for test: i915_drm_fdinfo results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: sw_sync results: parsing output: 39/ for test: gem_exec_schedule results: parsing output: 40/ for test: api_intel_bb results: parsing output: 41/ for test: kms_cursor_crc results: parsing output: 42/ for test: i915_drm_fdinfo results: parsing output: 43/ for test: syncobj_wait results: parsing output: 44/ for test: gem_softpin results: parsing output: 45/ for test: kms_cursor_crc results: parsing output: 46/ for test: gem_exec_schedule results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: syncobj_timeline results: parsing output: 49/ for test: kms_async_flips results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_cursor_legacy results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: gem_bad_reloc results: parsing output: 56/ for test: gem_exec_gttfill results: parsing output: 57/ for test: gem_exec_params results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: gem_exec_endless results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: vgem_basic results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: gem_flink_basic results: parsing output: 65/ for test: kms_vrr results: parsing output: 66/ for test: gem_ctx_persistence results: parsing output: 67/ for test: i915_pm_rpm results: parsing output: 68/ for test: kms_psr2_sf results: parsing output: 69/ for test: gem_wait results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: gem_lmem_swapping results: parsing output: 72/ for test: prime_vgem results: parsing output: 73/ for test: gem_exec_reloc results: parsing output: 74/ for test: kms_cdclk results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_ccs results: parsing output: 78/ for test: gem_ctx_isolation results: parsing output: 79/ for test: kms_sequence results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_exec_schedule results: parsing output: 84/ for test: kms_lease results: parsing output: 85/ for test: kms_flip results: parsing output: 86/ for test: gem_render_copy results: parsing output: 87/ for test: perf_pmu results: parsing output: 88/ for test: gem_mmap_wc results: no output, setting notrun results: parsing output: 89/ for test: kms_ccs results: no output, setting notrun results: parsing output: 90/ for test: kms_prop_blob results: no output, setting notrun results: parsing output: 91/ for test: kms_psr results: no output, setting notrun results: parsing output: 92/ for test: kms_pm_rpm results: no output, setting notrun results: parsing output: 93/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 94/ for test: gem_userptr_blits results: no output, setting notrun results: parsing output: 95/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 96/ for test: gem_ctx_shared results: no output, setting notrun results: parsing output: 97/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 98/ for test: kms_psr2_sf results: no output, setting notrun results: parsing output: 99/ for test: kms_psr results: no output, setting notrun results: parsing output: 100/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 101/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 102/ for test: prime_vgem results: no output, setting notrun results: parsing output: 103/ for test: i915_selftest results: no output, setting notrun results: parsing output: 104/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 105/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 106/ for test: gem_userptr_blits results: no output, setting notrun results: parsing output: 107/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 108/ for test: gem_softpin results: no output, setting notrun results: parsing output: 109/ for test: gem_exec_schedule results: no output, setting notrun results: parsing output: 110/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 111/ for test: gem_softpin results: no output, setting notrun results: parsing output: 112/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 113/ for test: sriov_basic results: no output, setting notrun results: parsing output: 114/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 115/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 116/ for test: gem_workarounds results: no output, setting notrun results: parsing output: 117/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 118/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 119/ for test: kms_ccs results: no output, setting notrun results: parsing output: 120/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 121/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 122/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 123/ for test: gem_close results: no output, setting notrun results: parsing output: 124/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 125/ for test: kms_flip results: no output, setting notrun results: parsing output: 126/ for test: kms_vblank results: no output, setting notrun results: parsing output: 127/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 128/ for test: sysfs_timeslice_duration results: no output, setting notrun results: parsing output: 129/ for test: kms_dirtyfb results: no output, setting notrun results: parsing output: 130/ for test: gem_userptr_blits results: no output, setting notrun results: parsing output: 131/ for test: kms_plane_cursor results: no output, setting notrun Done.