[60.270218] Initializing watchdogs
[60.270266]   /dev/watchdog0
[60.285599] [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.290201] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.292568] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.296119] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[60.431745] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[60.435658] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[60.534682] [002/132] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[60.637414] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[60.641702] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[60.738963] [003/132] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[60.834951] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[61.524628] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.691s)
[61.693035] [004/132] (959s left) gen7_exec_parse (basic-offset)
[61.759106] Subtest basic-offset: SKIP (0.000s)
[61.827496] [005/132] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[61.918861] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[66.222029] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.309s)
[67.450118] [006/132] (953s left) tools_test (tools_test)
[67.531039] Starting subtest: tools_test
[67.642926] Subtest tools_test: SUCCESS (0.126s)
[67.732899] [007/132] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[67.840373] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[67.845657] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[68.944892] [008/132] (952s left) kms_flip (modeset-vs-vblank-race)
[69.035049] Starting subtest: modeset-vs-vblank-race
[69.037486] Starting dynamic subtest: A-eDP1
[73.759442] Dynamic subtest A-eDP1: SUCCESS (4.725s)
[73.770413] Starting dynamic subtest: B-eDP1
[78.490052] Dynamic subtest B-eDP1: SUCCESS (4.730s)
[78.500324] Starting dynamic subtest: C-eDP1
[83.101885] Dynamic subtest C-eDP1: SUCCESS (4.610s)
[83.111796] Starting dynamic subtest: D-eDP1
[87.748378] Dynamic subtest D-eDP1: SUCCESS (4.646s)
[87.750381] Subtest modeset-vs-vblank-race: SUCCESS (18.719s)
[88.899338] [009/132] (932s left) i915_pm_rpm (reg-read-ioctl)
[91.039444] Starting subtest: reg-read-ioctl
[93.328999] Subtest reg-read-ioctl: SUCCESS (2.293s)
[93.705737] [010/132] (927s left) gem_exec_balancer (hang)
[93.957355] Starting subtest: hang
[95.902019] Subtest hang: SUCCESS (1.945s)
[96.008822] [011/132] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[96.105064] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[96.109086] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[96.172189] [012/132] (925s left) perf_pmu (faulting-read)
[96.216338] Starting subtest: faulting-read
[96.218774] Starting dynamic subtest: wb
[96.221134] Dynamic subtest wb: SUCCESS (0.001s)
[96.230556] Starting dynamic subtest: wc
[96.232757] Dynamic subtest wc: SUCCESS (0.000s)
[96.240466] Starting dynamic subtest: uc
[96.242686] Dynamic subtest uc: SUCCESS (0.000s)
[96.244905] Subtest faulting-read: SUCCESS (0.002s)
[96.322197] [013/132] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[96.418145] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[96.422334] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[96.507508] [014/132] (924s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[96.913714] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[97.719588] [015/132] (923s left) gem_exec_schedule (pi-distinct-iova)
[97.921308] Starting subtest: pi-distinct-iova
[97.923398] Starting dynamic subtest: rcs0
[97.997852] Dynamic subtest rcs0: SUCCESS (0.078s)
[98.008543] Starting dynamic subtest: vcs0
[98.068803] Dynamic subtest vcs0: SUCCESS (0.071s)
[98.079816] Starting dynamic subtest: vcs1
[98.131848] Dynamic subtest vcs1: SUCCESS (0.063s)
[98.144888] Starting dynamic subtest: vecs0
[98.191631] Dynamic subtest vecs0: SUCCESS (0.060s)
[98.202366] Starting dynamic subtest: ccs0
[98.251423] Dynamic subtest ccs0: SUCCESS (0.059s)
[98.254191] Subtest pi-distinct-iova: SUCCESS (0.332s)
[100.014415] [016/132] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[100.116662] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[100.120829] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[100.206014] [017/132] (921s left) drm_read (short-buffer-block)
[100.352045] Starting subtest: short-buffer-block
[100.354472] Subtest short-buffer-block: SUCCESS (0.000s)
[100.485564] [018/132] (921s left) perf (oa-formats)
[100.610753] Starting subtest: oa-formats
[100.612988] Starting dynamic subtest: 0-rcs0
[100.625641] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[100.635221] Starting dynamic subtest: 1-vecs0
[100.647870] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[100.650163] Subtest oa-formats: SUCCESS (0.038s)
[100.694590] [019/132] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[100.787731] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[100.792300] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[100.875908] [020/132] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[100.976410] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[100.979994] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.053912] [021/132] (920s left) kms_psr (pr-basic)
[101.140144] Starting subtest: pr-basic
[101.143815] Subtest pr-basic: SKIP (0.000s)
[101.209242] [022/132] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[101.303518] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[101.305439] Starting dynamic subtest: pipe-A-eDP-1
[101.324885] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.334610] Starting dynamic subtest: pipe-B-eDP-1
[101.352154] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.359685] Starting dynamic subtest: pipe-C-eDP-1
[101.377224] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.384773] Starting dynamic subtest: pipe-D-eDP-1
[101.402652] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.405980] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[103.600631] [023/132] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[103.981540] Subtest hdmi-mode-timings: SKIP (0.000s)
[104.819340] [024/132] (916s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[104.945725] Starting subtest: dp-mst-lic-type-0-hdcp14
[104.950160] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[105.077234] [025/132] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[105.185557] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[105.190030] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[105.253825] [026/132] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[105.339364] Starting subtest: primary-4-tiled-reflect-x-180
[112.374718] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.038s)
[113.523617] [027/132] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[113.618565] Starting subtest: 2x-flip-vs-panning-interruptible
[113.630873] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[113.730434] [028/132] (908s left) kms_flip (plain-flip-fb-recreate)
[113.822104] Starting subtest: plain-flip-fb-recreate
[113.824388] Starting dynamic subtest: A-eDP1
[122.705562] Dynamic subtest A-eDP1: SUCCESS (8.883s)
[122.715379] Starting dynamic subtest: B-eDP1
[131.533540] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[131.543579] Starting dynamic subtest: C-eDP1
[140.356086] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[140.366554] Starting dynamic subtest: D-eDP1
[149.191785] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[149.196535] Subtest plain-flip-fb-recreate: SUCCESS (35.374s)
[150.374030] [029/132] (871s left) gem_tiled_partial_pwrite_pread (writes)
[150.442481] Subtest writes: SKIP (0.000s)
[150.505288] [030/132] (871s left) gem_lmem_swapping (heavy-verify-random)
[150.546356] Subtest heavy-verify-random: SKIP (0.000s)
[150.592691] [031/132] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[150.700495] Starting subtest: x-tiled-64bpp-rotate-90
[150.719111] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s)
[150.830816] [032/132] (871s left) vgem_basic (debugfs)
[150.929988] Starting subtest: debugfs
[150.932224] Subtest debugfs: SUCCESS (0.000s)
[150.991966] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[150.995072] [033/132] (871s left) kms_atomic_interruptible (legacy-setmode)
[151.083739] Starting subtest: legacy-setmode
[151.085985] Starting dynamic subtest: pipe-A-eDP-1
[158.036322] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.952s)
[158.038695] Subtest legacy-setmode: SUCCESS (6.953s)
[158.900131] [034/132] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[159.022214] Starting subtest: reject-modify-context-protection-off-2
[159.024877] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[159.139437] [035/132] (863s left) gem_exec_basic (basic)
[159.188751] Starting subtest: basic
[159.191065] Starting dynamic subtest: rcs0-smem
[159.193396] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[159.203972] Starting dynamic subtest: bcs0-smem
[159.205833] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[159.213508] Starting dynamic subtest: vcs0-smem
[159.215413] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[159.222885] Starting dynamic subtest: vcs1-smem
[159.224818] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[159.232286] Starting dynamic subtest: vecs0-smem
[159.234209] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[159.241746] Starting dynamic subtest: ccs0-smem
[159.243648] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[159.245531] Subtest basic: SUCCESS (0.014s)
[160.957911] [036/132] (861s left) api_intel_bb (offset-control)
[161.022934] Starting subtest: offset-control
[161.029793] Subtest offset-control: SUCCESS (0.008s)
[161.152686] [037/132] (861s left) kms_joiner (basic-max-non-joiner)
[161.258846] Starting subtest: basic-max-non-joiner
[161.263329] Subtest basic-max-non-joiner: SKIP (0.000s)
[161.328727] [038/132] (860s left) kms_addfb_basic (small-bo)
[161.419880] Starting subtest: small-bo
[161.421778] Subtest small-bo: SUCCESS (0.000s)
[161.514045] [039/132] (860s left) i915_query (query-topology-garbage-items)
[161.580521] Starting subtest: query-topology-garbage-items
[161.582693] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[161.672217] [040/132] (860s left) perf (gen12-group-exclusive-stream-ctx-handle)
[161.773496] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[161.805607] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.030s)
[161.846279] [041/132] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[163.885283] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[163.889462] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[163.990428] [042/132] (858s left) gem_exec_params (cliprects-invalid)
[164.055566] Starting subtest: cliprects-invalid
[164.057986] Subtest cliprects-invalid: SUCCESS (0.000s)
[164.158906] [043/132] (858s left) kms_cursor_crc (cursor-random-64x64)
[164.343679] Starting subtest: cursor-random-64x64
[164.349898] Starting dynamic subtest: pipe-A-eDP-1
[167.672088] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.325s)
[167.702958] Starting dynamic subtest: pipe-D-eDP-1
[171.663578] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.966s)
[171.665880] Subtest cursor-random-64x64: SUCCESS (7.318s)
[172.545305] [044/132] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[172.639837] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[172.644197] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[172.737382] [045/132] (849s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[172.842477] Starting subtest: 4-tiled-16bpp-rotate-180
[174.201647] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.360s)
[174.319285] [046/132] (848s left) dumb_buffer (create-valid-dumb)
[174.388138] Starting subtest: create-valid-dumb
[174.390063] Subtest create-valid-dumb: SUCCESS (0.000s)
[174.494368] [047/132] (848s left) gem_softpin (zero)
[174.551524] Starting subtest: zero
[174.557291] Subtest zero: SUCCESS (0.004s)
[174.664380] [048/132] (848s left) gem_blits (basic)
[174.719581] Starting subtest: basic
[176.129327] Subtest basic: SUCCESS (1.408s)
[176.235419] [049/132] (846s left) gem_busy (close-race)
[176.297328] Starting subtest: close-race
[199.901486] Subtest close-race: SUCCESS (23.604s)
[200.278261] [050/132] (822s left) syncobj_eventfd (binary-wait-before-signal)
[200.370703] Starting subtest: binary-wait-before-signal
[200.401740] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[200.483717] [051/132] (822s left) prime_mmap (test_errors)
[200.536911] Starting subtest: test_errors
[200.539061] Starting dynamic subtest: test_errors-smem
[200.639720] Dynamic subtest test_errors-smem: SUCCESS (0.104s)
[200.642127] Subtest test_errors: SUCCESS (0.105s)
[200.741949] [052/132] (822s left) gem_ctx_persistence (heartbeat-stop)
[200.800172] Starting subtest: heartbeat-stop
[200.804879] Subtest heartbeat-stop: SKIP (0.000s)
[200.910484] [053/132] (822s left) gem_ctx_param (invalid-get-ringsize)
[200.959081] Starting subtest: invalid-get-ringsize
[200.961326] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[201.053965] [054/132] (821s left) i915_query (query-topology-matches-eu-total)
[201.107189] Starting subtest: query-topology-matches-eu-total
[201.109470] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[201.201728] [055/132] (821s left) kms_cursor_edge_walk (64x64-right-edge)
[201.296933] Starting subtest: 64x64-right-edge
[201.299134] Starting dynamic subtest: pipe-A-eDP-1
[204.721086] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[204.731795] Starting dynamic subtest: pipe-D-eDP-1
[207.849802] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[207.852056] Subtest 64x64-right-edge: SUCCESS (6.553s)
[208.657103] [056/132] (814s left) kms_plane (plane-position-covered)
[208.764393] Starting subtest: plane-position-covered
[209.281658] Starting dynamic subtest: pipe-A-plane-1
[210.570535] Dynamic subtest pipe-A-plane-1: SUCCESS (1.290s)
[210.580191] Starting dynamic subtest: pipe-A-plane-2
[211.871065] Dynamic subtest pipe-A-plane-2: SUCCESS (1.300s)
[211.881340] Starting dynamic subtest: pipe-A-plane-3
[213.155402] Dynamic subtest pipe-A-plane-3: SUCCESS (1.282s)
[213.164243] Starting dynamic subtest: pipe-A-plane-4
[214.458498] Dynamic subtest pipe-A-plane-4: SUCCESS (1.302s)
[214.470006] Starting dynamic subtest: pipe-A-plane-5
[214.483267] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[215.696568] Starting dynamic subtest: pipe-B-plane-1
[216.964398] Dynamic subtest pipe-B-plane-1: SUCCESS (1.279s)
[216.974285] Starting dynamic subtest: pipe-B-plane-2
[218.303455] Dynamic subtest pipe-B-plane-2: SUCCESS (1.339s)
[218.313080] Starting dynamic subtest: pipe-B-plane-3
[219.610097] Dynamic subtest pipe-B-plane-3: SUCCESS (1.304s)
[219.621992] Starting dynamic subtest: pipe-B-plane-4
[220.933476] Dynamic subtest pipe-B-plane-4: SUCCESS (1.324s)
[220.944632] Starting dynamic subtest: pipe-B-plane-5
[220.964666] Dynamic subtest pipe-B-plane-5: SUCCESS (0.029s)
[220.966825] Subtest plane-position-covered: SUCCESS (12.201s)
[221.817427] [057/132] (801s left) kms_frontbuffer_tracking (psr-suspend)
[221.928720] Starting subtest: psr-suspend
[260.492517] Subtest psr-suspend: SUCCESS (9.672s)
[271.629974] [058/132] (762s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[271.756039] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[271.760049] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[271.856343] [059/132] (762s left) gem_exec_schedule (fairslice)
[271.933168] Starting subtest: fairslice
[271.935329] Starting dynamic subtest: rcs0
[273.950617] Dynamic subtest rcs0: SUCCESS (2.018s)
[273.960555] Starting dynamic subtest: bcs0
[275.968839] Dynamic subtest bcs0: SUCCESS (2.015s)
[275.979149] Starting dynamic subtest: vcs0
[277.991765] Dynamic subtest vcs0: SUCCESS (2.019s)
[278.002820] Starting dynamic subtest: vcs1
[280.005726] Dynamic subtest vcs1: SUCCESS (2.013s)
[280.016858] Starting dynamic subtest: vecs0
[282.026309] Dynamic subtest vecs0: SUCCESS (2.015s)
[282.036612] Starting dynamic subtest: ccs0
[284.044811] Dynamic subtest ccs0: SUCCESS (2.018s)
[284.046806] Subtest fairslice: SUCCESS (12.103s)
[284.346021] [060/132] (749s left) sw_sync (alloc_fence_invalid_timeline)
[284.394304] Starting subtest: alloc_fence_invalid_timeline
[284.396702] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[284.455615] [061/132] (749s left) gem_exec_whisper (basic-fds-forked)
[284.530052] Starting subtest: basic-fds-forked
[308.803125] Subtest basic-fds-forked: SUCCESS (24.268s)
[309.001842] [062/132] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[309.109987] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[309.114409] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[309.206585] [063/132] (725s left) gem_vm_create (execbuf)
[309.258519] Starting subtest: execbuf
[309.265270] Subtest execbuf: SUCCESS (0.007s)
[309.380684] [064/132] (725s left) kms_cursor_crc (cursor-onscreen-256x85)
[309.620324] Starting subtest: cursor-onscreen-256x85
[309.666033] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[309.851176] [065/132] (724s left) kms_plane_alpha_blend (coverage-7efc)
[309.945122] Starting subtest: coverage-7efc
[310.248785] Starting dynamic subtest: pipe-A-eDP-1
[310.867826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s)
[310.896937] Starting dynamic subtest: pipe-D-eDP-1
[312.221599] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[312.224017] Subtest coverage-7efc: SUCCESS (2.276s)
[313.059425] [066/132] (721s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[313.148441] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[313.150856] Starting dynamic subtest: pipe-A
[313.173234] Dynamic subtest pipe-A: SKIP (0.019s)
[313.183214] Starting dynamic subtest: pipe-B
[313.202466] Dynamic subtest pipe-B: SKIP (0.031s)
[313.213096] Starting dynamic subtest: pipe-C
[313.233981] Dynamic subtest pipe-C: SKIP (0.031s)
[313.244111] Starting dynamic subtest: pipe-D
[313.267371] Dynamic subtest pipe-D: SKIP (0.032s)
[313.271778] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.117s)
[313.371124] [067/132] (721s left) vgem_basic (busy-fence)
[313.417123] Starting subtest: busy-fence
[313.419051] Subtest busy-fence: SUCCESS (0.000s)
[313.476431] [068/132] (721s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[313.568833] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[313.598221] Starting dynamic subtest: pipe-A-plane-0
[314.019770] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[314.029160] Starting dynamic subtest: pipe-A-plane-3
[314.275379] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[314.284834] Starting dynamic subtest: pipe-A-plane-5
[314.288293] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[315.360240] Starting dynamic subtest: pipe-B-plane-0
[315.829740] Dynamic subtest pipe-B-plane-0: SUCCESS (0.478s)
[315.841393] Starting dynamic subtest: pipe-B-plane-3
[316.096148] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[316.109236] Starting dynamic subtest: pipe-B-plane-5
[316.113605] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[316.411277] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.842s)
[317.239557] [069/132] (717s left) kms_addfb_basic (invalid-set-prop-any)
[317.297402] Starting subtest: invalid-set-prop-any
[317.299425] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[317.435290] [070/132] (717s left) kms_addfb_basic (size-max)
[317.525603] Starting subtest: size-max
[317.527899] Subtest size-max: SUCCESS (0.000s)
[317.640560] [071/132] (717s left) kms_addfb_basic (bad-pitch-128)
[317.702367] Starting subtest: bad-pitch-128
[317.704242] Subtest bad-pitch-128: SUCCESS (0.000s)
[317.836301] [072/132] (716s left) syncobj_timeline (single-wait-available-submitted)
[317.898923] Starting subtest: single-wait-available-submitted
[317.901228] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[318.002018] [073/132] (716s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[318.097474] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[319.121130] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.024s)
[319.280388] [074/132] (715s left) gem_pread (exhaustion)
[319.338426] Subtest exhaustion: SKIP (0.000s)
[319.393867] [075/132] (715s left) kms_frontbuffer_tracking (psr-1p-rte)
[319.495931] Starting subtest: psr-1p-rte
[324.866756] Subtest psr-1p-rte: SUCCESS (5.373s)
[325.014512] [076/132] (709s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[325.135041] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[342.844247] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.706s)
[343.657106] [077/132] (691s left) api_intel_allocator (fork-simple-once)
[343.716949] Starting subtest: fork-simple-once
[343.729719] Subtest fork-simple-once: SUCCESS (0.015s)
[343.839190] [078/132] (691s left) gem_set_tiling_vs_pwrite
[343.965649] [079/132] (691s left) kms_pm_backlight (brightness-with-dpms)
[344.047788] Starting subtest: brightness-with-dpms
[344.097317] Starting dynamic subtest: eDP-1
[346.538192] Dynamic subtest eDP-1: SUCCESS (2.440s)
[346.540713] Subtest brightness-with-dpms: SUCCESS (2.492s)
[347.428662] [080/132] (687s left) kms_lease (lease-invalid-crtc)
[347.525468] Starting subtest: lease-invalid-crtc
[347.527717] Starting dynamic subtest: pipe-A-eDP-1
[347.529770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[347.539483] Starting dynamic subtest: pipe-B-eDP-1
[347.541337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[347.551230] Starting dynamic subtest: pipe-C-eDP-1
[347.553387] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[347.562917] Starting dynamic subtest: pipe-D-eDP-1
[347.564813] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[347.566748] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[347.605928] [081/132] (687s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[347.707077] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[347.711106] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[347.810405] [082/132] (687s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[347.917162] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[354.874566] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.958s)
[355.017472] [083/132] (680s left) kms_dp_linktrain_fallback (dp-fallback)
[355.115885] Starting subtest: dp-fallback
[355.122330] Subtest dp-fallback: SKIP (0.000s)
[355.201762] [084/132] (680s left) kms_vblank (ts-continuation-idle)
[355.294044] Starting subtest: ts-continuation-idle
[355.296392] Starting dynamic subtest: pipe-A-eDP-1
[355.692807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[355.709723] Starting dynamic subtest: pipe-D-eDP-1
[356.745286] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.048s)
[356.747482] Subtest ts-continuation-idle: SUCCESS (1.453s)
[357.628576] [085/132] (677s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[357.731163] Starting subtest: fbc-psr-cursor-mmap-gtt
[357.733522] Starting dynamic subtest: eDP-1
[357.737865] Dynamic subtest eDP-1: SKIP (0.000s)
[357.742226] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[357.809064] [086/132] (677s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[357.919187] Starting subtest: cursor-vs-flip-varying-size
[389.228700] Subtest cursor-vs-flip-varying-size: SUCCESS (31.308s)
[390.056249] [087/132] (645s left) i915_drm_fdinfo (busy-check-all)
[390.100194] Starting subtest: busy-check-all
[390.102444] Starting dynamic subtest: rcs0
[390.109705] Dynamic subtest rcs0: SKIP (0.007s)
[390.123383] Starting dynamic subtest: bcs0
[390.127953] Dynamic subtest bcs0: SKIP (0.000s)
[390.140735] Starting dynamic subtest: vcs0
[390.144809] Dynamic subtest vcs0: SKIP (0.000s)
[390.154129] Starting dynamic subtest: vcs1
[390.158276] Dynamic subtest vcs1: SKIP (0.000s)
[390.167857] Starting dynamic subtest: vecs0
[390.171867] Dynamic subtest vecs0: SKIP (0.000s)
[390.181492] Starting dynamic subtest: ccs0
[390.185660] Dynamic subtest ccs0: SKIP (0.000s)
[390.189811] Subtest busy-check-all: SKIP (0.013s)
[390.230840] [088/132] (645s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[390.356915] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[390.359279] Starting dynamic subtest: pipe-A-eDP-1
[390.379472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[390.390165] Starting dynamic subtest: pipe-B-eDP-1
[390.409900] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[390.419459] Starting dynamic subtest: pipe-C-eDP-1
[390.438422] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[390.447613] Starting dynamic subtest: pipe-D-eDP-1
[390.466606] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[390.468466] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[392.627293] [089/132] (642s left) prime_busy (before-wait)
[392.697238] Starting subtest: before-wait
[392.702555] Starting dynamic subtest: rcs0
[392.737108] Dynamic subtest rcs0: SUCCESS (0.036s)
[392.748723] Starting dynamic subtest: bcs0
[392.783134] Dynamic subtest bcs0: SUCCESS (0.045s)
[392.793795] Starting dynamic subtest: vcs0
[392.822894] Dynamic subtest vcs0: SUCCESS (0.039s)
[392.832911] Starting dynamic subtest: vcs1
[392.863086] Dynamic subtest vcs1: SUCCESS (0.039s)
[392.873194] Starting dynamic subtest: vecs0
[392.905062] Dynamic subtest vecs0: SUCCESS (0.041s)
[392.915111] Starting dynamic subtest: ccs0
[392.945841] Dynamic subtest ccs0: SUCCESS (0.040s)
[393.054963] Subtest before-wait: SUCCESS (0.356s)
[393.131753] [090/132] (642s left) gem_ppgtt (blt-vs-render-ctx0)
[393.189337] Starting subtest: blt-vs-render-ctx0
[426.004594] Subtest blt-vs-render-ctx0: SUCCESS (32.812s)
[426.126445] [091/132] (609s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[426.284193] Starting subtest: cursorB-vs-flipB-atomic
[426.288841] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[426.429251] [092/132] (609s left) gem_exec_reloc (basic-wc-read-active)
[426.490259] Subtest basic-wc-read-active: SKIP (0.000s)
[426.561136] [093/132] (609s left) gem_exec_fence (syncobj-import)
[427.029559] Starting subtest: syncobj-import
[427.034781] Subtest syncobj-import: SUCCESS (0.005s)
[428.867832] [094/132] (606s left) kms_psr (fbc-psr2-sprite-blt)
[428.969477] Starting subtest: fbc-psr2-sprite-blt
[428.971768] Starting dynamic subtest: eDP-1
[428.975908] Dynamic subtest eDP-1: SKIP (0.000s)
[428.980212] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[429.050558] [095/132] (606s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[429.142343] Starting subtest: plane-lut1d-post-ctm3x4
[429.300845] Starting dynamic subtest: pipe-A-plane-0
[429.465808] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[429.476803] Starting dynamic subtest: pipe-A-plane-1
[429.633022] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[429.643598] Starting dynamic subtest: pipe-A-plane-2
[429.821501] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[431.050311] Starting dynamic subtest: pipe-B-plane-0
[431.211675] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[431.223123] Starting dynamic subtest: pipe-B-plane-1
[431.353020] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[431.363626] Starting dynamic subtest: pipe-B-plane-2
[431.508961] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[432.754197] Starting dynamic subtest: pipe-C-plane-0
[432.878727] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[432.889449] Starting dynamic subtest: pipe-C-plane-1
[433.022955] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[433.033591] Starting dynamic subtest: pipe-C-plane-2
[433.167726] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[434.367760] Starting dynamic subtest: pipe-D-plane-0
[434.516731] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[434.530541] Starting dynamic subtest: pipe-D-plane-1
[434.658705] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[434.670248] Starting dynamic subtest: pipe-D-plane-2
[434.803332] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[435.095146] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.953s)
[435.949604] [096/132] (599s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[436.009051] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[436.013535] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[436.212016] [097/132] (599s left) kms_big_fb (linear-8bpp-rotate-180)
[436.311702] Starting subtest: linear-8bpp-rotate-180
[437.580034] Subtest linear-8bpp-rotate-180: SUCCESS (1.269s)
[437.716086] [098/132] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[437.816908] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[437.820300] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[437.913361] [099/132] (598s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[438.009359] Starting subtest: extended-modeset-hang-oldfb-with-reset
[438.011343] Starting dynamic subtest: pipe-A
[449.730637] Dynamic subtest pipe-A: SUCCESS (11.719s)
[449.745040] Starting dynamic subtest: pipe-D
[462.005824] Dynamic subtest pipe-D: SUCCESS (12.268s)
[462.008103] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.992s)
[462.810919] [100/132] (573s left) gem_exec_schedule (timeslicing)
[462.889539] Starting subtest: timeslicing
[462.891492] Starting dynamic subtest: rcs0
[462.901617] Dynamic subtest rcs0: SUCCESS (0.021s)
[462.914235] Starting dynamic subtest: bcs0
[462.923360] Dynamic subtest bcs0: SUCCESS (0.021s)
[462.933745] Starting dynamic subtest: vcs0
[462.943784] Dynamic subtest vcs0: SUCCESS (0.020s)
[462.953914] Starting dynamic subtest: vcs1
[462.965037] Dynamic subtest vcs1: SUCCESS (0.020s)
[462.977729] Starting dynamic subtest: vecs0
[462.984922] Dynamic subtest vecs0: SUCCESS (0.020s)
[462.994929] Starting dynamic subtest: ccs0
[463.004662] Dynamic subtest ccs0: SUCCESS (0.019s)
[463.006790] Subtest timeslicing: SUCCESS (0.125s)
[464.859934] [101/132] (571s left) kms_chamelium_color (ctm-0-25)
[464.957672] Subtest ctm-0-25: SKIP (0.000s)
[465.008097] [102/132] (571s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[465.106599] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[465.108749] Starting dynamic subtest: pipe-A-eDP-1
[465.201943] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[465.214110] Starting dynamic subtest: pipe-B-eDP-1
[466.381029] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[466.385757] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.280s)
[467.576926] [103/132] (568s left) gem_mmap (short-mmap)
[467.642342] Subtest short-mmap: SKIP (0.000s)
[467.697621] [104/132] (568s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[467.747473] Starting subtest: multi-wait-available-unsubmitted-submitted
[467.749739] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[467.859170] [105/132] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[467.959676] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[467.963800] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[468.064339] [106/132] (568s left) kms_getfb (getfb2-accept-nv12)
[468.168479] Starting subtest: getfb2-accept-nv12
[468.170743] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[468.262494] [107/132] (568s left) syncobj_timeline (invalid-signal-zero-handles)
[468.317081] Starting subtest: invalid-signal-zero-handles
[468.319326] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[468.411887] [108/132] (567s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[468.513018] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[468.516307] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[468.588499] [109/132] (567s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[468.689366] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[468.691362] Starting dynamic subtest: pipe-A-eDP-1
[468.741184] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[468.753298] Starting dynamic subtest: pipe-B-eDP-1
[468.799918] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[468.810413] Starting dynamic subtest: pipe-C-eDP-1
[468.858078] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[468.869839] Starting dynamic subtest: pipe-D-eDP-1
[468.916505] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[468.920358] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[470.942412] [110/132] (565s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[471.041235] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[471.049864] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[471.135637] [111/132] (565s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[471.233674] Starting subtest: async-flip-with-page-flip-events-tiled
[471.605426] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[474.416492] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.811s)
[474.427073] Starting dynamic subtest: pipe-A-eDP-1-4
[476.589698] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[476.600083] Starting dynamic subtest: pipe-A-eDP-1-4
[478.600478] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[478.613401] Starting dynamic subtest: pipe-A-eDP-1-x
[480.780071] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[481.147942] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[483.939051] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[483.951539] Starting dynamic subtest: pipe-B-eDP-1-4
[486.125012] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[486.138215] Starting dynamic subtest: pipe-B-eDP-1-4
[488.135131] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[488.147463] Starting dynamic subtest: pipe-B-eDP-1-x
[490.324898] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[490.690740] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[493.474997] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[493.485920] Starting dynamic subtest: pipe-C-eDP-1-4
[495.649841] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[495.660111] Starting dynamic subtest: pipe-C-eDP-1-4
[497.660072] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[497.671086] Starting dynamic subtest: pipe-C-eDP-1-x
[499.838365] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[500.206387] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[503.008715] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.809s)
[503.020749] Starting dynamic subtest: pipe-D-eDP-1-4
[505.182851] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[505.196549] Starting dynamic subtest: pipe-D-eDP-1-4
[507.193130] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[507.206714] Starting dynamic subtest: pipe-D-eDP-1-x
[509.370968] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[509.373419] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.137s)
[510.604416] [112/132] (525s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[510.713906] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[510.718280] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[510.805878] [113/132] (525s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[510.851894] Starting subtest: etime-multi-wait-for-submit-submitted
[510.952230] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[511.030663] [114/132] (525s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[512.952684] Starting subtest: modeset-non-lpsp-stress-no-wait
[513.012091] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.058s)
[513.342857] [115/132] (523s left) gem_exec_params (sol-reset-invalid)
[513.394856] Starting subtest: sol-reset-invalid
[513.399885] Subtest sol-reset-invalid: SUCCESS (0.003s)
[514.856964] [116/132] (521s left) gem_mmap_gtt (cpuset-big-copy)
[514.918749] Subtest cpuset-big-copy: SKIP (0.000s)
[514.983757] [117/132] (521s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[515.084419] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[522.757926] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.677s)
[522.901202] [118/132] (513s left) kms_psr (psr2-sprite-plane-onoff)
[522.994527] Starting subtest: psr2-sprite-plane-onoff
[522.996702] Starting dynamic subtest: eDP-1
[524.701177] Dynamic subtest eDP-1: SUCCESS (1.706s)
[524.703370] Subtest psr2-sprite-plane-onoff: SUCCESS (1.707s)
[525.558948] [119/132] (511s left) kms_dsc (dsc-with-output-formats)
[525.646622] Starting subtest: dsc-with-output-formats
[525.668435] Subtest dsc-with-output-formats: SKIP (0.000s)
[525.727038] [120/132] (511s left) gen3_mixed_blits
[525.851824] [121/132] (511s left) gem_mmap_offset (clear-via-pagefault)
[525.912046] Starting subtest: clear-via-pagefault
[525.914516] Starting dynamic subtest: smem0
[560.537885] Dynamic subtest smem0: SUCCESS (34.622s)
[560.540111] Subtest clear-via-pagefault: SUCCESS (34.623s)
[560.638958] [122/132] (476s left) gem_eio (reset-stress)
[560.881961] Starting subtest: reset-stress
[560.884189] Starting dynamic subtest: render
[565.947631] Dynamic subtest render: SUCCESS (5.064s)
[565.965553] Starting dynamic subtest: bsd1
[584.303464] Dynamic subtest bsd1: SUCCESS (18.354s)
[584.320172] Starting dynamic subtest: bsd2
[602.277231] Dynamic subtest bsd2: SUCCESS (17.972s)
[602.294773] Starting dynamic subtest: blt
[602.299103] Dynamic subtest blt: SKIP (0.000s)
[602.309061] Starting dynamic subtest: vebox
[620.346405] Dynamic subtest vebox: SUCCESS (18.066s)
[620.348768] Subtest reset-stress: SUCCESS (59.460s)
[621.868730] [123/132] (415s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[621.927103] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[621.929335] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[622.033926] [124/132] (414s left) kms_vblank (query-busy-hang)
[622.138024] Starting subtest: query-busy-hang
[622.140189] Starting dynamic subtest: pipe-A-eDP-1
[624.015682] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[624.031894] Starting dynamic subtest: pipe-D-eDP-1
[626.619802] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.601s)
[626.622171] Subtest query-busy-hang: SUCCESS (4.482s)
[627.422142] [125/132] (409s left) kms_psr (fbc-pr-cursor-plane-onoff)
[627.517773] Starting subtest: fbc-pr-cursor-plane-onoff
[627.521826] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[627.590078] [126/132] (409s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[627.679381] Starting subtest: psr-1p-primscrn-cur-indfb-move
[635.013405] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.337s)
[635.130862] [127/132] (402s left) tools_test (sysfs_l3_parity)
[635.188898] Starting subtest: sysfs_l3_parity
[635.249333] Subtest sysfs_l3_parity: SKIP (0.069s)
[635.305097] [128/132] (401s left) kms_vblank (crtc-id)
[635.402704] Starting subtest: crtc-id
[635.404482] Starting dynamic subtest: pipe-A-eDP-1
[635.860605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[635.878601] Starting dynamic subtest: pipe-D-eDP-1
[636.961440] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s)
[636.963736] Subtest crtc-id: SUCCESS (1.559s)
[637.794020] [129/132] (399s left) gem_ctx_engines (independent)
[637.852613] Starting subtest: independent
[637.854529] Starting dynamic subtest: rcs0
[637.997903] Dynamic subtest rcs0: SUCCESS (0.146s)
[638.011187] Starting dynamic subtest: bcs0
[638.159838] Dynamic subtest bcs0: SUCCESS (0.162s)
[638.172272] Starting dynamic subtest: vcs0
[638.309458] Dynamic subtest vcs0: SUCCESS (0.148s)
[638.322683] Starting dynamic subtest: vcs1
[638.468806] Dynamic subtest vcs1: SUCCESS (0.159s)
[638.480580] Starting dynamic subtest: vecs0
[638.621411] Dynamic subtest vecs0: SUCCESS (0.150s)
[638.632500] Starting dynamic subtest: ccs0
[638.799880] Dynamic subtest ccs0: SUCCESS (0.178s)
[638.812941] Starting dynamic subtest: all-engines
[639.469343] Dynamic subtest all-engines: SUCCESS (0.668s)
[639.472111] Subtest independent: SUCCESS (1.618s)
[639.971431] [130/132] (397s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[640.076559] Starting subtest: flip-vs-dpms-on-nop-interruptible
[640.078883] Starting dynamic subtest: A-eDP1
[641.891034] Dynamic subtest A-eDP1: SUCCESS (1.812s)
[641.904577] Starting dynamic subtest: B-eDP1
[643.730533] Dynamic subtest B-eDP1: SUCCESS (1.837s)
[643.743335] Starting dynamic subtest: C-eDP1
[645.549584] Dynamic subtest C-eDP1: SUCCESS (1.817s)
[645.564738] Starting dynamic subtest: D-eDP1
[647.381109] Dynamic subtest D-eDP1: SUCCESS (1.830s)
[647.385844] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.308s)
[648.554032] [131/132] (388s left) kms_plane_lowres (tiling-x)
[648.642940] Starting subtest: tiling-x
[648.645257] Starting dynamic subtest: pipe-A-eDP-1
[648.649752] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[648.939530] Starting dynamic subtest: pipe-B-eDP-1
[648.944043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[648.954545] Starting dynamic subtest: pipe-C-eDP-1
[648.959009] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[648.969272] Starting dynamic subtest: pipe-D-eDP-1
[648.973608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[648.977945] Subtest tiling-x: SKIP (0.293s)
[649.775326] [132/132] (387s left) i915_pm_freq_api (freq-reset)
[649.836884] Starting subtest: freq-reset
[649.839232] Starting dynamic subtest: gt0
[650.045583] Dynamic subtest gt0: SUCCESS (0.205s)
[650.057570] Starting dynamic subtest: gt1
[650.222440] Dynamic subtest gt1: SUCCESS (0.174s)
[650.225233] Subtest freq-reset: SUCCESS (0.381s)
[650.292927] 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: syncobj_eventfd
results: parsing output: 50/ for test: prime_mmap
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: gem_ctx_param
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: kms_cursor_edge_walk
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_vm_create
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_plane_alpha_blend
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_pread
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: api_intel_allocator
results: parsing output: 77/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 78/ for test: kms_pm_backlight
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_dp_linktrain_fallback
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: prime_busy
results: parsing output: 89/ for test: gem_ppgtt
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_color_pipeline
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_busy
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_chamelium_color
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: gem_mmap
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_dsc
results: parsing output: 119/ for test: gen3_mixed_blits
results: parsing output: 120/ for test: gem_mmap_offset
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: tools_test
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_ctx_engines
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_plane_lowres
results: parsing output: 131/ for test: i915_pm_freq_api
Done.