Run Test: slices-bi-singlenode-login 2026-02-25 23:12:15.307666 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-02-25 23:12:18.378261 CET - Run: slices --version 2026-02-25 23:12:18.566496 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.7 Slices clientlib bi v5.0.6 2026-02-25 23:12:18.566822 CET - Run: slices pubkey list --format text 2026-02-25 23:12:19.138741 CET - Pubkey already registered 2026-02-25 23:12:19.139016 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-02-25 23:12:19.658458 CET - Refreshed infrastructure list. Total: 22 entries. 2026-02-25 23:12:19.658579 CET - Check List Flavors 2026-02-25 23:12:19.658777 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-02-25 23:12:23.752529 CET - Check List DiskImages 2026-02-25 23:12:23.752771 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-02-25 23:12:26.513710 CET - Requesting resources 2026-02-25 23:12:26.514177 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-26593841 2026-02-25 23:12:28.347301 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kjbdrndaedr9j5cmnj6hj41r 2026-02-25 23:12:28.347511 CET - Waiting until resource ready 2026-02-25 23:12:30.347958 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-26593841 tst 2026-02-25 23:12:31.018368 CET - Status: IMAGING 2026-02-25 23:12:33.671888 CET - Status: IMAGING 2026-02-25 23:12:36.332532 CET - Status: STARTING 2026-02-25 23:12:38.987857 CET - Status: STARTING 2026-02-25 23:12:41.637422 CET - Status: STARTING 2026-02-25 23:12:44.294589 CET - Status: STARTING 2026-02-25 23:12:46.919582 CET - Status: STARTING 2026-02-25 23:12:49.565785 CET - Status: STARTING 2026-02-25 23:12:52.213804 CET - Status: STARTING 2026-02-25 23:12:54.871644 CET - Status: STARTING 2026-02-25 23:12:57.542969 CET - Status: STARTING 2026-02-25 23:13:00.204764 CET - Status: STARTING 2026-02-25 23:13:02.873241 CET - Status: STARTING 2026-02-25 23:13:05.535230 CET - Status: STARTING 2026-02-25 23:13:08.197509 CET - Status: STARTING 2026-02-25 23:13:10.859681 CET - Status: STARTING 2026-02-25 23:13:13.527587 CET - Status: STARTING 2026-02-25 23:13:16.213770 CET - Status: STARTING 2026-02-25 23:13:18.871225 CET - Status: STARTING 2026-02-25 23:13:21.530983 CET - Status: STARTING 2026-02-25 23:13:24.190138 CET - Status: STARTING 2026-02-25 23:13:26.824066 CET - Status: STARTING 2026-02-25 23:13:29.484787 CET - Status: STARTING 2026-02-25 23:13:32.141614 CET - Status: STARTING 2026-02-25 23:13:34.767373 CET - Status: STARTING 2026-02-25 23:13:37.432235 CET - Status: STARTING 2026-02-25 23:13:40.092835 CET - Status: STARTING 2026-02-25 23:13:42.751105 CET - Status: STARTING 2026-02-25 23:13:45.376788 CET - Status: STARTING 2026-02-25 23:13:48.003888 CET - Status: STARTING 2026-02-25 23:13:50.620972 CET - Status: STARTING 2026-02-25 23:13:53.243790 CET - Status: STARTING 2026-02-25 23:13:55.883081 CET - Status: STARTING 2026-02-25 23:13:58.552380 CET - Status: STARTING 2026-02-25 23:14:01.213622 CET - Status: STARTING 2026-02-25 23:14:03.879507 CET - Status: STARTING 2026-02-25 23:14:06.534819 CET - Status: STARTING 2026-02-25 23:14:09.180476 CET - Status: STARTING 2026-02-25 23:14:11.817721 CET - Status: STARTING 2026-02-25 23:14:14.449823 CET - Status: STARTING 2026-02-25 23:14:17.095052 CET - Status: STARTING 2026-02-25 23:14:19.728880 CET - Status: STARTING 2026-02-25 23:14:22.369686 CET - Status: STARTING 2026-02-25 23:14:25.019550 CET - Status: STARTING 2026-02-25 23:14:27.672626 CET - Status: STARTING 2026-02-25 23:14:30.325999 CET - Status: STARTING 2026-02-25 23:14:32.970557 CET - Status: STARTING 2026-02-25 23:14:35.611525 CET - Status: STARTING 2026-02-25 23:14:38.254776 CET - Status: STARTING 2026-02-25 23:14:40.890165 CET - Status: STARTING 2026-02-25 23:14:43.529760 CET - Status: STARTING 2026-02-25 23:14:46.157377 CET - Status: STARTING 2026-02-25 23:14:48.791984 CET - Status: STARTING 2026-02-25 23:14:51.478127 CET - Status: STARTING 2026-02-25 23:14:54.112483 CET - Status: STARTING 2026-02-25 23:14:56.739287 CET - Status: STARTING 2026-02-25 23:14:59.372226 CET - Status: STARTING 2026-02-25 23:15:02.003963 CET - Status: STARTING 2026-02-25 23:15:04.622982 CET - Status: STARTING 2026-02-25 23:15:07.257991 CET - Status: STARTING 2026-02-25 23:15:09.914554 CET - Status: STARTING 2026-02-25 23:15:12.578224 CET - Status: UP 2026-02-25 23:15:12.578265 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kjbdrmkfebjv55wnfzk62dsb 2026-02-25 23:15:12.578297 CET - Check if resources are registered in experiment 2026-02-25 23:15:12.578458 CET - Run: slices experiment list-resources --format json tst-26593841 2026-02-25 23:15:13.191925 CET - Status (on expauth): UP 2026-02-25 23:15:13.192110 CET - Testing extend expires_at (all resources in experiment) 2026-02-25 23:15:13.192279 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-26593841 2026-02-25 23:15:17.286766 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-26593841 tst 2026-02-25 23:15:17.920210 CET - Testing extend expires_at (single resource in experiment) 2026-02-25 23:15:17.920376 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-26593841 2026-02-25 23:15:21.958664 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-26593841 tst 2026-02-25 23:15:22.581925 CET - Testing ssh login 2026-02-25 23:15:22.591434 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-26593841 tst 2026-02-25 23:15:23.219190 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-26593841 tst 2026-02-25 23:15:23.850843 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/step_CheckSSHpubkeyresource_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-26593841 tst 2026-02-25 23:15:23.850926 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-02-25 23:15:23.850946 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-25 23:15:23.851093 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-26593841 tst 2026-02-25 23:15:24.487136 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/step_CheckSSHpubkeyproxy_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-26593841 tst 2026-02-25 23:15:24.487205 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-25 23:15:24.487221 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-25 23:15:24.487305 CET - Logging in using 'slices bi ssh' 2026-02-25 23:15:24.487325 CET - Forcing IPv4 only. 2026-02-25 23:15:24.487425 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-26593841 tst -- -4 uname -a 2026-02-25 23:15:25.163534 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/step_Sshloginviaslices-cliIPv4only_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-26593841 tst -- -4 uname -a 2026-02-25 23:15:25.163605 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/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-25 23:15:25.163622 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-lyon1-bi-baremetal1', 'ssh', '--show', 'nothing', '--experiment', 'tst-26593841', 'tst', '--', '-4', 'uname', '-a'] 2026-02-25 23:15:25.163747 CET - Run: ssh-keygen -F taurus-15.lyon 2026-02-25 23:15:25.167140 CET - Run: ssh-keygen -F taurus-15.lyon:22 2026-02-25 23:15:25.170219 CET - Run: ssh-keygen -F access.grid5000.fr 2026-02-25 23:15:25.173172 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-02-25 23:15:25.176000 CET - Logging in using 'slices bi ssh' 2026-02-25 23:15:25.176060 CET - Forcing IPv6 only. 2026-02-25 23:15:25.176154 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-26593841 tst -- -6 uname -a 2026-02-25 23:15:25.815186 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/step_Sshloginviaslices-cliIPv6only_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-26593841 tst -- -6 uname -a 2026-02-25 23:15:25.815254 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/cli_ssh_ipv6_uname_stderr.txt': Host key verification failed. kex_exchange_identification: Connection closed by remote host Connection closed by UNKNOWN port 65535 2026-02-25 23:15:25.815270 CET - Error in test step 'Ssh login (via slices-cli, IPv6 only)': command returned an error: ['/opt/slices-monitor-worker/slices-cli-venv/bin/slices', 'bi', '--infra', 'fr-lyon1-bi-baremetal1', 'ssh', '--show', 'nothing', '--experiment', 'tst-26593841', 'tst', '--', '-6', 'uname', '-a'] 2026-02-25 23:15:25.815292 CET - Wait 5s before retry 2026-02-25 23:15:30.815473 CET - Forcing IPv6 only. 2026-02-25 23:15:31.450771 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/step_Sshloginviaslices-cliIPv6onlyRetry1_retry1_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-26593841 tst -- -6 uname -a 2026-02-25 23:15:31.450839 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/cli_ssh_ipv6_retry1_uname_stderr.txt': Host key verification failed. kex_exchange_identification: Connection closed by remote host Connection closed by UNKNOWN port 65535 2026-02-25 23:15:31.450855 CET - Error in test step 'Ssh login (via slices-cli, IPv6 only) (Retry 1)': command returned an error: ['/opt/slices-monitor-worker/slices-cli-venv/bin/slices', 'bi', '--infra', 'fr-lyon1-bi-baremetal1', 'ssh', '--show', 'nothing', '--experiment', 'tst-26593841', 'tst', '--', '-6', 'uname', '-a'] 2026-02-25 23:15:31.450877 CET - Logging in using SSH over SSH proxy 2026-02-25 23:15:31.451046 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-26593841 tst 2026-02-25 23:15:32.071379 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/step_Sshinfoproxy_pubkey_openssh_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-26593841 tst 2026-02-25 23:15:32.071446 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/4075d39e-e1f5-463a-a143-c37cef0550f5/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-25 23:15:32.071462 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-02-25 23:15:32.077516 CET - Destroying tst-26593841 tst 2026-02-25 23:15:32.077666 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-26593841 tst