[61.393886] Initializing watchdogs [61.393932] /dev/watchdog0 [61.408197] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [61.412333] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.414333] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.416315] [001/129] (960s left) kms_cursor_edge_walk (256x256-top-bottom) [61.592690] Starting subtest: 256x256-top-bottom [61.593650] Starting dynamic subtest: pipe-A-eDP-1 [65.002901] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s) [65.010103] Starting dynamic subtest: pipe-D-eDP-1 [68.107894] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s) [68.108879] Subtest 256x256-top-bottom: SUCCESS (6.547s) [68.896680] [002/129] (953s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [68.961363] Starting subtest: invalid-multi-wait-unsubmitted [68.962349] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [69.061314] [003/129] (952s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [69.157661] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [69.158670] Starting dynamic subtest: pipe-A-eDP-1 [69.167608] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [69.173598] Starting dynamic subtest: pipe-B-eDP-1 [69.182075] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [69.187187] Starting dynamic subtest: pipe-C-eDP-1 [69.195454] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [69.200600] Starting dynamic subtest: pipe-D-eDP-1 [69.210704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [69.212490] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.002s) [71.355244] [004/129] (950s left) gem_exec_schedule (pi-common) [71.704976] Starting subtest: pi-common [71.706257] Starting dynamic subtest: rcs0 [71.804371] Dynamic subtest rcs0: SUCCESS (0.100s) [71.816817] Starting dynamic subtest: bcs0 [71.884008] Dynamic subtest bcs0: SUCCESS (0.079s) [71.897631] Starting dynamic subtest: vcs0 [71.962678] Dynamic subtest vcs0: SUCCESS (0.077s) [71.973149] Starting dynamic subtest: vcs1 [72.038500] Dynamic subtest vcs1: SUCCESS (0.077s) [72.051469] Starting dynamic subtest: vecs0 [72.112823] Dynamic subtest vecs0: SUCCESS (0.074s) [72.125404] Starting dynamic subtest: ccs0 [72.185077] Dynamic subtest ccs0: SUCCESS (0.072s) [72.186733] Subtest pi-common: SUCCESS (0.482s) [72.437479] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true [72.439197] [005/129] (949s left) kms_addfb_basic (bad-pitch-65536) [72.492784] Starting subtest: bad-pitch-65536 [72.493792] Subtest bad-pitch-65536: SUCCESS (0.000s) [72.650221] [006/129] (949s left) gem_exec_gttfill (engines) [72.721791] Starting subtest: engines [72.722872] Starting dynamic subtest: rcs0 [97.553882] Dynamic subtest rcs0: SUCCESS (24.835s) [97.561655] Starting dynamic subtest: bcs0 [122.980733] Dynamic subtest bcs0: SUCCESS (25.424s) [122.988849] Starting dynamic subtest: vcs0 [148.349885] Dynamic subtest vcs0: SUCCESS (25.366s) [148.358103] Starting dynamic subtest: vcs1 [173.808055] Dynamic subtest vcs1: SUCCESS (25.458s) [173.814059] Starting dynamic subtest: vecs0 [199.204946] Dynamic subtest vecs0: SUCCESS (25.397s) [199.212216] Starting dynamic subtest: ccs0 [224.618364] Dynamic subtest ccs0: SUCCESS (25.412s) [224.619733] Subtest engines: SUCCESS (151.894s) [224.800254] [007/129] (797s left) syncobj_wait (invalid-wait-illegal-handle) [224.896454] Starting subtest: invalid-wait-illegal-handle [224.897443] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [225.010512] [008/129] (797s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [225.106558] Starting subtest: primary-4-tiled-reflect-x-0 [232.131363] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.024s) [233.364984] [009/129] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [233.464549] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [233.466236] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [233.572410] [010/129] (788s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [233.665619] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [233.666745] Starting dynamic subtest: pipe-A-eDP-1 [233.674908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [233.681878] Starting dynamic subtest: pipe-B-eDP-1 [233.689594] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [233.695871] Starting dynamic subtest: pipe-C-eDP-1 [233.703384] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [233.708829] Starting dynamic subtest: pipe-D-eDP-1 [233.716293] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [233.717096] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.003s) [235.824797] [011/129] (786s left) kms_draw_crc (draw-method-render) [235.926067] Starting subtest: draw-method-render [235.926886] Starting dynamic subtest: xrgb8888-untiled [236.155211] Dynamic subtest xrgb8888-untiled: SUCCESS (0.230s) [236.162030] Starting dynamic subtest: rgb565-untiled [236.366443] Dynamic subtest rgb565-untiled: SUCCESS (0.211s) [236.373938] Starting dynamic subtest: xrgb2101010-untiled [236.577604] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s) [236.583895] Starting dynamic subtest: xbgr16161616f-untiled [236.833248] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.255s) [236.839893] Starting dynamic subtest: xrgb8888-xtiled [236.977582] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [236.984822] Starting dynamic subtest: rgb565-xtiled [237.088865] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s) [237.095800] Starting dynamic subtest: xrgb2101010-xtiled [237.210911] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [237.216787] Starting dynamic subtest: xbgr16161616f-xtiled [237.355287] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.144s) [237.361986] Starting dynamic subtest: xrgb8888-4tiled [237.488572] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s) [237.495093] Starting dynamic subtest: rgb565-4tiled [237.610938] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s) [237.616776] Starting dynamic subtest: xrgb2101010-4tiled [237.722021] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s) [237.728950] Starting dynamic subtest: xbgr16161616f-4tiled [237.866301] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [237.867468] Subtest draw-method-render: SUCCESS (1.941s) [237.951033] [012/129] (784s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [238.070064] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [238.928172] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.859s) [239.197393] [013/129] (783s left) dumb_buffer (map-uaf) [239.261466] Starting subtest: map-uaf [239.278179] Subtest map-uaf: SUCCESS (0.018s) [239.393400] [014/129] (782s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [239.487783] Starting subtest: primary-yf-tiled-reflect-x-270 [239.489739] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [239.553535] [015/129] (782s left) kms_psr (pr-cursor-mmap-cpu) [239.658897] Starting subtest: pr-cursor-mmap-cpu [239.660890] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [239.723765] [016/129] (782s left) gem_pxp (hw-rejects-pxp-context) [239.855539] Starting subtest: hw-rejects-pxp-context [239.857535] Subtest hw-rejects-pxp-context: SKIP (0.000s) [239.971278] [017/129] (782s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [240.092448] Starting subtest: cursorB-vs-flipB-atomic-transitions [240.094485] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [240.185143] [018/129] (782s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [240.282591] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [240.284401] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [241.341289] [019/129] (781s left) kms_flip (2x-nonexisting-fb) [241.428679] Starting subtest: 2x-nonexisting-fb [241.440108] Subtest 2x-nonexisting-fb: SKIP (0.011s) [241.518432] [020/129] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [241.607761] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [241.609589] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [241.727115] [021/129] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [241.832331] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [241.834062] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [241.926990] [022/129] (780s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [242.026057] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [242.027970] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [242.118966] [023/129] (780s left) gem_ppgtt (blt-vs-render-ctxn) [242.170654] Starting subtest: blt-vs-render-ctxN [275.090641] Subtest blt-vs-render-ctxN: SUCCESS (32.915s) [275.233838] [024/129] (747s left) i915_suspend (basic-s3-without-i915) [275.281303] Starting subtest: basic-s3-without-i915 [278.760959] Subtest basic-s3-without-i915: SKIP (3.476s) [280.160561] [025/129] (742s left) kms_cursor_crc (cursor-rapid-movement-32x32) [280.313215] Starting subtest: cursor-rapid-movement-32x32 [280.342667] Subtest cursor-rapid-movement-32x32: SKIP (0.039s) [280.623220] [026/129] (742s left) gem_lmem_swapping (parallel-random-verify-ccs) [280.661090] Subtest parallel-random-verify-ccs: SKIP (0.000s) [280.690970] [027/129] (742s left) gem_userptr_blits (probe) [280.776915] Starting subtest: probe [280.865198] Subtest probe: SUCCESS (0.087s) [280.980113] [028/129] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [281.077235] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [281.078982] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [281.167311] [029/129] (741s left) kms_fbcon_fbt (psr) [281.226876] Starting subtest: psr [286.607967] Subtest psr: SUCCESS (5.378s) [286.683491] [030/129] (736s left) gem_ctx_param (invalid-ctx-get) [286.743443] Starting subtest: invalid-ctx-get [286.745137] Subtest invalid-ctx-get: SUCCESS (0.000s) [286.812398] [031/129] (736s left) perf (mi-rpc) [286.928837] Starting subtest: mi-rpc [286.930596] Subtest mi-rpc: SKIP (0.000s) [286.962412] [032/129] (735s left) kms_big_fb (x-tiled-16bpp-rotate-180) [287.067843] Starting subtest: x-tiled-16bpp-rotate-180 [288.396936] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.330s) [288.550207] [033/129] (734s left) drm_fdinfo (idle) [288.586927] Starting subtest: idle [288.588069] Starting dynamic subtest: rcs0 [289.165892] Dynamic subtest rcs0: SUCCESS (0.578s) [289.174175] Starting dynamic subtest: bcs0 [289.672994] Dynamic subtest bcs0: SUCCESS (0.504s) [289.682371] Starting dynamic subtest: vcs0 [290.178729] Dynamic subtest vcs0: SUCCESS (0.503s) [290.187360] Starting dynamic subtest: vcs1 [290.681823] Dynamic subtest vcs1: SUCCESS (0.504s) [290.688915] Starting dynamic subtest: vecs0 [291.186225] Dynamic subtest vecs0: SUCCESS (0.503s) [291.193361] Starting dynamic subtest: ccs0 [291.691496] Dynamic subtest ccs0: SUCCESS (0.504s) [291.692859] Subtest idle: SUCCESS (3.102s) [291.762022] [034/129] (731s left) kms_psr (psr2-sprite-render) [291.861940] Starting subtest: psr2-sprite-render [291.862847] Starting dynamic subtest: eDP-1 [293.618670] Dynamic subtest eDP-1: SUCCESS (1.755s) [293.619896] Subtest psr2-sprite-render: SUCCESS (1.755s) [294.474431] [035/129] (728s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [294.527119] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [294.585891] [036/129] (728s left) kms_vrr (flip-suspend) [294.677813] Starting subtest: flip-suspend [294.680709] Subtest flip-suspend: SKIP (0.000s) [294.744007] [037/129] (728s left) syncobj_timeline (single-wait-all-signaled) [294.799187] Starting subtest: single-wait-all-signaled [294.800412] Subtest single-wait-all-signaled: SUCCESS (0.001s) [294.903679] [038/129] (728s left) gem_exec_async (concurrent-writes) [294.963249] Starting subtest: concurrent-writes [294.964357] Starting dynamic subtest: rcs0 [294.977074] Dynamic subtest rcs0: SUCCESS (0.014s) [294.985984] Starting dynamic subtest: bcs0 [294.986887] Dynamic subtest bcs0: SUCCESS (0.007s) [294.993494] Starting dynamic subtest: vcs0 [294.994347] Dynamic subtest vcs0: SUCCESS (0.004s) [295.000134] Starting dynamic subtest: vcs1 [295.001047] Dynamic subtest vcs1: SUCCESS (0.007s) [295.007485] Starting dynamic subtest: vecs0 [295.008382] Dynamic subtest vecs0: SUCCESS (0.007s) [295.014075] Starting dynamic subtest: ccs0 [295.014910] Dynamic subtest ccs0: SUCCESS (0.006s) [295.015827] Subtest concurrent-writes: SUCCESS (0.046s) [295.259975] [039/129] (727s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [295.352835] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [295.364766] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s) [295.434245] [040/129] (727s left) kms_psr (fbc-pr-no-drrs) [295.534176] Starting subtest: fbc-pr-no-drrs [295.536100] Subtest fbc-pr-no-drrs: SKIP (0.000s) [295.599040] [041/129] (727s left) gem_exec_schedule (wide) [295.784314] Starting subtest: wide [295.785812] Starting dynamic subtest: rcs0 [304.390937] Dynamic subtest rcs0: SUCCESS (8.605s) [304.397700] Starting dynamic subtest: vcs0 [314.855736] Dynamic subtest vcs0: SUCCESS (10.464s) [314.864860] Starting dynamic subtest: vcs1 [323.641853] Dynamic subtest vcs1: SUCCESS (8.786s) [323.649122] Starting dynamic subtest: vecs0 [333.800775] Dynamic subtest vecs0: SUCCESS (10.158s) [333.809015] Starting dynamic subtest: ccs0 [345.759643] Dynamic subtest ccs0: SUCCESS (11.958s) [345.760964] Subtest wide: SUCCESS (49.973s) [347.064748] [042/129] (676s left) core_auth (getclient-master-drop) [347.099097] Starting subtest: getclient-master-drop [347.128863] Subtest getclient-master-drop: SUCCESS (0.029s) [347.240179] [043/129] (675s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [347.288276] Starting subtest: etime-multi-wait-for-submit-unsubmitted [347.399370] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s) [347.469402] [044/129] (675s left) kms_lease (cursor-implicit-plane) [347.561781] Starting subtest: cursor-implicit-plane [347.562812] Starting dynamic subtest: pipe-A-eDP-1 [348.035138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s) [348.042030] Starting dynamic subtest: pipe-B-eDP-1 [349.180791] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s) [349.187995] Starting dynamic subtest: pipe-C-eDP-1 [350.298787] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s) [350.306147] Starting dynamic subtest: pipe-D-eDP-1 [351.422887] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s) [351.424448] Subtest cursor-implicit-plane: SUCCESS (3.860s) [352.273639] [045/129] (670s left) kms_pm_dc (dc5-dpms-negative) [353.383134] Starting subtest: dc5-dpms-negative [353.384875] Subtest dc5-dpms-negative: SKIP (0.000s) [353.447675] [046/129] (669s left) gem_exec_reloc (basic-gtt-read-noreloc) [353.512910] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [353.587109] [047/129] (669s left) kms_cursor_crc (cursor-onscreen-256x85) [353.814597] Starting subtest: cursor-onscreen-256x85 [353.850700] Subtest cursor-onscreen-256x85: SKIP (0.035s) [354.021591] [048/129] (669s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu) [354.122192] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu [358.746041] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.622s) [358.854629] [049/129] (664s left) gem_ctx_engines (invalid-engines) [358.912826] Starting subtest: invalid-engines [358.920067] Subtest invalid-engines: SUCCESS (0.007s) [359.139731] [050/129] (664s left) kms_vblank (ts-continuation-modeset-hang) [359.245027] Starting subtest: ts-continuation-modeset-hang [359.245920] Starting dynamic subtest: pipe-A-eDP-1 [385.698999] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.452s) [385.708971] Starting dynamic subtest: pipe-D-eDP-1 [410.651973] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.947s) [410.653211] Subtest ts-continuation-modeset-hang: SUCCESS (51.406s) [411.519016] [051/129] (611s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [411.624517] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [414.996037] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (3.373s) [415.117143] [052/129] (608s left) kms_hdr (bpc-switch) [415.202768] Starting subtest: bpc-switch [416.224791] Starting dynamic subtest: pipe-A-eDP-1 [419.507649] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.283s) [419.508807] Subtest bpc-switch: SUCCESS (4.305s) [419.637509] [053/129] (603s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [419.727869] Starting subtest: psr-rgb101010-draw-render [424.846388] Subtest psr-rgb101010-draw-render: SUCCESS (5.119s) [424.975435] [054/129] (598s left) kms_concurrent (multi-plane-atomic-lowres) [425.070134] Starting subtest: multi-plane-atomic-lowres [425.071084] Starting dynamic subtest: pipe-A-eDP-1 [425.584518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.513s) [425.585556] Subtest multi-plane-atomic-lowres: SUCCESS (0.514s) [426.458254] [055/129] (597s left) kms_busy (basic-hang) [426.567861] Starting subtest: basic-hang [426.570329] Starting dynamic subtest: flip-pipe-A [427.180695] Dynamic subtest flip-pipe-A: SUCCESS (0.611s) [427.191476] Starting dynamic subtest: modeset-pipe-A [430.554328] Dynamic subtest modeset-pipe-A: SUCCESS (3.371s) [430.562323] Starting dynamic subtest: flip-pipe-D [431.824253] Dynamic subtest flip-pipe-D: SUCCESS (1.270s) [431.831040] Starting dynamic subtest: modeset-pipe-D [435.255230] Dynamic subtest modeset-pipe-D: SUCCESS (3.430s) [435.256155] Subtest basic-hang: SUCCESS (8.687s) [436.042928] [056/129] (587s left) i915_pm_freq_mult (media-freq) [436.097798] Starting subtest: media-freq [436.098895] Starting dynamic subtest: gt0 [436.100762] Dynamic subtest gt0: SKIP (0.000s) [436.108099] Starting dynamic subtest: gt1 [436.109707] Dynamic subtest gt1: SKIP (0.000s) [436.111415] Subtest media-freq: SKIP (0.001s) [436.194164] [057/129] (587s left) gem_mmap_offset (mmap-unmap) [436.248045] Starting subtest: mmap-unmap [436.249223] Starting dynamic subtest: smem0 [461.184444] Dynamic subtest smem0: SUCCESS (24.934s) [461.189119] Subtest mmap-unmap: SUCCESS (24.934s) [461.376895] [058/129] (562s left) kms_flip (plain-flip-ts-check) [461.487465] Starting subtest: plain-flip-ts-check [461.491110] Starting dynamic subtest: A-eDP1 [470.431984] Dynamic subtest A-eDP1: SUCCESS (8.942s) [470.441720] Starting dynamic subtest: B-eDP1 [479.358077] Dynamic subtest B-eDP1: SUCCESS (8.924s) [479.366944] Starting dynamic subtest: C-eDP1 [488.266428] Dynamic subtest C-eDP1: SUCCESS (8.907s) [488.275766] Starting dynamic subtest: D-eDP1 [497.097590] Dynamic subtest D-eDP1: SUCCESS (8.828s) [497.101509] Subtest plain-flip-ts-check: SUCCESS (35.611s) [498.258035] [059/129] (525s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [498.368736] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [498.369668] Starting dynamic subtest: pipe-A [499.969688] Dynamic subtest pipe-A: SUCCESS (1.600s) [499.977615] Starting dynamic subtest: pipe-B [502.619792] Dynamic subtest pipe-B: SUCCESS (2.649s) [502.627910] Starting dynamic subtest: pipe-C [503.786476] Dynamic subtest pipe-C: SUCCESS (1.164s) [503.795994] Starting dynamic subtest: pipe-D [505.011915] Dynamic subtest pipe-D: SUCCESS (1.226s) [505.012881] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.643s) [506.154935] [060/129] (517s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [506.278812] Starting subtest: flip-vs-cursor-crc-atomic [506.898935] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.618s) [507.688787] [061/129] (516s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [507.782503] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [507.793977] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [507.866896] [062/129] (515s left) syncobj_timeline (single-wait-available-submitted) [507.919949] Starting subtest: single-wait-available-submitted [507.921211] Subtest single-wait-available-submitted: SUCCESS (0.000s) [508.019099] [063/129] (515s left) kms_psr2_su (page_flip-p010) [508.080448] Subtest page_flip-P010: SKIP (0.000s) [508.136742] [064/129] (515s left) gem_exec_params (invalid-fence-in-submit) [508.196407] Starting subtest: invalid-fence-in-submit [508.200067] Subtest invalid-fence-in-submit: SUCCESS (0.003s) [508.343148] [065/129] (515s left) gem_workarounds (reset-fd) [508.400104] Starting subtest: reset-fd [508.583996] Subtest reset-fd: SUCCESS (0.184s) [508.717133] [066/129] (515s left) perf_pmu (semaphore-wait-idle) [508.755993] Starting subtest: semaphore-wait-idle [508.756934] Starting dynamic subtest: rcs0 [509.272425] Dynamic subtest rcs0: SUCCESS (0.512s) [509.283608] Starting dynamic subtest: bcs0 [509.786039] Dynamic subtest bcs0: SUCCESS (0.510s) [509.796610] Starting dynamic subtest: vcs0 [510.295405] Dynamic subtest vcs0: SUCCESS (0.509s) [510.305150] Starting dynamic subtest: vcs1 [510.811109] Dynamic subtest vcs1: SUCCESS (0.511s) [510.819476] Starting dynamic subtest: vecs0 [511.324841] Dynamic subtest vecs0: SUCCESS (0.512s) [511.333505] Starting dynamic subtest: ccs0 [511.841107] Dynamic subtest ccs0: SUCCESS (0.514s) [511.842695] Subtest semaphore-wait-idle: SUCCESS (3.083s) [513.007992] [067/129] (510s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [513.124318] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [513.126043] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [513.236812] [068/129] (510s left) syncobj_wait (invalid-reset-bad-pad) [513.289283] Starting subtest: invalid-reset-bad-pad [513.290152] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [513.404787] [069/129] (510s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [513.511071] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [514.369429] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.859s) [514.566995] [070/129] (509s left) gem_ctx_shared (q-promotion) [514.641490] Starting subtest: Q-promotion [514.642533] Starting dynamic subtest: rcs0 [514.748984] Dynamic subtest rcs0: SUCCESS (0.106s) [514.760295] Starting dynamic subtest: vcs0 [514.842030] Dynamic subtest vcs0: SUCCESS (0.091s) [514.858062] Starting dynamic subtest: vcs1 [514.929078] Dynamic subtest vcs1: SUCCESS (0.086s) [514.945162] Starting dynamic subtest: vecs0 [515.011325] Dynamic subtest vecs0: SUCCESS (0.081s) [515.026083] Starting dynamic subtest: ccs0 [515.104415] Dynamic subtest ccs0: SUCCESS (0.091s) [515.105987] Subtest Q-promotion: SUCCESS (0.462s) [516.023513] [071/129] (508s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [516.125834] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [516.128119] Starting dynamic subtest: pipe-A-default-mode [516.413549] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [516.415627] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.285s) [517.209270] [072/129] (506s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [517.312322] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [517.314040] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [517.417059] [073/129] (506s left) kms_atomic_interruptible (legacy-dpms) [517.511279] Starting subtest: legacy-dpms [517.512187] Starting dynamic subtest: pipe-A-eDP-1 [524.934161] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.423s) [524.935027] Subtest legacy-dpms: SUCCESS (7.424s) [525.760317] [074/129] (498s left) sysfs_heartbeat_interval (nopreempt) [525.811867] Starting subtest: nopreempt [525.813340] Starting dynamic subtest: vecs0 [534.965856] Dynamic subtest vecs0: SUCCESS (9.153s) [534.977287] Starting dynamic subtest: ccs0 [539.037260] Dynamic subtest ccs0: SUCCESS (4.067s) [539.050960] Starting dynamic subtest: vcs0 [548.940329] Dynamic subtest vcs0: SUCCESS (9.899s) [548.951961] Starting dynamic subtest: bcs0 [552.866437] Dynamic subtest bcs0: SUCCESS (3.926s) [552.876300] Starting dynamic subtest: rcs0 [556.947557] Dynamic subtest rcs0: SUCCESS (4.079s) [556.957307] Starting dynamic subtest: vcs1 [566.975360] Dynamic subtest vcs1: SUCCESS (10.024s) [566.976608] Subtest nopreempt: SUCCESS (41.160s) [567.045324] [075/129] (457s left) gem_mmap_wc (close) [567.099963] Subtest close: SKIP (0.000s) [567.156410] [076/129] (457s left) kms_psr (psr2-dpms) [567.255212] Starting subtest: psr2-dpms [567.256151] Starting dynamic subtest: eDP-1 [570.082591] Dynamic subtest eDP-1: SUCCESS (2.825s) [570.083629] Subtest psr2-dpms: SUCCESS (2.826s) [570.940437] [077/129] (453s left) kms_prop_blob (basic) [571.004491] Starting subtest: basic [571.005766] Subtest basic: SUCCESS (0.000s) [571.111019] [078/129] (453s left) gen7_exec_parse (oacontrol-tracking) [571.160214] Subtest oacontrol-tracking: SKIP (0.000s) [571.231724] [079/129] (453s left) kms_flip (2x-wf_vblank-ts-check) [571.324664] Starting subtest: 2x-wf_vblank-ts-check [571.335914] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [571.417269] [080/129] (452s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [571.522407] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [575.005318] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (3.483s) [575.170461] [081/129] (449s left) kms_setmode (basic) [575.223658] Starting subtest: basic [575.559199] Starting dynamic subtest: pipe-A-eDP-1 [577.590275] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.027s) [577.942025] Starting dynamic subtest: pipe-B-eDP-1 [580.018035] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.080s) [580.324387] Subtest basic: SUCCESS (5.099s) [581.153143] [082/129] (443s left) kms_atomic (plane-cursor-legacy) [581.248445] Starting subtest: plane-cursor-legacy [581.249448] Starting dynamic subtest: pipe-A-eDP-1 [581.624961] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s) [581.625949] Subtest plane-cursor-legacy: SUCCESS (0.376s) [582.473017] [083/129] (442s left) kms_big_fb (y-tiled-32bpp-rotate-270) [582.577245] Starting subtest: y-tiled-32bpp-rotate-270 [582.579115] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [582.692108] [084/129] (441s left) kms_big_fb (4-tiled-16bpp-rotate-90) [582.797830] Starting subtest: 4-tiled-16bpp-rotate-90 [582.818388] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s) [582.948419] [085/129] (441s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [583.044159] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [583.045824] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [583.150358] [086/129] (441s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [583.246985] Starting subtest: compare-crc-sanitycheck-xr24 [583.248023] Starting dynamic subtest: pipe-A-eDP-1 [583.873716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s) [583.881055] Starting dynamic subtest: pipe-B-eDP-1 [585.118882] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s) [585.126720] Starting dynamic subtest: pipe-C-eDP-1 [586.311737] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.190s) [586.324102] Starting dynamic subtest: pipe-D-eDP-1 [587.531083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s) [587.532139] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.284s) [588.383359] [087/129] (436s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [588.476883] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [588.478579] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [588.590542] [088/129] (436s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [588.651201] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [588.653910] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [588.826845] [089/129] (435s left) syncobj_wait (invalid-reset-illegal-handle) [588.881175] Starting subtest: invalid-reset-illegal-handle [588.882165] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [588.976432] [090/129] (435s left) perf (non-zero-reason) [589.048132] Starting subtest: non-zero-reason [589.049320] Starting dynamic subtest: 0-rcs0 [594.501594] Dynamic subtest 0-rcs0: SUCCESS (5.450s) [594.511179] Starting dynamic subtest: 1-vcs0 [598.449357] Dynamic subtest 1-vcs0: SUCCESS (3.947s) [598.450707] Subtest non-zero-reason: SUCCESS (9.399s) [598.485980] [091/129] (426s left) gem_mmap_gtt (flink-race) [598.540077] Subtest flink-race: SKIP (0.000s) [598.602250] [092/129] (426s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [598.703941] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [598.705748] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [598.814380] [093/129] (425s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [598.932382] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [599.915541] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.982s) [600.707268] [094/129] (424s left) gem_exec_balancer (semaphore) [600.780266] Starting subtest: semaphore [601.982993] Subtest semaphore: SUCCESS (1.200s) [602.301365] [095/129] (422s left) gem_exec_whisper (basic-queues-forked) [602.367065] Starting subtest: basic-queues-forked [626.876307] Subtest basic-queues-forked: SUCCESS (24.504s) [627.054461] [096/129] (397s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [632.066550] Starting subtest: fbc-pr-plane-move-sf-dmg-area [632.068599] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s) [632.899626] [097/129] (392s left) gem_ctx_param (basic-default) [632.948542] Starting subtest: basic-default [632.949623] Subtest basic-default: SUCCESS (0.000s) [633.015913] [098/129] (391s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [633.108871] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [633.109837] Starting dynamic subtest: pipe-A-eDP-1 [633.117741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [633.125737] Starting dynamic subtest: pipe-B-eDP-1 [633.133630] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [633.141414] Starting dynamic subtest: pipe-C-eDP-1 [633.149060] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [633.156389] Starting dynamic subtest: pipe-D-eDP-1 [633.163977] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [633.164929] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [635.249421] [099/129] (389s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [635.336843] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [635.337844] Starting dynamic subtest: pipe-A-eDP-1 [635.346603] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [635.356831] Starting dynamic subtest: pipe-B-eDP-1 [635.368055] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [635.377039] Starting dynamic subtest: pipe-C-eDP-1 [635.385490] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [635.392624] Starting dynamic subtest: pipe-D-eDP-1 [635.401513] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [635.403396] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [637.513095] [100/129] (387s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [637.619862] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [637.622019] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [637.706158] [101/129] (387s left) syncobj_timeline (invalid-transfer-bad-pad) [637.783642] Starting subtest: invalid-transfer-bad-pad [637.784821] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [637.893098] [102/129] (387s left) gem_reg_read (timestamp-monotonic) [637.948468] Starting subtest: timestamp-monotonic [642.250666] Subtest timestamp-monotonic: SUCCESS (4.299s) [642.318621] [103/129] (382s left) gem_softpin (invalid) [642.371409] Starting subtest: invalid [642.381395] Subtest invalid: SUCCESS (0.010s) [642.529900] [104/129] (382s left) gem_ctx_bad_destroy (invalid-pad) [642.578744] Starting subtest: invalid-pad [642.579925] Subtest invalid-pad: SUCCESS (0.000s) [642.648172] [105/129] (382s left) gem_barrier_race (remote-request) [642.705260] Starting subtest: remote-request [642.706349] Starting dynamic subtest: rcs0 [647.886987] Dynamic subtest rcs0: SUCCESS (5.180s) [647.894273] Subtest remote-request: SUCCESS (5.181s) [648.001567] [106/129] (377s left) kms_plane_alpha_blend (constant-alpha-max) [648.112931] Starting subtest: constant-alpha-max [648.548391] Starting dynamic subtest: pipe-A-eDP-1 [649.424994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.876s) [649.434502] Starting dynamic subtest: pipe-D-eDP-1 [650.999900] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.573s) [651.001059] Subtest constant-alpha-max: SUCCESS (2.886s) [651.866391] [107/129] (373s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [651.969978] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [651.971736] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [652.079259] [108/129] (373s left) kms_addfb_basic (invalid-set-prop) [652.141285] Starting subtest: invalid-set-prop [652.142303] Subtest invalid-set-prop: SUCCESS (0.000s) [652.273246] [109/129] (373s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [652.660259] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [653.466984] [110/129] (371s left) gem_exec_fence (nb-await) [653.654056] Starting subtest: nb-await [653.655303] Starting dynamic subtest: rcs0 [653.719092] Dynamic subtest rcs0: SUCCESS (0.065s) [653.728976] Starting dynamic subtest: bcs0 [653.782179] Dynamic subtest bcs0: SUCCESS (0.061s) [653.793673] Starting dynamic subtest: vcs0 [653.840735] Dynamic subtest vcs0: SUCCESS (0.056s) [653.850426] Starting dynamic subtest: vcs1 [653.898543] Dynamic subtest vcs1: SUCCESS (0.056s) [653.909665] Starting dynamic subtest: vecs0 [653.957070] Dynamic subtest vecs0: SUCCESS (0.057s) [653.966884] Starting dynamic subtest: ccs0 [654.014300] Dynamic subtest ccs0: SUCCESS (0.056s) [654.015663] Subtest nb-await: SUCCESS (0.361s) [656.000067] [111/129] (369s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [656.106430] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [656.108033] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [656.208028] [112/129] (369s left) kms_chamelium_frames (dp-crc-fast) [656.578855] Subtest dp-crc-fast: SKIP (0.000s) [657.392585] [113/129] (368s left) gem_request_retire (retire-vma-not-inactive) [657.443850] Starting subtest: retire-vma-not-inactive [657.503572] Subtest retire-vma-not-inactive: SUCCESS (0.058s) [657.652804] [114/129] (367s left) kms_cursor_crc (cursor-alpha-transparent) [657.750606] Starting subtest: cursor-alpha-transparent [657.751762] Starting dynamic subtest: pipe-A-eDP-1 [658.383466] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s) [658.391367] Starting dynamic subtest: pipe-D-eDP-1 [659.702504] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [659.703519] Subtest cursor-alpha-transparent: SUCCESS (1.953s) [660.565044] [115/129] (364s left) i915_pm_rpm (gem-pread) [662.114386] Starting subtest: gem-pread [664.476434] Subtest gem-pread: SUCCESS (2.363s) [664.592592] [116/129] (360s left) gen9_exec_parse (batch-zero-length) [664.651905] Subtest batch-zero-length: SKIP (0.000s) [664.748853] [117/129] (360s left) syncobj_wait (wait-all-interrupted) [664.804206] Starting subtest: wait-all-interrupted [664.906946] Subtest wait-all-interrupted: SUCCESS (0.101s) [664.976489] [118/129] (360s left) kms_psr (fbc-psr-dpms) [665.077584] Starting subtest: fbc-psr-dpms [665.078616] Starting dynamic subtest: eDP-1 [665.080461] Dynamic subtest eDP-1: SKIP (0.000s) [665.082211] Subtest fbc-psr-dpms: SKIP (0.001s) [665.143222] [119/129] (360s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [665.230900] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [665.232117] Starting dynamic subtest: pipe-A-default-mode [666.386034] Dynamic subtest pipe-A-default-mode: SKIP (1.153s) [666.387796] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.154s) [666.564098] [120/129] (359s left) gem_mmap_wc (invalid-flags) [666.619555] Subtest invalid-flags: SKIP (0.000s) [666.670967] [121/129] (359s left) gem_exec_flush (basic-batch-kernel-default-uc) [666.740718] Starting subtest: basic-batch-kernel-default-uc [673.700306] Subtest basic-batch-kernel-default-uc: SUCCESS (6.959s) [673.885426] [122/129] (351s left) api_intel_bb (lot-of-buffers) [673.945181] Starting subtest: lot-of-buffers [674.930307] Subtest lot-of-buffers: SUCCESS (0.983s) [675.754704] [123/129] (350s left) gem_ctx_persistence (hostile) [675.815861] Starting subtest: hostile [685.974804] Subtest hostile: SUCCESS (10.154s) [686.085637] [124/129] (339s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt) [686.190238] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt [686.192033] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [686.296058] [125/129] (339s left) kms_force_connector_basic (force-load-detect) [686.378415] Starting subtest: force-load-detect [686.380576] Subtest force-load-detect: SKIP (0.000s) [686.496145] [126/129] (339s left) kms_force_connector_basic (prune-stale-modes) [686.579466] Starting subtest: prune-stale-modes [686.976097] Subtest prune-stale-modes: SUCCESS (0.398s) [687.131132] [127/129] (338s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [687.195395] Starting subtest: mixed-tiled-to-yf-tiled-ccs [687.197467] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [687.374724] [128/129] (338s left) kms_plane_multiple (tiling-y) [687.473830] Starting subtest: tiling-y [687.475584] Subtest tiling-y: SKIP (0.000s) [687.538220] [129/129] (338s left) syncobj_eventfd (binary-wait-signaled) [687.589182] Starting subtest: binary-wait-signaled [687.590296] Subtest binary-wait-signaled: SUCCESS (0.000s) [687.685618] Closing watchdogs Done.