Run Test: slices-bi-singlenode-login 2026-02-28 23:12:35.786729 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-02-28 23:12:38.778414 CET - Run: slices --version 2026-02-28 23:12:38.957679 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.7 Slices clientlib bi v5.1.1 2026-02-28 23:12:38.957925 CET - Run: slices pubkey list --format text 2026-02-28 23:12:39.498522 CET - Pubkey already registered 2026-02-28 23:12:39.498755 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-02-28 23:12:39.982799 CET - Refreshed infrastructure list. Total: 22 entries. 2026-02-28 23:12:39.982892 CET - Check List Flavors 2026-02-28 23:12:39.983088 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-02-28 23:12:40.706542 CET - Check List DiskImages 2026-02-28 23:12:40.706727 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-02-28 23:12:41.271900 CET - Requesting resources 2026-02-28 23:12:41.272352 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-af62dae9 2026-02-28 23:12:42.859006 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kjk4z8kjet1b1td5q0jsm5dp 2026-02-28 23:12:42.859115 CET - Waiting until resource ready 2026-02-28 23:12:44.859527 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-af62dae9 tst 2026-02-28 23:12:45.481419 CET - Status: IMAGING 2026-02-28 23:12:48.111022 CET - Status: IMAGING 2026-02-28 23:12:50.752784 CET - Status: STARTING 2026-02-28 23:12:53.368381 CET - Status: STARTING 2026-02-28 23:12:55.992903 CET - Status: STARTING 2026-02-28 23:12:58.606667 CET - Status: STARTING 2026-02-28 23:13:01.237397 CET - Status: STARTING 2026-02-28 23:13:03.858613 CET - Status: STARTING 2026-02-28 23:13:06.474412 CET - Status: STARTING 2026-02-28 23:13:09.088940 CET - Status: STARTING 2026-02-28 23:13:11.721992 CET - Status: STARTING 2026-02-28 23:13:14.340657 CET - Status: STARTING 2026-02-28 23:13:16.975772 CET - Status: STARTING 2026-02-28 23:13:19.591403 CET - Status: STARTING 2026-02-28 23:13:22.211045 CET - Status: STARTING 2026-02-28 23:13:24.832521 CET - Status: STARTING 2026-02-28 23:13:27.448844 CET - Status: STARTING 2026-02-28 23:13:30.067418 CET - Status: STARTING 2026-02-28 23:13:32.675018 CET - Status: STARTING 2026-02-28 23:13:35.293273 CET - Status: STARTING 2026-02-28 23:13:37.911530 CET - Status: STARTING 2026-02-28 23:13:40.530990 CET - Status: STARTING 2026-02-28 23:13:43.158755 CET - Status: STARTING 2026-02-28 23:13:45.790289 CET - Status: STARTING 2026-02-28 23:13:48.418311 CET - Status: STARTING 2026-02-28 23:13:51.041054 CET - Status: STARTING 2026-02-28 23:13:53.653698 CET - Status: STARTING 2026-02-28 23:13:56.273265 CET - Status: STARTING 2026-02-28 23:13:58.891039 CET - Status: STARTING 2026-02-28 23:14:01.512251 CET - Status: STARTING 2026-02-28 23:14:04.135131 CET - Status: STARTING 2026-02-28 23:14:06.759475 CET - Status: STARTING 2026-02-28 23:14:09.370660 CET - Status: STARTING 2026-02-28 23:14:11.997524 CET - Status: STARTING 2026-02-28 23:14:14.618377 CET - Status: STARTING 2026-02-28 23:14:17.229428 CET - Status: STARTING 2026-02-28 23:14:19.846185 CET - Status: STARTING 2026-02-28 23:14:22.475390 CET - Status: STARTING 2026-02-28 23:14:25.091104 CET - Status: STARTING 2026-02-28 23:14:27.708472 CET - Status: STARTING 2026-02-28 23:14:30.328663 CET - Status: STARTING 2026-02-28 23:14:32.941129 CET - Status: STARTING 2026-02-28 23:14:35.565554 CET - Status: STARTING 2026-02-28 23:14:38.190122 CET - Status: STARTING 2026-02-28 23:14:40.811799 CET - Status: STARTING 2026-02-28 23:14:43.432269 CET - Status: STARTING 2026-02-28 23:14:46.044878 CET - Status: STARTING 2026-02-28 23:14:48.659281 CET - Status: STARTING 2026-02-28 23:14:51.278161 CET - Status: STARTING 2026-02-28 23:14:53.894424 CET - Status: STARTING 2026-02-28 23:14:56.523510 CET - Status: STARTING 2026-02-28 23:14:59.144298 CET - Status: STARTING 2026-02-28 23:15:01.774943 CET - Status: STARTING 2026-02-28 23:15:04.397984 CET - Status: STARTING 2026-02-28 23:15:07.030645 CET - Status: STARTING 2026-02-28 23:15:09.649582 CET - Status: STARTING 2026-02-28 23:15:12.286425 CET - Status: STARTING 2026-02-28 23:15:14.900840 CET - Status: STARTING 2026-02-28 23:15:17.522697 CET - Status: STARTING 2026-02-28 23:15:20.202926 CET - Status: STARTING 2026-02-28 23:15:22.840892 CET - Status: STARTING 2026-02-28 23:15:25.468978 CET - Status: STARTING 2026-02-28 23:15:28.093246 CET - Status: STARTING 2026-02-28 23:15:30.718122 CET - Status: STARTING 2026-02-28 23:15:33.348613 CET - Status: UP 2026-02-28 23:15:33.348655 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kjk4z82gfd9ajnbcsabryjdr 2026-02-28 23:15:33.348688 CET - Check if resources are registered in experiment 2026-02-28 23:15:33.348896 CET - Run: slices experiment list-resources --format json tst-af62dae9 2026-02-28 23:15:33.943593 CET - Status (on expauth): UP 2026-02-28 23:15:33.943738 CET - Testing extend expires_at (all resources in experiment) 2026-02-28 23:15:33.943868 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-af62dae9 2026-02-28 23:15:37.963476 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-af62dae9 tst 2026-02-28 23:15:38.579932 CET - Testing extend expires_at (single resource in experiment) 2026-02-28 23:15:38.580101 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-af62dae9 2026-02-28 23:15:42.596020 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-af62dae9 tst 2026-02-28 23:15:43.224227 CET - Testing ssh login 2026-02-28 23:15:43.233940 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-af62dae9 tst 2026-02-28 23:15:43.873511 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-af62dae9 tst 2026-02-28 23:15:44.497502 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/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-af62dae9 tst 2026-02-28 23:15:44.497570 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-02-28 23:15:44.497588 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-28 23:15:44.497763 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-af62dae9 tst 2026-02-28 23:15:45.114354 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/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-af62dae9 tst 2026-02-28 23:15:45.114421 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-28 23:15:45.114438 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-02-28 23:15:45.114540 CET - Logging in using 'slices bi ssh' 2026-02-28 23:15:45.114561 CET - Forcing IPv4 only. 2026-02-28 23:15:45.114657 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-af62dae9 tst -- -4 uname -a 2026-02-28 23:15:45.724975 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/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-af62dae9 tst -- -4 uname -a 2026-02-28 23:15:45.725041 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/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-28 23:15:45.725056 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-af62dae9', 'tst', '--', '-4', 'uname', '-a'] 2026-02-28 23:15:45.725179 CET - Run: ssh-keygen -F taurus-1.lyon 2026-02-28 23:15:45.728462 CET - Run: ssh-keygen -F taurus-1.lyon:22 2026-02-28 23:15:45.731503 CET - Run: ssh-keygen -F access.grid5000.fr 2026-02-28 23:15:45.734379 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-02-28 23:15:45.737154 CET - Logging in using 'slices bi ssh' 2026-02-28 23:15:45.737224 CET - Forcing IPv6 only. 2026-02-28 23:15:45.737319 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-af62dae9 tst -- -6 uname -a 2026-02-28 23:15:46.347830 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/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-af62dae9 tst -- -6 uname -a 2026-02-28 23:15:46.347899 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/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-28 23:15:46.347915 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-af62dae9', 'tst', '--', '-6', 'uname', '-a'] 2026-02-28 23:15:46.347934 CET - Wait 5s before retry 2026-02-28 23:15:51.348095 CET - Forcing IPv6 only. 2026-02-28 23:15:51.981435 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/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-af62dae9 tst -- -6 uname -a 2026-02-28 23:15:51.981504 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/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-28 23:15:51.981521 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-af62dae9', 'tst', '--', '-6', 'uname', '-a'] 2026-02-28 23:15:51.981544 CET - Logging in using SSH over SSH proxy 2026-02-28 23:15:51.981671 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-af62dae9 tst 2026-02-28 23:15:52.623850 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/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-af62dae9 tst 2026-02-28 23:15:52.623916 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/9a77f5d6-c0ab-49c4-8ed0-d05bf4af31d4/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-02-28 23:15:52.623931 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-02-28 23:15:52.629842 CET - Destroying tst-af62dae9 tst 2026-02-28 23:15:52.629993 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-af62dae9 tst