[59.697435] Initializing watchdogs
[59.697481]   /dev/watchdog0
[59.711822] [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.716387] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.718764] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.722226] [001/133] (960s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[59.858580] Starting subtest: yf-tiled-32bpp-rotate-0
[59.862909] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[59.957615] [002/133] (960s left) syncobj_timeline (reset-signaled)
[60.018967] Starting subtest: reset-signaled
[60.021392] Subtest reset-signaled: SUCCESS (0.001s)
[60.122729] [003/133] (960s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[60.185133] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[60.241824] [004/133] (960s left) kms_dp_linktrain_fallback (dsc-fallback)
[60.345184] Starting subtest: dsc-fallback
[60.351586] Subtest dsc-fallback: SKIP (0.000s)
[60.425593] [005/133] (959s left) kms_content_protection (dp-mst-type-0-hdcp14)
[60.574644] Starting subtest: dp-mst-type-0-hdcp14
[60.578611] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[60.678120] [006/133] (959s left) syncobj_timeline (wait-all-interrupted)
[60.728221] Starting subtest: wait-all-interrupted
[60.829705] Subtest wait-all-interrupted: SUCCESS (0.101s)
[60.902992] [007/133] (959s left) kms_cursor_crc (cursor-alpha-opaque)
[60.994520] Starting subtest: cursor-alpha-opaque
[60.996765] Starting dynamic subtest: pipe-A-eDP-1
[61.664258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.669s)
[61.671821] Starting dynamic subtest: pipe-D-eDP-1
[62.945801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s)
[62.948048] Subtest cursor-alpha-opaque: SUCCESS (1.950s)
[63.742852] [008/133] (956s left) gem_softpin (softpin)
[63.814433] Starting subtest: softpin
[96.065815] Subtest softpin: SUCCESS (32.236s)
[96.168227] [009/133] (924s left) gem_exec_reloc (basic-write-gtt-noreloc)
[96.235554] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[96.308388] [010/133] (924s left) gem_cs_tlb (engines)
[96.373568] Starting subtest: engines
[96.375750] Starting dynamic subtest: rcs0
[98.528657] Dynamic subtest rcs0: SUCCESS (2.153s)
[98.539136] Starting dynamic subtest: bcs0
[100.680871] Dynamic subtest bcs0: SUCCESS (2.152s)
[100.690070] Starting dynamic subtest: vcs0
[102.833133] Dynamic subtest vcs0: SUCCESS (2.152s)
[102.840749] Starting dynamic subtest: vcs1
[104.987065] Dynamic subtest vcs1: SUCCESS (2.153s)
[104.995562] Starting dynamic subtest: vecs0
[107.138892] Dynamic subtest vecs0: SUCCESS (2.152s)
[107.146705] Starting dynamic subtest: ccs0
[109.291519] Dynamic subtest ccs0: SUCCESS (2.151s)
[109.293868] Subtest engines: SUCCESS (12.914s)
[109.405813] [011/133] (911s left) gem_exec_reloc (basic-gtt)
[109.460071] Subtest basic-gtt: SKIP (0.000s)
[109.526225] [012/133] (911s left) sw_sync (timeline_closed_signaled)
[109.567324] Starting subtest: timeline_closed_signaled
[109.569654] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[109.613256] [013/133] (911s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[109.711455] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[109.715789] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[110.872967] [014/133] (909s left) i915_query (query-regions-unallocated)
[110.936247] Starting subtest: query-regions-unallocated
[110.938626] Subtest query-regions-unallocated: SUCCESS (0.000s)
[111.042176] [015/133] (909s left) gem_bad_reloc (negative-reloc-lut)
[111.109455] Subtest negative-reloc-lut: SKIP (0.000s)
[111.184854] [016/133] (909s left) gem_exec_params (invalid-bsd2-flag-on-render)
[111.244572] Starting subtest: invalid-bsd2-flag-on-render
[111.247123] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[111.360846] [017/133] (909s left) syncobj_eventfd (binary-wait-before-signal)
[111.413026] Starting subtest: binary-wait-before-signal
[111.442775] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[111.515770] [018/133] (909s left) drm_mm (drm_mm)
[111.556069] Starting subtest: drm_mm
[111.590417] Starting dynamic subtest: drm_test_mm_init
[111.671355] Dynamic subtest drm_test_mm_init: SUCCESS (0.080s)
[111.680321] Starting dynamic subtest: drm_test_mm_debug
[111.775217] Dynamic subtest drm_test_mm_debug: SUCCESS (0.104s)
[111.783820] Starting dynamic subtest: drm_test_mm_align32
[111.907411] Dynamic subtest drm_test_mm_align32: SUCCESS (0.131s)
[111.916132] Starting dynamic subtest: drm_test_mm_align64
[112.003511] Dynamic subtest drm_test_mm_align64: SUCCESS (0.097s)
[112.012073] Starting dynamic subtest: drm_test_mm_lowest
[112.116548] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.111s)
[112.125215] Starting dynamic subtest: drm_test_mm_highest
[112.209255] Dynamic subtest drm_test_mm_highest: SUCCESS (0.093s)
[112.211249] Subtest drm_mm: SUCCESS (0.652s)
[112.391363] [019/133] (908s left) kms_flip (flip-vs-rmfb-interruptible)
[112.500285] Starting subtest: flip-vs-rmfb-interruptible
[112.502799] Starting dynamic subtest: A-eDP1
[121.156802] Dynamic subtest A-eDP1: SUCCESS (8.655s)
[121.166411] Starting dynamic subtest: B-eDP1
[129.781153] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[129.791621] Starting dynamic subtest: C-eDP1
[138.393955] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[138.401884] Starting dynamic subtest: D-eDP1
[147.054979] Dynamic subtest D-eDP1: SUCCESS (8.659s)
[147.059987] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.558s)
[148.196174] [020/133] (872s left) gem_mmap_offset (bad-extensions)
[148.258588] Starting subtest: bad-extensions
[148.261072] Subtest bad-extensions: SUCCESS (0.000s)
[148.360145] [021/133] (872s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[148.483318] Starting subtest: basic-flip-after-cursor-legacy
[149.410611] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.925s)
[150.233988] [022/133] (870s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[150.324753] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[150.329238] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[150.414153] [023/133] (870s left) sw_sync (sync_merge_same)
[150.451654] Starting subtest: sync_merge_same
[150.453635] Subtest sync_merge_same: SUCCESS (0.000s)
[150.508725] [024/133] (870s left) kms_setmode (invalid-clone-exclusive-crtc)
[150.566855] Starting subtest: invalid-clone-exclusive-crtc
[150.573358] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[150.677444] [025/133] (870s left) syncobj_wait (single-wait-all-submitted)
[150.724795] Starting subtest: single-wait-all-submitted
[150.834415] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[150.922936] [026/133] (870s left) core_auth (many-magics)
[150.977124] Starting subtest: many-magics
[151.922486] Subtest many-magics: SUCCESS (0.946s)
[152.067771] [027/133] (869s left) perf_pmu (busy-no-semaphores)
[152.109245] Starting subtest: busy-no-semaphores
[152.111103] Starting dynamic subtest: rcs0
[152.656546] Dynamic subtest rcs0: SUCCESS (0.545s)
[152.667868] Starting dynamic subtest: bcs0
[153.206035] Dynamic subtest bcs0: SUCCESS (0.546s)
[153.216956] Starting dynamic subtest: vcs0
[153.758076] Dynamic subtest vcs0: SUCCESS (0.549s)
[153.769535] Starting dynamic subtest: vcs1
[155.416027] Dynamic subtest vcs1: SUCCESS (1.655s)
[155.426941] Starting dynamic subtest: vecs0
[157.400800] Dynamic subtest vecs0: SUCCESS (1.982s)
[157.412060] Starting dynamic subtest: ccs0
[159.446137] Dynamic subtest ccs0: SUCCESS (2.041s)
[159.448932] Subtest busy-no-semaphores: SUCCESS (7.337s)
[159.572305] [028/133] (861s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[159.667863] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[159.671792] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[159.735893] [029/133] (861s left) gem_mmap_gtt (big-copy)
[159.784353] Subtest big-copy: SKIP (0.000s)
[159.841354] [030/133] (861s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[159.931317] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[159.935522] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[160.029305] [031/133] (861s left) gem_ctx_persistence (idempotent)
[160.096486] Starting subtest: idempotent
[160.098872] Subtest idempotent: SUCCESS (0.000s)
[160.207030] [032/133] (861s left) kms_hdmi_inject (inject-audio)
[160.553071] Starting subtest: inject-audio
[160.828375] Subtest inject-audio: SUCCESS (0.278s)
[161.424449] [033/133] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[161.513066] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[161.517657] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[161.626387] [034/133] (859s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[161.723117] Starting subtest: pr-primary-plane-update-sf-dmg-area
[161.727222] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[161.790404] [035/133] (859s left) gem_spin_batch (resubmit-new-all)
[161.847558] Starting subtest: resubmit-new-all
[161.849877] Starting dynamic subtest: rcs0
[161.862111] Dynamic subtest rcs0: SUCCESS (0.014s)
[161.872268] Starting dynamic subtest: bcs0
[161.874455] Dynamic subtest bcs0: SUCCESS (0.008s)
[161.882648] Starting dynamic subtest: vcs0
[161.884856] Dynamic subtest vcs0: SUCCESS (0.008s)
[161.893176] Starting dynamic subtest: vcs1
[161.895410] Dynamic subtest vcs1: SUCCESS (0.007s)
[161.903147] Starting dynamic subtest: vecs0
[161.905059] Dynamic subtest vecs0: SUCCESS (0.007s)
[161.913046] Starting dynamic subtest: ccs0
[161.915219] Dynamic subtest ccs0: SUCCESS (0.009s)
[161.917341] Subtest resubmit-new-all: SUCCESS (0.061s)
[163.963105] [036/133] (857s left) kms_flip (2x-plain-flip-interruptible)
[164.059408] Starting subtest: 2x-plain-flip-interruptible
[164.069457] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[164.141434] [037/133] (857s left) gem_exec_store (basic)
[164.207456] Starting subtest: basic
[164.319644] Subtest basic: SUCCESS (0.113s)
[164.503506] [038/133] (857s left) gem_exec_params (invalid-batch-start-offset)
[164.561809] Starting subtest: invalid-batch-start-offset
[164.567242] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[164.674398] [039/133] (857s left) gem_exec_fence (syncobj-signal)
[165.150770] Starting subtest: syncobj-signal
[165.153053] Subtest syncobj-signal: SUCCESS (0.006s)
[167.022940] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[167.028842] [040/133] (854s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[167.158948] Starting subtest: cursorA-vs-flipA-toggle
[178.281092] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.123s)
[179.166484] [041/133] (842s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[179.305661] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[210.966846] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.660s)
[211.761724] [042/133] (810s left) kms_frontbuffer_tracking (psr-suspend)
[211.866132] Starting subtest: psr-suspend
[249.639245] Subtest psr-suspend: SUCCESS (8.650s)
[249.759266] [043/133] (772s left) prime_mmap_coherency (write)
[249.821757] Starting subtest: write
[255.233456] Subtest write: SUCCESS (5.374s)
[255.393796] [044/133] (766s left) gem_render_copy (y-tiled)
[255.461726] Starting subtest: y-tiled
[255.466222] Subtest y-tiled: SKIP (0.000s)
[255.648565] [045/133] (766s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[255.745702] Starting subtest: bad-pixel-format-y-tiled-ccs
[255.748029] Starting dynamic subtest: pipe-A-eDP-1
[255.770098] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[255.780951] Starting dynamic subtest: pipe-B-eDP-1
[255.801621] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[255.810528] Starting dynamic subtest: pipe-C-eDP-1
[255.831057] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[255.839114] Starting dynamic subtest: pipe-D-eDP-1
[255.861006] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[255.865556] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[258.042815] [046/133] (763s left) gem_ctx_isolation (preservation-reset)
[258.223564] Starting subtest: preservation-reset
[258.226014] Starting dynamic subtest: rcs0
[258.514969] Dynamic subtest rcs0: SUCCESS (0.295s)
[258.528054] Starting dynamic subtest: bcs0
[258.837798] Dynamic subtest bcs0: SUCCESS (0.321s)
[258.852423] Starting dynamic subtest: vcs0
[259.153976] Dynamic subtest vcs0: SUCCESS (0.314s)
[259.164808] Starting dynamic subtest: vcs1
[260.312121] Dynamic subtest vcs1: SUCCESS (1.153s)
[260.324609] Starting dynamic subtest: vecs0
[262.322636] Dynamic subtest vecs0: SUCCESS (2.004s)
[262.334037] Starting dynamic subtest: ccs0
[264.324782] Dynamic subtest ccs0: SUCCESS (1.997s)
[264.327405] Subtest preservation-reset: SUCCESS (6.093s)
[264.457401] [047/133] (757s left) i915_hangman (hangcheck-unterminated)
[264.531105] Starting subtest: hangcheck-unterminated
[276.010211] Subtest hangcheck-unterminated: SUCCESS (11.465s)
[276.161588] [048/133] (745s left) kms_plane_alpha_blend (coverage-7efc)
[276.253807] Starting subtest: coverage-7efc
[276.542337] Starting dynamic subtest: pipe-A-eDP-1
[277.157021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.614s)
[277.188341] Starting dynamic subtest: pipe-D-eDP-1
[278.481548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[278.483848] Subtest coverage-7efc: SUCCESS (2.227s)
[279.313674] [049/133] (742s left) kms_flip (nonexisting-fb)
[279.426961] Starting subtest: nonexisting-fb
[279.428860] Starting dynamic subtest: A-eDP1
[280.637475] Dynamic subtest A-eDP1: SUCCESS (1.213s)
[280.647224] Starting dynamic subtest: B-eDP1
[281.823026] Dynamic subtest B-eDP1: SUCCESS (1.185s)
[281.833832] Starting dynamic subtest: C-eDP1
[282.941968] Dynamic subtest C-eDP1: SUCCESS (1.118s)
[282.951835] Starting dynamic subtest: D-eDP1
[284.128848] Dynamic subtest D-eDP1: SUCCESS (1.186s)
[284.133658] Subtest nonexisting-fb: SUCCESS (4.712s)
[285.396561] [050/133] (736s left) kms_psr (fbc-psr2-primary-page-flip)
[285.481436] Starting subtest: fbc-psr2-primary-page-flip
[285.483734] Starting dynamic subtest: eDP-1
[285.488184] Dynamic subtest eDP-1: SKIP (0.000s)
[285.492472] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[285.554705] [051/133] (736s left) gem_exec_balancer (parallel-keep-in-fence)
[285.810984] Starting subtest: parallel-keep-in-fence
[287.120962] Subtest parallel-keep-in-fence: SUCCESS (1.310s)
[287.210404] [052/133] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[287.300988] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[287.304955] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[287.413257] [053/133] (734s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[287.506885] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[287.510853] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[287.627360] [054/133] (734s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[287.718683] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[291.863508] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.150s)
[292.989872] [055/133] (729s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[293.092826] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[293.097314] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[293.220063] [056/133] (729s left) perf (non-zero-reason)
[293.347792] Starting subtest: non-zero-reason
[293.349998] Starting dynamic subtest: 0-rcs0
[298.774425] Dynamic subtest 0-rcs0: SUCCESS (5.426s)
[298.787400] Starting dynamic subtest: 1-vecs0
[302.695167] Dynamic subtest 1-vecs0: SUCCESS (3.919s)
[302.698321] Subtest non-zero-reason: SUCCESS (9.347s)
[302.744171] [057/133] (719s left) gem_exec_flush (basic-uc-set-default)
[302.797462] Starting subtest: basic-uc-set-default
[308.265810] Subtest basic-uc-set-default: SUCCESS (5.467s)
[308.461870] [058/133] (714s left) gem_exec_async (concurrent-writes)
[308.524704] Starting subtest: concurrent-writes
[308.527540] Starting dynamic subtest: rcs0
[308.555818] Dynamic subtest rcs0: SUCCESS (0.031s)
[308.568781] Starting dynamic subtest: bcs0
[308.574023] Dynamic subtest bcs0: SUCCESS (0.017s)
[308.583695] Starting dynamic subtest: vcs0
[308.586042] Dynamic subtest vcs0: SUCCESS (0.008s)
[308.595605] Starting dynamic subtest: vcs1
[308.597819] Dynamic subtest vcs1: SUCCESS (0.008s)
[308.607540] Starting dynamic subtest: vecs0
[308.609528] Dynamic subtest vecs0: SUCCESS (0.012s)
[308.619377] Starting dynamic subtest: ccs0
[308.621587] Dynamic subtest ccs0: SUCCESS (0.008s)
[308.623847] Subtest concurrent-writes: SUCCESS (0.089s)
[308.866534] [059/133] (713s left) syncobj_wait (reset-unsignaled)
[308.929816] Starting subtest: reset-unsignaled
[308.932167] Subtest reset-unsignaled: SUCCESS (0.000s)
[309.037959] [060/133] (713s left) api_intel_allocator (fork-simple-once)
[309.090131] Starting subtest: fork-simple-once
[309.103495] Subtest fork-simple-once: SUCCESS (0.016s)
[309.232072] [061/133] (713s left) i915_pm_rpm (gem-mmap-type)
[311.162675] Starting subtest: gem-mmap-type
[311.165214] Starting dynamic subtest: wb-smem0
[314.989662] Dynamic subtest wb-smem0: SUCCESS (3.827s)
[314.999692] Starting dynamic subtest: wc-smem0
[318.167613] Dynamic subtest wc-smem0: SUCCESS (3.175s)
[318.180446] Starting dynamic subtest: uc-smem0
[321.345064] Dynamic subtest uc-smem0: SUCCESS (3.176s)
[321.347440] Subtest gem-mmap-type: SUCCESS (10.182s)
[321.431692] [062/133] (701s left) gem_exec_schedule (manyslice)
[321.497733] Starting subtest: manyslice
[321.499852] Starting dynamic subtest: rcs0
[326.635768] Dynamic subtest rcs0: SUCCESS (5.145s)
[326.650326] Starting dynamic subtest: bcs0
[333.276226] Dynamic subtest bcs0: SUCCESS (6.635s)
[333.289174] Starting dynamic subtest: vcs0
[338.352818] Dynamic subtest vcs0: SUCCESS (5.073s)
[338.366416] Starting dynamic subtest: vcs1
[344.433121] Dynamic subtest vcs1: SUCCESS (6.076s)
[344.448174] Starting dynamic subtest: vecs0
[350.001137] Dynamic subtest vecs0: SUCCESS (5.568s)
[350.016060] Starting dynamic subtest: ccs0
[356.184647] Dynamic subtest ccs0: SUCCESS (6.183s)
[356.187288] Subtest manyslice: SUCCESS (34.693s)
[356.495010] [063/133] (666s left) kms_big_fb (linear-addfb)
[356.600730] Starting subtest: linear-addfb
[356.603054] Subtest linear-addfb: SUCCESS (0.000s)
[356.698103] [064/133] (666s left) kms_vblank (wait-forked-busy-hang)
[356.787970] Starting subtest: wait-forked-busy-hang
[356.789846] Starting dynamic subtest: pipe-A-eDP-1
[382.820199] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.031s)
[382.834958] Starting dynamic subtest: pipe-D-eDP-1
[407.771899] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.947s)
[407.774104] Subtest wait-forked-busy-hang: SUCCESS (50.982s)
[408.574431] [065/133] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[408.670965] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[415.393618] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.724s)
[415.529469] [066/133] (607s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[415.636234] Starting subtest: 4-tiled-8bpp-rotate-270
[415.659233] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.023s)
[415.785331] [067/133] (607s left) gem_exec_balancer (full-pulse)
[415.853303] Starting subtest: full-pulse
[420.928394] Subtest full-pulse: SUCCESS (5.074s)
[421.257345] [068/133] (601s left) vgem_basic (busy-fence)
[421.299564] Starting subtest: busy-fence
[421.301852] Subtest busy-fence: SUCCESS (0.000s)
[421.357819] [069/133] (601s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[421.756169] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[422.544236] [070/133] (600s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[422.641567] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[422.643855] Starting dynamic subtest: pipe-A-eDP-1
[422.667159] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[422.678722] Starting dynamic subtest: pipe-B-eDP-1
[422.699814] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[422.709443] Starting dynamic subtest: pipe-C-eDP-1
[422.730471] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[422.742247] Starting dynamic subtest: pipe-D-eDP-1
[422.763366] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[422.767674] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[424.879277] [071/133] (598s left) kms_cursor_crc (cursor-random-32x32)
[425.021920] Starting subtest: cursor-random-32x32
[425.069049] Subtest cursor-random-32x32: SKIP (0.042s)
[425.344431] [072/133] (597s left) kms_universal_plane (universal-plane-pageflip-windowed)
[425.434527] Starting subtest: universal-plane-pageflip-windowed
[425.437238] Starting dynamic subtest: pipe-A-eDP-1
[426.037390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[426.051511] Starting dynamic subtest: pipe-B-eDP-1
[427.269280] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.225s)
[427.279813] Starting dynamic subtest: pipe-C-eDP-1
[428.453883] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s)
[428.465417] Starting dynamic subtest: pipe-D-eDP-1
[429.640965] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.187s)
[429.643448] Subtest universal-plane-pageflip-windowed: SUCCESS (4.210s)
[430.470048] [073/133] (592s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[430.578231] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[430.582625] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[430.669480] [074/133] (592s left) gem_mmap_gtt (basic-copy)
[430.716832] Subtest basic-copy: SKIP (0.000s)
[430.776211] [075/133] (592s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[430.837286] Starting subtest: y-tiled-to-vebox-y-tiled
[430.841863] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[431.024540] [076/133] (592s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[431.127213] Starting subtest: yf-tiled-64bpp-rotate-270
[431.131691] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[431.237165] [077/133] (592s left) gem_workarounds (basic-read)
[431.308583] Starting subtest: basic-read
[431.319601] Subtest basic-read: SUCCESS (0.011s)
[431.436038] [078/133] (591s left) api_intel_bb (reset-bb)
[431.491607] Starting subtest: reset-bb
[431.493478] Subtest reset-bb: SUCCESS (0.004s)
[431.615785] [079/133] (591s left) kms_cursor_crc (cursor-sliding-512x512)
[431.896023] Starting subtest: cursor-sliding-512x512
[431.900558] Subtest cursor-sliding-512x512: SKIP (0.001s)
[432.048894] [080/133] (591s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[432.135440] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[432.139087] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[432.224929] [081/133] (591s left) kms_pm_dc (dc6-dpms)
[433.323785] Starting subtest: dc6-dpms
[435.408066] Subtest dc6-dpms: SUCCESS (2.083s)
[435.484744] [082/133] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[435.575286] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[435.579906] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[435.680191] [083/133] (587s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[435.799825] Starting subtest: y-tiled-32bpp-rotate-0
[435.804829] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[435.917596] [084/133] (587s left) kms_plane_cursor (primary)
[436.019641] Starting subtest: primary
[436.024134] Starting dynamic subtest: pipe-A-eDP-1-size-64
[438.619869] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.600s)
[438.645274] Starting dynamic subtest: pipe-A-eDP-1-size-128
[441.222018] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[441.246680] Starting dynamic subtest: pipe-A-eDP-1-size-256
[443.879360] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.638s)
[444.197057] Starting dynamic subtest: pipe-B-eDP-1-size-64
[447.517270] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.329s)
[447.542524] Starting dynamic subtest: pipe-B-eDP-1-size-128
[450.097185] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[450.125643] Starting dynamic subtest: pipe-B-eDP-1-size-256
[452.689239] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[453.005631] Starting dynamic subtest: pipe-C-eDP-1-size-64
[455.950340] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.956s)
[455.977281] Starting dynamic subtest: pipe-C-eDP-1-size-128
[458.150958] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[458.177850] Starting dynamic subtest: pipe-C-eDP-1-size-256
[460.394801] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[460.729500] Starting dynamic subtest: pipe-D-eDP-1-size-64
[463.669823] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.950s)
[463.697909] Starting dynamic subtest: pipe-D-eDP-1-size-128
[465.882043] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.192s)
[465.913813] Starting dynamic subtest: pipe-D-eDP-1-size-256
[468.081787] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[468.390050] Subtest primary: SUCCESS (32.362s)
[469.272671] [085/133] (554s left) syncobj_wait (multi-wait-submitted)
[469.331500] Starting subtest: multi-wait-submitted
[469.439808] Subtest multi-wait-submitted: SUCCESS (0.108s)
[469.518705] [086/133] (554s left) gem_vm_create (create-ext)
[469.584258] Starting subtest: create-ext
[469.590068] Subtest create-ext: SUCCESS (0.006s)
[469.704317] [087/133] (554s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[469.813143] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[469.815055] Starting dynamic subtest: pipe-A-eDP-1
[486.343342] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.426s)
[486.353718] Starting dynamic subtest: pipe-B-eDP-1
[503.291890] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.372s)
[503.306621] Starting dynamic subtest: pipe-C-eDP-1
[520.271151] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.393s)
[520.281213] Starting dynamic subtest: pipe-D-eDP-1
[537.292066] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s)
[537.294017] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.637s)
[538.487387] [088/133] (485s left) gem_render_copy (linear-to-vebox-yf-tiled)
[538.556268] Starting subtest: linear-to-vebox-yf-tiled
[538.560687] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[538.746088] [089/133] (485s left) kms_psr (psr2-cursor-render)
[538.841226] Starting subtest: psr2-cursor-render
[538.843631] Starting dynamic subtest: eDP-1
[540.526683] Dynamic subtest eDP-1: SUCCESS (1.673s)
[540.529034] Subtest psr2-cursor-render: SUCCESS (1.675s)
[541.405189] [090/133] (482s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[541.505974] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[548.107365] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.576s)
[548.239368] [091/133] (475s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[548.343505] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[548.348012] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[548.428880] [092/133] (475s left) gem_mmap_wc (write-wc-read-gtt)
[548.491407] Subtest write-wc-read-gtt: SKIP (0.000s)
[548.563244] [093/133] (475s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[548.661359] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[555.312672] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.642s)
[555.439134] [094/133] (468s left) kms_joiner (basic-force-ultra-joiner)
[555.552216] Starting subtest: basic-force-ultra-joiner
[555.556550] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[555.622504] [095/133] (468s left) drm_read (short-buffer-block)
[555.773550] Starting subtest: short-buffer-block
[555.775927] Subtest short-buffer-block: SUCCESS (0.000s)
[555.892906] [096/133] (468s left) kms_psr (pr-cursor-render)
[555.983892] Starting subtest: pr-cursor-render
[555.988338] Subtest pr-cursor-render: SKIP (0.000s)
[556.066872] [097/133] (468s left) i915_drm_fdinfo (all-busy-idle-check-all)
[556.117160] Starting subtest: all-busy-idle-check-all
[556.124233] Subtest all-busy-idle-check-all: SKIP (0.006s)
[556.214183] [098/133] (468s left) kms_flip (2x-flip-vs-fences)
[556.333885] Starting subtest: 2x-flip-vs-fences
[556.337212] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[556.463174] [099/133] (467s left) kms_psr (fbc-pr-cursor-plane-onoff)
[556.548985] Starting subtest: fbc-pr-cursor-plane-onoff
[556.552536] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[556.623222] [100/133] (467s left) kms_psr (psr-sprite-mmap-gtt)
[556.718787] Starting subtest: psr-sprite-mmap-gtt
[556.720660] Starting dynamic subtest: eDP-1
[558.139981] Dynamic subtest eDP-1: SKIP (1.414s)
[558.144992] Subtest psr-sprite-mmap-gtt: SKIP (1.416s)
[558.346061] [101/133] (466s left) kms_properties (colorop-properties-atomic)
[558.447703] Starting subtest: colorop-properties-atomic
[558.450030] Starting dynamic subtest: pipe-A-eDP-1
[558.825934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[558.836054] Starting dynamic subtest: pipe-B-eDP-1
[559.875640] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.046s)
[559.886463] Starting dynamic subtest: pipe-C-eDP-1
[560.982924] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[560.995437] Starting dynamic subtest: pipe-D-eDP-1
[562.079626] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s)
[562.081979] Subtest colorop-properties-atomic: SUCCESS (3.628s)
[562.945770] [102/133] (461s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[563.324516] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[564.116033] [103/133] (460s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[564.221027] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[564.223272] Starting dynamic subtest: pipe-A-eDP-1
[564.249701] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[564.262180] Starting dynamic subtest: pipe-B-eDP-1
[564.286444] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[564.295886] Starting dynamic subtest: pipe-C-eDP-1
[564.319766] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[564.328794] Starting dynamic subtest: pipe-D-eDP-1
[564.353652] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[564.358102] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[566.454647] [104/133] (458s left) kms_fb_coherency (memset-crc)
[566.554369] Starting subtest: memset-crc
[566.556538] Starting dynamic subtest: mmap-offset-wc
[566.922150] Dynamic subtest mmap-offset-wc: SUCCESS (0.366s)
[567.211450] Starting dynamic subtest: mmap-offset-uc
[573.376764] Dynamic subtest mmap-offset-uc: SUCCESS (6.178s)
[573.677512] Subtest memset-crc: SUCCESS (7.123s)
[574.554322] [105/133] (450s left) gem_exec_params (sol-reset-not-gen7)
[574.622488] Starting subtest: sol-reset-not-gen7
[574.627816] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[574.741935] [106/133] (449s left) kms_lease (simple-lease)
[574.845005] Starting subtest: simple-lease
[574.847383] Starting dynamic subtest: pipe-A-eDP-1
[575.357569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.512s)
[575.367949] Starting dynamic subtest: pipe-B-eDP-1
[576.779618] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.422s)
[576.790367] Starting dynamic subtest: pipe-C-eDP-1
[578.251450] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.469s)
[578.261459] Starting dynamic subtest: pipe-D-eDP-1
[579.654053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[579.656343] Subtest simple-lease: SUCCESS (4.810s)
[580.458318] [107/133] (444s left) gem_basic (create-close)
[580.515658] Starting subtest: create-close
[580.519988] Subtest create-close: SUCCESS (0.000s)
[580.631087] [108/133] (444s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[580.724169] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[580.728418] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[580.823127] [109/133] (443s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[580.927052] Starting subtest: x-tiled-8bpp-rotate-90
[580.951482] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[581.075434] [110/133] (443s left) prime_vgem (basic-blt)
[581.144388] Starting subtest: basic-blt
[581.183041] Subtest basic-blt: SUCCESS (0.038s)
[581.310655] [111/133] (443s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[581.410089] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[581.411934] Starting dynamic subtest: pipe-A
[581.430789] Dynamic subtest pipe-A: SKIP (0.018s)
[581.440482] Starting dynamic subtest: pipe-B
[581.463804] Dynamic subtest pipe-B: SKIP (0.031s)
[581.474632] Starting dynamic subtest: pipe-C
[581.494657] Dynamic subtest pipe-C: SKIP (0.031s)
[581.503885] Starting dynamic subtest: pipe-D
[581.526804] Dynamic subtest pipe-D: SKIP (0.031s)
[581.530332] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.115s)
[581.615502] [112/133] (443s left) kms_plane (plane-position-hole)
[581.714933] Starting subtest: plane-position-hole
[582.230717] Starting dynamic subtest: pipe-A-plane-1
[583.520107] Dynamic subtest pipe-A-plane-1: SUCCESS (1.285s)
[583.533986] Starting dynamic subtest: pipe-A-plane-2
[584.789418] Dynamic subtest pipe-A-plane-2: SUCCESS (1.270s)
[584.799820] Starting dynamic subtest: pipe-A-plane-3
[586.145500] Dynamic subtest pipe-A-plane-3: SUCCESS (1.356s)
[586.156408] Starting dynamic subtest: pipe-A-plane-4
[587.390580] Dynamic subtest pipe-A-plane-4: SUCCESS (1.243s)
[587.401343] Starting dynamic subtest: pipe-A-plane-5
[587.415050] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[588.610783] Starting dynamic subtest: pipe-B-plane-1
[589.912398] Dynamic subtest pipe-B-plane-1: SUCCESS (1.314s)
[589.922938] Starting dynamic subtest: pipe-B-plane-2
[591.179911] Dynamic subtest pipe-B-plane-2: SUCCESS (1.267s)
[591.191815] Starting dynamic subtest: pipe-B-plane-3
[592.486245] Dynamic subtest pipe-B-plane-3: SUCCESS (1.306s)
[592.496274] Starting dynamic subtest: pipe-B-plane-4
[593.777059] Dynamic subtest pipe-B-plane-4: SUCCESS (1.289s)
[593.788342] Starting dynamic subtest: pipe-B-plane-5
[593.804684] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[593.807024] Subtest plane-position-hole: SUCCESS (12.087s)
[594.651022] [113/133] (430s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[594.747838] Starting subtest: addfb25-yf-tiled-legacy
[594.749706] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[594.861121] [114/133] (430s left) gem_softpin (evict-snoop)
[594.927518] Starting subtest: evict-snoop
[594.931480] Subtest evict-snoop: SKIP (0.000s)
[595.056605] [115/133] (429s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[595.147711] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[595.152790] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[595.254826] [116/133] (429s left) kms_atomic_transition (modeset-transition)
[595.355641] Starting subtest: modeset-transition
[595.357598] Starting dynamic subtest: 1x-outputs
[606.213414] Dynamic subtest 1x-outputs: SUCCESS (10.852s)
[606.215861] Subtest modeset-transition: SUCCESS (10.854s)
[607.054780] [117/133] (418s left) kms_color (degamma)
[607.149675] Starting subtest: degamma
[607.151604] Starting dynamic subtest: pipe-A-eDP-1
[607.870806] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[607.881050] Starting dynamic subtest: pipe-B-eDP-1
[609.326594] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.457s)
[609.337403] Starting dynamic subtest: pipe-C-eDP-1
[610.687467] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.357s)
[610.697487] Starting dynamic subtest: pipe-D-eDP-1
[612.095251] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.407s)
[612.097474] Subtest degamma: SUCCESS (4.945s)
[612.940058] [118/133] (412s left) perf (missing-sample-flags)
[613.040437] Starting subtest: missing-sample-flags
[613.042911] Subtest missing-sample-flags: SUCCESS (0.000s)
[613.086038] [119/133] (412s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[613.185100] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[613.189354] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[613.283975] [120/133] (411s left) gem_exec_schedule (u-independent)
[613.373868] Starting subtest: u-independent
[613.376274] Starting dynamic subtest: rcs0
[614.821575] Dynamic subtest rcs0: SUCCESS (1.455s)
[614.846529] Starting dynamic subtest: vcs0
[616.746001] Dynamic subtest vcs0: SUCCESS (1.921s)
[616.759339] Starting dynamic subtest: vcs1
[618.805182] Dynamic subtest vcs1: SUCCESS (2.056s)
[618.818544] Starting dynamic subtest: vecs0
[620.780368] Dynamic subtest vecs0: SUCCESS (1.972s)
[620.793144] Starting dynamic subtest: ccs0
[622.820634] Dynamic subtest ccs0: SUCCESS (2.037s)
[622.823773] Subtest u-independent: SUCCESS (9.453s)
[623.130228] [121/133] (402s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[623.195304] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[623.197611] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[623.317143] [122/133] (401s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[623.421544] Starting subtest: psr-1p-pri-indfb-multidraw
[646.218184] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.800s)
[646.371148] [123/133] (378s left) gem_exec_whisper (basic-queues-priority)
[646.450147] Starting subtest: basic-queues-priority
[670.842123] Subtest basic-queues-priority: SUCCESS (24.392s)
[671.030191] [124/133] (354s left) kms_pm_rpm (i2c)
[672.972214] Starting subtest: i2c
[678.315032] Subtest i2c: SUCCESS (5.346s)
[678.404417] [125/133] (347s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[678.457193] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[678.560116] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[678.638584] [126/133] (346s left) kms_psr (fbc-psr-basic)
[678.735007] Starting subtest: fbc-psr-basic
[678.737274] Starting dynamic subtest: eDP-1
[678.741680] Dynamic subtest eDP-1: SKIP (0.000s)
[678.746045] Subtest fbc-psr-basic: SKIP (0.001s)
[678.809453] [127/133] (346s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[678.896975] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[682.776601] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.884s)
[683.940997] [128/133] (341s left) prime_self_import (export-vs-gem_close-race)
[683.983784] Starting subtest: export-vs-gem_close-race
[689.068158] Subtest export-vs-gem_close-race: SUCCESS (5.083s)
[689.158387] [129/133] (336s left) gem_eio (suspend)
[689.388038] Starting subtest: suspend
[701.612629] Subtest suspend: SUCCESS (12.222s)
[701.747894] [130/133] (323s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[701.864335] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[709.084154] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.221s)
[709.213877] [131/133] (316s left) gen9_exec_parse (batch-zero-length)
[709.283035] Subtest batch-zero-length: SKIP (0.000s)
[709.356243] [132/133] (316s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[709.465176] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[709.469155] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[709.565258] [133/133] (316s left) gem_userptr_blits (coherency-unsync)
[709.632269] Subtest coherency-unsync: SKIP (0.000s)
[709.758471] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_dp_linktrain_fallback
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: gem_cs_tlb
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: sw_sync
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: i915_query
results: parsing output: 14/ for test: gem_bad_reloc
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: syncobj_eventfd
results: parsing output: 17/ for test: drm_mm
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_setmode
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: core_auth
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: kms_hdmi_inject
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_spin_batch
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_exec_store
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: prime_mmap_coherency
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_ctx_isolation
results: parsing output: 46/ for test: i915_hangman
results: parsing output: 47/ for test: kms_plane_alpha_blend
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: gem_exec_flush
results: parsing output: 57/ for test: gem_exec_async
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: i915_pm_rpm
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_universal_plane
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_mmap_gtt
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_workarounds
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_pm_dc
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_plane_cursor
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: gem_vm_create
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_joiner
results: parsing output: 94/ for test: drm_read
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: i915_drm_fdinfo
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_properties
results: parsing output: 101/ for test: kms_chamelium_frames
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_fb_coherency
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: kms_lease
results: parsing output: 106/ for test: gem_basic
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_atomic_transition
results: parsing output: 116/ for test: kms_color
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: prime_self_import
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gen9_exec_parse
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_userptr_blits
Done.