Run Test: slices-bi-singlenode-login 2026-03-15 01:43:59.132758 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-15 01:44:02.208135 CET - Run: slices --version 2026-03-15 01:44:02.386063 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-15 01:44:02.386321 CET - Run: slices pubkey list --format text 2026-03-15 01:44:02.931680 CET - Pubkey already registered 2026-03-15 01:44:02.931910 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-15 01:44:03.422751 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-15 01:44:03.422892 CET - Check List Flavors 2026-03-15 01:44:03.423056 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-03-15 01:44:04.169775 CET - Check List DiskImages 2026-03-15 01:44:04.169974 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-03-15 01:44:04.727831 CET - Requesting resources 2026-03-15 01:44:04.728253 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-b1cfe795 2026-03-15 01:44:06.507855 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kkqf6hb4fzhs8z1m7e9v52jw 2026-03-15 01:44:06.508035 CET - Waiting until resource ready 2026-03-15 01:44:08.508429 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-b1cfe795 tst 2026-03-15 01:44:09.197263 CET - Status: IMAGING 2026-03-15 01:44:11.841194 CET - Status: IMAGING 2026-03-15 01:44:14.477865 CET - Status: STARTING 2026-03-15 01:44:17.110462 CET - Status: STARTING 2026-03-15 01:44:19.740605 CET - Status: STARTING 2026-03-15 01:44:22.376261 CET - Status: STARTING 2026-03-15 01:44:25.061878 CET - Status: STARTING 2026-03-15 01:44:27.709496 CET - Status: STARTING 2026-03-15 01:44:30.335207 CET - Status: STARTING 2026-03-15 01:44:32.971376 CET - Status: STARTING 2026-03-15 01:44:35.632648 CET - Status: STARTING 2026-03-15 01:44:38.261562 CET - Status: STARTING 2026-03-15 01:44:40.873072 CET - Status: STARTING 2026-03-15 01:44:43.500136 CET - Status: STARTING 2026-03-15 01:44:46.143959 CET - Status: STARTING 2026-03-15 01:44:48.774271 CET - Status: STARTING 2026-03-15 01:44:51.401011 CET - Status: STARTING 2026-03-15 01:44:54.034938 CET - Status: STARTING 2026-03-15 01:44:56.679214 CET - Status: STARTING 2026-03-15 01:44:59.307069 CET - Status: STARTING 2026-03-15 01:45:01.971953 CET - Status: STARTING 2026-03-15 01:45:04.603791 CET - Status: STARTING 2026-03-15 01:45:07.247249 CET - Status: STARTING 2026-03-15 01:45:09.877182 CET - Status: STARTING 2026-03-15 01:45:12.507851 CET - Status: STARTING 2026-03-15 01:45:15.142736 CET - Status: STARTING 2026-03-15 01:45:17.786075 CET - Status: STARTING 2026-03-15 01:45:20.412393 CET - Status: STARTING 2026-03-15 01:45:23.057117 CET - Status: STARTING 2026-03-15 01:45:25.691108 CET - Status: STARTING 2026-03-15 01:45:28.325553 CET - Status: STARTING 2026-03-15 01:45:30.953882 CET - Status: STARTING 2026-03-15 01:45:33.577955 CET - Status: STARTING 2026-03-15 01:45:36.225164 CET - Status: STARTING 2026-03-15 01:45:38.846645 CET - Status: STARTING 2026-03-15 01:45:41.475410 CET - Status: STARTING 2026-03-15 01:45:44.100953 CET - Status: STARTING 2026-03-15 01:45:46.734085 CET - Status: STARTING 2026-03-15 01:45:49.368162 CET - Status: STARTING 2026-03-15 01:45:51.983126 CET - Status: STARTING 2026-03-15 01:45:54.605024 CET - Status: STARTING 2026-03-15 01:45:57.232249 CET - Status: STARTING 2026-03-15 01:45:59.854492 CET - Status: STARTING 2026-03-15 01:46:02.471136 CET - Status: STARTING 2026-03-15 01:46:05.085714 CET - Status: STARTING 2026-03-15 01:46:07.709752 CET - Status: STARTING 2026-03-15 01:46:10.325832 CET - Status: STARTING 2026-03-15 01:46:12.948520 CET - Status: STARTING 2026-03-15 01:46:15.581674 CET - Status: STARTING 2026-03-15 01:46:18.219290 CET - Status: STARTING 2026-03-15 01:46:20.852032 CET - Status: STARTING 2026-03-15 01:46:23.478533 CET - Status: STARTING 2026-03-15 01:46:26.112307 CET - Status: STARTING 2026-03-15 01:46:28.742628 CET - Status: STARTING 2026-03-15 01:46:31.366869 CET - Status: STARTING 2026-03-15 01:46:33.992378 CET - Status: STARTING 2026-03-15 01:46:36.633669 CET - Status: STARTING 2026-03-15 01:46:39.264783 CET - Status: STARTING 2026-03-15 01:46:41.903601 CET - Status: STARTING 2026-03-15 01:46:44.525814 CET - Status: STARTING 2026-03-15 01:46:47.154256 CET - Status: STARTING 2026-03-15 01:46:49.775178 CET - Status: STARTING 2026-03-15 01:46:52.398582 CET - Status: STARTING 2026-03-15 01:46:55.022887 CET - Status: STARTING 2026-03-15 01:46:57.646349 CET - Status: STARTING 2026-03-15 01:47:00.269706 CET - Status: STARTING 2026-03-15 01:47:02.898359 CET - Status: STARTING 2026-03-15 01:47:05.520926 CET - Status: STARTING 2026-03-15 01:47:08.146767 CET - Status: STARTING 2026-03-15 01:47:10.767204 CET - Status: STARTING 2026-03-15 01:47:13.392784 CET - Status: STARTING 2026-03-15 01:47:16.011470 CET - Status: STARTING 2026-03-15 01:47:18.628922 CET - Status: STARTING 2026-03-15 01:47:21.268561 CET - Status: STARTING 2026-03-15 01:47:23.891570 CET - Status: STARTING 2026-03-15 01:47:26.519932 CET - Status: STARTING 2026-03-15 01:47:29.145369 CET - Status: STARTING 2026-03-15 01:47:31.773484 CET - Status: STARTING 2026-03-15 01:47:34.401921 CET - Status: STARTING 2026-03-15 01:47:37.034967 CET - Status: STARTING 2026-03-15 01:47:39.654198 CET - Status: STARTING 2026-03-15 01:47:42.281397 CET - Status: STARTING 2026-03-15 01:47:44.904712 CET - Status: STARTING 2026-03-15 01:47:47.533541 CET - Status: STARTING 2026-03-15 01:47:50.153319 CET - Status: UP 2026-03-15 01:47:50.153363 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kkqf6gk1f3vs1734mn7kdea3 2026-03-15 01:47:50.153396 CET - Validate resources 2026-03-15 01:47:50.765971 CET - The fields of the created resource were validated. 2026-03-15 01:47:50.766028 CET - Check if resources are registered in experiment 2026-03-15 01:47:50.766185 CET - Run: slices experiment list-resources --format json tst-b1cfe795 2026-03-15 01:47:51.352655 CET - Status (on expauth): UP 2026-03-15 01:47:51.352814 CET - Testing extend expires_at (all resources in experiment) 2026-03-15 01:47:51.352961 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-b1cfe795 2026-03-15 01:47:55.423327 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-b1cfe795 tst 2026-03-15 01:47:56.047447 CET - Testing extend expires_at (single resource in experiment) 2026-03-15 01:47:56.047634 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-b1cfe795 2026-03-15 01:48:00.041153 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-b1cfe795 tst 2026-03-15 01:48:00.675548 CET - Testing ssh login 2026-03-15 01:48:00.685529 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-b1cfe795 tst 2026-03-15 01:48:01.321932 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-b1cfe795 tst 2026-03-15 01:48:01.952306 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/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-b1cfe795 tst 2026-03-15 01:48:01.952402 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-03-15 01:48:01.952421 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-15 01:48:01.952559 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-b1cfe795 tst 2026-03-15 01:48:02.590869 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/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-b1cfe795 tst 2026-03-15 01:48:02.590941 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-15 01:48:02.590960 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-15 01:48:02.591044 CET - Logging in using 'slices bi ssh' 2026-03-15 01:48:02.591066 CET - Forcing IPv4 only. 2026-03-15 01:48:02.591174 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-b1cfe795 tst -- -4 uname -a 2026-03-15 01:48:03.253014 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/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-b1cfe795 tst -- -4 uname -a 2026-03-15 01:48:03.253087 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/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-15 01:48:03.253105 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-b1cfe795', 'tst', '--', '-4', 'uname', '-a'] 2026-03-15 01:48:03.253236 CET - Run: ssh-keygen -F taurus-13.lyon 2026-03-15 01:48:03.257362 CET - Run: ssh-keygen -F taurus-13.lyon:22 2026-03-15 01:48:03.261488 CET - Run: ssh-keygen -F access.grid5000.fr 2026-03-15 01:48:03.265196 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-03-15 01:48:03.268952 CET - Logging in using 'slices bi ssh' 2026-03-15 01:48:03.269032 CET - Forcing IPv6 only. 2026-03-15 01:48:03.269145 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-b1cfe795 tst -- -6 uname -a 2026-03-15 01:48:03.962542 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/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-b1cfe795 tst -- -6 uname -a 2026-03-15 01:48:03.962611 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/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-15 01:48:03.962629 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-b1cfe795', 'tst', '--', '-6', 'uname', '-a'] 2026-03-15 01:48:03.962651 CET - Wait 5s before retry 2026-03-15 01:48:08.962833 CET - Forcing IPv6 only. 2026-03-15 01:48:09.586684 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/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-b1cfe795 tst -- -6 uname -a 2026-03-15 01:48:09.586757 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/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-15 01:48:09.586774 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-b1cfe795', 'tst', '--', '-6', 'uname', '-a'] 2026-03-15 01:48:09.586799 CET - Logging in using SSH over SSH proxy 2026-03-15 01:48:09.586918 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-b1cfe795 tst 2026-03-15 01:48:10.211204 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/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-b1cfe795 tst 2026-03-15 01:48:10.211270 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/168201a3-b2ea-4ee6-814f-beb7fea36aea/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-15 01:48:10.211286 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-03-15 01:48:10.217130 CET - Destroying tst-b1cfe795 tst 2026-03-15 01:48:10.217277 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-b1cfe795 tst