[58.751429] Initializing watchdogs
[58.751471]   /dev/watchdog0
[58.764892] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.769141] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.771283] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.774518] [001/131] (960s left) drm_mm (drm_mm)
[58.826666] Starting subtest: drm_mm
[58.836831] Starting dynamic subtest: drm_test_mm_init
[58.933677] Dynamic subtest drm_test_mm_init: SUCCESS (0.096s)
[58.942102] Starting dynamic subtest: drm_test_mm_debug
[59.036157] Dynamic subtest drm_test_mm_debug: SUCCESS (0.102s)
[59.044666] Starting dynamic subtest: drm_test_mm_align32
[59.133309] Dynamic subtest drm_test_mm_align32: SUCCESS (0.095s)
[59.141444] Starting dynamic subtest: drm_test_mm_align64
[59.231339] Dynamic subtest drm_test_mm_align64: SUCCESS (0.098s)
[59.238699] Starting dynamic subtest: drm_test_mm_lowest
[59.323283] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.090s)
[59.329655] Starting dynamic subtest: drm_test_mm_highest
[59.417240] Dynamic subtest drm_test_mm_highest: SUCCESS (0.093s)
[59.419595] Subtest drm_mm: SUCCESS (0.586s)
[59.559223] [002/131] (959s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[59.649112] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[59.652903] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[59.727471] [003/131] (959s left) sriov_basic (enable-vfs-autoprobe-on)
[59.778484] Starting subtest: enable-vfs-autoprobe-on
[59.780490] Starting dynamic subtest: numvfs-1
[59.843894] Dynamic subtest numvfs-1: FAIL (0.015s)
[59.851793] Starting dynamic subtest: numvfs-2
[59.908175] Dynamic subtest numvfs-2: FAIL (0.004s)
[59.914547] Starting dynamic subtest: numvfs-3
[59.971230] Dynamic subtest numvfs-3: FAIL (0.004s)
[59.977166] Starting dynamic subtest: numvfs-4
[60.033789] Dynamic subtest numvfs-4: FAIL (0.003s)
[60.039760] Starting dynamic subtest: numvfs-5
[60.095869] Dynamic subtest numvfs-5: FAIL (0.004s)
[60.103139] Starting dynamic subtest: numvfs-6
[60.159994] Dynamic subtest numvfs-6: FAIL (0.004s)
[60.166069] Starting dynamic subtest: numvfs-7
[60.223667] Dynamic subtest numvfs-7: FAIL (0.004s)
[60.230746] Starting dynamic subtest: numvfs-random
[60.286543] Dynamic subtest numvfs-random: FAIL (0.003s)
[60.292980] Starting dynamic subtest: numvfs-all
[60.349729] Dynamic subtest numvfs-all: FAIL (0.389s)
[60.351379] Subtest enable-vfs-autoprobe-on: FAIL (0.433s)
[60.381576] [004/131] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[60.476916] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[67.062078] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.559s)
[67.355262] [005/131] (952s left) kms_universal_plane (cursor-fb-leak)
[67.538794] Starting subtest: cursor-fb-leak
[67.541143] Starting dynamic subtest: pipe-A-eDP-1
[67.921386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.382s)
[67.933300] Starting dynamic subtest: pipe-B-eDP-1
[69.269846] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.344s)
[69.278781] Starting dynamic subtest: pipe-C-eDP-1
[70.584276] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.311s)
[70.593858] Starting dynamic subtest: pipe-D-eDP-1
[71.917931] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[71.920509] Subtest cursor-fb-leak: SUCCESS (4.372s)
[73.083861] [006/131] (946s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[73.140454] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[73.200943] [007/131] (946s left) gem_exec_basic (basic)
[73.265356] Starting subtest: basic
[73.267762] Starting dynamic subtest: rcs0-smem
[73.270166] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[73.279119] Starting dynamic subtest: bcs0-smem
[73.280984] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[73.287575] Starting dynamic subtest: vcs0-smem
[73.289553] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[73.295982] Starting dynamic subtest: vcs1-smem
[73.297920] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[73.304325] Starting dynamic subtest: vecs0-smem
[73.306201] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[73.312578] Starting dynamic subtest: ccs0-smem
[73.314481] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[73.316346] Subtest basic: SUCCESS (0.010s)
[74.948866] [008/131] (944s left) kms_flip (2x-flip-vs-panning)
[75.039187] Starting subtest: 2x-flip-vs-panning
[75.047955] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[75.163248] [009/131] (944s left) gem_exec_fence (syncobj-export)
[75.604057] Starting subtest: syncobj-export
[75.609343] Subtest syncobj-export: SUCCESS (0.006s)
[76.974706] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[76.978145] [010/131] (942s left) i915_getparams_basic (basic-subslice-total)
[77.033767] Starting subtest: basic-subslice-total
[77.038479] Subtest basic-subslice-total: SUCCESS (0.000s)
[77.122574] [011/131] (942s left) gem_close_race (multigpu-basic-process)
[77.191532] Starting subtest: multigpu-basic-process
[77.196196] Subtest multigpu-basic-process: SKIP (0.000s)
[77.421414] [012/131] (942s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[77.540768] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[77.545561] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[77.686499] [013/131] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[77.775226] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[77.779620] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[77.867156] [014/131] (941s left) gem_vm_create (execbuf)
[77.930340] Starting subtest: execbuf
[77.934522] Subtest execbuf: SUCCESS (0.006s)
[78.053749] [015/131] (941s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[78.173325] Starting subtest: yf-tiled-addfb-size-overflow
[78.177955] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[78.267841] [016/131] (941s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[78.365898] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[78.377727] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[78.465673] [017/131] (941s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[78.559617] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[78.561677] Starting dynamic subtest: pipe-A-eDP-1
[78.612477] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[78.620614] Starting dynamic subtest: pipe-B-eDP-1
[78.668396] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[78.676560] Starting dynamic subtest: pipe-C-eDP-1
[78.724068] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[78.734073] Starting dynamic subtest: pipe-D-eDP-1
[78.781728] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[78.785212] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[80.771884] [018/131] (939s left) gem_close_race (basic-threads)
[80.834557] Starting subtest: basic-threads
[82.183788] Subtest basic-threads: SUCCESS (1.347s)
[82.382759] [019/131] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[82.485281] Starting subtest: fbcpsr-2p-rte
[82.489399] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[82.578412] [020/131] (937s left) sysfs_timeslice_duration (timeout)
[82.635720] Starting subtest: timeout
[82.638118] Starting dynamic subtest: vecs0
[91.924517] Dynamic subtest vecs0: SUCCESS (9.283s)
[91.934360] Starting dynamic subtest: ccs0
[93.191048] Dynamic subtest ccs0: SUCCESS (1.267s)
[93.200663] Starting dynamic subtest: vcs0
[102.929459] Dynamic subtest vcs0: SUCCESS (9.734s)
[102.937919] Starting dynamic subtest: bcs0
[103.511934] Dynamic subtest bcs0: SUCCESS (0.582s)
[103.521433] Starting dynamic subtest: rcs0
[104.729041] Dynamic subtest rcs0: SUCCESS (1.216s)
[104.738351] Starting dynamic subtest: vcs1
[113.930430] Dynamic subtest vcs1: SUCCESS (9.197s)
[113.932690] Subtest timeout: SUCCESS (31.284s)
[114.001339] [021/131] (906s left) gem_exec_params (sol-reset-not-gen7)
[114.057322] Starting subtest: sol-reset-not-gen7
[114.061751] Subtest sol-reset-not-gen7: SUCCESS (0.005s)
[114.185575] [022/131] (905s left) kms_chamelium_edid (hdmi-edid-read)
[114.590685] Subtest hdmi-edid-read: SKIP (0.000s)
[115.395227] [023/131] (904s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[115.496670] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[115.501138] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[115.600678] [024/131] (904s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[115.659600] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[115.664347] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[115.851698] [025/131] (904s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[115.973525] Starting subtest: 2x-flip-vs-cursor-legacy
[115.977974] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[116.114502] [026/131] (904s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[116.211314] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[116.215770] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[116.284323] [027/131] (904s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[116.376739] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[116.379073] Starting dynamic subtest: pipe-A-eDP-1
[116.402179] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[116.412323] Starting dynamic subtest: pipe-B-eDP-1
[116.433995] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[116.440788] Starting dynamic subtest: pipe-C-eDP-1
[116.461462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[116.468224] Starting dynamic subtest: pipe-D-eDP-1
[116.490330] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[116.494445] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[118.660465] [028/131] (901s left) gem_sync (basic-each)
[118.729362] Starting subtest: basic-each
[120.982137] Subtest basic-each: SUCCESS (2.264s)
[121.167227] [029/131] (899s left) kms_cursor_edge_walk (64x64-top-edge)
[121.254054] Starting subtest: 64x64-top-edge
[121.256407] Starting dynamic subtest: pipe-A-eDP-1
[124.717278] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[124.729112] Starting dynamic subtest: pipe-D-eDP-1
[127.850308] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[127.852314] Subtest 64x64-top-edge: SUCCESS (6.595s)
[128.651548] [030/131] (891s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[128.742980] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[128.747391] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[128.829684] [031/131] (891s left) kms_psr (psr-cursor-plane-move)
[128.924727] Starting subtest: psr-cursor-plane-move
[128.927059] Starting dynamic subtest: eDP-1
[130.643968] Dynamic subtest eDP-1: SUCCESS (1.718s)
[130.645997] Subtest psr-cursor-plane-move: SUCCESS (1.718s)
[131.513774] [032/131] (889s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[131.602719] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[131.604935] Starting dynamic subtest: pipe-A-eDP-1
[131.625568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[131.635127] Starting dynamic subtest: pipe-B-eDP-1
[131.654429] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[131.661345] Starting dynamic subtest: pipe-C-eDP-1
[131.680805] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[131.687481] Starting dynamic subtest: pipe-D-eDP-1
[131.706605] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[131.708531] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[133.873518] [033/131] (886s left) gem_mmap_gtt (hang)
[133.934816] Subtest hang: SKIP (0.000s)
[133.988090] [034/131] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[134.103702] Starting subtest: basic-busy-flip-before-cursor-atomic
[134.108087] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[134.245924] [035/131] (886s left) gem_exec_reloc (basic-wc-read)
[134.296399] Subtest basic-wc-read: SKIP (0.000s)
[134.368122] [036/131] (886s left) gem_mmap_gtt (basic-small-copy-xy)
[134.420414] Subtest basic-small-copy-XY: SKIP (0.000s)
[134.482506] [037/131] (886s left) gen9_exec_parse (bb-start-far)
[134.538069] Subtest bb-start-far: SKIP (0.000s)
[134.610391] [038/131] (886s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[134.706726] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[134.708927] Starting dynamic subtest: pipe-A-eDP-1
[134.728630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[134.736451] Starting dynamic subtest: pipe-B-eDP-1
[134.755694] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[134.762901] Starting dynamic subtest: pipe-C-eDP-1
[134.781731] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[134.789432] Starting dynamic subtest: pipe-D-eDP-1
[134.808050] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[134.810094] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[136.947577] [039/131] (883s left) kms_content_protection (legacy)
[137.099892] Starting subtest: legacy
[137.104720] Subtest legacy: SKIP (0.000s)
[137.211765] [040/131] (883s left) kms_vblank (query-idle)
[137.309888] Starting subtest: query-idle
[137.311836] Starting dynamic subtest: pipe-A-eDP-1
[139.057638] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.749s)
[139.072883] Starting dynamic subtest: pipe-D-eDP-1
[141.475648] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.415s)
[141.478107] Subtest query-idle: SUCCESS (4.167s)
[142.298593] [041/131] (878s left) gem_ctx_param (invalid-get-no-zeromap)
[142.344967] Starting subtest: invalid-get-no-zeromap
[142.347159] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[142.461572] [042/131] (878s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[142.529761] Starting subtest: etime-single-wait-for-submit-unsubmitted
[142.632754] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[142.723320] [043/131] (878s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[142.813544] Starting subtest: 4-tiled-8bpp-rotate-270
[142.834870] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[142.946917] [044/131] (878s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[143.042842] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[143.047276] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[143.143734] [045/131] (877s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[143.241167] Starting subtest: x-tiled-addfb-size-offset-overflow
[143.243445] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[143.338596] [046/131] (877s left) tools_test (sysfs_l3_parity)
[143.384518] Starting subtest: sysfs_l3_parity
[143.451412] Subtest sysfs_l3_parity: SKIP (0.078s)
[143.503480] [047/131] (877s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[143.599974] Starting subtest: fbc-psr2-cursor-mmap-gtt
[143.602306] Starting dynamic subtest: eDP-1
[143.606651] Dynamic subtest eDP-1: SKIP (0.000s)
[143.611581] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[143.681546] [048/131] (877s left) api_intel_allocator (open-vm)
[143.735584] Starting subtest: open-vm
[143.740273] Subtest open-vm: SUCCESS (0.006s)
[143.870587] [049/131] (877s left) gem_exec_reloc (basic-range-active)
[143.922685] Subtest basic-range-active: SKIP (0.000s)
[143.996879] [050/131] (877s left) kms_fbcon_fbt (psr-suspend)
[144.057499] Starting subtest: psr-suspend
[193.319247] Subtest psr-suspend: SUCCESS (19.387s)
[193.428039] [051/131] (827s left) gem_exec_balancer (parallel-balancer)
[193.707330] Starting subtest: parallel-balancer
[194.594744] Subtest parallel-balancer: SUCCESS (0.868s)
[194.702449] [052/131] (826s left) kms_cursor_crc (cursor-random-max-size)
[195.007350] Starting subtest: cursor-random-max-size
[195.014703] Subtest cursor-random-max-size: SKIP (0.000s)
[195.141714] [053/131] (826s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[195.214054] Starting subtest: map-fixed-invalidate-overlap
[195.219132] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[195.326831] [054/131] (826s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[195.385157] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[195.442692] [055/131] (826s left) i915_drm_fdinfo (most-busy-idle-check-all)
[195.487334] Starting subtest: most-busy-idle-check-all
[195.490009] Starting dynamic subtest: rcs0
[195.495000] Dynamic subtest rcs0: SKIP (0.004s)
[195.503759] Starting dynamic subtest: bcs0
[195.508972] Dynamic subtest bcs0: SKIP (0.000s)
[195.517172] Starting dynamic subtest: vcs0
[195.522135] Dynamic subtest vcs0: SKIP (0.000s)
[195.530076] Starting dynamic subtest: vcs1
[195.534935] Dynamic subtest vcs1: SKIP (0.000s)
[195.542996] Starting dynamic subtest: vecs0
[195.547966] Dynamic subtest vecs0: SKIP (0.001s)
[195.555646] Starting dynamic subtest: ccs0
[195.560387] Dynamic subtest ccs0: SKIP (0.000s)
[195.565183] Subtest most-busy-idle-check-all: SKIP (0.010s)
[195.606994] [056/131] (825s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[195.742349] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[195.746951] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[195.845552] [057/131] (825s left) kms_psr (fbc-pr-cursor-plane-move)
[195.935196] Starting subtest: fbc-pr-cursor-plane-move
[195.940086] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[196.007497] [058/131] (825s left) kms_flip (wf_vblank-ts-check)
[196.099524] Starting subtest: wf_vblank-ts-check
[196.101243] Starting dynamic subtest: A-eDP1
[216.860522] Dynamic subtest A-eDP1: SUCCESS (20.636s)
[216.868981] Starting dynamic subtest: B-eDP1
[225.796342] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[225.804885] Starting dynamic subtest: C-eDP1
[234.726001] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[234.736117] Starting dynamic subtest: D-eDP1
[243.659988] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[243.665824] Subtest wf_vblank-ts-check: SUCCESS (47.432s)
[244.872098] [059/131] (776s left) kms_async_flips (test-cursor-atomic)
[244.958049] Starting subtest: test-cursor-atomic
[245.331983] Starting dynamic subtest: pipe-A-eDP-1
[246.167144] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.837s)
[246.537297] Starting dynamic subtest: pipe-B-eDP-1
[247.295103] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[247.670334] Starting dynamic subtest: pipe-C-eDP-1
[248.420499] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.757s)
[248.790268] Starting dynamic subtest: pipe-D-eDP-1
[249.553748] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[249.556384] Subtest test-cursor-atomic: SUCCESS (4.597s)
[250.730406] [060/131] (770s left) kms_dp_linktrain_fallback (dp-fallback)
[250.816351] Starting subtest: dp-fallback
[250.824208] Subtest dp-fallback: SKIP (0.000s)
[250.888122] [061/131] (770s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[250.943379] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[250.946327] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[251.041538] [062/131] (770s left) gem_ctx_persistence (legacy-engines-queued)
[251.098174] Starting subtest: legacy-engines-queued
[251.101336] Starting dynamic subtest: render
[251.159930] Dynamic subtest render: SUCCESS (0.061s)
[251.171180] Starting dynamic subtest: bsd1
[252.369499] Dynamic subtest bsd1: SUCCESS (1.206s)
[252.381405] Starting dynamic subtest: bsd2
[254.352465] Dynamic subtest bsd2: SUCCESS (1.979s)
[254.364224] Starting dynamic subtest: blt
[254.383408] Dynamic subtest blt: SUCCESS (0.029s)
[254.392364] Starting dynamic subtest: vebox
[256.337812] Dynamic subtest vebox: SUCCESS (1.952s)
[256.340917] Subtest legacy-engines-queued: SUCCESS (5.239s)
[256.425649] [063/131] (765s left) gem_exec_schedule (u-lateslice)
[256.506109] Starting subtest: u-lateslice
[256.508838] Starting dynamic subtest: rcs0
[256.529768] Dynamic subtest rcs0: SUCCESS (0.037s)
[256.540356] Starting dynamic subtest: bcs0
[256.555231] Dynamic subtest bcs0: SUCCESS (0.025s)
[256.563828] Starting dynamic subtest: vcs0
[256.582307] Dynamic subtest vcs0: SUCCESS (0.025s)
[256.590917] Starting dynamic subtest: vcs1
[256.618665] Dynamic subtest vcs1: SUCCESS (0.035s)
[256.627247] Starting dynamic subtest: vecs0
[256.652765] Dynamic subtest vecs0: SUCCESS (0.032s)
[256.661472] Starting dynamic subtest: ccs0
[256.681323] Dynamic subtest ccs0: SUCCESS (0.027s)
[256.683911] Subtest u-lateslice: SUCCESS (0.190s)
[258.432183] [064/131] (763s left) gem_partial_pwrite_pread (write-snoop)
[258.498683] Subtest write-snoop: SKIP (0.000s)
[258.569997] [065/131] (763s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[258.662080] Starting subtest: read-crc-frame-sequence
[258.664702] Starting dynamic subtest: pipe-A-eDP-1
[259.370144] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[259.378644] Starting dynamic subtest: pipe-B-eDP-1
[260.718940] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s)
[260.729306] Starting dynamic subtest: pipe-C-eDP-1
[262.103846] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[262.113445] Starting dynamic subtest: pipe-D-eDP-1
[263.436264] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[263.438814] Subtest read-crc-frame-sequence: SUCCESS (4.771s)
[264.250807] [066/131] (757s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[264.327312] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[264.330476] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[264.427547] [067/131] (757s left) kms_feature_discovery (display-2x)
[264.517422] Starting subtest: display-2x
[264.522365] Subtest display-2x: SKIP (0.000s)
[264.586924] [068/131] (757s left) syncobj_wait (wait-all-delayed-signal)
[264.642431] Starting subtest: wait-all-delayed-signal
[264.743852] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[264.830468] [069/131] (757s left) kms_legacy_colorkey (basic)
[264.928203] Starting subtest: basic
[264.931052] Starting dynamic subtest: pipe-A
[264.971697] Dynamic subtest pipe-A: SUCCESS (0.045s)
[264.983476] Starting dynamic subtest: pipe-B
[264.986116] Dynamic subtest pipe-B: SUCCESS (0.000s)
[264.994707] Starting dynamic subtest: pipe-C
[264.997460] Dynamic subtest pipe-C: SUCCESS (0.000s)
[265.005049] Starting dynamic subtest: pipe-D
[265.007214] Dynamic subtest pipe-D: SUCCESS (0.000s)
[265.009613] Subtest basic: SUCCESS (0.049s)
[265.060668] [070/131] (757s left) kms_cdclk (plane-scaling)
[265.152008] Starting subtest: plane-scaling
[265.154700] Starting dynamic subtest: pipe-A-eDP-1
[265.442371] Dynamic subtest pipe-A-eDP-1: SKIP (0.285s)
[265.451669] Starting dynamic subtest: pipe-B-eDP-1
[265.457302] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[265.466024] Starting dynamic subtest: pipe-C-eDP-1
[265.471573] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[265.480064] Starting dynamic subtest: pipe-D-eDP-1
[265.485406] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[265.491231] Subtest plane-scaling: SKIP (0.292s)
[266.276652] [071/131] (755s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[266.336908] Starting subtest: multi-wait-all-for-submit-available-signaled
[266.339371] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[266.446398] [072/131] (755s left) gem_pxp (create-protected-buffer)
[266.566734] Starting subtest: create-protected-buffer
[266.569650] Subtest create-protected-buffer: SUCCESS (0.000s)
[266.682518] [073/131] (755s left) i915_suspend (forcewake)
[266.734526] Starting subtest: forcewake
[298.318298] Subtest forcewake: SUCCESS (2.289s)
[299.391875] [074/131] (723s left) kms_cursor_crc (cursor-offscreen-256x85)
[299.666870] Starting subtest: cursor-offscreen-256x85
[299.720030] Subtest cursor-offscreen-256x85: SKIP (0.046s)
[299.902617] [075/131] (723s left) kms_big_fb (linear-64bpp-rotate-180)
[300.023941] Starting subtest: linear-64bpp-rotate-180
[301.532997] Subtest linear-64bpp-rotate-180: SUCCESS (1.458s)
[301.703372] [076/131] (721s left) gem_exec_reloc (basic-gtt-read)
[301.764955] Subtest basic-gtt-read: SKIP (0.000s)
[301.834195] [077/131] (721s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[301.919719] Starting subtest: pixel-format-linear-modifier-source-clamping
[301.945823] Starting dynamic subtest: pipe-A-plane-0
[305.608969] Dynamic subtest pipe-A-plane-0: SUCCESS (3.577s)
[305.619398] Starting dynamic subtest: pipe-A-plane-3
[307.461188] Dynamic subtest pipe-A-plane-3: SUCCESS (1.821s)
[308.610052] Starting dynamic subtest: pipe-B-plane-0
[312.224993] Dynamic subtest pipe-B-plane-0: SUCCESS (3.589s)
[312.235725] Starting dynamic subtest: pipe-B-plane-3
[313.960182] Dynamic subtest pipe-B-plane-3: SUCCESS (1.720s)
[314.304385] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.203s)
[315.141530] [078/131] (708s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[315.228290] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[315.230616] Starting dynamic subtest: pipe-A
[315.290863] Dynamic subtest pipe-A: SUCCESS (0.064s)
[315.301693] Starting dynamic subtest: pipe-B
[316.480353] Dynamic subtest pipe-B: SUCCESS (1.183s)
[316.491746] Starting dynamic subtest: pipe-C
[317.599546] Dynamic subtest pipe-C: SUCCESS (1.112s)
[317.607894] Starting dynamic subtest: pipe-D
[318.730580] Dynamic subtest pipe-D: SUCCESS (1.126s)
[318.733077] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.489s)
[319.896924] [079/131] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[320.003638] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[327.405779] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.388s)
[327.552659] [080/131] (695s left) gem_wait (invalid-flags)
[327.608278] Starting subtest: invalid-flags
[327.610709] Subtest invalid-flags: SUCCESS (0.000s)
[327.841541] [081/131] (695s left) kms_psr (fbc-psr-primary-mmap-gtt)
[327.940012] Starting subtest: fbc-psr-primary-mmap-gtt
[327.942348] Starting dynamic subtest: eDP-1
[327.946404] Dynamic subtest eDP-1: SKIP (0.000s)
[327.950459] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[328.011546] [082/131] (695s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[328.070390] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[328.072923] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[328.174686] [083/131] (695s left) gem_eio (in-flight-contexts-1us)
[328.403838] Starting subtest: in-flight-contexts-1us
[339.683700] Subtest in-flight-contexts-1us: SUCCESS (11.277s)
[339.865938] [084/131] (683s left) gem_spin_batch (resubmit)
[339.932078] Starting subtest: resubmit
[339.934320] Starting dynamic subtest: rcs0
[339.938791] Dynamic subtest rcs0: SUCCESS (0.006s)
[339.947606] Starting dynamic subtest: bcs0
[339.949509] Dynamic subtest bcs0: SUCCESS (0.002s)
[339.957700] Starting dynamic subtest: vcs0
[339.959875] Dynamic subtest vcs0: SUCCESS (0.004s)
[339.967882] Starting dynamic subtest: vcs1
[339.970063] Dynamic subtest vcs1: SUCCESS (0.002s)
[339.978266] Starting dynamic subtest: vecs0
[339.980414] Dynamic subtest vecs0: SUCCESS (0.003s)
[339.988668] Starting dynamic subtest: ccs0
[339.990874] Dynamic subtest ccs0: SUCCESS (0.003s)
[339.993085] Subtest resubmit: SUCCESS (0.025s)
[340.177087] [085/131] (683s left) syncobj_wait (invalid-reset-bad-pad)
[340.229750] Starting subtest: invalid-reset-bad-pad
[340.232207] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[340.321122] [086/131] (683s left) prime_mmap (test_forked_cpu_write)
[340.388818] Starting subtest: test_forked_cpu_write
[340.391155] Starting dynamic subtest: test_forked_cpu_write-smem
[340.393407] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s)
[340.395682] Subtest test_forked_cpu_write: SUCCESS (0.007s)
[340.500519] [087/131] (683s left) syncobj_timeline (signal)
[340.556495] Starting subtest: signal
[340.558914] Subtest signal: SUCCESS (0.000s)
[340.651534] [088/131] (683s left) kms_big_fb (y-tiled-addfb)
[340.750687] Starting subtest: y-tiled-addfb
[340.754351] Subtest y-tiled-addfb: SKIP (0.000s)
[340.861282] [089/131] (683s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[340.956485] Starting subtest: fbcpsr-tiling-y
[340.959884] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[341.071859] [090/131] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[341.165460] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[341.168944] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[341.262617] [091/131] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[341.369498] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[345.318051] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.949s)
[346.462774] [092/131] (677s left) gem_pipe_control_store_loop (reused-buffer)
[346.530049] Starting subtest: reused-buffer
[348.684585] Subtest reused-buffer: SUCCESS (2.151s)
[348.801424] [093/131] (675s left) kms_pm_rpm (pm-tiling)
[350.838238] Starting subtest: pm-tiling
[350.843790] Subtest pm-tiling: SKIP (0.000s)
[351.208744] [094/131] (672s left) gem_exec_schedule (deep)
[351.387722] Starting subtest: deep
[351.390269] Starting dynamic subtest: rcs0
[356.914253] Dynamic subtest rcs0: SKIP (5.521s)
[356.925376] Starting dynamic subtest: vcs0
[367.933966] Dynamic subtest vcs0: SUCCESS (11.014s)
[367.949546] Starting dynamic subtest: vcs1
[379.854768] Dynamic subtest vcs1: SUCCESS (11.914s)
[379.867126] Starting dynamic subtest: vecs0
[392.050040] Dynamic subtest vecs0: SUCCESS (12.189s)
[392.062982] Starting dynamic subtest: ccs0
[404.870661] Dynamic subtest ccs0: SUCCESS (12.822s)
[404.873400] Subtest deep: SUCCESS (53.467s)
[406.025196] [095/131] (618s left) gem_render_copy (yf-tiled)
[406.072547] Starting subtest: yf-tiled
[406.076795] Subtest yf-tiled: SKIP (0.000s)
[406.258794] [096/131] (617s left) gem_exec_schedule (out-order)
[406.341247] Starting subtest: out-order
[406.343341] Starting dynamic subtest: rcs0
[406.503209] Dynamic subtest rcs0: SUCCESS (0.169s)
[406.514982] Starting dynamic subtest: vcs0
[406.618482] Dynamic subtest vcs0: SUCCESS (0.113s)
[406.632569] Starting dynamic subtest: vcs1
[406.725250] Dynamic subtest vcs1: SUCCESS (0.107s)
[406.737651] Starting dynamic subtest: vecs0
[406.825723] Dynamic subtest vecs0: SUCCESS (0.100s)
[406.837616] Starting dynamic subtest: ccs0
[406.969179] Dynamic subtest ccs0: SUCCESS (0.142s)
[406.972406] Subtest out-order: SUCCESS (0.634s)
[407.730155] [097/131] (616s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[407.847385] Starting subtest: cursorB-vs-flipA-legacy
[407.851658] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[407.992737] [098/131] (616s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[408.086413] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[408.088697] Starting dynamic subtest: pipe-A-default-mode
[409.284542] Dynamic subtest pipe-A-default-mode: SKIP (1.198s)
[409.289328] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.199s)
[409.457628] [099/131] (614s left) kms_joiner (invalid-modeset-force-big-joiner)
[409.568486] Starting subtest: invalid-modeset-force-big-joiner
[409.572555] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[409.634126] [100/131] (614s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[409.746500] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[409.750803] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[409.825581] [101/131] (614s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[409.883217] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[409.987630] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[410.075726] [102/131] (614s left) core_getclient (basic)
[410.128991] Starting subtest: basic
[410.130927] Subtest basic: SUCCESS (0.000s)
[410.224445] [103/131] (614s left) perf (gen12-group-exclusive-stream-sample-oa)
[410.350524] Starting subtest: gen12-group-exclusive-stream-sample-oa
[410.375211] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.024s)
[410.421892] [104/131] (614s left) prime_self_import (basic-with_two_bos)
[410.455574] Starting subtest: basic-with_two_bos
[410.466070] Subtest basic-with_two_bos: SUCCESS (0.016s)
[410.569935] [105/131] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[410.678776] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[410.682764] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[410.775013] [106/131] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[410.868311] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[410.872270] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[410.972693] [107/131] (613s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[411.063262] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[411.066963] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[411.156768] [108/131] (613s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[411.246005] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[411.249475] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[411.342932] [109/131] (613s left) kms_getfb (getfb2-handle-zero)
[411.432689] Starting subtest: getfb2-handle-zero
[411.434669] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[411.530192] [110/131] (613s left) gem_mmap_gtt (pf-nonblock)
[411.577706] Subtest pf-nonblock: SKIP (0.000s)
[411.648463] [111/131] (613s left) gem_exec_reloc (basic-cpu-noreloc)
[411.702808] Subtest basic-cpu-noreloc: SKIP (0.000s)
[411.760251] [112/131] (613s left) fbdev (unaligned-read)
[411.800879] Starting subtest: unaligned-read
[411.815379] Subtest unaligned-read: SUCCESS (0.014s)
[411.867425] [113/131] (613s left) kms_prop_blob (blob-prop-core)
[411.929936] Starting subtest: blob-prop-core
[411.931774] Subtest blob-prop-core: SUCCESS (0.000s)
[412.034097] [114/131] (612s left) kms_color (ctm-0-75)
[412.120146] Starting subtest: ctm-0-75
[412.121857] Starting dynamic subtest: pipe-A-eDP-1
[417.102246] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.982s)
[417.111427] Starting dynamic subtest: pipe-B-eDP-1
[422.801007] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.699s)
[422.810506] Starting dynamic subtest: pipe-C-eDP-1
[428.196873] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.394s)
[428.208876] Starting dynamic subtest: pipe-D-eDP-1
[433.506405] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.310s)
[433.508760] Subtest ctm-0-75: SUCCESS (21.388s)
[434.324968] [115/131] (590s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[434.717873] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[435.534554] [116/131] (589s left) gem_mmap_gtt (basic-small-copy-odd)
[435.597494] Subtest basic-small-copy-odd: SKIP (0.000s)
[435.654783] [117/131] (589s left) gem_exec_flush (basic-wb-pro-default)
[435.712145] Starting subtest: basic-wb-pro-default
[441.165888] Subtest basic-wb-pro-default: SUCCESS (5.453s)
[441.358980] [118/131] (583s left) gem_close_race (basic-process)
[441.428449] Starting subtest: basic-process
[441.471983] Subtest basic-process: SUCCESS (0.043s)
[441.656987] [119/131] (583s left) i915_pm_rpm (gem-evict-pwrite)
[443.785870] Starting subtest: gem-evict-pwrite
[443.790935] Subtest gem-evict-pwrite: SKIP (0.000s)
[444.169929] [120/131] (580s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[444.261329] Starting subtest: multiplane-rotation-cropping-top
[461.654939] Subtest multiplane-rotation-cropping-top: SUCCESS (17.393s)
[461.770817] [121/131] (563s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[461.897101] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[462.866947] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.967s)
[463.685832] [122/131] (561s left) gem_exec_store (basic)
[463.753326] Starting subtest: basic
[463.867009] Subtest basic: SUCCESS (0.116s)
[464.051520] [123/131] (561s left) perf_pmu (idle)
[464.105025] Starting subtest: idle
[464.107211] Starting dynamic subtest: rcs0
[464.645252] Dynamic subtest rcs0: SUCCESS (0.538s)
[464.656756] Starting dynamic subtest: bcs0
[465.161639] Dynamic subtest bcs0: SUCCESS (0.513s)
[465.170982] Starting dynamic subtest: vcs0
[465.677255] Dynamic subtest vcs0: SUCCESS (0.513s)
[465.690120] Starting dynamic subtest: vcs1
[466.200505] Dynamic subtest vcs1: SUCCESS (0.517s)
[466.211669] Starting dynamic subtest: vecs0
[466.713838] Dynamic subtest vecs0: SUCCESS (0.513s)
[466.725968] Starting dynamic subtest: ccs0
[467.233886] Dynamic subtest ccs0: SUCCESS (0.513s)
[467.236489] Subtest idle: SUCCESS (3.124s)
[467.320616] [124/131] (557s left) kms_psr (pr-primary-page-flip)
[467.419219] Starting subtest: pr-primary-page-flip
[467.423610] Subtest pr-primary-page-flip: SKIP (0.000s)
[467.492773] [125/131] (557s left) kms_pm_dc (dc3co-vpb-simulation)
[468.578219] Starting subtest: dc3co-vpb-simulation
[478.024595] Subtest dc3co-vpb-simulation: SKIP (9.439s)
[478.155781] [126/131] (547s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[478.252271] Starting subtest: psr-rgb101010-draw-mmap-gtt
[478.256797] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[478.359535] [127/131] (547s left) gem_exec_params (invalid-bsd-ring)
[478.412085] Starting subtest: invalid-bsd-ring
[478.414362] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[478.519538] [128/131] (546s left) kms_plane (pixel-format-y-tiled-modifier)
[478.619336] Starting subtest: pixel-format-y-tiled-modifier
[478.623832] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[478.692151] [129/131] (546s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[478.740869] Subtest writes-after-reads-uncached: SKIP (0.000s)
[478.819865] [130/131] (546s left) gem_lmem_swapping (massive-random)
[478.863564] Subtest massive-random: SKIP (0.000s)
[478.902725] [131/131] (546s left) kms_3d (basic)
[478.963383] Starting subtest: basic
[481.143507] Subtest basic: SUCCESS (2.181s)
[481.623159] Closing watchdogs
results: parsing output: 0/ for test: drm_mm
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: sriov_basic
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_universal_plane
results: parsing output: 5/ for test: kms_pipe_b_c_ivb
results: parsing output: 6/ for test: gem_exec_basic
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: i915_getparams_basic
results: parsing output: 10/ for test: gem_close_race
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_vm_create
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_close_race
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: sysfs_timeslice_duration
results: parsing output: 20/ for test: gem_exec_params
results: parsing output: 21/ for test: kms_chamelium_edid
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_sync
results: parsing output: 28/ for test: kms_cursor_edge_walk
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_content_protection
results: parsing output: 39/ for test: kms_vblank
results: parsing output: 40/ for test: gem_ctx_param
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: tools_test
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: api_intel_allocator
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_fbcon_fbt
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: kms_dp_linktrain_fallback
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_ctx_persistence
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: gem_partial_pwrite_pread
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_feature_discovery
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_legacy_colorkey
results: parsing output: 69/ for test: kms_cdclk
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_pxp
results: parsing output: 72/ for test: i915_suspend
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_wait
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: gem_spin_batch
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: prime_mmap
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_pipe_control_store_loop
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_joiner
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: core_getclient
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: prime_self_import
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_getfb
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: fbdev
results: parsing output: 112/ for test: kms_prop_blob
results: parsing output: 113/ for test: kms_color
results: parsing output: 114/ for test: kms_chamelium_hpd
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: gem_exec_flush
results: parsing output: 117/ for test: gem_close_race
results: parsing output: 118/ for test: i915_pm_rpm
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_exec_store
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_pm_dc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: gem_partial_pwrite_pread
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: kms_3d
Done.