[58.175047] Initializing watchdogs
[58.175119]   /dev/watchdog0
[58.188586] [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]
[58.193452] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.195575] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.199252] [001/133] (960s left) core_auth (getclient-master-drop)
[58.254880] Starting subtest: getclient-master-drop
[58.276375] Subtest getclient-master-drop: SUCCESS (0.022s)
[58.386381] [002/133] (960s left) gem_workarounds (reset)
[58.461612] Starting subtest: reset
[58.570288] Subtest reset: SUCCESS (0.109s)
[58.724286] [003/133] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[58.832692] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[58.836930] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[58.909330] [004/133] (959s left) i915_hangman (hangcheck-unterminated)
[58.963124] Starting subtest: hangcheck-unterminated
[70.899728] Subtest hangcheck-unterminated: SUCCESS (11.971s)
[71.044651] [005/133] (947s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[71.142097] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[71.144255] Starting dynamic subtest: pipe-A-eDP-1
[71.263878] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[71.275979] Starting dynamic subtest: pipe-B-eDP-1
[72.385877] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[72.390631] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.249s)
[73.595188] [006/133] (945s left) gem_exec_whisper (basic-normal-all)
[73.676190] Starting subtest: basic-normal-all
[76.140548] Subtest basic-normal-all: SUCCESS (2.464s)
[76.331294] [007/133] (942s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[76.435750] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[76.438042] Starting dynamic subtest: pipe-A-eDP-1
[92.901730] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.472s)
[92.911251] Starting dynamic subtest: pipe-B-eDP-1
[110.048496] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.147s)
[110.050727] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.621s)
[110.857830] [008/133] (908s left) dmabuf (all-tests)
[110.899990] Starting subtest: all-tests
[110.902307] Starting dynamic subtest: sanitycheck
[111.052777] Dynamic subtest sanitycheck: SUCCESS (0.151s)
[111.063632] Starting dynamic subtest: dma_fence
[111.343175] Dynamic subtest dma_fence: SUCCESS (0.289s)
[111.352571] Starting dynamic subtest: dma_fence_chain
[119.883034] Dynamic subtest dma_fence_chain: SUCCESS (8.539s)
[119.893590] Starting dynamic subtest: dma_fence_unwrap
[120.012582] Dynamic subtest dma_fence_unwrap: SUCCESS (0.129s)
[120.022945] Starting dynamic subtest: dma_resv
[120.167740] Dynamic subtest dma_resv: SUCCESS (0.154s)
[120.170326] Subtest all-tests: SUCCESS (9.267s)
[120.238536] [009/133] (898s left) gem_render_copy_redux (interruptible)
[120.309574] Starting subtest: interruptible
[120.714332] Subtest interruptible: SUCCESS (0.407s)
[120.868745] [010/133] (898s left) gem_exec_schedule (pi-shared-iova)
[121.053658] Starting subtest: pi-shared-iova
[121.056074] Starting dynamic subtest: rcs0
[121.184827] Dynamic subtest rcs0: SUCCESS (0.133s)
[121.196996] Starting dynamic subtest: vcs0
[121.265848] Dynamic subtest vcs0: SUCCESS (0.081s)
[121.277278] Starting dynamic subtest: vcs1
[121.347087] Dynamic subtest vcs1: SUCCESS (0.080s)
[121.359531] Starting dynamic subtest: vecs0
[121.419998] Dynamic subtest vecs0: SUCCESS (0.075s)
[121.431192] Starting dynamic subtest: ccs0
[121.544170] Dynamic subtest ccs0: SUCCESS (0.122s)
[121.546699] Subtest pi-shared-iova: SUCCESS (0.493s)
[123.020376] [011/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[123.126454] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[123.130918] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[123.245327] [012/133] (895s left) gem_render_copy (y-tiled)
[123.303655] Starting subtest: y-tiled
[123.308669] Subtest y-tiled: SKIP (0.000s)
[123.495218] [013/133] (895s left) kms_busy (basic)
[123.597331] Starting subtest: basic
[123.599809] Starting dynamic subtest: flip
[124.199328] Dynamic subtest flip: SUCCESS (0.603s)
[124.209100] Starting dynamic subtest: modeset
[127.663419] Dynamic subtest modeset: SUCCESS (3.463s)
[127.665816] Subtest basic: SUCCESS (4.067s)
[128.475155] [014/133] (890s left) kms_psr (psr2-cursor-blt)
[128.572212] Starting subtest: psr2-cursor-blt
[128.574498] Starting dynamic subtest: eDP-1
[130.238867] Dynamic subtest eDP-1: SUCCESS (1.666s)
[130.241266] Subtest psr2-cursor-blt: SUCCESS (1.667s)
[131.061621] [015/133] (888s left) kms_flip (2x-plain-flip-fb-recreate)
[131.155467] Starting subtest: 2x-plain-flip-fb-recreate
[131.166736] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[131.274961] [016/133] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[131.378492] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[131.382607] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[131.484198] [017/133] (887s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[131.591409] Starting subtest: fbcpsr-stridechange
[137.761988] Subtest fbcpsr-stridechange: SUCCESS (6.174s)
[137.943285] [018/133] (881s left) gem_mmap_gtt (close-race)
[138.012257] Subtest close-race: SKIP (0.000s)
[138.076748] [019/133] (881s left) perf_pmu (semaphore-wait)
[138.113301] Starting subtest: semaphore-wait
[138.115400] Starting dynamic subtest: rcs0
[138.628867] Dynamic subtest rcs0: SUCCESS (0.513s)
[138.638386] Starting dynamic subtest: bcs0
[139.143390] Dynamic subtest bcs0: SUCCESS (0.513s)
[139.156627] Starting dynamic subtest: vcs0
[139.666012] Dynamic subtest vcs0: SUCCESS (0.511s)
[139.679118] Starting dynamic subtest: vcs1
[140.167100] Dynamic subtest vcs1: SUCCESS (0.510s)
[140.178044] Starting dynamic subtest: vecs0
[140.679437] Dynamic subtest vecs0: SUCCESS (0.511s)
[140.690920] Starting dynamic subtest: ccs0
[141.196857] Dynamic subtest ccs0: SUCCESS (0.514s)
[141.199748] Subtest semaphore-wait: SUCCESS (3.083s)
[141.359762] [020/133] (878s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[141.470668] Starting subtest: primary-4-tiled-reflect-x-0
[148.617842] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.147s)
[149.869749] [021/133] (869s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[149.981096] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[150.627672] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[150.835158] [022/133] (868s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[150.942225] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[150.946267] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[151.073899] [023/133] (868s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[151.171091] Starting subtest: plane-upscale-20x20-with-pixel-format
[151.173405] Starting dynamic subtest: pipe-A
[152.219988] Dynamic subtest pipe-A: SUCCESS (1.049s)
[152.232270] Starting dynamic subtest: pipe-B
[154.349359] Dynamic subtest pipe-B: SUCCESS (2.130s)
[154.358083] Starting dynamic subtest: pipe-C
[155.548719] Dynamic subtest pipe-C: SUCCESS (1.198s)
[155.558389] Starting dynamic subtest: pipe-D
[156.698932] Dynamic subtest pipe-D: SUCCESS (1.149s)
[156.701612] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.530s)
[157.909786] [024/133] (861s left) kms_color (ctm-negative)
[158.020058] Starting subtest: ctm-negative
[158.022298] Starting dynamic subtest: pipe-A-eDP-1
[158.717752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[158.726873] Starting dynamic subtest: pipe-B-eDP-1
[160.103888] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s)
[160.112876] Starting dynamic subtest: pipe-C-eDP-1
[161.521778] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.417s)
[161.529978] Starting dynamic subtest: pipe-D-eDP-1
[162.904796] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.382s)
[162.907223] Subtest ctm-negative: SUCCESS (4.885s)
[163.734129] [025/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[163.827489] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[163.831895] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[163.932631] [026/133] (855s left) kms_addfb_basic (too-wide)
[164.026203] Starting subtest: too-wide
[164.028047] Subtest too-wide: SUCCESS (0.000s)
[164.156085] [027/133] (855s left) syncobj_basic (bad-flags-fd-to-handle)
[164.223193] Starting subtest: bad-flags-fd-to-handle
[164.225580] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[164.337545] [028/133] (855s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[164.434578] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[164.436807] Starting dynamic subtest: pipe-A-eDP-1
[164.459092] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.470263] Starting dynamic subtest: pipe-B-eDP-1
[164.492513] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.502551] Starting dynamic subtest: pipe-C-eDP-1
[164.524107] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.534152] Starting dynamic subtest: pipe-D-eDP-1
[164.555490] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.559616] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[166.614660] [029/133] (853s left) kms_big_fb (linear-16bpp-rotate-270)
[166.735510] Starting subtest: linear-16bpp-rotate-270
[166.754673] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[166.902099] [030/133] (852s left) kms_pm_rpm (legacy-planes-dpms)
[169.040882] Starting subtest: legacy-planes-dpms
[169.043758] Starting dynamic subtest: plane-64
[177.617243] Dynamic subtest plane-64: SUCCESS (8.574s)
[177.628328] Starting dynamic subtest: plane-94
[185.921632] Dynamic subtest plane-94: SUCCESS (8.301s)
[185.933666] Starting dynamic subtest: plane-124
[194.252922] Dynamic subtest plane-124: SUCCESS (8.329s)
[194.263681] Starting dynamic subtest: plane-134
[202.567399] Dynamic subtest plane-134: SUCCESS (8.311s)
[202.570293] Subtest legacy-planes-dpms: SUCCESS (33.524s)
[202.960488] [031/133] (816s left) syncobj_timeline (multi-wait-all-available-signaled)
[203.024679] Starting subtest: multi-wait-all-available-signaled
[203.026706] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[203.128452] [032/133] (816s left) gem_pxp (create-regular-buffer)
[203.241843] Starting subtest: create-regular-buffer
[203.244605] Subtest create-regular-buffer: SUCCESS (0.000s)
[203.369392] [033/133] (816s left) gem_userptr_blits (sync-overlap)
[203.436467] Starting subtest: sync-overlap
[203.438456] Subtest sync-overlap: SUCCESS (0.000s)
[203.587230] [034/133] (816s left) kms_cursor_crc (cursor-offscreen-256x85)
[203.836570] Starting subtest: cursor-offscreen-256x85
[203.880839] Subtest cursor-offscreen-256x85: SKIP (0.040s)
[204.063324] [035/133] (815s left) kms_vblank (wait-forked-hang)
[204.151173] Starting subtest: wait-forked-hang
[204.152981] Starting dynamic subtest: pipe-A-eDP-1
[230.676109] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.522s)
[230.691636] Starting dynamic subtest: pipe-D-eDP-1
[245.660314] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.981s)
[245.662433] Subtest wait-forked-hang: SUCCESS (41.507s)
[246.512025] [036/133] (773s left) gem_exec_reloc (basic-wc-active)
[246.581606] Subtest basic-wc-active: SKIP (0.000s)
[246.662230] [037/133] (773s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[246.766588] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[246.768781] Starting dynamic subtest: pipe-A-eDP-1
[246.788171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[246.798296] Starting dynamic subtest: pipe-B-eDP-1
[246.817114] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[246.825966] Starting dynamic subtest: pipe-C-eDP-1
[246.844608] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[246.852608] Starting dynamic subtest: pipe-D-eDP-1
[246.871097] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[246.873144] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[249.090393] [038/133] (771s left) kms_flip (2x-dpms-vs-vblank-race)
[249.192966] Starting subtest: 2x-dpms-vs-vblank-race
[249.200746] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[249.330405] [039/133] (770s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[249.437332] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[249.441305] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[249.513382] [040/133] (770s left) kms_atomic (plane-cursor-legacy)
[249.617418] Starting subtest: plane-cursor-legacy
[249.619781] Starting dynamic subtest: pipe-A-eDP-1
[249.991169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s)
[249.993502] Subtest plane-cursor-legacy: SUCCESS (0.373s)
[250.805375] [041/133] (769s left) gem_partial_pwrite_pread (write-uncached)
[250.866625] Subtest write-uncached: SKIP (0.000s)
[250.948326] [042/133] (769s left) gem_create (create-ext-cpu-access-sanity-check)
[251.119362] Starting subtest: create-ext-cpu-access-sanity-check
[251.124200] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[251.213430] [043/133] (769s left) gem_mmap_gtt (zero-extend)
[251.278879] Subtest zero-extend: SKIP (0.000s)
[251.331968] [044/133] (769s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[251.433591] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[251.437772] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[251.513507] [045/133] (768s left) api_intel_allocator (fork-simple-stress)
[251.568907] Starting subtest: fork-simple-stress
[256.971523] Subtest fork-simple-stress: SUCCESS (5.402s)
[257.108396] [046/133] (763s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[257.241849] Starting subtest: y-tiled-64bpp-rotate-180
[257.246264] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[257.393055] [047/133] (763s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[257.482053] Starting subtest: yf-tiled-to-vebox-y-tiled
[257.486183] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[257.692214] [048/133] (762s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[257.814638] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[264.338330] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.526s)
[264.461406] [049/133] (756s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[264.518614] Starting subtest: protected-encrypted-src-copy-not-readible
[264.639719] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.119s)
[264.783902] [050/133] (755s left) i915_pm_rps (basic-api)
[264.842012] Starting subtest: basic-api
[264.846288] Subtest basic-api: SKIP (0.001s)
[264.952280] [051/133] (755s left) gem_busy (busy)
[265.006843] Starting subtest: busy
[265.009642] Starting dynamic subtest: all-engines
[265.078182] Dynamic subtest all-engines: SUCCESS (0.071s)
[265.088353] Starting dynamic subtest: rcs0
[266.909207] Dynamic subtest rcs0: SUCCESS (1.828s)
[266.919241] Starting dynamic subtest: bcs0
[266.951053] Dynamic subtest bcs0: SUCCESS (0.040s)
[266.959115] Starting dynamic subtest: vcs0
[266.993077] Dynamic subtest vcs0: SUCCESS (0.040s)
[267.002712] Starting dynamic subtest: vcs1
[268.892243] Dynamic subtest vcs1: SUCCESS (1.896s)
[268.902560] Starting dynamic subtest: vecs0
[270.874950] Dynamic subtest vecs0: SUCCESS (1.983s)
[270.885067] Starting dynamic subtest: ccs0
[272.923353] Dynamic subtest ccs0: SUCCESS (2.045s)
[272.925542] Subtest busy: SUCCESS (7.914s)
[273.292870] [052/133] (747s left) kms_dp_link_training (non-uhbr-sst)
[273.397026] Starting subtest: non-uhbr-sst
[273.405874] Subtest non-uhbr-sst: SKIP (0.000s)
[273.477600] [053/133] (747s left) gem_unfence_active_buffers
[273.658492] [054/133] (747s left) kms_dsc (dsc-with-formats)
[273.757148] Starting subtest: dsc-with-formats
[273.797282] Subtest dsc-with-formats: SKIP (0.001s)
[273.837461] [055/133] (746s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[273.933975] Starting subtest: plane-downscale-factor-0-75-with-rotation
[273.936215] Starting dynamic subtest: pipe-A
[274.164474] Dynamic subtest pipe-A: SUCCESS (0.232s)
[274.172545] Starting dynamic subtest: pipe-B
[275.510457] Dynamic subtest pipe-B: SUCCESS (1.345s)
[275.518923] Starting dynamic subtest: pipe-C
[276.814584] Dynamic subtest pipe-C: SUCCESS (1.303s)
[276.823901] Starting dynamic subtest: pipe-D
[278.156849] Dynamic subtest pipe-D: SUCCESS (1.341s)
[278.159165] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.225s)
[279.352574] [056/133] (741s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[279.477528] Starting subtest: cursor-vs-flip-toggle
[310.105436] Subtest cursor-vs-flip-toggle: SUCCESS (30.625s)
[310.975893] [057/133] (709s left) kms_psr (fbc-psr-cursor-blt)
[311.082162] Starting subtest: fbc-psr-cursor-blt
[311.084448] Starting dynamic subtest: eDP-1
[311.088839] Dynamic subtest eDP-1: SKIP (0.000s)
[311.093238] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[311.163218] [058/133] (709s left) gem_ctx_exec (basic)
[311.227487] Starting subtest: basic
[311.232387] Subtest basic: SUCCESS (0.006s)
[311.389919] [059/133] (709s left) gem_sync (basic-store-all)
[311.474020] Starting subtest: basic-store-all
[315.961931] Subtest basic-store-all: SUCCESS (4.493s)
[316.157754] [060/133] (704s left) kms_flip (2x-blocking-wf_vblank)
[316.256171] Starting subtest: 2x-blocking-wf_vblank
[316.264541] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[316.374684] [061/133] (704s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[316.466208] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[316.468512] Starting dynamic subtest: pipe-A-eDP-1
[316.490853] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.503461] Starting dynamic subtest: pipe-B-eDP-1
[316.524786] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.532810] Starting dynamic subtest: pipe-C-eDP-1
[316.554126] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.561901] Starting dynamic subtest: pipe-D-eDP-1
[316.583491] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.587887] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[318.767026] [062/133] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[318.871655] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[318.875717] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[319.009120] [063/133] (702s left) gem_ctx_persistence (idempotent)
[319.064061] Starting subtest: idempotent
[319.066293] Subtest idempotent: SUCCESS (0.000s)
[319.192584] [064/133] (701s left) gem_flink_basic (basic)
[319.238868] Starting subtest: basic
[319.240756] Subtest basic: SUCCESS (0.000s)
[319.371961] [065/133] (701s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[319.462978] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[319.490262] Starting dynamic subtest: pipe-A-plane-0
[319.911866] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[319.919796] Starting dynamic subtest: pipe-A-plane-3
[320.189935] Dynamic subtest pipe-A-plane-3: SUCCESS (0.277s)
[320.200637] Starting dynamic subtest: pipe-A-plane-5
[320.204298] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[321.251648] Starting dynamic subtest: pipe-B-plane-0
[321.677474] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[321.688196] Starting dynamic subtest: pipe-B-plane-3
[321.933715] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[321.950995] Starting dynamic subtest: pipe-B-plane-5
[321.955870] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[322.244685] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.782s)
[323.139856] [066/133] (698s left) kms_cursor_crc (cursor-random-512x512)
[323.439060] Starting subtest: cursor-random-512x512
[323.443884] Subtest cursor-random-512x512: SKIP (0.001s)
[323.646356] [067/133] (697s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[324.030157] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[324.820911] [068/133] (696s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[324.936772] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[324.941184] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[325.044223] [069/133] (696s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[325.141354] Starting subtest: psr-rgb565-draw-render
[332.204440] Subtest psr-rgb565-draw-render: SUCCESS (7.065s)
[332.352567] [070/133] (689s left) perf (unprivileged-single-ctx-counters)
[332.480158] Starting subtest: unprivileged-single-ctx-counters
[332.484700] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[332.524939] [071/133] (688s left) kms_cursor_edge_walk (128x128-top-edge)
[332.618886] Starting subtest: 128x128-top-edge
[332.621129] Starting dynamic subtest: pipe-A-eDP-1
[336.031247] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.410s)
[336.040722] Starting dynamic subtest: pipe-D-eDP-1
[339.164981] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[339.167235] Subtest 128x128-top-edge: SUCCESS (6.545s)
[339.980383] [072/133] (681s left) i915_drm_fdinfo (memory-info-resident)
[340.022459] Starting subtest: memory-info-resident
[340.024632] Starting dynamic subtest: smem0
[342.771425] Dynamic subtest smem0: SUCCESS (2.751s)
[342.773735] Subtest memory-info-resident: SUCCESS (2.752s)
[342.858410] [073/133] (678s left) kms_pm_rpm (dpms-lpsp)
[345.100406] Starting subtest: dpms-lpsp
[345.405413] Subtest dpms-lpsp: SUCCESS (0.305s)
[345.514517] [074/133] (676s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[345.635601] Starting subtest: cursorA-vs-flipA-legacy
[356.771996] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.136s)
[357.600102] [075/133] (663s left) gen9_exec_parse (allowed-single)
[357.660670] Subtest allowed-single: SKIP (0.000s)
[357.723701] [076/133] (663s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[357.810309] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[357.812640] Starting dynamic subtest: pipe-A-eDP-1
[357.835603] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.846716] Starting dynamic subtest: pipe-B-eDP-1
[357.868124] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.877734] Starting dynamic subtest: pipe-C-eDP-1
[357.898516] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.906377] Starting dynamic subtest: pipe-D-eDP-1
[357.927978] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.932277] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[359.962218] [077/133] (661s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[360.061700] Starting subtest: 4-tiled-32bpp-rotate-180
[361.441878] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.379s)
[361.623547] [078/133] (660s left) kms_lease (simple-lease)
[361.730126] Starting subtest: simple-lease
[361.732091] Starting dynamic subtest: pipe-A-eDP-1
[362.232941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.503s)
[362.243376] Starting dynamic subtest: pipe-B-eDP-1
[363.676044] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[363.685085] Starting dynamic subtest: pipe-C-eDP-1
[365.068645] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[365.077262] Starting dynamic subtest: pipe-D-eDP-1
[366.481241] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.412s)
[366.483629] Subtest simple-lease: SUCCESS (4.752s)
[367.298483] [079/133] (654s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[367.414222] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[367.418315] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[367.523201] [080/133] (654s left) gem_userptr_blits (create-destroy-sync)
[367.589095] Starting subtest: create-destroy-sync
[372.606275] Subtest create-destroy-sync: SUCCESS (5.017s)
[372.768278] [081/133] (649s left) gem_exec_whisper (basic-queues-priority)
[372.836692] Starting subtest: basic-queues-priority
[395.914096] Subtest basic-queues-priority: SUCCESS (23.072s)
[396.109732] [082/133] (625s left) gem_exec_fence (expired-history)
[396.588577] Starting subtest: expired-history
[403.662357] Subtest expired-history: SUCCESS (7.075s)
[404.170718] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[404.174042] [083/133] (617s left) gem_exec_gttfill (all-engines)
[404.248703] Starting subtest: all-engines
[428.084041] Subtest all-engines: SUCCESS (23.834s)
[428.297557] [084/133] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[428.451113] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[435.767971] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.320s)
[435.936116] [085/133] (586s left) syncobj_timeline (reset-during-wait-for-submit)
[436.002885] Starting subtest: reset-during-wait-for-submit
[436.105888] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[436.197116] [086/133] (585s left) kms_vblank (query-forked)
[436.281075] Starting subtest: query-forked
[436.282963] Starting dynamic subtest: pipe-A-eDP-1
[438.091059] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[438.105190] Starting dynamic subtest: pipe-D-eDP-1
[440.600506] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.504s)
[440.602421] Subtest query-forked: SUCCESS (4.318s)
[441.454211] [087/133] (580s left) i915_selftest (mock)
[445.076057] Starting subtest: mock
[445.078877] Starting dynamic subtest: sanitycheck
[445.829069] Dynamic subtest sanitycheck: SUCCESS (0.752s)
[445.838780] Starting dynamic subtest: shmem
[446.558919] Dynamic subtest shmem: SUCCESS (0.728s)
[446.568501] Starting dynamic subtest: fence
[454.071382] Dynamic subtest fence: SUCCESS (7.509s)
[454.086105] Starting dynamic subtest: scatterlist
[455.845520] Dynamic subtest scatterlist: SUCCESS (1.772s)
[455.855112] Starting dynamic subtest: syncmap
[459.163461] Dynamic subtest syncmap: SUCCESS (3.315s)
[459.171736] Starting dynamic subtest: uncore
[459.909239] Dynamic subtest uncore: SUCCESS (0.745s)
[459.918748] Starting dynamic subtest: ring
[460.656176] Dynamic subtest ring: SUCCESS (0.745s)
[460.664342] Starting dynamic subtest: engine
[461.398213] Dynamic subtest engine: SUCCESS (0.740s)
[461.408173] Starting dynamic subtest: timelines
[465.278291] Dynamic subtest timelines: SUCCESS (3.877s)
[465.287610] Starting dynamic subtest: requests
[468.586213] Dynamic subtest requests: SUCCESS (3.305s)
[468.595806] Starting dynamic subtest: objects
[469.378168] Dynamic subtest objects: SUCCESS (0.791s)
[469.387894] Starting dynamic subtest: phys
[470.191128] Dynamic subtest phys: SUCCESS (0.811s)
[470.200388] Starting dynamic subtest: dmabuf
[471.006196] Dynamic subtest dmabuf: SUCCESS (0.813s)
[471.015655] Starting dynamic subtest: vma
[476.497392] Dynamic subtest vma: SUCCESS (5.488s)
[476.507187] Starting dynamic subtest: evict
[477.948817] Dynamic subtest evict: SUCCESS (1.449s)
[477.958497] Starting dynamic subtest: gtt
[481.151772] Dynamic subtest gtt: SUCCESS (3.200s)
[481.161169] Starting dynamic subtest: hugepages
[482.112123] Dynamic subtest hugepages: SUCCESS (0.958s)
[482.122089] Starting dynamic subtest: memory_region
[484.629192] Dynamic subtest memory_region: SUCCESS (2.515s)
[484.631975] Subtest mock: SUCCESS (39.552s)
[484.690462] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[484.691166] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[484.694258] [088/133] (537s left) perf_pmu (busy-check-all)
[486.174807] Starting subtest: busy-check-all
[486.177096] Starting dynamic subtest: rcs0
[486.753961] Dynamic subtest rcs0: SUCCESS (0.578s)
[486.765891] Starting dynamic subtest: bcs0
[487.303711] Dynamic subtest bcs0: SUCCESS (0.548s)
[487.314603] Starting dynamic subtest: vcs0
[488.921310] Dynamic subtest vcs0: SUCCESS (1.613s)
[488.932329] Starting dynamic subtest: vcs1
[490.902554] Dynamic subtest vcs1: SUCCESS (1.979s)
[490.914293] Starting dynamic subtest: vecs0
[492.886534] Dynamic subtest vecs0: SUCCESS (1.980s)
[492.898099] Starting dynamic subtest: ccs0
[493.441095] Dynamic subtest ccs0: SUCCESS (0.552s)
[493.443677] Subtest busy-check-all: SUCCESS (7.267s)
[493.518946] [FACT perf_pmu (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[493.520109] [FACT perf_pmu (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[493.523787] [089/133] (528s left) gem_exec_params (no-blt)
[493.588870] Starting subtest: no-blt
[493.593856] Subtest no-blt: SUCCESS (0.003s)
[493.757464] [090/133] (528s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[493.849301] Starting subtest: basic-max-pipe-crc-check
[493.854099] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[493.893292] [091/133] (528s left) perf (gen8-unprivileged-single-ctx-counters)
[494.031618] Starting subtest: gen8-unprivileged-single-ctx-counters
[494.036043] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[494.071966] [092/133] (528s left) kms_rotation_crc (cursor-rotation-180)
[494.170925] Starting subtest: cursor-rotation-180
[495.633854] Subtest cursor-rotation-180: SUCCESS (1.464s)
[496.867844] [093/133] (525s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[496.976497] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[496.980987] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[497.101423] [094/133] (525s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[497.203407] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[497.207740] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[497.319647] [095/133] (525s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[497.372292] Starting subtest: framebuffer-vs-set-tiling
[497.376850] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[497.526445] [096/133] (524s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[498.053721] Starting subtest: syncobj-timeline-multiple-ext-nodes
[498.055606] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[500.003834] [097/133] (522s left) kms_flip (2x-nonexisting-fb-interruptible)
[500.110054] Starting subtest: 2x-nonexisting-fb-interruptible
[500.121463] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[500.259895] [098/133] (522s left) kms_psr (psr2-sprite-plane-move)
[500.364971] Starting subtest: psr2-sprite-plane-move
[500.367269] Starting dynamic subtest: eDP-1
[502.193356] Dynamic subtest eDP-1: SUCCESS (1.822s)
[502.196436] Subtest psr2-sprite-plane-move: SUCCESS (1.823s)
[503.039922] [099/133] (519s left) kms_psr (fbc-psr2-cursor-plane-move)
[503.142696] Starting subtest: fbc-psr2-cursor-plane-move
[503.144986] Starting dynamic subtest: eDP-1
[503.149087] Dynamic subtest eDP-1: SKIP (0.000s)
[503.153230] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[503.225814] [100/133] (519s left) kms_rotation_crc (bad-pixel-format)
[503.330760] Starting subtest: bad-pixel-format
[503.335100] Subtest bad-pixel-format: SKIP (0.001s)
[503.413813] [101/133] (519s left) kms_invalid_mode (bad-vsync-end)
[503.513675] Starting subtest: bad-vsync-end
[503.516037] Starting dynamic subtest: pipe-A-eDP-1
[503.813639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[503.822820] Starting dynamic subtest: pipe-B-eDP-1
[503.825149] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[503.833240] Starting dynamic subtest: pipe-C-eDP-1
[503.835537] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[503.843562] Starting dynamic subtest: pipe-D-eDP-1
[503.845893] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[503.848298] Subtest bad-vsync-end: SUCCESS (0.307s)
[504.674629] [102/133] (517s left) gem_exec_schedule (preempt-user)
[504.742440] Starting subtest: preempt-user
[504.744824] Starting dynamic subtest: rcs0
[504.755377] Dynamic subtest rcs0: SUCCESS (0.023s)
[504.765813] Starting dynamic subtest: bcs0
[504.774720] Dynamic subtest bcs0: SUCCESS (0.019s)
[504.782981] Starting dynamic subtest: vcs0
[504.797258] Dynamic subtest vcs0: SUCCESS (0.022s)
[504.810939] Starting dynamic subtest: vcs1
[504.827780] Dynamic subtest vcs1: SUCCESS (0.029s)
[504.840747] Starting dynamic subtest: vecs0
[504.847338] Dynamic subtest vecs0: SUCCESS (0.019s)
[504.855775] Starting dynamic subtest: ccs0
[504.867027] Dynamic subtest ccs0: SUCCESS (0.019s)
[504.869437] Subtest preempt-user: SUCCESS (0.136s)
[505.990885] [103/133] (516s left) syncobj_wait (wait-zero-handles)
[506.054397] Starting subtest: wait-zero-handles
[506.056627] Subtest wait-zero-handles: SUCCESS (0.000s)
[506.188053] [104/133] (516s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[506.292447] Starting subtest: basic-flip-before-cursor-varying-size
[507.242254] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.949s)
[508.105622] [105/133] (514s left) gem_softpin (softpin)
[508.165786] Starting subtest: softpin
[540.418663] Subtest softpin: SUCCESS (32.247s)
[540.573625] [106/133] (482s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[540.701017] Starting subtest: 2x-cursor-vs-flip-legacy
[540.705490] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[540.852090] [107/133] (481s left) kms_getfb (getfb-reject-nv12)
[540.951943] Starting subtest: getfb-reject-nv12
[540.954241] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[541.069868] [108/133] (481s left) gem_ctx_persistence (engines-persistence)
[541.124477] Starting subtest: engines-persistence
[541.126840] Starting dynamic subtest: rcs0
[541.925306] Dynamic subtest rcs0: SUCCESS (0.799s)
[541.938039] Starting dynamic subtest: bcs0
[542.702348] Dynamic subtest bcs0: SUCCESS (0.774s)
[542.714619] Starting dynamic subtest: vcs0
[543.533255] Dynamic subtest vcs0: SUCCESS (0.829s)
[543.544681] Starting dynamic subtest: vcs1
[544.364234] Dynamic subtest vcs1: SUCCESS (0.829s)
[544.373767] Starting dynamic subtest: vecs0
[545.176300] Dynamic subtest vecs0: SUCCESS (0.810s)
[545.187139] Starting dynamic subtest: ccs0
[545.964680] Dynamic subtest ccs0: SUCCESS (0.786s)
[545.967097] Subtest engines-persistence: SUCCESS (4.841s)
[546.058882] [109/133] (476s left) gem_tiled_blits (basic)
[546.118643] Subtest basic: SKIP (0.000s)
[546.185319] [110/133] (476s left) kms_chamelium_color (ctm-green-to-red)
[546.299777] Subtest ctm-green-to-red: SKIP (0.000s)
[546.343049] [111/133] (476s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[546.434043] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[546.438565] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[546.521404] [112/133] (476s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[546.574791] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[546.682801] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s)
[546.769345] [113/133] (476s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[546.826189] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[546.929725] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[547.018195] [114/133] (476s left) gem_ctx_shared (disjoint-timelines)
[547.081260] Starting subtest: disjoint-timelines
[547.108692] Subtest disjoint-timelines: SUCCESS (0.027s)
[547.378393] [115/133] (475s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[547.484914] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[547.489285] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[547.567428] [116/133] (475s left) kms_properties (get_properties-sanity-atomic)
[547.666552] Starting subtest: get_properties-sanity-atomic
[547.668885] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[547.755167] [117/133] (475s left) kms_addfb_basic (basic-x-tiled-legacy)
[547.809727] Starting subtest: basic-x-tiled-legacy
[547.813974] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[547.964205] [118/133] (475s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[548.062333] Starting subtest: yf-tiled-64bpp-rotate-180
[548.066422] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[548.169807] [119/133] (475s left) kms_content_protection (lic-type-0-hdcp14)
[548.316539] Starting subtest: lic-type-0-hdcp14
[548.320203] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[548.453485] [120/133] (474s left) perf_pmu (all-busy-check-all)
[548.489074] Starting subtest: all-busy-check-all
[549.910831] Subtest all-busy-check-all: SUCCESS (1.421s)
[550.034331] [121/133] (473s left) syncobj_timeline (single-wait-all-available-submitted)
[550.098879] Starting subtest: single-wait-all-available-submitted
[550.101025] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[550.221539] [122/133] (473s left) prime_vgem (basic-write)
[550.305448] Starting subtest: basic-write
[550.318577] Subtest basic-write: SKIP (0.014s)
[550.446248] [123/133] (473s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[550.558353] Starting subtest: x-tiled-16bpp-rotate-90
[550.577785] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[550.688426] [124/133] (472s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[550.810674] Starting subtest: 2x-cursor-vs-flip-atomic
[550.815336] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[550.965619] [125/133] (472s left) gem_tiled_pread_basic (basic)
[551.020078] Subtest basic: SKIP (0.000s)
[551.091319] [126/133] (472s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[551.196414] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[551.199799] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[551.301352] [127/133] (472s left) gem_spin_batch (resubmit-all)
[551.369317] Starting subtest: resubmit-all
[551.371463] Starting dynamic subtest: rcs0
[551.380712] Dynamic subtest rcs0: SUCCESS (0.011s)
[551.392510] Starting dynamic subtest: bcs0
[551.394442] Dynamic subtest bcs0: SUCCESS (0.002s)
[551.402563] Starting dynamic subtest: vcs0
[551.404304] Dynamic subtest vcs0: SUCCESS (0.002s)
[551.413497] Starting dynamic subtest: vcs1
[551.415135] Dynamic subtest vcs1: SUCCESS (0.002s)
[551.422374] Starting dynamic subtest: vecs0
[551.424058] Dynamic subtest vecs0: SUCCESS (0.002s)
[551.431236] Starting dynamic subtest: ccs0
[551.432792] Dynamic subtest ccs0: SUCCESS (0.002s)
[551.434371] Subtest resubmit-all: SUCCESS (0.025s)
[552.968832] [128/133] (470s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[553.076414] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[560.004867] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.930s)
[560.179877] [129/133] (463s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[560.289497] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[560.294478] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[560.415412] [130/133] (463s left) gem_mmap_wc (write-read)
[560.489970] Subtest write-read: SKIP (0.000s)
[560.559392] [131/133] (463s left) perf_pmu (busy-start)
[560.601363] Starting subtest: busy-start
[560.603540] Starting dynamic subtest: rcs0
[563.152287] Dynamic subtest rcs0: SUCCESS (2.550s)
[563.164136] Starting dynamic subtest: bcs0
[565.700206] Dynamic subtest bcs0: SUCCESS (2.546s)
[565.711747] Starting dynamic subtest: vcs0
[568.917335] Dynamic subtest vcs0: SUCCESS (3.213s)
[568.927092] Starting dynamic subtest: vcs1
[572.885095] Dynamic subtest vcs1: SUCCESS (3.965s)
[572.903573] Starting dynamic subtest: vecs0
[576.916764] Dynamic subtest vecs0: SUCCESS (4.029s)
[576.928140] Starting dynamic subtest: ccs0
[579.466219] Dynamic subtest ccs0: SUCCESS (2.548s)
[579.468725] Subtest busy-start: SUCCESS (18.865s)
[579.605900] [132/133] (444s left) gem_exec_balancer (bonded-false-hang)
[579.908603] Starting subtest: bonded-false-hang
[579.913141] Subtest bonded-false-hang: SKIP (0.000s)
[580.002267] [133/133] (443s left) kms_chamelium_frames (hdmi-crc-multiple)
[580.418288] Subtest hdmi-crc-multiple: SKIP (0.000s)
[581.229898] Closing watchdogs
results: parsing output: 0/ for test: core_auth
results: parsing output: 1/ for test: gem_workarounds
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: i915_hangman
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: dmabuf
results: parsing output: 8/ for test: gem_render_copy_redux
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_busy
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: syncobj_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_pm_rpm
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_atomic
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: gem_create
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: i915_pm_rps
results: parsing output: 50/ for test: gem_busy
results: parsing output: 51/ for test: kms_dp_link_training
results: parsing output: 52/ for test: gem_unfence_active_buffers
results: parsing output: 53/ for test: kms_dsc
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_ctx_exec
results: parsing output: 58/ for test: gem_sync
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: gem_flink_basic
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: kms_cursor_edge_walk
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gen9_exec_parse
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_exec_gttfill
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: i915_selftest
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_multipipe_modeset
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_invalid_mode
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: gem_tiled_blits
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_ctx_shared
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_properties
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_content_protection
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_tiled_pread_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_spin_batch
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_chamelium_frames
Done.