[58.976208] Initializing watchdogs
[58.976255]   /dev/watchdog0
[58.990703] [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.994908] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.998226] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.001705] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[59.128118] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[59.132575] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[59.230553] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[59.324191] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[59.328216] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[59.410606] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[59.515578] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[60.271956] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.759s)
[60.409081] [004/133] (959s left) gen7_exec_parse (basic-offset)
[60.466786] Subtest basic-offset: SKIP (0.000s)
[60.535183] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[60.630774] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[64.844160] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.221s)
[66.002816] [006/133] (953s left) tools_test (tools_test)
[66.056331] Starting subtest: tools_test
[66.104165] Subtest tools_test: SUCCESS (0.063s)
[66.176905] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[66.262252] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[66.266963] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[67.445199] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[67.656786] Starting subtest: modeset-vs-vblank-race
[67.659139] Starting dynamic subtest: A-eDP1
[72.346289] Dynamic subtest A-eDP1: SUCCESS (4.691s)
[72.356465] Starting dynamic subtest: B-eDP1
[77.065723] Dynamic subtest B-eDP1: SUCCESS (4.719s)
[77.074267] Starting dynamic subtest: C-eDP1
[81.692515] Dynamic subtest C-eDP1: SUCCESS (4.625s)
[81.702955] Starting dynamic subtest: D-eDP1
[86.332649] Dynamic subtest D-eDP1: SUCCESS (4.640s)
[86.335139] Subtest modeset-vs-vblank-race: SUCCESS (18.683s)
[87.490552] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[89.130805] Starting subtest: reg-read-ioctl
[91.417469] Subtest reg-read-ioctl: SUCCESS (2.291s)
[91.796736] [010/133] (928s left) gem_exec_balancer (hang)
[92.059686] Starting subtest: hang
[93.907533] Subtest hang: SUCCESS (1.848s)
[94.018230] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[94.105313] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[94.109588] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[94.178762] [012/133] (925s left) perf_pmu (faulting-read)
[94.223709] Starting subtest: faulting-read
[94.225900] Starting dynamic subtest: wb
[94.228264] Dynamic subtest wb: SUCCESS (0.001s)
[94.235943] Starting dynamic subtest: wc
[94.237794] Dynamic subtest wc: SUCCESS (0.000s)
[94.248037] Starting dynamic subtest: uc
[94.250500] Dynamic subtest uc: SUCCESS (0.000s)
[94.252759] Subtest faulting-read: SUCCESS (0.002s)
[94.334578] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[94.437205] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[94.441352] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[94.540772] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[94.936707] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[95.793278] [015/133] (924s left) gem_exec_schedule (pi-distinct-iova)
[95.980315] Starting subtest: pi-distinct-iova
[95.982761] Starting dynamic subtest: rcs0
[96.052360] Dynamic subtest rcs0: SUCCESS (0.074s)
[96.063721] Starting dynamic subtest: vcs0
[96.109567] Dynamic subtest vcs0: SUCCESS (0.057s)
[96.117654] Starting dynamic subtest: vcs1
[96.175093] Dynamic subtest vcs1: SUCCESS (0.065s)
[96.184547] Starting dynamic subtest: vecs0
[96.229828] Dynamic subtest vecs0: SUCCESS (0.055s)
[96.239565] Starting dynamic subtest: ccs0
[96.288839] Dynamic subtest ccs0: SUCCESS (0.059s)
[96.291290] Subtest pi-distinct-iova: SUCCESS (0.311s)
[97.957651] [016/133] (922s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[98.065752] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[98.069981] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[98.164525] [017/133] (921s left) drm_read (short-buffer-block)
[98.293952] Starting subtest: short-buffer-block
[98.296456] Subtest short-buffer-block: SUCCESS (0.000s)
[98.419255] [018/133] (921s left) perf (oa-formats)
[98.539761] Starting subtest: oa-formats
[98.542059] Starting dynamic subtest: 0-rcs0
[98.553088] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[98.561061] Starting dynamic subtest: 1-vcs1
[98.574832] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[98.577246] Subtest oa-formats: SUCCESS (0.037s)
[98.622494] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[98.725456] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[98.729621] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[98.822877] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[98.916577] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[98.920214] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[99.005544] [021/133] (921s left) kms_psr (pr-basic)
[99.096738] Starting subtest: pr-basic
[99.100312] Subtest pr-basic: SKIP (0.000s)
[99.178634] [022/133] (921s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[99.276232] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[99.278074] Starting dynamic subtest: pipe-A-eDP-1
[99.296957] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.305205] Starting dynamic subtest: pipe-B-eDP-1
[99.322125] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.329199] Starting dynamic subtest: pipe-C-eDP-1
[99.347555] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.354723] Starting dynamic subtest: pipe-D-eDP-1
[99.372943] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.376526] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[101.490736] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[101.882335] Subtest hdmi-mode-timings: SKIP (0.000s)
[102.700654] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[102.836664] Starting subtest: dp-mst-lic-type-0-hdcp14
[102.841790] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[102.965140] [025/133] (917s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[103.067445] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[103.071571] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[103.147931] [026/133] (917s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[103.244578] Starting subtest: primary-4-tiled-reflect-x-180
[110.091820] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.848s)
[111.284312] [027/133] (909s left) kms_flip (2x-flip-vs-panning-interruptible)
[111.383542] Starting subtest: 2x-flip-vs-panning-interruptible
[111.394871] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[111.467292] [028/133] (909s left) kms_flip (plain-flip-fb-recreate)
[111.563757] Starting subtest: plain-flip-fb-recreate
[111.565990] Starting dynamic subtest: A-eDP1
[120.476892] Dynamic subtest A-eDP1: SUCCESS (8.915s)
[120.487692] Starting dynamic subtest: B-eDP1
[129.310426] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[129.320063] Starting dynamic subtest: C-eDP1
[138.138328] Dynamic subtest C-eDP1: SUCCESS (8.827s)
[138.146767] Starting dynamic subtest: D-eDP1
[146.972125] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[146.974079] Subtest plain-flip-fb-recreate: SUCCESS (35.414s)
[148.139923] [029/133] (872s left) gem_tiled_partial_pwrite_pread (writes)
[148.214153] Subtest writes: SKIP (0.000s)
[148.275313] [030/133] (872s left) gem_lmem_swapping (heavy-verify-random)
[148.313938] Subtest heavy-verify-random: SKIP (0.000s)
[148.351597] [031/133] (872s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[148.458407] Starting subtest: x-tiled-64bpp-rotate-90
[148.477378] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s)
[148.602889] [032/133] (872s left) vgem_basic (debugfs)
[148.687842] Starting subtest: debugfs
[148.690105] Subtest debugfs: SUCCESS (0.000s)
[148.742377] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[148.745631] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[148.842287] Starting subtest: legacy-setmode
[148.844721] Starting dynamic subtest: pipe-A-eDP-1
[155.714291] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.871s)
[155.716272] Subtest legacy-setmode: SUCCESS (6.872s)
[156.526876] [034/133] (864s left) gem_pxp (reject-modify-context-protection-off-2)
[156.666750] Starting subtest: reject-modify-context-protection-off-2
[156.669151] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[156.784053] [035/133] (864s left) gem_exec_basic (basic)
[156.834571] Starting subtest: basic
[156.836933] Starting dynamic subtest: rcs0-smem
[156.839243] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[156.847696] Starting dynamic subtest: bcs0-smem
[156.850088] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[156.857983] Starting dynamic subtest: vcs0-smem
[156.860263] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[156.867965] Starting dynamic subtest: vcs1-smem
[156.870736] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[156.877926] Starting dynamic subtest: vecs0-smem
[156.879871] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[156.887128] Starting dynamic subtest: ccs0-smem
[156.889028] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[156.890939] Subtest basic: SUCCESS (0.019s)
[158.982193] [036/133] (861s left) api_intel_bb (offset-control)
[159.031048] Starting subtest: offset-control
[159.037260] Subtest offset-control: SUCCESS (0.008s)
[159.155916] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[159.253780] Starting subtest: basic-max-non-joiner
[159.258326] Subtest basic-max-non-joiner: SKIP (0.000s)
[159.319655] [038/133] (861s left) kms_addfb_basic (small-bo)
[159.421138] Starting subtest: small-bo
[159.422972] Subtest small-bo: SUCCESS (0.000s)
[159.511708] [039/133] (861s left) i915_query (query-topology-garbage-items)
[159.578957] Starting subtest: query-topology-garbage-items
[159.581349] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[159.687355] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[159.777929] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[159.806374] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[159.843734] [041/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[161.889435] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[161.893866] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[162.017041] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[162.083786] Starting subtest: cliprects-invalid
[162.086202] Subtest cliprects-invalid: SUCCESS (0.000s)
[162.205344] [043/133] (858s left) kms_cursor_crc (cursor-random-64x64)
[162.416777] Starting subtest: cursor-random-64x64
[162.419333] Starting dynamic subtest: pipe-A-eDP-1
[165.736099] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.319s)
[165.774971] Starting dynamic subtest: pipe-D-eDP-1
[169.751313] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s)
[169.753705] Subtest cursor-random-64x64: SUCCESS (7.337s)
[170.573369] [044/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[170.670775] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[170.675046] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[170.783030] [045/133] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[170.881370] Starting subtest: 4-tiled-16bpp-rotate-180
[172.204575] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.323s)
[172.338073] [046/133] (848s left) dumb_buffer (create-valid-dumb)
[172.412640] Starting subtest: create-valid-dumb
[172.414743] Subtest create-valid-dumb: SUCCESS (0.000s)
[172.516881] [047/133] (848s left) gem_softpin (zero)
[172.587191] Starting subtest: zero
[172.593572] Subtest zero: SUCCESS (0.005s)
[172.734047] [048/133] (848s left) gem_blits (basic)
[172.807681] Starting subtest: basic
[174.203900] Subtest basic: SUCCESS (1.397s)
[174.312312] [049/133] (847s left) gem_busy (close-race)
[174.375153] Starting subtest: close-race
[197.906549] Subtest close-race: SUCCESS (23.533s)
[198.260530] [050/133] (823s left) gem_exec_alignment (forked)
[198.361847] Starting subtest: forked
[236.820765] Subtest forked: SUCCESS (38.460s)
[236.903736] [051/133] (784s left) syncobj_eventfd (binary-wait-before-signal)
[236.991640] Starting subtest: binary-wait-before-signal
[237.022373] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[237.117753] [052/133] (784s left) prime_mmap (test_errors)
[237.177505] Starting subtest: test_errors
[237.179457] Starting dynamic subtest: test_errors-smem
[237.273729] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[237.276572] Subtest test_errors: SUCCESS (0.097s)
[237.372337] [053/133] (784s left) gem_ctx_persistence (heartbeat-stop)
[237.431577] Starting subtest: heartbeat-stop
[237.436192] Subtest heartbeat-stop: SKIP (0.000s)
[237.539891] [054/133] (784s left) gem_ctx_param (invalid-get-ringsize)
[237.589824] Starting subtest: invalid-get-ringsize
[237.592546] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[237.682941] [055/133] (783s left) i915_query (query-topology-matches-eu-total)
[237.736190] Starting subtest: query-topology-matches-eu-total
[237.738534] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[237.835227] [056/133] (783s left) kms_cursor_edge_walk (64x64-right-edge)
[237.927148] Starting subtest: 64x64-right-edge
[237.929142] Starting dynamic subtest: pipe-A-eDP-1
[241.337338] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.410s)
[241.346877] Starting dynamic subtest: pipe-D-eDP-1
[244.463544] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[244.465470] Subtest 64x64-right-edge: SUCCESS (6.535s)
[245.276062] [057/133] (776s left) kms_plane (plane-position-covered)
[245.374126] Starting subtest: plane-position-covered
[245.890268] Starting dynamic subtest: pipe-A-plane-1
[247.197458] Dynamic subtest pipe-A-plane-1: SUCCESS (1.306s)
[247.208080] Starting dynamic subtest: pipe-A-plane-2
[248.497396] Dynamic subtest pipe-A-plane-2: SUCCESS (1.298s)
[248.507536] Starting dynamic subtest: pipe-A-plane-3
[249.821210] Dynamic subtest pipe-A-plane-3: SUCCESS (1.322s)
[249.831148] Starting dynamic subtest: pipe-A-plane-4
[251.044371] Dynamic subtest pipe-A-plane-4: SUCCESS (1.224s)
[251.053864] Starting dynamic subtest: pipe-A-plane-5
[251.083368] Dynamic subtest pipe-A-plane-5: SUCCESS (0.038s)
[252.243105] Starting dynamic subtest: pipe-B-plane-1
[253.570896] Dynamic subtest pipe-B-plane-1: SUCCESS (1.335s)
[253.580788] Starting dynamic subtest: pipe-B-plane-2
[254.834867] Dynamic subtest pipe-B-plane-2: SUCCESS (1.265s)
[254.845370] Starting dynamic subtest: pipe-B-plane-3
[256.075095] Dynamic subtest pipe-B-plane-3: SUCCESS (1.237s)
[256.085276] Starting dynamic subtest: pipe-B-plane-4
[257.352492] Dynamic subtest pipe-B-plane-4: SUCCESS (1.278s)
[257.361249] Starting dynamic subtest: pipe-B-plane-5
[257.376414] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[257.378697] Subtest plane-position-covered: SUCCESS (12.001s)
[258.203945] [058/133] (763s left) kms_frontbuffer_tracking (psr-suspend)
[258.309257] Starting subtest: psr-suspend
[296.517575] Subtest psr-suspend: SUCCESS (8.089s)
[296.620572] [059/133] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[296.723070] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[296.728360] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[296.827602] [060/133] (725s left) gem_exec_schedule (fairslice)
[296.902230] Starting subtest: fairslice
[296.905052] Starting dynamic subtest: rcs0
[298.913789] Dynamic subtest rcs0: SUCCESS (2.035s)
[298.924906] Starting dynamic subtest: bcs0
[300.934369] Dynamic subtest bcs0: SUCCESS (2.029s)
[300.945094] Starting dynamic subtest: vcs0
[302.954811] Dynamic subtest vcs0: SUCCESS (2.028s)
[302.965999] Starting dynamic subtest: vcs1
[304.975704] Dynamic subtest vcs1: SUCCESS (2.026s)
[304.986817] Starting dynamic subtest: vecs0
[306.994045] Dynamic subtest vecs0: SUCCESS (2.026s)
[307.005113] Starting dynamic subtest: ccs0
[309.015849] Dynamic subtest ccs0: SUCCESS (2.025s)
[309.018332] Subtest fairslice: SUCCESS (12.175s)
[309.316300] [061/133] (712s left) sw_sync (alloc_fence_invalid_timeline)
[309.364314] Starting subtest: alloc_fence_invalid_timeline
[309.367119] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[309.430708] [062/133] (712s left) gem_exec_whisper (basic-fds-forked)
[309.504090] Starting subtest: basic-fds-forked
[334.412018] Subtest basic-fds-forked: SUCCESS (24.921s)
[334.598376] [063/133] (687s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[334.705119] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[334.710653] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[334.792955] [064/133] (687s left) gem_vm_create (execbuf)
[334.857298] Starting subtest: execbuf
[334.866683] Subtest execbuf: SUCCESS (0.009s)
[334.981215] [065/133] (687s left) kms_cursor_crc (cursor-onscreen-256x85)
[335.247118] Starting subtest: cursor-onscreen-256x85
[335.291883] Subtest cursor-onscreen-256x85: SKIP (0.039s)
[335.486340] [066/133] (686s left) kms_plane_alpha_blend (coverage-7efc)
[335.583806] Starting subtest: coverage-7efc
[335.883765] Starting dynamic subtest: pipe-A-eDP-1
[336.436430] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[336.463312] Starting dynamic subtest: pipe-D-eDP-1
[337.762462] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[337.765220] Subtest coverage-7efc: SUCCESS (2.178s)
[338.603142] [067/133] (683s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[338.710709] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[338.713189] Starting dynamic subtest: pipe-A
[338.732865] Dynamic subtest pipe-A: SKIP (0.016s)
[338.744033] Starting dynamic subtest: pipe-B
[338.759508] Dynamic subtest pipe-B: SKIP (0.029s)
[338.769498] Starting dynamic subtest: pipe-C
[338.787801] Dynamic subtest pipe-C: SKIP (0.028s)
[338.797553] Starting dynamic subtest: pipe-D
[338.818977] Dynamic subtest pipe-D: SKIP (0.029s)
[338.823694] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.104s)
[338.907175] [068/133] (683s left) vgem_basic (busy-fence)
[338.961184] Starting subtest: busy-fence
[338.964216] Subtest busy-fence: SUCCESS (0.000s)
[339.019210] [069/133] (683s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[339.116319] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[339.145551] Starting dynamic subtest: pipe-A-plane-0
[339.578227] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[339.589914] Starting dynamic subtest: pipe-A-plane-3
[339.844924] Dynamic subtest pipe-A-plane-3: SUCCESS (0.263s)
[339.853973] Starting dynamic subtest: pipe-A-plane-5
[339.857828] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[340.990604] Starting dynamic subtest: pipe-B-plane-0
[341.429009] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[341.440582] Starting dynamic subtest: pipe-B-plane-3
[341.682594] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[341.692130] Starting dynamic subtest: pipe-B-plane-5
[341.696932] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[342.000297] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.887s)
[342.881258] [070/133] (679s left) kms_addfb_basic (invalid-set-prop-any)
[342.934799] Starting subtest: invalid-set-prop-any
[342.937114] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[343.062383] [071/133] (679s left) kms_addfb_basic (size-max)
[343.153212] Starting subtest: size-max
[343.156087] Subtest size-max: SUCCESS (0.000s)
[343.256964] [072/133] (679s left) kms_addfb_basic (bad-pitch-128)
[343.310708] Starting subtest: bad-pitch-128
[343.313071] Subtest bad-pitch-128: SUCCESS (0.000s)
[343.451009] [073/133] (678s left) syncobj_timeline (single-wait-available-submitted)
[343.508050] Starting subtest: single-wait-available-submitted
[343.511008] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[343.616807] [074/133] (678s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[343.722242] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[344.745615] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.023s)
[344.856414] [075/133] (677s left) gem_pread (exhaustion)
[344.911157] Subtest exhaustion: SKIP (0.000s)
[344.978889] [076/133] (677s left) kms_frontbuffer_tracking (psr-1p-rte)
[345.077860] Starting subtest: psr-1p-rte
[350.477117] Subtest psr-1p-rte: SUCCESS (5.403s)
[350.614933] [077/133] (671s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[350.728953] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[368.208341] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.482s)
[368.999675] [078/133] (653s left) api_intel_allocator (fork-simple-once)
[369.063259] Starting subtest: fork-simple-once
[369.079721] Subtest fork-simple-once: SUCCESS (0.019s)
[369.193874] [079/133] (653s left) gem_set_tiling_vs_pwrite
[369.320521] [080/133] (653s left) kms_pm_backlight (brightness-with-dpms)
[369.418326] Starting subtest: brightness-with-dpms
[369.468588] Starting dynamic subtest: eDP-1
[371.884726] Dynamic subtest eDP-1: SUCCESS (2.414s)
[371.888321] Subtest brightness-with-dpms: SUCCESS (2.467s)
[372.800301] [081/133] (650s left) kms_lease (lease-invalid-crtc)
[372.903635] Starting subtest: lease-invalid-crtc
[372.906396] Starting dynamic subtest: pipe-A-eDP-1
[372.909191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[372.929225] Starting dynamic subtest: pipe-B-eDP-1
[372.932216] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[372.945473] Starting dynamic subtest: pipe-C-eDP-1
[372.948511] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[372.960322] Starting dynamic subtest: pipe-D-eDP-1
[372.963320] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[372.966167] Subtest lease-invalid-crtc: SUCCESS (0.005s)
[373.005438] [082/133] (649s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[373.116576] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[373.121867] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[373.212727] [083/133] (649s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[373.309253] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[380.189694] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.885s)
[380.328150] [084/133] (642s left) kms_dp_linktrain_fallback (dp-fallback)
[380.430095] Starting subtest: dp-fallback
[380.438067] Subtest dp-fallback: SKIP (0.000s)
[380.529425] [085/133] (642s left) kms_vblank (ts-continuation-idle)
[380.615576] Starting subtest: ts-continuation-idle
[380.617980] Starting dynamic subtest: pipe-A-eDP-1
[381.013048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[381.031471] Starting dynamic subtest: pipe-D-eDP-1
[382.075116] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.062s)
[382.077851] Subtest ts-continuation-idle: SUCCESS (1.463s)
[382.958200] [086/133] (640s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[383.047717] Starting subtest: fbc-psr-cursor-mmap-gtt
[383.050107] Starting dynamic subtest: eDP-1
[383.054765] Dynamic subtest eDP-1: SKIP (0.000s)
[383.059300] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[383.140218] [087/133] (639s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[383.249571] Starting subtest: cursor-vs-flip-varying-size
[414.428120] Subtest cursor-vs-flip-varying-size: SUCCESS (31.172s)
[415.281008] [088/133] (607s left) i915_drm_fdinfo (busy-check-all)
[415.327762] Starting subtest: busy-check-all
[415.330205] Starting dynamic subtest: rcs0
[415.335309] Dynamic subtest rcs0: SKIP (0.004s)
[415.345104] Starting dynamic subtest: bcs0
[415.350089] Dynamic subtest bcs0: SKIP (0.000s)
[415.360153] Starting dynamic subtest: vcs0
[415.365163] Dynamic subtest vcs0: SKIP (0.000s)
[415.375913] Starting dynamic subtest: vcs1
[415.380953] Dynamic subtest vcs1: SKIP (0.000s)
[415.390475] Starting dynamic subtest: vecs0
[415.395325] Dynamic subtest vecs0: SKIP (0.000s)
[415.404586] Starting dynamic subtest: ccs0
[415.409326] Dynamic subtest ccs0: SKIP (0.000s)
[415.414197] Subtest busy-check-all: SKIP (0.009s)
[415.453530] [089/133] (607s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[415.562295] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[415.564867] Starting dynamic subtest: pipe-A-eDP-1
[415.585585] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[415.596775] Starting dynamic subtest: pipe-B-eDP-1
[415.617041] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[415.626072] Starting dynamic subtest: pipe-C-eDP-1
[415.646499] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[415.655198] Starting dynamic subtest: pipe-D-eDP-1
[415.675585] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[415.677724] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[417.831344] [090/133] (605s left) prime_busy (before-wait)
[417.891115] Starting subtest: before-wait
[417.894109] Starting dynamic subtest: rcs0
[417.929722] Dynamic subtest rcs0: SUCCESS (0.036s)
[417.940495] Starting dynamic subtest: bcs0
[417.970124] Dynamic subtest bcs0: SUCCESS (0.040s)
[417.979481] Starting dynamic subtest: vcs0
[418.012577] Dynamic subtest vcs0: SUCCESS (0.042s)
[418.022210] Starting dynamic subtest: vcs1
[418.055667] Dynamic subtest vcs1: SUCCESS (0.042s)
[418.066039] Starting dynamic subtest: vecs0
[418.098536] Dynamic subtest vecs0: SUCCESS (0.042s)
[418.108305] Starting dynamic subtest: ccs0
[418.140297] Dynamic subtest ccs0: SUCCESS (0.041s)
[418.248918] Subtest before-wait: SUCCESS (0.358s)
[418.325625] [091/133] (604s left) gem_ppgtt (blt-vs-render-ctx0)
[418.381575] Starting subtest: blt-vs-render-ctx0
[451.174531] Subtest blt-vs-render-ctx0: SUCCESS (32.791s)
[451.295798] [092/133] (571s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[451.473909] Starting subtest: cursorB-vs-flipB-atomic
[451.478200] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[451.619933] [093/133] (571s left) gem_exec_reloc (basic-wc-read-active)
[451.685861] Subtest basic-wc-read-active: SKIP (0.000s)
[451.767328] [094/133] (571s left) gem_exec_fence (syncobj-import)
[452.220431] Starting subtest: syncobj-import
[452.227109] Subtest syncobj-import: SUCCESS (0.006s)
[454.120763] [095/133] (569s left) kms_psr (fbc-psr2-sprite-blt)
[454.210093] Starting subtest: fbc-psr2-sprite-blt
[454.212980] Starting dynamic subtest: eDP-1
[454.217960] Dynamic subtest eDP-1: SKIP (0.000s)
[454.222454] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[454.285655] [096/133] (569s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[454.391099] Starting subtest: plane-lut1d-post-ctm3x4
[454.526073] Starting dynamic subtest: pipe-A-plane-0
[454.693677] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[454.704981] Starting dynamic subtest: pipe-A-plane-1
[454.825329] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[454.836376] Starting dynamic subtest: pipe-A-plane-2
[454.970550] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[456.122721] Starting dynamic subtest: pipe-B-plane-0
[456.270229] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[456.281349] Starting dynamic subtest: pipe-B-plane-1
[456.426022] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[456.436348] Starting dynamic subtest: pipe-B-plane-2
[456.580850] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[457.786381] Starting dynamic subtest: pipe-C-plane-0
[457.918849] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[457.929115] Starting dynamic subtest: pipe-C-plane-1
[458.063177] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[458.073609] Starting dynamic subtest: pipe-C-plane-2
[458.229526] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[459.402145] Starting dynamic subtest: pipe-D-plane-0
[459.572308] Dynamic subtest pipe-D-plane-0: SUCCESS (0.178s)
[459.583125] Starting dynamic subtest: pipe-D-plane-1
[459.794247] Dynamic subtest pipe-D-plane-1: SUCCESS (0.220s)
[459.804944] Starting dynamic subtest: pipe-D-plane-2
[459.938123] Dynamic subtest pipe-D-plane-2: SUCCESS (0.142s)
[460.239163] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.849s)
[461.071937] [097/133] (562s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[461.142146] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[461.147925] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[461.326138] [098/133] (562s left) kms_big_fb (linear-8bpp-rotate-180)
[461.421468] Starting subtest: linear-8bpp-rotate-180
[462.770055] Subtest linear-8bpp-rotate-180: SUCCESS (1.348s)
[462.893487] [099/133] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[462.995568] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[463.000068] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[463.095250] [100/133] (560s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[463.203705] Starting subtest: extended-modeset-hang-oldfb-with-reset
[463.205825] Starting dynamic subtest: pipe-A
[475.048028] Dynamic subtest pipe-A: SUCCESS (11.846s)
[475.058701] Starting dynamic subtest: pipe-D
[487.311389] Dynamic subtest pipe-D: SUCCESS (12.262s)
[487.314309] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.112s)
[488.115022] [101/133] (535s left) gem_exec_schedule (timeslicing)
[488.206295] Starting subtest: timeslicing
[488.209012] Starting dynamic subtest: rcs0
[488.216833] Dynamic subtest rcs0: SUCCESS (0.023s)
[488.238335] Starting dynamic subtest: bcs0
[488.241753] Dynamic subtest bcs0: SUCCESS (0.022s)
[488.252035] Starting dynamic subtest: vcs0
[488.261117] Dynamic subtest vcs0: SUCCESS (0.023s)
[488.271688] Starting dynamic subtest: vcs1
[488.282258] Dynamic subtest vcs1: SUCCESS (0.020s)
[488.292623] Starting dynamic subtest: vecs0
[488.303511] Dynamic subtest vecs0: SUCCESS (0.020s)
[488.327198] Starting dynamic subtest: ccs0
[488.329972] Dynamic subtest ccs0: SUCCESS (0.019s)
[488.332835] Subtest timeslicing: SUCCESS (0.134s)
[490.106277] [102/133] (533s left) kms_chamelium_color (ctm-0-25)
[490.202127] Subtest ctm-0-25: SKIP (0.000s)
[490.249796] [103/133] (533s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[490.345804] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[490.348461] Starting dynamic subtest: pipe-A-eDP-1
[490.480488] Dynamic subtest pipe-A-eDP-1: SKIP (0.137s)
[490.491142] Starting dynamic subtest: pipe-B-eDP-1
[491.584984] Dynamic subtest pipe-B-eDP-1: SKIP (1.102s)
[491.590144] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.242s)
[492.777842] [104/133] (531s left) gem_mmap (short-mmap)
[492.844155] Subtest short-mmap: SKIP (0.000s)
[492.906894] [105/133] (530s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[492.960116] Starting subtest: multi-wait-available-unsubmitted-submitted
[492.962578] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[493.091207] [106/133] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[493.183467] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[493.188159] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[493.265873] [107/133] (530s left) kms_getfb (getfb2-accept-nv12)
[493.358833] Starting subtest: getfb2-accept-nv12
[493.361349] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[493.469832] [108/133] (530s left) syncobj_timeline (invalid-signal-zero-handles)
[493.523751] Starting subtest: invalid-signal-zero-handles
[493.526354] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[493.625599] [109/133] (530s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[493.722449] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[493.726993] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[493.796400] [110/133] (530s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[493.886884] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[493.889192] Starting dynamic subtest: pipe-A-eDP-1
[493.945817] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[493.958577] Starting dynamic subtest: pipe-B-eDP-1
[494.018005] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[494.029100] Starting dynamic subtest: pipe-C-eDP-1
[494.086584] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[494.096672] Starting dynamic subtest: pipe-D-eDP-1
[494.153105] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[494.157528] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[496.046475] [111/133] (528s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[496.141981] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[496.152668] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[496.236648] [112/133] (527s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[496.319430] Starting subtest: async-flip-with-page-flip-events-tiled
[496.690075] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[499.410255] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.720s)
[499.424844] Starting dynamic subtest: pipe-A-eDP-1-4
[501.595700] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[501.609330] Starting dynamic subtest: pipe-A-eDP-1-4
[503.604790] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[503.615246] Starting dynamic subtest: pipe-A-eDP-1-x
[505.794585] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[506.170616] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[508.941464] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[508.952318] Starting dynamic subtest: pipe-B-eDP-1-4
[511.137233] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.195s)
[511.150383] Starting dynamic subtest: pipe-B-eDP-1-4
[513.146518] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[513.157335] Starting dynamic subtest: pipe-B-eDP-1-x
[515.347340] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[515.727869] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[518.477854] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[518.491751] Starting dynamic subtest: pipe-C-eDP-1-4
[520.662159] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.182s)
[520.673316] Starting dynamic subtest: pipe-C-eDP-1-4
[522.672243] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[522.683310] Starting dynamic subtest: pipe-C-eDP-1-x
[524.863203] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[525.233932] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[528.005937] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.780s)
[528.020178] Starting dynamic subtest: pipe-D-eDP-1-4
[530.181073] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[530.192496] Starting dynamic subtest: pipe-D-eDP-1-4
[532.191785] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[532.203133] Starting dynamic subtest: pipe-D-eDP-1-x
[534.382493] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[534.385478] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.065s)
[535.603701] [113/133] (488s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[535.709127] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[535.715091] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[535.791071] [114/133] (488s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[535.838794] Starting subtest: etime-multi-wait-for-submit-submitted
[535.945301] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[536.026830] [115/133] (488s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[538.250361] Starting subtest: modeset-non-lpsp-stress-no-wait
[538.296121] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.048s)
[538.616572] [116/133] (485s left) gem_exec_params (sol-reset-invalid)
[538.696168] Starting subtest: sol-reset-invalid
[538.701347] Subtest sol-reset-invalid: SUCCESS (0.003s)
[540.107409] [117/133] (484s left) gem_mmap_gtt (cpuset-big-copy)
[540.169203] Subtest cpuset-big-copy: SKIP (0.000s)
[540.228678] [118/133] (484s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[540.335114] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[547.820393] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.485s)
[547.944541] [119/133] (476s left) kms_psr (psr2-sprite-plane-onoff)
[548.037732] Starting subtest: psr2-sprite-plane-onoff
[548.040177] Starting dynamic subtest: eDP-1
[549.817074] Dynamic subtest eDP-1: SUCCESS (1.778s)
[549.819589] Subtest psr2-sprite-plane-onoff: SUCCESS (1.780s)
[550.677519] [120/133] (473s left) kms_dsc (dsc-with-output-formats)
[550.787033] Starting subtest: dsc-with-output-formats
[550.809944] Subtest dsc-with-output-formats: SKIP (0.000s)
[550.860634] [121/133] (473s left) gen3_mixed_blits
[550.974465] [122/133] (473s left) gem_mmap_offset (clear-via-pagefault)
[551.025592] Starting subtest: clear-via-pagefault
[551.027475] Starting dynamic subtest: smem0
[584.578336] Dynamic subtest smem0: SUCCESS (33.546s)
[584.581350] Subtest clear-via-pagefault: SUCCESS (33.548s)
[584.678165] [123/133] (439s left) gem_eio (reset-stress)
[584.902834] Starting subtest: reset-stress
[584.905312] Starting dynamic subtest: render
[589.876064] Dynamic subtest render: SUCCESS (4.972s)
[589.894065] Starting dynamic subtest: bsd1
[607.568606] Dynamic subtest bsd1: SUCCESS (17.692s)
[607.585565] Starting dynamic subtest: bsd2
[625.553228] Dynamic subtest bsd2: SUCCESS (17.984s)
[625.572322] Starting dynamic subtest: blt
[625.577305] Dynamic subtest blt: SKIP (0.000s)
[625.587376] Starting dynamic subtest: vebox
[643.539236] Dynamic subtest vebox: SUCCESS (17.986s)
[643.541829] Subtest reset-stress: SUCCESS (58.639s)
[645.123168] [124/133] (379s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[645.179205] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[645.182175] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[645.275821] [125/133] (379s left) kms_vblank (query-busy-hang)
[645.370464] Starting subtest: query-busy-hang
[645.372803] Starting dynamic subtest: pipe-A-eDP-1
[647.245188] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[647.261039] Starting dynamic subtest: pipe-D-eDP-1
[649.827200] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s)
[649.830184] Subtest query-busy-hang: SUCCESS (4.460s)
[650.623573] [126/133] (374s left) kms_psr (fbc-pr-cursor-plane-onoff)
[650.718941] Starting subtest: fbc-pr-cursor-plane-onoff
[650.724815] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[650.832488] [127/133] (374s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[650.932136] Starting subtest: psr-1p-primscrn-cur-indfb-move
[658.247879] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.320s)
[658.361942] [128/133] (366s left) tools_test (sysfs_l3_parity)
[658.423028] Starting subtest: sysfs_l3_parity
[658.493948] Subtest sysfs_l3_parity: SKIP (0.085s)
[658.548102] [129/133] (366s left) kms_vblank (crtc-id)
[658.638139] Starting subtest: crtc-id
[658.640561] Starting dynamic subtest: pipe-A-eDP-1
[659.092078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[659.107726] Starting dynamic subtest: pipe-D-eDP-1
[660.256922] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.160s)
[660.259119] Subtest crtc-id: SUCCESS (1.619s)
[661.104415] [130/133] (363s left) gem_ctx_engines (independent)
[661.163323] Starting subtest: independent
[661.166151] Starting dynamic subtest: rcs0
[661.327806] Dynamic subtest rcs0: SUCCESS (0.165s)
[661.342779] Starting dynamic subtest: bcs0
[661.483149] Dynamic subtest bcs0: SUCCESS (0.155s)
[661.496235] Starting dynamic subtest: vcs0
[661.665303] Dynamic subtest vcs0: SUCCESS (0.181s)
[661.678535] Starting dynamic subtest: vcs1
[661.824896] Dynamic subtest vcs1: SUCCESS (0.159s)
[661.836471] Starting dynamic subtest: vecs0
[661.991897] Dynamic subtest vecs0: SUCCESS (0.166s)
[662.005344] Starting dynamic subtest: ccs0
[662.146306] Dynamic subtest ccs0: SUCCESS (0.153s)
[662.159751] Starting dynamic subtest: all-engines
[662.843782] Dynamic subtest all-engines: SUCCESS (0.697s)
[662.846297] Subtest independent: SUCCESS (1.684s)
[663.224056] [131/133] (361s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[663.320019] Starting subtest: flip-vs-dpms-on-nop-interruptible
[663.322447] Starting dynamic subtest: A-eDP1
[665.184459] Dynamic subtest A-eDP1: SUCCESS (1.865s)
[665.196919] Starting dynamic subtest: B-eDP1
[667.016136] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[667.027337] Starting dynamic subtest: C-eDP1
[668.846019] Dynamic subtest C-eDP1: SUCCESS (1.828s)
[668.860576] Starting dynamic subtest: D-eDP1
[670.673304] Dynamic subtest D-eDP1: SUCCESS (1.827s)
[670.679575] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.362s)
[671.863418] [132/133] (353s left) kms_plane_lowres (tiling-x)
[671.976048] Starting subtest: tiling-x
[671.978546] Starting dynamic subtest: pipe-A-eDP-1
[671.983659] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[672.275931] Starting dynamic subtest: pipe-B-eDP-1
[672.281134] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[672.291687] Starting dynamic subtest: pipe-C-eDP-1
[672.297068] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[672.307607] Starting dynamic subtest: pipe-D-eDP-1
[672.312888] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[672.318104] Subtest tiling-x: SKIP (0.297s)
[673.075350] [133/133] (352s left) i915_pm_freq_api (freq-reset)
[673.137485] Starting subtest: freq-reset
[673.140327] Starting dynamic subtest: gt0
[673.328550] Dynamic subtest gt0: SUCCESS (0.191s)
[673.340347] Starting dynamic subtest: gt1
[673.501322] Dynamic subtest gt1: SUCCESS (0.170s)
[673.504315] Subtest freq-reset: SUCCESS (0.363s)
[673.576081] 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.