Run Test: slices-bi-singlenode-login 2026-02-25 07:15:43.964689 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-02-25 07:15:46.972376 CET - Run: slices --version 2026-02-25 07:15:47.149974 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-25 07:15:47.150232 CET - Run: slices pubkey list --format text 2026-02-25 07:15:47.712542 CET - Pubkey already registered 2026-02-25 07:15:47.712787 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-02-25 07:15:48.200768 CET - Refreshed infrastructure list. Total: 21 entries. 2026-02-25 07:15:48.200873 CET - Check List Flavors 2026-02-25 07:15:48.201051 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-02-25 07:15:52.162643 CET - Check List DiskImages 2026-02-25 07:15:52.162831 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-02-25 07:15:55.024058 CET - Requesting resources 2026-02-25 07:15:55.024505 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-35166527 2026-02-25 07:15:56.655491 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kj9q16vte998kqysgnbv6bz5 2026-02-25 07:15:56.655680 CET - Waiting until resource ready 2026-02-25 07:15:58.656070 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-35166527 tst 2026-02-25 07:15:59.280331 CET - Status: IMAGING 2026-02-25 07:16:01.914437 CET - Status: IMAGING 2026-02-25 07:16:04.537125 CET - Status: STARTING 2026-02-25 07:16:07.164061 CET - Status: STARTING 2026-02-25 07:16:09.792849 CET - Status: STARTING 2026-02-25 07:16:12.410070 CET - Status: STARTING 2026-02-25 07:16:15.034155 CET - Status: STARTING 2026-02-25 07:16:17.665068 CET - Status: STARTING 2026-02-25 07:16:20.290863 CET - Status: STARTING 2026-02-25 07:16:22.914919 CET - Status: STARTING 2026-02-25 07:16:25.540563 CET - Status: STARTING 2026-02-25 07:16:28.159475 CET - Status: STARTING 2026-02-25 07:16:30.771144 CET - Status: STARTING 2026-02-25 07:16:33.379975 CET - Status: STARTING 2026-02-25 07:16:36.004888 CET - Status: STARTING 2026-02-25 07:16:38.622040 CET - Status: STARTING 2026-02-25 07:16:41.246045 CET - Status: STARTING 2026-02-25 07:16:43.872458 CET - Status: STARTING 2026-02-25 07:16:46.496091 CET - Status: STARTING 2026-02-25 07:16:49.123425 CET - Status: STARTING 2026-02-25 07:16:51.741310 CET - Status: STARTING 2026-02-25 07:16:54.352294 CET - Status: STARTING 2026-02-25 07:16:56.959804 CET - Status: STARTING 2026-02-25 07:16:59.580980 CET - Status: STARTING 2026-02-25 07:17:02.277007 CET - Status: STARTING 2026-02-25 07:17:04.904995 CET - Status: STARTING 2026-02-25 07:17:07.528613 CET - Status: STARTING 2026-02-25 07:17:10.139029 CET - Status: STARTING 2026-02-25 07:17:12.761360 CET - Status: STARTING 2026-02-25 07:17:15.375244 CET - Status: STARTING 2026-02-25 07:17:18.007458 CET - Status: STARTING 2026-02-25 07:17:20.619408 CET - Status: STARTING 2026-02-25 07:17:23.239540 CET - Status: STARTING 2026-02-25 07:17:25.872033 CET - Status: STARTING 2026-02-25 07:17:28.481598 CET - Status: STARTING 2026-02-25 07:17:31.101425 CET - Status: STARTING 2026-02-25 07:17:33.735537 CET - Status: STARTING 2026-02-25 07:17:36.348028 CET - Status: STARTING 2026-02-25 07:17:38.964769 CET - Status: STARTING 2026-02-25 07:17:41.594183 CET - Status: STARTING 2026-02-25 07:17:44.209366 CET - Status: STARTING 2026-02-25 07:17:46.840091 CET - Status: STARTING 2026-02-25 07:17:49.449870 CET - Status: STARTING 2026-02-25 07:17:52.062078 CET - Status: STARTING 2026-02-25 07:17:54.683765 CET - Status: STARTING 2026-02-25 07:17:57.295332 CET - Status: STARTING 2026-02-25 07:17:59.950683 CET - Status: STARTING 2026-02-25 07:18:02.628654 CET - Status: STARTING 2026-02-25 07:18:05.318306 CET - Status: STARTING 2026-02-25 07:18:08.000152 CET - Status: STARTING 2026-02-25 07:18:10.667155 CET - Status: STARTING 2026-02-25 07:18:13.284456 CET - Status: STARTING 2026-02-25 07:18:15.905089 CET - Status: STARTING 2026-02-25 07:18:18.543496 CET - Status: STARTING 2026-02-25 07:18:21.156466 CET - Status: STARTING 2026-02-25 07:18:23.776851 CET - Status: STARTING 2026-02-25 07:18:26.387036 CET - Status: STARTING 2026-02-25 07:18:29.019565 CET - Status: STARTING 2026-02-25 07:18:31.627604 CET - Status: STARTING 2026-02-25 07:18:34.245069 CET - Status: STARTING 2026-02-25 07:18:36.853921 CET - Status: STARTING 2026-02-25 07:18:39.462022 CET - Status: STARTING 2026-02-25 07:18:42.082576 CET - Status: STARTING 2026-02-25 07:18:44.765787 CET - Status: STARTING 2026-02-25 07:18:47.392935 CET - Status: UP 2026-02-25 07:18:47.392986 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kj9q1683fgbvdwpy8c00b259 2026-02-25 07:18:47.393022 CET - Check if resources are registered in experiment 2026-02-25 07:18:47.393220 CET - Run: slices experiment list-resources --format json tst-35166527 2026-02-25 07:18:47.972764 CET - Status (on expauth): UP 2026-02-25 07:18:47.972900 CET - Testing extend expires_at (all resources in experiment) 2026-02-25 07:18:47.973038 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-35166527 2026-02-25 07:18:51.328340 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-35166527 2026-02-25 07:18:51.328422 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/experiment-extend-all.txt': Extending Experiment container from 2026-02-25 09:15 CET to 2026-02-25 10:18 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 Extending resource on fr-lyon1-bi-baremetal1: modifying expire of resource 1… 1… Resources failed to extend ❌ Failure: INTERNAL_ERROR task_id='e16fe4304a1e47bc9f6424431a8a799f' task_name='slices_bi_refimpl_backend.tasks.compute_resource:update_expire_comput e_resources' labels={} labels_types={} args=['exp_expauth.ilabt.imec.be_01kj9q1683fgbvdwpy8c00b259', datetime.datetime(2026, 2, 25, 9, 18, tzinfo=TzInfo(0))] kwargs={} Details stored at: /root/.slices/cli_error_details/err_2026-02-25T06:18:51+00:00.txt 2026-02-25 07:18:51.328442 CET - Error in test step 'Check extend expire': "slices bi extend" failed 2026-02-25 07:18:51.328462 CET - Testing ssh login 2026-02-25 07:18:51.338478 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-35166527 tst 2026-02-25 07:18:51.955308 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-35166527 tst 2026-02-25 07:18:52.573510 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-35166527 tst 2026-02-25 07:18:52.573596 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-02-25 07:18:52.573636 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-25 07:18:52.573777 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-35166527 tst 2026-02-25 07:18:53.187002 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-35166527 tst 2026-02-25 07:18:53.187069 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-25 07:18:53.187084 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-25 07:18:53.187171 CET - Logging in using 'slices bi ssh' 2026-02-25 07:18:53.187189 CET - Forcing IPv4 only. 2026-02-25 07:18:53.187285 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-35166527 tst -- -4 uname -a 2026-02-25 07:18:53.846604 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-35166527 tst -- -4 uname -a 2026-02-25 07:18:53.846672 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-25 07:18:53.846688 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-35166527', 'tst', '--', '-4', 'uname', '-a'] 2026-02-25 07:18:53.846805 CET - Run: ssh-keygen -F taurus-11.lyon 2026-02-25 07:18:53.850322 CET - Run: ssh-keygen -F taurus-11.lyon:22 2026-02-25 07:18:53.853442 CET - Run: ssh-keygen -F access.grid5000.fr 2026-02-25 07:18:53.856334 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-02-25 07:18:53.859085 CET - Logging in using 'slices bi ssh' 2026-02-25 07:18:53.859157 CET - Forcing IPv6 only. 2026-02-25 07:18:53.859254 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-35166527 tst -- -6 uname -a 2026-02-25 07:18:54.462513 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-35166527 tst -- -6 uname -a 2026-02-25 07:18:54.462597 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-25 07:18:54.462614 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-35166527', 'tst', '--', '-6', 'uname', '-a'] 2026-02-25 07:18:54.462636 CET - Wait 5s before retry 2026-02-25 07:18:59.462833 CET - Forcing IPv6 only. 2026-02-25 07:19:00.086329 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-35166527 tst -- -6 uname -a 2026-02-25 07:19:00.086430 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-25 07:19:00.086452 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-35166527', 'tst', '--', '-6', 'uname', '-a'] 2026-02-25 07:19:00.086486 CET - Logging in using SSH over SSH proxy 2026-02-25 07:19:00.086673 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-35166527 tst 2026-02-25 07:19:00.693612 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/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-35166527 tst 2026-02-25 07:19:00.693713 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/8044d16c-5cb0-431a-9fa0-f5c1b5363840/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-25 07:19:00.693736 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-02-25 07:19:00.700177 CET - Destroying tst-35166527 tst 2026-02-25 07:19:00.700351 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-35166527 tst