[72.300059] Initializing watchdogs
[72.300113]   /dev/watchdog0
[72.316890] [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]
[72.322174] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.324741] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.328186] [001/133] (960s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[72.658102] Starting subtest: plane-lut1d-ctm3x4
[72.828583] Starting dynamic subtest: pipe-A-plane-0
[73.005711] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[73.013656] Starting dynamic subtest: pipe-A-plane-1
[73.195014] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[73.203345] Starting dynamic subtest: pipe-A-plane-2
[73.383679] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[74.606815] Starting dynamic subtest: pipe-B-plane-0
[74.765825] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[74.775307] Starting dynamic subtest: pipe-B-plane-1
[74.932609] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[74.940798] Starting dynamic subtest: pipe-B-plane-2
[75.122855] Dynamic subtest pipe-B-plane-2: SUCCESS (0.189s)
[76.351712] Starting dynamic subtest: pipe-C-plane-0
[76.512371] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[76.524063] Starting dynamic subtest: pipe-C-plane-1
[76.667991] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[76.677911] Starting dynamic subtest: pipe-C-plane-2
[76.834683] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[78.096827] Starting dynamic subtest: pipe-D-plane-0
[78.232343] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[78.241391] Starting dynamic subtest: pipe-D-plane-1
[78.387999] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[78.396603] Starting dynamic subtest: pipe-D-plane-2
[78.544077] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[78.841208] Subtest plane-lut1d-ctm3x4: SUCCESS (6.176s)
[79.663260] [002/133] (953s left) kms_lease (lease-unleased-crtc)
[79.764235] Starting subtest: lease-unleased-crtc
[79.766524] Starting dynamic subtest: pipe-A-eDP-1
[80.058878] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[80.068546] Starting dynamic subtest: pipe-B-eDP-1
[80.800319] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.741s)
[80.810886] Starting dynamic subtest: pipe-C-eDP-1
[80.813475] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[80.821045] Starting dynamic subtest: pipe-D-eDP-1
[80.823539] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[80.825908] Subtest lease-unleased-crtc: SUCCESS (1.043s)
[81.200099] [003/133] (951s left) i915_pm_rps (fence-order)
[81.256256] Starting subtest: fence-order
[84.767324] Subtest fence-order: SUCCESS (3.506s)
[84.880109] [004/133] (948s left) kms_cursor_crc (cursor-offscreen-32x10)
[85.041144] Starting subtest: cursor-offscreen-32x10
[85.092107] Subtest cursor-offscreen-32x10: SKIP (0.046s)
[85.359583] [005/133] (947s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[85.450192] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[85.452538] Starting dynamic subtest: pipe-A-eDP-1
[85.476170] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[85.486829] Starting dynamic subtest: pipe-B-eDP-1
[85.508644] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[85.516213] Starting dynamic subtest: pipe-C-eDP-1
[85.537839] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.545552] Starting dynamic subtest: pipe-D-eDP-1
[85.576509] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.580936] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.003s)
[87.754236] [006/133] (945s left) kms_chamelium_color (ctm-negative)
[87.859574] Subtest ctm-negative: SKIP (0.000s)
[87.901108] [007/133] (945s left) gem_exec_balancer (smoke)
[87.955257] Starting subtest: smoke
[110.596857] Subtest smoke: SUCCESS (22.632s)
[112.478697] [008/133] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[112.583319] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[112.587708] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[112.668173] [009/133] (920s left) kms_prop_blob (invalid-set-prop-any)
[112.735494] Starting subtest: invalid-set-prop-any
[112.737941] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[112.829395] [010/133] (920s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[112.881959] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[112.987080] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[113.061752] [011/133] (920s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[113.451690] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[114.276638] [012/133] (918s left) kms_flip (bo-too-big)
[114.381679] Starting subtest: bo-too-big
[114.384104] Starting dynamic subtest: A-eDP1
[115.750233] Dynamic subtest A-eDP1: SUCCESS (1.371s)
[115.760668] Starting dynamic subtest: B-eDP1
[117.095071] Dynamic subtest B-eDP1: SUCCESS (1.344s)
[117.104737] Starting dynamic subtest: C-eDP1
[118.443706] Dynamic subtest C-eDP1: SUCCESS (1.347s)
[118.456967] Starting dynamic subtest: D-eDP1
[119.773680] Dynamic subtest D-eDP1: SUCCESS (1.330s)
[119.778308] Subtest bo-too-big: SUCCESS (5.399s)
[120.967982] [013/133] (912s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[121.025716] Starting subtest: yf-tiled-ccs-to-y-tiled
[121.029974] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[121.209064] [014/133] (912s left) kms_cursor_edge_walk (256x256-top-edge)
[121.296079] Starting subtest: 256x256-top-edge
[121.298484] Starting dynamic subtest: pipe-A-eDP-1
[124.730674] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[124.739978] Starting dynamic subtest: pipe-D-eDP-1
[127.854878] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[127.857242] Subtest 256x256-top-edge: SUCCESS (6.560s)
[128.674936] [015/133] (904s left) prime_mmap (test_errors)
[128.729180] Starting subtest: test_errors
[128.731179] Starting dynamic subtest: test_errors-smem
[128.833378] Dynamic subtest test_errors-smem: SUCCESS (0.104s)
[128.835911] Subtest test_errors: SUCCESS (0.105s)
[128.932469] [016/133] (904s left) kms_addfb_basic (bad-pitch-999)
[128.983064] Starting subtest: bad-pitch-999
[128.985023] Subtest bad-pitch-999: SUCCESS (0.000s)
[129.107408] [017/133] (904s left) perf_pmu (busy-no-semaphores)
[129.151461] Starting subtest: busy-no-semaphores
[129.153600] Starting dynamic subtest: rcs0
[129.702972] Dynamic subtest rcs0: SUCCESS (0.551s)
[129.714372] Starting dynamic subtest: bcs0
[130.252647] Dynamic subtest bcs0: SUCCESS (0.548s)
[130.264377] Starting dynamic subtest: vcs0
[130.804224] Dynamic subtest vcs0: SUCCESS (0.550s)
[130.815643] Starting dynamic subtest: vcs1
[132.835686] Dynamic subtest vcs1: SUCCESS (2.030s)
[132.847481] Starting dynamic subtest: vecs0
[134.817365] Dynamic subtest vecs0: SUCCESS (1.980s)
[134.827859] Starting dynamic subtest: ccs0
[136.866338] Dynamic subtest ccs0: SUCCESS (2.047s)
[136.869192] Subtest busy-no-semaphores: SUCCESS (7.715s)
[136.994294] [018/133] (896s left) gem_ctx_param (set-priority-range)
[137.042313] Starting subtest: set-priority-range
[137.054318] Subtest set-priority-range: SUCCESS (0.013s)
[137.172956] [019/133] (896s left) gem_eio (in-flight-10ms)
[137.379085] Starting subtest: in-flight-10ms
[145.968127] Subtest in-flight-10ms: SUCCESS (8.587s)
[146.095411] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[146.098707] [020/133] (887s left) gem_exec_fence (syncobj-timeline-export)
[146.621450] Starting subtest: syncobj-timeline-export
[146.627016] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[147.349214] [021/133] (886s left) kms_psr (fbc-psr2-suspend)
[147.437100] Starting subtest: fbc-psr2-suspend
[147.439411] Starting dynamic subtest: eDP-1
[147.443801] Dynamic subtest eDP-1: SKIP (0.000s)
[147.448368] Subtest fbc-psr2-suspend: SKIP (0.001s)
[147.510882] [022/133] (886s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[147.606299] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[147.610579] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[147.722305] [023/133] (885s left) gem_create (create-valid-nonaligned)
[147.778859] Starting subtest: create-valid-nonaligned
[147.781095] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[147.965023] [024/133] (885s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[148.054491] Starting subtest: psr-rgb101010-draw-blt
[155.411182] Subtest psr-rgb101010-draw-blt: SUCCESS (7.360s)
[155.538082] [025/133] (878s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[155.593984] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[155.698705] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[155.788564] [026/133] (878s left) kms_plane_lowres (tiling-none)
[155.882449] Starting subtest: tiling-none
[155.884747] Starting dynamic subtest: pipe-A-eDP-1
[155.889346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[156.184371] Starting dynamic subtest: pipe-B-eDP-1
[156.189201] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[156.198356] Starting dynamic subtest: pipe-C-eDP-1
[156.202802] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.211611] Starting dynamic subtest: pipe-D-eDP-1
[156.215668] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[156.219697] Subtest tiling-none: SKIP (0.299s)
[157.033563] [027/133] (876s left) gem_exec_create (basic)
[157.099781] Starting subtest: basic
[157.102160] Starting dynamic subtest: smem
[160.351861] Dynamic subtest smem: SUCCESS (3.252s)
[160.354964] Subtest basic: SUCCESS (3.253s)
[160.555433] [028/133] (873s left) gem_softpin (allocator-evict)
[160.613622] Starting subtest: allocator-evict
[160.615937] Starting dynamic subtest: rcs0
[184.626757] Dynamic subtest rcs0: SUCCESS (24.011s)
[184.636499] Starting dynamic subtest: bcs0
[208.934922] Dynamic subtest bcs0: SUCCESS (24.306s)
[208.944627] Starting dynamic subtest: vcs0
[232.486369] Dynamic subtest vcs0: SUCCESS (23.548s)
[232.498296] Starting dynamic subtest: vcs1
[256.306158] Dynamic subtest vcs1: SUCCESS (23.818s)
[256.316332] Starting dynamic subtest: vecs0
[280.249245] Dynamic subtest vecs0: SUCCESS (23.941s)
[280.261705] Starting dynamic subtest: ccs0
[304.127693] Dynamic subtest ccs0: SUCCESS (23.876s)
[304.130388] Subtest allocator-evict: SUCCESS (143.505s)
[304.224684] [029/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[304.366762] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[304.371364] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[304.472861] [030/133] (729s left) gem_exec_schedule (timeslicing)
[304.551667] Starting subtest: timeslicing
[304.553613] Starting dynamic subtest: rcs0
[304.561600] Dynamic subtest rcs0: SUCCESS (0.019s)
[304.572020] Starting dynamic subtest: bcs0
[304.581701] Dynamic subtest bcs0: SUCCESS (0.019s)
[304.593630] Starting dynamic subtest: vcs0
[304.601548] Dynamic subtest vcs0: SUCCESS (0.020s)
[304.610679] Starting dynamic subtest: vcs1
[304.622257] Dynamic subtest vcs1: SUCCESS (0.020s)
[304.631364] Starting dynamic subtest: vecs0
[304.642605] Dynamic subtest vecs0: SUCCESS (0.020s)
[304.652187] Starting dynamic subtest: ccs0
[304.664054] Dynamic subtest ccs0: SUCCESS (0.021s)
[304.666297] Subtest timeslicing: SUCCESS (0.122s)
[306.375568] [031/133] (727s left) kms_vblank (wait-forked-hang)
[306.475654] Starting subtest: wait-forked-hang
[306.477759] Starting dynamic subtest: pipe-A-eDP-1
[333.169208] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.693s)
[333.183581] Starting dynamic subtest: pipe-D-eDP-1
[358.111892] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.936s)
[358.114454] Subtest wait-forked-hang: SUCCESS (51.634s)
[358.983039] [032/133] (675s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[359.094629] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[359.098916] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[359.197114] [033/133] (674s left) i915_pm_freq_mult (media-freq)
[359.260204] Starting subtest: media-freq
[359.262139] Starting dynamic subtest: gt0
[359.266248] Dynamic subtest gt0: SKIP (0.000s)
[359.277284] Starting dynamic subtest: gt1
[359.281280] Dynamic subtest gt1: SKIP (0.000s)
[359.285244] Subtest media-freq: SKIP (0.001s)
[359.361258] [034/133] (674s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[359.465403] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[359.467330] Starting dynamic subtest: pipe-A-eDP-1
[360.825131] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.360s)
[361.106691] Starting dynamic subtest: pipe-B-eDP-1
[362.146690] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[362.420120] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.956s)
[363.256465] [035/133] (670s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[363.319372] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[363.381456] [036/133] (670s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[363.475168] Starting subtest: 4-tiled-16bpp-rotate-180
[364.878275] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.405s)
[365.001509] [037/133] (669s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[365.119421] Starting subtest: basic-busy-flip-before-cursor-legacy
[365.123216] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[365.266728] [038/133] (669s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[365.321758] Starting subtest: y-tiled-ccs-to-x-tiled
[365.326069] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[365.505487] [039/133] (668s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[365.609119] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[366.620572] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[366.768382] [040/133] (667s left) perf (global-sseu-config)
[366.913239] Starting subtest: global-sseu-config
[366.916691] Subtest global-sseu-config: SKIP (0.000s)
[366.955670] [041/133] (667s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[367.049540] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[367.051417] Starting dynamic subtest: pipe-A-eDP-1
[367.567834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.493s)
[367.579624] Starting dynamic subtest: pipe-B-eDP-1
[369.043687] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s)
[369.054185] Starting dynamic subtest: pipe-C-eDP-1
[370.494998] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.450s)
[370.505974] Starting dynamic subtest: pipe-D-eDP-1
[371.934817] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.440s)
[371.936717] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.858s)
[373.091626] [042/133] (661s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[373.189165] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[373.193645] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[373.263049] [043/133] (661s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[373.349909] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[373.354440] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[374.515861] [044/133] (660s left) kms_cursor_crc (cursor-size-change)
[374.605121] Starting subtest: cursor-size-change
[374.607395] Starting dynamic subtest: pipe-A-eDP-1
[375.403080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s)
[375.414234] Starting dynamic subtest: pipe-D-eDP-1
[376.886462] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.482s)
[376.888892] Subtest cursor-size-change: SUCCESS (2.283s)
[377.705279] [045/133] (656s left) syncobj_timeline (transfer-timeline-point)
[377.751810] Starting subtest: transfer-timeline-point
[377.754039] Subtest transfer-timeline-point: SUCCESS (0.000s)
[377.872373] [046/133] (656s left) gen9_exec_parse (bb-oversize)
[377.934793] Subtest bb-oversize: SKIP (0.000s)
[378.011769] [047/133] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[378.104602] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[378.108716] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[378.201400] [048/133] (656s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[378.298939] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[378.303045] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[378.377939] [049/133] (656s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[378.429601] Starting subtest: yf-tiled-to-vebox-y-tiled
[378.434192] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[378.626994] [050/133] (656s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[378.937756] Starting subtest: cursor-rapid-movement-512x170
[378.942311] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[379.117337] [051/133] (655s left) prime_self_import (basic-with_one_bo)
[379.156027] Starting subtest: basic-with_one_bo
[379.172067] Subtest basic-with_one_bo: SUCCESS (0.019s)
[379.285809] [052/133] (655s left) kms_pm_backlight (bad-brightness)
[379.379472] Starting subtest: bad-brightness
[379.426793] Starting dynamic subtest: eDP-1
[379.744354] Dynamic subtest eDP-1: SUCCESS (0.316s)
[379.746776] Subtest bad-brightness: SUCCESS (0.366s)
[380.633111] [053/133] (654s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[380.726878] Starting subtest: psr-dirtyfb-ioctl
[380.729422] Starting dynamic subtest: A-eDP-1
[384.642079] Dynamic subtest A-eDP-1: SUCCESS (3.917s)
[384.644495] Subtest psr-dirtyfb-ioctl: SUCCESS (3.918s)
[385.509503] [054/133] (649s left) gem_exec_balancer (hog)
[385.586989] Starting subtest: hog
[385.591445] Subtest hog: SKIP (0.000s)
[385.885402] [055/133] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[385.992783] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[385.996938] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[386.079267] [056/133] (649s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[386.169255] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[386.171592] Starting dynamic subtest: pipe-A-eDP-1
[386.194064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[386.206174] Starting dynamic subtest: pipe-B-eDP-1
[386.227676] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[386.237326] Starting dynamic subtest: pipe-C-eDP-1
[386.258822] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[386.268434] Starting dynamic subtest: pipe-D-eDP-1
[386.290150] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[386.294572] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[388.485835] [057/133] (646s left) syncobj_wait (multi-wait-all-submitted)
[388.545271] Starting subtest: multi-wait-all-submitted
[388.651068] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[388.740772] [058/133] (646s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[388.861737] Starting subtest: 2x-cursor-vs-flip-legacy
[388.866752] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[389.012200] [059/133] (646s left) kms_psr (pr-primary-render)
[389.095072] Starting subtest: pr-primary-render
[389.098919] Subtest pr-primary-render: SKIP (0.000s)
[389.184854] [060/133] (646s left) gem_workarounds (reset-context)
[389.268672] Starting subtest: reset-context
[389.455389] Subtest reset-context: SUCCESS (0.187s)
[389.583442] [061/133] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[389.682922] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[389.686477] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[389.785255] [062/133] (645s left) kms_psr (fbc-psr2-sprite-blt)
[389.874923] Starting subtest: fbc-psr2-sprite-blt
[389.876877] Starting dynamic subtest: eDP-1
[389.880322] Dynamic subtest eDP-1: SKIP (0.000s)
[389.883771] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[389.949062] [063/133] (645s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[390.045960] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[390.706542] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.661s)
[390.880985] [064/133] (644s left) kms_psr (fbc-pr-primary-mmap-cpu)
[390.963314] Starting subtest: fbc-pr-primary-mmap-cpu
[390.967561] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[391.050987] [065/133] (644s left) gem_exec_schedule (fifo)
[391.128651] Starting subtest: fifo
[391.130987] Starting dynamic subtest: rcs0
[391.217733] Dynamic subtest rcs0: SUCCESS (0.098s)
[391.230010] Starting dynamic subtest: vcs0
[391.295044] Dynamic subtest vcs0: SUCCESS (0.077s)
[391.309126] Starting dynamic subtest: vcs1
[391.373995] Dynamic subtest vcs1: SUCCESS (0.078s)
[391.384198] Starting dynamic subtest: vecs0
[391.455880] Dynamic subtest vecs0: SUCCESS (0.081s)
[391.469047] Starting dynamic subtest: ccs0
[391.551940] Dynamic subtest ccs0: SUCCESS (0.094s)
[391.554964] Subtest fifo: SUCCESS (0.432s)
[392.456328] [066/133] (643s left) gem_ctx_persistence (heartbeat-stop)
[392.516442] Starting subtest: heartbeat-stop
[392.521132] Subtest heartbeat-stop: SKIP (0.000s)
[392.628133] [067/133] (643s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[392.733512] Starting subtest: pr-cursor-plane-update-sf
[392.737482] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[392.802933] [068/133] (642s left) kms_busy (extended-modeset-hang-newfb)
[392.910303] Starting subtest: extended-modeset-hang-newfb
[392.912593] Starting dynamic subtest: pipe-A
[427.262107] Dynamic subtest pipe-A: SUCCESS (34.350s)
[427.272474] Starting dynamic subtest: pipe-D
[450.317498] Dynamic subtest pipe-D: SUCCESS (23.053s)
[450.319861] Subtest extended-modeset-hang-newfb: SUCCESS (57.407s)
[451.201935] [069/133] (584s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[451.297201] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[451.301647] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[451.396180] [070/133] (584s left) api_intel_bb (object-reloc-purge-cache)
[451.440903] Starting subtest: object-reloc-purge-cache
[451.445595] Subtest object-reloc-purge-cache: SKIP (0.003s)
[451.589440] [071/133] (584s left) core_setmaster (master-drop-set-root)
[451.652543] Starting subtest: master-drop-set-root
[451.665510] Subtest master-drop-set-root: SUCCESS (0.013s)
[451.717128] [072/133] (584s left) gem_exec_reloc (basic-gtt-cpu-active)
[451.781140] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[451.848227] [073/133] (584s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[451.964048] Starting subtest: cursor-vs-flip-atomic
[481.669214] Subtest cursor-vs-flip-atomic: SUCCESS (29.700s)
[482.529367] [074/133] (553s left) kms_flip (flip-vs-wf_vblank-interruptible)
[482.637900] Starting subtest: flip-vs-wf_vblank-interruptible
[482.640498] Starting dynamic subtest: A-eDP1
[484.572291] Dynamic subtest A-eDP1: SUCCESS (1.932s)
[484.586168] Starting dynamic subtest: B-eDP1
[486.506894] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[486.519855] Starting dynamic subtest: C-eDP1
[488.431078] Dynamic subtest C-eDP1: SUCCESS (1.921s)
[488.444149] Starting dynamic subtest: D-eDP1
[490.360819] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[490.365754] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.726s)
[491.598684] [075/133] (544s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[491.697904] Starting subtest: x-tiled-8bpp-rotate-180
[492.966612] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.269s)
[493.080152] [076/133] (542s left) i915_drm_fdinfo (basics)
[493.119219] Starting subtest: basics
[493.121260] Subtest basics: SUCCESS (0.000s)
[493.188658] [077/133] (542s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[493.295748] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[493.299475] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[493.378022] [078/133] (542s left) api_intel_allocator (alloc-simple)
[493.432887] Starting subtest: alloc-simple
[493.437153] Subtest alloc-simple: SUCCESS (0.004s)
[493.562756] [079/133] (542s left) sysfs_preempt_timeout (idempotent)
[493.624384] Starting subtest: idempotent
[493.626231] Starting dynamic subtest: vecs0
[493.627989] Dynamic subtest vecs0: SUCCESS (0.000s)
[493.638081] Starting dynamic subtest: ccs0
[493.639759] Dynamic subtest ccs0: SUCCESS (0.000s)
[493.649116] Starting dynamic subtest: vcs0
[493.650854] Dynamic subtest vcs0: SUCCESS (0.000s)
[493.660111] Starting dynamic subtest: bcs0
[493.661834] Dynamic subtest bcs0: SUCCESS (0.000s)
[493.671543] Starting dynamic subtest: rcs0
[493.673084] Dynamic subtest rcs0: SUCCESS (0.000s)
[493.682317] Starting dynamic subtest: vcs1
[493.684063] Dynamic subtest vcs1: SUCCESS (0.000s)
[493.685760] Subtest idempotent: SUCCESS (0.007s)
[493.727837] [080/133] (542s left) gem_exec_whisper (basic-queues-forked)
[493.799068] Starting subtest: basic-queues-forked
[518.288860] Subtest basic-queues-forked: SUCCESS (24.483s)
[518.482154] [081/133] (517s left) gem_userptr_blits (nohangcheck)
[518.554968] Starting subtest: nohangcheck
[518.904438] Subtest nohangcheck: SUCCESS (0.346s)
[519.025161] [082/133] (517s left) perf (blocking)
[519.110971] Starting subtest: blocking
[519.113240] Starting dynamic subtest: 0-rcs0
[529.151551] Dynamic subtest 0-rcs0: SUCCESS (10.037s)
[529.163266] Starting dynamic subtest: 1-vcs0
[539.171726] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[539.174248] Subtest blocking: SUCCESS (20.059s)
[539.223305] [083/133] (497s left) gem_exec_schedule (preempt-queue-contexts-chain)
[539.307907] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[539.604785] [084/133] (496s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[539.702355] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[539.706848] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[539.810665] [085/133] (496s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[539.900314] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[547.035401] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.139s)
[547.147406] [086/133] (489s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[547.195574] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[547.298390] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[547.391505] [087/133] (489s left) gem_pwrite (basic-exhaustion)
[547.450934] Subtest basic-exhaustion: SKIP (0.000s)
[547.515051] [088/133] (489s left) kms_dsc (dsc-with-output-formats)
[547.610259] Starting subtest: dsc-with-output-formats
[547.632202] Subtest dsc-with-output-formats: SKIP (0.000s)
[547.684290] [089/133] (488s left) kms_addfb_basic (invalid-set-prop)
[547.747561] Starting subtest: invalid-set-prop
[547.749823] Subtest invalid-set-prop: SUCCESS (0.000s)
[547.886800] [090/133] (488s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[547.983064] Starting subtest: plane-all-modeset-transition-fencing
[547.987294] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[548.058284] [091/133] (488s left) kms_big_fb (y-tiled-addfb)
[548.155092] Starting subtest: y-tiled-addfb
[548.159542] Subtest y-tiled-addfb: SKIP (0.000s)
[548.262223] [092/133] (488s left) prime_busy (after)
[548.324298] Starting subtest: after
[548.329265] Starting dynamic subtest: rcs0
[548.361541] Dynamic subtest rcs0: SUCCESS (0.032s)
[548.373525] Starting dynamic subtest: bcs0
[548.416495] Dynamic subtest bcs0: SUCCESS (0.055s)
[548.427816] Starting dynamic subtest: vcs0
[548.457641] Dynamic subtest vcs0: SUCCESS (0.040s)
[548.467863] Starting dynamic subtest: vcs1
[548.498880] Dynamic subtest vcs1: SUCCESS (0.041s)
[548.508861] Starting dynamic subtest: vecs0
[548.539457] Dynamic subtest vecs0: SUCCESS (0.040s)
[548.549494] Starting dynamic subtest: ccs0
[548.579886] Dynamic subtest ccs0: SUCCESS (0.040s)
[548.689700] Subtest after: SUCCESS (0.363s)
[548.794263] [093/133] (487s left) gem_mmap_gtt (big-bo)
[548.847842] Subtest big-bo: SKIP (0.000s)
[548.903401] [094/133] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[549.010636] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[556.140394] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.133s)
[556.249354] [095/133] (480s left) fbdev (info)
[556.291271] Starting subtest: info
[556.293170] Subtest info: SUCCESS (0.000s)
[556.365509] [096/133] (480s left) gem_ctx_isolation (nonpriv)
[556.419107] Starting subtest: nonpriv
[556.421411] Starting dynamic subtest: rcs0
[556.654231] Dynamic subtest rcs0: SUCCESS (0.235s)
[556.668827] Starting dynamic subtest: bcs0
[556.914845] Dynamic subtest bcs0: SUCCESS (0.260s)
[556.925338] Starting dynamic subtest: vcs0
[557.181961] Dynamic subtest vcs0: SUCCESS (0.266s)
[557.192472] Starting dynamic subtest: vcs1
[558.516507] Dynamic subtest vcs1: SUCCESS (1.333s)
[558.526900] Starting dynamic subtest: vecs0
[560.591367] Dynamic subtest vecs0: SUCCESS (2.074s)
[560.601912] Starting dynamic subtest: ccs0
[562.610389] Dynamic subtest ccs0: SUCCESS (2.018s)
[562.612718] Subtest nonpriv: SUCCESS (6.192s)
[562.855178] [097/133] (474s left) kms_addfb_basic (too-high)
[562.946231] Starting subtest: too-high
[562.948176] Subtest too-high: SUCCESS (0.001s)
[563.045270] [098/133] (473s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[563.142615] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[572.685877] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.544s)
[572.814624] [099/133] (464s left) syncobj_timeline (invalid-transfer-bad-pad)
[572.864392] Starting subtest: invalid-transfer-bad-pad
[572.866759] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[572.958400] [100/133] (464s left) kms_async_flips (async-flip-hang)
[573.046996] Starting subtest: async-flip-hang
[573.433330] Starting dynamic subtest: pipe-A-eDP-1
[599.805279] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.367s)
[600.210994] Starting dynamic subtest: pipe-B-eDP-1
[615.869071] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.666s)
[616.253347] Starting dynamic subtest: pipe-C-eDP-1
[631.863755] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.617s)
[632.240849] Starting dynamic subtest: pipe-D-eDP-1
[647.801839] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.570s)
[647.804353] Subtest async-flip-hang: SUCCESS (74.753s)
[648.990196] [101/133] (388s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[649.094556] Starting subtest: multiplane-rotation-cropping-bottom
[666.586731] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.494s)
[666.713607] [102/133] (370s left) syncobj_timeline (multi-wait-available-submitted)
[666.781793] Starting subtest: multi-wait-available-submitted
[666.784106] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[666.901462] [103/133] (370s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[667.000638] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[673.940426] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.941s)
[674.079433] [104/133] (363s left) i915_pm_rps (thresholds-idle)
[674.143659] Starting subtest: thresholds-idle
[674.147938] Subtest thresholds-idle: SKIP (0.000s)
[674.249954] [105/133] (363s left) kms_pm_dc (dc3co-vpb-simulation)
[675.348245] Starting subtest: dc3co-vpb-simulation
[683.940271] Subtest dc3co-vpb-simulation: SKIP (8.589s)
[684.074329] [106/133] (353s left) kms_scaling_modes (scaling-mode-none)
[684.178173] Starting subtest: scaling-mode-none
[684.180520] Starting dynamic subtest: pipe-A-eDP-1
[684.270916] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s)
[684.284591] Starting dynamic subtest: pipe-B-eDP-1
[684.305729] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s)
[684.319237] Starting dynamic subtest: pipe-C-eDP-1
[684.339950] Dynamic subtest pipe-C-eDP-1: SKIP (0.033s)
[684.354024] Starting dynamic subtest: pipe-D-eDP-1
[684.376366] Dynamic subtest pipe-D-eDP-1: SKIP (0.036s)
[684.380527] Subtest scaling-mode-none: SKIP (0.199s)
[684.495973] [107/133] (352s left) gem_ctx_shared (q-promotion)
[684.550365] Starting subtest: Q-promotion
[684.552681] Starting dynamic subtest: rcs0
[684.662932] Dynamic subtest rcs0: SUCCESS (0.111s)
[684.675967] Starting dynamic subtest: vcs0
[684.762801] Dynamic subtest vcs0: SUCCESS (0.100s)
[684.777778] Starting dynamic subtest: vcs1
[684.853659] Dynamic subtest vcs1: SUCCESS (0.089s)
[684.871249] Starting dynamic subtest: vecs0
[684.940520] Dynamic subtest vecs0: SUCCESS (0.086s)
[684.956262] Starting dynamic subtest: ccs0
[685.038322] Dynamic subtest ccs0: SUCCESS (0.095s)
[685.040923] Subtest Q-promotion: SUCCESS (0.488s)
[686.379579] [108/133] (351s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[686.482616] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[690.852397] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.372s)
[692.054673] [109/133] (345s left) gem_caching (writes)
[692.117834] Subtest writes: SKIP (0.000s)
[692.185712] [110/133] (345s left) kms_hdr (static-toggle-dpms)
[692.271057] Starting subtest: static-toggle-dpms
[692.277572] Subtest static-toggle-dpms: SKIP (0.000s)
[692.347522] [111/133] (345s left) kms_plane_alpha_blend (alpha-transparent-fb)
[692.431308] Starting subtest: alpha-transparent-fb
[692.720547] Starting dynamic subtest: pipe-A-eDP-1
[693.354554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[693.365855] Starting dynamic subtest: pipe-D-eDP-1
[694.732465] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.376s)
[694.734901] Subtest alpha-transparent-fb: SUCCESS (2.303s)
[695.616938] [112/133] (342s left) gem_mmap_gtt (hang-busy)
[695.701276] Subtest hang-busy: SKIP (0.000s)
[695.800795] [113/133] (341s left) kms_flip (basic-flip-vs-modeset)
[695.907270] Starting subtest: basic-flip-vs-modeset
[695.909496] Starting dynamic subtest: A-eDP1
[698.481901] Dynamic subtest A-eDP1: SUCCESS (2.573s)
[698.493936] Starting dynamic subtest: B-eDP1
[700.664929] Dynamic subtest B-eDP1: SUCCESS (2.180s)
[700.677687] Starting dynamic subtest: C-eDP1
[702.847410] Dynamic subtest C-eDP1: SUCCESS (2.180s)
[702.860079] Starting dynamic subtest: D-eDP1
[705.038361] Dynamic subtest D-eDP1: SUCCESS (2.191s)
[705.040690] Subtest basic-flip-vs-modeset: SUCCESS (9.132s)
[705.846100] [114/133] (331s left) kms_plane (pixel-format-x-tiled-modifier)
[705.953131] Starting subtest: pixel-format-x-tiled-modifier
[705.979575] Starting dynamic subtest: pipe-A-plane-0
[706.378777] Dynamic subtest pipe-A-plane-0: SUCCESS (0.399s)
[706.389495] Starting dynamic subtest: pipe-A-plane-3
[706.700925] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s)
[706.711604] Starting dynamic subtest: pipe-A-plane-5
[706.716156] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[707.854214] Starting dynamic subtest: pipe-B-plane-0
[708.250589] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[708.262069] Starting dynamic subtest: pipe-B-plane-3
[708.584819] Dynamic subtest pipe-B-plane-3: SUCCESS (0.332s)
[708.596248] Starting dynamic subtest: pipe-B-plane-5
[708.600800] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[708.893727] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.943s)
[709.722787] [115/133] (328s left) gem_ccs (suspend-resume)
[709.789707] Starting subtest: suspend-resume
[709.793990] Subtest suspend-resume: SKIP (0.000s)
[709.911603] [116/133] (327s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[710.006109] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[710.010653] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[710.114820] [117/133] (327s left) syncobj_basic (create-signaled)
[710.159996] Starting subtest: create-signaled
[710.162209] Subtest create-signaled: SUCCESS (0.000s)
[710.256926] [118/133] (327s left) gem_exec_whisper (basic-normal-all)
[710.314514] Starting subtest: basic-normal-all
[712.606512] Subtest basic-normal-all: SUCCESS (2.289s)
[712.792999] [119/133] (325s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[712.893154] Starting subtest: plane-downscale-factor-0-5-with-rotation
[712.895400] Starting dynamic subtest: pipe-A
[712.914619] Dynamic subtest pipe-A: SKIP (0.016s)
[712.925215] Starting dynamic subtest: pipe-B
[712.946422] Dynamic subtest pipe-B: SKIP (0.030s)
[712.959377] Starting dynamic subtest: pipe-C
[712.976954] Dynamic subtest pipe-C: SKIP (0.031s)
[712.987279] Starting dynamic subtest: pipe-D
[713.007589] Dynamic subtest pipe-D: SKIP (0.031s)
[713.011364] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.112s)
[713.106347] [120/133] (324s left) kms_pm_rpm (universal-planes-dpms)
[714.640111] Starting subtest: universal-planes-dpms
[714.642265] Starting dynamic subtest: plane-35
[722.961758] Dynamic subtest plane-35: SUCCESS (8.324s)
[722.977814] Starting dynamic subtest: plane-65
[731.391911] Dynamic subtest plane-65: SUCCESS (8.427s)
[731.404681] Starting dynamic subtest: plane-95
[739.716027] Dynamic subtest plane-95: SUCCESS (8.321s)
[739.729186] Starting dynamic subtest: plane-125
[748.154039] Dynamic subtest plane-125: SUCCESS (8.434s)
[748.170539] Starting dynamic subtest: plane-135
[756.501831] Dynamic subtest plane-135: SUCCESS (8.346s)
[756.514808] Starting dynamic subtest: plane-145
[764.814047] Dynamic subtest plane-145: SUCCESS (8.308s)
[764.817218] Subtest universal-planes-dpms: SUCCESS (50.177s)
[765.208116] [121/133] (272s left) kms_content_protection (type1)
[765.355041] Starting subtest: type1
[765.359709] Subtest type1: SKIP (0.000s)
[765.475670] [122/133] (272s left) kms_chamelium_hpd (hdmi-hpd-fast)
[765.868820] Subtest hdmi-hpd-fast: SKIP (0.000s)
[766.707244] [123/133] (271s left) prime_self_import (basic-llseek-bad)
[766.745172] Starting subtest: basic-llseek-bad
[766.766449] Subtest basic-llseek-bad: SUCCESS (0.023s)
[766.881856] [124/133] (271s left) kms_big_fb (linear-8bpp-rotate-270)
[766.975841] Starting subtest: linear-8bpp-rotate-270
[766.996039] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[767.125128] [125/133] (271s left) kms_vblank (crtc-id)
[767.231075] Starting subtest: crtc-id
[767.233351] Starting dynamic subtest: pipe-A-eDP-1
[767.680588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[767.695990] Starting dynamic subtest: pipe-D-eDP-1
[768.873588] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.191s)
[768.875718] Subtest crtc-id: SUCCESS (1.643s)
[769.690825] [126/133] (268s left) kms_properties (plane-properties-atomic)
[769.801023] Starting subtest: plane-properties-atomic
[769.803138] Starting dynamic subtest: pipe-A-eDP-1
[770.338682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.536s)
[770.349529] Starting dynamic subtest: pipe-B-eDP-1
[771.652834] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.311s)
[771.663793] Starting dynamic subtest: pipe-C-eDP-1
[772.889606] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[772.902031] Starting dynamic subtest: pipe-D-eDP-1
[774.124324] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[774.126692] Subtest plane-properties-atomic: SUCCESS (4.325s)
[774.931452] [127/133] (263s left) gem_exec_reloc (basic-wc-active)
[774.987640] Subtest basic-wc-active: SKIP (0.000s)
[775.062435] [128/133] (263s left) kms_psr (psr-cursor-plane-onoff)
[775.146279] Starting subtest: psr-cursor-plane-onoff
[775.148591] Starting dynamic subtest: eDP-1
[776.924297] Dynamic subtest eDP-1: SUCCESS (1.777s)
[776.926575] Subtest psr-cursor-plane-onoff: SUCCESS (1.778s)
[777.794694] [129/133] (260s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[777.895884] Starting subtest: psr-rgb565-draw-render
[785.022270] Subtest psr-rgb565-draw-render: SUCCESS (7.130s)
[785.150696] [130/133] (253s left) kms_atomic_interruptible (legacy-dpms)
[785.241217] Starting subtest: legacy-dpms
[785.243530] Starting dynamic subtest: pipe-A-eDP-1
[792.648484] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.406s)
[792.650826] Subtest legacy-dpms: SUCCESS (7.407s)
[793.500427] [131/133] (244s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[793.595186] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[793.599186] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[793.707520] [132/133] (244s left) kms_frontbuffer_tracking (psr-1p-rte)
[793.803705] Starting subtest: psr-1p-rte
[799.160074] Subtest psr-1p-rte: SUCCESS (5.362s)
[799.287774] [133/133] (239s left) gem_media_vme
[799.406627] Closing watchdogs
results: parsing output: 0/ for test: kms_color_pipeline
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: i915_pm_rps
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_chamelium_color
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_prop_blob
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_chamelium_frames
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: prime_mmap
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_create
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_plane_lowres
results: parsing output: 26/ for test: gem_exec_create
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_vblank
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_freq_mult
results: parsing output: 33/ for test: kms_atomic_transition
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gen9_exec_parse
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: prime_self_import
results: parsing output: 51/ for test: kms_pm_backlight
results: parsing output: 52/ for test: kms_dirtyfb
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_workarounds
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_busy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: core_setmaster
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: i915_drm_fdinfo
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: sysfs_preempt_timeout
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_pwrite
results: parsing output: 87/ for test: kms_dsc
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_atomic_transition
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: prime_busy
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: fbdev
results: parsing output: 95/ for test: gem_ctx_isolation
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_async_flips
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: kms_pm_dc
results: parsing output: 105/ for test: kms_scaling_modes
results: parsing output: 106/ for test: gem_ctx_shared
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_caching
results: parsing output: 109/ for test: kms_hdr
results: parsing output: 110/ for test: kms_plane_alpha_blend
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: gem_ccs
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_basic
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_pm_rpm
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: kms_chamelium_hpd
results: parsing output: 122/ for test: prime_self_import
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_atomic_interruptible
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_media_vme
Done.