[58.005927] Initializing watchdogs
[58.005973]   /dev/watchdog0
[58.020828] [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.025222] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.027448] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.030998] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[58.155167] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[58.159648] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[58.260414] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[58.355060] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[58.359565] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[58.442975] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[58.535189] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[59.206139] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.669s)
[59.352946] [004/133] (959s left) gen7_exec_parse (basic-offset)
[59.421898] Subtest basic-offset: SKIP (0.000s)
[59.483846] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[59.577260] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[63.883001] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.292s)
[65.032578] [006/133] (953s left) tools_test (tools_test)
[65.093233] Starting subtest: tools_test
[65.140057] Subtest tools_test: SUCCESS (0.066s)
[65.197910] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[65.287936] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[65.292567] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[66.445065] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[66.536668] Starting subtest: modeset-vs-vblank-race
[66.538938] Starting dynamic subtest: A-eDP1
[71.285236] Dynamic subtest A-eDP1: SUCCESS (4.743s)
[71.294895] Starting dynamic subtest: B-eDP1
[76.020242] Dynamic subtest B-eDP1: SUCCESS (4.730s)
[76.029523] Starting dynamic subtest: C-eDP1
[80.638476] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[80.646433] Starting dynamic subtest: D-eDP1
[85.261271] Dynamic subtest D-eDP1: SUCCESS (4.620s)
[85.265824] Subtest modeset-vs-vblank-race: SUCCESS (18.718s)
[86.414430] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[88.040206] Starting subtest: reg-read-ioctl
[90.340987] Subtest reg-read-ioctl: SUCCESS (2.303s)
[90.720659] [010/133] (928s left) gem_exec_balancer (hang)
[90.991943] Starting subtest: hang
[92.896897] Subtest hang: SUCCESS (1.904s)
[93.019164] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[93.116296] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[93.120644] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[93.185909] [012/133] (925s left) perf_pmu (faulting-read)
[93.224630] Starting subtest: faulting-read
[93.227214] Starting dynamic subtest: wb
[93.229686] Dynamic subtest wb: SUCCESS (0.001s)
[93.243081] Starting dynamic subtest: wc
[93.245166] Dynamic subtest wc: SUCCESS (0.000s)
[93.252788] Starting dynamic subtest: uc
[93.254761] Dynamic subtest uc: SUCCESS (0.000s)
[93.256695] Subtest faulting-read: SUCCESS (0.002s)
[93.315211] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[93.406441] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[93.410525] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[93.487549] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[93.874821] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[94.710865] [015/133] (924s left) gem_exec_schedule (pi-distinct-iova)
[94.889453] Starting subtest: pi-distinct-iova
[94.891318] Starting dynamic subtest: rcs0
[94.964475] Dynamic subtest rcs0: SUCCESS (0.076s)
[94.973369] Starting dynamic subtest: vcs0
[95.023619] Dynamic subtest vcs0: SUCCESS (0.059s)
[95.032618] Starting dynamic subtest: vcs1
[95.086497] Dynamic subtest vcs1: SUCCESS (0.062s)
[95.096720] Starting dynamic subtest: vecs0
[95.156418] Dynamic subtest vecs0: SUCCESS (0.070s)
[95.164534] Starting dynamic subtest: ccs0
[95.221261] Dynamic subtest ccs0: SUCCESS (0.064s)
[95.223710] Subtest pi-distinct-iova: SUCCESS (0.333s)
[97.008617] [016/133] (922s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[97.112695] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[97.117184] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[97.206157] [017/133] (921s left) drm_read (short-buffer-block)
[97.348994] Starting subtest: short-buffer-block
[97.351195] Subtest short-buffer-block: SUCCESS (0.000s)
[97.460954] [018/133] (921s left) perf (oa-formats)
[97.610543] Starting subtest: oa-formats
[97.612802] Starting dynamic subtest: 0-rcs0
[97.624294] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[97.632638] Starting dynamic subtest: 1-vecs0
[97.645923] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[97.648306] Subtest oa-formats: SUCCESS (0.037s)
[97.701989] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[97.808624] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[97.813169] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[97.906329] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[97.997305] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[98.000832] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[98.098175] [021/133] (921s left) kms_psr (pr-basic)
[98.186122] Starting subtest: pr-basic
[98.189439] Subtest pr-basic: SKIP (0.000s)
[98.270700] [022/133] (921s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[98.362795] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[98.365082] Starting dynamic subtest: pipe-A-eDP-1
[98.384933] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.394529] Starting dynamic subtest: pipe-B-eDP-1
[98.411925] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.419338] Starting dynamic subtest: pipe-C-eDP-1
[98.437305] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.444342] Starting dynamic subtest: pipe-D-eDP-1
[98.462644] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.466254] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[100.547314] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[100.926243] Subtest hdmi-mode-timings: SKIP (0.000s)
[101.737659] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[101.877847] Starting subtest: dp-mst-lic-type-0-hdcp14
[101.882580] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[101.981907] [025/133] (917s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[102.089589] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[102.093828] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[102.152937] [026/133] (917s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[102.240441] Starting subtest: primary-4-tiled-reflect-x-180
[109.284478] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.046s)
[110.519847] [027/133] (909s left) kms_flip (2x-flip-vs-panning-interruptible)
[110.615020] Starting subtest: 2x-flip-vs-panning-interruptible
[110.626351] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[110.729303] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[110.834714] Starting subtest: plain-flip-fb-recreate
[110.836940] Starting dynamic subtest: A-eDP1
[119.707961] Dynamic subtest A-eDP1: SUCCESS (8.875s)
[119.717318] Starting dynamic subtest: B-eDP1
[128.539724] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[128.547338] Starting dynamic subtest: C-eDP1
[137.362050] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[137.371709] Starting dynamic subtest: D-eDP1
[146.203496] Dynamic subtest D-eDP1: SUCCESS (8.839s)
[146.207621] Subtest plain-flip-fb-recreate: SUCCESS (35.372s)
[147.381224] [029/133] (872s left) gem_tiled_partial_pwrite_pread (writes)
[147.440121] Subtest writes: SKIP (0.000s)
[147.503383] [030/133] (872s left) gem_lmem_swapping (heavy-verify-random)
[147.544861] Subtest heavy-verify-random: SKIP (0.000s)
[147.594576] [031/133] (872s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[147.691577] Starting subtest: x-tiled-64bpp-rotate-90
[147.710684] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[147.833638] [032/133] (871s left) vgem_basic (debugfs)
[147.933451] Starting subtest: debugfs
[147.935737] Subtest debugfs: SUCCESS (0.000s)
[147.985531] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[147.988517] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[148.072306] Starting subtest: legacy-setmode
[148.074648] Starting dynamic subtest: pipe-A-eDP-1
[154.988075] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.913s)
[154.990496] Subtest legacy-setmode: SUCCESS (6.914s)
[155.855306] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[155.989958] Starting subtest: reject-modify-context-protection-off-2
[155.992486] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[156.114873] [035/133] (863s left) gem_exec_basic (basic)
[156.166940] Starting subtest: basic
[156.169254] Starting dynamic subtest: rcs0-smem
[156.171605] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[156.183844] Starting dynamic subtest: bcs0-smem
[156.185679] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[156.192933] Starting dynamic subtest: vcs0-smem
[156.194877] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[156.201829] Starting dynamic subtest: vcs1-smem
[156.203681] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[156.210658] Starting dynamic subtest: vecs0-smem
[156.212555] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[156.219544] Starting dynamic subtest: ccs0-smem
[156.221476] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[156.223401] Subtest basic: SUCCESS (0.015s)
[157.948710] [036/133] (861s left) api_intel_bb (offset-control)
[158.012366] Starting subtest: offset-control
[158.017893] Subtest offset-control: SUCCESS (0.007s)
[158.168539] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[158.271862] Starting subtest: basic-max-non-joiner
[158.276398] Subtest basic-max-non-joiner: SKIP (0.000s)
[158.336966] [038/133] (861s left) kms_addfb_basic (small-bo)
[158.432246] Starting subtest: small-bo
[158.434489] Subtest small-bo: SUCCESS (0.000s)
[158.537975] [039/133] (861s left) i915_query (query-topology-garbage-items)
[158.602973] Starting subtest: query-topology-garbage-items
[158.605278] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[158.721439] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[158.818335] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[158.847499] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s)
[158.892696] [041/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[160.868664] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[160.872916] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[160.965612] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[161.025436] Starting subtest: cliprects-invalid
[161.027768] Subtest cliprects-invalid: SUCCESS (0.000s)
[161.125929] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[161.291145] Starting subtest: cursor-random-64x64
[161.293463] Starting dynamic subtest: pipe-A-eDP-1
[164.635514] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.340s)
[164.665062] Starting dynamic subtest: pipe-D-eDP-1
[168.681307] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.021s)
[168.683473] Subtest cursor-random-64x64: SUCCESS (7.388s)
[169.527612] [044/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[169.635251] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[169.639811] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[169.738687] [045/133] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[169.840672] Starting subtest: 4-tiled-16bpp-rotate-180
[171.176773] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.335s)
[171.285009] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[171.337245] Starting subtest: create-valid-dumb
[171.338877] Subtest create-valid-dumb: SUCCESS (0.000s)
[171.420856] [047/133] (848s left) gem_softpin (zero)
[171.468232] Starting subtest: zero
[171.473891] Subtest zero: SUCCESS (0.004s)
[171.581391] [048/133] (848s left) gem_blits (basic)
[171.647205] Starting subtest: basic
[173.040036] Subtest basic: SUCCESS (1.391s)
[173.143502] [049/133] (847s left) gem_busy (close-race)
[173.219324] Starting subtest: close-race
[198.934492] Subtest close-race: SUCCESS (25.709s)
[199.303479] [050/133] (821s left) gem_exec_alignment (forked)
[199.411273] Starting subtest: forked
[237.931822] Subtest forked: SUCCESS (38.517s)
[238.010827] [051/133] (782s left) syncobj_eventfd (binary-wait-before-signal)
[238.096022] Starting subtest: binary-wait-before-signal
[238.127204] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[238.206330] [052/133] (782s left) prime_mmap (test_errors)
[238.257758] Starting subtest: test_errors
[238.259967] Starting dynamic subtest: test_errors-smem
[238.354057] Dynamic subtest test_errors-smem: SUCCESS (0.098s)
[238.356326] Subtest test_errors: SUCCESS (0.099s)
[238.449584] [053/133] (782s left) gem_ctx_persistence (heartbeat-stop)
[238.509970] Starting subtest: heartbeat-stop
[238.515027] Subtest heartbeat-stop: SKIP (0.000s)
[238.607764] [054/133] (781s left) gem_ctx_param (invalid-get-ringsize)
[238.661629] Starting subtest: invalid-get-ringsize
[238.664517] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[238.771810] [055/133] (781s left) i915_query (query-topology-matches-eu-total)
[238.828745] Starting subtest: query-topology-matches-eu-total
[238.830593] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[238.917332] [056/133] (781s left) kms_cursor_edge_walk (64x64-right-edge)
[239.020291] Starting subtest: 64x64-right-edge
[239.022258] Starting dynamic subtest: pipe-A-eDP-1
[242.476200] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[242.485429] Starting dynamic subtest: pipe-D-eDP-1
[245.598427] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[245.600648] Subtest 64x64-right-edge: SUCCESS (6.578s)
[246.417038] [057/133] (774s left) kms_plane (plane-position-covered)
[246.511092] Starting subtest: plane-position-covered
[247.039972] Starting dynamic subtest: pipe-A-plane-1
[248.290356] Dynamic subtest pipe-A-plane-1: SUCCESS (1.251s)
[248.299166] Starting dynamic subtest: pipe-A-plane-2
[249.565065] Dynamic subtest pipe-A-plane-2: SUCCESS (1.273s)
[249.574316] Starting dynamic subtest: pipe-A-plane-3
[250.845755] Dynamic subtest pipe-A-plane-3: SUCCESS (1.281s)
[250.855771] Starting dynamic subtest: pipe-A-plane-4
[252.130450] Dynamic subtest pipe-A-plane-4: SUCCESS (1.283s)
[252.140859] Starting dynamic subtest: pipe-A-plane-5
[252.155806] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[253.349748] Starting dynamic subtest: pipe-B-plane-1
[254.662448] Dynamic subtest pipe-B-plane-1: SUCCESS (1.321s)
[254.673045] Starting dynamic subtest: pipe-B-plane-2
[255.987825] Dynamic subtest pipe-B-plane-2: SUCCESS (1.323s)
[255.997681] Starting dynamic subtest: pipe-B-plane-3
[257.237047] Dynamic subtest pipe-B-plane-3: SUCCESS (1.249s)
[257.246628] Starting dynamic subtest: pipe-B-plane-4
[258.575654] Dynamic subtest pipe-B-plane-4: SUCCESS (1.340s)
[258.585700] Starting dynamic subtest: pipe-B-plane-5
[258.602079] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[258.604220] Subtest plane-position-covered: SUCCESS (12.090s)
[259.442992] [058/133] (761s left) kms_frontbuffer_tracking (psr-suspend)
[259.551170] Starting subtest: psr-suspend
[297.840419] Subtest psr-suspend: SUCCESS (8.986s)
[297.972778] [059/133] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[298.075539] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[298.080075] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[298.170763] [060/133] (722s left) gem_exec_schedule (fairslice)
[298.245733] Starting subtest: fairslice
[298.248120] Starting dynamic subtest: rcs0
[300.261513] Dynamic subtest rcs0: SUCCESS (1.961s)
[300.274891] Starting dynamic subtest: bcs0
[302.283305] Dynamic subtest bcs0: SUCCESS (1.970s)
[302.295036] Starting dynamic subtest: vcs0
[304.301878] Dynamic subtest vcs0: SUCCESS (1.983s)
[304.314114] Starting dynamic subtest: vcs1
[306.323869] Dynamic subtest vcs1: SUCCESS (1.989s)
[306.335677] Starting dynamic subtest: vecs0
[308.339459] Dynamic subtest vecs0: SUCCESS (1.995s)
[308.350264] Starting dynamic subtest: ccs0
[310.359546] Dynamic subtest ccs0: SUCCESS (2.002s)
[310.361827] Subtest fairslice: SUCCESS (11.907s)
[310.673992] [061/133] (710s left) sw_sync (alloc_fence_invalid_timeline)
[310.717820] Starting subtest: alloc_fence_invalid_timeline
[310.719948] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[310.778502] [062/133] (710s left) gem_exec_whisper (basic-fds-forked)
[310.850069] Starting subtest: basic-fds-forked
[335.321557] Subtest basic-fds-forked: SUCCESS (24.424s)
[335.512478] [063/133] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[335.617451] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[335.621516] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[335.715463] [064/133] (685s left) gem_vm_create (execbuf)
[335.776602] Starting subtest: execbuf
[335.783807] Subtest execbuf: SUCCESS (0.007s)
[335.910268] [065/133] (685s left) kms_cursor_crc (cursor-onscreen-256x85)
[336.165221] Starting subtest: cursor-onscreen-256x85
[336.210564] Subtest cursor-onscreen-256x85: SKIP (0.040s)
[336.364399] [066/133] (684s left) kms_plane_alpha_blend (coverage-7efc)
[336.455629] Starting subtest: coverage-7efc
[336.749862] Starting dynamic subtest: pipe-A-eDP-1
[337.361834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[337.389398] Starting dynamic subtest: pipe-D-eDP-1
[338.638708] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[338.640982] Subtest coverage-7efc: SUCCESS (2.185s)
[339.493587] [067/133] (681s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[339.595253] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[339.597574] Starting dynamic subtest: pipe-A
[339.615529] Dynamic subtest pipe-A: SKIP (0.017s)
[339.627738] Starting dynamic subtest: pipe-B
[339.645812] Dynamic subtest pipe-B: SKIP (0.029s)
[339.655955] Starting dynamic subtest: pipe-C
[339.680241] Dynamic subtest pipe-C: SKIP (0.031s)
[339.691662] Starting dynamic subtest: pipe-D
[339.709013] Dynamic subtest pipe-D: SKIP (0.031s)
[339.713239] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.111s)
[339.796425] [068/133] (681s left) vgem_basic (busy-fence)
[339.841480] Starting subtest: busy-fence
[339.843786] Subtest busy-fence: SUCCESS (0.000s)
[339.898129] [069/133] (681s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[339.989429] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[340.018649] Starting dynamic subtest: pipe-A-plane-0
[340.428596] Dynamic subtest pipe-A-plane-0: SUCCESS (0.411s)
[340.437860] Starting dynamic subtest: pipe-A-plane-3
[340.683999] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[340.694657] Starting dynamic subtest: pipe-A-plane-5
[340.698477] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[341.776266] Starting dynamic subtest: pipe-B-plane-0
[342.189979] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[342.200856] Starting dynamic subtest: pipe-B-plane-3
[342.445273] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[342.455353] Starting dynamic subtest: pipe-B-plane-5
[342.459608] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[342.761979] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.775s)
[343.556048] [070/133] (677s left) kms_addfb_basic (invalid-set-prop-any)
[343.612839] Starting subtest: invalid-set-prop-any
[343.615061] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[343.744456] [071/133] (677s left) kms_addfb_basic (size-max)
[343.839302] Starting subtest: size-max
[343.841624] Subtest size-max: SUCCESS (0.000s)
[343.939453] [072/133] (677s left) kms_addfb_basic (bad-pitch-128)
[344.000771] Starting subtest: bad-pitch-128
[344.002918] Subtest bad-pitch-128: SUCCESS (0.000s)
[344.146559] [073/133] (677s left) syncobj_timeline (single-wait-available-submitted)
[344.201856] Starting subtest: single-wait-available-submitted
[344.204146] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[344.301366] [074/133] (677s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[344.401978] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[345.369501] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.968s)
[345.490038] [075/133] (675s left) gem_pread (exhaustion)
[345.541839] Subtest exhaustion: SKIP (0.000s)
[345.599925] [076/133] (675s left) kms_frontbuffer_tracking (psr-1p-rte)
[345.701895] Starting subtest: psr-1p-rte
[351.053464] Subtest psr-1p-rte: SUCCESS (5.357s)
[351.168630] [077/133] (670s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[351.293793] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[368.464382] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.166s)
[369.391935] [078/133] (652s left) api_intel_allocator (fork-simple-once)
[369.449913] Starting subtest: fork-simple-once
[369.466735] Subtest fork-simple-once: SUCCESS (0.018s)
[369.631873] [079/133] (652s left) gem_set_tiling_vs_pwrite
[369.775142] [080/133] (652s left) kms_pm_backlight (brightness-with-dpms)
[369.865387] Starting subtest: brightness-with-dpms
[369.916960] Starting dynamic subtest: eDP-1
[372.341579] Dynamic subtest eDP-1: SUCCESS (2.425s)
[372.343720] Subtest brightness-with-dpms: SUCCESS (2.476s)
[373.220353] [081/133] (648s left) kms_lease (lease-invalid-crtc)
[373.317264] Starting subtest: lease-invalid-crtc
[373.319522] Starting dynamic subtest: pipe-A-eDP-1
[373.321731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[373.331514] Starting dynamic subtest: pipe-B-eDP-1
[373.333765] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[373.343428] Starting dynamic subtest: pipe-C-eDP-1
[373.345583] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[373.354230] Starting dynamic subtest: pipe-D-eDP-1
[373.356036] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[373.357871] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[373.394724] [082/133] (648s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[373.486909] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[373.490953] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[373.579036] [083/133] (648s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[373.663494] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[380.425730] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.762s)
[380.554094] [084/133] (641s left) kms_dp_linktrain_fallback (dp-fallback)
[380.639233] Starting subtest: dp-fallback
[380.645543] Subtest dp-fallback: SKIP (0.000s)
[380.729697] [085/133] (641s left) kms_vblank (ts-continuation-idle)
[380.826411] Starting subtest: ts-continuation-idle
[380.828262] Starting dynamic subtest: pipe-A-eDP-1
[381.243516] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[381.258768] Starting dynamic subtest: pipe-D-eDP-1
[382.352320] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.103s)
[382.354860] Subtest ts-continuation-idle: SUCCESS (1.524s)
[383.227144] [086/133] (638s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[383.338239] Starting subtest: fbc-psr-cursor-mmap-gtt
[383.340582] Starting dynamic subtest: eDP-1
[383.344996] Dynamic subtest eDP-1: SKIP (0.000s)
[383.349479] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[383.416443] [087/133] (638s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[383.537489] Starting subtest: cursor-vs-flip-varying-size
[414.725050] Subtest cursor-vs-flip-varying-size: SUCCESS (31.187s)
[415.558543] [088/133] (606s left) i915_drm_fdinfo (busy-check-all)
[415.605955] Starting subtest: busy-check-all
[415.607976] Starting dynamic subtest: rcs0
[415.612740] Dynamic subtest rcs0: SKIP (0.004s)
[415.627724] Starting dynamic subtest: bcs0
[415.632282] Dynamic subtest bcs0: SKIP (0.000s)
[415.645502] Starting dynamic subtest: vcs0
[415.649918] Dynamic subtest vcs0: SKIP (0.000s)
[415.661197] Starting dynamic subtest: vcs1
[415.665871] Dynamic subtest vcs1: SKIP (0.000s)
[415.674777] Starting dynamic subtest: vecs0
[415.678960] Dynamic subtest vecs0: SKIP (0.000s)
[415.688267] Starting dynamic subtest: ccs0
[415.692359] Dynamic subtest ccs0: SKIP (0.000s)
[415.696347] Subtest busy-check-all: SKIP (0.009s)
[415.734144] [089/133] (606s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[415.846494] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[415.848760] Starting dynamic subtest: pipe-A-eDP-1
[415.869404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[415.880530] Starting dynamic subtest: pipe-B-eDP-1
[415.899903] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[415.910323] Starting dynamic subtest: pipe-C-eDP-1
[415.929398] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[415.938217] Starting dynamic subtest: pipe-D-eDP-1
[415.957347] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[415.959217] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[418.036825] [090/133] (604s left) prime_busy (before-wait)
[418.095531] Starting subtest: before-wait
[418.100211] Starting dynamic subtest: rcs0
[418.122906] Dynamic subtest rcs0: SUCCESS (0.025s)
[418.133967] Starting dynamic subtest: bcs0
[418.161808] Dynamic subtest bcs0: SUCCESS (0.038s)
[418.171481] Starting dynamic subtest: vcs0
[418.203209] Dynamic subtest vcs0: SUCCESS (0.040s)
[418.213127] Starting dynamic subtest: vcs1
[418.244089] Dynamic subtest vcs1: SUCCESS (0.040s)
[418.255965] Starting dynamic subtest: vecs0
[418.284629] Dynamic subtest vecs0: SUCCESS (0.040s)
[418.294706] Starting dynamic subtest: ccs0
[418.325639] Dynamic subtest ccs0: SUCCESS (0.040s)
[418.434442] Subtest before-wait: SUCCESS (0.337s)
[418.513265] [091/133] (603s left) gem_ppgtt (blt-vs-render-ctx0)
[418.564838] Starting subtest: blt-vs-render-ctx0
[451.432840] Subtest blt-vs-render-ctx0: SUCCESS (32.865s)
[451.560151] [092/133] (570s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[451.728711] Starting subtest: cursorB-vs-flipB-atomic
[451.733250] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[451.873364] [093/133] (570s left) gem_exec_reloc (basic-wc-read-active)
[451.941780] Subtest basic-wc-read-active: SKIP (0.000s)
[452.023469] [094/133] (570s left) gem_exec_fence (syncobj-import)
[452.497448] Starting subtest: syncobj-import
[452.503781] Subtest syncobj-import: SUCCESS (0.006s)
[454.298532] [095/133] (568s left) kms_psr (fbc-psr2-sprite-blt)
[454.400140] Starting subtest: fbc-psr2-sprite-blt
[454.402438] Starting dynamic subtest: eDP-1
[454.406408] Dynamic subtest eDP-1: SKIP (0.000s)
[454.410410] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[454.474677] [096/133] (567s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[454.582466] Starting subtest: plane-lut1d-post-ctm3x4
[454.719237] Starting dynamic subtest: pipe-A-plane-0
[454.863215] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[454.873932] Starting dynamic subtest: pipe-A-plane-1
[455.007732] Dynamic subtest pipe-A-plane-1: SUCCESS (0.143s)
[455.018188] Starting dynamic subtest: pipe-A-plane-2
[455.141221] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[456.317843] Starting dynamic subtest: pipe-B-plane-0
[456.509268] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[456.519471] Starting dynamic subtest: pipe-B-plane-1
[456.642891] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[456.652732] Starting dynamic subtest: pipe-B-plane-2
[456.787243] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[457.949229] Starting dynamic subtest: pipe-C-plane-0
[458.073536] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[458.083826] Starting dynamic subtest: pipe-C-plane-1
[458.229643] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[458.239766] Starting dynamic subtest: pipe-C-plane-2
[458.373647] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[459.582518] Starting dynamic subtest: pipe-D-plane-0
[459.749656] Dynamic subtest pipe-D-plane-0: SUCCESS (0.177s)
[459.759475] Starting dynamic subtest: pipe-D-plane-1
[459.894019] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[459.904367] Starting dynamic subtest: pipe-D-plane-2
[460.027126] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[460.314838] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.731s)
[461.146338] [097/133] (561s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[461.216814] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[461.221228] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[461.415271] [098/133] (561s left) kms_big_fb (linear-8bpp-rotate-180)
[461.509322] Starting subtest: linear-8bpp-rotate-180
[462.826210] Subtest linear-8bpp-rotate-180: SUCCESS (1.318s)
[462.950879] [099/133] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[463.053316] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[463.056701] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[463.145073] [100/133] (559s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[463.241890] Starting subtest: extended-modeset-hang-oldfb-with-reset
[463.243717] Starting dynamic subtest: pipe-A
[475.249235] Dynamic subtest pipe-A: SUCCESS (12.005s)
[475.262367] Starting dynamic subtest: pipe-D
[487.990383] Dynamic subtest pipe-D: SUCCESS (12.730s)
[487.992858] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.743s)
[488.789395] [101/133] (533s left) gem_exec_schedule (timeslicing)
[488.878471] Starting subtest: timeslicing
[488.880392] Starting dynamic subtest: rcs0
[488.889835] Dynamic subtest rcs0: SUCCESS (0.022s)
[488.903400] Starting dynamic subtest: bcs0
[488.910654] Dynamic subtest bcs0: SUCCESS (0.020s)
[488.921348] Starting dynamic subtest: vcs0
[488.932396] Dynamic subtest vcs0: SUCCESS (0.021s)
[488.942878] Starting dynamic subtest: vcs1
[488.952935] Dynamic subtest vcs1: SUCCESS (0.020s)
[488.962665] Starting dynamic subtest: vecs0
[488.974324] Dynamic subtest vecs0: SUCCESS (0.020s)
[488.987377] Starting dynamic subtest: ccs0
[488.997703] Dynamic subtest ccs0: SUCCESS (0.022s)
[489.000044] Subtest timeslicing: SUCCESS (0.130s)
[490.242037] [102/133] (532s left) kms_chamelium_color (ctm-0-25)
[490.330335] Subtest ctm-0-25: SKIP (0.000s)
[490.376588] [103/133] (532s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[490.465729] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[490.467929] Starting dynamic subtest: pipe-A-eDP-1
[490.560453] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[490.573146] Starting dynamic subtest: pipe-B-eDP-1
[491.678049] Dynamic subtest pipe-B-eDP-1: SKIP (1.116s)
[491.682837] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.217s)
[492.870987] [104/133] (529s left) gem_mmap (short-mmap)
[492.934570] Subtest short-mmap: SKIP (0.000s)
[492.996406] [105/133] (529s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[493.063527] Starting subtest: multi-wait-available-unsubmitted-submitted
[493.065395] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[493.153845] [106/133] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[493.261812] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[493.265947] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[493.355128] [107/133] (529s left) kms_getfb (getfb2-accept-nv12)
[493.448237] Starting subtest: getfb2-accept-nv12
[493.450547] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[493.560483] [108/133] (529s left) syncobj_timeline (invalid-signal-zero-handles)
[493.634928] Starting subtest: invalid-signal-zero-handles
[493.637276] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[493.753807] [109/133] (529s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[493.857632] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[493.861389] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[493.958573] [110/133] (529s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[494.046616] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[494.048454] Starting dynamic subtest: pipe-A-eDP-1
[494.095917] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[494.106113] Starting dynamic subtest: pipe-B-eDP-1
[494.152297] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[494.163302] Starting dynamic subtest: pipe-C-eDP-1
[494.211461] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[494.221966] Starting dynamic subtest: pipe-D-eDP-1
[494.270082] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[494.273959] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[496.267923] [111/133] (526s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[496.376843] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[496.386399] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[496.494293] [112/133] (526s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[496.591409] Starting subtest: async-flip-with-page-flip-events-tiled
[496.968995] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[499.730351] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.760s)
[499.740524] Starting dynamic subtest: pipe-A-eDP-1-4
[501.905441] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[501.918638] Starting dynamic subtest: pipe-A-eDP-1-4
[503.916122] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s)
[503.926955] Starting dynamic subtest: pipe-A-eDP-1-x
[506.106615] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[506.478576] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[509.265532] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[509.276836] Starting dynamic subtest: pipe-B-eDP-1-4
[511.450955] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[511.461481] Starting dynamic subtest: pipe-B-eDP-1-4
[513.461485] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[513.475239] Starting dynamic subtest: pipe-B-eDP-1-x
[515.652087] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[516.021189] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[518.801538] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[518.812875] Starting dynamic subtest: pipe-C-eDP-1-4
[520.976713] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[520.987103] Starting dynamic subtest: pipe-C-eDP-1-4
[522.986993] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[522.997540] Starting dynamic subtest: pipe-C-eDP-1-x
[525.164606] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[525.528665] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[528.328216] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.807s)
[528.341871] Starting dynamic subtest: pipe-D-eDP-1-4
[530.502659] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[530.514753] Starting dynamic subtest: pipe-D-eDP-1-4
[532.511595] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[532.523656] Starting dynamic subtest: pipe-D-eDP-1-x
[534.701584] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[534.704464] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.108s)
[535.918669] [113/133] (487s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[536.010909] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[536.016218] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[536.121403] [114/133] (487s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[536.175995] Starting subtest: etime-multi-wait-for-submit-submitted
[536.280920] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[536.357122] [115/133] (486s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[538.380567] Starting subtest: modeset-non-lpsp-stress-no-wait
[538.429665] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.048s)
[538.759210] [116/133] (484s left) gem_exec_params (sol-reset-invalid)
[538.813822] Starting subtest: sol-reset-invalid
[538.819037] Subtest sol-reset-invalid: SUCCESS (0.002s)
[540.294067] [117/133] (483s left) gem_mmap_gtt (cpuset-big-copy)
[540.363295] Subtest cpuset-big-copy: SKIP (0.000s)
[540.421129] [118/133] (482s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[540.523051] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[548.101407] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.583s)
[548.240045] [119/133] (475s left) kms_psr (psr2-sprite-plane-onoff)
[548.332151] Starting subtest: psr2-sprite-plane-onoff
[548.334271] Starting dynamic subtest: eDP-1
[550.075361] Dynamic subtest eDP-1: SUCCESS (1.741s)
[550.077447] Subtest psr2-sprite-plane-onoff: SUCCESS (1.742s)
[550.931541] [120/133] (472s left) kms_dsc (dsc-with-output-formats)
[551.032379] Starting subtest: dsc-with-output-formats
[551.055093] Subtest dsc-with-output-formats: SKIP (0.001s)
[551.103453] [121/133] (472s left) gen3_mixed_blits
[551.228657] [122/133] (472s left) gem_mmap_offset (clear-via-pagefault)
[551.282666] Starting subtest: clear-via-pagefault
[551.284968] Starting dynamic subtest: smem0
[585.078984] Dynamic subtest smem0: SUCCESS (33.792s)
[585.081257] Subtest clear-via-pagefault: SUCCESS (33.794s)
[585.198413] [123/133] (438s left) gem_eio (reset-stress)
[585.481949] Starting subtest: reset-stress
[585.483986] Starting dynamic subtest: render
[590.580565] Dynamic subtest render: SUCCESS (5.096s)
[590.598763] Starting dynamic subtest: bsd1
[608.743409] Dynamic subtest bsd1: SUCCESS (18.160s)
[608.761050] Starting dynamic subtest: bsd2
[626.717347] Dynamic subtest bsd2: SUCCESS (17.971s)
[626.732801] Starting dynamic subtest: blt
[626.737095] Dynamic subtest blt: SKIP (0.000s)
[626.746866] Starting dynamic subtest: vebox
[644.748780] Dynamic subtest vebox: SUCCESS (18.028s)
[644.751681] Subtest reset-stress: SUCCESS (59.260s)
[646.262569] [124/133] (377s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[646.320248] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[646.322489] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[646.419585] [125/133] (377s left) kms_vblank (query-busy-hang)
[646.513188] Starting subtest: query-busy-hang
[646.515451] Starting dynamic subtest: pipe-A-eDP-1
[648.397560] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[648.413386] Starting dynamic subtest: pipe-D-eDP-1
[650.989923] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[650.991906] Subtest query-busy-hang: SUCCESS (4.476s)
[651.794385] [126/133] (371s left) kms_psr (fbc-pr-cursor-plane-onoff)
[651.882063] Starting subtest: fbc-pr-cursor-plane-onoff
[651.886417] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[651.955200] [127/133] (371s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[652.054418] Starting subtest: psr-1p-primscrn-cur-indfb-move
[659.373822] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.321s)
[659.500062] [128/133] (364s left) tools_test (sysfs_l3_parity)
[659.556064] Starting subtest: sysfs_l3_parity
[659.615602] Subtest sysfs_l3_parity: SKIP (0.073s)
[659.673724] [129/133] (364s left) kms_vblank (crtc-id)
[659.763241] Starting subtest: crtc-id
[659.765459] Starting dynamic subtest: pipe-A-eDP-1
[660.209851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[660.225765] Starting dynamic subtest: pipe-D-eDP-1
[661.380757] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.169s)
[661.382826] Subtest crtc-id: SUCCESS (1.618s)
[662.207863] [130/133] (361s left) gem_ctx_engines (independent)
[662.266025] Starting subtest: independent
[662.268463] Starting dynamic subtest: rcs0
[662.418148] Dynamic subtest rcs0: SUCCESS (0.150s)
[662.431200] Starting dynamic subtest: bcs0
[662.585242] Dynamic subtest bcs0: SUCCESS (0.166s)
[662.596722] Starting dynamic subtest: vcs0
[662.749843] Dynamic subtest vcs0: SUCCESS (0.163s)
[662.762625] Starting dynamic subtest: vcs1
[662.925762] Dynamic subtest vcs1: SUCCESS (0.174s)
[662.939082] Starting dynamic subtest: vecs0
[663.091232] Dynamic subtest vecs0: SUCCESS (0.165s)
[663.101914] Starting dynamic subtest: ccs0
[663.266426] Dynamic subtest ccs0: SUCCESS (0.175s)
[663.276513] Starting dynamic subtest: all-engines
[663.887309] Dynamic subtest all-engines: SUCCESS (0.620s)
[663.889881] Subtest independent: SUCCESS (1.621s)
[664.398678] [131/133] (359s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[664.489443] Starting subtest: flip-vs-dpms-on-nop-interruptible
[664.491847] Starting dynamic subtest: A-eDP1
[666.313629] Dynamic subtest A-eDP1: SUCCESS (1.822s)
[666.327393] Starting dynamic subtest: B-eDP1
[668.145745] Dynamic subtest B-eDP1: SUCCESS (1.829s)
[668.159966] Starting dynamic subtest: C-eDP1
[669.970932] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[669.982919] Starting dynamic subtest: D-eDP1
[671.807573] Dynamic subtest D-eDP1: SUCCESS (1.834s)
[671.813950] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.324s)
[672.991028] [132/133] (351s left) kms_plane_lowres (tiling-x)
[673.094614] Starting subtest: tiling-x
[673.097073] Starting dynamic subtest: pipe-A-eDP-1
[673.101804] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[673.395386] Starting dynamic subtest: pipe-B-eDP-1
[673.400130] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[673.410561] Starting dynamic subtest: pipe-C-eDP-1
[673.415197] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[673.424790] Starting dynamic subtest: pipe-D-eDP-1
[673.429183] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[673.433462] Subtest tiling-x: SKIP (0.292s)
[674.230959] [133/133] (349s left) i915_pm_freq_api (freq-reset)
[674.293285] Starting subtest: freq-reset
[674.295621] Starting dynamic subtest: gt0
[674.483940] Dynamic subtest gt0: SUCCESS (0.190s)
[674.497964] Starting dynamic subtest: gt1
[674.664251] Dynamic subtest gt1: SUCCESS (0.175s)
[674.667894] Subtest freq-reset: SUCCESS (0.369s)
[674.737320] 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.