[67.642803] Initializing watchdogs [67.642880] /dev/watchdog0 [67.677791] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [67.699660] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [67.706799] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [67.709830] [001/156] (960s left) kms_vblank (ts-continuation-idle-hang) [69.288222] Starting subtest: ts-continuation-idle-hang [69.289190] Starting dynamic subtest: pipe-A-HDMI-A-3 [95.519268] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.232s) [95.529058] Starting dynamic subtest: pipe-D-HDMI-A-3 [120.507382] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.985s) [120.508286] Subtest ts-continuation-idle-hang: SUCCESS (51.222s) [120.719350] [002/156] (907s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [122.229427] Starting subtest: flip-vs-cursor-crc-legacy [122.804186] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.575s) [123.021133] [003/156] (905s left) perf_pmu (init-sema) [123.092998] Starting subtest: init-sema [123.093955] Starting dynamic subtest: rcs0 [123.094910] Dynamic subtest rcs0: SUCCESS (0.003s) [123.103389] Starting dynamic subtest: bcs0 [123.104314] Dynamic subtest bcs0: SUCCESS (0.000s) [123.112372] Starting dynamic subtest: vcs0 [123.113286] Dynamic subtest vcs0: SUCCESS (0.001s) [123.121589] Starting dynamic subtest: vcs1 [123.122792] Dynamic subtest vcs1: SUCCESS (0.000s) [123.131165] Starting dynamic subtest: vecs0 [123.132136] Dynamic subtest vecs0: SUCCESS (0.001s) [123.140637] Starting dynamic subtest: vecs1 [123.141788] Dynamic subtest vecs1: SUCCESS (0.000s) [123.150172] Starting dynamic subtest: ccs0 [123.151283] Dynamic subtest ccs0: SUCCESS (0.001s) [123.152241] Subtest init-sema: SUCCESS (0.008s) [123.214122] [004/156] (905s left) gem_mmap_wc (read) [123.284990] Subtest read: SKIP (0.000s) [123.364224] [005/156] (905s left) gem_exec_capture (capture) [123.448784] Starting subtest: capture [123.449743] Starting dynamic subtest: rcs0-smem [124.386154] Dynamic subtest rcs0-smem: SUCCESS (0.936s) [124.396120] Starting dynamic subtest: rcs0-lmem0 [125.795184] Dynamic subtest rcs0-lmem0: SUCCESS (1.409s) [125.803584] Starting dynamic subtest: bcs0-smem [126.685054] Dynamic subtest bcs0-smem: SUCCESS (0.890s) [126.693836] Starting dynamic subtest: bcs0-lmem0 [128.088199] Dynamic subtest bcs0-lmem0: SUCCESS (1.402s) [128.096698] Starting dynamic subtest: vcs0-smem [128.980182] Dynamic subtest vcs0-smem: SUCCESS (0.892s) [128.989036] Starting dynamic subtest: vcs0-lmem0 [129.880201] Dynamic subtest vcs0-lmem0: SUCCESS (0.900s) [129.888728] Starting dynamic subtest: vcs1-smem [130.774046] Dynamic subtest vcs1-smem: SUCCESS (0.893s) [130.782636] Starting dynamic subtest: vcs1-lmem0 [132.182155] Dynamic subtest vcs1-lmem0: SUCCESS (1.408s) [132.190694] Starting dynamic subtest: vecs0-smem [133.238248] Dynamic subtest vecs0-smem: FAIL (1.037s) [133.246403] Starting dynamic subtest: vecs0-lmem0 [134.623261] Dynamic subtest vecs0-lmem0: FAIL (1.381s) [134.631476] Starting dynamic subtest: vecs1-smem [136.026249] Dynamic subtest vecs1-smem: FAIL (1.402s) [136.034431] Starting dynamic subtest: vecs1-lmem0 [137.038389] Dynamic subtest vecs1-lmem0: FAIL (1.012s) [137.046591] Starting dynamic subtest: ccs0-smem [138.425051] Dynamic subtest ccs0-smem: SUCCESS (1.409s) [138.434056] Starting dynamic subtest: ccs0-lmem0 [139.848312] Dynamic subtest ccs0-lmem0: SUCCESS (1.422s) [139.849266] Subtest capture: FAIL (16.398s) [139.964836] [006/156] (888s left) kms_psr (psr2-primary-blt) [141.480134] Subtest psr2-primary-blt: SKIP (0.000s) [141.540147] [007/156] (886s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt) [143.053940] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt [143.055741] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [143.179995] [008/156] (885s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [144.713900] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [144.715504] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [144.826087] [009/156] (883s left) gem_tiled_swapping (non-threaded) [144.921937] Subtest non-threaded: SKIP (0.000s) [145.003218] [010/156] (883s left) kms_hdr (static-toggle) [146.519133] Starting subtest: static-toggle [146.519991] Starting dynamic subtest: pipe-A-HDMI-A-3-XRGB2101010 [146.521780] Dynamic subtest pipe-A-HDMI-A-3-XRGB2101010: SKIP (0.000s) [146.531012] Starting dynamic subtest: pipe-A-HDMI-A-3-XRGB16161616F [146.533079] Dynamic subtest pipe-A-HDMI-A-3-XRGB16161616F: SKIP (0.000s) [146.535075] Subtest static-toggle: SKIP (0.003s) [146.616101] [011/156] (882s left) gem_mmap_offset (ptrace) [146.709060] Starting subtest: ptrace [146.713603] Starting dynamic subtest: lmem0-fixed [146.845419] Dynamic subtest lmem0-fixed: SUCCESS (0.121s) [146.854055] Starting dynamic subtest: smem0-fixed [146.854999] Dynamic subtest smem0-fixed: SUCCESS (0.016s) [146.855971] Subtest ptrace: SUCCESS (0.145s) [147.015475] [012/156] (881s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [148.521096] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [148.522383] Starting dynamic subtest: pipe-A [150.533444] Dynamic subtest pipe-A: SUCCESS (2.012s) [150.554621] Starting dynamic subtest: pipe-B [152.642454] Dynamic subtest pipe-B: SUCCESS (2.109s) [152.658051] Starting dynamic subtest: pipe-C [152.900943] Dynamic subtest pipe-C: SUCCESS (0.258s) [152.918940] Starting dynamic subtest: pipe-D [153.159323] Dynamic subtest pipe-D: SUCCESS (0.258s) [153.160356] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (4.638s) [153.371875] [013/156] (875s left) gen3_render_linear_blits [153.508817] [014/156] (875s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc) [155.019589] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc [155.021259] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [155.156693] [015/156] (873s left) kms_pm_backlight (fade-with-dpms) [156.696646] Subtest fade-with-dpms: SKIP (0.000s) [156.756547] [016/156] (872s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [158.269007] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [158.270817] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [158.408505] [017/156] (870s left) gem_softpin (allocator-evict) [158.516842] Starting subtest: allocator-evict [158.517760] Starting dynamic subtest: rcs0 [185.675804] Dynamic subtest rcs0: SUCCESS (27.159s) [185.685280] Starting dynamic subtest: bcs0 [212.993500] Dynamic subtest bcs0: SUCCESS (27.317s) [213.002616] Starting dynamic subtest: vcs0 [240.404430] Dynamic subtest vcs0: SUCCESS (27.410s) [240.413720] Starting dynamic subtest: vcs1 [267.873491] Dynamic subtest vcs1: SUCCESS (27.468s) [267.882701] Starting dynamic subtest: vecs0 [294.966454] Dynamic subtest vecs0: SUCCESS (27.091s) [294.975524] Starting dynamic subtest: vecs1 [322.060442] Dynamic subtest vecs1: SUCCESS (27.093s) [322.069742] Starting dynamic subtest: ccs0 [349.366986] Dynamic subtest ccs0: SUCCESS (27.305s) [349.368030] Subtest allocator-evict: SUCCESS (190.846s) [349.505919] [018/156] (679s left) gem_mmap_wc (copy) [349.626903] Subtest copy: SKIP (0.000s) [349.698505] [019/156] (679s left) gem_mmap_gtt (close-race) [349.855998] Subtest close-race: SKIP (0.000s) [349.948584] [020/156] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [351.460892] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [351.462539] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [351.590412] [021/156] (677s left) kms_lease (lessee-list) [353.124157] Starting subtest: lessee-list [353.125114] Starting dynamic subtest: pipe-A-HDMI-A-3 [353.127358] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.002s) [353.138173] Starting dynamic subtest: pipe-B-HDMI-A-3 [353.139247] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.002s) [353.148843] Starting dynamic subtest: pipe-C-HDMI-A-3 [353.149752] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.002s) [353.159212] Starting dynamic subtest: pipe-D-HDMI-A-3 [353.160177] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.002s) [353.161051] Subtest lessee-list: SUCCESS (0.012s) [353.352331] [022/156] (676s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [354.863143] Starting subtest: primary-x-tiled-reflect-x-0 [365.221035] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.357s) [365.521062] [023/156] (664s left) syncobj_wait (wait-all-for-submit-delayed-submit) [365.600832] Starting subtest: wait-all-for-submit-delayed-submit [365.703872] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [365.811568] [024/156] (663s left) kms_flip (flip-vs-fences) [367.322172] Starting subtest: flip-vs-fences [367.323961] Subtest flip-vs-fences: SKIP (0.000s) [367.551505] [025/156] (662s left) gem_eio (context-create) [367.851956] Starting subtest: context-create [368.308301] Subtest context-create: SUCCESS (0.457s) [369.956579] [026/156] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [371.488159] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [371.489941] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [371.634267] [027/156] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [373.175625] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [373.177258] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [373.319089] [028/156] (656s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [374.858276] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [374.859174] Starting dynamic subtest: pipe-A-valid-mode [375.832575] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.974s) [375.833480] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.975s) [376.061162] [029/156] (654s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [377.571316] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [377.584040] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.013s) [377.690439] [030/156] (652s left) kms_pm_rpm (fences-dpms) [382.068312] Starting subtest: fences-dpms [382.071609] Subtest fences-dpms: SKIP (0.000s) [383.014641] [031/156] (647s left) gem_exec_nop (basic-series) [383.097137] Starting subtest: basic-series [387.446213] Subtest basic-series: SUCCESS (4.348s) [387.728294] [032/156] (642s left) fbdev (nullptr) [387.786201] Starting subtest: nullptr [387.787156] Subtest nullptr: SUCCESS (0.000s) [387.882637] [033/156] (642s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [389.394688] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [389.441679] [034/156] (640s left) kms_prime (basic-crc-vgem) [391.004262] Subtest basic-crc-vgem: SKIP (0.000s) [391.237623] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true [391.239730] [035/156] (639s left) kms_flip (flip-vs-suspend-interruptible) [392.761121] Starting subtest: flip-vs-suspend-interruptible [392.763168] Starting dynamic subtest: A-HDMI-A3 [449.743628] Dynamic subtest A-HDMI-A3: SUCCESS (11.055s) [449.746809] Subtest flip-vs-suspend-interruptible: SUCCESS (11.058s) [455.888284] [036/156] (580s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [457.428305] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [457.429223] Starting dynamic subtest: pipe-A-HDMI-A-3 [457.438598] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [457.451842] Starting dynamic subtest: pipe-B-HDMI-A-3 [457.461061] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [457.473897] Starting dynamic subtest: pipe-C-HDMI-A-3 [457.482968] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [457.495756] Starting dynamic subtest: pipe-D-HDMI-A-3 [457.505756] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [457.507601] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [457.761799] [037/156] (578s left) kms_addfb_basic (addfb25-bad-modifier) [459.305973] Starting subtest: addfb25-bad-modifier [459.306874] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [459.438399] [038/156] (577s left) syncobj_timeline (device-submit-unordered) [459.545672] Starting subtest: device-submit-unordered [459.546670] Subtest device-submit-unordered: SUCCESS (0.001s) [459.747050] [039/156] (577s left) kms_big_fb (4-tiled-16bpp-rotate-90) [461.294289] Starting subtest: 4-tiled-16bpp-rotate-90 [461.354338] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.059s) [461.584898] [040/156] (575s left) gem_exec_store (pages) [461.675638] Starting subtest: pages [461.676526] Starting dynamic subtest: rcs0 [461.819436] Dynamic subtest rcs0: SUCCESS (0.142s) [461.832621] Starting dynamic subtest: bcs0 [461.917145] Dynamic subtest bcs0: SUCCESS (0.096s) [461.930436] Starting dynamic subtest: vcs0 [462.020223] Dynamic subtest vcs0: SUCCESS (0.102s) [462.033211] Starting dynamic subtest: vcs1 [462.118184] Dynamic subtest vcs1: SUCCESS (0.096s) [462.131030] Starting dynamic subtest: vecs0 [462.220262] Dynamic subtest vecs0: SUCCESS (0.101s) [462.232753] Starting dynamic subtest: vecs1 [462.318247] Dynamic subtest vecs1: SUCCESS (0.097s) [462.331099] Starting dynamic subtest: ccs0 [462.418500] Dynamic subtest ccs0: SUCCESS (0.099s) [462.419534] Subtest pages: SUCCESS (0.736s) [462.699921] [041/156] (574s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [464.236123] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [464.237862] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [464.370059] [042/156] (572s left) gem_close_race (basic-threads) [464.512703] Starting subtest: basic-threads [465.693803] Subtest basic-threads: SUCCESS (1.173s) [466.004554] [043/156] (571s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [467.531181] Starting subtest: bad-aux-stride-y-tiled-ccs [467.532100] Starting dynamic subtest: pipe-A-HDMI-A-3 [467.541015] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [467.554045] Starting dynamic subtest: pipe-B-HDMI-A-3 [467.562991] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [467.575341] Starting dynamic subtest: pipe-C-HDMI-A-3 [467.584591] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [467.597041] Starting dynamic subtest: pipe-D-HDMI-A-3 [467.606208] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [467.608456] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s) [467.893460] [044/156] (569s left) kms_chamelium_hpd (vga-hpd-without-ddc) [469.464029] Subtest vga-hpd-without-ddc: SKIP (0.000s) [469.603207] [045/156] (567s left) gem_partial_pwrite_pread (write-display) [469.697298] Subtest write-display: SKIP (0.000s) [469.785323] [046/156] (567s left) kms_invalid_mode (bad-vsync-start) [471.316082] Starting subtest: bad-vsync-start [471.317033] Starting dynamic subtest: pipe-A-HDMI-A-3 [471.361016] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.044s) [471.374447] Starting dynamic subtest: pipe-B-HDMI-A-3 [471.375621] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [471.388810] Starting dynamic subtest: pipe-C-HDMI-A-3 [471.389781] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [471.402438] Starting dynamic subtest: pipe-D-HDMI-A-3 [471.403359] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [471.404286] Subtest bad-vsync-start: SUCCESS (0.051s) [471.569157] [047/156] (565s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [471.653539] Starting subtest: x-tiled-to-vebox-y-tiled [471.655426] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [471.901448] [048/156] (565s left) kms_dsc (dsc-fractional-bpp-with-bpc) [473.420500] Starting subtest: dsc-fractional-bpp-with-bpc [473.432999] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [473.525021] [049/156] (564s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [475.062180] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [475.063888] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [475.193524] [050/156] (562s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt) [476.740338] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt [476.742109] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [476.908462] [051/156] (560s left) gem_exec_reloc (basic-cpu-noreloc) [477.021528] Subtest basic-cpu-noreloc: SKIP (0.000s) [477.107473] [052/156] (560s left) gem_userptr_blits (userfault) [477.200123] Starting subtest: userfault [477.204205] Subtest userfault: SUCCESS (0.006s) [477.401212] [053/156] (560s left) perf (global-sseu-config-invalid) [477.791255] Starting subtest: global-sseu-config-invalid [477.792993] Subtest global-sseu-config-invalid: SKIP (0.000s) [477.858141] [054/156] (560s left) gem_exercise_blt (fast-copy) [477.972004] Starting subtest: fast-copy [477.972968] Starting dynamic subtest: linear-smem-smem [478.020586] Dynamic subtest linear-smem-smem: SUCCESS (0.049s) [478.033777] Starting dynamic subtest: linear-smem-lmem0 [478.037434] Dynamic subtest linear-smem-lmem0: SUCCESS (0.016s) [478.050321] Starting dynamic subtest: linear-lmem0-smem [478.137377] Dynamic subtest linear-lmem0-smem: SUCCESS (0.099s) [478.150115] Starting dynamic subtest: linear-lmem0-lmem0 [478.236000] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.098s) [478.248530] Starting dynamic subtest: xmajor-smem-smem [478.252353] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s) [478.265046] Starting dynamic subtest: xmajor-smem-lmem0 [478.268346] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.015s) [478.281110] Starting dynamic subtest: xmajor-lmem0-smem [478.376970] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.108s) [478.390195] Starting dynamic subtest: xmajor-lmem0-lmem0 [478.481785] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.104s) [478.494756] Starting dynamic subtest: tile4-smem-smem [478.499218] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s) [478.511873] Starting dynamic subtest: tile4-smem-lmem0 [478.515203] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.015s) [478.527972] Starting dynamic subtest: tile4-lmem0-smem [478.620571] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.105s) [478.633662] Starting dynamic subtest: tile4-lmem0-lmem0 [478.721052] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.100s) [478.734092] Starting dynamic subtest: tile64-smem-smem [478.737764] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s) [478.751043] Starting dynamic subtest: tile64-smem-lmem0 [478.754123] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.016s) [478.767178] Starting dynamic subtest: tile64-lmem0-smem [478.854622] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.100s) [478.868010] Starting dynamic subtest: tile64-lmem0-lmem0 [478.964236] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.109s) [478.965209] Subtest fast-copy: SUCCESS (0.992s) [479.124521] [055/156] (558s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [480.645557] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [480.647250] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [480.753741] [056/156] (557s left) kms_flip (2x-wf_vblank-ts-check) [482.290077] Starting subtest: 2x-wf_vblank-ts-check [482.302901] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s) [482.430716] [057/156] (555s left) vgem_basic (dmabuf-mmap) [482.513077] Starting subtest: dmabuf-mmap [482.531681] Subtest dmabuf-mmap: SUCCESS (0.019s) [482.613178] [058/156] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [484.138689] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [484.140368] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [484.272389] [059/156] (554s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render) [485.814100] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render [485.815803] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [485.933755] [060/156] (552s left) gem_ctx_engines (independent) [486.043348] Starting subtest: independent [486.044287] Starting dynamic subtest: rcs0 [486.227816] Dynamic subtest rcs0: SUCCESS (0.168s) [486.240423] Starting dynamic subtest: bcs0 [486.385560] Dynamic subtest bcs0: SUCCESS (0.170s) [486.400008] Starting dynamic subtest: vcs0 [486.566394] Dynamic subtest vcs0: SUCCESS (0.173s) [486.579366] Starting dynamic subtest: vcs1 [486.742701] Dynamic subtest vcs1: SUCCESS (0.180s) [486.755965] Starting dynamic subtest: vecs0 [486.906419] Dynamic subtest vecs0: SUCCESS (0.168s) [486.919439] Starting dynamic subtest: vecs1 [487.076211] Dynamic subtest vecs1: SUCCESS (0.170s) [487.089151] Starting dynamic subtest: ccs0 [487.250289] Dynamic subtest ccs0: SUCCESS (0.173s) [487.263243] Starting dynamic subtest: all-engines [487.636072] Dynamic subtest all-engines: SUCCESS (0.385s) [487.637042] Subtest independent: SUCCESS (1.593s) [488.589484] [061/156] (549s left) gem_ctx_persistence (legacy-engines-cleanup) [488.679114] Starting subtest: legacy-engines-cleanup [488.680059] Starting dynamic subtest: render [488.771233] Dynamic subtest render: SUCCESS (0.092s) [488.787022] Starting dynamic subtest: bsd1 [488.804195] Dynamic subtest bsd1: SUCCESS (0.032s) [488.827039] Starting dynamic subtest: bsd2 [488.842101] Dynamic subtest bsd2: SUCCESS (0.036s) [488.864333] Starting dynamic subtest: blt [488.884105] Dynamic subtest blt: SUCCESS (0.041s) [488.904629] Starting dynamic subtest: vebox [488.924262] Dynamic subtest vebox: SUCCESS (0.039s) [488.925415] Subtest legacy-engines-cleanup: SUCCESS (0.246s) [489.149570] [062/156] (549s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [489.241557] Starting subtest: y-tiled-to-vebox-yf-tiled [489.243708] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [489.469720] [063/156] (549s left) kms_content_protection (uevent-hdcp14) [491.049425] Starting subtest: uevent-hdcp14 [491.052339] Subtest uevent-hdcp14: SKIP (0.002s) [491.218465] [064/156] (547s left) syncobj_timeline (invalid-signal-illegal-handle) [491.307211] Starting subtest: invalid-signal-illegal-handle [491.308223] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [491.493292] [065/156] (547s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [493.017956] Starting subtest: fbcpsr-rgb565-draw-blt [493.019716] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s) [493.166182] [066/156] (545s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move) [494.720872] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move [494.722751] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [494.936707] [067/156] (544s left) kms_psr (pr-primary-blt) [496.457837] Subtest pr-primary-blt: SKIP (0.000s) [496.514671] [068/156] (542s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [498.032666] Starting subtest: basic-flip-after-cursor-varying-size [499.039992] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.007s) [499.282779] [069/156] (539s left) kms_psr (fbc-psr2-primary-blt) [500.800354] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [500.870904] [070/156] (538s left) kms_psr (fbc-psr-cursor-render) [502.390243] Subtest fbc-psr-cursor-render: SKIP (0.000s) [502.456160] [071/156] (536s left) kms_big_fb (x-tiled-8bpp-rotate-0) [503.992015] Starting subtest: x-tiled-8bpp-rotate-0 [505.609563] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.616s) [505.782524] [072/156] (533s left) gem_fenced_exec_thrash (no-spare-fences-busy) [505.871130] Subtest no-spare-fences-busy: SKIP (0.000s) [505.959486] [073/156] (533s left) vgem_basic (bad-fence) [506.026856] Starting subtest: bad-fence [506.027798] Subtest bad-fence: SUCCESS (0.000s) [506.112145] [074/156] (533s left) kms_color_pipeline (plane-ctm3x4-lut1d) [507.630681] Starting subtest: plane-ctm3x4-lut1d [507.826645] Starting dynamic subtest: pipe-A-plane-0 [508.076328] Dynamic subtest pipe-A-plane-0: SUCCESS (0.249s) [508.116688] Starting dynamic subtest: pipe-A-plane-1 [508.293084] Dynamic subtest pipe-A-plane-1: SUCCESS (0.214s) [508.331157] Starting dynamic subtest: pipe-A-plane-2 [508.493210] Dynamic subtest pipe-A-plane-2: SUCCESS (0.198s) [508.793546] Starting dynamic subtest: pipe-B-plane-0 [508.942612] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [508.973406] Starting dynamic subtest: pipe-B-plane-1 [509.126353] Dynamic subtest pipe-B-plane-1: SUCCESS (0.181s) [509.165213] Starting dynamic subtest: pipe-B-plane-2 [509.325209] Dynamic subtest pipe-B-plane-2: SUCCESS (0.197s) [509.626374] Starting dynamic subtest: pipe-C-plane-0 [509.786978] Dynamic subtest pipe-C-plane-0: SUCCESS (0.199s) [509.825245] Starting dynamic subtest: pipe-C-plane-1 [510.003586] Dynamic subtest pipe-C-plane-1: SUCCESS (0.214s) [510.041685] Starting dynamic subtest: pipe-C-plane-2 [510.202846] Dynamic subtest pipe-C-plane-2: SUCCESS (0.197s) [510.513089] Starting dynamic subtest: pipe-D-plane-0 [510.694746] Dynamic subtest pipe-D-plane-0: SUCCESS (0.215s) [510.734016] Starting dynamic subtest: pipe-D-plane-1 [510.895010] Dynamic subtest pipe-D-plane-1: SUCCESS (0.197s) [510.932430] Starting dynamic subtest: pipe-D-plane-2 [511.110555] Dynamic subtest pipe-D-plane-2: SUCCESS (0.211s) [511.133278] Subtest plane-ctm3x4-lut1d: SUCCESS (3.502s) [511.356047] [075/156] (528s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [512.880648] Starting subtest: fbc-rgb565-draw-mmap-wc [512.882382] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s) [513.021555] [076/156] (526s left) i915_suspend (debugfs-reader) [513.144276] Starting subtest: debugfs-reader [534.749153] Subtest debugfs-reader: SUCCESS (5.648s) [539.970566] [077/156] (504s left) api_intel_bb (crc32) [540.059509] Starting subtest: crc32 [540.060472] Starting dynamic subtest: rcs0-lmem0 [540.318973] Dynamic subtest rcs0-lmem0: SUCCESS (0.258s) [540.334097] Starting dynamic subtest: rcs0-smem0 [540.607060] Dynamic subtest rcs0-smem0: SUCCESS (0.281s) [540.621085] Starting dynamic subtest: bcs0-lmem0 [540.846926] Dynamic subtest bcs0-lmem0: SUCCESS (0.234s) [540.861231] Starting dynamic subtest: bcs0-smem0 [541.178086] Dynamic subtest bcs0-smem0: SUCCESS (0.323s) [541.195262] Starting dynamic subtest: vcs0-lmem0 [541.602917] Dynamic subtest vcs0-lmem0: SUCCESS (0.414s) [541.619756] Starting dynamic subtest: vcs0-smem0 [542.144815] Dynamic subtest vcs0-smem0: SUCCESS (0.529s) [542.162101] Starting dynamic subtest: vcs1-lmem0 [542.571248] Dynamic subtest vcs1-lmem0: SUCCESS (0.417s) [542.588165] Starting dynamic subtest: vcs1-smem0 [543.133482] Dynamic subtest vcs1-smem0: SUCCESS (0.550s) [543.150693] Starting dynamic subtest: vecs0-lmem0 [543.565120] Dynamic subtest vecs0-lmem0: SUCCESS (0.422s) [543.582032] Starting dynamic subtest: vecs0-smem0 [544.112067] Dynamic subtest vecs0-smem0: SUCCESS (0.536s) [544.128882] Starting dynamic subtest: vecs1-lmem0 [544.539796] Dynamic subtest vecs1-lmem0: SUCCESS (0.419s) [544.556956] Starting dynamic subtest: vecs1-smem0 [545.098834] Dynamic subtest vecs1-smem0: SUCCESS (0.549s) [545.115663] Starting dynamic subtest: ccs0-lmem0 [545.355269] Dynamic subtest ccs0-lmem0: SUCCESS (0.250s) [545.376146] Starting dynamic subtest: ccs0-smem0 [545.701658] Dynamic subtest ccs0-smem0: SUCCESS (0.339s) [545.703825] Subtest crc32: SUCCESS (5.561s) [545.886954] [078/156] (499s left) kms_sequence (get-forked-busy) [547.419695] Starting subtest: get-forked-busy [547.420754] Starting dynamic subtest: pipe-A-HDMI-A-3 [550.054947] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.614s) [550.097675] Starting dynamic subtest: pipe-B-HDMI-A-3 [552.616424] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.535s) [552.651659] Starting dynamic subtest: pipe-C-HDMI-A-3 [555.150645] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.528s) [555.183285] Starting dynamic subtest: pipe-D-HDMI-A-3 [557.663428] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.500s) [557.665066] Subtest get-forked-busy: SUCCESS (10.194s) [557.923933] [079/156] (487s left) gem_fenced_exec_thrash (2-spare-fences) [558.011259] Subtest 2-spare-fences: SKIP (0.000s) [558.079383] [080/156] (486s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [559.654081] Starting subtest: cursor-tearing-framebuffer-change [559.656255] Starting dynamic subtest: pipe-A-HDMI-A-3 [560.142310] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.486s) [560.157828] Starting dynamic subtest: pipe-D-HDMI-A-3 [560.511361] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.366s) [560.512295] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.855s) [561.068075] [081/156] (484s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite) [562.595971] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite [562.597877] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [562.722442] [082/156] (482s left) gem_readwrite (read-write) [562.819901] Subtest read-write: SKIP (0.000s) [562.902120] [083/156] (482s left) kms_properties (invalid-properties-legacy) [564.423643] Starting subtest: invalid-properties-legacy [564.574526] Subtest invalid-properties-legacy: SUCCESS (0.152s) [564.677542] [084/156] (480s left) kms_addfb_basic (basic) [564.765338] Starting subtest: basic [564.766267] Subtest basic: SUCCESS (0.000s) [566.364666] [085/156] (479s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc) [567.912624] Starting subtest: hdr-rgb101010-draw-mmap-wc [567.914191] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [568.061226] [086/156] (477s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-onoff) [569.619836] Starting subtest: hdr-2p-scndscrn-cur-indfb-onoff [569.621614] Subtest hdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [569.792678] [087/156] (475s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff) [571.331694] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff [571.333606] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [571.478414] [088/156] (474s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt) [573.030807] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt [573.032551] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [573.177984] [089/156] (472s left) gem_exec_parallel (contexts) [573.293210] Starting subtest: contexts [573.294200] Starting dynamic subtest: rcs0 [577.840758] Dynamic subtest rcs0: SUCCESS (4.548s) [577.854701] Starting dynamic subtest: bcs0 [582.455741] Dynamic subtest bcs0: SUCCESS (4.614s) [582.469264] Starting dynamic subtest: vcs0 [587.065936] Dynamic subtest vcs0: SUCCESS (4.609s) [587.080926] Starting dynamic subtest: vcs1 [591.526833] Dynamic subtest vcs1: SUCCESS (4.459s) [591.540379] Starting dynamic subtest: vecs0 [595.974376] Dynamic subtest vecs0: SUCCESS (4.446s) [595.987955] Starting dynamic subtest: vecs1 [600.671704] Dynamic subtest vecs1: SUCCESS (4.695s) [600.685738] Starting dynamic subtest: ccs0 [604.809256] Dynamic subtest ccs0: SUCCESS (4.135s) [604.810377] Subtest contexts: SUCCESS (31.514s) [605.112579] [090/156] (440s left) gem_exec_schedule (semaphore-codependency) [605.209298] Starting subtest: semaphore-codependency [605.247332] Subtest semaphore-codependency: SUCCESS (0.038s) [605.645533] [091/156] (440s left) vgem_basic (second-client) [605.699316] Starting subtest: second-client [605.734211] Subtest second-client: SUCCESS (0.033s) [605.850170] [092/156] (440s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render) [607.374724] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render [607.376491] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [607.512418] [093/156] (438s left) gem_exec_schedule (fifo) [607.636558] Starting subtest: fifo [607.637519] Starting dynamic subtest: rcs0 [607.916363] Dynamic subtest rcs0: SUCCESS (0.279s) [607.930290] Starting dynamic subtest: bcs0 [608.113016] Dynamic subtest bcs0: SUCCESS (0.196s) [608.126727] Starting dynamic subtest: vcs0 [608.323486] Dynamic subtest vcs0: SUCCESS (0.209s) [608.336888] Starting dynamic subtest: vcs1 [608.534979] Dynamic subtest vcs1: SUCCESS (0.210s) [608.548013] Starting dynamic subtest: vecs0 [608.746408] Dynamic subtest vecs0: SUCCESS (0.210s) [608.761029] Starting dynamic subtest: vecs1 [608.948557] Dynamic subtest vecs1: SUCCESS (0.201s) [608.962214] Starting dynamic subtest: ccs0 [609.158339] Dynamic subtest ccs0: SUCCESS (0.209s) [609.159186] Subtest fifo: SUCCESS (1.522s) [609.597858] [094/156] (436s left) kms_atomic_transition (plane-all-modeset-transition) [611.117753] Starting subtest: plane-all-modeset-transition [611.118703] Starting dynamic subtest: pipe-A-HDMI-A-3 [625.748672] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (14.624s) [625.805743] Starting dynamic subtest: pipe-B-HDMI-A-3 [636.910758] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (11.117s) [636.928845] Subtest plane-all-modeset-transition: SUCCESS (25.802s) [637.139988] [095/156] (409s left) kms_chamelium_edid (vga-edid-read) [638.699929] Subtest vga-edid-read: SKIP (0.000s) [638.837170] [096/156] (407s left) kms_cursor_crc (cursor-random-256x85) [640.631169] Starting subtest: cursor-random-256x85 [640.636194] Starting dynamic subtest: pipe-A-HDMI-A-3 [645.172107] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.537s) [645.210178] Starting dynamic subtest: pipe-D-HDMI-A-3 [649.695463] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.498s) [649.696337] Subtest cursor-random-256x85: SUCCESS (9.066s) [649.985518] [097/156] (396s left) kms_flip (2x-plain-flip) [651.542001] Starting subtest: 2x-plain-flip [651.555215] Subtest 2x-plain-flip: SKIP (0.013s) [651.663099] [098/156] (394s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render) [653.193830] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render [653.195552] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [653.331412] [099/156] (393s left) kms_flip (flip-vs-dpms-off-vs-modeset) [654.875629] Starting subtest: flip-vs-dpms-off-vs-modeset [654.880655] Starting dynamic subtest: A-HDMI-A3 [655.665896] Dynamic subtest A-HDMI-A3: SUCCESS (0.785s) [655.681291] Starting dynamic subtest: B-HDMI-A3 [656.377216] Dynamic subtest B-HDMI-A3: SUCCESS (0.710s) [656.390622] Starting dynamic subtest: C-HDMI-A3 [657.072728] Dynamic subtest C-HDMI-A3: SUCCESS (0.694s) [657.086994] Starting dynamic subtest: D-HDMI-A3 [657.768621] Dynamic subtest D-HDMI-A3: SUCCESS (0.694s) [657.769584] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.893s) [658.000795] [100/156] (388s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [659.532699] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [659.534647] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [659.661571] [101/156] (387s left) kms_busy (extended-pageflip-hang-newfb) [661.212941] Starting subtest: extended-pageflip-hang-newfb [661.213878] Starting dynamic subtest: pipe-A [669.061265] Dynamic subtest pipe-A: SUCCESS (7.847s) [669.076291] Starting dynamic subtest: pipe-D [676.877689] Dynamic subtest pipe-D: SUCCESS (7.813s) [676.878687] Subtest extended-pageflip-hang-newfb: SUCCESS (15.666s) [677.129570] [102/156] (369s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt) [678.651855] Starting subtest: psrhdr-rgb565-draw-mmap-gtt [678.653661] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s) [678.799431] [103/156] (368s left) kms_big_fb (y-tiled-32bpp-rotate-180) [680.357849] Starting subtest: y-tiled-32bpp-rotate-180 [680.359775] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [680.492388] [104/156] (366s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [680.594152] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [680.595148] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [680.797070] [105/156] (366s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [682.323692] Starting subtest: fbc-rgb101010-draw-blt [683.102451] Subtest fbc-rgb101010-draw-blt: SUCCESS (0.779s) [683.318616] [106/156] (363s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [684.835938] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [684.836967] Starting dynamic subtest: pipe-A-HDMI-A-3 [724.270259] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (8.245s) [724.289810] Starting dynamic subtest: pipe-B-HDMI-A-3 [762.924797] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (7.212s) [762.977377] Starting dynamic subtest: pipe-C-HDMI-A-3 [801.910772] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (7.415s) [801.938388] Starting dynamic subtest: pipe-D-HDMI-A-3 [841.934497] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (7.439s) [841.935618] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SUCCESS (30.326s) [848.200196] [107/156] (205s left) api_intel_bb (object-noreloc-purge-cache-simple) [848.296031] Starting subtest: object-noreloc-purge-cache-simple [848.326891] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.030s) [848.534046] [108/156] (204s left) gem_exec_balancer (hang) [848.936383] Starting subtest: hang [852.557696] Subtest hang: SUCCESS (3.567s) [852.746875] [109/156] (200s left) gem_sync (basic-store-all) [852.844013] Starting subtest: basic-store-all [857.125164] Subtest basic-store-all: SUCCESS (4.242s) [857.349741] [110/156] (196s left) kms_psr (psr-primary-page-flip) [858.876106] Subtest psr-primary-page-flip: SKIP (0.000s) [858.931990] [111/156] (194s left) gem_exec_schedule (preempt-hang) [859.141979] Starting subtest: preempt-hang [859.143611] Starting dynamic subtest: rcs0 [859.529299] Dynamic subtest rcs0: SUCCESS (0.384s) [859.543272] Starting dynamic subtest: bcs0 [859.854217] Dynamic subtest bcs0: SUCCESS (0.322s) [859.868560] Starting dynamic subtest: vcs0 [860.191851] Dynamic subtest vcs0: SUCCESS (0.335s) [860.205889] Starting dynamic subtest: vcs1 [860.550108] Dynamic subtest vcs1: SUCCESS (0.355s) [860.564319] Starting dynamic subtest: vecs0 [860.894959] Dynamic subtest vecs0: SUCCESS (0.342s) [860.908965] Starting dynamic subtest: vecs1 [861.254648] Dynamic subtest vecs1: SUCCESS (0.356s) [861.268607] Starting dynamic subtest: ccs0 [861.581858] Dynamic subtest ccs0: SUCCESS (0.326s) [861.582812] Subtest preempt-hang: SUCCESS (2.429s) [861.894627] [112/156] (191s left) kms_flip (2x-flip-vs-panning) [863.416839] Starting subtest: 2x-flip-vs-panning [863.429551] Subtest 2x-flip-vs-panning: SKIP (0.013s) [863.551898] [113/156] (190s left) kms_frontbuffer_tracking (hdr-suspend) [865.097588] Starting subtest: hdr-suspend [865.099355] Subtest hdr-suspend: SKIP (0.000s) [865.293412] [114/156] (188s left) syncobj_timeline (transfer-timeline-point) [865.378967] Starting subtest: transfer-timeline-point [865.379866] Subtest transfer-timeline-point: SUCCESS (0.001s) [865.587434] [115/156] (188s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move) [867.120519] Starting subtest: hdr-1p-primscrn-cur-indfb-move [867.122311] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [867.249193] [116/156] (186s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite) [868.792340] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite [868.793934] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [868.956976] [117/156] (185s left) kms_cursor_crc (cursor-offscreen-512x170) [870.809826] Starting subtest: cursor-offscreen-512x170 [870.813518] Subtest cursor-offscreen-512x170: SKIP (0.001s) [871.027774] [118/156] (183s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-plflip-blt) [872.556419] Starting subtest: psrhdr-1p-primscrn-indfb-plflip-blt [872.558213] Subtest psrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [872.701158] [119/156] (181s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [874.246402] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [874.248335] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [874.383719] [120/156] (179s left) gem_ctx_persistence (engines-hostile) [874.494103] Starting subtest: engines-hostile [874.495019] Starting dynamic subtest: rcs0 [874.640411] Dynamic subtest rcs0: SUCCESS (0.145s) [874.685939] Starting dynamic subtest: bcs0 [874.691648] Dynamic subtest bcs0: SUCCESS (0.049s) [874.709620] Starting dynamic subtest: vcs0 [874.761744] Dynamic subtest vcs0: SUCCESS (0.069s) [874.785535] Starting dynamic subtest: vcs1 [874.882503] Dynamic subtest vcs1: SUCCESS (0.119s) [874.929328] Starting dynamic subtest: vecs0 [874.947701] Dynamic subtest vecs0: SUCCESS (0.062s) [874.967681] Starting dynamic subtest: vecs1 [875.044525] Dynamic subtest vecs1: SUCCESS (0.095s) [875.091908] Starting dynamic subtest: ccs0 [875.109838] Dynamic subtest ccs0: SUCCESS (0.062s) [875.110925] Subtest engines-hostile: SUCCESS (0.616s) [875.305331] [121/156] (179s left) i915_pm_rpm (debugfs-forcewake-user) [879.669068] Starting subtest: debugfs-forcewake-user [890.882195] Subtest debugfs-forcewake-user: SUCCESS (11.211s) [891.099257] [122/156] (163s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt) [893.195237] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt [893.196912] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [893.350287] [123/156] (161s left) kms_frontbuffer_tracking (hdr-2p-rte) [894.903445] Starting subtest: hdr-2p-rte [894.905217] Subtest hdr-2p-rte: SKIP (0.000s) [895.099334] [124/156] (159s left) kms_dp_link_training (uhbr-mst) [896.625421] Starting subtest: uhbr-mst [896.627151] Subtest uhbr-mst: SKIP (0.000s) [896.839777] [125/156] (157s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc) [898.363690] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc [898.365500] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [898.512958] [126/156] (156s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu) [900.065064] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu [900.066705] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [900.215929] [127/156] (154s left) kms_plane_alpha_blend (coverage-7efc) [901.761709] Starting subtest: coverage-7efc [902.009089] Starting dynamic subtest: pipe-A-HDMI-A-3 [902.472877] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.463s) [902.508581] Starting dynamic subtest: pipe-D-HDMI-A-3 [903.100809] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.604s) [903.101746] Subtest coverage-7efc: SUCCESS (1.339s) [903.322080] [128/156] (151s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [904.844575] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [904.846342] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [905.006038] [129/156] (150s left) syncobj_wait (single-wait-all-signaled) [905.110816] Starting subtest: single-wait-all-signaled [905.111759] Subtest single-wait-all-signaled: SUCCESS (0.000s) [905.277740] [130/156] (149s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [906.799549] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [906.801145] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [907.028127] [131/156] (148s left) gem_exec_fence (syncobj-invalid-wait) [907.591421] Starting subtest: syncobj-invalid-wait [907.592405] Subtest syncobj-invalid-wait: SUCCESS (0.001s) [908.014295] [132/156] (147s left) kms_chamelium_color (ctm-green-to-red) [909.536842] Subtest ctm-green-to-red: SKIP (0.000s) [909.596222] [133/156] (145s left) kms_atomic (plane-primary-overlay-mutable-zpos) [911.115649] Starting subtest: plane-primary-overlay-mutable-zpos [912.813759] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.697s) [913.050229] [134/156] (142s left) prime_busy (hang-wait) [913.135173] Starting subtest: hang-wait [913.137515] Starting dynamic subtest: rcs0 [939.161245] Dynamic subtest rcs0: SUCCESS (26.010s) [939.175054] Starting dynamic subtest: bcs0 [946.246382] Dynamic subtest bcs0: SUCCESS (7.084s) [946.260807] Starting dynamic subtest: vcs0 [953.281378] Dynamic subtest vcs0: SUCCESS (7.038s) [953.295817] Starting dynamic subtest: vcs1 [960.268915] Dynamic subtest vcs1: SUCCESS (6.987s) [960.283096] Starting dynamic subtest: vecs0 [967.308966] Dynamic subtest vecs0: SUCCESS (7.040s) [967.323390] Starting dynamic subtest: vecs1 [974.269352] Dynamic subtest vecs1: SUCCESS (6.961s) [974.283995] Starting dynamic subtest: ccs0 [988.116661] Dynamic subtest ccs0: SUCCESS (13.844s) [988.117645] Subtest hang-wait: SUCCESS (74.973s) [988.246839] [135/156] ( 67s left) i915_hangman (detector) [988.342788] Starting subtest: detector [988.343720] Starting dynamic subtest: rcs0 [997.856794] Dynamic subtest rcs0: SUCCESS (9.512s) [997.872290] Starting dynamic subtest: bcs0 [1007.801771] Dynamic subtest bcs0: SUCCESS (9.942s) [1007.817277] Starting dynamic subtest: vcs0 [1017.790795] Dynamic subtest vcs0: SUCCESS (9.985s) [1017.806266] Starting dynamic subtest: vcs1 [1027.867846] Dynamic subtest vcs1: SUCCESS (10.073s) [1027.883485] Starting dynamic subtest: vecs0 [1037.831797] Dynamic subtest vecs0: SUCCESS (9.960s) [1037.848721] Starting dynamic subtest: vecs1 [1047.809948] Dynamic subtest vecs1: SUCCESS (9.974s) [1047.825816] Starting dynamic subtest: ccs0 [1057.796797] Dynamic subtest ccs0: SUCCESS (9.982s) [1057.797796] Subtest detector: SUCCESS (69.436s) [1057.935568] Overall timeout time exceeded, stopping. [1057.965950] Closing watchdogs results: parsing output: 0/ for test: kms_vblank results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: perf_pmu results: parsing output: 3/ for test: gem_mmap_wc results: parsing output: 4/ for test: gem_exec_capture results: parsing output: 5/ for test: kms_psr results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_tiled_swapping results: parsing output: 9/ for test: kms_hdr results: parsing output: 10/ for test: gem_mmap_offset results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: gen3_render_linear_blits results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_pm_backlight results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_softpin results: parsing output: 17/ for test: gem_mmap_wc results: parsing output: 18/ for test: gem_mmap_gtt results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_lease results: parsing output: 21/ for test: kms_rotation_crc results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: kms_flip results: parsing output: 24/ for test: gem_eio results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_flip_scaled_crc results: parsing output: 28/ for test: kms_flip results: parsing output: 29/ for test: kms_pm_rpm results: parsing output: 30/ for test: gem_exec_nop results: parsing output: 31/ for test: fbdev results: parsing output: 32/ for test: kms_psr2_sf results: parsing output: 33/ for test: kms_prime results: parsing output: 34/ for test: kms_flip results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: kms_addfb_basic results: parsing output: 37/ for test: syncobj_timeline results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: gem_exec_store results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_close_race results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_chamelium_hpd results: parsing output: 44/ for test: gem_partial_pwrite_pread results: parsing output: 45/ for test: kms_invalid_mode results: parsing output: 46/ for test: gem_render_copy results: parsing output: 47/ for test: kms_dsc results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_exec_reloc results: parsing output: 51/ for test: gem_userptr_blits results: parsing output: 52/ for test: perf results: parsing output: 53/ for test: gem_exercise_blt results: parsing output: 54/ for test: kms_plane results: parsing output: 55/ for test: kms_flip results: parsing output: 56/ for test: vgem_basic results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_ctx_engines results: parsing output: 60/ for test: gem_ctx_persistence results: parsing output: 61/ for test: gem_render_copy results: parsing output: 62/ for test: kms_content_protection results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_psr results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: gem_fenced_exec_thrash results: parsing output: 72/ for test: vgem_basic results: parsing output: 73/ for test: kms_color_pipeline results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: i915_suspend results: parsing output: 76/ for test: api_intel_bb results: parsing output: 77/ for test: kms_sequence results: parsing output: 78/ for test: gem_fenced_exec_thrash results: parsing output: 79/ for test: kms_cursor_crc results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_readwrite results: parsing output: 82/ for test: kms_properties results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking 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_exec_parallel results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: vgem_basic results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: gem_exec_schedule results: parsing output: 93/ for test: kms_atomic_transition results: parsing output: 94/ for test: kms_chamelium_edid results: parsing output: 95/ for test: kms_cursor_crc results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_flip results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_busy results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: api_intel_bb results: parsing output: 107/ for test: gem_exec_balancer results: parsing output: 108/ for test: gem_sync results: parsing output: 109/ for test: kms_psr results: parsing output: 110/ for test: gem_exec_schedule results: parsing output: 111/ for test: kms_flip results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_cursor_crc results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_ctx_persistence results: parsing output: 120/ for test: i915_pm_rpm results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_dp_link_training results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_plane_alpha_blend results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_exec_fence results: parsing output: 131/ for test: kms_chamelium_color results: parsing output: 132/ for test: kms_atomic results: parsing output: 133/ for test: prime_busy results: parsing output: 134/ for test: i915_hangman results: parsing output: 135/ for test: dmabuf_sync_file results: no output, setting notrun results: parsing output: 136/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 137/ for test: i915_query results: no output, setting notrun results: parsing output: 138/ for test: kms_plane results: no output, setting notrun results: parsing output: 139/ for test: kms_getfb results: no output, setting notrun results: parsing output: 140/ for test: kms_psr2_sf results: no output, setting notrun results: parsing output: 141/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 142/ for test: gen9_exec_parse results: no output, setting notrun results: parsing output: 143/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 144/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 145/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 146/ for test: gem_create results: no output, setting notrun results: parsing output: 147/ for test: vgem_basic results: no output, setting notrun results: parsing output: 148/ for test: kms_ccs results: no output, setting notrun results: parsing output: 149/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 150/ for test: kms_addfb_basic results: no output, setting notrun results: parsing output: 151/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 152/ for test: kms_flip results: no output, setting notrun results: parsing output: 153/ for test: kms_psr results: no output, setting notrun results: parsing output: 154/ for test: i915_drm_fdinfo results: no output, setting notrun results: parsing output: 155/ for test: syncobj_timeline results: no output, setting notrun Done.