Run Test: slices-bi-singlenode-login 2026-04-12 00:18:38.498527 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-12 00:18:41.669269 CEST - Run: slices --version 2026-04-12 00:18:41.883612 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.5.0 Slices clientlib bi v5.1.2 2026-04-12 00:18:41.883864 CEST - Run: slices pubkey list --format text 2026-04-12 00:18:42.448774 CEST - Pubkey already registered 2026-04-12 00:18:42.448996 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-12 00:18:42.946354 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-12 00:18:42.946503 CEST - Check List Flavors 2026-04-12 00:18:42.946680 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-04-12 00:18:43.712255 CEST - Check List DiskImages 2026-04-12 00:18:43.712459 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-04-12 00:18:44.327682 CEST - Requesting resources 2026-04-12 00:18:44.328153 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-ebd3f98e 2026-04-12 00:18:46.045695 CEST - Resource ID: r_fr-lyon1-bi-baremetal1_01knza0h8yen0vqgfpp4xvcpnd 2026-04-12 00:18:46.045803 CEST - Waiting until resource ready 2026-04-12 00:18:48.046157 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-ebd3f98e tst 2026-04-12 00:18:48.711443 CEST - Status: IMAGING 2026-04-12 00:18:51.376994 CEST - Status: IMAGING 2026-04-12 00:18:54.042696 CEST - Status: IMAGING 2026-04-12 00:18:56.708424 CEST - Status: IMAGING 2026-04-12 00:18:59.374171 CEST - Status: IMAGING 2026-04-12 00:19:02.039771 CEST - Status: IMAGING 2026-04-12 00:19:04.705386 CEST - Status: STARTING 2026-04-12 00:19:07.371289 CEST - Status: STARTING 2026-04-12 00:19:10.036892 CEST - Status: STARTING 2026-04-12 00:19:12.702284 CEST - Status: STARTING 2026-04-12 00:19:15.368004 CEST - Status: STARTING 2026-04-12 00:19:18.033527 CEST - Status: STARTING 2026-04-12 00:19:20.699032 CEST - Status: STARTING 2026-04-12 00:19:23.364523 CEST - Status: STARTING 2026-04-12 00:19:26.030273 CEST - Status: STARTING 2026-04-12 00:19:28.695976 CEST - Status: STARTING 2026-04-12 00:19:31.361575 CEST - Status: STARTING 2026-04-12 00:19:34.027078 CEST - Status: STARTING 2026-04-12 00:19:36.692603 CEST - Status: STARTING 2026-04-12 00:19:39.358252 CEST - Status: STARTING 2026-04-12 00:19:42.024620 CEST - Status: STARTING 2026-04-12 00:19:44.690352 CEST - Status: STARTING 2026-04-12 00:19:47.356249 CEST - Status: STARTING 2026-04-12 00:19:50.021884 CEST - Status: STARTING 2026-04-12 00:19:52.687313 CEST - Status: STARTING 2026-04-12 00:19:55.352803 CEST - Status: STARTING 2026-04-12 00:19:58.018423 CEST - Status: STARTING 2026-04-12 00:20:00.684453 CEST - Status: STARTING 2026-04-12 00:20:03.400911 CEST - Status: STARTING 2026-04-12 00:20:06.117225 CEST - Status: STARTING 2026-04-12 00:20:08.833500 CEST - Status: STARTING 2026-04-12 00:20:11.549482 CEST - Status: STARTING 2026-04-12 00:20:14.265556 CEST - Status: STARTING 2026-04-12 00:20:16.981593 CEST - Status: STARTING 2026-04-12 00:20:19.697965 CEST - Status: STARTING 2026-04-12 00:20:22.463959 CEST - Status: STARTING 2026-04-12 00:20:25.179970 CEST - Status: STARTING 2026-04-12 00:20:27.896065 CEST - Status: STARTING 2026-04-12 00:20:30.562239 CEST - Status: STARTING 2026-04-12 00:20:33.328179 CEST - Status: STARTING 2026-04-12 00:20:36.044411 CEST - Status: STARTING 2026-04-12 00:20:38.710526 CEST - Status: STARTING 2026-04-12 00:20:41.376648 CEST - Status: STARTING 2026-04-12 00:20:44.092645 CEST - Status: STARTING 2026-04-12 00:20:46.758487 CEST - Status: STARTING 2026-04-12 00:20:49.424902 CEST - Status: STARTING 2026-04-12 00:20:52.090485 CEST - Status: STARTING 2026-04-12 00:20:54.756042 CEST - Status: STARTING 2026-04-12 00:20:57.421511 CEST - Status: STARTING 2026-04-12 00:21:00.087239 CEST - Status: STARTING 2026-04-12 00:21:02.752774 CEST - Status: STARTING 2026-04-12 00:21:05.418426 CEST - Status: STARTING 2026-04-12 00:21:08.083926 CEST - Status: STARTING 2026-04-12 00:21:10.749432 CEST - Status: STARTING 2026-04-12 00:21:13.414982 CEST - Status: STARTING 2026-04-12 00:21:16.080514 CEST - Status: STARTING 2026-04-12 00:21:18.746314 CEST - Status: STARTING 2026-04-12 00:21:21.411792 CEST - Status: STARTING 2026-04-12 00:21:24.077398 CEST - Status: STARTING 2026-04-12 00:21:26.692744 CEST - Status: STARTING 2026-04-12 00:21:29.358391 CEST - Status: STARTING 2026-04-12 00:21:32.024100 CEST - Status: STARTING 2026-04-12 00:21:34.690148 CEST - Status: STARTING 2026-04-12 00:21:37.405914 CEST - Status: STARTING 2026-04-12 00:21:40.071442 CEST - Status: UP 2026-04-12 00:21:40.071488 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01knza0gm1e4pb15yafn9wq86n 2026-04-12 00:21:40.071521 CEST - Validate resources 2026-04-12 00:21:40.738258 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/step_Validateresources_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-ebd3f98e tst 2026-04-12 00:21:40.738341 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/list-resources_json.txt': [ { "cluster_id": "taurus-3", "created_at": "2026-04-11T22:18:45.914256Z", "disk_image_id": "image_fr-lyon1-bi-baremetal1_0kx4kze8x8b5avj3vx2266mv04", "experiment_id": "exp_expauth.ilabt.imec.be_01knza0gm1e4pb15yafn9wq86n", "expires_at": "2026-04-12T00:18:00Z", "flavor_id": "flavor_fr-lyon1-bi-baremetal1_77w548gf80b44a4yh7cxmjscef", "friendly_name": "tst", "id": "r_fr-lyon1-bi-baremetal1_01knza0h8yen0vqgfpp4xvcpnd", "network_interfaces": [], "private_ipv4": null, "private_ipv6": null, "public_ipv4": null, "public_ipv6": null, "ssh_authorized_keys": [ "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINNiZPtQkfCEsc1x2QSwNWekfhWwWZbOvpE8hE0dH253 Wim (ftester) Van de Meerssche" ], "ssh_logins": [ { "host": "taurus-3.lyon", "port": 22, "username": "root", "host_keys": [], "description": "Single node compute resource reservation login infos", "jump_proxy": { "host": "access.grid5000.fr", "port": 22, "username": "slicesbo", "host_keys": [], "description": "Grid'5000 frontal site proxy", "jump_proxy": null } } ], "status": "up", "terminated_at": null, "userdata": null, "console_url": null, "machine_id": null, "failure_reason": null, "infra_id": "fr-lyon1-bi-baremetal1", "machine_name": null } ] 2026-04-12 00:21:40.738359 CEST - Error in test step 'Validate resources': "slices bi list-resources" returned resource without private IPv4 address, but the test requested one. 2026-04-12 00:21:40.738380 CEST - Check if resources are registered in experiment 2026-04-12 00:21:40.738501 CEST - Run: slices experiment list-resources --format json tst-ebd3f98e 2026-04-12 00:21:41.353462 CEST - Status (on expauth): UP 2026-04-12 00:21:41.353594 CEST - Testing extend expires_at (all resources in experiment) 2026-04-12 00:21:41.353728 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-ebd3f98e 2026-04-12 00:21:45.526412 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-ebd3f98e tst 2026-04-12 00:21:46.141556 CEST - Testing extend expires_at (single resource in experiment) 2026-04-12 00:21:46.141726 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-ebd3f98e 2026-04-12 00:21:50.113855 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-ebd3f98e tst 2026-04-12 00:21:50.779073 CEST - Testing ssh login 2026-04-12 00:21:50.789052 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-ebd3f98e tst 2026-04-12 00:21:51.454439 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-ebd3f98e tst 2026-04-12 00:21:52.120361 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/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-ebd3f98e tst 2026-04-12 00:21:52.120433 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-04-12 00:21:52.120451 CEST - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-04-12 00:21:52.120606 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-ebd3f98e tst 2026-04-12 00:21:52.786334 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/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-ebd3f98e tst 2026-04-12 00:21:52.786400 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-04-12 00:21:52.786420 CEST - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-04-12 00:21:52.786509 CEST - Logging in using 'slices bi ssh' 2026-04-12 00:21:52.786528 CEST - Forcing IPv4 only. 2026-04-12 00:21:52.786633 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-ebd3f98e tst -- -4 uname -a 2026-04-12 00:21:53.465909 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/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-ebd3f98e tst -- -4 uname -a 2026-04-12 00:21:53.465978 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/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-04-12 00:21:53.465997 CEST - 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-ebd3f98e', 'tst', '--', '-4', 'uname', '-a'] 2026-04-12 00:21:53.466137 CEST - Run: ssh-keygen -F taurus-3.lyon 2026-04-12 00:21:53.469756 CEST - Run: ssh-keygen -F taurus-3.lyon:22 2026-04-12 00:21:53.473278 CEST - Run: ssh-keygen -F access.grid5000.fr 2026-04-12 00:21:53.476795 CEST - Run: ssh-keygen -F access.grid5000.fr:22 2026-04-12 00:21:53.480209 CEST - Logging in using 'slices bi ssh' 2026-04-12 00:21:53.480267 CEST - Forcing IPv6 only. 2026-04-12 00:21:53.480353 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-ebd3f98e tst -- -6 uname -a 2026-04-12 00:21:54.136524 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/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-ebd3f98e tst -- -6 uname -a 2026-04-12 00:21:54.136596 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/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-04-12 00:21:54.136613 CEST - 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-ebd3f98e', 'tst', '--', '-6', 'uname', '-a'] 2026-04-12 00:21:54.136634 CEST - Wait 5s before retry 2026-04-12 00:21:59.136816 CEST - Forcing IPv6 only. 2026-04-12 00:21:59.756545 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/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-ebd3f98e tst -- -6 uname -a 2026-04-12 00:21:59.756615 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/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-04-12 00:21:59.756631 CEST - 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-ebd3f98e', 'tst', '--', '-6', 'uname', '-a'] 2026-04-12 00:21:59.756656 CEST - Logging in using SSH over SSH proxy 2026-04-12 00:21:59.756800 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-ebd3f98e tst 2026-04-12 00:22:00.422568 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/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-ebd3f98e tst 2026-04-12 00:22:00.422632 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/556f81f3-4792-4e65-805a-4e94a9e9dcc5/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-04-12 00:22:00.422647 CEST - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-04-12 00:22:00.428965 CEST - Destroying tst-ebd3f98e tst 2026-04-12 00:22:00.429128 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-ebd3f98e tst