[55.798736] Initializing watchdogs
[55.798844]   /dev/watchdog0
[55.815321] [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]
[55.819968] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.822410] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.825758] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[55.942785] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[55.947192] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[56.039637] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-x)
[56.092743] Subtest fault-concurrent-X: SKIP (0.000s)
[56.149648] [003/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[56.241045] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[56.253954] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[56.326110] [004/133] (960s left) syncobj_wait (wait-any-snapshot)
[56.381702] Starting subtest: wait-any-snapshot
[56.464097] Subtest wait-any-snapshot: SUCCESS (0.081s)
[56.550844] [005/133] (959s left) kms_frontbuffer_tracking (psr-1p-rte)
[56.640080] Starting subtest: psr-1p-rte
[62.101326] Subtest psr-1p-rte: SUCCESS (5.418s)
[62.224868] [006/133] (954s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[62.317282] Starting subtest: disable-crc-after-crtc
[62.319680] Starting dynamic subtest: pipe-A-eDP-1
[63.960222] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.635s)
[63.970140] Starting dynamic subtest: pipe-B-eDP-1
[66.340071] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.371s)
[66.350021] Starting dynamic subtest: pipe-C-eDP-1
[68.606095] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.257s)
[68.614370] Starting dynamic subtest: pipe-D-eDP-1
[70.876085] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.264s)
[70.878297] Subtest disable-crc-after-crtc: SUCCESS (8.532s)
[71.704903] [007/133] (944s left) kms_dp_link_training (uhbr-sst)
[71.805096] Starting subtest: uhbr-sst
[71.813665] Subtest uhbr-sst: SKIP (0.000s)
[71.871167] [008/133] (944s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[71.919609] Starting subtest: invalid-single-wait-all-unsubmitted
[71.921506] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[72.018195] [009/133] (944s left) gem_ctx_isolation (preservation)
[72.075136] Starting subtest: preservation
[72.077454] Starting dynamic subtest: rcs0
[72.206757] Dynamic subtest rcs0: SUCCESS (0.132s)
[72.216476] Starting dynamic subtest: bcs0
[72.455772] Dynamic subtest bcs0: SUCCESS (0.246s)
[72.465515] Starting dynamic subtest: vcs0
[72.959536] Dynamic subtest vcs0: SUCCESS (0.504s)
[72.968157] Starting dynamic subtest: vcs1
[74.455552] Dynamic subtest vcs1: SUCCESS (1.493s)
[74.468028] Starting dynamic subtest: vecs0
[76.443757] Dynamic subtest vecs0: SUCCESS (1.985s)
[76.454840] Starting dynamic subtest: ccs0
[78.434482] Dynamic subtest ccs0: SUCCESS (1.989s)
[78.437224] Subtest preservation: SUCCESS (6.352s)
[78.659649] [010/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[78.761673] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[78.765970] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[78.847526] [011/133] (937s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[78.938718] Starting subtest: primary-y-tiled-reflect-x-270
[78.943197] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[79.010476] [012/133] (937s left) kms_psr (fbc-psr-no-drrs)
[79.104944] Starting subtest: fbc-psr-no-drrs
[79.107262] Starting dynamic subtest: eDP-1
[79.111807] Dynamic subtest eDP-1: SKIP (0.000s)
[79.116397] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[79.175222] [013/133] (937s left) core_setmaster (master-drop-set-user)
[79.249831] Starting subtest: master-drop-set-user
[79.265331] Subtest master-drop-set-user: SUCCESS (0.015s)
[79.299970] [014/133] (937s left) gem_eio (wait-1us)
[79.498605] Starting subtest: wait-1us
[79.794833] Subtest wait-1us: SUCCESS (0.297s)
[79.939167] [015/133] (936s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[80.029374] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[80.031363] Starting dynamic subtest: pipe-A-eDP-1
[80.048960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[80.058166] Starting dynamic subtest: pipe-B-eDP-1
[80.074703] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[80.083855] Starting dynamic subtest: pipe-C-eDP-1
[80.099711] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[80.107210] Starting dynamic subtest: pipe-D-eDP-1
[80.123081] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[80.124842] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[82.301112] [016/133] (934s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[82.402871] Starting subtest: y-tiled-16bpp-rotate-90
[82.407239] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[82.493169] [017/133] (934s left) gem_ppgtt (shrink-vs-evict-pinned)
[82.550783] Starting subtest: shrink-vs-evict-pinned
[90.323609] Subtest shrink-vs-evict-pinned: SUCCESS (7.769s)
[90.407781] [018/133] (926s left) kms_getfb (getfb-reject-nv12)
[90.520070] Starting subtest: getfb-reject-nv12
[90.522411] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[90.618546] [019/133] (926s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[90.727242] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[98.411971] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.687s)
[98.511225] [020/133] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[98.642699] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[98.646988] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[98.770209] [021/133] (918s left) kms_properties (plane-properties-legacy)
[98.855674] Starting subtest: plane-properties-legacy
[98.857568] Starting dynamic subtest: pipe-A-eDP-1
[99.441536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[99.450852] Starting dynamic subtest: pipe-B-eDP-1
[100.727106] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[100.735805] Starting dynamic subtest: pipe-C-eDP-1
[102.052621] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.325s)
[102.060999] Starting dynamic subtest: pipe-D-eDP-1
[103.292725] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[103.295332] Subtest plane-properties-legacy: SUCCESS (4.438s)
[104.091829] [022/133] (913s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[104.187682] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[104.191655] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[104.257424] [023/133] (912s left) gem_exec_reloc (basic-cpu-noreloc)
[104.318607] Subtest basic-cpu-noreloc: SKIP (0.000s)
[104.383398] [024/133] (912s left) i915_query (query-topology-coherent-slice-mask)
[104.436981] Starting subtest: query-topology-coherent-slice-mask
[104.441440] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[104.530931] [025/133] (912s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[104.586743] Starting subtest: multi-wait-available-submitted-signaled
[104.588821] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[104.692042] [026/133] (912s left) gem_exec_fence (syncobj-unused-fence)
[105.121637] Starting subtest: syncobj-unused-fence
[105.126670] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[106.392368] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[106.395939] [027/133] (910s left) gem_mmap_wc (write-read-distinct)
[106.459418] Subtest write-read-distinct: SKIP (0.000s)
[106.521816] [028/133] (910s left) kms_cursor_edge_walk (128x128-top-bottom)
[106.612931] Starting subtest: 128x128-top-bottom
[106.615184] Starting dynamic subtest: pipe-A-eDP-1
[110.061049] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[110.070137] Starting dynamic subtest: pipe-D-eDP-1
[113.183443] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[113.185824] Subtest 128x128-top-bottom: SUCCESS (6.571s)
[113.992248] [029/133] (903s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[114.084767] Starting subtest: fbc-psr2-primary-mmap-cpu
[114.086700] Starting dynamic subtest: eDP-1
[114.090801] Dynamic subtest eDP-1: SKIP (0.000s)
[114.094899] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[114.159667] [030/133] (903s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[114.269739] Starting subtest: x-tiled-32bpp-rotate-270
[114.289115] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[114.403922] [031/133] (903s left) kms_psr (pr-cursor-mmap-cpu)
[114.499583] Starting subtest: pr-cursor-mmap-cpu
[114.503682] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[114.571257] [032/133] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[114.667865] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[114.672128] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[114.756926] [033/133] (902s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[114.866681] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[114.871302] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[114.968756] [034/133] (902s left) kms_big_fb (yf-tiled-addfb)
[115.083551] Starting subtest: yf-tiled-addfb
[115.087433] Subtest yf-tiled-addfb: SKIP (0.000s)
[115.194787] [035/133] (902s left) prime_vgem (wait)
[115.270255] Starting subtest: wait
[115.271967] Starting dynamic subtest: rcs0
[115.317984] Dynamic subtest rcs0: SUCCESS (0.050s)
[115.325992] Starting dynamic subtest: bcs0
[115.374561] Dynamic subtest bcs0: SUCCESS (0.056s)
[115.382431] Starting dynamic subtest: vcs0
[115.422935] Dynamic subtest vcs0: SUCCESS (0.048s)
[115.430687] Starting dynamic subtest: vcs1
[115.466460] Dynamic subtest vcs1: SUCCESS (0.043s)
[115.474297] Starting dynamic subtest: vecs0
[115.514241] Dynamic subtest vecs0: SUCCESS (0.047s)
[115.522258] Starting dynamic subtest: ccs0
[115.561834] Dynamic subtest ccs0: SUCCESS (0.047s)
[115.563728] Subtest wait: SUCCESS (0.294s)
[115.668681] [036/133] (902s left) gem_mmap_offset (partial-remap)
[115.728413] Starting subtest: partial-remap
[115.730170] Starting dynamic subtest: smem0
[115.737681] Dynamic subtest smem0: SUCCESS (0.004s)
[115.739531] Subtest partial-remap: SUCCESS (0.004s)
[115.846297] [037/133] (901s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[115.939372] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[115.941283] Starting dynamic subtest: pipe-A-eDP-1
[121.785293] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.845s)
[121.796838] Starting dynamic subtest: pipe-B-eDP-1
[128.441371] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[128.443558] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.503s)
[129.307941] [038/133] (888s left) kms_hdr (static-toggle-suspend)
[129.408091] Starting subtest: static-toggle-suspend
[129.414340] Subtest static-toggle-suspend: SKIP (0.000s)
[129.482986] [039/133] (888s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[129.544189] Starting subtest: yf-tiled-to-vebox-yf-tiled
[129.548675] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[129.738956] [040/133] (888s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[129.833838] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[129.836124] Starting dynamic subtest: pipe-A-eDP-1
[129.858513] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[129.868938] Starting dynamic subtest: pipe-B-eDP-1
[129.890222] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[129.898289] Starting dynamic subtest: pipe-C-eDP-1
[129.919597] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[129.927127] Starting dynamic subtest: pipe-D-eDP-1
[129.949331] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[129.953724] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[132.073765] [041/133] (885s left) kms_pm_rpm (pc8-residency)
[133.609246] Starting subtest: pc8-residency
[133.614245] Subtest pc8-residency: SKIP (0.000s)
[134.321886] [042/133] (883s left) gem_exec_schedule (preemptive-hang)
[134.503786] Starting subtest: preemptive-hang
[134.506068] Starting dynamic subtest: rcs0
[143.500437] Dynamic subtest rcs0: SUCCESS (8.997s)
[143.510622] Starting dynamic subtest: bcs0
[152.456075] Dynamic subtest bcs0: SUCCESS (8.955s)
[152.465863] Starting dynamic subtest: vcs0
[161.416838] Dynamic subtest vcs0: SUCCESS (8.961s)
[161.427284] Starting dynamic subtest: vcs1
[170.440247] Dynamic subtest vcs1: SUCCESS (9.020s)
[170.450722] Starting dynamic subtest: vecs0
[179.462900] Dynamic subtest vecs0: SUCCESS (9.020s)
[179.480617] Starting dynamic subtest: ccs0
[188.491295] Dynamic subtest ccs0: SUCCESS (9.029s)
[188.493821] Subtest preemptive-hang: SUCCESS (53.989s)
[188.720139] [043/133] (829s left) kms_pipe_crc_basic (bad-source)
[188.844217] Starting subtest: bad-source
[188.846626] Subtest bad-source: SUCCESS (0.000s)
[188.930862] [044/133] (829s left) gem_exec_schedule (preempt-user)
[189.008799] Starting subtest: preempt-user
[189.011318] Starting dynamic subtest: rcs0
[189.033452] Dynamic subtest rcs0: SUCCESS (0.034s)
[189.048301] Starting dynamic subtest: bcs0
[189.054294] Dynamic subtest bcs0: SUCCESS (0.020s)
[189.062791] Starting dynamic subtest: vcs0
[189.076086] Dynamic subtest vcs0: SUCCESS (0.021s)
[189.084622] Starting dynamic subtest: vcs1
[189.095619] Dynamic subtest vcs1: SUCCESS (0.019s)
[189.103972] Starting dynamic subtest: vecs0
[189.114688] Dynamic subtest vecs0: SUCCESS (0.019s)
[189.123315] Starting dynamic subtest: ccs0
[189.136291] Dynamic subtest ccs0: SUCCESS (0.021s)
[189.138523] Subtest preempt-user: SUCCESS (0.137s)
[190.391536] [045/133] (827s left) gem_huc_copy (huc-copy)
[190.457471] Starting subtest: huc-copy
[190.462638] Subtest huc-copy: SUCCESS (0.003s)
[190.588303] [046/133] (827s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[190.694045] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[191.730505] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.036s)
[191.840101] [047/133] (826s left) kms_content_protection (dp-mst-lic-type-1)
[191.976329] Starting subtest: dp-mst-lic-type-1
[191.980305] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[192.086949] [048/133] (826s left) core_getclient (basic)
[192.133458] Starting subtest: basic
[192.135477] Subtest basic: SUCCESS (0.000s)
[192.228708] [049/133] (826s left) gem_mmap (short-mmap)
[192.279087] Subtest short-mmap: SKIP (0.000s)
[192.331689] [050/133] (825s left) perf_pmu (busy-check-all)
[192.370064] Starting subtest: busy-check-all
[192.371997] Starting dynamic subtest: rcs0
[192.923557] Dynamic subtest rcs0: SUCCESS (0.552s)
[192.935266] Starting dynamic subtest: bcs0
[193.474329] Dynamic subtest bcs0: SUCCESS (0.549s)
[193.487849] Starting dynamic subtest: vcs0
[195.297584] Dynamic subtest vcs0: SUCCESS (1.821s)
[195.309534] Starting dynamic subtest: vcs1
[197.345731] Dynamic subtest vcs1: SUCCESS (2.045s)
[197.357413] Starting dynamic subtest: vecs0
[199.329579] Dynamic subtest vecs0: SUCCESS (1.982s)
[199.341747] Starting dynamic subtest: ccs0
[199.882271] Dynamic subtest ccs0: SUCCESS (0.552s)
[199.884799] Subtest busy-check-all: SUCCESS (7.513s)
[199.995330] [051/133] (818s left) gem_partial_pwrite_pread (write-display)
[200.046971] Subtest write-display: SKIP (0.000s)
[200.104953] [052/133] (818s left) gem_ctx_sseu (invalid-sseu)
[200.176115] Subtest invalid-sseu: SKIP (0.000s)
[200.255662] [053/133] (818s left) kms_plane_multiple (tiling-none)
[200.351860] Starting subtest: tiling-none
[200.354376] Starting dynamic subtest: pipe-A-eDP-1
[204.047783] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.695s)
[204.060649] Starting dynamic subtest: pipe-B-eDP-1
[208.401113] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.354s)
[208.411585] Starting dynamic subtest: pipe-C-eDP-1
[212.753660] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.348s)
[212.763499] Starting dynamic subtest: pipe-D-eDP-1
[217.084276] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.331s)
[217.086340] Subtest tiling-none: SUCCESS (16.733s)
[217.891036] [054/133] (800s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[217.971915] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[218.037157] [055/133] (800s left) i915_pm_rpm (system-suspend-devices)
[219.563314] Starting subtest: system-suspend-devices
[227.339415] Subtest system-suspend-devices: SUCCESS (7.779s)
[236.737657] [056/133] (790s left) kms_async_flips (test-time-stamp-atomic)
[236.857826] Starting subtest: test-time-stamp-atomic
[237.242872] Starting dynamic subtest: pipe-A-eDP-1
[238.019425] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.774s)
[238.410228] Starting dynamic subtest: pipe-B-eDP-1
[239.167847] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[239.548580] Starting dynamic subtest: pipe-C-eDP-1
[240.305723] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[240.672098] Starting dynamic subtest: pipe-D-eDP-1
[241.432623] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[241.435085] Subtest test-time-stamp-atomic: SUCCESS (4.575s)
[242.594897] [057/133] (785s left) kms_cursor_crc (cursor-offscreen-256x256)
[242.833347] Starting subtest: cursor-offscreen-256x256
[242.838337] Starting dynamic subtest: pipe-A-eDP-1
[244.777221] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[244.806876] Starting dynamic subtest: pipe-D-eDP-1
[247.398750] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[247.401127] Subtest cursor-offscreen-256x256: SUCCESS (4.565s)
[248.266417] [058/133] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[248.369404] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[248.373417] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[248.464142] [059/133] (779s left) gem_exec_await (wide-contexts)
[248.670926] Starting subtest: wide-contexts
[272.302107] Subtest wide-contexts: SUCCESS (23.629s)
[272.512813] [060/133] (755s left) kms_flip (nonexisting-fb-interruptible)
[272.679366] Starting subtest: nonexisting-fb-interruptible
[272.681732] Starting dynamic subtest: A-eDP1
[273.842322] Dynamic subtest A-eDP1: SUCCESS (1.162s)
[273.852677] Starting dynamic subtest: B-eDP1
[274.963743] Dynamic subtest B-eDP1: SUCCESS (1.120s)
[274.974707] Starting dynamic subtest: C-eDP1
[276.099262] Dynamic subtest C-eDP1: SUCCESS (1.134s)
[276.115730] Starting dynamic subtest: D-eDP1
[277.223110] Dynamic subtest D-eDP1: SUCCESS (1.121s)
[277.228413] Subtest nonexisting-fb-interruptible: SUCCESS (4.549s)
[278.400883] [061/133] (749s left) kms_psr (psr2-no-drrs)
[278.501094] Starting subtest: psr2-no-drrs
[278.503408] Starting dynamic subtest: eDP-1
[280.081705] Dynamic subtest eDP-1: SUCCESS (1.578s)
[280.083920] Subtest psr2-no-drrs: SUCCESS (1.579s)
[280.875045] [062/133] (746s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[280.977256] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[281.006684] Starting dynamic subtest: pipe-A-plane-0
[281.296420] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[281.306357] Starting dynamic subtest: pipe-A-plane-3
[281.528696] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[282.674176] Starting dynamic subtest: pipe-B-plane-0
[282.967199] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[282.978233] Starting dynamic subtest: pipe-B-plane-3
[283.209619] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[283.521290] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.543s)
[284.355186] [063/133] (743s left) gem_exec_balancer (bonded-true-hang)
[284.612182] Starting subtest: bonded-true-hang
[284.617058] Subtest bonded-true-hang: SKIP (0.000s)
[284.735116] [064/133] (743s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[285.128015] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[285.960603] [065/133] (741s left) gem_exec_reloc (basic-write-cpu-noreloc)
[286.035199] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[286.113462] [066/133] (741s left) kms_hdmi_inject (inject-4k)
[286.437807] Starting subtest: inject-4k
[286.755088] Subtest inject-4k: SUCCESS (0.318s)
[287.340665] [067/133] (740s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[287.401078] Starting subtest: etime-single-wait-all-for-submit-submitted
[287.509993] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[287.612169] [068/133] (740s left) kms_flip (flip-vs-modeset-vs-hang)
[287.704854] Starting subtest: flip-vs-modeset-vs-hang
[287.707308] Starting dynamic subtest: A-eDP1
[338.810361] Dynamic subtest A-eDP1: SUCCESS (51.103s)
[338.821919] Starting dynamic subtest: D-eDP1
[388.795557] Dynamic subtest D-eDP1: SUCCESS (49.980s)
[388.797671] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.091s)
[389.176733] [069/133] (638s left) kms_lease (master-vs-lease)
[389.281363] Starting subtest: master-vs-lease
[389.283669] Subtest master-vs-lease: SUCCESS (0.002s)
[389.391747] [070/133] (638s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[389.480260] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[389.482663] Starting dynamic subtest: pipe-A-eDP-1
[389.989974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s)
[390.001801] Starting dynamic subtest: pipe-B-eDP-1
[391.378678] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[391.389938] Starting dynamic subtest: pipe-C-eDP-1
[392.740067] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[392.751387] Starting dynamic subtest: pipe-D-eDP-1
[394.173922] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.435s)
[394.175874] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.667s)
[395.296968] [071/133] (632s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[395.353901] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[395.358509] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[395.553105] [072/133] (632s left) gem_ctx_engines (invalid-engines)
[395.626625] Starting subtest: invalid-engines
[395.634449] Subtest invalid-engines: SUCCESS (0.008s)
[395.861349] [073/133] (632s left) gem_exec_params (dr4-dirt)
[395.925499] Starting subtest: DR4-dirt
[395.927597] Subtest DR4-dirt: SUCCESS (0.000s)
[396.017831] [074/133] (632s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[396.117769] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[396.122554] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[396.218399] [075/133] (632s left) sw_sync (sync_multi_producer_single_consumer)
[396.257528] Starting subtest: sync_multi_producer_single_consumer
[397.333318] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[397.413520] [076/133] (631s left) syncobj_timeline (wait-all-for-submit-complex)
[397.462743] Starting subtest: wait-all-for-submit-complex
[397.678642] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[397.756826] [077/133] (630s left) gem_eio (execbuf)
[397.950833] Starting subtest: execbuf
[398.230543] Subtest execbuf: SUCCESS (0.281s)
[398.379951] [078/133] (630s left) gem_partial_pwrite_pread (writes-after-reads)
[398.441766] Subtest writes-after-reads: SKIP (0.000s)
[398.514073] [079/133] (630s left) kms_feature_discovery (dp-mst)
[398.595381] Starting subtest: dp-mst
[398.599727] Subtest dp-mst: SKIP (0.000s)
[398.668884] [080/133] (629s left) perf (low-oa-exponent-permissions)
[398.827271] Starting subtest: low-oa-exponent-permissions
[398.864698] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[398.919440] [081/133] (629s left) gem_exec_fence (syncobj-import)
[399.345644] Starting subtest: syncobj-import
[399.351735] Subtest syncobj-import: SUCCESS (0.005s)
[400.416559] [082/133] (628s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[400.514039] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[400.516376] Starting dynamic subtest: pipe-A-eDP-1
[400.599376] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[400.610495] Starting dynamic subtest: pipe-B-eDP-1
[401.744175] Dynamic subtest pipe-B-eDP-1: SKIP (1.143s)
[401.748790] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.235s)
[402.993543] [083/133] (625s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[403.100334] Starting subtest: cursorB-vs-flipB-atomic
[403.104820] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[403.247068] [084/133] (625s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[403.342957] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[403.354425] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[403.444938] [085/133] (625s left) kms_vblank (ts-continuation-idle)
[403.539111] Starting subtest: ts-continuation-idle
[403.541175] Starting dynamic subtest: pipe-A-eDP-1
[403.950850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[403.973940] Starting dynamic subtest: pipe-D-eDP-1
[405.047606] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.091s)
[405.049669] Subtest ts-continuation-idle: SUCCESS (1.508s)
[405.897113] [086/133] (622s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[406.002329] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[406.007113] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[407.093552] [087/133] (621s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[407.192098] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[407.196607] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[407.299399] [088/133] (621s left) syncobj_eventfd (invalid-bad-flags)
[407.353450] Starting subtest: invalid-bad-flags
[407.355576] Subtest invalid-bad-flags: SUCCESS (0.000s)
[407.461815] [089/133] (621s left) kms_pwrite_crc (basic)
[407.563216] Starting subtest: basic
[408.230385] Subtest basic: SUCCESS (0.669s)
[409.100612] [090/133] (619s left) gem_sync (basic-store-each)
[409.185583] Starting subtest: basic-store-each
[411.486236] Subtest basic-store-each: SUCCESS (2.312s)
[411.678712] [091/133] (617s left) kms_universal_plane (universal-plane-sanity)
[411.782259] Starting subtest: universal-plane-sanity
[411.784655] Starting dynamic subtest: pipe-A-eDP-1
[412.392228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[412.402685] Starting dynamic subtest: pipe-B-eDP-1
[413.587726] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[413.598920] Starting dynamic subtest: pipe-C-eDP-1
[414.766339] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.176s)
[414.776951] Starting dynamic subtest: pipe-D-eDP-1
[415.956081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.190s)
[415.958434] Subtest universal-plane-sanity: SUCCESS (4.177s)
[416.799428] [092/133] (612s left) gem_spin_batch (legacy)
[416.857655] Starting subtest: legacy
[416.860103] Starting dynamic subtest: default
[420.100370] Dynamic subtest default: SUCCESS (3.237s)
[420.113591] Starting dynamic subtest: render
[423.336908] Dynamic subtest render: SUCCESS (3.233s)
[423.346823] Starting dynamic subtest: bsd
[426.576474] Dynamic subtest bsd: SUCCESS (3.236s)
[426.587750] Starting dynamic subtest: bsd1
[429.812403] Dynamic subtest bsd1: SUCCESS (3.234s)
[429.824411] Starting dynamic subtest: bsd2
[433.050490] Dynamic subtest bsd2: SUCCESS (3.234s)
[433.062337] Starting dynamic subtest: blt
[436.286415] Dynamic subtest blt: SUCCESS (3.234s)
[436.299075] Starting dynamic subtest: vebox
[439.522735] Dynamic subtest vebox: SUCCESS (3.233s)
[439.524784] Subtest legacy: SUCCESS (22.661s)
[440.378771] [093/133] (588s left) kms_rotation_crc (primary-rotation-90)
[440.494132] Starting subtest: primary-rotation-90
[440.498700] Subtest primary-rotation-90: SKIP (0.001s)
[440.574121] [094/133] (588s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[440.669602] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[449.331074] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.665s)
[449.496800] [095/133] (579s left) api_intel_allocator (default-alignment)
[449.550532] Starting subtest: default-alignment
[449.552942] Subtest default-alignment: SUCCESS (0.004s)
[449.672103] [096/133] (579s left) kms_chamelium_frames (hdmi-frame-dump)
[450.057592] Subtest hdmi-frame-dump: SKIP (0.000s)
[450.869505] [097/133] (578s left) kms_chamelium_audio (hdmi-audio)
[451.262949] Subtest hdmi-audio: SKIP (0.000s)
[452.076367] [098/133] (577s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[452.190453] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[453.029640] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[453.237029] [099/133] (576s left) gen7_exec_parse (bitmasks)
[453.316730] Subtest bitmasks: SKIP (0.000s)
[453.385651] [100/133] (576s left) gem_mmap_wc (set-cache-level)
[453.452745] Subtest set-cache-level: SKIP (0.000s)
[453.514850] [101/133] (576s left) gem_madvise (dontneed-before-exec)
[453.549797] Starting subtest: dontneed-before-exec
[453.565496] Subtest dontneed-before-exec: SKIP (0.012s)
[453.624576] [102/133] (575s left) i915_module_load (resize-bar)
[453.660925] Starting subtest: resize-bar
[453.667973] Subtest resize-bar: SKIP (0.006s)
[453.714300] [103/133] (575s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[453.815440] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[453.817722] Starting dynamic subtest: pipe-A-eDP-1
[453.826427] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[453.836864] Starting dynamic subtest: pipe-B-eDP-1
[453.845698] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[453.856593] Starting dynamic subtest: pipe-C-eDP-1
[453.864858] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[453.874446] Starting dynamic subtest: pipe-D-eDP-1
[453.882780] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[453.886647] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[456.095343] [104/133] (573s left) gem_eio (wait-immediate)
[456.313754] Starting subtest: wait-immediate
[456.689829] Subtest wait-immediate: SUCCESS (0.377s)
[456.831319] [105/133] (572s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[456.934576] Starting subtest: 2x-long-flip-vs-cursor-legacy
[456.939039] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[457.092316] [106/133] (572s left) gem_exec_reloc (basic-gtt-wc-active)
[457.151660] Subtest basic-gtt-wc-active: SKIP (0.000s)
[457.224275] [107/133] (572s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[457.319984] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[457.323687] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[457.392304] [108/133] (572s left) kms_frontbuffer_tracking (fbc-tiling-4)
[457.492442] Starting subtest: fbc-tiling-4
[461.640600] Subtest fbc-tiling-4: SUCCESS (4.151s)
[462.799539] [109/133] (567s left) kms_big_fb (linear-32bpp-rotate-270)
[462.899502] Starting subtest: linear-32bpp-rotate-270
[462.918813] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[463.035864] [110/133] (566s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[463.118972] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[463.121376] Starting dynamic subtest: pipe-A
[463.229414] Dynamic subtest pipe-A: SKIP (0.107s)
[463.240890] Starting dynamic subtest: pipe-B
[464.429299] Dynamic subtest pipe-B: SKIP (1.198s)
[464.440317] Starting dynamic subtest: pipe-C
[465.621583] Dynamic subtest pipe-C: SUCCESS (1.197s)
[465.634252] Starting dynamic subtest: pipe-D
[466.821407] Dynamic subtest pipe-D: SUCCESS (1.199s)
[466.823831] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.705s)
[467.992813] [111/133] (561s left) fbdev (pan)
[468.032826] Starting subtest: pan
[468.061024] Subtest pan: SUCCESS (0.029s)
[468.136764] [112/133] (561s left) gem_exec_capture (pi)
[468.194187] Starting subtest: pi
[468.196574] Starting dynamic subtest: rcs0
[472.259665] Dynamic subtest rcs0: SUCCESS (4.067s)
[472.273244] Starting dynamic subtest: bcs0
[476.174397] Dynamic subtest bcs0: SUCCESS (3.913s)
[476.187486] Starting dynamic subtest: vcs0
[480.128517] Dynamic subtest vcs0: SUCCESS (3.953s)
[480.141327] Starting dynamic subtest: vcs1
[484.108823] Dynamic subtest vcs1: SUCCESS (3.979s)
[484.120201] Starting dynamic subtest: vecs0
[488.095546] Dynamic subtest vecs0: SUCCESS (3.984s)
[488.107425] Starting dynamic subtest: ccs0
[492.136427] Dynamic subtest ccs0: SUCCESS (4.038s)
[492.139378] Subtest pi: SUCCESS (23.943s)
[492.222122] [113/133] (537s left) i915_query (query-regions-garbage-items)
[492.319084] Starting subtest: query-regions-garbage-items
[492.321250] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[492.425737] [114/133] (537s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[492.528136] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[492.532571] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[492.602767] [115/133] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[492.711516] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[492.715841] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[492.817266] [116/133] (537s left) gem_userptr_blits (sd-probe)
[492.882211] Starting subtest: sd-probe
[492.884623] Subtest sd-probe: SUCCESS (0.000s)
[493.006039] [117/133] (537s left) i915_drm_fdinfo (busy-check-all)
[493.050479] Starting subtest: busy-check-all
[493.052326] Starting dynamic subtest: rcs0
[493.056842] Dynamic subtest rcs0: SKIP (0.004s)
[493.067638] Starting dynamic subtest: bcs0
[493.072077] Dynamic subtest bcs0: SKIP (0.000s)
[493.081871] Starting dynamic subtest: vcs0
[493.085364] Dynamic subtest vcs0: SKIP (0.000s)
[493.094492] Starting dynamic subtest: vcs1
[493.097814] Dynamic subtest vcs1: SKIP (0.000s)
[493.108306] Starting dynamic subtest: vecs0
[493.111630] Dynamic subtest vecs0: SKIP (0.000s)
[493.120686] Starting dynamic subtest: ccs0
[493.123995] Dynamic subtest ccs0: SKIP (0.000s)
[493.127480] Subtest busy-check-all: SKIP (0.009s)
[493.164687] [118/133] (537s left) syncobj_timeline (wait-zero-handles)
[493.243281] Starting subtest: wait-zero-handles
[493.245224] Subtest wait-zero-handles: SUCCESS (0.000s)
[493.346973] [119/133] (536s left) syncobj_basic (bad-create-flags)
[493.408514] Starting subtest: bad-create-flags
[493.410136] Subtest bad-create-flags: SUCCESS (0.000s)
[493.506841] [120/133] (536s left) perf_pmu (busy-start)
[493.548097] Starting subtest: busy-start
[493.549866] Starting dynamic subtest: rcs0
[496.099694] Dynamic subtest rcs0: SUCCESS (2.552s)
[496.112630] Starting dynamic subtest: bcs0
[498.649938] Dynamic subtest bcs0: SUCCESS (2.548s)
[498.665971] Starting dynamic subtest: vcs0
[502.305071] Dynamic subtest vcs0: SUCCESS (3.650s)
[502.317691] Starting dynamic subtest: vcs1
[506.339633] Dynamic subtest vcs1: SUCCESS (4.032s)
[506.351035] Starting dynamic subtest: vecs0
[510.305639] Dynamic subtest vecs0: SUCCESS (3.963s)
[510.316742] Starting dynamic subtest: ccs0
[512.854555] Dynamic subtest ccs0: SUCCESS (2.548s)
[512.857120] Subtest busy-start: SUCCESS (19.308s)
[512.954615] [121/133] (517s left) gem_ctx_persistence (processes)
[513.022070] Starting subtest: processes
[514.366690] Subtest processes: SUCCESS (1.344s)
[514.455237] [122/133] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[514.567072] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[514.571133] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[514.680634] [123/133] (515s left) gen3_mixed_blits
[514.809442] [124/133] (515s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[514.900908] Starting subtest: async-flip-with-page-flip-events-tiled
[515.275317] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[518.035400] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[518.049114] Starting dynamic subtest: pipe-A-eDP-1-4
[520.210069] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[520.223056] Starting dynamic subtest: pipe-A-eDP-1-4
[522.220421] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[522.232638] Starting dynamic subtest: pipe-A-eDP-1-x
[524.398459] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[524.778253] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[527.528373] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.758s)
[527.540856] Starting dynamic subtest: pipe-B-eDP-1-4
[529.714077] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[529.727234] Starting dynamic subtest: pipe-B-eDP-1-4
[531.724772] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[531.738092] Starting dynamic subtest: pipe-B-eDP-1-x
[533.913677] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[534.286390] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[537.019509] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.740s)
[537.030081] Starting dynamic subtest: pipe-C-eDP-1-4
[539.204696] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s)
[539.215897] Starting dynamic subtest: pipe-C-eDP-1-4
[541.214987] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[541.226326] Starting dynamic subtest: pipe-C-eDP-1-x
[543.393708] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[543.758848] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[546.524927] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.774s)
[546.535765] Starting dynamic subtest: pipe-D-eDP-1-4
[548.698094] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s)
[548.709274] Starting dynamic subtest: pipe-D-eDP-1-4
[550.708260] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[550.719299] Starting dynamic subtest: pipe-D-eDP-1-x
[552.886786] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[552.889614] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (37.985s)
[554.086440] [125/133] (476s left) gem_exec_whisper (basic-contexts)
[554.146291] Starting subtest: basic-contexts
[561.351796] Subtest basic-contexts: SUCCESS (7.200s)
[561.537630] [126/133] (469s left) kms_cursor_crc (cursor-random-512x170)
[561.864491] Starting subtest: cursor-random-512x170
[561.869022] Subtest cursor-random-512x170: SKIP (0.001s)
[562.010707] [127/133] (468s left) kms_color_pipeline (plane-ctm3x4)
[562.119279] Starting subtest: plane-ctm3x4
[562.254064] Starting dynamic subtest: pipe-A-plane-0
[562.387325] Dynamic subtest pipe-A-plane-0: SUCCESS (0.133s)
[562.398187] Starting dynamic subtest: pipe-A-plane-1
[562.520977] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[562.531046] Starting dynamic subtest: pipe-A-plane-2
[562.653444] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[563.845040] Starting dynamic subtest: pipe-B-plane-0
[563.965588] Dynamic subtest pipe-B-plane-0: SUCCESS (0.133s)
[563.976282] Starting dynamic subtest: pipe-B-plane-1
[564.075699] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[564.086245] Starting dynamic subtest: pipe-B-plane-2
[564.186518] Dynamic subtest pipe-B-plane-2: SUCCESS (0.110s)
[565.356377] Starting dynamic subtest: pipe-C-plane-0
[565.470251] Dynamic subtest pipe-C-plane-0: SUCCESS (0.121s)
[565.481691] Starting dynamic subtest: pipe-C-plane-1
[565.613885] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[565.625311] Starting dynamic subtest: pipe-C-plane-2
[565.746846] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[566.933259] Starting dynamic subtest: pipe-D-plane-0
[567.035367] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[567.045918] Starting dynamic subtest: pipe-D-plane-1
[567.146314] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[567.156608] Starting dynamic subtest: pipe-D-plane-2
[567.257365] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[567.545892] Subtest plane-ctm3x4: SUCCESS (5.427s)
[568.393080] [128/133] (462s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[568.489068] Starting subtest: fbcpsr-1p-rte
[575.410342] Subtest fbcpsr-1p-rte: SUCCESS (6.926s)
[575.560594] [129/133] (455s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[575.684272] Starting subtest: basic-flip-before-cursor-legacy
[576.638073] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.953s)
[577.472355] [130/133] (453s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[577.570097] Starting subtest: plane-upscale-factor-0-25-with-rotation
[577.572288] Starting dynamic subtest: pipe-A
[577.795958] Dynamic subtest pipe-A: SUCCESS (0.227s)
[577.810776] Starting dynamic subtest: pipe-B
[579.129941] Dynamic subtest pipe-B: SUCCESS (1.331s)
[579.146406] Starting dynamic subtest: pipe-C
[580.429435] Dynamic subtest pipe-C: SUCCESS (1.298s)
[580.440169] Starting dynamic subtest: pipe-D
[581.723052] Dynamic subtest pipe-D: SUCCESS (1.292s)
[581.725314] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.155s)
[582.882254] [131/133] (447s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[582.996702] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[614.877865] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.878s)
[615.679951] [132/133] (415s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[615.784917] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[615.789175] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[615.897213] [133/133] (415s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[617.524502] Starting subtest: dpms-mode-unset-lpsp
[621.566863] Subtest dpms-mode-unset-lpsp: SUCCESS (4.046s)
[621.975927] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_dp_link_training
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: core_setmaster
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_ppgtt
results: parsing output: 17/ for test: kms_getfb
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_properties
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_huc_copy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: core_getclient
results: parsing output: 48/ for test: gem_mmap
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: kms_plane_multiple
results: parsing output: 53/ for test: gem_fenced_exec_thrash
results: parsing output: 54/ for test: i915_pm_rpm
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_await
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_hdmi_inject
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: gem_ctx_engines
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_eventfd
results: parsing output: 88/ for test: kms_pwrite_crc
results: parsing output: 89/ for test: gem_sync
results: parsing output: 90/ for test: kms_universal_plane
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: kms_chamelium_audio
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gen7_exec_parse
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: gem_madvise
results: parsing output: 101/ for test: i915_module_load
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gen3_mixed_blits
results: parsing output: 123/ for test: kms_async_flips
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_color_pipeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_pm_rpm
Done.