[123.803328] Initializing watchdogs
[123.803376]   /dev/watchdog0
[123.816961] [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]
[123.821214] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[123.823414] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[123.826911] [001/131] (960s left) sw_sync (sync_multi_producer_single_consumer)
[123.941074] Starting subtest: sync_multi_producer_single_consumer
[125.015770] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[125.070227] [002/131] (959s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[125.167822] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[125.170164] Starting dynamic subtest: pipe-A-eDP-1
[125.195069] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[125.201927] Starting dynamic subtest: pipe-B-eDP-1
[125.224286] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[125.230647] Starting dynamic subtest: pipe-C-eDP-1
[125.253647] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[125.260898] Starting dynamic subtest: pipe-D-eDP-1
[125.284803] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[125.289361] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[127.284087] [003/131] (957s left) gem_exec_schedule (smoketest)
[127.473955] Starting subtest: smoketest
[127.476238] Starting dynamic subtest: rcs0
[133.019988] Dynamic subtest rcs0: SUCCESS (5.497s)
[133.027702] Starting dynamic subtest: bcs0
[138.535321] Dynamic subtest bcs0: SUCCESS (5.511s)
[138.545072] Starting dynamic subtest: vcs0
[144.033864] Dynamic subtest vcs0: SUCCESS (5.496s)
[144.041769] Starting dynamic subtest: vcs1
[149.545324] Dynamic subtest vcs1: SUCCESS (5.513s)
[149.556744] Starting dynamic subtest: vecs0
[155.046190] Dynamic subtest vecs0: SUCCESS (5.500s)
[155.057099] Starting dynamic subtest: ccs0
[160.563043] Dynamic subtest ccs0: SUCCESS (5.509s)
[160.565440] Subtest smoketest: SUCCESS (33.027s)
[160.751732] [004/131] (923s left) gem_exec_balancer (bonded-dual)
[160.820558] Starting subtest: bonded-dual
[160.824795] Subtest bonded-dual: SKIP (0.000s)
[161.114411] [005/131] (923s left) kms_psr (psr2-cursor-plane-move)
[161.219790] Starting subtest: psr2-cursor-plane-move
[161.222174] Starting dynamic subtest: eDP-1
[162.976094] Dynamic subtest eDP-1: SUCCESS (1.757s)
[162.978507] Subtest psr2-cursor-plane-move: SUCCESS (1.757s)
[163.753398] [006/131] (920s left) kms_psr (fbc-psr-primary-blt)
[163.852858] Starting subtest: fbc-psr-primary-blt
[163.855241] Starting dynamic subtest: eDP-1
[163.859619] Dynamic subtest eDP-1: SKIP (0.000s)
[163.863996] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[163.918511] [007/131] (920s left) kms_big_fb (linear-32bpp-rotate-90)
[164.024115] Starting subtest: linear-32bpp-rotate-90
[164.047195] Subtest linear-32bpp-rotate-90: SKIP (0.023s)
[164.164151] [008/131] (920s left) device_reset (cold-reset-bound)
[164.213087] Starting subtest: cold-reset-bound
[164.217635] Subtest cold-reset-bound: SKIP (0.000s)
[164.276108] [009/131] (920s left) kms_cursor_crc (cursor-size-hints)
[164.398720] Starting subtest: cursor-size-hints
[164.401072] Starting dynamic subtest: pipe-A-eDP-1
[165.050492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[165.058974] Starting dynamic subtest: pipe-D-eDP-1
[166.333570] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s)
[166.335819] Subtest cursor-size-hints: SUCCESS (1.934s)
[167.115403] [010/131] (917s left) prime_self_import (reimport-vs-gem_close-race)
[167.148198] Starting subtest: reimport-vs-gem_close-race
[172.247797] Subtest reimport-vs-gem_close-race: SUCCESS (5.099s)
[172.313529] [011/131] (912s left) perf_pmu (all-busy-check-all)
[172.358867] Starting subtest: all-busy-check-all
[173.930513] Subtest all-busy-check-all: SUCCESS (1.572s)
[174.043838] [012/131] (910s left) gem_exec_fence (syncobj-export)
[174.516086] Starting subtest: syncobj-export
[174.524894] Subtest syncobj-export: SUCCESS (0.008s)
[175.950885] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[175.953961] [013/131] (908s left) sw_sync (alloc_fence)
[175.987541] Starting subtest: alloc_fence
[175.990030] Subtest alloc_fence: SUCCESS (0.000s)
[176.032176] [014/131] (908s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[181.048059] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[181.052664] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.003s)
[181.901276] [015/131] (902s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[182.004983] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[184.918365] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.917s)
[185.056481] [016/131] (899s left) gem_fence_thrash (bo-write-verify-x)
[185.090369] Starting subtest: bo-write-verify-x
[185.124902] Subtest bo-write-verify-x: SKIP (0.032s)
[185.180476] [017/131] (899s left) gem_exec_reloc (basic-write-wc-noreloc)
[185.238506] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[185.297284] [018/131] (899s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[185.383563] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[185.387529] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[186.456858] [019/131] (898s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[186.585048] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[186.720121] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.136s)
[186.836697] [020/131] (898s left) i915_pm_rps (min-max-config-loaded)
[186.902071] Starting subtest: min-max-config-loaded
[186.906880] Subtest min-max-config-loaded: SKIP (0.000s)
[186.978123] [021/131] (898s left) gem_readwrite (beyond-eob)
[187.026109] Subtest beyond-EOB: SKIP (0.000s)
[187.097874] [022/131] (897s left) gem_render_copy (linear-to-vebox-yf-tiled)
[187.161494] Starting subtest: linear-to-vebox-yf-tiled
[187.165995] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[187.338493] [023/131] (897s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[187.436228] Starting subtest: 2x-flip-vs-modeset-vs-hang
[187.447446] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[187.519519] [024/131] (897s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[187.613750] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[192.227093] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.616s)
[192.360687] [025/131] (892s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[192.454927] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[192.457350] Starting dynamic subtest: pipe-A
[192.792660] Dynamic subtest pipe-A: SUCCESS (0.338s)
[192.802605] Starting dynamic subtest: pipe-B
[194.195237] Dynamic subtest pipe-B: SUCCESS (1.402s)
[194.204385] Starting dynamic subtest: pipe-C
[195.618650] Dynamic subtest pipe-C: SUCCESS (1.423s)
[195.627621] Starting dynamic subtest: pipe-D
[197.041673] Dynamic subtest pipe-D: SUCCESS (1.422s)
[197.044268] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.586s)
[198.212402] [026/131] (886s left) kms_cursor_crc (cursor-random-32x32)
[198.344482] Starting subtest: cursor-random-32x32
[198.385607] Subtest cursor-random-32x32: SKIP (0.035s)
[198.634391] [027/131] (886s left) kms_vrr (negative-basic)
[198.729996] Starting subtest: negative-basic
[198.737028] Starting dynamic subtest: pipe-A-eDP-1
[204.194490] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.454s)
[204.481321] Subtest negative-basic: SUCCESS (5.749s)
[205.333450] [028/131] (879s left) gem_wait (busy)
[205.400714] Starting subtest: busy
[205.403320] Starting dynamic subtest: all-engines
[206.891971] Dynamic subtest all-engines: SUCCESS (1.489s)
[206.903047] Starting dynamic subtest: rcs0
[207.430610] Dynamic subtest rcs0: SUCCESS (0.540s)
[207.440347] Starting dynamic subtest: bcs0
[207.969760] Dynamic subtest bcs0: SUCCESS (0.539s)
[207.979999] Starting dynamic subtest: vcs0
[209.965905] Dynamic subtest vcs0: SUCCESS (1.994s)
[209.975557] Starting dynamic subtest: vcs1
[211.946422] Dynamic subtest vcs1: SUCCESS (1.980s)
[211.957066] Starting dynamic subtest: vecs0
[213.930038] Dynamic subtest vecs0: SUCCESS (1.983s)
[213.940722] Starting dynamic subtest: ccs0
[214.471018] Dynamic subtest ccs0: SUCCESS (0.541s)
[214.473516] Subtest busy: SUCCESS (9.069s)
[214.669547] [029/131] (870s left) syncobj_timeline (wait-any-snapshot)
[214.733317] Starting subtest: wait-any-snapshot
[214.815686] Subtest wait-any-snapshot: SUCCESS (0.081s)
[214.887732] [030/131] (870s left) perf (blocking)
[214.997626] Starting subtest: blocking
[214.999572] Starting dynamic subtest: 0-rcs0
[225.036444] Dynamic subtest 0-rcs0: SUCCESS (10.039s)
[225.044307] Starting dynamic subtest: 1-vcs1
[235.058705] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[235.061412] Subtest blocking: SUCCESS (20.061s)
[235.106964] [031/131] (850s left) gem_eio (wait-wedge-10ms)
[235.315581] Starting subtest: wait-wedge-10ms
[237.038412] Subtest wait-wedge-10ms: SUCCESS (1.722s)
[237.186971] [032/131] (848s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[237.306541] Starting subtest: cursorA-vs-flipB-atomic-transitions
[237.310625] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[237.434557] [033/131] (848s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[237.537072] Starting subtest: multiplane-rotation-cropping-bottom
[244.764487] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.227s)
[244.885684] [034/131] (840s left) kms_psr (psr2-sprite-plane-move)
[244.975576] Starting subtest: psr2-sprite-plane-move
[244.977607] Starting dynamic subtest: eDP-1
[246.738259] Dynamic subtest eDP-1: SUCCESS (1.761s)
[246.740786] Subtest psr2-sprite-plane-move: SUCCESS (1.762s)
[247.573546] [035/131] (837s left) gem_exec_schedule (pi-distinct-iova)
[247.754437] Starting subtest: pi-distinct-iova
[247.756584] Starting dynamic subtest: rcs0
[247.827880] Dynamic subtest rcs0: SUCCESS (0.076s)
[247.840867] Starting dynamic subtest: vcs0
[247.885145] Dynamic subtest vcs0: SUCCESS (0.058s)
[247.897651] Starting dynamic subtest: vcs1
[247.940575] Dynamic subtest vcs1: SUCCESS (0.055s)
[247.951286] Starting dynamic subtest: vecs0
[247.991621] Dynamic subtest vecs0: SUCCESS (0.050s)
[248.002135] Starting dynamic subtest: ccs0
[248.064082] Dynamic subtest ccs0: SUCCESS (0.071s)
[248.066657] Subtest pi-distinct-iova: SUCCESS (0.313s)
[249.024262] [036/131] (836s left) gem_exec_flush (basic-uc-rw-default)
[249.083697] Starting subtest: basic-uc-rw-default
[254.560172] Subtest basic-uc-rw-default: SUCCESS (5.476s)
[254.739860] [037/131] (830s left) drm_fdinfo (isolation)
[254.781944] Starting subtest: isolation
[254.784664] Starting dynamic subtest: rcs0
[254.823073] Dynamic subtest rcs0: SKIP (0.041s)
[254.834287] Starting dynamic subtest: bcs0
[254.838722] Dynamic subtest bcs0: SKIP (0.001s)
[254.848885] Starting dynamic subtest: vcs0
[254.853468] Dynamic subtest vcs0: SKIP (0.000s)
[254.861086] Starting dynamic subtest: vcs1
[254.865293] Dynamic subtest vcs1: SKIP (0.000s)
[254.872702] Starting dynamic subtest: vecs0
[254.876948] Dynamic subtest vecs0: SKIP (0.000s)
[254.884559] Starting dynamic subtest: ccs0
[254.888782] Dynamic subtest ccs0: SKIP (0.000s)
[254.892975] Subtest isolation: SKIP (0.046s)
[254.922815] [038/131] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[255.032814] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[255.037289] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[255.117957] [039/131] (830s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[255.221359] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[255.225617] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[255.346119] [040/131] (830s left) kms_atomic_transition (modeset-transition-fencing)
[255.438212] Starting subtest: modeset-transition-fencing
[255.440477] Starting dynamic subtest: 1x-outputs
[265.904373] Dynamic subtest 1x-outputs: SUCCESS (10.463s)
[266.165294] Subtest modeset-transition-fencing: SUCCESS (10.726s)
[267.018920] [041/131] (818s left) kms_lease (lease-uevent)
[267.113645] Starting subtest: lease-uevent
[268.132694] Subtest lease-uevent: SUCCESS (1.020s)
[268.247223] [042/131] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[268.358508] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[268.362973] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[268.473923] [043/131] (817s left) gem_ringfill (engines-basic)
[273.902777] Starting subtest: engines-basic
[273.905026] Starting dynamic subtest: rcs0
[273.992022] Dynamic subtest rcs0: SUCCESS (0.091s)
[274.003631] Starting dynamic subtest: bcs0
[274.038311] Dynamic subtest bcs0: SUCCESS (0.046s)
[274.048124] Starting dynamic subtest: vcs0
[274.079827] Dynamic subtest vcs0: SUCCESS (0.041s)
[274.088951] Starting dynamic subtest: vcs1
[274.120813] Dynamic subtest vcs1: SUCCESS (0.040s)
[274.129737] Starting dynamic subtest: vecs0
[274.163875] Dynamic subtest vecs0: SUCCESS (0.041s)
[274.177475] Starting dynamic subtest: ccs0
[274.211541] Dynamic subtest ccs0: SUCCESS (0.046s)
[274.213903] Subtest engines-basic: SUCCESS (0.311s)
[274.283034] [044/131] (811s left) gem_ctx_bad_destroy (invalid-pad)
[274.340686] Starting subtest: invalid-pad
[274.343043] Subtest invalid-pad: SUCCESS (0.000s)
[274.414052] [045/131] (811s left) kms_psr (fbc-pr-primary-render)
[274.516940] Starting subtest: fbc-pr-primary-render
[274.521206] Subtest fbc-pr-primary-render: SKIP (0.000s)
[274.585916] [046/131] (811s left) gem_mmap_wc (invalid-flags)
[274.648104] Subtest invalid-flags: SKIP (0.000s)
[274.706933] [047/131] (811s left) gem_exec_whisper (basic-contexts)
[274.772114] Starting subtest: basic-contexts
[281.465154] Subtest basic-contexts: SUCCESS (6.689s)
[281.645013] [048/131] (804s left) kms_feature_discovery (display-3x)
[281.754293] Starting subtest: display-3x
[281.759300] Subtest display-3x: SKIP (0.000s)
[281.818933] [049/131] (804s left) kms_prop_blob (blob-prop-lifetime)
[281.880514] Starting subtest: blob-prop-lifetime
[281.882855] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[281.969124] [050/131] (804s left) kms_joiner (basic-force-ultra-joiner)
[282.076468] Starting subtest: basic-force-ultra-joiner
[282.080700] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[282.136301] [051/131] (803s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[282.240546] Starting subtest: psr-rgb565-draw-mmap-wc
[286.783417] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (4.545s)
[286.893780] [052/131] (799s left) gem_exec_reloc (basic-write-gtt-active)
[286.949186] Subtest basic-write-gtt-active: SKIP (0.000s)
[287.009567] [053/131] (799s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[289.057362] Starting subtest: modeset-lpsp-stress-no-wait
[298.599479] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.541s)
[298.676124] [054/131] (787s left) kms_cursor_edge_walk (256x256-right-edge)
[298.770959] Starting subtest: 256x256-right-edge
[298.773395] Starting dynamic subtest: pipe-A-eDP-1
[302.215456] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[302.224549] Starting dynamic subtest: pipe-D-eDP-1
[305.318800] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.102s)
[305.321068] Subtest 256x256-right-edge: SUCCESS (6.545s)
[306.122039] [055/131] (780s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[306.514332] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[307.320921] [056/131] (778s left) gem_lmem_swapping (massive)
[307.364304] Subtest massive: SKIP (0.000s)
[307.408811] [057/131] (778s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[307.511836] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[307.514174] Starting dynamic subtest: pipe-A-eDP-1
[307.537129] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[307.546708] Starting dynamic subtest: pipe-B-eDP-1
[307.568364] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[307.576488] Starting dynamic subtest: pipe-C-eDP-1
[307.598288] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[307.607046] Starting dynamic subtest: pipe-D-eDP-1
[307.628902] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[307.633080] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[309.705492] [058/131] (776s left) syncobj_wait (invalid-reset-illegal-handle)
[309.774265] Starting subtest: invalid-reset-illegal-handle
[309.776493] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[309.882874] [059/131] (776s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[309.985279] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[309.987462] Starting dynamic subtest: pipe-A
[310.490839] Dynamic subtest pipe-A: SUCCESS (0.505s)
[310.500492] Starting dynamic subtest: pipe-B
[312.062606] Dynamic subtest pipe-B: SUCCESS (1.571s)
[312.071765] Starting dynamic subtest: pipe-C
[313.585427] Dynamic subtest pipe-C: SUCCESS (1.522s)
[313.595232] Starting dynamic subtest: pipe-D
[315.114747] Dynamic subtest pipe-D: SUCCESS (1.529s)
[315.117182] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (5.130s)
[316.318601] [060/131] (770s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[316.420738] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[316.423481] Starting dynamic subtest: pipe-A-eDP-1
[316.481754] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[316.491570] Starting dynamic subtest: pipe-B-eDP-1
[316.550943] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[316.560419] Starting dynamic subtest: pipe-C-eDP-1
[316.618164] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[316.627520] Starting dynamic subtest: pipe-D-eDP-1
[316.685972] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[316.690066] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[318.569979] [061/131] (767s left) gem_mmap_gtt (hang)
[318.622878] Subtest hang: SKIP (0.000s)
[318.673955] [062/131] (767s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[318.786229] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[321.494652] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.711s)
[321.626393] [063/131] (764s left) sriov_basic (enable-vfs-autoprobe-off)
[321.687766] Starting subtest: enable-vfs-autoprobe-off
[321.689503] Starting dynamic subtest: numvfs-1
[321.749999] Dynamic subtest numvfs-1: FAIL (0.004s)
[321.759707] Starting dynamic subtest: numvfs-2
[321.821069] Dynamic subtest numvfs-2: FAIL (0.003s)
[321.830322] Starting dynamic subtest: numvfs-3
[321.890831] Dynamic subtest numvfs-3: FAIL (0.003s)
[321.899648] Starting dynamic subtest: numvfs-4
[321.958860] Dynamic subtest numvfs-4: FAIL (0.003s)
[321.967769] Starting dynamic subtest: numvfs-5
[322.028590] Dynamic subtest numvfs-5: FAIL (0.004s)
[322.037773] Starting dynamic subtest: numvfs-6
[322.097463] Dynamic subtest numvfs-6: FAIL (0.003s)
[322.106219] Starting dynamic subtest: numvfs-7
[322.168972] Dynamic subtest numvfs-7: FAIL (0.004s)
[322.185155] Starting dynamic subtest: numvfs-random
[322.246033] Dynamic subtest numvfs-random: FAIL (0.003s)
[322.255137] Starting dynamic subtest: numvfs-all
[322.315019] Dynamic subtest numvfs-all: FAIL (0.427s)
[322.316909] Subtest enable-vfs-autoprobe-off: FAIL (0.460s)
[322.347572] [064/131] (764s left) kms_dp_linktrain_fallback (dp-fallback)
[322.442976] Starting subtest: dp-fallback
[322.448658] Subtest dp-fallback: SKIP (0.000s)
[322.507073] [065/131] (764s left) gem_bad_reloc (negative-reloc-bltcopy)
[322.574840] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[322.648488] [066/131] (763s left) kms_async_flips (async-flip-with-page-flip-events)
[322.750499] Starting subtest: async-flip-with-page-flip-events
[323.119506] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs
[323.877526] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.755s)
[323.885891] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[326.132033] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.256s)
[326.140683] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc
[326.396693] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.262s)
[326.404404] Starting dynamic subtest: pipe-A-eDP-1-4
[328.687130] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.291s)
[328.695572] Starting dynamic subtest: pipe-A-eDP-1-x
[330.987962] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.299s)
[330.999101] Starting dynamic subtest: pipe-A-eDP-1-linear
[333.299279] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.310s)
[333.661428] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs
[334.397646] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.740s)
[334.407367] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[336.651424] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.256s)
[336.659883] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc
[336.940611] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.285s)
[336.950359] Starting dynamic subtest: pipe-B-eDP-1-4
[339.229169] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.291s)
[339.238263] Starting dynamic subtest: pipe-B-eDP-1-x
[341.529506] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.299s)
[341.538252] Starting dynamic subtest: pipe-B-eDP-1-linear
[343.829816] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.299s)
[344.191824] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs
[344.920079] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.732s)
[344.928465] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[347.175451] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.257s)
[347.184364] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc
[347.456146] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.278s)
[347.464904] Starting dynamic subtest: pipe-C-eDP-1-4
[349.730930] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.274s)
[349.739927] Starting dynamic subtest: pipe-C-eDP-1-x
[352.018989] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.287s)
[352.028289] Starting dynamic subtest: pipe-C-eDP-1-linear
[354.309876] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.288s)
[354.673494] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs
[355.446279] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.779s)
[355.456038] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[357.698708] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.256s)
[357.707640] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc
[357.963715] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.262s)
[357.973205] Starting dynamic subtest: pipe-D-eDP-1-4
[360.254386] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.292s)
[360.263493] Starting dynamic subtest: pipe-D-eDP-1-x
[362.543868] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.288s)
[362.554745] Starting dynamic subtest: pipe-D-eDP-1-linear
[364.833478] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.286s)
[364.836092] Subtest async-flip-with-page-flip-events: SUCCESS (42.082s)
[366.018322] [067/131] (720s left) gen9_exec_parse (shadow-peek)
[366.076938] Subtest shadow-peek: SKIP (0.000s)
[366.134247] [068/131] (720s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[366.249945] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[370.851522] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.605s)
[370.961258] [069/131] (715s left) kms_plane_alpha_blend (constant-alpha-max)
[371.061269] Starting subtest: constant-alpha-max
[371.493028] Starting dynamic subtest: pipe-A-eDP-1
[372.504345] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.009s)
[372.513362] Starting dynamic subtest: pipe-D-eDP-1
[374.081788] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.577s)
[374.083786] Subtest constant-alpha-max: SUCCESS (3.019s)
[374.934670] [070/131] (711s left) syncobj_timeline (invalid-signal-bad-pad)
[374.996024] Starting subtest: invalid-signal-bad-pad
[374.998273] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[375.106622] [071/131] (711s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[375.216337] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[376.437622] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.222s)
[376.600656] [072/131] (710s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[376.708883] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[376.712327] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[376.803180] [073/131] (710s left) i915_selftest (perf)
[380.321838] Starting subtest: perf
[380.324887] Starting dynamic subtest: engine_cs
[384.744563] Dynamic subtest engine_cs: SUCCESS (4.423s)
[384.753794] Starting dynamic subtest: request
[392.026060] Dynamic subtest request: SUCCESS (7.280s)
[392.035047] Starting dynamic subtest: migrate
[396.476959] Dynamic subtest migrate: SUCCESS (4.448s)
[396.485775] Starting dynamic subtest: region
[402.824332] Dynamic subtest region: SUCCESS (6.345s)
[402.826959] Subtest perf: SUCCESS (22.502s)
[402.849156] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[402.849935] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[402.853204] [074/131] (684s left) gem_ctx_persistence (legacy-engines-mixed)
[404.224673] Starting subtest: legacy-engines-mixed
[404.226676] Starting dynamic subtest: render
[404.347932] Dynamic subtest render: SUCCESS (0.122s)
[404.356659] Starting dynamic subtest: bsd1
[404.407975] Dynamic subtest bsd1: SUCCESS (0.059s)
[404.417634] Starting dynamic subtest: bsd2
[404.487903] Dynamic subtest bsd2: SUCCESS (0.078s)
[404.498037] Starting dynamic subtest: blt
[404.564861] Dynamic subtest blt: SUCCESS (0.075s)
[404.574852] Starting dynamic subtest: vebox
[404.644988] Dynamic subtest vebox: SUCCESS (0.077s)
[404.647463] Subtest legacy-engines-mixed: SUCCESS (0.423s)
[404.692476] [FACT gem_ctx_persistence (legacy-engines-mixed)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[404.694243] [FACT gem_ctx_persistence (legacy-engines-mixed)] new: kernel.kmod_is_loaded.i915: true
[404.697610] [075/131] (682s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[404.793727] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[404.796480] Starting dynamic subtest: pipe-A-eDP-1
[404.819524] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[404.829867] Starting dynamic subtest: pipe-B-eDP-1
[404.851594] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[404.858974] Starting dynamic subtest: pipe-C-eDP-1
[404.881774] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[404.890540] Starting dynamic subtest: pipe-D-eDP-1
[404.913950] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[404.918367] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[406.931135] [076/131] (680s left) kms_cursor_crc (cursor-offscreen-256x256)
[407.146820] Starting subtest: cursor-offscreen-256x256
[407.151768] Starting dynamic subtest: pipe-A-eDP-1
[409.102777] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.950s)
[409.125739] Starting dynamic subtest: pipe-D-eDP-1
[411.752264] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.631s)
[411.754624] Subtest cursor-offscreen-256x256: SUCCESS (4.604s)
[412.588166] [077/131] (674s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[412.693481] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[417.417115] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.726s)
[417.537914] [078/131] (669s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[417.657087] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[417.661283] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[417.751075] [079/131] (669s left) gem_exec_reloc (basic-wc)
[417.813884] Subtest basic-wc: SKIP (0.000s)
[417.892636] [080/131] (669s left) gem_busy (semaphore)
[418.082651] Subtest semaphore: SKIP (0.000s)
[418.310808] [081/131] (668s left) syncobj_timeline (etime-multi-wait-all-submitted)
[418.367267] Starting subtest: etime-multi-wait-all-submitted
[418.470460] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[418.540415] [082/131] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[418.633556] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[418.637913] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[418.729332] [083/131] (668s left) gem_linear_blits (basic)
[419.149045] Starting subtest: basic
[419.159077] Subtest basic: SUCCESS (0.010s)
[419.295060] [084/131] (667s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[419.433746] Starting subtest: fbc-tiling-linear
[422.161978] Subtest fbc-tiling-linear: SUCCESS (2.732s)
[422.293594] [085/131] (665s left) gem_spin_batch (spin-all-new)
[422.349581] Starting subtest: spin-all-new
[422.362371] Subtest spin-all-new: SUCCESS (0.012s)
[423.946527] [086/131] (663s left) dumb_buffer (create-clear)
[423.998219] Starting subtest: create-clear
[465.921033] Subtest create-clear: SUCCESS (41.916s)
[466.037438] [087/131] (621s left) kms_addfb_basic (too-high)
[466.141430] Starting subtest: too-high
[466.143778] Subtest too-high: SUCCESS (0.000s)
[466.264438] [088/131] (621s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[466.366352] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[466.370347] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[466.482403] [089/131] (620s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[466.590420] Starting subtest: blocking-absolute-wf_vblank-interruptible
[466.592680] Starting dynamic subtest: A-eDP1
[475.358417] Dynamic subtest A-eDP1: SUCCESS (8.766s)
[475.367057] Starting dynamic subtest: B-eDP1
[484.086420] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[484.096206] Starting dynamic subtest: C-eDP1
[492.804147] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[492.813764] Starting dynamic subtest: D-eDP1
[501.530497] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[501.533118] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.940s)
[502.731929] [090/131] (584s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[502.837071] Starting subtest: fbc-psr2-sprite-mmap-gtt
[502.839231] Starting dynamic subtest: eDP-1
[502.843148] Dynamic subtest eDP-1: SKIP (0.000s)
[502.847076] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[502.904438] [091/131] (584s left) syncobj_wait (single-wait-for-submit-signaled)
[502.978449] Starting subtest: single-wait-for-submit-signaled
[502.980901] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[503.046426] [092/131] (584s left) syncobj_wait (multi-wait-all-submitted-signaled)
[503.103451] Starting subtest: multi-wait-all-submitted-signaled
[503.206670] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[503.276495] [093/131] (584s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[503.373355] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[503.375726] Starting dynamic subtest: pipe-A-default-mode
[503.662371] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[503.666962] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.287s)
[504.461011] [094/131] (583s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[509.517428] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[509.522139] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[510.351059] [095/131] (577s left) perf_pmu (event-wait)
[510.392196] Starting subtest: event-wait
[510.394627] Starting dynamic subtest: rcs0
[510.399076] Dynamic subtest rcs0: SKIP (0.000s)
[510.403541] Subtest event-wait: SKIP (0.001s)
[510.491446] [096/131] (577s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[510.565815] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[510.622283] [097/131] (577s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[510.735790] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[515.136941] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.405s)
[515.251692] [098/131] (572s left) prime_vgem (basic-gtt)
[515.333122] Starting subtest: basic-gtt
[515.337549] Subtest basic-gtt: SKIP (0.000s)
[515.415262] [099/131] (572s left) gem_mmap_offset (ptrace)
[515.476442] Starting subtest: ptrace
[515.478688] Starting dynamic subtest: smem0-wb
[515.492848] Dynamic subtest smem0-wb: SUCCESS (0.015s)
[515.501694] Starting dynamic subtest: smem0-wc
[515.514752] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[515.522821] Starting dynamic subtest: smem0-uc
[515.537071] Dynamic subtest smem0-uc: SUCCESS (0.022s)
[515.539399] Subtest ptrace: SUCCESS (0.063s)
[515.670068] [100/131] (572s left) gem_exec_balancer (parallel-contexts)
[515.919597] Starting subtest: parallel-contexts
[518.119248] Subtest parallel-contexts: SUCCESS (2.200s)
[518.223541] [101/131] (569s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[518.331222] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[518.333424] Starting dynamic subtest: pipe-A-default-mode
[518.621102] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[518.625723] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s)
[519.403586] [102/131] (568s left) sw_sync (sync_merge)
[519.437965] Starting subtest: sync_merge
[519.440462] Subtest sync_merge: SUCCESS (0.000s)
[519.491183] [103/131] (568s left) gem_exec_fence (basic-await)
[519.664870] Starting subtest: basic-await
[519.667453] Starting dynamic subtest: rcs0
[519.748048] Dynamic subtest rcs0: SUCCESS (0.082s)
[519.762190] Starting dynamic subtest: bcs0
[519.830814] Dynamic subtest bcs0: SUCCESS (0.082s)
[519.843545] Starting dynamic subtest: vcs0
[519.913152] Dynamic subtest vcs0: SUCCESS (0.082s)
[519.924810] Starting dynamic subtest: vcs1
[519.993264] Dynamic subtest vcs1: SUCCESS (0.078s)
[520.004386] Starting dynamic subtest: vecs0
[520.071582] Dynamic subtest vecs0: SUCCESS (0.077s)
[520.083859] Starting dynamic subtest: ccs0
[520.150059] Dynamic subtest ccs0: SUCCESS (0.076s)
[520.153034] Subtest basic-await: SUCCESS (0.485s)
[521.996973] [104/131] (566s left) gem_ctx_persistence (heartbeat-close)
[522.059084] Starting subtest: heartbeat-close
[522.063584] Subtest heartbeat-close: SKIP (0.000s)
[522.159665] [105/131] (565s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[522.264804] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[522.267164] Starting dynamic subtest: pipe-A
[522.285455] Dynamic subtest pipe-A: SKIP (0.015s)
[522.295375] Starting dynamic subtest: pipe-B
[522.315108] Dynamic subtest pipe-B: SKIP (0.028s)
[522.324771] Starting dynamic subtest: pipe-C
[522.341518] Dynamic subtest pipe-C: SKIP (0.027s)
[522.351046] Starting dynamic subtest: pipe-D
[522.368957] Dynamic subtest pipe-D: SKIP (0.027s)
[522.372778] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.098s)
[522.468337] [106/131] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[522.573559] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[522.577751] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[522.675608] [107/131] (565s left) api_intel_allocator (gem-pool)
[522.736077] Starting subtest: gem-pool
[522.743187] Subtest gem-pool: SUCCESS (0.009s)
[522.874801] [108/131] (565s left) perf_pmu (multi-client)
[522.915991] Starting subtest: multi-client
[522.917542] Starting dynamic subtest: rcs0
[523.984095] Dynamic subtest rcs0: SUCCESS (1.067s)
[523.993780] Starting dynamic subtest: bcs0
[525.030845] Dynamic subtest bcs0: SUCCESS (1.044s)
[525.041691] Starting dynamic subtest: vcs0
[526.085053] Dynamic subtest vcs0: SUCCESS (1.052s)
[526.096735] Starting dynamic subtest: vcs1
[527.968395] Dynamic subtest vcs1: SUCCESS (1.881s)
[527.980084] Starting dynamic subtest: vecs0
[529.954054] Dynamic subtest vecs0: SUCCESS (1.984s)
[529.966296] Starting dynamic subtest: ccs0
[531.937694] Dynamic subtest ccs0: SUCCESS (1.982s)
[531.940264] Subtest multi-client: SUCCESS (9.021s)
[532.062116] [109/131] (556s left) gem_mmap_gtt (fault-concurrent-x)
[532.125110] Subtest fault-concurrent-X: SKIP (0.000s)
[532.172497] [110/131] (556s left) gem_mmap_gtt (basic-write-read)
[532.231918] Subtest basic-write-read: SKIP (0.000s)
[532.289536] [111/131] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[532.397435] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[537.594169] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.199s)
[537.740493] [112/131] (550s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[537.848185] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[537.852193] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[537.957505] [113/131] (550s left) prime_mmap (test_invalid_sync_flags)
[538.024617] Starting subtest: test_invalid_sync_flags
[538.027102] Starting dynamic subtest: test_invalid_sync_flags-smem
[538.029107] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[538.031105] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[538.116903] [114/131] (550s left) kms_chamelium_color (ctm-limited-range)
[538.222331] Subtest ctm-limited-range: SKIP (0.000s)
[538.263082] [115/131] (550s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[538.390141] Starting subtest: flip-vs-cursor-varying-size
[546.173770] Subtest flip-vs-cursor-varying-size: SUCCESS (7.784s)
[546.981660] [116/131] (541s left) gem_exec_params (no-blt)
[547.039358] Starting subtest: no-blt
[547.044549] Subtest no-blt: SUCCESS (0.002s)
[547.157627] [117/131] (541s left) gem_userptr_blits (process-exit-busy)
[547.237916] Starting subtest: process-exit-busy
[547.252487] Subtest process-exit-busy: SUCCESS (0.015s)
[547.392157] [118/131] (541s left) kms_flip (dpms-vs-vblank-race)
[547.491098] Starting subtest: dpms-vs-vblank-race
[547.493415] Starting dynamic subtest: A-eDP1
[552.442089] Dynamic subtest A-eDP1: SUCCESS (4.948s)
[552.459510] Starting dynamic subtest: B-eDP1
[557.049726] Dynamic subtest B-eDP1: SUCCESS (4.607s)
[557.059801] Starting dynamic subtest: C-eDP1
[561.642492] Dynamic subtest C-eDP1: SUCCESS (4.589s)
[561.651126] Starting dynamic subtest: D-eDP1
[566.235105] Dynamic subtest D-eDP1: SUCCESS (4.592s)
[566.237469] Subtest dpms-vs-vblank-race: SUCCESS (18.745s)
[567.107352] [119/131] (521s left) kms_big_fb (4-tiled-addfb-size-overflow)
[567.210415] Starting subtest: 4-tiled-addfb-size-overflow
[567.212366] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[567.298421] [120/131] (521s left) gem_create (create-ext-placement-each)
[567.466947] Starting subtest: create-ext-placement-each
[567.469736] Subtest create-ext-placement-each: SUCCESS (0.000s)
[567.568686] [121/131] (521s left) i915_module_load (resize-bar)
[567.606526] Starting subtest: resize-bar
[567.613528] Subtest resize-bar: SKIP (0.006s)
[567.651734] [122/131] (521s left) kms_flip (2x-absolute-wf_vblank)
[567.741993] Starting subtest: 2x-absolute-wf_vblank
[567.753199] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[567.824993] [123/131] (520s left) kms_vblank (ts-continuation-modeset-rpm)
[567.919284] Starting subtest: ts-continuation-modeset-rpm
[567.921539] Starting dynamic subtest: pipe-A-eDP-1
[570.410708] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.487s)
[570.424929] Starting dynamic subtest: pipe-D-eDP-1
[572.641645] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.227s)
[572.643806] Subtest ts-continuation-modeset-rpm: SUCCESS (4.718s)
[573.416426] [124/131] (515s left) gem_exec_params (larger-than-life-batch)
[573.484498] Starting subtest: larger-than-life-batch
[576.966998] Subtest larger-than-life-batch: SUCCESS (3.482s)
[577.944842] [125/131] (510s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[578.037833] Starting subtest: multi-wait-available-unsubmitted-submitted
[578.040391] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[578.140960] [126/131] (510s left) kms_fbcon_fbt (fbc-suspend)
[578.203547] Starting subtest: fbc-suspend
[624.946342] Subtest fbc-suspend: SUCCESS (17.621s)
[625.025061] [127/131] (492s left) sysfs_preempt_timeout (idempotent)
[625.097639] Starting subtest: idempotent
[625.099988] Starting dynamic subtest: vecs0
[625.102321] Dynamic subtest vecs0: SUCCESS (0.000s)
[625.113311] Starting dynamic subtest: ccs0
[625.115240] Dynamic subtest ccs0: SUCCESS (0.000s)
[625.124411] Starting dynamic subtest: vcs0
[625.126322] Dynamic subtest vcs0: SUCCESS (0.000s)
[625.135450] Starting dynamic subtest: bcs0
[625.137412] Dynamic subtest bcs0: SUCCESS (0.000s)
[625.146788] Starting dynamic subtest: rcs0
[625.148707] Dynamic subtest rcs0: SUCCESS (0.000s)
[625.158130] Starting dynamic subtest: vcs1
[625.160290] Dynamic subtest vcs1: SUCCESS (0.000s)
[625.162472] Subtest idempotent: SUCCESS (0.006s)
[625.214127] [128/131] (492s left) kms_color (invalid-degamma-lut-sizes)
[625.328951] Starting subtest: invalid-degamma-lut-sizes
[625.331191] Starting dynamic subtest: pipe-A
[625.619340] Dynamic subtest pipe-A: SUCCESS (0.283s)
[625.629750] Starting dynamic subtest: pipe-B
[625.632041] Dynamic subtest pipe-B: SUCCESS (0.001s)
[625.641603] Starting dynamic subtest: pipe-C
[625.644378] Dynamic subtest pipe-C: SUCCESS (0.001s)
[625.653859] Starting dynamic subtest: pipe-D
[625.656000] Dynamic subtest pipe-D: SUCCESS (0.001s)
[625.658135] Subtest invalid-degamma-lut-sizes: SUCCESS (0.287s)
[626.472896] [129/131] (491s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[626.578339] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[631.868341] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.240s)
[632.023008] [130/131] (486s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[632.082965] Starting subtest: single-wait-all-for-submit-signaled
[632.085316] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[632.165760] [131/131] (486s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[632.282817] Starting subtest: yf-tiled-32bpp-rotate-270
[632.287308] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[632.377816] Closing watchdogs
results: parsing output: 0/ for test: sw_sync
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: device_reset
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: prime_self_import
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: sw_sync
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_fence_thrash
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: i915_pm_rps
results: parsing output: 20/ for test: gem_readwrite
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_vrr
results: parsing output: 27/ for test: gem_wait
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_exec_flush
results: parsing output: 36/ for test: drm_fdinfo
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_atomic_transition
results: parsing output: 40/ for test: kms_lease
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_ringfill
results: parsing output: 43/ for test: gem_ctx_bad_destroy
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: kms_feature_discovery
results: parsing output: 48/ for test: kms_prop_blob
results: parsing output: 49/ for test: kms_joiner
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: kms_chamelium_frames
results: parsing output: 55/ for test: gem_lmem_swapping
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: sriov_basic
results: parsing output: 63/ for test: kms_dp_linktrain_fallback
results: parsing output: 64/ for test: gem_bad_reloc
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_alpha_blend
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_selftest
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_linear_blits
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_spin_batch
results: parsing output: 85/ for test: dumb_buffer
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_pipe_b_c_ivb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: prime_vgem
results: parsing output: 98/ for test: gem_mmap_offset
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: kms_flip_scaled_crc
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: kms_chamelium_color
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_create
results: parsing output: 120/ for test: i915_module_load
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_vblank
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_fbcon_fbt
results: parsing output: 126/ for test: sysfs_preempt_timeout
results: parsing output: 127/ for test: kms_color
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_big_fb
Done.