[58.015203] Initializing watchdogs
[58.015278]   /dev/watchdog0
[58.029450] [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.033589] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.035783] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.039186] [001/133] (960s left) core_auth (getclient-master-drop)
[58.099212] Starting subtest: getclient-master-drop
[58.121899] Subtest getclient-master-drop: SUCCESS (0.024s)
[58.250724] [002/133] (960s left) gem_workarounds (reset)
[58.315951] Starting subtest: reset
[58.426057] Subtest reset: SUCCESS (0.110s)
[58.593020] [003/133] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[58.689827] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[58.693927] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[58.783309] [004/133] (959s left) i915_hangman (hangcheck-unterminated)
[58.851982] Starting subtest: hangcheck-unterminated
[69.875767] Subtest hangcheck-unterminated: SUCCESS (11.014s)
[70.020334] [005/133] (948s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[70.127180] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[70.129473] Starting dynamic subtest: pipe-A-eDP-1
[70.248727] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[70.258407] Starting dynamic subtest: pipe-B-eDP-1
[71.398644] Dynamic subtest pipe-B-eDP-1: SKIP (1.149s)
[71.403333] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.275s)
[72.693050] [006/133] (946s left) gem_exec_whisper (basic-normal-all)
[72.759179] Starting subtest: basic-normal-all
[75.196275] Subtest basic-normal-all: SUCCESS (2.435s)
[75.384734] [007/133] (943s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[75.489545] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[75.491811] Starting dynamic subtest: pipe-A-eDP-1
[91.950295] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.463s)
[91.960091] Starting dynamic subtest: pipe-B-eDP-1
[109.167623] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.217s)
[109.170075] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.682s)
[110.050975] [008/133] (908s left) dmabuf (all-tests)
[110.089122] Starting subtest: all-tests
[110.091026] Starting dynamic subtest: sanitycheck
[110.218602] Dynamic subtest sanitycheck: SUCCESS (0.130s)
[110.229390] Starting dynamic subtest: dma_fence
[110.501507] Dynamic subtest dma_fence: SUCCESS (0.282s)
[110.512629] Starting dynamic subtest: dma_fence_chain
[118.800490] Dynamic subtest dma_fence_chain: SUCCESS (8.298s)
[118.809585] Starting dynamic subtest: dma_fence_unwrap
[118.939439] Dynamic subtest dma_fence_unwrap: SUCCESS (0.137s)
[118.950556] Starting dynamic subtest: dma_resv
[119.058765] Dynamic subtest dma_resv: SUCCESS (0.117s)
[119.061707] Subtest all-tests: SUCCESS (8.971s)
[119.146422] [009/133] (899s left) gem_render_copy_redux (interruptible)
[119.212461] Starting subtest: interruptible
[119.607517] Subtest interruptible: SUCCESS (0.395s)
[119.774515] [010/133] (899s left) gem_exec_schedule (pi-shared-iova)
[119.959743] Starting subtest: pi-shared-iova
[119.961817] Starting dynamic subtest: rcs0
[120.095339] Dynamic subtest rcs0: SUCCESS (0.136s)
[120.106764] Starting dynamic subtest: vcs0
[120.174893] Dynamic subtest vcs0: SUCCESS (0.080s)
[120.186103] Starting dynamic subtest: vcs1
[120.254321] Dynamic subtest vcs1: SUCCESS (0.078s)
[120.268662] Starting dynamic subtest: vecs0
[120.331199] Dynamic subtest vecs0: SUCCESS (0.077s)
[120.342727] Starting dynamic subtest: ccs0
[120.451062] Dynamic subtest ccs0: SUCCESS (0.120s)
[120.454032] Subtest pi-shared-iova: SUCCESS (0.492s)
[122.069307] [011/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[122.177964] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[122.182065] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[122.295275] [012/133] (896s left) gem_render_copy (y-tiled)
[122.359084] Starting subtest: y-tiled
[122.363301] Subtest y-tiled: SKIP (0.000s)
[122.574399] [013/133] (896s left) kms_busy (basic)
[122.665182] Starting subtest: basic
[122.667479] Starting dynamic subtest: flip
[123.281764] Dynamic subtest flip: SUCCESS (0.617s)
[123.291073] Starting dynamic subtest: modeset
[126.681598] Dynamic subtest modeset: SUCCESS (3.399s)
[126.684044] Subtest basic: SUCCESS (4.017s)
[127.489921] [014/133] (891s left) kms_psr (psr2-cursor-blt)
[127.585569] Starting subtest: psr2-cursor-blt
[127.587829] Starting dynamic subtest: eDP-1
[129.253953] Dynamic subtest eDP-1: SUCCESS (1.669s)
[129.256058] Subtest psr2-cursor-blt: SUCCESS (1.670s)
[130.071955] [015/133] (889s left) kms_flip (2x-plain-flip-fb-recreate)
[130.180204] Starting subtest: 2x-plain-flip-fb-recreate
[130.190809] Subtest 2x-plain-flip-fb-recreate: SKIP (0.012s)
[130.285665] [016/133] (888s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[130.381212] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[130.385276] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[130.487694] [017/133] (888s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[130.589742] Starting subtest: fbcpsr-stridechange
[136.696484] Subtest fbcpsr-stridechange: SUCCESS (6.108s)
[136.844069] [018/133] (882s left) gem_mmap_gtt (close-race)
[136.901921] Subtest close-race: SKIP (0.000s)
[136.969068] [019/133] (882s left) perf_pmu (semaphore-wait)
[137.009341] Starting subtest: semaphore-wait
[137.011244] Starting dynamic subtest: rcs0
[137.526063] Dynamic subtest rcs0: SUCCESS (0.516s)
[137.537320] Starting dynamic subtest: bcs0
[138.039453] Dynamic subtest bcs0: SUCCESS (0.512s)
[138.050687] Starting dynamic subtest: vcs0
[138.551397] Dynamic subtest vcs0: SUCCESS (0.510s)
[138.562850] Starting dynamic subtest: vcs1
[139.063860] Dynamic subtest vcs1: SUCCESS (0.511s)
[139.073073] Starting dynamic subtest: vecs0
[139.578366] Dynamic subtest vecs0: SUCCESS (0.513s)
[139.589943] Starting dynamic subtest: ccs0
[140.092469] Dynamic subtest ccs0: SUCCESS (0.513s)
[140.095594] Subtest semaphore-wait: SUCCESS (3.084s)
[140.224697] [020/133] (879s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[140.324390] Starting subtest: primary-4-tiled-reflect-x-0
[147.350666] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.025s)
[148.550250] [021/133] (870s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[148.665075] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[149.355319] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[149.562547] [022/133] (869s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[149.675374] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[149.679755] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[149.795893] [023/133] (869s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[149.893490] Starting subtest: plane-upscale-20x20-with-pixel-format
[149.895705] Starting dynamic subtest: pipe-A
[150.940219] Dynamic subtest pipe-A: SUCCESS (1.050s)
[150.949022] Starting dynamic subtest: pipe-B
[153.050386] Dynamic subtest pipe-B: SUCCESS (2.109s)
[153.059478] Starting dynamic subtest: pipe-C
[154.249659] Dynamic subtest pipe-C: SUCCESS (1.198s)
[154.258949] Starting dynamic subtest: pipe-D
[155.479096] Dynamic subtest pipe-D: SUCCESS (1.229s)
[155.481421] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.588s)
[156.695303] [024/133] (862s left) kms_color (ctm-negative)
[156.791137] Starting subtest: ctm-negative
[156.793467] Starting dynamic subtest: pipe-A-eDP-1
[157.508910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[157.517528] Starting dynamic subtest: pipe-B-eDP-1
[158.902803] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[158.912685] Starting dynamic subtest: pipe-C-eDP-1
[160.250599] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[160.259301] Starting dynamic subtest: pipe-D-eDP-1
[161.596833] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[161.599101] Subtest ctm-negative: SUCCESS (4.804s)
[162.431576] [025/133] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[162.539764] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[162.544193] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[162.665802] [026/133] (856s left) kms_addfb_basic (too-wide)
[162.765160] Starting subtest: too-wide
[162.767421] Subtest too-wide: SUCCESS (0.000s)
[162.888893] [027/133] (856s left) syncobj_basic (bad-flags-fd-to-handle)
[162.951321] Starting subtest: bad-flags-fd-to-handle
[162.953272] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[163.069248] [028/133] (856s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[163.166290] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[163.168515] Starting dynamic subtest: pipe-A-eDP-1
[163.191317] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[163.202232] Starting dynamic subtest: pipe-B-eDP-1
[163.224026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[163.231884] Starting dynamic subtest: pipe-C-eDP-1
[163.253407] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[163.261255] Starting dynamic subtest: pipe-D-eDP-1
[163.283364] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[163.287489] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[165.388768] [029/133] (854s left) kms_big_fb (linear-16bpp-rotate-270)
[165.487509] Starting subtest: linear-16bpp-rotate-270
[165.508408] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[165.635516] [030/133] (854s left) kms_pm_rpm (legacy-planes-dpms)
[167.151203] Starting subtest: legacy-planes-dpms
[167.154047] Starting dynamic subtest: plane-64
[175.723500] Dynamic subtest plane-64: SUCCESS (8.571s)
[175.734882] Starting dynamic subtest: plane-94
[184.122749] Dynamic subtest plane-94: SUCCESS (8.396s)
[184.133851] Starting dynamic subtest: plane-124
[192.404287] Dynamic subtest plane-124: SUCCESS (8.279s)
[192.415805] Starting dynamic subtest: plane-134
[200.675461] Dynamic subtest plane-134: SUCCESS (8.269s)
[200.677951] Subtest legacy-planes-dpms: SUCCESS (33.524s)
[201.043787] [031/133] (818s left) syncobj_timeline (multi-wait-all-available-signaled)
[201.108010] Starting subtest: multi-wait-all-available-signaled
[201.109898] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[201.206259] [032/133] (818s left) gem_pxp (create-regular-buffer)
[201.332830] Starting subtest: create-regular-buffer
[201.335286] Subtest create-regular-buffer: SUCCESS (0.000s)
[201.468865] [033/133] (818s left) gem_userptr_blits (sync-overlap)
[201.541587] Starting subtest: sync-overlap
[201.543574] Subtest sync-overlap: SUCCESS (0.000s)
[201.695821] [034/133] (818s left) kms_cursor_crc (cursor-offscreen-256x85)
[201.957934] Starting subtest: cursor-offscreen-256x85
[202.001146] Subtest cursor-offscreen-256x85: SKIP (0.039s)
[202.202345] [035/133] (817s left) kms_vblank (wait-forked-hang)
[202.308149] Starting subtest: wait-forked-hang
[202.309686] Starting dynamic subtest: pipe-A-eDP-1
[228.693033] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.381s)
[228.707844] Starting dynamic subtest: pipe-D-eDP-1
[253.654445] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.960s)
[253.656344] Subtest wait-forked-hang: SUCCESS (51.345s)
[254.506478] [036/133] (765s left) gem_exec_reloc (basic-wc-active)
[254.567548] Subtest basic-wc-active: SKIP (0.000s)
[254.647350] [037/133] (765s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[254.738069] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[254.740942] Starting dynamic subtest: pipe-A-eDP-1
[254.763989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[254.781196] Starting dynamic subtest: pipe-B-eDP-1
[254.801229] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[254.817257] Starting dynamic subtest: pipe-C-eDP-1
[254.837339] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[254.853454] Starting dynamic subtest: pipe-D-eDP-1
[254.873236] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[254.875452] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[256.971417] [038/133] (763s left) kms_flip (2x-dpms-vs-vblank-race)
[257.082063] Starting subtest: 2x-dpms-vs-vblank-race
[257.093219] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[257.176135] [039/133] (762s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[257.273168] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[257.277253] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[257.346268] [040/133] (762s left) kms_atomic (plane-cursor-legacy)
[257.436969] Starting subtest: plane-cursor-legacy
[257.439145] Starting dynamic subtest: pipe-A-eDP-1
[257.820524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.383s)
[257.822807] Subtest plane-cursor-legacy: SUCCESS (0.385s)
[258.711241] [041/133] (761s left) gem_partial_pwrite_pread (write-uncached)
[258.772706] Subtest write-uncached: SKIP (0.000s)
[258.843065] [042/133] (761s left) gem_create (create-ext-cpu-access-sanity-check)
[259.011110] Starting subtest: create-ext-cpu-access-sanity-check
[259.015898] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[259.094113] [043/133] (761s left) gem_mmap_gtt (zero-extend)
[259.152798] Subtest zero-extend: SKIP (0.000s)
[259.204331] [044/133] (760s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[259.301323] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[259.305749] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[259.393365] [045/133] (760s left) api_intel_allocator (fork-simple-stress)
[259.461482] Starting subtest: fork-simple-stress
[264.911135] Subtest fork-simple-stress: SUCCESS (5.396s)
[265.012560] [046/133] (755s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[265.129400] Starting subtest: y-tiled-64bpp-rotate-180
[265.133571] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[265.271447] [047/133] (755s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[265.337443] Starting subtest: yf-tiled-to-vebox-y-tiled
[265.341606] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[265.531404] [048/133] (754s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[265.631113] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[272.121516] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.494s)
[272.255991] [049/133] (748s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[272.324511] Starting subtest: protected-encrypted-src-copy-not-readible
[272.436600] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[272.588066] [050/133] (747s left) i915_pm_rps (basic-api)
[272.652603] Starting subtest: basic-api
[272.656939] Subtest basic-api: SKIP (0.001s)
[272.785093] [051/133] (747s left) gem_busy (busy)
[272.845700] Starting subtest: busy
[272.847801] Starting dynamic subtest: all-engines
[272.917196] Dynamic subtest all-engines: SUCCESS (0.071s)
[272.927189] Starting dynamic subtest: rcs0
[274.847075] Dynamic subtest rcs0: SUCCESS (1.928s)
[274.856243] Starting dynamic subtest: bcs0
[274.928447] Dynamic subtest bcs0: SUCCESS (0.078s)
[274.937661] Starting dynamic subtest: vcs0
[274.968861] Dynamic subtest vcs0: SUCCESS (0.039s)
[274.983172] Starting dynamic subtest: vcs1
[276.892339] Dynamic subtest vcs1: SUCCESS (1.921s)
[276.901236] Starting dynamic subtest: vecs0
[278.990143] Dynamic subtest vecs0: SUCCESS (2.044s)
[279.002730] Starting dynamic subtest: ccs0
[280.924233] Dynamic subtest ccs0: SUCCESS (1.984s)
[280.926690] Subtest busy: SUCCESS (8.076s)
[281.299324] [052/133] (739s left) kms_dp_link_training (non-uhbr-sst)
[281.401044] Starting subtest: non-uhbr-sst
[281.409334] Subtest non-uhbr-sst: SKIP (0.000s)
[281.478427] [053/133] (739s left) gem_unfence_active_buffers
[281.665039] [054/133] (738s left) kms_dsc (dsc-with-formats)
[281.756879] Starting subtest: dsc-with-formats
[281.796627] Subtest dsc-with-formats: SKIP (0.001s)
[281.837703] [055/133] (738s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[281.937897] Starting subtest: plane-downscale-factor-0-75-with-rotation
[281.940177] Starting dynamic subtest: pipe-A
[282.166481] Dynamic subtest pipe-A: SUCCESS (0.230s)
[282.176549] Starting dynamic subtest: pipe-B
[283.484246] Dynamic subtest pipe-B: SUCCESS (1.317s)
[283.493904] Starting dynamic subtest: pipe-C
[284.813089] Dynamic subtest pipe-C: SUCCESS (1.328s)
[284.823100] Starting dynamic subtest: pipe-D
[286.157160] Dynamic subtest pipe-D: SUCCESS (1.343s)
[286.159471] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.221s)
[287.338434] [056/133] (733s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[287.453387] Starting subtest: cursor-vs-flip-toggle
[318.080851] Subtest cursor-vs-flip-toggle: SUCCESS (30.624s)
[318.963103] [057/133] (701s left) kms_psr (fbc-psr-cursor-blt)
[319.064880] Starting subtest: fbc-psr-cursor-blt
[319.067131] Starting dynamic subtest: eDP-1
[319.071402] Dynamic subtest eDP-1: SKIP (0.000s)
[319.075705] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[319.145970] [058/133] (701s left) gem_ctx_exec (basic)
[319.219639] Starting subtest: basic
[319.225058] Subtest basic: SUCCESS (0.006s)
[319.377424] [059/133] (701s left) gem_sync (basic-store-all)
[319.455624] Starting subtest: basic-store-all
[324.079476] Subtest basic-store-all: SUCCESS (4.613s)
[324.255420] [060/133] (696s left) kms_flip (2x-blocking-wf_vblank)
[324.361137] Starting subtest: 2x-blocking-wf_vblank
[324.369731] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[324.500036] [061/133] (696s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[324.594224] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[324.596506] Starting dynamic subtest: pipe-A-eDP-1
[324.632837] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[324.643893] Starting dynamic subtest: pipe-B-eDP-1
[324.667018] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[324.677073] Starting dynamic subtest: pipe-C-eDP-1
[324.699514] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[324.708091] Starting dynamic subtest: pipe-D-eDP-1
[324.730657] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[324.734823] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[326.762626] [062/133] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[326.869344] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[326.873329] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[326.987342] [063/133] (693s left) gem_ctx_persistence (idempotent)
[327.063550] Starting subtest: idempotent
[327.065927] Subtest idempotent: SUCCESS (0.000s)
[327.188312] [064/133] (693s left) gem_flink_basic (basic)
[327.240677] Starting subtest: basic
[327.243298] Subtest basic: SUCCESS (0.000s)
[327.368774] [065/133] (693s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[327.451124] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[327.477121] Starting dynamic subtest: pipe-A-plane-0
[327.898791] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[327.907234] Starting dynamic subtest: pipe-A-plane-3
[328.143095] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[328.151634] Starting dynamic subtest: pipe-A-plane-5
[328.155124] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[329.236188] Starting dynamic subtest: pipe-B-plane-0
[329.659930] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[329.668507] Starting dynamic subtest: pipe-B-plane-3
[329.915953] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[329.924111] Starting dynamic subtest: pipe-B-plane-5
[329.928587] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[330.223477] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.771s)
[331.116406] [066/133] (689s left) kms_cursor_crc (cursor-random-512x512)
[331.398466] Starting subtest: cursor-random-512x512
[331.403281] Subtest cursor-random-512x512: SKIP (0.001s)
[331.598622] [067/133] (689s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[331.987803] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[332.813148] [068/133] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[332.923239] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[332.927325] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[333.053382] [069/133] (688s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[333.151425] Starting subtest: psr-rgb565-draw-render
[340.167968] Subtest psr-rgb565-draw-render: SUCCESS (7.018s)
[340.312468] [070/133] (680s left) perf (unprivileged-single-ctx-counters)
[340.447016] Starting subtest: unprivileged-single-ctx-counters
[340.450846] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[340.488213] [071/133] (680s left) kms_cursor_edge_walk (128x128-top-edge)
[340.582630] Starting subtest: 128x128-top-edge
[340.584803] Starting dynamic subtest: pipe-A-eDP-1
[344.040701] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[344.049396] Starting dynamic subtest: pipe-D-eDP-1
[347.161754] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[347.164065] Subtest 128x128-top-edge: SUCCESS (6.581s)
[347.992592] [072/133] (673s left) i915_drm_fdinfo (memory-info-resident)
[348.045869] Starting subtest: memory-info-resident
[348.048277] Starting dynamic subtest: smem0
[350.872361] Dynamic subtest smem0: SUCCESS (2.829s)
[350.874479] Subtest memory-info-resident: SUCCESS (2.830s)
[350.958281] [073/133] (670s left) kms_pm_rpm (dpms-lpsp)
[353.088651] Starting subtest: dpms-lpsp
[353.399713] Subtest dpms-lpsp: SUCCESS (0.313s)
[353.496311] [074/133] (667s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[353.618823] Starting subtest: cursorA-vs-flipA-legacy
[364.747233] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.127s)
[365.590210] [075/133] (655s left) gen9_exec_parse (allowed-single)
[365.663063] Subtest allowed-single: SKIP (0.000s)
[365.748031] [076/133] (655s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[365.839135] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[365.841366] Starting dynamic subtest: pipe-A-eDP-1
[365.864698] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[365.875316] Starting dynamic subtest: pipe-B-eDP-1
[365.897414] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[365.905826] Starting dynamic subtest: pipe-C-eDP-1
[365.927406] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[365.935774] Starting dynamic subtest: pipe-D-eDP-1
[365.957486] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[365.961588] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[368.065031] [077/133] (653s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[368.168804] Starting subtest: 4-tiled-32bpp-rotate-180
[369.513317] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.345s)
[369.682061] [078/133] (651s left) kms_lease (simple-lease)
[369.782216] Starting subtest: simple-lease
[369.784087] Starting dynamic subtest: pipe-A-eDP-1
[370.282806] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.500s)
[370.291782] Starting dynamic subtest: pipe-B-eDP-1
[371.689436] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[371.702489] Starting dynamic subtest: pipe-C-eDP-1
[373.082177] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[373.091898] Starting dynamic subtest: pipe-D-eDP-1
[374.476583] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.394s)
[374.479032] Subtest simple-lease: SUCCESS (4.694s)
[375.303312] [079/133] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[375.410481] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[375.414789] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[375.535633] [080/133] (646s left) gem_userptr_blits (create-destroy-sync)
[375.605962] Starting subtest: create-destroy-sync
[380.676206] Subtest create-destroy-sync: SUCCESS (5.016s)
[380.762054] [081/133] (640s left) gem_exec_whisper (basic-queues-priority)
[380.823282] Starting subtest: basic-queues-priority
[403.835559] Subtest basic-queues-priority: SUCCESS (23.009s)
[404.028973] [082/133] (617s left) gem_exec_fence (expired-history)
[404.539503] Starting subtest: expired-history
[411.541808] Subtest expired-history: SUCCESS (7.003s)
[412.187665] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[412.191119] [083/133] (609s left) gem_exec_gttfill (all-engines)
[412.267754] Starting subtest: all-engines
[435.997068] Subtest all-engines: SUCCESS (23.730s)
[436.197176] [084/133] (585s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[436.362460] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[443.687293] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.327s)
[443.844851] [085/133] (577s left) syncobj_timeline (reset-during-wait-for-submit)
[443.910518] Starting subtest: reset-during-wait-for-submit
[444.016708] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[444.100532] [086/133] (577s left) kms_vblank (query-forked)
[444.200998] Starting subtest: query-forked
[444.202850] Starting dynamic subtest: pipe-A-eDP-1
[446.019948] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[446.033803] Starting dynamic subtest: pipe-D-eDP-1
[448.511735] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.491s)
[448.514068] Subtest query-forked: SUCCESS (4.312s)
[449.390130] [087/133] (572s left) i915_selftest (mock)
[452.919427] Starting subtest: mock
[452.922205] Starting dynamic subtest: sanitycheck
[453.695114] Dynamic subtest sanitycheck: SUCCESS (0.775s)
[453.704471] Starting dynamic subtest: shmem
[454.424087] Dynamic subtest shmem: SUCCESS (0.727s)
[454.433852] Starting dynamic subtest: fence
[462.082532] Dynamic subtest fence: SUCCESS (7.655s)
[462.092097] Starting dynamic subtest: scatterlist
[463.740430] Dynamic subtest scatterlist: SUCCESS (1.656s)
[463.749993] Starting dynamic subtest: syncmap
[467.346299] Dynamic subtest syncmap: SUCCESS (3.603s)
[467.355803] Starting dynamic subtest: uncore
[468.081082] Dynamic subtest uncore: SUCCESS (0.733s)
[468.090281] Starting dynamic subtest: ring
[468.820105] Dynamic subtest ring: SUCCESS (0.737s)
[468.829626] Starting dynamic subtest: engine
[469.569213] Dynamic subtest engine: SUCCESS (0.747s)
[469.579284] Starting dynamic subtest: timelines
[473.513358] Dynamic subtest timelines: SUCCESS (3.941s)
[473.523228] Starting dynamic subtest: requests
[477.434351] Dynamic subtest requests: SUCCESS (3.918s)
[477.443887] Starting dynamic subtest: objects
[478.219498] Dynamic subtest objects: SUCCESS (0.784s)
[478.229144] Starting dynamic subtest: phys
[479.029244] Dynamic subtest phys: SUCCESS (0.808s)
[479.038775] Starting dynamic subtest: dmabuf
[479.893182] Dynamic subtest dmabuf: SUCCESS (0.849s)
[479.902771] Starting dynamic subtest: vma
[485.277526] Dynamic subtest vma: SUCCESS (5.394s)
[485.287081] Starting dynamic subtest: evict
[486.694366] Dynamic subtest evict: SUCCESS (1.415s)
[486.704187] Starting dynamic subtest: gtt
[490.469385] Dynamic subtest gtt: SUCCESS (3.774s)
[490.479214] Starting dynamic subtest: hugepages
[491.477084] Dynamic subtest hugepages: SUCCESS (1.006s)
[491.486917] Starting dynamic subtest: memory_region
[494.082863] Dynamic subtest memory_region: SUCCESS (2.604s)
[494.085447] Subtest mock: SUCCESS (41.163s)
[494.112770] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[494.113464] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[494.116577] [088/133] (527s left) perf_pmu (busy-check-all)
[495.629936] Starting subtest: busy-check-all
[495.632386] Starting dynamic subtest: rcs0
[496.212408] Dynamic subtest rcs0: SUCCESS (0.581s)
[496.224036] Starting dynamic subtest: bcs0
[496.761614] Dynamic subtest bcs0: SUCCESS (0.548s)
[496.773339] Starting dynamic subtest: vcs0
[497.881087] Dynamic subtest vcs0: SUCCESS (1.116s)
[497.891858] Starting dynamic subtest: vcs1
[499.925974] Dynamic subtest vcs1: SUCCESS (2.041s)
[499.936785] Starting dynamic subtest: vecs0
[501.909717] Dynamic subtest vecs0: SUCCESS (1.981s)
[501.920412] Starting dynamic subtest: ccs0
[502.464041] Dynamic subtest ccs0: SUCCESS (0.554s)
[502.466468] Subtest busy-check-all: SUCCESS (6.835s)
[502.562237] [FACT perf_pmu (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[502.563382] [FACT perf_pmu (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[502.566858] [089/133] (519s left) gem_exec_params (no-blt)
[502.644061] Starting subtest: no-blt
[502.646454] Subtest no-blt: SUCCESS (0.003s)
[502.809301] [090/133] (519s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[502.915406] Starting subtest: basic-max-pipe-crc-check
[502.919997] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[502.965321] [091/133] (519s left) perf (gen8-unprivileged-single-ctx-counters)
[503.111032] Starting subtest: gen8-unprivileged-single-ctx-counters
[503.114824] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[503.155288] [092/133] (518s left) kms_rotation_crc (cursor-rotation-180)
[503.257138] Starting subtest: cursor-rotation-180
[504.787301] Subtest cursor-rotation-180: SUCCESS (1.532s)
[506.301535] [093/133] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[506.408973] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[506.413148] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[506.534485] [094/133] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[506.649975] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[506.654056] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[506.777913] [095/133] (515s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[506.851459] Starting subtest: framebuffer-vs-set-tiling
[506.855907] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[507.031717] [096/133] (515s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[507.564300] Starting subtest: syncobj-timeline-multiple-ext-nodes
[507.566791] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[508.952282] [097/133] (513s left) kms_flip (2x-nonexisting-fb-interruptible)
[509.055428] Starting subtest: 2x-nonexisting-fb-interruptible
[509.066952] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[509.152704] [098/133] (513s left) kms_psr (psr2-sprite-plane-move)
[509.264468] Starting subtest: psr2-sprite-plane-move
[509.266613] Starting dynamic subtest: eDP-1
[511.002930] Dynamic subtest eDP-1: SUCCESS (1.737s)
[511.004868] Subtest psr2-sprite-plane-move: SUCCESS (1.738s)
[511.864397] [099/133] (510s left) kms_psr (fbc-psr2-cursor-plane-move)
[511.963197] Starting subtest: fbc-psr2-cursor-plane-move
[511.965564] Starting dynamic subtest: eDP-1
[511.969828] Dynamic subtest eDP-1: SKIP (0.000s)
[511.973805] Subtest fbc-psr2-cursor-plane-move: SKIP (0.002s)
[512.061973] [100/133] (510s left) kms_rotation_crc (bad-pixel-format)
[512.154920] Starting subtest: bad-pixel-format
[512.158860] Subtest bad-pixel-format: SKIP (0.001s)
[512.236903] [101/133] (510s left) kms_invalid_mode (bad-vsync-end)
[512.333496] Starting subtest: bad-vsync-end
[512.335858] Starting dynamic subtest: pipe-A-eDP-1
[512.635330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s)
[512.644670] Starting dynamic subtest: pipe-B-eDP-1
[512.646561] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[512.654498] Starting dynamic subtest: pipe-C-eDP-1
[512.656759] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[512.664661] Starting dynamic subtest: pipe-D-eDP-1
[512.666527] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[512.668447] Subtest bad-vsync-end: SUCCESS (0.309s)
[513.492952] [102/133] (508s left) gem_exec_schedule (preempt-user)
[513.564393] Starting subtest: preempt-user
[513.566752] Starting dynamic subtest: rcs0
[513.580148] Dynamic subtest rcs0: SUCCESS (0.024s)
[513.590320] Starting dynamic subtest: bcs0
[513.598532] Dynamic subtest bcs0: SUCCESS (0.018s)
[513.610533] Starting dynamic subtest: vcs0
[513.621087] Dynamic subtest vcs0: SUCCESS (0.022s)
[513.629667] Starting dynamic subtest: vcs1
[513.641223] Dynamic subtest vcs1: SUCCESS (0.019s)
[513.649631] Starting dynamic subtest: vecs0
[513.663139] Dynamic subtest vecs0: SUCCESS (0.021s)
[513.672424] Starting dynamic subtest: ccs0
[513.683398] Dynamic subtest ccs0: SUCCESS (0.020s)
[513.685643] Subtest preempt-user: SUCCESS (0.128s)
[515.020705] [103/133] (507s left) syncobj_wait (wait-zero-handles)
[515.075405] Starting subtest: wait-zero-handles
[515.077646] Subtest wait-zero-handles: SUCCESS (0.000s)
[515.196891] [104/133] (507s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[515.316053] Starting subtest: basic-flip-before-cursor-varying-size
[516.264408] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.949s)
[517.133377] [105/133] (505s left) gem_softpin (softpin)
[517.209347] Starting subtest: softpin
[549.567785] Subtest softpin: SUCCESS (32.356s)
[549.698332] [106/133] (472s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[549.820783] Starting subtest: 2x-cursor-vs-flip-legacy
[549.825396] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[549.978782] [107/133] (472s left) kms_getfb (getfb-reject-nv12)
[550.075032] Starting subtest: getfb-reject-nv12
[550.077214] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[550.188643] [108/133] (472s left) gem_ctx_persistence (engines-persistence)
[550.249665] Starting subtest: engines-persistence
[550.251711] Starting dynamic subtest: rcs0
[551.077169] Dynamic subtest rcs0: SUCCESS (0.829s)
[551.089184] Starting dynamic subtest: bcs0
[551.826746] Dynamic subtest bcs0: SUCCESS (0.748s)
[551.838072] Starting dynamic subtest: vcs0
[552.618985] Dynamic subtest vcs0: SUCCESS (0.790s)
[552.630512] Starting dynamic subtest: vcs1
[553.413977] Dynamic subtest vcs1: SUCCESS (0.793s)
[553.423990] Starting dynamic subtest: vecs0
[554.283810] Dynamic subtest vecs0: SUCCESS (0.868s)
[554.293688] Starting dynamic subtest: ccs0
[555.077794] Dynamic subtest ccs0: SUCCESS (0.791s)
[555.080287] Subtest engines-persistence: SUCCESS (4.830s)
[555.234098] [109/133] (467s left) gem_tiled_blits (basic)
[555.307679] Subtest basic: SKIP (0.000s)
[555.399066] [110/133] (467s left) kms_chamelium_color (ctm-green-to-red)
[555.501033] Subtest ctm-green-to-red: SKIP (0.000s)
[555.546397] [111/133] (467s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[555.638430] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[555.642799] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[555.722406] [112/133] (467s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[555.789582] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[555.898283] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[555.984901] [113/133] (466s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[556.058427] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[556.160737] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[556.252012] [114/133] (466s left) gem_ctx_shared (disjoint-timelines)
[556.330485] Starting subtest: disjoint-timelines
[556.383149] Subtest disjoint-timelines: SUCCESS (0.055s)
[556.640433] [115/133] (466s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[556.750291] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[556.754694] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[556.834986] [116/133] (466s left) kms_properties (get_properties-sanity-atomic)
[556.929846] Starting subtest: get_properties-sanity-atomic
[556.932120] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[557.014941] [117/133] (466s left) kms_addfb_basic (basic-x-tiled-legacy)
[557.071049] Starting subtest: basic-x-tiled-legacy
[557.075578] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[557.206284] [118/133] (465s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[557.308270] Starting subtest: yf-tiled-64bpp-rotate-180
[557.312566] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[557.418715] [119/133] (465s left) kms_content_protection (lic-type-0-hdcp14)
[557.562486] Starting subtest: lic-type-0-hdcp14
[557.566315] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[557.709438] [120/133] (465s left) perf_pmu (all-busy-check-all)
[557.744560] Starting subtest: all-busy-check-all
[558.934046] Subtest all-busy-check-all: SUCCESS (1.189s)
[559.078760] [121/133] (464s left) syncobj_timeline (single-wait-all-available-submitted)
[559.153513] Starting subtest: single-wait-all-available-submitted
[559.155720] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[559.284332] [122/133] (463s left) prime_vgem (basic-write)
[559.377900] Starting subtest: basic-write
[559.391467] Subtest basic-write: SKIP (0.012s)
[559.527055] [123/133] (463s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[559.634662] Starting subtest: x-tiled-16bpp-rotate-90
[559.655707] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[559.816156] [124/133] (463s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[559.948048] Starting subtest: 2x-cursor-vs-flip-atomic
[559.951691] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[560.098650] [125/133] (463s left) gem_tiled_pread_basic (basic)
[560.168788] Subtest basic: SKIP (0.000s)
[560.242133] [126/133] (463s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[560.342838] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[560.346355] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[560.465300] [127/133] (463s left) gem_spin_batch (resubmit-all)
[560.538781] Starting subtest: resubmit-all
[560.540588] Starting dynamic subtest: rcs0
[560.552866] Dynamic subtest rcs0: SUCCESS (0.014s)
[560.561379] Starting dynamic subtest: bcs0
[560.563126] Dynamic subtest bcs0: SUCCESS (0.002s)
[560.570967] Starting dynamic subtest: vcs0
[560.572748] Dynamic subtest vcs0: SUCCESS (0.002s)
[560.580348] Starting dynamic subtest: vcs1
[560.582120] Dynamic subtest vcs1: SUCCESS (0.002s)
[560.589700] Starting dynamic subtest: vecs0
[560.591529] Dynamic subtest vecs0: SUCCESS (0.002s)
[560.598965] Starting dynamic subtest: ccs0
[560.600755] Dynamic subtest ccs0: SUCCESS (0.002s)
[560.602535] Subtest resubmit-all: SUCCESS (0.029s)
[560.826234] [128/133] (462s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[560.929930] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[567.740581] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.813s)
[567.910058] [129/133] (455s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[568.022593] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[568.026577] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[568.150368] [130/133] (455s left) gem_mmap_wc (write-read)
[568.217194] Subtest write-read: SKIP (0.000s)
[568.281234] [131/133] (455s left) perf_pmu (busy-start)
[568.317101] Starting subtest: busy-start
[568.318990] Starting dynamic subtest: rcs0
[570.864080] Dynamic subtest rcs0: SUCCESS (2.549s)
[570.874633] Starting dynamic subtest: bcs0
[573.431823] Dynamic subtest bcs0: SUCCESS (2.546s)
[573.442194] Starting dynamic subtest: vcs0
[576.917198] Dynamic subtest vcs0: SUCCESS (3.501s)
[576.928092] Starting dynamic subtest: vcs1
[580.885219] Dynamic subtest vcs1: SUCCESS (3.965s)
[580.895706] Starting dynamic subtest: vecs0
[584.917421] Dynamic subtest vecs0: SUCCESS (4.029s)
[584.931996] Starting dynamic subtest: ccs0
[587.484736] Dynamic subtest ccs0: SUCCESS (2.546s)
[587.486669] Subtest busy-start: SUCCESS (19.150s)
[587.587507] [132/133] (436s left) gem_exec_balancer (bonded-false-hang)
[587.866079] Starting subtest: bonded-false-hang
[587.870459] Subtest bonded-false-hang: SKIP (0.000s)
[587.992365] [133/133] (435s left) kms_chamelium_frames (hdmi-crc-multiple)
[588.376705] Subtest hdmi-crc-multiple: SKIP (0.000s)
[589.164277] 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.