Test run: - Start at Mon Sep 28 04:10:44 UTC 2026 - Docker image: "monitor-test-runner:scli-manual-manual" - Container name: "test-run-bf5b373e-da52-4159-be38-01e72d0445e2" - Runner git commit: 3d31de04c823a30705ff3eab5a5f3c3f420ec99c 2026-09-25T10:35:24+02:00 Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Uninstalled 1 package in 0.76ms Installed 1 package in 1ms Run Test: slices-bi-singlenode-login 2026-09-28 04:10:49.044711 UTC - OS release: PRETTY_NAME="Debian GNU/Linux 13 (trixie)" NAME="Debian GNU/Linux" VERSION_ID="13" VERSION="13 (trixie)" VERSION_CODENAME=trixie DEBIAN_VERSION_FULL=13.5 ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" 2026-09-28 04:10:49.046722 UTC - ls -a /root/ /scripts/: '/root/:\n.\n..\n.bashrc\n.cache\n.local\n.profile\n.slices\n.wget-hsts\n\n/scripts/:\n.\n..\n.slices\nrun_test_runner.sh\n' 2026-09-28 04:10:49.046798 UTC - env: {'PATH': '/app/.venv/bin:/usr/local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/root/.local/bin/', 'COLUMNS': '200'} 2026-09-28 04:10:49.046923 UTC - which slices: /usr/local/bin/slices 2026-09-28 04:10:49.046947 UTC - Slices CLI exe: 'slices' 2026-09-28 04:10:49.047204 UTC - Run: slices --version 2026-09-28 04:10:53.344199 UTC - version: Slices CLI v2026.1.3 Slices CLI core v1.2.6 Slices CLI ai v1.1.0 Slices CLI bi v2.2.1 Slices clientlib bi v6.1.1 Slices clientlib core v5.6.0 Slices clientlib ai v1.0.0 2026-09-28 04:10:53.344974 UTC - Run: slices pubkey list --format text 2026-09-28 04:10:54.366736 UTC - Pubkey already registered 2026-09-28 04:10:54.366969 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-09-28 04:10:55.559235 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-09-28 04:10:55.559353 UTC - Check List Flavors 2026-09-28 04:10:55.559528 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-09-28 04:10:56.736684 UTC - Check List DiskImages 2026-09-28 04:10:56.736912 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-09-28 04:10:57.968120 UTC - Requesting resources 2026-09-28 04:10:57.968608 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-09-28 04:10:57.968759 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-e5bd6bac --user-data /tmp/tmpvdlpykcb 2026-09-28 04:10:59.827503 UTC - Resource ID: r_ch-geneva-bi-vm1_01m3k3ayhce61st43s0krn715q 2026-09-28 04:10:59.827662 UTC - Waiting until resource ready 2026-09-28 04:11:01.827988 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-e5bd6bac tst 2026-09-28 04:11:03.497991 UTC - Status: IMAGING 2026-09-28 04:11:07.393281 UTC - Status: IMAGING 2026-09-28 04:11:10.923154 UTC - Status: IMAGING 2026-09-28 04:11:14.064947 UTC - Status: IMAGING 2026-09-28 04:11:17.264858 UTC - Status: IMAGING 2026-09-28 04:11:20.365228 UTC - Status: IMAGING 2026-09-28 04:11:23.665277 UTC - Status: IMAGING 2026-09-28 04:11:27.069557 UTC - Status: IMAGING 2026-09-28 04:11:30.513632 UTC - Status: IMAGING 2026-09-28 04:11:33.495884 UTC - Status: IMAGING 2026-09-28 04:11:36.512207 UTC - Status: IMAGING 2026-09-28 04:11:39.378579 UTC - Status: IMAGING 2026-09-28 04:11:42.448175 UTC - Status: IMAGING 2026-09-28 04:11:45.581494 UTC - Status: IMAGING 2026-09-28 04:11:48.892310 UTC - Status: IMAGING 2026-09-28 04:11:52.563635 UTC - Status: IMAGING 2026-09-28 04:11:55.919150 UTC - Status: IMAGING 2026-09-28 04:11:59.497478 UTC - Status: IMAGING 2026-09-28 04:12:03.224698 UTC - Status: IMAGING 2026-09-28 04:12:06.541764 UTC - Status: IMAGING 2026-09-28 04:12:09.790524 UTC - Status: IMAGING 2026-09-28 04:12:13.242798 UTC - Status: IMAGING 2026-09-28 04:12:16.165268 UTC - Status: IMAGING 2026-09-28 04:12:19.035061 UTC - Status: IMAGING 2026-09-28 04:12:22.011343 UTC - Status: IMAGING 2026-09-28 04:12:24.927997 UTC - Status: IMAGING 2026-09-28 04:12:27.796770 UTC - Status: IMAGING 2026-09-28 04:12:30.663486 UTC - Status: IMAGING 2026-09-28 04:12:33.533458 UTC - Status: IMAGING 2026-09-28 04:12:36.349586 UTC - Status: IMAGING 2026-09-28 04:12:39.416048 UTC - Status: IMAGING 2026-09-28 04:12:42.586390 UTC - Status: IMAGING 2026-09-28 04:12:45.402414 UTC - Status: IMAGING 2026-09-28 04:12:48.318834 UTC - Status: IMAGING 2026-09-28 04:12:51.185831 UTC - Status: UP 2026-09-28 04:12:51.185971 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01m3k3ay57ezzse3ak6n3cah1t 2026-09-28 04:12:51.186028 UTC - Validate resources 2026-09-28 04:12:52.016375 UTC - "slices bi list-resources" returned resource without private IPv4 address, but with a public IPv4 address. As test_allow_public_ipv4_instead_of_private is set, that is acceptable. 2026-09-28 04:12:52.016450 UTC - The fields of the created resource were validated. 2026-09-28 04:12:52.016490 UTC - Check if resources are registered in experiment 2026-09-28 04:12:52.016666 UTC - Run: slices experiment list-resources --format json tst-e5bd6bac 2026-09-28 04:12:52.787009 UTC - Status (on expauth): UP 2026-09-28 04:12:52.787150 UTC - Testing extend expires_at (all resources in experiment) 2026-09-28 04:12:52.787279 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-e5bd6bac 2026-09-28 04:12:54.003967 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-e5bd6bac tst 2026-09-28 04:12:54.877478 UTC - Run: slices experiment list-resources --format json tst-e5bd6bac 2026-09-28 04:12:55.693565 UTC - expires_at (on expauth): 2026-09-28T07:12:00Z (correctly extended) 2026-09-28 04:12:55.693682 UTC - Testing extend expires_at (single resource in experiment) 2026-09-28 04:12:55.693862 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-e5bd6bac 2026-09-28 04:12:56.911271 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-e5bd6bac tst 2026-09-28 04:12:57.777713 UTC - Run: slices experiment list-resources --format json tst-e5bd6bac 2026-09-28 04:12:58.543259 UTC - expires_at (on expauth): 2026-09-28T08:12:00Z (correctly extended) 2026-09-28 04:12:58.543366 UTC - Testing ssh login 2026-09-28 04:12:58.554885 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-e5bd6bac tst 2026-09-28 04:12:59.421077 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-e5bd6bac tst 2026-09-28 04:13:00.337637 UTC - Logging in using 'slices bi ssh' 2026-09-28 04:13:00.337708 UTC - Forcing IPv4 only. 2026-09-28 04:13:00.337840 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-e5bd6bac tst -- -4 uname -a 2026-09-28 04:13:02.857969 UTC - Forcing IPv4 only. 2026-09-28 04:13:02.858205 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-e5bd6bac tst -- -4 uptime 2026-09-28 04:13:04.125279 UTC - CLI SSH Test passed. 2026-09-28 04:13:04.125356 UTC - Uname: Linux 9524f874-af0c-4a76-a2a6-5351b52bb50f-b6fa97cc-9ea7-4f9b-9541-f0 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-09-28 04:13:04.125375 UTC - Uptime: 04:13:04 up 1 min, 1 user, load average: 0.26, 0.08, 0.03 2026-09-28 04:13:04.125415 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-09-28 04:13:04.125877 UTC - Added paramiko HostKeyEntry for 5.53.108.252 2026-09-28 04:13:04.125985 UTC - Added paramiko HostKeyEntry for 5.53.108.252 2026-09-28 04:13:04.126138 UTC - Added paramiko HostKeyEntry for 5.53.108.252 2026-09-28 04:13:04.126336 UTC - Connecting to 5.53.108.252:22 2026-09-28 04:13:04.687796 UTC - SSH Test output: 2026-09-28 04:13:04.687873 UTC - Uname: Linux 9524f874-af0c-4a76-a2a6-5351b52bb50f-b6fa97cc-9ea7-4f9b-9541-f0 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-09-28 04:13:04.687894 UTC - Uptime: 04:13:04 up 1 min, 1 user, load average: 0.26, 0.08, 0.03 2026-09-28 04:13:04.786621 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-09-28 04:13:04.786705 UTC - lsb_release matches expected value 2026-09-28 04:13:04.786725 UTC - SSH Test passed. 2026-09-28 04:13:04.873444 UTC - Cloud-init user-data: Hello World. The time is now Mon, 28 Sep 2026 04:12:32 +0000! 2026-09-28 04:13:04.873598 UTC - Skip SSH proxy test because no jump proxy 2026-09-28 04:13:04.881012 UTC - Destroying tst-e5bd6bac tst 2026-09-28 04:13:04.881199 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-e5bd6bac tst