[59.755264] Initializing watchdogs
[59.755309]   /dev/watchdog0
[59.769941] [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]
[59.774122] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.776255] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.779673] [001/133] (960s left) core_auth (getclient-master-drop)
[59.836449] Starting subtest: getclient-master-drop
[59.863074] Subtest getclient-master-drop: SUCCESS (0.025s)
[59.998055] [002/133] (960s left) gem_workarounds (reset)
[60.060396] Starting subtest: reset
[60.165816] Subtest reset: SUCCESS (0.105s)
[60.317931] [003/133] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[60.405369] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[60.409840] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[60.489306] [004/133] (959s left) i915_hangman (hangcheck-unterminated)
[60.557506] Starting subtest: hangcheck-unterminated
[70.899606] Subtest hangcheck-unterminated: SUCCESS (10.342s)
[71.038957] [005/133] (949s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[71.157557] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[71.159849] Starting dynamic subtest: pipe-A-eDP-1
[71.278851] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[71.288785] Starting dynamic subtest: pipe-B-eDP-1
[72.420827] Dynamic subtest pipe-B-eDP-1: SKIP (1.141s)
[72.425500] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.268s)
[73.632492] [006/133] (946s left) gem_exec_whisper (basic-normal-all)
[73.698387] Starting subtest: basic-normal-all
[76.168367] Subtest basic-normal-all: SUCCESS (2.468s)
[76.359140] [007/133] (944s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[76.468120] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[76.470771] Starting dynamic subtest: pipe-A-eDP-1
[92.913741] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.449s)
[92.923740] Starting dynamic subtest: pipe-B-eDP-1
[110.087081] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.169s)
[110.089521] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.620s)
[110.894958] [008/133] (909s left) dmabuf (all-tests)
[110.934848] Starting subtest: all-tests
[110.937215] Starting dynamic subtest: sanitycheck
[111.084738] Dynamic subtest sanitycheck: SUCCESS (0.150s)
[111.095619] Starting dynamic subtest: dma_fence
[111.405469] Dynamic subtest dma_fence: SUCCESS (0.320s)
[111.416136] Starting dynamic subtest: dma_fence_chain
[119.906401] Dynamic subtest dma_fence_chain: SUCCESS (8.499s)
[119.917133] Starting dynamic subtest: dma_fence_unwrap
[120.034721] Dynamic subtest dma_fence_unwrap: SUCCESS (0.126s)
[120.051723] Starting dynamic subtest: dma_resv
[120.171295] Dynamic subtest dma_resv: SUCCESS (0.135s)
[120.174526] Subtest all-tests: SUCCESS (9.236s)
[120.248219] [009/133] (900s left) gem_render_copy_redux (interruptible)
[120.324541] Starting subtest: interruptible
[120.731828] Subtest interruptible: SUCCESS (0.409s)
[120.881614] [010/133] (899s left) gem_exec_schedule (pi-shared-iova)
[121.070196] Starting subtest: pi-shared-iova
[121.072509] Starting dynamic subtest: rcs0
[121.200101] Dynamic subtest rcs0: SUCCESS (0.130s)
[121.210539] Starting dynamic subtest: vcs0
[121.293109] Dynamic subtest vcs0: SUCCESS (0.093s)
[121.305546] Starting dynamic subtest: vcs1
[121.367051] Dynamic subtest vcs1: SUCCESS (0.075s)
[121.378717] Starting dynamic subtest: vecs0
[121.456547] Dynamic subtest vecs0: SUCCESS (0.089s)
[121.467874] Starting dynamic subtest: ccs0
[121.578826] Dynamic subtest ccs0: SUCCESS (0.121s)
[121.581265] Subtest pi-shared-iova: SUCCESS (0.510s)
[123.039246] [011/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[123.155156] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[123.159112] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[123.275669] [012/133] (897s left) gem_render_copy (y-tiled)
[123.346921] Starting subtest: y-tiled
[123.351164] Subtest y-tiled: SKIP (0.000s)
[123.542194] [013/133] (897s left) kms_busy (basic)
[123.655817] Starting subtest: basic
[123.658252] Starting dynamic subtest: flip
[124.290626] Dynamic subtest flip: SUCCESS (0.635s)
[124.300247] Starting dynamic subtest: modeset
[127.717248] Dynamic subtest modeset: SUCCESS (3.424s)
[127.719611] Subtest basic: SUCCESS (4.061s)
[128.538159] [014/133] (892s left) kms_psr (psr2-cursor-blt)
[128.642878] Starting subtest: psr2-cursor-blt
[128.645182] Starting dynamic subtest: eDP-1
[130.388949] Dynamic subtest eDP-1: SUCCESS (1.747s)
[130.391585] Subtest psr2-cursor-blt: SUCCESS (1.747s)
[131.194653] [015/133] (889s left) kms_flip (2x-plain-flip-fb-recreate)
[131.292279] Starting subtest: 2x-plain-flip-fb-recreate
[131.303207] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[131.427965] [016/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[131.533982] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[131.538184] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[131.655083] [017/133] (889s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[131.746379] Starting subtest: fbcpsr-stridechange
[137.863707] Subtest fbcpsr-stridechange: SUCCESS (6.119s)
[138.020467] [018/133] (882s left) gem_mmap_gtt (close-race)
[138.090257] Subtest close-race: SKIP (0.000s)
[138.190600] [019/133] (882s left) perf_pmu (semaphore-wait)
[138.238617] Starting subtest: semaphore-wait
[138.240900] Starting dynamic subtest: rcs0
[138.753543] Dynamic subtest rcs0: SUCCESS (0.513s)
[138.763036] Starting dynamic subtest: bcs0
[139.267550] Dynamic subtest bcs0: SUCCESS (0.512s)
[139.276884] Starting dynamic subtest: vcs0
[139.781045] Dynamic subtest vcs0: SUCCESS (0.512s)
[139.792245] Starting dynamic subtest: vcs1
[140.294522] Dynamic subtest vcs1: SUCCESS (0.511s)
[140.305766] Starting dynamic subtest: vecs0
[140.806281] Dynamic subtest vecs0: SUCCESS (0.510s)
[140.815081] Starting dynamic subtest: ccs0
[141.322712] Dynamic subtest ccs0: SUCCESS (0.515s)
[141.325729] Subtest semaphore-wait: SUCCESS (3.083s)
[141.483260] [020/133] (879s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[141.586188] Starting subtest: primary-4-tiled-reflect-x-0
[148.570245] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.985s)
[149.783772] [021/133] (871s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[149.887171] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[150.566587] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[150.773215] [022/133] (870s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[150.883791] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[150.887887] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[151.010573] [023/133] (870s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[151.100986] Starting subtest: plane-upscale-20x20-with-pixel-format
[151.103368] Starting dynamic subtest: pipe-A
[152.148227] Dynamic subtest pipe-A: SUCCESS (1.049s)
[152.157598] Starting dynamic subtest: pipe-B
[154.276819] Dynamic subtest pipe-B: SUCCESS (2.128s)
[154.285539] Starting dynamic subtest: pipe-C
[155.465905] Dynamic subtest pipe-C: SUCCESS (1.188s)
[155.475705] Starting dynamic subtest: pipe-D
[156.700825] Dynamic subtest pipe-D: SUCCESS (1.234s)
[156.703239] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.602s)
[157.892788] [024/133] (863s left) kms_color (ctm-negative)
[158.001808] Starting subtest: ctm-negative
[158.004141] Starting dynamic subtest: pipe-A-eDP-1
[158.709922] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[158.718314] Starting dynamic subtest: pipe-B-eDP-1
[160.145292] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[160.154014] Starting dynamic subtest: pipe-C-eDP-1
[161.477275] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.331s)
[161.485756] Starting dynamic subtest: pipe-D-eDP-1
[162.805593] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[162.808022] Subtest ctm-negative: SUCCESS (4.804s)
[163.620070] [025/133] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[163.731815] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[163.736093] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[163.856556] [026/133] (857s left) kms_addfb_basic (too-wide)
[163.962144] Starting subtest: too-wide
[163.964069] Subtest too-wide: SUCCESS (0.000s)
[164.078353] [027/133] (857s left) syncobj_basic (bad-flags-fd-to-handle)
[164.143326] Starting subtest: bad-flags-fd-to-handle
[164.145671] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[164.266918] [028/133] (857s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[164.363253] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[164.365577] Starting dynamic subtest: pipe-A-eDP-1
[164.387517] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.399028] Starting dynamic subtest: pipe-B-eDP-1
[164.419117] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.426807] Starting dynamic subtest: pipe-C-eDP-1
[164.447220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.454805] Starting dynamic subtest: pipe-D-eDP-1
[164.476234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.480594] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[166.595791] [029/133] (854s left) kms_big_fb (linear-16bpp-rotate-270)
[166.708100] Starting subtest: linear-16bpp-rotate-270
[166.727293] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[166.872423] [030/133] (854s left) kms_pm_rpm (legacy-planes-dpms)
[169.091852] Starting subtest: legacy-planes-dpms
[169.094307] Starting dynamic subtest: plane-64
[177.697229] Dynamic subtest plane-64: SUCCESS (8.609s)
[177.708681] Starting dynamic subtest: plane-94
[186.297203] Dynamic subtest plane-94: SUCCESS (8.597s)
[186.308372] Starting dynamic subtest: plane-124
[194.589486] Dynamic subtest plane-124: SUCCESS (8.290s)
[194.600437] Starting dynamic subtest: plane-134
[202.884496] Dynamic subtest plane-134: SUCCESS (8.292s)
[202.887811] Subtest legacy-planes-dpms: SUCCESS (33.797s)
[203.292247] [031/133] (818s left) syncobj_timeline (multi-wait-all-available-signaled)
[203.360216] Starting subtest: multi-wait-all-available-signaled
[203.362429] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[203.480090] [032/133] (818s left) gem_pxp (create-regular-buffer)
[203.604667] Starting subtest: create-regular-buffer
[203.607053] Subtest create-regular-buffer: SUCCESS (0.000s)
[203.733382] [033/133] (817s left) gem_userptr_blits (sync-overlap)
[203.813170] Starting subtest: sync-overlap
[203.815131] Subtest sync-overlap: SUCCESS (0.000s)
[203.963932] [034/133] (817s left) kms_cursor_crc (cursor-offscreen-256x85)
[204.223374] Starting subtest: cursor-offscreen-256x85
[204.266982] Subtest cursor-offscreen-256x85: SKIP (0.040s)
[204.478600] [035/133] (817s left) kms_vblank (wait-forked-hang)
[204.587289] Starting subtest: wait-forked-hang
[204.589139] Starting dynamic subtest: pipe-A-eDP-1
[230.751149] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.161s)
[230.765246] Starting dynamic subtest: pipe-D-eDP-1
[255.653660] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.898s)
[255.656021] Subtest wait-forked-hang: SUCCESS (51.065s)
[256.530845] [036/133] (765s left) gem_exec_reloc (basic-wc-active)
[256.609938] Subtest basic-wc-active: SKIP (0.000s)
[256.668738] [037/133] (765s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[256.759919] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[256.762248] Starting dynamic subtest: pipe-A-eDP-1
[256.782916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[256.794064] Starting dynamic subtest: pipe-B-eDP-1
[256.813447] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[256.821260] Starting dynamic subtest: pipe-C-eDP-1
[256.840591] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[256.848664] Starting dynamic subtest: pipe-D-eDP-1
[256.868115] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[256.870018] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[258.998016] [038/133] (762s left) kms_flip (2x-dpms-vs-vblank-race)
[259.105553] Starting subtest: 2x-dpms-vs-vblank-race
[259.114453] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[259.206223] [039/133] (762s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[259.298870] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[259.302952] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[259.388708] [040/133] (762s left) kms_atomic (plane-cursor-legacy)
[259.488099] Starting subtest: plane-cursor-legacy
[259.490298] Starting dynamic subtest: pipe-A-eDP-1
[259.875220] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.386s)
[259.877622] Subtest plane-cursor-legacy: SUCCESS (0.388s)
[260.718159] [041/133] (761s left) gem_partial_pwrite_pread (write-uncached)
[260.789195] Subtest write-uncached: SKIP (0.000s)
[260.871797] [042/133] (761s left) gem_create (create-ext-cpu-access-sanity-check)
[261.040027] Starting subtest: create-ext-cpu-access-sanity-check
[261.044520] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[261.120264] [043/133] (760s left) gem_mmap_gtt (zero-extend)
[261.187288] Subtest zero-extend: SKIP (0.000s)
[261.262744] [044/133] (760s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[261.365075] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[261.369128] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[261.445295] [045/133] (760s left) api_intel_allocator (fork-simple-stress)
[261.503098] Starting subtest: fork-simple-stress
[266.898908] Subtest fork-simple-stress: SUCCESS (5.397s)
[267.030517] [046/133] (755s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[267.146421] Starting subtest: y-tiled-64bpp-rotate-180
[267.150818] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[267.292416] [047/133] (754s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[267.376371] Starting subtest: yf-tiled-to-vebox-y-tiled
[267.380835] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[267.566580] [048/133] (754s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[267.683493] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[274.260347] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.579s)
[274.417727] [049/133] (747s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[274.484642] Starting subtest: protected-encrypted-src-copy-not-readible
[274.596094] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.110s)
[274.752917] [050/133] (747s left) i915_pm_rps (basic-api)
[274.816511] Starting subtest: basic-api
[274.821100] Subtest basic-api: SKIP (0.001s)
[274.937707] [051/133] (747s left) gem_busy (busy)
[275.007579] Starting subtest: busy
[275.009854] Starting dynamic subtest: all-engines
[275.067839] Dynamic subtest all-engines: SUCCESS (0.063s)
[275.076754] Starting dynamic subtest: rcs0
[276.894287] Dynamic subtest rcs0: SUCCESS (1.825s)
[276.905108] Starting dynamic subtest: bcs0
[276.972753] Dynamic subtest bcs0: SUCCESS (0.075s)
[276.981870] Starting dynamic subtest: vcs0
[277.012364] Dynamic subtest vcs0: SUCCESS (0.039s)
[277.020082] Starting dynamic subtest: vcs1
[278.938877] Dynamic subtest vcs1: SUCCESS (1.924s)
[278.948057] Starting dynamic subtest: vecs0
[280.922836] Dynamic subtest vecs0: SUCCESS (1.982s)
[280.933494] Starting dynamic subtest: ccs0
[282.907578] Dynamic subtest ccs0: SUCCESS (1.983s)
[282.910082] Subtest busy: SUCCESS (7.900s)
[283.309378] [052/133] (739s left) kms_dp_link_training (non-uhbr-sst)
[283.416750] Starting subtest: non-uhbr-sst
[283.425130] Subtest non-uhbr-sst: SKIP (0.000s)
[283.499059] [053/133] (738s left) gem_unfence_active_buffers
[283.657489] [054/133] (738s left) kms_dsc (dsc-with-formats)
[283.746665] Starting subtest: dsc-with-formats
[283.785184] Subtest dsc-with-formats: SKIP (0.001s)
[283.826511] [055/133] (738s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[283.924816] Starting subtest: plane-downscale-factor-0-75-with-rotation
[283.926986] Starting dynamic subtest: pipe-A
[284.164483] Dynamic subtest pipe-A: SUCCESS (0.241s)
[284.173960] Starting dynamic subtest: pipe-B
[285.420307] Dynamic subtest pipe-B: SUCCESS (1.255s)
[285.428714] Starting dynamic subtest: pipe-C
[286.753132] Dynamic subtest pipe-C: SUCCESS (1.332s)
[286.762728] Starting dynamic subtest: pipe-D
[288.081941] Dynamic subtest pipe-D: SUCCESS (1.328s)
[288.084342] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.159s)
[289.298334] [056/133] (733s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[289.430202] Starting subtest: cursor-vs-flip-toggle
[320.088614] Subtest cursor-vs-flip-toggle: SUCCESS (30.657s)
[320.931706] [057/133] (701s left) kms_psr (fbc-psr-cursor-blt)
[321.031605] Starting subtest: fbc-psr-cursor-blt
[321.033689] Starting dynamic subtest: eDP-1
[321.037544] Dynamic subtest eDP-1: SKIP (0.000s)
[321.041510] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[321.114846] [058/133] (701s left) gem_ctx_exec (basic)
[321.168857] Starting subtest: basic
[321.173533] Subtest basic: SUCCESS (0.006s)
[321.324343] [059/133] (701s left) gem_sync (basic-store-all)
[321.407796] Starting subtest: basic-store-all
[325.938017] Subtest basic-store-all: SUCCESS (4.540s)
[326.135419] [060/133] (696s left) kms_flip (2x-blocking-wf_vblank)
[326.246830] Starting subtest: 2x-blocking-wf_vblank
[326.256073] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[326.387888] [061/133] (696s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[326.499466] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[326.501756] Starting dynamic subtest: pipe-A-eDP-1
[326.523564] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.534601] Starting dynamic subtest: pipe-B-eDP-1
[326.554797] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[326.562332] Starting dynamic subtest: pipe-C-eDP-1
[326.583168] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.590972] Starting dynamic subtest: pipe-D-eDP-1
[326.612587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.616943] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[328.793940] [062/133] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[328.889991] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[328.894182] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[329.008828] [063/133] (693s left) gem_ctx_persistence (idempotent)
[329.061268] Starting subtest: idempotent
[329.063532] Subtest idempotent: SUCCESS (0.000s)
[329.201454] [064/133] (693s left) gem_flink_basic (basic)
[329.263469] Starting subtest: basic
[329.265418] Subtest basic: SUCCESS (0.000s)
[329.390472] [065/133] (693s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[329.476259] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[329.501815] Starting dynamic subtest: pipe-A-plane-0
[329.912199] Dynamic subtest pipe-A-plane-0: SUCCESS (0.411s)
[329.920557] Starting dynamic subtest: pipe-A-plane-3
[330.168076] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[330.180262] Starting dynamic subtest: pipe-A-plane-5
[330.184061] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[331.272812] Starting dynamic subtest: pipe-B-plane-0
[331.698307] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[331.707091] Starting dynamic subtest: pipe-B-plane-3
[331.944194] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[331.953073] Starting dynamic subtest: pipe-B-plane-5
[331.957558] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[332.257863] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.782s)
[333.069120] [066/133] (689s left) kms_cursor_crc (cursor-random-512x512)
[333.358440] Starting subtest: cursor-random-512x512
[333.362816] Subtest cursor-random-512x512: SKIP (0.001s)
[333.571691] [067/133] (689s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[333.953275] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[334.759423] [068/133] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[334.868134] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[334.872708] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[334.972546] [069/133] (688s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[335.080308] Starting subtest: psr-rgb565-draw-render
[342.106411] Subtest psr-rgb565-draw-render: SUCCESS (7.028s)
[342.253374] [070/133] (680s left) perf (unprivileged-single-ctx-counters)
[342.370180] Starting subtest: unprivileged-single-ctx-counters
[342.374443] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[342.413341] [071/133] (680s left) kms_cursor_edge_walk (128x128-top-edge)
[342.507097] Starting subtest: 128x128-top-edge
[342.509334] Starting dynamic subtest: pipe-A-eDP-1
[345.966889] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.456s)
[345.976702] Starting dynamic subtest: pipe-D-eDP-1
[349.083053] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[349.085216] Subtest 128x128-top-edge: SUCCESS (6.574s)
[349.913390] [072/133] (673s left) i915_drm_fdinfo (memory-info-resident)
[349.950239] Starting subtest: memory-info-resident
[349.952560] Starting dynamic subtest: smem0
[352.796240] Dynamic subtest smem0: SUCCESS (2.847s)
[352.798592] Subtest memory-info-resident: SUCCESS (2.848s)
[352.883176] [073/133] (670s left) kms_pm_rpm (dpms-lpsp)
[355.013485] Starting subtest: dpms-lpsp
[355.327572] Subtest dpms-lpsp: SUCCESS (0.314s)
[355.438300] [074/133] (667s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[355.550826] Starting subtest: cursorA-vs-flipA-legacy
[366.696026] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.142s)
[367.536449] [075/133] (655s left) gen9_exec_parse (allowed-single)
[367.604976] Subtest allowed-single: SKIP (0.000s)
[367.684122] [076/133] (655s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[367.782550] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[367.784666] Starting dynamic subtest: pipe-A-eDP-1
[367.806541] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.817073] Starting dynamic subtest: pipe-B-eDP-1
[367.837808] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.846154] Starting dynamic subtest: pipe-C-eDP-1
[367.867163] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.875768] Starting dynamic subtest: pipe-D-eDP-1
[367.898246] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.902280] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.005s)
[370.092170] [077/133] (653s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[370.197708] Starting subtest: 4-tiled-32bpp-rotate-180
[371.610410] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.414s)
[371.798773] [078/133] (651s left) kms_lease (simple-lease)
[371.896063] Starting subtest: simple-lease
[371.897923] Starting dynamic subtest: pipe-A-eDP-1
[372.407601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.510s)
[372.416237] Starting dynamic subtest: pipe-B-eDP-1
[373.833959] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[373.843344] Starting dynamic subtest: pipe-C-eDP-1
[375.227364] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s)
[375.236597] Starting dynamic subtest: pipe-D-eDP-1
[376.628359] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[376.630752] Subtest simple-lease: SUCCESS (4.732s)
[377.442701] [079/133] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[377.557683] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[377.562147] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[377.661448] [080/133] (645s left) gem_userptr_blits (create-destroy-sync)
[377.738071] Starting subtest: create-destroy-sync
[382.750526] Subtest create-destroy-sync: SUCCESS (5.013s)
[382.920176] [081/133] (640s left) gem_exec_whisper (basic-queues-priority)
[382.999082] Starting subtest: basic-queues-priority
[405.911509] Subtest basic-queues-priority: SUCCESS (22.909s)
[406.122092] [082/133] (617s left) gem_exec_fence (expired-history)
[406.607916] Starting subtest: expired-history
[413.603921] Subtest expired-history: SUCCESS (6.997s)
[414.187714] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[414.191145] [083/133] (609s left) gem_exec_gttfill (all-engines)
[414.262355] Starting subtest: all-engines
[438.424701] Subtest all-engines: SUCCESS (24.163s)
[438.625466] [084/133] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[438.780605] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[446.020039] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.242s)
[446.186432] [085/133] (577s left) syncobj_timeline (reset-during-wait-for-submit)
[446.250575] Starting subtest: reset-during-wait-for-submit
[446.354717] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[446.444294] [086/133] (577s left) kms_vblank (query-forked)
[446.533690] Starting subtest: query-forked
[446.535798] Starting dynamic subtest: pipe-A-eDP-1
[448.352470] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[448.367232] Starting dynamic subtest: pipe-D-eDP-1
[450.835326] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.480s)
[450.837180] Subtest query-forked: SUCCESS (4.301s)
[451.719443] [087/133] (571s left) i915_selftest (mock)
[456.555719] Starting subtest: mock
[456.558797] Starting dynamic subtest: sanitycheck
[457.281346] Dynamic subtest sanitycheck: SUCCESS (0.725s)
[457.291101] Starting dynamic subtest: shmem
[458.014171] Dynamic subtest shmem: SUCCESS (0.731s)
[458.030545] Starting dynamic subtest: fence
[466.076061] Dynamic subtest fence: SUCCESS (8.059s)
[466.085559] Starting dynamic subtest: scatterlist
[467.832662] Dynamic subtest scatterlist: SUCCESS (1.754s)
[467.842621] Starting dynamic subtest: syncmap
[471.165904] Dynamic subtest syncmap: SUCCESS (3.331s)
[471.175576] Starting dynamic subtest: uncore
[471.886922] Dynamic subtest uncore: SUCCESS (0.719s)
[471.902384] Starting dynamic subtest: ring
[472.613052] Dynamic subtest ring: SUCCESS (0.723s)
[472.622699] Starting dynamic subtest: engine
[473.329147] Dynamic subtest engine: SUCCESS (0.714s)
[473.338841] Starting dynamic subtest: timelines
[477.207959] Dynamic subtest timelines: SUCCESS (3.876s)
[477.217203] Starting dynamic subtest: requests
[480.826033] Dynamic subtest requests: SUCCESS (3.616s)
[480.835284] Starting dynamic subtest: objects
[481.726661] Dynamic subtest objects: SUCCESS (0.898s)
[481.736228] Starting dynamic subtest: phys
[482.631597] Dynamic subtest phys: SUCCESS (0.903s)
[482.639967] Starting dynamic subtest: dmabuf
[483.511997] Dynamic subtest dmabuf: SUCCESS (0.878s)
[483.521719] Starting dynamic subtest: vma
[488.997076] Dynamic subtest vma: SUCCESS (5.483s)
[489.006626] Starting dynamic subtest: evict
[490.492569] Dynamic subtest evict: SUCCESS (1.493s)
[490.501681] Starting dynamic subtest: gtt
[493.732354] Dynamic subtest gtt: SUCCESS (3.237s)
[493.741199] Starting dynamic subtest: hugepages
[494.722372] Dynamic subtest hugepages: SUCCESS (0.988s)
[494.731456] Starting dynamic subtest: memory_region
[497.372398] Dynamic subtest memory_region: SUCCESS (2.647s)
[497.375262] Subtest mock: SUCCESS (40.816s)
[497.404819] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[497.405508] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[497.408636] [088/133] (526s left) perf_pmu (busy-check-all)
[498.913068] Starting subtest: busy-check-all
[498.915284] Starting dynamic subtest: rcs0
[499.502832] Dynamic subtest rcs0: SUCCESS (0.589s)
[499.514755] Starting dynamic subtest: bcs0
[500.053311] Dynamic subtest bcs0: SUCCESS (0.549s)
[500.063714] Starting dynamic subtest: vcs0
[501.909818] Dynamic subtest vcs0: SUCCESS (1.854s)
[501.920727] Starting dynamic subtest: vcs1
[503.893672] Dynamic subtest vcs1: SUCCESS (1.980s)
[503.905211] Starting dynamic subtest: vecs0
[505.878232] Dynamic subtest vecs0: SUCCESS (1.982s)
[505.888963] Starting dynamic subtest: ccs0
[506.428584] Dynamic subtest ccs0: SUCCESS (0.549s)
[506.431066] Subtest busy-check-all: SUCCESS (7.516s)
[506.504019] [FACT perf_pmu (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[506.505157] [FACT perf_pmu (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[506.508807] [089/133] (517s left) gem_exec_params (no-blt)
[506.575378] Starting subtest: no-blt
[506.577603] Subtest no-blt: SUCCESS (0.003s)
[506.721133] [090/133] (517s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[506.822873] Starting subtest: basic-max-pipe-crc-check
[506.827233] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[506.868990] [091/133] (517s left) perf (gen8-unprivileged-single-ctx-counters)
[507.016010] Starting subtest: gen8-unprivileged-single-ctx-counters
[507.020262] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[507.061976] [092/133] (516s left) kms_rotation_crc (cursor-rotation-180)
[507.157518] Starting subtest: cursor-rotation-180
[508.863608] Subtest cursor-rotation-180: SUCCESS (1.705s)
[510.082560] [093/133] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[510.175682] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[510.179721] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[510.308494] [094/133] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[510.404623] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[510.408734] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[510.515412] [095/133] (513s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[510.573036] Starting subtest: framebuffer-vs-set-tiling
[510.577640] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[510.736171] [096/133] (513s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[511.264063] Starting subtest: syncobj-timeline-multiple-ext-nodes
[511.267062] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[512.990909] [097/133] (511s left) kms_flip (2x-nonexisting-fb-interruptible)
[513.090802] Starting subtest: 2x-nonexisting-fb-interruptible
[513.102625] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[513.229757] [098/133] (510s left) kms_psr (psr2-sprite-plane-move)
[513.313143] Starting subtest: psr2-sprite-plane-move
[513.315333] Starting dynamic subtest: eDP-1
[515.086652] Dynamic subtest eDP-1: SUCCESS (1.774s)
[515.088819] Subtest psr2-sprite-plane-move: SUCCESS (1.775s)
[515.947377] [099/133] (508s left) kms_psr (fbc-psr2-cursor-plane-move)
[516.051044] Starting subtest: fbc-psr2-cursor-plane-move
[516.053417] Starting dynamic subtest: eDP-1
[516.057824] Dynamic subtest eDP-1: SKIP (0.000s)
[516.062279] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[516.134485] [100/133] (508s left) kms_rotation_crc (bad-pixel-format)
[516.237044] Starting subtest: bad-pixel-format
[516.241492] Subtest bad-pixel-format: SKIP (0.001s)
[516.346521] [101/133] (507s left) kms_invalid_mode (bad-vsync-end)
[516.445227] Starting subtest: bad-vsync-end
[516.447491] Starting dynamic subtest: pipe-A-eDP-1
[516.731634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[516.740756] Starting dynamic subtest: pipe-B-eDP-1
[516.742727] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[516.750606] Starting dynamic subtest: pipe-C-eDP-1
[516.752987] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[516.760644] Starting dynamic subtest: pipe-D-eDP-1
[516.763078] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[516.765308] Subtest bad-vsync-end: SUCCESS (0.290s)
[517.560230] [102/133] (506s left) gem_exec_schedule (preempt-user)
[517.628040] Starting subtest: preempt-user
[517.630193] Starting dynamic subtest: rcs0
[517.642178] Dynamic subtest rcs0: SUCCESS (0.023s)
[517.653207] Starting dynamic subtest: bcs0
[517.661314] Dynamic subtest bcs0: SUCCESS (0.018s)
[517.669572] Starting dynamic subtest: vcs0
[517.680788] Dynamic subtest vcs0: SUCCESS (0.019s)
[517.689337] Starting dynamic subtest: vcs1
[517.701921] Dynamic subtest vcs1: SUCCESS (0.020s)
[517.710192] Starting dynamic subtest: vecs0
[517.720413] Dynamic subtest vecs0: SUCCESS (0.018s)
[517.728644] Starting dynamic subtest: ccs0
[517.739622] Dynamic subtest ccs0: SUCCESS (0.019s)
[517.741881] Subtest preempt-user: SUCCESS (0.121s)
[519.043589] [103/133] (505s left) syncobj_wait (wait-zero-handles)
[519.099684] Starting subtest: wait-zero-handles
[519.101585] Subtest wait-zero-handles: SUCCESS (0.000s)
[519.212191] [104/133] (505s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[519.333200] Starting subtest: basic-flip-before-cursor-varying-size
[520.290048] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.957s)
[521.110390] [105/133] (503s left) gem_softpin (softpin)
[521.167853] Starting subtest: softpin
[553.389691] Subtest softpin: SUCCESS (32.217s)
[553.548091] [106/133] (470s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[553.670707] Starting subtest: 2x-cursor-vs-flip-legacy
[553.675252] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[553.837407] [107/133] (470s left) kms_getfb (getfb-reject-nv12)
[553.932973] Starting subtest: getfb-reject-nv12
[553.935260] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[554.047104] [108/133] (470s left) gem_ctx_persistence (engines-persistence)
[554.115490] Starting subtest: engines-persistence
[554.117474] Starting dynamic subtest: rcs0
[554.916665] Dynamic subtest rcs0: SUCCESS (0.803s)
[554.929571] Starting dynamic subtest: bcs0
[555.685058] Dynamic subtest bcs0: SUCCESS (0.766s)
[555.697786] Starting dynamic subtest: vcs0
[556.472840] Dynamic subtest vcs0: SUCCESS (0.783s)
[556.484030] Starting dynamic subtest: vcs1
[557.299280] Dynamic subtest vcs1: SUCCESS (0.828s)
[557.312085] Starting dynamic subtest: vecs0
[558.085410] Dynamic subtest vecs0: SUCCESS (0.784s)
[558.096236] Starting dynamic subtest: ccs0
[558.964566] Dynamic subtest ccs0: SUCCESS (0.877s)
[558.967299] Subtest engines-persistence: SUCCESS (4.854s)
[559.063391] [109/133] (465s left) gem_tiled_blits (basic)
[559.138612] Subtest basic: SKIP (0.000s)
[559.218624] [110/133] (465s left) kms_chamelium_color (ctm-green-to-red)
[559.315173] Subtest ctm-green-to-red: SKIP (0.000s)
[559.361412] [111/133] (465s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[559.447822] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[559.452130] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[559.526046] [112/133] (465s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[559.591634] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[559.698339] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[559.796088] [113/133] (464s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[559.863752] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[559.970027] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[560.055288] [114/133] (464s left) gem_ctx_shared (disjoint-timelines)
[560.126835] Starting subtest: disjoint-timelines
[560.157409] Subtest disjoint-timelines: SUCCESS (0.030s)
[560.413238] [115/133] (464s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[560.497426] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[560.501534] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[560.582940] [116/133] (464s left) kms_properties (get_properties-sanity-atomic)
[560.676214] Starting subtest: get_properties-sanity-atomic
[560.678445] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[560.779704] [117/133] (464s left) kms_addfb_basic (basic-x-tiled-legacy)
[560.826719] Starting subtest: basic-x-tiled-legacy
[560.831366] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[560.995456] [118/133] (463s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[561.112944] Starting subtest: yf-tiled-64bpp-rotate-180
[561.117417] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[561.239726] [119/133] (463s left) kms_content_protection (lic-type-0-hdcp14)
[561.376126] Starting subtest: lic-type-0-hdcp14
[561.379914] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[561.526205] [120/133] (463s left) perf_pmu (all-busy-check-all)
[561.564184] Starting subtest: all-busy-check-all
[562.902072] Subtest all-busy-check-all: SUCCESS (1.336s)
[563.033081] [121/133] (462s left) syncobj_timeline (single-wait-all-available-submitted)
[563.100922] Starting subtest: single-wait-all-available-submitted
[563.103120] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[563.228225] [122/133] (461s left) prime_vgem (basic-write)
[563.316746] Starting subtest: basic-write
[563.332289] Subtest basic-write: SKIP (0.013s)
[563.472432] [123/133] (461s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[563.576472] Starting subtest: x-tiled-16bpp-rotate-90
[563.596273] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[563.708794] [124/133] (461s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[563.839624] Starting subtest: 2x-cursor-vs-flip-atomic
[563.844221] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[563.995470] [125/133] (461s left) gem_tiled_pread_basic (basic)
[564.054855] Subtest basic: SKIP (0.000s)
[564.116921] [126/133] (461s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[564.223065] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[564.226639] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[564.340299] [127/133] (461s left) gem_spin_batch (resubmit-all)
[564.404925] Starting subtest: resubmit-all
[564.407018] Starting dynamic subtest: rcs0
[564.417250] Dynamic subtest rcs0: SUCCESS (0.012s)
[564.428622] Starting dynamic subtest: bcs0
[564.430662] Dynamic subtest bcs0: SUCCESS (0.002s)
[564.438222] Starting dynamic subtest: vcs0
[564.439763] Dynamic subtest vcs0: SUCCESS (0.002s)
[564.446832] Starting dynamic subtest: vcs1
[564.448467] Dynamic subtest vcs1: SUCCESS (0.002s)
[564.455384] Starting dynamic subtest: vecs0
[564.457105] Dynamic subtest vecs0: SUCCESS (0.002s)
[564.463993] Starting dynamic subtest: ccs0
[564.465637] Dynamic subtest ccs0: SUCCESS (0.002s)
[564.467309] Subtest resubmit-all: SUCCESS (0.026s)
[564.697625] [128/133] (460s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[564.793135] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[571.691396] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.899s)
[571.852260] [129/133] (453s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[571.966244] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[571.970593] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[572.058940] [130/133] (453s left) gem_mmap_wc (write-read)
[572.110701] Subtest write-read: SKIP (0.000s)
[572.183163] [131/133] (453s left) perf_pmu (busy-start)
[572.217881] Starting subtest: busy-start
[572.220286] Starting dynamic subtest: rcs0
[574.766285] Dynamic subtest rcs0: SUCCESS (2.549s)
[574.776732] Starting dynamic subtest: bcs0
[577.315284] Dynamic subtest bcs0: SUCCESS (2.547s)
[577.326077] Starting dynamic subtest: vcs0
[580.885029] Dynamic subtest vcs0: SUCCESS (3.566s)
[580.894198] Starting dynamic subtest: vcs1
[584.917480] Dynamic subtest vcs1: SUCCESS (4.029s)
[584.927935] Starting dynamic subtest: vecs0
[588.949362] Dynamic subtest vecs0: SUCCESS (4.029s)
[588.960470] Starting dynamic subtest: ccs0
[591.496687] Dynamic subtest ccs0: SUCCESS (2.547s)
[591.499352] Subtest busy-start: SUCCESS (19.282s)
[591.630589] [132/133] (433s left) gem_exec_balancer (bonded-false-hang)
[591.896531] Starting subtest: bonded-false-hang
[591.901447] Subtest bonded-false-hang: SKIP (0.000s)
[592.040473] [133/133] (433s left) kms_chamelium_frames (hdmi-crc-multiple)
[592.424288] Subtest hdmi-crc-multiple: SKIP (0.000s)
[593.215692] 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.