[60.202202] Initializing watchdogs
[60.202268]   /dev/watchdog0
[60.227212] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.236705] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.240608] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.243333] [001/129] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[60.529033] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[60.530649] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[60.674947] [002/129] (960s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[60.747559] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[60.748526] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[60.882682] [003/129] (959s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[61.083423] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[61.085237] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[61.375287] [004/129] (959s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[61.692165] Starting subtest: cursor-rapid-movement-64x21
[61.695947] Starting dynamic subtest: pipe-A-DP-4
[62.162709] Dynamic subtest pipe-A-DP-4: SUCCESS (0.469s)
[62.208158] Starting dynamic subtest: pipe-D-DP-4
[62.575871] Dynamic subtest pipe-D-DP-4: SUCCESS (0.376s)
[62.577025] Subtest cursor-rapid-movement-64x21: SUCCESS (0.888s)
[63.022810] [005/129] (957s left) syncobj_wait (invalid-reset-zero-handles)
[63.095557] Starting subtest: invalid-reset-zero-handles
[63.096443] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[63.238596] [006/129] (957s left) syncobj_eventfd (invalid-bad-flags)
[63.310573] Starting subtest: invalid-bad-flags
[63.311497] Subtest invalid-bad-flags: SUCCESS (0.000s)
[63.438215] [007/129] (957s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[63.648604] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[64.910836] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.260s)
[65.089582] [008/129] (956s left) gem_ctx_engines (execute-one)
[65.178112] Starting subtest: execute-one
[68.350924] Subtest execute-one: SUCCESS (3.183s)
[68.611911] [009/129] (952s left) gen9_exec_parse (cmd-crossing-page)
[68.693401] Subtest cmd-crossing-page: SKIP (0.000s)
[68.770146] [010/129] (952s left) syncobj_basic (bad-destroy-pad)
[68.838969] Starting subtest: bad-destroy-pad
[68.839884] Subtest bad-destroy-pad: SUCCESS (0.000s)
[69.000192] [011/129] (952s left) kms_pipe_crc_basic (read-crc)
[69.199594] Starting subtest: read-crc
[69.200492] Starting dynamic subtest: pipe-A-DP-4
[69.814811] Dynamic subtest pipe-A-DP-4: SUCCESS (0.614s)
[69.826774] Starting dynamic subtest: pipe-B-DP-4
[70.357927] Dynamic subtest pipe-B-DP-4: SUCCESS (0.543s)
[70.370930] Starting dynamic subtest: pipe-C-DP-4
[70.936008] Dynamic subtest pipe-C-DP-4: SUCCESS (0.578s)
[70.947291] Starting dynamic subtest: pipe-D-DP-4
[71.515863] Dynamic subtest pipe-D-DP-4: SUCCESS (0.579s)
[71.516820] Subtest read-crc: SUCCESS (2.320s)
[71.776565] [012/129] (949s left) gem_mmap_gtt (basic-wc)
[71.849691] Subtest basic-wc: SKIP (0.000s)
[71.921192] [013/129] (949s left) gem_ringfill (basic-all)
[72.384462] Starting subtest: basic-all
[74.085989] Subtest basic-all: SUCCESS (1.704s)
[74.216959] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[74.219090] [014/129] (947s left) i915_pm_rps (min-max-config-idle)
[74.345848] Starting subtest: min-max-config-idle
[74.348393] Subtest min-max-config-idle: SKIP (0.001s)
[74.516465] [015/129] (947s left) gem_basic (multigpu-create-close)
[74.596054] Starting subtest: multigpu-create-close
[74.598047] Subtest multigpu-create-close: SKIP (0.000s)
[74.733621] [016/129] (946s left) i915_pm_rpm (gem-execbuf)
[77.068080] Starting subtest: gem-execbuf
[77.070300] Starting dynamic subtest: lmem0
[79.815892] Dynamic subtest lmem0: SUCCESS (2.748s)
[79.825608] Starting dynamic subtest: smem0
[82.654375] Dynamic subtest smem0: SUCCESS (2.838s)
[82.656457] Subtest gem-execbuf: SUCCESS (5.587s)
[83.047060] [017/129] (938s left) perf (whitelisted-registers-userspace-config)
[83.371075] Starting subtest: whitelisted-registers-userspace-config
[83.371966] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[83.431105] [018/129] (938s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[83.650275] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[84.891525] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.240s)
[85.073923] [019/129] (936s left) kms_psr (pr-sprite-render)
[85.281413] Subtest pr-sprite-render: SKIP (0.000s)
[85.326215] [020/129] (936s left) kms_vrr (lobf)
[85.535519] Starting subtest: lobf
[85.537301] Subtest lobf: SKIP (0.000s)
[85.653679] [021/129] (936s left) kms_lease (lease-unleased-crtc)
[85.859709] Starting subtest: lease-unleased-crtc
[85.860581] Starting dynamic subtest: pipe-A-DP-4
[85.996658] Dynamic subtest pipe-A-DP-4: SUCCESS (0.136s)
[86.005597] Starting dynamic subtest: pipe-B-DP-4
[86.064748] Dynamic subtest pipe-B-DP-4: SUCCESS (0.067s)
[86.074101] Starting dynamic subtest: pipe-C-DP-4
[86.131181] Dynamic subtest pipe-C-DP-4: SUCCESS (0.065s)
[86.139069] Starting dynamic subtest: pipe-D-DP-4
[86.197393] Dynamic subtest pipe-D-DP-4: SUCCESS (0.065s)
[86.198329] Subtest lease-unleased-crtc: SUCCESS (0.338s)
[86.388256] [022/129] (935s left) kms_atomic_transition (plane-all-transition-fencing)
[86.595732] Starting subtest: plane-all-transition-fencing
[86.596587] Starting dynamic subtest: pipe-A-DP-4
[90.320076] Dynamic subtest pipe-A-DP-4: SUCCESS (3.722s)
[90.426421] Starting dynamic subtest: pipe-B-DP-4
[94.192226] Dynamic subtest pipe-B-DP-4: SUCCESS (3.796s)
[94.245269] Subtest plane-all-transition-fencing: SUCCESS (7.648s)
[94.504693] [023/129] (927s left) kms_vblank (ts-continuation-modeset-hang)
[94.716576] Starting subtest: ts-continuation-modeset-hang
[94.717478] Starting dynamic subtest: pipe-A-DP-4
[121.561418] Dynamic subtest pipe-A-DP-4: SUCCESS (26.843s)
[121.571374] Starting dynamic subtest: pipe-D-DP-4
[146.563747] Dynamic subtest pipe-D-DP-4: SUCCESS (24.998s)
[146.564613] Subtest ts-continuation-modeset-hang: SUCCESS (51.845s)
[146.815502] [024/129] (875s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[147.021834] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[147.022706] Starting dynamic subtest: pipe-A-DP-4
[147.031459] Dynamic subtest pipe-A-DP-4: SKIP (0.001s)
[147.039635] Starting dynamic subtest: pipe-B-DP-4
[147.048302] Dynamic subtest pipe-B-DP-4: SKIP (0.001s)
[147.056392] Starting dynamic subtest: pipe-C-DP-4
[147.064879] Dynamic subtest pipe-C-DP-4: SKIP (0.001s)
[147.072749] Starting dynamic subtest: pipe-D-DP-4
[147.081503] Dynamic subtest pipe-D-DP-4: SKIP (0.001s)
[147.083386] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[147.469730] [025/129] (874s left) perf (create-destroy-userspace-config)
[147.665300] Starting subtest: create-destroy-userspace-config
[147.695460] Subtest create-destroy-userspace-config: SUCCESS (0.030s)
[147.745666] [026/129] (874s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[147.953893] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[158.903161] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.947s)
[159.163047] [027/129] (863s left) gem_exec_fence (submit)
[159.405190] Starting subtest: submit
[159.407960] Subtest submit: SKIP (0.000s)
[160.150702] [028/129] (862s left) gem_eio (in-flight-external)
[160.420242] Starting subtest: in-flight-external
[161.951207] Subtest in-flight-external: SUCCESS (1.531s)
[162.179604] [029/129] (860s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[162.257593] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[162.258520] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[162.411342] [030/129] (860s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[162.618745] Starting subtest: primary-yf-tiled-reflect-x-180
[162.717625] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.098s)
[162.871810] [031/129] (859s left) kms_psr (psr-primary-blt)
[163.079257] Subtest psr-primary-blt: SKIP (0.000s)
[163.138744] [032/129] (859s left) gem_exec_schedule (u-fairslice)
[163.228783] Starting subtest: u-fairslice
[163.229740] Starting dynamic subtest: rcs0
[165.272418] Dynamic subtest rcs0: SUCCESS (2.042s)
[165.281776] Starting dynamic subtest: bcs0
[167.290401] Dynamic subtest bcs0: SUCCESS (2.017s)
[167.299597] Starting dynamic subtest: vcs0
[169.306880] Dynamic subtest vcs0: SUCCESS (2.016s)
[169.316632] Starting dynamic subtest: vcs1
[171.325923] Dynamic subtest vcs1: SUCCESS (2.019s)
[171.335229] Starting dynamic subtest: vecs0
[173.342851] Dynamic subtest vecs0: SUCCESS (2.016s)
[173.352592] Starting dynamic subtest: vecs1
[175.361514] Dynamic subtest vecs1: SUCCESS (2.018s)
[175.370926] Starting dynamic subtest: ccs0
[177.377868] Dynamic subtest ccs0: SUCCESS (2.016s)
[177.379016] Subtest u-fairslice: SUCCESS (14.147s)
[177.785610] [033/129] (845s left) gem_pxp (reject-modify-context-protection-off-1)
[180.391471] Starting subtest: reject-modify-context-protection-off-1
[180.393506] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[180.488876] [034/129] (842s left) gem_softpin (evict-active-interruptible)
[180.573262] Starting subtest: evict-active-interruptible
[180.590082] Subtest evict-active-interruptible: SUCCESS (0.017s)
[180.700830] [035/129] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[180.931586] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[180.933425] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[181.068246] [036/129] (841s left) gem_lmem_swapping (basic)
[183.847849] Starting subtest: basic
[183.848928] Starting dynamic subtest: lmem0
[200.860239] Dynamic subtest lmem0: SUCCESS (17.012s)
[200.861228] Subtest basic: SUCCESS (17.012s)
[202.599043] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[202.600042] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[202.601863] [037/129] (820s left) debugfs_test (read_all_entries)
[204.051398] Starting subtest: read_all_entries
[204.587401] Subtest read_all_entries: SUCCESS (0.536s)
[204.824967] [FACT debugfs_test (read_all_entries)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[204.828460] [FACT debugfs_test (read_all_entries)] new: kernel.kmod_is_loaded.i915: true
[204.832064] [038/129] (818s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[205.040180] Starting subtest: plane-primary-overlay-mutable-zpos
[206.732284] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.691s)
[207.068562] [039/129] (816s left) fbdev (pan)
[207.120153] Starting subtest: pan
[207.164334] Subtest pan: SUCCESS (0.044s)
[207.290535] [040/129] (815s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[207.382458] Starting subtest: y-tiled-ccs-to-y-tiled
[207.384599] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[207.612941] [041/129] (815s left) i915_suspend (fence-restore-untiled)
[207.705235] Starting subtest: fence-restore-untiled
[207.707381] Subtest fence-restore-untiled: SKIP (0.000s)
[207.846547] [042/129] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[208.057952] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[208.059771] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[208.172233] [043/129] (815s left) gem_userptr_blits (relocations)
[208.264227] Starting subtest: relocations
[208.266035] Subtest relocations: SKIP (0.000s)
[208.465368] [044/129] (815s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[208.680722] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[208.694742] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.013s)
[208.801220] [045/129] (814s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[209.015524] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[209.017290] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[209.145584] [046/129] (814s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[209.353942] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[209.354742] Starting dynamic subtest: pipe-A
[210.033918] Dynamic subtest pipe-A: SKIP (0.678s)
[210.042429] Starting dynamic subtest: pipe-B
[211.060025] Dynamic subtest pipe-B: SKIP (1.025s)
[211.068341] Starting dynamic subtest: pipe-C
[212.089848] Dynamic subtest pipe-C: SKIP (1.029s)
[212.098103] Starting dynamic subtest: pipe-D
[213.120058] Dynamic subtest pipe-D: SKIP (1.029s)
[213.121488] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (3.765s)
[213.240539] [047/129] (810s left) syncobj_wait (wait-zero-handles)
[213.337807] Starting subtest: wait-zero-handles
[213.338749] Subtest wait-zero-handles: SUCCESS (0.000s)
[213.458445] [048/129] (810s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[213.672787] Starting subtest: psr-2p-primscrn-cur-indfb-move
[213.674528] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[213.774842] [049/129] (809s left) gem_softpin (invalid)
[213.859661] Starting subtest: invalid
[213.870802] Subtest invalid: SUCCESS (0.011s)
[213.990851] [050/129] (809s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[214.202601] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[214.204315] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[214.291922] [051/129] (809s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[214.499664] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[214.500474] Starting dynamic subtest: pipe-A
[215.064370] Dynamic subtest pipe-A: SUCCESS (0.565s)
[215.072941] Starting dynamic subtest: pipe-B
[215.701087] Dynamic subtest pipe-B: SUCCESS (0.634s)
[215.726255] Starting dynamic subtest: pipe-C
[216.352086] Dynamic subtest pipe-C: SUCCESS (0.649s)
[216.374519] Starting dynamic subtest: pipe-D
[217.005397] Dynamic subtest pipe-D: SUCCESS (0.651s)
[217.007059] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (2.508s)
[217.360718] [052/129] (806s left) kms_draw_crc (draw-method-mmap-wc)
[217.577943] Starting subtest: draw-method-mmap-wc
[217.579638] Subtest draw-method-mmap-wc: SKIP (0.000s)
[217.739266] [053/129] (806s left) kms_chamelium_hpd (dp-hpd-storm)
[218.018533] Subtest dp-hpd-storm: SKIP (0.000s)
[218.169532] [054/129] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[218.382811] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[218.384524] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[218.509114] [055/129] (805s left) kms_flip (2x-blocking-absolute-wf_vblank)
[218.718030] Starting subtest: 2x-blocking-absolute-wf_vblank
[218.731567] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[218.824008] [056/129] (805s left) gem_eio (in-flight-contexts-1us)
[219.084365] Starting subtest: in-flight-contexts-1us
[232.963189] Subtest in-flight-contexts-1us: SUCCESS (13.878s)
[233.201066] [057/129] (791s left) prime_mmap (test_forked_cpu_write)
[233.283422] Starting subtest: test_forked_cpu_write
[233.284344] Starting dynamic subtest: test_forked_cpu_write-smem
[233.295199] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[233.304701] Starting dynamic subtest: test_forked_cpu_write-lmem0
[233.307436] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.011s)
[233.308335] Subtest test_forked_cpu_write: SUCCESS (0.025s)
[233.472573] [058/129] (790s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[234.077447] Starting subtest: syncobj-timeline-invalid-wait
[234.079874] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s)
[234.311154] [059/129] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[234.523895] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[234.525666] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[234.663804] [060/129] (789s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[234.877055] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[234.936716] [061/129] (789s left) gen7_exec_parse (oacontrol-tracking)
[235.021136] Subtest oacontrol-tracking: SKIP (0.000s)
[235.111158] [062/129] (789s left) drm_fdinfo (all-busy-check-all)
[235.183263] Starting subtest: all-busy-check-all
[235.206357] Subtest all-busy-check-all: SKIP (0.022s)
[235.289981] [063/129] (789s left) gem_mmap_gtt (basic-write-read)
[235.401122] Subtest basic-write-read: SKIP (0.000s)
[235.474043] [064/129] (789s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[235.690550] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[235.692430] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[235.837054] [065/129] (788s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[236.051990] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[236.053851] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[236.174390] [066/129] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[236.385613] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[236.387279] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[236.503127] [067/129] (788s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[236.723590] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[236.724496] Starting dynamic subtest: pipe-A-DP-4
[236.733170] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[236.742526] Starting dynamic subtest: pipe-B-DP-4
[236.751213] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[236.760439] Starting dynamic subtest: pipe-C-DP-4
[236.768894] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[236.777923] Starting dynamic subtest: pipe-D-DP-4
[236.787333] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[236.789402] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[237.166241] [068/129] (787s left) kms_getfb (getfb-handle-protection)
[237.259447] Starting subtest: getfb-handle-protection
[237.279087] Subtest getfb-handle-protection: SUCCESS (0.020s)
[237.411588] [069/129] (787s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[237.618948] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[237.619951] Starting dynamic subtest: pipe-A-DP-4
[237.628807] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[237.638387] Starting dynamic subtest: pipe-B-DP-4
[237.647164] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[237.656405] Starting dynamic subtest: pipe-C-DP-4
[237.664958] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[237.674151] Starting dynamic subtest: pipe-D-DP-4
[237.683887] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[237.685848] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[238.060434] [070/129] (786s left) gem_exec_schedule (deep)
[238.271980] Starting subtest: deep
[238.273013] Starting dynamic subtest: rcs0
[251.051894] Dynamic subtest rcs0: SUCCESS (12.779s)
[251.061754] Starting dynamic subtest: bcs0
[264.233253] Dynamic subtest bcs0: SUCCESS (13.180s)
[264.243170] Starting dynamic subtest: vcs0
[277.386374] Dynamic subtest vcs0: SUCCESS (13.151s)
[277.396151] Starting dynamic subtest: vcs1
[290.535053] Dynamic subtest vcs1: SUCCESS (13.147s)
[290.544851] Starting dynamic subtest: vecs0
[303.409450] Dynamic subtest vecs0: SUCCESS (12.873s)
[303.419368] Starting dynamic subtest: vecs1
[316.621468] Dynamic subtest vecs1: SUCCESS (13.211s)
[316.631386] Starting dynamic subtest: ccs0
[330.206575] Dynamic subtest ccs0: SUCCESS (13.584s)
[330.207547] Subtest deep: SUCCESS (91.933s)
[331.010276] [071/129] (694s left) gem_exec_reloc (basic-write-gtt-active)
[331.094253] Subtest basic-write-gtt-active: SKIP (0.000s)
[331.171627] [072/129] (693s left) kms_force_connector_basic (force-connector-state)
[331.282567] Starting subtest: force-connector-state
[331.690212] Subtest force-connector-state: SUCCESS (0.408s)
[332.114732] [073/129] (693s left) kms_cursor_crc (cursor-offscreen-512x512)
[332.526432] Starting subtest: cursor-offscreen-512x512
[332.528293] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[332.811859] [074/129] (692s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[333.030603] Starting subtest: yf-tiled-64bpp-rotate-270
[333.032379] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[333.136815] [075/129] (692s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[333.349451] Starting subtest: short-flip-after-cursor-atomic-transitions
[334.371125] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.021s)
[334.651833] [076/129] (690s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[334.737304] Starting subtest: yf-tiled-to-vebox-x-tiled
[334.739190] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[334.996384] [077/129] (690s left) gem_mmap (bad-size)
[335.087522] Subtest bad-size: SKIP (0.000s)
[335.171353] [078/129] (690s left) gem_exec_schedule (semaphore-noskip)
[335.265560] Starting subtest: semaphore-noskip
[336.077859] Subtest semaphore-noskip: SUCCESS (0.812s)
[336.472355] [079/129] (689s left) gem_exec_whisper (basic-contexts-forked)
[336.567732] Starting subtest: basic-contexts-forked
[359.072156] Subtest basic-contexts-forked: SUCCESS (22.502s)
[359.306182] [080/129] (666s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[359.525254] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[359.527024] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[359.647020] [081/129] (666s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[359.734103] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[359.839567] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[359.978616] [082/129] (665s left) gem_exec_flush (basic-wb-pro-default)
[360.069901] Subtest basic-wb-pro-default: SKIP (0.000s)
[360.150265] [083/129] (665s left) gem_spin_batch (legacy-resubmit-new)
[360.240391] Starting subtest: legacy-resubmit-new
[360.241354] Starting dynamic subtest: default
[360.267465] Dynamic subtest default: SUCCESS (0.026s)
[360.278992] Starting dynamic subtest: render
[360.279984] Dynamic subtest render: SUCCESS (0.004s)
[360.290167] Starting dynamic subtest: bsd
[360.291163] Dynamic subtest bsd: SUCCESS (0.003s)
[360.301333] Starting dynamic subtest: bsd1
[360.302418] Dynamic subtest bsd1: SUCCESS (0.003s)
[360.312206] Starting dynamic subtest: bsd2
[360.313170] Dynamic subtest bsd2: SUCCESS (0.004s)
[360.322773] Starting dynamic subtest: blt
[360.323869] Dynamic subtest blt: SUCCESS (0.005s)
[360.333133] Starting dynamic subtest: vebox
[360.334204] Dynamic subtest vebox: SUCCESS (0.003s)
[360.335372] Subtest legacy-resubmit-new: SUCCESS (0.057s)
[360.620511] [084/129] (665s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[360.830684] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[360.831599] Starting dynamic subtest: pipe-A-valid-mode
[360.912054] Dynamic subtest pipe-A-valid-mode: SKIP (0.079s)
[360.913909] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.081s)
[361.121139] [085/129] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[361.342441] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[361.344140] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[361.458044] [086/129] (664s left) gem_shrink (reclaim)
[361.542647] Starting subtest: reclaim
[363.794769] Subtest reclaim: SUCCESS (2.251s)
[364.016472] [087/129] (662s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[364.244615] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[364.245371] Starting dynamic subtest: pipe-A
[364.350524] Dynamic subtest pipe-A: SUCCESS (0.106s)
[364.363865] Starting dynamic subtest: pipe-B
[364.553598] Dynamic subtest pipe-B: SUCCESS (0.202s)
[364.566794] Starting dynamic subtest: pipe-C
[364.772913] Dynamic subtest pipe-C: SUCCESS (0.218s)
[364.785295] Starting dynamic subtest: pipe-D
[364.977506] Dynamic subtest pipe-D: SUCCESS (0.203s)
[364.983563] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.735s)
[365.349236] [088/129] (660s left) kms_fbcon_fbt (fbc-suspend)
[365.431519] Starting subtest: fbc-suspend
[417.643231] Subtest fbc-suspend: SUCCESS (21.363s)
[417.791196] [089/129] (639s left) kms_sequence (queue-idle)
[418.001588] Starting subtest: queue-idle
[418.002523] Starting dynamic subtest: pipe-A-DP-4
[420.347995] Dynamic subtest pipe-A-DP-4: SUCCESS (2.345s)
[420.359528] Starting dynamic subtest: pipe-B-DP-4
[422.627355] Dynamic subtest pipe-B-DP-4: SUCCESS (2.277s)
[422.639348] Starting dynamic subtest: pipe-C-DP-4
[424.899098] Dynamic subtest pipe-C-DP-4: SUCCESS (2.270s)
[424.911220] Starting dynamic subtest: pipe-D-DP-4
[427.174476] Dynamic subtest pipe-D-DP-4: SUCCESS (2.273s)
[427.175369] Subtest queue-idle: SUCCESS (9.173s)
[427.444049] [090/129] (629s left) gem_exec_parallel (fds)
[427.533646] Starting subtest: fds
[427.534626] Starting dynamic subtest: rcs0
[430.979964] Dynamic subtest rcs0: SUCCESS (3.445s)
[430.991732] Starting dynamic subtest: bcs0
[435.747786] Dynamic subtest bcs0: SUCCESS (4.795s)
[435.759262] Starting dynamic subtest: vcs0
[440.407170] Dynamic subtest vcs0: SUCCESS (4.689s)
[440.419178] Starting dynamic subtest: vcs1
[443.962463] Dynamic subtest vcs1: SUCCESS (3.569s)
[443.974524] Starting dynamic subtest: vecs0
[447.196169] Dynamic subtest vecs0: SUCCESS (3.241s)
[447.208336] Starting dynamic subtest: vecs1
[451.840918] Dynamic subtest vecs1: SUCCESS (4.653s)
[451.853898] Starting dynamic subtest: ccs0
[456.562721] Dynamic subtest ccs0: SUCCESS (4.726s)
[456.563778] Subtest fds: SUCCESS (29.125s)
[456.854573] [091/129] (600s left) kms_pm_rpm (drm-resources-equal)
[458.903931] Starting subtest: drm-resources-equal
[460.287881] Subtest drm-resources-equal: SUCCESS (1.385s)
[460.426785] [092/129] (596s left) api_intel_bb (blit-noreloc-purge-cache)
[460.514509] Starting subtest: blit-noreloc-purge-cache
[460.542112] Subtest blit-noreloc-purge-cache: SUCCESS (0.028s)
[460.731948] [093/129] (596s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[460.945307] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[461.004388] [094/129] (596s left) perf_pmu (busy-accuracy-50)
[461.077369] Starting subtest: busy-accuracy-50
[461.078250] Starting dynamic subtest: rcs0
[462.628493] Dynamic subtest rcs0: SUCCESS (1.551s)
[462.641195] Starting dynamic subtest: bcs0
[464.183559] Dynamic subtest bcs0: SUCCESS (1.555s)
[464.196396] Starting dynamic subtest: vcs0
[465.739568] Dynamic subtest vcs0: SUCCESS (1.556s)
[465.752386] Starting dynamic subtest: vcs1
[467.294535] Dynamic subtest vcs1: SUCCESS (1.555s)
[467.307434] Starting dynamic subtest: vecs0
[468.850503] Dynamic subtest vecs0: SUCCESS (1.556s)
[468.863370] Starting dynamic subtest: vecs1
[470.403548] Dynamic subtest vecs1: SUCCESS (1.553s)
[470.416786] Starting dynamic subtest: ccs0
[471.955637] Dynamic subtest ccs0: SUCCESS (1.552s)
[471.956582] Subtest busy-accuracy-50: SUCCESS (10.885s)
[472.164930] [095/129] (585s left) gem_caching (writes)
[472.249912] Starting subtest: writes
[475.926890] Subtest writes: SUCCESS (3.679s)
[476.092478] [096/129] (581s left) gem_softpin (evict-snoop-interruptible)
[476.180298] Starting subtest: evict-snoop-interruptible
[476.182183] Subtest evict-snoop-interruptible: SKIP (0.000s)
[476.285250] [097/129] (581s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[476.507273] Starting subtest: fbcpsr-rgb101010-draw-blt
[476.509239] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[476.666081] [098/129] (581s left) gem_workarounds (basic-read-context)
[476.758888] Starting subtest: basic-read-context
[476.790571] Subtest basic-read-context: SUCCESS (0.032s)
[476.938733] [099/129] (580s left) gem_mmap_offset (mmap-unmap)
[477.013554] Starting subtest: mmap-unmap
[477.014478] Starting dynamic subtest: lmem0
[477.966526] Dynamic subtest lmem0: SUCCESS (0.953s)
[477.982151] Starting dynamic subtest: smem0
[479.321084] Dynamic subtest smem0: SUCCESS (1.354s)
[479.322135] Subtest mmap-unmap: SUCCESS (2.310s)
[479.499200] [100/129] (578s left) kms_flip (modeset-vs-vblank-race-interruptible)
[479.771500] Starting subtest: modeset-vs-vblank-race-interruptible
[479.778274] Starting dynamic subtest: A-DP4
[482.964713] Dynamic subtest A-DP4: SUCCESS (3.187s)
[483.012367] Starting dynamic subtest: B-DP4
[486.197647] Dynamic subtest B-DP4: SUCCESS (3.229s)
[486.243131] Starting dynamic subtest: C-DP4
[489.259868] Dynamic subtest C-DP4: SUCCESS (3.058s)
[489.303751] Starting dynamic subtest: D-DP4
[492.313064] Dynamic subtest D-DP4: SUCCESS (3.049s)
[492.319693] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.552s)
[492.666551] [101/129] (565s left) kms_flip (blocking-absolute-wf_vblank)
[492.881575] Starting subtest: blocking-absolute-wf_vblank
[492.887300] Starting dynamic subtest: A-DP4
[500.896668] Dynamic subtest A-DP4: SUCCESS (8.013s)
[500.912645] Starting dynamic subtest: B-DP4
[508.805881] Dynamic subtest B-DP4: SUCCESS (7.912s)
[508.820898] Starting dynamic subtest: C-DP4
[516.722770] Dynamic subtest C-DP4: SUCCESS (7.920s)
[516.737452] Starting dynamic subtest: D-DP4
[524.634880] Dynamic subtest D-DP4: SUCCESS (7.915s)
[524.637311] Subtest blocking-absolute-wf_vblank: SUCCESS (31.772s)
[524.963313] [102/129] (533s left) gem_exec_balancer (parallel-keep-submit-fence)
[525.296593] Starting subtest: parallel-keep-submit-fence
[527.267501] Subtest parallel-keep-submit-fence: SUCCESS (1.972s)
[527.388485] [103/129] (530s left) gem_ctx_persistence (idempotent)
[527.473044] Starting subtest: idempotent
[527.474229] Subtest idempotent: SUCCESS (0.000s)
[527.605895] [104/129] (530s left) kms_setmode (basic-clone-single-crtc)
[527.684542] Starting subtest: basic-clone-single-crtc
[527.687338] Subtest basic-clone-single-crtc: SKIP (0.000s)
[527.845268] [105/129] (530s left) syncobj_timeline (invalid-wait-illegal-handle)
[527.928075] Starting subtest: invalid-wait-illegal-handle
[527.929043] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[528.063498] [106/129] (530s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[528.286959] Starting subtest: psr-rgb565-draw-blt
[528.288893] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[528.450832] [107/129] (529s left) kms_chamelium_color (degamma)
[528.658372] Subtest degamma: SKIP (0.000s)
[528.712554] [108/129] (529s left) api_intel_bb (object-noreloc-purge-cache-simple)
[528.790553] Starting subtest: object-noreloc-purge-cache-simple
[528.817929] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.028s)
[529.027238] [109/129] (529s left) perf_pmu (multi-client)
[529.099528] Starting subtest: multi-client
[529.100482] Starting dynamic subtest: rcs0
[530.199726] Dynamic subtest rcs0: SUCCESS (1.099s)
[530.216519] Starting dynamic subtest: bcs0
[531.256251] Dynamic subtest bcs0: SUCCESS (1.049s)
[531.272782] Starting dynamic subtest: vcs0
[532.310233] Dynamic subtest vcs0: SUCCESS (1.046s)
[532.326677] Starting dynamic subtest: vcs1
[533.364009] Dynamic subtest vcs1: SUCCESS (1.046s)
[533.380688] Starting dynamic subtest: vecs0
[534.418246] Dynamic subtest vecs0: SUCCESS (1.047s)
[534.435476] Starting dynamic subtest: vecs1
[535.473822] Dynamic subtest vecs1: SUCCESS (1.048s)
[535.490274] Starting dynamic subtest: ccs0
[536.527657] Dynamic subtest ccs0: SUCCESS (1.047s)
[536.530101] Subtest multi-client: SUCCESS (7.414s)
[536.691818] [110/129] (521s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[536.898799] Starting subtest: flip-vs-cursor-crc-legacy
[537.442620] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.542s)
[537.721685] [111/129] (520s left) perf (disabled-read-error)
[538.061736] Starting subtest: disabled-read-error
[538.094157] Subtest disabled-read-error: SUCCESS (0.032s)
[538.160620] [112/129] (520s left) kms_feature_discovery (psr2)
[538.371341] Starting subtest: psr2
[538.373138] Subtest psr2: SKIP (0.000s)
[538.461037] [113/129] (520s left) kms_psr (fbc-psr-sprite-plane-onoff)
[538.667392] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[538.722547] [114/129] (520s left) perf (invalid-oa-format-id)
[538.935756] Starting subtest: invalid-oa-format-id
[538.952700] Subtest invalid-oa-format-id: SUCCESS (0.017s)
[539.010666] [115/129] (519s left) kms_cursor_crc (cursor-offscreen-64x64)
[539.314697] Starting subtest: cursor-offscreen-64x64
[539.320270] Starting dynamic subtest: pipe-A-DP-4
[541.834728] Dynamic subtest pipe-A-DP-4: SUCCESS (2.510s)
[541.887229] Starting dynamic subtest: pipe-D-DP-4
[544.304588] Dynamic subtest pipe-D-DP-4: SUCCESS (2.426s)
[544.305625] Subtest cursor-offscreen-64x64: SUCCESS (4.982s)
[544.764735] [116/129] (514s left) kms_atomic (atomic-invalid-params)
[544.977936] Starting subtest: atomic-invalid-params
[544.978922] Starting dynamic subtest: pipe-A-DP-4
[545.538174] Dynamic subtest pipe-A-DP-4: SUCCESS (0.558s)
[545.539140] Subtest atomic-invalid-params: SUCCESS (0.561s)
[545.820820] [117/129] (513s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[546.054748] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[546.055672] Starting dynamic subtest: pipe-A-DP-4
[546.064162] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[546.077123] Starting dynamic subtest: pipe-B-DP-4
[546.085616] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[546.098351] Starting dynamic subtest: pipe-C-DP-4
[546.106676] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[546.119595] Starting dynamic subtest: pipe-D-DP-4
[546.129758] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[546.131639] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[546.536557] [118/129] (512s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[546.759779] Starting subtest: x-tiled-8bpp-rotate-180
[548.278632] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.516s)
[548.481542] [119/129] (510s left) kms_color (legacy-gamma)
[548.690039] Starting subtest: legacy-gamma
[548.691015] Starting dynamic subtest: pipe-A-DP-4
[549.355565] Dynamic subtest pipe-A-DP-4: SUCCESS (0.664s)
[549.379260] Starting dynamic subtest: pipe-B-DP-4
[549.939685] Dynamic subtest pipe-B-DP-4: SUCCESS (0.582s)
[549.962062] Starting dynamic subtest: pipe-C-DP-4
[550.523101] Dynamic subtest pipe-C-DP-4: SUCCESS (0.582s)
[550.543646] Starting dynamic subtest: pipe-D-DP-4
[551.130154] Dynamic subtest pipe-D-DP-4: SUCCESS (0.604s)
[551.131303] Subtest legacy-gamma: SUCCESS (2.438s)
[551.406656] [120/129] (507s left) kms_cursor_edge_walk (64x64-top-edge)
[551.613851] Starting subtest: 64x64-top-edge
[551.614719] Starting dynamic subtest: pipe-A-DP-4
[555.043668] Dynamic subtest pipe-A-DP-4: SUCCESS (3.427s)
[555.067512] Starting dynamic subtest: pipe-D-DP-4
[558.376179] Dynamic subtest pipe-D-DP-4: SUCCESS (3.328s)
[558.377155] Subtest 64x64-top-edge: SUCCESS (6.760s)
[558.633595] [121/129] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[558.848584] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[558.850450] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[558.961024] [122/129] (500s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[559.174156] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[559.231872] [123/129] (500s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[559.442736] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[559.444488] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[559.575396] [124/129] (500s left) kms_psr (fbc-psr-dpms)
[559.786389] Subtest fbc-psr-dpms: SKIP (0.000s)
[559.848712] [125/129] (499s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[560.065761] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[560.079730] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s)
[560.171322] [126/129] (499s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[560.387269] Starting subtest: flip-vs-cursor-toggle
[571.309069] Subtest flip-vs-cursor-toggle: SUCCESS (10.919s)
[571.570633] [127/129] (488s left) kms_pm_rpm (pc8-residency)
[573.920344] Starting subtest: pc8-residency
[573.922600] Subtest pc8-residency: SKIP (0.000s)
[574.197725] [128/129] (485s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[574.279092] Starting subtest: invalid-bsd2-flag-on-blt
[574.280045] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[574.410514] [129/129] (485s left) gem_ctx_param (vm)
[574.485936] Starting subtest: vm
[574.560213] Subtest vm: SUCCESS (0.074s)
[574.784930] Closing watchdogs
Done.