Run Test: slices-bi-singlenode-login 2026-03-02 16:11:57.654148 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-02 16:12:00.802455 CET - Run: slices --version 2026-03-02 16:12:00.979776 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib bi v5.1.1 Slices clientlib core v5.3.8 2026-03-02 16:12:00.980105 CET - Run: slices pubkey list --format text 2026-03-02 16:12:01.514597 CET - Pubkey already registered 2026-03-02 16:12:01.514919 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-02 16:12:02.005466 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-02 16:12:02.005580 CET - Check List Flavors 2026-03-02 16:12:02.005792 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-03-02 16:12:02.684544 CET - Check List DiskImages 2026-03-02 16:12:02.684929 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-03-02 16:12:03.235687 CET - Requesting resources 2026-03-02 16:12:03.236167 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-a6233286 2026-03-02 16:12:04.927542 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kjqhpg64eshsn3q4hqrd6w74 2026-03-02 16:12:04.927667 CET - Waiting until resource ready 2026-03-02 16:12:06.928096 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-a6233286 tst 2026-03-02 16:12:07.606652 CET - Status: IMAGING 2026-03-02 16:12:10.299588 CET - Status: IMAGING 2026-03-02 16:12:12.917768 CET - Status: STARTING 2026-03-02 16:12:15.542887 CET - Status: STARTING 2026-03-02 16:12:18.178616 CET - Status: STARTING 2026-03-02 16:12:20.795796 CET - Status: STARTING 2026-03-02 16:12:23.412021 CET - Status: STARTING 2026-03-02 16:12:26.033851 CET - Status: STARTING 2026-03-02 16:12:28.652007 CET - Status: STARTING 2026-03-02 16:12:31.320498 CET - Status: STARTING 2026-03-02 16:12:33.938938 CET - Status: STARTING 2026-03-02 16:12:36.559717 CET - Status: STARTING 2026-03-02 16:12:39.181311 CET - Status: STARTING 2026-03-02 16:12:41.813895 CET - Status: STARTING 2026-03-02 16:12:44.436108 CET - Status: STARTING 2026-03-02 16:12:47.073136 CET - Status: STARTING 2026-03-02 16:12:49.725913 CET - Status: STARTING 2026-03-02 16:12:52.396485 CET - Status: STARTING 2026-03-02 16:12:55.046194 CET - Status: STARTING 2026-03-02 16:12:57.670016 CET - Status: STARTING 2026-03-02 16:13:00.331261 CET - Status: STARTING 2026-03-02 16:13:02.955368 CET - Status: STARTING 2026-03-02 16:13:05.623887 CET - Status: STARTING 2026-03-02 16:13:08.312249 CET - Status: STARTING 2026-03-02 16:13:10.975999 CET - Status: STARTING 2026-03-02 16:13:13.620891 CET - Status: STARTING 2026-03-02 16:13:16.283860 CET - Status: STARTING 2026-03-02 16:13:18.903974 CET - Status: STARTING 2026-03-02 16:13:21.528387 CET - Status: STARTING 2026-03-02 16:13:24.150084 CET - Status: STARTING 2026-03-02 16:13:26.823403 CET - Status: STARTING 2026-03-02 16:13:29.540844 CET - Status: STARTING 2026-03-02 16:13:32.225781 CET - Status: STARTING 2026-03-02 16:13:34.901231 CET - Status: STARTING 2026-03-02 16:13:37.528027 CET - Status: STARTING 2026-03-02 16:13:40.195173 CET - Status: STARTING 2026-03-02 16:13:42.868950 CET - Status: STARTING 2026-03-02 16:13:45.499845 CET - Status: STARTING 2026-03-02 16:13:48.191991 CET - Status: STARTING 2026-03-02 16:13:50.887923 CET - Status: STARTING 2026-03-02 16:13:53.559651 CET - Status: STARTING 2026-03-02 16:13:56.193503 CET - Status: STARTING 2026-03-02 16:13:58.826425 CET - Status: STARTING 2026-03-02 16:14:01.491724 CET - Status: STARTING 2026-03-02 16:14:04.183130 CET - Status: STARTING 2026-03-02 16:14:06.843098 CET - Status: STARTING 2026-03-02 16:14:09.460355 CET - Status: STARTING 2026-03-02 16:14:12.081183 CET - Status: STARTING 2026-03-02 16:14:14.741240 CET - Status: STARTING 2026-03-02 16:14:17.373867 CET - Status: STARTING 2026-03-02 16:14:20.049713 CET - Status: STARTING 2026-03-02 16:14:22.749047 CET - Status: STARTING 2026-03-02 16:14:25.386181 CET - Status: STARTING 2026-03-02 16:14:28.008276 CET - Status: STARTING 2026-03-02 16:14:30.683018 CET - Status: STARTING 2026-03-02 16:14:33.354113 CET - Status: STARTING 2026-03-02 16:14:36.030678 CET - Status: STARTING 2026-03-02 16:14:38.650123 CET - Status: STARTING 2026-03-02 16:14:41.269435 CET - Status: STARTING 2026-03-02 16:14:43.890280 CET - Status: STARTING 2026-03-02 16:14:46.517565 CET - Status: STARTING 2026-03-02 16:14:49.166627 CET - Status: STARTING 2026-03-02 16:14:51.811743 CET - Status: STARTING 2026-03-02 16:14:54.433465 CET - Status: STARTING 2026-03-02 16:14:57.067131 CET - Status: UP 2026-03-02 16:14:57.067187 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kjqhpfjvfcnrtbpet65xcrtb 2026-03-02 16:14:57.067224 CET - Check if resources are registered in experiment 2026-03-02 16:14:57.067432 CET - Run: slices experiment list-resources --format json tst-a6233286 2026-03-02 16:14:57.660067 CET - Status (on expauth): UP 2026-03-02 16:14:57.660235 CET - Testing extend expires_at (all resources in experiment) 2026-03-02 16:14:57.660390 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-a6233286 2026-03-02 16:15:01.674183 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-a6233286 tst 2026-03-02 16:15:02.302598 CET - Testing extend expires_at (single resource in experiment) 2026-03-02 16:15:02.302780 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-a6233286 2026-03-02 16:15:06.332253 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-a6233286 tst 2026-03-02 16:15:07.015503 CET - Testing ssh login 2026-03-02 16:15:07.025720 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-a6233286 tst 2026-03-02 16:15:07.683424 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-a6233286 tst 2026-03-02 16:15:08.357621 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/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-a6233286 tst 2026-03-02 16:15:08.357701 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-03-02 16:15:08.357720 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-02 16:15:08.357898 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-a6233286 tst 2026-03-02 16:15:09.022534 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/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-a6233286 tst 2026-03-02 16:15:09.022632 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-02 16:15:09.022651 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-02 16:15:09.022787 CET - Logging in using 'slices bi ssh' 2026-03-02 16:15:09.022810 CET - Forcing IPv4 only. 2026-03-02 16:15:09.022928 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-a6233286 tst -- -4 uname -a 2026-03-02 16:15:09.658579 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/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-a6233286 tst -- -4 uname -a 2026-03-02 16:15:09.658662 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/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-02 16:15:09.658680 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-a6233286', 'tst', '--', '-4', 'uname', '-a'] 2026-03-02 16:15:09.658829 CET - Run: ssh-keygen -F taurus-13.lyon 2026-03-02 16:15:09.662518 CET - Run: ssh-keygen -F taurus-13.lyon:22 2026-03-02 16:15:09.665556 CET - Run: ssh-keygen -F access.grid5000.fr 2026-03-02 16:15:09.668452 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-03-02 16:15:09.671306 CET - Logging in using 'slices bi ssh' 2026-03-02 16:15:09.671371 CET - Forcing IPv6 only. 2026-03-02 16:15:09.671463 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-a6233286 tst -- -6 uname -a 2026-03-02 16:15:10.293747 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/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-a6233286 tst -- -6 uname -a 2026-03-02 16:15:10.293829 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/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-02 16:15:10.293847 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-a6233286', 'tst', '--', '-6', 'uname', '-a'] 2026-03-02 16:15:10.293873 CET - Wait 5s before retry 2026-03-02 16:15:15.294082 CET - Forcing IPv6 only. 2026-03-02 16:15:15.916315 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/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-a6233286 tst -- -6 uname -a 2026-03-02 16:15:15.916382 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/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-02 16:15:15.916398 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-a6233286', 'tst', '--', '-6', 'uname', '-a'] 2026-03-02 16:15:15.916420 CET - Logging in using SSH over SSH proxy 2026-03-02 16:15:15.916565 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-a6233286 tst 2026-03-02 16:15:16.551885 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/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-a6233286 tst 2026-03-02 16:15:16.551959 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/675fff5a-4663-413e-9205-a04d825e7148/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-02 16:15:16.551977 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-03-02 16:15:16.558063 CET - Destroying tst-a6233286 tst 2026-03-02 16:15:16.558228 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-a6233286 tst