[57.695767] Initializing watchdogs
[57.695814]   /dev/watchdog0
[57.711343] [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.715757] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.717912] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.721227] [001/133] (960s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[57.850893] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[57.855640] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[58.995748] [002/133] (959s left) kms_cursor_crc (cursor-sliding-256x85)
[59.251418] Starting subtest: cursor-sliding-256x85
[59.305488] Subtest cursor-sliding-256x85: SKIP (0.049s)
[59.476935] [003/133] (958s left) gem_exec_gttfill (engines)
[59.549321] Starting subtest: engines
[59.551822] Starting dynamic subtest: rcs0
[82.456930] Dynamic subtest rcs0: SUCCESS (22.854s)
[82.467411] Starting dynamic subtest: bcs0
[105.818231] Dynamic subtest bcs0: SUCCESS (23.349s)
[105.828665] Starting dynamic subtest: vcs0
[129.127069] Dynamic subtest vcs0: SUCCESS (23.306s)
[129.142782] Starting dynamic subtest: vcs1
[152.408853] Dynamic subtest vcs1: SUCCESS (23.278s)
[152.423915] Starting dynamic subtest: vecs0
[175.732587] Dynamic subtest vecs0: SUCCESS (23.320s)
[175.747198] Starting dynamic subtest: ccs0
[199.018953] Dynamic subtest ccs0: SUCCESS (23.283s)
[199.022120] Subtest engines: SUCCESS (139.398s)
[199.209097] [004/133] (819s left) kms_vblank (ts-continuation-modeset)
[199.352693] Starting subtest: ts-continuation-modeset
[199.355070] Starting dynamic subtest: pipe-A-eDP-1
[200.891687] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.535s)
[200.907706] Starting dynamic subtest: pipe-D-eDP-1
[203.061309] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.167s)
[203.063751] Subtest ts-continuation-modeset: SUCCESS (3.705s)
[203.862372] [005/133] (814s left) kms_joiner (basic-big-joiner)
[203.971592] Starting subtest: basic-big-joiner
[203.975758] Subtest basic-big-joiner: SKIP (0.000s)
[204.035096] [006/133] (814s left) gem_exec_flush (basic-wb-prw-default)
[204.089628] Starting subtest: basic-wb-prw-default
[209.555491] Subtest basic-wb-prw-default: SUCCESS (5.466s)
[209.751809] [007/133] (808s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[209.847496] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[209.851751] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[209.915873] [008/133] (808s left) perf_pmu (most-busy-idle-check-all)
[209.957628] Starting subtest: most-busy-idle-check-all
[209.959963] Starting dynamic subtest: rcs0
[211.926914] Dynamic subtest rcs0: SUCCESS (1.969s)
[211.937887] Starting dynamic subtest: bcs0
[213.908901] Dynamic subtest bcs0: SUCCESS (1.981s)
[213.919326] Starting dynamic subtest: vcs0
[215.894825] Dynamic subtest vcs0: SUCCESS (1.984s)
[215.906297] Starting dynamic subtest: vcs1
[217.941037] Dynamic subtest vcs1: SUCCESS (2.044s)
[217.952712] Starting dynamic subtest: vecs0
[219.925877] Dynamic subtest vecs0: SUCCESS (1.984s)
[219.937774] Starting dynamic subtest: ccs0
[221.909691] Dynamic subtest ccs0: SUCCESS (1.982s)
[221.912633] Subtest most-busy-idle-check-all: SUCCESS (11.952s)
[222.030052] [009/133] (796s left) gem_ctx_shared (exec-shared-gtt)
[222.091506] Starting subtest: exec-shared-gtt
[222.093382] Starting dynamic subtest: rcs0
[222.104950] Dynamic subtest rcs0: SUCCESS (0.016s)
[222.114092] Starting dynamic subtest: bcs0
[222.119638] Dynamic subtest bcs0: SUCCESS (0.014s)
[222.128736] Starting dynamic subtest: vcs0
[222.133325] Dynamic subtest vcs0: SUCCESS (0.012s)
[222.141992] Starting dynamic subtest: vcs1
[222.144113] Dynamic subtest vcs1: SUCCESS (0.009s)
[222.152653] Starting dynamic subtest: vecs0
[222.154714] Dynamic subtest vecs0: SUCCESS (0.007s)
[222.163104] Starting dynamic subtest: ccs0
[222.164936] Dynamic subtest ccs0: SUCCESS (0.007s)
[222.166756] Subtest exec-shared-gtt: SUCCESS (0.067s)
[222.339357] [010/133] (796s left) kms_plane_scaling (planes-scaler-unity-scaling)
[222.429195] Starting subtest: planes-scaler-unity-scaling
[222.431767] Starting dynamic subtest: pipe-A
[222.490941] Dynamic subtest pipe-A: SUCCESS (0.064s)
[222.501495] Starting dynamic subtest: pipe-B
[223.688600] Dynamic subtest pipe-B: SUCCESS (1.197s)
[223.699309] Starting dynamic subtest: pipe-C
[224.810228] Dynamic subtest pipe-C: SUCCESS (1.121s)
[224.819405] Starting dynamic subtest: pipe-D
[225.951488] Dynamic subtest pipe-D: SUCCESS (1.140s)
[225.954428] Subtest planes-scaler-unity-scaling: SUCCESS (3.525s)
[227.101771] [011/133] (791s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[227.202748] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[227.207560] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[227.301826] [012/133] (791s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[227.612821] Starting subtest: cursor-rapid-movement-max-size
[227.619798] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[227.739229] [013/133] (790s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[227.834486] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[227.838813] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[227.935726] [014/133] (790s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[228.024741] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[228.027013] Starting dynamic subtest: pipe-A-eDP-1
[228.086463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[228.094931] Starting dynamic subtest: pipe-B-eDP-1
[228.150905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.064s)
[228.159953] Starting dynamic subtest: pipe-C-eDP-1
[228.216071] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.064s)
[228.224951] Starting dynamic subtest: pipe-D-eDP-1
[228.281968] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.065s)
[228.284050] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.257s)
[230.480915] [015/133] (788s left) syncobj_timeline (invalid-signal-illegal-handle)
[230.543502] Starting subtest: invalid-signal-illegal-handle
[230.545806] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[230.613333] [016/133] (788s left) kms_rotation_crc (primary-rotation-180)
[230.696783] Starting subtest: primary-rotation-180
[237.661752] Subtest primary-rotation-180: SUCCESS (6.967s)
[238.861241] [017/133] (779s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[238.980381] Starting subtest: flip-vs-cursor-busy-crc-legacy
[239.829073] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.848s)
[240.679605] [018/133] (778s left) syncobj_eventfd (binary-wait-signaled)
[240.737674] Starting subtest: binary-wait-signaled
[240.739908] Subtest binary-wait-signaled: SUCCESS (0.000s)
[240.833567] [019/133] (778s left) kms_flip (2x-flip-vs-suspend-interruptible)
[240.921894] Starting subtest: 2x-flip-vs-suspend-interruptible
[240.934561] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[241.012994] [020/133] (777s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[241.107626] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[241.511969] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[244.264368] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.752s)
[244.274148] Starting dynamic subtest: pipe-A-eDP-1-4
[246.451253] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[246.463936] Starting dynamic subtest: pipe-A-eDP-1-4
[248.461653] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[248.472968] Starting dynamic subtest: pipe-A-eDP-1-x
[250.652085] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[251.018584] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[253.801665] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[253.811744] Starting dynamic subtest: pipe-B-eDP-1-4
[255.975613] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s)
[255.986668] Starting dynamic subtest: pipe-B-eDP-1-4
[257.985921] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[257.999081] Starting dynamic subtest: pipe-B-eDP-1-x
[260.176100] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[260.545298] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[263.332041] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[263.343591] Starting dynamic subtest: pipe-C-eDP-1-4
[265.506429] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[265.517498] Starting dynamic subtest: pipe-C-eDP-1-4
[267.517224] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[267.528034] Starting dynamic subtest: pipe-C-eDP-1-x
[269.685423] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[270.046645] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[272.863571] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.822s)
[272.872750] Starting dynamic subtest: pipe-D-eDP-1-4
[275.037849] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[275.052617] Starting dynamic subtest: pipe-D-eDP-1-4
[277.047454] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[277.056419] Starting dynamic subtest: pipe-D-eDP-1-x
[279.226646] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[279.229293] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.117s)
[280.441229] [021/133] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[280.542509] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[280.546578] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[280.633542] [022/133] (738s left) dmabuf_sync_file (export-multiwait)
[280.756160] Starting subtest: export-multiwait
[280.758158] Subtest export-multiwait: SUCCESS (0.001s)
[280.818402] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[280.821874] [023/133] (738s left) gem_userptr_blits (stress-mm-invalidate-close)
[280.893431] Starting subtest: stress-mm-invalidate-close
[283.043650] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[283.164229] [024/133] (735s left) kms_force_connector_basic (force-connector-state)
[283.248953] Starting subtest: force-connector-state
[283.859241] Subtest force-connector-state: SUCCESS (0.613s)
[284.798926] [025/133] (734s left) gem_bad_reloc (negative-reloc-lut)
[284.858936] Subtest negative-reloc-lut: SKIP (0.000s)
[284.929262] [026/133] (734s left) kms_content_protection (atomic-dpms)
[285.068059] Starting subtest: atomic-dpms
[285.072653] Subtest atomic-dpms: SKIP (0.000s)
[285.196239] [027/133] (734s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[285.253854] Starting subtest: etime-multi-wait-available-unsubmitted
[285.360754] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[285.451319] [028/133] (733s left) gem_exec_whisper (basic-queues-priority)
[285.515746] Starting subtest: basic-queues-priority
[309.987595] Subtest basic-queues-priority: SUCCESS (24.470s)
[310.169198] [029/133] (709s left) gem_madvise (dontneed-before-exec)
[310.215342] Starting subtest: dontneed-before-exec
[310.230154] Subtest dontneed-before-exec: SKIP (0.013s)
[310.287665] [030/133] (709s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[310.376701] Starting subtest: fbc-psr2-sprite-mmap-gtt
[310.379015] Starting dynamic subtest: eDP-1
[310.383142] Dynamic subtest eDP-1: SKIP (0.000s)
[310.387321] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[310.450157] [031/133] (708s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[310.509484] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[310.580244] [032/133] (708s left) kms_vblank (invalid)
[310.667663] Starting subtest: invalid
[310.669565] Starting dynamic subtest: pipe-A-eDP-1
[311.092231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.429s)
[311.094419] Subtest invalid: SUCCESS (0.430s)
[311.884350] [033/133] (707s left) sysfs_preempt_timeout (invalid)
[311.963418] Starting subtest: invalid
[311.965937] Starting dynamic subtest: vecs0
[311.968315] Dynamic subtest vecs0: SUCCESS (0.000s)
[311.979088] Starting dynamic subtest: ccs0
[311.981228] Dynamic subtest ccs0: SUCCESS (0.000s)
[311.989965] Starting dynamic subtest: vcs0
[311.992112] Dynamic subtest vcs0: SUCCESS (0.000s)
[312.000856] Starting dynamic subtest: bcs0
[312.003056] Dynamic subtest bcs0: SUCCESS (0.000s)
[312.013082] Starting dynamic subtest: rcs0
[312.015198] Dynamic subtest rcs0: SUCCESS (0.000s)
[312.023468] Starting dynamic subtest: vcs1
[312.025287] Dynamic subtest vcs1: SUCCESS (0.000s)
[312.027133] Subtest invalid: SUCCESS (0.004s)
[312.083135] [034/133] (707s left) kms_draw_crc (draw-method-mmap-cpu)
[312.177118] Starting subtest: draw-method-mmap-cpu
[312.179263] Starting dynamic subtest: xrgb8888-untiled
[312.420969] Dynamic subtest xrgb8888-untiled: SUCCESS (0.246s)
[312.431433] Starting dynamic subtest: rgb565-untiled
[312.643384] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[312.652435] Starting dynamic subtest: xrgb2101010-untiled
[312.864928] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[312.879663] Starting dynamic subtest: xbgr16161616f-untiled
[313.098401] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[313.107772] Starting dynamic subtest: xrgb8888-xtiled
[313.220480] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[313.229819] Starting dynamic subtest: rgb565-xtiled
[313.376429] Dynamic subtest rgb565-xtiled: SUCCESS (0.155s)
[313.385889] Starting dynamic subtest: xrgb2101010-xtiled
[313.509382] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[313.518390] Starting dynamic subtest: xbgr16161616f-xtiled
[313.642734] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[313.651937] Starting dynamic subtest: xrgb8888-4tiled
[313.787184] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[313.796472] Starting dynamic subtest: rgb565-4tiled
[313.931858] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[313.941323] Starting dynamic subtest: xrgb2101010-4tiled
[314.076159] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s)
[314.086725] Starting dynamic subtest: xbgr16161616f-4tiled
[314.220628] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[314.222622] Subtest draw-method-mmap-cpu: SUCCESS (2.046s)
[314.318102] [035/133] (705s left) kms_prop_blob (invalid-set-prop)
[314.378458] Starting subtest: invalid-set-prop
[314.380146] Subtest invalid-set-prop: SUCCESS (0.000s)
[314.503834] [036/133] (705s left) gem_mmap_wc (write-read-distinct)
[314.563350] Subtest write-read-distinct: SKIP (0.000s)
[314.617182] [037/133] (705s left) sw_sync (alloc_merge_fence)
[314.650221] Starting subtest: alloc_merge_fence
[314.652149] Subtest alloc_merge_fence: SUCCESS (0.000s)
[314.716437] [038/133] (705s left) gem_vm_create (create-ext)
[314.772281] Starting subtest: create-ext
[314.777830] Subtest create-ext: SUCCESS (0.006s)
[314.896646] [039/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[314.996511] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[314.999885] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[315.100723] [040/133] (704s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[315.196229] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[315.199888] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[315.318242] [041/133] (704s left) kms_flip (basic-flip-vs-modeset)
[315.422671] Starting subtest: basic-flip-vs-modeset
[315.424646] Starting dynamic subtest: A-eDP1
[318.011722] Dynamic subtest A-eDP1: SUCCESS (2.585s)
[318.021666] Starting dynamic subtest: B-eDP1
[320.201771] Dynamic subtest B-eDP1: SUCCESS (2.188s)
[320.211599] Starting dynamic subtest: C-eDP1
[322.407825] Dynamic subtest C-eDP1: SUCCESS (2.209s)
[322.417819] Starting dynamic subtest: D-eDP1
[324.596825] Dynamic subtest D-eDP1: SUCCESS (2.185s)
[324.599129] Subtest basic-flip-vs-modeset: SUCCESS (9.174s)
[325.471897] [042/133] (694s left) i915_drm_fdinfo (isolation)
[325.516273] Starting subtest: isolation
[325.518261] Starting dynamic subtest: rcs0
[325.537855] Dynamic subtest rcs0: SKIP (0.021s)
[325.548868] Starting dynamic subtest: bcs0
[325.553314] Dynamic subtest bcs0: SKIP (0.000s)
[325.562326] Starting dynamic subtest: vcs0
[325.566821] Dynamic subtest vcs0: SKIP (0.000s)
[325.575064] Starting dynamic subtest: vcs1
[325.579222] Dynamic subtest vcs1: SKIP (0.000s)
[325.588221] Starting dynamic subtest: vecs0
[325.592185] Dynamic subtest vecs0: SKIP (0.000s)
[325.600847] Starting dynamic subtest: ccs0
[325.604943] Dynamic subtest ccs0: SKIP (0.000s)
[325.609045] Subtest isolation: SKIP (0.025s)
[325.646292] [043/133] (694s left) gem_exec_fence (long-history)
[326.089308] Starting subtest: long-history
[333.615647] Subtest long-history: SUCCESS (7.525s)
[334.217127] [044/133] (685s left) kms_atomic_interruptible (legacy-pageflip)
[334.317731] Starting subtest: legacy-pageflip
[334.319853] Starting dynamic subtest: pipe-A-eDP-1
[341.773075] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.455s)
[341.775389] Subtest legacy-pageflip: SUCCESS (7.456s)
[342.604534] [045/133] (677s left) gem_softpin (allocator-fork)
[342.661292] Starting subtest: allocator-fork
[344.877963] Subtest allocator-fork: SUCCESS (2.215s)
[345.007986] [046/133] (675s left) gen7_exec_parse (basic-offset)
[345.063179] Subtest basic-offset: SKIP (0.000s)
[345.133697] [047/133] (674s left) gem_sync (basic-each)
[345.200838] Starting subtest: basic-each
[347.645668] Subtest basic-each: SUCCESS (2.454s)
[347.836633] [048/133] (672s left) gem_exec_reloc (basic-write-cpu)
[347.890880] Subtest basic-write-cpu: SKIP (0.000s)
[347.960584] [049/133] (672s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[350.091052] Starting subtest: dpms-mode-unset-lpsp
[354.166310] Subtest dpms-mode-unset-lpsp: SUCCESS (4.078s)
[354.555270] [050/133] (665s left) kms_psr (psr2-primary-page-flip)
[354.661223] Starting subtest: psr2-primary-page-flip
[354.663610] Starting dynamic subtest: eDP-1
[356.410282] Dynamic subtest eDP-1: SUCCESS (1.748s)
[356.412649] Subtest psr2-primary-page-flip: SUCCESS (1.749s)
[357.277342] [051/133] (663s left) gem_mmap_wc (write-gtt-read-wc)
[357.326688] Subtest write-gtt-read-wc: SKIP (0.000s)
[357.390517] [052/133] (662s left) kms_cursor_crc (cursor-onscreen-128x42)
[357.624314] Starting subtest: cursor-onscreen-128x42
[357.679122] Subtest cursor-onscreen-128x42: SKIP (0.050s)
[357.877068] [053/133] (662s left) gem_exec_whisper (basic-fds)
[357.942100] Starting subtest: basic-fds
[364.323807] Subtest basic-fds: SUCCESS (6.365s)
[364.494257] [054/133] (655s left) kms_pm_rpm (system-suspend-idle)
[366.020458] Starting subtest: system-suspend-idle
[386.093487] Subtest system-suspend-idle: SUCCESS (4.821s)
[391.490607] [055/133] (633s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[391.625465] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[391.629673] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[391.722521] [056/133] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[391.815933] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[399.294297] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.299s)
[399.433125] [057/133] (626s left) gem_ctx_persistence (hang)
[399.501312] Starting subtest: hang
[399.505838] Subtest hang: SKIP (0.000s)
[399.612340] [058/133] (626s left) core_debugfs (read-all-entries)
[399.669940] Starting subtest: read-all-entries
[399.766305] Subtest read-all-entries: SUCCESS (0.095s)
[399.848929] [059/133] (625s left) kms_psr (pr-cursor-plane-onoff)
[399.940805] Starting subtest: pr-cursor-plane-onoff
[399.945145] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[400.017391] [060/133] (625s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[400.108655] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[400.112923] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[400.221928] [061/133] (625s left) gem_mmap (big-bo)
[400.286071] Subtest big-bo: SKIP (0.000s)
[400.341734] [062/133] (625s left) gem_exec_schedule (preempt-other-chain)
[400.413158] Starting subtest: preempt-other-chain
[400.415083] Starting dynamic subtest: rcs0
[400.495824] Dynamic subtest rcs0: SUCCESS (0.082s)
[400.508701] Starting dynamic subtest: bcs0
[400.578118] Dynamic subtest bcs0: SUCCESS (0.080s)
[400.588963] Starting dynamic subtest: vcs0
[400.659105] Dynamic subtest vcs0: SUCCESS (0.078s)
[400.673332] Starting dynamic subtest: vcs1
[400.742949] Dynamic subtest vcs1: SUCCESS (0.082s)
[400.756362] Starting dynamic subtest: vecs0
[400.824041] Dynamic subtest vecs0: SUCCESS (0.080s)
[400.834670] Starting dynamic subtest: ccs0
[400.906152] Dynamic subtest ccs0: SUCCESS (0.081s)
[400.908674] Subtest preempt-other-chain: SUCCESS (0.487s)
[402.241679] [063/133] (623s left) gem_eio (in-flight-suspend)
[402.480609] Starting subtest: in-flight-suspend
[447.184427] Subtest in-flight-suspend: SUCCESS (15.058s)
[455.345619] [064/133] (578s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[455.452097] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[455.456912] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[455.516730] [065/133] (578s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[455.890441] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[456.777676] [066/133] (577s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[456.871328] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[456.875856] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[456.949612] [067/133] (577s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[457.005194] Starting subtest: multi-wait-all-for-submit-signaled
[457.007562] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[457.129149] [068/133] (576s left) kms_psr (fbc-pr-no-drrs)
[457.226918] Starting subtest: fbc-pr-no-drrs
[457.231050] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[457.340770] [069/133] (576s left) syncobj_timeline (wait-all-for-submit-complex)
[457.407079] Starting subtest: wait-all-for-submit-complex
[457.622286] Subtest wait-all-for-submit-complex: SUCCESS (0.208s)
[457.704256] [070/133] (576s left) syncobj_wait (wait-all-interrupted)
[457.758110] Starting subtest: wait-all-interrupted
[457.859844] Subtest wait-all-interrupted: SUCCESS (0.099s)
[457.942187] [071/133] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[458.052204] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[458.056721] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[458.174371] [072/133] (576s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[458.292793] Starting subtest: fbcpsr-tiling-linear
[464.948385] Subtest fbcpsr-tiling-linear: SUCCESS (6.537s)
[465.089669] [073/133] (569s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[465.143890] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[465.148200] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[465.348865] [074/133] (569s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[465.444247] Starting subtest: fbc-dirtyfb-ioctl
[465.446584] Starting dynamic subtest: A-eDP-1
[468.033465] Dynamic subtest A-eDP-1: SUCCESS (2.565s)
[468.035881] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.566s)
[468.902886] [075/133] (565s left) kms_color_pipeline (plane-lut1d-lut1d)
[469.000287] Starting subtest: plane-lut1d-lut1d
[469.158483] Starting dynamic subtest: pipe-A-plane-0
[469.337174] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[469.352907] Starting dynamic subtest: pipe-A-plane-1
[469.504364] Dynamic subtest pipe-A-plane-1: SUCCESS (0.164s)
[469.514962] Starting dynamic subtest: pipe-A-plane-2
[469.672233] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[470.900473] Starting dynamic subtest: pipe-B-plane-0
[471.070895] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[471.081709] Starting dynamic subtest: pipe-B-plane-1
[471.226765] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[471.239245] Starting dynamic subtest: pipe-B-plane-2
[471.394191] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[472.597791] Starting dynamic subtest: pipe-C-plane-0
[472.756359] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[472.767294] Starting dynamic subtest: pipe-C-plane-1
[472.924430] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[472.939830] Starting dynamic subtest: pipe-C-plane-2
[473.090964] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[474.289412] Starting dynamic subtest: pipe-D-plane-0
[474.425587] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[474.436551] Starting dynamic subtest: pipe-D-plane-1
[474.581645] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[474.592245] Starting dynamic subtest: pipe-D-plane-2
[474.737748] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[475.032712] Subtest plane-lut1d-lut1d: SUCCESS (6.003s)
[475.858095] [076/133] (558s left) api_intel_allocator (two-level-inception)
[475.930704] Starting subtest: two-level-inception
[481.342729] Subtest two-level-inception: SUCCESS (5.400s)
[481.469419] [077/133] (553s left) gem_render_copy (linear-to-vebox-y-tiled)
[481.529788] Starting subtest: linear-to-vebox-y-tiled
[481.534273] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[481.717954] [078/133] (552s left) gem_mmap_gtt (close-race)
[481.783567] Subtest close-race: SKIP (0.000s)
[481.860859] [079/133] (552s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[481.961260] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[481.965885] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[483.066747] [080/133] (551s left) i915_suspend (forcewake)
[483.125057] Starting subtest: forcewake
[514.882715] Subtest forcewake: SUCCESS (4.017s)
[520.972944] [081/133] (519s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[521.394124] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[522.177297] [082/133] (518s left) kms_plane_alpha_blend (alpha-7efc)
[522.273998] Starting subtest: alpha-7efc
[522.575231] Starting dynamic subtest: pipe-A-eDP-1
[523.190051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[523.221502] Starting dynamic subtest: pipe-D-eDP-1
[524.548836] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[524.551266] Subtest alpha-7efc: SUCCESS (2.215s)
[525.380864] [083/133] (515s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[525.484792] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[525.486997] Starting dynamic subtest: pipe-A-eDP-1
[525.514205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[525.526543] Starting dynamic subtest: pipe-B-eDP-1
[525.550922] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[525.560758] Starting dynamic subtest: pipe-C-eDP-1
[525.585072] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[525.597447] Starting dynamic subtest: pipe-D-eDP-1
[525.621048] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[525.625368] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[527.733625] [084/133] (513s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[527.849263] Starting subtest: yf-tiled-64bpp-rotate-90
[527.853545] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[527.949320] [085/133] (512s left) gem_exec_balancer (parallel)
[528.211446] Starting subtest: parallel
[529.187047] Subtest parallel: SUCCESS (0.963s)
[529.513204] [086/133] (511s left) i915_pm_rpm (gem-mmap-type)
[531.657202] Starting subtest: gem-mmap-type
[531.660021] Starting dynamic subtest: wb-smem0
[535.157370] Dynamic subtest wb-smem0: SUCCESS (3.477s)
[535.170334] Starting dynamic subtest: wc-smem0
[538.344292] Dynamic subtest wc-smem0: SUCCESS (3.168s)
[538.356997] Starting dynamic subtest: uc-smem0
[541.213295] Dynamic subtest uc-smem0: SUCCESS (2.858s)
[541.215613] Subtest gem-mmap-type: SUCCESS (9.507s)
[541.303767] [087/133] (499s left) gem_userptr_blits (map-fixed-invalidate-busy)
[541.370586] Starting subtest: map-fixed-invalidate-busy
[541.375237] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[541.485483] [088/133] (499s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[541.580439] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[541.584714] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[541.683168] [089/133] (499s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[541.777912] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[541.782004] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[541.874807] [090/133] (499s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[541.973232] Starting subtest: y-tiled-64bpp-rotate-0
[541.977482] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[542.064964] [091/133] (499s left) prime_vgem (basic-blt)
[542.138352] Starting subtest: basic-blt
[542.169342] Subtest basic-blt: SUCCESS (0.030s)
[542.294281] [092/133] (498s left) gem_ctx_persistence (engines-hostile)
[542.353723] Starting subtest: engines-hostile
[542.355545] Starting dynamic subtest: rcs0
[542.426070] Dynamic subtest rcs0: SUCCESS (0.072s)
[542.441129] Starting dynamic subtest: bcs0
[542.525340] Dynamic subtest bcs0: SUCCESS (0.096s)
[542.539591] Starting dynamic subtest: vcs0
[542.625960] Dynamic subtest vcs0: SUCCESS (0.098s)
[542.638638] Starting dynamic subtest: vcs1
[542.723021] Dynamic subtest vcs1: SUCCESS (0.095s)
[542.735515] Starting dynamic subtest: vecs0
[542.822358] Dynamic subtest vecs0: SUCCESS (0.097s)
[542.834274] Starting dynamic subtest: ccs0
[542.906957] Dynamic subtest ccs0: SUCCESS (0.082s)
[542.909048] Subtest engines-hostile: SUCCESS (0.553s)
[543.037211] [093/133] (498s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[543.142593] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[543.145903] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[543.248295] [094/133] (498s left) gem_mmap_gtt (basic-wc)
[543.301675] Subtest basic-wc: SKIP (0.000s)
[543.369291] [095/133] (498s left) gem_exec_params (cliprects_ptr-dirt)
[543.427009] Starting subtest: cliprects_ptr-dirt
[543.429101] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[543.533018] [096/133] (497s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[543.631114] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[547.305861] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.671s)
[548.472394] [097/133] (492s left) kms_big_fb (linear-16bpp-rotate-180)
[548.566557] Starting subtest: linear-16bpp-rotate-180
[549.969053] Subtest linear-16bpp-rotate-180: SUCCESS (1.401s)
[550.072242] [098/133] (491s left) perf (invalid-create-userspace-config)
[550.201651] Starting subtest: invalid-create-userspace-config
[550.203624] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[550.247912] [099/133] (491s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[550.350571] Starting subtest: 4-tiled-64bpp-rotate-0
[551.976045] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.624s)
[552.143947] [100/133] (489s left) core_auth (many-magics)
[552.212324] Starting subtest: many-magics
[553.192129] Subtest many-magics: SUCCESS (0.978s)
[553.332726] [101/133] (488s left) gem_mmap_offset (clear)
[553.391368] Starting subtest: clear
[553.393894] Starting dynamic subtest: smem0
[577.373890] Dynamic subtest smem0: SUCCESS (23.960s)
[577.376313] Subtest clear: SUCCESS (23.963s)
[577.520938] [102/133] (464s left) gem_exec_params (invalid-bsd-ring)
[577.626278] Starting subtest: invalid-bsd-ring
[577.628531] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[577.722573] [103/133] (464s left) prime_udl
[577.810973] [104/133] (463s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[577.912266] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[577.916310] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[578.006973] [105/133] (463s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[578.110046] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[578.111936] Starting dynamic subtest: pipe-A-eDP-1
[580.446638] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.336s)
[580.456841] Starting dynamic subtest: pipe-B-eDP-1
[582.884716] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.435s)
[582.895552] Starting dynamic subtest: pipe-C-eDP-1
[585.029202] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.143s)
[585.039738] Starting dynamic subtest: pipe-D-eDP-1
[587.120905] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.088s)
[587.122934] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.008s)
[588.365437] [106/133] (453s left) prime_mmap (test_userptr)
[588.425947] Starting subtest: test_userptr
[588.428283] Starting dynamic subtest: test_userptr-smem
[588.430491] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[588.432762] Subtest test_userptr: SUCCESS (0.001s)
[588.526071] [107/133] (453s left) kms_psr (psr-sprite-render)
[588.616721] Starting subtest: psr-sprite-render
[588.619070] Starting dynamic subtest: eDP-1
[590.355368] Dynamic subtest eDP-1: SUCCESS (1.735s)
[590.357598] Subtest psr-sprite-render: SUCCESS (1.736s)
[591.167656] [108/133] (450s left) kms_flip (2x-flip-vs-panning)
[591.279001] Starting subtest: 2x-flip-vs-panning
[591.286828] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[591.370691] [109/133] (450s left) gem_exec_balancer (parallel-ordering)
[591.625671] Starting subtest: parallel-ordering
[592.626147] Subtest parallel-ordering: SUCCESS (0.999s)
[592.757767] [110/133] (449s left) kms_psr (fbc-psr2-primary-page-flip)
[592.857041] Starting subtest: fbc-psr2-primary-page-flip
[592.858977] Starting dynamic subtest: eDP-1
[592.862994] Dynamic subtest eDP-1: SKIP (0.000s)
[592.867109] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[592.930720] [111/133] (449s left) kms_hdr (bpc-switch-suspend)
[593.011159] Starting subtest: bpc-switch-suspend
[594.107932] Starting dynamic subtest: pipe-A-eDP-1
[613.978433] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.921s)
[613.980723] Subtest bpc-switch-suspend: SUCCESS (6.018s)
[624.110015] [112/133] (428s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[624.222342] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[629.010405] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.671s)
[630.194523] [113/133] (421s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[630.254549] Starting subtest: single-wait-for-submit-unsubmitted
[630.364909] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[630.444503] [114/133] (421s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[630.547799] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[637.973256] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.339s)
[638.093152] [115/133] (414s left) kms_atomic (test-only)
[638.196389] Starting subtest: test-only
[638.250394] Starting dynamic subtest: pipe-A-eDP-1
[640.781360] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.517s)
[640.783834] Subtest test-only: SUCCESS (2.571s)
[641.626615] [116/133] (410s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[641.714817] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[641.717014] Starting dynamic subtest: pipe-A-eDP-1
[641.726941] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[641.738605] Starting dynamic subtest: pipe-B-eDP-1
[641.747117] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[641.757748] Starting dynamic subtest: pipe-C-eDP-1
[641.765968] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[641.775868] Starting dynamic subtest: pipe-D-eDP-1
[641.783867] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[641.787728] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[644.016336] [117/133] (408s left) gem_create (hog-create)
[644.067853] Starting subtest: hog-create
[644.070253] Starting dynamic subtest: smem0
[676.443047] Dynamic subtest smem0: SUCCESS (32.344s)
[676.445721] Subtest hog-create: SUCCESS (32.346s)
[676.649386] [118/133] (375s left) syncobj_wait (invalid-reset-one-illegal-handle)
[676.714841] Starting subtest: invalid-reset-one-illegal-handle
[676.717314] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[676.835191] [119/133] (375s left) perf (gen12-invalid-class-instance)
[676.955621] Starting subtest: gen12-invalid-class-instance
[676.971523] Subtest gen12-invalid-class-instance: SUCCESS (0.013s)
[677.020630] [120/133] (375s left) perf_pmu (invalid-init)
[677.069037] Starting subtest: invalid-init
[677.071356] Subtest invalid-init: SUCCESS (0.000s)
[677.180638] [121/133] (375s left) gem_flink_basic (basic)
[677.231415] Starting subtest: basic
[677.233402] Subtest basic: SUCCESS (0.000s)
[677.324231] [122/133] (375s left) kms_flip (2x-plain-flip)
[677.424008] Starting subtest: 2x-plain-flip
[677.432981] Subtest 2x-plain-flip: SKIP (0.011s)
[677.525182] [123/133] (375s left) gem_mmap_offset (pf-nonblock)
[677.582917] Starting subtest: pf-nonblock
[677.589292] Subtest pf-nonblock: SUCCESS (0.006s)
[677.728343] [124/133] (374s left) kms_atomic_transition (plane-all-transition-fencing)
[677.817248] Starting subtest: plane-all-transition-fencing
[677.819139] Starting dynamic subtest: pipe-A-eDP-1
[680.313079] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[680.632089] Starting dynamic subtest: pipe-B-eDP-1
[683.867307] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.246s)
[684.165538] Subtest plane-all-transition-fencing: SUCCESS (6.345s)
[685.042261] [125/133] (367s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[685.101495] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[685.204340] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[685.297027] [126/133] (367s left) sw_sync (sync_busy)
[685.339591] Starting subtest: sync_busy
[685.342125] Subtest sync_busy: SUCCESS (0.002s)
[685.409528] [127/133] (367s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[685.498725] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[689.474073] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.978s)
[690.672014] [128/133] (362s left) i915_hangman (gt-engine-error)
[690.752525] Starting subtest: gt-engine-error
[690.754511] Starting dynamic subtest: rcs0
[692.351274] Dynamic subtest rcs0: SUCCESS (1.599s)
[692.365014] Starting dynamic subtest: bcs0
[696.382515] Dynamic subtest bcs0: SUCCESS (4.027s)
[696.399440] Starting dynamic subtest: vcs0
[698.366980] Dynamic subtest vcs0: SUCCESS (1.981s)
[698.380881] Starting dynamic subtest: vcs1
[700.350729] Dynamic subtest vcs1: SUCCESS (1.980s)
[700.363951] Starting dynamic subtest: vecs0
[702.398821] Dynamic subtest vecs0: SUCCESS (2.044s)
[702.416274] Starting dynamic subtest: ccs0
[704.318830] Dynamic subtest ccs0: SUCCESS (1.916s)
[704.321564] Subtest gt-engine-error: SUCCESS (13.566s)
[704.403496] [129/133] (348s left) gem_exec_schedule (semaphore-resolve)
[704.484415] Starting subtest: semaphore-resolve
[704.546794] Subtest semaphore-resolve: SUCCESS (0.067s)
[704.885937] [130/133] (348s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[704.997618] Starting subtest: yf-tiled-32bpp-rotate-180
[705.001852] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[705.109029] [131/133] (347s left) kms_plane (plane-position-hole-dpms)
[705.200724] Starting subtest: plane-position-hole-dpms
[705.736113] Starting dynamic subtest: pipe-A-plane-1
[708.064341] Dynamic subtest pipe-A-plane-1: SUCCESS (2.329s)
[708.077463] Starting dynamic subtest: pipe-A-plane-2
[710.466751] Dynamic subtest pipe-A-plane-2: SUCCESS (2.399s)
[710.477483] Starting dynamic subtest: pipe-A-plane-3
[712.873736] Dynamic subtest pipe-A-plane-3: SUCCESS (2.405s)
[712.885386] Starting dynamic subtest: pipe-A-plane-4
[715.279834] Dynamic subtest pipe-A-plane-4: SUCCESS (2.406s)
[715.290911] Starting dynamic subtest: pipe-A-plane-5
[715.302972] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[716.520015] Starting dynamic subtest: pipe-B-plane-1
[718.873810] Dynamic subtest pipe-B-plane-1: SUCCESS (2.363s)
[718.884995] Starting dynamic subtest: pipe-B-plane-2
[721.280407] Dynamic subtest pipe-B-plane-2: SUCCESS (2.403s)
[721.291384] Starting dynamic subtest: pipe-B-plane-3
[723.681728] Dynamic subtest pipe-B-plane-3: SUCCESS (2.400s)
[723.693024] Starting dynamic subtest: pipe-B-plane-4
[726.070119] Dynamic subtest pipe-B-plane-4: SUCCESS (2.387s)
[726.080865] Starting dynamic subtest: pipe-B-plane-5
[726.094522] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[726.096757] Subtest plane-position-hole-dpms: SUCCESS (20.888s)
[726.947012] [132/133] (326s left) prime_self_import (basic-llseek-size)
[726.990959] Starting subtest: basic-llseek-size
[727.011717] Subtest basic-llseek-size: SUCCESS (0.021s)
[727.119812] [133/133] (325s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[727.220069] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[727.223854] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[727.285851] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_exec_gttfill
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: kms_joiner
results: parsing output: 5/ for test: gem_exec_flush
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: gem_ctx_shared
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: syncobj_eventfd
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: dmabuf_sync_file
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: kms_force_connector_basic
results: parsing output: 24/ for test: gem_bad_reloc
results: parsing output: 25/ for test: kms_content_protection
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: gem_madvise
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_vblank
results: parsing output: 32/ for test: sysfs_preempt_timeout
results: parsing output: 33/ for test: kms_draw_crc
results: parsing output: 34/ for test: kms_prop_blob
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: sw_sync
results: parsing output: 37/ for test: gem_vm_create
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: i915_drm_fdinfo
results: parsing output: 42/ for test: gem_exec_fence
results: parsing output: 43/ for test: kms_atomic_interruptible
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: gen7_exec_parse
results: parsing output: 46/ for test: gem_sync
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_mmap_wc
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: gem_exec_whisper
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: core_debugfs
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: gem_mmap
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: kms_chamelium_edid
results: parsing output: 65/ for test: kms_plane
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: kms_dirtyfb
results: parsing output: 74/ for test: kms_color_pipeline
results: parsing output: 75/ for test: api_intel_allocator
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: i915_suspend
results: parsing output: 80/ for test: kms_chamelium_hpd
results: parsing output: 81/ for test: kms_plane_alpha_blend
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: i915_pm_rpm
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: prime_vgem
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: core_auth
results: parsing output: 100/ for test: gem_mmap_offset
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: prime_udl
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_hdr
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_create
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_flink_basic
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_mmap_offset
results: parsing output: 123/ for test: kms_atomic_transition
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: i915_hangman
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: prime_self_import
results: parsing output: 132/ for test: kms_joiner
Done.