[60.094150] Initializing watchdogs
[60.094200]   /dev/watchdog0
[60.109962] [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.114655] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.117051] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.120337] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[60.246093] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[60.250332] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[60.357034] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[60.449991] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[60.454246] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[60.560181] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[60.654714] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[61.342481] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[61.522722] [004/133] (959s left) gen7_exec_parse (basic-offset)
[61.589072] Subtest basic-offset: SKIP (0.000s)
[61.652546] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[61.772376] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[66.029040] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.274s)
[67.246464] [006/133] (953s left) tools_test (tools_test)
[67.313860] Starting subtest: tools_test
[67.426592] Subtest tools_test: SUCCESS (0.129s)
[67.515183] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[67.699080] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[67.703712] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[68.846215] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[68.931301] Starting subtest: modeset-vs-vblank-race
[68.933800] Starting dynamic subtest: A-eDP1
[73.675206] Dynamic subtest A-eDP1: SUCCESS (4.749s)
[73.683579] Starting dynamic subtest: B-eDP1
[78.408954] Dynamic subtest B-eDP1: SUCCESS (4.735s)
[78.419663] Starting dynamic subtest: C-eDP1
[83.024374] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[83.034094] Starting dynamic subtest: D-eDP1
[87.577041] Dynamic subtest D-eDP1: SUCCESS (4.551s)
[87.579388] Subtest modeset-vs-vblank-race: SUCCESS (18.656s)
[88.758872] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[91.099845] Starting subtest: reg-read-ioctl
[93.499240] Subtest reg-read-ioctl: SUCCESS (2.403s)
[93.880354] [010/133] (927s left) gem_exec_balancer (hang)
[94.158194] Starting subtest: hang
[95.898103] Subtest hang: SUCCESS (1.740s)
[96.059337] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[96.156166] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[96.160565] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[96.230056] [012/133] (924s left) perf_pmu (faulting-read)
[96.279900] Starting subtest: faulting-read
[96.282242] Starting dynamic subtest: wb
[96.284399] Dynamic subtest wb: SUCCESS (0.001s)
[96.292729] Starting dynamic subtest: wc
[96.294587] Dynamic subtest wc: SUCCESS (0.000s)
[96.304719] Starting dynamic subtest: uc
[96.306754] Dynamic subtest uc: SUCCESS (0.000s)
[96.308785] Subtest faulting-read: SUCCESS (0.002s)
[96.405242] [013/133] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[96.494932] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[96.499370] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[96.589022] [014/133] (924s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[96.968267] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[97.775969] [015/133] (923s left) gem_exec_schedule (pi-distinct-iova)
[97.955786] Starting subtest: pi-distinct-iova
[97.957798] Starting dynamic subtest: rcs0
[98.028984] Dynamic subtest rcs0: SUCCESS (0.075s)
[98.037071] Starting dynamic subtest: vcs0
[98.091687] Dynamic subtest vcs0: SUCCESS (0.063s)
[98.101671] Starting dynamic subtest: vcs1
[98.162415] Dynamic subtest vcs1: SUCCESS (0.071s)
[98.172862] Starting dynamic subtest: vecs0
[98.225231] Dynamic subtest vecs0: SUCCESS (0.062s)
[98.237656] Starting dynamic subtest: ccs0
[98.283631] Dynamic subtest ccs0: SUCCESS (0.058s)
[98.286049] Subtest pi-distinct-iova: SUCCESS (0.331s)
[100.026298] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[100.119155] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[100.123123] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[100.210767] [017/133] (921s left) drm_read (short-buffer-block)
[100.360018] Starting subtest: short-buffer-block
[100.362417] Subtest short-buffer-block: SUCCESS (0.000s)
[100.472979] [018/133] (920s left) perf (oa-formats)
[100.596228] Starting subtest: oa-formats
[100.598106] Starting dynamic subtest: 0-rcs0
[100.611643] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[100.621270] Starting dynamic subtest: 1-vecs0
[100.635038] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[100.637278] Subtest oa-formats: SUCCESS (0.040s)
[100.685783] [019/133] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[100.785593] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[100.789810] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[100.874438] [020/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[100.967824] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[100.972092] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.059949] [021/133] (920s left) kms_psr (pr-basic)
[101.150474] Starting subtest: pr-basic
[101.153993] Subtest pr-basic: SKIP (0.000s)
[101.234741] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[101.329886] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[101.331774] Starting dynamic subtest: pipe-A-eDP-1
[101.350044] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.358402] Starting dynamic subtest: pipe-B-eDP-1
[101.375385] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.382485] Starting dynamic subtest: pipe-C-eDP-1
[101.399693] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.406705] Starting dynamic subtest: pipe-D-eDP-1
[101.424221] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.427599] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[103.563702] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[103.967299] Subtest hdmi-mode-timings: SKIP (0.000s)
[104.771193] [024/133] (916s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[104.907847] Starting subtest: dp-mst-lic-type-0-hdcp14
[104.912607] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[105.019459] [025/133] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[105.115246] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[105.119611] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[105.199170] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[105.290975] Starting subtest: primary-4-tiled-reflect-x-180
[112.185022] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.897s)
[113.349889] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[113.462367] Starting subtest: 2x-flip-vs-panning-interruptible
[113.474366] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[113.551787] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[113.647713] Starting subtest: plain-flip-fb-recreate
[113.649942] Starting dynamic subtest: A-eDP1
[122.537344] Dynamic subtest A-eDP1: SUCCESS (8.891s)
[122.546066] Starting dynamic subtest: B-eDP1
[131.373974] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[131.384292] Starting dynamic subtest: C-eDP1
[140.205267] Dynamic subtest C-eDP1: SUCCESS (8.829s)
[140.214844] Starting dynamic subtest: D-eDP1
[149.035998] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[149.040458] Subtest plain-flip-fb-recreate: SUCCESS (35.396s)
[150.212530] [029/133] (871s left) gem_tiled_partial_pwrite_pread (writes)
[150.277411] Subtest writes: SKIP (0.000s)
[150.346335] [030/133] (871s left) gem_lmem_swapping (heavy-verify-random)
[150.389290] Subtest heavy-verify-random: SKIP (0.000s)
[150.435990] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[150.543264] Starting subtest: x-tiled-64bpp-rotate-90
[150.561767] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s)
[150.686489] [032/133] (871s left) vgem_basic (debugfs)
[150.795275] Starting subtest: debugfs
[150.797156] Subtest debugfs: SUCCESS (0.000s)
[150.854164] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[150.857400] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[150.947803] Starting subtest: legacy-setmode
[150.950019] Starting dynamic subtest: pipe-A-eDP-1
[157.858724] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.908s)
[157.860719] Subtest legacy-setmode: SUCCESS (6.909s)
[158.731115] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[158.846417] Starting subtest: reject-modify-context-protection-off-2
[158.848949] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[158.951248] [035/133] (863s left) gem_exec_basic (basic)
[159.006779] Starting subtest: basic
[159.009182] Starting dynamic subtest: rcs0-smem
[159.011351] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[159.020370] Starting dynamic subtest: bcs0-smem
[159.022513] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[159.030052] Starting dynamic subtest: vcs0-smem
[159.031902] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[159.039361] Starting dynamic subtest: vcs1-smem
[159.041250] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[159.048498] Starting dynamic subtest: vecs0-smem
[159.050383] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[159.057595] Starting dynamic subtest: ccs0-smem
[159.059445] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[159.061321] Subtest basic: SUCCESS (0.013s)
[160.977017] [036/133] (861s left) api_intel_bb (offset-control)
[161.045076] Starting subtest: offset-control
[161.051905] Subtest offset-control: SUCCESS (0.007s)
[161.167727] [037/133] (860s left) kms_joiner (basic-max-non-joiner)
[161.282070] Starting subtest: basic-max-non-joiner
[161.286075] Subtest basic-max-non-joiner: SKIP (0.000s)
[161.348027] [038/133] (860s left) kms_addfb_basic (small-bo)
[161.447960] Starting subtest: small-bo
[161.450094] Subtest small-bo: SUCCESS (0.000s)
[161.546842] [039/133] (860s left) i915_query (query-topology-garbage-items)
[161.614974] Starting subtest: query-topology-garbage-items
[161.617143] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[161.745531] [040/133] (860s left) perf (gen12-group-exclusive-stream-ctx-handle)
[161.844414] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[161.865304] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.022s)
[161.903718] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[163.936221] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[163.940189] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[164.044723] [042/133] (858s left) gem_exec_params (cliprects-invalid)
[164.107586] Starting subtest: cliprects-invalid
[164.109842] Subtest cliprects-invalid: SUCCESS (0.000s)
[164.212334] [043/133] (858s left) kms_cursor_crc (cursor-random-64x64)
[164.393579] Starting subtest: cursor-random-64x64
[164.398416] Starting dynamic subtest: pipe-A-eDP-1
[167.741070] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.343s)
[167.769431] Starting dynamic subtest: pipe-D-eDP-1
[171.763485] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.001s)
[171.765739] Subtest cursor-random-64x64: SUCCESS (7.370s)
[172.601014] [044/133] (849s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[172.725484] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[172.730091] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[172.823326] [045/133] (849s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[172.926562] Starting subtest: 4-tiled-16bpp-rotate-180
[174.272040] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.346s)
[174.384309] [046/133] (848s left) dumb_buffer (create-valid-dumb)
[174.442591] Starting subtest: create-valid-dumb
[174.444487] Subtest create-valid-dumb: SUCCESS (0.000s)
[174.542101] [047/133] (848s left) gem_softpin (zero)
[174.593260] Starting subtest: zero
[174.600058] Subtest zero: SUCCESS (0.005s)
[174.728818] [048/133] (847s left) gem_blits (basic)
[174.788469] Starting subtest: basic
[176.206560] Subtest basic: SUCCESS (1.416s)
[176.312971] [049/133] (846s left) gem_busy (close-race)
[176.371052] Starting subtest: close-race
[199.912893] Subtest close-race: SUCCESS (23.541s)
[200.284473] [050/133] (822s left) gem_exec_alignment (forked)
[200.381064] Starting subtest: forked
[240.020491] Subtest forked: SUCCESS (39.637s)
[240.102370] [051/133] (782s left) syncobj_eventfd (binary-wait-before-signal)
[240.212460] Starting subtest: binary-wait-before-signal
[240.243213] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[240.332592] [052/133] (782s left) prime_mmap (test_errors)
[240.395992] Starting subtest: test_errors
[240.397959] Starting dynamic subtest: test_errors-smem
[240.498467] Dynamic subtest test_errors-smem: SUCCESS (0.103s)
[240.501291] Subtest test_errors: SUCCESS (0.104s)
[240.592778] [053/133] (782s left) gem_ctx_persistence (heartbeat-stop)
[240.646065] Starting subtest: heartbeat-stop
[240.650476] Subtest heartbeat-stop: SKIP (0.000s)
[240.748439] [054/133] (782s left) gem_ctx_param (invalid-get-ringsize)
[240.797682] Starting subtest: invalid-get-ringsize
[240.800058] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[240.895804] [055/133] (782s left) i915_query (query-topology-matches-eu-total)
[240.948885] Starting subtest: query-topology-matches-eu-total
[240.951165] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[241.044579] [056/133] (781s left) kms_cursor_edge_walk (64x64-right-edge)
[241.136938] Starting subtest: 64x64-right-edge
[241.138901] Starting dynamic subtest: pipe-A-eDP-1
[244.565400] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[244.575687] Starting dynamic subtest: pipe-D-eDP-1
[247.686398] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[247.688594] Subtest 64x64-right-edge: SUCCESS (6.550s)
[248.524395] [057/133] (774s left) kms_plane (plane-position-covered)
[248.624868] Starting subtest: plane-position-covered
[249.164033] Starting dynamic subtest: pipe-A-plane-1
[250.514265] Dynamic subtest pipe-A-plane-1: SUCCESS (1.352s)
[250.532172] Starting dynamic subtest: pipe-A-plane-2
[251.897535] Dynamic subtest pipe-A-plane-2: SUCCESS (1.382s)
[251.907344] Starting dynamic subtest: pipe-A-plane-3
[253.211454] Dynamic subtest pipe-A-plane-3: SUCCESS (1.313s)
[253.221315] Starting dynamic subtest: pipe-A-plane-4
[254.549372] Dynamic subtest pipe-A-plane-4: SUCCESS (1.338s)
[254.558876] Starting dynamic subtest: pipe-A-plane-5
[254.576191] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[255.775129] Starting dynamic subtest: pipe-B-plane-1
[257.081722] Dynamic subtest pipe-B-plane-1: SUCCESS (1.314s)
[257.091284] Starting dynamic subtest: pipe-B-plane-2
[258.415649] Dynamic subtest pipe-B-plane-2: SUCCESS (1.333s)
[258.425116] Starting dynamic subtest: pipe-B-plane-3
[259.741476] Dynamic subtest pipe-B-plane-3: SUCCESS (1.324s)
[259.751446] Starting dynamic subtest: pipe-B-plane-4
[261.072543] Dynamic subtest pipe-B-plane-4: SUCCESS (1.330s)
[261.082687] Starting dynamic subtest: pipe-B-plane-5
[261.098734] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[261.101059] Subtest plane-position-covered: SUCCESS (12.474s)
[261.877105] [058/133] (761s left) kms_frontbuffer_tracking (psr-suspend)
[261.978586] Starting subtest: psr-suspend
[301.488281] Subtest psr-suspend: SUCCESS (8.930s)
[311.606660] [059/133] (721s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[311.761231] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[311.765621] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[311.878551] [060/133] (721s left) gem_exec_schedule (fairslice)
[311.943920] Starting subtest: fairslice
[311.945921] Starting dynamic subtest: rcs0
[313.953960] Dynamic subtest rcs0: SUCCESS (2.071s)
[313.966003] Starting dynamic subtest: bcs0
[315.972932] Dynamic subtest bcs0: SUCCESS (2.059s)
[315.983455] Starting dynamic subtest: vcs0
[317.993601] Dynamic subtest vcs0: SUCCESS (2.051s)
[318.004335] Starting dynamic subtest: vcs1
[320.009766] Dynamic subtest vcs1: SUCCESS (2.041s)
[320.021648] Starting dynamic subtest: vecs0
[322.047692] Dynamic subtest vecs0: SUCCESS (2.035s)
[322.057287] Starting dynamic subtest: ccs0
[324.048203] Dynamic subtest ccs0: SUCCESS (2.034s)
[324.050169] Subtest fairslice: SUCCESS (12.296s)
[324.350858] [061/133] (708s left) sw_sync (alloc_fence_invalid_timeline)
[324.386716] Starting subtest: alloc_fence_invalid_timeline
[324.388970] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[324.464428] [062/133] (708s left) gem_exec_whisper (basic-fds-forked)
[324.529078] Starting subtest: basic-fds-forked
[347.894363] Subtest basic-fds-forked: SUCCESS (23.409s)
[348.082673] [063/133] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[348.189034] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[348.192995] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[348.283438] [064/133] (685s left) gem_vm_create (execbuf)
[348.342127] Starting subtest: execbuf
[348.350511] Subtest execbuf: SUCCESS (0.008s)
[348.460350] [065/133] (684s left) kms_cursor_crc (cursor-onscreen-256x85)
[348.710373] Starting subtest: cursor-onscreen-256x85
[348.778589] Subtest cursor-onscreen-256x85: SKIP (0.065s)
[348.961881] [066/133] (684s left) kms_plane_alpha_blend (coverage-7efc)
[349.050309] Starting subtest: coverage-7efc
[349.367552] Starting dynamic subtest: pipe-A-eDP-1
[350.010446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.640s)
[350.037678] Starting dynamic subtest: pipe-D-eDP-1
[351.362511] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[351.365276] Subtest coverage-7efc: SUCCESS (2.313s)
[352.210796] [067/133] (681s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[352.302268] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[352.304614] Starting dynamic subtest: pipe-A
[352.323920] Dynamic subtest pipe-A: SKIP (0.018s)
[352.337259] Starting dynamic subtest: pipe-B
[352.355738] Dynamic subtest pipe-B: SKIP (0.031s)
[352.365702] Starting dynamic subtest: pipe-C
[352.386502] Dynamic subtest pipe-C: SKIP (0.030s)
[352.396399] Starting dynamic subtest: pipe-D
[352.418958] Dynamic subtest pipe-D: SKIP (0.031s)
[352.423329] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.112s)
[352.518955] [068/133] (680s left) vgem_basic (busy-fence)
[352.568005] Starting subtest: busy-fence
[352.570208] Subtest busy-fence: SUCCESS (0.000s)
[352.627876] [069/133] (680s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[352.705995] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[352.735421] Starting dynamic subtest: pipe-A-plane-0
[353.179157] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[353.189419] Starting dynamic subtest: pipe-A-plane-3
[353.445761] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[353.455304] Starting dynamic subtest: pipe-A-plane-5
[353.458810] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[354.599308] Starting dynamic subtest: pipe-B-plane-0
[355.046422] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[355.056512] Starting dynamic subtest: pipe-B-plane-3
[355.302527] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[355.312485] Starting dynamic subtest: pipe-B-plane-5
[355.317004] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[355.614111] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.910s)
[356.481977] [070/133] (677s left) kms_addfb_basic (invalid-set-prop-any)
[356.549284] Starting subtest: invalid-set-prop-any
[356.551240] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[356.677231] [071/133] (676s left) kms_addfb_basic (size-max)
[356.769759] Starting subtest: size-max
[356.772011] Subtest size-max: SUCCESS (0.000s)
[356.865199] [072/133] (676s left) kms_addfb_basic (bad-pitch-128)
[356.915156] Starting subtest: bad-pitch-128
[356.917077] Subtest bad-pitch-128: SUCCESS (0.000s)
[357.074969] [073/133] (676s left) syncobj_timeline (single-wait-available-submitted)
[357.134188] Starting subtest: single-wait-available-submitted
[357.136568] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[357.254644] [074/133] (676s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[357.362585] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[358.397197] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.035s)
[358.519618] [075/133] (675s left) gem_pread (exhaustion)
[358.577219] Subtest exhaustion: SKIP (0.000s)
[358.654648] [076/133] (675s left) kms_frontbuffer_tracking (psr-1p-rte)
[358.756468] Starting subtest: psr-1p-rte
[364.209139] Subtest psr-1p-rte: SUCCESS (5.460s)
[364.365393] [077/133] (669s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[364.493103] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[381.890649] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.403s)
[382.762330] [078/133] (651s left) api_intel_allocator (fork-simple-once)
[382.817250] Starting subtest: fork-simple-once
[382.832585] Subtest fork-simple-once: SUCCESS (0.018s)
[382.955775] [079/133] (651s left) gem_set_tiling_vs_pwrite
[383.065088] [080/133] (650s left) kms_pm_backlight (brightness-with-dpms)
[383.150984] Starting subtest: brightness-with-dpms
[383.203810] Starting dynamic subtest: eDP-1
[385.572773] Dynamic subtest eDP-1: SUCCESS (2.370s)
[385.575108] Subtest brightness-with-dpms: SUCCESS (2.424s)
[386.448154] [081/133] (647s left) kms_lease (lease-invalid-crtc)
[386.552899] Starting subtest: lease-invalid-crtc
[386.555133] Starting dynamic subtest: pipe-A-eDP-1
[386.557285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[386.567576] Starting dynamic subtest: pipe-B-eDP-1
[386.569868] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[386.579903] Starting dynamic subtest: pipe-C-eDP-1
[386.582001] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[386.592662] Starting dynamic subtest: pipe-D-eDP-1
[386.594520] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[386.596411] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[386.635312] [082/133] (647s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[386.732810] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[386.736988] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[386.833044] [083/133] (647s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[386.935425] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[393.875233] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.946s)
[394.028166] [084/133] (640s left) kms_dp_linktrain_fallback (dp-fallback)
[394.133124] Starting subtest: dp-fallback
[394.139279] Subtest dp-fallback: SKIP (0.000s)
[394.206225] [085/133] (640s left) kms_vblank (ts-continuation-idle)
[394.299061] Starting subtest: ts-continuation-idle
[394.301302] Starting dynamic subtest: pipe-A-eDP-1
[394.698992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[394.714602] Starting dynamic subtest: pipe-D-eDP-1
[395.761405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.058s)
[395.763542] Subtest ts-continuation-idle: SUCCESS (1.463s)
[396.642652] [086/133] (637s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[396.732686] Starting subtest: fbc-psr-cursor-mmap-gtt
[396.734915] Starting dynamic subtest: eDP-1
[396.739065] Dynamic subtest eDP-1: SKIP (0.000s)
[396.743226] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[396.810559] [087/133] (637s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[396.930890] Starting subtest: cursor-vs-flip-varying-size
[428.205509] Subtest cursor-vs-flip-varying-size: SUCCESS (31.269s)
[429.077704] [088/133] (605s left) i915_drm_fdinfo (busy-check-all)
[429.122516] Starting subtest: busy-check-all
[429.124754] Starting dynamic subtest: rcs0
[429.129455] Dynamic subtest rcs0: SKIP (0.004s)
[429.141025] Starting dynamic subtest: bcs0
[429.145715] Dynamic subtest bcs0: SKIP (0.001s)
[429.155021] Starting dynamic subtest: vcs0
[429.159167] Dynamic subtest vcs0: SKIP (0.001s)
[429.169013] Starting dynamic subtest: vcs1
[429.173405] Dynamic subtest vcs1: SKIP (0.001s)
[429.182442] Starting dynamic subtest: vecs0
[429.186511] Dynamic subtest vecs0: SKIP (0.001s)
[429.195439] Starting dynamic subtest: ccs0
[429.199488] Dynamic subtest ccs0: SKIP (0.001s)
[429.203572] Subtest busy-check-all: SKIP (0.022s)
[429.244664] [089/133] (605s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[429.382733] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[429.384970] Starting dynamic subtest: pipe-A-eDP-1
[429.404701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[429.416427] Starting dynamic subtest: pipe-B-eDP-1
[429.435707] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[429.445516] Starting dynamic subtest: pipe-C-eDP-1
[429.465493] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[429.475273] Starting dynamic subtest: pipe-D-eDP-1
[429.494617] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[429.496829] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[431.550630] [090/133] (602s left) prime_busy (before-wait)
[431.615343] Starting subtest: before-wait
[431.620435] Starting dynamic subtest: rcs0
[431.646249] Dynamic subtest rcs0: SUCCESS (0.027s)
[431.658172] Starting dynamic subtest: bcs0
[431.696321] Dynamic subtest bcs0: SUCCESS (0.049s)
[431.706011] Starting dynamic subtest: vcs0
[431.735733] Dynamic subtest vcs0: SUCCESS (0.038s)
[431.745229] Starting dynamic subtest: vcs1
[431.775723] Dynamic subtest vcs1: SUCCESS (0.040s)
[431.785195] Starting dynamic subtest: vecs0
[431.816060] Dynamic subtest vecs0: SUCCESS (0.038s)
[431.825775] Starting dynamic subtest: ccs0
[431.857292] Dynamic subtest ccs0: SUCCESS (0.041s)
[431.966477] Subtest before-wait: SUCCESS (0.349s)
[432.045695] [091/133] (602s left) gem_ppgtt (blt-vs-render-ctx0)
[432.102613] Starting subtest: blt-vs-render-ctx0
[464.873065] Subtest blt-vs-render-ctx0: SUCCESS (32.768s)
[464.987872] [092/133] (569s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[465.159849] Starting subtest: cursorB-vs-flipB-atomic
[465.164228] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[465.306625] [093/133] (569s left) gem_exec_reloc (basic-wc-read-active)
[465.363690] Subtest basic-wc-read-active: SKIP (0.000s)
[465.447703] [094/133] (569s left) gem_exec_fence (syncobj-import)
[465.936490] Starting subtest: syncobj-import
[465.941900] Subtest syncobj-import: SUCCESS (0.005s)
[467.548507] [095/133] (567s left) kms_psr (fbc-psr2-sprite-blt)
[467.646011] Starting subtest: fbc-psr2-sprite-blt
[467.648353] Starting dynamic subtest: eDP-1
[467.652760] Dynamic subtest eDP-1: SKIP (0.000s)
[467.657116] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[467.722771] [096/133] (566s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[467.820212] Starting subtest: plane-lut1d-post-ctm3x4
[467.998938] Starting dynamic subtest: pipe-A-plane-0
[468.165806] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[468.176467] Starting dynamic subtest: pipe-A-plane-1
[468.321252] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[468.331947] Starting dynamic subtest: pipe-A-plane-2
[468.465496] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[469.631052] Starting dynamic subtest: pipe-B-plane-0
[469.789000] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[469.799145] Starting dynamic subtest: pipe-B-plane-1
[469.978292] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[469.988597] Starting dynamic subtest: pipe-B-plane-2
[470.166929] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[471.356111] Starting dynamic subtest: pipe-C-plane-0
[471.487682] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[471.497982] Starting dynamic subtest: pipe-C-plane-1
[471.631967] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[471.642152] Starting dynamic subtest: pipe-C-plane-2
[471.776351] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[472.996116] Starting dynamic subtest: pipe-D-plane-0
[473.143510] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[473.159095] Starting dynamic subtest: pipe-D-plane-1
[473.320958] Dynamic subtest pipe-D-plane-1: SUCCESS (0.176s)
[473.331481] Starting dynamic subtest: pipe-D-plane-2
[473.465454] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[473.753068] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.933s)
[474.550794] [097/133] (560s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[474.604587] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[474.608987] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[474.788044] [098/133] (559s left) kms_big_fb (linear-8bpp-rotate-180)
[474.904135] Starting subtest: linear-8bpp-rotate-180
[476.229153] Subtest linear-8bpp-rotate-180: SUCCESS (1.327s)
[476.362957] [099/133] (558s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[476.456044] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[476.459530] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[476.545736] [100/133] (558s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[476.649711] Starting subtest: extended-modeset-hang-oldfb-with-reset
[476.651730] Starting dynamic subtest: pipe-A
[488.245063] Dynamic subtest pipe-A: SUCCESS (11.596s)
[488.258745] Starting dynamic subtest: pipe-D
[500.494177] Dynamic subtest pipe-D: SUCCESS (12.246s)
[500.496633] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.851s)
[501.295702] [101/133] (533s left) gem_exec_schedule (timeslicing)
[501.388310] Starting subtest: timeslicing
[501.390295] Starting dynamic subtest: rcs0
[501.401815] Dynamic subtest rcs0: SUCCESS (0.023s)
[501.414476] Starting dynamic subtest: bcs0
[501.423141] Dynamic subtest bcs0: SUCCESS (0.020s)
[501.433242] Starting dynamic subtest: vcs0
[501.444717] Dynamic subtest vcs0: SUCCESS (0.020s)
[501.457487] Starting dynamic subtest: vcs1
[501.465254] Dynamic subtest vcs1: SUCCESS (0.020s)
[501.479970] Starting dynamic subtest: vecs0
[501.485637] Dynamic subtest vecs0: SUCCESS (0.020s)
[501.495906] Starting dynamic subtest: ccs0
[501.504961] Dynamic subtest ccs0: SUCCESS (0.019s)
[501.507453] Subtest timeslicing: SUCCESS (0.127s)
[503.580388] [102/133] (531s left) kms_chamelium_color (ctm-0-25)
[503.692398] Subtest ctm-0-25: SKIP (0.000s)
[503.740125] [103/133] (531s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[503.836114] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[503.838451] Starting dynamic subtest: pipe-A-eDP-1
[503.931040] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[503.942274] Starting dynamic subtest: pipe-B-eDP-1
[505.058596] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[505.063138] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.228s)
[506.245981] [104/133] (528s left) gem_mmap (short-mmap)
[506.298436] Subtest short-mmap: SKIP (0.000s)
[506.357770] [105/133] (528s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[506.409772] Starting subtest: multi-wait-available-unsubmitted-submitted
[506.412215] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[506.502293] [106/133] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[506.593247] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[506.597532] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[506.698652] [107/133] (528s left) kms_getfb (getfb2-accept-nv12)
[506.790070] Starting subtest: getfb2-accept-nv12
[506.792448] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[506.903799] [108/133] (528s left) syncobj_timeline (invalid-signal-zero-handles)
[506.955893] Starting subtest: invalid-signal-zero-handles
[506.958192] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[507.053797] [109/133] (528s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[507.142014] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[507.146247] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[507.216187] [110/133] (528s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[507.315862] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[507.317743] Starting dynamic subtest: pipe-A-eDP-1
[507.363959] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[507.373910] Starting dynamic subtest: pipe-B-eDP-1
[507.419459] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[507.430016] Starting dynamic subtest: pipe-C-eDP-1
[507.476898] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[507.489161] Starting dynamic subtest: pipe-D-eDP-1
[507.533495] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[507.536728] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[509.613253] [111/133] (525s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[509.713608] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[509.723856] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[509.822303] [112/133] (525s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[509.916668] Starting subtest: async-flip-with-page-flip-events-tiled
[510.300516] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[513.099548] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[513.112811] Starting dynamic subtest: pipe-A-eDP-1-4
[515.317588] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.216s)
[515.328596] Starting dynamic subtest: pipe-A-eDP-1-4
[517.326660] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[517.337705] Starting dynamic subtest: pipe-A-eDP-1-x
[519.504569] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[519.884890] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[522.634974] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[522.645491] Starting dynamic subtest: pipe-B-eDP-1-4
[524.820514] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[524.831458] Starting dynamic subtest: pipe-B-eDP-1-4
[526.829567] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[526.840557] Starting dynamic subtest: pipe-B-eDP-1-x
[529.030877] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[529.397086] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[532.166975] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.780s)
[532.177716] Starting dynamic subtest: pipe-C-eDP-1-4
[534.330127] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[534.340922] Starting dynamic subtest: pipe-C-eDP-1-4
[536.339653] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[536.350668] Starting dynamic subtest: pipe-C-eDP-1-x
[538.519102] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[538.892749] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[541.612638] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.726s)
[541.624751] Starting dynamic subtest: pipe-D-eDP-1-4
[543.787926] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[543.798660] Starting dynamic subtest: pipe-D-eDP-1-4
[545.797916] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[545.808249] Starting dynamic subtest: pipe-D-eDP-1-x
[547.978196] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[547.980805] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.064s)
[549.212790] [113/133] (486s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[549.320440] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[549.324528] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[549.416799] [114/133] (486s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[549.472295] Starting subtest: etime-multi-wait-for-submit-submitted
[549.576396] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[549.665269] [115/133] (485s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[551.693882] Starting subtest: modeset-non-lpsp-stress-no-wait
[551.737913] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.047s)
[552.066431] [116/133] (483s left) gem_exec_params (sol-reset-invalid)
[552.125459] Starting subtest: sol-reset-invalid
[552.127792] Subtest sol-reset-invalid: SUCCESS (0.002s)
[553.545989] [117/133] (482s left) gem_mmap_gtt (cpuset-big-copy)
[553.621077] Subtest cpuset-big-copy: SKIP (0.000s)
[553.686658] [118/133] (482s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[553.790499] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[561.489239] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.700s)
[561.609530] [119/133] (474s left) kms_psr (psr2-sprite-plane-onoff)
[561.715055] Starting subtest: psr2-sprite-plane-onoff
[561.717268] Starting dynamic subtest: eDP-1
[563.420630] Dynamic subtest eDP-1: SUCCESS (1.703s)
[563.422815] Subtest psr2-sprite-plane-onoff: SUCCESS (1.704s)
[564.287027] [120/133] (471s left) kms_dsc (dsc-with-output-formats)
[564.387111] Starting subtest: dsc-with-output-formats
[564.408367] Subtest dsc-with-output-formats: SKIP (0.000s)
[564.478394] [121/133] (471s left) gen3_mixed_blits
[564.595645] [122/133] (471s left) gem_mmap_offset (clear-via-pagefault)
[564.658400] Starting subtest: clear-via-pagefault
[564.660711] Starting dynamic subtest: smem0
[598.060570] Dynamic subtest smem0: SUCCESS (33.393s)
[598.063212] Subtest clear-via-pagefault: SUCCESS (33.395s)
[598.184450] [123/133] (437s left) gem_eio (reset-stress)
[598.434194] Starting subtest: reset-stress
[598.437215] Starting dynamic subtest: render
[603.559070] Dynamic subtest render: SUCCESS (5.122s)
[603.577173] Starting dynamic subtest: bsd1
[622.035864] Dynamic subtest bsd1: SUCCESS (18.476s)
[622.053539] Starting dynamic subtest: bsd2
[640.024413] Dynamic subtest bsd2: SUCCESS (17.988s)
[640.041384] Starting dynamic subtest: blt
[640.045550] Dynamic subtest blt: SKIP (0.000s)
[640.055436] Starting dynamic subtest: vebox
[658.034792] Dynamic subtest vebox: SUCCESS (18.010s)
[658.037264] Subtest reset-stress: SUCCESS (59.602s)
[659.510793] [124/133] (376s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[659.554501] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[659.557218] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[659.668793] [125/133] (376s left) kms_vblank (query-busy-hang)
[659.769830] Starting subtest: query-busy-hang
[659.771737] Starting dynamic subtest: pipe-A-eDP-1
[661.654717] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[661.671366] Starting dynamic subtest: pipe-D-eDP-1
[664.225471] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.569s)
[664.227915] Subtest query-busy-hang: SUCCESS (4.459s)
[665.081053] [126/133] (371s left) kms_psr (fbc-pr-cursor-plane-onoff)
[665.172983] Starting subtest: fbc-pr-cursor-plane-onoff
[665.177452] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[665.261242] [127/133] (370s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[665.353961] Starting subtest: psr-1p-primscrn-cur-indfb-move
[672.662947] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.311s)
[672.788057] [128/133] (363s left) tools_test (sysfs_l3_parity)
[672.842597] Starting subtest: sysfs_l3_parity
[672.920909] Subtest sysfs_l3_parity: SKIP (0.091s)
[672.975519] [129/133] (363s left) kms_vblank (crtc-id)
[673.067065] Starting subtest: crtc-id
[673.069308] Starting dynamic subtest: pipe-A-eDP-1
[673.507337] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[673.524296] Starting dynamic subtest: pipe-D-eDP-1
[674.660252] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s)
[674.662267] Subtest crtc-id: SUCCESS (1.594s)
[675.494818] [130/133] (360s left) gem_ctx_engines (independent)
[675.561040] Starting subtest: independent
[675.562927] Starting dynamic subtest: rcs0
[675.709582] Dynamic subtest rcs0: SUCCESS (0.150s)
[675.722589] Starting dynamic subtest: bcs0
[675.874976] Dynamic subtest bcs0: SUCCESS (0.164s)
[675.889088] Starting dynamic subtest: vcs0
[676.060572] Dynamic subtest vcs0: SUCCESS (0.184s)
[676.075793] Starting dynamic subtest: vcs1
[676.237751] Dynamic subtest vcs1: SUCCESS (0.177s)
[676.248014] Starting dynamic subtest: vecs0
[676.411357] Dynamic subtest vecs0: SUCCESS (0.172s)
[676.422621] Starting dynamic subtest: ccs0
[676.587594] Dynamic subtest ccs0: SUCCESS (0.175s)
[676.598546] Starting dynamic subtest: all-engines
[677.289139] Dynamic subtest all-engines: SUCCESS (0.701s)
[677.291803] Subtest independent: SUCCESS (1.730s)
[677.702401] [131/133] (358s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[677.793508] Starting subtest: flip-vs-dpms-on-nop-interruptible
[677.795714] Starting dynamic subtest: A-eDP1
[679.692762] Dynamic subtest A-eDP1: SUCCESS (1.898s)
[679.710237] Starting dynamic subtest: B-eDP1
[681.521443] Dynamic subtest B-eDP1: SUCCESS (1.826s)
[681.535541] Starting dynamic subtest: C-eDP1
[683.334219] Dynamic subtest C-eDP1: SUCCESS (1.811s)
[683.354734] Starting dynamic subtest: D-eDP1
[685.165929] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[685.172099] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.380s)
[686.372588] [132/133] (349s left) kms_plane_lowres (tiling-x)
[686.471217] Starting subtest: tiling-x
[686.473542] Starting dynamic subtest: pipe-A-eDP-1
[686.478131] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[686.771017] Starting dynamic subtest: pipe-B-eDP-1
[686.775481] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[686.785623] Starting dynamic subtest: pipe-C-eDP-1
[686.790538] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[686.800867] Starting dynamic subtest: pipe-D-eDP-1
[686.805661] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[686.810098] Subtest tiling-x: SKIP (0.297s)
[687.579169] [133/133] (348s left) i915_pm_freq_api (freq-reset)
[687.654709] Starting subtest: freq-reset
[687.657016] Starting dynamic subtest: gt0
[687.845867] Dynamic subtest gt0: SUCCESS (0.190s)
[687.858428] Starting dynamic subtest: gt1
[688.021940] Dynamic subtest gt1: SUCCESS (0.173s)
[688.024865] Subtest freq-reset: SUCCESS (0.366s)
[688.111499] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_pm_rpm
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: drm_read
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_atomic_interruptible
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: gem_exec_basic
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: dumb_buffer
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: gem_blits
results: parsing output: 48/ for test: gem_busy
results: parsing output: 49/ for test: gem_exec_alignment
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_vm_create
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_pread
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_dp_linktrain_fallback
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: prime_busy
results: parsing output: 90/ for test: gem_ppgtt
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_mmap
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_dsc
results: parsing output: 120/ for test: gen3_mixed_blits
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: tools_test
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_plane_lowres
results: parsing output: 132/ for test: i915_pm_freq_api
Done.