[61.984511] Initializing watchdogs
[61.984573]   /dev/watchdog0
[62.003921] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.014733] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.018562] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.020866] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[62.207894] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[62.209545] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.389470] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[62.575176] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[62.576911] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[62.755430] [003/133] (959s left) kms_cursor_crc (cursor-offscreen-128x42)
[63.153590] Starting subtest: cursor-offscreen-128x42
[63.169151] Starting dynamic subtest: pipe-A-DP-3
[65.762135] Dynamic subtest pipe-A-DP-3: SUCCESS (2.592s)
[65.803916] Starting dynamic subtest: pipe-D-DP-3
[68.220646] Dynamic subtest pipe-D-DP-3: SUCCESS (2.422s)
[68.221560] Subtest cursor-offscreen-128x42: SUCCESS (5.064s)
[68.624933] [004/133] (954s left) i915_suspend (forcewake)
[68.702889] Starting subtest: forcewake
[107.461182] Subtest forcewake: SUCCESS (7.173s)
[107.563702] [005/133] (915s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[107.652306] Subtest writes-after-reads-uncached: SKIP (0.000s)
[107.723928] [006/133] (915s left) i915_drm_fdinfo (virtual-busy-hang-all)
[107.784761] Starting subtest: virtual-busy-hang-all
[107.786568] Subtest virtual-busy-hang-all: SKIP (0.000s)
[107.934437] [007/133] (915s left) kms_plane (pixel-format-y-tiled-modifier)
[108.111211] Starting subtest: pixel-format-y-tiled-modifier
[108.112845] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[108.229441] [008/133] (914s left) gem_mmap_gtt (fault-concurrent)
[108.299235] Subtest fault-concurrent: SKIP (0.000s)
[108.380478] [009/133] (914s left) kms_flip_tiling (flip-change-tiling)
[108.556020] Starting subtest: flip-change-tiling
[108.556891] Starting dynamic subtest: pipe-A-DP-3-4-to-4
[108.816944] Dynamic subtest pipe-A-DP-3-4-to-4: SUCCESS (0.260s)
[108.833509] Starting dynamic subtest: pipe-A-DP-3-4-to-x
[109.017633] Dynamic subtest pipe-A-DP-3-4-to-x: SUCCESS (0.200s)
[109.055913] Starting dynamic subtest: pipe-A-DP-3-4-to-linear
[109.233976] Dynamic subtest pipe-A-DP-3-4-to-linear: SUCCESS (0.216s)
[109.272729] Starting dynamic subtest: pipe-A-DP-3-x-to-4
[109.450645] Dynamic subtest pipe-A-DP-3-x-to-4: SUCCESS (0.216s)
[109.464711] Starting dynamic subtest: pipe-A-DP-3-x-to-x
[109.600069] Dynamic subtest pipe-A-DP-3-x-to-x: SUCCESS (0.149s)
[109.613706] Starting dynamic subtest: pipe-A-DP-3-x-to-linear
[109.784260] Dynamic subtest pipe-A-DP-3-x-to-linear: SUCCESS (0.183s)
[109.822372] Starting dynamic subtest: pipe-A-DP-3-linear-to-4
[110.000430] Dynamic subtest pipe-A-DP-3-linear-to-4: SUCCESS (0.216s)
[110.044863] Starting dynamic subtest: pipe-A-DP-3-linear-to-x
[110.217245] Dynamic subtest pipe-A-DP-3-linear-to-x: SUCCESS (0.215s)
[110.231437] Starting dynamic subtest: pipe-A-DP-3-linear-to-linear
[110.366905] Dynamic subtest pipe-A-DP-3-linear-to-linear: SUCCESS (0.149s)
[110.430539] Starting dynamic subtest: pipe-B-DP-3-4-to-4
[110.765663] Dynamic subtest pipe-B-DP-3-4-to-4: SUCCESS (0.345s)
[110.802301] Starting dynamic subtest: pipe-B-DP-3-4-to-x
[110.930347] Dynamic subtest pipe-B-DP-3-4-to-x: SUCCESS (0.166s)
[110.942624] Starting dynamic subtest: pipe-B-DP-3-4-to-linear
[111.064229] Dynamic subtest pipe-B-DP-3-4-to-linear: SUCCESS (0.133s)
[111.101616] Starting dynamic subtest: pipe-B-DP-3-x-to-4
[111.230082] Dynamic subtest pipe-B-DP-3-x-to-4: SUCCESS (0.166s)
[111.247224] Starting dynamic subtest: pipe-B-DP-3-x-to-x
[111.380112] Dynamic subtest pipe-B-DP-3-x-to-x: SUCCESS (0.149s)
[111.395483] Starting dynamic subtest: pipe-B-DP-3-x-to-linear
[111.530782] Dynamic subtest pipe-B-DP-3-x-to-linear: SUCCESS (0.150s)
[111.569596] Starting dynamic subtest: pipe-B-DP-3-linear-to-4
[111.696566] Dynamic subtest pipe-B-DP-3-linear-to-4: SUCCESS (0.166s)
[111.708540] Starting dynamic subtest: pipe-B-DP-3-linear-to-x
[111.829919] Dynamic subtest pipe-B-DP-3-linear-to-x: SUCCESS (0.133s)
[111.852765] Starting dynamic subtest: pipe-B-DP-3-linear-to-linear
[111.979979] Dynamic subtest pipe-B-DP-3-linear-to-linear: SUCCESS (0.150s)
[112.023379] Starting dynamic subtest: pipe-C-DP-3-4-to-4
[112.343700] Dynamic subtest pipe-C-DP-3-4-to-4: SUCCESS (0.329s)
[112.382269] Starting dynamic subtest: pipe-C-DP-3-4-to-x
[112.509256] Dynamic subtest pipe-C-DP-3-4-to-x: SUCCESS (0.166s)
[112.521750] Starting dynamic subtest: pipe-C-DP-3-4-to-linear
[112.643440] Dynamic subtest pipe-C-DP-3-4-to-linear: SUCCESS (0.133s)
[112.680047] Starting dynamic subtest: pipe-C-DP-3-x-to-4
[112.808938] Dynamic subtest pipe-C-DP-3-x-to-4: SUCCESS (0.165s)
[112.831264] Starting dynamic subtest: pipe-C-DP-3-x-to-x
[112.960003] Dynamic subtest pipe-C-DP-3-x-to-x: SUCCESS (0.150s)
[112.995486] Starting dynamic subtest: pipe-C-DP-3-x-to-linear
[113.125758] Dynamic subtest pipe-C-DP-3-x-to-linear: SUCCESS (0.165s)
[113.153158] Starting dynamic subtest: pipe-C-DP-3-linear-to-4
[113.292297] Dynamic subtest pipe-C-DP-3-linear-to-4: SUCCESS (0.166s)
[113.325788] Starting dynamic subtest: pipe-C-DP-3-linear-to-x
[113.459902] Dynamic subtest pipe-C-DP-3-linear-to-x: SUCCESS (0.166s)
[113.495882] Starting dynamic subtest: pipe-C-DP-3-linear-to-linear
[113.625524] Dynamic subtest pipe-C-DP-3-linear-to-linear: SUCCESS (0.165s)
[113.668746] Starting dynamic subtest: pipe-D-DP-3-4-to-4
[113.989692] Dynamic subtest pipe-D-DP-3-4-to-4: SUCCESS (0.329s)
[114.027341] Starting dynamic subtest: pipe-D-DP-3-4-to-x
[114.155503] Dynamic subtest pipe-D-DP-3-4-to-x: SUCCESS (0.166s)
[114.179177] Starting dynamic subtest: pipe-D-DP-3-4-to-linear
[114.305103] Dynamic subtest pipe-D-DP-3-4-to-linear: SUCCESS (0.149s)
[114.327390] Starting dynamic subtest: pipe-D-DP-3-x-to-4
[114.455059] Dynamic subtest pipe-D-DP-3-x-to-4: SUCCESS (0.150s)
[114.474062] Starting dynamic subtest: pipe-D-DP-3-x-to-x
[114.605237] Dynamic subtest pipe-D-DP-3-x-to-x: SUCCESS (0.150s)
[114.633613] Starting dynamic subtest: pipe-D-DP-3-x-to-linear
[114.754946] Dynamic subtest pipe-D-DP-3-x-to-linear: SUCCESS (0.149s)
[114.767041] Starting dynamic subtest: pipe-D-DP-3-linear-to-4
[114.888311] Dynamic subtest pipe-D-DP-3-linear-to-4: SUCCESS (0.133s)
[114.915803] Starting dynamic subtest: pipe-D-DP-3-linear-to-x
[115.055378] Dynamic subtest pipe-D-DP-3-linear-to-x: SUCCESS (0.166s)
[115.069232] Starting dynamic subtest: pipe-D-DP-3-linear-to-linear
[115.188310] Dynamic subtest pipe-D-DP-3-linear-to-linear: SUCCESS (0.132s)
[115.221316] Subtest flip-change-tiling: SUCCESS (6.668s)
[115.598082] [010/133] (907s left) vgem_basic (unload)
[115.640782] Starting subtest: unload
[144.753316] Subtest unload: SUCCESS (29.116s)
[144.924807] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[144.926832] [011/133] (878s left) gem_mmap_gtt (basic-write-read)
[145.016251] Subtest basic-write-read: SKIP (0.000s)
[145.089264] [012/133] (878s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[146.613572] Starting subtest: modeset-lpsp-stress-no-wait
[146.812655] Subtest modeset-lpsp-stress-no-wait: SKIP (0.201s)
[147.063660] [013/133] (876s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[147.250373] Starting subtest: short-flip-after-cursor-atomic-transitions
[148.302254] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.052s)
[148.629805] [014/133] (874s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[148.815908] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[148.816787] Starting dynamic subtest: pipe-A-valid-mode
[151.397607] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.578s)
[151.399227] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.580s)
[151.727779] [015/133] (871s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[151.919869] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[151.976924] [016/133] (871s left) syncobj_basic (bad-fd-to-handle)
[152.054241] Starting subtest: bad-fd-to-handle
[152.055179] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[152.180005] [017/133] (871s left) syncobj_wait (multi-wait-submitted-signaled)
[152.258157] Starting subtest: multi-wait-submitted-signaled
[152.258931] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[152.441033] [018/133] (871s left) kms_color (invalid-ctm-matrix-sizes)
[152.625875] Starting subtest: invalid-ctm-matrix-sizes
[152.626787] Starting dynamic subtest: pipe-A
[152.629177] Dynamic subtest pipe-A: SUCCESS (0.003s)
[152.638903] Starting dynamic subtest: pipe-B
[152.639823] Dynamic subtest pipe-B: SUCCESS (0.004s)
[152.649728] Starting dynamic subtest: pipe-C
[152.650927] Dynamic subtest pipe-C: SUCCESS (0.005s)
[152.660701] Starting dynamic subtest: pipe-D
[152.661625] Dynamic subtest pipe-D: SUCCESS (0.006s)
[152.662543] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.019s)
[152.783027] [019/133] (870s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[152.982816] Starting subtest: yf-tiled-64bpp-rotate-0
[152.984546] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[153.177269] [020/133] (870s left) gen7_exec_parse (batch-without-end)
[153.263243] Subtest batch-without-end: SKIP (0.000s)
[153.337151] [021/133] (870s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[153.534457] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[154.229559] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.695s)
[154.488189] [022/133] (869s left) gem_ctx_persistence (heartbeat-stop)
[154.571549] Starting subtest: heartbeat-stop
[154.573570] Subtest heartbeat-stop: SKIP (0.000s)
[154.741289] [023/133] (869s left) gem_userptr_blits (mmap-offset-banned)
[154.829604] Starting subtest: mmap-offset-banned
[154.830501] Starting dynamic subtest: fixed
[154.831370] Dynamic subtest fixed: SUCCESS (0.000s)
[154.832258] Subtest mmap-offset-banned: SUCCESS (0.000s)
[155.001732] [024/133] (869s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[155.194891] Starting subtest: 4-tiled-8bpp-rotate-90
[155.246584] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.051s)
[155.462299] [025/133] (868s left) gem_exec_whisper (basic-fds)
[155.566124] Starting subtest: basic-fds
[165.072470] Subtest basic-fds: SUCCESS (9.505s)
[165.322706] [026/133] (858s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[165.516746] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[165.518462] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[165.682454] [027/133] (858s left) gem_mmap_wc (close)
[165.760485] Subtest close: SKIP (0.000s)
[165.840365] [028/133] (858s left) kms_async_flips (async-flip-hang)
[166.024440] Starting subtest: async-flip-hang
[166.251588] Starting dynamic subtest: pipe-A-DP-3
[181.063888] Dynamic subtest pipe-A-DP-3: SUCCESS (14.813s)
[181.257146] Starting dynamic subtest: pipe-B-DP-3
[206.085570] Dynamic subtest pipe-B-DP-3: SUCCESS (24.838s)
[206.263169] Starting dynamic subtest: pipe-C-DP-3
[221.077744] Dynamic subtest pipe-C-DP-3: SUCCESS (14.824s)
[221.281188] Starting dynamic subtest: pipe-D-DP-3
[246.097769] Dynamic subtest pipe-D-DP-3: SUCCESS (24.827s)
[246.098757] Subtest async-flip-hang: SUCCESS (80.075s)
[246.623938] [029/133] (777s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[246.818879] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[246.820503] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[246.976544] [030/133] (777s left) perf (enable-disable)
[247.407214] Starting subtest: enable-disable
[247.408061] Starting dynamic subtest: 0-rcs0
[249.676633] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[249.677546] Subtest enable-disable: SUCCESS (2.270s)
[249.744215] [031/133] (774s left) gem_mmap (basic)
[249.840588] Subtest basic: SKIP (0.000s)
[249.949495] [032/133] (774s left) gem_exec_balancer (fairslice)
[250.040309] Starting subtest: fairslice
[255.588713] Subtest fairslice: SUCCESS (5.548s)
[256.022775] [033/133] (768s left) gem_exec_reloc (basic-wc-cpu-active)
[256.108751] Subtest basic-wc-cpu-active: SKIP (0.000s)
[256.185876] [034/133] (768s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[256.384306] Starting subtest: y-tiled-64bpp-rotate-90
[256.386088] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[256.542891] [035/133] (768s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[256.731467] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[256.746779] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.014s)
[256.891209] [036/133] (768s left) gem_spin_batch (legacy)
[256.977972] Starting subtest: legacy
[256.978828] Starting dynamic subtest: default
[260.240542] Dynamic subtest default: SUCCESS (3.259s)
[260.252934] Starting dynamic subtest: render
[263.476671] Dynamic subtest render: SUCCESS (3.234s)
[263.488720] Starting dynamic subtest: bsd
[266.713822] Dynamic subtest bsd: SUCCESS (3.234s)
[266.727273] Starting dynamic subtest: bsd1
[269.952036] Dynamic subtest bsd1: SUCCESS (3.235s)
[269.963905] Starting dynamic subtest: bsd2
[273.188029] Dynamic subtest bsd2: SUCCESS (3.233s)
[273.201486] Starting dynamic subtest: blt
[276.424767] Dynamic subtest blt: SUCCESS (3.234s)
[276.440191] Starting dynamic subtest: vebox
[279.662564] Dynamic subtest vebox: SUCCESS (3.235s)
[279.664314] Subtest legacy: SUCCESS (22.683s)
[279.936850] [037/133] (745s left) kms_flip (flip-vs-panning)
[280.122834] Starting subtest: flip-vs-panning
[280.126921] Starting dynamic subtest: A-DP3
[287.977923] Dynamic subtest A-DP3: SUCCESS (7.850s)
[287.990122] Starting dynamic subtest: B-DP3
[295.773924] Dynamic subtest B-DP3: SUCCESS (7.795s)
[295.784948] Starting dynamic subtest: C-DP3
[303.550857] Dynamic subtest C-DP3: SUCCESS (7.776s)
[303.562623] Starting dynamic subtest: D-DP3
[311.335287] Dynamic subtest D-DP3: SUCCESS (7.782s)
[311.342508] Subtest flip-vs-panning: SUCCESS (31.218s)
[311.730874] [038/133] (713s left) kms_lease (implicit-plane-lease)
[311.919679] Starting subtest: implicit-plane-lease
[311.924406] Subtest implicit-plane-lease: SUCCESS (0.004s)
[312.131740] [039/133] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[312.326252] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[312.328053] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[312.534101] [040/133] (712s left) kms_selftest (drm_dp_mst_helper)
[312.581519] Starting subtest: drm_dp_mst_helper
[312.608275] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[312.689543] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.081s)
[312.700820] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[312.795686] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.104s)
[312.830619] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[312.883010] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.086s)
[312.884159] Subtest drm_dp_mst_helper: SUCCESS (0.302s)
[313.114105] [041/133] (712s left) i915_query (query-topology-unsupported)
[313.187503] Starting subtest: query-topology-unsupported
[313.189354] Subtest query-topology-unsupported: SKIP (0.000s)
[313.359932] [042/133] (711s left) gem_eio (in-flight-10ms)
[313.653697] Starting subtest: in-flight-10ms
[318.755525] Subtest in-flight-10ms: SUCCESS (5.102s)
[319.049439] [043/133] (706s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[319.249436] Starting subtest: extended-modeset-hang-oldfb-with-reset
[319.251438] Starting dynamic subtest: pipe-A
[329.956902] Dynamic subtest pipe-A: SUCCESS (10.704s)
[329.986027] Starting dynamic subtest: pipe-D
[340.678571] Dynamic subtest pipe-D: SUCCESS (10.712s)
[340.679532] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.429s)
[340.980922] [044/133] (684s left) kms_psr (psr-sprite-render)
[341.165097] Subtest psr-sprite-render: SKIP (0.000s)
[341.248540] [045/133] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[341.437809] Starting subtest: psr-1p-primscrn-cur-indfb-move
[341.439483] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[341.630800] [046/133] (684s left) gem_mmap_offset (blt-coherency)
[341.707567] Starting subtest: blt-coherency
[341.740492] Subtest blt-coherency: SUCCESS (0.034s)
[341.910689] [047/133] (683s left) kms_cursor_edge_walk (256x256-top-bottom)
[342.094584] Starting subtest: 256x256-top-bottom
[342.095438] Starting dynamic subtest: pipe-A-DP-3
[345.533568] Dynamic subtest pipe-A-DP-3: SUCCESS (3.438s)
[345.545130] Starting dynamic subtest: pipe-D-DP-3
[348.883679] Dynamic subtest pipe-D-DP-3: SUCCESS (3.347s)
[348.884998] Subtest 256x256-top-bottom: SUCCESS (6.789s)
[349.187122] [048/133] (676s left) gem_reg_read (timestamp-moving)
[349.264809] Starting subtest: timestamp-moving
[350.265507] Subtest timestamp-moving: SUCCESS (1.001s)
[350.419088] [049/133] (675s left) kms_feature_discovery (display-1x)
[350.599589] Starting subtest: display-1x
[350.600514] Subtest display-1x: SUCCESS (0.000s)
[350.716826] [050/133] (675s left) gem_eio (wait-wedge-immediate)
[351.045504] Starting subtest: wait-wedge-immediate
[352.478940] Subtest wait-wedge-immediate: SUCCESS (1.434s)
[352.751804] [051/133] (673s left) gem_fence_thrash (bo-copy)
[352.798273] Starting subtest: bo-copy
[352.829507] Subtest bo-copy: SKIP (0.031s)
[352.896912] [052/133] (673s left) gem_partial_pwrite_pread (write)
[352.979859] Subtest write: SKIP (0.000s)
[353.070466] [053/133] (673s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[353.261232] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[353.262911] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[353.419836] [054/133] (672s left) gem_mmap_gtt (basic-small-bo-tiledy)
[353.496372] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[353.563586] [055/133] (672s left) gem_exec_schedule (fifo)
[353.653981] Starting subtest: fifo
[353.654866] Starting dynamic subtest: rcs0
[353.936026] Dynamic subtest rcs0: SUCCESS (0.281s)
[353.947692] Starting dynamic subtest: bcs0
[354.135770] Dynamic subtest bcs0: SUCCESS (0.199s)
[354.147279] Starting dynamic subtest: vcs0
[354.343019] Dynamic subtest vcs0: SUCCESS (0.206s)
[354.354581] Starting dynamic subtest: vcs1
[354.550817] Dynamic subtest vcs1: SUCCESS (0.207s)
[354.562425] Starting dynamic subtest: vecs0
[354.758731] Dynamic subtest vecs0: SUCCESS (0.207s)
[354.770105] Starting dynamic subtest: vecs1
[354.965795] Dynamic subtest vecs1: SUCCESS (0.206s)
[354.977569] Starting dynamic subtest: ccs0
[355.176021] Dynamic subtest ccs0: SUCCESS (0.209s)
[355.176934] Subtest fifo: SUCCESS (1.522s)
[355.686839] [056/133] (670s left) i915_pm_rpm (gem-execbuf)
[357.599640] Starting subtest: gem-execbuf
[357.600559] Starting dynamic subtest: lmem0
[359.199038] Dynamic subtest lmem0: SUCCESS (1.600s)
[359.232940] Starting dynamic subtest: smem0
[363.657700] Dynamic subtest smem0: SUCCESS (4.456s)
[363.659706] Subtest gem-execbuf: SUCCESS (6.062s)
[364.077278] [057/133] (662s left) i915_drm_fdinfo (memory-info-active)
[364.146746] Starting subtest: memory-info-active
[364.147684] Starting dynamic subtest: lmem0
[367.938535] Dynamic subtest lmem0: SUCCESS (3.791s)
[367.958502] Starting dynamic subtest: smem0
[372.481729] Dynamic subtest smem0: SUCCESS (4.540s)
[372.482723] Subtest memory-info-active: SUCCESS (8.335s)
[372.625924] [058/133] (653s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[372.894242] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[373.045600] [059/133] (653s left) gem_fence_thrash (bo-write-verify-threaded-none)
[373.091315] Starting subtest: bo-write-verify-threaded-none
[373.129350] Subtest bo-write-verify-threaded-none: SKIP (0.037s)
[373.230631] [060/133] (653s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[373.424788] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[373.426416] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[373.620747] [061/133] (653s left) gem_ctx_param (invalid-set-ringsize)
[373.693828] Starting subtest: invalid-set-ringsize
[373.694757] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[373.826836] [062/133] (652s left) kms_plane_multiple (tiling-x)
[374.012248] Starting subtest: tiling-x
[374.014409] Starting dynamic subtest: pipe-A-DP-3
[375.126582] Dynamic subtest pipe-A-DP-3: SUCCESS (1.113s)
[375.142304] Starting dynamic subtest: pipe-B-DP-3
[376.196034] Dynamic subtest pipe-B-DP-3: SUCCESS (1.068s)
[376.209527] Starting dynamic subtest: pipe-C-DP-3
[377.269900] Dynamic subtest pipe-C-DP-3: SUCCESS (1.072s)
[377.292563] Starting dynamic subtest: pipe-D-DP-3
[378.345652] Dynamic subtest pipe-D-DP-3: SUCCESS (1.071s)
[378.346520] Subtest tiling-x: SUCCESS (4.333s)
[378.682838] [063/133] (648s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[378.956729] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[379.113111] [064/133] (647s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[379.299527] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[379.314947] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.015s)
[379.465227] [065/133] (647s left) syncobj_timeline (multi-wait-signaled)
[379.542565] Starting subtest: multi-wait-signaled
[379.543470] Subtest multi-wait-signaled: SUCCESS (0.001s)
[379.738803] [066/133] (647s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[379.931386] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[379.933119] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[380.120628] [067/133] (647s left) syncobj_wait (multi-wait-for-submit-signaled)
[380.198772] Starting subtest: multi-wait-for-submit-signaled
[380.199676] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[380.371987] [068/133] (646s left) gem_exec_schedule (preempt-queue-contexts-chain)
[380.468861] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[380.836834] [069/133] (646s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[381.027474] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[381.029211] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[381.186993] [070/133] (646s left) gem_gpgpu_fill (basic)
[381.266561] Starting subtest: basic
[381.267537] Starting dynamic subtest: smem
[381.298441] Dynamic subtest smem: SUCCESS (0.031s)
[381.312460] Starting dynamic subtest: lmem0
[381.313443] Dynamic subtest lmem0: SUCCESS (0.013s)
[381.314531] Subtest basic: SUCCESS (0.046s)
[381.526509] [071/133] (645s left) prime_busy (hang)
[381.611591] Starting subtest: hang
[381.613988] Starting dynamic subtest: rcs0
[408.088487] Dynamic subtest rcs0: SUCCESS (26.474s)
[408.100753] Starting dynamic subtest: bcs0
[415.238206] Dynamic subtest bcs0: SUCCESS (7.149s)
[415.250259] Starting dynamic subtest: vcs0
[422.226512] Dynamic subtest vcs0: SUCCESS (6.988s)
[422.238839] Starting dynamic subtest: vcs1
[429.210301] Dynamic subtest vcs1: SUCCESS (6.974s)
[429.222424] Starting dynamic subtest: vecs0
[436.241358] Dynamic subtest vecs0: SUCCESS (7.039s)
[436.253867] Starting dynamic subtest: vecs1
[443.225609] Dynamic subtest vecs1: SUCCESS (6.976s)
[443.237781] Starting dynamic subtest: ccs0
[457.051801] Dynamic subtest ccs0: SUCCESS (13.831s)
[457.052730] Subtest hang: SUCCESS (75.441s)
[457.217926] [072/133] (570s left) kms_atomic (atomic-invalid-params)
[457.403986] Starting subtest: atomic-invalid-params
[457.406302] Starting dynamic subtest: pipe-A-DP-3
[457.967493] Dynamic subtest pipe-A-DP-3: SUCCESS (0.560s)
[457.968517] Subtest atomic-invalid-params: SUCCESS (0.563s)
[458.290416] [073/133] (569s left) gem_exec_reloc (basic-write-wc-active)
[458.380373] Subtest basic-write-wc-active: SKIP (0.000s)
[458.483393] [074/133] (569s left) gem_userptr_blits (invalid-null-pointer)
[458.573394] Starting subtest: invalid-null-pointer
[458.574257] Subtest invalid-null-pointer: SUCCESS (0.001s)
[458.788160] [075/133] (569s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[458.972723] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[459.037688] [076/133] (568s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[459.228738] Starting subtest: random-ccs-data-y-tiled-ccs
[459.229606] Starting dynamic subtest: pipe-A-DP-3
[459.238540] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[459.250358] Starting dynamic subtest: pipe-B-DP-3
[459.259538] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[459.271097] Starting dynamic subtest: pipe-C-DP-3
[459.280057] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[459.291581] Starting dynamic subtest: pipe-D-DP-3
[459.303180] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[459.305423] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.007s)
[459.718090] [077/133] (568s left) kms_addfb_basic (invalid-get-prop-any)
[459.794087] Starting subtest: invalid-get-prop-any
[459.794897] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[460.073299] [078/133] (567s left) perf_pmu (busy-idle-check-all)
[460.144593] Starting subtest: busy-idle-check-all
[460.145575] Starting dynamic subtest: rcs0
[460.839964] Dynamic subtest rcs0: SUCCESS (0.695s)
[460.858281] Starting dynamic subtest: bcs0
[461.498769] Dynamic subtest bcs0: SUCCESS (0.656s)
[461.545451] Starting dynamic subtest: vcs0
[462.183836] Dynamic subtest vcs0: SUCCESS (0.680s)
[462.205460] Starting dynamic subtest: vcs1
[462.845751] Dynamic subtest vcs1: SUCCESS (0.657s)
[462.890469] Starting dynamic subtest: vecs0
[463.528842] Dynamic subtest vecs0: SUCCESS (0.678s)
[463.575582] Starting dynamic subtest: vecs1
[464.214847] Dynamic subtest vecs1: SUCCESS (0.681s)
[464.235975] Starting dynamic subtest: ccs0
[464.879132] Dynamic subtest ccs0: SUCCESS (0.659s)
[464.885007] Subtest busy-idle-check-all: SUCCESS (4.736s)
[465.080902] [079/133] (563s left) gem_exec_schedule (preempt-queue-contexts)
[465.172714] Subtest preempt-queue-contexts: SKIP (0.000s)
[465.541284] [080/133] (562s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[465.726869] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[465.729161] Starting dynamic subtest: pipe-A-DP-3
[465.737199] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[465.749689] Starting dynamic subtest: pipe-B-DP-3
[465.758221] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[465.770552] Starting dynamic subtest: pipe-C-DP-3
[465.778696] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[465.791047] Starting dynamic subtest: pipe-D-DP-3
[465.800783] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[465.802489] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[466.199188] [081/133] (562s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[466.588653] Starting subtest: cursor-rapid-movement-128x42
[466.593578] Starting dynamic subtest: pipe-A-DP-3
[467.057610] Dynamic subtest pipe-A-DP-3: SUCCESS (0.464s)
[467.107295] Starting dynamic subtest: pipe-D-DP-3
[467.469586] Dynamic subtest pipe-D-DP-3: SUCCESS (0.374s)
[467.470453] Subtest cursor-rapid-movement-128x42: SUCCESS (0.880s)
[467.919635] [082/133] (560s left) perf (gen12-group-exclusive-stream-sample-oa)
[468.183539] Starting subtest: gen12-group-exclusive-stream-sample-oa
[468.205187] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[468.269690] [083/133] (560s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[468.455722] Starting subtest: pixel-format-linear-modifier-source-clamping
[468.487769] Starting dynamic subtest: pipe-A-plane-0
[474.553998] Dynamic subtest pipe-A-plane-0: SUCCESS (6.066s)
[474.570131] Starting dynamic subtest: pipe-A-plane-3
[477.587582] Dynamic subtest pipe-A-plane-3: SUCCESS (3.032s)
[477.834109] Starting dynamic subtest: pipe-B-plane-0
[483.461916] Dynamic subtest pipe-B-plane-0: SUCCESS (5.649s)
[483.476972] Starting dynamic subtest: pipe-B-plane-3
[486.478604] Dynamic subtest pipe-B-plane-3: SUCCESS (3.016s)
[486.569262] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (18.114s)
[486.856888] [084/133] (541s left) kms_psr (pr-cursor-mmap-cpu)
[487.046837] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[487.101969] [085/133] (541s left) gem_exec_fence (basic-await)
[487.310495] Starting subtest: basic-await
[487.311384] Starting dynamic subtest: rcs0
[487.420516] Dynamic subtest rcs0: SUCCESS (0.112s)
[487.438146] Starting dynamic subtest: bcs0
[487.513908] Dynamic subtest bcs0: SUCCESS (0.092s)
[487.530854] Starting dynamic subtest: vcs0
[487.602954] Dynamic subtest vcs0: SUCCESS (0.088s)
[487.621439] Starting dynamic subtest: vcs1
[487.693884] Dynamic subtest vcs1: SUCCESS (0.090s)
[487.712004] Starting dynamic subtest: vecs0
[487.783275] Dynamic subtest vecs0: SUCCESS (0.088s)
[487.799379] Starting dynamic subtest: vecs1
[487.870604] Dynamic subtest vecs1: SUCCESS (0.086s)
[487.889379] Starting dynamic subtest: ccs0
[487.962882] Dynamic subtest ccs0: SUCCESS (0.091s)
[487.963825] Subtest basic-await: SUCCESS (0.656s)
[488.792477] [086/133] (539s left) syncobj_timeline (signal-point-0)
[488.871675] Starting subtest: signal-point-0
[488.872627] Subtest signal-point-0: SUCCESS (0.000s)
[489.017030] [087/133] (539s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[489.205728] Starting subtest: psr-farfromfence-mmap-gtt
[489.207445] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[489.409275] [088/133] (539s left) dumb_buffer (map-uaf)
[489.487751] Starting subtest: map-uaf
[489.508327] Subtest map-uaf: SUCCESS (0.020s)
[489.654945] [089/133] (539s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[489.847227] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[489.848932] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[490.041793] [090/133] (538s left) sysfs_heartbeat_interval (precise)
[490.124657] Starting subtest: precise
[490.125766] Starting dynamic subtest: vecs0
[492.805705] Dynamic subtest vecs0: SUCCESS (2.681s)
[492.819768] Starting dynamic subtest: ccs0
[494.389562] Dynamic subtest ccs0: SUCCESS (1.582s)
[494.402840] Starting dynamic subtest: vcs0
[495.934594] Dynamic subtest vcs0: SUCCESS (1.544s)
[495.948646] Starting dynamic subtest: bcs0
[498.848384] Dynamic subtest bcs0: SUCCESS (2.912s)
[498.861816] Starting dynamic subtest: vecs1
[500.352545] Dynamic subtest vecs1: SUCCESS (1.503s)
[500.366095] Starting dynamic subtest: rcs0
[501.911691] Dynamic subtest rcs0: SUCCESS (1.558s)
[501.930453] Starting dynamic subtest: vcs1
[503.424618] Dynamic subtest vcs1: SUCCESS (1.511s)
[503.425529] Subtest precise: SUCCESS (13.301s)
[503.657813] [091/133] (525s left) kms_addfb_basic (too-high)
[503.848918] Starting subtest: too-high
[503.849767] Subtest too-high: SUCCESS (0.001s)
[504.038908] [092/133] (525s left) gem_ctx_engines (execute-one)
[504.128290] Starting subtest: execute-one
[507.521637] Subtest execute-one: SUCCESS (3.393s)
[507.852867] [093/133] (521s left) gem_mmap_offset (ptrace)
[507.928677] Starting subtest: ptrace
[507.933066] Starting dynamic subtest: lmem0-fixed
[508.048543] Dynamic subtest lmem0-fixed: SUCCESS (0.115s)
[508.064215] Starting dynamic subtest: smem0-fixed
[508.067510] Dynamic subtest smem0-fixed: SUCCESS (0.015s)
[508.068523] Subtest ptrace: SUCCESS (0.139s)
[508.271208] [094/133] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[508.477400] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[508.479137] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[508.647872] [095/133] (520s left) api_intel_bb (object-reloc-keep-cache)
[508.725858] Starting subtest: object-reloc-keep-cache
[508.730239] Subtest object-reloc-keep-cache: SKIP (0.004s)
[508.954148] [096/133] (520s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[509.139604] Starting subtest: basic-flip-before-cursor-atomic
[510.165969] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.026s)
[510.497790] [097/133] (519s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[510.578900] Starting subtest: yf-tiled-ccs-to-y-tiled
[510.580912] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[510.832334] [098/133] (518s left) gem_exec_fence (syncobj-timeline-export)
[511.471901] Starting subtest: syncobj-timeline-export
[511.521403] Subtest syncobj-timeline-export: SUCCESS (0.050s)
[511.830167] [099/133] (517s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[512.020483] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[512.022229] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[512.211149] [100/133] (517s left) kms_psr (psr2-primary-page-flip)
[512.414424] Subtest psr2-primary-page-flip: SKIP (0.000s)
[512.476974] [101/133] (517s left) syncobj_eventfd (invalid-bad-pad)
[512.553634] Starting subtest: invalid-bad-pad
[512.554555] Subtest invalid-bad-pad: SUCCESS (0.000s)
[512.688078] [102/133] (517s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[512.876223] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[512.878482] Starting dynamic subtest: pipe-A-DP-3
[512.886625] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[512.899171] Starting dynamic subtest: pipe-B-DP-3
[512.907310] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[512.919774] Starting dynamic subtest: pipe-C-DP-3
[512.927847] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[512.940405] Starting dynamic subtest: pipe-D-DP-3
[512.950869] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[512.952868] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[513.393477] [103/133] (516s left) testdisplay
[532.630820] [104/133] (497s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[532.826595] Starting subtest: disable-crc-after-crtc
[532.827489] Starting dynamic subtest: pipe-A-DP-3
[533.553333] Dynamic subtest pipe-A-DP-3: SUCCESS (0.725s)
[533.573856] Starting dynamic subtest: pipe-B-DP-3
[534.180761] Dynamic subtest pipe-B-DP-3: SUCCESS (0.625s)
[534.197397] Starting dynamic subtest: pipe-C-DP-3
[534.791723] Dynamic subtest pipe-C-DP-3: SUCCESS (0.608s)
[534.808247] Starting dynamic subtest: pipe-D-DP-3
[535.389746] Dynamic subtest pipe-D-DP-3: SUCCESS (0.596s)
[535.390719] Subtest disable-crc-after-crtc: SUCCESS (2.564s)
[535.687289] [105/133] (494s left) syncobj_wait (wait-for-submit-complex)
[535.775747] Starting subtest: wait-for-submit-complex
[535.839441] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[535.960789] [106/133] (494s left) gem_lmem_swapping (verify-random)
[538.679879] Starting subtest: verify-random
[538.680769] Starting dynamic subtest: lmem0
[547.167881] Dynamic subtest lmem0: SUCCESS (8.487s)
[547.168847] Subtest verify-random: SUCCESS (8.488s)
[548.218860] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[548.219822] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[548.221938] [107/133] (481s left) gem_close_race (basic-process)
[549.867962] Starting subtest: basic-process
[549.943825] Subtest basic-process: SUCCESS (0.076s)
[550.202382] [FACT gem_close_race (basic-process)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[550.204908] [FACT gem_close_race (basic-process)] new: kernel.kmod_is_loaded.i915: true
[550.207901] [108/133] (480s left) gem_sync (basic-many-each)
[550.305785] Starting subtest: basic-many-each
[552.723184] Subtest basic-many-each: SUCCESS (2.417s)
[553.024223] [109/133] (477s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[553.102687] Starting subtest: multi-wait-all-for-submit-available-signaled
[553.103564] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[553.297208] [110/133] (477s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[553.373872] Starting subtest: etime-single-wait-all-available-unsubmitted
[553.475559] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[553.659046] [111/133] (476s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[553.845750] Starting subtest: plane-upscale-factor-0-25-with-rotation
[553.846467] Starting dynamic subtest: pipe-A
[554.243224] Dynamic subtest pipe-A: SUCCESS (0.398s)
[554.259467] Starting dynamic subtest: pipe-B
[554.706815] Dynamic subtest pipe-B: SUCCESS (0.462s)
[554.728575] Starting dynamic subtest: pipe-C
[555.186868] Dynamic subtest pipe-C: SUCCESS (0.478s)
[555.212380] Starting dynamic subtest: pipe-D
[555.666901] Dynamic subtest pipe-D: SUCCESS (0.478s)
[555.668122] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (1.823s)
[556.030684] [112/133] (474s left) gem_fence_thrash (bo-write-verify-none)
[556.077363] Starting subtest: bo-write-verify-none
[556.108778] Subtest bo-write-verify-none: SKIP (0.030s)
[556.195823] [113/133] (474s left) kms_vblank (wait-busy)
[556.381741] Starting subtest: wait-busy
[556.382613] Starting dynamic subtest: pipe-A-DP-3
[558.899630] Dynamic subtest pipe-A-DP-3: SUCCESS (2.516s)
[558.931190] Starting dynamic subtest: pipe-D-DP-3
[561.346628] Dynamic subtest pipe-D-DP-3: SUCCESS (2.436s)
[561.347577] Subtest wait-busy: SUCCESS (4.965s)
[561.628687] [114/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[561.819510] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[561.821270] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[562.011904] [115/133] (468s left) kms_psr (fbc-pr-primary-render)
[562.199221] Subtest fbc-pr-primary-render: SKIP (0.000s)
[562.257177] [116/133] (468s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[562.454964] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[562.456708] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[562.811589] [117/133] (468s left) gem_exec_reloc (basic-wc-cpu)
[562.894810] Subtest basic-wc-cpu: SKIP (0.000s)
[562.984805] [118/133] (468s left) kms_prop_blob (invalid-get-prop-any)
[563.062990] Starting subtest: invalid-get-prop-any
[563.063948] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[563.196911] [119/133] (467s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[563.379748] Starting subtest: drrs-dirtyfb-ioctl
[563.384849] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[563.525273] [120/133] (467s left) gem_ctx_shared (single-timeline)
[563.614280] Starting subtest: single-timeline
[563.651597] Subtest single-timeline: SUCCESS (0.035s)
[563.999849] [121/133] (467s left) kms_content_protection (legacy-hdcp14)
[564.252787] Starting subtest: legacy-hdcp14
[564.537080] Starting dynamic subtest: pipe-A-DP-3
[685.677242] Dynamic subtest pipe-A-DP-3: FAIL (120.871s)
[685.678397] Subtest legacy-hdcp14: FAIL (121.266s)
[685.850454] [122/133] (345s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[686.039615] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[686.040516] Starting dynamic subtest: pipe-A-DP-3
[686.049534] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[686.061052] Starting dynamic subtest: pipe-B-DP-3
[686.070140] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[686.081525] Starting dynamic subtest: pipe-C-DP-3
[686.090366] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[686.101956] Starting dynamic subtest: pipe-D-DP-3
[686.114191] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[686.115893] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[686.505529] [123/133] (344s left) prime_udl
[686.620561] [124/133] (344s left) kms_hdr (static-toggle)
[686.804957] Starting subtest: static-toggle
[690.387904] Starting dynamic subtest: pipe-A-DP-3
[691.542294] Dynamic subtest pipe-A-DP-3: SUCCESS (1.154s)
[691.546717] Subtest static-toggle: SUCCESS (4.739s)
[691.874240] [125/133] (339s left) dmabuf_sync_file (import-multiple-read-write)
[691.938965] Starting subtest: import-multiple-read-write
[691.942878] Subtest import-multiple-read-write: SUCCESS (0.004s)
[692.094669] [126/133] (339s left) syncobj_wait (reset-signaled)
[692.181678] Starting subtest: reset-signaled
[692.182647] Subtest reset-signaled: SUCCESS (0.000s)
[692.372972] [127/133] (339s left) kms_pm_dc (dc5-dpms)
[693.565735] Starting subtest: dc5-dpms
[694.979664] Subtest dc5-dpms: SUCCESS (1.414s)
[695.104391] [128/133] (336s left) gem_gtt_cpu_tlb
[695.285083] [129/133] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[695.476306] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[695.478000] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[695.669116] [130/133] (336s left) kms_psr2_su (frontbuffer-xrgb8888)
[695.754752] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[695.833866] [131/133] (336s left) gem_render_copy (yf-tiled-ccs-to-linear)
[695.918241] Starting subtest: yf-tiled-ccs-to-linear
[695.920430] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[696.215006] [132/133] (335s left) api_intel_allocator (reopen)
[696.303773] Starting subtest: reopen
[696.332608] Subtest reopen: SUCCESS (0.030s)
[696.571171] [133/133] (335s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[696.768102] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[697.985381] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.217s)
[698.235230] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: i915_suspend
results: parsing output: 4/ for test: gem_partial_pwrite_pread
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_flip_tiling
results: parsing output: 9/ for test: vgem_basic
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: syncobj_basic
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_color
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gen7_exec_parse
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: kms_async_flips
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: gem_mmap
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: gem_spin_batch
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_selftest
results: parsing output: 40/ for test: i915_query
results: parsing output: 41/ for test: gem_eio
results: parsing output: 42/ for test: kms_busy
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_mmap_offset
results: parsing output: 46/ for test: kms_cursor_edge_walk
results: parsing output: 47/ for test: gem_reg_read
results: parsing output: 48/ for test: kms_feature_discovery
results: parsing output: 49/ for test: gem_eio
results: parsing output: 50/ for test: gem_fence_thrash
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: i915_drm_fdinfo
results: parsing output: 57/ for test: kms_chamelium_edid
results: parsing output: 58/ for test: gem_fence_thrash
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_ctx_param
results: parsing output: 61/ for test: kms_plane_multiple
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_gpgpu_fill
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: kms_atomic
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: dumb_buffer
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: sysfs_heartbeat_interval
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: gem_ctx_engines
results: parsing output: 92/ for test: gem_mmap_offset
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: syncobj_eventfd
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: testdisplay
results: parsing output: 103/ for test: kms_pipe_crc_basic
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: gem_close_race
results: parsing output: 107/ for test: gem_sync
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: gem_fence_thrash
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_prop_blob
results: parsing output: 118/ for test: kms_dirtyfb
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: prime_udl
results: parsing output: 123/ for test: kms_hdr
results: parsing output: 124/ for test: dmabuf_sync_file
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_pm_dc
results: parsing output: 127/ for test: gem_gtt_cpu_tlb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr2_su
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: api_intel_allocator
results: parsing output: 132/ for test: kms_big_fb
Done.