[60.332547] Initializing watchdogs
[60.332612]   /dev/watchdog0
[60.351839] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.362331] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.366293] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.368704] [001/131] (960s left) kms_big_fb (linear-32bpp-rotate-270)
[60.568552] Starting subtest: linear-32bpp-rotate-270
[60.636462] Subtest linear-32bpp-rotate-270: SKIP (0.067s)
[60.833609] [002/131] (960s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[61.013780] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[61.014639] Starting dynamic subtest: pipe-A-valid-mode
[63.575967] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.552s)
[63.577635] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SUCCESS (2.554s)
[63.908574] [003/131] (957s left) kms_cursor_edge_walk (256x256-top-bottom)
[64.084953] Starting subtest: 256x256-top-bottom
[64.085815] Starting dynamic subtest: pipe-A-DP-3
[67.549499] Dynamic subtest pipe-A-DP-3: SUCCESS (3.457s)
[67.559008] Starting dynamic subtest: pipe-D-DP-3
[70.849299] Dynamic subtest pipe-D-DP-3: SUCCESS (3.295s)
[70.850260] Subtest 256x256-top-bottom: SUCCESS (6.755s)
[71.156948] [004/131] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[71.339233] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[71.340913] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.522323] [005/131] (949s left) kms_chamelium_edid (dp-edid-resolution-list)
[71.798167] Subtest dp-edid-resolution-list: SKIP (0.000s)
[71.941403] [006/131] (949s left) vgem_basic (bad-flag)
[72.027365] Starting subtest: bad-flag
[72.028438] Subtest bad-flag: SUCCESS (0.000s)
[72.184761] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true
[72.186468] [007/131] (949s left) kms_cursor_crc (cursor-onscreen-256x256)
[72.600227] Starting subtest: cursor-onscreen-256x256
[72.603974] Starting dynamic subtest: pipe-A-DP-3
[75.187194] Dynamic subtest pipe-A-DP-3: SUCCESS (2.581s)
[75.231969] Starting dynamic subtest: pipe-D-DP-3
[77.645451] Dynamic subtest pipe-D-DP-3: SUCCESS (2.420s)
[77.646388] Subtest cursor-onscreen-256x256: SUCCESS (5.043s)
[78.102675] [008/131] (943s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[78.303574] Starting subtest: 4-tiled-32bpp-rotate-0
[80.032760] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.729s)
[80.276279] [009/131] (941s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[80.464055] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[80.464908] Starting dynamic subtest: pipe-A-DP-3
[80.473051] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[80.481244] Starting dynamic subtest: pipe-B-DP-3
[80.489565] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[80.497551] Starting dynamic subtest: pipe-C-DP-3
[80.505708] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[80.513454] Starting dynamic subtest: pipe-D-DP-3
[80.522471] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[80.524511] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[80.935152] [010/131] (940s left) gem_ctx_persistence (heartbeat-close)
[81.027792] Starting subtest: heartbeat-close
[81.029761] Subtest heartbeat-close: SKIP (0.000s)
[81.235244] [011/131] (940s left) gem_exec_reloc (basic-write-read-noreloc)
[81.319407] Subtest basic-write-read-noreloc: SKIP (0.000s)
[81.397375] [012/131] (940s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[81.472069] Starting subtest: wait-all-for-submit-delayed-submit
[81.576277] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[81.708792] [013/131] (940s left) kms_psr (fbc-pr-suspend)
[81.907383] Subtest fbc-pr-suspend: SKIP (0.000s)
[81.963093] [014/131] (939s left) kms_lease (lease-invalid-crtc)
[82.147900] Starting subtest: lease-invalid-crtc
[82.148784] Starting dynamic subtest: pipe-A-DP-3
[82.149625] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[82.157728] Starting dynamic subtest: pipe-B-DP-3
[82.158552] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[82.166753] Starting dynamic subtest: pipe-C-DP-3
[82.167861] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[82.176901] Starting dynamic subtest: pipe-D-DP-3
[82.178102] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[82.179165] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[82.290533] [015/131] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[82.478242] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[82.479956] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[82.677465] [016/131] (939s left) kms_pm_lpsp (screens-disabled)
[83.893850] Starting subtest: screens-disabled
[83.895514] Subtest screens-disabled: SKIP (0.000s)
[84.051513] [017/131] (937s left) gen9_exec_parse (unaligned-access)
[84.133264] Subtest unaligned-access: SKIP (0.000s)
[84.194975] [018/131] (937s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[84.378595] Starting subtest: cursorA-vs-flipB-atomic-transitions
[84.381275] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[84.537538] [019/131] (937s left) gem_mmap_wc (bad-offset)
[84.613842] Subtest bad-offset: SKIP (0.000s)
[84.678227] [020/131] (937s left) gem_ctx_isolation (preservation-reset)
[84.874421] Starting subtest: preservation-reset
[84.875329] Starting dynamic subtest: rcs0
[85.461364] Dynamic subtest rcs0: SUCCESS (0.587s)
[85.470465] Starting dynamic subtest: bcs0
[86.092068] Dynamic subtest bcs0: SUCCESS (0.631s)
[86.100741] Starting dynamic subtest: vcs0
[86.711984] Dynamic subtest vcs0: SUCCESS (0.620s)
[86.720554] Starting dynamic subtest: vcs1
[87.314606] Dynamic subtest vcs1: SUCCESS (0.603s)
[87.323444] Starting dynamic subtest: vecs0
[87.917535] Dynamic subtest vecs0: SUCCESS (0.603s)
[87.926123] Starting dynamic subtest: vecs1
[88.530494] Dynamic subtest vecs1: SUCCESS (0.605s)
[88.539119] Starting dynamic subtest: ccs0
[89.119546] Dynamic subtest ccs0: SUCCESS (0.597s)
[89.120431] Subtest preservation-reset: SUCCESS (4.247s)
[89.395715] [021/131] (932s left) gem_bad_reloc (negative-reloc-bltcopy)
[89.479471] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[89.577956] [022/131] (932s left) syncobj_wait (single-wait-for-submit-submitted)
[89.653129] Starting subtest: single-wait-for-submit-submitted
[89.759885] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[89.930245] [023/131] (932s left) gem_mmap_gtt (basic-small-copy)
[90.012064] Subtest basic-small-copy: SKIP (0.000s)
[90.085302] [024/131] (932s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[90.286465] Starting subtest: yf-tiled-16bpp-rotate-270
[90.288306] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[90.484201] [025/131] (932s left) kms_feature_discovery (display-4x)
[90.666396] Starting subtest: display-4x
[90.668160] Subtest display-4x: SKIP (0.000s)
[90.811960] [026/131] (931s left) gem_exec_reloc (basic-gtt-read-active)
[90.894322] Subtest basic-gtt-read-active: SKIP (0.000s)
[90.962379] [027/131] (931s left) gen9_exec_parse (allowed-all)
[91.042971] Subtest allowed-all: SKIP (0.000s)
[91.133212] [028/131] (931s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[91.321066] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[91.336456] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s)
[91.514948] [029/131] (931s left) kms_invalid_mode (bad-htotal)
[91.697498] Starting subtest: bad-htotal
[91.698407] Starting dynamic subtest: pipe-A-DP-3
[91.779933] Dynamic subtest pipe-A-DP-3: SUCCESS (0.081s)
[91.792353] Starting dynamic subtest: pipe-B-DP-3
[91.793556] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[91.805386] Starting dynamic subtest: pipe-C-DP-3
[91.806554] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[91.817826] Starting dynamic subtest: pipe-D-DP-3
[91.818776] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[91.819719] Subtest bad-htotal: SUCCESS (0.089s)
[92.061536] [030/131] (930s left) syncobj_eventfd (invalid-illegal-handle)
[92.139897] Starting subtest: invalid-illegal-handle
[92.140888] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[92.291864] [031/131] (930s left) gem_exec_schedule (thriceslice)
[92.386975] Starting subtest: thriceslice
[92.387872] Starting dynamic subtest: rcs0
[92.438107] Dynamic subtest rcs0: SUCCESS (0.052s)
[92.448874] Starting dynamic subtest: bcs0
[92.491863] Dynamic subtest bcs0: SUCCESS (0.053s)
[92.509571] Starting dynamic subtest: vcs0
[92.553107] Dynamic subtest vcs0: SUCCESS (0.060s)
[92.574991] Starting dynamic subtest: vcs1
[92.619471] Dynamic subtest vcs1: SUCCESS (0.066s)
[92.632025] Starting dynamic subtest: vecs0
[92.653761] Dynamic subtest vecs0: SUCCESS (0.034s)
[92.671632] Starting dynamic subtest: vecs1
[92.715088] Dynamic subtest vecs1: SUCCESS (0.060s)
[92.749193] Starting dynamic subtest: ccs0
[92.793189] Dynamic subtest ccs0: SUCCESS (0.077s)
[92.794728] Subtest thriceslice: SUCCESS (0.407s)
[93.226705] [032/131] (929s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[93.413296] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[93.414991] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[93.586033] [033/131] (929s left) kms_psr (psr2-sprite-blt)
[93.772403] Subtest psr2-sprite-blt: SKIP (0.000s)
[93.822790] [034/131] (929s left) gem_ccs (block-multicopy-compressed)
[93.912381] Starting subtest: block-multicopy-compressed
[93.913298] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[93.958031] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.045s)
[93.966778] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[94.054990] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.097s)
[94.063629] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[94.071440] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[94.080182] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[94.173367] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.102s)
[94.182123] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[94.190089] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[94.198756] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[94.291976] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.102s)
[94.300610] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[94.309352] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.017s)
[94.318061] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[94.416339] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.107s)
[94.417221] Subtest block-multicopy-compressed: SUCCESS (0.504s)
[94.609082] [035/131] (928s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[94.799909] Starting subtest: plane-upscale-20x20-with-modifiers
[94.800732] Starting dynamic subtest: pipe-A
[95.364549] Dynamic subtest pipe-A: SUCCESS (0.564s)
[95.381848] Starting dynamic subtest: pipe-B
[96.008932] Dynamic subtest pipe-B: SUCCESS (0.644s)
[96.017781] Starting dynamic subtest: pipe-C
[96.638554] Dynamic subtest pipe-C: SUCCESS (0.629s)
[96.658578] Starting dynamic subtest: pipe-D
[97.283345] Dynamic subtest pipe-D: SUCCESS (0.644s)
[97.284512] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.484s)
[97.662259] [036/131] (925s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[97.856168] Starting subtest: x-tiled-8bpp-rotate-270
[97.912632] Subtest x-tiled-8bpp-rotate-270: SKIP (0.056s)
[98.147360] [037/131] (925s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[98.331902] Starting subtest: bo-too-small-due-to-tiling
[98.333586] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[98.527055] [038/131] (924s left) gem_workarounds (basic-read-context)
[98.631170] Starting subtest: basic-read-context
[98.673466] Subtest basic-read-context: SUCCESS (0.042s)
[98.916653] [039/131] (924s left) kms_flip (2x-blocking-wf_vblank)
[99.098570] Starting subtest: 2x-blocking-wf_vblank
[99.113514] Subtest 2x-blocking-wf_vblank: SKIP (0.014s)
[99.284464] [040/131] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[99.471401] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[99.473148] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[99.661981] [041/131] (924s left) gem_mmap_gtt (basic-write-read)
[99.739041] Subtest basic-write-read: SKIP (0.000s)
[99.800738] [042/131] (923s left) prime_vgem (fence-wait)
[99.902208] Starting subtest: fence-wait
[99.903172] Starting dynamic subtest: rcs0
[101.000307] Dynamic subtest rcs0: SUCCESS (1.097s)
[101.010271] Starting dynamic subtest: bcs0
[102.088495] Dynamic subtest bcs0: SUCCESS (1.087s)
[102.097525] Starting dynamic subtest: vcs0
[103.138224] Dynamic subtest vcs0: SUCCESS (1.049s)
[103.147483] Starting dynamic subtest: vcs1
[104.182431] Dynamic subtest vcs1: SUCCESS (1.043s)
[104.195993] Starting dynamic subtest: vecs0
[105.226126] Dynamic subtest vecs0: SUCCESS (1.042s)
[105.240132] Starting dynamic subtest: vecs1
[106.269181] Dynamic subtest vecs1: SUCCESS (1.041s)
[106.282209] Starting dynamic subtest: ccs0
[107.312146] Dynamic subtest ccs0: SUCCESS (1.041s)
[107.314104] Subtest fence-wait: SUCCESS (7.411s)
[107.490828] [043/131] (916s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[107.679416] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[107.681120] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[107.879077] [044/131] (916s left) kms_flip (2x-nonexisting-fb)
[108.060145] Starting subtest: 2x-nonexisting-fb
[108.074986] Subtest 2x-nonexisting-fb: SKIP (0.014s)
[108.253074] [045/131] (915s left) perf_pmu (busy-idle)
[108.322573] Starting subtest: busy-idle
[108.323468] Starting dynamic subtest: rcs0
[109.054493] Dynamic subtest rcs0: SUCCESS (0.731s)
[109.068632] Starting dynamic subtest: bcs0
[109.720603] Dynamic subtest bcs0: SUCCESS (0.664s)
[109.732646] Starting dynamic subtest: vcs0
[110.383671] Dynamic subtest vcs0: SUCCESS (0.661s)
[110.397481] Starting dynamic subtest: vcs1
[111.050488] Dynamic subtest vcs1: SUCCESS (0.665s)
[111.064213] Starting dynamic subtest: vecs0
[111.716729] Dynamic subtest vecs0: SUCCESS (0.664s)
[111.731073] Starting dynamic subtest: vecs1
[112.379590] Dynamic subtest vecs1: SUCCESS (0.661s)
[112.394213] Starting dynamic subtest: ccs0
[113.050520] Dynamic subtest ccs0: SUCCESS (0.669s)
[113.052361] Subtest busy-idle: SUCCESS (4.728s)
[113.241687] [046/131] (910s left) kms_rotation_crc (primary-rotation-90)
[113.427512] Starting subtest: primary-rotation-90
[113.429228] Subtest primary-rotation-90: SKIP (0.001s)
[113.600808] [047/131] (910s left) dmabuf_sync_file (export-wait-after-attach)
[113.661614] Starting subtest: export-wait-after-attach
[113.662501] Subtest export-wait-after-attach: SUCCESS (0.001s)
[113.826373] [048/131] (910s left) kms_dirtyfb (default-dirtyfb-ioctl)
[114.013366] Starting subtest: default-dirtyfb-ioctl
[114.014270] Starting dynamic subtest: A-DP-3
[115.467405] Dynamic subtest A-DP-3: SUCCESS (1.453s)
[115.468234] Subtest default-dirtyfb-ioctl: SUCCESS (1.454s)
[115.728638] [049/131] (908s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[115.920237] Starting subtest: psr-rgb101010-draw-blt
[115.921909] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[116.112650] [050/131] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[116.306391] Starting subtest: addfb25-y-tiled-legacy
[116.307253] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[116.493057] [051/131] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[116.682441] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[121.132561] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.451s)
[121.381313] [052/131] (903s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[121.571986] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[121.574280] Starting dynamic subtest: pipe-A-DP-3
[121.577845] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[121.588399] Starting dynamic subtest: pipe-B-DP-3
[121.591888] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[121.601757] Starting dynamic subtest: pipe-C-DP-3
[121.605162] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[121.614952] Starting dynamic subtest: pipe-D-DP-3
[121.618210] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[121.619850] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[122.041727] [053/131] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[122.233437] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[122.235156] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[122.440777] [054/131] (902s left) kms_psr (fbc-pr-cursor-render)
[122.631574] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[122.683209] [055/131] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[122.869411] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[122.871131] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[123.074210] [056/131] (901s left) kms_busy (basic-hang)
[123.277015] Starting subtest: basic-hang
[123.277918] Starting dynamic subtest: flip-pipe-A
[123.903058] Dynamic subtest flip-pipe-A: SUCCESS (0.625s)
[123.921482] Starting dynamic subtest: modeset-pipe-A
[124.782937] Dynamic subtest modeset-pipe-A: SUCCESS (0.878s)
[124.802855] Starting dynamic subtest: flip-pipe-D
[125.269766] Dynamic subtest flip-pipe-D: SUCCESS (0.482s)
[125.280379] Starting dynamic subtest: modeset-pipe-D
[126.144287] Dynamic subtest modeset-pipe-D: SUCCESS (0.874s)
[126.145227] Subtest basic-hang: SUCCESS (2.868s)
[126.447785] [057/131] (898s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[126.528175] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[126.529165] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[126.732215] [058/131] (898s left) gem_userptr_blits (input-checking)
[126.818631] Starting subtest: input-checking
[126.819452] Subtest input-checking: SUCCESS (0.000s)
[127.047280] [059/131] (898s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[127.531229] Starting subtest: cursor-rapid-movement-512x170
[127.534168] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[127.813128] [060/131] (897s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[128.015018] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[128.016642] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[128.184728] [061/131] (897s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[128.371194] Starting subtest: flip-vs-cursor-varying-size
[140.255296] Subtest flip-vs-cursor-varying-size: SUCCESS (11.884s)
[140.545891] [062/131] (884s left) gem_exec_basic (basic)
[140.627473] Starting subtest: basic
[140.628395] Starting dynamic subtest: rcs0-smem
[140.630587] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[140.641205] Starting dynamic subtest: bcs0-smem
[140.642154] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[140.652341] Starting dynamic subtest: vcs0-smem
[140.653216] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[140.663205] Starting dynamic subtest: vcs1-smem
[140.664412] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[140.674381] Starting dynamic subtest: vecs0-smem
[140.675638] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[140.685323] Starting dynamic subtest: vecs1-smem
[140.686552] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[140.696235] Starting dynamic subtest: ccs0-smem
[140.697346] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[140.707195] Starting dynamic subtest: rcs0-lmem0
[140.708439] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[140.718329] Starting dynamic subtest: bcs0-lmem0
[140.719494] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[140.729487] Starting dynamic subtest: vcs0-lmem0
[140.730549] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[140.740349] Starting dynamic subtest: vcs1-lmem0
[140.741432] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[140.751387] Starting dynamic subtest: vecs0-lmem0
[140.752266] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[140.762463] Starting dynamic subtest: vecs1-lmem0
[140.763511] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[140.773780] Starting dynamic subtest: ccs0-lmem0
[140.774904] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[140.776156] Subtest basic: SUCCESS (0.018s)
[140.920775] [063/131] (884s left) kms_psr (fbc-psr-cursor-plane-onoff)
[141.107529] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[141.163433] [064/131] (884s left) gem_spin_batch (spin-all)
[141.256201] Starting subtest: spin-all
[141.303776] Subtest spin-all: SUCCESS (0.048s)
[141.603074] [065/131] (883s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[141.793122] Starting subtest: 2x-long-cursor-vs-flip-atomic
[141.795980] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[141.954144] [066/131] (883s left) kms_psr (psr2-cursor-mmap-cpu)
[142.141322] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[142.196195] [067/131] (883s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[142.384375] Starting subtest: plane-downscale-factor-0-5-with-rotation
[142.385193] Starting dynamic subtest: pipe-A
[142.753683] Dynamic subtest pipe-A: SUCCESS (0.369s)
[142.774619] Starting dynamic subtest: pipe-B
[143.233579] Dynamic subtest pipe-B: SUCCESS (0.479s)
[143.258173] Starting dynamic subtest: pipe-C
[143.712946] Dynamic subtest pipe-C: SUCCESS (0.478s)
[143.736078] Starting dynamic subtest: pipe-D
[144.190637] Dynamic subtest pipe-D: SUCCESS (0.476s)
[144.191788] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.807s)
[144.550648] [068/131] (881s left) kms_atomic (plane-invalid-params-fence)
[144.739135] Starting subtest: plane-invalid-params-fence
[144.739990] Starting dynamic subtest: pipe-A-DP-3
[145.298867] Dynamic subtest pipe-A-DP-3: SUCCESS (0.558s)
[145.300041] Subtest plane-invalid-params-fence: SUCCESS (0.560s)
[145.637985] [069/131] (880s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[145.828941] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[145.830666] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[146.038370] [070/131] (879s left) prime_vgem (coherency-gtt)
[146.142387] Starting subtest: coherency-gtt
[146.144415] Subtest coherency-gtt: SKIP (0.000s)
[146.291381] [071/131] (879s left) gem_exec_balancer (parallel)
[146.644898] Starting subtest: parallel
[148.248070] Subtest parallel: SUCCESS (1.603s)
[148.415726] [072/131] (877s left) gem_render_copy (linear-to-vebox-y-tiled)
[148.498454] Starting subtest: linear-to-vebox-y-tiled
[148.500585] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[148.778889] [073/131] (877s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[148.964119] Starting subtest: 2x-flip-vs-cursor-atomic
[148.965730] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[149.123858] [074/131] (877s left) gem_exec_reloc (basic-write-wc-active)
[149.208516] Subtest basic-write-wc-active: SKIP (0.000s)
[149.302897] [075/131] (876s left) i915_pm_rps (reset)
[149.397457] Starting subtest: reset
[154.215507] Subtest reset: SUCCESS (4.818s)
[154.424565] [076/131] (871s left) api_intel_bb (object-reloc-keep-cache)
[154.501378] Starting subtest: object-reloc-keep-cache
[154.503138] Subtest object-reloc-keep-cache: SKIP (0.002s)
[154.718813] [077/131] (871s left) gem_tiled_pread_pwrite
[154.894307] [078/131] (871s left) kms_plane_alpha_blend (alpha-7efc)
[155.077667] Starting subtest: alpha-7efc
[155.337175] Starting dynamic subtest: pipe-A-DP-3
[155.844295] Dynamic subtest pipe-A-DP-3: SUCCESS (0.507s)
[155.875175] Starting dynamic subtest: pipe-D-DP-3
[156.514253] Dynamic subtest pipe-D-DP-3: SUCCESS (0.649s)
[156.515155] Subtest alpha-7efc: SUCCESS (1.436s)
[156.851369] [079/131] (869s left) kms_prop_blob (blob-multiple)
[156.928227] Starting subtest: blob-multiple
[156.960325] Subtest blob-multiple: SUCCESS (0.032s)
[157.120352] [080/131] (869s left) gem_exec_reloc (basic-cpu-active)
[157.204362] Subtest basic-cpu-active: SKIP (0.000s)
[157.277575] [081/131] (869s left) gem_shrink (reclaim)
[157.364080] Starting subtest: reclaim
[159.624525] Subtest reclaim: SUCCESS (2.260s)
[159.875753] [082/131] (866s left) gem_gtt_cpu_tlb
[160.027035] [083/131] (866s left) kms_vblank (query-busy-hang)
[160.212189] Starting subtest: query-busy-hang
[160.213117] Starting dynamic subtest: pipe-A-DP-3
[186.559207] Dynamic subtest pipe-A-DP-3: SUCCESS (26.346s)
[186.572563] Starting dynamic subtest: pipe-D-DP-3
[211.580786] Dynamic subtest pipe-D-DP-3: SUCCESS (25.017s)
[211.581781] Subtest query-busy-hang: SUCCESS (51.370s)
[211.889576] [084/131] (815s left) kms_plane_multiple (tiling-4)
[212.074832] Starting subtest: tiling-4
[212.077181] Starting dynamic subtest: pipe-A-DP-3
[213.181940] Dynamic subtest pipe-A-DP-3: SUCCESS (1.105s)
[213.192724] Starting dynamic subtest: pipe-B-DP-3
[214.235914] Dynamic subtest pipe-B-DP-3: SUCCESS (1.053s)
[214.249380] Starting dynamic subtest: pipe-C-DP-3
[215.271653] Dynamic subtest pipe-C-DP-3: SUCCESS (1.034s)
[215.283731] Starting dynamic subtest: pipe-D-DP-3
[216.321899] Dynamic subtest pipe-D-DP-3: SUCCESS (1.048s)
[216.322787] Subtest tiling-4: SUCCESS (4.247s)
[216.654897] [085/131] (810s left) gem_userptr_blits (vma-merge)
[216.765899] Starting subtest: vma-merge
[216.845588] Subtest vma-merge: SUCCESS (0.080s)
[217.071554] [086/131] (809s left) syncobj_timeline (etime-single-wait-all-submitted)
[217.147464] Starting subtest: etime-single-wait-all-submitted
[217.260287] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[217.400790] [087/131] (809s left) kms_feature_discovery (display)
[217.584941] Starting subtest: display
[217.585892] Subtest display: SUCCESS (0.000s)
[217.764140] [088/131] (809s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[217.959197] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[217.960985] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[218.158551] [089/131] (809s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[218.238440] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[218.239350] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[218.406206] [090/131] (808s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[218.599171] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[218.647105] [091/131] (808s left) perf (invalid-remove-userspace-config)
[219.041962] Starting subtest: invalid-remove-userspace-config
[219.050712] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[219.100092] [092/131] (808s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[219.283288] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[219.284194] Starting dynamic subtest: pipe-A-valid-mode
[219.364981] Dynamic subtest pipe-A-valid-mode: SKIP (0.080s)
[219.366619] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.082s)
[219.613477] [093/131] (807s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[219.793429] Starting subtest: cursorA-vs-flipA-toggle
[230.745995] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.951s)
[231.075738] [094/131] (796s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[231.263750] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[231.266176] Starting dynamic subtest: pipe-A-DP-3
[231.274184] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[231.284750] Starting dynamic subtest: pipe-B-DP-3
[231.292899] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[231.303182] Starting dynamic subtest: pipe-C-DP-3
[231.310966] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[231.321361] Starting dynamic subtest: pipe-D-DP-3
[231.331749] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[231.333856] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[231.746158] [095/131] (795s left) kms_flip (dpms-vs-vblank-race-interruptible)
[231.933279] Starting subtest: dpms-vs-vblank-race-interruptible
[231.938130] Starting dynamic subtest: A-DP3
[235.133065] Dynamic subtest A-DP3: SUCCESS (3.194s)
[235.156276] Starting dynamic subtest: B-DP3
[238.122494] Dynamic subtest B-DP3: SUCCESS (2.986s)
[238.136342] Starting dynamic subtest: C-DP3
[241.105846] Dynamic subtest C-DP3: SUCCESS (2.983s)
[241.117375] Starting dynamic subtest: D-DP3
[244.247918] Dynamic subtest D-DP3: SUCCESS (3.141s)
[244.250206] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.316s)
[244.554792] [096/131] (783s left) gem_exec_flush (basic-uc-rw-default)
[244.641229] Subtest basic-uc-rw-default: SKIP (0.000s)
[244.728440] [097/131] (783s left) gem_eio (reset-stress)
[245.057115] Starting subtest: reset-stress
[245.058103] Starting dynamic subtest: render
[252.087417] Dynamic subtest render: SUCCESS (7.030s)
[252.098381] Starting dynamic subtest: bsd1
[259.172219] Dynamic subtest bsd1: SUCCESS (7.084s)
[259.183189] Starting dynamic subtest: bsd2
[266.227694] Dynamic subtest bsd2: SUCCESS (7.054s)
[266.239041] Starting dynamic subtest: blt
[273.242731] Dynamic subtest blt: SUCCESS (7.014s)
[273.254161] Starting dynamic subtest: vebox
[280.301875] Dynamic subtest vebox: SUCCESS (7.058s)
[280.302616] Subtest reset-stress: SUCCESS (35.247s)
[280.635481] [098/131] (747s left) kms_content_protection (lic-type-0)
[280.895199] Starting subtest: lic-type-0
[280.918770] Starting dynamic subtest: pipe-A-DP-3
[402.438375] Dynamic subtest pipe-A-DP-3: FAIL (121.339s)
[402.439271] Subtest lic-type-0: FAIL (121.454s)
[402.669391] [099/131] (625s left) syncobj_timeline (invalid-signal-illegal-point)
[402.746352] Starting subtest: invalid-signal-illegal-point
[402.747274] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[402.965931] [100/131] (625s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[403.041420] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[403.109787] [101/131] (625s left) gem_exec_schedule (pi-common)
[403.316375] Starting subtest: pi-common
[403.317328] Starting dynamic subtest: rcs0
[403.349485] Dynamic subtest rcs0: SUCCESS (0.033s)
[403.362816] Starting dynamic subtest: bcs0
[403.380860] Dynamic subtest bcs0: SUCCESS (0.030s)
[403.393430] Starting dynamic subtest: vcs0
[403.411475] Dynamic subtest vcs0: SUCCESS (0.030s)
[403.424059] Starting dynamic subtest: vcs1
[403.441352] Dynamic subtest vcs1: SUCCESS (0.029s)
[403.454202] Starting dynamic subtest: vecs0
[403.471133] Dynamic subtest vecs0: SUCCESS (0.029s)
[403.483882] Starting dynamic subtest: vecs1
[403.500532] Dynamic subtest vecs1: SUCCESS (0.028s)
[403.513255] Starting dynamic subtest: ccs0
[403.531035] Dynamic subtest ccs0: SUCCESS (0.029s)
[403.531953] Subtest pi-common: SUCCESS (0.215s)
[403.802139] [102/131] (624s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[403.985286] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[403.986190] Starting dynamic subtest: pipe-A-DP-3
[404.007218] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[404.018057] Starting dynamic subtest: pipe-B-DP-3
[404.038915] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[404.049597] Starting dynamic subtest: pipe-C-DP-3
[404.070887] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[404.081739] Starting dynamic subtest: pipe-D-DP-3
[404.110049] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[404.111975] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.015s)
[404.460551] [103/131] (623s left) kms_vblank (wait-forked-hang)
[404.647277] Starting subtest: wait-forked-hang
[404.648191] Starting dynamic subtest: pipe-A-DP-3
[431.549418] Dynamic subtest pipe-A-DP-3: SUCCESS (26.902s)
[431.563655] Starting dynamic subtest: pipe-D-DP-3
[456.554078] Dynamic subtest pipe-D-DP-3: SUCCESS (25.001s)
[456.554993] Subtest wait-forked-hang: SUCCESS (51.909s)
[456.831136] [104/131] (571s left) gem_exec_whisper (basic-normal)
[456.920589] Starting subtest: basic-normal
[460.542425] Subtest basic-normal: SUCCESS (3.621s)
[460.796474] [105/131] (567s left) syncobj_wait (reset-signaled)
[460.872481] Starting subtest: reset-signaled
[460.873419] Subtest reset-signaled: SUCCESS (0.000s)
[461.077781] [106/131] (567s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[461.270074] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[461.271857] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[461.427614] [107/131] (567s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[461.511604] Starting subtest: y-tiled-to-vebox-yf-tiled
[461.513442] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[461.814439] [108/131] (566s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[462.001294] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[463.067716] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.067s)
[463.398575] [109/131] (565s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[463.654508] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[463.803018] [110/131] (565s left) gem_cs_tlb (engines)
[463.887191] Starting subtest: engines
[463.888131] Starting dynamic subtest: rcs0
[466.041948] Dynamic subtest rcs0: SUCCESS (2.153s)
[466.053265] Starting dynamic subtest: bcs0
[468.195559] Dynamic subtest bcs0: SUCCESS (2.153s)
[468.206589] Starting dynamic subtest: vcs0
[470.348885] Dynamic subtest vcs0: SUCCESS (2.152s)
[470.359940] Starting dynamic subtest: vcs1
[472.501999] Dynamic subtest vcs1: SUCCESS (2.152s)
[472.512698] Starting dynamic subtest: vecs0
[474.654436] Dynamic subtest vecs0: SUCCESS (2.151s)
[474.665508] Starting dynamic subtest: vecs1
[476.808509] Dynamic subtest vecs1: SUCCESS (2.153s)
[476.819506] Starting dynamic subtest: ccs0
[478.961737] Dynamic subtest ccs0: SUCCESS (2.152s)
[478.962698] Subtest engines: SUCCESS (15.074s)
[479.188283] [111/131] (549s left) gem_eio (in-flight-internal-1us)
[479.496976] Starting subtest: in-flight-internal-1us
[480.898177] Subtest in-flight-internal-1us: SUCCESS (1.402s)
[481.199775] [112/131] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[481.390869] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[481.392533] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[481.593355] [113/131] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[481.784140] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[481.785890] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[481.978777] [114/131] (547s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[482.172042] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[482.173749] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[482.375820] [115/131] (546s left) api_intel_allocator (alloc-simple)
[482.456272] Starting subtest: alloc-simple
[482.483167] Subtest alloc-simple: SUCCESS (0.027s)
[482.708399] [116/131] (546s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[482.892896] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[482.895094] Starting dynamic subtest: pipe-A-DP-3
[482.903966] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[482.915082] Starting dynamic subtest: pipe-B-DP-3
[482.924115] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[482.934827] Starting dynamic subtest: pipe-C-DP-3
[482.943550] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[482.954358] Starting dynamic subtest: pipe-D-DP-3
[482.965467] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[482.967459] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[483.353668] [117/131] (546s left) gem_exec_fence (invalid-fence-array)
[483.928124] Starting subtest: invalid-fence-array
[483.930160] Subtest invalid-fence-array: SUCCESS (0.002s)
[484.387484] [118/131] (545s left) kms_frontbuffer_tracking (fbc-tiling-y)
[484.582591] Starting subtest: fbc-tiling-y
[484.584562] Subtest fbc-tiling-y: SKIP (0.000s)
[484.788058] [119/131] (544s left) gem_exec_reloc (basic-wc-cpu-active)
[484.871418] Subtest basic-wc-cpu-active: SKIP (0.000s)
[484.946037] [120/131] (544s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[485.139144] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[485.196576] [121/131] (544s left) perf_pmu (render-node-busy)
[485.308737] Starting subtest: render-node-busy
[485.309542] Starting dynamic subtest: rcs0
[485.935411] Dynamic subtest rcs0: SUCCESS (0.626s)
[485.951180] Starting dynamic subtest: bcs0
[486.501753] Dynamic subtest bcs0: SUCCESS (0.564s)
[486.517239] Starting dynamic subtest: vcs0
[487.064772] Dynamic subtest vcs0: SUCCESS (0.558s)
[487.080121] Starting dynamic subtest: vcs1
[487.624744] Dynamic subtest vcs1: SUCCESS (0.555s)
[487.639893] Starting dynamic subtest: vecs0
[488.185778] Dynamic subtest vecs0: SUCCESS (0.556s)
[488.201254] Starting dynamic subtest: vecs1
[488.748755] Dynamic subtest vecs1: SUCCESS (0.558s)
[488.763979] Starting dynamic subtest: ccs0
[489.308824] Dynamic subtest ccs0: SUCCESS (0.555s)
[489.311714] Subtest render-node-busy: SUCCESS (4.002s)
[489.451318] [122/131] (540s left) gem_exec_reloc (basic-active)
[489.534248] Subtest basic-active: SKIP (0.000s)
[489.618594] [123/131] (540s left) gem_lmem_swapping (parallel-random-engines)
[492.300301] Starting subtest: parallel-random-engines
[492.301373] Starting dynamic subtest: lmem0
[533.741118] Dynamic subtest lmem0: SUCCESS (41.440s)
[533.742118] Subtest parallel-random-engines: SUCCESS (41.442s)
[534.798885] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[534.799877] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[534.801793] [124/131] (495s left) gem_lmem_swapping (parallel-random)
[536.330818] Starting subtest: parallel-random
[536.331754] Starting dynamic subtest: lmem0
[581.743608] Dynamic subtest lmem0: SUCCESS (45.409s)
[581.744616] Subtest parallel-random: SUCCESS (45.411s)
[582.824912] [125/131] (447s left) i915_fb_tiling (basic-x-tiling)
[584.358676] Subtest basic-x-tiling: SKIP (0.000s)
[584.420847] [FACT i915_fb_tiling (basic-x-tiling)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[584.423534] [FACT i915_fb_tiling (basic-x-tiling)] new: kernel.kmod_is_loaded.i915: true
[584.426676] [126/131] (445s left) gem_eio (context-create)
[584.673340] Starting subtest: context-create
[585.051402] Subtest context-create: SUCCESS (0.378s)
[585.330511] [127/131] (444s left) gem_mmap_offset (bad-object)
[585.410351] Starting subtest: bad-object
[585.411252] Subtest bad-object: SUCCESS (0.000s)
[585.616864] [128/131] (444s left) kms_scaling_modes (scaling-mode-full-aspect)
[585.802998] Starting subtest: scaling-mode-full-aspect
[585.808018] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[585.968751] [129/131] (444s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[586.157979] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[586.159524] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[586.369613] [130/131] (443s left) i915_suspend (forcewake)
[586.464644] Starting subtest: forcewake
[625.436362] Subtest forcewake: SUCCESS (7.207s)
[625.570343] [131/131] (404s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[625.762624] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[628.671175] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.909s)
[628.883966] 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.