Run Test: slices-bi-singlenode-login 2026-04-19 00:23:49.170429 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-19 00:23:53.494884 CEST - Run: slices --version 2026-04-19 00:23:53.709402 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-19 00:23:53.709741 CEST - Run: slices pubkey list --format text 2026-04-19 00:23:54.325162 CEST - Pubkey already registered 2026-04-19 00:23:54.325442 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-19 00:23:54.840618 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-19 00:23:54.840768 CEST - Check List Flavors 2026-04-19 00:23:54.840977 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-04-19 00:23:55.606767 CEST - Check List DiskImages 2026-04-19 00:23:55.607024 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-04-19 00:23:56.222470 CEST - Requesting resources 2026-04-19 00:23:56.223033 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-4d38e3b8 2026-04-19 00:23:57.940889 CEST - Resource ID: r_fr-lyon1-bi-baremetal1_01kphb32vcey88dke2f9hsta6n 2026-04-19 00:23:57.941016 CEST - Waiting until resource ready 2026-04-19 00:23:59.941398 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-4d38e3b8 tst 2026-04-19 00:24:00.606813 CEST - Status: IMAGING 2026-04-19 00:24:03.272538 CEST - Status: IMAGING 2026-04-19 00:24:05.938224 CEST - Status: STARTING 2026-04-19 00:24:08.654022 CEST - Status: STARTING 2026-04-19 00:24:11.319652 CEST - Status: STARTING 2026-04-19 00:24:13.985399 CEST - Status: STARTING 2026-04-19 00:24:16.651132 CEST - Status: STARTING 2026-04-19 00:24:19.317011 CEST - Status: STARTING 2026-04-19 00:24:21.982669 CEST - Status: STARTING 2026-04-19 00:24:24.648330 CEST - Status: STARTING 2026-04-19 00:24:27.313994 CEST - Status: STARTING 2026-04-19 00:24:29.979894 CEST - Status: STARTING 2026-04-19 00:24:32.645646 CEST - Status: STARTING 2026-04-19 00:24:35.311430 CEST - Status: STARTING 2026-04-19 00:24:37.977351 CEST - Status: STARTING 2026-04-19 00:24:40.643285 CEST - Status: STARTING 2026-04-19 00:24:43.308968 CEST - Status: STARTING 2026-04-19 00:24:45.974624 CEST - Status: STARTING 2026-04-19 00:24:48.640402 CEST - Status: STARTING 2026-04-19 00:24:51.306062 CEST - Status: STARTING 2026-04-19 00:24:53.971765 CEST - Status: STARTING 2026-04-19 00:24:56.687660 CEST - Status: STARTING 2026-04-19 00:24:59.353309 CEST - Status: STARTING 2026-04-19 00:25:02.018885 CEST - Status: STARTING 2026-04-19 00:25:04.684694 CEST - Status: STARTING 2026-04-19 00:25:07.350436 CEST - Status: STARTING 2026-04-19 00:25:10.016069 CEST - Status: STARTING 2026-04-19 00:25:12.732016 CEST - Status: STARTING 2026-04-19 00:25:15.398586 CEST - Status: STARTING 2026-04-19 00:25:18.064309 CEST - Status: STARTING 2026-04-19 00:25:20.730068 CEST - Status: STARTING 2026-04-19 00:25:23.395759 CEST - Status: STARTING 2026-04-19 00:25:26.061379 CEST - Status: STARTING 2026-04-19 00:25:28.727201 CEST - Status: STARTING 2026-04-19 00:25:31.393310 CEST - Status: STARTING 2026-04-19 00:25:34.059305 CEST - Status: STARTING 2026-04-19 00:25:36.725330 CEST - Status: STARTING 2026-04-19 00:25:39.391744 CEST - Status: STARTING 2026-04-19 00:25:42.057567 CEST - Status: STARTING 2026-04-19 00:25:44.724372 CEST - Status: STARTING 2026-04-19 00:25:47.390146 CEST - Status: STARTING 2026-04-19 00:25:50.105860 CEST - Status: STARTING 2026-04-19 00:25:52.771619 CEST - Status: STARTING 2026-04-19 00:25:55.437296 CEST - Status: STARTING 2026-04-19 00:25:58.103068 CEST - Status: STARTING 2026-04-19 00:26:00.768748 CEST - Status: STARTING 2026-04-19 00:26:03.434520 CEST - Status: STARTING 2026-04-19 00:26:06.100261 CEST - Status: STARTING 2026-04-19 00:26:08.765958 CEST - Status: STARTING 2026-04-19 00:26:11.431627 CEST - Status: STARTING 2026-04-19 00:26:14.097345 CEST - Status: STARTING 2026-04-19 00:26:16.763034 CEST - Status: STARTING 2026-04-19 00:26:19.428650 CEST - Status: STARTING 2026-04-19 00:26:22.094384 CEST - Status: STARTING 2026-04-19 00:26:24.760309 CEST - Status: STARTING 2026-04-19 00:26:27.425860 CEST - Status: STARTING 2026-04-19 00:26:30.091591 CEST - Status: STARTING 2026-04-19 00:26:32.757262 CEST - Status: STARTING 2026-04-19 00:26:35.423162 CEST - Status: STARTING 2026-04-19 00:26:38.088909 CEST - Status: STARTING 2026-04-19 00:26:40.754552 CEST - Status: STARTING 2026-04-19 00:26:43.420213 CEST - Status: STARTING 2026-04-19 00:26:46.085881 CEST - Status: STARTING 2026-04-19 00:26:48.751683 CEST - Status: STARTING 2026-04-19 00:26:51.417375 CEST - Status: UP 2026-04-19 00:26:51.417458 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kphb3276eambymgaf403s2kh 2026-04-19 00:26:51.417496 CEST - Validate resources 2026-04-19 00:26:52.084679 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-4d38e3b8 tst 2026-04-19 00:26:52.084788 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/list-resources_json.txt': [ { "cluster_id": "taurus-15", "created_at": "2026-04-18T22:23:57.795621Z", "disk_image_id": "image_fr-lyon1-bi-baremetal1_0kx4kze8x8b5avj3vx2266mv04", "experiment_id": "exp_expauth.ilabt.imec.be_01kphb3276eambymgaf403s2kh", "expires_at": "2026-04-19T00:23:00Z", "flavor_id": "flavor_fr-lyon1-bi-baremetal1_77w548gf80b44a4yh7cxmjscef", "friendly_name": "tst", "id": "r_fr-lyon1-bi-baremetal1_01kphb32vcey88dke2f9hsta6n", "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-15.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-19 00:26:52.084812 CEST - Error in test step 'Validate resources': "slices bi list-resources" returned resource without private IPv4 address, but the test requested one. 2026-04-19 00:26:52.084837 CEST - Check if resources are registered in experiment 2026-04-19 00:26:52.084980 CEST - Run: slices experiment list-resources --format json tst-4d38e3b8 2026-04-19 00:26:52.751740 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/step_Checkexperimentprint-resources_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices experiment list-resources --format json tst-4d38e3b8 2026-04-19 00:26:52.751826 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/experiment-list-resources.txt': /opt/slices-monitor-worker/slices-cli-venv/lib/python3.14/site-packages/authlib/_joserfc_helpers.py:8: AuthlibDeprecationWarning: authlib.jose module is deprecated, please use joserfc instead. It will be compatible before version 2.0.0. from authlib.jose import ECKey [ { "id": "r_fr-lyon1-bi-baremetal1_01kphb32vcey88dke2f9hsta6n", "created_at": "2026-04-18T22:23:57.795621Z", "created_by": "user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g", "experiment_id": "exp_expauth.ilabt.imec.be_01kphb3276eambymgaf403s2kh", "friendly_name": "tst", "project_id": "proj_account.ilabt.imec.be_5pzabws7n79ydsagfg3vntg590", "service_id": "bi", "infra_id": "fr-lyon1-bi-baremetal1", "status": "up", "type": "baremetal", "description": "debian11-min image on taurus-15 node", "expires_at": "2026-04-19T00:23:00Z", "terminated_at": null, "terminated_by": null } ] 2026-04-19 00:26:52.751855 CEST - Error in test step 'Check experiment print-resources': "slices experiment list-resources" returned invalid json 2026-04-19 00:26:52.751943 CEST - Testing extend expires_at (all resources in experiment) 2026-04-19 00:26:52.752055 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-4d38e3b8 2026-04-19 00:26:56.924934 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-4d38e3b8 tst 2026-04-19 00:26:57.590617 CEST - Testing extend expires_at (single resource in experiment) 2026-04-19 00:26:57.590840 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-4d38e3b8 2026-04-19 00:27:01.714140 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-4d38e3b8 tst 2026-04-19 00:27:02.379796 CEST - Testing ssh login 2026-04-19 00:27:02.390046 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-4d38e3b8 tst 2026-04-19 00:27:03.055438 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-4d38e3b8 tst 2026-04-19 00:27:03.771561 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-4d38e3b8 tst 2026-04-19 00:27:03.771638 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-04-19 00:27:03.771658 CEST - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-04-19 00:27:03.771805 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-4d38e3b8 tst 2026-04-19 00:27:04.537858 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-4d38e3b8 tst 2026-04-19 00:27:04.537935 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-04-19 00:27:04.537956 CEST - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-04-19 00:27:04.538056 CEST - Logging in using 'slices bi ssh' 2026-04-19 00:27:04.538081 CEST - Forcing IPv4 only. 2026-04-19 00:27:04.538185 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-4d38e3b8 tst -- -4 uname -a 2026-04-19 00:27:05.304412 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-4d38e3b8 tst -- -4 uname -a 2026-04-19 00:27:05.304495 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-19 00:27:05.304517 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-4d38e3b8', 'tst', '--', '-4', 'uname', '-a'] 2026-04-19 00:27:05.304651 CEST - Run: ssh-keygen -F taurus-15.lyon 2026-04-19 00:27:05.308318 CEST - Run: ssh-keygen -F taurus-15.lyon:22 2026-04-19 00:27:05.311874 CEST - Run: ssh-keygen -F access.grid5000.fr 2026-04-19 00:27:05.315392 CEST - Run: ssh-keygen -F access.grid5000.fr:22 2026-04-19 00:27:05.318844 CEST - Logging in using 'slices bi ssh' 2026-04-19 00:27:05.318919 CEST - Forcing IPv6 only. 2026-04-19 00:27:05.319018 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-4d38e3b8 tst -- -6 uname -a 2026-04-19 00:27:06.035122 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-4d38e3b8 tst -- -6 uname -a 2026-04-19 00:27:06.035209 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-19 00:27:06.035230 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-4d38e3b8', 'tst', '--', '-6', 'uname', '-a'] 2026-04-19 00:27:06.035256 CEST - Wait 5s before retry 2026-04-19 00:27:11.035458 CEST - Forcing IPv6 only. 2026-04-19 00:27:11.751864 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-4d38e3b8 tst -- -6 uname -a 2026-04-19 00:27:11.751954 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-19 00:27:11.751976 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-4d38e3b8', 'tst', '--', '-6', 'uname', '-a'] 2026-04-19 00:27:11.752013 CEST - Logging in using SSH over SSH proxy 2026-04-19 00:27:11.752170 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-4d38e3b8 tst 2026-04-19 00:27:12.417965 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/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-4d38e3b8 tst 2026-04-19 00:27:12.418063 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/21d14287-bf4e-4d05-8267-28c068707d0f/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-04-19 00:27:12.418086 CEST - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-04-19 00:27:12.424065 CEST - Destroying tst-4d38e3b8 tst 2026-04-19 00:27:12.424218 CEST - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-4d38e3b8 tst