[56.335016] Initializing watchdogs
[56.335136]   /dev/watchdog0
[56.349375] [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]
[56.353577] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.355800] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.359062] [001/131] (960s left) kms_psr (fbc-psr2-primary-page-flip)
[56.467805] Starting subtest: fbc-psr2-primary-page-flip
[56.470070] Starting dynamic subtest: eDP-1
[56.474518] Dynamic subtest eDP-1: SKIP (0.000s)
[56.478659] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[56.538955] [002/131] (960s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[56.627574] Starting subtest: bo-too-small-due-to-tiling
[56.631483] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[56.736653] [003/131] (960s left) gem_exec_fence (concurrent)
[56.915578] Starting subtest: concurrent
[56.920180] Subtest concurrent: SKIP (0.000s)
[59.015202] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[59.018125] [004/131] (957s left) gem_exec_reloc (basic-gtt-cpu)
[59.082732] Subtest basic-gtt-cpu: SKIP (0.000s)
[59.167594] [005/131] (957s left) gen3_mixed_blits
[59.293889] [006/131] (957s left) syncobj_timeline (device-submit-unordered)
[59.350681] Starting subtest: device-submit-unordered
[59.353143] Subtest device-submit-unordered: SUCCESS (0.000s)
[59.481880] [007/131] (957s left) kms_big_fb (x-tiled-addfb)
[59.596436] Starting subtest: x-tiled-addfb
[59.598613] Subtest x-tiled-addfb: SUCCESS (0.000s)
[59.725066] [008/131] (957s left) kms_cursor_crc (cursor-onscreen-32x10)
[59.884210] Starting subtest: cursor-onscreen-32x10
[59.928662] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[60.188594] [009/131] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[60.276333] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[60.280020] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[60.396245] [010/131] (956s left) api_intel_bb (object-reloc-keep-cache)
[60.453651] Starting subtest: object-reloc-keep-cache
[60.457968] Subtest object-reloc-keep-cache: SKIP (0.004s)
[60.602262] [011/131] (956s left) gem_pwrite (basic-exhaustion)
[60.657573] Subtest basic-exhaustion: SKIP (0.000s)
[60.721275] [012/131] (956s left) gem_workarounds (basic-read)
[60.782410] Starting subtest: basic-read
[60.791743] Subtest basic-read: SUCCESS (0.010s)
[60.942207] [013/131] (956s left) gem_mmap_gtt (medium-copy-odd)
[60.994851] Subtest medium-copy-odd: SKIP (0.000s)
[61.053614] [014/131] (956s left) gem_workarounds (suspend-resume-fd)
[61.123527] Starting subtest: suspend-resume-fd
[77.648915] Subtest suspend-resume-fd: SUCCESS (1.277s)
[77.802556] [015/131] (939s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[82.847955] Starting subtest: fbc-pr-cursor-plane-update-sf
[82.852469] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[83.705756] [016/131] (933s left) kms_invalid_mode (clock-too-high)
[83.800166] Starting subtest: clock-too-high
[83.802582] Starting dynamic subtest: pipe-A-eDP-1
[83.806785] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.816599] Starting dynamic subtest: pipe-B-eDP-1
[83.820535] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.828059] Starting dynamic subtest: pipe-C-eDP-1
[83.832190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.839492] Starting dynamic subtest: pipe-D-eDP-1
[83.843762] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.848162] Subtest clock-too-high: SKIP (0.003s)
[83.882224] [017/131] (933s left) kms_plane_cursor (primary)
[83.977819] Starting subtest: primary
[83.982199] Starting dynamic subtest: pipe-A-eDP-1-size-64
[86.659207] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.720s)
[86.682810] Starting dynamic subtest: pipe-A-eDP-1-size-128
[89.366161] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.715s)
[89.389174] Starting dynamic subtest: pipe-A-eDP-1-size-256
[92.004303] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.638s)
[92.317599] Starting dynamic subtest: pipe-B-eDP-1-size-64
[95.685640] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.393s)
[95.710200] Starting dynamic subtest: pipe-B-eDP-1-size-128
[98.389206] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.695s)
[98.415044] Starting dynamic subtest: pipe-B-eDP-1-size-256
[101.050443] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.649s)
[101.361100] Starting dynamic subtest: pipe-C-eDP-1-size-64
[104.382830] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.035s)
[104.409298] Starting dynamic subtest: pipe-C-eDP-1-size-128
[106.690301] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.291s)
[106.716676] Starting dynamic subtest: pipe-C-eDP-1-size-256
[108.867425] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[109.182190] Starting dynamic subtest: pipe-D-eDP-1-size-64
[112.159149] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.984s)
[112.188392] Starting dynamic subtest: pipe-D-eDP-1-size-128
[114.561525] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.380s)
[114.586723] Starting dynamic subtest: pipe-D-eDP-1-size-256
[116.871184] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.290s)
[117.178996] Subtest primary: SUCCESS (33.324s)
[117.998231] [018/131] (899s left) kms_cursor_crc (cursor-sliding-256x256)
[118.231776] Starting subtest: cursor-sliding-256x256
[118.236852] Starting dynamic subtest: pipe-A-eDP-1
[121.483490] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.247s)
[121.510290] Starting dynamic subtest: pipe-D-eDP-1
[125.372025] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.867s)
[125.374885] Subtest cursor-sliding-256x256: SUCCESS (7.139s)
[126.289315] [019/131] (891s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[126.383232] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[133.159883] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.778s)
[133.297801] [020/131] (884s left) i915_drm_fdinfo (idle)
[133.337865] Starting subtest: idle
[133.340065] Starting dynamic subtest: rcs0
[133.929023] Dynamic subtest rcs0: SUCCESS (0.591s)
[133.942762] Starting dynamic subtest: bcs0
[134.437407] Dynamic subtest bcs0: SUCCESS (0.504s)
[134.447811] Starting dynamic subtest: vcs0
[134.944692] Dynamic subtest vcs0: SUCCESS (0.504s)
[134.955945] Starting dynamic subtest: vcs1
[135.449972] Dynamic subtest vcs1: SUCCESS (0.503s)
[135.461640] Starting dynamic subtest: vecs0
[135.956040] Dynamic subtest vecs0: SUCCESS (0.503s)
[135.966739] Starting dynamic subtest: ccs0
[136.463143] Dynamic subtest ccs0: SUCCESS (0.504s)
[136.465803] Subtest idle: SUCCESS (3.126s)
[136.558587] [021/131] (881s left) kms_flip (2x-plain-flip)
[136.655341] Starting subtest: 2x-plain-flip
[136.663937] Subtest 2x-plain-flip: SKIP (0.010s)
[136.751892] [022/131] (880s left) kms_big_fb (linear-32bpp-rotate-0)
[136.848274] Starting subtest: linear-32bpp-rotate-0
[138.324049] Subtest linear-32bpp-rotate-0: SUCCESS (1.477s)
[138.505328] [023/131] (879s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[138.592017] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[138.595385] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[138.728638] [024/131] (879s left) gem_ctx_engines (invalid-engines)
[138.791403] Starting subtest: invalid-engines
[138.799788] Subtest invalid-engines: SUCCESS (0.008s)
[139.048908] [025/131] (878s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[139.106255] Starting subtest: single-wait-all-for-submit-unsubmitted
[139.211867] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[139.287563] [026/131] (878s left) kms_cursor_legacy (torture-bo)
[139.400786] Starting subtest: torture-bo
[139.402721] Starting dynamic subtest: pipe-A
[145.632148] Dynamic subtest pipe-A: SUCCESS (6.230s)
[145.644456] Starting dynamic subtest: pipe-B
[152.131895] Dynamic subtest pipe-B: SUCCESS (6.499s)
[152.143104] Starting dynamic subtest: pipe-C
[158.556328] Dynamic subtest pipe-C: SUCCESS (6.424s)
[158.567377] Starting dynamic subtest: pipe-D
[164.861458] Dynamic subtest pipe-D: SUCCESS (6.305s)
[164.871847] Starting dynamic subtest: all-pipes
[171.492000] Dynamic subtest all-pipes: SUCCESS (6.630s)
[171.494336] Subtest torture-bo: SUCCESS (32.101s)
[171.679449] [027/131] (846s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[171.732259] Starting subtest: etime-multi-wait-for-submit-submitted
[171.836081] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[171.923745] [028/131] (845s left) kms_vrr (negative-basic)
[172.014056] Starting subtest: negative-basic
[172.020366] Starting dynamic subtest: pipe-A-eDP-1
[177.924573] Dynamic subtest pipe-A-eDP-1: FAIL (5.432s)
[177.926279] Subtest negative-basic: FAIL (5.730s)
[178.650125] [029/131] (839s left) kms_psr (psr-basic)
[178.749788] Starting subtest: psr-basic
[178.751936] Starting dynamic subtest: eDP-1
[180.339880] Dynamic subtest eDP-1: SUCCESS (1.588s)
[180.342072] Subtest psr-basic: SUCCESS (1.589s)
[181.240763] [030/131] (836s left) gem_spin_batch (resubmit-new-all)
[181.294422] Starting subtest: resubmit-new-all
[181.296763] Starting dynamic subtest: rcs0
[181.308878] Dynamic subtest rcs0: SUCCESS (0.014s)
[181.319471] Starting dynamic subtest: bcs0
[181.321797] Dynamic subtest bcs0: SUCCESS (0.009s)
[181.330503] Starting dynamic subtest: vcs0
[181.332415] Dynamic subtest vcs0: SUCCESS (0.008s)
[181.340348] Starting dynamic subtest: vcs1
[181.342543] Dynamic subtest vcs1: SUCCESS (0.008s)
[181.351030] Starting dynamic subtest: vecs0
[181.352940] Dynamic subtest vecs0: SUCCESS (0.008s)
[181.361204] Starting dynamic subtest: ccs0
[181.363330] Dynamic subtest ccs0: SUCCESS (0.009s)
[181.365457] Subtest resubmit-new-all: SUCCESS (0.064s)
[183.204990] [031/131] (834s left) gem_exec_async (forked-writes)
[183.268569] Starting subtest: forked-writes
[183.270772] Starting dynamic subtest: rcs0
[183.299971] Dynamic subtest rcs0: SUCCESS (0.031s)
[183.310187] Starting dynamic subtest: bcs0
[183.323259] Dynamic subtest bcs0: SUCCESS (0.023s)
[183.332530] Starting dynamic subtest: vcs0
[183.344446] Dynamic subtest vcs0: SUCCESS (0.020s)
[183.354671] Starting dynamic subtest: vcs1
[183.366862] Dynamic subtest vcs1: SUCCESS (0.022s)
[183.375765] Starting dynamic subtest: vecs0
[183.387512] Dynamic subtest vecs0: SUCCESS (0.020s)
[183.396951] Starting dynamic subtest: ccs0
[183.409748] Dynamic subtest ccs0: SUCCESS (0.021s)
[183.412067] Subtest forked-writes: SUCCESS (0.142s)
[183.680695] [032/131] (834s left) api_intel_bb (add-remove-objects)
[183.741831] Starting subtest: add-remove-objects
[183.751896] Subtest add-remove-objects: SUCCESS (0.012s)
[183.905235] [033/131] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[184.007166] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[184.011356] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[184.123900] [034/131] (833s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[184.220361] Starting subtest: psr-rgb565-draw-render
[191.165171] Subtest psr-rgb565-draw-render: SUCCESS (6.945s)
[191.309143] [035/131] (826s left) kms_flip (2x-plain-flip-ts-check)
[191.404448] Starting subtest: 2x-plain-flip-ts-check
[191.413565] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[191.535312] [036/131] (826s left) dumb_buffer (invalid-bpp)
[191.589181] Starting subtest: invalid-bpp
[191.591414] Subtest invalid-bpp: SUCCESS (0.000s)
[191.702657] [037/131] (826s left) sysfs_timeslice_duration (duration)
[191.760533] Starting subtest: duration
[191.762949] Starting dynamic subtest: vecs0
[205.070729] Dynamic subtest vecs0: SUCCESS (13.306s)
[205.083296] Starting dynamic subtest: ccs0
[218.220983] Dynamic subtest ccs0: SUCCESS (13.149s)
[218.232307] Starting dynamic subtest: vcs0
[232.077480] Dynamic subtest vcs0: SUCCESS (13.854s)
[232.089178] Starting dynamic subtest: bcs0
[245.239077] Dynamic subtest bcs0: SUCCESS (13.162s)
[245.252281] Starting dynamic subtest: rcs0
[258.413095] Dynamic subtest rcs0: SUCCESS (13.174s)
[258.424588] Starting dynamic subtest: vcs1
[272.077310] Dynamic subtest vcs1: SUCCESS (13.663s)
[272.080636] Subtest duration: SUCCESS (80.325s)
[272.165437] [038/131] (746s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[272.271401] Starting subtest: y-tiled-64bpp-rotate-180
[272.275419] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[272.401592] [039/131] (745s left) prime_vgem (wait)
[272.499806] Starting subtest: wait
[272.502135] Starting dynamic subtest: rcs0
[272.568217] Dynamic subtest rcs0: SUCCESS (0.069s)
[272.576259] Starting dynamic subtest: bcs0
[272.644357] Dynamic subtest bcs0: SUCCESS (0.075s)
[272.652500] Starting dynamic subtest: vcs0
[272.687436] Dynamic subtest vcs0: SUCCESS (0.042s)
[272.695409] Starting dynamic subtest: vcs1
[272.732557] Dynamic subtest vcs1: SUCCESS (0.044s)
[272.740733] Starting dynamic subtest: vecs0
[272.780173] Dynamic subtest vecs0: SUCCESS (0.047s)
[272.788523] Starting dynamic subtest: ccs0
[272.825978] Dynamic subtest ccs0: SUCCESS (0.045s)
[272.828239] Subtest wait: SUCCESS (0.328s)
[272.969971] [040/131] (745s left) gem_pipe_control_store_loop (fresh-buffer)
[273.015757] Starting subtest: fresh-buffer
[275.169171] Subtest fresh-buffer: SUCCESS (2.153s)
[275.307495] [041/131] (743s left) gem_ctx_persistence (heartbeat-many)
[275.367968] Starting subtest: heartbeat-many
[275.372689] Subtest heartbeat-many: SKIP (0.000s)
[275.496181] [042/131] (742s left) dumb_buffer (map-invalid-size)
[275.543406] Starting subtest: map-invalid-size
[275.545719] Subtest map-invalid-size: SUCCESS (0.000s)
[275.674261] [043/131] (742s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[275.784324] Starting subtest: pipe-fbc-rte
[275.791061] Starting dynamic subtest: pipe-B-eDP-1
[281.306189] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.526s)
[281.313749] Subtest pipe-fbc-rte: SUCCESS (5.528s)
[283.565577] [044/131] (734s left) gem_fence_thrash (bo-write-verify-x)
[283.601191] Starting subtest: bo-write-verify-x
[283.611173] Subtest bo-write-verify-x: SKIP (0.011s)
[283.683822] [045/131] (734s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[283.745128] Starting subtest: basic-batch-kernel-default-cmd
[283.749755] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[283.941381] [046/131] (734s left) i915_hangman (gt-engine-error)
[284.010200] Starting subtest: gt-engine-error
[284.012428] Starting dynamic subtest: rcs0
[287.053383] Dynamic subtest rcs0: SUCCESS (3.043s)
[287.064743] Starting dynamic subtest: bcs0
[289.164901] Dynamic subtest bcs0: SUCCESS (2.110s)
[289.175275] Starting dynamic subtest: vcs0
[291.151518] Dynamic subtest vcs0: SUCCESS (1.984s)
[291.163147] Starting dynamic subtest: vcs1
[293.133381] Dynamic subtest vcs1: SUCCESS (1.980s)
[293.143210] Starting dynamic subtest: vecs0
[295.118773] Dynamic subtest vecs0: SUCCESS (1.983s)
[295.131532] Starting dynamic subtest: ccs0
[297.166757] Dynamic subtest ccs0: SUCCESS (2.045s)
[297.169440] Subtest gt-engine-error: SUCCESS (13.160s)
[297.319736] [047/131] (721s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[297.435993] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[298.435426] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.001s)
[298.574026] [048/131] (720s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[298.670217] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[298.673714] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[298.799198] [049/131] (719s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[298.891475] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[298.893565] Starting dynamic subtest: pipe-A-default-mode
[301.567206] Dynamic subtest pipe-A-default-mode: SUCCESS (2.677s)
[301.569508] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.678s)
[302.436743] [050/131] (716s left) kms_chamelium_frames (hdmi-crc-multiple)
[302.807760] Subtest hdmi-crc-multiple: SKIP (0.000s)
[303.636910] [051/131] (715s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[303.740525] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[303.753196] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[303.844706] [052/131] (714s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[303.940689] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[310.985878] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.046s)
[311.168282] [053/131] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[311.264403] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[311.268485] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[311.386359] [054/131] (707s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[311.438584] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[311.440802] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[311.562741] [055/131] (707s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[311.640383] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[311.642734] Starting dynamic subtest: pipe-A-eDP-1
[311.665172] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[311.676264] Starting dynamic subtest: pipe-B-eDP-1
[311.697718] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[311.705629] Starting dynamic subtest: pipe-C-eDP-1
[311.727309] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[311.735142] Starting dynamic subtest: pipe-D-eDP-1
[311.757867] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[311.762516] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[313.932725] [056/131] (705s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[314.033145] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[318.175536] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.144s)
[319.330476] [057/131] (699s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[319.420791] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[319.423188] Starting dynamic subtest: pipe-A
[319.439521] Dynamic subtest pipe-A: SKIP (0.016s)
[319.453227] Starting dynamic subtest: pipe-B
[319.469803] Dynamic subtest pipe-B: SKIP (0.028s)
[319.482656] Starting dynamic subtest: pipe-C
[319.496341] Dynamic subtest pipe-C: SKIP (0.028s)
[319.506494] Starting dynamic subtest: pipe-D
[319.524432] Dynamic subtest pipe-D: SKIP (0.027s)
[319.529168] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.101s)
[319.645401] [058/131] (699s left) kms_psr (fbc-psr-cursor-plane-move)
[319.745250] Starting subtest: fbc-psr-cursor-plane-move
[319.747557] Starting dynamic subtest: eDP-1
[319.751925] Dynamic subtest eDP-1: SKIP (0.000s)
[319.756373] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[319.833924] [059/131] (699s left) gem_exec_fence (syncobj-invalid-wait)
[320.263874] Starting subtest: syncobj-invalid-wait
[320.266418] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[322.272733] [060/131] (696s left) syncobj_basic (bad-create-flags)
[322.327365] Starting subtest: bad-create-flags
[322.329779] Subtest bad-create-flags: SUCCESS (0.000s)
[322.464467] [061/131] (696s left) kms_feature_discovery (display-1x)
[322.559892] Starting subtest: display-1x
[322.562183] Subtest display-1x: SUCCESS (0.000s)
[322.657356] [062/131] (696s left) kms_pm_rpm (modeset-lpsp-stress)
[324.276834] Starting subtest: modeset-lpsp-stress
[340.360899] Subtest modeset-lpsp-stress: SUCCESS (16.085s)
[340.460362] [063/131] (678s left) prime_mmap_kms (buffer-sharing)
[340.556098] Starting subtest: buffer-sharing
[341.004004] Subtest buffer-sharing: SUCCESS (0.448s)
[341.856421] [064/131] (677s left) kms_chamelium_color (degamma)
[341.944233] Subtest degamma: SKIP (0.000s)
[341.989057] [065/131] (677s left) gem_ctx_param (invalid-get-ringsize)
[342.037571] Starting subtest: invalid-get-ringsize
[342.039902] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[342.167235] [066/131] (677s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[347.210364] Starting subtest: psr2-overlay-plane-update-continuous-sf
[347.212936] Starting dynamic subtest: pipe-A-eDP-1
[348.986796] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.774s)
[348.996432] Starting dynamic subtest: pipe-B-eDP-1
[350.712367] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.724s)
[350.714659] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.502s)
[351.540086] [067/131] (667s left) gem_exec_reloc (basic-write-read-active)
[351.608810] Subtest basic-write-read-active: SKIP (0.000s)
[351.678918] [068/131] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[351.770773] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[358.993301] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.227s)
[359.155478] [069/131] (660s left) kms_force_connector_basic (force-load-detect)
[359.227195] Starting subtest: force-load-detect
[359.231805] Subtest force-load-detect: SKIP (0.000s)
[359.366819] [070/131] (660s left) kms_pm_rpm (modeset-non-lpsp-stress)
[361.290848] Starting subtest: modeset-non-lpsp-stress
[362.442766] Subtest modeset-non-lpsp-stress: SKIP (1.152s)
[362.834552] [071/131] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[362.936287] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[362.940421] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[363.052526] [072/131] (656s left) gem_exec_schedule (fairslice-all)
[363.115441] Starting subtest: fairslice-all
[365.168912] Subtest fairslice-all: SUCCESS (2.059s)
[367.191534] [073/131] (652s left) kms_color (ctm-0-25)
[367.284938] Starting subtest: ctm-0-25
[367.287186] Starting dynamic subtest: pipe-A-eDP-1
[370.792210] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.506s)
[370.801209] Starting dynamic subtest: pipe-B-eDP-1
[374.930978] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.138s)
[374.942634] Starting dynamic subtest: pipe-C-eDP-1
[378.963196] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.032s)
[378.972068] Starting dynamic subtest: pipe-D-eDP-1
[382.955605] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.993s)
[382.957921] Subtest ctm-0-25: SUCCESS (15.672s)
[383.861632] [074/131] (635s left) gem_flink_race (flink_close)
[383.902816] Starting subtest: flink_close
[389.004054] Subtest flink_close: SUCCESS (5.101s)
[389.096075] [075/131] (630s left) gem_exec_params (rel-constants-invalid)
[389.173726] Starting subtest: rel-constants-invalid
[389.176157] Subtest rel-constants-invalid: SUCCESS (0.000s)
[389.321226] [076/131] (630s left) gen9_exec_parse (secure-batches)
[389.377321] Subtest secure-batches: SKIP (0.000s)
[389.478765] [077/131] (630s left) drm_read (short-buffer-nonblock)
[389.631607] Starting subtest: short-buffer-nonblock
[389.634000] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[389.795250] [078/131] (630s left) kms_psr (psr2-cursor-mmap-gtt)
[389.906202] Starting subtest: psr2-cursor-mmap-gtt
[389.908486] Starting dynamic subtest: eDP-1
[391.603068] Dynamic subtest eDP-1: SUCCESS (1.695s)
[391.605838] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.696s)
[392.410978] [079/131] (627s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[392.501565] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[392.503852] Starting dynamic subtest: pipe-A
[392.611039] Dynamic subtest pipe-A: SKIP (0.105s)
[392.620414] Starting dynamic subtest: pipe-B
[393.760821] Dynamic subtest pipe-B: SKIP (1.149s)
[393.770597] Starting dynamic subtest: pipe-C
[394.896003] Dynamic subtest pipe-C: SUCCESS (1.142s)
[394.906139] Starting dynamic subtest: pipe-D
[396.047240] Dynamic subtest pipe-D: SUCCESS (1.151s)
[396.049535] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.549s)
[397.252743] [080/131] (622s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[397.333925] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[397.336441] Starting dynamic subtest: pipe-A-eDP-1
[397.357487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[397.367757] Starting dynamic subtest: pipe-B-eDP-1
[397.387496] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[397.396023] Starting dynamic subtest: pipe-C-eDP-1
[397.415707] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[397.425006] Starting dynamic subtest: pipe-D-eDP-1
[397.445777] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[397.447904] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[399.543570] [081/131] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[399.648193] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[399.652610] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[399.777440] [082/131] (620s left) syncobj_basic (bad-destroy-pad)
[399.835907] Starting subtest: bad-destroy-pad
[399.837930] Subtest bad-destroy-pad: SUCCESS (0.000s)
[399.953992] [083/131] (620s left) gem_userptr_blits (dmabuf-unsync)
[400.027588] Subtest dmabuf-unsync: SKIP (0.000s)
[400.190580] [084/131] (619s left) kms_rotation_crc (sprite-rotation-180)
[400.287276] Starting subtest: sprite-rotation-180
[405.191958] Subtest sprite-rotation-180: SUCCESS (4.908s)
[406.408908] [085/131] (613s left) gem_vm_create (invalid-create)
[406.464420] Starting subtest: invalid-create
[406.466735] Subtest invalid-create: SUCCESS (0.002s)
[406.609431] [086/131] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[406.717726] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[406.722142] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[406.856858] [087/131] (613s left) syncobj_wait (multi-wait-for-submit-signaled)
[406.919274] Starting subtest: multi-wait-for-submit-signaled
[406.921575] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[407.051200] [088/131] (613s left) vgem_basic (mmap)
[407.090212] Starting subtest: mmap
[407.104251] Subtest mmap: SUCCESS (0.016s)
[407.183055] [089/131] (613s left) gem_eio (in-flight-internal-10ms)
[407.410041] Starting subtest: in-flight-internal-10ms
[409.284924] Subtest in-flight-internal-10ms: SUCCESS (1.874s)
[409.450560] [090/131] (610s left) gem_partial_pwrite_pread (reads-snoop)
[409.514755] Subtest reads-snoop: SKIP (0.000s)
[409.604496] [091/131] (610s left) gem_exec_schedule (timeslicing)
[409.679620] Starting subtest: timeslicing
[409.681662] Starting dynamic subtest: rcs0
[409.689012] Dynamic subtest rcs0: SUCCESS (0.021s)
[409.698550] Starting dynamic subtest: bcs0
[409.710318] Dynamic subtest bcs0: SUCCESS (0.020s)
[409.719761] Starting dynamic subtest: vcs0
[409.731999] Dynamic subtest vcs0: SUCCESS (0.021s)
[409.744398] Starting dynamic subtest: vcs1
[409.754523] Dynamic subtest vcs1: SUCCESS (0.021s)
[409.763739] Starting dynamic subtest: vecs0
[409.776167] Dynamic subtest vecs0: SUCCESS (0.021s)
[409.785435] Starting dynamic subtest: ccs0
[409.798577] Dynamic subtest ccs0: SUCCESS (0.021s)
[409.800929] Subtest timeslicing: SUCCESS (0.132s)
[411.242087] [092/131] (609s left) kms_addfb_basic (master-rmfb)
[411.297617] Starting subtest: master-rmfb
[411.300047] Subtest master-rmfb: SUCCESS (0.001s)
[411.449697] [093/131] (609s left) gem_set_tiling_vs_gtt
[411.582834] [094/131] (609s left) gem_exec_reloc (basic-cpu-gtt)
[411.637787] Subtest basic-cpu-gtt: SKIP (0.000s)
[411.742397] [095/131] (608s left) kms_cursor_crc (cursor-onscreen-max-size)
[412.039990] Starting subtest: cursor-onscreen-max-size
[412.046380] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[412.210090] [096/131] (608s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[412.312869] Starting subtest: psr-rgb101010-draw-render
[419.427061] Subtest psr-rgb101010-draw-render: SUCCESS (7.116s)
[419.577846] [097/131] (601s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[419.670423] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[423.329072] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.663s)
[424.514298] [098/131] (596s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[424.625505] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[433.513779] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.891s)
[434.322159] [099/131] (586s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[434.410850] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[434.413150] Starting dynamic subtest: pipe-A-eDP-1
[434.422173] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[434.431735] Starting dynamic subtest: pipe-B-eDP-1
[434.440852] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[434.449942] Starting dynamic subtest: pipe-C-eDP-1
[434.458275] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[434.467170] Starting dynamic subtest: pipe-D-eDP-1
[434.475342] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[434.479681] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[436.679683] [100/131] (584s left) kms_pwrite_crc
[438.317449] [101/131] (582s left) syncobj_timeline (wait-all-for-submit-snapshot)
[438.376641] Starting subtest: wait-all-for-submit-snapshot
[438.459203] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[438.558739] [102/131] (582s left) kms_psr (fbc-pr-sprite-blt)
[438.652101] Starting subtest: fbc-pr-sprite-blt
[438.656357] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[438.738936] [103/131] (582s left) kms_content_protection (dp-mst-lic-type-1)
[438.879157] Starting subtest: dp-mst-lic-type-1
[438.883857] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[439.019583] [104/131] (581s left) kms_writeback (writeback-fb-id)
[439.121215] Subtest writeback-fb-id: SKIP (0.000s)
[439.164858] [105/131] (581s left) kms_async_flips (test-cursor-atomic)
[439.259749] Starting subtest: test-cursor-atomic
[439.263594] Subtest test-cursor-atomic: SKIP (0.000s)
[440.462562] [106/131] (580s left) gem_media_fill (media-fill)
[440.520181] Subtest media-fill: SKIP (0.000s)
[440.661780] [107/131] (580s left) kms_properties (plane-properties-legacy)
[440.745967] Starting subtest: plane-properties-legacy
[440.747818] Starting dynamic subtest: pipe-A-eDP-1
[441.301811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[441.315428] Starting dynamic subtest: pipe-B-eDP-1
[442.627796] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.325s)
[442.638300] Starting dynamic subtest: pipe-C-eDP-1
[443.861093] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.231s)
[443.872891] Starting dynamic subtest: pipe-D-eDP-1
[445.096400] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[445.098847] Subtest plane-properties-legacy: SUCCESS (4.352s)
[445.903642] [108/131] (575s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[445.952866] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[445.957248] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[446.150016] [109/131] (575s left) gem_lmem_swapping (heavy-verify-random)
[446.188395] Subtest heavy-verify-random: SKIP (0.000s)
[446.233386] [110/131] (575s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[446.292610] Starting subtest: invalid-single-wait-all-unsubmitted
[446.294895] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[446.388926] [111/131] (574s left) kms_lease (lease-invalid-connector)
[446.480240] Starting subtest: lease-invalid-connector
[446.482482] Starting dynamic subtest: pipe-A-eDP-1
[446.484626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[446.493888] Starting dynamic subtest: pipe-B-eDP-1
[446.495780] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[446.504822] Starting dynamic subtest: pipe-C-eDP-1
[446.506928] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[446.515941] Starting dynamic subtest: pipe-D-eDP-1
[446.517798] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[446.519709] Subtest lease-invalid-connector: SUCCESS (0.004s)
[446.581042] [112/131] (574s left) gem_eio (kms)
[446.858971] Starting subtest: kms
[467.811512] Subtest kms: SUCCESS (20.955s)
[469.002449] [113/131] (552s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[469.105757] Starting subtest: extended-pageflip-modeset-hang-oldfb
[469.107959] Starting dynamic subtest: pipe-A
[476.998961] Dynamic subtest pipe-A: SUCCESS (7.893s)
[477.008285] Starting dynamic subtest: pipe-D
[485.595485] Dynamic subtest pipe-D: SUCCESS (8.596s)
[485.597876] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.494s)
[486.460535] [114/131] (534s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[486.558101] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[487.481721] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.923s)
[487.626585] [115/131] (533s left) perf (buffer-fill)
[487.773019] Starting subtest: buffer-fill
[487.775025] Starting dynamic subtest: 0-rcs0
[490.018439] Dynamic subtest 0-rcs0: SUCCESS (2.245s)
[490.028838] Starting dynamic subtest: 1-vecs0
[494.416298] Dynamic subtest 1-vecs0: SUCCESS (4.397s)
[494.418726] Subtest buffer-fill: SUCCESS (6.645s)
[494.467437] [116/131] (527s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[494.578473] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[494.582779] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[494.700487] [117/131] (526s left) kms_vblank (query-forked-hang)
[494.782482] Starting subtest: query-forked-hang
[494.784681] Starting dynamic subtest: pipe-A-eDP-1
[520.936171] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.158s)
[520.950587] Starting dynamic subtest: pipe-D-eDP-1
[535.923761] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.988s)
[535.926315] Subtest query-forked-hang: SUCCESS (41.151s)
[536.826632] [118/131] (484s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[536.913153] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[536.915423] Starting dynamic subtest: pipe-A-eDP-1
[536.935819] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[536.947653] Starting dynamic subtest: pipe-B-eDP-1
[536.966302] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[536.975603] Starting dynamic subtest: pipe-C-eDP-1
[536.994848] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[537.004798] Starting dynamic subtest: pipe-D-eDP-1
[537.024191] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[537.026051] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[539.098485] [119/131] (482s left) perf_pmu (semaphore-wait-idle)
[539.136549] Starting subtest: semaphore-wait-idle
[539.138721] Starting dynamic subtest: rcs0
[539.651942] Dynamic subtest rcs0: SUCCESS (0.515s)
[539.663065] Starting dynamic subtest: bcs0
[540.168150] Dynamic subtest bcs0: SUCCESS (0.512s)
[540.184294] Starting dynamic subtest: vcs0
[540.682352] Dynamic subtest vcs0: SUCCESS (0.511s)
[540.695737] Starting dynamic subtest: vcs1
[541.196159] Dynamic subtest vcs1: SUCCESS (0.511s)
[541.208576] Starting dynamic subtest: vecs0
[541.708895] Dynamic subtest vecs0: SUCCESS (0.510s)
[541.721895] Starting dynamic subtest: ccs0
[542.223546] Dynamic subtest ccs0: SUCCESS (0.512s)
[542.226193] Subtest semaphore-wait-idle: SUCCESS (3.089s)
[542.352025] [120/131] (479s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[542.454132] Starting subtest: psr-1p-pri-indfb-multidraw
[564.446497] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (21.990s)
[564.584237] [121/131] (457s left) i915_pm_rpm (sysfs-read)
[566.310792] Starting subtest: sysfs-read
[567.474841] Subtest sysfs-read: SUCCESS (1.158s)
[567.847259] [122/131] (453s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[567.910674] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[567.914709] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[568.108309] [123/131] (453s left) gem_fence_thrash (bo-write-verify-none)
[568.142366] Starting subtest: bo-write-verify-none
[568.160258] Subtest bo-write-verify-none: SKIP (0.014s)
[568.217414] [124/131] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[568.318422] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[575.213083] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.891s)
[575.351472] [125/131] (446s left) i915_pm_rps (waitboost)
[575.412613] Starting subtest: waitboost
[575.482714] Subtest waitboost: FAIL (0.005s)
[575.558558] [126/131] (446s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[575.654538] Starting subtest: compare-crc-sanitycheck-xr24
[575.656471] Starting dynamic subtest: pipe-A-eDP-1
[576.281742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[576.294392] Starting dynamic subtest: pipe-B-eDP-1
[577.503245] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s)
[577.513369] Starting dynamic subtest: pipe-C-eDP-1
[578.712871] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[578.728429] Starting dynamic subtest: pipe-D-eDP-1
[579.928366] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[579.930679] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.273s)
[580.795333] [127/131] (441s left) gem_exec_schedule (u-submit-late-slice)
[580.870886] Starting subtest: u-submit-late-slice
[580.873270] Starting dynamic subtest: rcs0
[580.899471] Dynamic subtest rcs0: SUCCESS (0.034s)
[580.910709] Starting dynamic subtest: bcs0
[580.934835] Dynamic subtest bcs0: SUCCESS (0.035s)
[580.945722] Starting dynamic subtest: vcs0
[580.967401] Dynamic subtest vcs0: SUCCESS (0.032s)
[580.977240] Starting dynamic subtest: vcs1
[580.998355] Dynamic subtest vcs1: SUCCESS (0.030s)
[581.011536] Starting dynamic subtest: vecs0
[581.027602] Dynamic subtest vecs0: SUCCESS (0.029s)
[581.036907] Starting dynamic subtest: ccs0
[581.065753] Dynamic subtest ccs0: SUCCESS (0.037s)
[581.068195] Subtest u-submit-late-slice: SUCCESS (0.202s)
[582.330236] [128/131] (439s left) gem_mmap_offset (close-race)
[582.385537] Starting subtest: close-race
[602.496557] Subtest close-race: SUCCESS (20.101s)
[602.674585] [129/131] (419s left) gem_exec_schedule (implicit-boths)
[602.756722] Starting subtest: implicit-boths
[602.758909] Starting dynamic subtest: rcs0
[602.933649] Dynamic subtest rcs0: SUCCESS (0.181s)
[602.946932] Starting dynamic subtest: vcs0
[603.046438] Dynamic subtest vcs0: SUCCESS (0.110s)
[603.055934] Starting dynamic subtest: vcs1
[603.160156] Dynamic subtest vcs1: SUCCESS (0.112s)
[603.173288] Starting dynamic subtest: vecs0
[603.269000] Dynamic subtest vecs0: SUCCESS (0.108s)
[603.282240] Starting dynamic subtest: ccs0
[603.408902] Dynamic subtest ccs0: SUCCESS (0.139s)
[603.411773] Subtest implicit-boths: SUCCESS (0.656s)
[604.291031] [130/131] (417s left) kms_scaling_modes (scaling-mode-full)
[604.394881] Starting subtest: scaling-mode-full
[604.396992] Starting dynamic subtest: pipe-A-eDP-1
[604.488466] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[604.498749] Starting dynamic subtest: pipe-B-eDP-1
[605.627172] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[605.639585] Starting dynamic subtest: pipe-C-eDP-1
[606.734304] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[606.745265] Starting dynamic subtest: pipe-D-eDP-1
[607.866530] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[607.868706] Subtest scaling-mode-full: SUCCESS (3.472s)
[609.143157] [131/131] (412s left) gem_softpin (softpin)
[609.210249] Starting subtest: softpin
[641.509021] Subtest softpin: SUCCESS (32.284s)
[641.648490] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: gen3_mixed_blits
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: gem_pwrite
results: parsing output: 11/ for test: gem_workarounds
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: gem_workarounds
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_invalid_mode
results: parsing output: 16/ for test: kms_plane_cursor
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_engines
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_vrr
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: gem_exec_async
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: dumb_buffer
results: parsing output: 36/ for test: sysfs_timeslice_duration
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: gem_pipe_control_store_loop
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: dumb_buffer
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_fence_thrash
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_plane_scaling
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: syncobj_basic
results: parsing output: 60/ for test: kms_feature_discovery
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: prime_mmap_kms
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: gem_ctx_param
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_force_connector_basic
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: gem_flink_race
results: parsing output: 74/ for test: gem_exec_params
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: drm_read
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_basic
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: gem_vm_create
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: vgem_basic
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: gem_partial_pwrite_pread
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: gem_set_tiling_vs_gtt
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_pwrite_crc
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_writeback
results: parsing output: 104/ for test: kms_async_flips
results: parsing output: 105/ for test: gem_media_fill
results: parsing output: 106/ for test: kms_properties
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_busy
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: i915_pm_rpm
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: gem_fence_thrash
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_scaling_modes
results: parsing output: 130/ for test: gem_softpin
Done.