Run Test: slices-bi-singlenode-login 2026-05-21 17:00:46.768062 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-05-21 17:00:50.290385 CEST - Run: slices --version 2026-05-21 17:00:50.504871 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.5.1 Slices clientlib bi v5.1.2 2026-05-21 17:00:50.505163 CEST - Run: slices pubkey list --format text 2026-05-21 17:00:51.270648 CEST - Pubkey already registered 2026-05-21 17:00:51.270902 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-05-21 17:00:51.836091 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-05-21 17:00:51.836229 CEST - Check List Flavors 2026-05-21 17:00:51.836422 CEST - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-05-21 17:00:52.702478 CEST - Check List DiskImages 2026-05-21 17:00:52.702672 CEST - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-05-21 17:00:53.318101 CEST - Requesting resources 2026-05-21 17:00:53.318532 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-05-21 17:00:53.318629 CEST - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-f2c46218 --user-data /tmp/tmptk_s1yk0 2026-05-21 17:00:55.487086 CEST - Resource ID: r_ch-geneva-bi-vm1_01ks5gvjc6fk89e45n8c5s5ker 2026-05-21 17:00:55.487207 CEST - Waiting until resource ready 2026-05-21 17:00:57.487616 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-f2c46218 tst 2026-05-21 17:00:58.203227 CEST - Status: IMAGING 2026-05-21 17:01:00.919263 CEST - Status: IMAGING 2026-05-21 17:01:03.635226 CEST - Status: IMAGING 2026-05-21 17:01:06.351547 CEST - Status: IMAGING 2026-05-21 17:01:09.067827 CEST - Status: IMAGING 2026-05-21 17:01:11.783630 CEST - Status: IMAGING 2026-05-21 17:01:14.499418 CEST - Status: IMAGING 2026-05-21 17:01:17.215631 CEST - Status: IMAGING 2026-05-21 17:01:19.931482 CEST - Status: IMAGING 2026-05-21 17:01:22.647458 CEST - Status: IMAGING 2026-05-21 17:01:25.363318 CEST - Status: IMAGING 2026-05-21 17:01:28.129929 CEST - Status: IMAGING 2026-05-21 17:01:30.896134 CEST - Status: IMAGING 2026-05-21 17:01:33.612145 CEST - Status: IMAGING 2026-05-21 17:01:36.328169 CEST - Status: IMAGING 2026-05-21 17:01:38.993938 CEST - Status: IMAGING 2026-05-21 17:01:41.709774 CEST - Status: IMAGING 2026-05-21 17:01:44.425727 CEST - Status: IMAGING 2026-05-21 17:01:47.142040 CEST - Status: IMAGING 2026-05-21 17:01:49.858152 CEST - Status: IMAGING 2026-05-21 17:01:52.575125 CEST - Status: IMAGING 2026-05-21 17:01:55.291713 CEST - Status: IMAGING 2026-05-21 17:01:58.058003 CEST - Status: IMAGING 2026-05-21 17:02:00.773985 CEST - Status: IMAGING 2026-05-21 17:02:03.490029 CEST - Status: IMAGING 2026-05-21 17:02:06.256314 CEST - Status: IMAGING 2026-05-21 17:02:08.972105 CEST - Status: IMAGING 2026-05-21 17:02:11.688061 CEST - Status: IMAGING 2026-05-21 17:02:14.404527 CEST - Status: IMAGING 2026-05-21 17:02:17.171159 CEST - Status: IMAGING 2026-05-21 17:02:19.887089 CEST - Status: IMAGING 2026-05-21 17:02:22.552824 CEST - Status: IMAGING 2026-05-21 17:02:25.268671 CEST - Status: IMAGING 2026-05-21 17:02:27.984889 CEST - Status: IMAGING 2026-05-21 17:02:30.751070 CEST - Status: IMAGING 2026-05-21 17:02:33.416610 CEST - Status: IMAGING 2026-05-21 17:02:36.182702 CEST - Status: IMAGING 2026-05-21 17:02:38.999237 CEST - Status: IMAGING 2026-05-21 17:02:41.815993 CEST - Status: IMAGING 2026-05-21 17:02:44.532343 CEST - Status: IMAGING 2026-05-21 17:02:47.298622 CEST - Status: IMAGING 2026-05-21 17:02:49.964310 CEST - Status: IMAGING 2026-05-21 17:02:52.680244 CEST - Status: IMAGING 2026-05-21 17:02:55.396155 CEST - Status: IMAGING 2026-05-21 17:02:58.111861 CEST - Status: IMAGING 2026-05-21 17:03:00.827939 CEST - Status: IMAGING 2026-05-21 17:03:03.644764 CEST - Status: IMAGING 2026-05-21 17:03:06.360733 CEST - Status: IMAGING 2026-05-21 17:03:09.076613 CEST - Status: IMAGING 2026-05-21 17:03:11.792410 CEST - Status: IMAGING 2026-05-21 17:03:14.508237 CEST - Status: IMAGING 2026-05-21 17:03:17.225110 CEST - Status: IMAGING 2026-05-21 17:03:19.941027 CEST - Status: IMAGING 2026-05-21 17:03:22.707267 CEST - Status: IMAGING 2026-05-21 17:03:25.473775 CEST - Status: IMAGING 2026-05-21 17:03:28.189723 CEST - Status: IMAGING 2026-05-21 17:03:30.905520 CEST - Status: IMAGING 2026-05-21 17:03:33.621548 CEST - Status: IMAGING 2026-05-21 17:03:36.337506 CEST - Status: IMAGING 2026-05-21 17:03:39.053776 CEST - Status: IMAGING 2026-05-21 17:03:41.819890 CEST - Status: IMAGING 2026-05-21 17:03:44.535926 CEST - Status: UP 2026-05-21 17:03:44.535985 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01ks5gvhk8e98s0cz82tafy8jr 2026-05-21 17:03:44.536040 CEST - Validate resources 2026-05-21 17:03:45.251775 CEST - "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-05-21 17:03:45.251837 CEST - The fields of the created resource were validated. 2026-05-21 17:03:45.251868 CEST - Check if resources are registered in experiment 2026-05-21 17:03:45.252022 CEST - Run: slices experiment list-resources --format json tst-f2c46218 2026-05-21 17:03:45.867219 CEST - Status (on expauth): UP 2026-05-21 17:03:45.867362 CEST - Testing extend expires_at (all resources in experiment) 2026-05-21 17:03:45.867487 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-f2c46218 2026-05-21 17:03:47.585327 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-f2c46218 tst 2026-05-21 17:03:48.300790 CEST - Testing extend expires_at (single resource in experiment) 2026-05-21 17:03:48.300987 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-f2c46218 2026-05-21 17:03:49.918666 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-f2c46218 tst 2026-05-21 17:03:50.635035 CEST - Testing ssh login 2026-05-21 17:03:50.644963 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-f2c46218 tst 2026-05-21 17:03:51.410628 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-f2c46218 tst 2026-05-21 17:03:52.126341 CEST - Logging in using 'slices bi ssh' 2026-05-21 17:03:52.126435 CEST - Forcing IPv4 only. 2026-05-21 17:03:52.126582 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-f2c46218 tst -- -4 uname -a 2026-05-21 17:03:54.596759 CEST - Forcing IPv4 only. 2026-05-21 17:03:54.596939 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-f2c46218 tst -- -4 uptime 2026-05-21 17:03:55.713205 CEST - CLI SSH Test passed. 2026-05-21 17:03:55.713260 CEST - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-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-05-21 17:03:55.713274 CEST - Uptime: 15:03:55 up 1 min, 2 users, load average: 0.40, 0.31, 0.12 2026-05-21 17:03:55.713301 CEST - Logging in using SSH (no SSH proxy in Resource) 2026-05-21 17:03:55.713710 CEST - Added paramiko HostKeyEntry for 5.53.108.111 2026-05-21 17:03:55.713783 CEST - Added paramiko HostKeyEntry for 5.53.108.111 2026-05-21 17:03:55.713956 CEST - Added paramiko HostKeyEntry for 5.53.108.111 2026-05-21 17:03:55.714117 CEST - Connecting to 5.53.108.111:22 2026-05-21 17:03:56.278797 CEST - SSH Test output: 2026-05-21 17:03:56.278860 CEST - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-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-05-21 17:03:56.278875 CEST - Uptime: 15:03:56 up 1 min, 1 user, load average: 0.40, 0.31, 0.12 2026-05-21 17:03:56.378902 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-05-21 17:03:56.378976 CEST - lsb_release matches expected value 2026-05-21 17:03:56.378991 CEST - SSH Test passed. 2026-05-21 17:03:56.476335 CEST - Cloud-init user-data: Hello World. The time is now Thu, 21 May 2026 15:03:23 +0000! 2026-05-21 17:03:56.476476 CEST - Skip SSH proxy test because no jump proxy 2026-05-21 17:03:56.483224 CEST - Destroying tst-f2c46218 tst 2026-05-21 17:03:56.483589 CEST - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-f2c46218 tst