Run Test: slices-bi-singlenode-login 2026-03-06 23:42:54.675742 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-06 23:42:57.692430 CET - Run: slices --version 2026-03-06 23:42:57.883317 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-06 23:42:57.883582 CET - Run: slices pubkey list --format text 2026-03-06 23:42:58.458686 CET - Pubkey already registered 2026-03-06 23:42:58.458902 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-06 23:42:58.969666 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-06 23:42:58.969764 CET - Check List Flavors 2026-03-06 23:42:58.969998 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-03-06 23:42:59.771370 CET - Check List DiskImages 2026-03-06 23:42:59.771563 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-03-06 23:43:00.336158 CET - Requesting resources 2026-03-06 23:43:00.336626 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-65841756 2026-03-06 23:43:01.899891 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kk2n330tee88v2bp2aa1zypk 2026-03-06 23:43:01.900017 CET - Waiting until resource ready 2026-03-06 23:43:03.900415 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-65841756 tst 2026-03-06 23:43:04.556198 CET - Status: IMAGING 2026-03-06 23:43:07.194143 CET - Status: IMAGING 2026-03-06 23:43:09.834828 CET - Status: STARTING 2026-03-06 23:43:12.481602 CET - Status: STARTING 2026-03-06 23:43:15.200321 CET - Status: STARTING 2026-03-06 23:43:17.949334 CET - Status: STARTING 2026-03-06 23:43:20.591588 CET - Status: STARTING 2026-03-06 23:43:23.229468 CET - Status: STARTING 2026-03-06 23:43:25.879771 CET - Status: STARTING 2026-03-06 23:43:28.576686 CET - Status: STARTING 2026-03-06 23:43:31.224498 CET - Status: STARTING 2026-03-06 23:43:33.884590 CET - Status: STARTING 2026-03-06 23:43:36.525505 CET - Status: STARTING 2026-03-06 23:43:39.217509 CET - Status: STARTING 2026-03-06 23:43:41.895254 CET - Status: STARTING 2026-03-06 23:43:44.537846 CET - Status: STARTING 2026-03-06 23:43:47.197691 CET - Status: STARTING 2026-03-06 23:43:49.864295 CET - Status: STARTING 2026-03-06 23:43:52.502375 CET - Status: STARTING 2026-03-06 23:43:55.139284 CET - Status: STARTING 2026-03-06 23:43:57.834855 CET - Status: STARTING 2026-03-06 23:44:00.515817 CET - Status: STARTING 2026-03-06 23:44:03.201679 CET - Status: STARTING 2026-03-06 23:44:05.844698 CET - Status: STARTING 2026-03-06 23:44:08.479545 CET - Status: STARTING 2026-03-06 23:44:11.154434 CET - Status: STARTING 2026-03-06 23:44:13.885372 CET - Status: STARTING 2026-03-06 23:44:16.551646 CET - Status: STARTING 2026-03-06 23:44:19.201119 CET - Status: STARTING 2026-03-06 23:44:21.858996 CET - Status: STARTING 2026-03-06 23:44:24.497062 CET - Status: STARTING 2026-03-06 23:44:27.216412 CET - Status: STARTING 2026-03-06 23:44:29.843426 CET - Status: STARTING 2026-03-06 23:44:32.590690 CET - Status: STARTING 2026-03-06 23:44:35.248241 CET - Status: STARTING 2026-03-06 23:44:37.884764 CET - Status: STARTING 2026-03-06 23:44:40.527802 CET - Status: STARTING 2026-03-06 23:44:43.175390 CET - Status: STARTING 2026-03-06 23:44:45.823520 CET - Status: STARTING 2026-03-06 23:44:48.465781 CET - Status: STARTING 2026-03-06 23:44:51.101433 CET - Status: STARTING 2026-03-06 23:44:53.742929 CET - Status: STARTING 2026-03-06 23:44:56.392957 CET - Status: STARTING 2026-03-06 23:44:59.047766 CET - Status: STARTING 2026-03-06 23:45:01.696093 CET - Status: STARTING 2026-03-06 23:45:04.360956 CET - Status: STARTING 2026-03-06 23:45:06.987881 CET - Status: STARTING 2026-03-06 23:45:09.614920 CET - Status: STARTING 2026-03-06 23:45:12.245332 CET - Status: STARTING 2026-03-06 23:45:14.867490 CET - Status: STARTING 2026-03-06 23:45:17.509548 CET - Status: STARTING 2026-03-06 23:45:20.149735 CET - Status: STARTING 2026-03-06 23:45:22.780291 CET - Status: STARTING 2026-03-06 23:45:25.475495 CET - Status: STARTING 2026-03-06 23:45:28.160317 CET - Status: STARTING 2026-03-06 23:45:30.886086 CET - Status: STARTING 2026-03-06 23:45:33.513530 CET - Status: STARTING 2026-03-06 23:45:36.144670 CET - Status: STARTING 2026-03-06 23:45:38.779626 CET - Status: STARTING 2026-03-06 23:45:41.414388 CET - Status: STARTING 2026-03-06 23:45:44.051665 CET - Status: STARTING 2026-03-06 23:45:46.751494 CET - Status: STARTING 2026-03-06 23:45:49.417079 CET - Status: UP 2026-03-06 23:45:49.417142 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kk2n32dper4t50aaf6qvhp3e 2026-03-06 23:45:49.417216 CET - Check if resources are registered in experiment 2026-03-06 23:45:49.417494 CET - Run: slices experiment list-resources --format json tst-65841756 2026-03-06 23:45:50.036589 CET - Status (on expauth): UP 2026-03-06 23:45:50.036742 CET - Testing extend expires_at (all resources in experiment) 2026-03-06 23:45:50.036898 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-65841756 2026-03-06 23:45:54.176691 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-65841756 tst 2026-03-06 23:45:54.834856 CET - Testing extend expires_at (single resource in experiment) 2026-03-06 23:45:54.835082 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-65841756 2026-03-06 23:45:58.847310 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-65841756 tst 2026-03-06 23:45:59.504560 CET - Testing ssh login 2026-03-06 23:45:59.514431 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-65841756 tst 2026-03-06 23:46:00.163485 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-65841756 tst 2026-03-06 23:46:00.796239 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/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-65841756 tst 2026-03-06 23:46:00.796335 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-03-06 23:46:00.796360 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-06 23:46:00.796543 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-65841756 tst 2026-03-06 23:46:01.426927 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/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-65841756 tst 2026-03-06 23:46:01.427011 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-06 23:46:01.427031 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-06 23:46:01.427109 CET - Logging in using 'slices bi ssh' 2026-03-06 23:46:01.427128 CET - Forcing IPv4 only. 2026-03-06 23:46:01.427256 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-65841756 tst -- -4 uname -a 2026-03-06 23:46:02.069533 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/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-65841756 tst -- -4 uname -a 2026-03-06 23:46:02.069603 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/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-06 23:46:02.069621 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-65841756', 'tst', '--', '-4', 'uname', '-a'] 2026-03-06 23:46:02.069756 CET - Run: ssh-keygen -F taurus-11.lyon 2026-03-06 23:46:02.073124 CET - Run: ssh-keygen -F taurus-11.lyon:22 2026-03-06 23:46:02.076190 CET - Run: ssh-keygen -F access.grid5000.fr 2026-03-06 23:46:02.079133 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-03-06 23:46:02.082014 CET - Logging in using 'slices bi ssh' 2026-03-06 23:46:02.082078 CET - Forcing IPv6 only. 2026-03-06 23:46:02.082185 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-65841756 tst -- -6 uname -a 2026-03-06 23:46:02.705611 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/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-65841756 tst -- -6 uname -a 2026-03-06 23:46:02.705680 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/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-06 23:46:02.705698 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-65841756', 'tst', '--', '-6', 'uname', '-a'] 2026-03-06 23:46:02.705719 CET - Wait 5s before retry 2026-03-06 23:46:07.705895 CET - Forcing IPv6 only. 2026-03-06 23:46:08.333958 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/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-65841756 tst -- -6 uname -a 2026-03-06 23:46:08.334026 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/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-06 23:46:08.334043 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-65841756', 'tst', '--', '-6', 'uname', '-a'] 2026-03-06 23:46:08.334068 CET - Logging in using SSH over SSH proxy 2026-03-06 23:46:08.334185 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-65841756 tst 2026-03-06 23:46:08.968342 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/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-65841756 tst 2026-03-06 23:46:08.968412 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/a1a248f8-d1fb-4030-8d5d-79387ff3272f/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-06 23:46:08.968430 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-03-06 23:46:08.974554 CET - Destroying tst-65841756 tst 2026-03-06 23:46:08.974734 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-65841756 tst