Run Test: slices-bi-singlenode-login 2026-02-23 23:13:24.060004 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-02-23 23:13:27.952884 CET - Run: slices --version 2026-02-23 23:13:28.142664 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.6 Slices clientlib bi v5.0.6 2026-02-23 23:13:28.142965 CET - Run: slices pubkey list --format text 2026-02-23 23:13:28.731432 CET - Pubkey already registered 2026-02-23 23:13:28.731696 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-02-23 23:13:29.267277 CET - Refreshed infrastructure list. Total: 21 entries. 2026-02-23 23:13:29.267442 CET - Check List Flavors 2026-02-23 23:13:29.267662 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-02-23 23:13:33.297786 CET - Check List DiskImages 2026-02-23 23:13:33.297986 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-02-23 23:13:36.057588 CET - Requesting resources 2026-02-23 23:13:36.058054 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-e6bc84b3 2026-02-23 23:13:37.845780 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kj691b96f4gb4pf6e9aadw9y 2026-02-23 23:13:37.845892 CET - Waiting until resource ready 2026-02-23 23:13:39.846307 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-e6bc84b3 tst 2026-02-23 23:13:40.457841 CET - Status: IMAGING 2026-02-23 23:13:43.066724 CET - Status: IMAGING 2026-02-23 23:13:45.669457 CET - Status: STARTING 2026-02-23 23:13:48.286589 CET - Status: STARTING 2026-02-23 23:13:50.899553 CET - Status: STARTING 2026-02-23 23:13:53.506590 CET - Status: STARTING 2026-02-23 23:13:56.123915 CET - Status: STARTING 2026-02-23 23:13:58.735895 CET - Status: STARTING 2026-02-23 23:14:01.350155 CET - Status: STARTING 2026-02-23 23:14:03.962392 CET - Status: STARTING 2026-02-23 23:14:06.567748 CET - Status: STARTING 2026-02-23 23:14:09.185835 CET - Status: STARTING 2026-02-23 23:14:11.800787 CET - Status: STARTING 2026-02-23 23:14:14.438347 CET - Status: STARTING 2026-02-23 23:14:17.056201 CET - Status: STARTING 2026-02-23 23:14:19.695884 CET - Status: STARTING 2026-02-23 23:14:22.358673 CET - Status: STARTING 2026-02-23 23:14:25.013161 CET - Status: STARTING 2026-02-23 23:14:27.671818 CET - Status: STARTING 2026-02-23 23:14:30.295207 CET - Status: STARTING 2026-02-23 23:14:32.907822 CET - Status: STARTING 2026-02-23 23:14:35.521860 CET - Status: STARTING 2026-02-23 23:14:38.179623 CET - Status: STARTING 2026-02-23 23:14:40.831714 CET - Status: STARTING 2026-02-23 23:14:43.494364 CET - Status: STARTING 2026-02-23 23:14:46.103684 CET - Status: STARTING 2026-02-23 23:14:48.712253 CET - Status: STARTING 2026-02-23 23:14:51.322731 CET - Status: STARTING 2026-02-23 23:14:53.946087 CET - Status: STARTING 2026-02-23 23:14:56.556936 CET - Status: STARTING 2026-02-23 23:14:59.216330 CET - Status: STARTING 2026-02-23 23:15:01.878301 CET - Status: STARTING 2026-02-23 23:15:04.484951 CET - Status: STARTING 2026-02-23 23:15:07.127018 CET - Status: STARTING 2026-02-23 23:15:09.760067 CET - Status: STARTING 2026-02-23 23:15:12.387848 CET - Status: STARTING 2026-02-23 23:15:14.994728 CET - Status: STARTING 2026-02-23 23:15:17.592348 CET - Status: STARTING 2026-02-23 23:15:20.202390 CET - Status: STARTING 2026-02-23 23:15:22.800223 CET - Status: STARTING 2026-02-23 23:15:25.406483 CET - Status: STARTING 2026-02-23 23:15:28.022618 CET - Status: STARTING 2026-02-23 23:15:30.647707 CET - Status: STARTING 2026-02-23 23:15:33.294617 CET - Status: STARTING 2026-02-23 23:15:35.919073 CET - Status: STARTING 2026-02-23 23:15:38.536027 CET - Status: STARTING 2026-02-23 23:15:41.144454 CET - Status: STARTING 2026-02-23 23:15:43.750734 CET - Status: STARTING 2026-02-23 23:15:46.359804 CET - Status: STARTING 2026-02-23 23:15:48.969418 CET - Status: STARTING 2026-02-23 23:15:51.587262 CET - Status: STARTING 2026-02-23 23:15:54.196945 CET - Status: STARTING 2026-02-23 23:15:56.805647 CET - Status: STARTING 2026-02-23 23:15:59.419887 CET - Status: STARTING 2026-02-23 23:16:02.022787 CET - Status: STARTING 2026-02-23 23:16:04.637854 CET - Status: STARTING 2026-02-23 23:16:07.244848 CET - Status: STARTING 2026-02-23 23:16:09.849058 CET - Status: STARTING 2026-02-23 23:16:12.462601 CET - Status: STARTING 2026-02-23 23:16:15.075172 CET - Status: STARTING 2026-02-23 23:16:17.684065 CET - Status: STARTING 2026-02-23 23:16:20.285901 CET - Status: STARTING 2026-02-23 23:16:22.893187 CET - Status: STARTING 2026-02-23 23:16:25.492441 CET - Status: STARTING 2026-02-23 23:16:28.134987 CET - Status: UP 2026-02-23 23:16:28.135034 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kj691ajwehq8w8yj14mmq2wj 2026-02-23 23:16:28.135067 CET - Check if resources are registered in experiment 2026-02-23 23:16:28.135234 CET - Run: slices experiment list-resources --format json tst-e6bc84b3 2026-02-23 23:16:28.740919 CET - Status (on expauth): UP 2026-02-23 23:16:28.741059 CET - Testing extend expires_at (all resources in experiment) 2026-02-23 23:16:28.741199 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-e6bc84b3 2026-02-23 23:16:32.640877 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/step_Checkextendexpire_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-e6bc84b3 2026-02-23 23:16:32.640961 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/experiment-extend-all.txt': Extending Experiment container from 2026-02-24 01:13 CET to 2026-02-24 02:16 CET... Extending the resources only on infrastructure fr-lyon1-bi-baremetal1. Use slices bi experiment list-resources to verify other infrastructures. 10.0% / modifying expire of resource 1/1 10.0% - modifying expire of resource 1/1 10.0% \ modifying expire of resource 1/1 10.0% | modifying expire of resource 1/1 10.0% / modifying expire of resource 1/1 Extending resource on fr-lyon1-bi-baremetal1: modifying expire of resource 1… 1… Resources failed to extend ❌ Failure: INTERNAL_ERROR task_id='4741f477dab94f298360892586e054cf' task_name='slices_bi_refimpl_backend.tasks.compute_resource:update_expire_comput e_resources' labels={} labels_types={} args=['exp_expauth.ilabt.imec.be_01kj691ajwehq8w8yj14mmq2wj', datetime.datetime(2026, 2, 24, 1, 16, tzinfo=TzInfo(0))] kwargs={} Details stored at: /root/.slices/cli_error_details/err_2026-02-23T22:16:32+00:00.txt 2026-02-23 23:16:32.640983 CET - Error in test step 'Check extend expire': "slices bi extend" failed 2026-02-23 23:16:32.641003 CET - Testing ssh login 2026-02-23 23:16:32.652327 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-e6bc84b3 tst 2026-02-23 23:16:33.279432 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-e6bc84b3 tst 2026-02-23 23:16:33.892018 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/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-e6bc84b3 tst 2026-02-23 23:16:33.892085 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-02-23 23:16:33.892122 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-23 23:16:33.892252 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-e6bc84b3 tst 2026-02-23 23:16:34.504857 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/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-e6bc84b3 tst 2026-02-23 23:16:34.504922 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-23 23:16:34.504938 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-23 23:16:34.505017 CET - Logging in using 'slices bi ssh' 2026-02-23 23:16:34.505037 CET - Forcing IPv4 only. 2026-02-23 23:16:34.505132 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-e6bc84b3 tst -- -4 uname -a 2026-02-23 23:16:35.157897 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/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-e6bc84b3 tst -- -4 uname -a 2026-02-23 23:16:35.157965 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/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-02-23 23:16:35.157981 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-e6bc84b3', 'tst', '--', '-4', 'uname', '-a'] 2026-02-23 23:16:35.158106 CET - Run: ssh-keygen -F taurus-13.lyon 2026-02-23 23:16:35.161432 CET - Run: ssh-keygen -F taurus-13.lyon:22 2026-02-23 23:16:35.164391 CET - Run: ssh-keygen -F access.grid5000.fr 2026-02-23 23:16:35.167130 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-02-23 23:16:35.169847 CET - Logging in using 'slices bi ssh' 2026-02-23 23:16:35.169899 CET - Forcing IPv6 only. 2026-02-23 23:16:35.169986 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-e6bc84b3 tst -- -6 uname -a 2026-02-23 23:16:35.769756 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/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-e6bc84b3 tst -- -6 uname -a 2026-02-23 23:16:35.769838 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/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-02-23 23:16:35.769855 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-e6bc84b3', 'tst', '--', '-6', 'uname', '-a'] 2026-02-23 23:16:35.769874 CET - Wait 5s before retry 2026-02-23 23:16:40.770095 CET - Forcing IPv6 only. 2026-02-23 23:16:41.391475 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/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-e6bc84b3 tst -- -6 uname -a 2026-02-23 23:16:41.391560 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/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-02-23 23:16:41.391584 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-e6bc84b3', 'tst', '--', '-6', 'uname', '-a'] 2026-02-23 23:16:41.391611 CET - Logging in using SSH over SSH proxy 2026-02-23 23:16:41.391764 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-e6bc84b3 tst 2026-02-23 23:16:42.011420 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/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-e6bc84b3 tst 2026-02-23 23:16:42.011485 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2ff6b1ac-d1a0-4189-8912-4a5f4c06f653/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-23 23:16:42.011500 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-02-23 23:16:42.023372 CET - Destroying tst-e6bc84b3 tst 2026-02-23 23:16:42.023603 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-e6bc84b3 tst