[56.695144] Initializing watchdogs
[56.695213]   /dev/watchdog0
[56.709862] [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]
[56.714415] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.716841] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.720148] [001/133] (960s left) core_auth (getclient-master-drop)
[56.776263] Starting subtest: getclient-master-drop
[56.792524] Subtest getclient-master-drop: SUCCESS (0.016s)
[56.917200] [002/133] (960s left) gem_workarounds (reset)
[56.992321] Starting subtest: reset
[57.118275] Subtest reset: SUCCESS (0.127s)
[57.281651] [003/133] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[57.382599] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[57.386672] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[57.474757] [004/133] (959s left) i915_hangman (hangcheck-unterminated)
[57.540095] Starting subtest: hangcheck-unterminated
[68.851549] Subtest hangcheck-unterminated: SUCCESS (11.354s)
[68.987687] [005/133] (948s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[69.097110] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[69.099265] Starting dynamic subtest: pipe-A-eDP-1
[69.231533] Dynamic subtest pipe-A-eDP-1: SKIP (0.138s)
[69.240761] Starting dynamic subtest: pipe-B-eDP-1
[70.361211] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[70.366774] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.269s)
[71.777308] [006/133] (945s left) gem_exec_whisper (basic-normal-all)
[71.846551] Starting subtest: basic-normal-all
[74.341219] Subtest basic-normal-all: SUCCESS (2.496s)
[74.530286] [007/133] (942s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[74.622066] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[74.624431] Starting dynamic subtest: pipe-A-eDP-1
[91.092208] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.477s)
[91.102239] Starting dynamic subtest: pipe-B-eDP-1
[108.232655] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.136s)
[108.235097] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.615s)
[109.040919] [008/133] (908s left) dmabuf (all-tests)
[109.074076] Starting subtest: all-tests
[109.076346] Starting dynamic subtest: sanitycheck
[109.192425] Dynamic subtest sanitycheck: SUCCESS (0.118s)
[109.203229] Starting dynamic subtest: dma_fence
[109.450685] Dynamic subtest dma_fence: SUCCESS (0.257s)
[109.461132] Starting dynamic subtest: dma_fence_chain
[117.905894] Dynamic subtest dma_fence_chain: SUCCESS (8.454s)
[117.915844] Starting dynamic subtest: dma_fence_unwrap
[118.078410] Dynamic subtest dma_fence_unwrap: SUCCESS (0.172s)
[118.087910] Starting dynamic subtest: dma_resv
[118.218713] Dynamic subtest dma_resv: SUCCESS (0.139s)
[118.221550] Subtest all-tests: SUCCESS (9.144s)
[118.291754] [009/133] (899s left) gem_render_copy_redux (interruptible)
[118.353810] Starting subtest: interruptible
[118.783492] Subtest interruptible: SUCCESS (0.430s)
[118.949639] [010/133] (898s left) gem_exec_schedule (pi-shared-iova)
[119.141456] Starting subtest: pi-shared-iova
[119.143869] Starting dynamic subtest: rcs0
[119.294568] Dynamic subtest rcs0: SUCCESS (0.155s)
[119.303628] Starting dynamic subtest: vcs0
[119.375770] Dynamic subtest vcs0: SUCCESS (0.082s)
[119.385989] Starting dynamic subtest: vcs1
[119.458022] Dynamic subtest vcs1: SUCCESS (0.082s)
[119.467453] Starting dynamic subtest: vecs0
[119.537291] Dynamic subtest vecs0: SUCCESS (0.079s)
[119.551211] Starting dynamic subtest: ccs0
[119.656292] Dynamic subtest ccs0: SUCCESS (0.117s)
[119.658985] Subtest pi-shared-iova: SUCCESS (0.516s)
[121.048529] [011/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[121.158399] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[121.162780] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[121.281983] [012/133] (896s left) gem_render_copy (y-tiled)
[121.344883] Starting subtest: y-tiled
[121.350024] Subtest y-tiled: SKIP (0.000s)
[121.537473] [013/133] (896s left) kms_busy (basic)
[121.631244] Starting subtest: basic
[121.633647] Starting dynamic subtest: flip
[122.244629] Dynamic subtest flip: SUCCESS (0.614s)
[122.254114] Starting dynamic subtest: modeset
[125.899513] Dynamic subtest modeset: SUCCESS (3.654s)
[125.901940] Subtest basic: SUCCESS (4.270s)
[126.709611] [014/133] (891s left) kms_psr (psr2-cursor-blt)
[126.814836] Starting subtest: psr2-cursor-blt
[126.817129] Starting dynamic subtest: eDP-1
[128.500240] Dynamic subtest eDP-1: SUCCESS (1.685s)
[128.502711] Subtest psr2-cursor-blt: SUCCESS (1.686s)
[129.323344] [015/133] (888s left) kms_flip (2x-plain-flip-fb-recreate)
[129.428232] Starting subtest: 2x-plain-flip-fb-recreate
[129.437982] Subtest 2x-plain-flip-fb-recreate: SKIP (0.012s)
[129.564388] [016/133] (888s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[129.670804] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[129.674777] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[129.760684] [017/133] (888s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[129.863985] Starting subtest: fbcpsr-stridechange
[136.165915] Subtest fbcpsr-stridechange: SUCCESS (6.303s)
[136.373179] [018/133] (881s left) gem_mmap_gtt (close-race)
[136.438140] Subtest close-race: SKIP (0.000s)
[136.501289] [019/133] (881s left) perf_pmu (semaphore-wait)
[136.540524] Starting subtest: semaphore-wait
[136.542819] Starting dynamic subtest: rcs0
[137.052384] Dynamic subtest rcs0: SUCCESS (0.511s)
[137.062528] Starting dynamic subtest: bcs0
[137.564808] Dynamic subtest bcs0: SUCCESS (0.510s)
[137.576049] Starting dynamic subtest: vcs0
[138.077917] Dynamic subtest vcs0: SUCCESS (0.511s)
[138.094749] Starting dynamic subtest: vcs1
[138.590495] Dynamic subtest vcs1: SUCCESS (0.511s)
[138.601572] Starting dynamic subtest: vecs0
[139.103505] Dynamic subtest vecs0: SUCCESS (0.511s)
[139.114766] Starting dynamic subtest: ccs0
[139.618273] Dynamic subtest ccs0: SUCCESS (0.513s)
[139.621220] Subtest semaphore-wait: SUCCESS (3.078s)
[140.973441] [020/133] (876s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[141.074550] Starting subtest: primary-4-tiled-reflect-x-0
[148.210525] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.137s)
[149.407134] [021/133] (868s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[149.525723] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[150.205181] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[150.402135] [022/133] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[150.499756] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[150.504234] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[150.617747] [023/133] (867s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[150.711584] Starting subtest: plane-upscale-20x20-with-pixel-format
[150.713804] Starting dynamic subtest: pipe-A
[151.783102] Dynamic subtest pipe-A: SUCCESS (1.074s)
[151.791682] Starting dynamic subtest: pipe-B
[153.891769] Dynamic subtest pipe-B: SUCCESS (2.108s)
[153.899999] Starting dynamic subtest: pipe-C
[155.085434] Dynamic subtest pipe-C: SUCCESS (1.193s)
[155.094965] Starting dynamic subtest: pipe-D
[156.304457] Dynamic subtest pipe-D: SUCCESS (1.218s)
[156.306851] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.595s)
[157.505820] [024/133] (860s left) kms_color (ctm-negative)
[157.617015] Starting subtest: ctm-negative
[157.619238] Starting dynamic subtest: pipe-A-eDP-1
[158.350187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[158.359354] Starting dynamic subtest: pipe-B-eDP-1
[159.830820] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s)
[159.839749] Starting dynamic subtest: pipe-C-eDP-1
[161.184732] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[161.193296] Starting dynamic subtest: pipe-D-eDP-1
[162.508483] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[162.510484] Subtest ctm-negative: SUCCESS (4.892s)
[163.319935] [025/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[163.422842] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[163.427089] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[163.536175] [026/133] (854s left) kms_addfb_basic (too-wide)
[163.638162] Starting subtest: too-wide
[163.640367] Subtest too-wide: SUCCESS (0.000s)
[163.757111] [027/133] (854s left) syncobj_basic (bad-flags-fd-to-handle)
[163.818499] Starting subtest: bad-flags-fd-to-handle
[163.820731] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[163.928159] [028/133] (854s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[164.018265] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[164.020530] Starting dynamic subtest: pipe-A-eDP-1
[164.043509] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.056180] Starting dynamic subtest: pipe-B-eDP-1
[164.078110] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.086330] Starting dynamic subtest: pipe-C-eDP-1
[164.107128] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.114866] Starting dynamic subtest: pipe-D-eDP-1
[164.136427] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.140768] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[166.287398] [029/133] (852s left) kms_big_fb (linear-16bpp-rotate-270)
[166.398618] Starting subtest: linear-16bpp-rotate-270
[166.417660] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[166.567647] [030/133] (851s left) kms_pm_rpm (legacy-planes-dpms)
[168.110857] Starting subtest: legacy-planes-dpms
[168.113237] Starting dynamic subtest: plane-64
[176.411958] Dynamic subtest plane-64: SUCCESS (8.303s)
[176.423069] Starting dynamic subtest: plane-94
[184.859076] Dynamic subtest plane-94: SUCCESS (8.445s)
[184.869693] Starting dynamic subtest: plane-124
[193.130049] Dynamic subtest plane-124: SUCCESS (8.268s)
[193.141565] Starting dynamic subtest: plane-134
[201.760569] Dynamic subtest plane-134: SUCCESS (8.627s)
[201.763558] Subtest legacy-planes-dpms: SUCCESS (33.652s)
[202.138507] [031/133] (816s left) syncobj_timeline (multi-wait-all-available-signaled)
[202.201407] Starting subtest: multi-wait-all-available-signaled
[202.203396] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[202.299020] [032/133] (816s left) gem_pxp (create-regular-buffer)
[202.423592] Starting subtest: create-regular-buffer
[202.426038] Subtest create-regular-buffer: SUCCESS (0.000s)
[202.569098] [033/133] (815s left) gem_userptr_blits (sync-overlap)
[202.647278] Starting subtest: sync-overlap
[202.649536] Subtest sync-overlap: SUCCESS (0.000s)
[202.781752] [034/133] (815s left) kms_cursor_crc (cursor-offscreen-256x85)
[203.040943] Starting subtest: cursor-offscreen-256x85
[203.087734] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[203.273246] [035/133] (815s left) kms_vblank (wait-forked-hang)
[203.367391] Starting subtest: wait-forked-hang
[203.369170] Starting dynamic subtest: pipe-A-eDP-1
[229.654073] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.285s)
[229.667345] Starting dynamic subtest: pipe-D-eDP-1
[254.681120] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.023s)
[254.683292] Subtest wait-forked-hang: SUCCESS (51.312s)
[255.485186] [036/133] (763s left) gem_exec_reloc (basic-wc-active)
[255.559730] Subtest basic-wc-active: SKIP (0.000s)
[255.648273] [037/133] (762s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[255.754799] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[255.757046] Starting dynamic subtest: pipe-A-eDP-1
[255.776418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[255.785968] Starting dynamic subtest: pipe-B-eDP-1
[255.804474] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[255.812828] Starting dynamic subtest: pipe-C-eDP-1
[255.831266] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[255.839388] Starting dynamic subtest: pipe-D-eDP-1
[255.858990] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[255.861062] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[258.051208] [038/133] (760s left) kms_flip (2x-dpms-vs-vblank-race)
[258.144192] Starting subtest: 2x-dpms-vs-vblank-race
[258.153353] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[258.280160] [039/133] (760s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[258.390987] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[258.395297] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[258.475840] [040/133] (760s left) kms_atomic (plane-cursor-legacy)
[258.566354] Starting subtest: plane-cursor-legacy
[258.568640] Starting dynamic subtest: pipe-A-eDP-1
[258.958910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[258.961168] Subtest plane-cursor-legacy: SUCCESS (0.391s)
[259.784232] [041/133] (758s left) gem_partial_pwrite_pread (write-uncached)
[259.845631] Subtest write-uncached: SKIP (0.000s)
[259.918142] [042/133] (758s left) gem_create (create-ext-cpu-access-sanity-check)
[260.086669] Starting subtest: create-ext-cpu-access-sanity-check
[260.091126] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[260.168508] [043/133] (758s left) gem_mmap_gtt (zero-extend)
[260.219089] Subtest zero-extend: SKIP (0.000s)
[260.285376] [044/133] (758s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[260.378053] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[260.382263] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[260.458565] [045/133] (758s left) api_intel_allocator (fork-simple-stress)
[260.518826] Starting subtest: fork-simple-stress
[265.914865] Subtest fork-simple-stress: SUCCESS (5.397s)
[266.062223] [046/133] (752s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[266.180658] Starting subtest: y-tiled-64bpp-rotate-180
[266.185290] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[266.326694] [047/133] (752s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[266.395227] Starting subtest: yf-tiled-to-vebox-y-tiled
[266.399442] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[266.589973] [048/133] (752s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[266.697207] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[273.238975] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.544s)
[273.374447] [049/133] (745s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[273.441731] Starting subtest: protected-encrypted-src-copy-not-readible
[273.554718] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[273.680226] [050/133] (745s left) i915_pm_rps (basic-api)
[273.745692] Starting subtest: basic-api
[273.750214] Subtest basic-api: SKIP (0.001s)
[273.829228] [051/133] (745s left) gem_busy (busy)
[273.897509] Starting subtest: busy
[273.899869] Starting dynamic subtest: all-engines
[273.976894] Dynamic subtest all-engines: SUCCESS (0.079s)
[273.993612] Starting dynamic subtest: rcs0
[275.870845] Dynamic subtest rcs0: SUCCESS (1.891s)
[275.882113] Starting dynamic subtest: bcs0
[275.959723] Dynamic subtest bcs0: SUCCESS (0.063s)
[275.979310] Starting dynamic subtest: vcs0
[275.989890] Dynamic subtest vcs0: SUCCESS (0.040s)
[276.009419] Starting dynamic subtest: vcs1
[277.931654] Dynamic subtest vcs1: SUCCESS (1.932s)
[277.950918] Starting dynamic subtest: vecs0
[279.898888] Dynamic subtest vecs0: SUCCESS (1.982s)
[279.909224] Starting dynamic subtest: ccs0
[281.945970] Dynamic subtest ccs0: SUCCESS (2.047s)
[281.948428] Subtest busy: SUCCESS (8.046s)
[282.323121] [052/133] (736s left) kms_dp_link_training (non-uhbr-sst)
[282.416808] Starting subtest: non-uhbr-sst
[282.425275] Subtest non-uhbr-sst: SKIP (0.000s)
[282.502937] [053/133] (736s left) gem_unfence_active_buffers
[282.671121] [054/133] (736s left) kms_dsc (dsc-with-formats)
[282.768540] Starting subtest: dsc-with-formats
[282.808798] Subtest dsc-with-formats: SKIP (0.001s)
[282.855240] [055/133] (736s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[282.958343] Starting subtest: plane-downscale-factor-0-75-with-rotation
[282.960675] Starting dynamic subtest: pipe-A
[283.186660] Dynamic subtest pipe-A: SUCCESS (0.231s)
[283.195903] Starting dynamic subtest: pipe-B
[284.462853] Dynamic subtest pipe-B: SUCCESS (1.275s)
[284.476708] Starting dynamic subtest: pipe-C
[285.806312] Dynamic subtest pipe-C: SUCCESS (1.342s)
[285.816715] Starting dynamic subtest: pipe-D
[287.117278] Dynamic subtest pipe-D: SUCCESS (1.310s)
[287.119693] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.162s)
[288.308129] [056/133] (731s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[288.449060] Starting subtest: cursor-vs-flip-toggle
[319.326525] Subtest cursor-vs-flip-toggle: SUCCESS (30.877s)
[320.150438] [057/133] (699s left) kms_psr (fbc-psr-cursor-blt)
[320.270232] Starting subtest: fbc-psr-cursor-blt
[320.272624] Starting dynamic subtest: eDP-1
[320.276936] Dynamic subtest eDP-1: SKIP (0.000s)
[320.281299] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[320.358759] [058/133] (699s left) gem_ctx_exec (basic)
[320.413230] Starting subtest: basic
[320.418762] Subtest basic: SUCCESS (0.008s)
[320.560897] [059/133] (698s left) gem_sync (basic-store-all)
[320.629280] Starting subtest: basic-store-all
[325.009114] Subtest basic-store-all: SUCCESS (4.392s)
[325.202043] [060/133] (694s left) kms_flip (2x-blocking-wf_vblank)
[325.295959] Starting subtest: 2x-blocking-wf_vblank
[325.306075] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[325.440474] [061/133] (694s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[325.539085] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[325.541398] Starting dynamic subtest: pipe-A-eDP-1
[325.563436] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[325.573980] Starting dynamic subtest: pipe-B-eDP-1
[325.594761] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[325.603265] Starting dynamic subtest: pipe-C-eDP-1
[325.624134] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[325.632293] Starting dynamic subtest: pipe-D-eDP-1
[325.654422] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[325.658373] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[327.800214] [062/133] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[327.913566] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[327.917935] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[328.051877] [063/133] (691s left) gem_ctx_persistence (idempotent)
[328.115703] Starting subtest: idempotent
[328.118181] Subtest idempotent: SUCCESS (0.000s)
[328.249622] [064/133] (691s left) gem_flink_basic (basic)
[328.306288] Starting subtest: basic
[328.308596] Subtest basic: SUCCESS (0.000s)
[328.447657] [065/133] (691s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[328.540135] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[328.566396] Starting dynamic subtest: pipe-A-plane-0
[328.987354] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[328.997891] Starting dynamic subtest: pipe-A-plane-3
[329.254219] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[329.262648] Starting dynamic subtest: pipe-A-plane-5
[329.266330] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[330.386477] Starting dynamic subtest: pipe-B-plane-0
[330.797125] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[330.806119] Starting dynamic subtest: pipe-B-plane-3
[331.052641] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[331.062634] Starting dynamic subtest: pipe-B-plane-5
[331.067223] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[331.363829] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.822s)
[332.166419] [066/133] (687s left) kms_cursor_crc (cursor-random-512x512)
[332.449202] Starting subtest: cursor-random-512x512
[332.454264] Subtest cursor-random-512x512: SKIP (0.001s)
[332.631304] [067/133] (687s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[333.030093] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[333.871020] [068/133] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[333.982841] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[333.987217] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[334.088345] [069/133] (685s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[334.190555] Starting subtest: psr-rgb565-draw-render
[341.264453] Subtest psr-rgb565-draw-render: SUCCESS (7.076s)
[341.399145] [070/133] (678s left) perf (unprivileged-single-ctx-counters)
[341.529366] Starting subtest: unprivileged-single-ctx-counters
[341.533603] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[341.571810] [071/133] (678s left) kms_cursor_edge_walk (128x128-top-edge)
[341.668378] Starting subtest: 128x128-top-edge
[341.670628] Starting dynamic subtest: pipe-A-eDP-1
[345.070446] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.401s)
[345.079885] Starting dynamic subtest: pipe-D-eDP-1
[348.198601] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[348.200780] Subtest 128x128-top-edge: SUCCESS (6.531s)
[349.024958] [072/133] (670s left) i915_drm_fdinfo (memory-info-resident)
[349.062385] Starting subtest: memory-info-resident
[349.064303] Starting dynamic subtest: smem0
[351.736175] Dynamic subtest smem0: SUCCESS (2.676s)
[351.738212] Subtest memory-info-resident: SUCCESS (2.677s)
[351.820267] [073/133] (668s left) kms_pm_rpm (dpms-lpsp)
[354.056231] Starting subtest: dpms-lpsp
[354.368921] Subtest dpms-lpsp: SUCCESS (0.318s)
[354.490148] [074/133] (665s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[354.614056] Starting subtest: cursorA-vs-flipA-legacy
[365.739028] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.123s)
[366.577260] [075/133] (653s left) gen9_exec_parse (allowed-single)
[366.637538] Subtest allowed-single: SKIP (0.000s)
[366.693831] [076/133] (653s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[366.787857] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[366.790593] Starting dynamic subtest: pipe-A-eDP-1
[366.814351] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[366.825510] Starting dynamic subtest: pipe-B-eDP-1
[366.847981] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[366.858495] Starting dynamic subtest: pipe-C-eDP-1
[366.879470] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[366.888104] Starting dynamic subtest: pipe-D-eDP-1
[366.909813] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[366.913818] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.005s)
[369.039550] [077/133] (651s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[369.156757] Starting subtest: 4-tiled-32bpp-rotate-180
[370.525668] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.368s)
[370.691946] [078/133] (649s left) kms_lease (simple-lease)
[370.801548] Starting subtest: simple-lease
[370.803698] Starting dynamic subtest: pipe-A-eDP-1
[371.304830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[371.313837] Starting dynamic subtest: pipe-B-eDP-1
[372.796078] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s)
[372.804863] Starting dynamic subtest: pipe-C-eDP-1
[374.198886] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[374.208228] Starting dynamic subtest: pipe-D-eDP-1
[375.607666] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[375.609913] Subtest simple-lease: SUCCESS (4.808s)
[376.431053] [079/133] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[376.544459] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[376.549043] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[376.679449] [080/133] (643s left) gem_userptr_blits (create-destroy-sync)
[376.761878] Starting subtest: create-destroy-sync
[381.776039] Subtest create-destroy-sync: SUCCESS (5.012s)
[381.941109] [081/133] (638s left) gem_exec_whisper (basic-queues-priority)
[382.007914] Starting subtest: basic-queues-priority
[404.894218] Subtest basic-queues-priority: SUCCESS (22.882s)
[405.087805] [082/133] (615s left) gem_exec_fence (expired-history)
[405.554978] Starting subtest: expired-history
[412.632034] Subtest expired-history: SUCCESS (7.077s)
[413.459749] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[413.464130] [083/133] (606s left) gem_exec_gttfill (all-engines)
[413.553669] Starting subtest: all-engines
[437.349398] Subtest all-engines: SUCCESS (23.793s)
[437.552930] [084/133] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[437.693840] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[445.074654] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.382s)
[445.245270] [085/133] (575s left) syncobj_timeline (reset-during-wait-for-submit)
[445.326057] Starting subtest: reset-during-wait-for-submit
[445.428115] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[445.523859] [086/133] (575s left) kms_vblank (query-forked)
[445.620165] Starting subtest: query-forked
[445.622055] Starting dynamic subtest: pipe-A-eDP-1
[447.457256] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.835s)
[447.471992] Starting dynamic subtest: pipe-D-eDP-1
[450.016335] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[450.018678] Subtest query-forked: SUCCESS (4.398s)
[450.839078] [087/133] (569s left) i915_selftest (mock)
[454.408070] Starting subtest: mock
[454.410555] Starting dynamic subtest: sanitycheck
[455.146190] Dynamic subtest sanitycheck: SUCCESS (0.737s)
[455.155342] Starting dynamic subtest: shmem
[455.923298] Dynamic subtest shmem: SUCCESS (0.775s)
[455.933032] Starting dynamic subtest: fence
[464.099258] Dynamic subtest fence: SUCCESS (8.173s)
[464.114018] Starting dynamic subtest: scatterlist
[465.864508] Dynamic subtest scatterlist: SUCCESS (1.763s)
[465.874261] Starting dynamic subtest: syncmap
[469.184562] Dynamic subtest syncmap: SUCCESS (3.317s)
[469.194366] Starting dynamic subtest: uncore
[469.949331] Dynamic subtest uncore: SUCCESS (0.763s)
[469.958987] Starting dynamic subtest: ring
[470.663062] Dynamic subtest ring: SUCCESS (0.712s)
[470.672688] Starting dynamic subtest: engine
[471.435195] Dynamic subtest engine: SUCCESS (0.770s)
[471.444907] Starting dynamic subtest: timelines
[475.340434] Dynamic subtest timelines: SUCCESS (3.902s)
[475.355504] Starting dynamic subtest: requests
[478.686357] Dynamic subtest requests: SUCCESS (3.343s)
[478.695857] Starting dynamic subtest: objects
[479.571417] Dynamic subtest objects: SUCCESS (0.883s)
[479.581053] Starting dynamic subtest: phys
[480.442297] Dynamic subtest phys: SUCCESS (0.869s)
[480.451847] Starting dynamic subtest: dmabuf
[481.306964] Dynamic subtest dmabuf: SUCCESS (0.863s)
[481.316662] Starting dynamic subtest: vma
[486.876319] Dynamic subtest vma: SUCCESS (5.566s)
[486.885782] Starting dynamic subtest: evict
[488.385215] Dynamic subtest evict: SUCCESS (1.507s)
[488.399986] Starting dynamic subtest: gtt
[491.678783] Dynamic subtest gtt: SUCCESS (3.292s)
[491.687469] Starting dynamic subtest: hugepages
[492.725782] Dynamic subtest hugepages: SUCCESS (1.044s)
[492.734904] Starting dynamic subtest: memory_region
[495.386536] Dynamic subtest memory_region: SUCCESS (2.658s)
[495.389124] Subtest mock: SUCCESS (40.977s)
[495.420096] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[495.420864] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[495.424177] [088/133] (525s left) perf_pmu (busy-check-all)
[496.895712] Starting subtest: busy-check-all
[496.897792] Starting dynamic subtest: rcs0
[497.479356] Dynamic subtest rcs0: SUCCESS (0.584s)
[497.490996] Starting dynamic subtest: bcs0
[498.031389] Dynamic subtest bcs0: SUCCESS (0.551s)
[498.042673] Starting dynamic subtest: vcs0
[499.928512] Dynamic subtest vcs0: SUCCESS (1.893s)
[499.940566] Starting dynamic subtest: vcs1
[501.910086] Dynamic subtest vcs1: SUCCESS (1.978s)
[501.921794] Starting dynamic subtest: vecs0
[503.891077] Dynamic subtest vecs0: SUCCESS (1.979s)
[503.902181] Starting dynamic subtest: ccs0
[504.443379] Dynamic subtest ccs0: SUCCESS (0.550s)
[504.446073] Subtest busy-check-all: SUCCESS (7.551s)
[504.565855] [FACT perf_pmu (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[504.567085] [FACT perf_pmu (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[504.570435] [089/133] (516s left) gem_exec_params (no-blt)
[504.638786] Starting subtest: no-blt
[504.641453] Subtest no-blt: SUCCESS (0.002s)
[504.778303] [090/133] (515s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[504.880977] Starting subtest: basic-max-pipe-crc-check
[504.885332] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[504.934274] [091/133] (515s left) perf (gen8-unprivileged-single-ctx-counters)
[505.068067] Starting subtest: gen8-unprivileged-single-ctx-counters
[505.072243] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[505.107533] [092/133] (515s left) kms_rotation_crc (cursor-rotation-180)
[505.203621] Starting subtest: cursor-rotation-180
[506.791700] Subtest cursor-rotation-180: SUCCESS (1.589s)
[508.003117] [093/133] (512s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[508.103032] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[508.107325] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[508.222226] [094/133] (512s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[508.326873] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[508.330955] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[508.458611] [095/133] (512s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[508.527279] Starting subtest: framebuffer-vs-set-tiling
[508.531864] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[508.688413] [096/133] (512s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[509.213295] Starting subtest: syncobj-timeline-multiple-ext-nodes
[509.215934] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[511.008679] [097/133] (510s left) kms_flip (2x-nonexisting-fb-interruptible)
[511.106107] Starting subtest: 2x-nonexisting-fb-interruptible
[511.118088] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[511.207684] [098/133] (509s left) kms_psr (psr2-sprite-plane-move)
[511.287281] Starting subtest: psr2-sprite-plane-move
[511.289527] Starting dynamic subtest: eDP-1
[513.020233] Dynamic subtest eDP-1: SUCCESS (1.733s)
[513.022599] Subtest psr2-sprite-plane-move: SUCCESS (1.735s)
[513.883757] [099/133] (507s left) kms_psr (fbc-psr2-cursor-plane-move)
[513.982387] Starting subtest: fbc-psr2-cursor-plane-move
[513.984631] Starting dynamic subtest: eDP-1
[513.988829] Dynamic subtest eDP-1: SKIP (0.000s)
[513.993164] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[514.078734] [100/133] (507s left) kms_rotation_crc (bad-pixel-format)
[514.178948] Starting subtest: bad-pixel-format
[514.183295] Subtest bad-pixel-format: SKIP (0.001s)
[514.260405] [101/133] (506s left) kms_invalid_mode (bad-vsync-end)
[514.366169] Starting subtest: bad-vsync-end
[514.368353] Starting dynamic subtest: pipe-A-eDP-1
[514.665542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.300s)
[514.674080] Starting dynamic subtest: pipe-B-eDP-1
[514.675898] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[514.683289] Starting dynamic subtest: pipe-C-eDP-1
[514.685200] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[514.693299] Starting dynamic subtest: pipe-D-eDP-1
[514.695470] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[514.697635] Subtest bad-vsync-end: SUCCESS (0.309s)
[515.504991] [102/133] (505s left) gem_exec_schedule (preempt-user)
[515.591315] Starting subtest: preempt-user
[515.593650] Starting dynamic subtest: rcs0
[515.605345] Dynamic subtest rcs0: SUCCESS (0.023s)
[515.617183] Starting dynamic subtest: bcs0
[515.625908] Dynamic subtest bcs0: SUCCESS (0.020s)
[515.636278] Starting dynamic subtest: vcs0
[515.648946] Dynamic subtest vcs0: SUCCESS (0.022s)
[515.657378] Starting dynamic subtest: vcs1
[515.668817] Dynamic subtest vcs1: SUCCESS (0.019s)
[515.677582] Starting dynamic subtest: vecs0
[515.687800] Dynamic subtest vecs0: SUCCESS (0.018s)
[515.698266] Starting dynamic subtest: ccs0
[515.708717] Dynamic subtest ccs0: SUCCESS (0.020s)
[515.710967] Subtest preempt-user: SUCCESS (0.128s)
[516.984459] [103/133] (504s left) syncobj_wait (wait-zero-handles)
[517.046486] Starting subtest: wait-zero-handles
[517.048456] Subtest wait-zero-handles: SUCCESS (0.000s)
[517.157294] [104/133] (504s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[517.285490] Starting subtest: basic-flip-before-cursor-varying-size
[518.242287] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.955s)
[519.125169] [105/133] (502s left) gem_softpin (softpin)
[519.192598] Starting subtest: softpin
[551.498820] Subtest softpin: SUCCESS (32.300s)
[551.643463] [106/133] (469s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[551.765523] Starting subtest: 2x-cursor-vs-flip-legacy
[551.769876] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[551.920877] [107/133] (469s left) kms_getfb (getfb-reject-nv12)
[552.011834] Starting subtest: getfb-reject-nv12
[552.013973] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[552.127525] [108/133] (469s left) gem_ctx_persistence (engines-persistence)
[552.176365] Starting subtest: engines-persistence
[552.178607] Starting dynamic subtest: rcs0
[553.003324] Dynamic subtest rcs0: SUCCESS (0.826s)
[553.016117] Starting dynamic subtest: bcs0
[553.826870] Dynamic subtest bcs0: SUCCESS (0.821s)
[553.838543] Starting dynamic subtest: vcs0
[554.583966] Dynamic subtest vcs0: SUCCESS (0.755s)
[554.594807] Starting dynamic subtest: vcs1
[555.361837] Dynamic subtest vcs1: SUCCESS (0.776s)
[555.373829] Starting dynamic subtest: vecs0
[556.121637] Dynamic subtest vecs0: SUCCESS (0.758s)
[556.130502] Starting dynamic subtest: ccs0
[556.891871] Dynamic subtest ccs0: SUCCESS (0.768s)
[556.894683] Subtest engines-persistence: SUCCESS (4.716s)
[556.984681] [109/133] (464s left) gem_tiled_blits (basic)
[557.048589] Subtest basic: SKIP (0.000s)
[557.124924] [110/133] (464s left) kms_chamelium_color (ctm-green-to-red)
[557.222623] Subtest ctm-green-to-red: SKIP (0.000s)
[557.277835] [111/133] (464s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[557.376149] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[557.380204] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[557.456691] [112/133] (464s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[557.518579] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[557.624459] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[557.718277] [113/133] (463s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[557.782505] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[557.888644] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[557.978620] [114/133] (463s left) gem_ctx_shared (disjoint-timelines)
[558.041139] Starting subtest: disjoint-timelines
[558.067677] Subtest disjoint-timelines: SUCCESS (0.026s)
[558.334388] [115/133] (463s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[558.424119] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[558.428482] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[558.507115] [116/133] (463s left) kms_properties (get_properties-sanity-atomic)
[558.602312] Starting subtest: get_properties-sanity-atomic
[558.604508] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[558.691796] [117/133] (463s left) kms_addfb_basic (basic-x-tiled-legacy)
[558.752570] Starting subtest: basic-x-tiled-legacy
[558.756883] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[558.908613] [118/133] (462s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[559.011911] Starting subtest: yf-tiled-64bpp-rotate-180
[559.016417] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[559.138095] [119/133] (462s left) kms_content_protection (lic-type-0-hdcp14)
[559.285565] Starting subtest: lic-type-0-hdcp14
[559.289553] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[559.428394] [120/133] (462s left) perf_pmu (all-busy-check-all)
[559.468689] Starting subtest: all-busy-check-all
[560.918027] Subtest all-busy-check-all: SUCCESS (1.447s)
[561.055936] [121/133] (460s left) syncobj_timeline (single-wait-all-available-submitted)
[561.108594] Starting subtest: single-wait-all-available-submitted
[561.110956] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[561.230508] [122/133] (460s left) prime_vgem (basic-write)
[561.335977] Starting subtest: basic-write
[561.346801] Subtest basic-write: SKIP (0.011s)
[561.490549] [123/133] (460s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[561.600967] Starting subtest: x-tiled-16bpp-rotate-90
[561.621588] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[561.778899] [124/133] (460s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[561.903415] Starting subtest: 2x-cursor-vs-flip-atomic
[561.907807] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[562.068277] [125/133] (460s left) gem_tiled_pread_basic (basic)
[562.129756] Subtest basic: SKIP (0.000s)
[562.200399] [126/133] (460s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[562.301355] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[562.304742] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[562.421499] [127/133] (459s left) gem_spin_batch (resubmit-all)
[562.483816] Starting subtest: resubmit-all
[562.485831] Starting dynamic subtest: rcs0
[562.494483] Dynamic subtest rcs0: SUCCESS (0.011s)
[562.504512] Starting dynamic subtest: bcs0
[562.506381] Dynamic subtest bcs0: SUCCESS (0.003s)
[562.514061] Starting dynamic subtest: vcs0
[562.515555] Dynamic subtest vcs0: SUCCESS (0.002s)
[562.522885] Starting dynamic subtest: vcs1
[562.524478] Dynamic subtest vcs1: SUCCESS (0.002s)
[562.532054] Starting dynamic subtest: vecs0
[562.533676] Dynamic subtest vecs0: SUCCESS (0.002s)
[562.542281] Starting dynamic subtest: ccs0
[562.543777] Dynamic subtest ccs0: SUCCESS (0.002s)
[562.545335] Subtest resubmit-all: SUCCESS (0.025s)
[563.973474] [128/133] (458s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[564.078781] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[570.983938] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.906s)
[571.154435] [129/133] (451s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[571.261109] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[571.265366] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[571.356027] [130/133] (451s left) gem_mmap_wc (write-read)
[571.405056] Subtest write-read: SKIP (0.000s)
[571.465213] [131/133] (450s left) perf_pmu (busy-start)
[571.503891] Starting subtest: busy-start
[571.505815] Starting dynamic subtest: rcs0
[574.051532] Dynamic subtest rcs0: SUCCESS (2.549s)
[574.063192] Starting dynamic subtest: bcs0
[576.600518] Dynamic subtest bcs0: SUCCESS (2.546s)
[576.612364] Starting dynamic subtest: vcs0
[579.923761] Dynamic subtest vcs0: SUCCESS (3.320s)
[579.935317] Starting dynamic subtest: vcs1
[583.891766] Dynamic subtest vcs1: SUCCESS (3.966s)
[583.903915] Starting dynamic subtest: vecs0
[587.923888] Dynamic subtest vecs0: SUCCESS (4.030s)
[587.935735] Starting dynamic subtest: ccs0
[590.473821] Dynamic subtest ccs0: SUCCESS (2.549s)
[590.476474] Subtest busy-start: SUCCESS (18.972s)
[590.596299] [132/133] (431s left) gem_exec_balancer (bonded-false-hang)
[590.869662] Starting subtest: bonded-false-hang
[590.874901] Subtest bonded-false-hang: SKIP (0.000s)
[591.013634] [133/133] (431s left) kms_chamelium_frames (hdmi-crc-multiple)
[591.418660] Subtest hdmi-crc-multiple: SKIP (0.000s)
[592.244764] 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.