[60.673414] Initializing watchdogs
[60.673461]   /dev/watchdog0
[60.688507] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.693467] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.695909] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.698285] [001/133] (960s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[60.761820] Starting subtest: yf-tiled-ccs-to-yf-tiled
[60.763917] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[60.950125] [002/133] (960s left) gem_exec_reloc (basic-write-cpu-noreloc)
[61.017207] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[61.081980] [003/133] (960s left) gem_render_copy (y-tiled)
[61.138311] Starting subtest: y-tiled
[61.140064] Subtest y-tiled: SKIP (0.000s)
[61.315404] [004/133] (959s left) gem_userptr_blits (probe)
[61.377696] Starting subtest: probe
[61.459689] Subtest probe: SUCCESS (0.081s)
[61.563992] [005/133] (959s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[61.610426] Starting subtest: single-wait-all-for-submit-available-signaled
[61.612579] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[61.703479] [006/133] (959s left) kms_getfb (getfb-handle-zero)
[61.800408] Starting subtest: getfb-handle-zero
[61.801410] Subtest getfb-handle-zero: SUCCESS (0.000s)
[61.896561] [007/133] (959s left) gem_exec_fence (syncobj-invalid-flags)
[62.337929] Starting subtest: syncobj-invalid-flags
[62.339319] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[63.935922] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[63.937919] [008/133] (957s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[64.019947] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[64.021751] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[64.083508] [009/133] (957s left) gem_mmap_gtt (basic-small-copy-xy)
[64.135586] Subtest basic-small-copy-XY: SKIP (0.000s)
[64.191174] [010/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[64.287694] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[64.289454] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[64.376416] [011/133] (957s left) kms_addfb_basic (bad-pitch-1024)
[64.424532] Starting subtest: bad-pitch-1024
[64.425302] Subtest bad-pitch-1024: SUCCESS (0.000s)
[64.549511] [012/133] (956s left) gem_exec_big (single)
[64.610709] Starting subtest: single
[69.667738] Subtest single: SUCCESS (5.010s)
[69.868807] [013/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[70.010922] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[70.012631] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[70.105373] [014/133] (951s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[70.202883] Starting subtest: fbcpsr-tiling-linear
[76.843348] Subtest fbcpsr-tiling-linear: SUCCESS (6.642s)
[76.964507] [015/133] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[77.064741] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[77.066364] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[77.153672] [016/133] (944s left) gem_exec_balancer (noheartbeat)
[77.443741] Starting subtest: noheartbeat
[77.445495] Subtest noheartbeat: SKIP (0.000s)
[77.543898] [017/133] (944s left) gem_exec_schedule (u-lateslice)
[77.606667] Starting subtest: u-lateslice
[77.607615] Starting dynamic subtest: rcs0
[77.629969] Dynamic subtest rcs0: SUCCESS (0.024s)
[77.637199] Starting dynamic subtest: bcs0
[77.646906] Dynamic subtest bcs0: SUCCESS (0.017s)
[77.655557] Starting dynamic subtest: vcs0
[77.664833] Dynamic subtest vcs0: SUCCESS (0.018s)
[77.671154] Starting dynamic subtest: vcs1
[77.683074] Dynamic subtest vcs1: SUCCESS (0.018s)
[77.689744] Starting dynamic subtest: vecs0
[77.699693] Dynamic subtest vecs0: SUCCESS (0.017s)
[77.705880] Starting dynamic subtest: ccs0
[77.716474] Dynamic subtest ccs0: SUCCESS (0.016s)
[77.717426] Subtest u-lateslice: SUCCESS (0.111s)
[79.003486] [018/133] (942s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[79.093068] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[79.093888] Starting dynamic subtest: pipe-A-eDP-1
[79.102585] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.109615] Starting dynamic subtest: pipe-B-eDP-1
[79.119280] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.127834] Starting dynamic subtest: pipe-C-eDP-1
[79.135696] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.141929] Starting dynamic subtest: pipe-D-eDP-1
[79.149905] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.151560] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[81.328998] [019/133] (940s left) gem_exec_params (dr1-dirt)
[81.388890] Starting subtest: DR1-dirt
[81.390099] Subtest DR1-dirt: SUCCESS (0.000s)
[81.479021] [020/133] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[81.566821] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[81.568655] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[81.683157] [021/133] (940s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[81.803260] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[82.929059] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.126s)
[83.035378] [022/133] (938s left) gem_pipe_control_store_loop (fresh-buffer)
[83.089156] Starting subtest: fresh-buffer
[85.250365] Subtest fresh-buffer: SUCCESS (2.151s)
[85.363853] [023/133] (936s left) i915_power (sanity)
[85.417244] Starting subtest: sanity
[89.476444] Subtest sanity: SUCCESS (4.048s)
[90.979714] [024/133] (930s left) gem_pxp (fail-invalid-protected-context)
[91.096263] Starting subtest: fail-invalid-protected-context
[91.097468] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[91.206197] [025/133] (930s left) i915_hangman (gt-engine-hang)
[91.256902] Starting subtest: gt-engine-hang
[91.257871] Starting dynamic subtest: rcs0
[92.863734] Dynamic subtest rcs0: SUCCESS (1.597s)
[92.874542] Starting dynamic subtest: bcs0
[94.910234] Dynamic subtest bcs0: SUCCESS (2.045s)
[94.920601] Starting dynamic subtest: vcs0
[96.897325] Dynamic subtest vcs0: SUCCESS (1.985s)
[96.906464] Starting dynamic subtest: vcs1
[98.879018] Dynamic subtest vcs1: SUCCESS (1.981s)
[98.889592] Starting dynamic subtest: vecs0
[100.862044] Dynamic subtest vecs0: SUCCESS (1.982s)
[100.872354] Starting dynamic subtest: ccs0
[102.911243] Dynamic subtest ccs0: SUCCESS (2.048s)
[102.912534] Subtest gt-engine-hang: SUCCESS (11.645s)
[103.015517] [026/133] (918s left) kms_flip (2x-plain-flip-interruptible)
[103.108937] Starting subtest: 2x-plain-flip-interruptible
[103.120771] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[103.216569] [027/133] (918s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[103.279950] Starting subtest: y-tiled-to-vebox-y-tiled
[103.281674] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[103.467772] [028/133] (918s left) kms_psr (pr-sprite-plane-move)
[103.557399] Starting subtest: pr-sprite-plane-move
[103.559161] Subtest pr-sprite-plane-move: SKIP (0.000s)
[103.623180] [029/133] (918s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[103.721432] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[103.735029] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.013s)
[103.821522] [030/133] (918s left) gem_exec_schedule (independent)
[103.881724] Starting subtest: independent
[103.882813] Starting dynamic subtest: rcs0
[105.888814] Dynamic subtest rcs0: SUCCESS (1.997s)
[105.898798] Starting dynamic subtest: vcs0
[107.966520] Dynamic subtest vcs0: SUCCESS (2.077s)
[107.976148] Starting dynamic subtest: vcs1
[109.928551] Dynamic subtest vcs1: SUCCESS (1.961s)
[109.938768] Starting dynamic subtest: vecs0
[111.913718] Dynamic subtest vecs0: SUCCESS (1.984s)
[111.923494] Starting dynamic subtest: ccs0
[113.952803] Dynamic subtest ccs0: SUCCESS (2.038s)
[113.954243] Subtest independent: SUCCESS (10.061s)
[114.248091] [031/133] (907s left) gem_exec_suspend (basic-s3)
[114.314730] Starting subtest: basic-S3
[114.315910] Starting dynamic subtest: smem
[134.992198] Dynamic subtest smem: SUCCESS (7.564s)
[134.993403] Subtest basic-S3: SUCCESS (7.566s)
[141.200509] [032/133] (887s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[141.601607] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[142.375499] [033/133] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[142.480606] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[142.482745] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[142.548025] [034/133] (885s left) api_intel_bb (simple-bb)
[142.599640] Starting subtest: simple-bb
[142.607927] Subtest simple-bb: SUCCESS (0.009s)
[142.718594] [035/133] (885s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[142.807691] Starting subtest: fbc-rgb565-draw-mmap-gtt
[142.809387] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[142.911115] [036/133] (885s left) kms_chamelium_color (ctm-limited-range)
[143.003357] Subtest ctm-limited-range: SKIP (0.000s)
[143.043790] [037/133] (885s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[143.132173] Starting subtest: 4-tiled-64bpp-rotate-0
[144.744204] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.612s)
[144.911935] [038/133] (883s left) kms_cursor_crc (cursor-random-256x256)
[145.147157] Starting subtest: cursor-random-256x256
[145.150019] Starting dynamic subtest: pipe-A-eDP-1
[148.529381] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.378s)
[148.557603] Starting dynamic subtest: pipe-D-eDP-1
[152.534166] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.982s)
[152.535141] Subtest cursor-random-256x256: SUCCESS (7.385s)
[153.388943] [039/133] (875s left) kms_chamelium_frames (dp-crc-fast)
[153.766207] Subtest dp-crc-fast: SKIP (0.000s)
[154.587275] [040/133] (873s left) gem_ctx_isolation (preservation-reset)
[154.764732] Starting subtest: preservation-reset
[154.765833] Starting dynamic subtest: rcs0
[155.043398] Dynamic subtest rcs0: SUCCESS (0.289s)
[155.053251] Starting dynamic subtest: bcs0
[155.364307] Dynamic subtest bcs0: SUCCESS (0.320s)
[155.375898] Starting dynamic subtest: vcs0
[155.674634] Dynamic subtest vcs0: SUCCESS (0.310s)
[155.684343] Starting dynamic subtest: vcs1
[157.288129] Dynamic subtest vcs1: SUCCESS (1.613s)
[157.299205] Starting dynamic subtest: vecs0
[159.285145] Dynamic subtest vecs0: SUCCESS (1.996s)
[159.295467] Starting dynamic subtest: ccs0
[161.349262] Dynamic subtest ccs0: SUCCESS (2.063s)
[161.350464] Subtest preservation-reset: SUCCESS (6.595s)
[161.469480] [041/133] (867s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[161.561568] Starting subtest: primary-y-tiled-reflect-x-270
[161.563503] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[161.630886] [042/133] (866s left) gem_lmem_swapping (random)
[161.665804] Subtest random: SKIP (0.000s)
[161.704039] [043/133] (866s left) gem_exec_whisper (basic-fds-priority-all)
[161.758147] Starting subtest: basic-fds-priority-all
[185.253797] Subtest basic-fds-priority-all: SUCCESS (23.482s)
[185.436369] [044/133] (843s left) kms_universal_plane (universal-plane-sanity)
[185.532393] Starting subtest: universal-plane-sanity
[185.533443] Starting dynamic subtest: pipe-A-eDP-1
[186.141576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[186.150712] Starting dynamic subtest: pipe-B-eDP-1
[187.345192] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.203s)
[187.354846] Starting dynamic subtest: pipe-C-eDP-1
[188.544196] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[188.552993] Starting dynamic subtest: pipe-D-eDP-1
[189.778600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[189.780148] Subtest universal-plane-sanity: SUCCESS (4.246s)
[190.637826] [045/133] (838s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[190.721441] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[190.723439] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[190.830672] [046/133] (837s left) gen9_exec_parse (bb-secure)
[190.880122] Subtest bb-secure: SKIP (0.000s)
[190.947054] [047/133] (837s left) sw_sync (sync_random_merge)
[190.977173] Starting subtest: sync_random_merge
[191.025279] Subtest sync_random_merge: SUCCESS (0.049s)
[191.095671] [048/133] (837s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[191.190664] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[191.192489] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[191.272945] [049/133] (837s left) perf_pmu (busy-double-start)
[191.308439] Starting subtest: busy-double-start
[191.309282] Starting dynamic subtest: rcs0
[194.913916] Dynamic subtest rcs0: FAIL (3.586s)
[194.923182] Starting dynamic subtest: bcs0
[198.463844] Dynamic subtest bcs0: SUCCESS (3.566s)
[198.472961] Starting dynamic subtest: vcs0
[202.503390] Dynamic subtest vcs0: SUCCESS (4.039s)
[202.512606] Starting dynamic subtest: vcs1
[206.558708] Dynamic subtest vcs1: SUCCESS (4.054s)
[206.570240] Starting dynamic subtest: vecs0
[210.524896] Dynamic subtest vecs0: SUCCESS (3.964s)
[210.537169] Starting dynamic subtest: ccs0
[214.121248] Dynamic subtest ccs0: FAIL (3.564s)
[214.122065] Subtest busy-double-start: FAIL (22.781s)
[214.201685] [050/133] (814s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[214.296441] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[214.297988] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[214.386159] [051/133] (814s left) sysfs_heartbeat_interval (idempotent)
[214.441912] Starting subtest: idempotent
[214.442957] Starting dynamic subtest: vecs0
[214.443983] Dynamic subtest vecs0: SUCCESS (0.001s)
[214.454396] Starting dynamic subtest: ccs0
[214.455453] Dynamic subtest ccs0: SUCCESS (0.001s)
[214.464510] Starting dynamic subtest: vcs0
[214.465590] Dynamic subtest vcs0: SUCCESS (0.000s)
[214.473485] Starting dynamic subtest: bcs0
[214.474312] Dynamic subtest bcs0: SUCCESS (0.001s)
[214.482220] Starting dynamic subtest: rcs0
[214.483113] Dynamic subtest rcs0: SUCCESS (0.000s)
[214.491225] Starting dynamic subtest: vcs1
[214.492287] Dynamic subtest vcs1: SUCCESS (0.000s)
[214.493179] Subtest idempotent: SUCCESS (0.006s)
[214.558117] [052/133] (814s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[214.654607] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[214.656498] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[214.752153] [053/133] (814s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[214.847872] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[215.718144] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.870s)
[215.895534] [054/133] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[215.999192] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[216.000744] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[216.085053] [055/133] (812s left) sw_sync (sync_merge_same)
[216.121113] Starting subtest: sync_merge_same
[216.122792] Subtest sync_merge_same: SUCCESS (0.000s)
[216.183033] [056/133] (812s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[218.124615] Starting subtest: modeset-non-lpsp-stress-no-wait
[218.173005] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s)
[218.495963] [057/133] (810s left) kms_hdr (invalid-hdr)
[218.579914] Starting subtest: invalid-hdr
[220.708645] Starting dynamic subtest: pipe-A-eDP-1
[223.643852] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.935s)
[223.644839] Subtest invalid-hdr: SUCCESS (5.064s)
[223.758169] [058/133] (805s left) kms_flip (2x-flip-vs-suspend-interruptible)
[223.854713] Starting subtest: 2x-flip-vs-suspend-interruptible
[223.866886] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[223.941120] [059/133] (805s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[224.028496] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[226.287387] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (2.259s)
[226.420369] [060/133] (802s left) gem_busy (busy)
[226.469858] Starting subtest: busy
[226.470958] Starting dynamic subtest: all-engines
[226.528370] Dynamic subtest all-engines: SUCCESS (0.058s)
[226.540773] Starting dynamic subtest: rcs0
[228.051333] Dynamic subtest rcs0: SUCCESS (1.517s)
[228.061603] Starting dynamic subtest: bcs0
[228.085447] Dynamic subtest bcs0: SUCCESS (0.038s)
[228.093888] Starting dynamic subtest: vcs0
[228.124262] Dynamic subtest vcs0: SUCCESS (0.039s)
[228.134900] Starting dynamic subtest: vcs1
[230.035263] Dynamic subtest vcs1: SUCCESS (1.901s)
[230.046368] Starting dynamic subtest: vecs0
[232.019462] Dynamic subtest vecs0: SUCCESS (1.982s)
[232.029590] Starting dynamic subtest: ccs0
[234.003784] Dynamic subtest ccs0: SUCCESS (1.983s)
[234.004929] Subtest busy: SUCCESS (7.525s)
[234.341462] [061/133] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[234.435145] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[234.437104] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[234.544666] [062/133] (794s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[234.590500] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[234.709142] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[234.785887] [063/133] (794s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[234.884121] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[234.885828] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[234.982072] [064/133] (794s left) kms_vblank (wait-forked)
[235.075517] Starting subtest: wait-forked
[235.076519] Starting dynamic subtest: pipe-A-eDP-1
[236.883301] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[236.894882] Starting dynamic subtest: pipe-D-eDP-1
[239.372042] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.487s)
[239.373072] Subtest wait-forked: SUCCESS (4.298s)
[240.224519] [065/133] (789s left) kms_async_flips (test-time-stamp)
[240.310602] Starting subtest: test-time-stamp
[240.702250] Starting dynamic subtest: pipe-A-eDP-1
[241.534884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.832s)
[241.926810] Starting dynamic subtest: pipe-B-eDP-1
[242.672854] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s)
[243.042467] Starting dynamic subtest: pipe-C-eDP-1
[243.804912] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[244.171604] Starting dynamic subtest: pipe-D-eDP-1
[244.933880] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[244.934942] Subtest test-time-stamp: SUCCESS (4.624s)
[246.094573] [066/133] (783s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[246.203379] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[246.205270] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[246.308151] [067/133] (783s left) kms_color (ctm-blue-to-red)
[246.390008] Starting subtest: ctm-blue-to-red
[246.391139] Starting dynamic subtest: pipe-A-eDP-1
[247.103910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[247.115747] Starting dynamic subtest: pipe-B-eDP-1
[248.508315] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[248.516908] Starting dynamic subtest: pipe-C-eDP-1
[249.910335] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.402s)
[249.919148] Starting dynamic subtest: pipe-D-eDP-1
[251.234559] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[251.235554] Subtest ctm-blue-to-red: SUCCESS (4.846s)
[252.050718] [068/133] (777s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[252.133858] Starting subtest: plane-use-after-nonblocking-unbind
[252.134761] Starting dynamic subtest: pipe-A-eDP-1
[252.196497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[252.504124] Starting dynamic subtest: pipe-B-eDP-1
[253.266852] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.771s)
[253.575666] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.442s)
[254.428553] [069/133] (775s left) gem_lmem_swapping (heavy-verify-multi)
[254.473788] Subtest heavy-verify-multi: SKIP (0.000s)
[254.512728] [070/133] (775s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[254.595187] Starting subtest: fbc-pr-cursor-plane-update-sf
[254.596836] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[254.667383] [071/133] (774s left) kms_addfb_basic (size-max)
[254.751836] Starting subtest: size-max
[254.752782] Subtest size-max: SUCCESS (0.000s)
[254.852556] [072/133] (774s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[254.939808] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[254.940681] Starting dynamic subtest: pipe-A
[254.959865] Dynamic subtest pipe-A: SKIP (0.018s)
[254.969165] Starting dynamic subtest: pipe-B
[254.991789] Dynamic subtest pipe-B: SKIP (0.032s)
[255.000643] Starting dynamic subtest: pipe-C
[255.024878] Dynamic subtest pipe-C: SKIP (0.033s)
[255.033336] Starting dynamic subtest: pipe-D
[255.058731] Dynamic subtest pipe-D: SKIP (0.033s)
[255.060375] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.119s)
[255.157937] [073/133] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[255.245901] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[255.247365] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[255.328733] [074/133] (774s left) gem_partial_pwrite_pread (reads-display)
[255.396844] Subtest reads-display: SKIP (0.000s)
[255.473022] [075/133] (774s left) kms_content_protection (dp-mst-type-1)
[255.611507] Starting subtest: dp-mst-type-1
[255.613547] Subtest dp-mst-type-1: SKIP (0.000s)
[255.739157] [076/133] (774s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[255.835665] Starting subtest: bad-rotation-90-yf-tiled-ccs
[255.836516] Starting dynamic subtest: pipe-A-eDP-1
[255.845312] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[255.854033] Starting dynamic subtest: pipe-B-eDP-1
[255.862880] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[255.871565] Starting dynamic subtest: pipe-C-eDP-1
[255.879909] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[255.888191] Starting dynamic subtest: pipe-D-eDP-1
[255.896914] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[255.898589] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[258.028377] [077/133] (771s left) kms_plane_alpha_blend (alpha-opaque-fb)
[258.114086] Starting subtest: alpha-opaque-fb
[258.398877] Starting dynamic subtest: pipe-A-eDP-1
[258.997317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[259.006596] Starting dynamic subtest: pipe-D-eDP-1
[260.398152] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s)
[260.399146] Subtest alpha-opaque-fb: SUCCESS (2.286s)
[261.286920] [078/133] (768s left) gem_softpin (reverse)
[261.344489] Starting subtest: reverse
[261.349658] Subtest reverse: SUCCESS (0.005s)
[261.470569] [079/133] (768s left) kms_flip (2x-flip-vs-panning-interruptible)
[261.557318] Starting subtest: 2x-flip-vs-panning-interruptible
[261.568920] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[261.659584] [080/133] (768s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[261.741056] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[261.742011] Starting dynamic subtest: pipe-A-eDP-1
[278.498656] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.799s)
[278.507359] Starting dynamic subtest: pipe-B-eDP-1
[296.503059] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.876s)
[296.512405] Starting dynamic subtest: pipe-C-eDP-1
[314.462656] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.797s)
[314.472376] Starting dynamic subtest: pipe-D-eDP-1
[332.462192] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.738s)
[332.463293] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.216s)
[339.732502] [081/133] (696s left) syncobj_timeline (invalid-transfer-non-existent-point)
[339.811343] Starting subtest: invalid-transfer-non-existent-point
[339.812529] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[339.908290] [082/133] (696s left) gem_ctx_shared (q-smoketest)
[339.962433] Starting subtest: Q-smoketest
[339.963522] Starting dynamic subtest: rcs0
[345.543944] Dynamic subtest rcs0: SUCCESS (5.512s)
[345.556408] Starting dynamic subtest: bcs0
[351.029836] Dynamic subtest bcs0: SUCCESS (5.486s)
[351.041092] Starting dynamic subtest: vcs0
[356.520036] Dynamic subtest vcs0: SUCCESS (5.483s)
[356.531334] Starting dynamic subtest: vcs1
[362.001853] Dynamic subtest vcs1: SUCCESS (5.481s)
[362.013479] Starting dynamic subtest: vecs0
[367.483600] Dynamic subtest vecs0: SUCCESS (5.477s)
[367.497172] Starting dynamic subtest: ccs0
[372.972956] Dynamic subtest ccs0: SUCCESS (5.488s)
[372.973978] Subtest Q-smoketest: SUCCESS (32.938s)
[373.100439] [083/133] (662s left) kms_lease (atomic-implicit-crtc)
[373.200212] Starting subtest: atomic-implicit-crtc
[373.201091] Starting dynamic subtest: pipe-A-eDP-1
[373.205513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[373.214837] Starting dynamic subtest: pipe-B-eDP-1
[373.219305] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[373.230496] Starting dynamic subtest: pipe-C-eDP-1
[373.234781] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[373.243510] Starting dynamic subtest: pipe-D-eDP-1
[373.247741] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[373.248680] Subtest atomic-implicit-crtc: SUCCESS (0.038s)
[373.327951] [084/133] (662s left) prime_busy (after)
[373.396099] Starting subtest: after
[373.399361] Starting dynamic subtest: rcs0
[373.434468] Dynamic subtest rcs0: SUCCESS (0.035s)
[373.445085] Starting dynamic subtest: bcs0
[373.482265] Dynamic subtest bcs0: SUCCESS (0.047s)
[373.491243] Starting dynamic subtest: vcs0
[373.521805] Dynamic subtest vcs0: SUCCESS (0.039s)
[373.532558] Starting dynamic subtest: vcs1
[373.561379] Dynamic subtest vcs1: SUCCESS (0.039s)
[373.569789] Starting dynamic subtest: vecs0
[373.600958] Dynamic subtest vecs0: SUCCESS (0.039s)
[373.609790] Starting dynamic subtest: ccs0
[373.640966] Dynamic subtest ccs0: SUCCESS (0.039s)
[373.749963] Subtest after: SUCCESS (0.352s)
[373.821579] [085/133] (662s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[373.926359] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[373.927258] Starting dynamic subtest: pipe-A-eDP-1
[374.027111] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[374.039232] Starting dynamic subtest: pipe-B-eDP-1
[375.179422] Dynamic subtest pipe-B-eDP-1: SKIP (1.150s)
[375.181074] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.254s)
[376.458028] [086/133] (659s left) kms_joiner (basic-force-big-joiner)
[376.559989] Starting subtest: basic-force-big-joiner
[376.561599] Subtest basic-force-big-joiner: SKIP (0.000s)
[376.632308] [087/133] (659s left) perf_pmu (render-node-busy)
[376.705254] Starting subtest: render-node-busy
[376.706472] Starting dynamic subtest: rcs0
[377.288076] Dynamic subtest rcs0: SUCCESS (0.583s)
[377.301176] Starting dynamic subtest: bcs0
[377.859351] Dynamic subtest bcs0: SUCCESS (0.569s)
[377.873683] Starting dynamic subtest: vcs0
[379.496706] Dynamic subtest vcs0: SUCCESS (1.626s)
[379.507500] Starting dynamic subtest: vcs1
[381.544690] Dynamic subtest vcs1: SUCCESS (2.045s)
[381.556096] Starting dynamic subtest: vecs0
[383.528487] Dynamic subtest vecs0: SUCCESS (1.981s)
[383.542029] Starting dynamic subtest: ccs0
[384.084053] Dynamic subtest ccs0: SUCCESS (0.562s)
[384.085196] Subtest render-node-busy: SUCCESS (7.380s)
[384.156551] [088/133] (652s left) gem_ctx_engines (independent)
[384.220456] Starting subtest: independent
[384.221351] Starting dynamic subtest: rcs0
[384.477985] Dynamic subtest rcs0: SUCCESS (0.250s)
[384.489069] Starting dynamic subtest: bcs0
[384.721026] Dynamic subtest bcs0: SUCCESS (0.242s)
[384.731545] Starting dynamic subtest: vcs0
[384.924208] Dynamic subtest vcs0: SUCCESS (0.202s)
[384.935146] Starting dynamic subtest: vcs1
[385.150379] Dynamic subtest vcs1: SUCCESS (0.226s)
[385.161462] Starting dynamic subtest: vecs0
[385.365728] Dynamic subtest vecs0: SUCCESS (0.215s)
[385.377274] Starting dynamic subtest: ccs0
[385.731659] Dynamic subtest ccs0: SUCCESS (0.365s)
[385.741983] Starting dynamic subtest: all-engines
[386.725886] Dynamic subtest all-engines: SUCCESS (0.993s)
[386.727104] Subtest independent: SUCCESS (2.499s)
[388.581730] [089/133] (647s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[388.670419] Starting subtest: psr2-overlay-plane-update-continuous-sf
[388.671472] Starting dynamic subtest: pipe-A-eDP-1
[389.803148] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.132s)
[389.813532] Starting dynamic subtest: pipe-B-eDP-1
[391.533255] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.729s)
[391.534078] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.864s)
[392.331456] [090/133] (643s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[392.411198] Starting subtest: plane-scaler-unity-scaling-with-rotation
[392.411974] Starting dynamic subtest: pipe-A
[392.639261] Dynamic subtest pipe-A: SUCCESS (0.228s)
[392.649194] Starting dynamic subtest: pipe-B
[393.922629] Dynamic subtest pipe-B: SUCCESS (1.282s)
[393.932840] Starting dynamic subtest: pipe-C
[395.258060] Dynamic subtest pipe-C: SUCCESS (1.335s)
[395.268298] Starting dynamic subtest: pipe-D
[396.604042] Dynamic subtest pipe-D: SUCCESS (1.345s)
[396.604799] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.194s)
[397.761926] [091/133] (638s left) kms_psr (psr-sprite-plane-onoff)
[397.860434] Starting subtest: psr-sprite-plane-onoff
[397.861414] Starting dynamic subtest: eDP-1
[399.608459] Dynamic subtest eDP-1: SUCCESS (1.747s)
[399.609347] Subtest psr-sprite-plane-onoff: SUCCESS (1.748s)
[400.427085] [092/133] (635s left) syncobj_timeline (multi-wait-submitted-signaled)
[400.491523] Starting subtest: multi-wait-submitted-signaled
[400.492424] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[400.604986] [093/133] (635s left) kms_feature_discovery (display-1x)
[400.699762] Starting subtest: display-1x
[400.700696] Subtest display-1x: SUCCESS (0.000s)
[400.782226] [094/133] (635s left) api_intel_allocator (open-vm)
[400.838937] Starting subtest: open-vm
[400.842771] Subtest open-vm: SUCCESS (0.005s)
[400.956035] [095/133] (635s left) syncobj_eventfd (binary-wait-signaled)
[401.013957] Starting subtest: binary-wait-signaled
[401.015393] Subtest binary-wait-signaled: SUCCESS (0.001s)
[401.133770] [096/133] (635s left) kms_psr (fbc-psr-cursor-render)
[401.218537] Starting subtest: fbc-psr-cursor-render
[401.219420] Starting dynamic subtest: eDP-1
[401.221276] Dynamic subtest eDP-1: SKIP (0.000s)
[401.222823] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[401.295777] [097/133] (635s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[401.383525] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[401.385321] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[401.475698] [098/133] (635s left) gem_userptr_blits (readonly-pwrite-unsync)
[401.536061] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[401.667733] [099/133] (634s left) syncobj_basic (bad-destroy-pad)
[401.713804] Starting subtest: bad-destroy-pad
[401.714954] Subtest bad-destroy-pad: SUCCESS (0.000s)
[401.809737] [100/133] (634s left) dmabuf_sync_file (export-before-signal)
[401.851391] Starting subtest: export-before-signal
[401.852367] Subtest export-before-signal: SUCCESS (0.001s)
[401.906878] [101/133] (634s left) gem_ctx_persistence (processes)
[401.967629] Starting subtest: processes
[403.497418] Subtest processes: SUCCESS (1.529s)
[403.575360] [102/133] (633s left) kms_cursor_crc (cursor-offscreen-256x85)
[403.840862] Starting subtest: cursor-offscreen-256x85
[403.889605] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[404.061525] [103/133] (632s left) gem_exec_reloc (basic-cpu-wc)
[404.125759] Subtest basic-cpu-wc: SKIP (0.000s)
[404.188935] [104/133] (632s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[404.281469] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[411.412700] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.133s)
[411.525411] [105/133] (625s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[411.582678] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[411.640808] [106/133] (625s left) perf (disabled-read-error)
[411.763193] Starting subtest: disabled-read-error
[411.777358] Subtest disabled-read-error: SUCCESS (0.015s)
[411.816526] [107/133] (625s left) kms_cursor_crc (cursor-tearing-position-change)
[411.912825] Starting subtest: cursor-tearing-position-change
[411.913692] Starting dynamic subtest: pipe-A-eDP-1
[412.477828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[412.486934] Starting dynamic subtest: pipe-D-eDP-1
[413.695272] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[413.696156] Subtest cursor-tearing-position-change: SUCCESS (1.782s)
[414.527956] [108/133] (622s left) core_auth (basic-auth)
[414.587588] Starting subtest: basic-auth
[414.588531] Subtest basic-auth: SUCCESS (0.001s)
[414.694752] [109/133] (622s left) i915_drm_fdinfo (context-close-stress)
[414.737930] Starting subtest: context-close-stress
[425.529927] Subtest context-close-stress: SUCCESS (10.745s)
[425.568356] [110/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[425.777628] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[425.779263] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[425.872086] [111/133] (611s left) syncobj_wait (single-wait-all-for-submit-signaled)
[425.927669] Starting subtest: single-wait-all-for-submit-signaled
[425.928446] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[426.015452] [112/133] (611s left) kms_debugfs (display-on-read-all)
[426.099151] Starting subtest: display-on-read-all
[426.267130] Subtest display-on-read-all: SUCCESS (0.168s)
[426.391231] [113/133] (610s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[426.511065] Starting subtest: 2x-long-cursor-vs-flip-atomic
[426.513272] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[426.652790] [114/133] (610s left) gem_partial_pwrite_pread (write)
[426.718444] Subtest write: SKIP (0.000s)
[426.795222] [115/133] (610s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[426.891442] Starting subtest: psr-1p-pri-indfb-multidraw
[450.010793] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.118s)
[450.108301] [116/133] (587s left) gem_mmap_offset (open-flood)
[450.158045] Starting subtest: open-flood
[471.646714] Subtest open-flood: SUCCESS (21.489s)
[471.780873] [117/133] (565s left) kms_pm_rpm (drm-resources-equal)
[473.624855] Starting subtest: drm-resources-equal
[478.661702] Subtest drm-resources-equal: SUCCESS (5.039s)
[478.750300] [118/133] (558s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[478.844171] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[478.845977] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[479.924674] [119/133] (557s left) gem_exec_schedule (implicit-boths)
[479.975842] Starting subtest: implicit-boths
[479.976822] Starting dynamic subtest: rcs0
[480.100410] Dynamic subtest rcs0: SUCCESS (0.124s)
[480.112646] Starting dynamic subtest: vcs0
[480.184031] Dynamic subtest vcs0: SUCCESS (0.082s)
[480.199286] Starting dynamic subtest: vcs1
[480.263399] Dynamic subtest vcs1: SUCCESS (0.078s)
[480.276393] Starting dynamic subtest: vecs0
[480.349031] Dynamic subtest vecs0: SUCCESS (0.085s)
[480.360531] Starting dynamic subtest: ccs0
[480.433571] Dynamic subtest ccs0: SUCCESS (0.083s)
[480.434983] Subtest implicit-boths: SUCCESS (0.458s)
[481.604337] [120/133] (555s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[481.700430] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[482.078886] Starting dynamic subtest: pipe-A-eDP-1
[484.812413] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.724s)
[485.169913] Starting dynamic subtest: pipe-B-eDP-1
[487.941840] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[488.297020] Starting dynamic subtest: pipe-C-eDP-1
[491.075038] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[491.426993] Starting dynamic subtest: pipe-D-eDP-1
[494.205473] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[494.206578] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.496s)
[495.379474] [121/133] (542s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[495.468299] Starting subtest: flip-vs-dpms-off-vs-modeset
[495.470860] Starting dynamic subtest: A-eDP1
[499.136241] Dynamic subtest A-eDP1: SUCCESS (3.665s)
[499.145851] Starting dynamic subtest: B-eDP1
[502.347990] Dynamic subtest B-eDP1: SUCCESS (3.211s)
[502.357382] Starting dynamic subtest: C-eDP1
[505.443919] Dynamic subtest C-eDP1: SUCCESS (3.093s)
[505.453938] Starting dynamic subtest: D-eDP1
[508.579752] Dynamic subtest D-eDP1: SUCCESS (3.136s)
[508.581929] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.113s)
[509.382556] [122/133] (528s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[509.449641] Starting subtest: etime-single-wait-for-submit-submitted
[509.556885] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[509.645959] [123/133] (527s left) sw_sync (timeline_closed)
[509.680132] Starting subtest: timeline_closed
[509.680955] Subtest timeline_closed: SUCCESS (0.000s)
[509.726631] [124/133] (527s left) gem_mmap (basic)
[509.775073] Subtest basic: SKIP (0.000s)
[509.837390] [125/133] (527s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[509.927223] Starting subtest: fbc-psr2-cursor-plane-onoff
[509.928066] Starting dynamic subtest: eDP-1
[509.929706] Dynamic subtest eDP-1: SKIP (0.000s)
[509.931499] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[510.011679] [126/133] (527s left) gem_exec_reloc (basic-gtt-active)
[510.069417] Subtest basic-gtt-active: SKIP (0.000s)
[510.133398] [127/133] (527s left) gem_mmap_wc (copy)
[510.179730] Subtest copy: SKIP (0.000s)
[510.241255] [128/133] (527s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[510.328214] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[513.869804] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.541s)
[515.004873] [129/133] (522s left) kms_addfb_basic (unused-pitches)
[515.062454] Starting subtest: unused-pitches
[515.063338] Subtest unused-pitches: SUCCESS (0.000s)
[515.198029] [130/133] (522s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[515.282577] Starting subtest: pixel-format-linear-modifier-source-clamping
[515.310455] Starting dynamic subtest: pipe-A-plane-0
[518.765798] Dynamic subtest pipe-A-plane-0: SUCCESS (3.455s)
[518.775292] Starting dynamic subtest: pipe-A-plane-3
[520.465840] Dynamic subtest pipe-A-plane-3: SUCCESS (1.699s)
[521.578104] Starting dynamic subtest: pipe-B-plane-0
[525.222801] Dynamic subtest pipe-B-plane-0: SUCCESS (3.655s)
[525.240497] Starting dynamic subtest: pipe-B-plane-3
[526.933836] Dynamic subtest pipe-B-plane-3: SUCCESS (1.709s)
[527.242129] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.959s)
[528.067248] [131/133] (509s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[528.159744] Starting subtest: psr-modesetfrombusy
[534.297936] Subtest psr-modesetfrombusy: SUCCESS (6.139s)
[534.436629] [132/133] (503s left) kms_psr (psr-cursor-mmap-cpu)
[534.533754] Starting subtest: psr-cursor-mmap-cpu
[534.534741] Starting dynamic subtest: eDP-1
[536.289531] Dynamic subtest eDP-1: SUCCESS (1.755s)
[536.290433] Subtest psr-cursor-mmap-cpu: SUCCESS (1.756s)
[537.166629] [133/133] (500s left) i915_pm_rpm (system-suspend)
[538.692634] Starting subtest: system-suspend
[557.080194] Subtest system-suspend: SUCCESS (3.257s)
[562.462479] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_exec_big
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_pipe_control_store_loop
results: parsing output: 22/ for test: i915_power
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: i915_hangman
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: gem_exec_suspend
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_color
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_chamelium_frames
results: parsing output: 39/ for test: gem_ctx_isolation
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_exec_whisper
results: parsing output: 43/ for test: kms_universal_plane
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gen9_exec_parse
results: parsing output: 46/ for test: sw_sync
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: sysfs_heartbeat_interval
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: kms_hdr
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_busy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_async_flips
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: kms_atomic_transition
results: parsing output: 68/ for test: gem_lmem_swapping
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_partial_pwrite_pread
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_plane_alpha_blend
results: parsing output: 77/ for test: gem_softpin
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: kms_lease
results: parsing output: 83/ for test: prime_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_joiner
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: gem_ctx_engines
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_feature_discovery
results: parsing output: 93/ for test: api_intel_allocator
results: parsing output: 94/ for test: syncobj_eventfd
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_plane
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: syncobj_basic
results: parsing output: 99/ for test: dmabuf_sync_file
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_mmap_wc
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: core_auth
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_debugfs
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_async_flips
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: gem_mmap
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: i915_pm_rpm
Done.