Run Test: slices-bi-singlenode-login 2026-02-16 16:16:35.026357 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-02-16 16:16:38.027054 CET - Run: slices --version 2026-02-16 16:16:38.208095 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.5 Slices clientlib bi v5.0.6 2026-02-16 16:16:38.208356 CET - Run: slices pubkey list --format text 2026-02-16 16:16:38.750989 CET - Pubkey already registered 2026-02-16 16:16:38.751209 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-02-16 16:16:39.237848 CET - Refreshed infrastructure list. Total: 20 entries. 2026-02-16 16:16:39.237999 CET - Check List Flavors 2026-02-16 16:16:39.238181 CET - Run: slices bi --infra fr-sophia2-bi-vm1 flavor list -f json 2026-02-16 16:16:40.100683 CET - Check List DiskImages 2026-02-16 16:16:40.100928 CET - Run: slices bi --infra fr-sophia2-bi-vm1 diskimage list -f json 2026-02-16 16:16:40.744940 CET - Requesting resources 2026-02-16 16:16:40.745468 CET - Run: slices bi --infra fr-sophia2-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-9815ad54 2026-02-16 16:16:42.931469 CET - Resource ID: r_fr-sophia2-bi-vm1_01khkgcxm8fh0s9vvdqx2pn1zh 2026-02-16 16:16:42.931729 CET - Waiting until resource ready 2026-02-16 16:16:44.932188 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-9815ad54 tst 2026-02-16 16:16:45.634851 CET - Status: IMAGING 2026-02-16 16:16:48.337813 CET - Status: IMAGING 2026-02-16 16:16:51.051080 CET - Status: IMAGING 2026-02-16 16:16:53.767511 CET - Status: IMAGING 2026-02-16 16:16:56.489831 CET - Status: IMAGING 2026-02-16 16:16:59.216905 CET - Status: IMAGING 2026-02-16 16:17:02.001071 CET - Status: BOOTING 2026-02-16 16:17:04.813958 CET - Status: BOOTING 2026-02-16 16:17:07.529355 CET - Status: BOOTING 2026-02-16 16:17:10.235109 CET - Status: BOOTING 2026-02-16 16:17:12.940623 CET - Status: BOOTING 2026-02-16 16:17:15.647760 CET - Status: BOOTING 2026-02-16 16:17:18.357147 CET - Status: BOOTING 2026-02-16 16:17:21.088429 CET - Status: BOOTING 2026-02-16 16:17:23.802399 CET - Status: BOOTING 2026-02-16 16:17:26.491505 CET - Status: BOOTING 2026-02-16 16:17:29.244596 CET - Status: BOOTING 2026-02-16 16:17:32.009323 CET - Status: BOOTING 2026-02-16 16:17:34.736697 CET - Status: BOOTING 2026-02-16 16:17:37.533456 CET - Status: BOOTING 2026-02-16 16:17:40.250920 CET - Status: BOOTING 2026-02-16 16:17:42.996528 CET - Status: BOOTING 2026-02-16 16:17:45.714066 CET - Status: BOOTING 2026-02-16 16:17:48.411818 CET - Status: BOOTING 2026-02-16 16:17:51.202304 CET - Status: BOOTING 2026-02-16 16:17:54.029490 CET - Status: BOOTING 2026-02-16 16:17:56.784309 CET - Status: BOOTING 2026-02-16 16:17:59.530294 CET - Status: BOOTING 2026-02-16 16:18:02.235767 CET - Status: BOOTING 2026-02-16 16:18:04.985464 CET - Status: BOOTING 2026-02-16 16:18:07.689897 CET - Status: BOOTING 2026-02-16 16:18:10.350940 CET - Status: UP 2026-02-16 16:18:10.350986 CET - Experiment ID: exp_expauth.ilabt.imec.be_01khkgcwkkfe8sy1n2gnzwk3w0 2026-02-16 16:18:10.351018 CET - Check if resources are registered in experiment 2026-02-16 16:18:10.351199 CET - Run: slices experiment list-resources --format json tst-9815ad54 2026-02-16 16:18:10.972761 CET - Status (on expauth): UP 2026-02-16 16:18:10.972888 CET - Testing extend expires_at (all resources in experiment) 2026-02-16 16:18:10.973027 CET - Run: slices bi --infra fr-sophia2-bi-vm1 extend --duration 3h --experiment tst-9815ad54 2026-02-16 16:18:12.822802 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-9815ad54 tst 2026-02-16 16:18:13.471776 CET - Testing extend expires_at (single resource in experiment) 2026-02-16 16:18:13.471965 CET - Run: slices bi --infra fr-sophia2-bi-vm1 extend tst --duration 4h --experiment tst-9815ad54 2026-02-16 16:18:15.100903 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-9815ad54 tst 2026-02-16 16:18:15.757816 CET - Testing ssh login 2026-02-16 16:18:15.767678 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-9815ad54 tst 2026-02-16 16:18:16.538822 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-9815ad54 tst 2026-02-16 16:18:17.311532 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-9815ad54 tst 2026-02-16 16:18:18.097959 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/949eef2b-229f-4625-be4e-274a36b39f42/step_CheckSSHpubkeyproxy_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-9815ad54 tst 2026-02-16 16:18:18.098029 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/949eef2b-229f-4625-be4e-274a36b39f42/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-16 16:18:18.098046 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-16 16:18:18.098116 CET - Logging in using 'slices bi ssh' 2026-02-16 16:18:18.098136 CET - Forcing IPv4 only. 2026-02-16 16:18:18.098237 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-9815ad54 tst -- -4 uname -a 2026-02-16 16:18:18.969922 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/949eef2b-229f-4625-be4e-274a36b39f42/step_Sshloginviaslices-cliIPv4only_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-9815ad54 tst -- -4 uname -a 2026-02-16 16:18:18.969992 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/949eef2b-229f-4625-be4e-274a36b39f42/cli_ssh_ipv4_uname_stderr.txt': Host key verification failed. kex_exchange_identification: Connection closed by remote host Connection closed by UNKNOWN port 65535 2026-02-16 16:18:18.970009 CET - 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', 'fr-sophia2-bi-vm1', 'ssh', '--show', 'nothing', '--experiment', 'tst-9815ad54', 'tst', '--', '-4', 'uname', '-a'] 2026-02-16 16:18:18.970135 CET - Run: ssh-keygen -F 172.28.2.92 2026-02-16 16:18:18.973548 CET - Run: ssh-keygen -F 172.28.2.92:22 2026-02-16 16:18:18.976566 CET - Run: ssh-keygen -F bastion1.theblueprintfactory.org 2026-02-16 16:18:18.979491 CET - Run: ssh-keygen -F bastion1.theblueprintfactory.org:22 2026-02-16 16:18:18.982324 CET - Logging in using SSH over SSH proxy 2026-02-16 16:18:18.982451 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-9815ad54 tst 2026-02-16 16:18:19.746368 CET - Added paramiko HostKeyEntry for 172.28.2.92 2026-02-16 16:18:19.746460 CET - Added paramiko HostKeyEntry for 172.28.2.92 2026-02-16 16:18:19.746614 CET - Added paramiko HostKeyEntry for 172.28.2.92 2026-02-16 16:18:19.746860 CET - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-02-16 16:18:19.899823 CET - Error in test step 'Ssh login (with proxy)': Server 'bastion1.theblueprintfactory.org' not found in known_hosts 2026-02-16 16:18:19.906225 CET - Destroying tst-9815ad54 tst 2026-02-16 16:18:19.906373 CET - Run: slices bi --infra fr-sophia2-bi-vm1 destroy --experiment tst-9815ad54 tst