Run Test: slices-bi-singlenode-login 2026-07-04 00:12:08.553506 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmpz2756a4b.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-07-04 00:12:12.777154 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/0a4304e2-c469-45ba-b763-712efcecf6ec/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-07-04 00:12:20.911844 CEST - Run: slices --version 2026-07-04 00:12:21.126252 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-04 00:12:21.126537 CEST - Run: slices pubkey list --format text 2026-07-04 00:12:21.792421 CEST - Pubkey already registered 2026-07-04 00:12:21.792669 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-04 00:12:22.357889 CEST - Refreshed infrastructure list. Total: 24 entries. 2026-07-04 00:12:22.358026 CEST - Check List Flavors 2026-07-04 00:12:22.358185 CEST - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-04 00:12:23.274156 CEST - Check List DiskImages 2026-07-04 00:12:23.274360 CEST - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-04 00:12:23.889752 CEST - Requesting resources 2026-07-04 00:12:23.890068 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-04 00:12:23.890174 CEST - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-ba94f903 --user-data /tmp/tmpz93f2__i 2026-07-04 00:12:26.159378 CEST - Resource ID: r_ch-geneva-bi-vm1_01kwn0mk7yeph89gcd6mqb33k3 2026-07-04 00:12:26.159524 CEST - Waiting until resource ready 2026-07-04 00:12:28.159911 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-ba94f903 tst 2026-07-04 00:12:28.925685 CEST - Status: IMAGING 2026-07-04 00:12:31.692267 CEST - Status: IMAGING 2026-07-04 00:12:34.459286 CEST - Status: IMAGING 2026-07-04 00:12:37.175434 CEST - Status: IMAGING 2026-07-04 00:12:39.891299 CEST - Status: IMAGING 2026-07-04 00:12:42.607644 CEST - Status: IMAGING 2026-07-04 00:12:45.374244 CEST - Status: IMAGING 2026-07-04 00:12:48.090170 CEST - Status: IMAGING 2026-07-04 00:12:50.806115 CEST - Status: IMAGING 2026-07-04 00:12:53.521951 CEST - Status: IMAGING 2026-07-04 00:12:56.237965 CEST - Status: IMAGING 2026-07-04 00:12:59.054337 CEST - Status: IMAGING 2026-07-04 00:13:01.770125 CEST - Status: IMAGING 2026-07-04 00:13:04.486010 CEST - Status: IMAGING 2026-07-04 00:13:07.202008 CEST - Status: IMAGING 2026-07-04 00:13:09.968163 CEST - Status: IMAGING 2026-07-04 00:13:12.684309 CEST - Status: IMAGING 2026-07-04 00:13:15.450715 CEST - Status: IMAGING 2026-07-04 00:13:18.166674 CEST - Status: IMAGING 2026-07-04 00:13:20.932891 CEST - Status: IMAGING 2026-07-04 00:13:23.649006 CEST - Status: IMAGING 2026-07-04 00:13:26.415420 CEST - Status: IMAGING 2026-07-04 00:13:29.131524 CEST - Status: IMAGING 2026-07-04 00:13:31.847437 CEST - Status: IMAGING 2026-07-04 00:13:34.563563 CEST - Status: IMAGING 2026-07-04 00:13:37.329905 CEST - Status: IMAGING 2026-07-04 00:13:40.045990 CEST - Status: IMAGING 2026-07-04 00:13:42.761676 CEST - Status: IMAGING 2026-07-04 00:13:45.527909 CEST - Status: IMAGING 2026-07-04 00:13:48.244793 CEST - Status: IMAGING 2026-07-04 00:13:50.960797 CEST - Status: IMAGING 2026-07-04 00:13:53.727297 CEST - Status: IMAGING 2026-07-04 00:13:56.494029 CEST - Status: IMAGING 2026-07-04 00:13:59.210350 CEST - Status: IMAGING 2026-07-04 00:14:01.977278 CEST - Status: IMAGING 2026-07-04 00:14:04.693768 CEST - Status: IMAGING 2026-07-04 00:14:07.460478 CEST - Status: IMAGING 2026-07-04 00:14:10.176537 CEST - Status: IMAGING 2026-07-04 00:14:12.892697 CEST - Status: IMAGING 2026-07-04 00:14:15.609324 CEST - Status: IMAGING 2026-07-04 00:14:18.325605 CEST - Status: IMAGING 2026-07-04 00:14:21.042013 CEST - Status: IMAGING 2026-07-04 00:14:23.808648 CEST - Status: IMAGING 2026-07-04 00:14:26.525010 CEST - Status: IMAGING 2026-07-04 00:14:29.291410 CEST - Status: IMAGING 2026-07-04 00:14:32.007387 CEST - Status: IMAGING 2026-07-04 00:14:34.723261 CEST - Status: IMAGING 2026-07-04 00:14:37.439540 CEST - Status: IMAGING 2026-07-04 00:14:40.155426 CEST - Status: IMAGING 2026-07-04 00:14:42.921822 CEST - Status: IMAGING 2026-07-04 00:14:45.637989 CEST - Status: IMAGING 2026-07-04 00:14:48.354373 CEST - Status: IMAGING 2026-07-04 00:14:51.120630 CEST - Status: IMAGING 2026-07-04 00:14:53.836646 CEST - Status: IMAGING 2026-07-04 00:14:56.602821 CEST - Status: IMAGING 2026-07-04 00:14:59.318835 CEST - Status: IMAGING 2026-07-04 00:15:02.035221 CEST - Status: UP 2026-07-04 00:15:02.035311 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kwn0mjdgekwtdgfesyzv7kjr 2026-07-04 00:15:02.035376 CEST - Validate resources 2026-07-04 00:15:02.801524 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-04 00:15:02.801624 CEST - The fields of the created resource were validated. 2026-07-04 00:15:02.801682 CEST - Check if resources are registered in experiment 2026-07-04 00:15:02.801919 CEST - Run: slices experiment list-resources --format json tst-ba94f903 2026-07-04 00:15:03.417441 CEST - Status (on expauth): UP 2026-07-04 00:15:03.417600 CEST - Testing extend expires_at (all resources in experiment) 2026-07-04 00:15:03.417746 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-ba94f903 2026-07-04 00:15:05.335978 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-ba94f903 tst 2026-07-04 00:15:06.051737 CEST - Run: slices experiment list-resources --format json tst-ba94f903 2026-07-04 00:15:06.667346 CEST - expires_at (on expauth): 2026-07-04T01:15:00Z (correctly extended) 2026-07-04 00:15:06.667477 CEST - Testing extend expires_at (single resource in experiment) 2026-07-04 00:15:06.667653 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-ba94f903 2026-07-04 00:15:08.436042 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-ba94f903 tst 2026-07-04 00:15:09.151812 CEST - Run: slices experiment list-resources --format json tst-ba94f903 2026-07-04 00:15:09.767234 CEST - expires_at (on expauth): 2026-07-04T02:15:00Z (correctly extended) 2026-07-04 00:15:09.767364 CEST - Testing ssh login 2026-07-04 00:15:09.777730 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-ba94f903 tst 2026-07-04 00:15:10.643719 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-ba94f903 tst 2026-07-04 00:15:11.459442 CEST - Logging in using 'slices bi ssh' 2026-07-04 00:15:11.459516 CEST - Forcing IPv4 only. 2026-07-04 00:15:11.459653 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-ba94f903 tst -- -4 uname -a 2026-07-04 00:17:23.008535 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/0a4304e2-c469-45ba-b763-712efcecf6ec/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-ba94f903 tst -- -4 uname -a 2026-07-04 00:17:23.008681 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/0a4304e2-c469-45ba-b763-712efcecf6ec/cli_ssh_ipv4_uname_stderr.txt': ssh: connect to host 5.53.108.161 port 22: Connection timed out 2026-07-04 00:17:23.008774 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-ba94f903', 'tst', '--', '-4', 'uname', '-a'] 2026-07-04 00:17:23.008845 CEST - Step 'Ssh login (via slices-cli, IPv4 only)' took 131.55 seconds, which is longer than the warning threshold of 20 seconds 2026-07-04 00:17:23.009068 CEST - Run: ssh-keygen -F 5.53.108.161 2026-07-04 00:17:23.017226 CEST - Run: ssh-keygen -F 5.53.108.161:22 2026-07-04 00:17:23.025273 CEST - Logging in using SSH (no SSH proxy in Resource) 2026-07-04 00:17:23.026083 CEST - Added paramiko HostKeyEntry for 5.53.108.161 2026-07-04 00:17:23.026267 CEST - Added paramiko HostKeyEntry for 5.53.108.161 2026-07-04 00:17:23.026492 CEST - Added paramiko HostKeyEntry for 5.53.108.161 2026-07-04 00:17:23.026747 CEST - Connecting to 5.53.108.161:22 2026-07-04 00:17:25.030590 CEST - Error in test step 'Ssh login (no proxy)': timed out 2026-07-04 00:17:25.030696 CEST - Skip SSH proxy test because no jump proxy 2026-07-04 00:17:25.037300 CEST - Destroying tst-ba94f903 tst 2026-07-04 00:17:25.037473 CEST - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-ba94f903 tst