Run Test: slices-bi-singlenode-login 2026-04-03 08:21:49.977625 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-03 08:21:54.088291 CEST - Run: slices --version 2026-04-03 08:21:54.284115 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.5.0 Slices clientlib bi v5.1.2 2026-04-03 08:21:54.284346 CEST - Run: slices pubkey list --format text 2026-04-03 08:21:54.859589 CEST - Pubkey already registered 2026-04-03 08:21:54.859810 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-03 08:21:55.393269 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-03 08:21:55.393360 CEST - Check List Flavors 2026-04-03 08:21:55.393527 CEST - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-04-03 08:21:56.174376 CEST - Check List DiskImages 2026-04-03 08:21:56.174578 CEST - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-04-03 08:21:56.780156 CEST - Requesting resources 2026-04-03 08:21:56.780861 CEST - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-de349c40 2026-04-03 08:21:58.419935 CEST - Resource ID: r_ch-geneva-bi-vm1_01kn902v4nf60r8s8rp3ye55f4 2026-04-03 08:21:58.420103 CEST - Waiting until resource ready 2026-04-03 08:22:00.420466 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-de349c40 tst 2026-04-03 08:22:01.108927 CEST - Status: IMAGING 2026-04-03 08:22:03.845122 CEST - Status: IMAGING 2026-04-03 08:22:06.520892 CEST - Status: IMAGING 2026-04-03 08:22:09.220063 CEST - Status: IMAGING 2026-04-03 08:22:11.899367 CEST - Status: IMAGING 2026-04-03 08:22:14.566378 CEST - Status: IMAGING 2026-04-03 08:22:17.266843 CEST - Status: IMAGING 2026-04-03 08:22:19.951186 CEST - Status: IMAGING 2026-04-03 08:22:22.664213 CEST - Status: IMAGING 2026-04-03 08:22:25.351656 CEST - Status: IMAGING 2026-04-03 08:22:28.033296 CEST - Status: IMAGING 2026-04-03 08:22:30.716673 CEST - Status: IMAGING 2026-04-03 08:22:33.394563 CEST - Status: IMAGING 2026-04-03 08:22:36.071458 CEST - Status: IMAGING 2026-04-03 08:22:38.740160 CEST - Status: IMAGING 2026-04-03 08:22:41.432305 CEST - Status: IMAGING 2026-04-03 08:22:44.131580 CEST - Status: IMAGING 2026-04-03 08:22:46.800324 CEST - Status: IMAGING 2026-04-03 08:22:49.466091 CEST - Status: IMAGING 2026-04-03 08:22:52.183619 CEST - Status: IMAGING 2026-04-03 08:22:54.858513 CEST - Status: IMAGING 2026-04-03 08:22:57.598800 CEST - Status: IMAGING 2026-04-03 08:23:00.337265 CEST - Status: IMAGING 2026-04-03 08:23:03.059729 CEST - Status: IMAGING 2026-04-03 08:23:05.795617 CEST - Status: IMAGING 2026-04-03 08:23:08.484227 CEST - Status: IMAGING 2026-04-03 08:23:11.212985 CEST - Status: IMAGING 2026-04-03 08:23:13.902908 CEST - Status: IMAGING 2026-04-03 08:23:16.596739 CEST - Status: IMAGING 2026-04-03 08:23:19.291223 CEST - Status: IMAGING 2026-04-03 08:23:21.983667 CEST - Status: IMAGING 2026-04-03 08:23:24.695060 CEST - Status: IMAGING 2026-04-03 08:23:27.397884 CEST - Status: IMAGING 2026-04-03 08:23:30.093300 CEST - Status: IMAGING 2026-04-03 08:23:32.799333 CEST - Status: IMAGING 2026-04-03 08:23:35.499093 CEST - Status: IMAGING 2026-04-03 08:23:38.178913 CEST - Status: IMAGING 2026-04-03 08:23:40.843792 CEST - Status: IMAGING 2026-04-03 08:23:43.518465 CEST - Status: IMAGING 2026-04-03 08:23:46.200906 CEST - Status: IMAGING 2026-04-03 08:23:48.882178 CEST - Status: IMAGING 2026-04-03 08:23:51.546555 CEST - Status: UP 2026-04-03 08:23:51.546608 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kn902thdenstrtfscwzfsxbf 2026-04-03 08:23:51.546646 CEST - Validate resources 2026-04-03 08:23:52.224308 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/ba648781-af0e-4b5e-badb-fa13d1a5fc2d/step_Validateresources_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-de349c40 tst 2026-04-03 08:23:52.224390 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/ba648781-af0e-4b5e-badb-fa13d1a5fc2d/list-resources_json.txt': [ { "cluster_id": "default", "created_at": "2026-04-03T06:21:58.285045Z", "disk_image_id": "image_ch-geneva-bi-vm1_20kfy65vcb9xabdgfszftvdjk6", "experiment_id": "exp_expauth.ilabt.imec.be_01kn902thdenstrtfscwzfsxbf", "expires_at": "2026-04-03T08:21:00Z", "flavor_id": "flavor_ch-geneva-bi-vm1_3rm28rdxe1947bbxqxb7e8xgc5", "friendly_name": "tst", "id": "r_ch-geneva-bi-vm1_01kn902v4nf60r8s8rp3ye55f4", "network_interfaces": [], "private_ipv4": "5.53.108.149", "private_ipv6": null, "public_ipv4": "5.53.108.149", "public_ipv6": null, "ssh_authorized_keys": [ "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINNiZPtQkfCEsc1x2QSwNWekfhWwWZbOvpE8hE0dH253 Wim (ftester) Van de Meerssche" ], "ssh_logins": [ { "host": "5.53.108.149", "port": 22, "username": "ubuntu", "host_keys": [ "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBCfB3oP3lqB7k3o4IhyrZrPniYf/FKZcTgzoiUIbrGEnkPOhxHwn+oJp/SQ8EJbEaTNZWebdIaNUbVlfP7+j6+A=", "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIC49WWa8Psie+FDX5Ctc4irTk6PSCqhJWL2i6w1X5tHH", "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDeh+MhJyOVkfHE7gvNkLDL+8IgcuqTZUCJHGxt8k+0dF5XWe4iXF3YVtWQKr/1CEsZgle/OhrgDcW86s/1j8F1trOXBAaWxmQYe6lDFCLOamNvngAUakF7CvMUvMyfG/v1cAumHF/jVOe3g/UFYAtLxHM0K8iysLpq04KswmHQdTppQfanL/fB6zesCyDmsN+QKcwKi3xvZYSes9zfWXep9trggF8RAQZzScMpCI/JALil5ZwPhvS5fV8ODzw7RGSjXbKo2T5oC4mb2WmUdhVvIC1DtzuRlOnfrugLYD8rJqtfEO0VMfOZvTOBn3c36CyrOS+5D4D8NNx5I/vU1q81lNxCbsPX7kMsnxxmtNHQy+qxTTMjQL8YwUTjE83WvUcvFGOCDJQwRAqmuX0Izp6ng2QMnh/mZzvLMYWCDhKWOT1NRS2LdNBbgOkbfKb0OV15BMw45fZms2QHfLiuJDhmDnaVjgBGFUsmiq2kLh7B/oDZirK+FFE04SasO2w5vRc=" ], "description": null, "jump_proxy": null } ], "status": "up", "terminated_at": null, "userdata": null, "console_url": null, "machine_id": null, "failure_reason": null, "infra_id": "ch-geneva-bi-vm1", "machine_name": null } ] 2026-04-03 08:23:52.224408 CEST - Error in test step 'Validate resources': The resource has a private IPv4 address, but it is NOT a private address: 5.53.108.149 2026-04-03 08:23:52.224431 CEST - Check if resources are registered in experiment 2026-04-03 08:23:52.224559 CEST - Run: slices experiment list-resources --format json tst-de349c40 2026-04-03 08:23:52.840257 CEST - Status (on expauth): UP 2026-04-03 08:23:52.840380 CEST - Testing extend expires_at (all resources in experiment) 2026-04-03 08:23:52.840514 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-de349c40 2026-04-03 08:23:59.227585 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-de349c40 tst 2026-04-03 08:23:59.898913 CEST - Testing extend expires_at (single resource in experiment) 2026-04-03 08:23:59.899088 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-de349c40 2026-04-03 08:24:01.945025 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-de349c40 tst 2026-04-03 08:24:02.628934 CEST - Testing ssh login 2026-04-03 08:24:02.638394 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-de349c40 tst 2026-04-03 08:24:03.346176 CEST - Error in test step 'Require Jump Proxy': No proxy in ComputeResource SSH info. 2026-04-03 08:24:03.346353 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-de349c40 tst 2026-04-03 08:24:04.049748 CEST - Logging in using 'slices bi ssh' 2026-04-03 08:24:04.049797 CEST - Forcing IPv4 only. 2026-04-03 08:24:04.049941 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-de349c40 tst -- -4 uname -a 2026-04-03 08:24:06.362425 CEST - Forcing IPv4 only. 2026-04-03 08:24:06.362592 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-de349c40 tst -- -4 uptime 2026-04-03 08:24:07.390461 CEST - CLI SSH Test passed. 2026-04-03 08:24:07.390505 CEST - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-b6fa97cc-9ea7-4f9b-9541-f0 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-04-03 08:24:07.390515 CEST - Uptime: 06:24:07 up 1 min, 1 user, load average: 0.76, 0.31, 0.11 2026-04-03 08:24:07.390543 CEST - Logging in using SSH (no SSH proxy in Resource) 2026-04-03 08:24:07.390968 CEST - Added paramiko HostKeyEntry for 5.53.108.149 2026-04-03 08:24:07.391038 CEST - Added paramiko HostKeyEntry for 5.53.108.149 2026-04-03 08:24:07.391163 CEST - Added paramiko HostKeyEntry for 5.53.108.149 2026-04-03 08:24:07.391309 CEST - Connecting to 5.53.108.149:22 2026-04-03 08:24:07.951570 CEST - SSH Test output: 2026-04-03 08:24:07.951610 CEST - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-b6fa97cc-9ea7-4f9b-9541-f0 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-04-03 08:24:07.951620 CEST - Uptime: 06:24:07 up 1 min, 1 user, load average: 0.70, 0.30, 0.11 2026-04-03 08:24:08.052313 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-03 08:24:08.052364 CEST - lsb_release matches expected value 2026-04-03 08:24:08.052375 CEST - SSH Test passed. 2026-04-03 08:24:08.052446 CEST - Skip SSH proxy test because no jump proxy 2026-04-03 08:24:08.058504 CEST - Destroying tst-de349c40 tst 2026-04-03 08:24:08.058668 CEST - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-de349c40 tst 2026-04-03 08:24:29.505851 CEST - Step 'Destroy' took 21.45 seconds, which is longer than the warning threshold of 15 seconds 2026-04-03 08:24:29.505912 CEST - Wait 2s before retry