[107.453647] Initializing watchdogs
[107.453705]   /dev/watchdog0
[107.473249] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[107.483313] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[107.487375] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[107.489647] [001/131] (960s left) kms_big_fb (linear-32bpp-rotate-270)
[107.680107] Starting subtest: linear-32bpp-rotate-270
[107.760284] Subtest linear-32bpp-rotate-270: SKIP (0.080s)
[107.967615] [002/131] (960s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[108.149430] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[108.150365] Starting dynamic subtest: pipe-A-valid-mode
[110.684835] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.532s)
[110.686518] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SUCCESS (2.534s)
[110.986943] [003/131] (957s left) kms_cursor_edge_walk (256x256-top-bottom)
[111.172252] Starting subtest: 256x256-top-bottom
[111.174140] Starting dynamic subtest: pipe-A-DP-3
[114.680008] Dynamic subtest pipe-A-DP-3: SUCCESS (3.506s)
[114.690700] Starting dynamic subtest: pipe-D-DP-3
[118.001457] Dynamic subtest pipe-D-DP-3: SUCCESS (3.318s)
[118.002406] Subtest 256x256-top-bottom: SUCCESS (6.827s)
[118.305552] [004/131] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[118.485597] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[118.487250] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.672666] [005/131] (949s left) kms_chamelium_edid (dp-edid-resolution-list)
[118.935846] Subtest dp-edid-resolution-list: SKIP (0.000s)
[119.077483] [006/131] (949s left) vgem_basic (bad-flag)
[119.158446] Starting subtest: bad-flag
[119.159390] Subtest bad-flag: SUCCESS (0.000s)
[119.316760] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true
[119.318980] [007/131] (949s left) kms_cursor_crc (cursor-onscreen-256x256)
[119.737704] Starting subtest: cursor-onscreen-256x256
[119.742066] Starting dynamic subtest: pipe-A-DP-3
[122.555395] Dynamic subtest pipe-A-DP-3: SUCCESS (2.812s)
[122.592388] Starting dynamic subtest: pipe-D-DP-3
[125.323468] Dynamic subtest pipe-D-DP-3: SUCCESS (2.737s)
[125.324455] Subtest cursor-onscreen-256x256: SUCCESS (5.584s)
[125.737900] [008/131] (942s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[125.933524] Starting subtest: 4-tiled-32bpp-rotate-0
[127.670740] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.736s)
[127.932607] [009/131] (940s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[128.122585] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[128.123433] Starting dynamic subtest: pipe-A-DP-3
[128.131654] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[128.139517] Starting dynamic subtest: pipe-B-DP-3
[128.147517] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[128.155298] Starting dynamic subtest: pipe-C-DP-3
[128.163337] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[128.171107] Starting dynamic subtest: pipe-D-DP-3
[128.179987] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[128.181844] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[128.594365] [010/131] (940s left) gem_ctx_persistence (heartbeat-close)
[128.680785] Starting subtest: heartbeat-close
[128.682730] Subtest heartbeat-close: SKIP (0.000s)
[128.879453] [011/131] (939s left) gem_exec_reloc (basic-write-read-noreloc)
[128.965210] Subtest basic-write-read-noreloc: SKIP (0.000s)
[129.038380] [012/131] (939s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[129.128030] Starting subtest: wait-all-for-submit-delayed-submit
[129.231936] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[129.373738] [013/131] (939s left) kms_psr (fbc-pr-suspend)
[129.554730] Subtest fbc-pr-suspend: SKIP (0.000s)
[129.603746] [014/131] (939s left) kms_lease (lease-invalid-crtc)
[129.786331] Starting subtest: lease-invalid-crtc
[129.787239] Starting dynamic subtest: pipe-A-DP-3
[129.788165] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[129.796376] Starting dynamic subtest: pipe-B-DP-3
[129.797290] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[129.805633] Starting dynamic subtest: pipe-C-DP-3
[129.806754] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[129.814712] Starting dynamic subtest: pipe-D-DP-3
[129.815834] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[129.816996] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[129.938218] [015/131] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[130.127277] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[130.128907] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[130.325926] [016/131] (938s left) kms_pm_lpsp (screens-disabled)
[131.517039] Starting subtest: screens-disabled
[131.518671] Subtest screens-disabled: SKIP (0.000s)
[131.681562] [017/131] (937s left) gen9_exec_parse (unaligned-access)
[131.762287] Subtest unaligned-access: SKIP (0.000s)
[131.842649] [018/131] (937s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[132.027698] Starting subtest: cursorA-vs-flipB-atomic-transitions
[132.029408] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[132.181441] [019/131] (937s left) gem_mmap_wc (bad-offset)
[132.261134] Subtest bad-offset: SKIP (0.000s)
[132.346082] [020/131] (937s left) gem_ctx_isolation (preservation-reset)
[132.538275] Starting subtest: preservation-reset
[132.539216] Starting dynamic subtest: rcs0
[133.125872] Dynamic subtest rcs0: SUCCESS (0.587s)
[133.134784] Starting dynamic subtest: bcs0
[133.737940] Dynamic subtest bcs0: SUCCESS (0.612s)
[133.746768] Starting dynamic subtest: vcs0
[134.358381] Dynamic subtest vcs0: SUCCESS (0.620s)
[134.367036] Starting dynamic subtest: vcs1
[134.980206] Dynamic subtest vcs1: SUCCESS (0.622s)
[134.989070] Starting dynamic subtest: vecs0
[135.616655] Dynamic subtest vecs0: SUCCESS (0.636s)
[135.625401] Starting dynamic subtest: vecs1
[136.229827] Dynamic subtest vecs1: SUCCESS (0.613s)
[136.238517] Starting dynamic subtest: ccs0
[136.828257] Dynamic subtest ccs0: SUCCESS (0.598s)
[136.829186] Subtest preservation-reset: SUCCESS (4.290s)
[137.090700] [021/131] (932s left) gem_bad_reloc (negative-reloc-bltcopy)
[137.175143] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[137.289010] [022/131] (932s left) syncobj_wait (single-wait-for-submit-submitted)
[137.366106] Starting subtest: single-wait-for-submit-submitted
[137.467996] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[137.637146] [023/131] (931s left) gem_mmap_gtt (basic-small-copy)
[137.714714] Subtest basic-small-copy: SKIP (0.000s)
[137.790727] [024/131] (931s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[137.983336] Starting subtest: yf-tiled-16bpp-rotate-270
[137.985167] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[138.193649] [025/131] (931s left) kms_feature_discovery (display-4x)
[138.379260] Starting subtest: display-4x
[138.380974] Subtest display-4x: SKIP (0.000s)
[138.526679] [026/131] (931s left) gem_exec_reloc (basic-gtt-read-active)
[138.608929] Subtest basic-gtt-read-active: SKIP (0.000s)
[138.689367] [027/131] (931s left) gen9_exec_parse (allowed-all)
[138.774170] Subtest allowed-all: SKIP (0.000s)
[138.839241] [028/131] (931s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[139.027882] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[139.043354] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s)
[139.202970] [029/131] (930s left) kms_invalid_mode (bad-htotal)
[139.391173] Starting subtest: bad-htotal
[139.392063] Starting dynamic subtest: pipe-A-DP-3
[139.474918] Dynamic subtest pipe-A-DP-3: SUCCESS (0.083s)
[139.486814] Starting dynamic subtest: pipe-B-DP-3
[139.487713] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[139.499010] Starting dynamic subtest: pipe-C-DP-3
[139.499988] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[139.511127] Starting dynamic subtest: pipe-D-DP-3
[139.512071] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[139.512942] Subtest bad-htotal: SUCCESS (0.091s)
[139.750887] [030/131] (930s left) syncobj_eventfd (invalid-illegal-handle)
[139.828937] Starting subtest: invalid-illegal-handle
[139.829850] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[140.014858] [031/131] (930s left) gem_exec_schedule (thriceslice)
[140.100377] Starting subtest: thriceslice
[140.101283] Starting dynamic subtest: rcs0
[140.152257] Dynamic subtest rcs0: SUCCESS (0.052s)
[140.161975] Starting dynamic subtest: bcs0
[140.206359] Dynamic subtest bcs0: SUCCESS (0.054s)
[140.217619] Starting dynamic subtest: vcs0
[140.261818] Dynamic subtest vcs0: SUCCESS (0.055s)
[140.273967] Starting dynamic subtest: vcs1
[140.319420] Dynamic subtest vcs1: SUCCESS (0.057s)
[140.334404] Starting dynamic subtest: vecs0
[140.357753] Dynamic subtest vecs0: SUCCESS (0.038s)
[140.378659] Starting dynamic subtest: vecs1
[140.400901] Dynamic subtest vecs1: SUCCESS (0.042s)
[140.413141] Starting dynamic subtest: ccs0
[140.436694] Dynamic subtest ccs0: SUCCESS (0.035s)
[140.437765] Subtest thriceslice: SUCCESS (0.336s)
[140.839211] [032/131] (929s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[141.028288] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[141.030019] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[141.214896] [033/131] (929s left) kms_psr (psr2-sprite-blt)
[141.400439] Subtest psr2-sprite-blt: SKIP (0.000s)
[141.461089] [034/131] (928s left) gem_ccs (block-multicopy-compressed)
[141.552387] Starting subtest: block-multicopy-compressed
[141.553283] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[141.598369] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.045s)
[141.607068] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[141.697514] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[141.706180] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[141.713951] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[141.722566] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[141.813494] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[141.822174] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[141.830125] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[141.838724] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[141.933456] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.103s)
[141.942130] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[141.950059] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s)
[141.958621] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[142.059653] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.109s)
[142.060541] Subtest block-multicopy-compressed: SUCCESS (0.507s)
[142.232791] [035/131] (928s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[142.413946] Starting subtest: plane-upscale-20x20-with-modifiers
[142.414770] Starting dynamic subtest: pipe-A
[142.986498] Dynamic subtest pipe-A: SUCCESS (0.572s)
[142.998963] Starting dynamic subtest: pipe-B
[143.614385] Dynamic subtest pipe-B: SUCCESS (0.627s)
[143.628531] Starting dynamic subtest: pipe-C
[144.244424] Dynamic subtest pipe-C: SUCCESS (0.629s)
[144.264234] Starting dynamic subtest: pipe-D
[144.889258] Dynamic subtest pipe-D: SUCCESS (0.644s)
[144.890203] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.475s)
[145.249863] [036/131] (925s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[145.451369] Starting subtest: x-tiled-8bpp-rotate-270
[145.502852] Subtest x-tiled-8bpp-rotate-270: SKIP (0.051s)
[145.714541] [037/131] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[145.897986] Starting subtest: bo-too-small-due-to-tiling
[145.899640] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[146.099867] [038/131] (924s left) gem_workarounds (basic-read-context)
[146.190625] Starting subtest: basic-read-context
[146.232915] Subtest basic-read-context: SUCCESS (0.042s)
[146.415246] [039/131] (924s left) kms_flip (2x-blocking-wf_vblank)
[146.597416] Starting subtest: 2x-blocking-wf_vblank
[146.612601] Subtest 2x-blocking-wf_vblank: SKIP (0.015s)
[146.799201] [040/131] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[146.997206] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[146.998899] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[147.200508] [041/131] (923s left) gem_mmap_gtt (basic-write-read)
[147.277191] Subtest basic-write-read: SKIP (0.000s)
[147.342750] [042/131] (923s left) prime_vgem (fence-wait)
[147.441137] Starting subtest: fence-wait
[147.442057] Starting dynamic subtest: rcs0
[148.513743] Dynamic subtest rcs0: SUCCESS (1.072s)
[148.523672] Starting dynamic subtest: bcs0
[149.582444] Dynamic subtest bcs0: SUCCESS (1.068s)
[149.591618] Starting dynamic subtest: vcs0
[150.631313] Dynamic subtest vcs0: SUCCESS (1.047s)
[150.641574] Starting dynamic subtest: vcs1
[151.677610] Dynamic subtest vcs1: SUCCESS (1.044s)
[151.690810] Starting dynamic subtest: vecs0
[152.723190] Dynamic subtest vecs0: SUCCESS (1.044s)
[152.732221] Starting dynamic subtest: vecs1
[153.765431] Dynamic subtest vecs1: SUCCESS (1.040s)
[153.777811] Starting dynamic subtest: ccs0
[154.809103] Dynamic subtest ccs0: SUCCESS (1.041s)
[154.811043] Subtest fence-wait: SUCCESS (7.367s)
[154.987102] [043/131] (915s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[155.173675] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[155.175248] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[155.369569] [044/131] (915s left) kms_flip (2x-nonexisting-fb)
[155.552593] Starting subtest: 2x-nonexisting-fb
[155.567567] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[155.749939] [045/131] (915s left) perf_pmu (busy-idle)
[155.818494] Starting subtest: busy-idle
[155.819402] Starting dynamic subtest: rcs0
[156.565185] Dynamic subtest rcs0: SUCCESS (0.746s)
[156.579401] Starting dynamic subtest: bcs0
[157.227664] Dynamic subtest bcs0: SUCCESS (0.660s)
[157.241527] Starting dynamic subtest: vcs0
[157.891543] Dynamic subtest vcs0: SUCCESS (0.662s)
[157.905489] Starting dynamic subtest: vcs1
[158.556547] Dynamic subtest vcs1: SUCCESS (0.663s)
[158.570839] Starting dynamic subtest: vecs0
[159.224687] Dynamic subtest vecs0: SUCCESS (0.666s)
[159.238167] Starting dynamic subtest: vecs1
[159.890573] Dynamic subtest vecs1: SUCCESS (0.664s)
[159.904895] Starting dynamic subtest: ccs0
[160.554667] Dynamic subtest ccs0: SUCCESS (0.662s)
[160.556439] Subtest busy-idle: SUCCESS (4.736s)
[160.768453] [046/131] (910s left) kms_rotation_crc (primary-rotation-90)
[160.949944] Starting subtest: primary-rotation-90
[160.951680] Subtest primary-rotation-90: SKIP (0.001s)
[161.103696] [047/131] (910s left) dmabuf_sync_file (export-wait-after-attach)
[161.154328] Starting subtest: export-wait-after-attach
[161.155233] Subtest export-wait-after-attach: SUCCESS (0.001s)
[161.313813] [048/131] (909s left) kms_dirtyfb (default-dirtyfb-ioctl)
[161.498162] Starting subtest: default-dirtyfb-ioctl
[161.499045] Starting dynamic subtest: A-DP-3
[162.943454] Dynamic subtest A-DP-3: SUCCESS (1.445s)
[162.944282] Subtest default-dirtyfb-ioctl: SUCCESS (1.446s)
[163.185473] [049/131] (908s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[163.375602] Starting subtest: psr-rgb101010-draw-blt
[163.377278] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[163.571026] [050/131] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[163.762956] Starting subtest: addfb25-y-tiled-legacy
[163.763850] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[163.942974] [051/131] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[164.133426] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[167.406318] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.273s)
[167.635605] [052/131] (903s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[167.826970] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[167.827915] Starting dynamic subtest: pipe-A-DP-3
[167.831212] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[167.841228] Starting dynamic subtest: pipe-B-DP-3
[167.844620] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[167.854411] Starting dynamic subtest: pipe-C-DP-3
[167.857846] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[167.867551] Starting dynamic subtest: pipe-D-DP-3
[167.870999] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[167.872563] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[168.315142] [053/131] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[168.502398] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[168.504126] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[168.710970] [054/131] (903s left) kms_psr (fbc-pr-cursor-render)
[168.898650] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[168.955145] [055/131] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[169.148520] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[169.150148] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[169.345547] [056/131] (902s left) kms_busy (basic-hang)
[169.530362] Starting subtest: basic-hang
[169.532301] Starting dynamic subtest: flip-pipe-A
[170.145759] Dynamic subtest flip-pipe-A: SUCCESS (0.613s)
[170.168165] Starting dynamic subtest: modeset-pipe-A
[171.063069] Dynamic subtest modeset-pipe-A: SUCCESS (0.916s)
[171.086862] Starting dynamic subtest: flip-pipe-D
[171.536838] Dynamic subtest flip-pipe-D: SUCCESS (0.468s)
[171.547381] Starting dynamic subtest: modeset-pipe-D
[172.376987] Dynamic subtest modeset-pipe-D: SUCCESS (0.839s)
[172.377978] Subtest basic-hang: SUCCESS (2.846s)
[172.708201] [057/131] (899s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[172.784047] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[172.784975] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[172.938426] [058/131] (899s left) gem_userptr_blits (input-checking)
[173.020788] Starting subtest: input-checking
[173.021597] Subtest input-checking: SUCCESS (0.000s)
[173.225153] [059/131] (898s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[173.713198] Starting subtest: cursor-rapid-movement-512x170
[173.716135] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[173.955527] [060/131] (898s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[174.153416] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[174.155135] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[174.344721] [061/131] (897s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[174.533053] Starting subtest: flip-vs-cursor-varying-size
[186.451181] Subtest flip-vs-cursor-varying-size: SUCCESS (11.918s)
[186.760113] [062/131] (885s left) gem_exec_basic (basic)
[186.848485] Starting subtest: basic
[186.849439] Starting dynamic subtest: rcs0-smem
[186.851734] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[186.862474] Starting dynamic subtest: bcs0-smem
[186.863350] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[186.873644] Starting dynamic subtest: vcs0-smem
[186.874792] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[186.884859] Starting dynamic subtest: vcs1-smem
[186.885838] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[186.895796] Starting dynamic subtest: vecs0-smem
[186.896968] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[186.906586] Starting dynamic subtest: vecs1-smem
[186.907574] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[186.917421] Starting dynamic subtest: ccs0-smem
[186.918615] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[186.928474] Starting dynamic subtest: rcs0-lmem0
[186.929591] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[186.939437] Starting dynamic subtest: bcs0-lmem0
[186.940547] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[186.950315] Starting dynamic subtest: vcs0-lmem0
[186.951426] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[186.961119] Starting dynamic subtest: vcs1-lmem0
[186.962124] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[186.971693] Starting dynamic subtest: vecs0-lmem0
[186.972525] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[186.982655] Starting dynamic subtest: vecs1-lmem0
[186.983789] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[186.993861] Starting dynamic subtest: ccs0-lmem0
[186.994819] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[186.995920] Subtest basic: SUCCESS (0.017s)
[187.121205] [063/131] (885s left) kms_psr (fbc-psr-cursor-plane-onoff)
[187.309660] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[187.375086] [064/131] (884s left) gem_spin_batch (spin-all)
[187.466691] Starting subtest: spin-all
[187.513519] Subtest spin-all: SUCCESS (0.047s)
[187.865859] [065/131] (884s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[188.052914] Starting subtest: 2x-long-cursor-vs-flip-atomic
[188.055840] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[188.220187] [066/131] (884s left) kms_psr (psr2-cursor-mmap-cpu)
[188.400754] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[188.458077] [067/131] (884s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[188.642746] Starting subtest: plane-downscale-factor-0-5-with-rotation
[188.643527] Starting dynamic subtest: pipe-A
[189.016197] Dynamic subtest pipe-A: SUCCESS (0.373s)
[189.044457] Starting dynamic subtest: pipe-B
[189.494325] Dynamic subtest pipe-B: SUCCESS (0.477s)
[189.507517] Starting dynamic subtest: pipe-C
[189.956445] Dynamic subtest pipe-C: SUCCESS (0.461s)
[189.981921] Starting dynamic subtest: pipe-D
[190.436488] Dynamic subtest pipe-D: SUCCESS (0.479s)
[190.437578] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.794s)
[190.799899] [068/131] (881s left) kms_atomic (plane-invalid-params-fence)
[190.986567] Starting subtest: plane-invalid-params-fence
[190.988629] Starting dynamic subtest: pipe-A-DP-3
[191.529471] Dynamic subtest pipe-A-DP-3: SUCCESS (0.540s)
[191.530620] Subtest plane-invalid-params-fence: SUCCESS (0.542s)
[191.861305] [069/131] (880s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[192.058713] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[192.060266] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[192.260743] [070/131] (880s left) prime_vgem (coherency-gtt)
[192.365799] Starting subtest: coherency-gtt
[192.367827] Subtest coherency-gtt: SKIP (0.000s)
[192.558931] [071/131] (880s left) gem_exec_balancer (parallel)
[192.898038] Starting subtest: parallel
[194.509739] Subtest parallel: SUCCESS (1.612s)
[194.676370] [072/131] (878s left) gem_render_copy (linear-to-vebox-y-tiled)
[194.759419] Starting subtest: linear-to-vebox-y-tiled
[194.761367] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[194.993748] [073/131] (878s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[195.187156] Starting subtest: 2x-flip-vs-cursor-atomic
[195.189135] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[195.346958] [074/131] (877s left) gem_exec_reloc (basic-write-wc-active)
[195.431540] Subtest basic-write-wc-active: SKIP (0.000s)
[195.524218] [075/131] (877s left) i915_pm_rps (reset)
[195.611507] Starting subtest: reset
[200.416577] Subtest reset: SUCCESS (4.805s)
[200.647577] [076/131] (872s left) api_intel_bb (object-reloc-keep-cache)
[200.722407] Starting subtest: object-reloc-keep-cache
[200.726342] Subtest object-reloc-keep-cache: SKIP (0.003s)
[200.911641] [077/131] (872s left) gem_tiled_pread_pwrite
[201.057670] [078/131] (872s left) kms_plane_alpha_blend (alpha-7efc)
[201.239481] Starting subtest: alpha-7efc
[201.506408] Starting dynamic subtest: pipe-A-DP-3
[201.990158] Dynamic subtest pipe-A-DP-3: SUCCESS (0.482s)
[202.033341] Starting dynamic subtest: pipe-D-DP-3
[202.608303] Dynamic subtest pipe-D-DP-3: SUCCESS (0.584s)
[202.609127] Subtest alpha-7efc: SUCCESS (1.368s)
[202.907533] [079/131] (870s left) kms_prop_blob (blob-multiple)
[202.995414] Starting subtest: blob-multiple
[203.026185] Subtest blob-multiple: SUCCESS (0.031s)
[203.227882] [080/131] (870s left) gem_exec_reloc (basic-cpu-active)
[203.309149] Subtest basic-cpu-active: SKIP (0.000s)
[203.394601] [081/131] (870s left) gem_shrink (reclaim)
[203.487005] Starting subtest: reclaim
[205.749113] Subtest reclaim: SUCCESS (2.261s)
[206.052149] [082/131] (867s left) gem_gtt_cpu_tlb
[206.204082] [083/131] (867s left) kms_vblank (query-busy-hang)
[206.388907] Starting subtest: query-busy-hang
[206.391168] Starting dynamic subtest: pipe-A-DP-3
[232.572200] Dynamic subtest pipe-A-DP-3: SUCCESS (26.181s)
[232.585702] Starting dynamic subtest: pipe-D-DP-3
[257.528464] Dynamic subtest pipe-D-DP-3: SUCCESS (24.951s)
[257.529289] Subtest query-busy-hang: SUCCESS (51.138s)
[257.815234] [084/131] (816s left) kms_plane_multiple (tiling-4)
[258.000168] Starting subtest: tiling-4
[258.001094] Starting dynamic subtest: pipe-A-DP-3
[259.132155] Dynamic subtest pipe-A-DP-3: SUCCESS (1.131s)
[259.143646] Starting dynamic subtest: pipe-B-DP-3
[260.184802] Dynamic subtest pipe-B-DP-3: SUCCESS (1.051s)
[260.197097] Starting dynamic subtest: pipe-C-DP-3
[261.274581] Dynamic subtest pipe-C-DP-3: SUCCESS (1.088s)
[261.286583] Starting dynamic subtest: pipe-D-DP-3
[262.298948] Dynamic subtest pipe-D-DP-3: SUCCESS (1.022s)
[262.299877] Subtest tiling-4: SUCCESS (4.300s)
[262.595923] [085/131] (811s left) gem_userptr_blits (vma-merge)
[262.702350] Starting subtest: vma-merge
[262.783276] Subtest vma-merge: SUCCESS (0.081s)
[262.965667] [086/131] (811s left) syncobj_timeline (etime-single-wait-all-submitted)
[263.054489] Starting subtest: etime-single-wait-all-submitted
[263.156295] Subtest etime-single-wait-all-submitted: SUCCESS (0.101s)
[263.311013] [087/131] (810s left) kms_feature_discovery (display)
[263.494739] Starting subtest: display
[263.495579] Subtest display: SUCCESS (0.000s)
[263.667325] [088/131] (810s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[263.870529] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[263.872254] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[264.080971] [089/131] (810s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[264.159292] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[264.160227] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[264.363784] [090/131] (809s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[264.561792] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[264.622634] [091/131] (809s left) perf (invalid-remove-userspace-config)
[265.009939] Starting subtest: invalid-remove-userspace-config
[265.018211] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[265.077425] [092/131] (809s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[265.261592] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[265.263997] Starting dynamic subtest: pipe-A-valid-mode
[265.338249] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[265.340048] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.076s)
[265.587274] [093/131] (808s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[265.768408] Starting subtest: cursorA-vs-flipA-toggle
[276.710983] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.942s)
[277.012803] [094/131] (797s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[277.196529] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[277.198899] Starting dynamic subtest: pipe-A-DP-3
[277.206861] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[277.217431] Starting dynamic subtest: pipe-B-DP-3
[277.225787] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[277.235889] Starting dynamic subtest: pipe-C-DP-3
[277.244057] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[277.254433] Starting dynamic subtest: pipe-D-DP-3
[277.264463] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[277.266446] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[277.687955] [095/131] (797s left) kms_flip (dpms-vs-vblank-race-interruptible)
[277.883937] Starting subtest: dpms-vs-vblank-race-interruptible
[277.888843] Starting dynamic subtest: A-DP3
[281.125925] Dynamic subtest A-DP3: SUCCESS (3.236s)
[281.144111] Starting dynamic subtest: B-DP3
[284.271906] Dynamic subtest B-DP3: SUCCESS (3.144s)
[284.282925] Starting dynamic subtest: C-DP3
[287.228943] Dynamic subtest C-DP3: SUCCESS (2.955s)
[287.239636] Starting dynamic subtest: D-DP3
[290.182855] Dynamic subtest D-DP3: SUCCESS (2.953s)
[290.185139] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.299s)
[290.480748] [096/131] (784s left) gem_exec_flush (basic-uc-rw-default)
[290.578050] Subtest basic-uc-rw-default: SKIP (0.000s)
[290.700852] [097/131] (784s left) gem_eio (reset-stress)
[291.002379] Starting subtest: reset-stress
[291.003293] Starting dynamic subtest: render
[298.027145] Dynamic subtest render: SUCCESS (7.025s)
[298.038173] Starting dynamic subtest: bsd1
[305.193113] Dynamic subtest bsd1: SUCCESS (7.164s)
[305.207191] Starting dynamic subtest: bsd2
[312.301383] Dynamic subtest bsd2: SUCCESS (7.107s)
[312.312801] Starting dynamic subtest: blt
[319.208620] Dynamic subtest blt: SUCCESS (6.906s)
[319.225371] Starting dynamic subtest: vebox
[326.245209] Dynamic subtest vebox: SUCCESS (7.035s)
[326.246194] Subtest reset-stress: SUCCESS (35.244s)
[326.581392] [098/131] (748s left) kms_content_protection (lic-type-0)
[326.840359] Starting subtest: lic-type-0
[326.877709] Starting dynamic subtest: pipe-A-DP-3
[448.228188] Dynamic subtest pipe-A-DP-3: FAIL (121.189s)
[448.229280] Subtest lic-type-0: FAIL (121.330s)
[448.481920] [099/131] (626s left) syncobj_timeline (invalid-signal-illegal-point)
[448.558244] Starting subtest: invalid-signal-illegal-point
[448.559146] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[448.728869] [100/131] (626s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[448.804271] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[448.875449] [101/131] (626s left) gem_exec_schedule (pi-common)
[449.115178] Starting subtest: pi-common
[449.116591] Starting dynamic subtest: rcs0
[449.154937] Dynamic subtest rcs0: SUCCESS (0.039s)
[449.167992] Starting dynamic subtest: bcs0
[449.186136] Dynamic subtest bcs0: SUCCESS (0.030s)
[449.198804] Starting dynamic subtest: vcs0
[449.216548] Dynamic subtest vcs0: SUCCESS (0.029s)
[449.229504] Starting dynamic subtest: vcs1
[449.248492] Dynamic subtest vcs1: SUCCESS (0.031s)
[449.261446] Starting dynamic subtest: vecs0
[449.279594] Dynamic subtest vecs0: SUCCESS (0.030s)
[449.292238] Starting dynamic subtest: vecs1
[449.309084] Dynamic subtest vecs1: SUCCESS (0.028s)
[449.321937] Starting dynamic subtest: ccs0
[449.338795] Dynamic subtest ccs0: SUCCESS (0.029s)
[449.339758] Subtest pi-common: SUCCESS (0.225s)
[449.647647] [102/131] (625s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[449.833005] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[449.835247] Starting dynamic subtest: pipe-A-DP-3
[449.856210] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[449.867049] Starting dynamic subtest: pipe-B-DP-3
[449.887915] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[449.898794] Starting dynamic subtest: pipe-C-DP-3
[449.924521] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[449.935227] Starting dynamic subtest: pipe-D-DP-3
[449.956787] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[449.958542] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.015s)
[450.307739] [103/131] (625s left) kms_vblank (wait-forked-hang)
[450.503677] Starting subtest: wait-forked-hang
[450.506136] Starting dynamic subtest: pipe-A-DP-3
[476.547419] Dynamic subtest pipe-A-DP-3: SUCCESS (26.040s)
[476.561262] Starting dynamic subtest: pipe-D-DP-3
[501.551874] Dynamic subtest pipe-D-DP-3: SUCCESS (24.999s)
[501.552771] Subtest wait-forked-hang: SUCCESS (51.046s)
[501.851611] [104/131] (573s left) gem_exec_whisper (basic-normal)
[501.946990] Starting subtest: basic-normal
[505.623038] Subtest basic-normal: SUCCESS (3.675s)
[505.867319] [105/131] (569s left) syncobj_wait (reset-signaled)
[505.943341] Starting subtest: reset-signaled
[505.944257] Subtest reset-signaled: SUCCESS (0.000s)
[506.116713] [106/131] (569s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[506.312161] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[506.314181] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[506.501614] [107/131] (569s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[506.584475] Starting subtest: y-tiled-to-vebox-yf-tiled
[506.586614] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[506.867789] [108/131] (568s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[507.094276] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[508.190680] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.097s)
[508.495597] [109/131] (567s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[508.778336] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[508.919806] [110/131] (566s left) gem_cs_tlb (engines)
[509.009301] Starting subtest: engines
[509.010186] Starting dynamic subtest: rcs0
[511.162430] Dynamic subtest rcs0: SUCCESS (2.153s)
[511.174225] Starting dynamic subtest: bcs0
[513.317220] Dynamic subtest bcs0: SUCCESS (2.153s)
[513.328443] Starting dynamic subtest: vcs0
[515.470137] Dynamic subtest vcs0: SUCCESS (2.152s)
[515.481249] Starting dynamic subtest: vcs1
[517.624044] Dynamic subtest vcs1: SUCCESS (2.152s)
[517.635367] Starting dynamic subtest: vecs0
[519.777610] Dynamic subtest vecs0: SUCCESS (2.152s)
[519.789649] Starting dynamic subtest: vecs1
[521.931988] Dynamic subtest vecs1: SUCCESS (2.153s)
[521.943236] Starting dynamic subtest: ccs0
[524.085627] Dynamic subtest ccs0: SUCCESS (2.152s)
[524.086628] Subtest engines: SUCCESS (15.076s)
[524.270626] [111/131] (551s left) gem_eio (in-flight-internal-1us)
[524.570982] Starting subtest: in-flight-internal-1us
[525.885580] Subtest in-flight-internal-1us: SUCCESS (1.315s)
[526.170779] [112/131] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[526.362123] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[526.363709] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[526.552189] [113/131] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[526.741133] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[526.742891] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[526.952516] [114/131] (549s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[527.149147] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[527.150876] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[527.358809] [115/131] (548s left) api_intel_allocator (alloc-simple)
[527.446682] Starting subtest: alloc-simple
[527.473224] Subtest alloc-simple: SUCCESS (0.028s)
[527.709034] [116/131] (548s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[527.893740] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[527.896032] Starting dynamic subtest: pipe-A-DP-3
[527.905008] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[527.916055] Starting dynamic subtest: pipe-B-DP-3
[527.925260] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[527.935986] Starting dynamic subtest: pipe-C-DP-3
[527.944859] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[527.955607] Starting dynamic subtest: pipe-D-DP-3
[527.966846] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[527.969112] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[528.354562] [117/131] (548s left) gem_exec_fence (invalid-fence-array)
[528.939479] Starting subtest: invalid-fence-array
[528.941820] Subtest invalid-fence-array: SUCCESS (0.002s)
[529.402234] [118/131] (547s left) kms_frontbuffer_tracking (fbc-tiling-y)
[529.590977] Starting subtest: fbc-tiling-y
[529.592673] Subtest fbc-tiling-y: SKIP (0.000s)
[529.783912] [119/131] (546s left) gem_exec_reloc (basic-wc-cpu-active)
[529.867225] Subtest basic-wc-cpu-active: SKIP (0.000s)
[529.966357] [120/131] (546s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[530.158330] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[530.210980] [121/131] (546s left) perf_pmu (render-node-busy)
[530.324754] Starting subtest: render-node-busy
[530.325585] Starting dynamic subtest: rcs0
[530.943065] Dynamic subtest rcs0: SUCCESS (0.617s)
[530.958325] Starting dynamic subtest: bcs0
[531.503729] Dynamic subtest bcs0: SUCCESS (0.556s)
[531.518725] Starting dynamic subtest: vcs0
[532.064593] Dynamic subtest vcs0: SUCCESS (0.556s)
[532.079444] Starting dynamic subtest: vcs1
[532.625753] Dynamic subtest vcs1: SUCCESS (0.556s)
[532.641038] Starting dynamic subtest: vecs0
[533.183766] Dynamic subtest vecs0: SUCCESS (0.553s)
[533.198738] Starting dynamic subtest: vecs1
[533.751760] Dynamic subtest vecs1: SUCCESS (0.563s)
[533.767225] Starting dynamic subtest: ccs0
[534.312786] Dynamic subtest ccs0: SUCCESS (0.556s)
[534.315667] Subtest render-node-busy: SUCCESS (3.990s)
[534.464842] [122/131] (542s left) gem_exec_reloc (basic-active)
[534.555416] Subtest basic-active: SKIP (0.000s)
[534.662842] [123/131] (542s left) gem_lmem_swapping (parallel-random-engines)
[537.346600] Starting subtest: parallel-random-engines
[537.347437] Starting dynamic subtest: lmem0
[579.014881] Dynamic subtest lmem0: SUCCESS (41.667s)
[579.015907] Subtest parallel-random-engines: SUCCESS (41.669s)
[580.121846] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[580.122930] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[580.125345] [124/131] (496s left) gem_lmem_swapping (parallel-random)
[581.652401] Starting subtest: parallel-random
[581.655550] Starting dynamic subtest: lmem0
[624.266405] Dynamic subtest lmem0: SUCCESS (42.612s)
[624.267411] Subtest parallel-random: SUCCESS (42.614s)
[625.370191] [125/131] (451s left) i915_fb_tiling (basic-x-tiling)
[626.896214] Subtest basic-x-tiling: SKIP (0.000s)
[626.964058] [FACT i915_fb_tiling (basic-x-tiling)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[626.966756] [FACT i915_fb_tiling (basic-x-tiling)] new: kernel.kmod_is_loaded.i915: true
[626.969658] [126/131] (449s left) gem_eio (context-create)
[627.199919] Starting subtest: context-create
[627.567366] Subtest context-create: SUCCESS (0.368s)
[627.846545] [127/131] (449s left) gem_mmap_offset (bad-object)
[627.922522] Starting subtest: bad-object
[627.923411] Subtest bad-object: SUCCESS (0.000s)
[628.086060] [128/131] (448s left) kms_scaling_modes (scaling-mode-full-aspect)
[628.273911] Starting subtest: scaling-mode-full-aspect
[628.278900] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[628.443340] [129/131] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[628.634288] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[628.635977] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[628.841066] [130/131] (448s left) i915_suspend (forcewake)
[628.937276] Starting subtest: forcewake
[667.420288] Subtest forcewake: SUCCESS (7.261s)
[667.548231] [131/131] (409s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[667.741928] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[670.550783] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.810s)
[670.800538] 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.