[57.086713] Initializing watchdogs
[57.086759]   /dev/watchdog0
[57.107107] [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.111408] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.113761] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.117229] [001/155] (960s left) kms_psr (psr2-sprite-plane-move)
[57.237818] Starting subtest: psr2-sprite-plane-move
[57.240166] Starting dynamic subtest: eDP-1
[59.054507] Dynamic subtest eDP-1: SUCCESS (1.789s)
[59.056764] Subtest psr2-sprite-plane-move: SUCCESS (1.790s)
[59.926237] [002/155] (957s left) kms_vblank (invalid)
[60.024648] Starting subtest: invalid
[60.026660] Starting dynamic subtest: pipe-A-eDP-1
[60.430303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[60.432818] Subtest invalid: SUCCESS (0.402s)
[61.264464] [003/155] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[61.365715] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[61.370205] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[61.459493] [004/155] (956s left) kms_atomic_interruptible (atomic-setmode)
[61.548601] Starting subtest: atomic-setmode
[61.551556] Starting dynamic subtest: pipe-A-eDP-1
[68.488705] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.891s)
[68.490654] Subtest atomic-setmode: SUCCESS (6.892s)
[69.344935] [005/155] (948s left) kms_psr (psr-sprite-plane-move)
[69.446650] Starting subtest: psr-sprite-plane-move
[69.448802] Starting dynamic subtest: eDP-1
[71.263742] Dynamic subtest eDP-1: SUCCESS (1.811s)
[71.266232] Subtest psr-sprite-plane-move: SUCCESS (1.811s)
[72.101064] [006/155] (945s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[72.203694] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[72.208269] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[72.378024] [007/155] (945s left) kms_prime (basic-crc-hybrid)
[72.526833] Subtest basic-crc-hybrid: SKIP (0.000s)
[72.671881] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[72.675300] [008/155] (945s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[72.864844] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[72.869500] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[73.143202] [009/155] (944s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[73.294413] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[73.296970] Starting dynamic subtest: pipe-A-eDP-1
[73.321598] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[73.329883] Starting dynamic subtest: pipe-B-eDP-1
[73.351842] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[73.359229] Starting dynamic subtest: pipe-C-eDP-1
[73.381612] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[73.388781] Starting dynamic subtest: pipe-D-eDP-1
[73.411088] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[73.415554] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[75.565361] [010/155] (942s left) prime_self_import (basic-llseek-size)
[75.599292] Starting subtest: basic-llseek-size
[75.623927] Subtest basic-llseek-size: SUCCESS (0.024s)
[75.733206] [011/155] (942s left) kms_hdr (static-toggle-suspend)
[75.832248] Starting subtest: static-toggle-suspend
[75.834603] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[75.838988] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[75.849421] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[75.854220] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[75.858595] Subtest static-toggle-suspend: SKIP (0.002s)
[75.900262] [012/155] (942s left) kms_psr (pr-cursor-plane-onoff)
[76.000668] Starting subtest: pr-cursor-plane-onoff
[76.004849] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[76.069961] [013/155] (942s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[76.172908] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[77.174547] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.001s)
[77.336813] [014/155] (940s left) i915_suspend (forcewake)
[77.395480] Starting subtest: forcewake
[108.945497] Subtest forcewake: SUCCESS (3.126s)
[110.044259] [015/155] (909s left) sw_sync (sync_multi_timeline_wait)
[110.085899] Starting subtest: sync_multi_timeline_wait
[110.087985] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[110.139792] [016/155] (909s left) kms_cursor_crc (cursor-onscreen-32x32)
[110.282060] Starting subtest: cursor-onscreen-32x32
[110.332366] Subtest cursor-onscreen-32x32: SKIP (0.047s)
[110.636235] [017/155] (908s left) syncobj_timeline (reset-multiple-signaled)
[110.695396] Starting subtest: reset-multiple-signaled
[110.697883] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[110.814972] [018/155] (908s left) kms_content_protection (atomic-hdcp14)
[110.954315] Starting subtest: atomic-hdcp14
[110.958989] Subtest atomic-hdcp14: SKIP (0.000s)
[111.076358] [019/155] (908s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[111.168924] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[111.971673] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s)
[112.157787] [020/155] (907s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[112.251266] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[112.253749] Starting dynamic subtest: pipe-A-eDP-1
[112.282415] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[112.292709] Starting dynamic subtest: pipe-B-eDP-1
[112.314429] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[112.322478] Starting dynamic subtest: pipe-C-eDP-1
[112.345408] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[112.355090] Starting dynamic subtest: pipe-D-eDP-1
[112.377504] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[112.382155] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[114.845564] [021/155] (904s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[114.950018] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[114.954247] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[115.021247] [022/155] (904s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[115.117276] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[115.119726] Starting dynamic subtest: pipe-A-eDP-1
[115.180473] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[115.188861] Starting dynamic subtest: pipe-B-eDP-1
[115.246772] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[115.257115] Starting dynamic subtest: pipe-C-eDP-1
[115.315377] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[115.325037] Starting dynamic subtest: pipe-D-eDP-1
[115.382901] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[115.387225] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.007s)
[117.449442] [023/155] (902s left) gem_mmap_offset (partial-unmap)
[117.496295] Starting subtest: partial-unmap
[117.498365] Starting dynamic subtest: smem0
[117.979103] Dynamic subtest smem0: SUCCESS (0.476s)
[117.981748] Subtest partial-unmap: SUCCESS (0.477s)
[118.117777] [024/155] (901s left) syncobj_timeline (wait-any-interrupted)
[118.177253] Starting subtest: wait-any-interrupted
[118.284123] Subtest wait-any-interrupted: SUCCESS (0.104s)
[118.360387] [025/155] (901s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[118.463324] Starting subtest: fbc-modesetfrombusy
[122.366143] Subtest fbc-modesetfrombusy: SUCCESS (3.873s)
[123.556463] [026/155] (896s left) api_intel_bb (render-ccs)
[123.628877] Starting subtest: render-ccs
[123.978853] Subtest render-ccs: SUCCESS (0.349s)
[124.089989] [027/155] (895s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[124.176980] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[124.179811] Starting dynamic subtest: pipe-A-default-mode
[125.308478] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[125.312558] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.121s)
[125.463031] [028/155] (894s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[125.564422] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[125.568957] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[125.661540] [029/155] (894s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[125.747572] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[125.775557] Starting dynamic subtest: pipe-A-plane-0
[126.065815] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[126.075628] Starting dynamic subtest: pipe-A-plane-3
[126.300221] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[127.383246] Starting dynamic subtest: pipe-B-plane-0
[127.683257] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[127.692729] Starting dynamic subtest: pipe-B-plane-3
[127.919155] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[128.247002] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.488s)
[129.068490] [030/155] (890s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[129.123934] Starting subtest: multi-wait-all-for-submit-available-submitted
[129.126154] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[129.219998] [031/155] (890s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[129.311454] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[129.315480] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[129.413661] [032/155] (890s left) gem_create (create-ext-cpu-access-sanity-check)
[129.574264] Starting subtest: create-ext-cpu-access-sanity-check
[129.578778] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s)
[129.650783] [033/155] (890s left) gem_softpin (evict-prime-sanity-check)
[129.706429] Starting subtest: evict-prime-sanity-check
[129.708904] Starting dynamic subtest: rcs0
[130.837730] Dynamic subtest rcs0: SUCCESS (1.128s)
[130.846622] Starting dynamic subtest: bcs0
[131.952993] Dynamic subtest bcs0: SUCCESS (1.112s)
[131.962141] Starting dynamic subtest: vcs0
[133.702619] Dynamic subtest vcs0: SUCCESS (1.743s)
[133.714848] Starting dynamic subtest: vcs1
[135.682917] Dynamic subtest vcs1: SUCCESS (1.975s)
[135.692219] Starting dynamic subtest: vecs0
[137.726624] Dynamic subtest vecs0: SUCCESS (2.040s)
[137.738609] Starting dynamic subtest: ccs0
[138.853174] Dynamic subtest ccs0: SUCCESS (1.125s)
[138.864493] Starting dynamic subtest: all
[139.961079] Dynamic subtest all: SUCCESS (1.107s)
[139.963571] Subtest evict-prime-sanity-check: SUCCESS (10.237s)
[140.053837] [034/155] (879s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[140.175959] Starting subtest: cursorB-vs-flipA-atomic
[140.180709] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[140.328933] [035/155] (879s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[140.421372] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[140.423661] Starting dynamic subtest: pipe-A-eDP-1
[140.507638] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[140.518298] Starting dynamic subtest: pipe-B-eDP-1
[141.678256] Dynamic subtest pipe-B-eDP-1: SKIP (1.171s)
[141.683046] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.261s)
[142.878461] [036/155] (877s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[142.976764] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[142.980908] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[143.080523] [037/155] (877s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[143.138760] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[143.142688] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[143.318142] [038/155] (876s left) gem_ctx_persistence (heartbeat-hang)
[143.374412] Starting subtest: heartbeat-hang
[143.379081] Subtest heartbeat-hang: SKIP (0.000s)
[143.478632] [039/155] (876s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[144.996582] Starting subtest: dpms-mode-unset-non-lpsp
[146.157212] Subtest dpms-mode-unset-non-lpsp: SKIP (1.158s)
[146.543928] [040/155] (873s left) perf (global-sseu-config-invalid)
[146.669854] Starting subtest: global-sseu-config-invalid
[146.674109] Subtest global-sseu-config-invalid: SKIP (0.000s)
[146.710711] [041/155] (873s left) kms_invalid_mode (clock-too-high)
[146.806825] Starting subtest: clock-too-high
[146.809113] Starting dynamic subtest: pipe-A-eDP-1
[147.094007] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[147.105238] Starting dynamic subtest: pipe-B-eDP-1
[147.109987] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[147.121011] Starting dynamic subtest: pipe-C-eDP-1
[147.125732] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[147.135273] Starting dynamic subtest: pipe-D-eDP-1
[147.139693] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[147.141582] Subtest clock-too-high: SUCCESS (0.294s)
[147.963410] [042/155] (872s left) gem_exec_balancer (sequential)
[148.025354] Starting subtest: sequential
[151.115403] Subtest sequential: SUCCESS (3.092s)
[151.450508] [043/155] (868s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[151.542998] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[151.547884] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[151.613415] [044/155] (868s left) kms_cursor_crc (cursor-suspend)
[151.754492] Starting subtest: cursor-suspend
[151.756869] Starting dynamic subtest: pipe-A-eDP-1
[184.427967] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.130s)
[184.439162] Starting dynamic subtest: pipe-D-eDP-1
[218.472995] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.753s)
[218.475266] Subtest cursor-suspend: SUCCESS (6.885s)
[219.322212] [045/155] (801s left) kms_addfb_basic (addfb25-bad-modifier)
[219.422905] Starting subtest: addfb25-bad-modifier
[219.425235] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[219.521119] [046/155] (800s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[219.616231] Starting subtest: plane-lut1d-pre-ctm3x4
[219.758217] Starting dynamic subtest: pipe-A-plane-0
[219.906940] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[219.922046] Starting dynamic subtest: pipe-A-plane-1
[220.043978] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[220.053587] Starting dynamic subtest: pipe-A-plane-2
[220.180959] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[221.358480] Starting dynamic subtest: pipe-B-plane-0
[221.544082] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[221.554052] Starting dynamic subtest: pipe-B-plane-1
[221.680901] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[221.690204] Starting dynamic subtest: pipe-B-plane-2
[221.817319] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[223.034193] Starting dynamic subtest: pipe-C-plane-0
[223.173470] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[223.183574] Starting dynamic subtest: pipe-C-plane-1
[223.320637] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[223.330342] Starting dynamic subtest: pipe-C-plane-2
[223.468031] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[224.697405] Starting dynamic subtest: pipe-D-plane-0
[224.825377] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[224.838555] Starting dynamic subtest: pipe-D-plane-1
[224.961037] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[224.970986] Starting dynamic subtest: pipe-D-plane-2
[225.107244] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[225.406667] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.666s)
[226.294200] [047/155] (794s left) gem_exec_balancer (bonded-semaphore)
[226.352051] Starting subtest: bonded-semaphore
[226.356720] Subtest bonded-semaphore: SKIP (0.000s)
[226.650455] [048/155] (793s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[226.776624] Starting subtest: 2x-long-cursor-vs-flip-legacy
[226.781279] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[226.922709] [049/155] (793s left) syncobj_wait (wait-for-submit-delayed-submit)
[226.981835] Starting subtest: wait-for-submit-delayed-submit
[227.085779] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[227.172653] [050/155] (793s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[227.286682] Starting subtest: cursorA-vs-flipA-atomic-transitions
[238.534622] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.180s)
[239.410424] [051/155] (781s left) gem_exec_reloc (basic-write-read-active)
[239.475052] Subtest basic-write-read-active: SKIP (0.000s)
[239.536628] [052/155] (781s left) kms_force_connector_basic (prune-stale-modes)
[239.619456] Starting subtest: prune-stale-modes
[240.060392] Subtest prune-stale-modes: SUCCESS (0.443s)
[240.199537] [053/155] (780s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[240.306879] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[240.311002] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[240.419189] [054/155] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[240.520281] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[240.523602] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[240.609882] [055/155] (780s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[240.704217] Starting subtest: random-ccs-data-y-tiled-ccs
[240.706218] Starting dynamic subtest: pipe-A-eDP-1
[240.727812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.740361] Starting dynamic subtest: pipe-B-eDP-1
[240.760225] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.769037] Starting dynamic subtest: pipe-C-eDP-1
[240.788690] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.796969] Starting dynamic subtest: pipe-D-eDP-1
[240.817396] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.820772] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[242.945891] [056/155] (777s left) sysfs_heartbeat_interval (nopreempt)
[243.012971] Starting subtest: nopreempt
[243.015315] Starting dynamic subtest: vecs0
[252.411165] Dynamic subtest vecs0: SUCCESS (9.390s)
[252.426209] Starting dynamic subtest: ccs0
[256.426579] Dynamic subtest ccs0: SUCCESS (4.013s)
[256.439653] Starting dynamic subtest: vcs0
[266.421899] Dynamic subtest vcs0: SUCCESS (9.989s)
[266.433562] Starting dynamic subtest: bcs0
[270.356871] Dynamic subtest bcs0: SUCCESS (3.935s)
[270.366992] Starting dynamic subtest: rcs0
[274.343639] Dynamic subtest rcs0: SUCCESS (3.982s)
[274.355169] Starting dynamic subtest: vcs1
[283.453179] Dynamic subtest vcs1: SUCCESS (9.103s)
[283.455846] Subtest nopreempt: SUCCESS (40.424s)
[283.528838] [057/155] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[283.625400] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[283.629445] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[283.727865] [058/155] (737s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[283.797863] Subtest tiled-to-tiled: SKIP (0.000s)
[283.864083] [059/155] (737s left) syncobj_basic (bad-handle-to-fd)
[283.916550] Starting subtest: bad-handle-to-fd
[283.918553] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[284.015229] [060/155] (737s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[284.112062] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[284.116471] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[284.202129] [061/155] (736s left) gem_exec_reloc (basic-write-wc-active)
[284.262624] Subtest basic-write-wc-active: SKIP (0.000s)
[284.347419] [062/155] (736s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[284.457685] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[284.461283] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[284.551810] [063/155] (736s left) gem_mmap_gtt (basic-copy)
[284.606332] Subtest basic-copy: SKIP (0.000s)
[284.673846] [064/155] (736s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[284.762621] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[284.766444] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[284.851474] [065/155] (736s left) perf_pmu (init-wait)
[284.890405] Starting subtest: init-wait
[284.892317] Starting dynamic subtest: rcs0
[284.894070] Dynamic subtest rcs0: SUCCESS (0.002s)
[284.903314] Starting dynamic subtest: bcs0
[284.905113] Dynamic subtest bcs0: SUCCESS (0.000s)
[284.913537] Starting dynamic subtest: vcs0
[284.915243] Dynamic subtest vcs0: SUCCESS (0.001s)
[284.923628] Starting dynamic subtest: vcs1
[284.925393] Dynamic subtest vcs1: SUCCESS (0.001s)
[284.933638] Starting dynamic subtest: vecs0
[284.935552] Dynamic subtest vecs0: SUCCESS (0.001s)
[284.943942] Starting dynamic subtest: ccs0
[284.945708] Dynamic subtest ccs0: SUCCESS (0.000s)
[284.947497] Subtest init-wait: SUCCESS (0.008s)
[285.022803] [066/155] (736s left) gen7_exec_parse (basic-offset)
[285.084896] Subtest basic-offset: SKIP (0.000s)
[285.158976] [067/155] (736s left) gen9_exec_parse (unaligned-access)
[285.210313] Subtest unaligned-access: SKIP (0.000s)
[285.266439] [068/155] (736s left) gem_ccs (large-ctrl-surf-copy)
[285.330036] Starting subtest: large-ctrl-surf-copy
[285.333993] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[285.424359] [069/155] (736s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[285.526662] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[286.573712] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.045s)
[286.708244] [070/155] (734s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt)
[286.813687] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt
[286.817325] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[286.908242] [071/155] (734s left) kms_cursor_crc (cursor-sliding-128x42)
[287.143080] Starting subtest: cursor-sliding-128x42
[287.193045] Subtest cursor-sliding-128x42: SKIP (0.044s)
[287.389307] [072/155] (734s left) kms_atomic_transition (modeset-transition-fencing)
[287.484669] Starting subtest: modeset-transition-fencing
[287.486643] Starting dynamic subtest: 1x-outputs
[298.323797] Dynamic subtest 1x-outputs: SUCCESS (10.837s)
[298.326602] Subtest modeset-transition-fencing: SUCCESS (10.838s)
[299.170904] [073/155] (722s left) kms_flip (flip-vs-panning-interruptible)
[299.264047] Starting subtest: flip-vs-panning-interruptible
[299.266222] Starting dynamic subtest: A-eDP1
[307.948755] Dynamic subtest A-eDP1: SUCCESS (8.679s)
[307.958917] Starting dynamic subtest: B-eDP1
[316.639722] Dynamic subtest B-eDP1: SUCCESS (8.689s)
[316.648980] Starting dynamic subtest: C-eDP1
[325.316522] Dynamic subtest C-eDP1: SUCCESS (8.678s)
[325.326593] Starting dynamic subtest: D-eDP1
[334.019880] Dynamic subtest D-eDP1: SUCCESS (8.704s)
[334.024487] Subtest flip-vs-panning-interruptible: SUCCESS (34.758s)
[335.257359] [074/155] (686s left) kms_psr2_su (page_flip-p010)
[335.308422] Subtest page_flip-P010: SKIP (0.000s)
[335.364271] [075/155] (686s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[335.464946] Starting subtest: 4-tiled-32bpp-rotate-180
[336.943637] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.479s)
[337.073641] [076/155] (684s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[337.135432] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[337.208360] [077/155] (684s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[337.298007] Starting subtest: plane-all-modeset-transition-internal-panels
[337.299833] Starting dynamic subtest: pipe-A-eDP-1
[338.673145] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.373s)
[338.952038] Starting dynamic subtest: pipe-B-eDP-1
[339.973305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.030s)
[340.245446] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.948s)
[341.070823] [078/155] (680s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[341.170275] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[341.174736] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[341.269734] [079/155] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[341.379659] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[345.116629] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.743s)
[346.257917] [080/155] (675s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[346.356196] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[346.360455] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[346.452056] [081/155] (675s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[346.833022] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[347.641683] [082/155] (674s left) gem_exec_schedule (u-independent)
[347.727088] Starting subtest: u-independent
[347.729537] Starting dynamic subtest: rcs0
[349.436101] Dynamic subtest rcs0: SUCCESS (1.717s)
[349.448584] Starting dynamic subtest: vcs0
[351.428121] Dynamic subtest vcs0: SUCCESS (1.990s)
[351.442361] Starting dynamic subtest: vcs1
[353.410331] Dynamic subtest vcs1: SUCCESS (1.979s)
[353.425230] Starting dynamic subtest: vecs0
[355.384825] Dynamic subtest vecs0: SUCCESS (1.973s)
[355.395193] Starting dynamic subtest: ccs0
[357.436010] Dynamic subtest ccs0: SUCCESS (2.048s)
[357.438810] Subtest u-independent: SUCCESS (9.718s)
[357.737942] [083/155] (664s left) kms_chamelium_frames (dp-crc-single)
[358.118450] Subtest dp-crc-single: SKIP (0.000s)
[358.931510] [084/155] (663s left) api_intel_bb (blit-noreloc-purge-cache)
[358.991373] Starting subtest: blit-noreloc-purge-cache
[359.001233] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[359.140244] [085/155] (662s left) gem_exec_reloc (basic-write-gtt-noreloc)
[359.191846] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[359.260087] [086/155] (662s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[359.353822] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[359.357968] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[359.444903] [087/155] (662s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render)
[359.547957] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render
[359.552028] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[359.672058] [088/155] (662s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[359.775529] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[359.779924] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[359.875617] [089/155] (662s left) gem_exec_schedule (implicit-read-write)
[359.938298] Starting subtest: implicit-read-write
[359.939943] Starting dynamic subtest: rcs0
[360.043432] Dynamic subtest rcs0: SUCCESS (0.113s)
[360.059000] Starting dynamic subtest: vcs0
[360.125024] Dynamic subtest vcs0: SUCCESS (0.080s)
[360.136736] Starting dynamic subtest: vcs1
[360.205484] Dynamic subtest vcs1: SUCCESS (0.080s)
[360.216396] Starting dynamic subtest: vecs0
[360.290803] Dynamic subtest vecs0: SUCCESS (0.084s)
[360.301981] Starting dynamic subtest: ccs0
[360.385091] Dynamic subtest ccs0: SUCCESS (0.094s)
[360.386962] Subtest implicit-read-write: SUCCESS (0.456s)
[361.492863] [090/155] (660s left) kms_dsc (dsc-with-bpc-formats)
[361.580997] Starting subtest: dsc-with-bpc-formats
[361.694431] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[361.733734] [091/155] (660s left) dmabuf_sync_file (export-basic)
[361.784448] Starting subtest: export-basic
[361.786311] Subtest export-basic: SUCCESS (0.001s)
[361.839946] [092/155] (660s left) kms_properties (invalid-properties-legacy)
[361.941168] Starting subtest: invalid-properties-legacy
[362.038439] Subtest invalid-properties-legacy: SUCCESS (0.100s)
[362.111952] [093/155] (660s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[362.216339] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[362.220807] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[362.316618] [094/155] (660s left) kms_vblank (ts-continuation-suspend)
[362.397789] Starting subtest: ts-continuation-suspend
[362.399714] Starting dynamic subtest: pipe-A-eDP-1
[378.250480] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.530s)
[378.267681] Starting dynamic subtest: pipe-D-eDP-1
[395.280887] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.259s)
[395.283450] Subtest ts-continuation-suspend: SUCCESS (3.792s)
[396.190128] [095/155] (626s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[396.256000] Starting subtest: etime-multi-wait-all-available-unsubmitted
[396.362864] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[396.446983] [096/155] (626s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[396.547948] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[400.669037] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.031s)
[401.830126] [097/155] (620s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[401.946098] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[401.951552] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[402.047646] [098/155] (620s left) perf (polling)
[402.138516] Starting subtest: polling
[402.141313] Starting dynamic subtest: 0-rcs0
[412.224278] Dynamic subtest 0-rcs0: SUCCESS (9.947s)
[412.236529] Starting dynamic subtest: 1-vecs0
[422.241304] Dynamic subtest 1-vecs0: SUCCESS (9.990s)
[422.244206] Subtest polling: SUCCESS (19.939s)
[422.286842] [099/155] (600s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt)
[422.406591] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt
[422.411211] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[422.501984] [100/155] (600s left) gem_linear_blits (interruptible)
[422.977903] Starting subtest: interruptible
[427.671432] Subtest interruptible: SUCCESS (4.637s)
[427.758403] [101/155] (595s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[427.926070] Starting subtest: async-flip-with-page-flip-events-linear
[428.310222] Starting dynamic subtest: pipe-A-eDP-1
[431.134762] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.770s)
[431.445100] Starting dynamic subtest: pipe-B-eDP-1
[434.232166] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.743s)
[434.554239] Starting dynamic subtest: pipe-C-eDP-1
[437.329667] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.737s)
[437.648679] Starting dynamic subtest: pipe-D-eDP-1
[440.378876] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.740s)
[440.381918] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.455s)
[441.536433] [102/155] (581s left) gem_exec_store (basic)
[441.602355] Starting subtest: basic
[441.697750] Subtest basic: SUCCESS (0.095s)
[441.886677] [103/155] (581s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[441.971184] Starting subtest: primary-y-tiled-reflect-x-90
[441.976205] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[442.041739] [104/155] (580s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[442.140607] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[449.014582] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.876s)
[449.148230] [105/155] (573s left) gem_exec_schedule (preempt-other-chain)
[449.240224] Starting subtest: preempt-other-chain
[449.242689] Starting dynamic subtest: rcs0
[449.315133] Dynamic subtest rcs0: SUCCESS (0.084s)
[449.331472] Starting dynamic subtest: bcs0
[449.396084] Dynamic subtest bcs0: SUCCESS (0.080s)
[449.407796] Starting dynamic subtest: vcs0
[449.472874] Dynamic subtest vcs0: SUCCESS (0.076s)
[449.488173] Starting dynamic subtest: vcs1
[449.555853] Dynamic subtest vcs1: SUCCESS (0.083s)
[449.567031] Starting dynamic subtest: vecs0
[449.637652] Dynamic subtest vecs0: SUCCESS (0.080s)
[449.650521] Starting dynamic subtest: ccs0
[449.715738] Dynamic subtest ccs0: SUCCESS (0.078s)
[449.719091] Subtest preempt-other-chain: SUCCESS (0.486s)
[450.539864] [106/155] (572s left) kms_lease (lease-get)
[450.632893] Starting subtest: lease-get
[450.635073] Starting dynamic subtest: pipe-A-eDP-1
[450.637340] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[450.647710] Starting dynamic subtest: pipe-B-eDP-1
[450.650081] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[450.659683] Starting dynamic subtest: pipe-C-eDP-1
[450.661952] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[450.671894] Starting dynamic subtest: pipe-D-eDP-1
[450.675020] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[450.677402] Subtest lease-get: SUCCESS (0.009s)
[450.753674] [107/155] (572s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[450.855483] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[450.860944] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[450.956441] [108/155] (572s left) kms_plane_alpha_blend (alpha-opaque-fb)
[451.049343] Starting subtest: alpha-opaque-fb
[451.336242] Starting dynamic subtest: pipe-A-eDP-1
[451.975445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[451.988199] Starting dynamic subtest: pipe-D-eDP-1
[453.339150] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.364s)
[453.342229] Subtest alpha-opaque-fb: SUCCESS (2.291s)
[454.237340] [109/155] (568s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[454.380121] Starting subtest: verify-pxp-execution-after-suspend-resume
[461.444628] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.062s)
[461.562907] [110/155] (561s left) gem_exec_fence (submit)
[461.741331] Starting subtest: submit
[461.747230] Subtest submit: SKIP (0.000s)
[463.514331] [111/155] (559s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[463.624074] Starting subtest: y-tiled-64bpp-rotate-90
[463.629210] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[463.729947] [112/155] (559s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[463.820116] Starting subtest: hdr-rgb101010-draw-render
[463.825183] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[463.924663] [113/155] (559s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[464.021980] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[464.026790] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[464.104224] [114/155] (559s left) gem_userptr_blits (create-destroy-unsync)
[464.176455] Subtest create-destroy-unsync: SKIP (0.000s)
[464.294030] [115/155] (559s left) gem_exec_params (cliprects_ptr-dirt)
[464.356742] Starting subtest: cliprects_ptr-dirt
[464.359348] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[464.450548] [116/155] (558s left) gem_eio (in-flight-suspend)
[464.666656] Starting subtest: in-flight-suspend
[507.539606] Subtest in-flight-suspend: SUCCESS (14.044s)
[507.682143] [117/155] (515s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[507.812541] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[507.817213] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[507.976841] [118/155] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[508.076250] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[508.080791] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[508.180412] [119/155] (515s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[508.279880] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[508.283708] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[508.381518] [120/155] (515s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[508.484443] Starting subtest: fbc-tiling-linear
[512.229969] Subtest fbc-tiling-linear: SUCCESS (3.651s)
[513.395930] [121/155] (510s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render)
[513.504605] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render
[513.510019] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[513.612704] [122/155] (510s left) i915_module_load (resize-bar)
[513.650042] Starting subtest: resize-bar
[513.660791] Subtest resize-bar: SKIP (0.009s)
[513.710745] [123/155] (510s left) gen9_exec_parse (bb-start-cmd)
[513.771181] Subtest bb-start-cmd: SKIP (0.000s)
[513.846275] [124/155] (509s left) prime_vgem (coherency-blt)
[513.921132] Starting subtest: coherency-blt
[515.122105] Subtest coherency-blt: SUCCESS (1.180s)
[515.240365] [125/155] (508s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[515.353098] Starting subtest: flip-vs-cursor-varying-size
[524.479098] Subtest flip-vs-cursor-varying-size: SUCCESS (9.048s)
[525.302031] [126/155] (498s left) gem_readwrite (beyond-eob)
[525.360714] Subtest beyond-EOB: SKIP (0.000s)
[525.448303] [127/155] (498s left) gem_lmem_swapping (massive-random)
[525.490193] Subtest massive-random: SKIP (0.000s)
[525.546052] [128/155] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[525.643455] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[532.912067] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.256s)
[533.059060] [129/155] (490s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[533.158209] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[533.162453] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[533.269289] [130/155] (490s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt)
[533.363389] Starting subtest: fbchdr-rgb101010-draw-blt
[533.367613] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s)
[533.461844] [131/155] (490s left) kms_dirtyfb (default-dirtyfb-ioctl)
[533.549572] Starting subtest: default-dirtyfb-ioctl
[533.551896] Starting dynamic subtest: A-eDP-1
[535.133297] Dynamic subtest A-eDP-1: SUCCESS (1.582s)
[535.135651] Subtest default-dirtyfb-ioctl: SUCCESS (1.583s)
[536.016033] [132/155] (488s left) gem_ctx_isolation (dirty-create)
[536.077247] Starting subtest: dirty-create
[536.079590] Starting dynamic subtest: rcs0
[536.260565] Dynamic subtest rcs0: SUCCESS (0.181s)
[536.272572] Starting dynamic subtest: bcs0
[536.471155] Dynamic subtest bcs0: SUCCESS (0.210s)
[536.481821] Starting dynamic subtest: vcs0
[536.686465] Dynamic subtest vcs0: SUCCESS (0.214s)
[536.698004] Starting dynamic subtest: vcs1
[538.454144] Dynamic subtest vcs1: SUCCESS (1.765s)
[538.464616] Starting dynamic subtest: vecs0
[540.453553] Dynamic subtest vecs0: SUCCESS (1.998s)
[540.466423] Starting dynamic subtest: ccs0
[542.479825] Dynamic subtest ccs0: SUCCESS (2.024s)
[542.482332] Subtest dirty-create: SUCCESS (6.398s)
[542.706210] [133/155] (481s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[542.802493] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[542.806621] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[542.895887] [134/155] (481s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[542.990258] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[542.993721] Starting dynamic subtest: pipe-A
[543.327866] Dynamic subtest pipe-A: SUCCESS (0.340s)
[543.339229] Starting dynamic subtest: pipe-B
[544.784921] Dynamic subtest pipe-B: SUCCESS (1.456s)
[544.796142] Starting dynamic subtest: pipe-C
[546.196129] Dynamic subtest pipe-C: SUCCESS (1.410s)
[546.208481] Starting dynamic subtest: pipe-D
[547.589261] Dynamic subtest pipe-D: SUCCESS (1.392s)
[547.591589] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.600s)
[548.748169] [135/155] (475s left) syncobj_timeline (etime-single-wait-all-submitted)
[548.794700] Starting subtest: etime-single-wait-all-submitted
[548.901970] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[548.981919] [136/155] (475s left) gem_partial_pwrite_pread (reads)
[549.043834] Subtest reads: SKIP (0.000s)
[549.108254] [137/155] (475s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[549.207541] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[549.211960] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[549.278898] [138/155] (475s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[549.340610] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[549.399601] [139/155] (475s left) kms_flip (2x-flip-vs-modeset)
[549.497724] Starting subtest: 2x-flip-vs-modeset
[549.505921] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[549.585711] [140/155] (474s left) kms_psr (pr-cursor-mmap-gtt)
[549.677975] Starting subtest: pr-cursor-mmap-gtt
[549.682235] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[549.751693] [141/155] (474s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[549.866738] Starting subtest: plane-upscale-20x20-with-pixel-format
[549.869070] Starting dynamic subtest: pipe-A
[550.913856] Dynamic subtest pipe-A: SUCCESS (1.049s)
[550.924590] Starting dynamic subtest: pipe-B
[553.001729] Dynamic subtest pipe-B: SUCCESS (2.086s)
[553.020294] Starting dynamic subtest: pipe-C
[554.163502] Dynamic subtest pipe-C: SUCCESS (1.161s)
[554.174998] Starting dynamic subtest: pipe-D
[555.358499] Dynamic subtest pipe-D: SUCCESS (1.193s)
[555.360839] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.494s)
[556.520234] [142/155] (468s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[556.609079] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[556.611240] Starting dynamic subtest: pipe-A-eDP-1
[556.634711] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[556.649016] Starting dynamic subtest: pipe-B-eDP-1
[556.671068] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[556.681485] Starting dynamic subtest: pipe-C-eDP-1
[556.703005] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[556.713014] Starting dynamic subtest: pipe-D-eDP-1
[556.735055] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[556.738961] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[558.827027] [143/155] (465s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[558.928283] Starting subtest: fbc-psr2-cursor-mmap-cpu
[558.930581] Starting dynamic subtest: eDP-1
[558.934905] Dynamic subtest eDP-1: SKIP (0.000s)
[558.939181] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[559.002579] [144/155] (465s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[559.053392] Starting subtest: framebuffer-vs-set-tiling
[559.057962] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[559.190424] [145/155] (465s left) i915_pm_rpm (system-suspend)
[561.427076] Starting subtest: system-suspend
[578.752962] Subtest system-suspend: SUCCESS (2.888s)
[579.170195] [146/155] (445s left) sw_sync (alloc_merge_fence)
[579.226472] Starting subtest: alloc_merge_fence
[579.228803] Subtest alloc_merge_fence: SUCCESS (0.000s)
[579.288736] [147/155] (445s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[579.400380] Starting subtest: fbcpsr-rgb565-draw-render
[586.572000] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.017s)
[586.708773] [148/155] (438s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[586.815208] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[586.819551] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[586.918060] [149/155] (437s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[587.007918] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[587.012071] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[587.110715] [150/155] (437s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[587.166172] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[587.226561] [151/155] (437s left) gem_pxp (hw-rejects-pxp-buffer)
[587.343179] Starting subtest: hw-rejects-pxp-buffer
[587.347884] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[587.472874] [152/155] (437s left) prime_mmap (test_aperture_limit)
[587.520630] Starting subtest: test_aperture_limit
[587.522512] Starting dynamic subtest: test_aperture_limit-smem
[587.529251] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[587.533035] Subtest test_aperture_limit: SKIP (0.009s)
[587.652601] [153/155] (437s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[587.745245] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[587.748821] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[587.830927] [154/155] (437s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[587.934236] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[587.937972] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[588.038071] [155/155] (437s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[588.139976] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[588.143382] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[588.233665] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_atomic_interruptible
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_prime
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: prime_self_import
results: parsing output: 10/ for test: kms_hdr
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: i915_suspend
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_mmap_offset
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: api_intel_bb
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_create
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: kms_color_pipeline
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_force_connector_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: sysfs_heartbeat_interval
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_set_tiling_vs_blt
results: parsing output: 58/ for test: syncobj_basic
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: gen7_exec_parse
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: gem_ccs
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_atomic_transition
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_psr2_su
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_atomic_transition
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_chamelium_hpd
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_chamelium_frames
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_dsc
results: parsing output: 90/ for test: dmabuf_sync_file
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_vblank
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_linear_blits
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: gem_exec_store
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_lease
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane_alpha_blend
results: parsing output: 108/ for test: gem_pxp
results: parsing output: 109/ for test: gem_exec_fence
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: gem_eio
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: i915_module_load
results: parsing output: 122/ for test: gen9_exec_parse
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_readwrite
results: parsing output: 126/ for test: gem_lmem_swapping
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_dirtyfb
results: parsing output: 131/ for test: gem_ctx_isolation
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_plane_scaling
results: parsing output: 134/ for test: syncobj_timeline
results: parsing output: 135/ for test: gem_partial_pwrite_pread
results: parsing output: 136/ for test: kms_flip_scaled_crc
results: parsing output: 137/ for test: gem_mmap_gtt
results: parsing output: 138/ for test: kms_flip
results: parsing output: 139/ for test: kms_psr
results: parsing output: 140/ for test: kms_plane_scaling
results: parsing output: 141/ for test: kms_ccs
results: parsing output: 142/ for test: kms_psr
results: parsing output: 143/ for test: kms_addfb_basic
results: parsing output: 144/ for test: i915_pm_rpm
results: parsing output: 145/ for test: sw_sync
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_mmap_wc
results: parsing output: 150/ for test: gem_pxp
results: parsing output: 151/ for test: prime_mmap
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.