Run Test: slices-bi-singlenode-login 2026-03-19 23:03:17.607718 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-19 23:03:20.725176 CET - Run: slices --version 2026-03-19 23:03:20.925754 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.8 Slices clientlib bi v5.1.2 2026-03-19 23:03:20.925982 CET - Run: slices pubkey list --format text 2026-03-19 23:03:21.497771 CET - Pubkey already registered 2026-03-19 23:03:21.497984 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-19 23:03:22.023955 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-19 23:03:22.024050 CET - Check List Flavors 2026-03-19 23:03:22.024252 CET - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-03-19 23:03:22.992995 CET - Check List DiskImages 2026-03-19 23:03:22.993185 CET - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-03-19 23:03:23.757186 CET - Requesting resources 2026-03-19 23:03:23.757641 CET - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-03-19 23:03:23.757735 CET - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-4012d3be --user-data /tmp/tmpelgyqg53 2026-03-19 23:03:30.526441 CET - Resource ID: r_gr-volos-bi-vm1_01km42024wfjhr22w8xdfmpv18 2026-03-19 23:03:30.526609 CET - Waiting until resource ready 2026-03-19 23:03:32.527012 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-4012d3be tst 2026-03-19 23:03:33.338884 CET - Status: IMAGING 2026-03-19 23:03:36.184610 CET - Status: IMAGING 2026-03-19 23:03:39.018122 CET - Status: IMAGING 2026-03-19 23:03:41.850771 CET - Status: BOOTING 2026-03-19 23:03:44.662486 CET - Status: BOOTING 2026-03-19 23:03:47.470875 CET - Status: BOOTING 2026-03-19 23:03:50.291975 CET - Status: BOOTING 2026-03-19 23:03:53.093737 CET - Status: BOOTING 2026-03-19 23:03:55.912077 CET - Status: BOOTING 2026-03-19 23:03:58.745309 CET - Status: BOOTING 2026-03-19 23:04:01.577692 CET - Status: BOOTING 2026-03-19 23:04:04.404494 CET - Status: BOOTING 2026-03-19 23:04:07.213867 CET - Status: BOOTING 2026-03-19 23:04:10.049369 CET - Status: BOOTING 2026-03-19 23:04:12.878791 CET - Status: BOOTING 2026-03-19 23:04:15.699092 CET - Status: BOOTING 2026-03-19 23:04:18.543551 CET - Status: BOOTING 2026-03-19 23:04:21.389729 CET - Status: BOOTING 2026-03-19 23:04:24.260436 CET - Status: BOOTING 2026-03-19 23:04:27.132377 CET - Status: BOOTING 2026-03-19 23:04:30.014699 CET - Status: BOOTING 2026-03-19 23:04:32.867351 CET - Status: BOOTING 2026-03-19 23:04:35.723135 CET - Status: BOOTING 2026-03-19 23:04:38.590699 CET - Status: BOOTING 2026-03-19 23:04:41.421676 CET - Status: BOOTING 2026-03-19 23:04:44.239843 CET - Status: BOOTING 2026-03-19 23:04:47.050003 CET - Status: BOOTING 2026-03-19 23:04:49.876194 CET - Status: BOOTING 2026-03-19 23:04:52.700770 CET - Status: BOOTING 2026-03-19 23:04:55.527465 CET - Status: BOOTING 2026-03-19 23:04:58.373730 CET - Status: BOOTING 2026-03-19 23:05:01.178183 CET - Status: BOOTING 2026-03-19 23:05:03.983491 CET - Status: BOOTING 2026-03-19 23:05:06.785459 CET - Status: BOOTING 2026-03-19 23:05:09.596127 CET - Status: BOOTING 2026-03-19 23:05:12.410176 CET - Status: BOOTING 2026-03-19 23:05:15.209202 CET - Status: BOOTING 2026-03-19 23:05:18.024670 CET - Status: UP 2026-03-19 23:05:18.024712 CET - Experiment ID: exp_expauth.ilabt.imec.be_01km41zx08e5sbjc0td6pdkbxy 2026-03-19 23:05:18.024758 CET - Validate resources 2026-03-19 23:05:18.855001 CET - The fields of the created resource were validated. 2026-03-19 23:05:18.855055 CET - Check if resources are registered in experiment 2026-03-19 23:05:18.855250 CET - Run: slices experiment list-resources --format json tst-4012d3be 2026-03-19 23:05:19.470837 CET - Status (on expauth): UP 2026-03-19 23:05:19.470964 CET - Testing extend expires_at (all resources in experiment) 2026-03-19 23:05:19.471094 CET - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-4012d3be 2026-03-19 23:05:21.727268 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-4012d3be tst 2026-03-19 23:05:22.544605 CET - Testing extend expires_at (single resource in experiment) 2026-03-19 23:05:22.544850 CET - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-4012d3be 2026-03-19 23:05:24.834164 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-4012d3be tst 2026-03-19 23:05:25.641594 CET - Testing ssh login 2026-03-19 23:05:25.651321 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-4012d3be tst 2026-03-19 23:05:26.587560 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-4012d3be tst 2026-03-19 23:05:27.518741 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-4012d3be tst 2026-03-19 23:05:28.478913 CET - Logging in using 'slices bi ssh' 2026-03-19 23:05:28.478962 CET - Forcing IPv4 only. 2026-03-19 23:05:28.479108 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-4012d3be tst -- -4 uname -a 2026-03-19 23:05:31.887556 CET - Forcing IPv4 only. 2026-03-19 23:05:31.887693 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-4012d3be tst -- -4 uptime 2026-03-19 23:05:34.424089 CET - CLI SSH Test passed. 2026-03-19 23:05:34.424130 CET - Uname: Linux tst 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-03-19 23:05:34.424139 CET - Uptime: 22:05:34 up 1 min, 1 user, load average: 1.21, 0.69, 0.27 2026-03-19 23:05:34.424165 CET - Logging in using SSH over SSH proxy 2026-03-19 23:05:34.424312 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-4012d3be tst 2026-03-19 23:05:35.356805 CET - Added paramiko HostKeyEntry for 10.64.45.158 2026-03-19 23:05:35.356901 CET - Added paramiko HostKeyEntry for 10.64.45.158 2026-03-19 23:05:35.357027 CET - Added paramiko HostKeyEntry for 10.64.45.158 2026-03-19 23:05:35.357285 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-19 23:05:35.357359 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-19 23:05:35.357391 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-19 23:05:35.357400 CET - Connecting to proxy 194.177.207.42:11122 2026-03-19 23:05:36.113847 CET - Connecting to 10.64.45.158:22 over proxy 2026-03-19 23:05:37.713998 CET - SSH Test output: 2026-03-19 23:05:37.714039 CET - Uname: Linux tst 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-03-19 23:05:37.714049 CET - Uptime: 22:05:37 up 1 min, 1 user, load average: 1.21, 0.69, 0.27 2026-03-19 23:05:38.039921 CET - lsb_release: Ubuntu 24.04.3 LTS 2026-03-19 23:05:38.039970 CET - lsb_release matches expected value 2026-03-19 23:05:38.039979 CET - SSH Test passed. 2026-03-19 23:05:38.394564 CET - Cloud-init user-data: Hello World. The time is now Thu, 19 Mar 2026 22:05:14 +0000! 2026-03-19 23:05:38.401105 CET - Destroying tst-4012d3be tst 2026-03-19 23:05:38.401272 CET - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-4012d3be tst