Run Test: slices-bi-singlenode-login 2026-04-05 00:18:41.691022 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-05 00:18:44.991162 CEST - Run: slices --version 2026-04-05 00:18:45.187436 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-05 00:18:45.187722 CEST - Run: slices pubkey list --format text 2026-04-05 00:18:45.773753 CEST - Pubkey already registered 2026-04-05 00:18:45.773998 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-05 00:18:46.307147 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-05 00:18:46.307244 CEST - Check List Flavors 2026-04-05 00:18:46.307481 CEST - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-04-05 00:18:47.136964 CEST - Check List DiskImages 2026-04-05 00:18:47.137158 CEST - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-04-05 00:18:47.727730 CEST - Requesting resources 2026-04-05 00:18:47.728199 CEST - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-8ad2fa6c 2026-04-05 00:18:49.526096 CEST - Resource ID: r_ch-geneva-bi-vm1_01knd97knqe7ra0jjwg1xrmdh8 2026-04-05 00:18:49.526268 CEST - Waiting until resource ready 2026-04-05 00:18:51.526817 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-8ad2fa6c tst 2026-04-05 00:18:52.204624 CEST - Status: IMAGING 2026-04-05 00:18:54.890725 CEST - Status: IMAGING 2026-04-05 00:18:57.566534 CEST - Status: IMAGING 2026-04-05 00:19:00.246380 CEST - Status: IMAGING 2026-04-05 00:19:02.930860 CEST - Status: IMAGING 2026-04-05 00:19:05.627452 CEST - Status: IMAGING 2026-04-05 00:19:08.298155 CEST - Status: IMAGING 2026-04-05 00:19:10.980811 CEST - Status: IMAGING 2026-04-05 00:19:13.669917 CEST - Status: IMAGING 2026-04-05 00:19:16.389724 CEST - Status: IMAGING 2026-04-05 00:19:19.092228 CEST - Status: IMAGING 2026-04-05 00:19:21.783813 CEST - Status: IMAGING 2026-04-05 00:19:24.474245 CEST - Status: IMAGING 2026-04-05 00:19:27.146702 CEST - Status: IMAGING 2026-04-05 00:19:29.814134 CEST - Status: IMAGING 2026-04-05 00:19:32.488818 CEST - Status: IMAGING 2026-04-05 00:19:35.162961 CEST - Status: IMAGING 2026-04-05 00:19:37.825614 CEST - Status: IMAGING 2026-04-05 00:19:40.521569 CEST - Status: IMAGING 2026-04-05 00:19:43.193732 CEST - Status: IMAGING 2026-04-05 00:19:45.954330 CEST - Status: IMAGING 2026-04-05 00:19:48.657517 CEST - Status: IMAGING 2026-04-05 00:19:51.347982 CEST - Status: IMAGING 2026-04-05 00:19:54.017572 CEST - Status: IMAGING 2026-04-05 00:19:56.692587 CEST - Status: IMAGING 2026-04-05 00:19:59.381523 CEST - Status: IMAGING 2026-04-05 00:20:02.082769 CEST - Status: IMAGING 2026-04-05 00:20:04.763918 CEST - Status: IMAGING 2026-04-05 00:20:07.456911 CEST - Status: IMAGING 2026-04-05 00:20:10.129107 CEST - Status: IMAGING 2026-04-05 00:20:12.795983 CEST - Status: IMAGING 2026-04-05 00:20:15.467421 CEST - Status: IMAGING 2026-04-05 00:20:18.141998 CEST - Status: IMAGING 2026-04-05 00:20:20.858319 CEST - Status: IMAGING 2026-04-05 00:20:23.552685 CEST - Status: IMAGING 2026-04-05 00:20:26.230372 CEST - Status: IMAGING 2026-04-05 00:20:28.951229 CEST - Status: IMAGING 2026-04-05 00:20:31.662231 CEST - Status: IMAGING 2026-04-05 00:20:34.359802 CEST - Status: IMAGING 2026-04-05 00:20:37.045106 CEST - Status: UP 2026-04-05 00:20:37.045151 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01knd97jyxe7p9etbmavx6rxzx 2026-04-05 00:20:37.045185 CEST - Validate resources 2026-04-05 00:20:37.712352 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/209759c8-bf4c-4ff0-b15c-8753bac36544/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-8ad2fa6c tst 2026-04-05 00:20:37.712436 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/209759c8-bf4c-4ff0-b15c-8753bac36544/list-resources_json.txt': [ { "cluster_id": "default", "created_at": "2026-04-04T22:18:49.388413Z", "disk_image_id": "image_ch-geneva-bi-vm1_20kfy65vcb9xabdgfszftvdjk6", "experiment_id": "exp_expauth.ilabt.imec.be_01knd97jyxe7p9etbmavx6rxzx", "expires_at": "2026-04-05T00:18:00Z", "flavor_id": "flavor_ch-geneva-bi-vm1_3rm28rdxe1947bbxqxb7e8xgc5", "friendly_name": "tst", "id": "r_ch-geneva-bi-vm1_01knd97knqe7ra0jjwg1xrmdh8", "network_interfaces": [], "private_ipv4": "5.53.108.183", "private_ipv6": null, "public_ipv4": "5.53.108.183", "public_ipv6": null, "ssh_authorized_keys": [ "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINNiZPtQkfCEsc1x2QSwNWekfhWwWZbOvpE8hE0dH253 Wim (ftester) Van de Meerssche" ], "ssh_logins": [ { "host": "5.53.108.183", "port": 22, "username": "ubuntu", "host_keys": [ "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBJYJBDIHBvzjGVgTbuIQxnTxao26BW1H8wZBDpNcrsGPJY/k/Ru1zwUfvfbLVBCLDKD0nPja6PZT7qs9oIzeJU8=", "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIIyg8vVFm6QG/j1PR3f50m8tf2I+LfC/C3jd5ls3A4fH", "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDrP2ac1rM9DGqkQ/zHM9FMHOH6mdOBtSHvd47KQBLCgIBDnjxFfceDwCMkspsTUUabZtY7jRAMlBGhpCTGRvRHkLsUr+Wtczmd6HQgVVMM/J5bu33/FGS21rmXyN3lMjTr3drgqx9jxTJf1FasQmEUxdagKpSVsdSBU4vGCxFxWwVeucLd+c7NigWj/cn7xpU5ywAa/H2prjZATfWJ/ABDsqTP2MUS6bcdXsgt8UNA2eM0v+EJaXXyQrVAecMZi8H7BdMOkPrgqIn7o8nFk19I5ymcMMGP0gip/1jqLuL2H6INJEK4kB02662jMwhVkKVIj+Kkm5F1YNyfL0d0BqJdDjOD009DSOHRSHTItGJGdIbbqklgEbzNJUYGfXwsYk2rhQGsmiy2s8bGRo2+hGzFw6pGoAyURgAI43GstbYhbSGjSisdbK+/iWM5fkx3D2QxiP73tw19L2h5gemkxKFlJUUpcXqi4aZ1lVCf8NFR/dbccpzl4pB8zjZskn8RYn8=" ], "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-05 00:20:37.712454 CEST - Error in test step 'Validate resources': The resource has a private IPv4 address, but it is NOT a private address: 5.53.108.183 2026-04-05 00:20:37.712477 CEST - Check if resources are registered in experiment 2026-04-05 00:20:37.712598 CEST - Run: slices experiment list-resources --format json tst-8ad2fa6c 2026-04-05 00:20:38.327837 CEST - Status (on expauth): UP 2026-04-05 00:20:38.327962 CEST - Testing extend expires_at (all resources in experiment) 2026-04-05 00:20:38.328093 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-8ad2fa6c 2026-04-05 00:20:40.521570 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-8ad2fa6c tst 2026-04-05 00:20:41.204489 CEST - Testing extend expires_at (single resource in experiment) 2026-04-05 00:20:41.204695 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-8ad2fa6c 2026-04-05 00:20:43.369618 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-8ad2fa6c tst 2026-04-05 00:20:44.076408 CEST - Testing ssh login 2026-04-05 00:20:44.086111 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-8ad2fa6c tst 2026-04-05 00:20:44.782459 CEST - Error in test step 'Require Jump Proxy': No proxy in ComputeResource SSH info. 2026-04-05 00:20:44.782619 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-8ad2fa6c tst 2026-04-05 00:20:45.490780 CEST - Logging in using 'slices bi ssh' 2026-04-05 00:20:45.490833 CEST - Forcing IPv4 only. 2026-04-05 00:20:45.490982 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-8ad2fa6c tst -- -4 uname -a 2026-04-05 00:20:47.842147 CEST - Forcing IPv4 only. 2026-04-05 00:20:47.842296 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-8ad2fa6c tst -- -4 uptime 2026-04-05 00:20:48.906138 CEST - CLI SSH Test passed. 2026-04-05 00:20:48.906177 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-05 00:20:48.906187 CEST - Uptime: 22:20:48 up 1 min, 2 users, load average: 0.75, 0.27, 0.10 2026-04-05 00:20:48.906212 CEST - Logging in using SSH (no SSH proxy in Resource) 2026-04-05 00:20:48.906617 CEST - Added paramiko HostKeyEntry for 5.53.108.183 2026-04-05 00:20:48.906696 CEST - Added paramiko HostKeyEntry for 5.53.108.183 2026-04-05 00:20:48.906825 CEST - Added paramiko HostKeyEntry for 5.53.108.183 2026-04-05 00:20:48.906972 CEST - Connecting to 5.53.108.183:22 2026-04-05 00:20:49.501850 CEST - SSH Test output: 2026-04-05 00:20:49.501894 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-05 00:20:49.501905 CEST - Uptime: 22:20:49 up 1 min, 1 user, load average: 0.75, 0.27, 0.10 2026-04-05 00:20:49.598442 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-05 00:20:49.598492 CEST - lsb_release matches expected value 2026-04-05 00:20:49.598502 CEST - SSH Test passed. 2026-04-05 00:20:49.598573 CEST - Skip SSH proxy test because no jump proxy 2026-04-05 00:20:49.607250 CEST - Destroying tst-8ad2fa6c tst 2026-04-05 00:20:49.607446 CEST - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-8ad2fa6c tst 2026-04-05 00:21:54.250588 CEST - Step 'Destroy' took 64.64 seconds, which is longer than the warning threshold of 15 seconds 2026-04-05 00:21:54.250654 CEST - Wait 2s before retry 2026-04-05 00:22:49.281079 CEST - Step 'Destroy' took 53.03 seconds, which is longer than the warning threshold of 15 seconds 2026-04-05 00:22:49.281138 CEST - Wait 2s before retry 2026-04-05 00:23:29.703330 CEST - Step 'Destroy' took 38.42 seconds, which is longer than the warning threshold of 15 seconds 2026-04-05 00:23:29.703398 CEST - Wait 2s before retry 2026-04-05 00:24:10.636423 CEST - Step 'Destroy' took 38.93 seconds, which is longer than the warning threshold of 15 seconds