[58.901602] Initializing watchdogs
[58.901672]   /dev/watchdog0
[58.919884] [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]
[58.924500] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.926853] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.930107] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[59.057904] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[59.062307] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[59.148621] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[59.239466] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[59.243698] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[59.338794] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[59.440936] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[60.131164] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[60.289487] [004/133] (959s left) gen7_exec_parse (basic-offset)
[60.349747] Subtest basic-offset: SKIP (0.000s)
[60.408498] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[60.498656] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[64.809581] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.315s)
[65.937574] [006/133] (953s left) tools_test (tools_test)
[65.993246] Starting subtest: tools_test
[66.052850] Subtest tools_test: SUCCESS (0.076s)
[66.125685] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[66.215054] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[66.219657] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[67.383312] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[67.533685] Starting subtest: modeset-vs-vblank-race
[67.536244] Starting dynamic subtest: A-eDP1
[72.285337] Dynamic subtest A-eDP1: SUCCESS (4.751s)
[72.294391] Starting dynamic subtest: B-eDP1
[77.021506] Dynamic subtest B-eDP1: SUCCESS (4.735s)
[77.031280] Starting dynamic subtest: C-eDP1
[81.748447] Dynamic subtest C-eDP1: SUCCESS (4.726s)
[81.758263] Starting dynamic subtest: D-eDP1
[86.406491] Dynamic subtest D-eDP1: SUCCESS (4.657s)
[86.411514] Subtest modeset-vs-vblank-race: SUCCESS (18.878s)
[87.560426] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[89.084052] Starting subtest: reg-read-ioctl
[91.367335] Subtest reg-read-ioctl: SUCCESS (2.283s)
[91.739244] [010/133] (928s left) gem_exec_balancer (hang)
[92.012361] Starting subtest: hang
[93.906306] Subtest hang: SUCCESS (1.894s)
[94.038673] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[94.140039] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[94.144438] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[94.211547] [012/133] (925s left) perf_pmu (faulting-read)
[94.256198] Starting subtest: faulting-read
[94.258516] Starting dynamic subtest: wb
[94.260778] Dynamic subtest wb: SUCCESS (0.001s)
[94.268850] Starting dynamic subtest: wc
[94.271068] Dynamic subtest wc: SUCCESS (0.000s)
[94.278981] Starting dynamic subtest: uc
[94.281196] Dynamic subtest uc: SUCCESS (0.000s)
[94.283383] Subtest faulting-read: SUCCESS (0.002s)
[94.361951] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[94.452275] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[94.456553] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[94.539580] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[94.930525] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[95.734243] [015/133] (924s left) gem_exec_schedule (pi-distinct-iova)
[95.919067] Starting subtest: pi-distinct-iova
[95.921194] Starting dynamic subtest: rcs0
[95.990676] Dynamic subtest rcs0: SUCCESS (0.074s)
[96.000602] Starting dynamic subtest: vcs0
[96.059423] Dynamic subtest vcs0: SUCCESS (0.068s)
[96.070709] Starting dynamic subtest: vcs1
[96.119402] Dynamic subtest vcs1: SUCCESS (0.059s)
[96.129626] Starting dynamic subtest: vecs0
[96.176999] Dynamic subtest vecs0: SUCCESS (0.059s)
[96.186052] Starting dynamic subtest: ccs0
[96.236520] Dynamic subtest ccs0: SUCCESS (0.058s)
[96.238964] Subtest pi-distinct-iova: SUCCESS (0.321s)
[97.976551] [016/133] (922s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[98.068893] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[98.073094] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[98.167147] [017/133] (921s left) drm_read (short-buffer-block)
[98.312895] Starting subtest: short-buffer-block
[98.315584] Subtest short-buffer-block: SUCCESS (0.000s)
[98.449861] [018/133] (921s left) perf (oa-formats)
[98.580689] Starting subtest: oa-formats
[98.582982] Starting dynamic subtest: 0-rcs0
[98.595345] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[98.608750] Starting dynamic subtest: 1-vcs1
[98.616959] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[98.619421] Subtest oa-formats: SUCCESS (0.037s)
[98.669636] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[98.776584] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[98.780686] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[98.885527] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[98.974082] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[98.977964] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[99.062785] [021/133] (921s left) kms_psr (pr-basic)
[99.152164] Starting subtest: pr-basic
[99.155519] Subtest pr-basic: SKIP (0.000s)
[99.221187] [022/133] (921s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[99.325213] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[99.327223] Starting dynamic subtest: pipe-A-eDP-1
[99.348282] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.357320] Starting dynamic subtest: pipe-B-eDP-1
[99.375768] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.382853] Starting dynamic subtest: pipe-C-eDP-1
[99.399949] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.408536] Starting dynamic subtest: pipe-D-eDP-1
[99.426099] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.429562] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[101.632053] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[102.026453] Subtest hdmi-mode-timings: SKIP (0.000s)
[102.844617] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[102.982136] Starting subtest: dp-mst-lic-type-0-hdcp14
[102.986766] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[103.114205] [025/133] (917s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[103.211108] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[103.215124] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[103.291531] [026/133] (917s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[103.373694] Starting subtest: primary-4-tiled-reflect-x-180
[110.361952] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.990s)
[111.536160] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[111.648054] Starting subtest: 2x-flip-vs-panning-interruptible
[111.659742] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[111.747989] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[111.841221] Starting subtest: plain-flip-fb-recreate
[111.843590] Starting dynamic subtest: A-eDP1
[120.713691] Dynamic subtest A-eDP1: SUCCESS (8.873s)
[120.721531] Starting dynamic subtest: B-eDP1
[129.560294] Dynamic subtest B-eDP1: SUCCESS (8.845s)
[129.573046] Starting dynamic subtest: C-eDP1
[138.368738] Dynamic subtest C-eDP1: SUCCESS (8.807s)
[138.384242] Starting dynamic subtest: D-eDP1
[147.203144] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[147.207798] Subtest plain-flip-fb-recreate: SUCCESS (35.368s)
[148.385798] [029/133] (872s left) gem_tiled_partial_pwrite_pread (writes)
[148.438939] Subtest writes: SKIP (0.000s)
[148.502277] [030/133] (872s left) gem_lmem_swapping (heavy-verify-random)
[148.544613] Subtest heavy-verify-random: SKIP (0.000s)
[148.590278] [031/133] (872s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[148.687999] Starting subtest: x-tiled-64bpp-rotate-90
[148.707052] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s)
[148.829764] [032/133] (871s left) vgem_basic (debugfs)
[148.928999] Starting subtest: debugfs
[148.931278] Subtest debugfs: SUCCESS (0.000s)
[148.986438] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[148.989904] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[149.081187] Starting subtest: legacy-setmode
[149.083511] Starting dynamic subtest: pipe-A-eDP-1
[155.982883] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.899s)
[155.985282] Subtest legacy-setmode: SUCCESS (6.901s)
[156.868628] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[157.006873] Starting subtest: reject-modify-context-protection-off-2
[157.009753] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[157.115302] [035/133] (863s left) gem_exec_basic (basic)
[157.185838] Starting subtest: basic
[157.188244] Starting dynamic subtest: rcs0-smem
[157.190582] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[157.200201] Starting dynamic subtest: bcs0-smem
[157.202371] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[157.210257] Starting dynamic subtest: vcs0-smem
[157.212495] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[157.220276] Starting dynamic subtest: vcs1-smem
[157.222447] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[157.230246] Starting dynamic subtest: vecs0-smem
[157.232516] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[157.240470] Starting dynamic subtest: ccs0-smem
[157.242676] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[157.244872] Subtest basic: SUCCESS (0.012s)
[158.971339] [036/133] (861s left) api_intel_bb (offset-control)
[159.027190] Starting subtest: offset-control
[159.032328] Subtest offset-control: SUCCESS (0.007s)
[159.169274] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[159.280915] Starting subtest: basic-max-non-joiner
[159.285152] Subtest basic-max-non-joiner: SKIP (0.000s)
[159.347543] [038/133] (861s left) kms_addfb_basic (small-bo)
[159.442216] Starting subtest: small-bo
[159.444161] Subtest small-bo: SUCCESS (0.000s)
[159.530074] [039/133] (861s left) i915_query (query-topology-garbage-items)
[159.598281] Starting subtest: query-topology-garbage-items
[159.600232] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[159.693727] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[159.794657] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[159.819105] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.022s)
[159.861031] [041/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[160.929752] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[160.934319] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[161.031709] [042/133] (860s left) gem_exec_params (cliprects-invalid)
[161.082334] Starting subtest: cliprects-invalid
[161.084754] Subtest cliprects-invalid: SUCCESS (0.000s)
[161.176686] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[161.342489] Starting subtest: cursor-random-64x64
[161.350046] Starting dynamic subtest: pipe-A-eDP-1
[164.682650] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.334s)
[164.712831] Starting dynamic subtest: pipe-D-eDP-1
[168.665815] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.960s)
[168.668211] Subtest cursor-random-64x64: SUCCESS (7.323s)
[169.538972] [044/133] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[169.640029] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[169.644351] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[169.755573] [045/133] (851s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[169.869720] Starting subtest: 4-tiled-16bpp-rotate-180
[171.270291] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.401s)
[171.377546] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[171.432142] Starting subtest: create-valid-dumb
[171.434066] Subtest create-valid-dumb: SUCCESS (0.000s)
[171.542695] [047/133] (849s left) gem_softpin (zero)
[171.599119] Starting subtest: zero
[171.605248] Subtest zero: SUCCESS (0.005s)
[171.724817] [048/133] (849s left) gem_blits (basic)
[171.774201] Starting subtest: basic
[173.204341] Subtest basic: SUCCESS (1.428s)
[173.311328] [049/133] (848s left) gem_busy (close-race)
[173.374398] Starting subtest: close-race
[198.932848] Subtest close-race: SUCCESS (25.555s)
[199.307591] [050/133] (822s left) gem_exec_alignment (forked)
[199.404626] Starting subtest: forked
[238.124087] Subtest forked: SUCCESS (38.716s)
[238.223488] [051/133] (783s left) syncobj_eventfd (binary-wait-before-signal)
[238.313925] Starting subtest: binary-wait-before-signal
[238.344770] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[238.422986] [052/133] (783s left) prime_mmap (test_errors)
[238.481869] Starting subtest: test_errors
[238.483793] Starting dynamic subtest: test_errors-smem
[238.579857] Dynamic subtest test_errors-smem: SUCCESS (0.099s)
[238.582500] Subtest test_errors: SUCCESS (0.100s)
[238.677259] [053/133] (782s left) gem_ctx_persistence (heartbeat-stop)
[238.744169] Starting subtest: heartbeat-stop
[238.748742] Subtest heartbeat-stop: SKIP (0.000s)
[238.851864] [054/133] (782s left) gem_ctx_param (invalid-get-ringsize)
[238.902700] Starting subtest: invalid-get-ringsize
[238.905096] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[238.998076] [055/133] (782s left) i915_query (query-topology-matches-eu-total)
[239.052217] Starting subtest: query-topology-matches-eu-total
[239.054602] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[239.166874] [056/133] (782s left) kms_cursor_edge_walk (64x64-right-edge)
[239.260998] Starting subtest: 64x64-right-edge
[239.262844] Starting dynamic subtest: pipe-A-eDP-1
[242.692869] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.431s)
[242.702252] Starting dynamic subtest: pipe-D-eDP-1
[245.828028] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[245.830406] Subtest 64x64-right-edge: SUCCESS (6.568s)
[246.634623] [057/133] (775s left) kms_plane (plane-position-covered)
[246.730989] Starting subtest: plane-position-covered
[247.265306] Starting dynamic subtest: pipe-A-plane-1
[248.536380] Dynamic subtest pipe-A-plane-1: SUCCESS (1.269s)
[248.546762] Starting dynamic subtest: pipe-A-plane-2
[249.839133] Dynamic subtest pipe-A-plane-2: SUCCESS (1.302s)
[249.848736] Starting dynamic subtest: pipe-A-plane-3
[251.119736] Dynamic subtest pipe-A-plane-3: SUCCESS (1.282s)
[251.130566] Starting dynamic subtest: pipe-A-plane-4
[252.415784] Dynamic subtest pipe-A-plane-4: SUCCESS (1.295s)
[252.426534] Starting dynamic subtest: pipe-A-plane-5
[252.443917] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[253.588468] Starting dynamic subtest: pipe-B-plane-1
[254.893626] Dynamic subtest pipe-B-plane-1: SUCCESS (1.311s)
[254.903817] Starting dynamic subtest: pipe-B-plane-2
[256.219353] Dynamic subtest pipe-B-plane-2: SUCCESS (1.325s)
[256.228865] Starting dynamic subtest: pipe-B-plane-3
[257.460058] Dynamic subtest pipe-B-plane-3: SUCCESS (1.242s)
[257.470435] Starting dynamic subtest: pipe-B-plane-4
[258.703197] Dynamic subtest pipe-B-plane-4: SUCCESS (1.240s)
[258.713330] Starting dynamic subtest: pipe-B-plane-5
[258.726193] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[258.728563] Subtest plane-position-covered: SUCCESS (11.995s)
[259.504068] [058/133] (762s left) kms_frontbuffer_tracking (psr-suspend)
[259.607169] Starting subtest: psr-suspend
[298.040774] Subtest psr-suspend: SUCCESS (9.670s)
[303.197217] [059/133] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[303.312090] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[303.316480] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[303.406642] [060/133] (723s left) gem_exec_schedule (fairslice)
[303.472968] Starting subtest: fairslice
[303.474828] Starting dynamic subtest: rcs0
[305.489331] Dynamic subtest rcs0: SUCCESS (2.020s)
[305.500753] Starting dynamic subtest: bcs0
[307.508078] Dynamic subtest bcs0: SUCCESS (2.015s)
[307.518543] Starting dynamic subtest: vcs0
[309.527658] Dynamic subtest vcs0: SUCCESS (2.017s)
[309.537097] Starting dynamic subtest: vcs1
[311.548240] Dynamic subtest vcs1: SUCCESS (2.019s)
[311.558361] Starting dynamic subtest: vecs0
[313.568379] Dynamic subtest vecs0: SUCCESS (2.016s)
[313.578436] Starting dynamic subtest: ccs0
[315.585458] Dynamic subtest ccs0: SUCCESS (2.017s)
[315.587659] Subtest fairslice: SUCCESS (12.110s)
[315.882630] [061/133] (711s left) sw_sync (alloc_fence_invalid_timeline)
[315.932783] Starting subtest: alloc_fence_invalid_timeline
[315.935151] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[316.010866] [062/133] (710s left) gem_exec_whisper (basic-fds-forked)
[316.082849] Starting subtest: basic-fds-forked
[340.324367] Subtest basic-fds-forked: SUCCESS (24.235s)
[340.508602] [063/133] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[340.632625] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[340.636637] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[340.736494] [064/133] (686s left) gem_vm_create (execbuf)
[340.790875] Starting subtest: execbuf
[340.798340] Subtest execbuf: SUCCESS (0.007s)
[340.923500] [065/133] (686s left) kms_cursor_crc (cursor-onscreen-256x85)
[341.170605] Starting subtest: cursor-onscreen-256x85
[341.219300] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[341.389773] [066/133] (685s left) kms_plane_alpha_blend (coverage-7efc)
[341.478295] Starting subtest: coverage-7efc
[341.775282] Starting dynamic subtest: pipe-A-eDP-1
[342.388884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.613s)
[342.420474] Starting dynamic subtest: pipe-D-eDP-1
[343.700970] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.288s)
[343.703216] Subtest coverage-7efc: SUCCESS (2.223s)
[344.540812] [067/133] (682s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[344.630020] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[344.632312] Starting dynamic subtest: pipe-A
[344.650264] Dynamic subtest pipe-A: SKIP (0.017s)
[344.660888] Starting dynamic subtest: pipe-B
[344.682761] Dynamic subtest pipe-B: SKIP (0.031s)
[344.692817] Starting dynamic subtest: pipe-C
[344.715435] Dynamic subtest pipe-C: SKIP (0.031s)
[344.725322] Starting dynamic subtest: pipe-D
[344.745468] Dynamic subtest pipe-D: SKIP (0.031s)
[344.749620] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.113s)
[344.855240] [068/133] (682s left) vgem_basic (busy-fence)
[344.903023] Starting subtest: busy-fence
[344.905011] Subtest busy-fence: SUCCESS (0.000s)
[344.959134] [069/133] (682s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[345.051843] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[345.081099] Starting dynamic subtest: pipe-A-plane-0
[345.535678] Dynamic subtest pipe-A-plane-0: SUCCESS (0.455s)
[345.545419] Starting dynamic subtest: pipe-A-plane-3
[345.791221] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[345.800769] Starting dynamic subtest: pipe-A-plane-5
[345.804500] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[346.922755] Starting dynamic subtest: pipe-B-plane-0
[347.346279] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[347.358269] Starting dynamic subtest: pipe-B-plane-3
[347.601876] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[347.612210] Starting dynamic subtest: pipe-B-plane-5
[347.616817] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[347.927562] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.877s)
[348.804151] [070/133] (678s left) kms_addfb_basic (invalid-set-prop-any)
[348.867064] Starting subtest: invalid-set-prop-any
[348.869373] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[349.009126] [071/133] (678s left) kms_addfb_basic (size-max)
[349.120721] Starting subtest: size-max
[349.122867] Subtest size-max: SUCCESS (0.000s)
[349.220384] [072/133] (678s left) kms_addfb_basic (bad-pitch-128)
[349.278806] Starting subtest: bad-pitch-128
[349.281083] Subtest bad-pitch-128: SUCCESS (0.000s)
[349.422268] [073/133] (678s left) syncobj_timeline (single-wait-available-submitted)
[349.472520] Starting subtest: single-wait-available-submitted
[349.474827] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[349.568670] [074/133] (677s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[349.665978] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[350.779513] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.112s)
[350.880526] [075/133] (676s left) gem_pread (exhaustion)
[350.953801] Subtest exhaustion: SKIP (0.000s)
[351.020893] [076/133] (676s left) kms_frontbuffer_tracking (psr-1p-rte)
[351.109926] Starting subtest: psr-1p-rte
[356.492971] Subtest psr-1p-rte: SUCCESS (5.385s)
[356.622389] [077/133] (671s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[356.749476] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[374.159306] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.406s)
[374.947559] [078/133] (652s left) api_intel_allocator (fork-simple-once)
[375.019819] Starting subtest: fork-simple-once
[375.031367] Subtest fork-simple-once: SUCCESS (0.013s)
[375.145121] [079/133] (652s left) gem_set_tiling_vs_pwrite
[375.269697] [080/133] (652s left) kms_pm_backlight (brightness-with-dpms)
[375.370303] Starting subtest: brightness-with-dpms
[375.421251] Starting dynamic subtest: eDP-1
[377.852315] Dynamic subtest eDP-1: SUCCESS (2.433s)
[377.854773] Subtest brightness-with-dpms: SUCCESS (2.483s)
[378.727101] [081/133] (649s left) kms_lease (lease-invalid-crtc)
[378.823645] Starting subtest: lease-invalid-crtc
[378.825869] Starting dynamic subtest: pipe-A-eDP-1
[378.828123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[378.838146] Starting dynamic subtest: pipe-B-eDP-1
[378.840318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[378.850166] Starting dynamic subtest: pipe-C-eDP-1
[378.852365] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[378.862269] Starting dynamic subtest: pipe-D-eDP-1
[378.864378] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[378.866433] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[378.905032] [082/133] (648s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[378.999963] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[379.004033] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[379.096604] [083/133] (648s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[379.201000] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[386.151921] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.952s)
[386.291792] [084/133] (641s left) kms_dp_linktrain_fallback (dp-fallback)
[386.386973] Starting subtest: dp-fallback
[386.393880] Subtest dp-fallback: SKIP (0.000s)
[386.464150] [085/133] (641s left) kms_vblank (ts-continuation-idle)
[386.569789] Starting subtest: ts-continuation-idle
[386.571943] Starting dynamic subtest: pipe-A-eDP-1
[386.977651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[386.993827] Starting dynamic subtest: pipe-D-eDP-1
[388.044878] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.065s)
[388.047336] Subtest ts-continuation-idle: SUCCESS (1.476s)
[388.920504] [086/133] (639s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[389.021296] Starting subtest: fbc-psr-cursor-mmap-gtt
[389.023716] Starting dynamic subtest: eDP-1
[389.028111] Dynamic subtest eDP-1: SKIP (0.000s)
[389.032532] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[389.103658] [087/133] (638s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[389.221525] Starting subtest: cursor-vs-flip-varying-size
[420.414114] Subtest cursor-vs-flip-varying-size: SUCCESS (31.190s)
[421.253338] [088/133] (606s left) i915_drm_fdinfo (busy-check-all)
[421.299393] Starting subtest: busy-check-all
[421.301666] Starting dynamic subtest: rcs0
[421.306191] Dynamic subtest rcs0: SKIP (0.004s)
[421.322862] Starting dynamic subtest: bcs0
[421.326852] Dynamic subtest bcs0: SKIP (0.000s)
[421.336279] Starting dynamic subtest: vcs0
[421.340403] Dynamic subtest vcs0: SKIP (0.000s)
[421.349734] Starting dynamic subtest: vcs1
[421.353812] Dynamic subtest vcs1: SKIP (0.000s)
[421.363207] Starting dynamic subtest: vecs0
[421.367395] Dynamic subtest vecs0: SKIP (0.000s)
[421.376738] Starting dynamic subtest: ccs0
[421.380821] Dynamic subtest ccs0: SKIP (0.000s)
[421.384925] Subtest busy-check-all: SKIP (0.010s)
[421.423567] [089/133] (606s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[421.545825] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[421.548017] Starting dynamic subtest: pipe-A-eDP-1
[421.568374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[421.580538] Starting dynamic subtest: pipe-B-eDP-1
[421.598849] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[421.608659] Starting dynamic subtest: pipe-C-eDP-1
[421.626962] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[421.636413] Starting dynamic subtest: pipe-D-eDP-1
[421.656734] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[421.659144] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[423.833135] [090/133] (604s left) prime_busy (before-wait)
[423.882232] Starting subtest: before-wait
[423.887678] Starting dynamic subtest: rcs0
[423.917123] Dynamic subtest rcs0: SUCCESS (0.031s)
[423.927044] Starting dynamic subtest: bcs0
[423.965089] Dynamic subtest bcs0: SUCCESS (0.047s)
[423.975744] Starting dynamic subtest: vcs0
[424.005446] Dynamic subtest vcs0: SUCCESS (0.040s)
[424.015133] Starting dynamic subtest: vcs1
[424.044367] Dynamic subtest vcs1: SUCCESS (0.038s)
[424.053995] Starting dynamic subtest: vecs0
[424.084382] Dynamic subtest vecs0: SUCCESS (0.039s)
[424.094042] Starting dynamic subtest: ccs0
[424.123873] Dynamic subtest ccs0: SUCCESS (0.039s)
[424.233071] Subtest before-wait: SUCCESS (0.349s)
[424.314985] [091/133] (603s left) gem_ppgtt (blt-vs-render-ctx0)
[424.373111] Starting subtest: blt-vs-render-ctx0
[457.126926] Subtest blt-vs-render-ctx0: SUCCESS (32.748s)
[457.268259] [092/133] (571s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[457.425412] Starting subtest: cursorB-vs-flipB-atomic
[457.430089] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[457.570891] [093/133] (570s left) gem_exec_reloc (basic-wc-read-active)
[457.644713] Subtest basic-wc-read-active: SKIP (0.000s)
[457.720834] [094/133] (570s left) gem_exec_fence (syncobj-import)
[458.190626] Starting subtest: syncobj-import
[458.196924] Subtest syncobj-import: SUCCESS (0.005s)
[459.780753] [095/133] (568s left) kms_psr (fbc-psr2-sprite-blt)
[459.871346] Starting subtest: fbc-psr2-sprite-blt
[459.874013] Starting dynamic subtest: eDP-1
[459.878584] Dynamic subtest eDP-1: SKIP (0.000s)
[459.883097] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[459.945717] [096/133] (568s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[460.046056] Starting subtest: plane-lut1d-post-ctm3x4
[460.203564] Starting dynamic subtest: pipe-A-plane-0
[460.380930] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[460.391259] Starting dynamic subtest: pipe-A-plane-1
[460.558638] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[460.569669] Starting dynamic subtest: pipe-A-plane-2
[460.736291] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[461.958765] Starting dynamic subtest: pipe-B-plane-0
[462.117958] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[462.129005] Starting dynamic subtest: pipe-B-plane-1
[462.272292] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[462.284802] Starting dynamic subtest: pipe-B-plane-2
[462.494414] Dynamic subtest pipe-B-plane-2: SUCCESS (0.221s)
[463.658590] Starting dynamic subtest: pipe-C-plane-0
[463.783329] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[463.795772] Starting dynamic subtest: pipe-C-plane-1
[463.927852] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[463.938512] Starting dynamic subtest: pipe-C-plane-2
[464.083304] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[465.275579] Starting dynamic subtest: pipe-D-plane-0
[465.412107] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[465.422828] Starting dynamic subtest: pipe-D-plane-1
[465.556235] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[465.566402] Starting dynamic subtest: pipe-D-plane-2
[465.722840] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[466.007038] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.962s)
[466.855159] [097/133] (561s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[466.925082] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[466.929453] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[467.108555] [098/133] (561s left) kms_big_fb (linear-8bpp-rotate-180)
[467.205748] Starting subtest: linear-8bpp-rotate-180
[468.497404] Subtest linear-8bpp-rotate-180: SUCCESS (1.292s)
[468.622377] [099/133] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[468.718815] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[468.722223] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[468.808986] [100/133] (559s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[468.918806] Starting subtest: extended-modeset-hang-oldfb-with-reset
[468.920694] Starting dynamic subtest: pipe-A
[480.829369] Dynamic subtest pipe-A: SUCCESS (11.906s)
[480.840913] Starting dynamic subtest: pipe-D
[493.110964] Dynamic subtest pipe-D: SUCCESS (12.277s)
[493.113543] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.188s)
[494.008391] [101/133] (534s left) gem_exec_schedule (timeslicing)
[494.080457] Starting subtest: timeslicing
[494.082726] Starting dynamic subtest: rcs0
[494.091909] Dynamic subtest rcs0: SUCCESS (0.022s)
[494.104428] Starting dynamic subtest: bcs0
[494.114970] Dynamic subtest bcs0: SUCCESS (0.022s)
[494.125540] Starting dynamic subtest: vcs0
[494.137070] Dynamic subtest vcs0: SUCCESS (0.021s)
[494.148788] Starting dynamic subtest: vcs1
[494.157833] Dynamic subtest vcs1: SUCCESS (0.020s)
[494.168023] Starting dynamic subtest: vecs0
[494.177972] Dynamic subtest vecs0: SUCCESS (0.020s)
[494.188199] Starting dynamic subtest: ccs0
[494.197911] Dynamic subtest ccs0: SUCCESS (0.019s)
[494.200251] Subtest timeslicing: SUCCESS (0.129s)
[495.725551] [102/133] (532s left) kms_chamelium_color (ctm-0-25)
[495.833305] Subtest ctm-0-25: SKIP (0.000s)
[495.879111] [103/133] (532s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[495.974144] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[495.976452] Starting dynamic subtest: pipe-A-eDP-1
[496.058908] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[496.069758] Starting dynamic subtest: pipe-B-eDP-1
[497.175272] Dynamic subtest pipe-B-eDP-1: SKIP (1.115s)
[497.179659] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.207s)
[498.365131] [104/133] (530s left) gem_mmap (short-mmap)
[498.421346] Subtest short-mmap: SKIP (0.000s)
[498.478622] [105/133] (530s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[498.536520] Starting subtest: multi-wait-available-unsubmitted-submitted
[498.538399] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[498.659348] [106/133] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[498.761721] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[498.765884] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[498.860647] [107/133] (530s left) kms_getfb (getfb2-accept-nv12)
[498.960160] Starting subtest: getfb2-accept-nv12
[498.962501] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[499.057149] [108/133] (529s left) syncobj_timeline (invalid-signal-zero-handles)
[499.113334] Starting subtest: invalid-signal-zero-handles
[499.115772] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[499.214190] [109/133] (529s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[499.302714] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[499.306180] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[499.374246] [110/133] (529s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[499.470976] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[499.473067] Starting dynamic subtest: pipe-A-eDP-1
[499.523061] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[499.534758] Starting dynamic subtest: pipe-B-eDP-1
[499.580865] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[499.591814] Starting dynamic subtest: pipe-C-eDP-1
[499.639897] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[499.650755] Starting dynamic subtest: pipe-D-eDP-1
[499.697935] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[499.701617] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[501.744992] [111/133] (527s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[501.836989] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[501.848766] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[501.933018] [112/133] (527s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[502.036096] Starting subtest: async-flip-with-page-flip-events-tiled
[502.424841] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[505.217561] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[505.228849] Starting dynamic subtest: pipe-A-eDP-1-4
[507.391915] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[507.402567] Starting dynamic subtest: pipe-A-eDP-1-4
[509.401836] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[509.412593] Starting dynamic subtest: pipe-A-eDP-1-x
[511.581311] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[511.949500] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[514.742444] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[514.753012] Starting dynamic subtest: pipe-B-eDP-1-4
[516.928773] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[516.941292] Starting dynamic subtest: pipe-B-eDP-1-4
[518.938785] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[518.951092] Starting dynamic subtest: pipe-B-eDP-1-x
[521.128860] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[521.496281] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[524.272944] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.785s)
[524.291641] Starting dynamic subtest: pipe-C-eDP-1-4
[526.447748] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[526.460533] Starting dynamic subtest: pipe-C-eDP-1-4
[528.457142] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[528.467951] Starting dynamic subtest: pipe-C-eDP-1-x
[530.635749] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[530.999418] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[533.805465] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[533.816325] Starting dynamic subtest: pipe-D-eDP-1-4
[535.979555] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[535.990824] Starting dynamic subtest: pipe-D-eDP-1-4
[537.998945] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[538.010431] Starting dynamic subtest: pipe-D-eDP-1-x
[540.179609] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[540.182306] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.143s)
[541.401001] [113/133] (487s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[541.500482] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[541.505103] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[541.601600] [114/133] (487s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[541.665171] Starting subtest: etime-multi-wait-for-submit-submitted
[541.766736] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[541.842582] [115/133] (487s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[543.877824] Starting subtest: modeset-non-lpsp-stress-no-wait
[543.924980] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s)
[544.255065] [116/133] (485s left) gem_exec_params (sol-reset-invalid)
[544.315670] Starting subtest: sol-reset-invalid
[544.318144] Subtest sol-reset-invalid: SUCCESS (0.002s)
[545.713440] [117/133] (483s left) gem_mmap_gtt (cpuset-big-copy)
[545.771409] Subtest cpuset-big-copy: SKIP (0.000s)
[545.845462] [118/133] (483s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[545.934953] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[553.692864] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.760s)
[553.823113] [119/133] (475s left) kms_psr (psr2-sprite-plane-onoff)
[553.910635] Starting subtest: psr2-sprite-plane-onoff
[553.912807] Starting dynamic subtest: eDP-1
[555.655320] Dynamic subtest eDP-1: SUCCESS (1.746s)
[555.657749] Subtest psr2-sprite-plane-onoff: SUCCESS (1.747s)
[556.505638] [120/133] (472s left) kms_dsc (dsc-with-output-formats)
[556.594752] Starting subtest: dsc-with-output-formats
[556.615876] Subtest dsc-with-output-formats: SKIP (0.000s)
[556.682951] [121/133] (472s left) gen3_mixed_blits
[556.810961] [122/133] (472s left) gem_mmap_offset (clear-via-pagefault)
[556.864732] Starting subtest: clear-via-pagefault
[556.866855] Starting dynamic subtest: smem0
[591.700126] Dynamic subtest smem0: SUCCESS (34.830s)
[591.702631] Subtest clear-via-pagefault: SUCCESS (34.833s)
[591.814479] [123/133] (437s left) gem_eio (reset-stress)
[592.057892] Starting subtest: reset-stress
[592.060426] Starting dynamic subtest: render
[597.128753] Dynamic subtest render: SUCCESS (5.069s)
[597.146633] Starting dynamic subtest: bsd1
[615.160455] Dynamic subtest bsd1: SUCCESS (18.031s)
[615.178149] Starting dynamic subtest: bsd2
[633.162460] Dynamic subtest bsd2: SUCCESS (17.999s)
[633.179723] Starting dynamic subtest: blt
[633.184599] Dynamic subtest blt: SKIP (0.000s)
[633.194278] Starting dynamic subtest: vebox
[651.231608] Dynamic subtest vebox: SUCCESS (18.067s)
[651.233738] Subtest reset-stress: SUCCESS (59.170s)
[652.718055] [124/133] (376s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[652.776301] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[652.778726] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[652.871017] [125/133] (376s left) kms_vblank (query-busy-hang)
[652.962316] Starting subtest: query-busy-hang
[652.964583] Starting dynamic subtest: pipe-A-eDP-1
[654.838748] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[654.854125] Starting dynamic subtest: pipe-D-eDP-1
[657.441946] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[657.444415] Subtest query-busy-hang: SUCCESS (4.482s)
[658.255583] [126/133] (371s left) kms_psr (fbc-pr-cursor-plane-onoff)
[658.361565] Starting subtest: fbc-pr-cursor-plane-onoff
[658.365795] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[658.445285] [127/133] (371s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[658.550459] Starting subtest: psr-1p-primscrn-cur-indfb-move
[665.939354] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.382s)
[666.122939] [128/133] (363s left) tools_test (sysfs_l3_parity)
[666.335442] Starting subtest: sysfs_l3_parity
[666.429613] Subtest sysfs_l3_parity: SKIP (0.171s)
[666.528491] [129/133] (363s left) kms_vblank (crtc-id)
[666.628119] Starting subtest: crtc-id
[666.629949] Starting dynamic subtest: pipe-A-eDP-1
[667.079524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[667.094614] Starting dynamic subtest: pipe-D-eDP-1
[668.230739] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[668.232955] Subtest crtc-id: SUCCESS (1.602s)
[669.066552] [130/133] (360s left) gem_ctx_engines (independent)
[669.129584] Starting subtest: independent
[669.131738] Starting dynamic subtest: rcs0
[669.270740] Dynamic subtest rcs0: SUCCESS (0.142s)
[669.282003] Starting dynamic subtest: bcs0
[669.440902] Dynamic subtest bcs0: SUCCESS (0.169s)
[669.451122] Starting dynamic subtest: vcs0
[669.615196] Dynamic subtest vcs0: SUCCESS (0.173s)
[669.626087] Starting dynamic subtest: vcs1
[669.789473] Dynamic subtest vcs1: SUCCESS (0.173s)
[669.800759] Starting dynamic subtest: vecs0
[669.965261] Dynamic subtest vecs0: SUCCESS (0.175s)
[669.976467] Starting dynamic subtest: ccs0
[670.136643] Dynamic subtest ccs0: SUCCESS (0.170s)
[670.149508] Starting dynamic subtest: all-engines
[670.993249] Dynamic subtest all-engines: SUCCESS (0.856s)
[670.995547] Subtest independent: SUCCESS (1.866s)
[672.759205] [131/133] (357s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[672.865210] Starting subtest: flip-vs-dpms-on-nop-interruptible
[672.867305] Starting dynamic subtest: A-eDP1
[674.753499] Dynamic subtest A-eDP1: SUCCESS (1.888s)
[674.764113] Starting dynamic subtest: B-eDP1
[676.593164] Dynamic subtest B-eDP1: SUCCESS (1.837s)
[676.604667] Starting dynamic subtest: C-eDP1
[678.414453] Dynamic subtest C-eDP1: SUCCESS (1.820s)
[678.426934] Starting dynamic subtest: D-eDP1
[680.244730] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[680.249761] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.385s)
[681.453765] [132/133] (348s left) kms_plane_lowres (tiling-x)
[681.549906] Starting subtest: tiling-x
[681.552263] Starting dynamic subtest: pipe-A-eDP-1
[681.556973] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[681.849577] Starting dynamic subtest: pipe-B-eDP-1
[681.854734] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[681.865185] Starting dynamic subtest: pipe-C-eDP-1
[681.870096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[681.880356] Starting dynamic subtest: pipe-D-eDP-1
[681.884853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[681.889038] Subtest tiling-x: SKIP (0.299s)
[682.669674] [133/133] (347s left) i915_pm_freq_api (freq-reset)
[682.725315] Starting subtest: freq-reset
[682.727957] Starting dynamic subtest: gt0
[682.918189] Dynamic subtest gt0: SUCCESS (0.190s)
[682.928931] Starting dynamic subtest: gt1
[683.089730] Dynamic subtest gt1: SUCCESS (0.171s)
[683.092570] Subtest freq-reset: SUCCESS (0.363s)
[683.164226] 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.