[62.211353] Initializing watchdogs
[62.211398]   /dev/watchdog0
[62.225786] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[62.229982] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.232265] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.235956] [001/133] (960s left) sriov_basic (enable-vfs-autoprobe-on)
[62.319735] Starting subtest: enable-vfs-autoprobe-on
[62.322223] Starting dynamic subtest: numvfs-1
[62.398284] Dynamic subtest numvfs-1: FAIL (0.015s)
[62.407204] Starting dynamic subtest: numvfs-2
[62.481894] Dynamic subtest numvfs-2: FAIL (0.003s)
[62.490233] Starting dynamic subtest: numvfs-3
[62.562549] Dynamic subtest numvfs-3: FAIL (0.003s)
[62.570471] Starting dynamic subtest: numvfs-4
[62.642318] Dynamic subtest numvfs-4: FAIL (0.003s)
[62.650921] Starting dynamic subtest: numvfs-5
[62.723987] Dynamic subtest numvfs-5: FAIL (0.003s)
[62.732911] Starting dynamic subtest: numvfs-6
[62.806991] Dynamic subtest numvfs-6: FAIL (0.003s)
[62.815632] Starting dynamic subtest: numvfs-7
[62.890524] Dynamic subtest numvfs-7: FAIL (0.003s)
[62.899019] Starting dynamic subtest: numvfs-random
[62.978092] Dynamic subtest numvfs-random: FAIL (0.003s)
[62.987214] Starting dynamic subtest: numvfs-all
[63.060060] Dynamic subtest numvfs-all: FAIL (0.504s)
[63.062031] Subtest enable-vfs-autoprobe-on: FAIL (0.546s)
[63.094187] [002/133] (959s left) syncobj_timeline (wait-all-interrupted)
[63.156458] Starting subtest: wait-all-interrupted
[63.256874] Subtest wait-all-interrupted: SUCCESS (0.102s)
[63.338218] [003/133] (959s left) perf_pmu (enable-race)
[63.383308] Starting subtest: enable-race
[63.385445] Starting dynamic subtest: rcs0
[76.170592] Dynamic subtest rcs0: SUCCESS (12.786s)
[76.177524] Starting dynamic subtest: bcs0
[88.912890] Dynamic subtest bcs0: SUCCESS (12.741s)
[88.920616] Starting dynamic subtest: vcs0
[104.794047] Dynamic subtest vcs0: SUCCESS (15.878s)
[104.803510] Starting dynamic subtest: vcs1
[120.792792] Dynamic subtest vcs1: SUCCESS (15.997s)
[120.802080] Starting dynamic subtest: vecs0
[136.792782] Dynamic subtest vecs0: SUCCESS (15.998s)
[136.802050] Starting dynamic subtest: ccs0
[149.544337] Dynamic subtest ccs0: SUCCESS (12.751s)
[149.547045] Subtest enable-race: SUCCESS (86.159s)
[149.680536] [004/133] (873s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[149.735140] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[149.737592] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[149.865459] [005/133] (873s left) gem_exec_balancer (hog)
[149.943787] Starting subtest: hog
[149.948761] Subtest hog: SKIP (0.000s)
[150.257687] [006/133] (872s left) gem_exec_parallel (engines)
[150.312869] Starting subtest: engines
[150.315322] Starting dynamic subtest: basic
[151.865153] Dynamic subtest basic: SUCCESS (1.551s)
[151.874761] Starting dynamic subtest: contexts
[156.164208] Dynamic subtest contexts: SUCCESS (4.298s)
[156.174921] Starting dynamic subtest: fds
[159.969032] Dynamic subtest fds: SUCCESS (3.803s)
[159.978879] Starting dynamic subtest: userptr
[161.819130] Dynamic subtest userptr: SUCCESS (1.849s)
[161.821633] Subtest engines: SUCCESS (11.505s)
[162.027372] [007/133] (860s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[162.101109] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[162.103443] Starting dynamic subtest: pipe-A-eDP-1
[162.126573] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[162.138351] Starting dynamic subtest: pipe-B-eDP-1
[162.159329] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[162.166984] Starting dynamic subtest: pipe-C-eDP-1
[162.188230] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[162.194929] Starting dynamic subtest: pipe-D-eDP-1
[162.216228] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[162.220560] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[164.271818] [008/133] (858s left) gem_eio (create-ext)
[164.520139] Starting subtest: create-ext
[164.876728] Subtest create-ext: SUCCESS (0.359s)
[165.019632] [009/133] (858s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[165.089531] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[165.091802] Starting dynamic subtest: pipe-A-eDP-1
[165.547819] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[165.556245] Starting dynamic subtest: pipe-B-eDP-1
[167.061770] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.507s)
[167.070558] Starting dynamic subtest: pipe-C-eDP-1
[168.506806] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.445s)
[168.516761] Starting dynamic subtest: pipe-D-eDP-1
[169.893189] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.385s)
[169.895149] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.776s)
[171.104036] [010/133] (851s left) i915_pm_rpm (reg-read-ioctl)
[172.938432] Starting subtest: reg-read-ioctl
[175.219524] Subtest reg-read-ioctl: SUCCESS (2.280s)
[175.590340] [011/133] (847s left) gem_fence_thrash (bo-write-verify-threaded-x)
[175.630871] Starting subtest: bo-write-verify-threaded-x
[175.654042] Subtest bo-write-verify-threaded-x: SKIP (0.022s)
[175.717783] [012/133] (847s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[175.826363] Starting subtest: flip-vs-cursor-atomic-transitions
[183.283670] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.456s)
[184.130376] [013/133] (839s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[184.239514] Starting subtest: cursorB-vs-flipA-atomic
[184.243914] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[184.386634] [014/133] (838s left) kms_dsc (dsc-with-bpc-formats)
[184.468457] Starting subtest: dsc-with-bpc-formats
[184.579503] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[184.615919] [015/133] (838s left) kms_chamelium_frames (dp-crc-single)
[184.981036] Subtest dp-crc-single: SKIP (0.000s)
[185.829229] [016/133] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[185.924291] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[185.928603] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[186.041737] [017/133] (837s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[186.105447] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[186.188561] [018/133] (837s left) gem_basic (bad-close)
[186.244972] Starting subtest: bad-close
[186.249171] Subtest bad-close: SUCCESS (0.000s)
[186.348871] [019/133] (837s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[186.432885] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[186.460182] Starting dynamic subtest: pipe-A-plane-0
[186.465295] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[186.475302] Starting dynamic subtest: pipe-A-plane-3
[186.479972] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[186.487587] Starting dynamic subtest: pipe-A-plane-5
[186.492550] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[187.538090] Starting dynamic subtest: pipe-B-plane-0
[187.542654] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[187.552354] Starting dynamic subtest: pipe-B-plane-3
[187.556632] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[187.564376] Starting dynamic subtest: pipe-B-plane-5
[187.569547] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[187.842085] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (1.407s)
[188.729096] [020/133] (834s left) gem_exec_reloc (basic-write-cpu-active)
[188.793156] Subtest basic-write-cpu-active: SKIP (0.000s)
[188.874245] [021/133] (834s left) i915_hangman (error-state-basic)
[188.942660] Starting subtest: error-state-basic
[189.101698] Subtest error-state-basic: SUCCESS (0.160s)
[189.187966] [022/133] (834s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[189.273900] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[190.240532] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.967s)
[190.407196] [023/133] (833s left) kms_cursor_crc (cursor-random-128x42)
[190.609826] Starting subtest: cursor-random-128x42
[190.653112] Subtest cursor-random-128x42: SKIP (0.041s)
[190.877198] [024/133] (832s left) gem_partial_pwrite_pread (writes-after-reads)
[190.937444] Subtest writes-after-reads: SKIP (0.000s)
[191.014711] [025/133] (832s left) core_getclient (basic)
[191.073225] Starting subtest: basic
[191.075156] Subtest basic: SUCCESS (0.000s)
[191.196103] [026/133] (832s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[191.277705] Starting subtest: yf-tiled-64bpp-rotate-180
[191.281398] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[191.401482] [027/133] (832s left) api_intel_allocator (default-alignment)
[191.460468] Starting subtest: default-alignment
[191.462212] Subtest default-alignment: SUCCESS (0.004s)
[191.595812] [028/133] (832s left) gem_mmap_gtt (basic-write-gtt)
[191.650951] Subtest basic-write-gtt: SKIP (0.000s)
[191.712389] [029/133] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[191.793967] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[191.797784] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[191.901527] [030/133] (831s left) kms_flip (flip-vs-dpms-on-nop)
[191.986108] Starting subtest: flip-vs-dpms-on-nop
[191.987772] Starting dynamic subtest: A-eDP1
[193.804198] Dynamic subtest A-eDP1: SUCCESS (1.819s)
[193.814240] Starting dynamic subtest: B-eDP1
[195.628353] Dynamic subtest B-eDP1: SUCCESS (1.822s)
[195.638538] Starting dynamic subtest: C-eDP1
[197.443486] Dynamic subtest C-eDP1: SUCCESS (1.814s)
[197.453054] Starting dynamic subtest: D-eDP1
[199.266670] Dynamic subtest D-eDP1: SUCCESS (1.823s)
[199.269124] Subtest flip-vs-dpms-on-nop: SUCCESS (7.285s)
[200.449058] [031/133] (823s left) gem_busy (busy)
[200.508783] Starting subtest: busy
[200.511126] Starting dynamic subtest: all-engines
[200.570247] Dynamic subtest all-engines: SUCCESS (0.061s)
[200.582453] Starting dynamic subtest: rcs0
[201.824586] Dynamic subtest rcs0: SUCCESS (1.253s)
[201.835284] Starting dynamic subtest: bcs0
[201.875912] Dynamic subtest bcs0: SUCCESS (0.049s)
[201.885314] Starting dynamic subtest: vcs0
[201.915861] Dynamic subtest vcs0: SUCCESS (0.041s)
[201.924696] Starting dynamic subtest: vcs1
[203.870664] Dynamic subtest vcs1: SUCCESS (1.949s)
[203.881885] Starting dynamic subtest: vecs0
[205.851633] Dynamic subtest vecs0: SUCCESS (1.983s)
[205.862077] Starting dynamic subtest: ccs0
[207.837909] Dynamic subtest ccs0: SUCCESS (1.985s)
[207.840497] Subtest busy: SUCCESS (7.327s)
[208.212964] [032/133] (815s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[208.319519] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[208.323795] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[208.447337] [033/133] (815s left) gem_exec_basic (basic)
[208.511547] Starting subtest: basic
[208.513917] Starting dynamic subtest: rcs0-smem
[208.516175] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[208.524791] Starting dynamic subtest: bcs0-smem
[208.527059] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[208.534748] Starting dynamic subtest: vcs0-smem
[208.536951] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[208.544488] Starting dynamic subtest: vcs1-smem
[208.546699] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[208.554479] Starting dynamic subtest: vecs0-smem
[208.556667] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[208.564336] Starting dynamic subtest: ccs0-smem
[208.566571] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[208.568744] Subtest basic: SUCCESS (0.014s)
[209.927708] [034/133] (814s left) gem_request_retire (retire-vma-not-inactive)
[209.996600] Starting subtest: retire-vma-not-inactive
[210.054487] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[210.204095] [035/133] (813s left) gem_exec_schedule (lateslice)
[210.282981] Starting subtest: lateslice
[210.285059] Starting dynamic subtest: rcs0
[210.294848] Dynamic subtest rcs0: SUCCESS (0.023s)
[210.305085] Starting dynamic subtest: bcs0
[210.313096] Dynamic subtest bcs0: SUCCESS (0.018s)
[210.321025] Starting dynamic subtest: vcs0
[210.331723] Dynamic subtest vcs0: SUCCESS (0.018s)
[210.339669] Starting dynamic subtest: vcs1
[210.351047] Dynamic subtest vcs1: SUCCESS (0.019s)
[210.359375] Starting dynamic subtest: vecs0
[210.370734] Dynamic subtest vecs0: SUCCESS (0.019s)
[210.378966] Starting dynamic subtest: ccs0
[210.388541] Dynamic subtest ccs0: SUCCESS (0.017s)
[210.390907] Subtest lateslice: SUCCESS (0.117s)
[211.962536] [036/133] (812s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[212.012999] Starting subtest: yf-tiled-to-vebox-yf-tiled
[212.017577] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[212.203735] [037/133] (811s left) kms_chamelium_hpd (common-hpd-after-suspend)
[212.582225] Subtest common-hpd-after-suspend: SKIP (0.000s)
[213.355173] [038/133] (810s left) syncobj_timeline (reset-signaled)
[213.423207] Starting subtest: reset-signaled
[213.425638] Subtest reset-signaled: SUCCESS (0.000s)
[213.529070] [039/133] (810s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[213.609232] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[213.636664] Starting dynamic subtest: pipe-A-plane-0
[214.070037] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[214.078994] Starting dynamic subtest: pipe-A-plane-3
[214.325853] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[214.334014] Starting dynamic subtest: pipe-A-plane-5
[214.337525] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[215.459056] Starting dynamic subtest: pipe-B-plane-0
[215.919612] Dynamic subtest pipe-B-plane-0: SUCCESS (0.467s)
[215.928231] Starting dynamic subtest: pipe-B-plane-3
[216.207850] Dynamic subtest pipe-B-plane-3: SUCCESS (0.287s)
[216.217578] Starting dynamic subtest: pipe-B-plane-5
[216.221665] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[216.514985] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.905s)
[217.336703] [040/133] (806s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[217.426705] Starting subtest: 4-tiled-64bpp-rotate-180
[219.049596] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.623s)
[219.226524] [041/133] (804s left) kms_psr2_su (frontbuffer-xrgb8888)
[219.277971] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[219.342506] [042/133] (804s left) kms_pm_rpm (dpms-non-lpsp)
[221.040429] Starting subtest: dpms-non-lpsp
[221.045335] Subtest dpms-non-lpsp: SKIP (0.001s)
[221.572527] [043/133] (802s left) perf (unprivileged-single-ctx-counters)
[221.690766] Starting subtest: unprivileged-single-ctx-counters
[221.695232] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[221.732142] [044/133] (802s left) gem_exec_schedule (semaphore-noskip)
[221.803080] Starting subtest: semaphore-noskip
[222.216186] Subtest semaphore-noskip: SUCCESS (0.421s)
[222.583746] [045/133] (801s left) kms_atomic_interruptible (legacy-cursor)
[222.669213] Starting subtest: legacy-cursor
[222.671504] Starting dynamic subtest: pipe-A-eDP-1
[230.055355] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.384s)
[230.057263] Subtest legacy-cursor: SUCCESS (7.385s)
[230.925449] [046/133] (793s left) sw_sync (alloc_merge_fence)
[230.962346] Starting subtest: alloc_merge_fence
[230.964736] Subtest alloc_merge_fence: SUCCESS (0.000s)
[231.028629] [047/133] (793s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[231.123056] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[231.499856] Starting dynamic subtest: pipe-A-eDP-1
[234.272242] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.771s)
[234.638541] Starting dynamic subtest: pipe-B-eDP-1
[237.403909] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.775s)
[237.766550] Starting dynamic subtest: pipe-C-eDP-1
[240.530106] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[240.887358] Starting dynamic subtest: pipe-D-eDP-1
[243.663758] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.782s)
[243.666322] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.541s)
[244.871303] [048/133] (779s left) kms_pm_rpm (modeset-lpsp-stress)
[247.078417] Starting subtest: modeset-lpsp-stress
[261.514129] Subtest modeset-lpsp-stress: SUCCESS (14.440s)
[261.610343] [049/133] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[261.689647] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[261.694044] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[261.816527] [050/133] (762s left) prime_self_import (basic-llseek-size)
[261.856822] Starting subtest: basic-llseek-size
[261.882147] Subtest basic-llseek-size: SUCCESS (0.026s)
[261.993461] [051/133] (762s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[262.076060] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[265.674040] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.604s)
[266.882011] [052/133] (757s left) gem_exec_fence (nb-await)
[267.064789] Starting subtest: nb-await
[267.067477] Starting dynamic subtest: rcs0
[267.130785] Dynamic subtest rcs0: SUCCESS (0.065s)
[267.142320] Starting dynamic subtest: bcs0
[267.189089] Dynamic subtest bcs0: SUCCESS (0.056s)
[267.200297] Starting dynamic subtest: vcs0
[267.247170] Dynamic subtest vcs0: SUCCESS (0.056s)
[267.258266] Starting dynamic subtest: vcs1
[267.306787] Dynamic subtest vcs1: SUCCESS (0.057s)
[267.317592] Starting dynamic subtest: vecs0
[267.365101] Dynamic subtest vecs0: SUCCESS (0.057s)
[267.375734] Starting dynamic subtest: ccs0
[267.422795] Dynamic subtest ccs0: SUCCESS (0.056s)
[267.425377] Subtest nb-await: SUCCESS (0.359s)
[268.949972] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[268.953065] [053/133] (755s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[269.029295] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[276.506339] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.481s)
[276.619926] [054/133] (748s left) kms_vblank (wait-idle)
[276.696742] Starting subtest: wait-idle
[276.698988] Starting dynamic subtest: pipe-A-eDP-1
[278.452728] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[278.468783] Starting dynamic subtest: pipe-D-eDP-1
[280.859209] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.406s)
[280.861656] Subtest wait-idle: SUCCESS (4.163s)
[281.708091] [055/133] (743s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[281.796801] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[281.799034] Starting dynamic subtest: pipe-A-eDP-1
[281.897064] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[281.906442] Starting dynamic subtest: pipe-B-eDP-1
[283.058415] Dynamic subtest pipe-B-eDP-1: SKIP (1.159s)
[283.062775] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.264s)
[284.259341] [056/133] (740s left) core_hotunplug (unbind-rebind)
[284.351583] Starting subtest: unbind-rebind
[290.352756] Subtest unbind-rebind: SUCCESS (6.002s)
[290.392660] [057/133] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[291.868991] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[291.873313] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[292.013097] [058/133] (732s left) gem_exec_whisper (basic-contexts-forked-all)
[292.093977] Starting subtest: basic-contexts-forked-all
[312.846681] Subtest basic-contexts-forked-all: SUCCESS (20.746s)
[313.041119] [059/133] (711s left) kms_cursor_crc (cursor-suspend)
[313.183398] Starting subtest: cursor-suspend
[313.185654] Starting dynamic subtest: pipe-A-eDP-1
[345.807895] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.374s)
[345.818885] Starting dynamic subtest: pipe-D-eDP-1
[379.777304] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.784s)
[379.780306] Subtest cursor-suspend: SUCCESS (7.162s)
[380.596077] [060/133] (644s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[380.676577] Starting subtest: fbc-pr-sprite-mmap-cpu
[380.681636] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[380.761088] [061/133] (644s left) gem_pxp (create-valid-protected-context)
[380.882315] Starting subtest: create-valid-protected-context
[380.885182] Subtest create-valid-protected-context: SUCCESS (0.001s)
[381.023556] [062/133] (644s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[381.113350] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[381.118349] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[381.223786] [063/133] (643s left) syncobj_wait (multi-wait-all-signaled)
[381.285884] Starting subtest: multi-wait-all-signaled
[381.288400] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[381.414767] [064/133] (643s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[381.493279] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[385.977870] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.480s)
[387.110823] [065/133] (638s left) i915_drm_fdinfo (virtual-busy-hang)
[387.148789] Starting subtest: virtual-busy-hang
[387.154303] Subtest virtual-busy-hang: SKIP (0.000s)
[387.235336] [066/133] (638s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[387.319316] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[387.324363] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[387.403359] [067/133] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[387.481031] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[387.485788] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[387.592935] [068/133] (637s left) gem_eio (banned)
[387.852125] Starting subtest: banned
[388.476080] Subtest banned: SUCCESS (0.624s)
[388.670272] [069/133] (636s left) gem_softpin (evict-prime)
[388.729717] Starting subtest: evict-prime
[388.731717] Starting dynamic subtest: rcs0
[389.919093] Dynamic subtest rcs0: SUCCESS (1.187s)
[389.931222] Starting dynamic subtest: bcs0
[391.064169] Dynamic subtest bcs0: SUCCESS (1.142s)
[391.077824] Starting dynamic subtest: vcs0
[392.275193] Dynamic subtest vcs0: SUCCESS (1.204s)
[392.297169] Starting dynamic subtest: vcs1
[394.328683] Dynamic subtest vcs1: SUCCESS (2.052s)
[394.342548] Starting dynamic subtest: vecs0
[396.235538] Dynamic subtest vecs0: SUCCESS (1.903s)
[396.248355] Starting dynamic subtest: ccs0
[397.392127] Dynamic subtest ccs0: SUCCESS (1.154s)
[397.404833] Starting dynamic subtest: all
[399.251526] Dynamic subtest all: SUCCESS (1.855s)
[399.254495] Subtest evict-prime: SUCCESS (10.513s)
[399.348469] [070/133] (626s left) gem_exec_reloc (basic-cpu-gtt)
[399.425457] Subtest basic-cpu-gtt: SKIP (0.000s)
[399.520144] [071/133] (625s left) kms_getfb (getfb2-into-addfb2)
[399.598547] Starting subtest: getfb2-into-addfb2
[399.601132] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[399.720825] [072/133] (625s left) sw_sync (sync_busy_fork)
[399.755342] Starting subtest: sync_busy_fork
[400.762090] Subtest sync_busy_fork: SUCCESS (1.011s)
[400.842898] [073/133] (624s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[400.929374] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[401.898919] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.970s)
[402.083876] [074/133] (623s left) gem_lmem_swapping (verify-random)
[402.128059] Subtest verify-random: SKIP (0.000s)
[402.177088] [075/133] (623s left) kms_atomic (plane-invalid-params)
[402.252118] Starting subtest: plane-invalid-params
[402.254505] Starting dynamic subtest: pipe-A-eDP-1
[402.662587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[402.665557] Subtest plane-invalid-params: SUCCESS (0.411s)
[403.551886] [076/133] (622s left) gem_ctx_persistence (processes)
[403.613399] Starting subtest: processes
[405.246763] Subtest processes: SUCCESS (1.633s)
[405.338698] [077/133] (620s left) prime_mmap (test_userptr)
[405.392303] Starting subtest: test_userptr
[405.395056] Starting dynamic subtest: test_userptr-smem
[405.397385] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[405.399745] Subtest test_userptr: SUCCESS (0.001s)
[405.504027] [078/133] (620s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[405.578527] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[406.480423] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.903s)
[406.664739] [079/133] (619s left) vgem_basic (dmabuf-export)
[406.705770] Starting subtest: dmabuf-export
[406.738567] Subtest dmabuf-export: SUCCESS (0.035s)
[406.856691] [080/133] (618s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[406.949652] Starting subtest: flip-vs-cursor-crc-atomic
[407.598782] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.648s)
[408.484323] [081/133] (617s left) gem_userptr_blits (userfault)
[408.551388] Starting subtest: userfault
[408.554037] Subtest userfault: SUCCESS (0.008s)
[408.718867] [082/133] (617s left) gem_partial_pwrite_pread (write-display)
[408.774200] Subtest write-display: SKIP (0.000s)
[408.834130] [083/133] (617s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[408.892509] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[408.997372] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[409.086394] [084/133] (616s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[409.166433] Starting subtest: 2x-flip-vs-rmfb-interruptible
[409.176196] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.008s)
[409.260801] [085/133] (616s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[409.341792] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[409.346847] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[409.445859] [086/133] (616s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[409.506700] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[409.613100] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[409.700771] [087/133] (616s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[409.784248] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[409.792535] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.007s)
[409.918023] [088/133] (616s left) kms_cursor_crc (cursor-offscreen-256x85)
[410.166823] Starting subtest: cursor-offscreen-256x85
[410.210289] Subtest cursor-offscreen-256x85: SKIP (0.038s)
[410.412334] [089/133] (615s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[410.472561] Starting subtest: x-tiled-to-vebox-yf-tiled
[410.478367] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[410.666990] [090/133] (615s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[410.747804] Starting subtest: psr-rgb101010-draw-mmap-gtt
[410.753325] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[410.867197] [091/133] (615s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[410.918385] Starting subtest: invalid-single-wait-unsubmitted
[410.921336] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[411.028669] [092/133] (615s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[411.107396] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[411.116811] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.007s)
[411.241851] [093/133] (615s left) kms_content_protection (lic-type-1)
[411.369071] Starting subtest: lic-type-1
[411.374389] Subtest lic-type-1: SKIP (0.000s)
[411.506816] [094/133] (614s left) kms_psr (pr-cursor-blt)
[411.593138] Starting subtest: pr-cursor-blt
[411.596935] Subtest pr-cursor-blt: SKIP (0.000s)
[411.690009] [095/133] (614s left) kms_display_modes (extended-mode-basic)
[411.765504] Starting subtest: extended-mode-basic
[411.770271] Subtest extended-mode-basic: SKIP (0.000s)
[411.815084] [096/133] (614s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[411.893434] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[411.898121] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[413.015906] [097/133] (613s left) perf (buffer-fill)
[413.142760] Starting subtest: buffer-fill
[413.145318] Starting dynamic subtest: 0-rcs0
[415.393534] Dynamic subtest 0-rcs0: SUCCESS (2.250s)
[415.404691] Starting dynamic subtest: 1-vcs0
[419.799871] Dynamic subtest 1-vcs0: SUCCESS (4.403s)
[419.802850] Subtest buffer-fill: SUCCESS (6.656s)
[419.846841] [098/133] (606s left) kms_atomic_transition (plane-all-transition-nonblocking)
[419.919317] Starting subtest: plane-all-transition-nonblocking
[419.921889] Starting dynamic subtest: pipe-A-eDP-1
[422.423140] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s)
[422.737202] Starting dynamic subtest: pipe-B-eDP-1
[425.949165] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.222s)
[426.250341] Subtest plane-all-transition-nonblocking: SUCCESS (6.326s)
[427.083883] [099/133] (599s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[427.166499] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[427.169289] Starting dynamic subtest: pipe-A-eDP-1
[427.196317] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.206892] Starting dynamic subtest: pipe-B-eDP-1
[427.232156] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.242127] Starting dynamic subtest: pipe-C-eDP-1
[427.267431] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.277194] Starting dynamic subtest: pipe-D-eDP-1
[427.303046] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.308129] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[429.352336] [100/133] (597s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[429.436440] Starting subtest: primary-x-tiled-reflect-x-180
[436.975171] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.535s)
[438.197060] [101/133] (588s left) prime_vgem (basic-fence-read)
[438.291447] Starting subtest: basic-fence-read
[438.337368] Subtest basic-fence-read: SKIP (0.045s)
[438.459978] [102/133] (588s left) gem_mmap_offset (oob-read)
[438.514379] Starting subtest: oob-read
[438.517275] Subtest oob-read: SUCCESS (0.000s)
[438.626691] [103/133] (588s left) kms_psr (psr-basic)
[438.711214] Starting subtest: psr-basic
[438.713613] Starting dynamic subtest: eDP-1
[440.387123] Dynamic subtest eDP-1: SUCCESS (1.676s)
[440.390202] Subtest psr-basic: SUCCESS (1.677s)
[441.267256] [104/133] (585s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[441.355009] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[448.286274] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.928s)
[448.466408] [105/133] (578s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[448.552037] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[448.554508] Starting dynamic subtest: A-eDP1
[452.092044] Dynamic subtest A-eDP1: SUCCESS (3.538s)
[452.104596] Starting dynamic subtest: B-eDP1
[455.296698] Dynamic subtest B-eDP1: SUCCESS (3.201s)
[455.310256] Starting dynamic subtest: C-eDP1
[458.487978] Dynamic subtest C-eDP1: SUCCESS (3.189s)
[458.501348] Starting dynamic subtest: D-eDP1
[461.595448] Dynamic subtest D-eDP1: SUCCESS (3.106s)
[461.598297] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.040s)
[462.406986] [106/133] (564s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[462.495434] Starting subtest: invalid-modeset-force-ultra-joiner
[462.500270] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[462.575862] [107/133] (564s left) i915_suspend (fence-restore-tiled2untiled)
[462.640428] Starting subtest: fence-restore-tiled2untiled
[462.645811] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[462.749916] [108/133] (564s left) prime_mmap (test_refcounting)
[462.800252] Starting subtest: test_refcounting
[462.803124] Starting dynamic subtest: test_refcounting-smem
[462.826512] Dynamic subtest test_refcounting-smem: SUCCESS (0.029s)
[462.829559] Subtest test_refcounting: SUCCESS (0.030s)
[462.949354] [109/133] (564s left) gen7_exec_parse (cmd-crossing-page)
[463.016466] Subtest cmd-crossing-page: SKIP (0.000s)
[463.107239] [110/133] (564s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[463.193957] Starting subtest: plane-ctm3x4-lut1d
[463.209858] Starting dynamic subtest: pipe-A-eDP-1
[463.908465] Dynamic subtest pipe-A-eDP-1: FAIL (0.305s)
[464.576397] Starting dynamic subtest: pipe-B-eDP-1
[465.446786] Dynamic subtest pipe-B-eDP-1: FAIL (0.317s)
[465.924412] Starting dynamic subtest: pipe-C-eDP-1
[466.863512] Dynamic subtest pipe-C-eDP-1: FAIL (0.256s)
[467.250310] Starting dynamic subtest: pipe-D-eDP-1
[468.189983] Dynamic subtest pipe-D-eDP-1: FAIL (0.245s)
[468.192234] Subtest plane-ctm3x4-lut1d: FAIL (4.578s)
[468.637451] [111/133] (558s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[468.716264] Starting subtest: basic-max-pipe-crc-check
[468.721456] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[468.773100] [112/133] (558s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[468.863215] Starting subtest: fbcpsr-rgb565-draw-pwrite
[475.786172] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.924s)
[475.936414] [113/133] (551s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[476.018395] Starting subtest: multiplane-rotation-cropping-top
[493.637627] Subtest multiplane-rotation-cropping-top: SUCCESS (17.638s)
[493.785700] [114/133] (533s left) gem_create (create-size-update)
[493.851767] Starting subtest: create-size-update
[493.853938] Subtest create-size-update: SUCCESS (0.000s)
[494.068029] [115/133] (533s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[494.150309] Starting subtest: fbc-pr-cursor-plane-update-sf
[494.155222] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[494.229207] [116/133] (533s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[494.308524] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[494.313530] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[494.405255] [117/133] (533s left) sw_sync (sync_merge_same)
[494.444273] Starting subtest: sync_merge_same
[494.447373] Subtest sync_merge_same: SUCCESS (0.000s)
[494.549119] [118/133] (532s left) sysfs_heartbeat_interval (idempotent)
[494.610272] Starting subtest: idempotent
[494.612762] Starting dynamic subtest: vecs0
[494.615221] Dynamic subtest vecs0: SUCCESS (0.001s)
[494.627272] Starting dynamic subtest: ccs0
[494.629435] Dynamic subtest ccs0: SUCCESS (0.001s)
[494.639681] Starting dynamic subtest: vcs0
[494.642361] Dynamic subtest vcs0: SUCCESS (0.000s)
[494.652339] Starting dynamic subtest: bcs0
[494.654542] Dynamic subtest bcs0: SUCCESS (0.001s)
[494.665228] Starting dynamic subtest: rcs0
[494.667521] Dynamic subtest rcs0: SUCCESS (0.001s)
[494.677265] Starting dynamic subtest: vcs1
[494.679432] Dynamic subtest vcs1: SUCCESS (0.000s)
[494.681782] Subtest idempotent: SUCCESS (0.008s)
[494.724494] [119/133] (532s left) kms_plane (pixel-format-y-tiled-modifier)
[494.809621] Starting subtest: pixel-format-y-tiled-modifier
[494.835568] Starting dynamic subtest: pipe-A-plane-0
[494.841297] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[494.853153] Starting dynamic subtest: pipe-A-plane-3
[494.857920] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[494.870235] Starting dynamic subtest: pipe-A-plane-5
[494.875373] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[495.914182] Starting dynamic subtest: pipe-B-plane-0
[495.920106] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[495.938050] Starting dynamic subtest: pipe-B-plane-3
[495.943257] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[495.958531] Starting dynamic subtest: pipe-B-plane-5
[495.964191] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[496.218376] Subtest pixel-format-y-tiled-modifier: SKIP (1.406s)
[497.097256] [120/133] (530s left) kms_plane_scaling (planes-downscale-factor-0-75)
[497.181203] Starting subtest: planes-downscale-factor-0-75
[497.184074] Starting dynamic subtest: pipe-A
[497.202086] Dynamic subtest pipe-A: SKIP (0.016s)
[497.219079] Starting dynamic subtest: pipe-B
[497.229895] Dynamic subtest pipe-B: SKIP (0.028s)
[497.246340] Starting dynamic subtest: pipe-C
[497.262471] Dynamic subtest pipe-C: SKIP (0.029s)
[497.273301] Starting dynamic subtest: pipe-D
[497.287388] Dynamic subtest pipe-D: SKIP (0.029s)
[497.293118] Subtest planes-downscale-factor-0-75: SKIP (0.105s)
[497.403804] [121/133] (530s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[497.497400] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[497.503053] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[497.617434] [122/133] (530s left) sw_sync (timeline_closed)
[497.659736] Starting subtest: timeline_closed
[497.662355] Subtest timeline_closed: SUCCESS (0.000s)
[497.724369] [123/133] (529s left) kms_vrr (seamless-rr-switch-vrr)
[497.805520] Starting subtest: seamless-rr-switch-vrr
[497.813375] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[497.893868] [124/133] (529s left) kms_legacy_colorkey (basic)
[497.970523] Starting subtest: basic
[497.973108] Starting dynamic subtest: pipe-A
[498.014078] Dynamic subtest pipe-A: SUCCESS (0.045s)
[498.027550] Starting dynamic subtest: pipe-B
[498.030036] Dynamic subtest pipe-B: SUCCESS (0.000s)
[498.040309] Starting dynamic subtest: pipe-C
[498.042327] Dynamic subtest pipe-C: SUCCESS (0.000s)
[498.052298] Starting dynamic subtest: pipe-D
[498.054509] Dynamic subtest pipe-D: SUCCESS (0.000s)
[498.059125] Subtest basic: SUCCESS (0.049s)
[498.100035] [125/133] (529s left) kms_psr (fbc-psr-sprite-plane-move)
[498.185142] Starting subtest: fbc-psr-sprite-plane-move
[498.187468] Starting dynamic subtest: eDP-1
[498.192132] Dynamic subtest eDP-1: SKIP (0.000s)
[498.196189] Subtest fbc-psr-sprite-plane-move: SKIP (0.003s)
[498.275032] [126/133] (529s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[498.350965] Starting subtest: y-tiled-8bpp-rotate-180
[498.355175] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[498.472134] [127/133] (529s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[498.562190] Starting subtest: 2x-flip-vs-cursor-atomic
[498.566353] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.003s)
[498.719110] [128/133] (529s left) kms_sequence (get-forked)
[498.789887] Starting subtest: get-forked
[498.792011] Starting dynamic subtest: pipe-A-eDP-1
[500.728365] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[500.739539] Starting dynamic subtest: pipe-B-eDP-1
[503.308987] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.577s)
[503.320522] Starting dynamic subtest: pipe-C-eDP-1
[505.805881] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.495s)
[505.820430] Starting dynamic subtest: pipe-D-eDP-1
[508.395695] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s)
[508.398514] Subtest get-forked: SUCCESS (9.608s)
[509.210166] [129/133] (518s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[509.293450] Starting subtest: random-ccs-data-yf-tiled-ccs
[509.296277] Starting dynamic subtest: pipe-A-eDP-1
[509.327934] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[509.349682] Starting dynamic subtest: pipe-B-eDP-1
[509.378456] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[509.389529] Starting dynamic subtest: pipe-C-eDP-1
[509.417279] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[509.427673] Starting dynamic subtest: pipe-D-eDP-1
[509.457215] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[509.462185] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[511.477303] [130/133] (516s left) gem_exec_whisper (basic-sync)
[511.555505] Starting subtest: basic-sync
[522.617505] Subtest basic-sync: SUCCESS (11.065s)
[522.812315] [131/133] (505s left) gem_ctx_isolation (preservation-reset)
[522.996176] Starting subtest: preservation-reset
[522.999338] Starting dynamic subtest: rcs0
[523.341647] Dynamic subtest rcs0: SUCCESS (0.344s)
[523.353317] Starting dynamic subtest: bcs0
[523.732042] Dynamic subtest bcs0: SUCCESS (0.390s)
[523.743521] Starting dynamic subtest: vcs0
[524.059691] Dynamic subtest vcs0: SUCCESS (0.327s)
[524.072562] Starting dynamic subtest: vcs1
[525.563300] Dynamic subtest vcs1: SUCCESS (1.502s)
[525.576021] Starting dynamic subtest: vecs0
[527.620660] Dynamic subtest vecs0: SUCCESS (2.056s)
[527.634336] Starting dynamic subtest: ccs0
[529.626167] Dynamic subtest ccs0: SUCCESS (2.005s)
[529.629315] Subtest preservation-reset: SUCCESS (6.632s)
[529.782774] [132/133] (498s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[529.882810] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[529.888026] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[530.015212] [133/133] (498s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[530.110302] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[530.115386] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[530.230256] 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.