Run Test: slices-bi-singlenode-login 2026-03-10 23:46:48.738143 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-10 23:46:51.753491 CET - Run: slices --version 2026-03-10 23:46:51.937857 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.8 Slices clientlib bi v5.1.2 2026-03-10 23:46:51.938094 CET - Run: slices pubkey list --format text 2026-03-10 23:46:52.514666 CET - Pubkey already registered 2026-03-10 23:46:52.514881 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-10 23:46:53.041200 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-10 23:46:53.041304 CET - Check List Flavors 2026-03-10 23:46:53.041483 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-03-10 23:46:53.923448 CET - Check List DiskImages 2026-03-10 23:46:53.923629 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-03-10 23:46:54.493201 CET - Requesting resources 2026-03-10 23:46:54.493662 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-373ba0c3 2026-03-10 23:46:56.171381 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kkcyx3shfr0sr62q89nzf5ms 2026-03-10 23:46:56.171488 CET - Waiting until resource ready 2026-03-10 23:46:58.171905 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-373ba0c3 tst 2026-03-10 23:46:58.809841 CET - Status: IMAGING 2026-03-10 23:47:01.457980 CET - Status: IMAGING 2026-03-10 23:47:04.101196 CET - Status: IMAGING 2026-03-10 23:47:06.722515 CET - Status: IMAGING 2026-03-10 23:47:09.371238 CET - Status: IMAGING 2026-03-10 23:47:12.017475 CET - Status: IMAGING 2026-03-10 23:47:14.663481 CET - Status: STARTING 2026-03-10 23:47:17.299671 CET - Status: STARTING 2026-03-10 23:47:19.960461 CET - Status: STARTING 2026-03-10 23:47:22.606251 CET - Status: STARTING 2026-03-10 23:47:25.238307 CET - Status: STARTING 2026-03-10 23:47:27.863380 CET - Status: STARTING 2026-03-10 23:47:30.488508 CET - Status: STARTING 2026-03-10 23:47:33.138683 CET - Status: STARTING 2026-03-10 23:47:35.793118 CET - Status: STARTING 2026-03-10 23:47:38.481837 CET - Status: STARTING 2026-03-10 23:47:41.136367 CET - Status: STARTING 2026-03-10 23:47:43.768962 CET - Status: STARTING 2026-03-10 23:47:46.408485 CET - Status: STARTING 2026-03-10 23:47:49.047241 CET - Status: STARTING 2026-03-10 23:47:51.677750 CET - Status: STARTING 2026-03-10 23:47:54.305744 CET - Status: STARTING 2026-03-10 23:47:56.933541 CET - Status: STARTING 2026-03-10 23:47:59.560869 CET - Status: STARTING 2026-03-10 23:48:02.198868 CET - Status: STARTING 2026-03-10 23:48:04.829772 CET - Status: STARTING 2026-03-10 23:48:07.534242 CET - Status: STARTING 2026-03-10 23:48:10.177517 CET - Status: STARTING 2026-03-10 23:48:12.806796 CET - Status: STARTING 2026-03-10 23:48:15.432834 CET - Status: STARTING 2026-03-10 23:48:18.078208 CET - Status: STARTING 2026-03-10 23:48:20.706913 CET - Status: STARTING 2026-03-10 23:48:23.338247 CET - Status: STARTING 2026-03-10 23:48:25.965588 CET - Status: STARTING 2026-03-10 23:48:28.585917 CET - Status: STARTING 2026-03-10 23:48:31.219768 CET - Status: STARTING 2026-03-10 23:48:33.852926 CET - Status: STARTING 2026-03-10 23:48:36.488709 CET - Status: STARTING 2026-03-10 23:48:39.127118 CET - Status: STARTING 2026-03-10 23:48:41.757626 CET - Status: STARTING 2026-03-10 23:48:44.386949 CET - Status: STARTING 2026-03-10 23:48:47.034913 CET - Status: STARTING 2026-03-10 23:48:49.770814 CET - Status: STARTING 2026-03-10 23:48:52.411110 CET - Status: STARTING 2026-03-10 23:48:55.033600 CET - Status: STARTING 2026-03-10 23:48:57.682687 CET - Status: STARTING 2026-03-10 23:49:00.309857 CET - Status: STARTING 2026-03-10 23:49:02.955900 CET - Status: STARTING 2026-03-10 23:49:05.608958 CET - Status: STARTING 2026-03-10 23:49:08.269067 CET - Status: STARTING 2026-03-10 23:49:10.914576 CET - Status: STARTING 2026-03-10 23:49:13.590338 CET - Status: STARTING 2026-03-10 23:49:16.225797 CET - Status: STARTING 2026-03-10 23:49:18.895366 CET - Status: STARTING 2026-03-10 23:49:21.530577 CET - Status: STARTING 2026-03-10 23:49:24.181589 CET - Status: STARTING 2026-03-10 23:49:26.812234 CET - Status: STARTING 2026-03-10 23:49:29.467484 CET - Status: STARTING 2026-03-10 23:49:32.185200 CET - Status: STARTING 2026-03-10 23:49:34.811921 CET - Status: STARTING 2026-03-10 23:49:37.483824 CET - Status: STARTING 2026-03-10 23:49:40.114475 CET - Status: STARTING 2026-03-10 23:49:42.760697 CET - Status: STARTING 2026-03-10 23:49:45.433694 CET - Status: STARTING 2026-03-10 23:49:48.108676 CET - Status: STARTING 2026-03-10 23:49:50.749319 CET - Status: STARTING 2026-03-10 23:49:53.388181 CET - Status: STARTING 2026-03-10 23:49:56.019303 CET - Status: UP 2026-03-10 23:49:56.019361 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kkcyx35fef98d5jhpf13qrjp 2026-03-10 23:49:56.019398 CET - Check if resources are registered in experiment 2026-03-10 23:49:56.019578 CET - Run: slices experiment list-resources --format json tst-373ba0c3 2026-03-10 23:49:56.606594 CET - Status (on expauth): UP 2026-03-10 23:49:56.606727 CET - Testing extend expires_at (all resources in experiment) 2026-03-10 23:49:56.606869 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-373ba0c3 2026-03-10 23:50:00.579939 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-373ba0c3 tst 2026-03-10 23:50:01.212011 CET - Testing extend expires_at (single resource in experiment) 2026-03-10 23:50:01.212186 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-373ba0c3 2026-03-10 23:50:05.203462 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-373ba0c3 tst 2026-03-10 23:50:05.845613 CET - Testing ssh login 2026-03-10 23:50:05.855740 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-373ba0c3 tst 2026-03-10 23:50:06.495455 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-373ba0c3 tst 2026-03-10 23:50:07.143752 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/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-373ba0c3 tst 2026-03-10 23:50:07.143821 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-03-10 23:50:07.143839 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-10 23:50:07.143980 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-373ba0c3 tst 2026-03-10 23:50:07.782464 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/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-373ba0c3 tst 2026-03-10 23:50:07.782529 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-10 23:50:07.782569 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-10 23:50:07.782649 CET - Logging in using 'slices bi ssh' 2026-03-10 23:50:07.782668 CET - Forcing IPv4 only. 2026-03-10 23:50:07.782766 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-373ba0c3 tst -- -4 uname -a 2026-03-10 23:50:08.471149 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/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-373ba0c3 tst -- -4 uname -a 2026-03-10 23:50:08.471219 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/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-03-10 23:50:08.471237 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-373ba0c3', 'tst', '--', '-4', 'uname', '-a'] 2026-03-10 23:50:08.471371 CET - Run: ssh-keygen -F taurus-1.lyon 2026-03-10 23:50:08.474713 CET - Run: ssh-keygen -F taurus-1.lyon:22 2026-03-10 23:50:08.477685 CET - Run: ssh-keygen -F access.grid5000.fr 2026-03-10 23:50:08.480542 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-03-10 23:50:08.483354 CET - Logging in using 'slices bi ssh' 2026-03-10 23:50:08.483413 CET - Forcing IPv6 only. 2026-03-10 23:50:08.483510 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-373ba0c3 tst -- -6 uname -a 2026-03-10 23:50:09.107173 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/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-373ba0c3 tst -- -6 uname -a 2026-03-10 23:50:09.107264 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/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-03-10 23:50:09.107289 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-373ba0c3', 'tst', '--', '-6', 'uname', '-a'] 2026-03-10 23:50:09.107350 CET - Wait 5s before retry 2026-03-10 23:50:14.107540 CET - Forcing IPv6 only. 2026-03-10 23:50:14.760410 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/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-373ba0c3 tst -- -6 uname -a 2026-03-10 23:50:14.760479 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/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-03-10 23:50:14.760495 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-373ba0c3', 'tst', '--', '-6', 'uname', '-a'] 2026-03-10 23:50:14.760519 CET - Logging in using SSH over SSH proxy 2026-03-10 23:50:14.760643 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-373ba0c3 tst 2026-03-10 23:50:15.444578 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/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-373ba0c3 tst 2026-03-10 23:50:15.444663 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/7bb45449-cef9-4d8f-ad1e-869e5fb79f00/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-10 23:50:15.444681 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-03-10 23:50:15.450936 CET - Destroying tst-373ba0c3 tst 2026-03-10 23:50:15.451106 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-373ba0c3 tst