[57.948293] Initializing watchdogs
[57.948338]   /dev/watchdog0
[57.962963] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.966901] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.968964] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.972469] [001/132] (960s left) api_intel_allocator (two-level-inception-interruptible)
[58.061726] Starting subtest: two-level-inception-interruptible
[63.429350] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[63.539568] [002/132] (954s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[63.628656] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[63.632941] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[63.731393] [003/132] (954s left) perf_pmu (all-busy-idle-check-all)
[63.771952] Starting subtest: all-busy-idle-check-all
[65.214304] Subtest all-busy-idle-check-all: SUCCESS (1.449s)
[65.335226] [004/132] (953s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[65.412310] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[65.481904] [005/132] (953s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[65.568890] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[65.571189] Starting dynamic subtest: pipe-A
[65.653850] Dynamic subtest pipe-A: SUCCESS (0.086s)
[65.663935] Starting dynamic subtest: pipe-B
[66.806571] Dynamic subtest pipe-B: SUCCESS (1.156s)
[66.816559] Starting dynamic subtest: pipe-C
[67.909303] Dynamic subtest pipe-C: SUCCESS (1.105s)
[67.918616] Starting dynamic subtest: pipe-D
[69.043512] Dynamic subtest pipe-D: SUCCESS (1.136s)
[69.045983] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.486s)
[70.195988] [006/132] (948s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[70.272986] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[70.277066] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[70.353390] [007/132] (948s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[70.432263] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[70.436617] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[70.541677] [008/132] (948s left) kms_vblank (wait-forked-busy-hang)
[70.617440] Starting subtest: wait-forked-busy-hang
[70.619350] Starting dynamic subtest: pipe-A-eDP-1
[97.026073] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.419s)
[97.039543] Starting dynamic subtest: pipe-D-eDP-1
[122.049883] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.024s)
[122.052017] Subtest wait-forked-busy-hang: SUCCESS (51.446s)
[122.868891] [009/132] (895s left) i915_suspend (debugfs-reader)
[122.928856] Starting subtest: debugfs-reader
[141.526546] Subtest debugfs-reader: SUCCESS (3.286s)
[141.604728] [010/132] (877s left) i915_drm_fdinfo (all-busy-idle-check-all)
[141.662545] Starting subtest: all-busy-idle-check-all
[141.666952] Subtest all-busy-idle-check-all: SKIP (0.003s)
[141.746561] [011/132] (877s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[141.836752] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[141.838783] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[141.920102] [012/132] (877s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[142.003826] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[148.957636] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.031s)
[149.058409] [013/132] (869s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[149.123629] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[149.230447] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[149.303320] [014/132] (869s left) i915_pm_rpm (system-suspend-execbuf)
[150.823660] Starting subtest: system-suspend-execbuf
[211.334244] Subtest system-suspend-execbuf: SUCCESS (45.088s)
[211.705546] [015/132] (807s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[211.794136] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[212.588742] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.795s)
[212.758881] [016/132] (806s left) prime_vgem (basic-fence-read)
[212.873111] Starting subtest: basic-fence-read
[212.880858] Subtest basic-fence-read: SKIP (0.006s)
[212.983387] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[212.986366] [017/132] (806s left) kms_addfb_basic (clobberred-modifier)
[213.039484] Starting subtest: clobberred-modifier
[213.043856] Subtest clobberred-modifier: SKIP (0.000s)
[213.169177] [018/132] (805s left) gem_exec_schedule (implicit-write-read)
[213.232135] Starting subtest: implicit-write-read
[213.234016] Starting dynamic subtest: rcs0
[213.341294] Dynamic subtest rcs0: SUCCESS (0.118s)
[213.354166] Starting dynamic subtest: vcs0
[213.422058] Dynamic subtest vcs0: SUCCESS (0.080s)
[213.434048] Starting dynamic subtest: vcs1
[213.499648] Dynamic subtest vcs1: SUCCESS (0.078s)
[213.512123] Starting dynamic subtest: vecs0
[213.601954] Dynamic subtest vecs0: SUCCESS (0.101s)
[213.613496] Starting dynamic subtest: ccs0
[213.680593] Dynamic subtest ccs0: SUCCESS (0.078s)
[213.682660] Subtest implicit-write-read: SUCCESS (0.459s)
[215.238028] [019/132] (803s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[215.333711] Starting subtest: flip-vs-cursor-legacy
[222.422418] Subtest flip-vs-cursor-legacy: SUCCESS (7.086s)
[223.234423] [020/132] (796s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[223.383273] Starting subtest: cursor-rapid-movement-64x64
[223.388556] Starting dynamic subtest: pipe-A-eDP-1
[223.933924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[223.964975] Starting dynamic subtest: pipe-D-eDP-1
[225.122563] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.167s)
[225.124574] Subtest cursor-rapid-movement-64x64: SUCCESS (1.738s)
[225.974518] [021/132] (793s left) device_reset (cold-reset-bound)
[226.021606] Starting subtest: cold-reset-bound
[226.025750] Subtest cold-reset-bound: SKIP (0.000s)
[226.084608] [022/132] (793s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[226.181028] Starting subtest: 2x-long-flip-vs-cursor-atomic
[226.185645] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[226.324675] [023/132] (793s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[226.690323] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[227.485710] [024/132] (791s left) gem_userptr_blits (sync-unmap-after-close)
[227.553366] Starting subtest: sync-unmap-after-close
[227.560671] Subtest sync-unmap-after-close: SUCCESS (0.008s)
[227.667611] [025/132] (791s left) sysfs_heartbeat_interval (invalid)
[227.727072] Starting subtest: invalid
[227.729468] Starting dynamic subtest: vecs0
[227.731854] Dynamic subtest vecs0: SUCCESS (0.000s)
[227.743068] Starting dynamic subtest: ccs0
[227.744946] Dynamic subtest ccs0: SUCCESS (0.000s)
[227.753753] Starting dynamic subtest: vcs0
[227.755694] Dynamic subtest vcs0: SUCCESS (0.000s)
[227.764427] Starting dynamic subtest: bcs0
[227.766353] Dynamic subtest bcs0: SUCCESS (0.000s)
[227.775731] Starting dynamic subtest: rcs0
[227.778028] Dynamic subtest rcs0: SUCCESS (0.000s)
[227.787050] Starting dynamic subtest: vcs1
[227.789005] Dynamic subtest vcs1: SUCCESS (0.000s)
[227.790912] Subtest invalid: SUCCESS (0.007s)
[227.831055] [026/132] (791s left) kms_flip (2x-flip-vs-suspend)
[227.915104] Starting subtest: 2x-flip-vs-suspend
[227.919479] Subtest 2x-flip-vs-suspend: SKIP (0.001s)
[228.021061] [027/132] (791s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[228.098889] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[228.200608] [028/132] (791s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[228.278124] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[228.280123] Starting dynamic subtest: pipe-A-eDP-1
[228.682360] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.382s)
[228.692835] Starting dynamic subtest: pipe-B-eDP-1
[230.124624] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s)
[230.134564] Starting dynamic subtest: pipe-C-eDP-1
[231.534235] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.408s)
[231.545547] Starting dynamic subtest: pipe-D-eDP-1
[232.850319] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[232.852646] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.545s)
[234.050823] [029/132] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[234.136962] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[234.141522] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[234.219392] [030/132] (785s left) kms_cursor_crc (cursor-offscreen-512x512)
[234.468105] Starting subtest: cursor-offscreen-512x512
[234.472755] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[234.611667] [031/132] (785s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[234.681561] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[234.683748] Starting dynamic subtest: pipe-A-default-mode
[235.815181] Dynamic subtest pipe-A-default-mode: SKIP (1.132s)
[235.819221] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.134s)
[235.945765] [032/132] (783s left) gen9_exec_parse (cmd-crossing-page)
[236.004918] Subtest cmd-crossing-page: SKIP (0.000s)
[236.074569] [033/132] (783s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[236.129757] Starting subtest: etime-multi-wait-all-available-unsubmitted
[236.238531] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[236.320291] [034/132] (783s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[236.413128] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[236.415474] Starting dynamic subtest: pipe-A-eDP-1
[237.729413] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.314s)
[238.021517] Starting dynamic subtest: pipe-B-eDP-1
[239.061252] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.062s)
[239.329401] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.916s)
[240.179971] [035/132] (779s left) kms_big_fb (linear-16bpp-rotate-0)
[240.258123] Starting subtest: linear-16bpp-rotate-0
[241.546561] Subtest linear-16bpp-rotate-0: SUCCESS (1.290s)
[241.697608] [036/132] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[241.765525] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[241.769080] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[241.850804] [037/132] (778s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[241.934955] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[241.936771] Starting dynamic subtest: pipe-A-eDP-1
[241.955413] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[241.969245] Starting dynamic subtest: pipe-B-eDP-1
[241.986763] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[241.998829] Starting dynamic subtest: pipe-C-eDP-1
[242.017750] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.027974] Starting dynamic subtest: pipe-D-eDP-1
[242.047101] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.050515] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[244.133670] [038/132] (775s left) kms_pm_rpm (fences)
[246.249451] Starting subtest: fences
[246.254050] Subtest fences: SKIP (0.000s)
[246.619900] [039/132] (773s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[246.697567] Starting subtest: psr-indfb-scaledprimary
[252.477242] Subtest psr-indfb-scaledprimary: SUCCESS (5.786s)
[252.601265] [040/132] (767s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[252.682069] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[257.019735] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.342s)
[258.156199] [041/132] (761s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[258.240813] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[264.784093] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.551s)
[264.920589] [042/132] (755s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[265.006932] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[266.106363] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.100s)
[266.228572] [043/132] (753s left) kms_plane_lowres (tiling-x)
[266.299197] Starting subtest: tiling-x
[266.301267] Starting dynamic subtest: pipe-A-eDP-1
[266.305271] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[266.594517] Starting dynamic subtest: pipe-B-eDP-1
[266.599225] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[266.608726] Starting dynamic subtest: pipe-C-eDP-1
[266.613457] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[266.622830] Starting dynamic subtest: pipe-D-eDP-1
[266.627398] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[266.631954] Subtest tiling-x: SKIP (0.293s)
[267.389889] [044/132] (752s left) gem_close_race (multigpu-basic-threads)
[267.468888] Starting subtest: multigpu-basic-threads
[267.473547] Subtest multigpu-basic-threads: SKIP (0.000s)
[267.690021] [045/132] (752s left) i915_hangman (detector)
[267.766381] Starting subtest: detector
[267.768393] Starting dynamic subtest: rcs0
[279.112517] Dynamic subtest rcs0: SUCCESS (11.343s)
[279.127400] Starting dynamic subtest: bcs0
[291.081693] Dynamic subtest bcs0: SUCCESS (11.965s)
[291.093987] Starting dynamic subtest: vcs0
[302.089060] Dynamic subtest vcs0: SUCCESS (11.004s)
[302.102103] Starting dynamic subtest: vcs1
[314.057738] Dynamic subtest vcs1: SUCCESS (11.966s)
[314.069716] Starting dynamic subtest: vecs0
[326.088481] Dynamic subtest vecs0: SUCCESS (12.029s)
[326.101779] Starting dynamic subtest: ccs0
[337.097452] Dynamic subtest ccs0: SUCCESS (11.008s)
[337.100222] Subtest detector: SUCCESS (69.331s)
[337.248395] [046/132] (683s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[337.338402] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[337.342937] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[337.443991] [047/132] (682s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[337.524207] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[337.528560] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[337.640858] [048/132] (682s left) gem_mmap_offset (clear-via-pagefault)
[337.698935] Starting subtest: clear-via-pagefault
[337.700851] Starting dynamic subtest: smem0
[363.081620] Dynamic subtest smem0: SUCCESS (25.381s)
[363.084036] Subtest clear-via-pagefault: SUCCESS (25.384s)
[363.187670] [049/132] (657s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[363.291238] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[363.295220] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[363.385063] [050/132] (657s left) kms_flip (dpms-vs-vblank-race)
[363.453354] Starting subtest: dpms-vs-vblank-race
[363.455714] Starting dynamic subtest: A-eDP1
[368.377280] Dynamic subtest A-eDP1: SUCCESS (4.926s)
[368.389656] Starting dynamic subtest: B-eDP1
[373.020049] Dynamic subtest B-eDP1: SUCCESS (4.640s)
[373.035159] Starting dynamic subtest: C-eDP1
[377.628159] Dynamic subtest C-eDP1: SUCCESS (4.607s)
[377.639171] Starting dynamic subtest: D-eDP1
[382.252050] Dynamic subtest D-eDP1: SUCCESS (4.625s)
[382.254347] Subtest dpms-vs-vblank-race: SUCCESS (18.808s)
[383.134020] [051/132] (637s left) syncobj_timeline (multi-wait-all-signaled)
[383.201901] Starting subtest: multi-wait-all-signaled
[383.204137] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[383.327765] [052/132] (637s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[383.441851] Starting subtest: modeset-atomic-cursor-hotspot
[383.446228] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[383.587367] [053/132] (637s left) gem_exec_fence (syncobj-timeline-signal)
[384.132472] Starting subtest: syncobj-timeline-signal
[384.142789] Subtest syncobj-timeline-signal: SUCCESS (0.012s)
[385.228104] [054/132] (635s left) kms_flip (2x-nonexisting-fb-interruptible)
[385.317497] Starting subtest: 2x-nonexisting-fb-interruptible
[385.325579] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.008s)
[385.440218] [055/132] (635s left) gem_ctx_param (invalid-get-engines)
[385.499838] Starting subtest: invalid-get-engines
[385.502182] Subtest invalid-get-engines: SUCCESS (0.001s)
[385.606517] [056/132] (635s left) kms_flip (flip-vs-fences)
[385.688837] Starting subtest: flip-vs-fences
[385.692791] Subtest flip-vs-fences: SKIP (0.000s)
[385.805401] [057/132] (634s left) kms_feature_discovery (display-1x)
[385.866777] Starting subtest: display-1x
[385.869080] Subtest display-1x: SUCCESS (0.000s)
[385.951231] [058/132] (634s left) gem_exec_balancer (nop)
[386.007647] Starting subtest: nop
[432.686716] Subtest nop: SUCCESS (46.670s)
[433.001376] [059/132] (587s left) gem_exercise_blt (fast-copy)
[433.061878] Starting subtest: fast-copy
[433.063789] Starting dynamic subtest: linear-smem-smem
[433.086077] Dynamic subtest linear-smem-smem: SUCCESS (0.026s)
[433.097226] Starting dynamic subtest: xmajor-smem-smem
[433.105866] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[433.115217] Starting dynamic subtest: tile4-smem-smem
[433.128066] Dynamic subtest tile4-smem-smem: SUCCESS (0.021s)
[433.140746] Starting dynamic subtest: tile64-smem-smem
[433.149016] Dynamic subtest tile64-smem-smem: SUCCESS (0.020s)
[433.151285] Subtest fast-copy: SUCCESS (0.090s)
[433.262388] [060/132] (587s left) kms_psr (psr2-primary-render)
[433.339532] Starting subtest: psr2-primary-render
[433.341874] Starting dynamic subtest: eDP-1
[435.045556] Dynamic subtest eDP-1: SUCCESS (1.704s)
[435.047607] Subtest psr2-primary-render: SUCCESS (1.705s)
[435.912138] [061/132] (585s left) gem_exec_reloc (basic-cpu-gtt)
[435.970575] Subtest basic-cpu-gtt: SKIP (0.000s)
[436.048531] [062/132] (584s left) gem_eio (in-flight-contexts-immediate)
[436.261099] Starting subtest: in-flight-contexts-immediate
[448.118417] Subtest in-flight-contexts-immediate: SUCCESS (11.857s)
[448.260117] [063/132] (572s left) gem_exec_schedule (preempt-user)
[448.347216] Starting subtest: preempt-user
[448.349437] Starting dynamic subtest: rcs0
[448.367554] Dynamic subtest rcs0: SUCCESS (0.029s)
[448.381987] Starting dynamic subtest: bcs0
[448.389240] Dynamic subtest bcs0: SUCCESS (0.021s)
[448.399713] Starting dynamic subtest: vcs0
[448.409400] Dynamic subtest vcs0: SUCCESS (0.019s)
[448.419952] Starting dynamic subtest: vcs1
[448.432526] Dynamic subtest vcs1: SUCCESS (0.022s)
[448.446283] Starting dynamic subtest: vecs0
[448.453478] Dynamic subtest vecs0: SUCCESS (0.021s)
[448.463943] Starting dynamic subtest: ccs0
[448.473633] Dynamic subtest ccs0: SUCCESS (0.019s)
[448.476024] Subtest preempt-user: SUCCESS (0.137s)
[450.167970] [064/132] (570s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[450.252018] Starting subtest: plane-lut1d-post-ctm3x4
[450.391164] Starting dynamic subtest: pipe-A-plane-0
[450.535130] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[450.545513] Starting dynamic subtest: pipe-A-plane-1
[450.668380] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[450.678395] Starting dynamic subtest: pipe-A-plane-2
[450.801774] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[452.001348] Starting dynamic subtest: pipe-B-plane-0
[452.147375] Dynamic subtest pipe-B-plane-0: SUCCESS (0.154s)
[452.157917] Starting dynamic subtest: pipe-B-plane-1
[452.336901] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[452.347409] Starting dynamic subtest: pipe-B-plane-2
[452.480983] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[453.649864] Starting dynamic subtest: pipe-C-plane-0
[453.774110] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[453.787377] Starting dynamic subtest: pipe-C-plane-1
[453.929403] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[453.939951] Starting dynamic subtest: pipe-C-plane-2
[454.062848] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[455.293707] Starting dynamic subtest: pipe-D-plane-0
[455.428968] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[455.439280] Starting dynamic subtest: pipe-D-plane-1
[455.562298] Dynamic subtest pipe-D-plane-1: SUCCESS (0.131s)
[455.572977] Starting dynamic subtest: pipe-D-plane-2
[455.717386] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[456.015523] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.763s)
[456.839329] [065/132] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[456.921591] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[463.830766] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.913s)
[463.967358] [066/132] (557s left) gem_blits (basic)
[464.031556] Starting subtest: basic
[465.422413] Subtest basic: SUCCESS (1.391s)
[465.532895] [067/132] (555s left) kms_content_protection (lic-type-0-hdcp14)
[465.652899] Starting subtest: lic-type-0-hdcp14
[465.657346] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[465.782320] [068/132] (555s left) syncobj_timeline (invalid-query-one-illegal-handle)
[465.834165] Starting subtest: invalid-query-one-illegal-handle
[465.836089] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[465.950717] [069/132] (555s left) gem_mmap_gtt (big-copy-xy)
[465.998987] Subtest big-copy-XY: SKIP (0.000s)
[466.060987] [070/132] (555s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[466.137086] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[466.141450] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[466.207968] [071/132] (555s left) kms_frontbuffer_tracking (fbc-stridechange)
[466.282402] Starting subtest: fbc-stridechange
[469.557642] Subtest fbc-stridechange: SUCCESS (3.279s)
[470.676864] [072/132] (550s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[470.756942] Starting subtest: 4-tiled-16bpp-rotate-270
[470.776476] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[470.890811] [073/132] (550s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[470.978135] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[480.161015] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.185s)
[480.309708] [074/132] (541s left) gem_exec_whisper (basic-fds)
[480.364673] Starting subtest: basic-fds
[487.296120] Subtest basic-fds: SUCCESS (6.926s)
[487.472291] [075/132] (534s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[487.548414] Starting subtest: nonblocking-crc-frame-sequence
[487.550639] Starting dynamic subtest: pipe-A-eDP-1
[488.298860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.749s)
[488.309783] Starting dynamic subtest: pipe-B-eDP-1
[489.737253] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.438s)
[489.747474] Starting dynamic subtest: pipe-C-eDP-1
[491.105462] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s)
[491.117485] Starting dynamic subtest: pipe-D-eDP-1
[492.437431] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[492.439853] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.892s)
[493.249640] [076/132] (528s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[493.321495] Starting subtest: pixel-format-linear-modifier-source-clamping
[493.347862] Starting dynamic subtest: pipe-A-plane-0
[496.980470] Dynamic subtest pipe-A-plane-0: SUCCESS (3.633s)
[496.991051] Starting dynamic subtest: pipe-A-plane-3
[498.702540] Dynamic subtest pipe-A-plane-3: SUCCESS (1.720s)
[499.834770] Starting dynamic subtest: pipe-B-plane-0
[503.336332] Dynamic subtest pipe-B-plane-0: SUCCESS (3.511s)
[503.346116] Starting dynamic subtest: pipe-B-plane-3
[505.036285] Dynamic subtest pipe-B-plane-3: SUCCESS (1.699s)
[505.353455] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.031s)
[506.213330] [077/132] (515s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[506.319292] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[506.323833] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[506.466122] [078/132] (515s left) gem_exec_fence (concurrent)
[506.636939] Starting subtest: concurrent
[506.641758] Subtest concurrent: SKIP (0.000s)
[508.212265] [079/132] (513s left) sw_sync (sync_merge_same)
[508.247982] Starting subtest: sync_merge_same
[508.250211] Subtest sync_merge_same: SUCCESS (0.000s)
[508.309249] [080/132] (513s left) gem_userptr_blits (input-checking)
[508.380013] Starting subtest: input-checking
[508.382174] Subtest input-checking: SUCCESS (0.000s)
[508.505692] [081/132] (513s left) kms_prime (basic-modeset-hybrid)
[508.565782] Subtest basic-modeset-hybrid: SKIP (0.000s)
[508.660510] [082/132] (513s left) api_intel_bb (intel-bb-blit-none)
[508.717786] Starting subtest: intel-bb-blit-none
[512.837538] Subtest intel-bb-blit-none: SUCCESS (4.119s)
[512.942287] [083/132] (508s left) gem_caching (read-writes)
[512.993051] Subtest read-writes: SKIP (0.000s)
[513.062875] [084/132] (508s left) kms_sequence (get-busy)
[513.151883] Starting subtest: get-busy
[513.154159] Starting dynamic subtest: pipe-A-eDP-1
[515.086842] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[515.098166] Starting dynamic subtest: pipe-B-eDP-1
[517.710596] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.624s)
[517.721920] Starting dynamic subtest: pipe-C-eDP-1
[520.328641] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.616s)
[520.339512] Starting dynamic subtest: pipe-D-eDP-1
[522.955321] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.626s)
[522.957667] Subtest get-busy: SUCCESS (9.806s)
[523.745053] [085/132] (498s left) gem_exec_reloc (basic-scanout)
[523.799314] Subtest basic-scanout: SKIP (0.000s)
[523.881660] [086/132] (498s left) gem_linear_blits (normal)
[524.396690] Starting subtest: normal
[527.754007] Subtest normal: SUCCESS (3.357s)
[527.966554] [087/132] (494s left) kms_cursor_crc (cursor-suspend)
[528.127844] Starting subtest: cursor-suspend
[528.130319] Starting dynamic subtest: pipe-A-eDP-1
[561.008359] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.208s)
[561.019678] Starting dynamic subtest: pipe-D-eDP-1
[594.995069] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.851s)
[594.997530] Subtest cursor-suspend: SUCCESS (7.063s)
[595.804199] [088/132] (426s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[595.883431] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[595.886078] Starting dynamic subtest: pipe-A-eDP-1
[595.911236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[595.924722] Starting dynamic subtest: pipe-B-eDP-1
[595.948598] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[595.960560] Starting dynamic subtest: pipe-C-eDP-1
[595.983792] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[595.994389] Starting dynamic subtest: pipe-D-eDP-1
[596.018456] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[596.021360] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[598.125738] [089/132] (424s left) syncobj_timeline (wait-any-interrupted)
[598.194639] Starting subtest: wait-any-interrupted
[598.303901] Subtest wait-any-interrupted: SUCCESS (0.109s)
[598.385687] [090/132] (423s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[598.454414] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[598.457294] Starting dynamic subtest: pipe-A-eDP-1
[598.492483] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[598.505660] Starting dynamic subtest: pipe-B-eDP-1
[598.531678] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[598.543209] Starting dynamic subtest: pipe-C-eDP-1
[598.568513] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[598.580288] Starting dynamic subtest: pipe-D-eDP-1
[598.603643] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[598.607874] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[600.702700] [091/132] (421s left) gen7_exec_parse (basic-allowed)
[600.759256] Subtest basic-allowed: SKIP (0.000s)
[600.834886] [092/132] (421s left) vgem_basic (debugfs)
[600.876765] Starting subtest: debugfs
[600.879279] Subtest debugfs: SUCCESS (0.000s)
[600.939020] [093/132] (421s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[600.986452] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[601.087463] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[601.182077] [094/132] (421s left) kms_psr (psr2-basic)
[601.251712] Starting subtest: psr2-basic
[601.254266] Starting dynamic subtest: eDP-1
[602.870819] Dynamic subtest eDP-1: SUCCESS (1.630s)
[602.873253] Subtest psr2-basic: SUCCESS (1.631s)
[603.673943] [095/132] (418s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[603.725731] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[603.819621] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.030s)
[603.861919] [096/132] (418s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[603.947314] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[604.934485] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.991s)
[605.058881] [097/132] (417s left) kms_psr (fbc-pr-sprite-render)
[605.134744] Starting subtest: fbc-pr-sprite-render
[605.139629] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[605.208919] [098/132] (417s left) gem_mmap_wc (write-wc-read-gtt)
[605.271312] Subtest write-wc-read-gtt: SKIP (0.000s)
[605.326455] [099/132] (417s left) gem_eio (create-ext)
[605.541180] Starting subtest: create-ext
[605.881110] Subtest create-ext: SUCCESS (0.341s)
[606.004238] [100/132] (416s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[606.064336] Starting subtest: y-tiled-to-vebox-y-tiled
[606.069130] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[606.255213] [101/132] (416s left) kms_invalid_mode (bad-vsync-end)
[606.340943] Starting subtest: bad-vsync-end
[606.343567] Starting dynamic subtest: pipe-A-eDP-1
[606.622559] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[606.640889] Starting dynamic subtest: pipe-B-eDP-1
[606.643203] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[606.654519] Starting dynamic subtest: pipe-C-eDP-1
[606.657409] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[606.668807] Starting dynamic subtest: pipe-D-eDP-1
[606.671439] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[606.674387] Subtest bad-vsync-end: SUCCESS (0.292s)
[607.488933] [102/132] (415s left) gem_softpin (evict-single-offset)
[607.540417] Starting subtest: evict-single-offset
[633.981605] Subtest evict-single-offset: SUCCESS (26.463s)
[634.069612] [103/132] (388s left) gem_eio (banned)
[634.354915] Starting subtest: banned
[635.011972] Subtest banned: SUCCESS (0.657s)
[635.148835] [104/132] (387s left) kms_chamelium_color (ctm-max)
[635.223316] Subtest ctm-max: SKIP (0.000s)
[635.272338] [105/132] (387s left) gem_exec_fence (basic-busy-all)
[635.329245] Starting subtest: basic-busy-all
[635.400244] Subtest basic-busy-all: SUCCESS (0.073s)
[637.072969] [106/132] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[637.160604] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[637.165895] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[637.270332] [107/132] (385s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[637.348147] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[637.353131] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[637.442474] [108/132] (385s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[637.521383] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[637.526407] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[637.596153] [109/132] (385s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[637.676151] Starting subtest: psr2-plane-move-sf-dmg-area
[637.678397] Starting dynamic subtest: pipe-A-eDP-1
[642.211388] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.540s)
[642.223337] Starting dynamic subtest: pipe-B-eDP-1
[647.518360] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.305s)
[647.521503] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.848s)
[648.389786] [110/132] (374s left) syncobj_wait (multi-wait-for-submit-submitted)
[648.470041] Starting subtest: multi-wait-for-submit-submitted
[648.576218] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[648.652770] [111/132] (374s left) kms_lease (lease-revoke)
[648.721210] Starting subtest: lease-revoke
[648.724251] Starting dynamic subtest: pipe-A-eDP-1
[648.758586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[648.770502] Starting dynamic subtest: pipe-B-eDP-1
[648.788900] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.030s)
[648.799868] Starting dynamic subtest: pipe-C-eDP-1
[648.820633] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.030s)
[648.831460] Starting dynamic subtest: pipe-D-eDP-1
[648.850780] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[648.853344] Subtest lease-revoke: SUCCESS (0.129s)
[648.957003] [112/132] (374s left) kms_chamelium_edid (hdmi-mode-timings)
[649.333429] Subtest hdmi-mode-timings: SKIP (0.000s)
[650.125974] [113/132] (373s left) perf_pmu (render-node-busy-idle)
[650.185993] Starting subtest: render-node-busy-idle
[650.188407] Starting dynamic subtest: rcs0
[650.866462] Dynamic subtest rcs0: SUCCESS (0.680s)
[650.881300] Starting dynamic subtest: bcs0
[651.525573] Dynamic subtest bcs0: SUCCESS (0.657s)
[651.540758] Starting dynamic subtest: vcs0
[652.988067] Dynamic subtest vcs0: SUCCESS (1.459s)
[653.003129] Starting dynamic subtest: vcs1
[654.972566] Dynamic subtest vcs1: SUCCESS (1.982s)
[654.985290] Starting dynamic subtest: vecs0
[656.955935] Dynamic subtest vecs0: SUCCESS (1.981s)
[656.968872] Starting dynamic subtest: ccs0
[657.615637] Dynamic subtest ccs0: SUCCESS (0.658s)
[657.618590] Subtest render-node-busy-idle: SUCCESS (7.433s)
[657.692359] [114/132] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[657.780386] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[657.785270] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[657.880821] [115/132] (365s left) gem_ctx_persistence (processes)
[657.945595] Starting subtest: processes
[659.961516] Subtest processes: SUCCESS (2.016s)
[660.044486] [116/132] (363s left) kms_psr (psr-no-drrs)
[660.122787] Starting subtest: psr-no-drrs
[660.125329] Starting dynamic subtest: eDP-1
[661.717334] Dynamic subtest eDP-1: SUCCESS (1.594s)
[661.720200] Subtest psr-no-drrs: SUCCESS (1.596s)
[662.589768] [117/132] (360s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[662.663333] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[662.665919] Starting dynamic subtest: pipe-A
[663.000188] Dynamic subtest pipe-A: SUCCESS (0.339s)
[663.012046] Starting dynamic subtest: pipe-B
[664.374195] Dynamic subtest pipe-B: SUCCESS (1.373s)
[664.385886] Starting dynamic subtest: pipe-C
[665.808832] Dynamic subtest pipe-C: SUCCESS (1.435s)
[665.822025] Starting dynamic subtest: pipe-D
[667.235406] Dynamic subtest pipe-D: SUCCESS (1.426s)
[667.238140] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.576s)
[668.410431] [118/132] (355s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[668.503041] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[668.508424] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[668.592051] [119/132] (354s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[668.677361] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[672.905239] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.233s)
[674.095902] [120/132] (349s left) drm_read (empty-block)
[674.252582] Starting subtest: empty-block
[675.252524] Subtest empty-block: SUCCESS (1.002s)
[675.418958] [121/132] (348s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[675.519029] Starting subtest: y-tiled-32bpp-rotate-180
[675.524205] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[675.619250] [122/132] (348s left) gem_mmap_wc (set-cache-level)
[675.683843] Subtest set-cache-level: SKIP (0.000s)
[675.748405] [123/132] (347s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[675.813351] Starting subtest: fbc-psr2-sprite-mmap-gtt
[675.816109] Starting dynamic subtest: eDP-1
[675.821109] Dynamic subtest eDP-1: SKIP (0.000s)
[675.826299] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[675.887883] [124/132] (347s left) gem_userptr_blits (readonly-pwrite-unsync)
[675.945548] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[676.050709] [125/132] (347s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[676.107420] Starting subtest: yf-tiled-ccs-to-y-tiled
[676.113122] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[676.290698] [126/132] (347s left) gem_mmap (bad-offset)
[676.355440] Subtest bad-offset: SKIP (0.000s)
[676.426123] [127/132] (347s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[676.503329] Starting subtest: pr-overlay-plane-update-continuous-sf
[676.508430] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[676.575896] [128/132] (347s left) syncobj_wait (signal)
[676.626578] Starting subtest: signal
[676.629586] Subtest signal: SUCCESS (0.000s)
[676.728256] [129/132] (347s left) gem_exec_flush (basic-uc-pro-default)
[676.792159] Starting subtest: basic-uc-pro-default
[682.270919] Subtest basic-uc-pro-default: SUCCESS (5.480s)
[682.475057] [130/132] (341s left) vgem_basic (dmabuf-fence-before)
[682.528866] Starting subtest: dmabuf-fence-before
[682.531876] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[682.589794] [131/132] (341s left) gem_exec_nop (basic-sequential)
[682.666402] Starting subtest: basic-sequential
[697.513240] Subtest basic-sequential: SUCCESS (14.858s)
[697.740407] [132/132] (326s left) perf_pmu (busy)
[697.786560] Starting subtest: busy
[697.789247] Starting dynamic subtest: rcs0
[698.394575] Dynamic subtest rcs0: SUCCESS (0.609s)
[698.409621] Starting dynamic subtest: bcs0
[698.965953] Dynamic subtest bcs0: SUCCESS (0.568s)
[698.981891] Starting dynamic subtest: vcs0
[700.988405] Dynamic subtest vcs0: SUCCESS (2.018s)
[701.003657] Starting dynamic subtest: vcs1
[702.972004] Dynamic subtest vcs1: SUCCESS (1.980s)
[702.987309] Starting dynamic subtest: vecs0
[704.956196] Dynamic subtest vecs0: SUCCESS (1.981s)
[704.970468] Starting dynamic subtest: ccs0
[705.522791] Dynamic subtest ccs0: SUCCESS (0.565s)
[705.525569] Subtest busy: SUCCESS (7.737s)
[705.628372] Closing watchdogs
results: parsing output: 0/ for test: api_intel_allocator
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_pipe_b_c_ivb
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: i915_suspend
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: i915_pm_rpm
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: prime_vgem
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: device_reset
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_chamelium_hpd
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: sysfs_heartbeat_interval
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: gen9_exec_parse
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_atomic_transition
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_plane_lowres
results: parsing output: 43/ for test: gem_close_race
results: parsing output: 44/ for test: i915_hangman
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_ctx_param
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_feature_discovery
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: gem_exercise_blt
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_color_pipeline
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_blits
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_prime
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: gem_caching
results: parsing output: 83/ for test: kms_sequence
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gem_linear_blits
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gen7_exec_parse
results: parsing output: 91/ for test: vgem_basic
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: sriov_basic
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gem_mmap_wc
results: parsing output: 98/ for test: gem_eio
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: kms_invalid_mode
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: kms_chamelium_color
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: kms_chamelium_edid
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: drm_read
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_mmap_wc
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: gem_render_copy
results: parsing output: 125/ for test: gem_mmap
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: gem_exec_nop
results: parsing output: 131/ for test: perf_pmu
Done.