Run Test: slices-bi-singlenode-login 2026-03-20 07:19:26.127195 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-20 07:19:29.184709 CET - Run: slices --version 2026-03-20 07:19:29.383496 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-20 07:19:29.383736 CET - Run: slices pubkey list --format text 2026-03-20 07:19:29.957356 CET - Pubkey already registered 2026-03-20 07:19:29.957577 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-20 07:19:30.492040 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-20 07:19:30.492135 CET - Check List Flavors 2026-03-20 07:19:30.492349 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-03-20 07:19:31.228826 CET - Check List DiskImages 2026-03-20 07:19:31.229008 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-03-20 07:19:31.820300 CET - Requesting resources 2026-03-20 07:19:31.820791 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-e030fb78 2026-03-20 07:19:33.436786 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01km4ycbhdeys9ss73j4c7nmr7 2026-03-20 07:19:33.436963 CET - Waiting until resource ready 2026-03-20 07:19:35.437373 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-e030fb78 tst 2026-03-20 07:19:36.096833 CET - Status: IMAGING 2026-03-20 07:19:38.753154 CET - Status: IMAGING 2026-03-20 07:19:41.397616 CET - Status: STARTING 2026-03-20 07:19:44.048148 CET - Status: STARTING 2026-03-20 07:19:46.691733 CET - Status: STARTING 2026-03-20 07:19:49.351088 CET - Status: STARTING 2026-03-20 07:19:52.007005 CET - Status: STARTING 2026-03-20 07:19:54.662094 CET - Status: STARTING 2026-03-20 07:19:57.311974 CET - Status: STARTING 2026-03-20 07:19:59.977749 CET - Status: STARTING 2026-03-20 07:20:02.634920 CET - Status: STARTING 2026-03-20 07:20:05.291495 CET - Status: STARTING 2026-03-20 07:20:07.937037 CET - Status: STARTING 2026-03-20 07:20:10.592662 CET - Status: STARTING 2026-03-20 07:20:13.232819 CET - Status: STARTING 2026-03-20 07:20:15.893064 CET - Status: STARTING 2026-03-20 07:20:18.582564 CET - Status: STARTING 2026-03-20 07:20:21.247172 CET - Status: STARTING 2026-03-20 07:20:23.906408 CET - Status: STARTING 2026-03-20 07:20:26.554180 CET - Status: STARTING 2026-03-20 07:20:29.208128 CET - Status: STARTING 2026-03-20 07:20:31.849593 CET - Status: STARTING 2026-03-20 07:20:34.513368 CET - Status: STARTING 2026-03-20 07:20:37.159221 CET - Status: STARTING 2026-03-20 07:20:39.811868 CET - Status: STARTING 2026-03-20 07:20:42.461439 CET - Status: STARTING 2026-03-20 07:20:45.134311 CET - Status: STARTING 2026-03-20 07:20:47.797549 CET - Status: STARTING 2026-03-20 07:20:50.447723 CET - Status: STARTING 2026-03-20 07:20:53.106501 CET - Status: STARTING 2026-03-20 07:20:55.766858 CET - Status: STARTING 2026-03-20 07:20:58.410652 CET - Status: STARTING 2026-03-20 07:21:01.070348 CET - Status: STARTING 2026-03-20 07:21:03.720303 CET - Status: STARTING 2026-03-20 07:21:06.368866 CET - Status: STARTING 2026-03-20 07:21:09.049227 CET - Status: STARTING 2026-03-20 07:21:11.699390 CET - Status: STARTING 2026-03-20 07:21:14.347148 CET - Status: STARTING 2026-03-20 07:21:16.985722 CET - Status: STARTING 2026-03-20 07:21:19.639976 CET - Status: STARTING 2026-03-20 07:21:22.295306 CET - Status: STARTING 2026-03-20 07:21:24.940601 CET - Status: STARTING 2026-03-20 07:21:27.591017 CET - Status: STARTING 2026-03-20 07:21:30.261135 CET - Status: STARTING 2026-03-20 07:21:32.900918 CET - Status: STARTING 2026-03-20 07:21:35.579306 CET - Status: STARTING 2026-03-20 07:21:38.225277 CET - Status: STARTING 2026-03-20 07:21:40.876375 CET - Status: STARTING 2026-03-20 07:21:43.530308 CET - Status: STARTING 2026-03-20 07:21:46.178797 CET - Status: STARTING 2026-03-20 07:21:48.829507 CET - Status: STARTING 2026-03-20 07:21:51.476574 CET - Status: STARTING 2026-03-20 07:21:54.121275 CET - Status: STARTING 2026-03-20 07:21:56.789943 CET - Status: STARTING 2026-03-20 07:21:59.440608 CET - Status: STARTING 2026-03-20 07:22:02.077649 CET - Status: STARTING 2026-03-20 07:22:04.722218 CET - Status: STARTING 2026-03-20 07:22:07.365357 CET - Status: STARTING 2026-03-20 07:22:10.005791 CET - Status: STARTING 2026-03-20 07:22:12.661605 CET - Status: STARTING 2026-03-20 07:22:15.319789 CET - Status: STARTING 2026-03-20 07:22:17.964634 CET - Status: STARTING 2026-03-20 07:22:20.610897 CET - Status: STARTING 2026-03-20 07:22:23.265343 CET - Status: STARTING 2026-03-20 07:22:25.908209 CET - Status: STARTING 2026-03-20 07:22:28.555536 CET - Status: STARTING 2026-03-20 07:22:31.216287 CET - Status: STARTING 2026-03-20 07:22:33.859088 CET - Status: STARTING 2026-03-20 07:22:36.506197 CET - Status: STARTING 2026-03-20 07:22:39.149280 CET - Status: STARTING 2026-03-20 07:22:41.807589 CET - Status: STARTING 2026-03-20 07:22:44.515681 CET - Status: STARTING 2026-03-20 07:22:47.165143 CET - Status: STARTING 2026-03-20 07:22:49.822767 CET - Status: STARTING 2026-03-20 07:22:52.473551 CET - Status: STARTING 2026-03-20 07:22:55.116511 CET - Status: UP 2026-03-20 07:22:55.116555 CET - Experiment ID: exp_expauth.ilabt.imec.be_01km4ycazqfjwa59pcy99hy3qt 2026-03-20 07:22:55.116587 CET - Validate resources 2026-03-20 07:22:55.755812 CET - The fields of the created resource were validated. 2026-03-20 07:22:55.755865 CET - Check if resources are registered in experiment 2026-03-20 07:22:55.756078 CET - Run: slices experiment list-resources --format json tst-e030fb78 2026-03-20 07:22:56.364031 CET - Status (on expauth): UP 2026-03-20 07:22:56.364152 CET - Testing extend expires_at (all resources in experiment) 2026-03-20 07:22:56.364277 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-e030fb78 2026-03-20 07:23:00.076626 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-e030fb78 tst 2026-03-20 07:23:00.729372 CET - Testing extend expires_at (single resource in experiment) 2026-03-20 07:23:00.729555 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-e030fb78 2026-03-20 07:23:04.750987 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-e030fb78 tst 2026-03-20 07:23:05.400749 CET - Testing ssh login 2026-03-20 07:23:05.410183 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-e030fb78 tst 2026-03-20 07:23:06.042296 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-e030fb78 tst 2026-03-20 07:23:06.695557 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/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-e030fb78 tst 2026-03-20 07:23:06.695626 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-03-20 07:23:06.695643 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-20 07:23:06.695778 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-e030fb78 tst 2026-03-20 07:23:07.341285 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/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-e030fb78 tst 2026-03-20 07:23:07.341349 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-20 07:23:07.341366 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-20 07:23:07.341446 CET - Logging in using 'slices bi ssh' 2026-03-20 07:23:07.341466 CET - Forcing IPv4 only. 2026-03-20 07:23:07.341579 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-e030fb78 tst -- -4 uname -a 2026-03-20 07:23:08.043470 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/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-e030fb78 tst -- -4 uname -a 2026-03-20 07:23:08.043551 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/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-20 07:23:08.043568 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-e030fb78', 'tst', '--', '-4', 'uname', '-a'] 2026-03-20 07:23:08.043695 CET - Run: ssh-keygen -F taurus-8.lyon 2026-03-20 07:23:08.047102 CET - Run: ssh-keygen -F taurus-8.lyon:22 2026-03-20 07:23:08.050203 CET - Run: ssh-keygen -F access.grid5000.fr 2026-03-20 07:23:08.053127 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-03-20 07:23:08.055906 CET - Logging in using 'slices bi ssh' 2026-03-20 07:23:08.055960 CET - Forcing IPv6 only. 2026-03-20 07:23:08.056051 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-e030fb78 tst -- -6 uname -a 2026-03-20 07:23:08.715785 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/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-e030fb78 tst -- -6 uname -a 2026-03-20 07:23:08.715892 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/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-20 07:23:08.715922 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-e030fb78', 'tst', '--', '-6', 'uname', '-a'] 2026-03-20 07:23:08.715955 CET - Wait 5s before retry 2026-03-20 07:23:13.716123 CET - Forcing IPv6 only. 2026-03-20 07:23:14.354768 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/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-e030fb78 tst -- -6 uname -a 2026-03-20 07:23:14.354838 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/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-20 07:23:14.354855 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-e030fb78', 'tst', '--', '-6', 'uname', '-a'] 2026-03-20 07:23:14.354880 CET - Logging in using SSH over SSH proxy 2026-03-20 07:23:14.355002 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-e030fb78 tst 2026-03-20 07:23:15.004891 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/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-e030fb78 tst 2026-03-20 07:23:15.004956 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/1701f504-de5c-4b67-95dc-d9b1de6f159b/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-20 07:23:15.004971 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-03-20 07:23:15.011505 CET - Destroying tst-e030fb78 tst 2026-03-20 07:23:15.011680 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-e030fb78 tst