[38.617678] Initializing watchdogs
[38.617720]   /dev/watchdog0
[38.623764] [001/142] (960s left) kms_async_flips (test-time-stamp)
[38.709567] Starting subtest: test-time-stamp
[39.081022] Starting dynamic subtest: pipe-A-eDP-1
[39.934083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.850s)
[40.306774] Starting dynamic subtest: pipe-B-eDP-1
[41.211209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.908s)
[41.582477] Starting dynamic subtest: pipe-C-eDP-1
[42.491336] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.915s)
[42.871911] Starting dynamic subtest: pipe-D-eDP-1
[43.762193] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.896s)
[43.764678] Subtest test-time-stamp: SUCCESS (5.053s)
[45.005185] [002/142] (954s left) kms_vblank (pipe-a-wait-busy)
[45.092606] Starting subtest: pipe-A-wait-busy
[46.970340] Subtest pipe-A-wait-busy: SUCCESS (1.878s)
[47.883700] [003/142] (951s left) gem_exec_store (basic)
[47.968961] Starting subtest: basic
[48.079102] Subtest basic: SUCCESS (0.110s)
[48.249547] [004/142] (950s left) gem_media_fill (media-fill)
[48.315561] Subtest media-fill: SKIP (0.000s)
[48.393931] [005/142] (950s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[48.474412] Starting subtest: cursorB-vs-flipB-toggle
[48.479054] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[48.559641] [006/142] (950s left) gem_flink_basic (flink-lifetime)
[48.619298] Starting subtest: flink-lifetime
[48.621568] Subtest flink-lifetime: SUCCESS (0.001s)
[48.701182] [007/142] (950s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[48.756504] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[48.758808] Starting dynamic subtest: pipe-A-eDP-1
[48.763513] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[48.769378] Starting dynamic subtest: pipe-B-eDP-1
[48.777175] Dynamic subtest pipe-B-eDP-1: SKIP (0.013s)
[48.783624] Starting dynamic subtest: pipe-C-eDP-1
[48.792124] Dynamic subtest pipe-C-eDP-1: SKIP (0.013s)
[48.802256] Starting dynamic subtest: pipe-D-eDP-1
[48.806799] Dynamic subtest pipe-D-eDP-1: SKIP (0.012s)
[48.811356] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.045s)
[48.881629] [008/142] (950s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[54.070603] Starting subtest: cursor-plane-move-continuous-exceed-fully-sf
[54.073028] Starting dynamic subtest: pipe-A-eDP-1
[65.894617] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.817s)
[65.904796] Starting dynamic subtest: pipe-B-eDP-1
[77.722712] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.830s)
[77.725401] Subtest cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.651s)
[78.653806] [009/142] (920s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[79.075033] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[79.081188] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[79.946099] [010/142] (919s left) vc4/vc4_tiling (get-bad-handle)
[80.043236] Subtest get-bad-handle: SKIP (0.000s)
[80.088493] [011/142] (919s left) kms_vblank (pipe-b-wait-busy-hang)
[80.148720] Starting subtest: pipe-B-wait-busy-hang
[95.312794] Subtest pipe-B-wait-busy-hang: SUCCESS (15.163s)
[96.203081] [012/142] (903s left) kms_big_fb (4-tiled-addfb)
[96.283778] Starting subtest: 4-tiled-addfb
[96.285988] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[96.361732] [013/142] (903s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[96.432713] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[101.632915] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.205s)
[101.754401] [014/142] (897s left) gem_flink_basic (bad-flink)
[101.801783] Starting subtest: bad-flink
[101.803758] Subtest bad-flink: SUCCESS (0.000s)
[101.845098] [015/142] (897s left) kms_vblank (pipe-d-query-forked-busy-hang)
[101.889672] Starting subtest: pipe-D-query-forked-busy-hang
[117.334610] Subtest pipe-D-query-forked-busy-hang: SUCCESS (15.445s)
[118.223091] [016/142] (881s left) gem_mmap_gtt (cpuset-big-copy)
[118.285700] Subtest cpuset-big-copy: SKIP (0.000s)
[118.316109] [017/142] (881s left) gem_exec_balancer (parallel-bb-first)
[118.564890] Starting subtest: parallel-bb-first
[119.234427] Subtest parallel-bb-first: SUCCESS (0.668s)
[120.489663] [018/142] (879s left) v3d/v3d_submit_cl (bad-bo)
[120.552695] Subtest bad-bo: SKIP (0.000s)
[120.590046] [019/142] (878s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_mc_ccs)
[120.985910] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs
[121.999076] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs: SUCCESS (1.013s)
[123.162483] [020/142] (876s left) i915_hangman (hangcheck-unterminated)
[123.229249] Starting subtest: hangcheck-unterminated
[134.441834] Subtest hangcheck-unterminated: SUCCESS (11.212s)
[134.553947] [021/142] (865s left) gem_softpin (allocator-evict)
[134.608567] Starting subtest: allocator-evict
[134.610842] Starting dynamic subtest: rcs0
[158.262686] Dynamic subtest rcs0: SUCCESS (23.656s)
[158.275852] Starting dynamic subtest: bcs0
[181.781199] Dynamic subtest bcs0: SUCCESS (23.518s)
[181.790477] Starting dynamic subtest: vcs0
[204.889960] Dynamic subtest vcs0: SUCCESS (23.109s)
[204.898432] Starting dynamic subtest: vcs1
[228.228284] Dynamic subtest vcs1: SUCCESS (23.338s)
[228.242359] Starting dynamic subtest: vecs0
[251.580785] Dynamic subtest vecs0: SUCCESS (23.352s)
[251.593776] Starting dynamic subtest: ccs0
[275.016059] Dynamic subtest ccs0: SUCCESS (23.435s)
[275.018598] Subtest allocator-evict: SUCCESS (140.410s)
[275.086805] [022/142] (724s left) gem_mmap_wc (write-read)
[275.176261] Subtest write-read: SKIP (0.000s)
[275.213240] [023/142] (724s left) kms_rotation_crc (sprite-rotation-180)
[275.290813] Starting subtest: sprite-rotation-180
[281.260444] Subtest sprite-rotation-180: SUCCESS (5.972s)
[282.577128] [024/142] (717s left) kms_cursor_edge_walk (128x128-left-edge)
[282.659286] Starting subtest: 128x128-left-edge
[282.661653] Starting dynamic subtest: pipe-A-eDP-1
[286.206316] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.543s)
[286.219874] Starting dynamic subtest: pipe-D-eDP-1
[289.439292] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.233s)
[289.442069] Subtest 128x128-left-edge: SUCCESS (6.781s)
[290.371478] [025/142] (709s left) syncobj_timeline (invalid-query-zero-handles)
[290.438506] Starting subtest: invalid-query-zero-handles
[290.440792] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[290.502412] [026/142] (709s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[290.564664] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[290.585838] [027/142] (709s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs)
[291.033493] Starting subtest: pipe-D-ccs-on-another-bo-yf_tiled_ccs
[291.038424] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[291.864505] [028/142] (707s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[291.958057] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[291.962676] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[292.057311] [029/142] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[292.132573] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[292.136513] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[292.219351] [030/142] (707s left) vgem_basic (dmabuf-mmap)
[292.307887] Starting subtest: dmabuf-mmap
[292.313103] Subtest dmabuf-mmap: SUCCESS (0.007s)
[292.354582] [031/142] (707s left) kms_flip (2x-flip-vs-panning)
[292.431578] Starting subtest: 2x-flip-vs-panning
[292.446795] Subtest 2x-flip-vs-panning: SKIP (0.014s)
[292.517151] [032/142] (707s left) i915_pm_rpm (system-suspend)
[294.636549] Starting subtest: system-suspend
[316.663715] Subtest system-suspend: SUCCESS (7.749s)
[317.495622] [033/142] (696s left) perf_pmu (event-wait)
[317.548201] Starting subtest: event-wait
[317.550627] Starting dynamic subtest: rcs0
[317.554857] Dynamic subtest rcs0: SKIP (0.000s)
[317.559011] Subtest event-wait: SKIP (0.001s)
[317.617835] [034/142] (696s left) perf (invalid-create-userspace-config)
[317.761495] Starting subtest: invalid-create-userspace-config
[317.763894] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[317.789600] [035/142] (696s left) kms_addfb_basic (unused-pitches)
[317.832230] Starting subtest: unused-pitches
[317.835085] Subtest unused-pitches: SUCCESS (0.000s)
[317.933599] [036/142] (696s left) perf (blocking-parameterized)
[318.041810] Starting subtest: blocking-parameterized
[338.059912] Subtest blocking-parameterized: SUCCESS (20.016s)
[338.096322] [037/142] (676s left) drm_fdinfo (basics)
[338.138837] Starting subtest: basics
[338.141494] Subtest basics: SUCCESS (0.000s)
[338.194088] [038/142] (676s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[338.571152] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[339.602458] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SUCCESS (1.030s)
[340.820172] [039/142] (673s left) gem_exec_params (invalid-fence-in-submit)
[340.893029] Starting subtest: invalid-fence-in-submit
[340.898375] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[340.991746] [040/142] (673s left) kms_plane (plane-position-hole)
[341.058398] Starting subtest: plane-position-hole
[341.060878] Starting dynamic subtest: pipe-A-planes
[347.232935] Dynamic subtest pipe-A-planes: SUCCESS (6.175s)
[347.247156] Starting dynamic subtest: pipe-B-planes
[354.113826] Dynamic subtest pipe-B-planes: SUCCESS (6.878s)
[354.116328] Subtest plane-position-hole: SUCCESS (13.055s)
[355.032594] [041/142] (659s left) kms_rotation_crc (multiplane-rotation)
[355.095153] Starting subtest: multiplane-rotation
[362.520987] Subtest multiplane-rotation: SUCCESS (7.426s)
[362.617563] [042/142] (651s left) gem_softpin (noreloc)
[362.675183] Starting subtest: noreloc
[368.079390] Subtest noreloc: SUCCESS (5.402s)
[368.182270] [043/142] (646s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_mc_ccs)
[368.590812] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs
[369.571615] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs: SUCCESS (0.981s)
[370.782099] [044/142] (643s left) kms_vblank (pipe-c-query-forked-busy-hang)
[370.867590] Starting subtest: pipe-C-query-forked-busy-hang
[385.556680] Subtest pipe-C-query-forked-busy-hang: SUCCESS (14.688s)
[386.435007] [045/142] (628s left) gem_exec_fence (submit67)
[386.641401] Starting subtest: submit67
[386.646418] Subtest submit67: SKIP (0.000s)
[388.823750] [046/142] (625s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[389.231723] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[390.247917] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.016s)
[391.432732] [047/142] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[391.498668] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[394.138927] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.648s)
[394.281762] [048/142] (620s left) gem_userptr_blits (usage-restrictions)
[394.345727] Starting subtest: usage-restrictions
[394.347821] Subtest usage-restrictions: SUCCESS (0.000s)
[394.462970] [049/142] (620s left) gem_cs_tlb (engines)
[394.533013] Starting subtest: engines
[394.535097] Starting dynamic subtest: rcs0
[396.690238] Dynamic subtest rcs0: SUCCESS (2.153s)
[396.706276] Starting dynamic subtest: bcs0
[398.840749] Dynamic subtest bcs0: SUCCESS (2.149s)
[398.856250] Starting dynamic subtest: vcs0
[400.990802] Dynamic subtest vcs0: SUCCESS (2.150s)
[401.002105] Starting dynamic subtest: vcs1
[403.141580] Dynamic subtest vcs1: SUCCESS (2.150s)
[403.152751] Starting dynamic subtest: vecs0
[405.294760] Dynamic subtest vecs0: SUCCESS (2.153s)
[405.311832] Starting dynamic subtest: ccs0
[407.447105] Dynamic subtest ccs0: SUCCESS (2.150s)
[407.449534] Subtest engines: SUCCESS (12.910s)
[407.548017] [050/142] (607s left) kms_psr (primary_mmap_cpu)
[407.640293] Starting subtest: primary_mmap_cpu
[409.453109] Subtest primary_mmap_cpu: SUCCESS (1.812s)
[410.392905] [051/142] (604s left) dmabuf_sync_file (export-multiwait)
[410.440245] Starting subtest: export-multiwait
[410.442458] Subtest export-multiwait: SUCCESS (0.001s)
[410.489706] [052/142] (604s left) gem_create (create-valid-nonaligned)
[410.538264] Starting subtest: create-valid-nonaligned
[410.540496] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[410.718553] [053/142] (603s left) prime_busy (hang-wait)
[410.774779] Starting subtest: hang-wait
[410.776814] Starting dynamic subtest: rcs0
[424.319180] Dynamic subtest rcs0: SUCCESS (13.543s)
[424.335472] Starting dynamic subtest: bcs0
[431.404335] Dynamic subtest bcs0: SUCCESS (7.084s)
[431.420056] Starting dynamic subtest: vcs0
[438.442383] Dynamic subtest vcs0: SUCCESS (7.040s)
[438.454545] Starting dynamic subtest: vcs1
[445.421230] Dynamic subtest vcs1: SUCCESS (6.976s)
[445.426932] Starting dynamic subtest: vecs0
[452.463180] Dynamic subtest vecs0: SUCCESS (7.040s)
[452.479143] Starting dynamic subtest: ccs0
[466.291797] Dynamic subtest ccs0: SUCCESS (13.829s)
[466.294255] Subtest hang-wait: SUCCESS (55.518s)
[466.393913] [054/142] (548s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[466.756094] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[467.637703] [055/142] (547s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[467.700007] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[467.704905] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[468.889043] [056/142] (545s left) kms_rotation_crc (primary-rotation-270)
[468.965379] Starting subtest: primary-rotation-270
[468.970224] Subtest primary-rotation-270: SKIP (0.001s)
[469.027890] [057/142] (545s left) syncobj_timeline (single-wait-available-submitted)
[469.079419] Starting subtest: single-wait-available-submitted
[469.081769] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[469.128156] [058/142] (545s left) gem_ctx_persistence (engines-mixed-process)
[469.200402] Starting subtest: engines-mixed-process
[469.203062] Starting dynamic subtest: rcs0
[470.737834] Dynamic subtest rcs0: SUCCESS (1.539s)
[470.754218] Starting dynamic subtest: bcs0
[472.788253] Dynamic subtest bcs0: SUCCESS (2.049s)
[472.805547] Starting dynamic subtest: vcs0
[492.841026] Dynamic subtest vcs0: SUCCESS (20.052s)
[492.857965] Starting dynamic subtest: vcs1
[512.898262] Dynamic subtest vcs1: SUCCESS (20.056s)
[512.914693] Starting dynamic subtest: vecs0
[532.957809] Dynamic subtest vecs0: SUCCESS (20.058s)
[532.975735] Starting dynamic subtest: ccs0
[534.738345] Dynamic subtest ccs0: SUCCESS (1.779s)
[534.740796] Subtest engines-mixed-process: SUCCESS (65.541s)
[534.809833] [059/142] (480s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[534.908294] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[534.910699] Starting dynamic subtest: pipe-A-default-mode
[537.818859] Dynamic subtest pipe-A-default-mode: SUCCESS (2.909s)
[537.821254] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.912s)
[538.710679] [060/142] (476s left) kms_content_protection (mei-interface)
[538.812117] Starting subtest: mei-interface
[538.816863] Subtest mei-interface: SKIP (0.001s)
[538.923717] [061/142] (475s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[539.012498] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[539.016916] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[539.102504] [062/142] (475s left) kms_addfb_basic (bad-pitch-0)
[539.138622] Starting subtest: bad-pitch-0
[539.140999] Subtest bad-pitch-0: SUCCESS (0.000s)
[539.242035] [063/142] (475s left) gem_ctx_bad_destroy (invalid-ctx)
[539.299032] Starting subtest: invalid-ctx
[539.301949] Subtest invalid-ctx: SUCCESS (0.000s)
[539.364887] [064/142] (475s left) kms_vblank (pipe-d-wait-forked-busy-hang)
[539.429591] Starting subtest: pipe-D-wait-forked-busy-hang
[554.603928] Subtest pipe-D-wait-forked-busy-hang: SUCCESS (15.175s)
[555.544740] [065/142] (459s left) kms_big_fb (linear-64bpp-rotate-180)
[555.629390] Starting subtest: linear-64bpp-rotate-180
[557.319892] Subtest linear-64bpp-rotate-180: SUCCESS (1.690s)
[557.504577] [066/142] (457s left) gem_pxp (regular-baseline-src-copy-readible)
[560.084416] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[560.148546] [067/142] (454s left) kms_force_connector_basic (force-load-detect)
[560.224483] Starting subtest: force-load-detect
[560.229412] Subtest force-load-detect: SKIP (0.000s)
[560.328325] [068/142] (454s left) gem_exec_reloc (basic-write-cpu)
[560.386079] Subtest basic-write-cpu: SKIP (0.000s)
[560.435294] [069/142] (454s left) vc4/vc4_perfmon (create-perfmon-0)
[560.529645] Subtest create-perfmon-0: SKIP (0.000s)
[560.581610] [070/142] (454s left) sw_sync (sync_merge_invalid)
[560.621643] Starting subtest: sync_merge_invalid
[560.627374] Subtest sync_merge_invalid: SUCCESS (0.003s)
[560.657778] [071/142] (454s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[560.745799] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[560.748153] Starting dynamic subtest: pipe-A-eDP-1
[560.762211] Dynamic subtest pipe-A-eDP-1: SKIP (0.012s)
[560.779020] Starting dynamic subtest: pipe-B-eDP-1
[560.783778] Dynamic subtest pipe-B-eDP-1: SKIP (0.015s)
[560.799267] Starting dynamic subtest: pipe-C-eDP-1
[560.804343] Dynamic subtest pipe-C-eDP-1: SKIP (0.015s)
[560.818127] Starting dynamic subtest: pipe-D-eDP-1
[560.822119] Dynamic subtest pipe-D-eDP-1: SKIP (0.015s)
[560.826096] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.063s)
[560.873404] [072/142] (454s left) gem_userptr_blits (map-fixed-invalidate-busy)
[560.920226] Starting subtest: map-fixed-invalidate-busy
[560.924821] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[561.026570] [073/142] (454s left) gem_ctx_param (invalid-set-no-zeromap)
[561.086238] Starting subtest: invalid-set-no-zeromap
[561.088391] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[561.151583] [074/142] (454s left) i915_selftest (perf)
[562.717677] Starting subtest: perf
[562.720674] Starting dynamic subtest: engine_cs
[564.431079] Dynamic subtest engine_cs: SUCCESS (1.712s)
[564.442687] Starting dynamic subtest: request
[568.731309] Dynamic subtest request: SUCCESS (4.298s)
[568.744448] Starting dynamic subtest: migrate
[570.377628] Dynamic subtest migrate: SUCCESS (1.645s)
[570.390672] Starting dynamic subtest: region
[574.012646] Dynamic subtest region: SUCCESS (3.633s)
[574.015715] Subtest perf: SUCCESS (11.294s)
[574.038252] [075/142] (441s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[574.980916] Starting subtest: basic-batch-kernel-default-cmd
[574.985564] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[575.127092] [076/142] (440s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs)
[575.561439] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs
[575.564588] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.000s)
[576.404536] [077/142] (438s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[576.755645] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[577.645938] [078/142] (437s left) i915_pm_rc6_residency (rc6-idle)
[577.685564] Starting subtest: rc6-idle
[577.691409] Starting dynamic subtest: rcs0
[589.922748] Dynamic subtest rcs0: SUCCESS (12.232s)
[589.937978] Starting dynamic subtest: bcs0
[602.189483] Dynamic subtest bcs0: SUCCESS (12.265s)
[602.202836] Starting dynamic subtest: vcs0
[614.456581] Dynamic subtest vcs0: SUCCESS (12.266s)
[614.469276] Starting dynamic subtest: vecs0
[626.972812] Dynamic subtest vecs0: SUCCESS (12.515s)
[626.986853] Starting dynamic subtest: ccs0
[639.922039] Dynamic subtest ccs0: SUCCESS (12.949s)
[639.924518] Subtest rc6-idle: SUCCESS (62.241s)
[641.300728] [079/142] (374s left) kms_invalid_mode (bad-vsync-end)
[641.366587] Starting subtest: bad-vsync-end
[641.368979] Starting dynamic subtest: eDP-1-pipe-A
[641.646341] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.282s)
[641.660525] Starting dynamic subtest: eDP-1-pipe-B
[641.662581] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.001s)
[641.674530] Starting dynamic subtest: eDP-1-pipe-C
[641.676900] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.001s)
[641.686613] Starting dynamic subtest: eDP-1-pipe-D
[641.689381] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.001s)
[641.692175] Subtest bad-vsync-end: SUCCESS (0.293s)
[642.584697] [080/142] (372s left) gem_ctx_shared (single-timeline)
[642.639710] Starting subtest: single-timeline
[642.658451] Subtest single-timeline: SUCCESS (0.004s)
[642.856226] [081/142] (372s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[642.938264] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[646.204296] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.270s)
[646.338748] [082/142] (369s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[646.398456] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[646.400820] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[646.464573] [083/142] (369s left) gem_userptr_blits (vma-merge)
[646.528657] Starting subtest: vma-merge
[666.654976] Subtest vma-merge: FAIL (20.084s)
[666.685158] [084/142] (348s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[667.072287] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[667.077990] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[667.977892] [085/142] (347s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs)
[668.359437] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs
[668.364331] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.001s)
[669.274949] [086/142] (346s left) gem_render_copy (x-tiled)
[669.337926] Starting subtest: x-tiled
[669.340578] Starting dynamic subtest: smem
[669.379993] Dynamic subtest smem: SUCCESS (0.042s)
[669.382410] Subtest x-tiled: SUCCESS (0.043s)
[669.560918] [087/142] (346s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[669.628968] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[669.632999] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[669.713491] [088/142] (345s left) kms_plane_alpha_blend (alpha-basic)
[669.782445] Starting subtest: alpha-basic
[670.003900] Starting dynamic subtest: pipe-A-eDP-1
[671.946268] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[671.979247] Starting dynamic subtest: pipe-D-eDP-1
[674.726749] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.760s)
[674.729224] Subtest alpha-basic: SUCCESS (4.947s)
[675.671452] [089/142] (339s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[675.737395] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[675.741327] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[675.827525] [090/142] (339s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[676.013506] Starting subtest: cursor-rapid-movement-512x512
[676.018244] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[676.126203] [091/142] (339s left) kms_cursor_crc (cursor-offscreen-32x10)
[676.217492] Starting subtest: cursor-offscreen-32x10
[676.247040] Subtest cursor-offscreen-32x10: SKIP (0.025s)
[676.429623] [092/142] (339s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[676.496153] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[676.498514] Starting dynamic subtest: pipe-A-default-mode
[679.438532] Dynamic subtest pipe-A-default-mode: SUCCESS (2.940s)
[679.441110] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.942s)
[680.345053] [093/142] (335s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[680.421694] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[685.734137] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.318s)
[685.864430] [094/142] (329s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[685.938928] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[685.943463] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[686.031929] [095/142] (329s left) gem_fenced_exec_thrash (too-many-fences)
[686.091698] Subtest too-many-fences: SKIP (0.000s)
[686.131902] [096/142] (329s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs)
[686.533961] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs
[687.512159] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (0.979s)
[688.727647] [097/142] (327s left) gem_blits (basic)
[688.782046] Starting subtest: basic
[689.828126] Subtest basic: SUCCESS (1.047s)
[689.935268] [098/142] (325s left) gem_exec_fence (syncobj-export)
[690.367345] Starting subtest: syncobj-export
[690.370051] Subtest syncobj-export: SUCCESS (0.002s)
[691.787401] [099/142] (324s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt)
[691.878288] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt
[696.670249] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.796s)
[696.801292] [100/142] (319s left) kms_psr2_sf (plane-move-sf-dmg-area)
[702.022973] Starting subtest: plane-move-sf-dmg-area
[702.025560] Starting dynamic subtest: pipe-A-eDP-1
[707.559310] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.535s)
[707.572919] Starting dynamic subtest: pipe-B-eDP-1
[713.141191] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.582s)
[713.143605] Subtest plane-move-sf-dmg-area: SUCCESS (11.123s)
[714.067270] [101/142] (301s left) api_intel_allocator (fork-simple-stress)
[714.125723] Starting subtest: fork-simple-stress
[719.529484] Subtest fork-simple-stress: SUCCESS (5.407s)
[719.623787] [102/142] (296s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs)
[719.983190] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs
[721.086194] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.102s)
[722.262274] [103/142] (293s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[722.360898] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[725.349735] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.995s)
[725.492803] [104/142] (290s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[725.592737] Starting subtest: y-tiled-32bpp-rotate-270
[725.597098] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[725.686295] [105/142] (290s left) syncobj_wait (wait-any-snapshot)
[725.733047] Starting subtest: wait-any-snapshot
[725.813657] Subtest wait-any-snapshot: SUCCESS (0.082s)
[725.882866] [106/142] (290s left) gem_tiled_blits (basic)
[725.942830] Subtest basic: SKIP (0.000s)
[725.970076] [107/142] (290s left) gem_exec_balancer (bonded-chain)
[726.035884] Starting subtest: bonded-chain
[732.788194] Subtest bonded-chain: SUCCESS (6.750s)
[733.813399] [108/142] (282s left) sysfs_preempt_timeout (invalid)
[733.860828] Starting subtest: invalid
[733.863374] Starting dynamic subtest: vecs0
[733.865839] Dynamic subtest vecs0: SUCCESS (0.000s)
[733.880020] Starting dynamic subtest: ccs0
[733.882543] Dynamic subtest ccs0: SUCCESS (0.000s)
[733.893317] Starting dynamic subtest: vcs0
[733.895299] Dynamic subtest vcs0: SUCCESS (0.000s)
[733.903354] Starting dynamic subtest: bcs0
[733.905266] Dynamic subtest bcs0: SUCCESS (0.000s)
[733.912089] Starting dynamic subtest: rcs0
[733.914017] Dynamic subtest rcs0: SUCCESS (0.000s)
[733.920439] Starting dynamic subtest: vcs1
[733.922331] Dynamic subtest vcs1: SUCCESS (0.000s)
[733.924258] Subtest invalid: SUCCESS (0.003s)
[733.940108] [109/142] (282s left) kms_chamelium_audio (dp-audio)
[734.293612] Subtest dp-audio: SKIP (0.000s)
[735.155022] [110/142] (281s left) v3d/v3d_perfmon (create-single-perfmon)
[735.227572] Subtest create-single-perfmon: SKIP (0.000s)
[735.266683] [111/142] (280s left) i915_pm_rpm (fences)
[736.953049] Starting subtest: fences
[736.958616] Subtest fences: SKIP (0.000s)
[737.533704] [112/142] (278s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_mc_ccs)
[737.892807] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs
[737.900839] Subtest pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[738.763502] [113/142] (277s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[738.859189] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[738.863862] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[738.945630] [114/142] (277s left) gem_pwrite (basic-self)
[738.986281] Subtest basic-self: SKIP (0.000s)
[739.017819] [115/142] (277s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[739.110625] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[739.114890] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[739.190598] [116/142] (277s left) syncobj_timeline (etime-multi-wait-all-submitted)
[739.233570] Starting subtest: etime-multi-wait-all-submitted
[739.335486] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[739.404781] [117/142] (276s left) api_intel_bb (destroy-bb)
[739.448644] Starting subtest: destroy-bb
[739.464036] Subtest destroy-bb: SUCCESS (0.013s)
[739.555677] [118/142] (276s left) gen9_exec_parse (batch-invalid-length)
[739.601967] Subtest batch-invalid-length: SKIP (0.000s)
[739.629574] [119/142] (276s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[739.995426] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[740.003664] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[740.875904] [120/142] (275s left) gem_exec_parallel (fds)
[740.931170] Starting subtest: fds
[740.933710] Starting dynamic subtest: rcs0
[743.007229] Dynamic subtest rcs0: SUCCESS (2.075s)
[743.023934] Starting dynamic subtest: bcs0
[745.125527] Dynamic subtest bcs0: SUCCESS (2.118s)
[745.141710] Starting dynamic subtest: vcs0
[748.750714] Dynamic subtest vcs0: SUCCESS (3.623s)
[748.767368] Starting dynamic subtest: vcs1
[750.933055] Dynamic subtest vcs1: SUCCESS (2.182s)
[750.949954] Starting dynamic subtest: vecs0
[753.019019] Dynamic subtest vecs0: SUCCESS (2.084s)
[753.035727] Starting dynamic subtest: ccs0
[755.099966] Dynamic subtest ccs0: SUCCESS (2.080s)
[755.103190] Subtest fds: SUCCESS (14.169s)
[755.300516] [121/142] (261s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[755.404010] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[759.966244] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.565s)
[760.109457] [122/142] (256s left) gem_exec_schedule (semaphore-codependency)
[760.168872] Starting subtest: semaphore-codependency
[760.174483] Subtest semaphore-codependency: SUCCESS (0.007s)
[760.510396] [123/142] (256s left) gem_softpin (softpin)
[760.568767] Starting subtest: softpin
[792.940571] Subtest softpin: SUCCESS (32.368s)
[793.045129] [124/142] (223s left) kms_lease (lease-unleased-crtc)
[793.123337] Starting subtest: lease-unleased-crtc
[793.125849] Starting dynamic subtest: pipe-A-eDP-1
[793.410654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[793.427855] Starting dynamic subtest: pipe-B-eDP-1
[794.248775] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.836s)
[794.268734] Starting dynamic subtest: pipe-C-eDP-1
[794.271255] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[794.282696] Starting dynamic subtest: pipe-D-eDP-1
[794.284994] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[794.287309] Subtest lease-unleased-crtc: SUCCESS (1.150s)
[794.630900] [125/142] (221s left) gem_mmap_gtt (big-copy)
[794.677945] Subtest big-copy: SKIP (0.000s)
[794.706982] [126/142] (221s left) gem_gpgpu_fill (basic)
[794.765664] Starting subtest: basic
[794.768132] Starting dynamic subtest: smem
[794.770592] Dynamic subtest smem: SUCCESS (0.004s)
[794.772595] Subtest basic: SUCCESS (0.004s)
[794.868751] [127/142] (221s left) kms_setmode (invalid-clone-single-crtc-stealing)
[794.924802] Starting subtest: invalid-clone-single-crtc-stealing
[794.930498] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[794.977811] [128/142] (221s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[795.045155] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[795.049758] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[795.155288] [129/142] (221s left) kms_flip (bo-too-big)
[795.220568] Starting subtest: bo-too-big
[795.226720] Starting dynamic subtest: A-eDP1
[796.700984] Dynamic subtest A-eDP1: SUCCESS (1.473s)
[796.709994] Starting dynamic subtest: B-eDP1
[798.167067] Dynamic subtest B-eDP1: SUCCESS (1.465s)
[798.184064] Starting dynamic subtest: C-eDP1
[799.652437] Dynamic subtest C-eDP1: SUCCESS (1.484s)
[799.670158] Starting dynamic subtest: D-eDP1
[801.108626] Dynamic subtest D-eDP1: SUCCESS (1.455s)
[801.117536] Subtest bo-too-big: SUCCESS (5.898s)
[802.455190] [130/142] (214s left) gem_ctx_param (set-priority-invalid-size)
[802.507125] Starting subtest: set-priority-invalid-size
[802.509809] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[802.574519] [131/142] (214s left) kms_feature_discovery (display-4x)
[802.653383] Starting subtest: display-4x
[802.657923] Subtest display-4x: SKIP (0.000s)
[802.720882] [132/142] (214s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[802.802389] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[803.356895] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.559s)
[803.501681] [133/142] (213s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[803.573238] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[808.874152] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.304s)
[809.001167] [134/142] (207s left) gem_exec_reloc (basic-write-wc)
[809.066647] Subtest basic-write-wc: SKIP (0.000s)
[809.139316] [135/142] (207s left) v3d/v3d_wait_bo (map-bo-0ns)
[809.198234] Subtest map-bo-0ns: SKIP (0.000s)
[809.246519] [136/142] (207s left) kms_big_joiner (2x-modeset)
[809.318931] Subtest 2x-modeset: SKIP (0.000s)
[809.333402] [137/142] (207s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[809.413756] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[809.418392] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[809.496547] [138/142] (207s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[809.565047] Starting subtest: x-tiled-16bpp-rotate-180
[810.883239] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.314s)
[811.024631] [139/142] (205s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[811.108890] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[811.112395] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[811.192542] [140/142] (205s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[811.229281] Starting subtest: x-tiled-to-vebox-y-tiled
[811.233283] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[811.411253] [141/142] (205s left) kms_dp_aux_dev
[811.611156] [142/142] (205s left) gem_userptr_blits (unsync-unmap)
[811.673202] Subtest unsync-unmap: SKIP (0.000s)
[811.780789] Closing watchdogs
Done.