[39.753659] Initializing watchdogs
[39.753867]   /dev/watchdog0
[39.771219] [001/142] (960s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[40.658432] Starting subtest: syncobj-timeline-multiple-ext-nodes
[40.663222] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[40.887376] [002/142] (959s left) kms_busy (extended-pageflip-hang-newfb)
[41.150794] Starting subtest: extended-pageflip-hang-newfb
[41.152446] Starting dynamic subtest: pipe-A
[45.037630] Dynamic subtest pipe-A: SUCCESS (3.882s)
[45.052453] Starting dynamic subtest: pipe-C
[49.058313] Dynamic subtest pipe-C: SUCCESS (4.019s)
[49.061020] Subtest extended-pageflip-hang-newfb: SUCCESS (7.910s)
[49.404033] [003/142] (950s left) kms_hdr (static-toggle-dpms)
[49.644893] Starting subtest: static-toggle-dpms
[49.647484] Subtest static-toggle-dpms: SKIP (0.000s)
[49.720702] [004/142] (950s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[49.969273] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[49.972082] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[50.051788] [005/142] (950s left) sysfs_preempt_timeout (invalid)
[50.202815] Starting subtest: invalid
[50.204388] Starting dynamic subtest: vecs0
[50.205894] Dynamic subtest vecs0: SUCCESS (0.001s)
[50.220862] Starting dynamic subtest: vcs0
[50.222215] Dynamic subtest vcs0: SUCCESS (0.001s)
[50.236523] Starting dynamic subtest: bcs0
[50.237844] Dynamic subtest bcs0: SUCCESS (0.001s)
[50.251908] Starting dynamic subtest: rcs0
[50.253296] Dynamic subtest rcs0: SUCCESS (0.001s)
[50.254739] Subtest invalid: SUCCESS (0.007s)
[50.285228] [006/142] (950s left) gem_exec_fence (submit-chain)
[50.586297] Starting subtest: submit-chain
[50.614085] Subtest submit-chain: SUCCESS (0.028s)
[51.285296] [007/142] (949s left) syncobj_wait (wait-all-complex)
[51.430954] Starting subtest: wait-all-complex
[51.647705] Subtest wait-all-complex: SUCCESS (0.217s)
[51.734788] [008/142] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[51.984149] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[51.986659] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[52.068556] [009/142] (948s left) kms_flip (flip-vs-modeset-vs-hang)
[52.292166] Starting subtest: flip-vs-modeset-vs-hang
[52.293764] Starting dynamic subtest: A-DP1
[66.903098] Dynamic subtest A-DP1: SUCCESS (14.609s)
[66.917477] Starting dynamic subtest: C-DP1
[80.916845] Dynamic subtest C-DP1: SUCCESS (14.015s)
[80.918221] Subtest flip-vs-modeset-vs-hang: SUCCESS (28.629s)
[81.292845] [010/142] (919s left) gem_exec_schedule (u-lateslice)
[81.470818] Starting subtest: u-lateslice
[81.472320] Starting dynamic subtest: rcs0
[81.510710] Dynamic subtest rcs0: SUCCESS (0.039s)
[81.526932] Starting dynamic subtest: bcs0
[81.548390] Dynamic subtest bcs0: SUCCESS (0.037s)
[81.564726] Starting dynamic subtest: vcs0
[81.579509] Dynamic subtest vcs0: SUCCESS (0.031s)
[81.595880] Starting dynamic subtest: vecs0
[81.612739] Dynamic subtest vecs0: SUCCESS (0.032s)
[81.614122] Subtest u-lateslice: SUCCESS (0.142s)
[81.974418] [011/142] (918s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[82.218573] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[82.221064] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[82.307887] [012/142] (918s left) gen9_exec_parse (cmd-crossing-page)
[82.476092] Starting subtest: cmd-crossing-page
[82.485330] Subtest cmd-crossing-page: SUCCESS (0.009s)
[82.708073] [013/142] (917s left) gem_create (create-invalid-size)
[82.847812] Starting subtest: create-invalid-size
[82.849184] Subtest create-invalid-size: SUCCESS (0.000s)
[83.056515] [014/142] (917s left) api_intel_bb (intel-bb-blit-y)
[83.198818] Starting subtest: intel-bb-blit-y
[86.486264] Subtest intel-bb-blit-y: SUCCESS (3.286s)
[86.589624] [015/142] (914s left) gem_userptr_blits (unsync-unmap-after-close)
[86.742158] Subtest unsync-unmap-after-close: SKIP (0.000s)
[86.907064] [016/142] (913s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[87.159467] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[87.161954] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[87.257589] [017/142] (913s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[87.733281] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[88.045166] [018/142] (912s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[88.292626] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[90.495961] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.206s)
[90.646738] [019/142] (910s left) kms_ccs (pipe-b-crc-primary-basic-yf_tiled_ccs)
[91.031193] Starting subtest: pipe-B-crc-primary-basic-yf_tiled_ccs
[91.692510] Subtest pipe-B-crc-primary-basic-yf_tiled_ccs: SUCCESS (0.661s)
[92.187988] [020/142] (908s left) kms_cursor_crc (cursor-random-64x21)
[92.438065] Starting subtest: cursor-random-64x21
[92.447935] Starting dynamic subtest: pipe-A-DP-1
[96.249688] Dynamic subtest pipe-A-DP-1: SUCCESS (3.803s)
[96.342609] Starting dynamic subtest: pipe-C-DP-1
[100.238358] Dynamic subtest pipe-C-DP-1: SUCCESS (3.911s)
[100.239701] Subtest cursor-random-64x21: SUCCESS (7.801s)
[100.604775] [021/142] (900s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[100.748370] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[100.854104] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[100.934705] [022/142] (900s left) gem_exec_reloc (basic-write-gtt)
[101.085774] Starting subtest: basic-write-gtt
[101.105541] Subtest basic-write-gtt: SUCCESS (0.020s)
[101.284781] [023/142] (899s left) v3d/v3d_wait_bo (used-bo)
[101.486166] Subtest used-bo: SKIP (0.000s)
[101.549146] [024/142] (899s left) gem_exec_reloc (basic-range)
[101.696969] Starting subtest: basic-range
[101.776151] Subtest basic-range: SUCCESS (0.078s)
[101.950385] [025/142] (899s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[102.088782] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[102.135295] [026/142] (899s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[102.446408] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[102.733064] [027/142] (898s left) gem_softpin (reverse)
[102.883408] Starting subtest: reverse
[102.903304] Subtest reverse: SUCCESS (0.020s)
[103.010947] [028/142] (898s left) gem_exec_balancer (bonded-false-hang)
[106.990620] Starting subtest: bonded-false-hang
[110.580623] Subtest bonded-false-hang: SUCCESS (3.590s)
[110.663598] [029/142] (890s left) i915_pm_rpm (fences)
[112.478726] Starting subtest: fences
[115.359749] Subtest fences: SUCCESS (2.880s)
[115.542051] [030/142] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[115.789171] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[115.791851] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[115.892029] [031/142] (885s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs)
[116.222696] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs
[116.682888] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SUCCESS (0.459s)
[117.230038] [032/142] (884s left) syncobj_wait (single-wait-for-submit-signaled)
[117.371484] Starting subtest: single-wait-for-submit-signaled
[117.373095] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[117.460651] [033/142] (883s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[117.941037] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[118.248092] [034/142] (883s left) kms_vblank (pipe-d-ts-continuation-suspend)
[118.488500] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s)
[118.561890] [035/142] (882s left) gem_ctx_persistence (heartbeat-many)
[118.709152] Starting subtest: heartbeat-many
[119.281735] Subtest heartbeat-many: SUCCESS (0.572s)
[119.362908] [036/142] (882s left) i915_selftest (live)
[120.901742] Starting subtest: live
[120.903312] Starting dynamic subtest: sanitycheck
[122.300143] Dynamic subtest sanitycheck: SUCCESS (1.397s)
[122.312465] Starting dynamic subtest: uncore
[123.448579] Dynamic subtest uncore: SUCCESS (1.147s)
[123.460562] Starting dynamic subtest: workarounds
[124.831620] Dynamic subtest workarounds: SUCCESS (1.382s)
[124.843485] Starting dynamic subtest: gt_engines
[126.473392] Dynamic subtest gt_engines: SUCCESS (1.641s)
[126.486869] Starting dynamic subtest: gt_timelines
[142.728263] Dynamic subtest gt_timelines: SUCCESS (16.251s)
[142.740822] Starting dynamic subtest: gt_contexts
[144.033152] Dynamic subtest gt_contexts: SUCCESS (1.305s)
[144.045343] Starting dynamic subtest: gt_lrc
[147.993877] Dynamic subtest gt_lrc: SUCCESS (3.959s)
[148.006160] Starting dynamic subtest: gt_mocs
[149.422403] Dynamic subtest gt_mocs: SUCCESS (1.425s)
[149.434598] Starting dynamic subtest: gt_pm
[157.805023] Dynamic subtest gt_pm: SUCCESS (8.382s)
[157.818205] Starting dynamic subtest: gt_heartbeat
[159.059652] Dynamic subtest gt_heartbeat: SUCCESS (1.253s)
[159.073237] Starting dynamic subtest: gt_tlb
[161.085856] Dynamic subtest gt_tlb: SUCCESS (2.024s)
[161.099023] Starting dynamic subtest: requests
[168.708947] Dynamic subtest requests: SUCCESS (7.622s)
[168.721281] Starting dynamic subtest: migrate
[173.169102] Dynamic subtest migrate: SUCCESS (4.459s)
[173.181444] Starting dynamic subtest: active
[174.339249] Dynamic subtest active: SUCCESS (1.168s)
[174.352016] Starting dynamic subtest: objects
[178.260311] Dynamic subtest objects: SUCCESS (3.920s)
[178.272649] Starting dynamic subtest: mman
[186.731559] Dynamic subtest mman: SUCCESS (8.470s)
[186.743674] Starting dynamic subtest: dmabuf
[188.152327] Dynamic subtest dmabuf: SUCCESS (1.419s)
[188.164427] Starting dynamic subtest: vma
[189.333275] Dynamic subtest vma: SUCCESS (1.179s)
[189.346703] Starting dynamic subtest: coherency
[192.916937] Dynamic subtest coherency: SUCCESS (3.581s)
[192.930821] Starting dynamic subtest: gtt
[202.227393] Dynamic subtest gtt: SUCCESS (9.307s)
[202.241955] Starting dynamic subtest: gem
[203.766403] Dynamic subtest gem: SUCCESS (1.538s)
[203.780230] Starting dynamic subtest: evict
[208.036609] Dynamic subtest evict: SUCCESS (4.269s)
[208.049036] Starting dynamic subtest: hugepages
[215.119445] Dynamic subtest hugepages: SUCCESS (7.082s)
[215.133819] Starting dynamic subtest: gem_contexts
[235.033116] Dynamic subtest gem_contexts: SUCCESS (19.910s)
[235.045465] Starting dynamic subtest: client
[236.395376] Dynamic subtest client: SUCCESS (1.360s)
[236.407802] Starting dynamic subtest: gem_migrate
[237.572465] Dynamic subtest gem_migrate: SUCCESS (1.176s)
[237.586258] Starting dynamic subtest: reset
[244.121296] Dynamic subtest reset: SUCCESS (6.547s)
[244.133808] Starting dynamic subtest: memory_region
[245.442939] Dynamic subtest memory_region: SUCCESS (1.319s)
[245.455496] Starting dynamic subtest: hangcheck
[269.933437] Dynamic subtest hangcheck: SUCCESS (24.487s)
[269.948056] Starting dynamic subtest: execlists
[280.716269] Dynamic subtest execlists: SUCCESS (10.781s)
[280.730470] Starting dynamic subtest: ring_submission
[281.908910] Dynamic subtest ring_submission: SUCCESS (1.189s)
[281.922979] Starting dynamic subtest: perf
[283.499856] Dynamic subtest perf: SUCCESS (1.589s)
[283.513835] Starting dynamic subtest: slpc
[284.839338] Dynamic subtest slpc: SUCCESS (1.336s)
[284.853900] Starting dynamic subtest: guc
[286.098189] Dynamic subtest guc: SUCCESS (1.258s)
[286.126109] Starting dynamic subtest: guc_multi_lrc
[287.528715] Dynamic subtest guc_multi_lrc: SUCCESS (1.430s)
[287.542983] Starting dynamic subtest: guc_hang
[289.002266] Dynamic subtest guc_hang: SUCCESS (1.470s)
[289.017928] Starting dynamic subtest: late_gt_pm
[290.468991] Dynamic subtest late_gt_pm: SUCCESS (1.466s)
[290.470403] Subtest live: SUCCESS (169.567s)
[290.506283] [037/142] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[292.129648] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[292.133557] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[292.291385] [038/142] (709s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[292.591511] Starting subtest: modeset-atomic-cursor-hotspot
[292.594631] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[292.682614] [039/142] (708s left) gem_workarounds (basic-read)
[292.871197] Starting subtest: basic-read
[292.914078] Subtest basic-read: SUCCESS (0.042s)
[293.030576] [040/142] (708s left) fbdev (eof)
[293.183417] Starting subtest: eof
[293.185585] Subtest eof: SUCCESS (0.002s)
[293.249474] [041/142] (708s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[293.499882] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[313.028348] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (19.525s)
[313.360954] [042/142] (688s left) kms_cursor_crc (cursor-offscreen-512x170)
[313.628705] Starting subtest: cursor-offscreen-512x170
[313.634426] Subtest cursor-offscreen-512x170: SKIP (0.003s)
[313.724633] [043/142] (688s left) perf (blocking-parameterized)
[314.006103] Starting subtest: blocking-parameterized
[334.115839] Subtest blocking-parameterized: SUCCESS (20.107s)
[334.156912] [044/142] (667s left) kms_ccs (pipe-c-missing-ccs-buffer-yf_tiled_ccs)
[334.606323] Starting subtest: pipe-C-missing-ccs-buffer-yf_tiled_ccs
[334.609074] Subtest pipe-C-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[334.931734] [045/142] (666s left) gem_wait (write-busy)
[335.113300] Starting subtest: write-busy
[335.114967] Starting dynamic subtest: all-engines
[335.662251] Dynamic subtest all-engines: SUCCESS (0.547s)
[335.684605] Starting dynamic subtest: rcs0
[336.190461] Dynamic subtest rcs0: SUCCESS (0.524s)
[336.207568] Starting dynamic subtest: bcs0
[336.718852] Dynamic subtest bcs0: SUCCESS (0.527s)
[336.740925] Starting dynamic subtest: vcs0
[337.240489] Dynamic subtest vcs0: SUCCESS (0.519s)
[337.260221] Starting dynamic subtest: vecs0
[337.760440] Dynamic subtest vecs0: SUCCESS (0.517s)
[337.762200] Subtest write-busy: SUCCESS (2.649s)
[338.000798] [046/142] (663s left) kms_addfb_basic (bad-pitch-63)
[338.144025] Starting subtest: bad-pitch-63
[338.145500] Subtest bad-pitch-63: SUCCESS (0.000s)
[338.331953] [047/142] (663s left) syncobj_timeline (invalid-transfer-illegal-handle)
[338.473474] Starting subtest: invalid-transfer-illegal-handle
[338.475050] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[338.565829] [048/142] (663s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[338.783635] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[338.788151] Starting dynamic subtest: A-DP1
[340.062676] Dynamic subtest A-DP1: SUCCESS (1.274s)
[340.080346] Starting dynamic subtest: B-DP1
[341.183202] Dynamic subtest B-DP1: SUCCESS (1.119s)
[341.205201] Starting dynamic subtest: C-DP1
[342.315990] Dynamic subtest C-DP1: SUCCESS (1.125s)
[342.317306] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.531s)
[342.680525] [049/142] (659s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[342.926706] Starting subtest: psr-rgb565-draw-mmap-wc
[342.929347] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[343.023826] [050/142] (659s left) syncobj_timeline (invalid-wait-zero-handles)
[343.166513] Starting subtest: invalid-wait-zero-handles
[343.168239] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[343.257123] [051/142] (658s left) gem_madvise (dontneed-before-mmap)
[343.394654] Starting subtest: dontneed-before-mmap
[343.409339] Subtest dontneed-before-mmap: SUCCESS (0.014s)
[343.525159] [052/142] (658s left) kms_lease (lease_invalid_connector)
[343.762688] Starting subtest: lease_invalid_connector
[343.764233] Starting dynamic subtest: pipe-A-DP-1
[343.765489] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[343.785463] Starting dynamic subtest: pipe-B-DP-1
[343.786688] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[343.802520] Starting dynamic subtest: pipe-C-DP-1
[343.803913] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[343.805106] Subtest lease_invalid_connector: SUCCESS (0.012s)
[343.857578] [053/142] (658s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_mc_ccs)
[344.271300] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_mc_ccs
[344.274135] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[344.653149] [054/142] (657s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[344.892160] Starting subtest: cursorA-vs-flipB-varying-size
[344.894661] Subtest cursorA-vs-flipB-varying-size: SKIP (0.002s)
[344.985116] [055/142] (657s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[345.239666] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[345.242735] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[345.333850] [056/142] (656s left) kms_flip (plain-flip-fb-recreate)
[345.551962] Starting subtest: plain-flip-fb-recreate
[345.556175] Starting dynamic subtest: A-DP1
[356.373906] Dynamic subtest A-DP1: SUCCESS (10.817s)
[356.390409] Starting dynamic subtest: B-DP1
[367.119923] Dynamic subtest B-DP1: SUCCESS (10.745s)
[367.140391] Starting dynamic subtest: C-DP1
[377.851276] Dynamic subtest C-DP1: SUCCESS (10.726s)
[377.852719] Subtest plain-flip-fb-recreate: SUCCESS (32.301s)
[378.284704] [057/142] (624s left) gem_eio (context-create)
[378.463424] Starting subtest: context-create
[378.504753] Subtest context-create: SUCCESS (0.039s)
[378.711471] [058/142] (623s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-c)
[378.948834] Starting subtest: universal-plane-pageflip-windowed-pipe-C
[379.708327] Subtest universal-plane-pageflip-windowed-pipe-C: SUCCESS (0.762s)
[380.035146] [059/142] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[380.290067] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[380.292656] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[380.400178] [060/142] (622s left) gem_exec_reloc (basic-wc-read)
[380.551038] Starting subtest: basic-wc-read
[380.572819] Subtest basic-wc-read: SUCCESS (0.021s)
[380.767574] [061/142] (621s left) gem_exec_schedule (manyslice)
[380.937053] Starting subtest: manyslice
[380.938790] Starting dynamic subtest: rcs0
[382.599045] Dynamic subtest rcs0: SUCCESS (1.658s)
[382.636914] Starting dynamic subtest: bcs0
[383.428795] Dynamic subtest bcs0: SUCCESS (0.822s)
[383.454757] Starting dynamic subtest: vcs0
[384.185453] Dynamic subtest vcs0: SUCCESS (0.758s)
[384.206475] Starting dynamic subtest: vecs0
[385.000290] Dynamic subtest vecs0: SUCCESS (0.812s)
[385.004335] Subtest manyslice: SUCCESS (4.063s)
[385.369281] [062/142] (617s left) gem_spin_batch (spin-all-new)
[385.532085] Starting subtest: spin-all-new
[385.559499] Subtest spin-all-new: SUCCESS (0.027s)
[385.786752] [063/142] (616s left) kms_fence_pin_leak
[388.981983] [064/142] (613s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[389.223077] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[389.224551] Starting dynamic subtest: pipe-A-DP-1
[389.550239] Dynamic subtest pipe-A-DP-1: SUCCESS (0.325s)
[389.577530] Starting dynamic subtest: pipe-B-DP-1
[389.936489] Dynamic subtest pipe-B-DP-1: SUCCESS (0.381s)
[389.961168] Starting dynamic subtest: pipe-C-DP-1
[390.036812] Dynamic subtest pipe-C-DP-1: SKIP (0.093s)
[390.038138] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.816s)
[390.429906] [065/142] (612s left) kms_psr (no_drrs)
[390.571683] Subtest no_drrs: SKIP (0.000s)
[390.629415] [066/142] (612s left) vc4/vc4_perfmon (create-single-perfmon)
[390.825698] Subtest create-single-perfmon: SKIP (0.000s)
[390.894927] [067/142] (611s left) vc4/vc4_wait_seqno (bad-seqno-0ns)
[391.092450] Subtest bad-seqno-0ns: SKIP (0.000s)
[391.161934] [068/142] (611s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[391.416381] Starting subtest: 4-tiled-32bpp-rotate-180
[391.419125] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[391.511958] [069/142] (611s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs)
[391.937901] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs
[391.940650] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[392.297962] [070/142] (610s left) gem_madvise (dontneed-before-pwrite)
[392.434683] Starting subtest: dontneed-before-pwrite
[392.441126] Subtest dontneed-before-pwrite: SUCCESS (0.005s)
[392.548453] [071/142] (610s left) kms_flip (basic-flip-vs-modeset)
[392.769197] Starting subtest: basic-flip-vs-modeset
[392.773909] Starting dynamic subtest: A-DP1
[394.081494] Dynamic subtest A-DP1: SUCCESS (1.310s)
[394.102407] Starting dynamic subtest: B-DP1
[395.246202] Dynamic subtest B-DP1: SUCCESS (1.157s)
[395.265316] Starting dynamic subtest: C-DP1
[396.385456] Dynamic subtest C-DP1: SUCCESS (1.138s)
[396.386834] Subtest basic-flip-vs-modeset: SUCCESS (3.619s)
[396.748684] [072/142] (606s left) kms_async_flips (async-flip-with-page-flip-events)
[396.985495] Starting subtest: async-flip-with-page-flip-events
[397.152078] Starting dynamic subtest: pipe-A-DP-1-Yf-CCS
[398.025889] Dynamic subtest pipe-A-DP-1-Yf-CCS: SKIP (0.871s)
[398.044655] Starting dynamic subtest: pipe-A-DP-1-Y-CCS
[398.704940] Dynamic subtest pipe-A-DP-1-Y-CCS: SKIP (0.677s)
[398.722994] Starting dynamic subtest: pipe-A-DP-1-Yf
[401.352268] Dynamic subtest pipe-A-DP-1-Yf: SUCCESS (2.646s)
[401.374044] Starting dynamic subtest: pipe-A-DP-1-Y
[404.035673] Dynamic subtest pipe-A-DP-1-Y: SUCCESS (2.680s)
[404.058702] Starting dynamic subtest: pipe-A-DP-1-X
[406.171479] Dynamic subtest pipe-A-DP-1-X: SUCCESS (2.129s)
[406.190202] Starting dynamic subtest: pipe-A-DP-1-linear
[406.323492] Dynamic subtest pipe-A-DP-1-linear: SKIP (0.150s)
[406.511973] Starting dynamic subtest: pipe-B-DP-1-Yf-CCS
[407.436428] Dynamic subtest pipe-B-DP-1-Yf-CCS: SKIP (0.939s)
[407.456836] Starting dynamic subtest: pipe-B-DP-1-Y-CCS
[408.114354] Dynamic subtest pipe-B-DP-1-Y-CCS: SKIP (0.674s)
[408.136070] Starting dynamic subtest: pipe-B-DP-1-Yf
[410.778544] Dynamic subtest pipe-B-DP-1-Yf: SUCCESS (2.663s)
[410.799647] Starting dynamic subtest: pipe-B-DP-1-Y
[413.428435] Dynamic subtest pipe-B-DP-1-Y: SUCCESS (2.646s)
[413.449764] Starting dynamic subtest: pipe-B-DP-1-X
[415.578248] Dynamic subtest pipe-B-DP-1-X: SUCCESS (2.146s)
[415.596964] Starting dynamic subtest: pipe-B-DP-1-linear
[415.749383] Dynamic subtest pipe-B-DP-1-linear: SKIP (0.166s)
[415.936920] Starting dynamic subtest: pipe-C-DP-1-Yf
[418.774129] Dynamic subtest pipe-C-DP-1-Yf: SUCCESS (2.854s)
[418.795247] Starting dynamic subtest: pipe-C-DP-1-Y
[421.452695] Dynamic subtest pipe-C-DP-1-Y: SUCCESS (2.675s)
[421.471797] Starting dynamic subtest: pipe-C-DP-1-X
[423.601777] Dynamic subtest pipe-C-DP-1-X: SUCCESS (2.146s)
[423.622870] Starting dynamic subtest: pipe-C-DP-1-linear
[423.755372] Dynamic subtest pipe-C-DP-1-linear: SKIP (0.149s)
[423.756982] Subtest async-flip-with-page-flip-events: SUCCESS (26.770s)
[424.227521] [073/142] (578s left) gem_partial_pwrite_pread (write)
[424.382461] Starting subtest: write
[438.822976] Subtest write: SUCCESS (14.441s)
[438.943748] [074/142] (564s left) gem_lmem_swapping (parallel-random-verify-ccs)
[439.098763] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[439.163600] [075/142] (563s left) perf (per-context-mode-unprivileged)
[439.389660] Starting subtest: per-context-mode-unprivileged
[439.392699] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[439.445343] [076/142] (563s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[439.784160] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[440.083864] [077/142] (563s left) gem_exec_nop (basic-series)
[440.251076] Starting subtest: basic-series
[443.313181] Subtest basic-series: SUCCESS (3.061s)
[443.543284] [078/142] (559s left) gem_ctx_engines (independent)
[443.709464] Starting subtest: independent
[443.713497] Starting dynamic subtest: rcs0
[443.948101] Dynamic subtest rcs0: SUCCESS (0.233s)
[443.967744] Starting dynamic subtest: bcs0
[444.226245] Dynamic subtest bcs0: SUCCESS (0.276s)
[444.245885] Starting dynamic subtest: vcs0
[444.439416] Dynamic subtest vcs0: SUCCESS (0.211s)
[444.463118] Starting dynamic subtest: vecs0
[444.668962] Dynamic subtest vecs0: SUCCESS (0.226s)
[444.689378] Starting dynamic subtest: all-engines
[445.126189] Dynamic subtest all-engines: SUCCESS (0.455s)
[445.127651] Subtest independent: SUCCESS (1.416s)
[445.363469] [079/142] (557s left) gem_mmap_gtt (fault-concurrent-y)
[445.508320] Starting subtest: fault-concurrent-Y
[448.962988] Subtest fault-concurrent-Y: SUCCESS (3.454s)
[449.278763] [080/142] (553s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[449.542735] Starting subtest: y-tiled-8bpp-rotate-270
[449.638645] Subtest y-tiled-8bpp-rotate-270: SKIP (0.094s)
[449.743451] [081/142] (553s left) core_auth (getclient-simple)
[449.879247] Starting subtest: getclient-simple
[449.884956] Subtest getclient-simple: SUCCESS (0.004s)
[449.979097] [082/142] (553s left) gem_render_copy (yf-tiled)
[450.146039] Starting subtest: yf-tiled
[450.147439] Starting dynamic subtest: smem
[450.527706] Dynamic subtest smem: SUCCESS (0.381s)
[450.530107] Subtest yf-tiled: SUCCESS (0.384s)
[450.728809] [083/142] (552s left) kms_vblank (pipe-b-query-busy-hang)
[450.974832] Starting subtest: pipe-B-query-busy-hang
[457.966620] Subtest pipe-B-query-busy-hang: SUCCESS (6.991s)
[458.305679] [084/142] (545s left) perf_pmu (init-wait)
[458.458292] Starting subtest: init-wait
[458.460347] Starting dynamic subtest: rcs0
[458.464949] Dynamic subtest rcs0: SUCCESS (0.003s)
[458.489030] Starting dynamic subtest: bcs0
[458.490371] Dynamic subtest bcs0: SUCCESS (0.001s)
[458.510689] Starting dynamic subtest: vcs0
[458.511979] Dynamic subtest vcs0: SUCCESS (0.002s)
[458.532545] Starting dynamic subtest: vecs0
[458.533969] Dynamic subtest vecs0: SUCCESS (0.002s)
[458.535459] Subtest init-wait: SUCCESS (0.019s)
[458.574518] [085/142] (544s left) gem_readwrite (write-bad-handle)
[458.715228] Starting subtest: write-bad-handle
[458.717918] Subtest write-bad-handle: SUCCESS (0.000s)
[458.810486] [086/142] (544s left) gem_exec_flush (basic-wb-ro-default)
[458.977121] Starting subtest: basic-wb-ro-default
[464.454244] Subtest basic-wb-ro-default: SUCCESS (5.477s)
[464.673947] [087/142] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[464.922984] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[464.925901] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[465.021123] [088/142] (538s left) kms_cursor_edge_walk (64x64-right-edge)
[465.256842] Starting subtest: 64x64-right-edge
[465.258243] Starting dynamic subtest: pipe-A-DP-1
[468.884328] Dynamic subtest pipe-A-DP-1: SUCCESS (3.624s)
[468.907312] Starting dynamic subtest: pipe-C-DP-1
[472.368577] Dynamic subtest pipe-C-DP-1: SUCCESS (3.480s)
[472.369947] Subtest 64x64-right-edge: SUCCESS (7.114s)
[472.700251] [089/142] (530s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs)
[473.108893] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs
[473.113119] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[473.521444] [090/142] (530s left) gem_ctx_param (invalid-get-ringsize)
[473.663130] Starting subtest: invalid-get-ringsize
[473.664701] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[473.756621] [091/142] (529s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[473.998894] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[474.001954] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[474.103958] [092/142] (529s left) gem_exec_schedule (reorder-wide)
[474.411411] Starting subtest: reorder-wide
[474.413041] Starting dynamic subtest: rcs0
[474.585135] Dynamic subtest rcs0: SUCCESS (0.170s)
[474.611342] Starting dynamic subtest: bcs0
[474.976405] Dynamic subtest bcs0: SUCCESS (0.388s)
[475.000575] Starting dynamic subtest: vcs0
[475.146479] Dynamic subtest vcs0: SUCCESS (0.168s)
[475.171114] Starting dynamic subtest: vecs0
[475.315220] Dynamic subtest vecs0: SUCCESS (0.166s)
[475.317561] Subtest reorder-wide: SUCCESS (0.905s)
[475.538103] [093/142] (528s left) gem_mmap_offset (close-race)
[475.679364] Starting subtest: close-race
[495.797621] Subtest close-race: SUCCESS (20.119s)
[495.904685] [094/142] (507s left) kms_flip (flip-vs-suspend-interruptible)
[496.140362] Starting subtest: flip-vs-suspend-interruptible
[496.145261] Starting dynamic subtest: A-DP1
[548.112929] Dynamic subtest A-DP1: SUCCESS (4.917s)
[548.152136] Starting dynamic subtest: B-DP1
[601.113712] Dynamic subtest B-DP1: SUCCESS (4.876s)
[601.145391] Starting dynamic subtest: C-DP1
[654.256361] Dynamic subtest C-DP1: SUCCESS (4.889s)
[654.257876] Subtest flip-vs-suspend-interruptible: SUCCESS (14.699s)
[659.613906] [095/142] (492s left) syncobj_wait (multi-wait-signaled)
[659.772480] Starting subtest: multi-wait-signaled
[659.774103] Subtest multi-wait-signaled: SUCCESS (0.001s)
[659.864360] [096/142] (492s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[660.103090] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[660.109435] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.005s)
[660.197494] [097/142] (492s left) kms_vblank (pipe-b-query-idle)
[660.441275] Starting subtest: pipe-B-query-idle
[663.050264] Subtest pipe-B-query-idle: SUCCESS (2.610s)
[663.390267] [098/142] (489s left) prime_mmap (test_refcounting)
[663.532149] Starting subtest: test_refcounting
[663.533548] Starting dynamic subtest: test_refcounting-smem
[663.538888] Dynamic subtest test_refcounting-smem: SUCCESS (0.007s)
[663.541113] Subtest test_refcounting: SUCCESS (0.009s)
[663.640930] [099/142] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[663.885307] Starting subtest: fbcpsr-1p-rte
[663.887784] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[663.989967] [100/142] (488s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[664.235150] Starting subtest: basic-flip-after-cursor-varying-size
[665.312112] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.074s)
[665.660649] [101/142] (486s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[665.908909] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[665.911530] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[666.009490] [102/142] (486s left) syncobj_timeline (reset-unsignaled)
[666.151596] Starting subtest: reset-unsignaled
[666.152961] Subtest reset-unsignaled: SUCCESS (0.000s)
[666.243380] [103/142] (486s left) perf (polling)
[666.482043] Starting subtest: polling
[666.483394] Starting dynamic subtest: 0-rcs0
[676.543422] Dynamic subtest 0-rcs0: SUCCESS (10.058s)
[676.544802] Subtest polling: SUCCESS (10.062s)
[676.594690] [104/142] (476s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs)
[676.969891] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs
[677.515891] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.546s)
[678.087250] [105/142] (474s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[678.345549] Starting subtest: y-tiled-16bpp-rotate-0
[681.941822] Subtest y-tiled-16bpp-rotate-0: SUCCESS (3.595s)
[682.269340] [106/142] (470s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[682.752972] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[683.080107] [107/142] (469s left) kms_chamelium_color (ctm-0-25)
[683.314003] Subtest ctm-0-25: SKIP (0.000s)
[683.379117] [108/142] (469s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[683.628690] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[686.216908] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.592s)
[686.378826] [109/142] (466s left) kms_flip (bo-too-big-interruptible)
[686.616510] Starting subtest: bo-too-big-interruptible
[686.621131] Starting dynamic subtest: A-DP1
[689.738556] Dynamic subtest A-DP1: SUCCESS (3.117s)
[689.766581] Starting dynamic subtest: B-DP1
[692.801082] Dynamic subtest B-DP1: SUCCESS (3.058s)
[692.829644] Starting dynamic subtest: C-DP1
[695.909883] Dynamic subtest C-DP1: SUCCESS (3.105s)
[695.911605] Subtest bo-too-big-interruptible: SUCCESS (9.296s)
[696.531167] [110/142] (456s left) gem_exec_balancer (parallel-keep-submit-fence)
[700.540558] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[700.646310] [111/142] (452s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[701.076621] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[701.079516] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[701.440595] [112/142] (451s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[701.682937] Starting subtest: fbc-rgb565-draw-mmap-wc
[703.844721] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.163s)
[703.990590] [113/142] (449s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[704.238087] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[704.241326] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[704.355135] [114/142] (448s left) kms_universal_plane (cursor-fb-leak-pipe-c)
[704.588970] Starting subtest: cursor-fb-leak-pipe-C
[705.246130] Subtest cursor-fb-leak-pipe-C: SUCCESS (0.658s)
[705.591787] [115/142] (447s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[705.736066] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[705.838450] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[705.928078] [116/142] (447s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs)
[706.370063] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs
[706.373057] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.001s)
[706.726687] [117/142] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[706.974350] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[706.977469] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[707.092889] [118/142] (446s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[707.351650] Starting subtest: yf-tiled-16bpp-rotate-270
[707.442740] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.089s)
[707.560648] [119/142] (445s left) gem_pxp (hw-rejects-pxp-buffer)
[710.223745] Starting subtest: hw-rejects-pxp-buffer
[710.225357] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[710.326340] [120/142] (443s left) kms_psr (psr2_primary_mmap_cpu)
[710.469422] Subtest psr2_primary_mmap_cpu: SKIP (0.000s)
[710.529394] [121/142] (442s left) kms_plane (plane-position-covered)
[710.774489] Starting subtest: plane-position-covered
[710.777193] Starting dynamic subtest: pipe-A-planes
[712.303685] Dynamic subtest pipe-A-planes: SUCCESS (1.527s)
[712.333357] Starting dynamic subtest: pipe-B-planes
[714.002035] Dynamic subtest pipe-B-planes: SUCCESS (1.691s)
[714.003463] Subtest plane-position-covered: SUCCESS (3.230s)
[714.357695] [122/142] (439s left) v3d/v3d_submit_cl (bad-perfmon)
[714.565818] Subtest bad-perfmon: SKIP (0.000s)
[714.644052] [123/142] (438s left) i915_module_load (load)
[714.781218] Starting subtest: load
[714.786595] Subtest load: SKIP (0.003s)
[714.857731] [124/142] (438s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[715.120516] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[716.648001] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.525s)
[716.791537] [125/142] (436s left) core_setmaster_vs_auth
[717.026123] [126/142] (436s left) kms_tv_load_detect (load-detect)
[717.168968] Subtest load-detect: SKIP (0.000s)
[717.224090] [127/142] (436s left) i915_pm_rps (reset)
[717.373116] Starting subtest: reset
[720.952208] Subtest reset: SUCCESS (3.578s)
[721.042133] [128/142] (432s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[721.281973] Starting subtest: 2x-long-flip-vs-cursor-atomic
[721.287353] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.004s)
[721.373278] [129/142] (432s left) kms_pm_backlight (fade-with-dpms)
[721.616191] Subtest fade-with-dpms: SKIP (0.000s)
[721.675676] [130/142] (432s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_mc_ccs)
[722.018557] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs
[722.021591] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[722.488745] [131/142] (431s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[722.875089] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[722.877994] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[723.296841] [132/142] (430s left) drm_fdinfo (busy-check-all)
[723.448997] Starting subtest: busy-check-all
[723.450490] Starting dynamic subtest: rcs0
[723.978897] Dynamic subtest rcs0: SUCCESS (0.529s)
[724.007941] Starting dynamic subtest: bcs0
[724.510805] Dynamic subtest bcs0: SUCCESS (0.529s)
[724.540329] Starting dynamic subtest: vcs0
[725.039680] Dynamic subtest vcs0: SUCCESS (0.526s)
[725.069731] Starting dynamic subtest: vecs0
[725.569815] Dynamic subtest vecs0: SUCCESS (0.527s)
[725.571441] Subtest busy-check-all: SUCCESS (2.123s)
[725.660506] [133/142] (428s left) gem_exec_whisper (basic-queues-all)
[725.832577] Starting subtest: basic-queues-all
[737.078617] Subtest basic-queues-all: SUCCESS (11.247s)
[737.294432] [134/142] (416s left) kms_properties (plane-properties-atomic)
[737.535990] Starting subtest: plane-properties-atomic
[738.562258] Subtest plane-properties-atomic: SUCCESS (1.022s)
[738.906603] [135/142] (415s left) kms_plane_alpha_blend (constant-alpha-min)
[739.143744] Starting subtest: constant-alpha-min
[739.466538] Starting dynamic subtest: pipe-A-DP-1
[740.153779] Dynamic subtest pipe-A-DP-1: SUCCESS (0.687s)
[740.197131] Starting dynamic subtest: pipe-C-DP-1
[741.103367] Dynamic subtest pipe-C-DP-1: SUCCESS (0.941s)
[741.104985] Subtest constant-alpha-min: SUCCESS (1.957s)
[741.470489] [136/142] (412s left) kms_flip (basic-flip-vs-wf_vblank)
[741.691202] Starting subtest: basic-flip-vs-wf_vblank
[741.698442] Starting dynamic subtest: A-DP1
[743.181634] Dynamic subtest A-DP1: SUCCESS (1.485s)
[743.209375] Starting dynamic subtest: B-DP1
[744.591113] Dynamic subtest B-DP1: SUCCESS (1.407s)
[744.621805] Starting dynamic subtest: C-DP1
[746.003674] Dynamic subtest C-DP1: SUCCESS (1.409s)
[746.008147] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.315s)
[746.434698] [137/142] (407s left) v3d/v3d_perfmon (create-single-perfmon)
[746.641351] Subtest create-single-perfmon: SKIP (0.000s)
[746.714692] [138/142] (407s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[746.962361] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[749.604630] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (2.643s)
[749.784260] [139/142] (404s left) kms_psr2_su (page_flip-nv12)
[749.927236] Subtest page_flip-NV12: SKIP (0.000s)
[749.984309] [140/142] (404s left) kms_color (ctm-green-to-red)
[750.222857] Starting subtest: ctm-green-to-red
[750.224140] Starting dynamic subtest: pipe-A
[750.753032] Dynamic subtest pipe-A: SUCCESS (0.529s)
[750.783139] Starting dynamic subtest: pipe-B
[751.456986] Dynamic subtest pipe-B: SUCCESS (0.701s)
[751.486402] Starting dynamic subtest: pipe-C
[752.172869] Dynamic subtest pipe-C: SUCCESS (0.713s)
[752.175191] Subtest ctm-green-to-red: SUCCESS (1.950s)
[752.519699] [141/142] (401s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[752.764240] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[752.765639] Starting dynamic subtest: pipe-A-valid-mode
[753.153609] Dynamic subtest pipe-A-valid-mode: SKIP (0.384s)
[753.156377] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SKIP (0.388s)
[753.535063] [142/142] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[753.785427] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[756.040078] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.257s)
[756.197965] Closing watchdogs
Done.