[63.561389] Initializing watchdogs
[63.561435]   /dev/watchdog0
[63.575413] [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]
[63.579759] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.582092] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.585251] [001/133] (960s left) sw_sync (sync_multi_producer_single_consumer)
[63.635079] Starting subtest: sync_multi_producer_single_consumer
[64.711264] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[64.782164] [002/133] (959s left) gem_exec_fence (nb-await)
[64.956141] Starting subtest: nb-await
[64.958714] Starting dynamic subtest: rcs0
[65.037593] Dynamic subtest rcs0: SUCCESS (0.081s)
[65.046960] Starting dynamic subtest: bcs0
[65.103996] Dynamic subtest bcs0: SUCCESS (0.065s)
[65.114648] Starting dynamic subtest: vcs0
[65.165401] Dynamic subtest vcs0: SUCCESS (0.060s)
[65.174808] Starting dynamic subtest: vcs1
[65.224547] Dynamic subtest vcs1: SUCCESS (0.058s)
[65.233377] Starting dynamic subtest: vecs0
[65.285367] Dynamic subtest vecs0: SUCCESS (0.060s)
[65.295046] Starting dynamic subtest: ccs0
[65.347056] Dynamic subtest ccs0: SUCCESS (0.061s)
[65.349943] Subtest nb-await: SUCCESS (0.391s)
[67.021966] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[67.026989] [003/133] (957s left) kms_flip (flip-vs-modeset-vs-hang)
[67.266048] Starting subtest: flip-vs-modeset-vs-hang
[67.268979] Starting dynamic subtest: A-eDP1
[118.389609] Dynamic subtest A-eDP1: SUCCESS (51.110s)
[118.401640] Starting dynamic subtest: D-eDP1
[168.372984] Dynamic subtest D-eDP1: SUCCESS (49.987s)
[168.375600] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.101s)
[168.723830] [004/133] (855s left) kms_atomic (plane-primary-legacy)
[168.814211] Starting subtest: plane-primary-legacy
[168.816236] Starting dynamic subtest: pipe-A-eDP-1
[169.274638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[169.277063] Subtest plane-primary-legacy: SUCCESS (0.462s)
[170.087579] [005/133] (854s left) kms_pm_dc (dc6-dpms)
[171.180667] Starting subtest: dc6-dpms
[173.248573] Subtest dc6-dpms: SUCCESS (2.068s)
[173.321127] [006/133] (851s left) kms_cursor_crc (cursor-onscreen-128x128)
[173.515949] Starting subtest: cursor-onscreen-128x128
[173.518413] Starting dynamic subtest: pipe-A-eDP-1
[175.629251] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[175.657076] Starting dynamic subtest: pipe-D-eDP-1
[178.411084] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.760s)
[178.413267] Subtest cursor-onscreen-128x128: SUCCESS (4.896s)
[179.277953] [007/133] (845s left) gem_pxp (create-regular-context-2)
[179.409078] Starting subtest: create-regular-context-2
[179.411826] Subtest create-regular-context-2: SUCCESS (0.002s)
[179.515530] [008/133] (844s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[179.579472] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[179.581755] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[179.687937] [009/133] (844s left) gem_ctx_param (invalid-get-engines)
[179.735669] Starting subtest: invalid-get-engines
[179.738085] Subtest invalid-get-engines: SUCCESS (0.001s)
[179.847422] [010/133] (844s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[179.944024] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[179.948346] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[180.015397] [011/133] (844s left) kms_big_fb (x-tiled-addfb-size-overflow)
[180.118217] Starting subtest: x-tiled-addfb-size-overflow
[180.120148] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[180.216188] [012/133] (844s left) gem_eio (in-flight-internal-10ms)
[180.433365] Starting subtest: in-flight-internal-10ms
[181.981889] Subtest in-flight-internal-10ms: SUCCESS (1.550s)
[182.128624] [013/133] (842s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[182.229198] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[182.231468] Starting dynamic subtest: A-eDP1
[191.121112] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[191.129451] Starting dynamic subtest: B-eDP1
[200.059085] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[200.069860] Starting dynamic subtest: C-eDP1
[209.022740] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[209.032118] Starting dynamic subtest: D-eDP1
[217.958383] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[217.960743] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.687s)
[219.146344] [014/133] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[219.241644] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[226.664276] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.426s)
[226.786628] [015/133] (797s left) kms_fb_coherency (memset-crc)
[226.882150] Starting subtest: memset-crc
[226.884380] Starting dynamic subtest: mmap-offset-wc
[227.255626] Dynamic subtest mmap-offset-wc: SUCCESS (0.375s)
[227.557646] Starting dynamic subtest: mmap-offset-uc
[233.624791] Dynamic subtest mmap-offset-uc: SUCCESS (6.073s)
[233.922891] Subtest memset-crc: SUCCESS (7.042s)
[234.720882] [016/133] (790s left) gem_exec_params (rsvd2-dirt)
[234.780067] Starting subtest: rsvd2-dirt
[234.784112] Subtest rsvd2-dirt: SKIP (0.000s)
[234.877144] [017/133] (789s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[234.976264] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[241.639212] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.667s)
[241.763627] [018/133] (783s left) gem_exec_reloc (basic-range)
[241.829496] Subtest basic-range: SKIP (0.000s)
[241.902610] [019/133] (782s left) kms_psr (fbc-psr-sprite-plane-move)
[241.996400] Starting subtest: fbc-psr-sprite-plane-move
[241.998835] Starting dynamic subtest: eDP-1
[242.003525] Dynamic subtest eDP-1: SKIP (0.000s)
[242.007706] Subtest fbc-psr-sprite-plane-move: SKIP (0.002s)
[242.079073] [020/133] (782s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[242.272884] Starting subtest: cursor-rapid-movement-64x64
[242.278167] Starting dynamic subtest: pipe-A-eDP-1
[242.820483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[242.852412] Starting dynamic subtest: pipe-D-eDP-1
[244.055185] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[244.057547] Subtest cursor-rapid-movement-64x64: SUCCESS (1.782s)
[244.910056] [021/133] (780s left) kms_addfb_basic (basic)
[244.969243] Starting subtest: basic
[244.971490] Subtest basic: SUCCESS (0.000s)
[245.100973] [022/133] (779s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[245.196828] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[252.399967] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.207s)
[252.539696] [023/133] (772s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[252.595401] Subtest tiled-to-untiled: SKIP (0.000s)
[252.672743] [024/133] (772s left) gem_exec_balancer (bonded-false-hang)
[252.934302] Starting subtest: bonded-false-hang
[252.939310] Subtest bonded-false-hang: SKIP (0.000s)
[253.038949] [025/133] (772s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[253.141216] Starting subtest: pixel-format-y-tiled-ccs-modifier
[253.145604] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[253.222818] [026/133] (771s left) kms_atomic_interruptible (legacy-dpms)
[253.320917] Starting subtest: legacy-dpms
[253.323298] Starting dynamic subtest: pipe-A-eDP-1
[260.766412] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.444s)
[260.768565] Subtest legacy-dpms: SUCCESS (7.445s)
[261.609358] [027/133] (763s left) tools_test (tools_test)
[261.662794] Starting subtest: tools_test
[261.714930] Subtest tools_test: SUCCESS (0.068s)
[261.785761] [028/133] (763s left) i915_suspend (forcewake)
[261.837615] Starting subtest: forcewake
[293.856868] Subtest forcewake: SUCCESS (2.417s)
[293.927913] [029/133] (731s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[294.004728] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[294.009398] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[294.185799] [030/133] (731s left) gem_userptr_blits (create-destroy-sync)
[294.252314] Starting subtest: create-destroy-sync
[299.321380] Subtest create-destroy-sync: SUCCESS (5.012s)
[299.386328] [031/133] (725s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[299.489520] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[299.493587] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[299.589393] [032/133] (725s left) gem_exec_fence (syncobj-unused-fence)
[300.013992] Starting subtest: syncobj-unused-fence
[300.019811] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[301.556738] [033/133] (723s left) kms_addfb_basic (invalid-get-prop)
[301.608334] Starting subtest: invalid-get-prop
[301.610643] Subtest invalid-get-prop: SUCCESS (0.000s)
[301.743743] [034/133] (723s left) i915_hangman (hangcheck-unterminated)
[301.813349] Starting subtest: hangcheck-unterminated
[313.478130] Subtest hangcheck-unterminated: SUCCESS (11.661s)
[313.586631] [035/133] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[313.680193] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[313.684211] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[313.765151] [036/133] (711s left) kms_cursor_legacy (torture-move)
[313.887789] Starting subtest: torture-move
[313.890352] Starting dynamic subtest: pipe-A
[319.867906] Dynamic subtest pipe-A: SUCCESS (5.977s)
[319.897004] Starting dynamic subtest: pipe-B
[326.840581] Dynamic subtest pipe-B: SUCCESS (6.971s)
[326.851061] Starting dynamic subtest: pipe-C
[334.320493] Dynamic subtest pipe-C: SUCCESS (7.477s)
[334.333021] Starting dynamic subtest: pipe-D
[341.194746] Dynamic subtest pipe-D: SUCCESS (6.871s)
[341.207277] Starting dynamic subtest: all-pipes
[347.668421] Dynamic subtest all-pipes: SUCCESS (6.470s)
[347.671423] Subtest torture-move: SUCCESS (33.775s)
[347.828660] [037/133] (677s left) syncobj_timeline (wait-for-submit-snapshot)
[347.897959] Starting subtest: wait-for-submit-snapshot
[347.978477] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[348.056598] [038/133] (677s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[348.179594] Starting subtest: cursor-vs-flip-atomic
[377.832378] Subtest cursor-vs-flip-atomic: SUCCESS (29.648s)
[378.627979] [039/133] (647s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[378.735119] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[378.739314] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[378.830947] [040/133] (646s left) syncobj_timeline (invalid-signal-bad-pad)
[378.883873] Starting subtest: invalid-signal-bad-pad
[378.886057] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[378.970266] [041/133] (646s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[379.051065] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[379.053263] Starting dynamic subtest: pipe-A-eDP-1
[379.075754] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[379.087492] Starting dynamic subtest: pipe-B-eDP-1
[379.109325] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[379.120478] Starting dynamic subtest: pipe-C-eDP-1
[379.141474] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[379.152500] Starting dynamic subtest: pipe-D-eDP-1
[379.174863] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[379.179154] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[381.201428] [042/133] (644s left) kms_addfb_basic (small-bo)
[381.307296] Starting subtest: small-bo
[381.309520] Subtest small-bo: SUCCESS (0.000s)
[381.404406] [043/133] (644s left) gem_exec_schedule (smoketest-all)
[381.483314] Starting subtest: smoketest-all
[413.875554] Subtest smoketest-all: SUCCESS (32.339s)
[415.588011] [044/133] (610s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[415.696536] Starting subtest: psr-rgb101010-draw-mmap-cpu
[422.752211] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.059s)
[422.853033] [045/133] (603s left) kms_plane_alpha_blend (alpha-7efc)
[422.951032] Starting subtest: alpha-7efc
[423.227584] Starting dynamic subtest: pipe-A-eDP-1
[423.814946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[423.842315] Starting dynamic subtest: pipe-D-eDP-1
[425.124737] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[425.127270] Subtest alpha-7efc: SUCCESS (2.176s)
[426.000371] [046/133] (599s left) gem_mmap_offset (partial-mmap)
[426.063506] Starting subtest: partial-mmap
[426.065971] Starting dynamic subtest: smem0
[426.068313] Dynamic subtest smem0: SUCCESS (0.004s)
[426.070270] Subtest partial-mmap: SUCCESS (0.005s)
[426.178881] [047/133] (599s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[426.286051] Starting subtest: psr2-cursor-plane-move-continuous-sf
[426.288383] Starting dynamic subtest: pipe-A-eDP-1
[436.626691] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.344s)
[436.636685] Starting dynamic subtest: pipe-B-eDP-1
[447.671053] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.043s)
[447.673194] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.389s)
[448.471137] [048/133] (577s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[448.575613] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[448.579688] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[448.676963] [049/133] (577s left) syncobj_wait (single-wait-all-submitted)
[448.734541] Starting subtest: single-wait-all-submitted
[448.835539] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[448.915128] [050/133] (577s left) gem_exec_suspend (basic)
[448.987735] Starting subtest: basic
[448.990226] Starting dynamic subtest: smem
[450.472459] Dynamic subtest smem: SUCCESS (1.482s)
[450.475565] Subtest basic: SUCCESS (1.485s)
[450.669945] [051/133] (575s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[452.697502] Starting subtest: modeset-lpsp-stress-no-wait
[462.321821] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.626s)
[462.413398] [052/133] (563s left) kms_big_fb (linear-8bpp-rotate-180)
[462.510691] Starting subtest: linear-8bpp-rotate-180
[463.783031] Subtest linear-8bpp-rotate-180: SUCCESS (1.274s)
[463.927316] [053/133] (562s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[463.987236] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[464.106358] [054/133] (562s left) kms_vblank (ts-continuation-idle)
[464.202429] Starting subtest: ts-continuation-idle
[464.204174] Starting dynamic subtest: pipe-A-eDP-1
[464.627886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[464.642600] Starting dynamic subtest: pipe-D-eDP-1
[465.796813] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.167s)
[465.799045] Subtest ts-continuation-idle: SUCCESS (1.596s)
[466.633805] [055/133] (559s left) gem_exec_params (secure-non-root)
[466.699217] Starting subtest: secure-non-root
[466.703961] Subtest secure-non-root: SKIP (0.000s)
[466.796430] [056/133] (559s left) kms_flip (2x-modeset-vs-vblank-race)
[466.885415] Starting subtest: 2x-modeset-vs-vblank-race
[466.893477] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[466.972998] [057/133] (559s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[467.033554] Starting subtest: y-tiled-ccs-to-x-tiled
[467.038417] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[467.213200] [058/133] (559s left) kms_psr (pr-primary-mmap-cpu)
[467.309740] Starting subtest: pr-primary-mmap-cpu
[467.314059] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[467.381403] [059/133] (559s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[467.478174] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[467.482107] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[467.584572] [060/133] (558s left) gem_ctx_sseu (engines)
[467.657159] Subtest engines: SKIP (0.000s)
[467.713628] [061/133] (558s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[467.802451] Starting subtest: fbc-rgb565-draw-blt
[471.990851] Subtest fbc-rgb565-draw-blt: SUCCESS (4.194s)
[473.136811] [062/133] (553s left) kms_flip (flip-vs-expired-vblank)
[473.228557] Starting subtest: flip-vs-expired-vblank
[473.230963] Starting dynamic subtest: A-eDP1
[481.961792] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[481.973252] Starting dynamic subtest: B-eDP1
[490.596937] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[490.608609] Starting dynamic subtest: C-eDP1
[499.233954] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[499.244453] Starting dynamic subtest: D-eDP1
[507.812690] Dynamic subtest D-eDP1: SUCCESS (8.622s)
[507.815122] Subtest flip-vs-expired-vblank: SUCCESS (34.588s)
[509.004365] [063/133] (517s left) kms_chamelium_color (ctm-max)
[509.099938] Subtest ctm-max: SKIP (0.000s)
[509.147283] [064/133] (517s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[509.252477] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[509.256622] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[509.377611] [065/133] (517s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[509.476869] Starting subtest: 4-tiled-addfb-size-offset-overflow
[509.479227] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[509.572911] [066/133] (517s left) gem_eio (in-flight-contexts-10ms)
[509.804316] Starting subtest: in-flight-contexts-10ms
[523.507817] Subtest in-flight-contexts-10ms: SUCCESS (13.704s)
[523.665044] [067/133] (503s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[523.761759] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[530.340129] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.582s)
[530.477594] [068/133] (496s left) kms_lease (lease-invalid-crtc)
[530.579000] Starting subtest: lease-invalid-crtc
[530.581307] Starting dynamic subtest: pipe-A-eDP-1
[530.583585] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[530.593059] Starting dynamic subtest: pipe-B-eDP-1
[530.595400] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[530.604343] Starting dynamic subtest: pipe-C-eDP-1
[530.606661] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[530.614977] Starting dynamic subtest: pipe-D-eDP-1
[530.616881] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[530.618856] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[530.656041] [069/133] (496s left) kms_cursor_crc (cursor-sliding-64x64)
[530.830363] Starting subtest: cursor-sliding-64x64
[530.835510] Starting dynamic subtest: pipe-A-eDP-1
[534.052588] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.218s)
[534.080558] Starting dynamic subtest: pipe-D-eDP-1
[538.042702] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.968s)
[538.045161] Subtest cursor-sliding-64x64: SUCCESS (7.210s)
[538.877122] [070/133] (488s left) kms_selftest (drm_format)
[538.930961] Starting subtest: drm_format
[538.980873] Starting dynamic subtest: drm_test_format_block_width_invalid
[539.096089] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.115s)
[539.105868] Starting dynamic subtest: drm_test_format_block_width_one_plane
[539.198084] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.102s)
[539.208828] Starting dynamic subtest: drm_test_format_block_width_two_plane
[539.293591] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.092s)
[539.308402] Starting dynamic subtest: drm_test_format_block_width_three_plane
[539.384955] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.091s)
[539.395381] Starting dynamic subtest: drm_test_format_block_width_tiled
[539.491133] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.105s)
[539.501862] Starting dynamic subtest: drm_test_format_block_height_invalid
[539.596037] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.104s)
[539.606792] Starting dynamic subtest: drm_test_format_block_height_one_plane
[539.709136] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.112s)
[539.719893] Starting dynamic subtest: drm_test_format_block_height_two_plane
[539.805975] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.097s)
[539.816709] Starting dynamic subtest: drm_test_format_block_height_three_plane
[539.904658] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.096s)
[539.914974] Starting dynamic subtest: drm_test_format_block_height_tiled
[540.008156] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.103s)
[540.018752] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[540.095977] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.087s)
[540.106009] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[540.195580] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.099s)
[540.205665] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[540.290120] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.095s)
[540.300228] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[540.379391] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.088s)
[540.389392] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[540.478514] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.098s)
[540.492664] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[540.578332] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.099s)
[540.588391] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[540.668178] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.089s)
[540.676470] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[540.760527] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.093s)
[540.762474] Subtest drm_format: SUCCESS (1.832s)
[540.931182] [071/133] (486s left) kms_psr (psr-no-drrs)
[541.018285] Starting subtest: psr-no-drrs
[541.020189] Starting dynamic subtest: eDP-1
[542.651348] Dynamic subtest eDP-1: SUCCESS (1.633s)
[542.653527] Subtest psr-no-drrs: SUCCESS (1.634s)
[543.523660] [072/133] (483s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[543.913220] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[544.743785] [073/133] (482s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[544.845460] Starting subtest: addfb25-y-tiled-legacy
[544.847440] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[544.953608] [074/133] (482s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[545.052122] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[545.054509] Starting dynamic subtest: pipe-A-eDP-1
[545.083304] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[545.094851] Starting dynamic subtest: pipe-B-eDP-1
[545.115724] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[545.125146] Starting dynamic subtest: pipe-C-eDP-1
[545.146875] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[545.155883] Starting dynamic subtest: pipe-D-eDP-1
[545.178155] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[545.182221] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[547.322217] [075/133] (479s left) perf_pmu (rc6-suspend)
[547.366181] Starting subtest: rc6-suspend
[569.978594] Subtest rc6-suspend: SUCCESS (7.544s)
[570.996764] [076/133] (456s left) gem_flink_basic (bad-open)
[571.068847] Starting subtest: bad-open
[571.071100] Subtest bad-open: SUCCESS (0.000s)
[571.155345] [077/133] (456s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[571.259799] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[571.263978] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[571.340574] [078/133] (455s left) kms_getfb (getfb2-handle-protection)
[571.428780] Starting subtest: getfb2-handle-protection
[571.450090] Subtest getfb2-handle-protection: SUCCESS (0.022s)
[571.556563] [079/133] (455s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[571.645860] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[571.649821] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[571.747545] [080/133] (455s left) kms_psr (psr-basic)
[571.837583] Starting subtest: psr-basic
[571.839859] Starting dynamic subtest: eDP-1
[573.465002] Dynamic subtest eDP-1: SUCCESS (1.624s)
[573.467541] Subtest psr-basic: SUCCESS (1.624s)
[574.343535] [081/133] (453s left) gem_mmap_wc (write-gtt-read-wc)
[574.395527] Subtest write-gtt-read-wc: SKIP (0.000s)
[574.464409] [082/133] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[574.569994] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[574.575075] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[574.666529] [083/133] (452s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[575.040639] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[575.848691] [084/133] (451s left) gem_exec_schedule (in-order)
[575.917418] Starting subtest: in-order
[575.919938] Starting dynamic subtest: rcs0
[576.018063] Dynamic subtest rcs0: SUCCESS (0.108s)
[576.030798] Starting dynamic subtest: vcs0
[576.109680] Dynamic subtest vcs0: SUCCESS (0.090s)
[576.122231] Starting dynamic subtest: vcs1
[576.238564] Dynamic subtest vcs1: SUCCESS (0.128s)
[576.250992] Starting dynamic subtest: vecs0
[576.319875] Dynamic subtest vecs0: SUCCESS (0.078s)
[576.332495] Starting dynamic subtest: ccs0
[576.412562] Dynamic subtest ccs0: SUCCESS (0.092s)
[576.415461] Subtest in-order: SUCCESS (0.503s)
[577.620986] [085/133] (449s left) api_intel_allocator (reloc-allocator)
[577.663176] Starting subtest: reloc-allocator
[577.665746] Starting dynamic subtest: basic
[577.668401] Dynamic subtest basic: SUCCESS (0.003s)
[577.680021] Starting dynamic subtest: parallel-one
[577.682363] Dynamic subtest parallel-one: SUCCESS (0.009s)
[577.691681] Starting dynamic subtest: print
[577.693940] Dynamic subtest print: SUCCESS (0.000s)
[577.702925] Starting dynamic subtest: reuse
[577.704764] Dynamic subtest reuse: SUCCESS (0.000s)
[577.713751] Starting dynamic subtest: fork-reopen-allocator
[577.715732] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[577.717915] Subtest reloc-allocator: SUCCESS (0.030s)
[577.812715] [086/133] (449s left) dmabuf_sync_file (export-wait-after-attach)
[577.868302] Starting subtest: export-wait-after-attach
[577.870740] Subtest export-wait-after-attach: SUCCESS (0.000s)
[577.930101] [087/133] (449s left) perf_pmu (busy-accuracy-2)
[577.971681] Starting subtest: busy-accuracy-2
[577.974220] Starting dynamic subtest: rcs0
[581.076874] Dynamic subtest rcs0: SUCCESS (3.051s)
[581.087024] Starting dynamic subtest: bcs0
[584.137003] Dynamic subtest bcs0: SUCCESS (3.059s)
[584.146770] Starting dynamic subtest: vcs0
[587.188843] Dynamic subtest vcs0: SUCCESS (3.047s)
[587.198780] Starting dynamic subtest: vcs1
[590.241027] Dynamic subtest vcs1: SUCCESS (3.048s)
[590.252458] Starting dynamic subtest: vecs0
[593.289058] Dynamic subtest vecs0: SUCCESS (3.045s)
[593.301060] Starting dynamic subtest: ccs0
[596.356464] Dynamic subtest ccs0: SUCCESS (3.063s)
[596.358882] Subtest busy-accuracy-2: SUCCESS (18.329s)
[596.421058] [088/133] (431s left) kms_flip (2x-flip-vs-suspend)
[596.532548] Starting subtest: 2x-flip-vs-suspend
[596.539678] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[596.639430] [089/133] (431s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[596.743151] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[596.745776] Starting dynamic subtest: pipe-A-eDP-1
[596.767820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[596.781886] Starting dynamic subtest: pipe-B-eDP-1
[596.805889] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[596.816310] Starting dynamic subtest: pipe-C-eDP-1
[596.840414] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[596.853083] Starting dynamic subtest: pipe-D-eDP-1
[596.877320] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[596.879761] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.010s)
[599.025261] [090/133] (428s left) gem_exec_fence (basic-busy)
[599.203966] Starting subtest: basic-busy
[599.206923] Starting dynamic subtest: rcs0
[599.259473] Dynamic subtest rcs0: SUCCESS (0.055s)
[599.272539] Starting dynamic subtest: bcs0
[599.314090] Dynamic subtest bcs0: SUCCESS (0.052s)
[599.327701] Starting dynamic subtest: vcs0
[599.367857] Dynamic subtest vcs0: SUCCESS (0.051s)
[599.380172] Starting dynamic subtest: vcs1
[599.421568] Dynamic subtest vcs1: SUCCESS (0.051s)
[599.433205] Starting dynamic subtest: vecs0
[599.478541] Dynamic subtest vecs0: SUCCESS (0.055s)
[599.493690] Starting dynamic subtest: ccs0
[599.536065] Dynamic subtest ccs0: SUCCESS (0.055s)
[599.539159] Subtest basic-busy: SUCCESS (0.334s)
[601.591665] [091/133] (426s left) gen9_exec_parse (batch-invalid-length)
[601.669750] Subtest batch-invalid-length: SKIP (0.000s)
[601.732397] [092/133] (426s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[601.798020] Starting subtest: framebuffer-vs-set-tiling
[601.803307] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[601.937972] [093/133] (425s left) fbdev (write)
[601.974907] Starting subtest: write
[602.330693] Subtest write: SUCCESS (0.356s)
[602.394665] [094/133] (425s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[602.478795] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[602.481112] Starting dynamic subtest: pipe-A-default-mode
[603.607763] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[603.612899] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.130s)
[603.768540] [095/133] (424s left) gem_ctx_persistence (userptr)
[603.825974] Starting subtest: userptr
[603.990674] Subtest userptr: SUCCESS (0.164s)
[604.082554] [096/133] (423s left) syncobj_timeline (multi-wait-submitted-signaled)
[604.148545] Starting subtest: multi-wait-submitted-signaled
[604.151087] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[604.266570] [097/133] (423s left) i915_drm_fdinfo (busy)
[604.304922] Starting subtest: busy
[604.307564] Starting dynamic subtest: rcs0
[604.322008] Dynamic subtest rcs0: SKIP (0.018s)
[604.332074] Starting dynamic subtest: bcs0
[604.340758] Dynamic subtest bcs0: SKIP (0.016s)
[604.351035] Starting dynamic subtest: vcs0
[604.356902] Dynamic subtest vcs0: SKIP (0.000s)
[604.367306] Starting dynamic subtest: vcs1
[604.372900] Dynamic subtest vcs1: SKIP (0.000s)
[604.382452] Starting dynamic subtest: vecs0
[604.387094] Dynamic subtest vecs0: SKIP (0.000s)
[604.396096] Starting dynamic subtest: ccs0
[604.401076] Dynamic subtest ccs0: SKIP (0.000s)
[604.406021] Subtest busy: SKIP (0.038s)
[604.444942] [098/133] (423s left) gem_eio (suspend)
[604.728808] Starting subtest: suspend
[616.977148] Subtest suspend: SUCCESS (12.252s)
[617.138658] [099/133] (411s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[617.231149] Starting subtest: primary-y-tiled-reflect-x-90
[617.236015] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[617.304176] [100/133] (410s left) gem_softpin (invalid)
[617.356736] Starting subtest: invalid
[617.361949] Subtest invalid: SUCCESS (0.005s)
[617.474051] [101/133] (410s left) perf_pmu (rc6)
[617.518953] Starting subtest: rc6
[617.521972] Starting dynamic subtest: gt0
[623.931173] Dynamic subtest gt0: SUCCESS (6.361s)
[623.942186] Starting dynamic subtest: runtime-pm-gt0
[631.658253] Dynamic subtest runtime-pm-gt0: SUCCESS (7.776s)
[631.671370] Starting dynamic subtest: runtime-pm-long-gt0
[644.165757] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.503s)
[644.179491] Starting dynamic subtest: other-idle-gt0
[650.565318] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[650.579068] Starting dynamic subtest: gt1
[656.850405] Dynamic subtest gt1: SUCCESS (6.339s)
[656.862174] Starting dynamic subtest: runtime-pm-gt1
[664.360291] Dynamic subtest runtime-pm-gt1: SUCCESS (7.505s)
[664.372800] Starting dynamic subtest: runtime-pm-long-gt1
[676.800011] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.436s)
[676.813457] Starting dynamic subtest: other-idle-gt1
[683.200442] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[683.203191] Subtest rc6: SUCCESS (65.621s)
[684.425029] [102/133] (343s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[684.527809] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[684.531875] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[684.588137] [103/133] (343s left) gem_tiled_fence_blits (basic)
[684.653983] Subtest basic: SKIP (0.000s)
[684.731839] [104/133] (343s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[684.828862] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[684.832901] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[684.876816] [105/133] (343s left) gem_exec_schedule (u-semaphore-codependency)
[684.949348] Starting subtest: u-semaphore-codependency
[684.958498] Subtest u-semaphore-codependency: SUCCESS (0.015s)
[685.275382] [106/133] (343s left) gem_ctx_engines (execute-oneforall)
[685.339802] Starting subtest: execute-oneforall
[686.084796] Subtest execute-oneforall: SUCCESS (0.744s)
[687.628069] [107/133] (340s left) kms_color (ctm-red-to-blue)
[687.737011] Starting subtest: ctm-red-to-blue
[687.739501] Starting dynamic subtest: pipe-A-eDP-1
[688.459649] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[688.472099] Starting dynamic subtest: pipe-B-eDP-1
[689.912950] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.453s)
[689.924200] Starting dynamic subtest: pipe-C-eDP-1
[691.302324] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[691.312205] Starting dynamic subtest: pipe-D-eDP-1
[692.646930] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[692.649749] Subtest ctm-red-to-blue: SUCCESS (4.912s)
[693.424324] [108/133] (335s left) core_getclient (basic)
[693.474445] Starting subtest: basic
[693.476962] Subtest basic: SUCCESS (0.000s)
[693.546572] [109/133] (335s left) kms_psr (fbc-pr-primary-page-flip)
[693.636111] Starting subtest: fbc-pr-primary-page-flip
[693.641803] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[693.687178] [110/133] (334s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[693.771631] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[693.773942] Starting dynamic subtest: pipe-A-eDP-1
[693.796345] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[693.806635] Starting dynamic subtest: pipe-B-eDP-1
[693.831612] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[693.840661] Starting dynamic subtest: pipe-C-eDP-1
[693.865099] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[693.874202] Starting dynamic subtest: pipe-D-eDP-1
[693.899983] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[693.905188] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[696.002302] [111/133] (332s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[696.064335] Starting subtest: etime-multi-wait-for-submit-submitted
[696.169078] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[696.223348] [112/133] (332s left) kms_plane_lowres (tiling-x)
[696.315173] Starting subtest: tiling-x
[696.317744] Starting dynamic subtest: pipe-A-eDP-1
[696.322523] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[696.609684] Starting dynamic subtest: pipe-B-eDP-1
[696.614650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[696.624157] Starting dynamic subtest: pipe-C-eDP-1
[696.629388] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[696.639037] Starting dynamic subtest: pipe-D-eDP-1
[696.644040] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[696.648994] Subtest tiling-x: SKIP (0.292s)
[697.433967] [113/133] (331s left) kms_force_connector_basic (force-edid)
[697.512046] Starting subtest: force-edid
[697.877180] Subtest force-edid: SUCCESS (0.365s)
[697.990829] [114/133] (330s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[698.104857] Starting subtest: cursorA-vs-flipA-atomic-transitions
[709.277433] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.170s)
[710.064372] [115/133] (318s left) kms_invalid_mode (clock-too-high)
[710.158284] Starting subtest: clock-too-high
[710.160846] Starting dynamic subtest: pipe-A-eDP-1
[710.166000] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[710.175687] Starting dynamic subtest: pipe-B-eDP-1
[710.180198] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[710.190048] Starting dynamic subtest: pipe-C-eDP-1
[710.194876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[710.204034] Starting dynamic subtest: pipe-D-eDP-1
[710.208878] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[710.213372] Subtest clock-too-high: SKIP (0.008s)
[710.252245] [116/133] (318s left) syncobj_timeline (single-wait-for-submit-signaled)
[710.307531] Starting subtest: single-wait-for-submit-signaled
[710.309904] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[710.378694] [117/133] (318s left) gem_exec_whisper (basic-contexts-forked-all)
[710.433059] Starting subtest: basic-contexts-forked-all
[734.616696] Subtest basic-contexts-forked-all: SUCCESS (24.122s)
[734.725638] [118/133] (294s left) gem_media_vme
[734.852570] [119/133] (294s left) prime_busy (hang)
[734.912478] Starting subtest: hang
[734.915055] Starting dynamic subtest: rcs0
[761.057207] Dynamic subtest rcs0: SUCCESS (26.126s)
[761.067370] Starting dynamic subtest: bcs0
[768.203990] Dynamic subtest bcs0: SUCCESS (7.153s)
[768.214021] Starting dynamic subtest: vcs0
[775.243861] Dynamic subtest vcs0: SUCCESS (7.037s)
[775.253672] Starting dynamic subtest: vcs1
[782.212942] Dynamic subtest vcs1: SUCCESS (6.970s)
[782.223328] Starting dynamic subtest: vecs0
[789.202353] Dynamic subtest vecs0: SUCCESS (6.972s)
[789.214995] Starting dynamic subtest: ccs0
[803.094774] Dynamic subtest ccs0: SUCCESS (13.903s)
[803.098084] Subtest hang: SUCCESS (68.170s)
[803.212700] [120/133] (225s left) gem_spin_batch (engines)
[803.269405] Starting subtest: engines
[803.272505] Starting dynamic subtest: rcs0
[806.523734] Dynamic subtest rcs0: SUCCESS (3.237s)
[806.539089] Starting dynamic subtest: bcs0
[809.802462] Dynamic subtest bcs0: SUCCESS (3.236s)
[809.815476] Starting dynamic subtest: vcs0
[813.044473] Dynamic subtest vcs0: SUCCESS (3.236s)
[813.057708] Starting dynamic subtest: vcs1
[816.278499] Dynamic subtest vcs1: SUCCESS (3.230s)
[816.291984] Starting dynamic subtest: vecs0
[819.517167] Dynamic subtest vecs0: SUCCESS (3.235s)
[819.530103] Starting dynamic subtest: ccs0
[822.753816] Dynamic subtest ccs0: SUCCESS (3.235s)
[822.756671] Subtest engines: SUCCESS (19.428s)
[822.915474] [121/133] (206s left) kms_concurrent (multi-plane-atomic-lowres)
[823.007963] Starting subtest: multi-plane-atomic-lowres
[823.010564] Starting dynamic subtest: pipe-A-eDP-1
[823.498756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.488s)
[823.509415] Starting dynamic subtest: pipe-B-eDP-1
[824.698008] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s)
[824.709170] Starting dynamic subtest: pipe-C-eDP-1
[825.984989] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.284s)
[825.995944] Starting dynamic subtest: pipe-D-eDP-1
[827.184240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.198s)
[827.187206] Subtest multi-plane-atomic-lowres: SUCCESS (4.176s)
[827.969536] [122/133] (201s left) syncobj_eventfd (invalid-illegal-eventfd)
[828.026091] Starting subtest: invalid-illegal-eventfd
[828.028998] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[828.089896] [123/133] (201s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[828.144853] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[828.147981] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[828.221096] [124/133] (201s left) i915_pm_rpm (gem-execbuf)
[829.757426] Starting subtest: gem-execbuf
[829.760020] Starting dynamic subtest: smem0
[831.533656] Dynamic subtest smem0: SUCCESS (1.779s)
[831.536107] Subtest gem-execbuf: SUCCESS (1.781s)
[831.598507] [125/133] (197s left) syncobj_wait (wait-any-interrupted)
[831.655000] Starting subtest: wait-any-interrupted
[831.755150] Subtest wait-any-interrupted: SUCCESS (0.101s)
[831.810483] [126/133] (197s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[831.913426] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[831.916009] Starting dynamic subtest: pipe-A-eDP-1
[848.421608] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.506s)
[848.433427] Starting dynamic subtest: pipe-B-eDP-1
[865.646982] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.219s)
[865.649729] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.729s)
[866.478762] [127/133] (162s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[866.579198] Starting subtest: verify-pxp-execution-after-suspend-resume
[873.641540] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.063s)
[873.752322] [128/133] (155s left) gem_lmem_swapping (parallel-random-engines)
[873.802660] Subtest parallel-random-engines: SKIP (0.000s)
[873.850331] [129/133] (155s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[873.946388] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[873.948627] Starting dynamic subtest: pipe-A-eDP-1
[873.972133] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[873.983891] Starting dynamic subtest: pipe-B-eDP-1
[874.008758] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[874.018421] Starting dynamic subtest: pipe-C-eDP-1
[874.043773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[874.053953] Starting dynamic subtest: pipe-D-eDP-1
[874.079145] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[874.084205] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[876.176850] [130/133] (153s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[876.282571] Starting subtest: y-tiled-16bpp-rotate-90
[876.288055] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[876.358531] [131/133] (153s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[876.461010] Starting subtest: fbc-rgb101010-draw-render
[881.054698] Subtest fbc-rgb101010-draw-render: SUCCESS (4.598s)
[882.171672] [132/133] (147s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[882.268755] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[882.273755] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[882.344697] [133/133] (147s left) kms_plane_scaling (planes-upscale-20x20)
[882.439614] Starting subtest: planes-upscale-20x20
[882.442103] Starting dynamic subtest: pipe-A
[882.499144] Dynamic subtest pipe-A: SUCCESS (0.062s)
[882.510965] Starting dynamic subtest: pipe-B
[883.675830] Dynamic subtest pipe-B: SUCCESS (1.176s)
[883.687185] Starting dynamic subtest: pipe-C
[884.764178] Dynamic subtest pipe-C: SUCCESS (1.087s)
[884.780641] Starting dynamic subtest: pipe-D
[885.850775] Dynamic subtest pipe-D: SUCCESS (1.084s)
[885.853172] Subtest planes-upscale-20x20: SUCCESS (3.415s)
[886.968465] Closing watchdogs
results: parsing output: 0/ for test: sw_sync
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_atomic
results: parsing output: 4/ for test: kms_pm_dc
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_fb_coherency
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_set_tiling_vs_blt
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: kms_atomic_interruptible
results: parsing output: 26/ for test: tools_test
results: parsing output: 27/ for test: i915_suspend
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: gem_mmap_offset
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: gem_exec_suspend
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_sseu
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_chamelium_color
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_lease
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_selftest
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: gem_flink_basic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_getfb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_mmap_wc
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_chamelium_edid
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: dmabuf_sync_file
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: i915_drm_fdinfo
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: gem_softpin
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_tiled_fence_blits
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_ctx_engines
results: parsing output: 106/ for test: kms_color
results: parsing output: 107/ for test: core_getclient
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_plane_lowres
results: parsing output: 112/ for test: kms_force_connector_basic
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: gem_media_vme
results: parsing output: 118/ for test: prime_busy
results: parsing output: 119/ for test: gem_spin_batch
results: parsing output: 120/ for test: kms_concurrent
results: parsing output: 121/ for test: syncobj_eventfd
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: i915_pm_rpm
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: gem_lmem_swapping
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
Done.