[60.110907] Initializing watchdogs
[60.111061]   /dev/watchdog0
[60.130547] [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]
[60.135853] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.138095] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.141531] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[60.273803] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[60.277843] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[60.379164] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[60.477840] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[60.482287] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[60.575255] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[60.673249] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[61.374805] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.703s)
[61.580234] [004/133] (959s left) gen7_exec_parse (basic-offset)
[61.648273] Subtest basic-offset: SKIP (0.000s)
[61.724554] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[61.817483] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[66.158337] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.343s)
[67.340613] [006/133] (953s left) tools_test (tools_test)
[67.413723] Starting subtest: tools_test
[67.526098] Subtest tools_test: SUCCESS (0.131s)
[67.631311] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[67.768091] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[67.772818] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[68.854937] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[68.947863] Starting subtest: modeset-vs-vblank-race
[68.950018] Starting dynamic subtest: A-eDP1
[73.685052] Dynamic subtest A-eDP1: SUCCESS (4.736s)
[73.693094] Starting dynamic subtest: B-eDP1
[78.408893] Dynamic subtest B-eDP1: SUCCESS (4.723s)
[78.423024] Starting dynamic subtest: C-eDP1
[83.108283] Dynamic subtest C-eDP1: SUCCESS (4.698s)
[83.118268] Starting dynamic subtest: D-eDP1
[87.715317] Dynamic subtest D-eDP1: SUCCESS (4.606s)
[87.719974] Subtest modeset-vs-vblank-race: SUCCESS (18.772s)
[88.873254] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[91.008217] Starting subtest: reg-read-ioctl
[93.408382] Subtest reg-read-ioctl: SUCCESS (2.401s)
[93.776781] [010/133] (927s left) gem_exec_balancer (hang)
[94.057763] Starting subtest: hang
[95.899445] Subtest hang: SUCCESS (1.842s)
[96.016924] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[96.113973] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[96.118087] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[96.183400] [012/133] (924s left) perf_pmu (faulting-read)
[96.224250] Starting subtest: faulting-read
[96.226559] Starting dynamic subtest: wb
[96.228921] Dynamic subtest wb: SUCCESS (0.001s)
[96.238256] Starting dynamic subtest: wc
[96.240066] Dynamic subtest wc: SUCCESS (0.000s)
[96.247707] Starting dynamic subtest: uc
[96.249615] Dynamic subtest uc: SUCCESS (0.000s)
[96.251472] Subtest faulting-read: SUCCESS (0.002s)
[96.331770] [013/133] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[96.419572] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[96.423728] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[96.507671] [014/133] (924s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[96.894387] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[97.681347] [015/133] (923s left) gem_exec_schedule (pi-distinct-iova)
[97.858052] Starting subtest: pi-distinct-iova
[97.860774] Starting dynamic subtest: rcs0
[97.934120] Dynamic subtest rcs0: SUCCESS (0.079s)
[97.945593] Starting dynamic subtest: vcs0
[97.994958] Dynamic subtest vcs0: SUCCESS (0.061s)
[98.007035] Starting dynamic subtest: vcs1
[98.062919] Dynamic subtest vcs1: SUCCESS (0.068s)
[98.074849] Starting dynamic subtest: vecs0
[98.119266] Dynamic subtest vecs0: SUCCESS (0.056s)
[98.130661] Starting dynamic subtest: ccs0
[98.177667] Dynamic subtest ccs0: SUCCESS (0.058s)
[98.180094] Subtest pi-distinct-iova: SUCCESS (0.323s)
[100.007732] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[100.103845] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[100.108276] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[100.188597] [017/133] (921s left) drm_read (short-buffer-block)
[100.339097] Starting subtest: short-buffer-block
[100.341581] Subtest short-buffer-block: SUCCESS (0.000s)
[100.451911] [018/133] (920s left) perf (oa-formats)
[100.576733] Starting subtest: oa-formats
[100.579270] Starting dynamic subtest: 0-rcs0
[100.589681] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[100.600850] Starting dynamic subtest: 1-vecs0
[100.611670] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[100.614295] Subtest oa-formats: SUCCESS (0.037s)
[100.658879] [019/133] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[100.752473] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[100.756607] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[100.843429] [020/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[100.940453] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[100.944955] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.032375] [021/133] (920s left) kms_psr (pr-basic)
[101.128884] Starting subtest: pr-basic
[101.132649] Subtest pr-basic: SKIP (0.000s)
[101.197902] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[101.284066] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[101.286131] Starting dynamic subtest: pipe-A-eDP-1
[101.304944] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.313434] Starting dynamic subtest: pipe-B-eDP-1
[101.330599] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.338478] Starting dynamic subtest: pipe-C-eDP-1
[101.355462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.363562] Starting dynamic subtest: pipe-D-eDP-1
[101.380970] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.384175] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[103.476332] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[103.879059] Subtest hdmi-mode-timings: SKIP (0.000s)
[104.688042] [024/133] (916s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[104.834998] Starting subtest: dp-mst-lic-type-0-hdcp14
[104.839458] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[104.959389] [025/133] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[105.067686] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[105.071831] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[105.134411] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[105.225958] Starting subtest: primary-4-tiled-reflect-x-180
[112.222570] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.999s)
[113.387160] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[113.492577] Starting subtest: 2x-flip-vs-panning-interruptible
[113.504419] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[113.576831] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[113.660430] Starting subtest: plain-flip-fb-recreate
[113.662737] Starting dynamic subtest: A-eDP1
[122.580757] Dynamic subtest A-eDP1: SUCCESS (8.918s)
[122.591097] Starting dynamic subtest: B-eDP1
[131.420939] Dynamic subtest B-eDP1: SUCCESS (8.840s)
[131.429068] Starting dynamic subtest: C-eDP1
[140.327879] Dynamic subtest C-eDP1: SUCCESS (8.905s)
[140.342075] Starting dynamic subtest: D-eDP1
[149.155495] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[149.159680] Subtest plain-flip-fb-recreate: SUCCESS (35.501s)
[150.337381] [029/133] (871s left) gem_tiled_partial_pwrite_pread (writes)
[150.404198] Subtest writes: SKIP (0.000s)
[150.476238] [030/133] (871s left) gem_lmem_swapping (heavy-verify-random)
[150.524857] Subtest heavy-verify-random: SKIP (0.000s)
[150.564554] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[150.661413] Starting subtest: x-tiled-64bpp-rotate-90
[150.680463] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[150.781090] [032/133] (871s left) vgem_basic (debugfs)
[150.892080] Starting subtest: debugfs
[150.894413] Subtest debugfs: SUCCESS (0.000s)
[150.949570] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[150.953034] [033/133] (870s left) kms_atomic_interruptible (legacy-setmode)
[151.036964] Starting subtest: legacy-setmode
[151.039204] Starting dynamic subtest: pipe-A-eDP-1
[157.930218] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.893s)
[157.932435] Subtest legacy-setmode: SUCCESS (6.894s)
[158.818051] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[158.931772] Starting subtest: reject-modify-context-protection-off-2
[158.934078] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[159.046101] [035/133] (862s left) gem_exec_basic (basic)
[159.101177] Starting subtest: basic
[159.103098] Starting dynamic subtest: rcs0-smem
[159.105384] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[159.118951] Starting dynamic subtest: bcs0-smem
[159.120911] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[159.128831] Starting dynamic subtest: vcs0-smem
[159.130742] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[159.138677] Starting dynamic subtest: vcs1-smem
[159.140600] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[159.148594] Starting dynamic subtest: vecs0-smem
[159.150546] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[159.158635] Starting dynamic subtest: ccs0-smem
[159.160584] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[159.162497] Subtest basic: SUCCESS (0.014s)
[160.956119] [036/133] (861s left) api_intel_bb (offset-control)
[161.018508] Starting subtest: offset-control
[161.031676] Subtest offset-control: SUCCESS (0.015s)
[161.167656] [037/133] (860s left) kms_joiner (basic-max-non-joiner)
[161.264417] Starting subtest: basic-max-non-joiner
[161.268312] Subtest basic-max-non-joiner: SKIP (0.000s)
[161.330081] [038/133] (860s left) kms_addfb_basic (small-bo)
[161.426064] Starting subtest: small-bo
[161.428193] Subtest small-bo: SUCCESS (0.000s)
[161.517265] [039/133] (860s left) i915_query (query-topology-garbage-items)
[161.567034] Starting subtest: query-topology-garbage-items
[161.569415] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[161.651447] [040/133] (860s left) perf (gen12-group-exclusive-stream-ctx-handle)
[161.741630] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[161.764909] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.021s)
[161.805784] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[162.913255] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[162.917228] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[163.002221] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[163.056249] Starting subtest: cliprects-invalid
[163.058588] Subtest cliprects-invalid: SUCCESS (0.000s)
[163.177728] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[163.356725] Starting subtest: cursor-random-64x64
[163.361875] Starting dynamic subtest: pipe-A-eDP-1
[166.692072] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.331s)
[166.720107] Starting dynamic subtest: pipe-D-eDP-1
[170.756756] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.042s)
[170.758681] Subtest cursor-random-64x64: SUCCESS (7.397s)
[171.563673] [044/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[171.674642] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[171.679040] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[171.768457] [045/133] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[171.865715] Starting subtest: 4-tiled-16bpp-rotate-180
[173.222684] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.357s)
[173.343508] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[173.400741] Starting subtest: create-valid-dumb
[173.402854] Subtest create-valid-dumb: SUCCESS (0.000s)
[173.502375] [047/133] (849s left) gem_softpin (zero)
[173.557929] Starting subtest: zero
[173.565731] Subtest zero: SUCCESS (0.008s)
[173.679324] [048/133] (848s left) gem_blits (basic)
[173.750018] Starting subtest: basic
[175.103068] Subtest basic: SUCCESS (1.352s)
[175.210941] [049/133] (847s left) gem_busy (close-race)
[175.272767] Starting subtest: close-race
[200.852861] Subtest close-race: SUCCESS (25.577s)
[201.238778] [050/133] (821s left) gem_exec_alignment (forked)
[201.354632] Starting subtest: forked
[240.373847] Subtest forked: SUCCESS (39.016s)
[240.451296] [051/133] (782s left) syncobj_eventfd (binary-wait-before-signal)
[240.561537] Starting subtest: binary-wait-before-signal
[240.589273] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[240.669932] [052/133] (782s left) prime_mmap (test_errors)
[240.733255] Starting subtest: test_errors
[240.735557] Starting dynamic subtest: test_errors-smem
[240.829603] Dynamic subtest test_errors-smem: SUCCESS (0.098s)
[240.832271] Subtest test_errors: SUCCESS (0.099s)
[240.949135] [053/133] (781s left) gem_ctx_persistence (heartbeat-stop)
[241.010107] Starting subtest: heartbeat-stop
[241.014703] Subtest heartbeat-stop: SKIP (0.000s)
[241.153083] [054/133] (781s left) gem_ctx_param (invalid-get-ringsize)
[241.214437] Starting subtest: invalid-get-ringsize
[241.216845] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[241.324543] [055/133] (781s left) i915_query (query-topology-matches-eu-total)
[241.389770] Starting subtest: query-topology-matches-eu-total
[241.391912] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[241.491306] [056/133] (781s left) kms_cursor_edge_walk (64x64-right-edge)
[241.590159] Starting subtest: 64x64-right-edge
[241.591966] Starting dynamic subtest: pipe-A-eDP-1
[245.007193] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s)
[245.018032] Starting dynamic subtest: pipe-D-eDP-1
[248.135881] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[248.137876] Subtest 64x64-right-edge: SUCCESS (6.545s)
[248.933620] [057/133] (774s left) kms_plane (plane-position-covered)
[249.041027] Starting subtest: plane-position-covered
[249.553524] Starting dynamic subtest: pipe-A-plane-1
[250.815208] Dynamic subtest pipe-A-plane-1: SUCCESS (1.264s)
[250.825488] Starting dynamic subtest: pipe-A-plane-2
[252.108961] Dynamic subtest pipe-A-plane-2: SUCCESS (1.293s)
[252.119369] Starting dynamic subtest: pipe-A-plane-3
[253.422206] Dynamic subtest pipe-A-plane-3: SUCCESS (1.310s)
[253.431896] Starting dynamic subtest: pipe-A-plane-4
[254.740888] Dynamic subtest pipe-A-plane-4: SUCCESS (1.316s)
[254.750553] Starting dynamic subtest: pipe-A-plane-5
[254.765517] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[255.968291] Starting dynamic subtest: pipe-B-plane-1
[257.202625] Dynamic subtest pipe-B-plane-1: SUCCESS (1.245s)
[257.213174] Starting dynamic subtest: pipe-B-plane-2
[258.448068] Dynamic subtest pipe-B-plane-2: SUCCESS (1.247s)
[258.457677] Starting dynamic subtest: pipe-B-plane-3
[259.807156] Dynamic subtest pipe-B-plane-3: SUCCESS (1.358s)
[259.818059] Starting dynamic subtest: pipe-B-plane-4
[261.134528] Dynamic subtest pipe-B-plane-4: SUCCESS (1.326s)
[261.144662] Starting dynamic subtest: pipe-B-plane-5
[261.161758] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[261.164063] Subtest plane-position-covered: SUCCESS (12.120s)
[262.003115] [058/133] (761s left) kms_frontbuffer_tracking (psr-suspend)
[262.111467] Starting subtest: psr-suspend
[300.353526] Subtest psr-suspend: SUCCESS (8.128s)
[300.513266] [059/133] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[300.605860] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[300.609965] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[300.722111] [060/133] (722s left) gem_exec_schedule (fairslice)
[300.785820] Starting subtest: fairslice
[300.788052] Starting dynamic subtest: rcs0
[302.800682] Dynamic subtest rcs0: SUCCESS (2.020s)
[302.812493] Starting dynamic subtest: bcs0
[304.821371] Dynamic subtest bcs0: SUCCESS (2.016s)
[304.832811] Starting dynamic subtest: vcs0
[306.842325] Dynamic subtest vcs0: SUCCESS (2.019s)
[306.854568] Starting dynamic subtest: vcs1
[308.856912] Dynamic subtest vcs1: SUCCESS (2.013s)
[308.869672] Starting dynamic subtest: vecs0
[310.875821] Dynamic subtest vecs0: SUCCESS (2.017s)
[310.888046] Starting dynamic subtest: ccs0
[312.900279] Dynamic subtest ccs0: SUCCESS (2.019s)
[312.902297] Subtest fairslice: SUCCESS (12.109s)
[313.197109] [061/133] (709s left) sw_sync (alloc_fence_invalid_timeline)
[313.239196] Starting subtest: alloc_fence_invalid_timeline
[313.241613] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[313.298353] [062/133] (709s left) gem_exec_whisper (basic-fds-forked)
[313.350534] Starting subtest: basic-fds-forked
[337.458919] Subtest basic-fds-forked: SUCCESS (24.105s)
[337.650966] [063/133] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[337.757863] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[337.762451] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[337.861457] [064/133] (685s left) gem_vm_create (execbuf)
[337.915466] Starting subtest: execbuf
[337.923468] Subtest execbuf: SUCCESS (0.008s)
[338.047794] [065/133] (685s left) kms_cursor_crc (cursor-onscreen-256x85)
[338.303160] Starting subtest: cursor-onscreen-256x85
[338.351439] Subtest cursor-onscreen-256x85: SKIP (0.045s)
[338.538116] [066/133] (684s left) kms_plane_alpha_blend (coverage-7efc)
[338.627511] Starting subtest: coverage-7efc
[338.929515] Starting dynamic subtest: pipe-A-eDP-1
[339.516969] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[339.543941] Starting dynamic subtest: pipe-D-eDP-1
[340.877022] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[340.879404] Subtest coverage-7efc: SUCCESS (2.249s)
[341.724036] [067/133] (681s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[341.833291] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[341.835710] Starting dynamic subtest: pipe-A
[341.855073] Dynamic subtest pipe-A: SKIP (0.018s)
[341.866525] Starting dynamic subtest: pipe-B
[341.891916] Dynamic subtest pipe-B: SKIP (0.035s)
[341.905051] Starting dynamic subtest: pipe-C
[341.922681] Dynamic subtest pipe-C: SKIP (0.032s)
[341.933851] Starting dynamic subtest: pipe-D
[341.955113] Dynamic subtest pipe-D: SKIP (0.031s)
[341.958874] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.119s)
[342.053611] [068/133] (681s left) vgem_basic (busy-fence)
[342.101952] Starting subtest: busy-fence
[342.104272] Subtest busy-fence: SUCCESS (0.000s)
[342.160332] [069/133] (681s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[342.253390] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[342.283298] Starting dynamic subtest: pipe-A-plane-0
[342.704078] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[342.714456] Starting dynamic subtest: pipe-A-plane-3
[342.970949] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[342.983019] Starting dynamic subtest: pipe-A-plane-5
[342.986958] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[344.094592] Starting dynamic subtest: pipe-B-plane-0
[344.516510] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[344.527255] Starting dynamic subtest: pipe-B-plane-3
[344.772963] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[344.795365] Starting dynamic subtest: pipe-B-plane-5
[344.799669] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[345.082357] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.829s)
[345.963669] [070/133] (677s left) kms_addfb_basic (invalid-set-prop-any)
[346.029550] Starting subtest: invalid-set-prop-any
[346.031776] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[346.174398] [071/133] (677s left) kms_addfb_basic (size-max)
[346.266002] Starting subtest: size-max
[346.267833] Subtest size-max: SUCCESS (0.000s)
[346.360992] [072/133] (677s left) kms_addfb_basic (bad-pitch-128)
[346.417010] Starting subtest: bad-pitch-128
[346.418829] Subtest bad-pitch-128: SUCCESS (0.000s)
[346.553542] [073/133] (677s left) syncobj_timeline (single-wait-available-submitted)
[346.609851] Starting subtest: single-wait-available-submitted
[346.612258] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[346.721825] [074/133] (677s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[346.821053] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[347.826940] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.006s)
[347.976511] [075/133] (675s left) gem_pread (exhaustion)
[348.035288] Subtest exhaustion: SKIP (0.000s)
[348.132203] [076/133] (675s left) kms_frontbuffer_tracking (psr-1p-rte)
[348.231369] Starting subtest: psr-1p-rte
[353.684727] Subtest psr-1p-rte: SUCCESS (5.456s)
[353.823980] [077/133] (670s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[353.942741] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[371.367755] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.423s)
[372.162714] [078/133] (651s left) api_intel_allocator (fork-simple-once)
[372.220642] Starting subtest: fork-simple-once
[372.235177] Subtest fork-simple-once: SUCCESS (0.017s)
[372.349179] [079/133] (651s left) gem_set_tiling_vs_pwrite
[372.489318] [080/133] (651s left) kms_pm_backlight (brightness-with-dpms)
[372.589271] Starting subtest: brightness-with-dpms
[372.643091] Starting dynamic subtest: eDP-1
[375.071834] Dynamic subtest eDP-1: SUCCESS (2.428s)
[375.074195] Subtest brightness-with-dpms: SUCCESS (2.483s)
[375.936594] [081/133] (648s left) kms_lease (lease-invalid-crtc)
[376.025240] Starting subtest: lease-invalid-crtc
[376.027457] Starting dynamic subtest: pipe-A-eDP-1
[376.029724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[376.040002] Starting dynamic subtest: pipe-B-eDP-1
[376.042470] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[376.052593] Starting dynamic subtest: pipe-C-eDP-1
[376.054781] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[376.065304] Starting dynamic subtest: pipe-D-eDP-1
[376.067453] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[376.069664] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[376.109278] [082/133] (648s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[376.215206] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[376.219538] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[376.319960] [083/133] (647s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[376.416758] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[383.418819] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.003s)
[383.572414] [084/133] (640s left) kms_dp_linktrain_fallback (dp-fallback)
[383.665395] Starting subtest: dp-fallback
[383.671678] Subtest dp-fallback: SKIP (0.000s)
[383.741991] [085/133] (640s left) kms_vblank (ts-continuation-idle)
[383.835253] Starting subtest: ts-continuation-idle
[383.837573] Starting dynamic subtest: pipe-A-eDP-1
[384.232899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[384.248754] Starting dynamic subtest: pipe-D-eDP-1
[385.366966] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[385.369437] Subtest ts-continuation-idle: SUCCESS (1.532s)
[386.243128] [086/133] (638s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[386.341349] Starting subtest: fbc-psr-cursor-mmap-gtt
[386.343553] Starting dynamic subtest: eDP-1
[386.347622] Dynamic subtest eDP-1: SKIP (0.000s)
[386.351671] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[386.416557] [087/133] (637s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[386.538624] Starting subtest: cursor-vs-flip-varying-size
[417.853734] Subtest cursor-vs-flip-varying-size: SUCCESS (31.312s)
[418.665187] [088/133] (605s left) i915_drm_fdinfo (busy-check-all)
[418.714675] Starting subtest: busy-check-all
[418.717264] Starting dynamic subtest: rcs0
[418.722481] Dynamic subtest rcs0: SKIP (0.003s)
[418.734307] Starting dynamic subtest: bcs0
[418.738530] Dynamic subtest bcs0: SKIP (0.000s)
[418.748482] Starting dynamic subtest: vcs0
[418.752933] Dynamic subtest vcs0: SKIP (0.000s)
[418.762602] Starting dynamic subtest: vcs1
[418.767143] Dynamic subtest vcs1: SKIP (0.000s)
[418.777088] Starting dynamic subtest: vecs0
[418.781622] Dynamic subtest vecs0: SKIP (0.000s)
[418.791678] Starting dynamic subtest: ccs0
[418.796189] Dynamic subtest ccs0: SKIP (0.000s)
[418.800832] Subtest busy-check-all: SKIP (0.008s)
[418.840632] [089/133] (605s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[418.969121] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[418.971329] Starting dynamic subtest: pipe-A-eDP-1
[418.991032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[419.001398] Starting dynamic subtest: pipe-B-eDP-1
[419.019592] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[419.029932] Starting dynamic subtest: pipe-C-eDP-1
[419.048477] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[419.059276] Starting dynamic subtest: pipe-D-eDP-1
[419.078514] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[419.080698] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[421.224293] [090/133] (603s left) prime_busy (before-wait)
[421.286755] Starting subtest: before-wait
[421.291382] Starting dynamic subtest: rcs0
[421.321245] Dynamic subtest rcs0: SUCCESS (0.032s)
[421.331592] Starting dynamic subtest: bcs0
[421.367021] Dynamic subtest bcs0: SUCCESS (0.044s)
[421.379008] Starting dynamic subtest: vcs0
[421.406623] Dynamic subtest vcs0: SUCCESS (0.039s)
[421.416374] Starting dynamic subtest: vcs1
[421.447158] Dynamic subtest vcs1: SUCCESS (0.040s)
[421.457146] Starting dynamic subtest: vecs0
[421.488169] Dynamic subtest vecs0: SUCCESS (0.040s)
[421.498940] Starting dynamic subtest: ccs0
[421.528546] Dynamic subtest ccs0: SUCCESS (0.040s)
[421.636960] Subtest before-wait: SUCCESS (0.349s)
[421.716631] [091/133] (602s left) gem_ppgtt (blt-vs-render-ctx0)
[421.781922] Starting subtest: blt-vs-render-ctx0
[454.507541] Subtest blt-vs-render-ctx0: SUCCESS (32.724s)
[454.659293] [092/133] (569s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[454.817750] Starting subtest: cursorB-vs-flipB-atomic
[454.822364] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[454.965214] [093/133] (569s left) gem_exec_reloc (basic-wc-read-active)
[455.037268] Subtest basic-wc-read-active: SKIP (0.000s)
[455.110707] [094/133] (569s left) gem_exec_fence (syncobj-import)
[455.566661] Starting subtest: syncobj-import
[455.571491] Subtest syncobj-import: SUCCESS (0.005s)
[457.106449] [095/133] (567s left) kms_psr (fbc-psr2-sprite-blt)
[457.192379] Starting subtest: fbc-psr2-sprite-blt
[457.194522] Starting dynamic subtest: eDP-1
[457.198436] Dynamic subtest eDP-1: SKIP (0.000s)
[457.202379] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[457.266258] [096/133] (567s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[457.362078] Starting subtest: plane-lut1d-post-ctm3x4
[457.499743] Starting dynamic subtest: pipe-A-plane-0
[457.676902] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[457.687922] Starting dynamic subtest: pipe-A-plane-1
[457.821735] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[457.833557] Starting dynamic subtest: pipe-A-plane-2
[457.966492] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[459.099678] Starting dynamic subtest: pipe-B-plane-0
[459.257545] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[459.268381] Starting dynamic subtest: pipe-B-plane-1
[459.401739] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[459.412478] Starting dynamic subtest: pipe-B-plane-2
[459.546272] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[460.750895] Starting dynamic subtest: pipe-C-plane-0
[460.908391] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[460.919429] Starting dynamic subtest: pipe-C-plane-1
[461.063630] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[461.074717] Starting dynamic subtest: pipe-C-plane-2
[461.208576] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[462.355027] Starting dynamic subtest: pipe-D-plane-0
[462.501058] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[462.511834] Starting dynamic subtest: pipe-D-plane-1
[462.646860] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[462.657437] Starting dynamic subtest: pipe-D-plane-2
[462.790292] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[463.081375] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.720s)
[463.946170] [097/133] (560s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[464.012994] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[464.017702] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[464.199884] [098/133] (560s left) kms_big_fb (linear-8bpp-rotate-180)
[464.307735] Starting subtest: linear-8bpp-rotate-180
[465.565905] Subtest linear-8bpp-rotate-180: SUCCESS (1.259s)
[465.702674] [099/133] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[465.797756] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[465.801469] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[465.907638] [100/133] (559s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[466.011253] Starting subtest: extended-modeset-hang-oldfb-with-reset
[466.013174] Starting dynamic subtest: pipe-A
[477.520297] Dynamic subtest pipe-A: SUCCESS (11.505s)
[477.531433] Starting dynamic subtest: pipe-D
[489.796012] Dynamic subtest pipe-D: SUCCESS (12.273s)
[489.798314] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.782s)
[490.597982] [101/133] (534s left) gem_exec_schedule (timeslicing)
[490.678828] Starting subtest: timeslicing
[490.681293] Starting dynamic subtest: rcs0
[490.689594] Dynamic subtest rcs0: SUCCESS (0.021s)
[490.702107] Starting dynamic subtest: bcs0
[490.710888] Dynamic subtest bcs0: SUCCESS (0.021s)
[490.721728] Starting dynamic subtest: vcs0
[490.732084] Dynamic subtest vcs0: SUCCESS (0.020s)
[490.743417] Starting dynamic subtest: vcs1
[490.753758] Dynamic subtest vcs1: SUCCESS (0.021s)
[490.765072] Starting dynamic subtest: vecs0
[490.774919] Dynamic subtest vecs0: SUCCESS (0.020s)
[490.786104] Starting dynamic subtest: ccs0
[490.794624] Dynamic subtest ccs0: SUCCESS (0.019s)
[490.797000] Subtest timeslicing: SUCCESS (0.127s)
[492.065724] [102/133] (532s left) kms_chamelium_color (ctm-0-25)
[492.168566] Subtest ctm-0-25: SKIP (0.000s)
[492.219161] [103/133] (532s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[492.319305] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[492.321647] Starting dynamic subtest: pipe-A-eDP-1
[492.414118] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[492.426561] Starting dynamic subtest: pipe-B-eDP-1
[493.567368] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s)
[493.572008] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.253s)
[494.755989] [104/133] (530s left) gem_mmap (short-mmap)
[494.832442] Subtest short-mmap: SKIP (0.000s)
[494.899001] [105/133] (530s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[494.955882] Starting subtest: multi-wait-available-unsubmitted-submitted
[494.957985] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[495.043855] [106/133] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[495.159548] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[495.163533] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[495.262722] [107/133] (530s left) kms_getfb (getfb2-accept-nv12)
[495.358172] Starting subtest: getfb2-accept-nv12
[495.360418] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[495.464374] [108/133] (529s left) syncobj_timeline (invalid-signal-zero-handles)
[495.520100] Starting subtest: invalid-signal-zero-handles
[495.522421] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[495.620069] [109/133] (529s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[495.701117] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[495.704828] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[495.773462] [110/133] (529s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[495.861772] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[495.863656] Starting dynamic subtest: pipe-A-eDP-1
[495.912046] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[495.922487] Starting dynamic subtest: pipe-B-eDP-1
[495.968801] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[495.979310] Starting dynamic subtest: pipe-C-eDP-1
[496.025924] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[496.035932] Starting dynamic subtest: pipe-D-eDP-1
[496.082058] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[496.085736] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[498.110202] [111/133] (527s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[498.204581] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[498.215971] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[498.333750] [112/133] (527s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[498.427340] Starting subtest: async-flip-with-page-flip-events-tiled
[498.798148] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[501.579755] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.780s)
[501.591286] Starting dynamic subtest: pipe-A-eDP-1-4
[503.754557] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[503.765119] Starting dynamic subtest: pipe-A-eDP-1-4
[505.764766] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[505.778108] Starting dynamic subtest: pipe-A-eDP-1-x
[507.955701] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[508.328049] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[511.109430] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[511.121445] Starting dynamic subtest: pipe-B-eDP-1-4
[513.295593] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[513.309090] Starting dynamic subtest: pipe-B-eDP-1-4
[515.305865] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[515.320015] Starting dynamic subtest: pipe-B-eDP-1-x
[517.495284] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[517.867303] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[520.640933] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[520.659345] Starting dynamic subtest: pipe-C-eDP-1-4
[522.815285] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[522.828698] Starting dynamic subtest: pipe-C-eDP-1-4
[524.826197] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[524.839713] Starting dynamic subtest: pipe-C-eDP-1-x
[527.004471] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[527.372443] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[530.176836] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[530.187787] Starting dynamic subtest: pipe-D-eDP-1-4
[532.350706] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[532.361562] Starting dynamic subtest: pipe-D-eDP-1-4
[534.361144] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[534.372108] Starting dynamic subtest: pipe-D-eDP-1-x
[536.539864] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[536.542314] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.112s)
[537.764769] [113/133] (487s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[537.880572] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[537.885044] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[537.980689] [114/133] (487s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[538.043072] Starting subtest: etime-multi-wait-for-submit-submitted
[538.149683] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[538.231910] [115/133] (487s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[540.150759] Starting subtest: modeset-non-lpsp-stress-no-wait
[540.212011] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.059s)
[540.547331] [116/133] (485s left) gem_exec_params (sol-reset-invalid)
[540.598973] Starting subtest: sol-reset-invalid
[540.601462] Subtest sol-reset-invalid: SUCCESS (0.002s)
[542.060338] [117/133] (483s left) gem_mmap_gtt (cpuset-big-copy)
[542.115791] Subtest cpuset-big-copy: SKIP (0.000s)
[542.172550] [118/133] (483s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[542.280125] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[549.927010] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.650s)
[550.047005] [119/133] (475s left) kms_psr (psr2-sprite-plane-onoff)
[550.137483] Starting subtest: psr2-sprite-plane-onoff
[550.139686] Starting dynamic subtest: eDP-1
[551.911591] Dynamic subtest eDP-1: SUCCESS (1.775s)
[551.913889] Subtest psr2-sprite-plane-onoff: SUCCESS (1.776s)
[552.745377] [120/133] (473s left) kms_dsc (dsc-with-output-formats)
[552.845275] Starting subtest: dsc-with-output-formats
[552.867285] Subtest dsc-with-output-formats: SKIP (0.000s)
[552.921782] [121/133] (472s left) gen3_mixed_blits
[553.044148] [122/133] (472s left) gem_mmap_offset (clear-via-pagefault)
[553.090877] Starting subtest: clear-via-pagefault
[553.092821] Starting dynamic subtest: smem0
[587.351743] Dynamic subtest smem0: SUCCESS (34.256s)
[587.353962] Subtest clear-via-pagefault: SUCCESS (34.257s)
[587.461715] [123/133] (438s left) gem_eio (reset-stress)
[587.702729] Starting subtest: reset-stress
[587.704651] Starting dynamic subtest: render
[592.814175] Dynamic subtest render: SUCCESS (5.109s)
[592.831673] Starting dynamic subtest: bsd1
[610.572556] Dynamic subtest bsd1: SUCCESS (17.756s)
[610.591241] Starting dynamic subtest: bsd2
[628.554908] Dynamic subtest bsd2: SUCCESS (17.979s)
[628.572761] Starting dynamic subtest: blt
[628.577065] Dynamic subtest blt: SKIP (0.000s)
[628.587763] Starting dynamic subtest: vebox
[646.530251] Dynamic subtest vebox: SUCCESS (17.973s)
[646.532310] Subtest reset-stress: SUCCESS (58.823s)
[648.045279] [124/133] (377s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[648.103597] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[648.106006] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[648.226266] [125/133] (377s left) kms_vblank (query-busy-hang)
[648.317368] Starting subtest: query-busy-hang
[648.319679] Starting dynamic subtest: pipe-A-eDP-1
[650.198556] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[650.214104] Starting dynamic subtest: pipe-D-eDP-1
[652.801130] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.597s)
[652.803648] Subtest query-busy-hang: SUCCESS (4.483s)
[653.609553] [126/133] (372s left) kms_psr (fbc-pr-cursor-plane-onoff)
[653.713647] Starting subtest: fbc-pr-cursor-plane-onoff
[653.718079] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[653.789876] [127/133] (372s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[653.878507] Starting subtest: psr-1p-primscrn-cur-indfb-move
[661.256552] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.380s)
[661.408992] [128/133] (364s left) tools_test (sysfs_l3_parity)
[661.466161] Starting subtest: sysfs_l3_parity
[661.523959] Subtest sysfs_l3_parity: SKIP (0.070s)
[661.581111] [129/133] (364s left) kms_vblank (crtc-id)
[661.682049] Starting subtest: crtc-id
[661.683876] Starting dynamic subtest: pipe-A-eDP-1
[662.124906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[662.140134] Starting dynamic subtest: pipe-D-eDP-1
[663.240839] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.113s)
[663.243040] Subtest crtc-id: SUCCESS (1.559s)
[664.081889] [130/133] (362s left) gem_ctx_engines (independent)
[664.144285] Starting subtest: independent
[664.146622] Starting dynamic subtest: rcs0
[664.298286] Dynamic subtest rcs0: SUCCESS (0.152s)
[664.308984] Starting dynamic subtest: bcs0
[664.474650] Dynamic subtest bcs0: SUCCESS (0.175s)
[664.486536] Starting dynamic subtest: vcs0
[664.649771] Dynamic subtest vcs0: SUCCESS (0.175s)
[664.661924] Starting dynamic subtest: vcs1
[664.824759] Dynamic subtest vcs1: SUCCESS (0.174s)
[664.836015] Starting dynamic subtest: vecs0
[665.010853] Dynamic subtest vecs0: SUCCESS (0.185s)
[665.022897] Starting dynamic subtest: ccs0
[665.186716] Dynamic subtest ccs0: SUCCESS (0.175s)
[665.199259] Starting dynamic subtest: all-engines
[665.788165] Dynamic subtest all-engines: SUCCESS (0.601s)
[665.790682] Subtest independent: SUCCESS (1.644s)
[666.208133] [131/133] (360s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[666.311285] Starting subtest: flip-vs-dpms-on-nop-interruptible
[666.313508] Starting dynamic subtest: A-eDP1
[668.162507] Dynamic subtest A-eDP1: SUCCESS (1.849s)
[668.177400] Starting dynamic subtest: B-eDP1
[669.993243] Dynamic subtest B-eDP1: SUCCESS (1.829s)
[670.007507] Starting dynamic subtest: C-eDP1
[671.809287] Dynamic subtest C-eDP1: SUCCESS (1.814s)
[671.821032] Starting dynamic subtest: D-eDP1
[673.636600] Dynamic subtest D-eDP1: SUCCESS (1.824s)
[673.641645] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.328s)
[674.822072] [132/133] (351s left) kms_plane_lowres (tiling-x)
[674.909242] Starting subtest: tiling-x
[674.911548] Starting dynamic subtest: pipe-A-eDP-1
[674.916300] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[675.206310] Starting dynamic subtest: pipe-B-eDP-1
[675.211020] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[675.222294] Starting dynamic subtest: pipe-C-eDP-1
[675.227088] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[675.237664] Starting dynamic subtest: pipe-D-eDP-1
[675.241916] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[675.246112] Subtest tiling-x: SKIP (0.294s)
[676.051212] [133/133] (350s left) i915_pm_freq_api (freq-reset)
[676.118944] Starting subtest: freq-reset
[676.121829] Starting dynamic subtest: gt0
[676.311126] Dynamic subtest gt0: SUCCESS (0.191s)
[676.323514] Starting dynamic subtest: gt1
[676.485118] Dynamic subtest gt1: SUCCESS (0.172s)
[676.488095] Subtest freq-reset: SUCCESS (0.365s)
[676.560435] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_pm_rpm
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: drm_read
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_atomic_interruptible
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: gem_exec_basic
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: dumb_buffer
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: gem_blits
results: parsing output: 48/ for test: gem_busy
results: parsing output: 49/ for test: gem_exec_alignment
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_vm_create
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_pread
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_dp_linktrain_fallback
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: prime_busy
results: parsing output: 90/ for test: gem_ppgtt
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_mmap
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_dsc
results: parsing output: 120/ for test: gen3_mixed_blits
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: tools_test
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_plane_lowres
results: parsing output: 132/ for test: i915_pm_freq_api
Done.