[52.483487] Initializing watchdogs [52.483680] /dev/watchdog0 [52.519190] [001/142] (960s left) kms_async_flips (test-time-stamp) [52.853806] Starting subtest: test-time-stamp [53.061643] Starting dynamic subtest: pipe-A-DP-1 [53.484646] Dynamic subtest pipe-A-DP-1: SUCCESS (0.434s) [53.680644] Starting dynamic subtest: pipe-B-DP-1 [53.989446] Dynamic subtest pipe-B-DP-1: SUCCESS (0.302s) [54.168569] Starting dynamic subtest: pipe-C-DP-1 [54.469483] Dynamic subtest pipe-C-DP-1: SUCCESS (0.294s) [54.488671] Subtest test-time-stamp: SUCCESS (1.599s) [54.965477] [002/142] (958s left) kms_vblank (pipe-a-wait-busy) [55.268514] Starting subtest: pipe-A-wait-busy [57.733946] Subtest pipe-A-wait-busy: SUCCESS (2.459s) [58.065227] [003/142] (955s left) gem_exec_store (basic) [58.361631] Starting subtest: basic [58.399991] Subtest basic: SUCCESS (0.091s) [58.628870] [004/142] (954s left) gem_media_fill (media-fill) [58.879408] Starting subtest: media-fill [58.901549] Starting dynamic subtest: smem [58.922770] Dynamic subtest smem: SUCCESS (0.011s) [58.943871] Subtest media-fill: SUCCESS (0.011s) [59.127725] [005/142] (954s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [59.439793] Starting subtest: cursorB-vs-flipB-toggle [59.477336] Subtest cursorB-vs-flipB-toggle: SKIP (0.002s) [59.565501] [006/142] (953s left) gem_flink_basic (flink-lifetime) [59.808647] Starting subtest: flink-lifetime [59.836235] Subtest flink-lifetime: SUCCESS (0.003s) [59.918810] [007/142] (953s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [60.230446] Starting subtest: planes-downscale-factor-0-5-unity-scaling [60.249734] Starting dynamic subtest: pipe-A-DP-1 [60.561594] Dynamic subtest pipe-A-DP-1: SUCCESS (0.340s) [60.593725] Starting dynamic subtest: pipe-B-DP-1 [60.942798] Dynamic subtest pipe-B-DP-1: SUCCESS (0.378s) [60.974609] Starting dynamic subtest: pipe-C-DP-1 [61.340212] Dynamic subtest pipe-C-DP-1: SUCCESS (0.397s) [61.362212] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (1.123s) [61.767252] [008/142] (951s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf) [62.024650] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [62.105942] [009/142] (951s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [62.652937] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s) [62.971054] [010/142] (950s left) vc4/vc4_tiling (get-bad-handle) [63.264456] Subtest get-bad-handle: SKIP (0.000s) [63.347691] [011/142] (950s left) kms_vblank (pipe-b-wait-busy-hang) [63.643564] Starting subtest: pipe-B-wait-busy-hang [71.116898] Subtest pipe-B-wait-busy-hang: SUCCESS (7.333s) [71.312045] [012/142] (942s left) kms_big_fb (4-tiled-addfb) [71.658671] Starting subtest: 4-tiled-addfb [71.701513] Subtest 4-tiled-addfb: SKIP (0.000s) [71.785872] [013/142] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [72.149503] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [72.191799] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [72.273745] [014/142] (941s left) gem_flink_basic (bad-flink) [72.505304] Starting subtest: bad-flink [72.524312] Subtest bad-flink: SUCCESS (0.000s) [72.604594] [015/142] (941s left) kms_vblank (pipe-d-query-forked-busy-hang) [72.918722] Subtest pipe-D-query-forked-busy-hang: SKIP (0.000s) [73.081603] [016/142] (941s left) gem_mmap_gtt (cpuset-big-copy) [73.314115] Starting subtest: cpuset-big-copy [95.357510] Subtest cpuset-big-copy: SUCCESS (22.074s) [95.816465] [017/142] (918s left) gem_exec_balancer (parallel-bb-first) [100.209876] Subtest parallel-bb-first: SKIP (0.000s) [100.293431] [018/142] (914s left) v3d/v3d_submit_cl (bad-bo) [100.588206] Subtest bad-bo: SKIP (0.000s) [100.676540] [019/142] (913s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_mc_ccs) [101.220188] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs [101.260212] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s) [101.598951] [020/142] (912s left) i915_hangman (hangcheck-unterminated) [101.835056] Starting subtest: hangcheck-unterminated [111.399767] Subtest hangcheck-unterminated: SUCCESS (9.446s) [111.483469] [021/142] (903s left) gem_softpin (allocator-evict) [111.721476] Starting subtest: allocator-evict [111.740190] Starting dynamic subtest: rcs0 [146.668894] Dynamic subtest rcs0: SUCCESS (34.969s) [146.706554] Starting dynamic subtest: bcs0 [184.503237] Dynamic subtest bcs0: SUCCESS (37.833s) [184.539345] Starting dynamic subtest: vcs0 [221.437628] Dynamic subtest vcs0: SUCCESS (36.934s) [221.472078] Starting dynamic subtest: vecs0 [258.351160] Dynamic subtest vecs0: SUCCESS (36.914s) [258.370395] Subtest allocator-evict: SUCCESS (146.651s) [258.468714] [022/142] (756s left) gem_mmap_wc (write-read) [258.808733] Starting subtest: write-read [258.827593] Subtest write-read: SUCCESS (0.034s) [258.930481] [023/142] (755s left) kms_rotation_crc (sprite-rotation-180) [259.477345] Starting subtest: sprite-rotation-180 [263.888747] Subtest sprite-rotation-180: SUCCESS (4.415s) [264.333400] [024/142] (750s left) kms_cursor_edge_walk (128x128-left-edge) [264.640523] Starting subtest: 128x128-left-edge [264.665765] Starting dynamic subtest: pipe-A-DP-1 [268.524368] Dynamic subtest pipe-A-DP-1: SUCCESS (3.872s) [268.564643] Starting dynamic subtest: pipe-C-DP-1 [272.013477] Dynamic subtest pipe-C-DP-1: SUCCESS (3.500s) [272.034798] Subtest 128x128-left-edge: SUCCESS (7.377s) [272.349941] [025/142] (742s left) syncobj_timeline (invalid-query-zero-handles) [272.604512] Starting subtest: invalid-query-zero-handles [272.623969] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [272.719408] [026/142] (742s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [272.979224] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [273.069053] [027/142] (742s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs) [273.617896] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s) [273.934840] [028/142] (741s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [274.241907] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [274.284999] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s) [274.377858] [029/142] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [274.747805] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [274.790086] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [274.876555] [030/142] (740s left) vgem_basic (dmabuf-mmap) [275.208217] Starting subtest: dmabuf-mmap [275.230266] Subtest dmabuf-mmap: SUCCESS (0.040s) [275.325189] [031/142] (740s left) kms_flip (2x-flip-vs-panning) [275.626785] Starting subtest: 2x-flip-vs-panning [275.665594] Subtest 2x-flip-vs-panning: SKIP (0.003s) [275.757789] [032/142] (739s left) i915_pm_rpm (system-suspend) [277.661778] Starting subtest: system-suspend