[58.753399] Initializing watchdogs
[58.753446]   /dev/watchdog0
[58.768936] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.773194] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.775162] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.778577] [001/131] (960s left) gem_mmap (pf-nonblock)
[58.861360] Subtest pf-nonblock: SKIP (0.000s)
[58.916395] [002/131] (960s left) gem_exec_whisper (basic-fds-all)
[58.986786] Starting subtest: basic-fds-all
[70.382633] Subtest basic-fds-all: SUCCESS (11.523s)
[70.575213] [003/131] (948s left) gem_exec_schedule (semaphore-power)
[70.755529] Subtest semaphore-power: SKIP (0.000s)
[70.942695] [004/131] (948s left) kms_content_protection (atomic-dpms)
[71.079148] Starting subtest: atomic-dpms
[71.083576] Subtest atomic-dpms: SKIP (0.000s)
[71.188516] [005/131] (948s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[71.275025] Starting subtest: yf-tiled-32bpp-rotate-90
[71.279563] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[71.370388] [006/131] (948s left) kms_plane (planar-pixel-format-settings)
[71.443869] Starting subtest: planar-pixel-format-settings
[71.527260] Subtest planar-pixel-format-settings: SUCCESS (0.083s)
[71.641525] [007/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[71.722526] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[71.724658] Starting dynamic subtest: pipe-A-default-mode
[72.847563] Dynamic subtest pipe-A-default-mode: SKIP (1.124s)
[72.851593] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.125s)
[73.045734] [008/131] (946s left) i915_suspend (fence-restore-tiled2untiled)
[73.131390] Starting subtest: fence-restore-tiled2untiled
[73.136546] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[73.315160] [009/131] (946s left) vgem_basic (setversion)
[73.421221] Starting subtest: setversion
[73.426698] Subtest setversion: SUCCESS (0.000s)
[73.485876] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[73.489755] [010/131] (946s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[73.556415] Starting subtest: bad-pixel-format-y-tiled-ccs
[73.558930] Starting dynamic subtest: pipe-A-eDP-1
[73.581652] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.592427] Starting dynamic subtest: pipe-B-eDP-1
[73.613111] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.622060] Starting dynamic subtest: pipe-C-eDP-1
[73.643061] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.651289] Starting dynamic subtest: pipe-D-eDP-1
[73.673586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.677698] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.002s)
[75.868052] [011/131] (943s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[75.945523] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[77.032703] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.091s)
[77.143204] [012/131] (942s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[77.217182] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[77.219048] Starting dynamic subtest: pipe-A-eDP-1
[93.415976] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.286s)
[93.428819] Starting dynamic subtest: pipe-B-eDP-1
[110.356042] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.484s)
[110.367114] Starting dynamic subtest: pipe-C-eDP-1
[127.331238] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.467s)
[127.344339] Starting dynamic subtest: pipe-D-eDP-1
[144.323750] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.401s)
[144.326615] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (9.641s)
[145.534007] [013/131] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[145.613902] Starting subtest: compare-crc-sanitycheck-nv12
[145.616341] Starting dynamic subtest: pipe-A-eDP-1
[146.316290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[146.325975] Starting dynamic subtest: pipe-B-eDP-1
[147.566639] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.280s)
[147.577052] Starting dynamic subtest: pipe-C-eDP-1
[148.831941] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.292s)
[148.841275] Starting dynamic subtest: pipe-D-eDP-1
[150.049293] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[150.051547] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.537s)
[150.844769] [014/131] (868s left) gem_exec_reloc (basic-concurrent0)
[150.910709] Subtest basic-concurrent0: SKIP (0.000s)
[150.989239] [015/131] (868s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[151.068592] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[155.397587] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.384s)
[156.583582] [016/131] (863s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[156.666116] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[156.668509] Starting dynamic subtest: pipe-A-eDP-1
[156.691811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[156.702253] Starting dynamic subtest: pipe-B-eDP-1
[156.724038] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[156.733477] Starting dynamic subtest: pipe-C-eDP-1
[156.754633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.763711] Starting dynamic subtest: pipe-D-eDP-1
[156.784290] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[156.788167] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[158.927138] [017/131] (861s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[159.013717] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[165.893112] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.906s)
[166.030830] [018/131] (853s left) kms_chamelium_hpd (hdmi-hpd)
[166.403245] Subtest hdmi-hpd: SKIP (0.000s)
[167.206672] [019/131] (852s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[167.283205] Starting subtest: psr-rgb565-draw-mmap-cpu
[174.072141] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.805s)
[174.172634] [020/131] (845s left) kms_psr (psr2-primary-render)
[174.251262] Starting subtest: psr2-primary-render
[174.253583] Starting dynamic subtest: eDP-1
[176.049729] Dynamic subtest eDP-1: SUCCESS (1.795s)
[176.051675] Subtest psr2-primary-render: SUCCESS (1.795s)
[176.905805] [021/131] (843s left) kms_psr (psr-suspend)
[176.982331] Starting subtest: psr-suspend
[176.984728] Starting dynamic subtest: eDP-1
[195.622256] Dynamic subtest eDP-1: SUCCESS (2.944s)
[195.625242] Subtest psr-suspend: SUCCESS (2.945s)
[196.485770] [022/131] (823s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[196.543938] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[196.648560] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[196.723266] [023/131] (823s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[196.804013] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[196.809151] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[196.898399] [024/131] (823s left) kms_psr (pr-sprite-render)
[196.976077] Starting subtest: pr-sprite-render
[196.981971] Subtest pr-sprite-render: SKIP (0.000s)
[197.049141] [025/131] (823s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[197.130917] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[197.133835] Starting dynamic subtest: pipe-A-eDP-1
[197.247510] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[197.258847] Starting dynamic subtest: pipe-B-eDP-1
[198.456939] Dynamic subtest pipe-B-eDP-1: SKIP (1.206s)
[198.462960] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.329s)
[199.637435] [026/131] (820s left) gem_mmap_gtt (basic-small-copy-odd)
[199.701601] Subtest basic-small-copy-odd: SKIP (0.000s)
[199.755628] [027/131] (820s left) gem_mmap_wc (write-read)
[199.815449] Subtest write-read: SKIP (0.000s)
[199.882395] [028/131] (820s left) kms_color (ctm-negative)
[199.964031] Starting subtest: ctm-negative
[199.966969] Starting dynamic subtest: pipe-A-eDP-1
[200.674593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[200.686695] Starting dynamic subtest: pipe-B-eDP-1
[202.059673] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[202.071105] Starting dynamic subtest: pipe-C-eDP-1
[203.428607] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[203.438717] Starting dynamic subtest: pipe-D-eDP-1
[204.755207] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[204.757800] Subtest ctm-negative: SUCCESS (4.794s)
[205.551368] [029/131] (814s left) kms_busy (basic-hang)
[205.636593] Starting subtest: basic-hang
[205.639096] Starting dynamic subtest: flip-pipe-A
[206.240223] Dynamic subtest flip-pipe-A: SUCCESS (0.601s)
[206.251738] Starting dynamic subtest: modeset-pipe-A
[209.673788] Dynamic subtest modeset-pipe-A: SUCCESS (3.434s)
[209.686039] Starting dynamic subtest: flip-pipe-D
[210.854482] Dynamic subtest flip-pipe-D: SUCCESS (1.179s)
[210.866142] Starting dynamic subtest: modeset-pipe-D
[214.300347] Dynamic subtest modeset-pipe-D: SUCCESS (3.444s)
[214.303026] Subtest basic-hang: SUCCESS (8.664s)
[215.101798] [030/131] (805s left) kms_fb_coherency (memset-crc)
[215.176121] Starting subtest: memset-crc
[215.179067] Starting dynamic subtest: mmap-offset-wc
[215.564706] Dynamic subtest mmap-offset-wc: SUCCESS (0.389s)
[215.868604] Starting dynamic subtest: mmap-offset-uc
[221.997738] Dynamic subtest mmap-offset-uc: SUCCESS (6.139s)
[222.286689] Subtest memset-crc: SUCCESS (7.113s)
[223.076845] [031/131] (797s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[223.155009] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[223.157839] Starting dynamic subtest: pipe-A-eDP-1
[224.351647] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.198s)
[224.362084] Starting dynamic subtest: pipe-B-eDP-1
[226.537724] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.215s)
[226.547848] Starting dynamic subtest: pipe-C-eDP-1
[228.733464] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.257s)
[228.743874] Starting dynamic subtest: pipe-D-eDP-1
[231.010107] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.326s)
[231.012938] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.001s)
[232.158751] [032/131] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[232.249938] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[232.254966] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[232.336390] [033/131] (788s left) kms_flip (flip-vs-modeset-vs-hang)
[232.410345] Starting subtest: flip-vs-modeset-vs-hang
[232.412940] Starting dynamic subtest: A-eDP1
[283.057976] Dynamic subtest A-eDP1: SUCCESS (50.762s)
[283.068720] Starting dynamic subtest: D-eDP1
[332.151088] Dynamic subtest D-eDP1: SUCCESS (49.098s)
[332.153787] Subtest flip-vs-modeset-vs-hang: SUCCESS (99.866s)
[332.538806] [034/131] (688s left) gem_mmap_gtt (big-copy-odd)
[332.602751] Subtest big-copy-odd: SKIP (0.000s)
[332.662314] [035/131] (688s left) i915_drm_fdinfo (virtual-busy-idle)
[332.701769] Starting subtest: virtual-busy-idle
[332.707119] Subtest virtual-busy-idle: SKIP (0.000s)
[332.766543] [036/131] (687s left) gem_ctx_param (invalid-set-ringsize)
[332.811979] Starting subtest: invalid-set-ringsize
[332.814810] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[332.915769] [037/131] (687s left) api_intel_bb (reset-flags)
[332.961843] Starting subtest: reset-flags
[332.968126] Subtest reset-flags: SUCCESS (0.008s)
[333.092364] [038/131] (687s left) kms_universal_plane (universal-plane-functional)
[333.162628] Starting subtest: universal-plane-functional
[333.165037] Starting dynamic subtest: pipe-A-eDP-1
[336.974242] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.812s)
[336.988472] Starting dynamic subtest: pipe-B-eDP-1
[341.463023] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.486s)
[341.475179] Starting dynamic subtest: pipe-C-eDP-1
[345.716070] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.250s)
[345.727558] Starting dynamic subtest: pipe-D-eDP-1
[349.878900] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.159s)
[349.881984] Subtest universal-plane-functional: SUCCESS (16.712s)
[350.720235] [039/131] (670s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[350.805849] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[350.810921] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[350.878569] [040/131] (670s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[350.932099] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[351.005759] [041/131] (669s left) gem_exec_reloc (basic-write-read-noreloc)
[351.068909] Subtest basic-write-read-noreloc: SKIP (0.000s)
[351.133957] [042/131] (669s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[351.210148] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[351.214892] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[351.297621] [043/131] (669s left) gem_wait (write-wait)
[351.350093] Starting subtest: write-wait
[351.353078] Starting dynamic subtest: all-engines
[352.462850] Dynamic subtest all-engines: SUCCESS (1.112s)
[352.480892] Starting dynamic subtest: rcs0
[353.525885] Dynamic subtest rcs0: SUCCESS (1.060s)
[353.545949] Starting dynamic subtest: bcs0
[354.587967] Dynamic subtest bcs0: SUCCESS (1.060s)
[354.608814] Starting dynamic subtest: vcs0
[355.647397] Dynamic subtest vcs0: SUCCESS (1.058s)
[355.666542] Starting dynamic subtest: vcs1
[356.708965] Dynamic subtest vcs1: SUCCESS (1.060s)
[356.727777] Starting dynamic subtest: vecs0
[357.769289] Dynamic subtest vecs0: SUCCESS (1.057s)
[357.788111] Starting dynamic subtest: ccs0
[358.831098] Dynamic subtest ccs0: SUCCESS (1.060s)
[358.834078] Subtest write-wait: SUCCESS (7.482s)
[359.035308] [044/131] (662s left) kms_vblank (ts-continuation-dpms-suspend)
[359.109805] Starting subtest: ts-continuation-dpms-suspend
[359.112195] Starting dynamic subtest: pipe-A-eDP-1
[376.745476] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[376.763922] Starting dynamic subtest: pipe-D-eDP-1
[394.730536] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.564s)
[394.733207] Subtest ts-continuation-dpms-suspend: SUCCESS (4.452s)
[395.511642] [045/131] (625s left) kms_flip (2x-absolute-wf_vblank)
[395.592162] Starting subtest: 2x-absolute-wf_vblank
[395.600111] Subtest 2x-absolute-wf_vblank: SKIP (0.007s)
[395.688579] [046/131] (625s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[395.739483] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[395.742067] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[395.834205] [047/131] (625s left) gem_mmap_offset (bad-flags)
[395.886996] Starting subtest: bad-flags
[395.889695] Subtest bad-flags: SUCCESS (0.000s)
[395.975356] [048/131] (625s left) prime_vgem (basic-gtt)
[396.047122] Starting subtest: basic-gtt
[396.052205] Subtest basic-gtt: SKIP (0.000s)
[396.142891] [049/131] (625s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[396.215170] Starting subtest: async-flip-with-page-flip-events-tiled
[396.592682] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[399.338964] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[399.350568] Starting dynamic subtest: pipe-A-eDP-1-4
[401.524880] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.218s)
[401.535482] Starting dynamic subtest: pipe-A-eDP-1-4
[403.538087] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.035s)
[403.549317] Starting dynamic subtest: pipe-A-eDP-1-x
[405.727216] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.208s)
[406.105714] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[408.844334] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.762s)
[408.855637] Starting dynamic subtest: pipe-B-eDP-1-4
[411.026197] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.190s)
[411.037821] Starting dynamic subtest: pipe-B-eDP-1-4
[413.038162] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.018s)
[413.052839] Starting dynamic subtest: pipe-B-eDP-1-x
[415.220953] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[415.583739] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[418.339511] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[418.351010] Starting dynamic subtest: pipe-C-eDP-1-4
[420.510291] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.172s)
[420.524190] Starting dynamic subtest: pipe-C-eDP-1-4
[422.516015] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[422.527606] Starting dynamic subtest: pipe-C-eDP-1-x
[424.692160] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[425.054720] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[427.848533] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[427.860898] Starting dynamic subtest: pipe-D-eDP-1-4
[430.025211] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[430.036788] Starting dynamic subtest: pipe-D-eDP-1-4
[432.035973] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[432.048370] Starting dynamic subtest: pipe-D-eDP-1-x
[434.216065] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[434.218899] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.197s)
[435.449315] [050/131] (585s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[435.502023] Starting subtest: etime-single-wait-available-unsubmitted
[435.608471] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[435.685477] [051/131] (585s left) prime_vgem (shrink)
[435.757029] Starting subtest: shrink
[435.786436] Subtest shrink: SUCCESS (0.028s)
[435.892279] [052/131] (585s left) gem_workarounds (reset-context)
[435.957188] Starting subtest: reset-context
[436.121506] Subtest reset-context: SUCCESS (0.164s)
[436.244309] [053/131] (585s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[436.320114] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[444.070688] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.753s)
[444.186779] [054/131] (577s left) gem_ccs (block-copy-compressed)
[444.250728] Starting subtest: block-copy-compressed
[444.256006] Subtest block-copy-compressed: SKIP (0.000s)
[444.363989] [055/131] (577s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[444.447887] Starting subtest: fbcpsr-1p-rte
[451.409118] Subtest fbcpsr-1p-rte: SUCCESS (6.968s)
[451.545291] [056/131] (570s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[451.645177] Starting subtest: flip-vs-cursor-busy-crc-atomic
[452.363019] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.716s)
[453.195691] [057/131] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[453.285007] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[453.290200] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[453.373691] [058/131] (568s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[453.446172] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[453.451661] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[453.516591] [059/131] (568s left) gen9_exec_parse (batch-invalid-length)
[453.574003] Subtest batch-invalid-length: SKIP (0.000s)
[453.645803] [060/131] (568s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[453.726551] Starting subtest: fbc-1p-pri-indfb-multidraw
[466.655688] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.938s)
[468.019930] [061/131] (553s left) kms_async_flips (test-time-stamp-atomic)
[468.100067] Starting subtest: test-time-stamp-atomic
[468.485833] Starting dynamic subtest: pipe-A-eDP-1
[469.311797] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s)
[469.702470] Starting dynamic subtest: pipe-B-eDP-1
[470.450596] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.755s)
[470.828988] Starting dynamic subtest: pipe-C-eDP-1
[471.590153] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[471.961462] Starting dynamic subtest: pipe-D-eDP-1
[472.723099] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[472.726187] Subtest test-time-stamp-atomic: SUCCESS (4.624s)
[473.876794] [062/131] (547s left) gem_exec_fence (syncobj-invalid-wait)
[474.293222] Starting subtest: syncobj-invalid-wait
[474.295636] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[475.877994] [063/131] (546s left) gem_exec_reloc (basic-cpu-read-active)
[475.938641] Subtest basic-cpu-read-active: SKIP (0.000s)
[475.999905] [064/131] (545s left) kms_atomic_interruptible (universal-setplane-cursor)
[476.080181] Starting subtest: universal-setplane-cursor
[476.083190] Starting dynamic subtest: pipe-A-eDP-1
[483.484885] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.406s)
[483.487602] Subtest universal-setplane-cursor: SUCCESS (7.407s)
[484.333847] [065/131] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[484.411362] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[484.415988] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[484.498058] [066/131] (537s left) kms_psr (fbc-psr2-sprite-render)
[484.576480] Starting subtest: fbc-psr2-sprite-render
[484.578958] Starting dynamic subtest: eDP-1
[484.583685] Dynamic subtest eDP-1: SKIP (0.000s)
[484.588677] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[484.649988] [067/131] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[484.726950] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[484.731771] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[484.835343] [068/131] (537s left) gem_exec_create (legacy)
[484.895079] Starting subtest: legacy
[484.898158] Starting dynamic subtest: smem
[486.984190] Dynamic subtest smem: SUCCESS (2.089s)
[486.987101] Subtest legacy: SUCCESS (2.090s)
[487.166515] [069/131] (534s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[487.242744] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[487.247757] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[487.360515] [070/131] (534s left) syncobj_timeline (reset-unsignaled)
[487.418049] Starting subtest: reset-unsignaled
[487.420898] Subtest reset-unsignaled: SUCCESS (0.000s)
[487.514192] [071/131] (534s left) kms_lease (simple-lease)
[487.592053] Starting subtest: simple-lease
[487.594879] Starting dynamic subtest: pipe-A-eDP-1
[488.093853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.499s)
[488.109332] Starting dynamic subtest: pipe-B-eDP-1
[489.564910] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.469s)
[489.577102] Starting dynamic subtest: pipe-C-eDP-1
[490.961371] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[490.973609] Starting dynamic subtest: pipe-D-eDP-1
[492.371373] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[492.374063] Subtest simple-lease: SUCCESS (4.780s)
[493.177712] [072/131] (529s left) i915_pm_rpm (gem-mmap-type)
[494.988367] Starting subtest: gem-mmap-type
[494.991330] Starting dynamic subtest: wb-smem0
[498.516952] Dynamic subtest wb-smem0: SUCCESS (3.525s)
[498.528786] Starting dynamic subtest: wc-smem0
[501.409887] Dynamic subtest wc-smem0: SUCCESS (2.892s)
[501.420795] Starting dynamic subtest: uc-smem0
[504.295724] Dynamic subtest uc-smem0: SUCCESS (2.880s)
[504.298451] Subtest gem-mmap-type: SUCCESS (9.302s)
[504.381717] [073/131] (517s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[504.462806] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[504.468210] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[504.564687] [074/131] (517s left) vgem_slow (nohang)
[504.611386] Starting subtest: nohang
[514.633702] Subtest nohang: SUCCESS (10.019s)
[514.710819] [075/131] (507s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[514.805938] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[514.810936] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[514.907621] [076/131] (507s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[514.983068] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[522.328182] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.347s)
[522.454105] [077/131] (500s left) kms_addfb_basic (bad-pitch-0)
[522.508049] Starting subtest: bad-pitch-0
[522.510398] Subtest bad-pitch-0: SUCCESS (0.000s)
[522.642469] [078/131] (499s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[522.725699] Starting subtest: 4-tiled-32bpp-rotate-270
[522.745057] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[522.849109] [079/131] (499s left) dmabuf_sync_file (import-multiple-read-only)
[522.889648] Starting subtest: import-multiple-read-only
[522.892265] Subtest import-multiple-read-only: SUCCESS (0.004s)
[522.948741] [080/131] (499s left) kms_cursor_edge_walk (256x256-top-edge)
[523.014306] Starting subtest: 256x256-top-edge
[523.016630] Starting dynamic subtest: pipe-A-eDP-1
[526.430809] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.415s)
[526.443164] Starting dynamic subtest: pipe-D-eDP-1
[529.546207] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[529.548984] Subtest 256x256-top-edge: SUCCESS (6.531s)
[530.348528] [081/131] (492s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[530.426785] Starting subtest: plane-upscale-20x20-with-modifiers
[530.429208] Starting dynamic subtest: pipe-A
[530.763105] Dynamic subtest pipe-A: SUCCESS (0.338s)
[530.775304] Starting dynamic subtest: pipe-B
[532.135952] Dynamic subtest pipe-B: SUCCESS (1.372s)
[532.147101] Starting dynamic subtest: pipe-C
[533.568929] Dynamic subtest pipe-C: SUCCESS (1.432s)
[533.580179] Starting dynamic subtest: pipe-D
[534.996182] Dynamic subtest pipe-D: SUCCESS (1.427s)
[534.999032] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.572s)
[536.166318] [082/131] (486s left) gem_mmap (bad-object)
[536.235641] Subtest bad-object: SKIP (0.000s)
[536.299694] [083/131] (486s left) syncobj_timeline (invalid-signal-illegal-point)
[536.348158] Starting subtest: invalid-signal-illegal-point
[536.350719] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[536.460233] [084/131] (486s left) gem_create (hog-create)
[536.523055] Starting subtest: hog-create
[536.525926] Starting dynamic subtest: smem0
[569.883781] Dynamic subtest smem0: SUCCESS (33.333s)
[569.888472] Subtest hog-create: SUCCESS (33.335s)
[570.054181] [085/131] (452s left) kms_flip (plain-flip-ts-check-interruptible)
[570.137675] Starting subtest: plain-flip-ts-check-interruptible
[570.140122] Starting dynamic subtest: A-eDP1
[578.958311] Dynamic subtest A-eDP1: SUCCESS (8.820s)
[578.971533] Starting dynamic subtest: B-eDP1
[587.780863] Dynamic subtest B-eDP1: SUCCESS (8.823s)
[587.792394] Starting dynamic subtest: C-eDP1
[596.598745] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[596.610562] Starting dynamic subtest: D-eDP1
[605.429041] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[605.431820] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.299s)
[606.589506] [086/131] (416s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[606.665938] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[606.674735] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.007s)
[606.754708] [087/131] (416s left) kms_psr (fbc-pr-sprite-plane-move)
[606.837887] Starting subtest: fbc-pr-sprite-plane-move
[606.843563] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[606.913476] [088/131] (416s left) gem_exec_schedule (implicit-write-read)
[606.984887] Starting subtest: implicit-write-read
[606.987018] Starting dynamic subtest: rcs0
[607.079387] Dynamic subtest rcs0: SUCCESS (0.105s)
[607.091109] Starting dynamic subtest: vcs0
[607.159839] Dynamic subtest vcs0: SUCCESS (0.079s)
[607.173958] Starting dynamic subtest: vcs1
[607.242502] Dynamic subtest vcs1: SUCCESS (0.081s)
[607.256742] Starting dynamic subtest: vecs0
[607.334971] Dynamic subtest vecs0: SUCCESS (0.092s)
[607.347303] Starting dynamic subtest: ccs0
[607.433494] Dynamic subtest ccs0: SUCCESS (0.097s)
[607.436356] Subtest implicit-write-read: SUCCESS (0.461s)
[608.977943] [089/131] (414s left) gem_mmap (bad-offset)
[609.023576] Subtest bad-offset: SKIP (0.000s)
[609.087045] [090/131] (413s left) gem_eio (in-flight-internal-10ms)
[609.303189] Starting subtest: in-flight-internal-10ms
[610.955425] Subtest in-flight-internal-10ms: SUCCESS (1.653s)
[611.080618] [091/131] (412s left) kms_cursor_crc (cursor-offscreen-256x256)
[611.311649] Starting subtest: cursor-offscreen-256x256
[611.317801] Starting dynamic subtest: pipe-A-eDP-1
[613.236974] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.919s)
[613.265062] Starting dynamic subtest: pipe-D-eDP-1
[615.909963] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.654s)
[615.912735] Subtest cursor-offscreen-256x256: SUCCESS (4.598s)
[616.771968] [092/131] (406s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[616.826988] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[616.832959] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[617.010037] [093/131] (406s left) sw_sync (timeline_closed_signaled)
[617.044052] Starting subtest: timeline_closed_signaled
[617.047014] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[617.099744] [094/131] (406s left) gem_exec_whisper (basic-sync-all)
[617.160806] Starting subtest: basic-sync-all
[625.052160] Subtest basic-sync-all: SUCCESS (7.887s)
[625.239568] [095/131] (398s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[625.318407] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[625.320839] Starting dynamic subtest: pipe-A-eDP-1
[626.689762] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.371s)
[626.968403] Starting dynamic subtest: pipe-B-eDP-1
[628.022833] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.064s)
[628.291184] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.971s)
[629.135019] [096/131] (394s left) kms_prop_blob (blob-prop-core)
[629.179169] Starting subtest: blob-prop-core
[629.182065] Subtest blob-prop-core: SUCCESS (0.000s)
[629.281728] [097/131] (394s left) gem_exec_reloc (basic-cpu-wc-active)
[629.339031] Subtest basic-cpu-wc-active: SKIP (0.000s)
[629.409687] [098/131] (394s left) kms_big_fb (y-tiled-addfb)
[629.494159] Starting subtest: y-tiled-addfb
[629.499718] Subtest y-tiled-addfb: SKIP (0.000s)
[629.596957] [099/131] (393s left) gem_ctx_param (set-priority-not-supported)
[629.644870] Starting subtest: set-priority-not-supported
[629.650178] Subtest set-priority-not-supported: SKIP (0.000s)
[629.727393] [100/131] (393s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[629.777036] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[629.839285] [101/131] (393s left) gem_softpin (evict-single-offset)
[629.894099] Starting subtest: evict-single-offset
[655.929191] Subtest evict-single-offset: SUCCESS (26.029s)
[656.025219] [102/131] (367s left) kms_chamelium_color (degamma)
[656.157508] Subtest degamma: SKIP (0.000s)
[656.206907] [103/131] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[656.295950] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[656.300202] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[656.393682] [104/131] (367s left) kms_properties (crtc-properties-legacy)
[656.473822] Starting subtest: crtc-properties-legacy
[656.476299] Starting dynamic subtest: pipe-A-eDP-1
[656.941719] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s)
[656.957167] Starting dynamic subtest: pipe-B-eDP-1
[658.095512] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[658.107202] Starting dynamic subtest: pipe-C-eDP-1
[659.221030] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[659.233597] Starting dynamic subtest: pipe-D-eDP-1
[660.345545] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[660.348190] Subtest crtc-properties-legacy: SUCCESS (3.875s)
[661.160115] [105/131] (362s left) api_intel_allocator (fork-simple-once)
[661.212691] Starting subtest: fork-simple-once
[661.224913] Subtest fork-simple-once: SUCCESS (0.015s)
[661.354000] [106/131] (362s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[661.428050] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[661.432913] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[661.542351] [107/131] (362s left) kms_pm_dc (dc5-dpms-negative)
[662.635724] Starting subtest: dc5-dpms-negative
[662.641185] Subtest dc5-dpms-negative: SKIP (0.000s)
[662.715955] [108/131] (361s left) i915_drm_fdinfo (virtual-busy-all)
[662.762960] Starting subtest: virtual-busy-all
[662.767926] Subtest virtual-busy-all: SKIP (0.000s)
[662.854641] [109/131] (361s left) kms_vrr (flip-suspend)
[662.933889] Starting subtest: flip-suspend
[662.941820] Subtest flip-suspend: SKIP (0.000s)
[663.020517] [110/131] (360s left) sysfs_heartbeat_interval (idempotent)
[663.082672] Starting subtest: idempotent
[663.085017] Starting dynamic subtest: vecs0
[663.087631] Dynamic subtest vecs0: SUCCESS (0.002s)
[663.103046] Starting dynamic subtest: ccs0
[663.105414] Dynamic subtest ccs0: SUCCESS (0.001s)
[663.116521] Starting dynamic subtest: vcs0
[663.118934] Dynamic subtest vcs0: SUCCESS (0.000s)
[663.129983] Starting dynamic subtest: bcs0
[663.132216] Dynamic subtest bcs0: SUCCESS (0.001s)
[663.143771] Starting dynamic subtest: rcs0
[663.146771] Dynamic subtest rcs0: SUCCESS (0.001s)
[663.158123] Starting dynamic subtest: vcs1
[663.160495] Dynamic subtest vcs1: SUCCESS (0.001s)
[663.162866] Subtest idempotent: SUCCESS (0.011s)
[663.203409] [111/131] (360s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[663.310760] Starting subtest: basic-flip-after-cursor-varying-size
[664.236772] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.924s)
[665.093562] [112/131] (358s left) gem_tiling_max_stride
[665.211382] [113/131] (358s left) kms_plane_multiple (2x-tiling-none)
[665.282865] Starting subtest: 2x-tiling-none
[665.287941] Subtest 2x-tiling-none: SKIP (0.000s)
[665.373963] [114/131] (358s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[665.425195] Starting subtest: yf-tiled-ccs-to-yf-tiled
[665.430906] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[665.616896] [115/131] (358s left) gem_exec_balancer (bonded-semaphore)
[665.670153] Starting subtest: bonded-semaphore
[665.675636] Subtest bonded-semaphore: SKIP (0.000s)
[665.969093] [116/131] (358s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[666.020736] Starting subtest: wait-all-for-submit-delayed-submit
[666.121382] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[666.204247] [117/131] (358s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[666.275541] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[666.281056] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[666.375865] [118/131] (357s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[666.448640] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[666.451085] Starting dynamic subtest: pipe-A-eDP-1
[666.476069] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[666.488229] Starting dynamic subtest: pipe-B-eDP-1
[666.513987] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[666.525306] Starting dynamic subtest: pipe-C-eDP-1
[666.551195] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[666.562206] Starting dynamic subtest: pipe-D-eDP-1
[666.588873] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[666.594054] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[668.675504] [119/131] (355s left) kms_cursor_crc (cursor-random-512x512)
[668.944728] Starting subtest: cursor-random-512x512
[668.949586] Subtest cursor-random-512x512: SKIP (0.001s)
[669.108063] [120/131] (355s left) kms_psr2_su (page_flip-nv12)
[669.173768] Subtest page_flip-NV12: SKIP (0.000s)
[669.240080] [121/131] (355s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[669.325811] Starting subtest: psr-2p-primscrn-cur-indfb-move
[669.331215] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[669.417698] [122/131] (355s left) perf_pmu (enable-race)
[669.465058] Starting subtest: enable-race
[669.468118] Starting dynamic subtest: rcs0
[682.228168] Dynamic subtest rcs0: SUCCESS (12.767s)
[682.241174] Starting dynamic subtest: bcs0
[694.971149] Dynamic subtest bcs0: SUCCESS (12.740s)
[694.984360] Starting dynamic subtest: vcs0
[710.828007] Dynamic subtest vcs0: SUCCESS (15.853s)
[710.841862] Starting dynamic subtest: vcs1
[726.828194] Dynamic subtest vcs1: SUCCESS (15.998s)
[726.840937] Starting dynamic subtest: vecs0
[742.829516] Dynamic subtest vecs0: SUCCESS (16.000s)
[742.845224] Starting dynamic subtest: ccs0
[755.618640] Dynamic subtest ccs0: SUCCESS (12.789s)
[755.621045] Subtest enable-race: SUCCESS (86.161s)
[755.725577] [123/131] (268s left) kms_draw_crc (fill-fb)
[755.801961] Starting subtest: fill-fb
[756.253067] Subtest fill-fb: SUCCESS (0.453s)
[756.350348] [124/131] (268s left) gem_ctx_persistence (idempotent)
[756.399208] Starting subtest: idempotent
[756.402058] Subtest idempotent: SUCCESS (0.000s)
[756.504260] [125/131] (268s left) syncobj_timeline (signal-array)
[756.556907] Starting subtest: signal-array
[756.559477] Subtest signal-array: SUCCESS (0.000s)
[756.661268] [126/131] (268s left) kms_invalid_mode (bad-vsync-start)
[756.728964] Starting subtest: bad-vsync-start
[756.731188] Starting dynamic subtest: pipe-A-eDP-1
[757.019391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[757.031888] Starting dynamic subtest: pipe-B-eDP-1
[757.034677] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[757.053052] Starting dynamic subtest: pipe-C-eDP-1
[757.055679] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[757.067686] Starting dynamic subtest: pipe-D-eDP-1
[757.069949] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[757.072053] Subtest bad-vsync-start: SUCCESS (0.295s)
[757.893760] [127/131] (266s left) kms_dp_link_training (non-uhbr-sst)
[757.973841] Starting subtest: non-uhbr-sst
[757.983209] Subtest non-uhbr-sst: SKIP (0.000s)
[758.049539] [128/131] (266s left) vgem_basic (unload)
[758.086716] Starting subtest: unload
[787.103937] Subtest unload: SUCCESS (29.023s)
[787.216021] [129/131] (237s left) sw_sync (sync_expired_merge)
[787.257333] Starting subtest: sync_expired_merge
[788.328956] Subtest sync_expired_merge: SUCCESS (1.074s)
[788.397000] [130/131] (236s left) gem_workarounds (suspend-resume-context)
[788.462865] Starting subtest: suspend-resume-context
[804.184626] Subtest suspend-resume-context: SUCCESS (1.223s)
[804.321296] [131/131] (220s left) gem_render_copy_redux (flink-interruptible)
[804.385090] Starting subtest: flink-interruptible
[805.118403] Subtest flink-interruptible: SUCCESS (0.734s)
[805.245279] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: i915_suspend
results: parsing output: 8/ for test: vgem_basic
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_pipe_crc_basic
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: kms_color
results: parsing output: 28/ for test: kms_busy
results: parsing output: 29/ for test: kms_fb_coherency
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: kms_universal_plane
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_wait
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: gem_mmap_offset
results: parsing output: 47/ for test: prime_vgem
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: prime_vgem
results: parsing output: 51/ for test: gem_workarounds
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ccs
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: gen9_exec_parse
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_async_flips
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: kms_atomic_interruptible
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_create
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: i915_pm_rpm
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: vgem_slow
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: dmabuf_sync_file
results: parsing output: 79/ for test: kms_cursor_edge_walk
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: gem_mmap
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_create
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_mmap
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: gem_exec_whisper
results: parsing output: 94/ for test: kms_atomic_transition
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gem_ctx_param
results: parsing output: 99/ for test: kms_pipe_b_c_ivb
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_properties
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_pm_dc
results: parsing output: 107/ for test: i915_drm_fdinfo
results: parsing output: 108/ for test: kms_vrr
results: parsing output: 109/ for test: sysfs_heartbeat_interval
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_tiling_max_stride
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_psr2_su
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_draw_crc
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_invalid_mode
results: parsing output: 126/ for test: kms_dp_link_training
results: parsing output: 127/ for test: vgem_basic
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: gem_workarounds
results: parsing output: 130/ for test: gem_render_copy_redux
Done.