Run Test: slices-bi-singlenode-login 2026-06-20 17:01:23.669725 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmpv2gdl_mj.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-20 17:01:27.843089 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/12e146ed-540d-4e76-8146-d44ea8e60d3c/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-20 17:01:59.429583 CEST - Run: slices --version 2026-06-20 17:02:01.550565 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-20 17:02:01.550859 CEST - Run: slices pubkey list --format text 2026-06-20 17:02:04.984783 CEST - Pubkey already registered 2026-06-20 17:02:04.985030 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-20 17:02:05.550076 CEST - Refreshed infrastructure list. Total: 23 entries. 2026-06-20 17:02:05.550205 CEST - Check List Flavors 2026-06-20 17:02:05.550386 CEST - Run: slices bi --infra it-genoa1-bi-vm1 flavor list -f json 2026-06-20 17:02:06.416180 CEST - Check List DiskImages 2026-06-20 17:02:06.416474 CEST - Run: slices bi --infra it-genoa1-bi-vm1 diskimage list -f json 2026-06-20 17:02:08.301458 CEST - Requesting resources 2026-06-20 17:02:08.301746 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-06-20 17:02:08.301849 CEST - Run: slices bi --infra it-genoa1-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-2e95e798 --user-data /tmp/tmpxatf0i83 2026-06-20 17:02:13.025073 CEST - Resource ID: r_it-genoa1-bi-vm1_01kvjrvfypetgtgs4tfypf41e2 2026-06-20 17:02:13.025206 CEST - Waiting until resource ready 2026-06-20 17:02:15.025545 CEST - Run: slices bi --infra it-genoa1-bi-vm1 list-resources --format json --experiment tst-2e95e798 tst 2026-06-20 17:02:18.697696 CEST - Status: IMAGING 2026-06-20 17:02:23.119675 CEST - Status: BOOTING 2026-06-20 17:02:29.456227 CEST - Status: BOOTING 2026-06-20 17:02:37.636667 CEST - Status: BOOTING 2026-06-20 17:02:43.165928 CEST - Status: BOOTING 2026-06-20 17:02:46.943060 CEST - Status: BOOTING 2026-06-20 17:02:54.381965 CEST - Status: UP 2026-06-20 17:02:54.382036 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kvjrvec9egfsfempd95qv7jf 2026-06-20 17:02:54.382075 CEST - Validate resources 2026-06-20 17:03:01.874475 CEST - The fields of the created resource were validated. 2026-06-20 17:03:01.874557 CEST - Step 'Validate resources' took 7.49 seconds, which is longer than the warning threshold of 5 seconds 2026-06-20 17:03:01.874584 CEST - Check if resources are registered in experiment 2026-06-20 17:03:01.874732 CEST - Run: slices experiment list-resources --format json tst-2e95e798 2026-06-20 17:03:09.015692 CEST - Status (on expauth): UP 2026-06-20 17:03:09.015830 CEST - Testing extend expires_at (all resources in experiment) 2026-06-20 17:03:09.015950 CEST - Run: slices bi --infra it-genoa1-bi-vm1 extend --duration 3h --experiment tst-2e95e798 2026-06-20 17:03:17.458564 CEST - Run: slices bi --infra it-genoa1-bi-vm1 list-resources --format json --experiment tst-2e95e798 tst 2026-06-20 17:03:23.897856 CEST - Run: slices experiment list-resources --format json tst-2e95e798 2026-06-20 17:03:29.181906 CEST - expires_at (on expauth): 2026-06-20T18:03:00Z (correctly extended) 2026-06-20 17:03:29.181992 CEST - Testing extend expires_at (single resource in experiment) 2026-06-20 17:03:29.182131 CEST - Run: slices bi --infra it-genoa1-bi-vm1 extend tst --duration 4h --experiment tst-2e95e798 2026-06-20 17:03:36.225532 CEST - Run: slices bi --infra it-genoa1-bi-vm1 list-resources --format json --experiment tst-2e95e798 tst 2026-06-20 17:03:41.408781 CEST - Run: slices experiment list-resources --format json tst-2e95e798 2026-06-20 17:03:42.074284 CEST - expires_at (on expauth): 2026-06-20T19:03:00Z (correctly extended) 2026-06-20 17:03:42.074463 CEST - Testing ssh login 2026-06-20 17:03:42.086994 CEST - Run: slices bi --infra it-genoa1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-2e95e798 tst 2026-06-20 17:03:43.053449 CEST - Run: slices bi --infra it-genoa1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-2e95e798 tst 2026-06-20 17:03:44.326712 CEST - Run: slices bi --infra it-genoa1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-2e95e798 tst 2026-06-20 17:03:45.510409 CEST - Logging in using 'slices bi ssh' 2026-06-20 17:03:45.510497 CEST - Forcing IPv4 only. 2026-06-20 17:03:45.510649 CEST - Run: slices bi --infra it-genoa1-bi-vm1 ssh --show nothing --experiment tst-2e95e798 tst -- -4 uname -a 2026-06-20 17:03:48.230885 CEST - Forcing IPv4 only. 2026-06-20 17:03:48.231114 CEST - Run: slices bi --infra it-genoa1-bi-vm1 ssh --show nothing --experiment tst-2e95e798 tst -- -4 uptime 2026-06-20 17:03:49.948290 CEST - CLI SSH Test passed. 2026-06-20 17:03:49.948369 CEST - Uname: Linux tst 6.8.0-87-generic #88-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 09:28:41 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-06-20 17:03:49.948386 CEST - Uptime: 15:03:49 up 1 min, 1 user, load average: 0.30, 0.17, 0.06 2026-06-20 17:03:49.948416 CEST - Logging in using SSH over SSH proxy 2026-06-20 17:03:49.948567 CEST - Run: slices bi --infra it-genoa1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-2e95e798 tst 2026-06-20 17:03:50.866589 CEST - Added paramiko HostKeyEntry for 172.30.44.3 2026-06-20 17:03:50.866707 CEST - Added paramiko HostKeyEntry for 172.30.44.3 2026-06-20 17:03:50.866849 CEST - Added paramiko HostKeyEntry for 172.30.44.3 2026-06-20 17:03:50.867036 CEST - Added paramiko HostKeyEntry for slices-bi.tnt-lab.unige.it 2026-06-20 17:03:50.867146 CEST - Added paramiko HostKeyEntry for slices-bi.tnt-lab.unige.it 2026-06-20 17:03:50.867217 CEST - Added paramiko HostKeyEntry for slices-bi.tnt-lab.unige.it 2026-06-20 17:03:50.867237 CEST - Connecting to proxy slices-bi.tnt-lab.unige.it:22 2026-06-20 17:03:51.368533 CEST - Connecting to 172.30.44.3:22 over proxy 2026-06-20 17:03:52.243130 CEST - SSH Test output: 2026-06-20 17:03:52.243198 CEST - Uname: Linux tst 6.8.0-87-generic #88-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 09:28:41 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-06-20 17:03:52.243216 CEST - Uptime: 15:03:52 up 1 min, 1 user, load average: 0.30, 0.17, 0.06 2026-06-20 17:03:52.429839 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-20 17:03:52.429907 CEST - lsb_release matches expected value 2026-06-20 17:03:52.429923 CEST - SSH Test passed. 2026-06-20 17:03:52.615162 CEST - Cloud-init user-data: Hello World. The time is now Sat, 20 Jun 2026 15:02:47 +0000! 2026-06-20 17:03:52.623593 CEST - Destroying tst-2e95e798 tst 2026-06-20 17:03:52.623826 CEST - Run: slices bi --infra it-genoa1-bi-vm1 destroy --experiment tst-2e95e798 tst