[57.419514] Initializing watchdogs
[57.419567]   /dev/watchdog0
[57.434208] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.438918] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.441108] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.444304] [001/133] (960s left) i915_pciid
[57.632066] [002/133] (960s left) kms_psr (fbc-pr-primary-mmap-gtt)
[57.727408] Starting subtest: fbc-pr-primary-mmap-gtt
[57.731571] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[57.802237] [003/133] (960s left) gem_watchdog (default-virtual)
[57.872241] Starting subtest: default-virtual
[64.152339] Subtest default-virtual: SUCCESS (6.357s)
[64.234329] [004/133] (953s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[64.325255] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[64.327423] Starting dynamic subtest: pipe-A-eDP-1
[64.337080] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.345803] Starting dynamic subtest: pipe-B-eDP-1
[64.355347] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.363824] Starting dynamic subtest: pipe-C-eDP-1
[64.373812] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.381085] Starting dynamic subtest: pipe-D-eDP-1
[64.389624] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[64.393883] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[66.612046] [005/133] (951s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[66.713681] Starting subtest: primary-4-tiled-reflect-x-180
[73.871377] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.183s)
[75.033457] [006/133] (943s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[75.134574] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[75.146072] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[75.262616] [007/133] (942s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[75.362366] Starting subtest: psr-rgb565-draw-mmap-wc
[82.126100] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.775s)
[82.229577] [008/133] (936s left) gem_caching (reads)
[82.292781] Subtest reads: SKIP (0.000s)
[82.358732] [009/133] (935s left) kms_addfb_basic (clobberred-modifier)
[82.415706] Starting subtest: clobberred-modifier
[82.420623] Subtest clobberred-modifier: SKIP (0.000s)
[82.543490] [010/133] (935s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[82.642817] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[82.645152] Starting dynamic subtest: pipe-A-eDP-1
[82.667372] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[82.676966] Starting dynamic subtest: pipe-B-eDP-1
[82.697744] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[82.705158] Starting dynamic subtest: pipe-C-eDP-1
[82.725989] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[82.733339] Starting dynamic subtest: pipe-D-eDP-1
[82.754253] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[82.758077] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[84.926431] [011/133] (933s left) gem_workarounds (suspend-resume)
[85.005874] Starting subtest: suspend-resume
[101.359768] Subtest suspend-resume: SUCCESS (2.021s)
[101.489365] [012/133] (916s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[101.615511] Starting subtest: drrs-dirtyfb-ioctl
[101.629180] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[101.722371] [013/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[101.820299] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[109.015755] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.362s)
[109.157433] [014/133] (909s left) gem_ccs (block-multicopy-compressed)
[109.217570] Starting subtest: block-multicopy-compressed
[109.221755] Subtest block-multicopy-compressed: SKIP (0.000s)
[109.325013] [015/133] (909s left) kms_plane (plane-position-hole-dpms)
[109.417406] Starting subtest: plane-position-hole-dpms
[109.924826] Starting dynamic subtest: pipe-A-plane-1
[112.266794] Dynamic subtest pipe-A-plane-1: SUCCESS (2.365s)
[112.275854] Starting dynamic subtest: pipe-A-plane-2
[114.609415] Dynamic subtest pipe-A-plane-2: SUCCESS (2.361s)
[114.620974] Starting dynamic subtest: pipe-A-plane-3
[116.948751] Dynamic subtest pipe-A-plane-3: SUCCESS (2.351s)
[116.957856] Starting dynamic subtest: pipe-A-plane-4
[119.333355] Dynamic subtest pipe-A-plane-4: SUCCESS (2.396s)
[119.342374] Starting dynamic subtest: pipe-A-plane-5
[119.358840] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[120.581900] Starting dynamic subtest: pipe-B-plane-1
[122.986174] Dynamic subtest pipe-B-plane-1: SUCCESS (2.417s)
[122.995331] Starting dynamic subtest: pipe-B-plane-2
[125.333947] Dynamic subtest pipe-B-plane-2: SUCCESS (2.351s)
[125.343548] Starting dynamic subtest: pipe-B-plane-3
[127.690032] Dynamic subtest pipe-B-plane-3: SUCCESS (2.360s)
[127.699610] Starting dynamic subtest: pipe-B-plane-4
[130.052215] Dynamic subtest pipe-B-plane-4: SUCCESS (2.363s)
[130.061047] Starting dynamic subtest: pipe-B-plane-5
[130.075399] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[130.077694] Subtest plane-position-hole-dpms: SUCCESS (20.754s)
[130.874284] [016/133] (887s left) gen3_render_mixed_blits
[130.993500] [017/133] (887s left) kms_atomic (plane-primary-legacy)
[131.088857] Starting subtest: plane-primary-legacy
[131.091084] Starting dynamic subtest: pipe-A-eDP-1
[131.572324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s)
[131.574721] Subtest plane-primary-legacy: SUCCESS (0.485s)
[132.418433] [018/133] (886s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[132.485969] Starting subtest: yf-tiled-ccs-to-x-tiled
[132.490418] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[132.683337] [019/133] (885s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[132.772889] Starting subtest: 4-tiled-64bpp-rotate-90
[132.793122] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[132.895511] [020/133] (885s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[132.987286] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[134.045251] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.058s)
[134.188745] [021/133] (884s left) syncobj_wait (wait-any-snapshot)
[134.246205] Starting subtest: wait-any-snapshot
[134.325683] Subtest wait-any-snapshot: SUCCESS (0.081s)
[134.412704] [022/133] (884s left) gem_exec_whisper (basic-normal)
[134.471398] Starting subtest: basic-normal
[138.184963] Subtest basic-normal: SUCCESS (3.710s)
[138.370277] [023/133] (880s left) gem_mmap (short-mmap)
[138.427854] Subtest short-mmap: SKIP (0.000s)
[138.483581] [024/133] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[138.586475] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[138.590348] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[138.691812] [025/133] (880s left) gem_exec_suspend (basic-s3-devices)
[138.757784] Starting subtest: basic-S3-devices
[138.760186] Starting dynamic subtest: smem
[150.597431] Dynamic subtest smem: SUCCESS (11.837s)
[150.600573] Subtest basic-S3-devices: SUCCESS (11.840s)
[150.779396] [026/133] (868s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[150.883840] Starting subtest: fbc-shrfb-scaledprimary
[153.866165] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.987s)
[155.078302] [027/133] (863s left) kms_atomic_transition (plane-all-modeset-transition)
[155.178024] Starting subtest: plane-all-modeset-transition
[155.182388] Subtest plane-all-modeset-transition: SKIP (0.000s)
[155.262479] [028/133] (863s left) gem_mmap_wc (write-read)
[155.322294] Subtest write-read: SKIP (0.000s)
[155.374021] [029/133] (863s left) kms_prop_blob (invalid-get-prop-any)
[155.427168] Starting subtest: invalid-get-prop-any
[155.429463] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[155.524537] [030/133] (863s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[155.639973] Starting subtest: flip-vs-cursor-crc-atomic
[156.362033] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.721s)
[157.197834] [031/133] (861s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[157.308922] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[161.817375] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.513s)
[162.997396] [032/133] (856s left) kms_chamelium_edid (vga-edid-read)
[163.379088] Subtest vga-edid-read: SKIP (0.000s)
[164.200381] [033/133] (855s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[164.585349] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[165.431010] [034/133] (853s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[165.479524] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[165.585718] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[165.660459] [035/133] (853s left) syncobj_timeline (single-wait-all-available-submitted)
[165.714631] Starting subtest: single-wait-all-available-submitted
[165.716960] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[165.808938] [036/133] (853s left) api_intel_allocator (two-level-inception)
[165.870114] Starting subtest: two-level-inception
[171.269691] Subtest two-level-inception: SUCCESS (5.401s)
[171.394211] [037/133] (847s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[171.499287] Starting subtest: 2x-absolute-wf_vblank-interruptible
[171.512319] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[171.590599] [038/133] (847s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[171.656382] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[171.660804] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[171.839401] [039/133] (847s left) kms_content_protection (dp-mst-type-0)
[171.987483] Starting subtest: dp-mst-type-0
[171.991932] Subtest dp-mst-type-0: SKIP (0.000s)
[172.115280] [040/133] (847s left) kms_pm_rpm (i2c)
[173.762534] Starting subtest: i2c
[179.347401] Subtest i2c: SUCCESS (5.584s)
[179.432838] [041/133] (840s left) prime_busy (after)
[179.485708] Starting subtest: after
[179.488093] Starting dynamic subtest: rcs0
[179.521067] Dynamic subtest rcs0: SUCCESS (0.035s)
[179.532337] Starting dynamic subtest: bcs0
[179.562951] Dynamic subtest bcs0: SUCCESS (0.041s)
[179.572720] Starting dynamic subtest: vcs0
[179.603279] Dynamic subtest vcs0: SUCCESS (0.040s)
[179.612831] Starting dynamic subtest: vcs1
[179.644499] Dynamic subtest vcs1: SUCCESS (0.040s)
[179.654168] Starting dynamic subtest: vecs0
[179.683098] Dynamic subtest vecs0: SUCCESS (0.038s)
[179.692534] Starting dynamic subtest: ccs0
[179.725239] Dynamic subtest ccs0: SUCCESS (0.041s)
[179.834727] Subtest after: SUCCESS (0.350s)
[179.908787] [042/133] (839s left) kms_frontbuffer_tracking (fbc-tiling-y)
[179.999392] Starting subtest: fbc-tiling-y
[180.003923] Subtest fbc-tiling-y: SKIP (0.000s)
[180.093510] [043/133] (839s left) i915_pm_sseu (full-enable)
[180.146948] Subtest full-enable: SKIP (0.000s)
[180.242704] [044/133] (839s left) kms_invalid_mode (zero-hdisplay)
[180.338963] Starting subtest: zero-hdisplay
[180.341237] Starting dynamic subtest: pipe-A-eDP-1
[180.626279] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[180.636251] Starting dynamic subtest: pipe-B-eDP-1
[180.638222] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[180.647233] Starting dynamic subtest: pipe-C-eDP-1
[180.649463] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[180.658288] Starting dynamic subtest: pipe-D-eDP-1
[180.660636] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[180.662961] Subtest zero-hdisplay: SUCCESS (0.291s)
[181.486601] [045/133] (838s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[181.590363] Starting subtest: y-tiled-8bpp-rotate-180
[181.594674] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[181.686037] [046/133] (838s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[181.742637] Starting subtest: etime-multi-wait-available-unsubmitted
[181.849027] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.105s)
[181.924135] [047/133] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[182.025675] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[182.029970] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[182.130308] [048/133] (837s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[182.186720] Starting subtest: invalid-bsd2-flag-on-vebox
[182.189061] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[182.302516] [049/133] (837s left) gem_ctx_shared (exec-single-timeline)
[182.357823] Starting subtest: exec-single-timeline
[182.360062] Starting dynamic subtest: rcs0
[183.392835] Dynamic subtest rcs0: SUCCESS (1.033s)
[183.403466] Starting dynamic subtest: bcs0
[184.481165] Dynamic subtest bcs0: SUCCESS (1.086s)
[184.493945] Starting dynamic subtest: vcs0
[185.569176] Dynamic subtest vcs0: SUCCESS (1.084s)
[185.582466] Starting dynamic subtest: vcs1
[186.658060] Dynamic subtest vcs1: SUCCESS (1.087s)
[186.670216] Starting dynamic subtest: vecs0
[187.747883] Dynamic subtest vecs0: SUCCESS (1.086s)
[187.760002] Starting dynamic subtest: ccs0
[188.833411] Dynamic subtest ccs0: SUCCESS (1.085s)
[188.836402] Subtest exec-single-timeline: SUCCESS (6.478s)
[189.661714] [050/133] (830s left) gem_mmap_gtt (isolation)
[189.722534] Subtest isolation: SKIP (0.000s)
[189.796278] [051/133] (830s left) gem_mmap (bad-offset)
[189.848078] Subtest bad-offset: SKIP (0.000s)
[189.915957] [052/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[190.015967] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[190.020408] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[190.145279] [053/133] (829s left) gem_flink_basic (bad-flink)
[190.216514] Starting subtest: bad-flink
[190.218920] Subtest bad-flink: SUCCESS (0.000s)
[190.328074] [054/133] (829s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[190.418433] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[190.422490] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[190.487805] [055/133] (829s left) kms_psr (psr2-sprite-blt)
[190.576431] Starting subtest: psr2-sprite-blt
[190.579024] Starting dynamic subtest: eDP-1
[192.382895] Dynamic subtest eDP-1: SUCCESS (1.805s)
[192.385212] Subtest psr2-sprite-blt: SUCCESS (1.807s)
[193.227346] [056/133] (827s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[193.282982] Starting subtest: invalid-single-wait-all-unsubmitted
[193.285196] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[193.373442] [057/133] (826s left) api_intel_bb (reset-bb)
[193.444499] Starting subtest: reset-bb
[193.449296] Subtest reset-bb: SUCCESS (0.004s)
[193.575152] [058/133] (826s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[193.668716] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[198.278275] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.614s)
[199.440376] [059/133] (820s left) kms_cursor_crc (cursor-sliding-256x256)
[199.693567] Starting subtest: cursor-sliding-256x256
[199.699227] Starting dynamic subtest: pipe-A-eDP-1
[202.936993] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.238s)
[202.964297] Starting dynamic subtest: pipe-D-eDP-1
[206.794458] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.838s)
[206.796671] Subtest cursor-sliding-256x256: SUCCESS (7.101s)
[207.590485] [060/133] (812s left) kms_setmode (clone-exclusive-crtc)
[207.659110] Starting subtest: clone-exclusive-crtc
[207.665626] Subtest clone-exclusive-crtc: SKIP (0.000s)
[207.770129] [061/133] (812s left) gem_exec_params (invalid-bsd2-flag-on-render)
[207.830325] Starting subtest: invalid-bsd2-flag-on-render
[207.832751] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[207.959424] [062/133] (812s left) perf_pmu (busy-accuracy-2)
[207.996634] Starting subtest: busy-accuracy-2
[207.999013] Starting dynamic subtest: rcs0
[211.040605] Dynamic subtest rcs0: SUCCESS (3.044s)
[211.052336] Starting dynamic subtest: bcs0
[214.101425] Dynamic subtest bcs0: SUCCESS (3.059s)
[214.111462] Starting dynamic subtest: vcs0
[217.145703] Dynamic subtest vcs0: SUCCESS (3.042s)
[217.158114] Starting dynamic subtest: vcs1
[220.197686] Dynamic subtest vcs1: SUCCESS (3.050s)
[220.208295] Starting dynamic subtest: vecs0
[223.245137] Dynamic subtest vecs0: SUCCESS (3.045s)
[223.256676] Starting dynamic subtest: ccs0
[226.305867] Dynamic subtest ccs0: SUCCESS (3.058s)
[226.308778] Subtest busy-accuracy-2: SUCCESS (18.313s)
[226.420231] [063/133] (794s left) gem_exec_balancer (bonded-chain)
[226.487144] Starting subtest: bonded-chain
[233.527389] Subtest bonded-chain: SUCCESS (7.039s)
[233.835885] [064/133] (786s left) gem_exec_params (invalid-ring2)
[233.894159] Starting subtest: invalid-ring2
[233.896517] Subtest invalid-ring2: SUCCESS (0.000s)
[234.011239] [065/133] (786s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[234.107557] Starting subtest: psr2-plane-move-sf-dmg-area
[234.109797] Starting dynamic subtest: pipe-A-eDP-1
[238.654605] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.548s)
[238.664463] Starting dynamic subtest: pipe-B-eDP-1
[243.971597] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.318s)
[243.973950] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.870s)
[244.836174] [066/133] (775s left) gem_tiled_blits (basic)
[244.905210] Subtest basic: SKIP (0.000s)
[244.972910] [067/133] (775s left) gem_exec_schedule (fairslice)
[245.049887] Starting subtest: fairslice
[245.051786] Starting dynamic subtest: rcs0
[247.066719] Dynamic subtest rcs0: SUCCESS (2.022s)
[247.081856] Starting dynamic subtest: bcs0
[249.085147] Dynamic subtest bcs0: SUCCESS (2.020s)
[249.095684] Starting dynamic subtest: vcs0
[251.106431] Dynamic subtest vcs0: SUCCESS (2.018s)
[251.117521] Starting dynamic subtest: vcs1
[253.124892] Dynamic subtest vcs1: SUCCESS (2.019s)
[253.136107] Starting dynamic subtest: vecs0
[255.146205] Dynamic subtest vecs0: SUCCESS (2.020s)
[255.156619] Starting dynamic subtest: ccs0
[257.164602] Dynamic subtest ccs0: SUCCESS (2.019s)
[257.166657] Subtest fairslice: SUCCESS (12.124s)
[257.460437] [068/133] (763s left) gem_madvise (dontneed-before-exec)
[257.499969] Starting subtest: dontneed-before-exec
[257.527178] Subtest dontneed-before-exec: SKIP (0.023s)
[257.590474] [069/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[257.688035] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[257.692360] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[257.778360] [070/133] (763s left) kms_psr (fbc-psr2-sprite-plane-move)
[257.873678] Starting subtest: fbc-psr2-sprite-plane-move
[257.875890] Starting dynamic subtest: eDP-1
[257.879738] Dynamic subtest eDP-1: SKIP (0.000s)
[257.883762] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[257.958392] [071/133] (762s left) gem_sync (basic-many-each)
[258.025403] Starting subtest: basic-many-each
[260.299721] Subtest basic-many-each: SUCCESS (2.285s)
[260.497748] [072/133] (760s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[260.580659] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[260.585000] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[260.651248] [073/133] (760s left) kms_cdclk (mode-transition-all-outputs)
[260.739880] Starting subtest: mode-transition-all-outputs
[261.042296] Subtest mode-transition-all-outputs: SKIP (0.300s)
[261.867285] [074/133] (759s left) kms_async_flips (alternate-sync-async-flip)
[261.967887] Starting subtest: alternate-sync-async-flip
[262.345221] Starting dynamic subtest: pipe-A-eDP-1
[265.157688] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.813s)
[265.545223] Starting dynamic subtest: pipe-B-eDP-1
[268.287116] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.751s)
[268.669283] Starting dynamic subtest: pipe-C-eDP-1
[271.425327] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[271.796143] Starting dynamic subtest: pipe-D-eDP-1
[274.552908] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[274.554997] Subtest alternate-sync-async-flip: SUCCESS (12.591s)
[275.721952] [075/133] (745s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[275.836909] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[275.840797] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[275.951396] [076/133] (745s left) syncobj_timeline (multi-wait-available-submitted)
[276.009745] Starting subtest: multi-wait-available-submitted
[276.012047] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[276.122202] [077/133] (744s left) gem_softpin (evict-prime-sanity-check)
[276.175433] Starting subtest: evict-prime-sanity-check
[276.177846] Starting dynamic subtest: rcs0
[277.320182] Dynamic subtest rcs0: SUCCESS (1.144s)
[277.330180] Starting dynamic subtest: bcs0
[278.436579] Dynamic subtest bcs0: SUCCESS (1.115s)
[278.449271] Starting dynamic subtest: vcs0
[279.612983] Dynamic subtest vcs0: SUCCESS (1.175s)
[279.623557] Starting dynamic subtest: vcs1
[281.600081] Dynamic subtest vcs1: SUCCESS (1.984s)
[281.612409] Starting dynamic subtest: vecs0
[283.562321] Dynamic subtest vecs0: SUCCESS (1.960s)
[283.575318] Starting dynamic subtest: ccs0
[284.705922] Dynamic subtest ccs0: SUCCESS (1.142s)
[284.718838] Starting dynamic subtest: all
[285.823662] Dynamic subtest all: SUCCESS (1.116s)
[285.826438] Subtest evict-prime-sanity-check: SUCCESS (9.651s)
[285.908138] [078/133] (735s left) kms_color (ctm-0-50)
[286.016497] Starting subtest: ctm-0-50
[286.018625] Starting dynamic subtest: pipe-A-eDP-1
[289.453310] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s)
[289.463551] Starting dynamic subtest: pipe-B-eDP-1
[293.652716] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.199s)
[293.662618] Starting dynamic subtest: pipe-C-eDP-1
[297.728346] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.078s)
[297.739147] Starting dynamic subtest: pipe-D-eDP-1
[301.707913] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.977s)
[301.710175] Subtest ctm-0-50: SUCCESS (15.695s)
[302.535015] [079/133] (718s left) kms_plane_lowres (tiling-y)
[302.639833] Starting subtest: tiling-y
[302.644322] Subtest tiling-y: SKIP (0.000s)
[302.711493] [080/133] (718s left) vgem_basic (mmap)
[302.821581] Starting subtest: mmap
[302.829532] Subtest mmap: SUCCESS (0.011s)
[302.887459] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[302.890828] [081/133] (718s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[302.986850] Starting subtest: bad-aux-stride-y-tiled-ccs
[302.989215] Starting dynamic subtest: pipe-A-eDP-1
[303.011394] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[303.022572] Starting dynamic subtest: pipe-B-eDP-1
[303.043753] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[303.053481] Starting dynamic subtest: pipe-C-eDP-1
[303.075037] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[303.086390] Starting dynamic subtest: pipe-D-eDP-1
[303.107628] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[303.111589] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[305.304787] [082/133] (716s left) gem_eio (wait-wedge-immediate)
[305.534718] Starting subtest: wait-wedge-immediate
[306.716848] Subtest wait-wedge-immediate: SUCCESS (1.182s)
[306.853456] [083/133] (714s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[306.907863] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[306.972730] [084/133] (714s left) gen7_exec_parse (load-register-reg)
[307.021758] Subtest load-register-reg: SKIP (0.000s)
[307.117374] [085/133] (714s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[307.223519] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[307.225688] Starting dynamic subtest: pipe-A-default-mode
[309.976342] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[309.978607] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.754s)
[310.807592] [086/133] (710s left) kms_plane_alpha_blend (constant-alpha-max)
[310.898015] Starting subtest: constant-alpha-max
[311.207610] Starting dynamic subtest: pipe-A-eDP-1
[312.340250] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.132s)
[312.350475] Starting dynamic subtest: pipe-D-eDP-1
[313.920216] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.579s)
[313.922555] Subtest constant-alpha-max: SUCCESS (3.025s)
[314.783245] [087/133] (706s left) kms_pm_lpsp (screens-disabled)
[315.896981] Starting subtest: screens-disabled
[315.901026] Subtest screens-disabled: SKIP (0.000s)
[315.971808] [088/133] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[316.068302] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[323.456953] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.393s)
[323.575227] [089/133] (698s left) kms_big_fb (linear-32bpp-rotate-90)
[323.676548] Starting subtest: linear-32bpp-rotate-90
[323.697028] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[323.807016] [090/133] (697s left) kms_rotation_crc (sprite-rotation-90)
[323.903232] Starting subtest: sprite-rotation-90
[323.907490] Subtest sprite-rotation-90: SKIP (0.001s)
[323.980237] [091/133] (697s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[324.302481] Starting subtest: cursor-rapid-movement-max-size
[324.309467] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[324.415509] [092/133] (697s left) syncobj_wait (wait-for-submit-snapshot)
[324.463088] Starting subtest: wait-for-submit-snapshot
[324.544593] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[324.638324] [093/133] (697s left) gem_ctx_persistence (legacy-engines-cleanup)
[324.705812] Starting subtest: legacy-engines-cleanup
[324.707761] Starting dynamic subtest: render
[324.760089] Dynamic subtest render: SUCCESS (0.054s)
[324.772149] Starting dynamic subtest: bsd1
[324.835694] Dynamic subtest bsd1: SUCCESS (0.075s)
[324.850056] Starting dynamic subtest: bsd2
[324.887827] Dynamic subtest bsd2: SUCCESS (0.049s)
[324.901399] Starting dynamic subtest: blt
[324.943304] Dynamic subtest blt: SUCCESS (0.052s)
[324.957203] Starting dynamic subtest: vebox
[324.971549] Dynamic subtest vebox: SUCCESS (0.026s)
[324.973530] Subtest legacy-engines-cleanup: SUCCESS (0.267s)
[325.097035] [094/133] (696s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[325.188722] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[325.192190] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[325.291749] [095/133] (696s left) device_reset (unbind-reset-rebind)
[325.344250] Starting subtest: unbind-reset-rebind
[330.307602] Subtest unbind-reset-rebind: SUCCESS (4.958s)
[330.351380] [096/133] (691s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[330.481363] Starting subtest: cursor-vs-flip-atomic-transitions
[360.916320] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.441s)
[361.743740] [097/133] (660s left) gem_ctx_engines (independent)
[361.823218] Starting subtest: independent
[361.825493] Starting dynamic subtest: rcs0
[361.963824] Dynamic subtest rcs0: SUCCESS (0.141s)
[361.978333] Starting dynamic subtest: bcs0
[362.096639] Dynamic subtest bcs0: SUCCESS (0.131s)
[362.109884] Starting dynamic subtest: vcs0
[362.220753] Dynamic subtest vcs0: SUCCESS (0.122s)
[362.231526] Starting dynamic subtest: vcs1
[362.333311] Dynamic subtest vcs1: SUCCESS (0.113s)
[362.344736] Starting dynamic subtest: vecs0
[362.442088] Dynamic subtest vecs0: SUCCESS (0.108s)
[362.454204] Starting dynamic subtest: ccs0
[362.578421] Dynamic subtest ccs0: SUCCESS (0.134s)
[362.589119] Starting dynamic subtest: all-engines
[363.070033] Dynamic subtest all-engines: SUCCESS (0.491s)
[363.072417] Subtest independent: SUCCESS (1.249s)
[363.730400] [098/133] (658s left) i915_drm_fdinfo (idle)
[363.779091] Starting subtest: idle
[363.781035] Starting dynamic subtest: rcs0
[364.341897] Dynamic subtest rcs0: SUCCESS (0.564s)
[364.355351] Starting dynamic subtest: bcs0
[364.848679] Dynamic subtest bcs0: SUCCESS (0.503s)
[364.859493] Starting dynamic subtest: vcs0
[365.354422] Dynamic subtest vcs0: SUCCESS (0.503s)
[365.368316] Starting dynamic subtest: vcs1
[365.860236] Dynamic subtest vcs1: SUCCESS (0.503s)
[365.873735] Starting dynamic subtest: vecs0
[366.366213] Dynamic subtest vecs0: SUCCESS (0.503s)
[366.379231] Starting dynamic subtest: ccs0
[366.871680] Dynamic subtest ccs0: SUCCESS (0.503s)
[366.874670] Subtest idle: SUCCESS (3.095s)
[366.950602] [099/133] (655s left) perf_pmu (most-busy-check-all)
[366.995097] Starting subtest: most-busy-check-all
[366.997347] Starting dynamic subtest: rcs0
[368.645137] Dynamic subtest rcs0: SUCCESS (1.650s)
[368.659459] Starting dynamic subtest: bcs0
[370.629146] Dynamic subtest bcs0: SUCCESS (1.982s)
[370.641986] Starting dynamic subtest: vcs0
[372.613548] Dynamic subtest vcs0: SUCCESS (1.981s)
[372.627603] Starting dynamic subtest: vcs1
[374.661194] Dynamic subtest vcs1: SUCCESS (2.045s)
[374.675718] Starting dynamic subtest: vecs0
[376.645531] Dynamic subtest vecs0: SUCCESS (1.981s)
[376.659954] Starting dynamic subtest: ccs0
[378.628957] Dynamic subtest ccs0: SUCCESS (1.981s)
[378.631992] Subtest most-busy-check-all: SUCCESS (11.639s)
[378.723989] [100/133] (643s left) kms_tiled_display (basic-test-pattern)
[378.844937] Subtest basic-test-pattern: SKIP (0.000s)
[378.895019] [101/133] (643s left) kms_psr (pr-sprite-plane-onoff)
[378.999933] Starting subtest: pr-sprite-plane-onoff
[379.004210] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[379.074768] [102/133] (643s left) kms_hdr (bpc-switch-dpms)
[379.160947] Starting subtest: bpc-switch-dpms
[380.211363] Starting dynamic subtest: pipe-A-eDP-1
[384.738063] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.527s)
[384.740449] Subtest bpc-switch-dpms: SUCCESS (5.580s)
[384.841196] [103/133] (637s left) gem_exec_fence (submit)
[385.014415] Starting subtest: submit
[385.019836] Subtest submit: SKIP (0.000s)
[386.706508] [104/133] (635s left) syncobj_wait (wait-all-interrupted)
[386.775974] Starting subtest: wait-all-interrupted
[386.879442] Subtest wait-all-interrupted: SUCCESS (0.103s)
[386.958455] [105/133] (635s left) gem_exec_schedule (submit-early-slice)
[387.046886] Starting subtest: submit-early-slice
[387.048889] Starting dynamic subtest: rcs0
[387.082284] Dynamic subtest rcs0: SUCCESS (0.043s)
[387.093299] Starting dynamic subtest: bcs0
[387.121715] Dynamic subtest bcs0: SUCCESS (0.038s)
[387.134101] Starting dynamic subtest: vcs0
[387.167684] Dynamic subtest vcs0: SUCCESS (0.045s)
[387.179919] Starting dynamic subtest: vcs1
[387.210370] Dynamic subtest vcs1: SUCCESS (0.042s)
[387.221938] Starting dynamic subtest: vecs0
[387.251248] Dynamic subtest vecs0: SUCCESS (0.040s)
[387.262555] Starting dynamic subtest: ccs0
[387.288695] Dynamic subtest ccs0: SUCCESS (0.037s)
[387.290995] Subtest submit-early-slice: SUCCESS (0.251s)
[388.717807] [106/133] (633s left) gem_exec_whisper (basic-queues-priority-all)
[388.790093] Starting subtest: basic-queues-priority-all
[410.991536] Subtest basic-queues-priority-all: SUCCESS (22.204s)
[411.176328] [107/133] (611s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[411.284734] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[411.289143] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[411.375396] [108/133] (611s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[411.470606] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[411.472923] Starting dynamic subtest: pipe-A-eDP-1
[411.481676] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.492825] Starting dynamic subtest: pipe-B-eDP-1
[411.501472] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.513243] Starting dynamic subtest: pipe-C-eDP-1
[411.521600] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.531837] Starting dynamic subtest: pipe-D-eDP-1
[411.540373] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.544662] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[413.742586] [109/133] (608s left) i915_pm_rpm (gem-execbuf-stress)
[415.774872] Starting subtest: gem-execbuf-stress
[415.777478] Starting dynamic subtest: smem0
[428.757241] Dynamic subtest smem0: SUCCESS (12.985s)
[428.773515] Starting dynamic subtest: extra-wait-smem0
[490.521402] Dynamic subtest extra-wait-smem0: SUCCESS (61.779s)
[490.524335] Subtest gem-execbuf-stress: SUCCESS (74.772s)
[490.902297] [110/133] (531s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[490.965325] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[490.967205] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[491.049254] [111/133] (531s left) gem_pread (snoop)
[491.101387] Subtest snoop: SKIP (0.000s)
[491.162809] [112/133] (531s left) kms_draw_crc (draw-method-mmap-cpu)
[491.251343] Starting subtest: draw-method-mmap-cpu
[491.255193] Starting dynamic subtest: xrgb8888-untiled
[491.494333] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[491.506343] Starting dynamic subtest: rgb565-untiled
[491.716694] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[491.727636] Starting dynamic subtest: xrgb2101010-untiled
[491.927182] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[491.937736] Starting dynamic subtest: xbgr16161616f-untiled
[492.153229] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[492.163668] Starting dynamic subtest: xrgb8888-xtiled
[492.293638] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.142s)
[492.304562] Starting dynamic subtest: rgb565-xtiled
[492.438213] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s)
[492.448549] Starting dynamic subtest: xrgb2101010-xtiled
[492.562746] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[492.574033] Starting dynamic subtest: xbgr16161616f-xtiled
[492.693512] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[492.704230] Starting dynamic subtest: xrgb8888-4tiled
[492.837864] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[492.848164] Starting dynamic subtest: rgb565-4tiled
[492.971251] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[492.981799] Starting dynamic subtest: xrgb2101010-4tiled
[493.104433] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.131s)
[493.117456] Starting dynamic subtest: xbgr16161616f-4tiled
[493.259986] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.153s)
[493.261754] Subtest draw-method-mmap-cpu: SUCCESS (2.014s)
[493.365623] [113/133] (529s left) kms_lease (possible-crtcs-filtering)
[493.456116] Starting subtest: possible-crtcs-filtering
[493.460267] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[493.576023] [114/133] (529s left) gem_ctx_persistence (engines-hostile-preempt)
[493.634711] Starting subtest: engines-hostile-preempt
[493.636744] Starting dynamic subtest: rcs0
[493.688878] Dynamic subtest rcs0: SUCCESS (0.054s)
[493.699071] Starting dynamic subtest: bcs0
[493.792195] Dynamic subtest bcs0: SUCCESS (0.101s)
[493.803142] Starting dynamic subtest: vcs0
[495.627088] Dynamic subtest vcs0: SUCCESS (1.831s)
[495.642472] Starting dynamic subtest: vcs1
[497.598049] Dynamic subtest vcs1: SUCCESS (1.969s)
[497.611933] Starting dynamic subtest: vecs0
[499.645873] Dynamic subtest vecs0: SUCCESS (2.046s)
[499.659200] Starting dynamic subtest: ccs0
[499.693156] Dynamic subtest ccs0: SUCCESS (0.046s)
[499.695501] Subtest engines-hostile-preempt: SUCCESS (6.061s)
[499.778971] [115/133] (523s left) syncobj_timeline (invalid-query-one-illegal-handle)
[499.827333] Starting subtest: invalid-query-one-illegal-handle
[499.829475] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[499.930457] [116/133] (522s left) gem_exec_reloc (basic-cpu-wc)
[499.994316] Subtest basic-cpu-wc: SKIP (0.000s)
[500.085145] [117/133] (522s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[500.195204] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[500.199734] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[500.317062] [118/133] (522s left) gem_pwrite (basic-self)
[500.379987] Subtest basic-self: SKIP (0.000s)
[500.449716] [119/133] (522s left) kms_cursor_crc (cursor-dpms)
[500.580017] Starting subtest: cursor-dpms
[500.582224] Starting dynamic subtest: pipe-A-eDP-1
[503.648993] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.069s)
[503.659843] Starting dynamic subtest: pipe-D-eDP-1
[507.257359] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.611s)
[507.259753] Subtest cursor-dpms: SUCCESS (6.682s)
[508.100544] [120/133] (514s left) vgem_basic (create)
[508.150593] Starting subtest: create
[508.152492] Subtest create: SUCCESS (0.000s)
[508.214992] [121/133] (514s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[508.327304] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[508.331342] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[508.419661] [122/133] (514s left) syncobj_timeline (wait-for-submit-snapshot)
[508.482877] Starting subtest: wait-for-submit-snapshot
[508.562573] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[508.667370] [123/133] (514s left) gem_exec_schedule (lateslice)
[508.735549] Starting subtest: lateslice
[508.737510] Starting dynamic subtest: rcs0
[508.750107] Dynamic subtest rcs0: SUCCESS (0.024s)
[508.761036] Starting dynamic subtest: bcs0
[508.768892] Dynamic subtest bcs0: SUCCESS (0.018s)
[508.779530] Starting dynamic subtest: vcs0
[508.787292] Dynamic subtest vcs0: SUCCESS (0.018s)
[508.797849] Starting dynamic subtest: vcs1
[508.805126] Dynamic subtest vcs1: SUCCESS (0.017s)
[508.815674] Starting dynamic subtest: vecs0
[508.821353] Dynamic subtest vecs0: SUCCESS (0.015s)
[508.834625] Starting dynamic subtest: ccs0
[508.839247] Dynamic subtest ccs0: SUCCESS (0.017s)
[508.841383] Subtest lateslice: SUCCESS (0.114s)
[510.736363] [124/133] (512s left) gem_exec_fence (basic-wait)
[510.925716] Starting subtest: basic-wait
[510.928265] Starting dynamic subtest: rcs0
[511.014882] Dynamic subtest rcs0: SUCCESS (0.092s)
[511.028434] Starting dynamic subtest: bcs0
[511.081894] Dynamic subtest bcs0: SUCCESS (0.064s)
[511.094577] Starting dynamic subtest: vcs0
[511.148007] Dynamic subtest vcs0: SUCCESS (0.064s)
[511.164909] Starting dynamic subtest: vcs1
[511.210374] Dynamic subtest vcs1: SUCCESS (0.060s)
[511.222672] Starting dynamic subtest: vecs0
[511.274207] Dynamic subtest vecs0: SUCCESS (0.062s)
[511.286900] Starting dynamic subtest: ccs0
[511.335032] Dynamic subtest ccs0: SUCCESS (0.059s)
[511.337525] Subtest basic-wait: SUCCESS (0.414s)
[512.728002] [125/133] (510s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[512.825952] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[512.830296] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[512.955575] [126/133] (510s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[513.066806] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[514.138561] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.073s)
[514.266460] [127/133] (509s left) gem_exec_fence (basic-busy-all)
[514.323473] Starting subtest: basic-busy-all
[514.405300] Subtest basic-busy-all: SUCCESS (0.083s)
[516.694340] [128/133] (506s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[516.787351] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[516.789693] Starting dynamic subtest: pipe-A-eDP-1
[527.773731] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.996s)
[527.787227] Starting dynamic subtest: pipe-B-eDP-1
[539.495146] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.721s)
[539.497400] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.722s)
[540.341056] [129/133] (483s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[540.449278] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[540.459909] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[540.550251] [130/133] (482s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[540.638689] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[547.979546] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.347s)
[548.071149] [131/133] (475s left) kms_plane_scaling (planes-upscale-factor-0-25)
[548.165701] Starting subtest: planes-upscale-factor-0-25
[548.167814] Starting dynamic subtest: pipe-A
[548.226128] Dynamic subtest pipe-A: SUCCESS (0.063s)
[548.238735] Starting dynamic subtest: pipe-B
[549.384450] Dynamic subtest pipe-B: SUCCESS (1.158s)
[549.397613] Starting dynamic subtest: pipe-C
[550.506730] Dynamic subtest pipe-C: SUCCESS (1.122s)
[550.518719] Starting dynamic subtest: pipe-D
[551.636478] Dynamic subtest pipe-D: SUCCESS (1.129s)
[551.638972] Subtest planes-upscale-factor-0-25: SUCCESS (3.475s)
[552.790298] [132/133] (470s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[552.902696] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[559.707874] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.812s)
[559.848999] [133/133] (463s left) kms_vblank (query-forked-hang)
[559.945819] Starting subtest: query-forked-hang
[559.947986] Starting dynamic subtest: pipe-A-eDP-1
[586.374695] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.438s)
[586.390371] Starting dynamic subtest: pipe-D-eDP-1
[611.389370] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.020s)
[611.391395] Subtest query-forked-hang: SUCCESS (51.463s)
[612.256198] Closing watchdogs
results: parsing output: 0/ for test: i915_pciid
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_watchdog
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_caching
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_workarounds
results: parsing output: 11/ for test: kms_dirtyfb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_ccs
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: gen3_render_mixed_blits
results: parsing output: 16/ for test: kms_atomic
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: gem_mmap
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_suspend
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: gem_mmap_wc
results: parsing output: 28/ for test: kms_prop_blob
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_content_protection
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: prime_busy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: i915_pm_sseu
results: parsing output: 43/ for test: kms_invalid_mode
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: gem_ctx_shared
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: gem_mmap
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_flink_basic
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_setmode
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: gem_tiled_blits
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_madvise
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_sync
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_cdclk
results: parsing output: 73/ for test: kms_async_flips
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_softpin
results: parsing output: 77/ for test: kms_color
results: parsing output: 78/ for test: kms_plane_lowres
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: kms_pipe_b_c_ivb
results: parsing output: 83/ for test: gen7_exec_parse
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_plane_alpha_blend
results: parsing output: 86/ for test: kms_pm_lpsp
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_rotation_crc
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: device_reset
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_ctx_engines
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_tiled_display
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_hdr
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: i915_pm_rpm
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: gem_pread
results: parsing output: 111/ for test: kms_draw_crc
results: parsing output: 112/ for test: kms_lease
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_pwrite
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_vblank
Done.