Run Test: slices-bi-singlenode-login 2026-06-07 08:27:34.231722 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmpuvej1wyz.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-07 08:27:38.656398 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/5d749b95-1aa8-4f4a-83c3-8c081da2fd5d/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-07 08:27:43.533891 CEST - Run: slices --version 2026-06-07 08:27:43.748451 CEST - version: Slices CLI v2026.1.2 Slices CLI core v1.2.4 Slices CLI ai v1.1.0 Slices CLI bi v2.2.0 Slices clientlib bi v6.1.1 Slices clientlib ai v1.0.0 Slices clientlib core v5.5.1 2026-06-07 08:27:43.748741 CEST - Run: slices pubkey list --format text 2026-06-07 08:27:44.314004 CEST - Pubkey already registered 2026-06-07 08:27:44.314259 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-07 08:27:44.879548 CEST - Refreshed infrastructure list. Total: 23 entries. 2026-06-07 08:27:44.879665 CEST - Check List Flavors 2026-06-07 08:27:44.879843 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-06-07 08:27:45.846298 CEST - Check List DiskImages 2026-06-07 08:27:45.846554 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-06-07 08:27:46.612526 CEST - Requesting resources 2026-06-07 08:27:46.612865 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-06-07 08:27:46.612971 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-93143c47 --user-data /tmp/tmp7hgw1dps 2026-06-07 08:27:51.090015 CEST - Resource ID: r_gr-volos-bi-vm1_01ktgc8adzfvg9d4zt5653314f 2026-06-07 08:27:51.090207 CEST - Waiting until resource ready 2026-06-07 08:27:53.090667 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-93143c47 tst 2026-06-07 08:27:53.956801 CEST - Status: IMAGING 2026-06-07 08:27:56.923646 CEST - Status: IMAGING 2026-06-07 08:27:59.890494 CEST - Status: IMAGING 2026-06-07 08:28:02.757242 CEST - Status: BOOTING 2026-06-07 08:28:05.623903 CEST - Status: BOOTING 2026-06-07 08:28:08.540980 CEST - Status: BOOTING 2026-06-07 08:28:12.460405 CEST - Status: BOOTING 2026-06-07 08:28:15.326938 CEST - Status: BOOTING 2026-06-07 08:28:18.243649 CEST - Status: BOOTING 2026-06-07 08:28:21.210853 CEST - Status: BOOTING 2026-06-07 08:28:24.127923 CEST - Status: BOOTING 2026-06-07 08:28:26.994623 CEST - Status: BOOTING 2026-06-07 08:28:29.861299 CEST - Status: BOOTING 2026-06-07 08:28:32.727846 CEST - Status: BOOTING 2026-06-07 08:28:35.594683 CEST - Status: BOOTING 2026-06-07 08:28:38.461423 CEST - Status: BOOTING 2026-06-07 08:28:41.679017 CEST - Status: BOOTING 2026-06-07 08:28:44.596077 CEST - Status: BOOTING 2026-06-07 08:28:47.462683 CEST - Status: BOOTING 2026-06-07 08:28:50.429790 CEST - Status: BOOTING 2026-06-07 08:28:53.296697 CEST - Status: BOOTING 2026-06-07 08:28:56.163345 CEST - Status: BOOTING 2026-06-07 08:28:59.130702 CEST - Status: BOOTING 2026-06-07 08:29:02.147810 CEST - Status: BOOTING 2026-06-07 08:29:05.014492 CEST - Status: BOOTING 2026-06-07 08:29:07.881256 CEST - Status: BOOTING 2026-06-07 08:29:10.747812 CEST - Status: BOOTING 2026-06-07 08:29:13.614368 CEST - Status: BOOTING 2026-06-07 08:29:16.481077 CEST - Status: BOOTING 2026-06-07 08:29:19.397773 CEST - Status: BOOTING 2026-06-07 08:29:22.265124 CEST - Status: BOOTING 2026-06-07 08:29:25.181736 CEST - Status: BOOTING 2026-06-07 08:29:28.098424 CEST - Status: BOOTING 2026-06-07 08:29:30.965079 CEST - Status: BOOTING 2026-06-07 08:29:33.831687 CEST - Status: BOOTING 2026-06-07 08:29:36.698235 CEST - Status: BOOTING 2026-06-07 08:29:39.617129 CEST - Status: BOOTING 2026-06-07 08:29:42.484170 CEST - Status: UP 2026-06-07 08:29:42.484252 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01ktgc877yfe794p8fhntg54ne 2026-06-07 08:29:42.484303 CEST - Validate resources 2026-06-07 08:29:43.351509 CEST - The fields of the created resource were validated. 2026-06-07 08:29:43.351631 CEST - Check if resources are registered in experiment 2026-06-07 08:29:43.351847 CEST - Run: slices experiment list-resources --format json tst-93143c47 2026-06-07 08:29:43.968369 CEST - Status (on expauth): UP 2026-06-07 08:29:43.968569 CEST - Testing extend expires_at (all resources in experiment) 2026-06-07 08:29:43.968753 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-93143c47 2026-06-07 08:29:47.442210 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-93143c47 tst 2026-06-07 08:29:48.309157 CEST - Run: slices experiment list-resources --format json tst-93143c47 2026-06-07 08:29:48.925001 CEST - expires_at (on expauth): 2026-06-07T09:29:00Z (correctly extended) 2026-06-07 08:29:48.925078 CEST - Testing extend expires_at (single resource in experiment) 2026-06-07 08:29:48.925230 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-93143c47 2026-06-07 08:29:51.195345 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-93143c47 tst 2026-06-07 08:29:52.062153 CEST - Run: slices experiment list-resources --format json tst-93143c47 2026-06-07 08:29:52.678078 CEST - expires_at (on expauth): 2026-06-07T10:29:00Z (correctly extended) 2026-06-07 08:29:52.678166 CEST - Testing ssh login 2026-06-07 08:29:52.688457 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-93143c47 tst 2026-06-07 08:29:53.654778 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-93143c47 tst 2026-06-07 08:29:54.621349 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-93143c47 tst 2026-06-07 08:29:55.587709 CEST - Logging in using 'slices bi ssh' 2026-06-07 08:29:55.587776 CEST - Forcing IPv4 only. 2026-06-07 08:29:55.587904 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-93143c47 tst -- -4 uname -a 2026-06-07 08:29:59.612201 CEST - Forcing IPv4 only. 2026-06-07 08:29:59.612385 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-93143c47 tst -- -4 uptime 2026-06-07 08:30:02.233142 CEST - CLI SSH Test passed. 2026-06-07 08:30:02.233200 CEST - 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-06-07 08:30:02.233214 CEST - Uptime: 06:30:02 up 1 min, 1 user, load average: 0.76, 0.37, 0.14 2026-06-07 08:30:02.233243 CEST - Logging in using SSH over SSH proxy 2026-06-07 08:30:02.233397 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-93143c47 tst 2026-06-07 08:30:03.350500 CEST - Added paramiko HostKeyEntry for 10.64.45.142 2026-06-07 08:30:03.350608 CEST - Added paramiko HostKeyEntry for 10.64.45.142 2026-06-07 08:30:03.350749 CEST - Added paramiko HostKeyEntry for 10.64.45.142 2026-06-07 08:30:03.351032 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-06-07 08:30:03.351119 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-06-07 08:30:03.351160 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-06-07 08:30:03.351172 CEST - Connecting to proxy 194.177.207.42:11122 2026-06-07 08:30:04.426125 CEST - Connecting to 10.64.45.142:22 over proxy 2026-06-07 08:30:06.276572 CEST - SSH Test output: 2026-06-07 08:30:06.276624 CEST - 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-06-07 08:30:06.276643 CEST - Uptime: 06:30:05 up 1 min, 1 user, load average: 0.70, 0.36, 0.14 2026-06-07 08:30:06.540289 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-07 08:30:06.540352 CEST - lsb_release matches expected value 2026-06-07 08:30:06.540366 CEST - SSH Test passed. 2026-06-07 08:30:06.844076 CEST - Cloud-init user-data: Hello World. The time is now Sun, 07 Jun 2026 06:29:36 +0000! 2026-06-07 08:30:06.850577 CEST - Destroying tst-93143c47 tst 2026-06-07 08:30:06.850757 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-93143c47 tst