Run Test: slices-bi-singlenode-login 2026-06-12 00:17:36.916449 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmp84cglg51.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-12 00:17:42.645076 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/5f486e75-5798-4d25-94c2-20cff5c42a17/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-12 00:17:51.135557 CEST - Run: slices --version 2026-06-12 00:17:51.350113 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-12 00:17:51.350399 CEST - Run: slices pubkey list --format text 2026-06-12 00:17:51.915691 CEST - Pubkey already registered 2026-06-12 00:17:51.915952 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-12 00:17:52.681773 CEST - Refreshed infrastructure list. Total: 23 entries. 2026-06-12 00:17:52.681890 CEST - Check List Flavors 2026-06-12 00:17:52.682078 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-06-12 00:17:53.949078 CEST - Check List DiskImages 2026-06-12 00:17:53.949289 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-06-12 00:17:54.715227 CEST - Requesting resources 2026-06-12 00:17:54.715533 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-06-12 00:17:54.715625 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-ba79f3fd --user-data /tmp/tmpal9hbvcl 2026-06-12 00:17:57.737402 CEST - Resource ID: r_gr-volos-bi-vm1_01ktwc6wz6fz9taks5zbkb9rr0 2026-06-12 00:17:57.737536 CEST - Waiting until resource ready 2026-06-12 00:17:59.737954 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-ba79f3fd tst 2026-06-12 00:18:00.604406 CEST - Status: BOOTING 2026-06-12 00:18:03.470909 CEST - Status: BOOTING 2026-06-12 00:18:06.337164 CEST - Status: BOOTING 2026-06-12 00:18:09.253625 CEST - Status: BOOTING 2026-06-12 00:18:12.170667 CEST - Status: BOOTING 2026-06-12 00:18:15.037499 CEST - Status: BOOTING 2026-06-12 00:18:17.954195 CEST - Status: BOOTING 2026-06-12 00:18:20.820848 CEST - Status: BOOTING 2026-06-12 00:18:23.687263 CEST - Status: BOOTING 2026-06-12 00:18:26.604158 CEST - Status: BOOTING 2026-06-12 00:18:29.570958 CEST - Status: BOOTING 2026-06-12 00:18:32.487642 CEST - Status: BOOTING 2026-06-12 00:18:35.354201 CEST - Status: UP 2026-06-12 00:18:35.354259 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01ktwc6v8zecrvpqpvtrtxrcqr 2026-06-12 00:18:35.354297 CEST - Validate resources 2026-06-12 00:18:36.220992 CEST - The fields of the created resource were validated. 2026-06-12 00:18:36.221069 CEST - Check if resources are registered in experiment 2026-06-12 00:18:36.221243 CEST - Run: slices experiment list-resources --format json tst-ba79f3fd 2026-06-12 00:18:36.836992 CEST - Status (on expauth): UP 2026-06-12 00:18:36.837206 CEST - Testing extend expires_at (all resources in experiment) 2026-06-12 00:18:36.837364 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-ba79f3fd 2026-06-12 00:18:39.207458 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-ba79f3fd tst 2026-06-12 00:18:40.124214 CEST - Run: slices experiment list-resources --format json tst-ba79f3fd 2026-06-12 00:18:40.740025 CEST - expires_at (on expauth): 2026-06-12T01:18:00Z (correctly extended) 2026-06-12 00:18:40.740167 CEST - Testing extend expires_at (single resource in experiment) 2026-06-12 00:18:40.740394 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-ba79f3fd 2026-06-12 00:18:43.060214 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-ba79f3fd tst 2026-06-12 00:18:43.926762 CEST - Run: slices experiment list-resources --format json tst-ba79f3fd 2026-06-12 00:18:44.542518 CEST - expires_at (on expauth): 2026-06-12T02:18:00Z (correctly extended) 2026-06-12 00:18:44.542649 CEST - Testing ssh login 2026-06-12 00:18:44.553459 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-ba79f3fd tst 2026-06-12 00:18:45.570115 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-ba79f3fd tst 2026-06-12 00:18:46.586680 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-ba79f3fd tst 2026-06-12 00:18:47.603070 CEST - Logging in using 'slices bi ssh' 2026-06-12 00:18:47.603159 CEST - Forcing IPv4 only. 2026-06-12 00:18:47.603327 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-ba79f3fd tst -- -4 uname -a 2026-06-12 00:18:51.026293 CEST - Forcing IPv4 only. 2026-06-12 00:18:51.026459 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-ba79f3fd tst -- -4 uptime 2026-06-12 00:18:53.597096 CEST - CLI SSH Test passed. 2026-06-12 00:18:53.597165 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-12 00:18:53.597180 CEST - Uptime: 22:18:52 up 0 min, 1 user, load average: 1.10, 0.31, 0.10 2026-06-12 00:18:53.597210 CEST - Logging in using SSH over SSH proxy 2026-06-12 00:18:53.597363 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-ba79f3fd tst 2026-06-12 00:18:54.614233 CEST - Added paramiko HostKeyEntry for 10.64.45.50 2026-06-12 00:18:54.614442 CEST - Added paramiko HostKeyEntry for 10.64.45.50 2026-06-12 00:18:54.614496 CEST - Added paramiko HostKeyEntry for 10.64.45.50 2026-06-12 00:18:54.614747 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-06-12 00:18:54.614821 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-06-12 00:18:54.614859 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-06-12 00:18:54.614870 CEST - Connecting to proxy 194.177.207.42:11122 2026-06-12 00:18:55.574018 CEST - Connecting to 10.64.45.50:22 over proxy 2026-06-12 00:18:57.290919 CEST - SSH Test output: 2026-06-12 00:18:57.290972 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-12 00:18:57.290987 CEST - Uptime: 22:18:56 up 0 min, 1 user, load average: 1.02, 0.30, 0.10 2026-06-12 00:18:57.592849 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-12 00:18:57.592909 CEST - lsb_release matches expected value 2026-06-12 00:18:57.592923 CEST - SSH Test passed. 2026-06-12 00:18:57.894902 CEST - Cloud-init user-data: Hello World. The time is now Thu, 11 Jun 2026 22:18:33 +0000! 2026-06-12 00:18:57.901633 CEST - Destroying tst-ba79f3fd tst 2026-06-12 00:18:57.901815 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-ba79f3fd tst