[117.182959] Initializing watchdogs
[117.183011]   /dev/watchdog0
[117.197092] [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]
[117.201283] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[117.203519] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[117.206831] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[117.326109] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[117.328513] Starting dynamic subtest: pipe-A
[117.410873] Dynamic subtest pipe-A: SUCCESS (0.087s)
[117.420564] Starting dynamic subtest: pipe-B
[118.583309] Dynamic subtest pipe-B: SUCCESS (1.172s)
[118.592646] Starting dynamic subtest: pipe-C
[119.695734] Dynamic subtest pipe-C: SUCCESS (1.111s)
[119.704766] Starting dynamic subtest: pipe-D
[120.816729] Dynamic subtest pipe-D: SUCCESS (1.121s)
[120.819209] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.494s)
[121.999488] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[122.081236] Starting subtest: forbidden-operations
[122.085671] Subtest forbidden-operations: SKIP (0.000s)
[122.248421] [003/134] (955s left) gem_mmap_gtt (big-bo)
[122.310088] Subtest big-bo: SKIP (0.000s)
[122.372028] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[122.471638] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[129.799743] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.333s)
[129.978345] [005/134] (947s left) kms_fence_pin_leak
[130.158259] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[130.281936] Starting subtest: x-tiled-16bpp-rotate-180
[131.527063] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.245s)
[131.701972] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[131.771898] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[131.834374] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[131.926447] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[131.937467] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[132.075515] [009/134] (945s left) perf_pmu (busy-check-all)
[132.111405] Starting subtest: busy-check-all
[132.113336] Starting dynamic subtest: rcs0
[132.664669] Dynamic subtest rcs0: SUCCESS (0.552s)
[132.675546] Starting dynamic subtest: bcs0
[133.213499] Dynamic subtest bcs0: SUCCESS (0.548s)
[133.223905] Starting dynamic subtest: vcs0
[134.934159] Dynamic subtest vcs0: SUCCESS (1.718s)
[134.944178] Starting dynamic subtest: vcs1
[136.916895] Dynamic subtest vcs1: SUCCESS (1.981s)
[136.927458] Starting dynamic subtest: vecs0
[138.899765] Dynamic subtest vecs0: SUCCESS (1.982s)
[138.910807] Starting dynamic subtest: ccs0
[139.453232] Dynamic subtest ccs0: SUCCESS (0.554s)
[139.455857] Subtest busy-check-all: SUCCESS (7.342s)
[139.585529] [010/134] (938s left) gem_mmap_wc (coherency)
[139.648926] Subtest coherency: SKIP (0.000s)
[139.720765] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[139.814628] Starting subtest: yf-tiled-addfb
[139.819249] Subtest yf-tiled-addfb: SKIP (0.000s)
[139.943294] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[140.046328] Starting subtest: extended-modeset-hang-oldfb-with-reset
[140.048618] Starting dynamic subtest: pipe-A
[151.994085] Dynamic subtest pipe-A: SUCCESS (11.945s)
[152.004054] Starting dynamic subtest: pipe-D
[164.266848] Dynamic subtest pipe-D: SUCCESS (12.272s)
[164.269161] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.222s)
[165.087103] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[165.182363] Starting subtest: constant-alpha-min
[165.477400] Starting dynamic subtest: pipe-A-eDP-1
[166.184162] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s)
[166.195025] Starting dynamic subtest: pipe-D-eDP-1
[167.626910] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.442s)
[167.629316] Subtest constant-alpha-min: SUCCESS (2.446s)
[168.458596] [014/134] (909s left) sysfs_timeslice_duration (duration)
[168.531721] Starting subtest: duration
[168.533620] Starting dynamic subtest: vecs0
[181.813216] Dynamic subtest vecs0: SUCCESS (13.281s)
[181.822556] Starting dynamic subtest: ccs0
[194.990068] Dynamic subtest ccs0: SUCCESS (13.176s)
[195.000556] Starting dynamic subtest: vcs0
[209.843032] Dynamic subtest vcs0: SUCCESS (14.849s)
[209.854111] Starting dynamic subtest: bcs0
[223.023484] Dynamic subtest bcs0: SUCCESS (13.180s)
[223.034739] Starting dynamic subtest: rcs0
[236.183093] Dynamic subtest rcs0: SUCCESS (13.158s)
[236.194754] Starting dynamic subtest: vcs1
[249.841283] Dynamic subtest vcs1: SUCCESS (13.656s)
[249.843984] Subtest duration: SUCCESS (81.309s)
[249.937975] [015/134] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[250.113407] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[253.720900] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.611s)
[254.949250] [016/134] (823s left) kms_cursor_crc (cursor-onscreen-64x64)
[255.129395] Starting subtest: cursor-onscreen-64x64
[255.134389] Starting dynamic subtest: pipe-A-eDP-1
[257.242507] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[257.270755] Starting dynamic subtest: pipe-D-eDP-1
[259.995397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.730s)
[259.997763] Subtest cursor-onscreen-64x64: SUCCESS (4.864s)
[260.804469] [017/134] (817s left) kms_color (ctm-red-to-blue)
[260.893706] Starting subtest: ctm-red-to-blue
[260.895953] Starting dynamic subtest: pipe-A-eDP-1
[261.604830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[261.613265] Starting dynamic subtest: pipe-B-eDP-1
[262.985459] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[262.994666] Starting dynamic subtest: pipe-C-eDP-1
[264.379455] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[264.395757] Starting dynamic subtest: pipe-D-eDP-1
[265.689445] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[265.691449] Subtest ctm-red-to-blue: SUCCESS (4.795s)
[266.522261] [018/134] (811s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[266.589833] Subtest writes-after-reads-uncached: SKIP (0.000s)
[266.645147] [019/134] (811s left) dumb_buffer (invalid-bpp)
[266.699195] Starting subtest: invalid-bpp
[266.701510] Subtest invalid-bpp: SUCCESS (0.000s)
[266.823065] [020/134] (811s left) gem_mmap_gtt (ptrace)
[266.886912] Subtest ptrace: SKIP (0.000s)
[266.949920] [021/134] (811s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[267.070302] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[267.074807] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[267.238335] [022/134] (811s left) gem_lmem_swapping (verify)
[267.283798] Subtest verify: SKIP (0.000s)
[267.321979] [023/134] (811s left) gem_spin_batch (resubmit-new)
[267.383352] Starting subtest: resubmit-new
[267.385713] Starting dynamic subtest: rcs0
[267.391256] Dynamic subtest rcs0: SUCCESS (0.007s)
[267.402309] Starting dynamic subtest: bcs0
[267.404591] Dynamic subtest bcs0: SUCCESS (0.003s)
[267.412547] Starting dynamic subtest: vcs0
[267.414898] Dynamic subtest vcs0: SUCCESS (0.004s)
[267.422337] Starting dynamic subtest: vcs1
[267.424244] Dynamic subtest vcs1: SUCCESS (0.005s)
[267.431610] Starting dynamic subtest: vecs0
[267.433390] Dynamic subtest vecs0: SUCCESS (0.004s)
[267.440492] Starting dynamic subtest: ccs0
[267.442121] Dynamic subtest ccs0: SUCCESS (0.004s)
[267.443676] Subtest resubmit-new: SUCCESS (0.030s)
[268.946052] [024/134] (809s left) kms_cursor_crc (cursor-random-512x512)
[269.232366] Starting subtest: cursor-random-512x512
[269.236838] Subtest cursor-random-512x512: SKIP (0.001s)
[269.413910] [025/134] (809s left) kms_properties (plane-properties-legacy)
[269.510727] Starting subtest: plane-properties-legacy
[269.512964] Starting dynamic subtest: pipe-A-eDP-1
[270.065679] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[270.075064] Starting dynamic subtest: pipe-B-eDP-1
[271.379306] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.312s)
[271.388563] Starting dynamic subtest: pipe-C-eDP-1
[272.593929] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[272.603110] Starting dynamic subtest: pipe-D-eDP-1
[273.833570] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[273.835698] Subtest plane-properties-legacy: SUCCESS (4.323s)
[274.664688] [026/134] (803s left) kms_vrr (flipline)
[274.772112] Starting subtest: flipline
[274.779112] Subtest flipline: SKIP (0.000s)
[274.868088] [027/134] (803s left) gem_exec_params (secure-non-master)
[274.922210] Starting subtest: secure-non-master
[274.926770] Subtest secure-non-master: SKIP (0.000s)
[275.062940] [028/134] (803s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[275.318927] Starting subtest: parallel-dmabuf-import-out-fence
[276.443923] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.125s)
[276.588237] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[277.688070] Starting subtest: dc5-dpms-negative
[277.692694] Subtest dc5-dpms-negative: SKIP (0.000s)
[277.782202] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[277.887085] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[277.891264] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[278.026112] [031/134] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[278.125244] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[284.878348] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.756s)
[285.003195] [032/134] (793s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[285.110077] Starting subtest: psr-argb161616f-draw-mmap-cpu
[285.114257] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[285.243488] [033/134] (793s left) gem_exec_whisper (basic-fds-all)
[285.303423] Starting subtest: basic-fds-all
[296.885408] Subtest basic-fds-all: SUCCESS (11.577s)
[297.087134] [034/134] (781s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[297.192430] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[297.196863] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[297.308976] [035/134] (781s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[297.423844] Starting subtest: psr-rgb565-draw-render
[304.437110] Subtest psr-rgb565-draw-render: SUCCESS (7.017s)
[304.594782] [036/134] (774s left) gem_render_copy_redux (flink)
[304.662078] Starting subtest: flink
[305.499514] Subtest flink: SUCCESS (0.839s)
[305.654796] [037/134] (773s left) gem_mmap_wc (bad-offset)
[305.701990] Subtest bad-offset: SKIP (0.000s)
[305.768757] [038/134] (773s left) gem_pxp (reject-modify-context-protection-off-2)
[305.901920] Starting subtest: reject-modify-context-protection-off-2
[305.903795] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[306.046486] [039/134] (773s left) kms_3d (basic)
[306.109666] Starting subtest: basic
[308.070606] Subtest basic: SUCCESS (1.962s)
[308.571835] [040/134] (770s left) gem_ctx_persistence (smoketest)
[308.646247] Starting subtest: smoketest
[348.852456] Subtest smoketest: SUCCESS (40.204s)
[348.950813] [041/134] (730s left) kms_psr (fbc-pr-suspend)
[349.058142] Starting subtest: fbc-pr-suspend
[349.062605] Subtest fbc-pr-suspend: SKIP (0.000s)
[349.159872] [042/134] (730s left) syncobj_timeline (multi-wait-for-submit-signaled)
[349.227299] Starting subtest: multi-wait-for-submit-signaled
[349.229484] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[349.356670] [043/134] (730s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[349.451303] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[349.453597] Starting dynamic subtest: pipe-A-default-mode
[352.112901] Dynamic subtest pipe-A-default-mode: SUCCESS (2.660s)
[352.114792] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.661s)
[352.963693] [044/134] (726s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[353.056071] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[353.058339] Starting dynamic subtest: pipe-A-default-mode
[355.738101] Dynamic subtest pipe-A-default-mode: SUCCESS (2.683s)
[355.740292] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.685s)
[356.558471] [045/134] (722s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[356.662030] Starting subtest: psr-rgb565-draw-mmap-cpu
[363.364128] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.704s)
[363.500462] [046/134] (715s left) vgem_basic (mmap)
[363.607541] Starting subtest: mmap
[363.612680] Subtest mmap: SUCCESS (0.007s)
[363.683223] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[363.686339] [047/134] (715s left) gem_userptr_blits (sync-unmap-after-close)
[363.758760] Starting subtest: sync-unmap-after-close
[363.769173] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[363.961665] [048/134] (715s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[364.338551] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[365.111432] [049/134] (714s left) kms_frontbuffer_tracking (basic)
[365.222268] Starting subtest: basic
[368.319896] Subtest basic: SUCCESS (3.101s)
[368.497336] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[368.598064] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[375.471363] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.874s)
[375.611660] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[375.721897] Starting subtest: fbc-rgb101010-draw-blt
[380.297929] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.580s)
[381.468157] [052/134] (698s left) kms_lease (lease-unleased-connector)
[381.572783] Starting subtest: lease-unleased-connector
[381.575056] Starting dynamic subtest: pipe-A-eDP-1
[381.580085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[381.589311] Starting dynamic subtest: pipe-B-eDP-1
[381.591415] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[381.605750] Starting dynamic subtest: pipe-C-eDP-1
[381.607838] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[381.616201] Starting dynamic subtest: pipe-D-eDP-1
[381.618311] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[381.620431] Subtest lease-unleased-connector: SUCCESS (0.031s)
[381.750129] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[381.815226] Subtest reads: SKIP (0.000s)
[381.913141] [054/134] (697s left) kms_dp_link_training (uhbr-sst)
[382.006964] Starting subtest: uhbr-sst
[382.015588] Subtest uhbr-sst: SKIP (0.000s)
[382.104627] [055/134] (697s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[382.173280] Starting subtest: etime-multi-wait-all-submitted-signaled
[382.281268] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[382.382756] [056/134] (697s left) kms_invalid_mode (overflow-vrefresh)
[382.487199] Starting subtest: overflow-vrefresh
[382.489578] Starting dynamic subtest: pipe-A-eDP-1
[382.771084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[382.780199] Starting dynamic subtest: pipe-B-eDP-1
[382.782347] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[382.790549] Starting dynamic subtest: pipe-C-eDP-1
[382.792854] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[382.800780] Starting dynamic subtest: pipe-D-eDP-1
[382.802743] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[382.804666] Subtest overflow-vrefresh: SUCCESS (0.289s)
[383.653856] [057/134] (696s left) kms_pm_rpm (i2c)
[385.173675] Starting subtest: i2c
[390.623864] Subtest i2c: SUCCESS (5.451s)
[390.739469] [058/134] (689s left) gem_exec_balancer (busy)
[390.794554] Starting subtest: busy
[392.941873] Subtest busy: SUCCESS (2.146s)
[393.291571] [059/134] (686s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[398.289141] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[398.293770] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[399.143377] [060/134] (680s left) gen9_exec_parse (batch-without-end)
[399.207316] Subtest batch-without-end: SKIP (0.000s)
[399.286167] [061/134] (680s left) gem_ctx_shared (exec-shared-gtt)
[399.345570] Starting subtest: exec-shared-gtt
[399.347771] Starting dynamic subtest: rcs0
[399.353218] Dynamic subtest rcs0: SUCCESS (0.007s)
[399.363475] Starting dynamic subtest: bcs0
[399.365323] Dynamic subtest bcs0: SUCCESS (0.007s)
[399.374192] Starting dynamic subtest: vcs0
[399.376310] Dynamic subtest vcs0: SUCCESS (0.007s)
[399.385147] Starting dynamic subtest: vcs1
[399.387411] Dynamic subtest vcs1: SUCCESS (0.008s)
[399.396275] Starting dynamic subtest: vecs0
[399.398118] Dynamic subtest vecs0: SUCCESS (0.007s)
[399.406205] Starting dynamic subtest: ccs0
[399.408350] Dynamic subtest ccs0: SUCCESS (0.005s)
[399.410371] Subtest exec-shared-gtt: SUCCESS (0.046s)
[399.595913] [062/134] (680s left) perf (invalid-oa-metric-set-id)
[399.753067] Starting subtest: invalid-oa-metric-set-id
[399.765969] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[399.803955] [063/134] (680s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[399.865703] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[399.867960] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[399.991419] [064/134] (680s left) gem_tiled_pread_pwrite
[400.100853] [065/134] (680s left) i915_pm_rps (thresholds-park)
[400.175998] Starting subtest: thresholds-park
[400.179566] Subtest thresholds-park: SKIP (0.001s)
[400.310923] [066/134] (679s left) gem_ctx_engines (invalid-engines)
[400.380359] Starting subtest: invalid-engines
[400.387917] Subtest invalid-engines: SUCCESS (0.008s)
[400.645546] [067/134] (679s left) vgem_basic (create)
[400.694384] Starting subtest: create
[400.696413] Subtest create: SUCCESS (0.000s)
[400.779986] [068/134] (679s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[400.883423] Starting subtest: fbc-psr2-sprite-mmap-cpu
[400.885748] Starting dynamic subtest: eDP-1
[400.890196] Dynamic subtest eDP-1: SKIP (0.000s)
[400.894616] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[400.980903] [069/134] (679s left) gem_mmap_gtt (big-copy-odd)
[401.041719] Subtest big-copy-odd: SKIP (0.000s)
[401.111164] [070/134] (679s left) gem_exec_reloc (basic-gtt-cpu-active)
[401.178405] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[401.278148] [071/134] (679s left) prime_busy (before-wait)
[401.325349] Starting subtest: before-wait
[401.330428] Starting dynamic subtest: rcs0
[401.360401] Dynamic subtest rcs0: SUCCESS (0.032s)
[401.371094] Starting dynamic subtest: bcs0
[401.405490] Dynamic subtest bcs0: SUCCESS (0.045s)
[401.415178] Starting dynamic subtest: vcs0
[401.447140] Dynamic subtest vcs0: SUCCESS (0.041s)
[401.456462] Starting dynamic subtest: vcs1
[401.487796] Dynamic subtest vcs1: SUCCESS (0.040s)
[401.497122] Starting dynamic subtest: vecs0
[401.529261] Dynamic subtest vecs0: SUCCESS (0.041s)
[401.538441] Starting dynamic subtest: ccs0
[401.570944] Dynamic subtest ccs0: SUCCESS (0.041s)
[401.679326] Subtest before-wait: SUCCESS (0.352s)
[401.777756] [072/134] (678s left) gem_exec_fence (keep-in-fence)
[401.946752] Starting subtest: keep-in-fence
[401.949116] Starting dynamic subtest: rcs0
[402.019900] Dynamic subtest rcs0: SUCCESS (0.072s)
[402.031775] Starting dynamic subtest: bcs0
[402.074576] Dynamic subtest bcs0: SUCCESS (0.053s)
[402.084898] Starting dynamic subtest: vcs0
[403.925412] Dynamic subtest vcs0: SUCCESS (1.847s)
[403.937883] Starting dynamic subtest: vcs1
[405.909395] Dynamic subtest vcs1: SUCCESS (1.981s)
[405.921742] Starting dynamic subtest: vecs0
[407.893056] Dynamic subtest vecs0: SUCCESS (1.982s)
[407.905044] Starting dynamic subtest: ccs0
[408.129873] Dynamic subtest ccs0: SUCCESS (0.235s)
[408.132786] Subtest keep-in-fence: SUCCESS (6.183s)
[410.079529] [073/134] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[410.194370] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[413.934661] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.743s)
[415.137685] [074/134] (665s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[415.242305] Starting subtest: 4-tiled-8bpp-rotate-270
[415.263891] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[415.438488] [075/134] (665s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[420.491453] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[420.493891] Starting dynamic subtest: pipe-A-eDP-1
[421.264286] Dynamic subtest pipe-A-eDP-1: SKIP (0.767s)
[421.273928] Starting dynamic subtest: pipe-B-eDP-1
[422.407547] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[422.412133] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.913s)
[423.710375] [076/134] (657s left) gem_ccs (block-multicopy-inplace)
[423.777789] Starting subtest: block-multicopy-inplace
[423.782504] Subtest block-multicopy-inplace: SKIP (0.000s)
[423.906354] [077/134] (656s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[424.009739] Starting subtest: x-tiled-addfb-size-offset-overflow
[424.012092] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[424.143827] [078/134] (656s left) kms_atomic (crtc-invalid-params)
[424.249019] Starting subtest: crtc-invalid-params
[424.251361] Starting dynamic subtest: pipe-A-eDP-1
[424.604752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[424.607103] Subtest crtc-invalid-params: SUCCESS (0.358s)
[425.437220] [079/134] (655s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[425.538069] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[425.539959] Starting dynamic subtest: pipe-A-eDP-1
[425.560218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[425.570698] Starting dynamic subtest: pipe-B-eDP-1
[425.590529] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[425.599350] Starting dynamic subtest: pipe-C-eDP-1
[425.619406] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[425.628217] Starting dynamic subtest: pipe-D-eDP-1
[425.648362] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[425.650662] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.091s)
[427.814353] [080/134] (653s left) gem_lmem_swapping (heavy-verify-multi)
[427.851932] Subtest heavy-verify-multi: SKIP (0.000s)
[427.905414] [081/134] (653s left) kms_chamelium_frames (hdmi-crc-fast)
[428.274356] Subtest hdmi-crc-fast: SKIP (0.000s)
[429.097613] [082/134] (651s left) kms_vblank (query-forked-busy-hang)
[429.196119] Starting subtest: query-forked-busy-hang
[429.198382] Starting dynamic subtest: pipe-A-eDP-1
[455.701048] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.502s)
[455.717585] Starting dynamic subtest: pipe-D-eDP-1
[470.689469] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.986s)
[470.691734] Subtest query-forked-busy-hang: SUCCESS (41.492s)
[471.508705] [083/134] (609s left) kms_big_fb (linear-16bpp-rotate-90)
[471.617172] Starting subtest: linear-16bpp-rotate-90
[471.637779] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[471.798620] [084/134] (609s left) gem_flink_race (flink_close)
[471.832076] Starting subtest: flink_close
[476.906953] Subtest flink_close: SUCCESS (5.079s)
[477.013942] [085/134] (604s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[477.114658] Starting subtest: fbcpsr-modesetfrombusy
[483.276220] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.166s)
[483.460466] [086/134] (597s left) gem_exec_schedule (thriceslice)
[483.536415] Starting subtest: thriceslice
[483.538192] Starting dynamic subtest: rcs0
[483.557436] Dynamic subtest rcs0: SUCCESS (0.030s)
[483.568973] Starting dynamic subtest: bcs0
[483.586778] Dynamic subtest bcs0: SUCCESS (0.029s)
[483.595662] Starting dynamic subtest: vcs0
[483.637600] Dynamic subtest vcs0: SUCCESS (0.049s)
[483.648157] Starting dynamic subtest: vcs1
[483.690580] Dynamic subtest vcs1: SUCCESS (0.050s)
[483.701805] Starting dynamic subtest: vecs0
[483.721695] Dynamic subtest vecs0: SUCCESS (0.028s)
[483.730118] Starting dynamic subtest: ccs0
[483.752520] Dynamic subtest ccs0: SUCCESS (0.029s)
[483.754522] Subtest thriceslice: SUCCESS (0.225s)
[484.081432] [087/134] (597s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[484.178091] Starting subtest: flip-vs-dpms-off-vs-modeset
[484.180248] Starting dynamic subtest: A-eDP1
[487.809392] Dynamic subtest A-eDP1: SUCCESS (3.632s)
[487.819558] Starting dynamic subtest: B-eDP1
[490.998235] Dynamic subtest B-eDP1: SUCCESS (3.187s)
[491.007952] Starting dynamic subtest: C-eDP1
[494.096691] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[494.107516] Starting dynamic subtest: D-eDP1
[497.210370] Dynamic subtest D-eDP1: SUCCESS (3.110s)
[497.212796] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.036s)
[498.026612] [088/134] (583s left) i915_pm_rps (min-max-config-idle)
[498.090115] Starting subtest: min-max-config-idle
[498.094567] Subtest min-max-config-idle: SKIP (0.001s)
[498.216528] [089/134] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[498.333600] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[504.793344] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.461s)
[504.957564] [090/134] (576s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[509.891060] Starting subtest: psr2-overlay-plane-move-continuous-sf
[509.893312] Starting dynamic subtest: pipe-A-eDP-1
[516.564307] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.672s)
[516.574449] Starting dynamic subtest: pipe-B-eDP-1
[523.203951] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.635s)
[523.206533] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.310s)
[524.013934] [091/134] (557s left) kms_concurrent (multi-plane-atomic-lowres)
[524.117097] Starting subtest: multi-plane-atomic-lowres
[524.119353] Starting dynamic subtest: pipe-A-eDP-1
[524.643964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.525s)
[524.646238] Subtest multi-plane-atomic-lowres: SUCCESS (0.526s)
[525.549286] [092/134] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[525.653458] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[525.657503] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[525.787940] [093/134] (555s left) api_intel_allocator (reopen)
[525.847466] Starting subtest: reopen
[525.852912] Subtest reopen: SUCCESS (0.004s)
[526.018415] [094/134] (555s left) kms_flip (dpms-vs-vblank-race)
[526.116099] Starting subtest: dpms-vs-vblank-race
[526.118266] Starting dynamic subtest: A-eDP1
[530.002483] Dynamic subtest A-eDP1: SUCCESS (3.884s)
[530.012823] Starting dynamic subtest: B-eDP1
[534.636741] Dynamic subtest B-eDP1: SUCCESS (4.633s)
[534.648751] Starting dynamic subtest: C-eDP1
[539.274073] Dynamic subtest C-eDP1: SUCCESS (4.636s)
[539.286633] Starting dynamic subtest: D-eDP1
[543.902133] Dynamic subtest D-eDP1: SUCCESS (4.628s)
[543.907862] Subtest dpms-vs-vblank-race: SUCCESS (17.789s)
[544.804957] [095/134] (536s left) syncobj_timeline (single-wait-all-available-signaled)
[544.858901] Starting subtest: single-wait-all-available-signaled
[544.861078] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[544.979256] [096/134] (536s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[545.074028] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[545.075850] Starting dynamic subtest: pipe-A-eDP-1
[546.426497] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.352s)
[546.705585] Starting dynamic subtest: pipe-B-eDP-1
[547.755522] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.058s)
[548.024068] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.951s)
[548.889240] [097/134] (532s left) gem_exec_params (rs-invalid)
[548.945565] Starting subtest: rs-invalid
[548.950328] Subtest rs-invalid: SUCCESS (0.003s)
[549.091489] [098/134] (532s left) kms_scaling_modes (scaling-mode-full-aspect)
[549.189749] Starting subtest: scaling-mode-full-aspect
[549.191982] Starting dynamic subtest: pipe-A-eDP-1
[549.281543] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[549.291602] Starting dynamic subtest: pipe-B-eDP-1
[550.403122] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.120s)
[550.414228] Starting dynamic subtest: pipe-C-eDP-1
[551.632052] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[551.643896] Starting dynamic subtest: pipe-D-eDP-1
[552.846770] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[552.849321] Subtest scaling-mode-full-aspect: SUCCESS (3.661s)
[554.037087] [099/134] (527s left) kms_plane (plane-panning-top-left)
[554.142887] Starting subtest: plane-panning-top-left
[554.144834] Starting dynamic subtest: pipe-A
[555.754469] Dynamic subtest pipe-A: SUCCESS (1.611s)
[555.764181] Starting dynamic subtest: pipe-B
[558.041287] Dynamic subtest pipe-B: SUCCESS (2.285s)
[558.043494] Subtest plane-panning-top-left: SUCCESS (3.899s)
[558.860493] [100/134] (522s left) kms_psr (psr2-sprite-mmap-cpu)
[558.966785] Starting subtest: psr2-sprite-mmap-cpu
[558.969205] Starting dynamic subtest: eDP-1
[560.638869] Dynamic subtest eDP-1: SUCCESS (1.672s)
[560.641256] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.673s)
[561.524199] [101/134] (520s left) gem_exec_params (rel-constants-invalid-ring)
[561.589593] Starting subtest: rel-constants-invalid-ring
[561.592011] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[561.732092] [102/134] (520s left) i915_query (query-garbage)
[561.785471] Starting subtest: query-garbage
[561.787823] Subtest query-garbage: SUCCESS (0.000s)
[561.923535] [103/134] (519s left) kms_psr (psr-cursor-mmap-cpu)
[562.032770] Starting subtest: psr-cursor-mmap-cpu
[562.035045] Starting dynamic subtest: eDP-1
[563.797411] Dynamic subtest eDP-1: SUCCESS (1.763s)
[563.799846] Subtest psr-cursor-mmap-cpu: SUCCESS (1.764s)
[564.687930] [104/134] (517s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[564.797553] Starting subtest: y-tiled-16bpp-rotate-90
[564.801648] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[564.924043] [105/134] (516s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[565.020721] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[565.025202] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[566.219820] [106/134] (515s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[566.337599] Starting subtest: flip-vs-cursor-legacy
[573.384338] Subtest flip-vs-cursor-legacy: SUCCESS (7.046s)
[574.231734] [107/134] (507s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[574.335672] Starting subtest: fbcpsr-argb161616f-draw-blt
[574.340207] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[574.467402] [108/134] (507s left) kms_flip (flip-vs-fences)
[574.566940] Starting subtest: flip-vs-fences
[574.571364] Subtest flip-vs-fences: SKIP (0.000s)
[574.703604] [109/134] (507s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[574.777071] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[574.865343] [110/134] (507s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[574.963390] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[574.965647] Starting dynamic subtest: pipe-A-eDP-1
[575.846239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s)
[575.856058] Starting dynamic subtest: pipe-B-eDP-1
[577.458572] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.609s)
[577.468513] Starting dynamic subtest: pipe-C-eDP-1
[578.938800] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.480s)
[578.948981] Starting dynamic subtest: pipe-D-eDP-1
[580.458070] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s)
[580.460441] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.485s)
[581.673422] [111/134] (500s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[581.770320] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[581.774716] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[581.896754] [112/134] (500s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[581.991568] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[581.993641] Starting dynamic subtest: pipe-A-eDP-1
[582.721261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[582.731939] Starting dynamic subtest: pipe-B-eDP-1
[584.476595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.754s)
[584.487486] Starting dynamic subtest: pipe-C-eDP-1
[586.295184] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.818s)
[586.305474] Starting dynamic subtest: pipe-D-eDP-1
[588.039471] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.742s)
[588.041688] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.041s)
[589.206929] [113/134] (493s left) i915_drm_fdinfo (memory-info-shared)
[589.251732] Starting subtest: memory-info-shared
[589.254089] Starting dynamic subtest: smem0
[589.309722] Dynamic subtest smem0: SUCCESS (0.058s)
[589.312653] Subtest memory-info-shared: SUCCESS (0.059s)
[589.410883] [114/134] (492s left) gem_exec_flush (basic-wb-set-default)
[589.474421] Starting subtest: basic-wb-set-default
[594.928807] Subtest basic-wb-set-default: SUCCESS (5.455s)
[595.144480] [115/134] (487s left) sysfs_timeslice_duration (timeout)
[595.202787] Starting subtest: timeout
[595.204786] Starting dynamic subtest: vecs0
[604.884988] Dynamic subtest vecs0: SUCCESS (9.685s)
[604.896346] Starting dynamic subtest: ccs0
[606.240790] Dynamic subtest ccs0: SUCCESS (1.352s)
[606.252520] Starting dynamic subtest: vcs0
[615.916701] Dynamic subtest vcs0: SUCCESS (9.672s)
[615.928071] Starting dynamic subtest: bcs0
[616.654910] Dynamic subtest bcs0: SUCCESS (0.736s)
[616.666359] Starting dynamic subtest: rcs0
[617.994815] Dynamic subtest rcs0: SUCCESS (1.339s)
[618.007213] Starting dynamic subtest: vcs1
[627.942101] Dynamic subtest vcs1: SUCCESS (9.941s)
[627.944860] Subtest timeout: SUCCESS (32.741s)
[628.041296] [116/134] (454s left) sriov_basic (enable-vfs-bind-unbind-each)
[628.100452] Starting subtest: enable-vfs-bind-unbind-each
[628.103034] Starting dynamic subtest: numvfs-1
[628.186569] Dynamic subtest numvfs-1: FAIL (0.029s)
[628.201159] Starting dynamic subtest: numvfs-2
[628.276608] Dynamic subtest numvfs-2: FAIL (0.004s)
[628.286797] Starting dynamic subtest: numvfs-3
[628.360052] Dynamic subtest numvfs-3: FAIL (0.007s)
[628.370294] Starting dynamic subtest: numvfs-4
[628.442841] Dynamic subtest numvfs-4: FAIL (0.004s)
[628.453778] Starting dynamic subtest: numvfs-5
[628.527430] Dynamic subtest numvfs-5: FAIL (0.004s)
[628.537638] Starting dynamic subtest: numvfs-6
[628.611350] Dynamic subtest numvfs-6: FAIL (0.003s)
[628.622120] Starting dynamic subtest: numvfs-7
[628.695411] Dynamic subtest numvfs-7: FAIL (0.006s)
[628.705701] Starting dynamic subtest: numvfs-random
[628.778610] Dynamic subtest numvfs-random: FAIL (0.003s)
[628.780666] Subtest enable-vfs-bind-unbind-each: FAIL (0.067s)
[628.823632] [117/134] (453s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[628.913981] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[628.918559] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[630.031784] [118/134] (452s left) kms_getfb (getfb-handle-not-fb)
[630.131696] Starting subtest: getfb-handle-not-fb
[630.134086] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[630.269045] [119/134] (452s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[630.334594] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[630.338868] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[630.537071] [120/134] (452s left) gem_workarounds (reset-context)
[630.615308] Starting subtest: reset-context
[630.778331] Subtest reset-context: SUCCESS (0.162s)
[630.936464] [121/134] (451s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[631.055538] Starting subtest: psr-farfromfence-mmap-gtt
[631.059660] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[631.191408] [122/134] (451s left) gem_wait (write-busy)
[631.254723] Starting subtest: write-busy
[631.257189] Starting dynamic subtest: all-engines
[631.875713] Dynamic subtest all-engines: SUCCESS (0.620s)
[631.891771] Starting dynamic subtest: rcs0
[632.429640] Dynamic subtest rcs0: SUCCESS (0.552s)
[632.445825] Starting dynamic subtest: bcs0
[632.979596] Dynamic subtest bcs0: SUCCESS (0.549s)
[632.995192] Starting dynamic subtest: vcs0
[634.900450] Dynamic subtest vcs0: SUCCESS (1.918s)
[634.916943] Starting dynamic subtest: vcs1
[636.884406] Dynamic subtest vcs1: SUCCESS (1.981s)
[636.900098] Starting dynamic subtest: vecs0
[638.932418] Dynamic subtest vecs0: SUCCESS (2.045s)
[638.948080] Starting dynamic subtest: ccs0
[639.482432] Dynamic subtest ccs0: SUCCESS (0.549s)
[639.484828] Subtest write-busy: SUCCESS (8.227s)
[639.702764] [123/134] (442s left) i915_hangman (detector)
[639.792330] Starting subtest: detector
[639.794715] Starting dynamic subtest: rcs0
[650.868036] Dynamic subtest rcs0: SUCCESS (11.073s)
[650.879973] Starting dynamic subtest: bcs0
[662.899793] Dynamic subtest bcs0: SUCCESS (12.028s)
[662.911563] Starting dynamic subtest: vcs0
[674.802782] Dynamic subtest vcs0: SUCCESS (11.900s)
[674.815803] Starting dynamic subtest: vcs1
[685.811144] Dynamic subtest vcs1: SUCCESS (11.005s)
[685.825716] Starting dynamic subtest: vecs0
[695.858991] Dynamic subtest vecs0: SUCCESS (10.045s)
[695.871106] Starting dynamic subtest: ccs0
[707.828314] Dynamic subtest ccs0: SUCCESS (11.965s)
[707.831830] Subtest detector: SUCCESS (68.033s)
[707.933429] [124/134] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[708.047296] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[708.051283] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[708.167164] [125/134] (374s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[708.279402] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[708.283772] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[708.446457] [126/134] (374s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[708.507203] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[708.573775] [127/134] (374s left) gem_exec_schedule (noreorder-corked)
[708.760311] Starting subtest: noreorder-corked
[708.762942] Starting dynamic subtest: rcs0
[709.902046] Dynamic subtest rcs0: SUCCESS (1.142s)
[709.914297] Starting dynamic subtest: vcs0
[711.908781] Dynamic subtest vcs0: SUCCESS (2.004s)
[711.920904] Starting dynamic subtest: vcs1
[713.899174] Dynamic subtest vcs1: SUCCESS (1.988s)
[713.912072] Starting dynamic subtest: vecs0
[715.909723] Dynamic subtest vecs0: SUCCESS (2.007s)
[715.921523] Starting dynamic subtest: ccs0
[717.080299] Dynamic subtest ccs0: SUCCESS (1.169s)
[717.083312] Subtest noreorder-corked: SUCCESS (8.321s)
[717.287959] [128/134] (365s left) kms_psr (pr-cursor-mmap-cpu)
[717.394063] Starting subtest: pr-cursor-mmap-cpu
[717.398227] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[717.491593] [129/134] (365s left) perf (invalid-oa-format-id)
[717.599632] Starting subtest: invalid-oa-format-id
[717.609168] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[717.652530] [130/134] (365s left) gem_eio (in-flight-internal-immediate)
[717.844269] Starting subtest: in-flight-internal-immediate
[718.983824] Subtest in-flight-internal-immediate: SUCCESS (1.139s)
[719.170112] [131/134] (363s left) kms_cursor_edge_walk (256x256-top-edge)
[719.267830] Starting subtest: 256x256-top-edge
[719.270055] Starting dynamic subtest: pipe-A-eDP-1
[722.765045] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.496s)
[722.774714] Starting dynamic subtest: pipe-D-eDP-1
[725.895827] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[725.898111] Subtest 256x256-top-edge: SUCCESS (6.630s)
[726.720935] [132/134] (356s left) gem_ctx_persistence (engines-persistence)
[726.789942] Starting subtest: engines-persistence
[726.792217] Starting dynamic subtest: rcs0
[727.667073] Dynamic subtest rcs0: SUCCESS (0.876s)
[727.680068] Starting dynamic subtest: bcs0
[728.450594] Dynamic subtest bcs0: SUCCESS (0.781s)
[728.462530] Starting dynamic subtest: vcs0
[729.325232] Dynamic subtest vcs0: SUCCESS (0.872s)
[729.337916] Starting dynamic subtest: vcs1
[730.155049] Dynamic subtest vcs1: SUCCESS (0.828s)
[730.167419] Starting dynamic subtest: vecs0
[730.976446] Dynamic subtest vecs0: SUCCESS (0.819s)
[730.989460] Starting dynamic subtest: ccs0
[731.741431] Dynamic subtest ccs0: SUCCESS (0.763s)
[731.744393] Subtest engines-persistence: SUCCESS (4.952s)
[731.851702] [133/134] (351s left) api_intel_bb (render-ccs)
[731.909528] Starting subtest: render-ccs
[732.269999] Subtest render-ccs: SUCCESS (0.361s)
[732.404852] [134/134] (350s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[732.514689] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[732.518799] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[732.638375] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_fence_pin_leak
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: kms_plane_alpha_blend
results: parsing output: 13/ for test: sysfs_timeslice_duration
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_pm_dc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_render_copy_redux
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_3d
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 53/ for test: kms_dp_link_training
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_tiled_pread_pwrite
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_flink_race
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: i915_pm_rps
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_concurrent
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_scaling_modes
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: sriov_basic
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: i915_hangman
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: api_intel_bb
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.