Run Test: slices-bi-singlenode-login 2026-07-06 08:13:45.137676 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmpc4u63_f8.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-07-06 08:13:49.010204 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/ef12dfc8-22e7-445e-8471-3d05287d148a/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-07-06 08:13:57.195204 CEST - Run: slices --version 2026-07-06 08:13:57.410081 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-07-06 08:13:57.410421 CEST - Run: slices pubkey list --format text 2026-07-06 08:13:58.075975 CEST - Pubkey already registered 2026-07-06 08:13:58.076284 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-06 08:13:58.642001 CEST - Refreshed infrastructure list. Total: 24 entries. 2026-07-06 08:13:58.642207 CEST - Check List Flavors 2026-07-06 08:13:58.642444 CEST - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-06 08:13:59.609266 CEST - Check List DiskImages 2026-07-06 08:13:59.609505 CEST - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-06 08:14:00.225229 CEST - Requesting resources 2026-07-06 08:14:00.225607 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-06 08:14:00.225720 CEST - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-ecb96e2f --user-data /tmp/tmpoul5nq7b 2026-07-06 08:14:02.244812 CEST - Resource ID: r_ch-geneva-bi-vm1_01kwv0zw2tfystaggwj58ky726 2026-07-06 08:14:02.244963 CEST - Waiting until resource ready 2026-07-06 08:14:04.245483 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-ecb96e2f tst 2026-07-06 08:14:05.061526 CEST - Status: IMAGING 2026-07-06 08:14:07.877939 CEST - Status: IMAGING 2026-07-06 08:14:10.594413 CEST - Status: IMAGING 2026-07-06 08:14:13.311077 CEST - Status: IMAGING 2026-07-06 08:14:16.127607 CEST - Status: IMAGING 2026-07-06 08:14:18.894594 CEST - Status: IMAGING 2026-07-06 08:14:21.660667 CEST - Status: IMAGING 2026-07-06 08:14:24.376682 CEST - Status: IMAGING 2026-07-06 08:14:27.092533 CEST - Status: IMAGING 2026-07-06 08:14:29.909369 CEST - Status: IMAGING 2026-07-06 08:14:32.625142 CEST - Status: IMAGING 2026-07-06 08:14:35.341191 CEST - Status: IMAGING 2026-07-06 08:14:38.157745 CEST - Status: IMAGING 2026-07-06 08:14:40.873617 CEST - Status: IMAGING 2026-07-06 08:14:43.589729 CEST - Status: IMAGING 2026-07-06 08:14:46.305728 CEST - Status: IMAGING 2026-07-06 08:14:49.021782 CEST - Status: IMAGING 2026-07-06 08:14:51.737822 CEST - Status: IMAGING 2026-07-06 08:14:54.453767 CEST - Status: IMAGING 2026-07-06 08:14:57.169821 CEST - Status: IMAGING 2026-07-06 08:14:59.885855 CEST - Status: IMAGING 2026-07-06 08:15:02.652097 CEST - Status: IMAGING 2026-07-06 08:15:05.368377 CEST - Status: IMAGING 2026-07-06 08:15:08.084433 CEST - Status: IMAGING 2026-07-06 08:15:10.850546 CEST - Status: IMAGING 2026-07-06 08:15:13.616657 CEST - Status: IMAGING 2026-07-06 08:15:16.332837 CEST - Status: IMAGING 2026-07-06 08:15:19.098956 CEST - Status: IMAGING 2026-07-06 08:15:21.865137 CEST - Status: IMAGING 2026-07-06 08:15:24.631088 CEST - Status: IMAGING 2026-07-06 08:15:27.397285 CEST - Status: IMAGING 2026-07-06 08:15:30.113462 CEST - Status: IMAGING 2026-07-06 08:15:32.879723 CEST - Status: IMAGING 2026-07-06 08:15:35.595732 CEST - Status: IMAGING 2026-07-06 08:15:38.311800 CEST - Status: IMAGING 2026-07-06 08:15:41.027753 CEST - Status: IMAGING 2026-07-06 08:15:43.743652 CEST - Status: IMAGING 2026-07-06 08:15:46.512579 CEST - Status: IMAGING 2026-07-06 08:15:49.229058 CEST - Status: IMAGING 2026-07-06 08:15:51.945119 CEST - Status: IMAGING 2026-07-06 08:15:54.661126 CEST - Status: IMAGING 2026-07-06 08:15:57.377023 CEST - Status: IMAGING 2026-07-06 08:16:00.143537 CEST - Status: IMAGING 2026-07-06 08:16:02.859906 CEST - Status: IMAGING 2026-07-06 08:16:05.626502 CEST - Status: IMAGING 2026-07-06 08:16:08.392568 CEST - Status: IMAGING 2026-07-06 08:16:11.108642 CEST - Status: IMAGING 2026-07-06 08:16:13.874808 CEST - Status: IMAGING 2026-07-06 08:16:16.691616 CEST - Status: IMAGING 2026-07-06 08:16:19.458043 CEST - Status: IMAGING 2026-07-06 08:16:22.224219 CEST - Status: IMAGING 2026-07-06 08:16:24.940076 CEST - Status: IMAGING 2026-07-06 08:16:27.656389 CEST - Status: IMAGING 2026-07-06 08:16:30.422849 CEST - Status: IMAGING 2026-07-06 08:16:33.138750 CEST - Status: IMAGING 2026-07-06 08:16:35.855287 CEST - Status: IMAGING 2026-07-06 08:16:38.571327 CEST - Status: UP 2026-07-06 08:16:38.571407 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kwv0zv9hexvrxxcma837t34f 2026-07-06 08:16:38.571463 CEST - Validate resources 2026-07-06 08:16:39.287364 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-07-06 08:16:39.287432 CEST - The fields of the created resource were validated. 2026-07-06 08:16:39.287465 CEST - Check if resources are registered in experiment 2026-07-06 08:16:39.287607 CEST - Run: slices experiment list-resources --format json tst-ecb96e2f 2026-07-06 08:16:39.902905 CEST - Status (on expauth): UP 2026-07-06 08:16:39.903053 CEST - Testing extend expires_at (all resources in experiment) 2026-07-06 08:16:39.903209 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-ecb96e2f 2026-07-06 08:16:41.670986 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-ecb96e2f tst 2026-07-06 08:16:42.386772 CEST - Run: slices experiment list-resources --format json tst-ecb96e2f 2026-07-06 08:16:43.002560 CEST - expires_at (on expauth): 2026-07-06T09:16:00Z (correctly extended) 2026-07-06 08:16:43.002650 CEST - Testing extend expires_at (single resource in experiment) 2026-07-06 08:16:43.002793 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-ecb96e2f 2026-07-06 08:16:44.770787 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-ecb96e2f tst 2026-07-06 08:16:45.486598 CEST - Run: slices experiment list-resources --format json tst-ecb96e2f 2026-07-06 08:16:46.102000 CEST - expires_at (on expauth): 2026-07-06T10:16:00Z (correctly extended) 2026-07-06 08:16:46.102126 CEST - Testing ssh login 2026-07-06 08:16:46.112700 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-ecb96e2f tst 2026-07-06 08:16:46.978590 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-ecb96e2f tst 2026-07-06 08:16:47.844743 CEST - Logging in using 'slices bi ssh' 2026-07-06 08:16:47.844821 CEST - Forcing IPv4 only. 2026-07-06 08:16:47.844966 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-ecb96e2f tst -- -4 uname -a 2026-07-06 08:18:58.242893 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/ef12dfc8-22e7-445e-8471-3d05287d148a/step_Sshloginviaslices-cliIPv4only_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-ecb96e2f tst -- -4 uname -a 2026-07-06 08:18:58.242975 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/ef12dfc8-22e7-445e-8471-3d05287d148a/cli_ssh_ipv4_uname_stderr.txt': ssh: connect to host 5.53.108.39 port 22: Connection timed out 2026-07-06 08:18:58.243003 CEST - Error in test step 'Ssh login (via slices-cli, IPv4 only)': command returned an error: ['/opt/slices-monitor-worker/slices-cli-venv/bin/slices', 'bi', '--infra', 'ch-geneva-bi-vm1', 'ssh', '--show', 'nothing', '--experiment', 'tst-ecb96e2f', 'tst', '--', '-4', 'uname', '-a'] 2026-07-06 08:18:58.243040 CEST - Step 'Ssh login (via slices-cli, IPv4 only)' took 130.40 seconds, which is longer than the warning threshold of 20 seconds 2026-07-06 08:18:58.243176 CEST - Run: ssh-keygen -F 5.53.108.39 2026-07-06 08:18:58.246903 CEST - Run: ssh-keygen -F 5.53.108.39:22 2026-07-06 08:18:58.250494 CEST - Logging in using SSH (no SSH proxy in Resource) 2026-07-06 08:18:58.250921 CEST - Added paramiko HostKeyEntry for 5.53.108.39 2026-07-06 08:18:58.251006 CEST - Added paramiko HostKeyEntry for 5.53.108.39 2026-07-06 08:18:58.251154 CEST - Added paramiko HostKeyEntry for 5.53.108.39 2026-07-06 08:18:58.251298 CEST - Connecting to 5.53.108.39:22 2026-07-06 08:19:00.253442 CEST - Error in test step 'Ssh login (no proxy)': timed out 2026-07-06 08:19:00.253541 CEST - Skip SSH proxy test because no jump proxy 2026-07-06 08:19:00.259755 CEST - Destroying tst-ecb96e2f tst 2026-07-06 08:19:00.259947 CEST - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-ecb96e2f tst