[50.904533] Initializing watchdogs
[50.904812]   /dev/watchdog0
[50.921991] [001/139] (960s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[51.184612] Starting subtest: cursorA-vs-flipB-toggle
[51.187743] Subtest cursorA-vs-flipB-toggle: SKIP (0.002s)
[51.261151] [002/139] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[51.520784] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[51.523681] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[51.609129] [003/139] (959s left) kms_cursor_edge_walk (128x128-top-bottom)
[51.845268] Starting subtest: 128x128-top-bottom
[51.849355] Starting dynamic subtest: pipe-A-DP-1
[55.749483] Dynamic subtest pipe-A-DP-1: SUCCESS (3.902s)
[55.763168] Starting dynamic subtest: pipe-C-DP-1
[59.244511] Dynamic subtest pipe-C-DP-1: SUCCESS (3.493s)
[59.246183] Subtest 128x128-top-bottom: SUCCESS (7.401s)
[59.550262] [004/139] (951s left) kms_flip (nonexisting-fb-interruptible)
[59.793493] Starting subtest: nonexisting-fb-interruptible
[59.797252] Starting dynamic subtest: A-DP1
[60.307631] Dynamic subtest A-DP1: SUCCESS (0.508s)
[60.319866] Starting dynamic subtest: B-DP1
[60.750996] Dynamic subtest B-DP1: SUCCESS (0.443s)
[60.766297] Starting dynamic subtest: C-DP1
[61.163185] Dynamic subtest C-DP1: SUCCESS (0.410s)
[61.164700] Subtest nonexisting-fb-interruptible: SUCCESS (1.371s)
[61.586630] [005/139] (949s left) kms_vblank (wait-idle)
[61.826932] Starting subtest: wait-idle
[61.828377] Starting dynamic subtest: pipe-A-DP-1
[64.098210] Dynamic subtest pipe-A-DP-1: SUCCESS (2.270s)
[64.114379] Starting dynamic subtest: pipe-C-DP-1
[66.557448] Dynamic subtest pipe-C-DP-1: SUCCESS (2.454s)
[66.559174] Subtest wait-idle: SUCCESS (4.732s)
[66.879214] [006/139] (944s left) kms_properties (invalid-properties-atomic)
[67.130642] Starting subtest: invalid-properties-atomic
[67.375057] Subtest invalid-properties-atomic: SUCCESS (0.244s)
[67.444450] [007/139] (944s left) gem_exec_reloc (basic-gtt-wc)
[67.620731] Starting subtest: basic-gtt-wc
[67.648925] Subtest basic-gtt-wc: SUCCESS (0.030s)
[67.828062] [008/139] (943s left) gem_ctx_param (invalid-param-get)
[67.970984] Starting subtest: invalid-param-get
[67.972635] Subtest invalid-param-get: SUCCESS (0.002s)
[68.046851] [009/139] (943s left) kms_ccs (pipe-c-ccs-on-another-bo-y-tiled-ccs)
[68.506105] Starting subtest: pipe-C-ccs-on-another-bo-y-tiled-ccs
[68.508588] Subtest pipe-C-ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[68.817389] [010/139] (942s left) kms_pm_rpm (cursor-dpms)
[70.540458] Starting subtest: cursor-dpms
[73.160969] Subtest cursor-dpms: SUCCESS (2.621s)
[73.584622] [011/139] (938s left) gem_userptr_blits (input-checking)
[73.753382] Starting subtest: input-checking
[73.754679] Subtest input-checking: SUCCESS (0.000s)
[73.917315] [012/139] (937s left) kms_dsc (dsc-with-bpc)
[74.150965] Subtest dsc-with-bpc: SKIP (0.000s)
[74.199128] [013/139] (937s left) api_intel_bb (simple-bb-ctx)
[74.339476] Starting subtest: simple-bb-ctx
[74.361033] Subtest simple-bb-ctx: SUCCESS (0.022s)
[74.464412] [014/139] (937s left) gem_mmap_offset (perf)
[74.606136] Starting subtest: perf
[74.607707] Starting dynamic subtest: smem0
[74.901816] Dynamic subtest smem0: SUCCESS (0.295s)
[74.903322] Subtest perf: SUCCESS (0.295s)
[74.998591] [015/139] (936s left) syncobj_basic (illegal-fd-to-handle)
[75.135798] Starting subtest: illegal-fd-to-handle
[75.137419] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[75.216231] [016/139] (936s left) gem_ctx_shared (q-in-order)
[75.380813] Starting subtest: Q-in-order
[75.382343] Starting dynamic subtest: rcs0
[75.569921] Dynamic subtest rcs0: SUCCESS (0.187s)
[75.590165] Starting dynamic subtest: bcs0
[75.686042] Dynamic subtest bcs0: SUCCESS (0.116s)
[75.705482] Starting dynamic subtest: vcs0
[75.777258] Dynamic subtest vcs0: SUCCESS (0.090s)
[75.799318] Starting dynamic subtest: vecs0
[75.866728] Dynamic subtest vecs0: SUCCESS (0.088s)
[75.868716] Subtest Q-in-order: SUCCESS (0.483s)
[76.085571] [017/139] (935s left) gem_mmap (basic)
[76.224569] Starting subtest: basic
[76.231040] Subtest basic: SUCCESS (0.001s)
[76.315935] [018/139] (935s left) kms_flip (2x-flip-vs-panning-vs-hang)
[76.540196] Starting subtest: 2x-flip-vs-panning-vs-hang
[76.546102] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.003s)
[76.649425] [019/139] (935s left) gen9_exec_parse (batch-zero-length)
[76.818427] Starting subtest: batch-zero-length
[76.821779] Subtest batch-zero-length: SUCCESS (0.003s)
[77.051795] [020/139] (935s left) syncobj_wait (wait-all-interrupted)
[77.194213] Starting subtest: wait-all-interrupted
[77.299571] Subtest wait-all-interrupted: SUCCESS (0.103s)
[77.382088] [021/139] (934s left) kms_psr2_su (page_flip-xrgb8888)
[77.522964] Subtest page_flip-XRGB8888: SKIP (0.000s)
[77.566651] [022/139] (934s left) kms_ccs (pipe-a-bad-pixel-format-y-tiled-gen12-rc-ccs)
[77.795573] Starting subtest: pipe-A-bad-pixel-format-y-tiled-gen12-rc-ccs
[77.798145] Subtest pipe-A-bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[78.334202] [023/139] (933s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[78.575246] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[78.580689] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.005s)
[78.672742] [024/139] (933s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[78.925580] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[81.369226] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.445s)
[81.505188] [025/139] (930s left) sysfs_heartbeat_interval (invalid)
[81.651984] Starting subtest: invalid
[81.653787] Starting dynamic subtest: vecs0
[81.655421] Dynamic subtest vecs0: SUCCESS (0.001s)
[81.672192] Starting dynamic subtest: vcs0
[81.673413] Dynamic subtest vcs0: SUCCESS (0.001s)
[81.688612] Starting dynamic subtest: bcs0
[81.689934] Dynamic subtest bcs0: SUCCESS (0.001s)
[81.704625] Starting dynamic subtest: rcs0
[81.705997] Dynamic subtest rcs0: SUCCESS (0.001s)
[81.707313] Subtest invalid: SUCCESS (0.007s)
[81.734541] [026/139] (930s left) i915_pipe_stress (stress-xrgb8888-ytiled)
[81.975824] Starting subtest: stress-xrgb8888-ytiled
[88.306560] Subtest stress-xrgb8888-ytiled: FAIL (6.001s)
[88.847761] [027/139] (923s left) v3d/v3d_perfmon (destroy-invalid-perfmon)
[89.046354] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[89.109353] [028/139] (923s left) kms_flip (flip-vs-expired-vblank)
[89.333639] Starting subtest: flip-vs-expired-vblank
[89.336884] Starting dynamic subtest: A-DP1
[99.934347] Dynamic subtest A-DP1: SUCCESS (10.598s)
[99.949514] Starting dynamic subtest: B-DP1
[110.376940] Dynamic subtest B-DP1: SUCCESS (10.442s)
[110.392177] Starting dynamic subtest: C-DP1
[120.831344] Dynamic subtest C-DP1: SUCCESS (10.453s)
[120.832618] Subtest flip-vs-expired-vblank: SUCCESS (31.502s)
[121.241768] [029/139] (891s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[121.486202] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[121.488724] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[121.588659] [030/139] (890s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-mc-ccs)
[122.060298] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[122.374851] [031/139] (890s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[122.635737] Starting subtest: 4-tiled-32bpp-rotate-90
[122.638572] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[122.739628] [032/139] (889s left) kms_chamelium_hpd (vga-hpd-fast)
[123.071404] Subtest vga-hpd-fast: SKIP (0.000s)
[123.356667] [033/139] (889s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[123.598221] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[125.420485] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (1.824s)
[125.551961] [034/139] (886s left) syncobj_timeline (etime-single-wait-all-submitted)
[125.696406] Starting subtest: etime-single-wait-all-submitted
[125.803964] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[125.883828] [035/139] (886s left) api_intel_allocator (reopen-fork)
[126.037340] Starting subtest: reopen-fork
[129.314502] Subtest reopen-fork: SUCCESS (3.276s)
[129.404252] [036/139] (883s left) perf (whitelisted-registers-userspace-config)
[129.685482] Starting subtest: whitelisted-registers-userspace-config
[129.687193] Subtest whitelisted-registers-userspace-config: SUCCESS (0.003s)
[129.733444] [037/139] (882s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-mc-ccs)
[130.146356] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs
[130.149026] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[130.520392] [038/139] (882s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[130.768599] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[130.771206] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[130.869821] [039/139] (881s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[131.125234] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[132.251965] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.126s)
[132.572662] [040/139] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[132.826668] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[132.829252] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[132.921209] [041/139] (879s left) perf_pmu (interrupts)
[133.069250] Starting subtest: interrupts
[134.198095] Subtest interrupts: SUCCESS (1.127s)
[134.287851] [042/139] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[134.534802] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[134.537463] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[134.636874] [043/139] (878s left) kms_big_fb (linear-8bpp-rotate-0)
[134.895213] Starting subtest: linear-8bpp-rotate-0
[138.836566] Subtest linear-8bpp-rotate-0: SUCCESS (3.939s)
[139.054837] [044/139] (873s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y-tiled-ccs)
[139.524618] Subtest pipe-D-crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.000s)
[139.831985] [045/139] (873s left) i915_query (query-topology-unsupported)
[139.978694] Starting subtest: query-topology-unsupported
[139.981472] Subtest query-topology-unsupported: SKIP (0.000s)
[140.066204] [046/139] (872s left) gem_spin_batch (resubmit)
[140.233462] Starting subtest: resubmit
[140.234871] Starting dynamic subtest: rcs0
[140.241057] Dynamic subtest rcs0: SUCCESS (0.007s)
[140.259355] Starting dynamic subtest: bcs0
[140.260785] Dynamic subtest bcs0: SUCCESS (0.008s)
[140.277899] Starting dynamic subtest: vcs0
[140.279350] Dynamic subtest vcs0: SUCCESS (0.006s)
[140.295869] Starting dynamic subtest: vecs0
[140.297192] Dynamic subtest vecs0: SUCCESS (0.005s)
[140.298464] Subtest resubmit: SUCCESS (0.030s)
[140.500335] [047/139] (872s left) gem_exec_fence (basic-await)
[140.807710] Starting subtest: basic-await
[140.809288] Starting dynamic subtest: rcs0
[140.941048] Dynamic subtest rcs0: SUCCESS (0.133s)
[140.958424] Starting dynamic subtest: bcs0
[141.073267] Dynamic subtest bcs0: SUCCESS (0.129s)
[141.090120] Starting dynamic subtest: vcs0
[141.203830] Dynamic subtest vcs0: SUCCESS (0.131s)
[141.221846] Starting dynamic subtest: vecs0
[141.336770] Dynamic subtest vecs0: SUCCESS (0.132s)
[141.338273] Subtest basic-await: SUCCESS (0.530s)
[142.000868] [048/139] (871s left) kms_pm_rpm (pc8-residency)
[143.719499] Starting subtest: pc8-residency
[143.724297] Subtest pc8-residency: SKIP (0.000s)
[144.204789] [049/139] (868s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[144.463725] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[144.466746] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[144.566263] [050/139] (868s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[144.810112] Starting subtest: short-flip-before-cursor-atomic-transitions
[145.911951] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.102s)
[146.246902] [051/139] (866s left) v3d/v3d_submit_csd (bad-extension)
[146.447116] Subtest bad-extension: SKIP (0.000s)
[146.511300] [052/139] (866s left) gem_exec_schedule (u-independent)
[146.679449] Starting subtest: u-independent
[146.681044] Starting dynamic subtest: rcs0
[146.862144] Dynamic subtest rcs0: SUCCESS (0.181s)
[146.882054] Starting dynamic subtest: bcs0
[147.048348] Dynamic subtest bcs0: SUCCESS (0.184s)
[147.066551] Starting dynamic subtest: vcs0
[147.232930] Dynamic subtest vcs0: SUCCESS (0.184s)
[147.250773] Starting dynamic subtest: vecs0
[147.410563] Dynamic subtest vecs0: SUCCESS (0.176s)
[147.412440] Subtest u-independent: SUCCESS (0.732s)
[147.745390] [053/139] (865s left) kms_chamelium_edid (hdmi-edid-read)
[148.074495] Subtest hdmi-edid-read: SKIP (0.000s)
[148.363980] [054/139] (864s left) kms_vrr (flipline)
[148.610985] Starting subtest: flipline
[148.613840] Subtest flipline: SKIP (0.000s)
[148.691922] [055/139] (864s left) kms_content_protection (atomic-dpms)
[148.969273] Starting subtest: atomic-dpms
[149.005284] Starting dynamic subtest: pipe-A-DP-1
[269.561384] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[270.085572] Closing watchdogs
[270.091999] Initializing watchdogs
[270.092199]   /dev/watchdog0
[270.113609] [056/139] (743s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[270.257750] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[270.307999] [057/139] (743s left) gem_mmap (bad-offset)
[270.444197] Starting subtest: bad-offset
[270.445540] Subtest bad-offset: SUCCESS (0.001s)
[270.540528] [058/139] (742s left) drm_fdinfo (virtual-busy-all)
[270.688470] Starting subtest: virtual-busy-all
[270.689809] Subtest virtual-busy-all: SUCCESS (0.001s)
[270.773875] [059/139] (742s left) sw_sync (sync_multi_consumer_producer)
[270.913866] Starting subtest: sync_multi_consumer_producer
[271.838649] Subtest sync_multi_consumer_producer: SUCCESS (0.923s)
[271.908133] [060/139] (741s left) i915_power (sanity)
[272.052193] Starting subtest: sanity
[276.081792] Subtest sanity: SUCCESS (4.024s)
[276.191893] [061/139] (737s left) kms_chamelium_color (ctm-0-25)
[276.435778] Subtest ctm-0-25: SKIP (0.000s)
[276.491820] [062/139] (737s left) kms_pipe_crc_basic (nonblocking-crc)
[276.725333] Starting subtest: nonblocking-crc
[276.726669] Starting dynamic subtest: pipe-A-DP-1
[277.350173] Dynamic subtest pipe-A-DP-1: SUCCESS (0.623s)
[277.369371] Starting dynamic subtest: pipe-B-DP-1
[278.097707] Dynamic subtest pipe-B-DP-1: SUCCESS (0.744s)
[278.117498] Starting dynamic subtest: pipe-C-DP-1
[278.882439] Dynamic subtest pipe-C-DP-1: SUCCESS (0.779s)
[278.883755] Subtest nonblocking-crc: SUCCESS (2.158s)
[279.184688] [063/139] (734s left) kms_plane_scaling (intel-max-src-size)
[279.421181] Starting subtest: intel-max-src-size
[279.427806] Starting dynamic subtest: pipe-A-DP-1
[279.481240] Dynamic subtest pipe-A-DP-1: SUCCESS (0.052s)
[279.482455] Subtest intel-max-src-size: SUCCESS (0.062s)
[279.598438] [064/139] (734s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[279.834676] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[279.844253] Starting dynamic subtest: pipe-A-DP-1
[280.477656] Dynamic subtest pipe-A-DP-1: SUCCESS (0.633s)
[280.506274] Starting dynamic subtest: pipe-B-DP-1
[281.398910] Dynamic subtest pipe-B-DP-1: SUCCESS (0.911s)
[281.425456] Starting dynamic subtest: pipe-C-DP-1
[281.764949] Dynamic subtest pipe-C-DP-1: SUCCESS (0.356s)
[281.766383] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (1.933s)
[282.172540] [065/139] (731s left) gem_ctx_param (invalid-ctx-set)
[282.318107] Starting subtest: invalid-ctx-set
[282.319422] Subtest invalid-ctx-set: SUCCESS (0.001s)
[282.405120] [066/139] (731s left) kms_ccs (pipe-a-missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[282.754480] Starting subtest: pipe-A-missing-ccs-buffer-4-tiled-mtl-mc-ccs
[282.757067] Subtest pipe-A-missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[283.178638] [067/139] (730s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[283.416609] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[324.972909] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (41.557s)
[325.314160] [068/139] (688s left) gem_exec_parallel (fds)
[325.480878] Starting subtest: fds
[325.482356] Starting dynamic subtest: rcs0
[334.461548] Dynamic subtest rcs0: SUCCESS (8.979s)
[334.480035] Starting dynamic subtest: bcs0
[344.742829] Dynamic subtest bcs0: SUCCESS (10.280s)
[344.765193] Starting dynamic subtest: vcs0
[354.711708] Dynamic subtest vcs0: SUCCESS (9.966s)
[354.734142] Starting dynamic subtest: vecs0
[365.708728] Dynamic subtest vecs0: SUCCESS (10.993s)
[365.710610] Subtest fds: SUCCESS (40.230s)
[365.939684] [069/139] (647s left) syncobj_timeline (transfer-timeline-point)
[366.089665] Starting subtest: transfer-timeline-point
[366.091055] Subtest transfer-timeline-point: SUCCESS (0.001s)
[366.178941] [070/139] (647s left) kms_invalid_mode (int-max-clock)
[366.422222] Starting subtest: int-max-clock
[366.423885] Starting dynamic subtest: pipe-A-DP-1
[366.506785] Dynamic subtest pipe-A-DP-1: SUCCESS (0.084s)
[366.532467] Starting dynamic subtest: pipe-B-DP-1
[366.534402] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[366.561325] Starting dynamic subtest: pipe-C-DP-1
[366.563295] Dynamic subtest pipe-C-DP-1: SUCCESS (0.002s)
[366.565214] Subtest int-max-clock: SUCCESS (0.100s)
[366.836302] [071/139] (647s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[367.099729] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[368.213888] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.116s)
[368.557634] [072/139] (645s left) i915_query (query-regions-sanity-check)
[368.722873] Starting subtest: query-regions-sanity-check
[368.761994] Subtest query-regions-sanity-check: SUCCESS (0.040s)
[368.888806] [073/139] (645s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-dg2-mc-ccs)
[369.282207] Starting subtest: pipe-B-bad-rotation-90-4-tiled-dg2-mc-ccs
[369.284825] Subtest pipe-B-bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[369.702464] [074/139] (644s left) perf (buffer-fill)
[369.945488] Starting subtest: buffer-fill
[369.947174] Starting dynamic subtest: 0-rcs0
[372.843385] Dynamic subtest 0-rcs0: SUCCESS (2.895s)
[372.845706] Subtest buffer-fill: SUCCESS (2.898s)
[372.903711] [075/139] (641s left) v3d/v3d_submit_csd (valid-multisync-submission)
[373.099436] Subtest valid-multisync-submission: SKIP (0.000s)
[373.168217] [076/139] (641s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[373.311482] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[373.419621] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[373.501836] [077/139] (640s left) kms_atomic (crtc-invalid-params-fence)
[373.743420] Starting subtest: crtc-invalid-params-fence
[373.744812] Starting dynamic subtest: pipe-A-DP-1
[374.162384] Dynamic subtest pipe-A-DP-1: SUCCESS (0.414s)
[374.163914] Subtest crtc-invalid-params-fence: SUCCESS (0.420s)
[374.468837] [078/139] (639s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[374.720698] Starting subtest: psr-1p-pri-indfb-multidraw
[374.723205] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[374.833862] [079/139] (639s left) gem_exec_basic (basic)
[374.992952] Starting subtest: basic
[374.994489] Starting dynamic subtest: rcs0-smem
[374.999104] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[375.019480] Starting dynamic subtest: bcs0-smem
[375.020805] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[375.038949] Starting dynamic subtest: vcs0-smem
[375.040266] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[375.058319] Starting dynamic subtest: vecs0-smem
[375.059615] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[375.060835] Subtest basic: SUCCESS (0.017s)
[375.233553] [080/139] (639s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[375.640468] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs
[375.642994] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[376.031850] [081/139] (638s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted)
[376.176093] Starting subtest: invalid-single-wait-all-available-unsubmitted
[376.177841] Subtest invalid-single-wait-all-available-unsubmitted: SUCCESS (0.000s)
[376.262862] [082/139] (638s left) kms_cursor_crc (cursor-offscreen-32x10)
[376.503209] Starting subtest: cursor-offscreen-32x10
[376.629380] Subtest cursor-offscreen-32x10: SKIP (0.123s)
[376.748982] [083/139] (637s left) perf (invalid-oa-metric-set-id)
[376.992322] Starting subtest: invalid-oa-metric-set-id
[377.039723] Subtest invalid-oa-metric-set-id: SUCCESS (0.047s)
[377.097685] [084/139] (637s left) syncobj_wait (single-wait-all-submitted)
[377.242974] Starting subtest: single-wait-all-submitted
[377.347253] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[377.430125] [085/139] (637s left) gem_exec_balancer (bonded-sync)
[377.596752] Starting subtest: bonded-sync
[381.372555] Subtest bonded-sync: SUCCESS (3.774s)
[385.283100] [086/139] (629s left) prime_vgem (coherency-blt)
[385.436999] Starting subtest: coherency-blt
[388.873131] Subtest coherency-blt: SUCCESS (3.433s)
[388.997767] [087/139] (625s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[389.239027] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[389.243255] Starting dynamic subtest: pipe-A-valid-mode
[389.365332] Dynamic subtest pipe-A-valid-mode: SKIP (0.122s)
[389.367981] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.127s)
[389.707937] [088/139] (624s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[389.956737] Starting subtest: fbcpsr-tiling-linear
[389.959339] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[390.056440] [089/139] (624s left) kms_tv_load_detect (load-detect)
[390.198041] Subtest load-detect: SKIP (0.000s)
[390.259808] [090/139] (624s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[390.509920] Starting subtest: cursor-rapid-movement-512x170
[390.515304] Subtest cursor-rapid-movement-512x170: SKIP (0.003s)
[390.606334] [091/139] (624s left) gem_ctx_param (invalid-size-set)
[390.749052] Starting subtest: invalid-size-set
[390.750744] Subtest invalid-size-set: SUCCESS (0.001s)
[390.841725] [092/139] (624s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[391.080423] Starting subtest: plane-primary-toggle-with-vblank-wait
[391.081873] Starting dynamic subtest: pipe-A-DP-1
[391.283198] Dynamic subtest pipe-A-DP-1: SUCCESS (0.201s)
[391.404866] Starting dynamic subtest: pipe-B-DP-1
[391.870147] Dynamic subtest pipe-B-DP-1: SUCCESS (0.487s)
[391.984961] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.905s)
[392.307923] [093/139] (622s left) gem_exec_schedule (lateslice)
[392.483655] Starting subtest: lateslice
[392.485331] Starting dynamic subtest: rcs0
[392.516353] Dynamic subtest rcs0: SUCCESS (0.031s)
[392.538939] Starting dynamic subtest: bcs0
[392.552316] Dynamic subtest bcs0: SUCCESS (0.032s)
[392.574788] Starting dynamic subtest: vcs0
[392.584116] Dynamic subtest vcs0: SUCCESS (0.029s)
[392.606817] Starting dynamic subtest: vecs0
[392.616115] Dynamic subtest vecs0: SUCCESS (0.029s)
[392.618340] Subtest lateslice: SUCCESS (0.134s)
[392.975828] [094/139] (621s left) gem_ctx_engines (independent)
[393.144273] Starting subtest: independent
[393.146263] Starting dynamic subtest: rcs0
[393.378311] Dynamic subtest rcs0: SUCCESS (0.229s)
[393.397324] Starting dynamic subtest: bcs0
[393.651937] Dynamic subtest bcs0: SUCCESS (0.270s)
[393.673541] Starting dynamic subtest: vcs0
[393.869842] Dynamic subtest vcs0: SUCCESS (0.211s)
[393.892307] Starting dynamic subtest: vecs0
[394.086733] Dynamic subtest vecs0: SUCCESS (0.220s)
[394.110159] Starting dynamic subtest: all-engines
[394.577763] Dynamic subtest all-engines: SUCCESS (0.487s)
[394.579179] Subtest independent: SUCCESS (1.433s)
[394.810855] [095/139] (620s left) vc4/vc4_mmap (mmap-bo)
[395.003529] Subtest mmap-bo: SKIP (0.000s)
[395.074391] [096/139] (619s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[395.826788] Starting subtest: syncobj-stationary-timeline-chain-engines
[395.952053] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.128s)
[396.174450] [097/139] (618s left) gem_create (create-ext-cpu-access-big)
[396.448269] Starting subtest: create-ext-cpu-access-big
[396.451036] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[396.541514] [098/139] (618s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[396.780873] Starting subtest: flip-vs-cursor-atomic
[412.500278] Subtest flip-vs-cursor-atomic: SUCCESS (15.718s)
[412.845899] [099/139] (602s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[413.011516] Starting subtest: yf-tiled-to-vebox-x-tiled
[413.014128] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[413.210117] [100/139] (601s left) kms_ccs (pipe-c-missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[413.656817] Starting subtest: pipe-C-missing-ccs-buffer-y-tiled-gen12-rc-ccs
[413.659390] Subtest pipe-C-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[413.991078] [101/139] (601s left) dumb_buffer (map-valid)
[414.134027] Starting subtest: map-valid
[414.135375] Subtest map-valid: SUCCESS (0.000s)
[414.241696] [102/139] (601s left) kms_properties (crtc-properties-atomic)
[414.483914] Starting subtest: crtc-properties-atomic
[415.522220] Subtest crtc-properties-atomic: SUCCESS (1.042s)
[415.875806] [103/139] (599s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[416.113304] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[416.117226] Starting dynamic subtest: pipe-A-valid-mode
[416.246111] Dynamic subtest pipe-A-valid-mode: SKIP (0.126s)
[416.248973] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.131s)
[416.581556] [104/139] (598s left) kms_big_fb (linear-8bpp-rotate-90)
[416.848444] Starting subtest: linear-8bpp-rotate-90
[416.937335] Subtest linear-8bpp-rotate-90: SKIP (0.086s)
[417.047627] [105/139] (598s left) gem_exec_reloc (basic-write-wc-active)
[417.200601] Starting subtest: basic-write-wc-active
[417.340086] Subtest basic-write-wc-active: SUCCESS (0.137s)
[417.531211] [106/139] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[417.791093] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[417.794511] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[417.898790] [107/139] (597s left) gem_ctx_persistence (legacy-engines-queued)
[418.051545] Starting subtest: legacy-engines-queued
[418.056106] Starting dynamic subtest: render
[418.103850] Dynamic subtest render: SUCCESS (0.050s)
[418.128034] Starting dynamic subtest: bsd
[418.177074] Dynamic subtest bsd: SUCCESS (0.068s)
[418.200224] Starting dynamic subtest: blt
[418.333591] Dynamic subtest blt: SUCCESS (0.153s)
[418.356346] Starting dynamic subtest: vebox
[418.401951] Dynamic subtest vebox: SUCCESS (0.063s)
[418.403707] Subtest legacy-engines-queued: SUCCESS (0.352s)
[418.499579] [108/139] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[418.746788] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[418.749412] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[418.848094] [109/139] (596s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[419.268195] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[419.270787] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[419.647247] [110/139] (595s left) kms_sequence (get-idle)
[419.885632] Starting subtest: get-idle
[419.887079] Starting dynamic subtest: pipe-A-DP-1
[422.238048] Dynamic subtest pipe-A-DP-1: SUCCESS (2.351s)
[422.261078] Starting dynamic subtest: pipe-B-DP-1
[424.754874] Dynamic subtest pipe-B-DP-1: SUCCESS (2.512s)
[424.778325] Starting dynamic subtest: pipe-C-DP-1
[427.279233] Dynamic subtest pipe-C-DP-1: SUCCESS (2.519s)
[427.280722] Subtest get-idle: SUCCESS (7.395s)
[427.600837] [111/139] (588s left) gem_exec_fence (syncobj-unused-fence)
[428.217810] Starting subtest: syncobj-unused-fence
[428.222633] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[428.582689] [112/139] (587s left) perf_pmu (busy-idle)
[428.729562] Starting subtest: busy-idle
[428.731091] Starting dynamic subtest: rcs0
[429.362613] Dynamic subtest rcs0: SUCCESS (0.632s)
[429.386107] Starting dynamic subtest: bcs0
[430.003924] Dynamic subtest bcs0: SUCCESS (0.638s)
[430.026877] Starting dynamic subtest: vcs0
[430.643532] Dynamic subtest vcs0: SUCCESS (0.635s)
[430.665516] Starting dynamic subtest: vecs0
[431.283337] Dynamic subtest vecs0: SUCCESS (0.635s)
[431.285199] Subtest busy-idle: SUCCESS (2.554s)
[431.383702] [113/139] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[431.637214] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[431.640238] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[431.731680] [114/139] (584s left) kms_flip (flip-vs-panning-interruptible)
[431.973462] Starting subtest: flip-vs-panning-interruptible
[431.980168] Starting dynamic subtest: A-DP1
[442.530679] Dynamic subtest A-DP1: SUCCESS (10.552s)
[442.552449] Starting dynamic subtest: B-DP1
[453.026674] Dynamic subtest B-DP1: SUCCESS (10.492s)
[453.048780] Starting dynamic subtest: C-DP1
[463.486875] Dynamic subtest C-DP1: SUCCESS (10.456s)
[463.492270] Subtest flip-vs-panning-interruptible: SUCCESS (31.517s)
[463.941997] [115/139] (551s left) gem_exec_reloc (basic-gtt-active)
[464.097361] Starting subtest: basic-gtt-active
[464.236804] Subtest basic-gtt-active: SUCCESS (0.138s)
[464.423762] [116/139] (551s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-ccs)
[464.828077] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-ccs
[464.829457] Subtest pipe-B-missing-ccs-buffer-y-tiled-ccs: SUCCESS (0.001s)
[465.229668] [117/139] (550s left) kms_plane_multiple (tiling-yf)
[465.468248] Starting subtest: tiling-yf
[465.469625] Starting dynamic subtest: pipe-A-DP-1
[467.370414] Dynamic subtest pipe-A-DP-1: SUCCESS (1.901s)
[467.391818] Starting dynamic subtest: pipe-B-DP-1
[469.461327] Dynamic subtest pipe-B-DP-1: SUCCESS (2.086s)
[469.484820] Starting dynamic subtest: pipe-C-DP-1
[471.528863] Dynamic subtest pipe-C-DP-1: SUCCESS (2.064s)
[471.533118] Subtest tiling-yf: SUCCESS (6.062s)
[471.892689] [118/139] (544s left) kms_psr (psr2_primary_mmap_gtt)
[472.038503] Subtest psr2_primary_mmap_gtt: SKIP (0.000s)
[472.093542] [119/139] (543s left) vc4/vc4_wait_bo (used-bo-0ns)
[472.288795] Subtest used-bo-0ns: SKIP (0.000s)
[472.357825] [120/139] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[472.604652] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[472.608098] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[472.709523] [121/139] (543s left) gem_pread (exhaustion)
[472.857648] Starting subtest: exhaustion
[488.788987] Subtest exhaustion: SUCCESS (15.933s)
[488.894180] [122/139] (527s left) sw_sync (alloc_fence)
[489.040122] Starting subtest: alloc_fence
[489.041607] Subtest alloc_fence: SUCCESS (0.000s)
[489.109498] [123/139] (526s left) kms_cursor_legacy (torture-move)
[489.356511] Starting subtest: torture-move
[489.358102] Starting dynamic subtest: pipe-A
[494.977766] Dynamic subtest pipe-A: SUCCESS (5.619s)
[494.999173] Starting dynamic subtest: pipe-B
[500.570561] Dynamic subtest pipe-B: SUCCESS (5.591s)
[500.589439] Starting dynamic subtest: pipe-C
[506.150542] Dynamic subtest pipe-C: SUCCESS (5.577s)
[506.172033] Starting dynamic subtest: all-pipes
[511.713076] Dynamic subtest all-pipes: SUCCESS (5.558s)
[511.715373] Subtest torture-move: SUCCESS (22.356s)
[511.811470] [124/139] (504s left) gem_workarounds (suspend-resume)
[511.988747] Starting subtest: suspend-resume
[530.370381] Subtest suspend-resume: SUCCESS (1.373s)
[534.518760] [125/139] (502s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[534.681402] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[534.683951] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[534.889186] [126/139] (502s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-ccs)
[535.375759] Subtest pipe-D-bad-pixel-format-y-tiled-ccs: SKIP (0.000s)
[535.687161] [127/139] (501s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[535.940345] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[535.943087] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[536.052827] [128/139] (501s left) gem_gpgpu_fill (basic)
[536.201873] Starting subtest: basic
[536.203409] Starting dynamic subtest: smem
[536.216262] Dynamic subtest smem: SUCCESS (0.011s)
[536.217724] Subtest basic: SUCCESS (0.014s)
[536.320846] [129/139] (501s left) kms_ccs (pipe-a-bad-rotation-90-yf-tiled-ccs)
[536.656983] Starting subtest: pipe-A-bad-rotation-90-yf-tiled-ccs
[537.117074] Subtest pipe-A-bad-rotation-90-yf-tiled-ccs: SUCCESS (0.458s)
[537.675193] [130/139] (499s left) gem_fenced_exec_thrash (no-spare-fences)
[537.825587] Starting subtest: no-spare-fences
[539.990788] Subtest no-spare-fences: SUCCESS (2.163s)
[540.375368] [131/139] (497s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[540.623579] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[542.697322] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.076s)
[542.839281] [132/139] (494s left) drm_read (empty-block)
[543.200807] Starting subtest: empty-block
[544.204342] Subtest empty-block: SUCCESS (1.001s)
[544.324859] [133/139] (493s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-rc-ccs)
[544.769947] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs
[544.772613] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[545.119898] [134/139] (492s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[545.390377] Starting subtest: y-tiled-8bpp-rotate-0
[548.307305] Subtest y-tiled-8bpp-rotate-0: SUCCESS (2.916s)
[548.551591] [135/139] (489s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[548.697489] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[548.702310] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.003s)
[548.801478] [136/139] (488s left) gem_exec_whisper (basic-queues-all)
[548.975164] Starting subtest: basic-queues-all
[559.893184] Subtest basic-queues-all: SUCCESS (10.917s)
[560.102439] [137/139] (477s left) kms_flip (bo-too-big-interruptible)
[560.339889] Starting subtest: bo-too-big-interruptible
[560.344734] Starting dynamic subtest: A-DP1
[563.402970] Dynamic subtest A-DP1: SUCCESS (3.058s)
[563.428841] Starting dynamic subtest: B-DP1
[566.420883] Dynamic subtest B-DP1: SUCCESS (3.014s)
[566.448330] Starting dynamic subtest: C-DP1
[569.461697] Dynamic subtest C-DP1: SUCCESS (3.037s)
[569.466332] Subtest bo-too-big-interruptible: SUCCESS (9.124s)
[570.083679] [138/139] (467s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[570.332769] Starting subtest: fbc-rgb565-draw-render
[572.554248] Subtest fbc-rgb565-draw-render: SUCCESS (2.221s)
[572.697706] [139/139] (465s left) gem_watchdog (default-physical)
[572.850644] Starting subtest: default-physical
[573.873107] Subtest default-physical: SUCCESS (1.020s)
[573.962771] Closing watchdogs
Done.