[37.732221] Initializing watchdogs
[37.732267]   /dev/watchdog0
[37.736781] [001/142] (960s left) kms_async_flips (test-time-stamp)
[37.805546] Starting subtest: test-time-stamp
[38.000653] Starting dynamic subtest: pipe-A-HDMI-A-2
[38.110741] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.108s)
[38.299456] Starting dynamic subtest: pipe-B-HDMI-A-2
[38.382440] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.084s)
[38.383951] Subtest test-time-stamp: SUCCESS (0.576s)
[38.657128] [002/142] (959s left) kms_vblank (pipe-a-wait-busy)
[38.736658] Starting subtest: pipe-A-wait-busy
[41.179135] Subtest pipe-A-wait-busy: SUCCESS (2.442s)
[41.329043] [003/142] (956s left) gem_exec_store (basic)
[41.377591] Starting subtest: basic
[41.443372] Subtest basic: SUCCESS (0.065s)
[41.614783] [004/142] (956s left) gem_media_fill (media-fill)
[41.666586] Starting subtest: media-fill
[41.667349] Starting dynamic subtest: smem
[41.669860] Dynamic subtest smem: SUCCESS (0.003s)
[41.670543] Subtest media-fill: SUCCESS (0.003s)
[41.879841] [005/142] (956s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[41.961928] Starting subtest: cursorB-vs-flipB-toggle
[41.963525] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[42.030802] [006/142] (956s left) gem_flink_basic (flink-lifetime)
[42.075875] Starting subtest: flink-lifetime
[42.077327] Subtest flink-lifetime: SUCCESS (0.001s)
[42.164962] [007/142] (956s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[42.248620] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[42.249319] Starting dynamic subtest: pipe-A-HDMI-A-2
[42.433820] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.183s)
[42.446554] Starting dynamic subtest: pipe-B-HDMI-A-2
[42.605766] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.170s)
[42.606950] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.357s)
[42.805557] [008/142] (955s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[42.853599] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[42.866092] [009/142] (955s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[43.029319] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[43.136378] [010/142] (955s left) vc4/vc4_tiling (get-bad-handle)
[43.196191] Subtest get-bad-handle: SKIP (0.000s)
[43.253538] [011/142] (955s left) kms_vblank (pipe-b-wait-busy-hang)
[43.336732] Starting subtest: pipe-B-wait-busy-hang
[56.832044] Subtest pipe-B-wait-busy-hang: SUCCESS (13.495s)
[56.989268] [012/142] (941s left) kms_big_fb (4-tiled-addfb)
[57.069369] Starting subtest: 4-tiled-addfb
[57.070695] Subtest 4-tiled-addfb: SKIP (0.000s)
[57.160378] [013/142] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[57.250584] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[57.251966] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[57.340801] [014/142] (941s left) gem_flink_basic (bad-flink)
[57.372066] Starting subtest: bad-flink
[57.372743] Subtest bad-flink: SUCCESS (0.000s)
[57.442616] [015/142] (941s left) kms_vblank (pipe-d-query-forked-busy-hang)
[57.525990] Subtest pipe-D-query-forked-busy-hang: SKIP (0.000s)
[57.592917] [016/142] (940s left) gem_mmap_gtt (cpuset-big-copy)
[57.636764] Starting subtest: cpuset-big-copy
[73.001859] Subtest cpuset-big-copy: SUCCESS (15.365s)
[73.106258] [017/142] (925s left) gem_exec_balancer (parallel-bb-first)
[74.094864] Subtest parallel-bb-first: SKIP (0.000s)
[74.152064] [018/142] (924s left) v3d/v3d_submit_cl (bad-bo)
[74.201824] Subtest bad-bo: SKIP (0.000s)
[74.255201] [019/142] (924s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_mc_ccs)
[74.442947] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[74.549274] [020/142] (924s left) i915_hangman (hangcheck-unterminated)
[74.596080] Starting subtest: hangcheck-unterminated
[84.214943] Subtest hangcheck-unterminated: SUCCESS (9.619s)
[84.294499] [021/142] (914s left) gem_softpin (allocator-evict)
[84.342960] Starting subtest: allocator-evict
[84.343658] Starting dynamic subtest: rcs0
[106.975528] Dynamic subtest rcs0: SUCCESS (22.632s)
[106.979759] Starting dynamic subtest: bcs0
[129.643863] Dynamic subtest bcs0: SUCCESS (22.668s)
[129.647942] Starting dynamic subtest: vcs0
[152.072806] Dynamic subtest vcs0: SUCCESS (22.429s)
[152.076818] Starting dynamic subtest: vecs0
[174.697085] Dynamic subtest vecs0: SUCCESS (22.624s)
[174.697859] Subtest allocator-evict: SUCCESS (90.354s)
[174.756823] [022/142] (823s left) gem_mmap_wc (write-read)
[174.820603] Starting subtest: write-read
[174.821369] Subtest write-read: SUCCESS (0.001s)
[174.939700] [023/142] (823s left) kms_rotation_crc (sprite-rotation-180)
[175.016692] Starting subtest: sprite-rotation-180
[180.250167] Subtest sprite-rotation-180: SUCCESS (5.233s)
[180.462975] [024/142] (818s left) kms_cursor_edge_walk (128x128-left-edge)
[180.545874] Starting subtest: 128x128-left-edge
[180.546716] Starting dynamic subtest: pipe-A-HDMI-A-2
[183.960716] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.414s)
[183.969677] Starting dynamic subtest: pipe-B-HDMI-A-2
[187.197288] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.234s)
[187.198262] Subtest 128x128-left-edge: SUCCESS (6.652s)
[187.312942] [025/142] (811s left) syncobj_timeline (invalid-query-zero-handles)
[187.362609] Starting subtest: invalid-query-zero-handles
[187.363327] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[187.432339] [026/142] (811s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[187.475579] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[187.497063] [027/142] (811s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs)
[187.674291] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[187.785315] [028/142] (810s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[187.867547] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[187.868906] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[187.934231] [029/142] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[188.018764] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[188.020107] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[188.121552] [030/142] (810s left) vgem_basic (dmabuf-mmap)
[188.190684] Starting subtest: dmabuf-mmap
[188.197367] Subtest dmabuf-mmap: SUCCESS (0.007s)
[188.239896] [031/142] (810s left) kms_flip (2x-flip-vs-panning)
[188.308187] Starting subtest: 2x-flip-vs-panning
[188.309540] Subtest 2x-flip-vs-panning: SKIP (0.001s)
[188.385417] [032/142] (810s left) i915_pm_rpm (system-suspend)
[189.905793] Starting subtest: system-suspend
[207.183424] Subtest system-suspend: SUCCESS (17.277s)
[210.459333] [033/142] (791s left) perf_pmu (event-wait)
[210.506538] Starting subtest: event-wait
[210.507243] Starting dynamic subtest: rcs0
[210.508618] Dynamic subtest rcs0: SKIP (0.000s)
[210.509968] Subtest event-wait: SKIP (0.000s)
[210.566528] [034/142] (791s left) perf (invalid-create-userspace-config)
[210.670659] Starting subtest: invalid-create-userspace-config
[210.671377] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[210.688476] [035/142] (791s left) kms_addfb_basic (unused-pitches)
[210.729691] Starting subtest: unused-pitches
[210.730365] Subtest unused-pitches: SUCCESS (0.000s)
[210.861894] [036/142] (791s left) perf (blocking-parameterized)
[210.943210] Starting subtest: blocking-parameterized
[230.958444] Subtest blocking-parameterized: SUCCESS (20.015s)
[230.972188] [037/142] (770s left) drm_fdinfo (basics)
[231.007492] Starting subtest: basics
[231.008335] Subtest basics: SUCCESS (0.000s)
[231.083343] [038/142] (770s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[231.281709] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[231.397428] [039/142] (770s left) gem_exec_params (invalid-fence-in-submit)
[231.440942] Starting subtest: invalid-fence-in-submit
[231.442427] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[231.549346] [040/142] (770s left) kms_plane (plane-position-hole)
[231.624741] Starting subtest: plane-position-hole
[231.625574] Starting dynamic subtest: pipe-A-planes
[233.469959] Dynamic subtest pipe-A-planes: SUCCESS (1.844s)
[233.477638] Starting dynamic subtest: pipe-B-planes
[235.182577] Dynamic subtest pipe-B-planes: SUCCESS (1.711s)
[235.183449] Subtest plane-position-hole: SUCCESS (3.559s)
[235.323419] [041/142] (766s left) kms_rotation_crc (multiplane-rotation)
[235.391788] Starting subtest: multiplane-rotation
[254.497556] Subtest multiplane-rotation: SUCCESS (19.102s)
[254.624981] [042/142] (747s left) gem_softpin (noreloc)
[254.667036] Starting subtest: noreloc
[260.060926] Subtest noreloc: SUCCESS (5.393s)
[260.165391] [043/142] (741s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_mc_ccs)
[260.337180] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs
[260.338501] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[260.458667] [044/142] (741s left) kms_vblank (pipe-c-query-forked-busy-hang)
[260.536467] Subtest pipe-C-query-forked-busy-hang: SKIP (0.000s)
[260.612865] [045/142] (741s left) gem_exec_fence (submit67)
[260.781305] Starting subtest: submit67
[260.782472] Starting dynamic subtest: rcs0
[261.561110] Dynamic subtest rcs0: SUCCESS (0.779s)
[261.566246] Starting dynamic subtest: bcs0
[262.021077] Dynamic subtest bcs0: SUCCESS (0.460s)
[262.025983] Starting dynamic subtest: vcs0
[262.515114] Dynamic subtest vcs0: SUCCESS (0.494s)
[262.519981] Starting dynamic subtest: vecs0
[262.998164] Dynamic subtest vecs0: SUCCESS (0.483s)
[262.998873] Subtest submit67: SUCCESS (2.218s)
[263.448687] [046/142] (738s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[263.620063] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[263.735502] [047/142] (738s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[263.809105] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[265.837154] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.031s)
[265.996532] [048/142] (736s left) gem_userptr_blits (usage-restrictions)
[266.037675] Starting subtest: usage-restrictions
[266.038341] Subtest usage-restrictions: SUCCESS (0.000s)
[266.154053] [049/142] (736s left) gem_cs_tlb (engines)
[266.196701] Starting subtest: engines
[266.197396] Starting dynamic subtest: rcs0
[268.348823] Dynamic subtest rcs0: SUCCESS (2.151s)
[268.354284] Starting dynamic subtest: bcs0
[270.499917] Dynamic subtest bcs0: SUCCESS (2.151s)
[270.504883] Starting dynamic subtest: vcs0
[272.650958] Dynamic subtest vcs0: SUCCESS (2.151s)
[272.656367] Starting dynamic subtest: vecs0
[274.802197] Dynamic subtest vecs0: SUCCESS (2.151s)
[274.802938] Subtest engines: SUCCESS (8.605s)
[274.901190] [050/142] (727s left) kms_psr (primary_mmap_cpu)
[274.939128] Subtest primary_mmap_cpu: SKIP (0.000s)
[274.962987] [051/142] (727s left) dmabuf_sync_file (export-multiwait)
[275.020944] Starting subtest: export-multiwait
[275.021831] Subtest export-multiwait: SUCCESS (0.000s)
[275.082678] [052/142] (727s left) gem_create (create-valid-nonaligned)
[275.125043] Starting subtest: create-valid-nonaligned
[275.125737] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[275.312690] [053/142] (726s left) prime_busy (hang-wait)
[275.356872] Starting subtest: hang-wait
[275.357544] Starting dynamic subtest: rcs0
[289.212349] Dynamic subtest rcs0: SUCCESS (13.853s)
[289.219693] Starting dynamic subtest: bcs0
[295.867831] Dynamic subtest bcs0: SUCCESS (6.653s)
[295.875497] Starting dynamic subtest: vcs0
[302.908409] Dynamic subtest vcs0: SUCCESS (7.038s)
[302.914831] Starting dynamic subtest: vecs0
[309.885059] Dynamic subtest vecs0: SUCCESS (6.974s)
[309.886145] Subtest hang-wait: SUCCESS (34.526s)
[309.971854] [054/142] (692s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[310.136133] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[310.207715] [055/142] (692s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[310.288618] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[310.290192] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[310.521114] [056/142] (691s left) kms_rotation_crc (primary-rotation-270)
[310.592510] Starting subtest: primary-rotation-270
[319.214235] Subtest primary-rotation-270: SUCCESS (8.623s)
[319.451872] [057/142] (682s left) syncobj_timeline (single-wait-available-submitted)
[319.493695] Starting subtest: single-wait-available-submitted
[319.494381] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[319.565454] [058/142] (682s left) gem_ctx_persistence (engines-mixed-process)
[319.607566] Starting subtest: engines-mixed-process
[319.608280] Starting dynamic subtest: rcs0
[319.936142] Dynamic subtest rcs0: SUCCESS (0.328s)
[319.942713] Starting dynamic subtest: bcs0
[320.271668] Dynamic subtest bcs0: SUCCESS (0.335s)
[320.290230] Starting dynamic subtest: vcs0
[320.597032] Dynamic subtest vcs0: SUCCESS (0.324s)
[320.602885] Starting dynamic subtest: vecs0
[320.915695] Dynamic subtest vecs0: SUCCESS (0.318s)
[320.917077] Subtest engines-mixed-process: SUCCESS (1.308s)
[321.003226] [059/142] (681s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[321.080341] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[321.082702] Starting dynamic subtest: pipe-A-valid-mode
[322.529449] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.447s)
[322.530725] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.449s)
[322.692851] [060/142] (679s left) kms_content_protection (mei-interface)
[322.767569] Starting subtest: mei-interface
[322.943818] Subtest mei-interface: SKIP (0.171s)
[323.159563] [061/142] (679s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[323.234418] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[323.235815] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[323.326669] [062/142] (679s left) kms_addfb_basic (bad-pitch-0)
[323.365758] Starting subtest: bad-pitch-0
[323.366416] Subtest bad-pitch-0: SUCCESS (0.000s)
[323.493402] [063/142] (679s left) gem_ctx_bad_destroy (invalid-ctx)
[323.535779] Starting subtest: invalid-ctx
[323.536440] Subtest invalid-ctx: SUCCESS (0.000s)
[323.605515] [064/142] (678s left) kms_vblank (pipe-d-wait-forked-busy-hang)
[323.682335] Subtest pipe-D-wait-forked-busy-hang: SKIP (0.000s)
[323.757725] [065/142] (678s left) kms_big_fb (linear-64bpp-rotate-180)
[323.839986] Starting subtest: linear-64bpp-rotate-180
[325.642619] Subtest linear-64bpp-rotate-180: SUCCESS (1.802s)
[325.770570] [066/142] (676s left) gem_pxp (regular-baseline-src-copy-readible)
[328.311065] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[328.375637] [067/142] (674s left) kms_force_connector_basic (force-load-detect)
[328.472983] Starting subtest: force-load-detect
[328.474309] Subtest force-load-detect: SKIP (0.000s)
[328.658135] [068/142] (673s left) gem_exec_reloc (basic-write-cpu)
[328.697602] Subtest basic-write-cpu: SKIP (0.000s)
[328.735225] [069/142] (673s left) vc4/vc4_perfmon (create-perfmon-0)
[328.809497] Subtest create-perfmon-0: SKIP (0.000s)
[328.873792] [070/142] (673s left) sw_sync (sync_merge_invalid)
[328.914016] Starting subtest: sync_merge_invalid
[328.916620] Subtest sync_merge_invalid: SUCCESS (0.002s)
[328.933399] [071/142] (673s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[329.000354] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[329.001120] Starting dynamic subtest: pipe-A-HDMI-A-2
[329.009404] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.008s)
[329.014482] Starting dynamic subtest: pipe-B-HDMI-A-2
[329.030506] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.020s)
[329.031841] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.030s)
[329.121496] [072/142] (673s left) gem_userptr_blits (map-fixed-invalidate-busy)
[329.170166] Starting subtest: map-fixed-invalidate-busy
[329.170854] Starting dynamic subtest: gtt
[329.867747] Dynamic subtest gtt: SUCCESS (0.697s)
[329.874099] Starting dynamic subtest: wb
[330.562613] Dynamic subtest wb: SUCCESS (0.694s)
[330.568090] Starting dynamic subtest: wc
[331.217274] Dynamic subtest wc: SUCCESS (0.654s)
[331.222648] Starting dynamic subtest: uc
[331.903365] Dynamic subtest uc: SUCCESS (0.686s)
[331.904086] Subtest map-fixed-invalidate-busy: SUCCESS (2.733s)
[332.027146] [073/142] (670s left) gem_ctx_param (invalid-set-no-zeromap)
[332.064465] Starting subtest: invalid-set-no-zeromap
[332.065240] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[332.134178] [074/142] (670s left) i915_selftest (perf)
[333.011950] Starting subtest: perf
[333.012869] Starting dynamic subtest: engine_cs
[334.848081] Dynamic subtest engine_cs: SUCCESS (1.835s)
[334.861806] Starting dynamic subtest: request
[339.609969] Dynamic subtest request: SUCCESS (4.760s)
[339.621871] Starting dynamic subtest: migrate
[341.375025] Dynamic subtest migrate: SUCCESS (1.763s)
[341.387504] Starting dynamic subtest: region
[344.004888] Dynamic subtest region: SUCCESS (2.628s)
[344.006371] Subtest perf: SUCCESS (10.993s)
[344.024099] [075/142] (658s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[345.576153] Starting subtest: basic-batch-kernel-default-cmd
[345.577517] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[345.731990] [076/142] (657s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs)
[345.912548] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[346.029394] [077/142] (656s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[346.175210] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[346.245207] [078/142] (656s left) i915_pm_rc6_residency (rc6-idle)
[346.283649] Starting subtest: rc6-idle
[346.286683] Starting dynamic subtest: rcs0
[358.549644] Dynamic subtest rcs0: SUCCESS (12.264s)
[358.558301] Starting dynamic subtest: bcs0
[370.758161] Dynamic subtest bcs0: SUCCESS (12.208s)
[370.766641] Starting dynamic subtest: vcs0
[382.967130] Dynamic subtest vcs0: SUCCESS (12.208s)
[382.975647] Starting dynamic subtest: vecs0
[395.177158] Dynamic subtest vecs0: SUCCESS (12.209s)
[395.177963] Subtest rc6-idle: SUCCESS (48.894s)
[395.447275] [079/142] (607s left) kms_invalid_mode (bad-vsync-end)
[395.523902] Starting subtest: bad-vsync-end
[395.524733] Starting dynamic subtest: HDMI-A-2-pipe-A
[395.612522] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (0.088s)
[395.623798] Starting dynamic subtest: HDMI-A-2-pipe-B
[395.624686] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (0.001s)
[395.625543] Subtest bad-vsync-end: SUCCESS (0.093s)
[395.779644] [080/142] (607s left) gem_ctx_shared (single-timeline)
[395.826895] Starting subtest: single-timeline
[395.832368] Subtest single-timeline: SUCCESS (0.004s)
[396.031592] [081/142] (606s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[396.110135] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[398.962887] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.855s)
[399.122242] [082/142] (603s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[399.157370] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[399.158080] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[399.224466] [083/142] (603s left) gem_userptr_blits (vma-merge)
[399.280991] Starting subtest: vma-merge
[419.340323] Subtest vma-merge: FAIL (20.049s)
[419.397294] [084/142] (583s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[419.560044] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[419.561409] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[419.680944] [085/142] (583s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs)
[419.846924] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs
[419.849228] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.001s)
[419.979469] [086/142] (583s left) gem_render_copy (x-tiled)
[420.021350] Starting subtest: x-tiled
[420.022061] Starting dynamic subtest: smem
[420.127919] Dynamic subtest smem: SUCCESS (0.106s)
[420.128614] Subtest x-tiled: SUCCESS (0.107s)
[420.306802] [087/142] (582s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[420.386071] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[420.387415] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[420.480114] [088/142] (582s left) kms_plane_alpha_blend (alpha-basic)
[420.550922] Starting subtest: alpha-basic
[420.607880] Starting dynamic subtest: pipe-A-HDMI-A-2
[423.108331] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.499s)
[423.134686] Starting dynamic subtest: pipe-B-HDMI-A-2
[425.723818] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.594s)
[425.724524] Subtest alpha-basic: SUCCESS (5.173s)
[425.860108] [089/142] (577s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[425.933985] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[425.935485] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[426.035174] [090/142] (577s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[426.115550] Starting subtest: cursor-rapid-movement-512x512
[426.116957] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[426.219088] [091/142] (576s left) kms_cursor_crc (cursor-offscreen-32x10)
[426.292026] Starting subtest: cursor-offscreen-32x10
[426.324169] Subtest cursor-offscreen-32x10: SKIP (0.031s)
[426.435776] [092/142] (576s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[426.510014] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[426.510700] Starting dynamic subtest: pipe-A-valid-mode
[427.989851] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.478s)
[427.991355] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (1.480s)
[428.146415] [093/142] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[428.221148] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[428.222463] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[428.312949] [094/142] (574s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[428.384214] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[428.385523] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[428.479256] [095/142] (574s left) gem_fenced_exec_thrash (too-many-fences)
[428.521702] Starting subtest: too-many-fences
[430.676246] Subtest too-many-fences: SUCCESS (2.151s)
[430.781373] [096/142] (572s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs)
[430.971627] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[431.088741] [097/142] (572s left) gem_blits (basic)
[431.126884] Starting subtest: basic
[434.274884] Subtest basic: SUCCESS (3.148s)
[434.380278] [098/142] (568s left) gem_exec_fence (syncobj-export)
[434.690240] Starting subtest: syncobj-export
[434.692141] Subtest syncobj-export: SUCCESS (0.002s)
[434.997631] [099/142] (568s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt)
[435.073955] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt
[435.075331] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[435.170297] [100/142] (568s left) kms_psr2_sf (plane-move-sf-dmg-area)
[435.211613] Subtest plane-move-sf-dmg-area: SKIP (0.000s)
[435.235099] [101/142] (568s left) api_intel_allocator (fork-simple-stress)
[435.271311] Starting subtest: fork-simple-stress
[440.676181] Subtest fork-simple-stress: SUCCESS (5.405s)
[440.783296] [102/142] (562s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs)
[440.952354] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs
[440.954078] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[441.093272] [103/142] (562s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[441.174687] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[443.644144] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.471s)
[443.787230] [104/142] (559s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[443.865996] Starting subtest: y-tiled-32bpp-rotate-270
[445.344467] Subtest y-tiled-32bpp-rotate-270: SUCCESS (1.478s)
[445.521987] [105/142] (557s left) syncobj_wait (wait-any-snapshot)
[445.565297] Starting subtest: wait-any-snapshot
[445.646794] Subtest wait-any-snapshot: SUCCESS (0.081s)
[445.730209] [106/142] (557s left) gem_tiled_blits (basic)
[445.987997] Starting subtest: basic
[445.996942] Subtest basic: SUCCESS (0.009s)
[446.116765] [107/142] (557s left) gem_exec_balancer (bonded-chain)
[446.204782] Starting subtest: bonded-chain
[446.975434] Subtest bonded-chain: SUCCESS (0.770s)
[447.937194] [108/142] (555s left) sysfs_preempt_timeout (invalid)
[447.977506] Starting subtest: invalid
[447.978210] Starting dynamic subtest: vecs0
[447.978908] Dynamic subtest vecs0: SUCCESS (0.000s)
[447.984183] Starting dynamic subtest: vcs0
[447.984878] Dynamic subtest vcs0: SUCCESS (0.000s)
[447.989993] Starting dynamic subtest: bcs0
[447.990699] Dynamic subtest bcs0: SUCCESS (0.000s)
[447.995824] Starting dynamic subtest: rcs0
[447.996513] Dynamic subtest rcs0: SUCCESS (0.000s)
[447.997202] Subtest invalid: SUCCESS (0.003s)
[448.057870] [109/142] (555s left) kms_chamelium_audio (dp-audio)
[448.207745] Subtest dp-audio: SKIP (0.000s)
[448.278954] [110/142] (555s left) v3d/v3d_perfmon (create-single-perfmon)
[448.349229] Subtest create-single-perfmon: SKIP (0.000s)
[448.412344] [111/142] (555s left) i915_pm_rpm (fences)
[449.997761] Starting subtest: fences
[452.745953] Subtest fences: SUCCESS (2.748s)
[452.952535] [112/142] (550s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_mc_ccs)
[453.091244] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs
[453.093262] Subtest pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[453.228242] [113/142] (550s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[453.304577] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[453.306028] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[453.394319] [114/142] (550s left) gem_pwrite (basic-self)
[453.435997] Subtest basic-self: SKIP (0.000s)
[453.471196] [115/142] (550s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[453.546349] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[453.547807] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[453.644481] [116/142] (550s left) syncobj_timeline (etime-multi-wait-all-submitted)
[453.685412] Starting subtest: etime-multi-wait-all-submitted
[453.793584] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[453.879428] [117/142] (549s left) api_intel_bb (destroy-bb)
[453.914806] Starting subtest: destroy-bb
[453.919449] Subtest destroy-bb: SUCCESS (0.005s)
[454.029827] [118/142] (549s left) gen9_exec_parse (batch-invalid-length)
[454.069096] Subtest batch-invalid-length: SKIP (0.000s)
[454.084895] [119/142] (549s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[454.261368] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[454.263539] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[454.379711] [120/142] (549s left) gem_exec_parallel (fds)
[454.423016] Starting subtest: fds
[454.423813] Starting dynamic subtest: rcs0
[456.351710] Dynamic subtest rcs0: SUCCESS (1.928s)
[456.374778] Starting dynamic subtest: bcs0
[458.251866] Dynamic subtest bcs0: SUCCESS (1.898s)
[458.275906] Starting dynamic subtest: vcs0
[460.184796] Dynamic subtest vcs0: SUCCESS (1.931s)
[460.207125] Starting dynamic subtest: vecs0
[462.110835] Dynamic subtest vecs0: SUCCESS (1.924s)
[462.112261] Subtest fds: SUCCESS (7.688s)
[462.312299] [121/142] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[462.387306] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[462.393399] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[462.487049] [122/142] (541s left) gem_exec_schedule (semaphore-codependency)
[462.534608] Starting subtest: semaphore-codependency
[462.538688] Subtest semaphore-codependency: SUCCESS (0.004s)
[462.846406] [123/142] (540s left) gem_softpin (softpin)
[462.890562] Starting subtest: softpin
[495.108433] Subtest softpin: SUCCESS (32.217s)
[495.221920] [124/142] (508s left) kms_lease (lease-unleased-crtc)
[495.291559] Starting subtest: lease-unleased-crtc
[495.292397] Starting dynamic subtest: pipe-A-HDMI-A-2
[495.397063] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.103s)
[495.405959] Starting dynamic subtest: pipe-B-HDMI-A-2
[495.435078] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.037s)
[495.435793] Subtest lease-unleased-crtc: SUCCESS (0.144s)
[495.555625] [125/142] (508s left) gem_mmap_gtt (big-copy)
[495.593471] Starting subtest: big-copy
[503.247998] Subtest big-copy: SUCCESS (7.654s)
[503.345986] [126/142] (500s left) gem_gpgpu_fill (basic)
[503.420671] Starting subtest: basic
[503.421370] Starting dynamic subtest: smem
[503.423030] Dynamic subtest smem: SUCCESS (0.002s)
[503.423780] Subtest basic: SUCCESS (0.003s)
[503.517892] [127/142] (500s left) kms_setmode (invalid-clone-single-crtc-stealing)
[503.561724] Starting subtest: invalid-clone-single-crtc-stealing
[503.563787] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[503.633942] [128/142] (500s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[503.715204] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[503.716557] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[503.822120] [129/142] (500s left) kms_flip (bo-too-big)
[503.892585] Starting subtest: bo-too-big
[503.894990] Starting dynamic subtest: A-HDMI-A2
[504.286182] Dynamic subtest A-HDMI-A2: SUCCESS (0.391s)
[504.304230] Starting dynamic subtest: B-HDMI-A2
[504.561350] Dynamic subtest B-HDMI-A2: SUCCESS (0.273s)
[504.564386] Subtest bo-too-big: SUCCESS (0.671s)
[504.800864] [130/142] (499s left) gem_ctx_param (set-priority-invalid-size)
[504.838681] Starting subtest: set-priority-invalid-size
[504.839386] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[504.927163] [131/142] (499s left) kms_feature_discovery (display-4x)
[505.003388] Starting subtest: display-4x
[505.004922] Subtest display-4x: SKIP (0.000s)
[505.082382] [132/142] (499s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[505.160752] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[505.448954] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.288s)
[505.594199] [133/142] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[505.663848] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[505.665293] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[505.764912] [134/142] (498s left) gem_exec_reloc (basic-write-wc)
[505.809243] Subtest basic-write-wc: SKIP (0.000s)
[505.867277] [135/142] (498s left) v3d/v3d_wait_bo (map-bo-0ns)
[505.950347] Subtest map-bo-0ns: SKIP (0.000s)
[506.014957] [136/142] (498s left) kms_big_joiner (2x-modeset)
[506.088845] Subtest 2x-modeset: SKIP (0.000s)
[506.106253] [137/142] (498s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[506.175419] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[506.176799] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[506.267387] [138/142] (497s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[506.344301] Starting subtest: x-tiled-16bpp-rotate-180
[507.707249] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.355s)
[507.843301] [139/142] (496s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[507.915474] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[507.916945] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[508.019045] [140/142] (496s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[508.060909] Starting subtest: x-tiled-to-vebox-y-tiled
[508.061673] Starting dynamic subtest: smem
[508.195694] Dynamic subtest smem: SUCCESS (0.126s)
[508.201259] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.127s)
[508.378050] [141/142] (495s left) kms_dp_aux_dev
[509.355475] [142/142] (494s left) gem_userptr_blits (unsync-unmap)
[509.395800] Subtest unsync-unmap: SKIP (0.000s)
[509.552835] Closing watchdogs
Done.