[57.475980] Initializing watchdogs
[57.476046]   /dev/watchdog0
[57.489161] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.493503] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.495728] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.499171] [001/133] (960s left) core_auth (getclient-master-drop)
[57.550891] Starting subtest: getclient-master-drop
[57.572903] Subtest getclient-master-drop: SUCCESS (0.023s)
[57.698655] [002/133] (960s left) gem_workarounds (reset)
[57.766058] Starting subtest: reset
[57.872386] Subtest reset: SUCCESS (0.105s)
[58.028998] [003/133] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[58.133649] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[58.137659] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[58.211109] [004/133] (959s left) i915_hangman (hangcheck-unterminated)
[58.276744] Starting subtest: hangcheck-unterminated
[69.878372] Subtest hangcheck-unterminated: SUCCESS (11.600s)
[70.006209] [005/133] (948s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[70.109376] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[70.111670] Starting dynamic subtest: pipe-A-eDP-1
[70.231803] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s)
[70.241488] Starting dynamic subtest: pipe-B-eDP-1
[71.439818] Dynamic subtest pipe-B-eDP-1: SKIP (1.205s)
[71.444608] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.331s)
[72.726537] [006/133] (945s left) gem_exec_whisper (basic-normal-all)
[72.784746] Starting subtest: basic-normal-all
[75.201410] Subtest basic-normal-all: SUCCESS (2.417s)
[75.392366] [007/133] (942s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[75.498346] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[75.500733] Starting dynamic subtest: pipe-A-eDP-1
[91.949092] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.457s)
[91.958809] Starting dynamic subtest: pipe-B-eDP-1
[109.099401] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.151s)
[109.101802] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.610s)
[109.982116] [008/133] (908s left) dmabuf (all-tests)
[110.023444] Starting subtest: all-tests
[110.025595] Starting dynamic subtest: sanitycheck
[110.159787] Dynamic subtest sanitycheck: SUCCESS (0.137s)
[110.169576] Starting dynamic subtest: dma_fence
[110.452607] Dynamic subtest dma_fence: SUCCESS (0.292s)
[110.463183] Starting dynamic subtest: dma_fence_chain
[118.857754] Dynamic subtest dma_fence_chain: SUCCESS (8.404s)
[118.866666] Starting dynamic subtest: dma_fence_unwrap
[118.991806] Dynamic subtest dma_fence_unwrap: SUCCESS (0.133s)
[119.001792] Starting dynamic subtest: dma_resv
[119.119975] Dynamic subtest dma_resv: SUCCESS (0.127s)
[119.122850] Subtest all-tests: SUCCESS (9.098s)
[119.198090] [009/133] (899s left) gem_render_copy_redux (interruptible)
[119.270245] Starting subtest: interruptible
[119.671589] Subtest interruptible: SUCCESS (0.403s)
[119.848196] [010/133] (898s left) gem_exec_schedule (pi-shared-iova)
[120.050434] Starting subtest: pi-shared-iova
[120.052853] Starting dynamic subtest: rcs0
[120.186451] Dynamic subtest rcs0: SUCCESS (0.138s)
[120.196741] Starting dynamic subtest: vcs0
[120.276761] Dynamic subtest vcs0: SUCCESS (0.091s)
[120.285530] Starting dynamic subtest: vcs1
[120.364226] Dynamic subtest vcs1: SUCCESS (0.087s)
[120.375808] Starting dynamic subtest: vecs0
[120.439296] Dynamic subtest vecs0: SUCCESS (0.075s)
[120.450165] Starting dynamic subtest: ccs0
[120.563861] Dynamic subtest ccs0: SUCCESS (0.123s)
[120.566585] Subtest pi-shared-iova: SUCCESS (0.515s)
[122.073188] [011/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[122.173650] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[122.177782] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[122.283892] [012/133] (896s left) gem_render_copy (y-tiled)
[122.356157] Starting subtest: y-tiled
[122.360784] Subtest y-tiled: SKIP (0.000s)
[122.546694] [013/133] (895s left) kms_busy (basic)
[122.655796] Starting subtest: basic
[122.658515] Starting dynamic subtest: flip
[123.272798] Dynamic subtest flip: SUCCESS (0.617s)
[123.282940] Starting dynamic subtest: modeset
[126.708378] Dynamic subtest modeset: SUCCESS (3.435s)
[126.710734] Subtest basic: SUCCESS (4.053s)
[127.516218] [014/133] (890s left) kms_psr (psr2-cursor-blt)
[127.623770] Starting subtest: psr2-cursor-blt
[127.626083] Starting dynamic subtest: eDP-1
[129.287587] Dynamic subtest eDP-1: SUCCESS (1.661s)
[129.289794] Subtest psr2-cursor-blt: SUCCESS (1.662s)
[130.094911] [015/133] (888s left) kms_flip (2x-plain-flip-fb-recreate)
[130.203295] Starting subtest: 2x-plain-flip-fb-recreate
[130.211601] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[130.322512] [016/133] (888s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[130.408088] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[130.412430] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[130.513602] [017/133] (888s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[130.614340] Starting subtest: fbcpsr-stridechange
[137.017684] Subtest fbcpsr-stridechange: SUCCESS (6.407s)
[137.196611] [018/133] (881s left) gem_mmap_gtt (close-race)
[137.260171] Subtest close-race: SKIP (0.000s)
[137.327488] [019/133] (881s left) perf_pmu (semaphore-wait)
[137.365982] Starting subtest: semaphore-wait
[137.368297] Starting dynamic subtest: rcs0
[137.878915] Dynamic subtest rcs0: SUCCESS (0.513s)
[137.890996] Starting dynamic subtest: bcs0
[138.391459] Dynamic subtest bcs0: SUCCESS (0.511s)
[138.402690] Starting dynamic subtest: vcs0
[138.903302] Dynamic subtest vcs0: SUCCESS (0.511s)
[138.914142] Starting dynamic subtest: vcs1
[139.414396] Dynamic subtest vcs1: SUCCESS (0.509s)
[139.425471] Starting dynamic subtest: vecs0
[139.926022] Dynamic subtest vecs0: SUCCESS (0.510s)
[139.936206] Starting dynamic subtest: ccs0
[140.441063] Dynamic subtest ccs0: SUCCESS (0.513s)
[140.444077] Subtest semaphore-wait: SUCCESS (3.076s)
[141.929529] [020/133] (876s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[142.054914] Starting subtest: primary-4-tiled-reflect-x-0
[149.120271] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.065s)
[150.348471] [021/133] (868s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[150.448792] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[151.117124] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[151.332953] [022/133] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[151.443052] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[151.447471] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[151.565228] [023/133] (867s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[151.680063] Starting subtest: plane-upscale-20x20-with-pixel-format
[151.682452] Starting dynamic subtest: pipe-A
[152.726930] Dynamic subtest pipe-A: SUCCESS (1.049s)
[152.737134] Starting dynamic subtest: pipe-B
[154.842374] Dynamic subtest pipe-B: SUCCESS (2.115s)
[154.851270] Starting dynamic subtest: pipe-C
[156.043454] Dynamic subtest pipe-C: SUCCESS (1.200s)
[156.057748] Starting dynamic subtest: pipe-D
[157.281919] Dynamic subtest pipe-D: SUCCESS (1.238s)
[157.284237] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.604s)
[158.471449] [024/133] (860s left) kms_color (ctm-negative)
[158.584313] Starting subtest: ctm-negative
[158.586592] Starting dynamic subtest: pipe-A-eDP-1
[159.281297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[159.291668] Starting dynamic subtest: pipe-B-eDP-1
[160.716975] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[160.726172] Starting dynamic subtest: pipe-C-eDP-1
[162.067358] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[162.076682] Starting dynamic subtest: pipe-D-eDP-1
[163.398282] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[163.400156] Subtest ctm-negative: SUCCESS (4.814s)
[164.224334] [025/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[164.338814] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[164.342974] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[164.437865] [026/133] (854s left) kms_addfb_basic (too-wide)
[164.546136] Starting subtest: too-wide
[164.548428] Subtest too-wide: SUCCESS (0.000s)
[164.683075] [027/133] (854s left) syncobj_basic (bad-flags-fd-to-handle)
[164.743367] Starting subtest: bad-flags-fd-to-handle
[164.745763] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[164.886232] [028/133] (854s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[164.989064] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[164.991289] Starting dynamic subtest: pipe-A-eDP-1
[165.013878] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[165.024080] Starting dynamic subtest: pipe-B-eDP-1
[165.045513] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[165.053189] Starting dynamic subtest: pipe-C-eDP-1
[165.074886] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[165.082533] Starting dynamic subtest: pipe-D-eDP-1
[165.104317] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[165.108685] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[167.280524] [029/133] (851s left) kms_big_fb (linear-16bpp-rotate-270)
[167.383673] Starting subtest: linear-16bpp-rotate-270
[167.402256] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[167.545577] [030/133] (851s left) kms_pm_rpm (legacy-planes-dpms)
[169.078678] Starting subtest: legacy-planes-dpms
[169.080832] Starting dynamic subtest: plane-64
[177.396067] Dynamic subtest plane-64: SUCCESS (8.318s)
[177.404999] Starting dynamic subtest: plane-94
[185.731579] Dynamic subtest plane-94: SUCCESS (8.336s)
[185.743439] Starting dynamic subtest: plane-124
[194.350057] Dynamic subtest plane-124: SUCCESS (8.616s)
[194.361226] Starting dynamic subtest: plane-134
[202.667351] Dynamic subtest plane-134: SUCCESS (8.314s)
[202.670241] Subtest legacy-planes-dpms: SUCCESS (33.592s)
[203.054767] [031/133] (816s left) syncobj_timeline (multi-wait-all-available-signaled)
[203.116853] Starting subtest: multi-wait-all-available-signaled
[203.119374] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[203.231730] [032/133] (815s left) gem_pxp (create-regular-buffer)
[203.359043] Starting subtest: create-regular-buffer
[203.361662] Subtest create-regular-buffer: SUCCESS (0.000s)
[203.492286] [033/133] (815s left) gem_userptr_blits (sync-overlap)
[203.571393] Starting subtest: sync-overlap
[203.573710] Subtest sync-overlap: SUCCESS (0.000s)
[203.720086] [034/133] (815s left) kms_cursor_crc (cursor-offscreen-256x85)
[203.982958] Starting subtest: cursor-offscreen-256x85
[204.029755] Subtest cursor-offscreen-256x85: SKIP (0.041s)
[204.230520] [035/133] (815s left) kms_vblank (wait-forked-hang)
[204.325550] Starting subtest: wait-forked-hang
[204.327356] Starting dynamic subtest: pipe-A-eDP-1
[230.678062] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.351s)
[230.691856] Starting dynamic subtest: pipe-D-eDP-1
[255.706737] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.025s)
[255.708718] Subtest wait-forked-hang: SUCCESS (51.380s)
[256.528185] [036/133] (762s left) gem_exec_reloc (basic-wc-active)
[256.581669] Subtest basic-wc-active: SKIP (0.000s)
[256.654302] [037/133] (762s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[256.748960] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[256.751153] Starting dynamic subtest: pipe-A-eDP-1
[256.770608] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[256.781141] Starting dynamic subtest: pipe-B-eDP-1
[256.800222] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[256.808586] Starting dynamic subtest: pipe-C-eDP-1
[256.828130] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[256.838402] Starting dynamic subtest: pipe-D-eDP-1
[256.857983] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[256.860197] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[259.003090] [038/133] (760s left) kms_flip (2x-dpms-vs-vblank-race)
[259.094608] Starting subtest: 2x-dpms-vs-vblank-race
[259.102506] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[259.213252] [039/133] (760s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[259.317661] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[259.321594] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[259.392370] [040/133] (760s left) kms_atomic (plane-cursor-legacy)
[259.488210] Starting subtest: plane-cursor-legacy
[259.490567] Starting dynamic subtest: pipe-A-eDP-1
[259.862377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s)
[259.864672] Subtest plane-cursor-legacy: SUCCESS (0.374s)
[260.758210] [041/133] (758s left) gem_partial_pwrite_pread (write-uncached)
[260.828606] Subtest write-uncached: SKIP (0.000s)
[260.903139] [042/133] (758s left) gem_create (create-ext-cpu-access-sanity-check)
[261.074905] Starting subtest: create-ext-cpu-access-sanity-check
[261.079386] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[261.168442] [043/133] (758s left) gem_mmap_gtt (zero-extend)
[261.236539] Subtest zero-extend: SKIP (0.000s)
[261.301969] [044/133] (758s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[261.390154] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[261.394290] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[261.474163] [045/133] (758s left) api_intel_allocator (fork-simple-stress)
[261.530603] Starting subtest: fork-simple-stress
[266.924530] Subtest fork-simple-stress: SUCCESS (5.396s)
[267.079445] [046/133] (752s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[267.214112] Starting subtest: y-tiled-64bpp-rotate-180
[267.218712] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[267.338998] [047/133] (752s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[267.415214] Starting subtest: yf-tiled-to-vebox-y-tiled
[267.419424] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[267.625479] [048/133] (752s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[267.749074] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[274.297292] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.551s)
[274.464784] [049/133] (745s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[274.528308] Starting subtest: protected-encrypted-src-copy-not-readible
[274.640955] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[274.785418] [050/133] (745s left) i915_pm_rps (basic-api)
[274.853562] Starting subtest: basic-api
[274.857740] Subtest basic-api: SKIP (0.001s)
[274.988387] [051/133] (745s left) gem_busy (busy)
[275.051321] Starting subtest: busy
[275.053785] Starting dynamic subtest: all-engines
[275.115583] Dynamic subtest all-engines: SUCCESS (0.064s)
[275.125281] Starting dynamic subtest: rcs0
[276.891240] Dynamic subtest rcs0: SUCCESS (1.773s)
[276.902195] Starting dynamic subtest: bcs0
[276.960227] Dynamic subtest bcs0: SUCCESS (0.067s)
[276.970412] Starting dynamic subtest: vcs0
[277.002512] Dynamic subtest vcs0: SUCCESS (0.041s)
[277.011703] Starting dynamic subtest: vcs1
[278.939270] Dynamic subtest vcs1: SUCCESS (1.932s)
[278.949571] Starting dynamic subtest: vecs0
[280.922871] Dynamic subtest vecs0: SUCCESS (1.982s)
[280.933059] Starting dynamic subtest: ccs0
[282.907926] Dynamic subtest ccs0: SUCCESS (1.984s)
[282.910579] Subtest busy: SUCCESS (7.853s)
[283.301357] [052/133] (736s left) kms_dp_link_training (non-uhbr-sst)
[283.418830] Starting subtest: non-uhbr-sst
[283.427028] Subtest non-uhbr-sst: SKIP (0.000s)
[283.499030] [053/133] (736s left) gem_unfence_active_buffers
[283.676263] [054/133] (736s left) kms_dsc (dsc-with-formats)
[283.770355] Starting subtest: dsc-with-formats
[283.810172] Subtest dsc-with-formats: SKIP (0.001s)
[283.853559] [055/133] (736s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[283.946115] Starting subtest: plane-downscale-factor-0-75-with-rotation
[283.948404] Starting dynamic subtest: pipe-A
[284.174101] Dynamic subtest pipe-A: SUCCESS (0.230s)
[284.182365] Starting dynamic subtest: pipe-B
[285.447600] Dynamic subtest pipe-B: SUCCESS (1.272s)
[285.456237] Starting dynamic subtest: pipe-C
[286.759970] Dynamic subtest pipe-C: SUCCESS (1.311s)
[286.769170] Starting dynamic subtest: pipe-D
[288.110982] Dynamic subtest pipe-D: SUCCESS (1.350s)
[288.113428] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.168s)
[289.283570] [056/133] (730s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[289.398064] Starting subtest: cursor-vs-flip-toggle
[320.185254] Subtest cursor-vs-flip-toggle: SUCCESS (30.781s)
[321.011546] [057/133] (699s left) kms_psr (fbc-psr-cursor-blt)
[321.109384] Starting subtest: fbc-psr-cursor-blt
[321.111616] Starting dynamic subtest: eDP-1
[321.116081] Dynamic subtest eDP-1: SKIP (0.000s)
[321.120440] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[321.195947] [058/133] (699s left) gem_ctx_exec (basic)
[321.256564] Starting subtest: basic
[321.262274] Subtest basic: SUCCESS (0.007s)
[321.418285] [059/133] (698s left) gem_sync (basic-store-all)
[321.494260] Starting subtest: basic-store-all
[326.061760] Subtest basic-store-all: SUCCESS (4.577s)
[326.256460] [060/133] (694s left) kms_flip (2x-blocking-wf_vblank)
[326.372391] Starting subtest: 2x-blocking-wf_vblank
[326.381405] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[326.467872] [061/133] (693s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[326.565232] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[326.567484] Starting dynamic subtest: pipe-A-eDP-1
[326.589454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.598568] Starting dynamic subtest: pipe-B-eDP-1
[326.619607] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[326.627602] Starting dynamic subtest: pipe-C-eDP-1
[326.648834] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.656776] Starting dynamic subtest: pipe-D-eDP-1
[326.678687] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.682794] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[328.886790] [062/133] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[328.997749] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[329.001967] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[329.105510] [063/133] (691s left) gem_ctx_persistence (idempotent)
[329.162883] Starting subtest: idempotent
[329.165264] Subtest idempotent: SUCCESS (0.000s)
[329.281968] [064/133] (691s left) gem_flink_basic (basic)
[329.335991] Starting subtest: basic
[329.338317] Subtest basic: SUCCESS (0.000s)
[329.438502] [065/133] (691s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[329.524294] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[329.549794] Starting dynamic subtest: pipe-A-plane-0
[329.971564] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[329.979950] Starting dynamic subtest: pipe-A-plane-3
[330.227177] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[330.236049] Starting dynamic subtest: pipe-A-plane-5
[330.239728] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[331.356795] Starting dynamic subtest: pipe-B-plane-0
[331.794602] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[331.806158] Starting dynamic subtest: pipe-B-plane-3
[332.050259] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[332.059624] Starting dynamic subtest: pipe-B-plane-5
[332.063849] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[332.367268] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.843s)
[333.237370] [066/133] (687s left) kms_cursor_crc (cursor-random-512x512)
[333.511445] Starting subtest: cursor-random-512x512
[333.515693] Subtest cursor-random-512x512: SKIP (0.001s)
[333.717759] [067/133] (686s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[334.120056] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[334.948467] [068/133] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[335.055899] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[335.060132] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[335.183821] [069/133] (685s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[335.284108] Starting subtest: psr-rgb565-draw-render
[342.296876] Subtest psr-rgb565-draw-render: SUCCESS (7.015s)
[342.442048] [070/133] (678s left) perf (unprivileged-single-ctx-counters)
[342.558278] Starting subtest: unprivileged-single-ctx-counters
[342.562864] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[342.596392] [071/133] (678s left) kms_cursor_edge_walk (128x128-top-edge)
[342.693749] Starting subtest: 128x128-top-edge
[342.696190] Starting dynamic subtest: pipe-A-eDP-1
[346.158038] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[346.168082] Starting dynamic subtest: pipe-D-eDP-1
[349.279633] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[349.281953] Subtest 128x128-top-edge: SUCCESS (6.586s)
[350.113383] [072/133] (670s left) i915_drm_fdinfo (memory-info-resident)
[350.152496] Starting subtest: memory-info-resident
[350.154748] Starting dynamic subtest: smem0
[352.886910] Dynamic subtest smem0: SUCCESS (2.736s)
[352.889255] Subtest memory-info-resident: SUCCESS (2.737s)
[352.974358] [073/133] (667s left) kms_pm_rpm (dpms-lpsp)
[355.104426] Starting subtest: dpms-lpsp
[355.408047] Subtest dpms-lpsp: SUCCESS (0.306s)
[355.493355] [074/133] (665s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[355.612905] Starting subtest: cursorA-vs-flipA-legacy
[366.730351] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.117s)
[367.599419] [075/133] (653s left) gen9_exec_parse (allowed-single)
[367.668470] Subtest allowed-single: SKIP (0.000s)
[367.733788] [076/133] (653s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[367.835062] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[367.837328] Starting dynamic subtest: pipe-A-eDP-1
[367.859870] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.869846] Starting dynamic subtest: pipe-B-eDP-1
[367.891901] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.901676] Starting dynamic subtest: pipe-C-eDP-1
[367.923050] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.931063] Starting dynamic subtest: pipe-D-eDP-1
[367.952778] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.957031] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[370.089116] [077/133] (650s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[370.192225] Starting subtest: 4-tiled-32bpp-rotate-180
[371.525059] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.334s)
[371.702685] [078/133] (649s left) kms_lease (simple-lease)
[371.794137] Starting subtest: simple-lease
[371.795919] Starting dynamic subtest: pipe-A-eDP-1
[372.318748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.524s)
[372.327691] Starting dynamic subtest: pipe-B-eDP-1
[373.727458] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[373.737235] Starting dynamic subtest: pipe-C-eDP-1
[375.114507] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[375.123857] Starting dynamic subtest: pipe-D-eDP-1
[376.522227] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[376.524530] Subtest simple-lease: SUCCESS (4.729s)
[377.345104] [079/133] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[377.439616] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[377.443671] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[377.561777] [080/133] (643s left) gem_userptr_blits (create-destroy-sync)
[377.633668] Starting subtest: create-destroy-sync
[382.643323] Subtest create-destroy-sync: SUCCESS (5.010s)
[382.796652] [081/133] (638s left) gem_exec_whisper (basic-queues-priority)
[382.872835] Starting subtest: basic-queues-priority
[405.977081] Subtest basic-queues-priority: SUCCESS (23.101s)
[406.182190] [082/133] (615s left) gem_exec_fence (expired-history)
[406.658935] Starting subtest: expired-history
[413.617203] Subtest expired-history: SUCCESS (6.958s)
[415.196859] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[415.200379] [083/133] (606s left) gem_exec_gttfill (all-engines)
[415.281422] Starting subtest: all-engines
[439.044192] Subtest all-engines: SUCCESS (23.762s)
[439.254960] [084/133] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[439.405641] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[446.680203] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.276s)
[446.836484] [085/133] (574s left) syncobj_timeline (reset-during-wait-for-submit)
[446.910797] Starting subtest: reset-during-wait-for-submit
[447.013841] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[447.099255] [086/133] (574s left) kms_vblank (query-forked)
[447.186267] Starting subtest: query-forked
[447.188538] Starting dynamic subtest: pipe-A-eDP-1
[448.996320] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[449.010478] Starting dynamic subtest: pipe-D-eDP-1
[451.465469] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.469s)
[451.467825] Subtest query-forked: SUCCESS (4.279s)
[452.333183] [087/133] (569s left) i915_selftest (mock)
[457.233259] Starting subtest: mock
[457.235951] Starting dynamic subtest: sanitycheck
[457.984515] Dynamic subtest sanitycheck: SUCCESS (0.751s)
[457.992917] Starting dynamic subtest: shmem
[458.729105] Dynamic subtest shmem: SUCCESS (0.742s)
[458.738329] Starting dynamic subtest: fence
[466.149369] Dynamic subtest fence: SUCCESS (7.417s)
[466.158721] Starting dynamic subtest: scatterlist
[467.913205] Dynamic subtest scatterlist: SUCCESS (1.762s)
[467.922363] Starting dynamic subtest: syncmap
[471.291956] Dynamic subtest syncmap: SUCCESS (3.376s)
[471.301176] Starting dynamic subtest: uncore
[472.031208] Dynamic subtest uncore: SUCCESS (0.737s)
[472.046532] Starting dynamic subtest: ring
[472.794049] Dynamic subtest ring: SUCCESS (0.760s)
[472.803519] Starting dynamic subtest: engine
[473.511073] Dynamic subtest engine: SUCCESS (0.715s)
[473.520426] Starting dynamic subtest: timelines
[477.525049] Dynamic subtest timelines: SUCCESS (3.988s)
[477.534674] Starting dynamic subtest: requests
[481.127251] Dynamic subtest requests: SUCCESS (3.623s)
[481.136702] Starting dynamic subtest: objects
[481.961857] Dynamic subtest objects: SUCCESS (0.833s)
[481.971549] Starting dynamic subtest: phys
[482.790638] Dynamic subtest phys: SUCCESS (0.827s)
[482.800207] Starting dynamic subtest: dmabuf
[483.656246] Dynamic subtest dmabuf: SUCCESS (0.863s)
[483.664098] Starting dynamic subtest: vma
[489.066063] Dynamic subtest vma: SUCCESS (5.408s)
[489.080359] Starting dynamic subtest: evict
[490.508537] Dynamic subtest evict: SUCCESS (1.440s)
[490.517827] Starting dynamic subtest: gtt
[493.777318] Dynamic subtest gtt: SUCCESS (3.267s)
[493.786533] Starting dynamic subtest: hugepages
[494.765499] Dynamic subtest hugepages: SUCCESS (0.986s)
[494.774622] Starting dynamic subtest: memory_region
[497.353278] Dynamic subtest memory_region: SUCCESS (2.585s)
[497.355857] Subtest mock: SUCCESS (40.119s)
[497.383627] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[497.384357] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[497.387559] [088/133] (524s left) perf_pmu (busy-check-all)
[498.888792] Starting subtest: busy-check-all
[498.891241] Starting dynamic subtest: rcs0
[499.469388] Dynamic subtest rcs0: SUCCESS (0.579s)
[499.480649] Starting dynamic subtest: bcs0
[500.019459] Dynamic subtest bcs0: SUCCESS (0.548s)
[500.030200] Starting dynamic subtest: vcs0
[501.913438] Dynamic subtest vcs0: SUCCESS (1.890s)
[501.931225] Starting dynamic subtest: vcs1
[503.830365] Dynamic subtest vcs1: SUCCESS (1.914s)
[503.841552] Starting dynamic subtest: vecs0
[505.878044] Dynamic subtest vecs0: SUCCESS (2.044s)
[505.888723] Starting dynamic subtest: ccs0
[506.430464] Dynamic subtest ccs0: SUCCESS (0.550s)
[506.432976] Subtest busy-check-all: SUCCESS (7.542s)
[506.488571] [FACT perf_pmu (busy-check-all)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[506.489723] [FACT perf_pmu (busy-check-all)] new: kernel.kmod_is_loaded.i915: true
[506.493245] [089/133] (515s left) gem_exec_params (no-blt)
[506.567959] Starting subtest: no-blt
[506.573674] Subtest no-blt: SUCCESS (0.006s)
[506.741311] [090/133] (514s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[506.831207] Starting subtest: basic-max-pipe-crc-check
[506.835665] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[506.882982] [091/133] (514s left) perf (gen8-unprivileged-single-ctx-counters)
[507.028754] Starting subtest: gen8-unprivileged-single-ctx-counters
[507.033098] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[507.071256] [092/133] (514s left) kms_rotation_crc (cursor-rotation-180)
[507.154304] Starting subtest: cursor-rotation-180
[508.646029] Subtest cursor-rotation-180: SUCCESS (1.492s)
[509.886663] [093/133] (511s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[509.986057] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[509.990685] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[510.111665] [094/133] (511s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[510.211041] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[510.215658] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[510.337121] [095/133] (511s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[510.405207] Starting subtest: framebuffer-vs-set-tiling
[510.409904] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[510.572355] [096/133] (511s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[511.094267] Starting subtest: syncobj-timeline-multiple-ext-nodes
[511.097095] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[513.048421] [097/133] (508s left) kms_flip (2x-nonexisting-fb-interruptible)
[513.151994] Starting subtest: 2x-nonexisting-fb-interruptible
[513.162557] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[513.291184] [098/133] (508s left) kms_psr (psr2-sprite-plane-move)
[513.382333] Starting subtest: psr2-sprite-plane-move
[513.384728] Starting dynamic subtest: eDP-1
[515.159413] Dynamic subtest eDP-1: SUCCESS (1.778s)
[515.161664] Subtest psr2-sprite-plane-move: SUCCESS (1.779s)
[516.020907] [099/133] (505s left) kms_psr (fbc-psr2-cursor-plane-move)
[516.121236] Starting subtest: fbc-psr2-cursor-plane-move
[516.123124] Starting dynamic subtest: eDP-1
[516.127090] Dynamic subtest eDP-1: SKIP (0.000s)
[516.131197] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[516.202551] [100/133] (505s left) kms_rotation_crc (bad-pixel-format)
[516.302996] Starting subtest: bad-pixel-format
[516.307444] Subtest bad-pixel-format: SKIP (0.001s)
[516.383968] [101/133] (505s left) kms_invalid_mode (bad-vsync-end)
[516.474513] Starting subtest: bad-vsync-end
[516.476748] Starting dynamic subtest: pipe-A-eDP-1
[516.755762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[516.764683] Starting dynamic subtest: pipe-B-eDP-1
[516.766625] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[516.773976] Starting dynamic subtest: pipe-C-eDP-1
[516.776346] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[516.784218] Starting dynamic subtest: pipe-D-eDP-1
[516.786544] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[516.788792] Subtest bad-vsync-end: SUCCESS (0.287s)
[517.561136] [102/133] (504s left) gem_exec_schedule (preempt-user)
[517.636929] Starting subtest: preempt-user
[517.639171] Starting dynamic subtest: rcs0
[517.650268] Dynamic subtest rcs0: SUCCESS (0.022s)
[517.659908] Starting dynamic subtest: bcs0
[517.670809] Dynamic subtest bcs0: SUCCESS (0.020s)
[517.678865] Starting dynamic subtest: vcs0
[517.690772] Dynamic subtest vcs0: SUCCESS (0.019s)
[517.699880] Starting dynamic subtest: vcs1
[517.711155] Dynamic subtest vcs1: SUCCESS (0.020s)
[517.719420] Starting dynamic subtest: vecs0
[517.730452] Dynamic subtest vecs0: SUCCESS (0.019s)
[517.738600] Starting dynamic subtest: ccs0
[517.750742] Dynamic subtest ccs0: SUCCESS (0.019s)
[517.753095] Subtest preempt-user: SUCCESS (0.123s)
[518.980356] [103/133] (503s left) syncobj_wait (wait-zero-handles)
[519.039604] Starting subtest: wait-zero-handles
[519.041814] Subtest wait-zero-handles: SUCCESS (0.000s)
[519.160576] [104/133] (502s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[519.287605] Starting subtest: basic-flip-before-cursor-varying-size
[520.236651] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.947s)
[521.084370] [105/133] (501s left) gem_softpin (softpin)
[521.154323] Starting subtest: softpin
[553.408885] Subtest softpin: SUCCESS (32.251s)
[553.564332] [106/133] (468s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[553.695286] Starting subtest: 2x-cursor-vs-flip-legacy
[553.699727] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[553.853058] [107/133] (468s left) kms_getfb (getfb-reject-nv12)
[553.956281] Starting subtest: getfb-reject-nv12
[553.958441] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[554.118439] [108/133] (468s left) gem_ctx_persistence (engines-persistence)
[554.179877] Starting subtest: engines-persistence
[554.182399] Starting dynamic subtest: rcs0
[554.998810] Dynamic subtest rcs0: SUCCESS (0.815s)
[555.009105] Starting dynamic subtest: bcs0
[555.784674] Dynamic subtest bcs0: SUCCESS (0.784s)
[555.793453] Starting dynamic subtest: vcs0
[556.588033] Dynamic subtest vcs0: SUCCESS (0.803s)
[556.598957] Starting dynamic subtest: vcs1
[557.412913] Dynamic subtest vcs1: SUCCESS (0.822s)
[557.427719] Starting dynamic subtest: vecs0
[558.186066] Dynamic subtest vecs0: SUCCESS (0.770s)
[558.196949] Starting dynamic subtest: ccs0
[559.010059] Dynamic subtest ccs0: SUCCESS (0.822s)
[559.012962] Subtest engines-persistence: SUCCESS (4.831s)
[559.116296] [109/133] (463s left) gem_tiled_blits (basic)
[559.182539] Subtest basic: SKIP (0.000s)
[559.268265] [110/133] (463s left) kms_chamelium_color (ctm-green-to-red)
[559.373479] Subtest ctm-green-to-red: SKIP (0.000s)
[559.425740] [111/133] (463s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[559.508815] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[559.513150] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[559.591806] [112/133] (462s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[559.642402] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[559.746717] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[559.829575] [113/133] (462s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[559.892277] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[559.992785] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[560.079461] [114/133] (462s left) gem_ctx_shared (disjoint-timelines)
[560.148274] Starting subtest: disjoint-timelines
[560.182813] Subtest disjoint-timelines: SUCCESS (0.034s)
[560.452538] [115/133] (462s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[560.555384] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[560.559651] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[560.636200] [116/133] (462s left) kms_properties (get_properties-sanity-atomic)
[560.733063] Starting subtest: get_properties-sanity-atomic
[560.735355] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[560.835262] [117/133] (461s left) kms_addfb_basic (basic-x-tiled-legacy)
[560.895476] Starting subtest: basic-x-tiled-legacy
[560.899754] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[561.066091] [118/133] (461s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[561.175662] Starting subtest: yf-tiled-64bpp-rotate-180
[561.180197] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[561.294531] [119/133] (461s left) kms_content_protection (lic-type-0-hdcp14)
[561.431604] Starting subtest: lic-type-0-hdcp14
[561.435055] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[561.589148] [120/133] (461s left) perf_pmu (all-busy-check-all)
[561.631239] Starting subtest: all-busy-check-all
[562.903325] Subtest all-busy-check-all: SUCCESS (1.271s)
[563.021490] [121/133] (459s left) syncobj_timeline (single-wait-all-available-submitted)
[563.076980] Starting subtest: single-wait-all-available-submitted
[563.079276] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[563.182058] [122/133] (459s left) prime_vgem (basic-write)
[563.245625] Starting subtest: basic-write
[563.261392] Subtest basic-write: SKIP (0.014s)
[563.398948] [123/133] (459s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[563.517105] Starting subtest: x-tiled-16bpp-rotate-90
[563.538365] Subtest x-tiled-16bpp-rotate-90: SKIP (0.021s)
[563.673401] [124/133] (459s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[563.784166] Starting subtest: 2x-cursor-vs-flip-atomic
[563.788360] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[563.942110] [125/133] (459s left) gem_tiled_pread_basic (basic)
[563.996063] Subtest basic: SKIP (0.000s)
[564.064964] [126/133] (458s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[564.164147] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[564.167569] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[564.266210] [127/133] (458s left) gem_spin_batch (resubmit-all)
[564.325807] Starting subtest: resubmit-all
[564.327856] Starting dynamic subtest: rcs0
[564.337232] Dynamic subtest rcs0: SUCCESS (0.011s)
[564.347484] Starting dynamic subtest: bcs0
[564.349396] Dynamic subtest bcs0: SUCCESS (0.003s)
[564.356919] Starting dynamic subtest: vcs0
[564.358470] Dynamic subtest vcs0: SUCCESS (0.002s)
[564.365914] Starting dynamic subtest: vcs1
[564.367636] Dynamic subtest vcs1: SUCCESS (0.002s)
[564.376773] Starting dynamic subtest: vecs0
[564.378317] Dynamic subtest vecs0: SUCCESS (0.002s)
[564.385146] Starting dynamic subtest: ccs0
[564.386732] Dynamic subtest ccs0: SUCCESS (0.002s)
[564.388285] Subtest resubmit-all: SUCCESS (0.025s)
[565.963343] [128/133] (457s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[566.070453] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[572.857990] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.789s)
[573.054957] [129/133] (450s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[573.169182] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[573.173189] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[573.302030] [130/133] (449s left) gem_mmap_wc (write-read)
[573.355860] Subtest write-read: SKIP (0.000s)
[573.429101] [131/133] (449s left) perf_pmu (busy-start)
[573.469722] Starting subtest: busy-start
[573.471579] Starting dynamic subtest: rcs0
[576.018493] Dynamic subtest rcs0: SUCCESS (2.550s)
[576.028742] Starting dynamic subtest: bcs0
[578.568562] Dynamic subtest bcs0: SUCCESS (2.547s)
[578.578689] Starting dynamic subtest: vcs0
[581.909892] Dynamic subtest vcs0: SUCCESS (3.337s)
[581.921311] Starting dynamic subtest: vcs1
[585.940992] Dynamic subtest vcs1: SUCCESS (4.028s)
[585.950224] Starting dynamic subtest: vecs0
[589.908900] Dynamic subtest vecs0: SUCCESS (3.966s)
[589.921208] Starting dynamic subtest: ccs0
[592.457750] Dynamic subtest ccs0: SUCCESS (2.547s)
[592.460421] Subtest busy-start: SUCCESS (18.992s)
[592.602876] [132/133] (430s left) gem_exec_balancer (bonded-false-hang)
[592.866858] Starting subtest: bonded-false-hang
[592.871269] Subtest bonded-false-hang: SKIP (0.000s)
[593.006395] [133/133] (430s left) kms_chamelium_frames (hdmi-crc-multiple)
[593.398814] Subtest hdmi-crc-multiple: SKIP (0.000s)
[594.190416] 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.