Run Test: slices-bi-singlenode-login 2026-02-03 23:00:22.588694 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-02-03 23:00:25.634631 CET - Run: slices --version 2026-02-03 23:00:25.809094 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.2 Slices clientlib bi v5.0.6 2026-02-03 23:00:25.809336 CET - Run: slices pubkey list --format text 2026-02-03 23:00:26.589985 CET - Pubkey already registered 2026-02-03 23:00:26.590204 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-02-03 23:00:27.096074 CET - Refreshed infrastructure list. Total: 20 entries. 2026-02-03 23:00:27.096175 CET - Check List Flavors 2026-02-03 23:00:27.096358 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-02-03 23:00:31.015591 CET - Check List DiskImages 2026-02-03 23:00:31.015778 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-02-03 23:00:33.784372 CET - Requesting resources 2026-02-03 23:00:33.784911 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-d67b30d5 2026-02-03 23:00:35.839663 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kgjrb3mdec1rzvct0tjcg2mn 2026-02-03 23:00:35.839776 CET - Waiting until resource ready 2026-02-03 23:00:37.840193 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-d67b30d5 tst 2026-02-03 23:00:38.453007 CET - Status: IMAGING 2026-02-03 23:00:41.059083 CET - Status: STARTING 2026-02-03 23:00:43.673825 CET - Status: STARTING 2026-02-03 23:00:46.286132 CET - Status: STARTING 2026-02-03 23:00:48.899196 CET - Status: STARTING 2026-02-03 23:00:51.514033 CET - Status: STARTING 2026-02-03 23:00:54.118225 CET - Status: STARTING 2026-02-03 23:00:56.726373 CET - Status: STARTING 2026-02-03 23:00:59.348895 CET - Status: STARTING 2026-02-03 23:01:01.968871 CET - Status: STARTING 2026-02-03 23:01:04.583027 CET - Status: STARTING 2026-02-03 23:01:07.196051 CET - Status: STARTING 2026-02-03 23:01:09.822931 CET - Status: STARTING 2026-02-03 23:01:12.432176 CET - Status: STARTING 2026-02-03 23:01:15.047281 CET - Status: STARTING 2026-02-03 23:01:17.665792 CET - Status: STARTING 2026-02-03 23:01:20.291832 CET - Status: STARTING 2026-02-03 23:01:22.910879 CET - Status: STARTING 2026-02-03 23:01:25.535991 CET - Status: STARTING 2026-02-03 23:01:28.158736 CET - Status: STARTING 2026-02-03 23:01:30.777964 CET - Status: STARTING 2026-02-03 23:01:33.401004 CET - Status: STARTING 2026-02-03 23:01:36.035028 CET - Status: STARTING 2026-02-03 23:01:38.650403 CET - Status: STARTING 2026-02-03 23:01:41.275908 CET - Status: STARTING 2026-02-03 23:01:43.925851 CET - Status: STARTING 2026-02-03 23:01:46.545062 CET - Status: STARTING 2026-02-03 23:01:49.171122 CET - Status: STARTING 2026-02-03 23:01:51.792679 CET - Status: STARTING 2026-02-03 23:01:54.424187 CET - Status: STARTING 2026-02-03 23:01:57.046480 CET - Status: STARTING 2026-02-03 23:01:59.667404 CET - Status: STARTING 2026-02-03 23:02:02.280798 CET - Status: STARTING 2026-02-03 23:02:04.898759 CET - Status: STARTING 2026-02-03 23:02:07.527415 CET - Status: STARTING 2026-02-03 23:02:10.144938 CET - Status: STARTING 2026-02-03 23:02:12.757842 CET - Status: STARTING 2026-02-03 23:02:15.391618 CET - Status: STARTING 2026-02-03 23:02:18.011114 CET - Status: STARTING 2026-02-03 23:02:20.621710 CET - Status: STARTING 2026-02-03 23:02:23.246686 CET - Status: STARTING 2026-02-03 23:02:25.862150 CET - Status: STARTING 2026-02-03 23:02:28.502521 CET - Status: STARTING 2026-02-03 23:02:31.121551 CET - Status: STARTING 2026-02-03 23:02:33.748623 CET - Status: STARTING 2026-02-03 23:02:36.370633 CET - Status: STARTING 2026-02-03 23:02:38.983348 CET - Status: STARTING 2026-02-03 23:02:41.604931 CET - Status: STARTING 2026-02-03 23:02:44.224630 CET - Status: STARTING 2026-02-03 23:02:46.853958 CET - Status: STARTING 2026-02-03 23:02:49.470821 CET - Status: STARTING 2026-02-03 23:02:52.091410 CET - Status: STARTING 2026-02-03 23:02:54.706985 CET - Status: STARTING 2026-02-03 23:02:57.320543 CET - Status: STARTING 2026-02-03 23:02:59.945740 CET - Status: STARTING 2026-02-03 23:03:02.568916 CET - Status: STARTING 2026-02-03 23:03:05.185118 CET - Status: STARTING 2026-02-03 23:03:07.801613 CET - Status: STARTING 2026-02-03 23:03:10.430347 CET - Status: STARTING 2026-02-03 23:03:13.053884 CET - Status: STARTING 2026-02-03 23:03:15.683591 CET - Status: STARTING 2026-02-03 23:03:18.301426 CET - Status: STARTING 2026-02-03 23:03:20.918727 CET - Status: STARTING 2026-02-03 23:03:23.541843 CET - Status: STARTING 2026-02-03 23:03:26.171701 CET - Status: STARTING 2026-02-03 23:03:28.795548 CET - Status: STARTING 2026-02-03 23:03:31.426295 CET - Status: STARTING 2026-02-03 23:03:34.076615 CET - Status: STARTING 2026-02-03 23:03:36.701047 CET - Status: STARTING 2026-02-03 23:03:39.335934 CET - Status: STARTING 2026-02-03 23:03:41.962938 CET - Status: STARTING 2026-02-03 23:03:44.601435 CET - Status: STARTING 2026-02-03 23:03:47.238545 CET - Status: STARTING 2026-02-03 23:03:49.855935 CET - Status: STARTING 2026-02-03 23:03:52.484114 CET - Status: STARTING 2026-02-03 23:03:55.102003 CET - Status: STARTING 2026-02-03 23:03:57.727000 CET - Status: STARTING 2026-02-03 23:04:00.353195 CET - Status: STARTING 2026-02-03 23:04:02.987898 CET - Status: STARTING 2026-02-03 23:04:05.605825 CET - Status: STARTING 2026-02-03 23:04:08.222160 CET - Status: STARTING 2026-02-03 23:04:10.840075 CET - Status: STARTING 2026-02-03 23:04:13.481830 CET - Status: STARTING 2026-02-03 23:04:16.120518 CET - Status: STARTING 2026-02-03 23:04:18.758485 CET - Status: STARTING 2026-02-03 23:04:21.397668 CET - Status: STARTING 2026-02-03 23:04:24.010770 CET - Status: STARTING 2026-02-03 23:04:26.635303 CET - Status: STARTING 2026-02-03 23:04:29.256128 CET - Status: STARTING 2026-02-03 23:04:31.874518 CET - Status: STARTING 2026-02-03 23:04:34.500648 CET - Status: STARTING 2026-02-03 23:04:37.120984 CET - Status: STARTING 2026-02-03 23:04:39.726117 CET - Status: STARTING 2026-02-03 23:04:42.338191 CET - Status: STARTING 2026-02-03 23:04:44.957141 CET - Status: STARTING 2026-02-03 23:04:47.577505 CET - Status: STARTING 2026-02-03 23:04:50.195683 CET - Status: STARTING 2026-02-03 23:04:52.818977 CET - Status: STARTING 2026-02-03 23:04:55.434722 CET - Status: STARTING 2026-02-03 23:04:58.052531 CET - Status: STARTING 2026-02-03 23:05:00.691870 CET - Status: STARTING 2026-02-03 23:05:03.334609 CET - Status: STARTING 2026-02-03 23:05:05.942045 CET - Status: STARTING 2026-02-03 23:05:08.558240 CET - Status: STARTING 2026-02-03 23:05:11.169366 CET - Status: STARTING 2026-02-03 23:05:13.788822 CET - Status: STARTING 2026-02-03 23:05:16.403294 CET - Status: STARTING 2026-02-03 23:05:19.042971 CET - Status: STARTING 2026-02-03 23:05:21.678454 CET - Status: STARTING 2026-02-03 23:05:24.323157 CET - Status: STARTING 2026-02-03 23:05:26.999033 CET - Status: STARTING 2026-02-03 23:05:29.631315 CET - Status: STARTING 2026-02-03 23:05:32.243085 CET - Status: STARTING 2026-02-03 23:05:34.861502 CET - Status: STARTING 2026-02-03 23:05:37.521844 CET - Status: STARTING 2026-02-03 23:05:40.141109 CET - Status: STARTING 2026-02-03 23:05:42.758550 CET - Status: STARTING 2026-02-03 23:05:45.406955 CET - Status: STARTING 2026-02-03 23:05:48.058554 CET - Status: STARTING 2026-02-03 23:05:50.704388 CET - Status: STARTING 2026-02-03 23:05:53.352651 CET - Status: STARTING 2026-02-03 23:05:55.995359 CET - Status: STARTING 2026-02-03 23:05:58.623184 CET - Status: STARTING 2026-02-03 23:06:01.242326 CET - Status: STARTING 2026-02-03 23:06:03.888289 CET - Status: STARTING 2026-02-03 23:06:06.517885 CET - Status: STARTING 2026-02-03 23:06:09.131860 CET - Status: STARTING 2026-02-03 23:06:11.769065 CET - Status: STARTING 2026-02-03 23:06:14.405677 CET - Status: STARTING 2026-02-03 23:06:17.026206 CET - Status: STARTING 2026-02-03 23:06:19.636691 CET - Status: STARTING 2026-02-03 23:06:22.269198 CET - Status: STARTING 2026-02-03 23:06:24.920584 CET - Status: STARTING 2026-02-03 23:06:27.546403 CET - Status: STARTING 2026-02-03 23:06:30.185493 CET - Status: STARTING 2026-02-03 23:06:32.830541 CET - Status: STARTING 2026-02-03 23:06:35.451325 CET - Status: STARTING 2026-02-03 23:06:38.069946 CET - Status: STARTING 2026-02-03 23:06:40.707139 CET - Status: UP 2026-02-03 23:06:40.707209 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kgjrb2v2e53rhb8g2gmb6j6h 2026-02-03 23:06:40.707245 CET - Check if resources are registered in experiment 2026-02-03 23:06:40.707420 CET - Run: slices experiment list-resources --format json tst-d67b30d5 2026-02-03 23:06:41.311018 CET - Status (on expauth): UP 2026-02-03 23:06:41.311157 CET - Testing extend expires_at (all resources in experiment) 2026-02-03 23:06:41.311297 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-d67b30d5 2026-02-03 23:06:42.840473 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-d67b30d5 2026-02-03 23:06:42.840556 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/experiment-extend-all.txt': Extending Experiment container from 2026-02-04 01:00 CET to 2026-02-04 02:06 CET... Extending the resources only on infrastructure fr-lyon1-bi-baremetal1. Use slices bi experiment list-resources to verify other infrastructures. Could not extend resources on infrastructure fr-lyon1-bi-baremetal1 ❌ TODO: Implement get_api_error_detail for other error types ApiException: Method Not Allowed ApiException('Unexpected HTTP status code: 405') Details stored at: /root/.slices/cli_error_details/err_2026-02-03T22:06:42+00:00.txt 2026-02-03 23:06:42.840579 CET - Error in test step 'Check extend expire': "slices bi extend" failed 2026-02-03 23:06:42.840600 CET - Testing ssh login 2026-02-03 23:06:42.850423 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d67b30d5 tst 2026-02-03 23:06:43.474797 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d67b30d5 tst 2026-02-03 23:06:44.087573 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-d67b30d5 tst 2026-02-03 23:06:44.087645 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-02-03 23:06:44.087664 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-03 23:06:44.087801 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-d67b30d5 tst 2026-02-03 23:06:44.709597 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-d67b30d5 tst 2026-02-03 23:06:44.709674 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-03 23:06:44.709691 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-03 23:06:44.709789 CET - Logging in using 'slices bi ssh' 2026-02-03 23:06:44.709810 CET - Forcing IPv4 only. 2026-02-03 23:06:44.709915 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-d67b30d5 tst -- -4 uname -a 2026-02-03 23:06:45.372653 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-d67b30d5 tst -- -4 uname -a 2026-02-03 23:06:45.372744 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-03 23:06:45.372762 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-d67b30d5', 'tst', '--', '-4', 'uname', '-a'] 2026-02-03 23:06:45.372896 CET - Run: ssh-keygen -F sagittaire-5.lyon 2026-02-03 23:06:45.376298 CET - Run: ssh-keygen -F sagittaire-5.lyon:22 2026-02-03 23:06:45.379346 CET - Run: ssh-keygen -F access.grid5000.fr 2026-02-03 23:06:45.382478 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-02-03 23:06:45.385484 CET - Logging in using 'slices bi ssh' 2026-02-03 23:06:45.385551 CET - Forcing IPv6 only. 2026-02-03 23:06:45.385650 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-d67b30d5 tst -- -6 uname -a 2026-02-03 23:06:45.989104 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-d67b30d5 tst -- -6 uname -a 2026-02-03 23:06:45.989173 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-03 23:06:45.989189 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-d67b30d5', 'tst', '--', '-6', 'uname', '-a'] 2026-02-03 23:06:45.989209 CET - Wait 5s before retry 2026-02-03 23:06:50.989404 CET - Forcing IPv6 only. 2026-02-03 23:06:51.606447 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-d67b30d5 tst -- -6 uname -a 2026-02-03 23:06:51.606542 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-03 23:06:51.606582 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-d67b30d5', 'tst', '--', '-6', 'uname', '-a'] 2026-02-03 23:06:51.606611 CET - Logging in using SSH over SSH proxy 2026-02-03 23:06:51.606753 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-d67b30d5 tst 2026-02-03 23:06:52.240219 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/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-d67b30d5 tst 2026-02-03 23:06:52.240295 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/22d1ee8e-c3bf-4f32-90c6-05fa60867bd4/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-03 23:06:52.240455 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-02-03 23:06:52.246956 CET - Destroying tst-d67b30d5 tst 2026-02-03 23:06:52.247110 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-d67b30d5 tst