[59.666284] Initializing watchdogs
[59.666331]   /dev/watchdog0
[59.680775] [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]
[59.685248] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.687495] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.690863] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[59.826052] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[59.830298] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[59.933339] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[60.035206] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[60.039576] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[60.124191] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[60.235567] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[60.917694] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.680s)
[61.063373] [004/133] (959s left) gen7_exec_parse (basic-offset)
[61.124301] Subtest basic-offset: SKIP (0.000s)
[61.166625] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[61.257444] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[65.522506] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.253s)
[66.706818] [006/133] (953s left) tools_test (tools_test)
[66.757397] Starting subtest: tools_test
[66.815066] Subtest tools_test: SUCCESS (0.074s)
[66.872915] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[67.115367] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[67.120355] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[68.243310] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[68.337670] Starting subtest: modeset-vs-vblank-race
[68.340103] Starting dynamic subtest: A-eDP1
[73.078938] Dynamic subtest A-eDP1: SUCCESS (4.734s)
[73.090191] Starting dynamic subtest: B-eDP1
[77.809646] Dynamic subtest B-eDP1: SUCCESS (4.727s)
[77.819745] Starting dynamic subtest: C-eDP1
[82.424224] Dynamic subtest C-eDP1: SUCCESS (4.610s)
[82.432631] Starting dynamic subtest: D-eDP1
[86.882642] Dynamic subtest D-eDP1: SUCCESS (4.456s)
[86.885268] Subtest modeset-vs-vblank-race: SUCCESS (18.534s)
[88.040090] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[90.080959] Starting subtest: reg-read-ioctl
[92.371298] Subtest reg-read-ioctl: SUCCESS (2.295s)
[92.735999] [010/133] (927s left) gem_exec_balancer (hang)
[93.003911] Starting subtest: hang
[94.942820] Subtest hang: SUCCESS (1.938s)
[95.069898] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[95.166151] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[95.170129] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[95.234871] [012/133] (925s left) perf_pmu (faulting-read)
[95.280420] Starting subtest: faulting-read
[95.282639] Starting dynamic subtest: wb
[95.284813] Dynamic subtest wb: SUCCESS (0.001s)
[95.292383] Starting dynamic subtest: wc
[95.294190] Dynamic subtest wc: SUCCESS (0.000s)
[95.301146] Starting dynamic subtest: uc
[95.302968] Dynamic subtest uc: SUCCESS (0.000s)
[95.304765] Subtest faulting-read: SUCCESS (0.002s)
[95.389789] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[95.490265] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[95.494548] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[95.602348] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[95.984399] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[96.834474] [015/133] (923s left) gem_exec_schedule (pi-distinct-iova)
[97.025271] Starting subtest: pi-distinct-iova
[97.027864] Starting dynamic subtest: rcs0
[97.098232] Dynamic subtest rcs0: SUCCESS (0.074s)
[97.110477] Starting dynamic subtest: vcs0
[97.159554] Dynamic subtest vcs0: SUCCESS (0.061s)
[97.171320] Starting dynamic subtest: vcs1
[97.217115] Dynamic subtest vcs1: SUCCESS (0.058s)
[97.226378] Starting dynamic subtest: vecs0
[97.284017] Dynamic subtest vecs0: SUCCESS (0.066s)
[97.295969] Starting dynamic subtest: ccs0
[97.345039] Dynamic subtest ccs0: SUCCESS (0.061s)
[97.347753] Subtest pi-distinct-iova: SUCCESS (0.322s)
[98.979249] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[99.088488] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[99.092881] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[99.184120] [017/133] (921s left) drm_read (short-buffer-block)
[99.323368] Starting subtest: short-buffer-block
[99.326090] Subtest short-buffer-block: SUCCESS (0.000s)
[99.440016] [018/133] (921s left) perf (oa-formats)
[99.564648] Starting subtest: oa-formats
[99.566513] Starting dynamic subtest: 0-rcs0
[99.578514] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[99.587519] Starting dynamic subtest: 1-vecs0
[99.599818] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[99.602083] Subtest oa-formats: SUCCESS (0.036s)
[99.644201] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[99.746039] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[99.750058] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[99.832651] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[99.928423] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[99.932645] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.014898] [021/133] (920s left) kms_psr (pr-basic)
[100.114468] Starting subtest: pr-basic
[100.118123] Subtest pr-basic: SKIP (0.000s)
[100.185348] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[100.284267] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[100.286059] Starting dynamic subtest: pipe-A-eDP-1
[100.304441] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.314257] Starting dynamic subtest: pipe-B-eDP-1
[100.330191] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.337282] Starting dynamic subtest: pipe-C-eDP-1
[100.354959] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.361697] Starting dynamic subtest: pipe-D-eDP-1
[100.380469] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.384202] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[102.528798] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[103.678894] Subtest hdmi-mode-timings: SKIP (0.000s)
[103.981076] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[104.116941] Starting subtest: dp-mst-lic-type-0-hdcp14
[104.121500] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[104.234194] [025/133] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[104.337574] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[104.341570] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[104.415936] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[104.505766] Starting subtest: primary-4-tiled-reflect-x-180
[111.522023] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.017s)
[112.669066] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[112.768834] Starting subtest: 2x-flip-vs-panning-interruptible
[112.779867] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[112.851667] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[112.943106] Starting subtest: plain-flip-fb-recreate
[112.945472] Starting dynamic subtest: A-eDP1
[121.765198] Dynamic subtest A-eDP1: SUCCESS (8.823s)
[121.774949] Starting dynamic subtest: B-eDP1
[130.600594] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[130.612274] Starting dynamic subtest: C-eDP1
[139.514629] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[139.524183] Starting dynamic subtest: D-eDP1
[148.347088] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[148.352069] Subtest plain-flip-fb-recreate: SUCCESS (35.410s)
[149.524422] [029/133] (871s left) gem_tiled_partial_pwrite_pread (writes)
[149.584741] Subtest writes: SKIP (0.000s)
[149.649812] [030/133] (871s left) gem_lmem_swapping (heavy-verify-random)
[149.696481] Subtest heavy-verify-random: SKIP (0.000s)
[149.739086] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[149.831866] Starting subtest: x-tiled-64bpp-rotate-90
[149.851615] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[149.966053] [032/133] (871s left) vgem_basic (debugfs)
[150.065377] Starting subtest: debugfs
[150.067619] Subtest debugfs: SUCCESS (0.000s)
[150.114208] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[150.117530] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[150.202924] Starting subtest: legacy-setmode
[150.205272] Starting dynamic subtest: pipe-A-eDP-1
[157.125483] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.923s)
[157.127898] Subtest legacy-setmode: SUCCESS (6.924s)
[158.023329] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[158.155993] Starting subtest: reject-modify-context-protection-off-2
[158.158623] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[158.286235] [035/133] (863s left) gem_exec_basic (basic)
[158.335465] Starting subtest: basic
[158.337677] Starting dynamic subtest: rcs0-smem
[158.340033] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[158.349622] Starting dynamic subtest: bcs0-smem
[158.351521] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[158.358963] Starting dynamic subtest: vcs0-smem
[158.360820] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[158.368176] Starting dynamic subtest: vcs1-smem
[158.370068] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[158.377197] Starting dynamic subtest: vecs0-smem
[158.379045] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[158.386274] Starting dynamic subtest: ccs0-smem
[158.388140] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[158.389982] Subtest basic: SUCCESS (0.011s)
[159.933489] [036/133] (861s left) api_intel_bb (offset-control)
[159.984988] Starting subtest: offset-control
[159.990053] Subtest offset-control: SUCCESS (0.007s)
[160.080725] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[160.179547] Starting subtest: basic-max-non-joiner
[160.183683] Subtest basic-max-non-joiner: SKIP (0.000s)
[160.257480] [038/133] (861s left) kms_addfb_basic (small-bo)
[160.357072] Starting subtest: small-bo
[160.358987] Subtest small-bo: SUCCESS (0.000s)
[160.466687] [039/133] (861s left) i915_query (query-topology-garbage-items)
[160.527005] Starting subtest: query-topology-garbage-items
[160.529067] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[160.626324] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[160.714624] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[160.746479] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.031s)
[160.790571] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[161.954703] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[161.959141] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[162.049491] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[162.101976] Starting subtest: cliprects-invalid
[162.104329] Subtest cliprects-invalid: SUCCESS (0.000s)
[162.204408] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[162.379687] Starting subtest: cursor-random-64x64
[162.384685] Starting dynamic subtest: pipe-A-eDP-1
[165.722821] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.338s)
[165.749404] Starting dynamic subtest: pipe-D-eDP-1
[169.721618] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.978s)
[169.723854] Subtest cursor-random-64x64: SUCCESS (7.340s)
[170.553136] [044/133] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[170.649881] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[170.654337] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[170.742386] [045/133] (851s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[170.837196] Starting subtest: 4-tiled-16bpp-rotate-180
[172.182064] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.346s)
[172.296216] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[172.344924] Starting subtest: create-valid-dumb
[172.347113] Subtest create-valid-dumb: SUCCESS (0.000s)
[172.443813] [047/133] (849s left) gem_softpin (zero)
[172.499350] Starting subtest: zero
[172.505243] Subtest zero: SUCCESS (0.004s)
[172.628497] [048/133] (849s left) gem_blits (basic)
[172.682220] Starting subtest: basic
[174.038365] Subtest basic: SUCCESS (1.355s)
[174.174768] [049/133] (847s left) gem_busy (close-race)
[174.245394] Starting subtest: close-race
[199.915944] Subtest close-race: SUCCESS (25.609s)
[200.211216] [050/133] (821s left) gem_exec_alignment (forked)
[200.315229] Starting subtest: forked
[239.762914] Subtest forked: SUCCESS (39.392s)
[239.809390] [051/133] (782s left) syncobj_eventfd (binary-wait-before-signal)
[239.910861] Starting subtest: binary-wait-before-signal
[239.939039] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[240.027658] [052/133] (782s left) prime_mmap (test_errors)
[240.080687] Starting subtest: test_errors
[240.082586] Starting dynamic subtest: test_errors-smem
[240.173548] Dynamic subtest test_errors-smem: SUCCESS (0.094s)
[240.176065] Subtest test_errors: SUCCESS (0.095s)
[240.281537] [053/133] (781s left) gem_ctx_persistence (heartbeat-stop)
[240.346330] Starting subtest: heartbeat-stop
[240.350920] Subtest heartbeat-stop: SKIP (0.000s)
[240.448995] [054/133] (781s left) gem_ctx_param (invalid-get-ringsize)
[240.499517] Starting subtest: invalid-get-ringsize
[240.501857] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[240.598370] [055/133] (781s left) i915_query (query-topology-matches-eu-total)
[240.653774] Starting subtest: query-topology-matches-eu-total
[240.656073] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[240.753789] [056/133] (781s left) kms_cursor_edge_walk (64x64-right-edge)
[240.857291] Starting subtest: 64x64-right-edge
[240.859182] Starting dynamic subtest: pipe-A-eDP-1
[244.288873] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s)
[244.298681] Starting dynamic subtest: pipe-D-eDP-1
[247.428407] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[247.430713] Subtest 64x64-right-edge: SUCCESS (6.572s)
[248.226844] [057/133] (774s left) kms_plane (plane-position-covered)
[248.323375] Starting subtest: plane-position-covered
[248.835860] Starting dynamic subtest: pipe-A-plane-1
[250.091407] Dynamic subtest pipe-A-plane-1: SUCCESS (1.255s)
[250.101793] Starting dynamic subtest: pipe-A-plane-2
[251.340126] Dynamic subtest pipe-A-plane-2: SUCCESS (1.248s)
[251.349614] Starting dynamic subtest: pipe-A-plane-3
[252.658923] Dynamic subtest pipe-A-plane-3: SUCCESS (1.320s)
[252.669733] Starting dynamic subtest: pipe-A-plane-4
[253.890100] Dynamic subtest pipe-A-plane-4: SUCCESS (1.231s)
[253.900105] Starting dynamic subtest: pipe-A-plane-5
[253.915728] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[255.050830] Starting dynamic subtest: pipe-B-plane-1
[256.272969] Dynamic subtest pipe-B-plane-1: SUCCESS (1.229s)
[256.282488] Starting dynamic subtest: pipe-B-plane-2
[257.526420] Dynamic subtest pipe-B-plane-2: SUCCESS (1.251s)
[257.535411] Starting dynamic subtest: pipe-B-plane-3
[258.737706] Dynamic subtest pipe-B-plane-3: SUCCESS (1.212s)
[258.748894] Starting dynamic subtest: pipe-B-plane-4
[259.970487] Dynamic subtest pipe-B-plane-4: SUCCESS (1.232s)
[259.979478] Starting dynamic subtest: pipe-B-plane-5
[259.997546] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[259.999528] Subtest plane-position-covered: SUCCESS (11.674s)
[260.778630] [058/133] (761s left) kms_frontbuffer_tracking (psr-suspend)
[260.885187] Starting subtest: psr-suspend
[298.642757] Subtest psr-suspend: SUCCESS (8.109s)
[298.747679] [059/133] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[298.858248] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[298.862804] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[298.970014] [060/133] (723s left) gem_exec_schedule (fairslice)
[299.034806] Starting subtest: fairslice
[299.036864] Starting dynamic subtest: rcs0
[301.050036] Dynamic subtest rcs0: SUCCESS (1.970s)
[301.062273] Starting dynamic subtest: bcs0
[303.069901] Dynamic subtest bcs0: SUCCESS (1.978s)
[303.080843] Starting dynamic subtest: vcs0
[305.089636] Dynamic subtest vcs0: SUCCESS (1.989s)
[305.098946] Starting dynamic subtest: vcs1
[307.158055] Dynamic subtest vcs1: SUCCESS (1.995s)
[307.169374] Starting dynamic subtest: vecs0
[309.133763] Dynamic subtest vecs0: SUCCESS (2.008s)
[309.144372] Starting dynamic subtest: ccs0
[311.152909] Dynamic subtest ccs0: SUCCESS (2.004s)
[311.155355] Subtest fairslice: SUCCESS (11.950s)
[311.466539] [061/133] (711s left) sw_sync (alloc_fence_invalid_timeline)
[311.509768] Starting subtest: alloc_fence_invalid_timeline
[311.511975] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[311.561949] [062/133] (711s left) gem_exec_whisper (basic-fds-forked)
[311.626440] Starting subtest: basic-fds-forked
[336.092129] Subtest basic-fds-forked: SUCCESS (24.420s)
[336.274839] [063/133] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[336.373682] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[336.377552] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[336.476024] [064/133] (686s left) gem_vm_create (execbuf)
[336.543667] Starting subtest: execbuf
[336.551304] Subtest execbuf: SUCCESS (0.008s)
[336.687065] [065/133] (686s left) kms_cursor_crc (cursor-onscreen-256x85)
[336.950835] Starting subtest: cursor-onscreen-256x85
[336.993534] Subtest cursor-onscreen-256x85: SKIP (0.040s)
[337.155233] [066/133] (685s left) kms_plane_alpha_blend (coverage-7efc)
[337.243279] Starting subtest: coverage-7efc
[337.541337] Starting dynamic subtest: pipe-A-eDP-1
[338.138932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[338.167027] Starting dynamic subtest: pipe-D-eDP-1
[339.492236] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[339.494638] Subtest coverage-7efc: SUCCESS (2.248s)
[340.345572] [067/133] (682s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[340.458372] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[340.460883] Starting dynamic subtest: pipe-A
[340.479154] Dynamic subtest pipe-A: SKIP (0.018s)
[340.492241] Starting dynamic subtest: pipe-B
[340.509729] Dynamic subtest pipe-B: SKIP (0.030s)
[340.519263] Starting dynamic subtest: pipe-C
[340.538498] Dynamic subtest pipe-C: SKIP (0.029s)
[340.548009] Starting dynamic subtest: pipe-D
[340.568384] Dynamic subtest pipe-D: SKIP (0.029s)
[340.572007] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.108s)
[340.683267] [068/133] (682s left) vgem_basic (busy-fence)
[340.724978] Starting subtest: busy-fence
[340.727067] Subtest busy-fence: SUCCESS (0.000s)
[340.781003] [069/133] (682s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[340.872204] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[340.900551] Starting dynamic subtest: pipe-A-plane-0
[341.344288] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[341.356378] Starting dynamic subtest: pipe-A-plane-3
[341.599848] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[341.609277] Starting dynamic subtest: pipe-A-plane-5
[341.612713] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[342.727275] Starting dynamic subtest: pipe-B-plane-0
[343.163367] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[343.173325] Starting dynamic subtest: pipe-B-plane-3
[343.418845] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[343.428761] Starting dynamic subtest: pipe-B-plane-5
[343.433109] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[343.732044] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.861s)
[344.616684] [070/133] (678s left) kms_addfb_basic (invalid-set-prop-any)
[344.669027] Starting subtest: invalid-set-prop-any
[344.671149] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[344.796938] [071/133] (678s left) kms_addfb_basic (size-max)
[344.898095] Starting subtest: size-max
[344.900272] Subtest size-max: SUCCESS (0.000s)
[344.980562] [072/133] (678s left) kms_addfb_basic (bad-pitch-128)
[345.034173] Starting subtest: bad-pitch-128
[345.036421] Subtest bad-pitch-128: SUCCESS (0.000s)
[345.173424] [073/133] (677s left) syncobj_timeline (single-wait-available-submitted)
[345.228242] Starting subtest: single-wait-available-submitted
[345.230518] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[345.326095] [074/133] (677s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[345.450351] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[346.518207] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.068s)
[346.640974] [075/133] (676s left) gem_pread (exhaustion)
[346.704740] Subtest exhaustion: SKIP (0.000s)
[346.763046] [076/133] (676s left) kms_frontbuffer_tracking (psr-1p-rte)
[346.852474] Starting subtest: psr-1p-rte
[352.242225] Subtest psr-1p-rte: SUCCESS (5.393s)
[352.377347] [077/133] (670s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[352.503872] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[369.642901] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.136s)
[370.434891] [078/133] (652s left) api_intel_allocator (fork-simple-once)
[370.499952] Starting subtest: fork-simple-once
[370.517608] Subtest fork-simple-once: SUCCESS (0.018s)
[370.626782] [079/133] (652s left) gem_set_tiling_vs_pwrite
[370.751615] [080/133] (652s left) kms_pm_backlight (brightness-with-dpms)
[370.855446] Starting subtest: brightness-with-dpms
[370.904836] Starting dynamic subtest: eDP-1
[373.335218] Dynamic subtest eDP-1: SUCCESS (2.426s)
[373.337553] Subtest brightness-with-dpms: SUCCESS (2.479s)
[374.196579] [081/133] (649s left) kms_lease (lease-invalid-crtc)
[374.298356] Starting subtest: lease-invalid-crtc
[374.300891] Starting dynamic subtest: pipe-A-eDP-1
[374.303230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[374.313518] Starting dynamic subtest: pipe-B-eDP-1
[374.315653] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[374.325858] Starting dynamic subtest: pipe-C-eDP-1
[374.327757] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[374.339107] Starting dynamic subtest: pipe-D-eDP-1
[374.340900] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[374.342777] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[374.379912] [082/133] (649s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[374.477810] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[374.481801] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[374.572974] [083/133] (648s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[374.674372] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[381.507522] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.832s)
[381.649681] [084/133] (641s left) kms_dp_linktrain_fallback (dp-fallback)
[381.739466] Starting subtest: dp-fallback
[381.746104] Subtest dp-fallback: SKIP (0.000s)
[381.811953] [085/133] (641s left) kms_vblank (ts-continuation-idle)
[381.898585] Starting subtest: ts-continuation-idle
[381.900790] Starting dynamic subtest: pipe-A-eDP-1
[382.295217] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[382.311065] Starting dynamic subtest: pipe-D-eDP-1
[383.424027] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[383.426330] Subtest ts-continuation-idle: SUCCESS (1.525s)
[384.293277] [086/133] (639s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[384.376946] Starting subtest: fbc-psr-cursor-mmap-gtt
[384.379251] Starting dynamic subtest: eDP-1
[384.383336] Dynamic subtest eDP-1: SKIP (0.000s)
[384.387502] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[384.451441] [087/133] (639s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[384.572426] Starting subtest: cursor-vs-flip-varying-size
[415.809983] Subtest cursor-vs-flip-varying-size: SUCCESS (31.236s)
[416.629305] [088/133] (607s left) i915_drm_fdinfo (busy-check-all)
[416.680849] Starting subtest: busy-check-all
[416.683221] Starting dynamic subtest: rcs0
[416.687880] Dynamic subtest rcs0: SKIP (0.003s)
[416.699850] Starting dynamic subtest: bcs0
[416.704220] Dynamic subtest bcs0: SKIP (0.000s)
[416.714854] Starting dynamic subtest: vcs0
[416.718934] Dynamic subtest vcs0: SKIP (0.000s)
[416.727737] Starting dynamic subtest: vcs1
[416.731826] Dynamic subtest vcs1: SKIP (0.000s)
[416.740551] Starting dynamic subtest: vecs0
[416.744596] Dynamic subtest vecs0: SKIP (0.000s)
[416.753559] Starting dynamic subtest: ccs0
[416.757581] Dynamic subtest ccs0: SKIP (0.000s)
[416.761588] Subtest busy-check-all: SKIP (0.008s)
[416.800045] [089/133] (606s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[416.925546] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[416.927773] Starting dynamic subtest: pipe-A-eDP-1
[416.948107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[416.959523] Starting dynamic subtest: pipe-B-eDP-1
[416.978623] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[416.987967] Starting dynamic subtest: pipe-C-eDP-1
[417.007159] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[417.018438] Starting dynamic subtest: pipe-D-eDP-1
[417.037619] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[417.039456] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[419.183481] [090/133] (604s left) prime_busy (before-wait)
[419.249993] Starting subtest: before-wait
[419.254843] Starting dynamic subtest: rcs0
[419.285651] Dynamic subtest rcs0: SUCCESS (0.032s)
[419.296575] Starting dynamic subtest: bcs0
[419.333830] Dynamic subtest bcs0: SUCCESS (0.047s)
[419.343763] Starting dynamic subtest: vcs0
[419.372133] Dynamic subtest vcs0: SUCCESS (0.038s)
[419.381281] Starting dynamic subtest: vcs1
[419.412783] Dynamic subtest vcs1: SUCCESS (0.040s)
[419.422348] Starting dynamic subtest: vecs0
[419.454579] Dynamic subtest vecs0: SUCCESS (0.041s)
[419.463817] Starting dynamic subtest: ccs0
[419.496055] Dynamic subtest ccs0: SUCCESS (0.041s)
[419.604174] Subtest before-wait: SUCCESS (0.352s)
[419.680212] [091/133] (604s left) gem_ppgtt (blt-vs-render-ctx0)
[419.749206] Starting subtest: blt-vs-render-ctx0
[452.525817] Subtest blt-vs-render-ctx0: SUCCESS (32.771s)
[452.657910] [092/133] (571s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[452.824638] Starting subtest: cursorB-vs-flipB-atomic
[452.829153] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[452.968800] [093/133] (570s left) gem_exec_reloc (basic-wc-read-active)
[453.037436] Subtest basic-wc-read-active: SKIP (0.000s)
[453.110821] [094/133] (570s left) gem_exec_fence (syncobj-import)
[453.575790] Starting subtest: syncobj-import
[453.581347] Subtest syncobj-import: SUCCESS (0.007s)
[455.616165] [095/133] (568s left) kms_psr (fbc-psr2-sprite-blt)
[455.721996] Starting subtest: fbc-psr2-sprite-blt
[455.724204] Starting dynamic subtest: eDP-1
[455.728474] Dynamic subtest eDP-1: SKIP (0.000s)
[455.732665] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[455.794668] [096/133] (568s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[455.882804] Starting subtest: plane-lut1d-post-ctm3x4
[456.019297] Starting dynamic subtest: pipe-A-plane-0
[456.163552] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[456.174002] Starting dynamic subtest: pipe-A-plane-1
[456.318965] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[456.329168] Starting dynamic subtest: pipe-A-plane-2
[456.452693] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[457.729053] Starting dynamic subtest: pipe-B-plane-0
[457.921409] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[457.931016] Starting dynamic subtest: pipe-B-plane-1
[458.098810] Dynamic subtest pipe-B-plane-1: SUCCESS (0.176s)
[458.109167] Starting dynamic subtest: pipe-B-plane-2
[458.243937] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[459.415849] Starting dynamic subtest: pipe-C-plane-0
[459.548815] Dynamic subtest pipe-C-plane-0: SUCCESS (0.143s)
[459.558650] Starting dynamic subtest: pipe-C-plane-1
[459.704296] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[459.715157] Starting dynamic subtest: pipe-C-plane-2
[459.848809] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[461.066732] Starting dynamic subtest: pipe-D-plane-0
[461.202355] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[461.212688] Starting dynamic subtest: pipe-D-plane-1
[461.335751] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[461.346748] Starting dynamic subtest: pipe-D-plane-2
[461.469495] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[461.758272] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.871s)
[462.641925] [097/133] (561s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[462.701462] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[462.705948] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[462.887481] [098/133] (561s left) kms_big_fb (linear-8bpp-rotate-180)
[462.991013] Starting subtest: linear-8bpp-rotate-180
[464.247627] Subtest linear-8bpp-rotate-180: SUCCESS (1.258s)
[464.376212] [099/133] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[464.472084] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[464.476233] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[464.576834] [100/133] (559s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[464.671571] Starting subtest: extended-modeset-hang-oldfb-with-reset
[464.673483] Starting dynamic subtest: pipe-A
[476.503290] Dynamic subtest pipe-A: SUCCESS (11.828s)
[476.519443] Starting dynamic subtest: pipe-D
[488.789563] Dynamic subtest pipe-D: SUCCESS (12.279s)
[488.791711] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.111s)
[489.590879] [101/133] (534s left) gem_exec_schedule (timeslicing)
[489.683224] Starting subtest: timeslicing
[489.685257] Starting dynamic subtest: rcs0
[489.694534] Dynamic subtest rcs0: SUCCESS (0.022s)
[489.706849] Starting dynamic subtest: bcs0
[489.715488] Dynamic subtest bcs0: SUCCESS (0.020s)
[489.725347] Starting dynamic subtest: vcs0
[489.736105] Dynamic subtest vcs0: SUCCESS (0.020s)
[489.745776] Starting dynamic subtest: vcs1
[489.756453] Dynamic subtest vcs1: SUCCESS (0.020s)
[489.766006] Starting dynamic subtest: vecs0
[489.776570] Dynamic subtest vecs0: SUCCESS (0.020s)
[489.786463] Starting dynamic subtest: ccs0
[489.796751] Dynamic subtest ccs0: SUCCESS (0.019s)
[489.798986] Subtest timeslicing: SUCCESS (0.125s)
[491.550517] [102/133] (532s left) kms_chamelium_color (ctm-0-25)
[491.650643] Subtest ctm-0-25: SKIP (0.000s)
[491.695204] [103/133] (532s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[491.803274] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[491.805554] Starting dynamic subtest: pipe-A-eDP-1
[491.886318] Dynamic subtest pipe-A-eDP-1: SKIP (0.087s)
[491.896882] Starting dynamic subtest: pipe-B-eDP-1
[493.074002] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s)
[493.078609] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.276s)
[494.253520] [104/133] (530s left) gem_mmap (short-mmap)
[494.309058] Subtest short-mmap: SKIP (0.000s)
[494.371230] [105/133] (530s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[494.432254] Starting subtest: multi-wait-available-unsubmitted-submitted
[494.434468] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[494.521197] [106/133] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[494.621691] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[494.625964] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[494.726890] [107/133] (529s left) kms_getfb (getfb2-accept-nv12)
[494.825416] Starting subtest: getfb2-accept-nv12
[494.827757] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[494.932081] [108/133] (529s left) syncobj_timeline (invalid-signal-zero-handles)
[494.998355] Starting subtest: invalid-signal-zero-handles
[495.000591] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[495.098431] [109/133] (529s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[495.186998] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[495.190691] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[495.259396] [110/133] (529s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[495.358456] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[495.360366] Starting dynamic subtest: pipe-A-eDP-1
[495.410172] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[495.421330] Starting dynamic subtest: pipe-B-eDP-1
[495.465926] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[495.474803] Starting dynamic subtest: pipe-C-eDP-1
[495.519842] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[495.529145] Starting dynamic subtest: pipe-D-eDP-1
[495.573045] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[495.576709] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[497.651057] [111/133] (527s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[497.756058] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[497.764445] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[497.845521] [112/133] (526s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[497.934707] Starting subtest: async-flip-with-page-flip-events-tiled
[498.319009] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[501.170912] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[501.183542] Starting dynamic subtest: pipe-A-eDP-1-4
[503.289225] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[503.302981] Starting dynamic subtest: pipe-A-eDP-1-4
[505.296900] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[505.307901] Starting dynamic subtest: pipe-A-eDP-1-x
[507.476567] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[507.848159] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[510.635486] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[510.648567] Starting dynamic subtest: pipe-B-eDP-1-4
[512.821844] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[512.834266] Starting dynamic subtest: pipe-B-eDP-1-4
[514.829896] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[514.840411] Starting dynamic subtest: pipe-B-eDP-1-x
[517.082307] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[517.402059] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[520.170325] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[520.181085] Starting dynamic subtest: pipe-C-eDP-1-4
[522.356976] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[522.380981] Starting dynamic subtest: pipe-C-eDP-1-4
[524.364240] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[524.377027] Starting dynamic subtest: pipe-C-eDP-1-x
[526.542959] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[526.913917] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[529.697142] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[529.709269] Starting dynamic subtest: pipe-D-eDP-1-4
[531.924241] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[531.938133] Starting dynamic subtest: pipe-D-eDP-1-4
[533.881107] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[533.894644] Starting dynamic subtest: pipe-D-eDP-1-x
[536.059395] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[536.061867] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.122s)
[537.281385] [113/133] (487s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[537.376504] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[537.380941] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[537.497600] [114/133] (487s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[537.557931] Starting subtest: etime-multi-wait-for-submit-submitted
[537.666283] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[537.754936] [115/133] (487s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[539.692709] Starting subtest: modeset-non-lpsp-stress-no-wait
[539.729559] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.039s)
[540.094049] [116/133] (484s left) gem_exec_params (sol-reset-invalid)
[540.155497] Starting subtest: sol-reset-invalid
[540.161392] Subtest sol-reset-invalid: SUCCESS (0.003s)
[541.556968] [117/133] (483s left) gem_mmap_gtt (cpuset-big-copy)
[541.622380] Subtest cpuset-big-copy: SKIP (0.000s)
[541.683109] [118/133] (483s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[541.778967] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[549.397434] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.624s)
[549.534647] [119/133] (475s left) kms_psr (psr2-sprite-plane-onoff)
[549.628202] Starting subtest: psr2-sprite-plane-onoff
[549.630532] Starting dynamic subtest: eDP-1
[551.419831] Dynamic subtest eDP-1: SUCCESS (1.791s)
[551.422138] Subtest psr2-sprite-plane-onoff: SUCCESS (1.792s)
[552.254456] [120/133] (472s left) kms_dsc (dsc-with-output-formats)
[552.347381] Starting subtest: dsc-with-output-formats
[552.369351] Subtest dsc-with-output-formats: SKIP (0.000s)
[552.421049] [121/133] (472s left) gen3_mixed_blits
[552.541862] [122/133] (472s left) gem_mmap_offset (clear-via-pagefault)
[552.595892] Starting subtest: clear-via-pagefault
[552.597773] Starting dynamic subtest: smem0
[585.570466] Dynamic subtest smem0: SUCCESS (32.915s)
[585.573012] Subtest clear-via-pagefault: SUCCESS (32.917s)
[585.615426] [123/133] (439s left) gem_eio (reset-stress)
[585.874888] Starting subtest: reset-stress
[585.877176] Starting dynamic subtest: render
[590.890419] Dynamic subtest render: SUCCESS (5.014s)
[590.908686] Starting dynamic subtest: bsd1
[609.035046] Dynamic subtest bsd1: SUCCESS (18.142s)
[609.051971] Starting dynamic subtest: bsd2
[627.012014] Dynamic subtest bsd2: SUCCESS (17.974s)
[627.029193] Starting dynamic subtest: blt
[627.033213] Dynamic subtest blt: SKIP (0.000s)
[627.044991] Starting dynamic subtest: vebox
[645.049791] Dynamic subtest vebox: SUCCESS (18.033s)
[645.051701] Subtest reset-stress: SUCCESS (59.168s)
[646.596749] [124/133] (378s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[646.662858] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[646.664857] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[646.763210] [125/133] (378s left) kms_vblank (query-busy-hang)
[646.860501] Starting subtest: query-busy-hang
[646.862922] Starting dynamic subtest: pipe-A-eDP-1
[648.753827] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s)
[648.769519] Starting dynamic subtest: pipe-D-eDP-1
[651.320307] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[651.322502] Subtest query-busy-hang: SUCCESS (4.460s)
[652.132548] [126/133] (373s left) kms_psr (fbc-pr-cursor-plane-onoff)
[652.244359] Starting subtest: fbc-pr-cursor-plane-onoff
[652.248468] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[652.330041] [127/133] (373s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[652.431930] Starting subtest: psr-1p-primscrn-cur-indfb-move
[659.848888] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.420s)
[659.977551] [128/133] (365s left) tools_test (sysfs_l3_parity)
[660.027579] Starting subtest: sysfs_l3_parity
[660.094976] Subtest sysfs_l3_parity: SKIP (0.078s)
[660.153664] [129/133] (365s left) kms_vblank (crtc-id)
[660.233412] Starting subtest: crtc-id
[660.235644] Starting dynamic subtest: pipe-A-eDP-1
[660.686444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s)
[660.702464] Starting dynamic subtest: pipe-D-eDP-1
[661.786316] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s)
[661.788637] Subtest crtc-id: SUCCESS (1.556s)
[662.620734] [130/133] (362s left) gem_ctx_engines (independent)
[662.685034] Starting subtest: independent
[662.687567] Starting dynamic subtest: rcs0
[662.840067] Dynamic subtest rcs0: SUCCESS (0.153s)
[662.852929] Starting dynamic subtest: bcs0
[663.014359] Dynamic subtest bcs0: SUCCESS (0.173s)
[663.025881] Starting dynamic subtest: vcs0
[663.190536] Dynamic subtest vcs0: SUCCESS (0.175s)
[663.203498] Starting dynamic subtest: vcs1
[663.341450] Dynamic subtest vcs1: SUCCESS (0.151s)
[663.355224] Starting dynamic subtest: vecs0
[663.514087] Dynamic subtest vecs0: SUCCESS (0.172s)
[663.526931] Starting dynamic subtest: ccs0
[663.672275] Dynamic subtest ccs0: SUCCESS (0.157s)
[663.684606] Starting dynamic subtest: all-engines
[664.403495] Dynamic subtest all-engines: SUCCESS (0.731s)
[664.406303] Subtest independent: SUCCESS (1.718s)
[664.694871] [131/133] (360s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[664.793909] Starting subtest: flip-vs-dpms-on-nop-interruptible
[664.796267] Starting dynamic subtest: A-eDP1
[666.605579] Dynamic subtest A-eDP1: SUCCESS (1.810s)
[666.627748] Starting dynamic subtest: B-eDP1
[668.427720] Dynamic subtest B-eDP1: SUCCESS (1.819s)
[668.445357] Starting dynamic subtest: C-eDP1
[670.246404] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[670.258922] Starting dynamic subtest: D-eDP1
[672.086400] Dynamic subtest D-eDP1: SUCCESS (1.838s)
[672.088839] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.295s)
[673.269294] [132/133] (352s left) kms_plane_lowres (tiling-x)
[673.360491] Starting subtest: tiling-x
[673.362787] Starting dynamic subtest: pipe-A-eDP-1
[673.367419] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[673.657940] Starting dynamic subtest: pipe-B-eDP-1
[673.662743] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[673.673234] Starting dynamic subtest: pipe-C-eDP-1
[673.678012] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[673.688229] Starting dynamic subtest: pipe-D-eDP-1
[673.692672] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[673.696871] Subtest tiling-x: SKIP (0.295s)
[674.513883] [133/133] (351s left) i915_pm_freq_api (freq-reset)
[674.586253] Starting subtest: freq-reset
[674.588990] Starting dynamic subtest: gt0
[674.776673] Dynamic subtest gt0: SUCCESS (0.190s)
[674.787882] Starting dynamic subtest: gt1
[674.948866] Dynamic subtest gt1: SUCCESS (0.169s)
[674.951427] Subtest freq-reset: SUCCESS (0.362s)
[675.022351] 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.