[57.383978] Initializing watchdogs
[57.384050]   /dev/watchdog0
[57.397490] [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]
[57.401589] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.404035] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.407427] [001/133] (960s left) sriov_basic (enable-vfs-autoprobe-on)
[57.498916] Starting subtest: enable-vfs-autoprobe-on
[57.501419] Starting dynamic subtest: numvfs-1
[57.580309] Dynamic subtest numvfs-1: FAIL (0.034s)
[57.588329] Starting dynamic subtest: numvfs-2
[57.659651] Dynamic subtest numvfs-2: FAIL (0.004s)
[57.668222] Starting dynamic subtest: numvfs-3
[57.739660] Dynamic subtest numvfs-3: FAIL (0.003s)
[57.747896] Starting dynamic subtest: numvfs-4
[57.821838] Dynamic subtest numvfs-4: FAIL (0.003s)
[57.829898] Starting dynamic subtest: numvfs-5
[57.901786] Dynamic subtest numvfs-5: FAIL (0.003s)
[57.909199] Starting dynamic subtest: numvfs-6
[57.981084] Dynamic subtest numvfs-6: FAIL (0.004s)
[57.988787] Starting dynamic subtest: numvfs-7
[58.061293] Dynamic subtest numvfs-7: FAIL (0.003s)
[58.067138] Starting dynamic subtest: numvfs-random
[58.138631] Dynamic subtest numvfs-random: FAIL (0.003s)
[58.145544] Starting dynamic subtest: numvfs-all
[58.217268] Dynamic subtest numvfs-all: FAIL (0.495s)
[58.218953] Subtest enable-vfs-autoprobe-on: FAIL (0.557s)
[58.251123] [002/133] (959s left) syncobj_timeline (wait-all-interrupted)
[58.303075] Starting subtest: wait-all-interrupted
[58.403780] Subtest wait-all-interrupted: SUCCESS (0.102s)
[58.487689] [003/133] (959s left) perf_pmu (enable-race)
[58.526471] Starting subtest: enable-race
[58.528362] Starting dynamic subtest: rcs0
[71.286451] Dynamic subtest rcs0: SUCCESS (12.796s)
[71.293822] Starting dynamic subtest: bcs0
[84.023146] Dynamic subtest bcs0: SUCCESS (12.740s)
[84.030852] Starting dynamic subtest: vcs0
[99.861364] Dynamic subtest vcs0: SUCCESS (15.835s)
[99.868863] Starting dynamic subtest: vcs1
[115.923348] Dynamic subtest vcs1: SUCCESS (16.061s)
[115.931132] Starting dynamic subtest: vecs0
[131.924948] Dynamic subtest vecs0: SUCCESS (16.000s)
[131.933053] Starting dynamic subtest: ccs0
[144.681474] Dynamic subtest ccs0: SUCCESS (12.756s)
[144.684241] Subtest enable-race: SUCCESS (86.193s)
[144.801948] [004/133] (873s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[144.857987] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[144.860484] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[144.967838] [005/133] (873s left) gem_exec_balancer (hog)
[145.021360] Starting subtest: hog
[145.026108] Subtest hog: SKIP (0.000s)
[145.343591] [006/133] (872s left) gem_exec_parallel (engines)
[145.400079] Starting subtest: engines
[145.402607] Starting dynamic subtest: basic
[148.889185] Dynamic subtest basic: SUCCESS (3.487s)
[148.896557] Starting dynamic subtest: contexts
[153.232990] Dynamic subtest contexts: SUCCESS (4.342s)
[153.241086] Starting dynamic subtest: fds
[156.999777] Dynamic subtest fds: SUCCESS (3.765s)
[157.009473] Starting dynamic subtest: userptr
[158.932443] Dynamic subtest userptr: SUCCESS (1.932s)
[158.934965] Subtest engines: SUCCESS (13.529s)
[159.132070] [007/133] (858s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[159.229292] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[159.231490] Starting dynamic subtest: pipe-A-eDP-1
[159.254714] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.264156] Starting dynamic subtest: pipe-B-eDP-1
[159.286413] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.293610] Starting dynamic subtest: pipe-C-eDP-1
[159.315871] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.323758] Starting dynamic subtest: pipe-D-eDP-1
[159.345394] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.349782] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[161.522868] [008/133] (856s left) gem_eio (create-ext)
[161.752730] Starting subtest: create-ext
[162.089708] Subtest create-ext: SUCCESS (0.335s)
[162.249176] [009/133] (855s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[162.341362] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[162.343699] Starting dynamic subtest: pipe-A-eDP-1
[162.804341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[162.813924] Starting dynamic subtest: pipe-B-eDP-1
[164.253421] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[164.262060] Starting dynamic subtest: pipe-C-eDP-1
[165.614864] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.357s)
[165.624593] Starting dynamic subtest: pipe-D-eDP-1
[166.952712] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[166.954598] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.582s)
[168.146213] [010/133] (850s left) i915_pm_rpm (reg-read-ioctl)
[170.005708] Starting subtest: reg-read-ioctl
[172.296610] Subtest reg-read-ioctl: SUCCESS (2.291s)
[172.684925] [011/133] (845s left) gem_fence_thrash (bo-write-verify-threaded-x)
[172.719370] Starting subtest: bo-write-verify-threaded-x
[172.737345] Subtest bo-write-verify-threaded-x: SKIP (0.014s)
[172.793229] [012/133] (845s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[172.910693] Starting subtest: flip-vs-cursor-atomic-transitions
[180.436286] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.522s)
[181.310610] [013/133] (837s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[181.445655] Starting subtest: cursorB-vs-flipA-atomic
[181.449944] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[181.601733] [014/133] (836s left) kms_dsc (dsc-with-bpc-formats)
[181.699843] Starting subtest: dsc-with-bpc-formats
[181.809316] Subtest dsc-with-bpc-formats: SKIP (0.006s)
[181.844334] [015/133] (836s left) kms_chamelium_frames (dp-crc-single)
[182.241579] Subtest dp-crc-single: SKIP (0.000s)
[183.012951] [016/133] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[183.113739] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[183.117670] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[183.229266] [017/133] (835s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[183.285106] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[183.353183] [018/133] (835s left) gem_basic (bad-close)
[183.407879] Starting subtest: bad-close
[183.412330] Subtest bad-close: SUCCESS (0.000s)
[183.541580] [019/133] (835s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[183.643620] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[183.670810] Starting dynamic subtest: pipe-A-plane-0
[183.675287] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[183.685181] Starting dynamic subtest: pipe-A-plane-3
[183.689464] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[183.696925] Starting dynamic subtest: pipe-A-plane-5
[183.701199] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[184.745964] Starting dynamic subtest: pipe-B-plane-0
[184.750523] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[184.759012] Starting dynamic subtest: pipe-B-plane-3
[184.763751] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[184.772502] Starting dynamic subtest: pipe-B-plane-5
[184.776970] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[185.048983] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (1.404s)
[185.931796] [020/133] (832s left) gem_exec_reloc (basic-write-cpu-active)
[185.996695] Subtest basic-write-cpu-active: SKIP (0.000s)
[186.070831] [021/133] (832s left) i915_hangman (error-state-basic)
[186.141662] Starting subtest: error-state-basic
[186.296091] Subtest error-state-basic: SUCCESS (0.156s)
[186.380180] [022/133] (832s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[186.480185] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[187.446587] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.967s)
[187.614986] [023/133] (831s left) kms_cursor_crc (cursor-random-128x42)
[187.856159] Starting subtest: cursor-random-128x42
[187.900668] Subtest cursor-random-128x42: SKIP (0.039s)
[188.136813] [024/133] (830s left) gem_partial_pwrite_pread (writes-after-reads)
[188.212223] Subtest writes-after-reads: SKIP (0.000s)
[188.299225] [025/133] (830s left) core_getclient (basic)
[188.364360] Starting subtest: basic
[188.366195] Subtest basic: SUCCESS (0.000s)
[188.471275] [026/133] (830s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[188.565976] Starting subtest: yf-tiled-64bpp-rotate-180
[188.569517] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[188.680296] [027/133] (830s left) api_intel_allocator (default-alignment)
[188.733159] Starting subtest: default-alignment
[188.735083] Subtest default-alignment: SUCCESS (0.003s)
[188.875566] [028/133] (830s left) gem_mmap_gtt (basic-write-gtt)
[188.935046] Subtest basic-write-gtt: SKIP (0.000s)
[188.998337] [029/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[189.097463] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[189.100999] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[189.224536] [030/133] (829s left) kms_flip (flip-vs-dpms-on-nop)
[189.308886] Starting subtest: flip-vs-dpms-on-nop
[189.310571] Starting dynamic subtest: A-eDP1
[191.212498] Dynamic subtest A-eDP1: SUCCESS (1.904s)
[191.220976] Starting dynamic subtest: B-eDP1
[193.042874] Dynamic subtest B-eDP1: SUCCESS (1.829s)
[193.053080] Starting dynamic subtest: C-eDP1
[194.866686] Dynamic subtest C-eDP1: SUCCESS (1.823s)
[194.875075] Starting dynamic subtest: D-eDP1
[196.684626] Dynamic subtest D-eDP1: SUCCESS (1.816s)
[196.687068] Subtest flip-vs-dpms-on-nop: SUCCESS (7.380s)
[197.871489] [031/133] (821s left) gem_busy (busy)
[197.943296] Starting subtest: busy
[197.945741] Starting dynamic subtest: all-engines
[198.009997] Dynamic subtest all-engines: SUCCESS (0.067s)
[198.018702] Starting dynamic subtest: rcs0
[199.846729] Dynamic subtest rcs0: SUCCESS (1.825s)
[199.855427] Starting dynamic subtest: bcs0
[199.916929] Dynamic subtest bcs0: SUCCESS (0.078s)
[199.926111] Starting dynamic subtest: vcs0
[199.954780] Dynamic subtest vcs0: SUCCESS (0.038s)
[199.963064] Starting dynamic subtest: vcs1
[201.882220] Dynamic subtest vcs1: SUCCESS (1.924s)
[201.892253] Starting dynamic subtest: vecs0
[203.929792] Dynamic subtest vecs0: SUCCESS (2.047s)
[203.939428] Starting dynamic subtest: ccs0
[205.913963] Dynamic subtest ccs0: SUCCESS (1.984s)
[205.916688] Subtest busy: SUCCESS (7.968s)
[206.278408] [032/133] (812s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[206.371729] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[206.375580] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[206.507864] [033/133] (812s left) gem_exec_basic (basic)
[206.565293] Starting subtest: basic
[206.567500] Starting dynamic subtest: rcs0-smem
[206.569814] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[206.578742] Starting dynamic subtest: bcs0-smem
[206.580614] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[206.588049] Starting dynamic subtest: vcs0-smem
[206.589935] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[206.597306] Starting dynamic subtest: vcs1-smem
[206.599152] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[206.606299] Starting dynamic subtest: vecs0-smem
[206.608157] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[206.614968] Starting dynamic subtest: ccs0-smem
[206.616861] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[206.618757] Subtest basic: SUCCESS (0.013s)
[207.939149] [034/133] (811s left) gem_request_retire (retire-vma-not-inactive)
[207.997748] Starting subtest: retire-vma-not-inactive
[208.057475] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[208.208808] [035/133] (810s left) gem_exec_schedule (lateslice)
[208.283403] Starting subtest: lateslice
[208.285691] Starting dynamic subtest: rcs0
[208.294296] Dynamic subtest rcs0: SUCCESS (0.022s)
[208.304685] Starting dynamic subtest: bcs0
[208.312344] Dynamic subtest bcs0: SUCCESS (0.017s)
[208.320055] Starting dynamic subtest: vcs0
[208.328458] Dynamic subtest vcs0: SUCCESS (0.016s)
[208.336254] Starting dynamic subtest: vcs1
[208.347064] Dynamic subtest vcs1: SUCCESS (0.018s)
[208.354887] Starting dynamic subtest: vecs0
[208.364279] Dynamic subtest vecs0: SUCCESS (0.017s)
[208.371854] Starting dynamic subtest: ccs0
[208.383316] Dynamic subtest ccs0: SUCCESS (0.019s)
[208.385627] Subtest lateslice: SUCCESS (0.111s)
[209.998671] [036/133] (809s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[210.062908] Starting subtest: yf-tiled-to-vebox-yf-tiled
[210.067763] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[210.257070] [037/133] (808s left) kms_chamelium_hpd (common-hpd-after-suspend)
[210.643030] Subtest common-hpd-after-suspend: SKIP (0.000s)
[211.475920] [038/133] (807s left) syncobj_timeline (reset-signaled)
[211.539394] Starting subtest: reset-signaled
[211.541701] Subtest reset-signaled: SUCCESS (0.000s)
[211.667344] [039/133] (807s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[211.753370] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[211.782823] Starting dynamic subtest: pipe-A-plane-0
[212.205263] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[212.218678] Starting dynamic subtest: pipe-A-plane-3
[212.461510] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[212.470339] Starting dynamic subtest: pipe-A-plane-5
[212.474259] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[213.578641] Starting dynamic subtest: pipe-B-plane-0
[213.983067] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[213.992331] Starting dynamic subtest: pipe-B-plane-3
[214.250343] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[214.259188] Starting dynamic subtest: pipe-B-plane-5
[214.263739] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[214.573165] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.819s)
[215.376943] [040/133] (803s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[215.477800] Starting subtest: 4-tiled-64bpp-rotate-180
[216.911116] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.436s)
[217.131693] [041/133] (802s left) kms_psr2_su (frontbuffer-xrgb8888)
[217.201101] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[217.269986] [042/133] (802s left) kms_pm_rpm (dpms-non-lpsp)
[219.008538] Starting subtest: dpms-non-lpsp
[219.013212] Subtest dpms-non-lpsp: SKIP (0.001s)
[219.519310] [043/133] (799s left) perf (unprivileged-single-ctx-counters)
[219.649076] Starting subtest: unprivileged-single-ctx-counters
[219.653385] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[219.695884] [044/133] (799s left) gem_exec_schedule (semaphore-noskip)
[219.770609] Starting subtest: semaphore-noskip
[220.185643] Subtest semaphore-noskip: SUCCESS (0.420s)
[220.542000] [045/133] (799s left) kms_atomic_interruptible (legacy-cursor)
[220.636830] Starting subtest: legacy-cursor
[220.639063] Starting dynamic subtest: pipe-A-eDP-1
[228.023075] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.386s)
[228.025515] Subtest legacy-cursor: SUCCESS (7.387s)
[228.876994] [046/133] (790s left) sw_sync (alloc_merge_fence)
[228.928378] Starting subtest: alloc_merge_fence
[228.930334] Subtest alloc_merge_fence: SUCCESS (0.000s)
[229.013999] [047/133] (790s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[229.096697] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[229.473948] Starting dynamic subtest: pipe-A-eDP-1
[232.243369] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.768s)
[232.608503] Starting dynamic subtest: pipe-B-eDP-1
[235.374056] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[235.737996] Starting dynamic subtest: pipe-C-eDP-1
[238.503040] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[238.872037] Starting dynamic subtest: pipe-D-eDP-1
[241.637681] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[241.640212] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.542s)
[242.842969] [048/133] (776s left) kms_pm_rpm (modeset-lpsp-stress)
[245.076239] Starting subtest: modeset-lpsp-stress
[260.624763] Subtest modeset-lpsp-stress: SUCCESS (15.551s)
[260.736251] [049/133] (758s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[260.856238] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[260.860206] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[260.966437] [050/133] (758s left) prime_self_import (basic-llseek-size)
[261.011436] Starting subtest: basic-llseek-size
[261.030506] Subtest basic-llseek-size: SUCCESS (0.019s)
[261.165185] [051/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[261.269383] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[264.883461] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.619s)
[266.100765] [052/133] (753s left) gem_exec_fence (nb-await)
[266.293195] Starting subtest: nb-await
[266.295125] Starting dynamic subtest: rcs0
[266.358063] Dynamic subtest rcs0: SUCCESS (0.067s)
[266.369075] Starting dynamic subtest: bcs0
[266.415475] Dynamic subtest bcs0: SUCCESS (0.056s)
[266.425838] Starting dynamic subtest: vcs0
[266.475180] Dynamic subtest vcs0: SUCCESS (0.058s)
[266.485233] Starting dynamic subtest: vcs1
[266.533803] Dynamic subtest vcs1: SUCCESS (0.057s)
[266.543245] Starting dynamic subtest: vecs0
[266.593586] Dynamic subtest vecs0: SUCCESS (0.058s)
[266.603490] Starting dynamic subtest: ccs0
[266.653552] Dynamic subtest ccs0: SUCCESS (0.058s)
[266.655916] Subtest nb-await: SUCCESS (0.365s)
[269.012108] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[269.015293] [053/133] (750s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[269.125404] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[276.668086] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.546s)
[276.793098] [054/133] (743s left) kms_vblank (wait-idle)
[276.889231] Starting subtest: wait-idle
[276.891491] Starting dynamic subtest: pipe-A-eDP-1
[278.646090] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[278.658729] Starting dynamic subtest: pipe-D-eDP-1
[281.112870] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.467s)
[281.115826] Subtest wait-idle: SUCCESS (4.224s)
[281.951261] [055/133] (737s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[282.064332] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[282.066566] Starting dynamic subtest: pipe-A-eDP-1
[282.160498] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[282.171208] Starting dynamic subtest: pipe-B-eDP-1
[283.314178] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s)
[283.318654] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.253s)
[284.505388] [056/133] (735s left) core_hotunplug (unbind-rebind)
[284.588326] Starting subtest: unbind-rebind
[291.826851] Subtest unbind-rebind: SUCCESS (7.236s)
[291.864159] [057/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[292.899530] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[292.903903] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[293.032254] [058/133] (727s left) gem_exec_whisper (basic-contexts-forked-all)
[293.104581] Starting subtest: basic-contexts-forked-all
[311.950723] Subtest basic-contexts-forked-all: SUCCESS (18.841s)
[312.139538] [059/133] (707s left) kms_cursor_crc (cursor-suspend)
[312.272731] Starting subtest: cursor-suspend
[312.274959] Starting dynamic subtest: pipe-A-eDP-1
[345.442834] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.262s)
[345.452559] Starting dynamic subtest: pipe-D-eDP-1
[378.430827] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.740s)
[378.433476] Subtest cursor-suspend: SUCCESS (7.005s)
[379.276796] [060/133] (640s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[379.372908] Starting subtest: fbc-pr-sprite-mmap-cpu
[379.377098] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[379.467219] [061/133] (640s left) gem_pxp (create-valid-protected-context)
[379.589746] Starting subtest: create-valid-protected-context
[379.592038] Subtest create-valid-protected-context: SUCCESS (0.002s)
[379.735377] [062/133] (640s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[379.828321] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[379.832637] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[379.954492] [063/133] (640s left) syncobj_wait (multi-wait-all-signaled)
[380.016842] Starting subtest: multi-wait-all-signaled
[380.018783] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[380.121170] [064/133] (640s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[380.213462] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[384.667543] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.507s)
[385.788623] [065/133] (634s left) i915_drm_fdinfo (virtual-busy-hang)
[385.824574] Starting subtest: virtual-busy-hang
[385.829202] Subtest virtual-busy-hang: SKIP (0.000s)
[385.908497] [066/133] (634s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[386.010690] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[386.015148] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[386.096310] [067/133] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[386.194023] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[386.198453] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[386.321821] [068/133] (634s left) gem_eio (banned)
[386.560364] Starting subtest: banned
[387.226622] Subtest banned: SUCCESS (0.672s)
[387.409047] [069/133] (633s left) gem_softpin (evict-prime)
[387.473351] Starting subtest: evict-prime
[387.475419] Starting dynamic subtest: rcs0
[388.656826] Dynamic subtest rcs0: SUCCESS (1.189s)
[388.669699] Starting dynamic subtest: bcs0
[389.800502] Dynamic subtest bcs0: SUCCESS (1.147s)
[389.812667] Starting dynamic subtest: vcs0
[391.194891] Dynamic subtest vcs0: SUCCESS (1.397s)
[391.207289] Starting dynamic subtest: vcs1
[393.165984] Dynamic subtest vcs1: SUCCESS (1.974s)
[393.178848] Starting dynamic subtest: vecs0
[395.165590] Dynamic subtest vecs0: SUCCESS (2.003s)
[395.177831] Starting dynamic subtest: ccs0
[396.317114] Dynamic subtest ccs0: SUCCESS (1.153s)
[396.330107] Starting dynamic subtest: all
[398.094087] Dynamic subtest all: SUCCESS (1.777s)
[398.096731] Subtest evict-prime: SUCCESS (10.656s)
[398.202059] [070/133] (622s left) gem_exec_reloc (basic-cpu-gtt)
[398.275167] Subtest basic-cpu-gtt: SKIP (0.000s)
[398.366590] [071/133] (622s left) kms_getfb (getfb2-into-addfb2)
[398.469871] Starting subtest: getfb2-into-addfb2
[398.472153] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[398.573446] [072/133] (622s left) sw_sync (sync_busy_fork)
[398.607829] Starting subtest: sync_busy_fork
[399.618533] Subtest sync_busy_fork: SUCCESS (1.012s)
[399.694335] [073/133] (620s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[399.801667] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[400.624446] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.825s)
[400.831710] [074/133] (619s left) gem_lmem_swapping (verify-random)
[400.876439] Subtest verify-random: SKIP (0.000s)
[400.915865] [075/133] (619s left) kms_atomic (plane-invalid-params)
[401.013224] Starting subtest: plane-invalid-params
[401.015736] Starting dynamic subtest: pipe-A-eDP-1
[401.399671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[401.402041] Subtest plane-invalid-params: SUCCESS (0.388s)
[402.249833] [076/133] (618s left) gem_ctx_persistence (processes)
[402.303863] Starting subtest: processes
[404.191159] Subtest processes: SUCCESS (1.889s)
[404.284139] [077/133] (616s left) prime_mmap (test_userptr)
[404.348604] Starting subtest: test_userptr
[404.351392] Starting dynamic subtest: test_userptr-smem
[404.353941] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[404.356351] Subtest test_userptr: SUCCESS (0.003s)
[404.481938] [078/133] (616s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[404.593580] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[405.394227] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s)
[405.570933] [079/133] (615s left) vgem_basic (dmabuf-export)
[405.609590] Starting subtest: dmabuf-export
[405.655083] Subtest dmabuf-export: SUCCESS (0.049s)
[405.808642] [080/133] (615s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[405.938770] Starting subtest: flip-vs-cursor-crc-atomic
[406.614658] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.676s)
[407.460433] [081/133] (613s left) gem_userptr_blits (userfault)
[407.529216] Starting subtest: userfault
[407.531244] Subtest userfault: SUCCESS (0.005s)
[407.687531] [082/133] (613s left) gem_partial_pwrite_pread (write-display)
[407.750155] Subtest write-display: SKIP (0.000s)
[407.820871] [083/133] (613s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[407.869280] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[407.971384] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[408.060651] [084/133] (613s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[408.154230] Starting subtest: 2x-flip-vs-rmfb-interruptible
[408.165118] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[408.298408] [085/133] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[408.400610] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[408.405416] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[408.526782] [086/133] (612s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[408.585855] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[408.693198] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[408.779604] [087/133] (612s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[408.860864] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[408.871859] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[408.958680] [088/133] (612s left) kms_cursor_crc (cursor-offscreen-256x85)
[409.228242] Starting subtest: cursor-offscreen-256x85
[409.273945] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[409.494378] [089/133] (611s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[409.548246] Starting subtest: x-tiled-to-vebox-yf-tiled
[409.552756] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[409.742693] [090/133] (611s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[409.848865] Starting subtest: psr-rgb101010-draw-mmap-gtt
[409.852866] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[409.973935] [091/133] (611s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[410.036868] Starting subtest: invalid-single-wait-unsubmitted
[410.038843] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[410.162620] [092/133] (611s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[410.253148] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[410.265994] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.012s)
[410.358879] [093/133] (611s left) kms_content_protection (lic-type-1)
[410.517116] Starting subtest: lic-type-1
[410.521771] Subtest lic-type-1: SKIP (0.000s)
[410.673409] [094/133] (610s left) kms_psr (pr-cursor-blt)
[410.766487] Starting subtest: pr-cursor-blt
[410.770058] Subtest pr-cursor-blt: SKIP (0.000s)
[410.845559] [095/133] (610s left) kms_display_modes (extended-mode-basic)
[410.938048] Starting subtest: extended-mode-basic
[410.941676] Subtest extended-mode-basic: SKIP (0.000s)
[410.984611] [096/133] (610s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[411.068309] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[411.071862] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[412.198692] [097/133] (609s left) perf (buffer-fill)
[412.324108] Starting subtest: buffer-fill
[412.325972] Starting dynamic subtest: 0-rcs0
[414.573855] Dynamic subtest 0-rcs0: SUCCESS (2.254s)
[414.585282] Starting dynamic subtest: 1-vecs0
[418.972237] Dynamic subtest 1-vecs0: SUCCESS (4.406s)
[418.974685] Subtest buffer-fill: SUCCESS (6.662s)
[419.018227] [098/133] (602s left) kms_atomic_transition (plane-all-transition-nonblocking)
[419.112874] Starting subtest: plane-all-transition-nonblocking
[419.115061] Starting dynamic subtest: pipe-A-eDP-1
[421.614184] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[421.924129] Starting dynamic subtest: pipe-B-eDP-1
[425.130899] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.221s)
[425.430405] Subtest plane-all-transition-nonblocking: SUCCESS (6.323s)
[426.239955] [099/133] (595s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[426.348104] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[426.350432] Starting dynamic subtest: pipe-A-eDP-1
[426.373826] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.385235] Starting dynamic subtest: pipe-B-eDP-1
[426.407063] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.416447] Starting dynamic subtest: pipe-C-eDP-1
[426.438118] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.447642] Starting dynamic subtest: pipe-D-eDP-1
[426.470481] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.474549] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[428.593252] [100/133] (593s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[428.694169] Starting subtest: primary-x-tiled-reflect-x-180
[435.924764] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.237s)
[437.172312] [101/133] (584s left) prime_vgem (basic-fence-read)
[437.264693] Starting subtest: basic-fence-read
[437.296899] Subtest basic-fence-read: SKIP (0.029s)
[437.422319] [102/133] (584s left) gem_mmap_offset (oob-read)
[437.465055] Starting subtest: oob-read
[437.467201] Subtest oob-read: SUCCESS (0.000s)
[437.605318] [103/133] (584s left) kms_psr (psr-basic)
[437.692853] Starting subtest: psr-basic
[437.694969] Starting dynamic subtest: eDP-1
[440.132506] Dynamic subtest eDP-1: SUCCESS (2.440s)
[440.134959] Subtest psr-basic: SUCCESS (2.441s)
[440.533804] [104/133] (581s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[440.626421] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[447.578999] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.952s)
[447.728262] [105/133] (574s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[447.826962] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[447.829129] Starting dynamic subtest: A-eDP1
[451.359244] Dynamic subtest A-eDP1: SUCCESS (3.528s)
[451.369887] Starting dynamic subtest: B-eDP1
[454.557425] Dynamic subtest B-eDP1: SUCCESS (3.197s)
[454.567256] Starting dynamic subtest: C-eDP1
[457.676163] Dynamic subtest C-eDP1: SUCCESS (3.117s)
[457.686738] Starting dynamic subtest: D-eDP1
[460.783241] Dynamic subtest D-eDP1: SUCCESS (3.107s)
[460.785642] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.956s)
[461.597552] [106/133] (560s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[461.700350] Starting subtest: invalid-modeset-force-ultra-joiner
[461.704395] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[461.801952] [107/133] (560s left) i915_suspend (fence-restore-tiled2untiled)
[461.865175] Starting subtest: fence-restore-tiled2untiled
[461.869487] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[461.997147] [108/133] (560s left) prime_mmap (test_refcounting)
[462.058354] Starting subtest: test_refcounting
[462.060655] Starting dynamic subtest: test_refcounting-smem
[462.090516] Dynamic subtest test_refcounting-smem: SUCCESS (0.035s)
[462.092904] Subtest test_refcounting: SUCCESS (0.036s)
[462.217572] [109/133] (559s left) gen7_exec_parse (cmd-crossing-page)
[462.273616] Subtest cmd-crossing-page: SKIP (0.000s)
[462.340215] [110/133] (559s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[462.445098] Starting subtest: plane-ctm3x4-lut1d
[462.460118] Starting dynamic subtest: pipe-A-eDP-1
[463.094074] Dynamic subtest pipe-A-eDP-1: FAIL (0.304s)
[463.874846] Starting dynamic subtest: pipe-B-eDP-1
[464.722050] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[465.313962] Starting dynamic subtest: pipe-C-eDP-1
[466.113241] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[466.649844] Starting dynamic subtest: pipe-D-eDP-1
[467.517595] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[467.519619] Subtest plane-ctm3x4-lut1d: FAIL (4.766s)
[468.041798] [111/133] (554s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[468.133911] Starting subtest: basic-max-pipe-crc-check
[468.138471] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[468.180603] [112/133] (554s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[468.286401] Starting subtest: fbcpsr-rgb565-draw-pwrite
[475.194599] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.913s)
[475.352868] [113/133] (546s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[475.445057] Starting subtest: multiplane-rotation-cropping-top
[492.852609] Subtest multiplane-rotation-cropping-top: SUCCESS (17.415s)
[493.026157] [114/133] (529s left) gem_create (create-size-update)
[493.092875] Starting subtest: create-size-update
[493.094579] Subtest create-size-update: SUCCESS (0.000s)
[493.309044] [115/133] (529s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[493.414987] Starting subtest: fbc-pr-cursor-plane-update-sf
[493.419320] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[493.493136] [116/133] (528s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[493.597453] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[493.601541] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[493.722550] [117/133] (528s left) sw_sync (sync_merge_same)
[493.758485] Starting subtest: sync_merge_same
[493.760759] Subtest sync_merge_same: SUCCESS (0.000s)
[493.842948] [118/133] (528s left) sysfs_heartbeat_interval (idempotent)
[493.903741] Starting subtest: idempotent
[493.906042] Starting dynamic subtest: vecs0
[493.908344] Dynamic subtest vecs0: SUCCESS (0.001s)
[493.918919] Starting dynamic subtest: ccs0
[493.920765] Dynamic subtest ccs0: SUCCESS (0.001s)
[493.929852] Starting dynamic subtest: vcs0
[493.931726] Dynamic subtest vcs0: SUCCESS (0.000s)
[493.940826] Starting dynamic subtest: bcs0
[493.942691] Dynamic subtest bcs0: SUCCESS (0.001s)
[493.951657] Starting dynamic subtest: rcs0
[493.953538] Dynamic subtest rcs0: SUCCESS (0.000s)
[493.962932] Starting dynamic subtest: vcs1
[493.965064] Dynamic subtest vcs1: SUCCESS (0.000s)
[493.967202] Subtest idempotent: SUCCESS (0.008s)
[494.036300] [119/133] (528s left) kms_plane (pixel-format-y-tiled-modifier)
[494.123098] Starting subtest: pixel-format-y-tiled-modifier
[494.148407] Starting dynamic subtest: pipe-A-plane-0
[494.152984] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[494.165430] Starting dynamic subtest: pipe-A-plane-3
[494.170046] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[494.181716] Starting dynamic subtest: pipe-A-plane-5
[494.185843] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[495.241585] Starting dynamic subtest: pipe-B-plane-0
[495.245852] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[495.255059] Starting dynamic subtest: pipe-B-plane-3
[495.259530] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[495.268873] Starting dynamic subtest: pipe-B-plane-5
[495.273392] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[495.576403] Subtest pixel-format-y-tiled-modifier: SKIP (1.454s)
[496.424512] [120/133] (526s left) kms_plane_scaling (planes-downscale-factor-0-75)
[496.527864] Starting subtest: planes-downscale-factor-0-75
[496.530208] Starting dynamic subtest: pipe-A
[496.552277] Dynamic subtest pipe-A: SKIP (0.018s)
[496.563346] Starting dynamic subtest: pipe-B
[496.581081] Dynamic subtest pipe-B: SKIP (0.029s)
[496.591237] Starting dynamic subtest: pipe-C
[496.610708] Dynamic subtest pipe-C: SKIP (0.029s)
[496.620698] Starting dynamic subtest: pipe-D
[496.640699] Dynamic subtest pipe-D: SKIP (0.029s)
[496.644431] Subtest planes-downscale-factor-0-75: SKIP (0.109s)
[496.769169] [121/133] (525s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[496.868554] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[496.872679] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[496.996855] [122/133] (525s left) sw_sync (timeline_closed)
[497.031846] Starting subtest: timeline_closed
[497.034030] Subtest timeline_closed: SUCCESS (0.000s)
[497.103968] [123/133] (525s left) kms_vrr (seamless-rr-switch-vrr)
[497.191877] Starting subtest: seamless-rr-switch-vrr
[497.198438] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[497.279468] [124/133] (525s left) kms_legacy_colorkey (basic)
[497.372923] Starting subtest: basic
[497.374473] Starting dynamic subtest: pipe-A
[497.416215] Dynamic subtest pipe-A: SUCCESS (0.045s)
[497.428889] Starting dynamic subtest: pipe-B
[497.430653] Dynamic subtest pipe-B: SUCCESS (0.000s)
[497.439957] Starting dynamic subtest: pipe-C
[497.441491] Dynamic subtest pipe-C: SUCCESS (0.000s)
[497.450119] Starting dynamic subtest: pipe-D
[497.451721] Dynamic subtest pipe-D: SUCCESS (0.000s)
[497.453366] Subtest basic: SUCCESS (0.050s)
[497.508427] [125/133] (525s left) kms_psr (fbc-psr-sprite-plane-move)
[497.610290] Starting subtest: fbc-psr-sprite-plane-move
[497.611879] Starting dynamic subtest: eDP-1
[497.615210] Dynamic subtest eDP-1: SKIP (0.000s)
[497.618909] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[497.690917] [126/133] (525s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[497.796432] Starting subtest: y-tiled-8bpp-rotate-180
[497.800133] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[497.899047] [127/133] (525s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[498.016556] Starting subtest: 2x-flip-vs-cursor-atomic
[498.027784] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[498.187960] [128/133] (524s left) kms_sequence (get-forked)
[498.270521] Starting subtest: get-forked
[498.272461] Starting dynamic subtest: pipe-A-eDP-1
[500.137489] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.866s)
[500.150517] Starting dynamic subtest: pipe-B-eDP-1
[502.634229] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.498s)
[502.646220] Starting dynamic subtest: pipe-C-eDP-1
[505.149400] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.513s)
[505.160724] Starting dynamic subtest: pipe-D-eDP-1
[507.715079] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[507.717419] Subtest get-forked: SUCCESS (9.447s)
[508.544171] [129/133] (514s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[508.648969] Starting subtest: random-ccs-data-yf-tiled-ccs
[508.651124] Starting dynamic subtest: pipe-A-eDP-1
[508.675759] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[508.688070] Starting dynamic subtest: pipe-B-eDP-1
[508.710609] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[508.720852] Starting dynamic subtest: pipe-C-eDP-1
[508.745144] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[508.755648] Starting dynamic subtest: pipe-D-eDP-1
[508.779321] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[508.783629] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[510.820043] [130/133] (512s left) gem_exec_whisper (basic-sync)
[510.886535] Starting subtest: basic-sync
[519.671684] Subtest basic-sync: SUCCESS (8.779s)
[519.883173] [131/133] (503s left) gem_ctx_isolation (preservation-reset)
[520.053840] Starting subtest: preservation-reset
[520.056543] Starting dynamic subtest: rcs0
[520.386504] Dynamic subtest rcs0: SUCCESS (0.332s)
[520.400023] Starting dynamic subtest: bcs0
[520.765996] Dynamic subtest bcs0: SUCCESS (0.378s)
[520.778983] Starting dynamic subtest: vcs0
[521.165947] Dynamic subtest vcs0: SUCCESS (0.399s)
[521.178849] Starting dynamic subtest: vcs1
[522.478872] Dynamic subtest vcs1: SUCCESS (1.312s)
[522.490879] Starting dynamic subtest: vecs0
[524.467211] Dynamic subtest vecs0: SUCCESS (1.987s)
[524.480363] Starting dynamic subtest: ccs0
[526.490182] Dynamic subtest ccs0: SUCCESS (2.021s)
[526.492639] Subtest preservation-reset: SUCCESS (6.437s)
[526.635606] [132/133] (496s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[526.751318] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[526.755402] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[526.869293] [133/133] (496s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[526.966677] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[526.970758] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[527.099825] Closing watchdogs
results: parsing output: 0/ for test: sriov_basic
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: gem_exec_parallel
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: i915_pm_rpm
results: parsing output: 10/ for test: gem_fence_thrash
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_dsc
results: parsing output: 14/ for test: kms_chamelium_frames
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: gem_basic
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: i915_hangman
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: gem_partial_pwrite_pread
results: parsing output: 24/ for test: core_getclient
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_busy
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_basic
results: parsing output: 33/ for test: gem_request_retire
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: kms_chamelium_hpd
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_psr2_su
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_atomic_interruptible
results: parsing output: 45/ for test: sw_sync
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: prime_self_import
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: core_hotunplug
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_eio
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_getfb
results: parsing output: 71/ for test: sw_sync
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_lmem_swapping
results: parsing output: 74/ for test: kms_atomic
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: vgem_basic
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: gem_partial_pwrite_pread
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_display_modes
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: kms_atomic_transition
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: prime_vgem
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_joiner
results: parsing output: 106/ for test: i915_suspend
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: gen7_exec_parse
results: parsing output: 109/ for test: kms_color_pipeline
results: parsing output: 110/ for test: kms_multipipe_modeset
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: gem_create
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: sysfs_heartbeat_interval
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_plane_scaling
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_vrr
results: parsing output: 123/ for test: kms_legacy_colorkey
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_sequence
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: gem_ctx_isolation
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.