[60.836513] Initializing watchdogs
[60.836580]   /dev/watchdog0
[60.856659] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.867779] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.872417] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.874943] [001/131] (960s left) kms_big_fb (linear-32bpp-rotate-270)
[61.073155] Starting subtest: linear-32bpp-rotate-270
[61.144749] Subtest linear-32bpp-rotate-270: SKIP (0.072s)
[61.370737] [002/131] (960s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[61.549971] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[61.550927] Starting dynamic subtest: pipe-A-valid-mode
[64.078886] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.535s)
[64.080319] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SUCCESS (2.536s)
[64.341265] [003/131] (957s left) kms_cursor_edge_walk (256x256-top-bottom)
[64.525960] Starting subtest: 256x256-top-bottom
[64.526921] Starting dynamic subtest: pipe-A-DP-3
[67.992696] Dynamic subtest pipe-A-DP-3: SUCCESS (3.473s)
[68.000958] Starting dynamic subtest: pipe-D-DP-3
[71.318241] Dynamic subtest pipe-D-DP-3: SUCCESS (3.329s)
[71.319295] Subtest 256x256-top-bottom: SUCCESS (6.805s)
[71.585090] [004/131] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[71.775810] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[71.777514] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.968259] [005/131] (949s left) kms_chamelium_edid (dp-edid-resolution-list)
[72.250455] Subtest dp-edid-resolution-list: SKIP (0.000s)
[72.394734] [006/131] (949s left) vgem_basic (bad-flag)
[72.491693] Starting subtest: bad-flag
[72.492652] Subtest bad-flag: SUCCESS (0.000s)
[72.613638] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true
[72.615540] [007/131] (949s left) kms_cursor_crc (cursor-onscreen-256x256)
[73.046374] Starting subtest: cursor-onscreen-256x256
[73.051139] Starting dynamic subtest: pipe-A-DP-3
[75.784982] Dynamic subtest pipe-A-DP-3: SUCCESS (2.736s)
[75.832954] Starting dynamic subtest: pipe-D-DP-3
[78.570174] Dynamic subtest pipe-D-DP-3: SUCCESS (2.745s)
[78.571181] Subtest cursor-onscreen-256x256: SUCCESS (5.525s)
[79.023170] [008/131] (942s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[79.231144] Starting subtest: 4-tiled-32bpp-rotate-0
[81.052072] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.820s)
[81.248334] [009/131] (940s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[81.437969] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[81.438918] Starting dynamic subtest: pipe-A-DP-3
[81.447506] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[81.455465] Starting dynamic subtest: pipe-B-DP-3
[81.464023] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[81.471916] Starting dynamic subtest: pipe-C-DP-3
[81.480290] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[81.488090] Starting dynamic subtest: pipe-D-DP-3
[81.496713] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[81.498397] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[81.911553] [010/131] (940s left) gem_ctx_persistence (heartbeat-close)
[82.008740] Starting subtest: heartbeat-close
[82.010739] Subtest heartbeat-close: SKIP (0.000s)
[82.212211] [011/131] (939s left) gem_exec_reloc (basic-write-read-noreloc)
[82.305779] Subtest basic-write-read-noreloc: SKIP (0.000s)
[82.373622] [012/131] (939s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[82.459481] Starting subtest: wait-all-for-submit-delayed-submit
[82.564064] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[82.702595] [013/131] (939s left) kms_psr (fbc-pr-suspend)
[82.892519] Subtest fbc-pr-suspend: SKIP (0.000s)
[82.954973] [014/131] (939s left) kms_lease (lease-invalid-crtc)
[83.150177] Starting subtest: lease-invalid-crtc
[83.151164] Starting dynamic subtest: pipe-A-DP-3
[83.152137] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[83.160403] Starting dynamic subtest: pipe-B-DP-3
[83.161346] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[83.169642] Starting dynamic subtest: pipe-C-DP-3
[83.170803] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[83.178632] Starting dynamic subtest: pipe-D-DP-3
[83.179608] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[83.180719] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[83.300773] [015/131] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[83.493693] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[83.495423] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[83.676213] [016/131] (938s left) kms_pm_lpsp (screens-disabled)
[84.871591] Starting subtest: screens-disabled
[84.873433] Subtest screens-disabled: SKIP (0.000s)
[85.029943] [017/131] (937s left) gen9_exec_parse (unaligned-access)
[85.115798] Subtest unaligned-access: SKIP (0.000s)
[85.188554] [018/131] (937s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[85.376056] Starting subtest: cursorA-vs-flipB-atomic-transitions
[85.378882] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[85.482709] [019/131] (937s left) gem_mmap_wc (bad-offset)
[85.568156] Subtest bad-offset: SKIP (0.000s)
[85.639531] [020/131] (936s left) gem_ctx_isolation (preservation-reset)
[85.840127] Starting subtest: preservation-reset
[85.841073] Starting dynamic subtest: rcs0
[86.443516] Dynamic subtest rcs0: SUCCESS (0.603s)
[86.452393] Starting dynamic subtest: bcs0
[87.082966] Dynamic subtest bcs0: SUCCESS (0.627s)
[87.091586] Starting dynamic subtest: vcs0
[87.718501] Dynamic subtest vcs0: SUCCESS (0.646s)
[87.726981] Starting dynamic subtest: vcs1
[88.344945] Dynamic subtest vcs1: SUCCESS (0.627s)
[88.353780] Starting dynamic subtest: vecs0
[88.959542] Dynamic subtest vecs0: SUCCESS (0.614s)
[88.968290] Starting dynamic subtest: vecs1
[89.622296] Dynamic subtest vecs1: SUCCESS (0.662s)
[89.630683] Starting dynamic subtest: ccs0
[90.273999] Dynamic subtest ccs0: SUCCESS (0.651s)
[90.275165] Subtest preservation-reset: SUCCESS (4.434s)
[90.528777] [021/131] (932s left) gem_bad_reloc (negative-reloc-bltcopy)
[90.616152] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[90.714153] [022/131] (932s left) syncobj_wait (single-wait-for-submit-submitted)
[90.792299] Starting subtest: single-wait-for-submit-submitted
[90.896730] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[91.019605] [023/131] (931s left) gem_mmap_gtt (basic-small-copy)
[91.099013] Subtest basic-small-copy: SKIP (0.000s)
[91.174690] [024/131] (931s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[91.372831] Starting subtest: yf-tiled-16bpp-rotate-270
[91.374609] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[91.561408] [025/131] (931s left) kms_feature_discovery (display-4x)
[91.753432] Starting subtest: display-4x
[91.755301] Subtest display-4x: SKIP (0.000s)
[91.883249] [026/131] (931s left) gem_exec_reloc (basic-gtt-read-active)
[91.970949] Subtest basic-gtt-read-active: SKIP (0.000s)
[92.065010] [027/131] (930s left) gen9_exec_parse (allowed-all)
[92.155501] Subtest allowed-all: SKIP (0.000s)
[92.276694] [028/131] (930s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[92.472199] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[92.488473] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s)
[92.654619] [029/131] (930s left) kms_invalid_mode (bad-htotal)
[92.843433] Starting subtest: bad-htotal
[92.844324] Starting dynamic subtest: pipe-A-DP-3
[92.922435] Dynamic subtest pipe-A-DP-3: SUCCESS (0.078s)
[92.931213] Starting dynamic subtest: pipe-B-DP-3
[92.932504] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[92.941129] Starting dynamic subtest: pipe-C-DP-3
[92.942378] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[92.950373] Starting dynamic subtest: pipe-D-DP-3
[92.951305] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[92.952229] Subtest bad-htotal: SUCCESS (0.084s)
[93.196995] [030/131] (930s left) syncobj_eventfd (invalid-illegal-handle)
[93.279152] Starting subtest: invalid-illegal-handle
[93.280166] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[93.406526] [031/131] (929s left) gem_exec_schedule (thriceslice)
[93.500771] Starting subtest: thriceslice
[93.501671] Starting dynamic subtest: rcs0
[93.552607] Dynamic subtest rcs0: SUCCESS (0.052s)
[93.563801] Starting dynamic subtest: bcs0
[93.608813] Dynamic subtest bcs0: SUCCESS (0.055s)
[93.620712] Starting dynamic subtest: vcs0
[93.664694] Dynamic subtest vcs0: SUCCESS (0.055s)
[93.681704] Starting dynamic subtest: vcs1
[93.705901] Dynamic subtest vcs1: SUCCESS (0.040s)
[93.726470] Starting dynamic subtest: vecs0
[93.750031] Dynamic subtest vecs0: SUCCESS (0.043s)
[93.770133] Starting dynamic subtest: vecs1
[93.792781] Dynamic subtest vecs1: SUCCESS (0.042s)
[93.809353] Starting dynamic subtest: ccs0
[93.832566] Dynamic subtest ccs0: SUCCESS (0.039s)
[93.833954] Subtest thriceslice: SUCCESS (0.332s)
[94.229381] [032/131] (929s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[94.424772] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[94.426519] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[94.614562] [033/131] (928s left) kms_psr (psr2-sprite-blt)
[94.803717] Subtest psr2-sprite-blt: SKIP (0.000s)
[94.859403] [034/131] (928s left) gem_ccs (block-multicopy-compressed)
[94.948412] Starting subtest: block-multicopy-compressed
[94.949378] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[94.996526] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.047s)
[95.005532] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[95.094077] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.097s)
[95.102751] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[95.111041] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[95.119578] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[95.206288] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[95.214418] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[95.223029] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[95.231501] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[95.318244] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[95.326550] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[95.335381] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s)
[95.343794] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[95.437445] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.102s)
[95.438418] Subtest block-multicopy-compressed: SUCCESS (0.489s)
[95.649666] [035/131] (927s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[95.837569] Starting subtest: plane-upscale-20x20-with-modifiers
[95.838423] Starting dynamic subtest: pipe-A
[96.400059] Dynamic subtest pipe-A: SUCCESS (0.562s)
[96.411143] Starting dynamic subtest: pipe-B
[97.032479] Dynamic subtest pipe-B: SUCCESS (0.632s)
[97.042745] Starting dynamic subtest: pipe-C
[97.662389] Dynamic subtest pipe-C: SUCCESS (0.629s)
[97.679706] Starting dynamic subtest: pipe-D
[98.308700] Dynamic subtest pipe-D: SUCCESS (0.646s)
[98.309853] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.471s)
[98.671324] [036/131] (925s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[98.872309] Starting subtest: x-tiled-8bpp-rotate-270
[98.924196] Subtest x-tiled-8bpp-rotate-270: SKIP (0.051s)
[99.133302] [037/131] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[99.322333] Starting subtest: bo-too-small-due-to-tiling
[99.324161] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[99.525527] [038/131] (924s left) gem_workarounds (basic-read-context)
[99.621754] Starting subtest: basic-read-context
[99.664956] Subtest basic-read-context: SUCCESS (0.043s)
[99.829487] [039/131] (924s left) kms_flip (2x-blocking-wf_vblank)
[100.024134] Starting subtest: 2x-blocking-wf_vblank
[100.040112] Subtest 2x-blocking-wf_vblank: SKIP (0.015s)
[100.188707] [040/131] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[100.386709] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[100.388431] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[100.572725] [041/131] (923s left) gem_mmap_gtt (basic-write-read)
[100.651135] Subtest basic-write-read: SKIP (0.000s)
[100.740809] [042/131] (923s left) prime_vgem (fence-wait)
[100.848242] Starting subtest: fence-wait
[100.849530] Starting dynamic subtest: rcs0
[101.928198] Dynamic subtest rcs0: SUCCESS (1.079s)
[101.937932] Starting dynamic subtest: bcs0
[103.026929] Dynamic subtest bcs0: SUCCESS (1.096s)
[103.037200] Starting dynamic subtest: vcs0
[104.075911] Dynamic subtest vcs0: SUCCESS (1.047s)
[104.084768] Starting dynamic subtest: vcs1
[105.120107] Dynamic subtest vcs1: SUCCESS (1.043s)
[105.136635] Starting dynamic subtest: vecs0
[106.163666] Dynamic subtest vecs0: SUCCESS (1.041s)
[106.176663] Starting dynamic subtest: vecs1
[107.208196] Dynamic subtest vecs1: SUCCESS (1.042s)
[107.222012] Starting dynamic subtest: ccs0
[108.251878] Dynamic subtest ccs0: SUCCESS (1.041s)
[108.254119] Subtest fence-wait: SUCCESS (7.403s)
[108.423869] [043/131] (915s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[108.619570] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[108.621264] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[108.826361] [044/131] (915s left) kms_flip (2x-nonexisting-fb)
[109.014054] Starting subtest: 2x-nonexisting-fb
[109.029981] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[109.199063] [045/131] (915s left) perf_pmu (busy-idle)
[109.272469] Starting subtest: busy-idle
[109.273458] Starting dynamic subtest: rcs0
[110.005584] Dynamic subtest rcs0: SUCCESS (0.732s)
[110.043080] Starting dynamic subtest: bcs0
[110.690646] Dynamic subtest bcs0: SUCCESS (0.683s)
[110.730303] Starting dynamic subtest: vcs0
[111.380120] Dynamic subtest vcs0: SUCCESS (0.687s)
[111.393567] Starting dynamic subtest: vcs1
[112.045690] Dynamic subtest vcs1: SUCCESS (0.663s)
[112.059569] Starting dynamic subtest: vecs0
[112.712183] Dynamic subtest vecs0: SUCCESS (0.664s)
[112.725817] Starting dynamic subtest: vecs1
[113.374671] Dynamic subtest vecs1: SUCCESS (0.660s)
[113.388819] Starting dynamic subtest: ccs0
[114.046391] Dynamic subtest ccs0: SUCCESS (0.670s)
[114.048281] Subtest busy-idle: SUCCESS (4.774s)
[114.246686] [046/131] (910s left) kms_rotation_crc (primary-rotation-90)
[114.438608] Starting subtest: primary-rotation-90
[114.441479] Subtest primary-rotation-90: SKIP (0.001s)
[114.611807] [047/131] (909s left) dmabuf_sync_file (export-wait-after-attach)
[114.675365] Starting subtest: export-wait-after-attach
[114.676333] Subtest export-wait-after-attach: SUCCESS (0.001s)
[114.806333] [048/131] (909s left) kms_dirtyfb (default-dirtyfb-ioctl)
[114.991980] Starting subtest: default-dirtyfb-ioctl
[114.992949] Starting dynamic subtest: A-DP-3
[116.465034] Dynamic subtest A-DP-3: SUCCESS (1.472s)
[116.465882] Subtest default-dirtyfb-ioctl: SUCCESS (1.473s)
[116.775390] [049/131] (907s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[116.974805] Starting subtest: psr-rgb101010-draw-blt
[116.976510] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[117.148137] [050/131] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[117.344743] Starting subtest: addfb25-y-tiled-legacy
[117.345622] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[117.537260] [051/131] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[117.733780] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[121.924813] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.191s)
[122.124733] [052/131] (902s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[122.315158] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[122.316106] Starting dynamic subtest: pipe-A-DP-3
[122.319548] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[122.329396] Starting dynamic subtest: pipe-B-DP-3
[122.333053] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[122.342637] Starting dynamic subtest: pipe-C-DP-3
[122.346157] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[122.355893] Starting dynamic subtest: pipe-D-DP-3
[122.359296] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[122.361040] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[122.781686] [053/131] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[122.980011] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[122.981818] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[123.183046] [054/131] (901s left) kms_psr (fbc-pr-cursor-render)
[123.376439] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[123.441694] [055/131] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[123.640766] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[123.642515] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[123.828237] [056/131] (901s left) kms_busy (basic-hang)
[124.030643] Starting subtest: basic-hang
[124.032629] Starting dynamic subtest: flip-pipe-A
[124.643466] Dynamic subtest flip-pipe-A: SUCCESS (0.611s)
[124.661651] Starting dynamic subtest: modeset-pipe-A
[125.626041] Dynamic subtest modeset-pipe-A: SUCCESS (0.981s)
[125.643852] Starting dynamic subtest: flip-pipe-D
[126.105101] Dynamic subtest flip-pipe-D: SUCCESS (0.475s)
[126.118368] Starting dynamic subtest: modeset-pipe-D
[127.001200] Dynamic subtest modeset-pipe-D: SUCCESS (0.895s)
[127.002124] Subtest basic-hang: SUCCESS (2.971s)
[127.278299] [057/131] (897s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[127.360271] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[127.361188] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[127.555757] [058/131] (897s left) gem_userptr_blits (input-checking)
[127.645428] Starting subtest: input-checking
[127.646342] Subtest input-checking: SUCCESS (0.000s)
[127.857064] [059/131] (897s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[128.370124] Starting subtest: cursor-rapid-movement-512x170
[128.373168] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[128.628148] [060/131] (896s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[128.829476] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[128.831320] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[129.025883] [061/131] (896s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[129.219162] Starting subtest: flip-vs-cursor-varying-size
[141.533211] Subtest flip-vs-cursor-varying-size: SUCCESS (12.314s)
[141.857636] [062/131] (883s left) gem_exec_basic (basic)
[141.943979] Starting subtest: basic
[141.944958] Starting dynamic subtest: rcs0-smem
[141.947349] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[141.958146] Starting dynamic subtest: bcs0-smem
[141.959099] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[141.969537] Starting dynamic subtest: vcs0-smem
[141.970797] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[141.980786] Starting dynamic subtest: vcs1-smem
[141.982031] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[141.991628] Starting dynamic subtest: vecs0-smem
[141.992793] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[142.002420] Starting dynamic subtest: vecs1-smem
[142.003551] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[142.013086] Starting dynamic subtest: ccs0-smem
[142.014369] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[142.024040] Starting dynamic subtest: rcs0-lmem0
[142.025173] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[142.034874] Starting dynamic subtest: bcs0-lmem0
[142.035895] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[142.045533] Starting dynamic subtest: vcs0-lmem0
[142.046635] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[142.056281] Starting dynamic subtest: vcs1-lmem0
[142.057414] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[142.067195] Starting dynamic subtest: vecs0-lmem0
[142.068170] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[142.078421] Starting dynamic subtest: vecs1-lmem0
[142.079465] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[142.089653] Starting dynamic subtest: ccs0-lmem0
[142.090876] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[142.091912] Subtest basic: SUCCESS (0.018s)
[142.184987] [063/131] (883s left) kms_psr (fbc-psr-cursor-plane-onoff)
[142.378525] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[142.437700] [064/131] (883s left) gem_spin_batch (spin-all)
[142.528787] Starting subtest: spin-all
[142.581381] Subtest spin-all: SUCCESS (0.053s)
[142.924663] [065/131] (882s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[143.116185] Starting subtest: 2x-long-cursor-vs-flip-atomic
[143.119166] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[143.245777] [066/131] (882s left) kms_psr (psr2-cursor-mmap-cpu)
[143.432802] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[143.488920] [067/131] (882s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[143.679079] Starting subtest: plane-downscale-factor-0-5-with-rotation
[143.679933] Starting dynamic subtest: pipe-A
[144.043254] Dynamic subtest pipe-A: SUCCESS (0.365s)
[144.059056] Starting dynamic subtest: pipe-B
[144.524548] Dynamic subtest pipe-B: SUCCESS (0.480s)
[144.544537] Starting dynamic subtest: pipe-C
[145.005581] Dynamic subtest pipe-C: SUCCESS (0.480s)
[145.020623] Starting dynamic subtest: pipe-D
[145.470492] Dynamic subtest pipe-D: SUCCESS (0.464s)
[145.471453] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.793s)
[145.802108] [068/131] (880s left) kms_atomic (plane-invalid-params-fence)
[145.996212] Starting subtest: plane-invalid-params-fence
[145.997162] Starting dynamic subtest: pipe-A-DP-3
[146.559089] Dynamic subtest pipe-A-DP-3: SUCCESS (0.562s)
[146.560026] Subtest plane-invalid-params-fence: SUCCESS (0.564s)
[146.877459] [069/131] (879s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[147.079048] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[147.080876] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[147.289798] [070/131] (878s left) prime_vgem (coherency-gtt)
[147.399231] Starting subtest: coherency-gtt
[147.401320] Subtest coherency-gtt: SKIP (0.000s)
[147.546275] [071/131] (878s left) gem_exec_balancer (parallel)
[147.909427] Starting subtest: parallel
[149.628779] Subtest parallel: SUCCESS (1.719s)
[149.757516] [072/131] (876s left) gem_render_copy (linear-to-vebox-y-tiled)
[149.844013] Starting subtest: linear-to-vebox-y-tiled
[149.846266] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[150.115910] [073/131] (876s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[150.307203] Starting subtest: 2x-flip-vs-cursor-atomic
[150.309022] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[150.484981] [074/131] (876s left) gem_exec_reloc (basic-write-wc-active)
[150.572398] Subtest basic-write-wc-active: SKIP (0.000s)
[150.651863] [075/131] (875s left) i915_pm_rps (reset)
[150.743253] Starting subtest: reset
[155.547369] Subtest reset: SUCCESS (4.805s)
[155.741345] [076/131] (870s left) api_intel_bb (object-reloc-keep-cache)
[155.830621] Starting subtest: object-reloc-keep-cache
[155.835468] Subtest object-reloc-keep-cache: SKIP (0.004s)
[156.028778] [077/131] (870s left) gem_tiled_pread_pwrite
[156.186308] [078/131] (870s left) kms_plane_alpha_blend (alpha-7efc)
[156.373931] Starting subtest: alpha-7efc
[156.641950] Starting dynamic subtest: pipe-A-DP-3
[157.182268] Dynamic subtest pipe-A-DP-3: SUCCESS (0.540s)
[157.218962] Starting dynamic subtest: pipe-D-DP-3
[157.897947] Dynamic subtest pipe-D-DP-3: SUCCESS (0.689s)
[157.898901] Subtest alpha-7efc: SUCCESS (1.524s)
[158.212844] [079/131] (868s left) kms_prop_blob (blob-multiple)
[158.293308] Starting subtest: blob-multiple
[158.328274] Subtest blob-multiple: SUCCESS (0.034s)
[158.529956] [080/131] (868s left) gem_exec_reloc (basic-cpu-active)
[158.617202] Subtest basic-cpu-active: SKIP (0.000s)
[158.715318] [081/131] (868s left) gem_shrink (reclaim)
[158.801472] Starting subtest: reclaim
[161.060898] Subtest reclaim: SUCCESS (2.259s)
[161.319834] [082/131] (865s left) gem_gtt_cpu_tlb
[161.501611] [083/131] (865s left) kms_vblank (query-busy-hang)
[161.689549] Starting subtest: query-busy-hang
[161.691768] Starting dynamic subtest: pipe-A-DP-3
[188.555543] Dynamic subtest pipe-A-DP-3: SUCCESS (26.862s)
[188.568803] Starting dynamic subtest: pipe-D-DP-3
[213.549190] Dynamic subtest pipe-D-DP-3: SUCCESS (24.989s)
[213.550113] Subtest query-busy-hang: SUCCESS (51.858s)
[213.861502] [084/131] (813s left) kms_plane_multiple (tiling-4)
[214.051397] Starting subtest: tiling-4
[214.052317] Starting dynamic subtest: pipe-A-DP-3
[215.207080] Dynamic subtest pipe-A-DP-3: SUCCESS (1.155s)
[215.223791] Starting dynamic subtest: pipe-B-DP-3
[216.307250] Dynamic subtest pipe-B-DP-3: SUCCESS (1.098s)
[216.317981] Starting dynamic subtest: pipe-C-DP-3
[217.400205] Dynamic subtest pipe-C-DP-3: SUCCESS (1.091s)
[217.410767] Starting dynamic subtest: pipe-D-DP-3
[218.527491] Dynamic subtest pipe-D-DP-3: SUCCESS (1.126s)
[218.528437] Subtest tiling-4: SUCCESS (4.476s)
[218.868729] [085/131] (808s left) gem_userptr_blits (vma-merge)
[218.971366] Starting subtest: vma-merge
[219.057789] Subtest vma-merge: SUCCESS (0.086s)
[219.266929] [086/131] (808s left) syncobj_timeline (etime-single-wait-all-submitted)
[219.346435] Starting subtest: etime-single-wait-all-submitted
[219.462422] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[219.597578] [087/131] (807s left) kms_feature_discovery (display)
[219.788356] Starting subtest: display
[219.789277] Subtest display: SUCCESS (0.000s)
[219.915652] [088/131] (807s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[220.119384] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[220.121207] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[220.318955] [089/131] (807s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[220.404491] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[220.405466] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[220.567272] [090/131] (807s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[220.775924] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[220.825346] [091/131] (806s left) perf (invalid-remove-userspace-config)
[221.232272] Starting subtest: invalid-remove-userspace-config
[221.240997] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[221.295170] [092/131] (806s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[221.489485] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[221.490356] Starting dynamic subtest: pipe-A-valid-mode
[221.574137] Dynamic subtest pipe-A-valid-mode: SKIP (0.083s)
[221.576080] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.085s)
[221.841191] [093/131] (806s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[222.029479] Starting subtest: cursorA-vs-flipA-toggle
[232.973180] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.943s)
[233.290992] [094/131] (794s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[233.478539] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[233.479433] Starting dynamic subtest: pipe-A-DP-3
[233.487994] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[233.498500] Starting dynamic subtest: pipe-B-DP-3
[233.507226] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[233.517515] Starting dynamic subtest: pipe-C-DP-3
[233.526054] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[233.536139] Starting dynamic subtest: pipe-D-DP-3
[233.546128] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[233.548049] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[233.992790] [095/131] (794s left) kms_flip (dpms-vs-vblank-race-interruptible)
[234.189192] Starting subtest: dpms-vs-vblank-race-interruptible
[234.194455] Starting dynamic subtest: A-DP3
[237.445144] Dynamic subtest A-DP3: SUCCESS (3.249s)
[237.458800] Starting dynamic subtest: B-DP3
[240.493927] Dynamic subtest B-DP3: SUCCESS (3.048s)
[240.505977] Starting dynamic subtest: C-DP3
[243.538414] Dynamic subtest C-DP3: SUCCESS (3.043s)
[243.551422] Starting dynamic subtest: D-DP3
[246.580414] Dynamic subtest D-DP3: SUCCESS (3.040s)
[246.582946] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.393s)
[246.922255] [096/131] (781s left) gem_exec_flush (basic-uc-rw-default)
[247.017660] Subtest basic-uc-rw-default: SKIP (0.000s)
[247.123551] [097/131] (781s left) gem_eio (reset-stress)
[247.433429] Starting subtest: reset-stress
[247.434450] Starting dynamic subtest: render
[254.525289] Dynamic subtest render: SUCCESS (7.091s)
[254.535487] Starting dynamic subtest: bsd1
[261.733076] Dynamic subtest bsd1: SUCCESS (7.206s)
[261.744203] Starting dynamic subtest: bsd2
[268.827911] Dynamic subtest bsd2: SUCCESS (7.093s)
[268.840351] Starting dynamic subtest: blt
[275.996517] Dynamic subtest blt: SUCCESS (7.168s)
[276.007496] Starting dynamic subtest: vebox
[283.148305] Dynamic subtest vebox: SUCCESS (7.151s)
[283.149271] Subtest reset-stress: SUCCESS (35.716s)
[283.486135] [098/131] (744s left) kms_content_protection (lic-type-0)
[283.749417] Starting subtest: lic-type-0
[283.783873] Starting dynamic subtest: pipe-A-DP-3
[406.243252] Dynamic subtest pipe-A-DP-3: FAIL (122.300s)
[406.244063] Subtest lic-type-0: FAIL (122.412s)
[406.422351] [099/131] (622s left) syncobj_timeline (invalid-signal-illegal-point)
[406.502400] Starting subtest: invalid-signal-illegal-point
[406.503335] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[406.643526] [100/131] (621s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[406.726224] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[406.798592] [101/131] (621s left) gem_exec_schedule (pi-common)
[407.018467] Starting subtest: pi-common
[407.019428] Starting dynamic subtest: rcs0
[407.049752] Dynamic subtest rcs0: SUCCESS (0.031s)
[407.061996] Starting dynamic subtest: bcs0
[407.081221] Dynamic subtest bcs0: SUCCESS (0.030s)
[407.093712] Starting dynamic subtest: vcs0
[407.112498] Dynamic subtest vcs0: SUCCESS (0.030s)
[407.125134] Starting dynamic subtest: vcs1
[407.143354] Dynamic subtest vcs1: SUCCESS (0.030s)
[407.156016] Starting dynamic subtest: vecs0
[407.174982] Dynamic subtest vecs0: SUCCESS (0.030s)
[407.187287] Starting dynamic subtest: vecs1
[407.207464] Dynamic subtest vecs1: SUCCESS (0.031s)
[407.220015] Starting dynamic subtest: ccs0
[407.239171] Dynamic subtest ccs0: SUCCESS (0.031s)
[407.240201] Subtest pi-common: SUCCESS (0.221s)
[407.576285] [102/131] (621s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[407.770478] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[407.771432] Starting dynamic subtest: pipe-A-DP-3
[407.801098] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[407.811558] Starting dynamic subtest: pipe-B-DP-3
[407.833441] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[407.843943] Starting dynamic subtest: pipe-C-DP-3
[407.870897] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[407.881817] Starting dynamic subtest: pipe-D-DP-3
[407.907523] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[407.909525] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.015s)
[408.249524] [103/131] (620s left) kms_vblank (wait-forked-hang)
[408.437584] Starting subtest: wait-forked-hang
[408.439964] Starting dynamic subtest: pipe-A-DP-3
[434.574435] Dynamic subtest pipe-A-DP-3: SUCCESS (26.135s)
[434.588180] Starting dynamic subtest: pipe-D-DP-3
[459.567686] Dynamic subtest pipe-D-DP-3: SUCCESS (24.989s)
[459.570241] Subtest wait-forked-hang: SUCCESS (51.131s)
[459.901780] [104/131] (568s left) gem_exec_whisper (basic-normal)
[459.998978] Starting subtest: basic-normal
[463.613438] Subtest basic-normal: SUCCESS (3.613s)
[463.865978] [105/131] (565s left) syncobj_wait (reset-signaled)
[463.947585] Starting subtest: reset-signaled
[463.948494] Subtest reset-signaled: SUCCESS (0.000s)
[464.134452] [106/131] (564s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[464.331333] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[464.333121] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[464.533899] [107/131] (564s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[464.622376] Starting subtest: y-tiled-to-vebox-yf-tiled
[464.624389] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[464.933655] [108/131] (564s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[465.131450] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[466.204483] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.074s)
[466.531010] [109/131] (562s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[466.806419] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[466.964391] [110/131] (562s left) gem_cs_tlb (engines)
[467.059381] Starting subtest: engines
[467.060391] Starting dynamic subtest: rcs0
[469.216206] Dynamic subtest rcs0: SUCCESS (2.155s)
[469.227042] Starting dynamic subtest: bcs0
[471.369591] Dynamic subtest bcs0: SUCCESS (2.152s)
[471.381154] Starting dynamic subtest: vcs0
[473.523759] Dynamic subtest vcs0: SUCCESS (2.153s)
[473.534649] Starting dynamic subtest: vcs1
[475.677621] Dynamic subtest vcs1: SUCCESS (2.153s)
[475.688459] Starting dynamic subtest: vecs0
[477.831050] Dynamic subtest vecs0: SUCCESS (2.152s)
[477.842013] Starting dynamic subtest: vecs1
[479.985564] Dynamic subtest vecs1: SUCCESS (2.154s)
[479.996374] Starting dynamic subtest: ccs0
[482.138530] Dynamic subtest ccs0: SUCCESS (2.152s)
[482.139426] Subtest engines: SUCCESS (15.079s)
[482.301266] [111/131] (547s left) gem_eio (in-flight-internal-1us)
[482.651390] Starting subtest: in-flight-internal-1us
[483.907948] Subtest in-flight-internal-1us: SUCCESS (1.258s)
[484.172482] [112/131] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[484.365522] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[484.367249] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[484.554553] [113/131] (544s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[484.752310] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[484.754104] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[484.954646] [114/131] (544s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[485.154574] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[485.156308] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[485.320541] [115/131] (544s left) api_intel_allocator (alloc-simple)
[485.400367] Starting subtest: alloc-simple
[485.431972] Subtest alloc-simple: SUCCESS (0.031s)
[485.656141] [116/131] (544s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[485.847405] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[485.848321] Starting dynamic subtest: pipe-A-DP-3
[485.857896] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[485.868467] Starting dynamic subtest: pipe-B-DP-3
[485.877950] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[485.888441] Starting dynamic subtest: pipe-C-DP-3
[485.897811] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[485.908572] Starting dynamic subtest: pipe-D-DP-3
[485.920409] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[485.922375] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[486.320857] [117/131] (543s left) gem_exec_fence (invalid-fence-array)
[486.839554] Starting subtest: invalid-fence-array
[486.842621] Subtest invalid-fence-array: SUCCESS (0.003s)
[487.299239] [118/131] (542s left) kms_frontbuffer_tracking (fbc-tiling-y)
[487.496083] Starting subtest: fbc-tiling-y
[487.497882] Subtest fbc-tiling-y: SKIP (0.000s)
[487.683390] [119/131] (542s left) gem_exec_reloc (basic-wc-cpu-active)
[487.770130] Subtest basic-wc-cpu-active: SKIP (0.000s)
[487.871736] [120/131] (542s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[488.070505] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[488.128051] [121/131] (541s left) perf_pmu (render-node-busy)
[488.242797] Starting subtest: render-node-busy
[488.243751] Starting dynamic subtest: rcs0
[488.838160] Dynamic subtest rcs0: SUCCESS (0.594s)
[488.853234] Starting dynamic subtest: bcs0
[489.406583] Dynamic subtest bcs0: SUCCESS (0.564s)
[489.427224] Starting dynamic subtest: vcs0
[489.970558] Dynamic subtest vcs0: SUCCESS (0.562s)
[489.985272] Starting dynamic subtest: vcs1
[490.529506] Dynamic subtest vcs1: SUCCESS (0.557s)
[490.544438] Starting dynamic subtest: vecs0
[491.087503] Dynamic subtest vecs0: SUCCESS (0.556s)
[491.102238] Starting dynamic subtest: vecs1
[491.647940] Dynamic subtest vecs1: SUCCESS (0.558s)
[491.663098] Starting dynamic subtest: ccs0
[492.209953] Dynamic subtest ccs0: SUCCESS (0.557s)
[492.215167] Subtest render-node-busy: SUCCESS (3.969s)
[492.367147] [122/131] (537s left) gem_exec_reloc (basic-active)
[492.452038] Subtest basic-active: SKIP (0.000s)
[492.528937] [123/131] (537s left) gem_lmem_swapping (parallel-random-engines)
[495.349838] Starting subtest: parallel-random-engines
[495.351848] Starting dynamic subtest: lmem0
[540.666298] Dynamic subtest lmem0: SUCCESS (45.317s)
[540.667347] Subtest parallel-random-engines: SUCCESS (45.318s)
[541.884718] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[541.885861] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[541.888181] [124/131] (488s left) gem_lmem_swapping (parallel-random)
[543.496962] Starting subtest: parallel-random
[543.497952] Starting dynamic subtest: lmem0
[588.811788] Dynamic subtest lmem0: SUCCESS (45.315s)
[588.812773] Subtest parallel-random: SUCCESS (45.316s)
[590.066752] [125/131] (440s left) i915_fb_tiling (basic-x-tiling)
[591.692506] Subtest basic-x-tiling: SKIP (0.000s)
[591.762008] [FACT i915_fb_tiling (basic-x-tiling)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[591.764478] [FACT i915_fb_tiling (basic-x-tiling)] new: kernel.kmod_is_loaded.i915: true
[591.767223] [126/131] (438s left) gem_eio (context-create)
[592.023436] Starting subtest: context-create
[592.383460] Subtest context-create: SUCCESS (0.360s)
[592.654193] [127/131] (437s left) gem_mmap_offset (bad-object)
[592.737690] Starting subtest: bad-object
[592.738598] Subtest bad-object: SUCCESS (0.000s)
[592.946960] [128/131] (437s left) kms_scaling_modes (scaling-mode-full-aspect)
[593.137653] Starting subtest: scaling-mode-full-aspect
[593.142790] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[593.277932] [129/131] (437s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[593.482131] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[593.483930] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[593.635848] [130/131] (437s left) i915_suspend (forcewake)
[593.733643] Starting subtest: forcewake
[632.607998] Subtest forcewake: SUCCESS (7.336s)
[632.746309] [131/131] (397s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[632.948224] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[635.777974] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.831s)
[636.045395] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_chamelium_edid
results: parsing output: 5/ for test: vgem_basic
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_lease
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_pm_lpsp
results: parsing output: 16/ for test: gen9_exec_parse
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gem_mmap_wc
results: parsing output: 19/ for test: gem_ctx_isolation
results: parsing output: 20/ for test: gem_bad_reloc
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_feature_discovery
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: gen9_exec_parse
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: syncobj_eventfd
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_ccs
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: gem_workarounds
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: dmabuf_sync_file
results: parsing output: 47/ for test: kms_dirtyfb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_busy
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_exec_basic
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_atomic
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: i915_pm_rps
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: gem_tiled_pread_pwrite
results: parsing output: 77/ for test: kms_plane_alpha_blend
results: parsing output: 78/ for test: kms_prop_blob
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_shrink
results: parsing output: 81/ for test: gem_gtt_cpu_tlb
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: kms_plane_multiple
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_feature_discovery
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_pipe_b_c_ivb
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: gem_cs_tlb
results: parsing output: 110/ for test: gem_eio
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: api_intel_allocator
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_lmem_swapping
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: i915_fb_tiling
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: kms_scaling_modes
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: i915_suspend
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.