[17.807473] Initializing watchdogs
[17.807521]   /dev/watchdog0
[17.812169] [001/142] (960s left) kms_async_flips (test-time-stamp)
[17.900094] Starting subtest: test-time-stamp
[18.000337] Starting dynamic subtest: pipe-A-HDMI-A-1
[18.090215] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.089s)
[18.203511] Starting dynamic subtest: pipe-B-HDMI-A-1
[18.274340] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.073s)
[18.383743] Starting dynamic subtest: pipe-C-HDMI-A-1
[18.445978] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.065s)
[18.544561] Starting dynamic subtest: pipe-D-HDMI-A-1
[18.615339] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.072s)
[18.616153] Subtest test-time-stamp: SUCCESS (0.715s)
[18.795905] [002/142] (959s left) kms_vblank (pipe-a-wait-busy)
[18.879232] Starting subtest: pipe-A-wait-busy
[20.123799] Subtest pipe-A-wait-busy: SUCCESS (1.244s)
[20.215449] [003/142] (958s left) gem_exec_store (basic)
[20.263584] Starting subtest: basic
[20.322836] Subtest basic: SUCCESS (0.059s)
[20.472567] [004/142] (957s left) gem_media_fill (media-fill)
[20.521791] Starting subtest: media-fill
[20.522506] Starting dynamic subtest: smem
[20.526363] Dynamic subtest smem: SUCCESS (0.004s)
[20.527103] Subtest media-fill: SUCCESS (0.005s)
[20.706092] [005/142] (957s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[20.799548] Starting subtest: cursorB-vs-flipB-toggle
[20.802061] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[20.830988] [006/142] (957s left) gem_flink_basic (flink-lifetime)
[20.864258] Starting subtest: flink-lifetime
[20.865912] Subtest flink-lifetime: SUCCESS (0.001s)
[20.921467] [007/142] (957s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[21.015658] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[21.016505] Starting dynamic subtest: pipe-A-HDMI-A-1
[21.127423] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.111s)
[21.131835] Starting dynamic subtest: pipe-B-HDMI-A-1
[21.244955] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.116s)
[21.249382] Starting dynamic subtest: pipe-C-HDMI-A-1
[21.361308] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.115s)
[21.365520] Starting dynamic subtest: pipe-D-HDMI-A-1
[21.478477] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.116s)
[21.479211] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.463s)
[21.609611] [008/142] (956s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[21.651791] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[21.665871] [009/142] (956s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[21.908925] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[22.729807] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.820s)
[22.868110] [010/142] (955s left) vc4/vc4_tiling (get-bad-handle)
[22.924202] Subtest get-bad-handle: SKIP (0.000s)
[22.956292] [011/142] (955s left) kms_vblank (pipe-b-wait-busy-hang)
[23.040931] Starting subtest: pipe-B-wait-busy-hang
[36.842746] Subtest pipe-B-wait-busy-hang: SUCCESS (13.801s)
[36.950891] [012/142] (941s left) kms_big_fb (4-tiled-addfb)
[37.046507] Starting subtest: 4-tiled-addfb
[37.047915] Subtest 4-tiled-addfb: SKIP (0.000s)
[37.095170] [013/142] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[37.186537] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[37.188057] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[37.249069] [014/142] (941s left) gem_flink_basic (bad-flink)
[37.295254] Starting subtest: bad-flink
[37.295978] Subtest bad-flink: SUCCESS (0.000s)
[37.326120] [015/142] (941s left) kms_vblank (pipe-d-query-forked-busy-hang)
[37.415879] Starting subtest: pipe-D-query-forked-busy-hang
[51.176586] Subtest pipe-D-query-forked-busy-hang: SUCCESS (13.760s)
[51.284920] [016/142] (927s left) gem_mmap_gtt (cpuset-big-copy)
[51.319916] Starting subtest: cpuset-big-copy
[63.628691] Subtest cpuset-big-copy: SUCCESS (12.309s)
[63.680957] [017/142] (914s left) gem_exec_balancer (parallel-bb-first)
[63.976288] Starting subtest: parallel-bb-first
[64.787049] Subtest parallel-bb-first: SUCCESS (0.811s)
[64.820250] [018/142] (913s left) v3d/v3d_submit_cl (bad-bo)
[64.883927] Subtest bad-bo: SKIP (0.000s)
[64.912432] [019/142] (913s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_mc_ccs)
[65.107552] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs
[65.109299] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[65.223928] [020/142] (913s left) i915_hangman (hangcheck-unterminated)
[65.265228] Starting subtest: hangcheck-unterminated
[75.239048] Subtest hangcheck-unterminated: SUCCESS (9.974s)
[75.308908] [021/142] (903s left) gem_softpin (allocator-evict)
[75.352142] Starting subtest: allocator-evict
[75.353102] Starting dynamic subtest: rcs0
[98.298537] Dynamic subtest rcs0: SUCCESS (22.946s)
[98.303187] Starting dynamic subtest: bcs0
[121.177768] Dynamic subtest bcs0: SUCCESS (22.879s)
[121.183608] Starting dynamic subtest: vcs0
[143.780416] Dynamic subtest vcs0: SUCCESS (22.602s)
[143.785642] Starting dynamic subtest: vcs1
[166.281910] Dynamic subtest vcs1: SUCCESS (22.501s)
[166.286202] Starting dynamic subtest: vecs0
[188.797314] Dynamic subtest vecs0: SUCCESS (22.515s)
[188.798054] Subtest allocator-evict: SUCCESS (113.445s)
[188.835214] [022/142] (789s left) gem_mmap_wc (write-read)
[188.902755] Starting subtest: write-read
[188.903455] Subtest write-read: SUCCESS (0.001s)
[188.950563] [023/142] (789s left) kms_rotation_crc (sprite-rotation-180)
[189.036529] Starting subtest: sprite-rotation-180
[191.783342] Subtest sprite-rotation-180: SUCCESS (2.746s)
[191.928523] [024/142] (786s left) kms_cursor_edge_walk (128x128-left-edge)
[192.009056] Starting subtest: 128x128-left-edge
[192.010722] Starting dynamic subtest: pipe-A-HDMI-A-1
[193.811025] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.800s)
[193.815701] Starting dynamic subtest: pipe-D-HDMI-A-1
[195.484872] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.673s)
[195.485660] Subtest 128x128-left-edge: SUCCESS (3.476s)
[195.558388] [025/142] (783s left) syncobj_timeline (invalid-query-zero-handles)
[195.602704] Starting subtest: invalid-query-zero-handles
[195.603492] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[195.642288] [026/142] (782s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[195.678321] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[195.698919] [027/142] (782s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs)
[195.929558] Starting subtest: pipe-D-ccs-on-another-bo-yf_tiled_ccs
[195.931123] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[196.013650] [028/142] (782s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[196.100581] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[196.103661] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[196.140163] [029/142] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[196.237496] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[196.238856] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[196.285231] [030/142] (782s left) vgem_basic (dmabuf-mmap)
[196.370960] Starting subtest: dmabuf-mmap
[196.378561] Subtest dmabuf-mmap: SUCCESS (0.008s)
[196.408309] [031/142] (782s left) kms_flip (2x-flip-vs-panning)
[196.477339] Starting subtest: 2x-flip-vs-panning
[196.489096] Subtest 2x-flip-vs-panning: SKIP (0.012s)
[196.533484] [032/142] (782s left) i915_pm_rpm (system-suspend)
[198.032095] Starting subtest: system-suspend
[215.155048] Subtest system-suspend: SUCCESS (1.582s)
[219.343812] [033/142] (778s left) perf_pmu (event-wait)
[219.389142] Starting subtest: event-wait
[219.389901] Starting dynamic subtest: rcs0
[219.391332] Dynamic subtest rcs0: SKIP (0.000s)
[219.392689] Subtest event-wait: SKIP (0.001s)
[219.429224] [034/142] (778s left) perf (invalid-create-userspace-config)
[219.510572] Starting subtest: invalid-create-userspace-config
[219.512395] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[219.526512] [035/142] (778s left) kms_addfb_basic (unused-pitches)
[219.559864] Starting subtest: unused-pitches
[219.560690] Subtest unused-pitches: SUCCESS (0.000s)
[219.655185] [036/142] (778s left) perf (blocking-parameterized)
[219.721837] Starting subtest: blocking-parameterized
[239.738267] Subtest blocking-parameterized: SUCCESS (20.016s)
[239.754687] [037/142] (758s left) drm_fdinfo (basics)
[239.788391] Starting subtest: basics
[239.789194] Subtest basics: SUCCESS (0.000s)
[239.841407] [038/142] (758s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[240.041176] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[240.042936] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[240.155410] [039/142] (758s left) gem_exec_params (invalid-fence-in-submit)
[240.191137] Starting subtest: invalid-fence-in-submit
[240.193040] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[240.263733] [040/142] (758s left) kms_plane (plane-position-hole)
[240.356376] Starting subtest: plane-position-hole
[240.358029] Starting dynamic subtest: pipe-A-planes
[241.898042] Dynamic subtest pipe-A-planes: SUCCESS (1.541s)
[241.903848] Starting dynamic subtest: pipe-B-planes
[243.380444] Dynamic subtest pipe-B-planes: SUCCESS (1.481s)
[243.381290] Subtest plane-position-hole: SUCCESS (3.025s)
[243.469506] [041/142] (754s left) kms_rotation_crc (multiplane-rotation)
[243.555581] Starting subtest: multiplane-rotation
[253.552747] Subtest multiplane-rotation: SUCCESS (9.998s)
[253.629386] [042/142] (744s left) gem_softpin (noreloc)
[253.676164] Starting subtest: noreloc
[259.084695] Subtest noreloc: SUCCESS (5.408s)
[259.151682] [043/142] (739s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_mc_ccs)
[259.308676] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs
[259.310428] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[259.449124] [044/142] (738s left) kms_vblank (pipe-c-query-forked-busy-hang)
[259.531703] Starting subtest: pipe-C-query-forked-busy-hang
[273.566653] Subtest pipe-C-query-forked-busy-hang: SUCCESS (14.033s)
[273.681998] [045/142] (724s left) gem_exec_fence (submit67)
[273.846057] Starting subtest: submit67
[273.847281] Starting dynamic subtest: rcs0
[274.814739] Dynamic subtest rcs0: SUCCESS (0.968s)
[274.820281] Starting dynamic subtest: bcs0
[275.308238] Dynamic subtest bcs0: SUCCESS (0.493s)
[275.313281] Starting dynamic subtest: vcs0
[275.811524] Dynamic subtest vcs0: SUCCESS (0.503s)
[275.816948] Starting dynamic subtest: vcs1
[276.340287] Dynamic subtest vcs1: SUCCESS (0.528s)
[276.345304] Starting dynamic subtest: vecs0
[276.851398] Dynamic subtest vecs0: SUCCESS (0.510s)
[276.852139] Subtest submit67: SUCCESS (3.006s)
[277.273194] [046/142] (721s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[277.462890] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[277.464694] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[277.577243] [047/142] (720s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[277.665579] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[278.764309] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (1.100s)
[278.872065] [048/142] (719s left) gem_userptr_blits (usage-restrictions)
[278.917032] Starting subtest: usage-restrictions
[278.917735] Subtest usage-restrictions: SUCCESS (0.000s)
[279.003606] [049/142] (719s left) gem_cs_tlb (engines)
[279.044750] Starting subtest: engines
[279.045471] Starting dynamic subtest: rcs0
[281.197514] Dynamic subtest rcs0: SUCCESS (2.151s)
[281.202802] Starting dynamic subtest: bcs0
[283.349257] Dynamic subtest bcs0: SUCCESS (2.151s)
[283.354467] Starting dynamic subtest: vcs0
[285.501550] Dynamic subtest vcs0: SUCCESS (2.152s)
[285.507126] Starting dynamic subtest: vcs1
[287.653354] Dynamic subtest vcs1: SUCCESS (2.151s)
[287.658431] Starting dynamic subtest: vecs0
[289.805013] Dynamic subtest vecs0: SUCCESS (2.151s)
[289.805901] Subtest engines: SUCCESS (10.759s)
[289.868758] [050/142] (708s left) kms_psr (primary_mmap_cpu)
[289.915863] Subtest primary_mmap_cpu: SKIP (0.000s)
[289.930196] [051/142] (708s left) dmabuf_sync_file (export-multiwait)
[289.974505] Starting subtest: export-multiwait
[289.975320] Subtest export-multiwait: SUCCESS (0.000s)
[290.012347] [052/142] (708s left) gem_create (create-valid-nonaligned)
[290.059621] Starting subtest: create-valid-nonaligned
[290.060336] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[290.224461] [053/142] (708s left) prime_busy (hang-wait)
[290.267414] Starting subtest: hang-wait
[290.268157] Starting dynamic subtest: rcs0
[304.756882] Dynamic subtest rcs0: SUCCESS (14.487s)
[304.763670] Starting dynamic subtest: bcs0
[311.412689] Dynamic subtest bcs0: SUCCESS (6.654s)
[311.420317] Starting dynamic subtest: vcs0
[318.453244] Dynamic subtest vcs0: SUCCESS (7.038s)
[318.461631] Starting dynamic subtest: vcs1
[325.428945] Dynamic subtest vcs1: SUCCESS (6.974s)
[325.436686] Starting dynamic subtest: vecs0
[332.468959] Dynamic subtest vecs0: SUCCESS (7.038s)
[332.469942] Subtest hang-wait: SUCCESS (42.200s)
[332.550629] [054/142] (666s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[332.696505] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[332.751259] [055/142] (665s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[332.831310] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[332.832790] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[333.053137] [056/142] (665s left) kms_rotation_crc (primary-rotation-270)
[333.137747] Starting subtest: primary-rotation-270
[338.254675] Subtest primary-rotation-270: SUCCESS (5.116s)
[338.409317] [057/142] (660s left) syncobj_timeline (single-wait-available-submitted)
[338.444527] Starting subtest: single-wait-available-submitted
[338.445250] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[338.488392] [058/142] (660s left) gem_ctx_persistence (engines-mixed-process)
[338.529274] Starting subtest: engines-mixed-process
[338.530045] Starting dynamic subtest: rcs0
[338.846853] Dynamic subtest rcs0: SUCCESS (0.317s)
[338.852581] Starting dynamic subtest: bcs0
[339.176013] Dynamic subtest bcs0: SUCCESS (0.328s)
[339.192618] Starting dynamic subtest: vcs0
[340.791918] Dynamic subtest vcs0: SUCCESS (1.613s)
[340.798018] Starting dynamic subtest: vcs1
[341.126221] Dynamic subtest vcs1: SUCCESS (0.335s)
[341.136577] Starting dynamic subtest: vecs0
[341.448033] Dynamic subtest vecs0: SUCCESS (0.321s)
[341.448866] Subtest engines-mixed-process: SUCCESS (2.919s)
[341.499061] [059/142] (657s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[341.591390] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[341.593287] Starting dynamic subtest: pipe-A-valid-mode
[342.401334] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.808s)
[342.402103] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.810s)
[342.509109] [060/142] (656s left) kms_content_protection (mei-interface)
[342.602915] Starting subtest: mei-interface
[342.901299] Subtest mei-interface: SKIP (0.296s)
[343.031332] [061/142] (655s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[343.118111] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[343.119523] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[343.183999] [062/142] (655s left) kms_addfb_basic (bad-pitch-0)
[343.224574] Starting subtest: bad-pitch-0
[343.225298] Subtest bad-pitch-0: SUCCESS (0.000s)
[343.319608] [063/142] (655s left) gem_ctx_bad_destroy (invalid-ctx)
[343.357928] Starting subtest: invalid-ctx
[343.358741] Subtest invalid-ctx: SUCCESS (0.000s)
[343.404039] [064/142] (655s left) kms_vblank (pipe-d-wait-forked-busy-hang)
[343.491355] Starting subtest: pipe-D-wait-forked-busy-hang
[357.537393] Subtest pipe-D-wait-forked-busy-hang: SUCCESS (14.045s)
[357.645506] [065/142] (641s left) kms_big_fb (linear-64bpp-rotate-180)
[357.740003] Starting subtest: linear-64bpp-rotate-180
[358.940168] Subtest linear-64bpp-rotate-180: SUCCESS (1.200s)
[359.061581] [066/142] (639s left) gem_pxp (regular-baseline-src-copy-readible)
[361.614875] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[361.661621] [067/142] (637s left) kms_force_connector_basic (force-load-detect)
[361.794547] Starting subtest: force-load-detect
[361.796207] Subtest force-load-detect: SKIP (0.000s)
[361.953511] [068/142] (636s left) gem_exec_reloc (basic-write-cpu)
[361.990037] Starting subtest: basic-write-cpu
[361.993880] Subtest basic-write-cpu: SUCCESS (0.004s)
[362.078745] [069/142] (636s left) vc4/vc4_perfmon (create-perfmon-0)
[362.141170] Subtest create-perfmon-0: SKIP (0.000s)
[362.173050] [070/142] (636s left) sw_sync (sync_merge_invalid)
[362.216868] Starting subtest: sync_merge_invalid
[362.219598] Subtest sync_merge_invalid: SUCCESS (0.002s)
[362.238366] [071/142] (636s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[362.321337] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[362.323466] Starting dynamic subtest: pipe-A-HDMI-A-1
[362.336409] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[362.343054] Starting dynamic subtest: pipe-B-HDMI-A-1
[362.365430] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.026s)
[362.371989] Starting dynamic subtest: pipe-C-HDMI-A-1
[362.393894] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.027s)
[362.400478] Starting dynamic subtest: pipe-D-HDMI-A-1
[362.421553] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.026s)
[362.423028] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.099s)
[362.472196] [072/142] (636s left) gem_userptr_blits (map-fixed-invalidate-busy)
[362.520475] Starting subtest: map-fixed-invalidate-busy
[362.521335] Starting dynamic subtest: gtt
[363.928809] Dynamic subtest gtt: SUCCESS (1.407s)
[363.935003] Starting dynamic subtest: wb
[365.310488] Dynamic subtest wb: SUCCESS (1.381s)
[365.315531] Starting dynamic subtest: wc
[366.712318] Dynamic subtest wc: SUCCESS (1.401s)
[366.718105] Starting dynamic subtest: uc
[368.104214] Dynamic subtest uc: SUCCESS (1.391s)
[368.105034] Subtest map-fixed-invalidate-busy: SUCCESS (5.584s)
[368.178700] [073/142] (630s left) gem_ctx_param (invalid-set-no-zeromap)
[368.223418] Starting subtest: invalid-set-no-zeromap
[368.224149] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[368.265969] [074/142] (630s left) i915_selftest (perf)
[369.202040] Starting subtest: perf
[369.202890] Starting dynamic subtest: engine_cs
[369.919072] Dynamic subtest engine_cs: SUCCESS (0.716s)
[369.927743] Starting dynamic subtest: request
[373.584084] Dynamic subtest request: SUCCESS (3.664s)
[373.592511] Starting dynamic subtest: migrate
[374.214029] Dynamic subtest migrate: SUCCESS (0.626s)
[374.221960] Starting dynamic subtest: region
[375.753133] Dynamic subtest region: SUCCESS (1.540s)
[375.754535] Subtest perf: SUCCESS (6.551s)
[375.773835] [075/142] (623s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[376.180264] Starting subtest: basic-batch-kernel-default-cmd
[376.182030] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[376.353665] [076/142] (622s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs)
[376.576215] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs
[376.577740] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[376.652002] [077/142] (622s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[376.788279] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[376.843367] [078/142] (622s left) i915_pm_rc6_residency (rc6-idle)
[376.877581] Starting subtest: rc6-idle
[376.879898] Starting dynamic subtest: rcs0
[389.092279] Dynamic subtest rcs0: SUCCESS (12.212s)
[389.099901] Starting dynamic subtest: bcs0
[401.302488] Dynamic subtest bcs0: SUCCESS (12.209s)
[401.310488] Starting dynamic subtest: vcs0
[413.510224] Dynamic subtest vcs0: SUCCESS (12.207s)
[413.516840] Starting dynamic subtest: vecs0
[425.721187] Dynamic subtest vecs0: SUCCESS (12.210s)
[425.721993] Subtest rc6-idle: SUCCESS (48.845s)
[425.964096] [079/142] (572s left) kms_invalid_mode (bad-vsync-end)
[426.054276] Starting subtest: bad-vsync-end
[426.055081] Starting dynamic subtest: HDMI-A-1-pipe-A
[426.099099] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.044s)
[426.105422] Starting dynamic subtest: HDMI-A-1-pipe-B
[426.106295] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.001s)
[426.110972] Starting dynamic subtest: HDMI-A-1-pipe-C
[426.111740] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.000s)
[426.116328] Starting dynamic subtest: HDMI-A-1-pipe-D
[426.117061] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (0.001s)
[426.117765] Subtest bad-vsync-end: SUCCESS (0.052s)
[426.197729] [080/142] (572s left) gem_ctx_shared (single-timeline)
[426.247376] Starting subtest: single-timeline
[426.253570] Subtest single-timeline: SUCCESS (0.005s)
[426.416108] [081/142] (572s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[426.510348] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[428.050235] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (1.541s)
[428.154991] [082/142] (570s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[428.199459] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[428.200241] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[428.239648] [083/142] (570s left) gem_userptr_blits (vma-merge)
[428.295080] Starting subtest: vma-merge
[448.350092] Subtest vma-merge: FAIL (20.045s)
[448.377719] [084/142] (550s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[448.537782] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[448.539542] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[448.681013] [085/142] (550s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs)
[448.836597] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs
[448.839382] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.002s)
[448.989573] [086/142] (550s left) gem_render_copy (x-tiled)
[449.033968] Starting subtest: x-tiled
[449.034855] Starting dynamic subtest: smem
[449.129448] Dynamic subtest smem: SUCCESS (0.095s)
[449.130425] Subtest x-tiled: SUCCESS (0.096s)
[449.289635] [087/142] (549s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[449.382111] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[449.383516] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[449.452891] [088/142] (549s left) kms_plane_alpha_blend (alpha-basic)
[449.544274] Starting subtest: alpha-basic
[449.608617] Starting dynamic subtest: pipe-A-HDMI-A-1
[450.920340] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.311s)
[450.947312] Starting dynamic subtest: pipe-D-HDMI-A-1
[452.437136] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.495s)
[452.437975] Subtest alpha-basic: SUCCESS (2.893s)
[452.536675] [089/142] (546s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[452.630991] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[452.632410] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[452.692094] [090/142] (546s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[452.787139] Starting subtest: cursor-rapid-movement-512x512
[452.789683] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[452.860217] [091/142] (546s left) kms_cursor_crc (cursor-offscreen-32x10)
[452.954478] Starting subtest: cursor-offscreen-32x10
[453.003965] Subtest cursor-offscreen-32x10: SKIP (0.048s)
[453.051219] [092/142] (546s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[453.133929] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[453.134705] Starting dynamic subtest: pipe-A-valid-mode
[453.865743] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.731s)
[453.866545] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.733s)
[453.972190] [093/142] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[454.067284] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[454.068674] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[454.115855] [094/142] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[454.206285] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[454.207646] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[454.271351] [095/142] (544s left) gem_fenced_exec_thrash (too-many-fences)
[454.310088] Starting subtest: too-many-fences
[456.462924] Subtest too-many-fences: SUCCESS (2.153s)
[456.549298] [096/142] (542s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs)
[456.778128] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs
[456.779720] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[456.878543] [097/142] (542s left) gem_blits (basic)
[456.917753] Starting subtest: basic
[460.469652] Subtest basic: SUCCESS (3.551s)
[460.537784] [098/142] (538s left) gem_exec_fence (syncobj-export)
[460.852705] Starting subtest: syncobj-export
[460.854439] Subtest syncobj-export: SUCCESS (0.002s)
[461.124766] [099/142] (538s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt)
[461.218780] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt
[461.220294] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[461.289663] [100/142] (537s left) kms_psr2_sf (plane-move-sf-dmg-area)
[461.330091] Subtest plane-move-sf-dmg-area: SKIP (0.000s)
[461.350543] [101/142] (537s left) api_intel_allocator (fork-simple-stress)
[461.390777] Starting subtest: fork-simple-stress
[466.795180] Subtest fork-simple-stress: SUCCESS (5.405s)
[466.874218] [102/142] (532s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs)
[467.035755] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs
[467.037489] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[467.200347] [103/142] (532s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[467.291248] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[468.619764] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (1.329s)
[468.726691] [104/142] (530s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[468.819978] Starting subtest: y-tiled-32bpp-rotate-270
[469.794908] Subtest y-tiled-32bpp-rotate-270: SUCCESS (0.974s)
[469.934105] [105/142] (529s left) syncobj_wait (wait-any-snapshot)
[469.979838] Starting subtest: wait-any-snapshot
[470.061323] Subtest wait-any-snapshot: SUCCESS (0.082s)
[470.110374] [106/142] (529s left) gem_tiled_blits (basic)
[470.377465] Starting subtest: basic
[470.393769] Subtest basic: SUCCESS (0.017s)
[470.493100] [107/142] (528s left) gem_exec_balancer (bonded-chain)
[470.581127] Starting subtest: bonded-chain
[477.424722] Subtest bonded-chain: SUCCESS (6.843s)
[477.659764] [108/142] (521s left) sysfs_preempt_timeout (invalid)
[477.699266] Starting subtest: invalid
[477.700027] Starting dynamic subtest: vecs0
[477.700762] Dynamic subtest vecs0: SUCCESS (0.000s)
[477.706224] Starting dynamic subtest: vcs0
[477.706992] Dynamic subtest vcs0: SUCCESS (0.000s)
[477.712167] Starting dynamic subtest: bcs0
[477.712931] Dynamic subtest bcs0: SUCCESS (0.000s)
[477.717940] Starting dynamic subtest: rcs0
[477.718640] Dynamic subtest rcs0: SUCCESS (0.000s)
[477.723846] Starting dynamic subtest: vcs1
[477.724667] Dynamic subtest vcs1: SUCCESS (0.000s)
[477.725448] Subtest invalid: SUCCESS (0.004s)
[477.741984] [109/142] (521s left) kms_chamelium_audio (dp-audio)
[477.879186] Subtest dp-audio: SKIP (0.000s)
[477.935971] [110/142] (521s left) v3d/v3d_perfmon (create-single-perfmon)
[477.992939] Subtest create-single-perfmon: SKIP (0.000s)
[478.023275] [111/142] (521s left) i915_pm_rpm (fences)
[489.615284] Starting subtest: fences
[492.883518] Subtest fences: SUCCESS (3.268s)
[492.940077] [112/142] (506s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_mc_ccs)
[493.080241] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs
[493.082290] Subtest pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[493.237374] [113/142] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[493.326764] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[493.328215] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[493.383751] [114/142] (506s left) gem_pwrite (basic-self)
[493.421954] Starting subtest: basic-self
[493.459808] Subtest basic-self: SUCCESS (0.038s)
[493.527984] [115/142] (506s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[493.623231] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[493.624679] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[493.673561] [116/142] (505s left) syncobj_timeline (etime-multi-wait-all-submitted)
[493.711270] Starting subtest: etime-multi-wait-all-submitted
[493.818597] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[493.861966] [117/142] (505s left) api_intel_bb (destroy-bb)
[493.905363] Starting subtest: destroy-bb
[493.911025] Subtest destroy-bb: SUCCESS (0.006s)
[493.988902] [118/142] (505s left) gen9_exec_parse (batch-invalid-length)
[494.033014] Subtest batch-invalid-length: SKIP (0.000s)
[494.056988] [119/142] (505s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[494.222236] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[494.224713] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[494.355112] [120/142] (505s left) gem_exec_parallel (fds)
[494.399603] Starting subtest: fds
[494.400347] Starting dynamic subtest: rcs0
[497.675558] Dynamic subtest rcs0: SUCCESS (3.275s)
[497.681166] Starting dynamic subtest: bcs0
[500.718971] Dynamic subtest bcs0: SUCCESS (3.043s)
[500.733324] Starting dynamic subtest: vcs0
[504.126917] Dynamic subtest vcs0: SUCCESS (3.407s)
[504.141158] Starting dynamic subtest: vcs1
[507.386418] Dynamic subtest vcs1: SUCCESS (3.258s)
[507.401204] Starting dynamic subtest: vecs0
[510.994951] Dynamic subtest vecs0: SUCCESS (3.607s)
[510.995921] Subtest fds: SUCCESS (16.595s)
[511.182102] [121/142] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[511.286918] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[511.288329] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[511.334598] [122/142] (488s left) gem_exec_schedule (semaphore-codependency)
[511.390191] Starting subtest: semaphore-codependency
[511.393330] Subtest semaphore-codependency: SUCCESS (0.006s)
[511.677782] [123/142] (488s left) gem_softpin (softpin)
[511.721764] Starting subtest: softpin
[544.051371] Subtest softpin: SUCCESS (32.328s)
[544.118960] [124/142] (455s left) kms_lease (lease-unleased-crtc)
[544.208804] Starting subtest: lease-unleased-crtc
[544.209521] Starting dynamic subtest: pipe-A-HDMI-A-1
[544.289415] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.080s)
[544.296592] Starting dynamic subtest: pipe-B-HDMI-A-1
[544.327241] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.036s)
[544.333793] Starting dynamic subtest: pipe-C-HDMI-A-1
[544.364755] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.036s)
[544.371508] Starting dynamic subtest: pipe-D-HDMI-A-1
[544.401988] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.036s)
[544.402717] Subtest lease-unleased-crtc: SUCCESS (0.194s)
[544.496997] [125/142] (455s left) gem_mmap_gtt (big-copy)
[544.537131] Starting subtest: big-copy
[550.605595] Subtest big-copy: SUCCESS (6.069s)
[550.667110] [126/142] (449s left) gem_gpgpu_fill (basic)
[550.742801] Starting subtest: basic
[550.743547] Starting dynamic subtest: smem
[550.746441] Dynamic subtest smem: SUCCESS (0.003s)
[550.747170] Subtest basic: SUCCESS (0.004s)
[550.827028] [127/142] (448s left) kms_setmode (invalid-clone-single-crtc-stealing)
[550.868001] Starting subtest: invalid-clone-single-crtc-stealing
[550.870270] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[550.902103] [128/142] (448s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[550.996205] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[550.997602] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[551.060377] [129/142] (448s left) kms_flip (bo-too-big)
[551.132795] Starting subtest: bo-too-big
[551.134960] Starting dynamic subtest: A-HDMI-A1
[551.470739] Dynamic subtest A-HDMI-A1: SUCCESS (0.335s)
[551.482258] Starting dynamic subtest: B-HDMI-A1
[551.709813] Dynamic subtest B-HDMI-A1: SUCCESS (0.238s)
[551.716644] Starting dynamic subtest: C-HDMI-A1
[551.941598] Dynamic subtest C-HDMI-A1: SUCCESS (0.231s)
[551.951286] Starting dynamic subtest: D-HDMI-A1
[552.182312] Dynamic subtest D-HDMI-A1: SUCCESS (0.239s)
[552.185109] Subtest bo-too-big: SUCCESS (1.053s)
[552.361782] [130/142] (447s left) gem_ctx_param (set-priority-invalid-size)
[552.406294] Starting subtest: set-priority-invalid-size
[552.407039] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[552.455652] [131/142] (447s left) kms_feature_discovery (display-4x)
[552.545349] Starting subtest: display-4x
[552.546866] Subtest display-4x: SKIP (0.000s)
[552.580056] [132/142] (447s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[552.672538] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[552.924761] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.252s)
[553.038850] [133/142] (446s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[553.134053] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[553.135563] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[553.196753] [134/142] (446s left) gem_exec_reloc (basic-write-wc)
[553.238622] Starting subtest: basic-write-wc
[553.242782] Subtest basic-write-wc: SUCCESS (0.004s)
[553.330221] [135/142] (446s left) v3d/v3d_wait_bo (map-bo-0ns)
[553.383655] Subtest map-bo-0ns: SKIP (0.000s)
[553.417250] [136/142] (446s left) kms_big_joiner (2x-modeset)
[553.508323] Subtest 2x-modeset: SKIP (0.000s)
[553.531799] [137/142] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[553.617695] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[553.619301] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[553.679541] [138/142] (446s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[553.771200] Starting subtest: x-tiled-16bpp-rotate-180
[554.675598] Subtest x-tiled-16bpp-rotate-180: SUCCESS (0.904s)
[554.807694] [139/142] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[554.899450] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[554.900891] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[554.951731] [140/142] (445s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[554.999949] Starting subtest: x-tiled-to-vebox-y-tiled
[555.000783] Starting dynamic subtest: smem
[555.097113] Dynamic subtest smem: SUCCESS (0.097s)
[555.097978] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[555.258883] [141/142] (444s left) kms_dp_aux_dev
[555.427747] [142/142] (444s left) gem_userptr_blits (unsync-unmap)
[555.475353] Subtest unsync-unmap: SKIP (0.000s)
[555.554613] Closing watchdogs
Done.