Run Test: slices-bi-singlenode-login 2026-03-11 23:42:22.712775 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-11 23:42:25.979900 CET - Run: slices --version 2026-03-11 23:42:26.156068 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.8 Slices clientlib bi v5.1.2 2026-03-11 23:42:26.156338 CET - Run: slices pubkey list --format text 2026-03-11 23:42:26.773096 CET - Pubkey already registered 2026-03-11 23:42:26.773341 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-11 23:42:27.260397 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-11 23:42:27.260501 CET - Check List Flavors 2026-03-11 23:42:27.260676 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-03-11 23:42:31.244748 CET - Check List DiskImages 2026-03-11 23:42:31.244977 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-03-11 23:42:34.047414 CET - Requesting resources 2026-03-11 23:42:34.047894 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-14ba0257 2026-03-11 23:42:35.759123 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kkfh1wfsexss3sjzjnxb0g1y 2026-03-11 23:42:35.759256 CET - Waiting until resource ready 2026-03-11 23:42:37.759637 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-14ba0257 tst 2026-03-11 23:42:38.387002 CET - Status: IMAGING 2026-03-11 23:42:41.032456 CET - Status: IMAGING 2026-03-11 23:42:43.681853 CET - Status: STARTING 2026-03-11 23:42:46.309600 CET - Status: STARTING 2026-03-11 23:42:48.933021 CET - Status: STARTING 2026-03-11 23:42:51.553716 CET - Status: STARTING 2026-03-11 23:42:54.195025 CET - Status: STARTING 2026-03-11 23:42:56.844682 CET - Status: STARTING 2026-03-11 23:42:59.468733 CET - Status: STARTING 2026-03-11 23:43:02.099841 CET - Status: STARTING 2026-03-11 23:43:04.733497 CET - Status: STARTING 2026-03-11 23:43:07.367584 CET - Status: STARTING 2026-03-11 23:43:09.992473 CET - Status: STARTING 2026-03-11 23:43:12.618299 CET - Status: STARTING 2026-03-11 23:43:15.243370 CET - Status: STARTING 2026-03-11 23:43:17.869371 CET - Status: STARTING 2026-03-11 23:43:20.555383 CET - Status: STARTING 2026-03-11 23:43:23.182518 CET - Status: STARTING 2026-03-11 23:43:25.821977 CET - Status: STARTING 2026-03-11 23:43:28.455091 CET - Status: STARTING 2026-03-11 23:43:31.076768 CET - Status: STARTING 2026-03-11 23:43:33.713440 CET - Status: STARTING 2026-03-11 23:43:36.336843 CET - Status: STARTING 2026-03-11 23:43:38.952492 CET - Status: STARTING 2026-03-11 23:43:41.566973 CET - Status: STARTING 2026-03-11 23:43:44.184955 CET - Status: STARTING 2026-03-11 23:43:46.810824 CET - Status: STARTING 2026-03-11 23:43:49.434264 CET - Status: STARTING 2026-03-11 23:43:52.061724 CET - Status: STARTING 2026-03-11 23:43:54.707620 CET - Status: STARTING 2026-03-11 23:43:57.329046 CET - Status: STARTING 2026-03-11 23:43:59.959460 CET - Status: STARTING 2026-03-11 23:44:02.584904 CET - Status: STARTING 2026-03-11 23:44:05.207168 CET - Status: STARTING 2026-03-11 23:44:07.839813 CET - Status: STARTING 2026-03-11 23:44:10.472792 CET - Status: STARTING 2026-03-11 23:44:13.111231 CET - Status: STARTING 2026-03-11 23:44:15.742920 CET - Status: STARTING 2026-03-11 23:44:18.358828 CET - Status: STARTING 2026-03-11 23:44:20.978915 CET - Status: STARTING 2026-03-11 23:44:23.602099 CET - Status: STARTING 2026-03-11 23:44:26.222532 CET - Status: STARTING 2026-03-11 23:44:28.844207 CET - Status: STARTING 2026-03-11 23:44:31.465721 CET - Status: STARTING 2026-03-11 23:44:34.096773 CET - Status: STARTING 2026-03-11 23:44:36.732214 CET - Status: STARTING 2026-03-11 23:44:39.362601 CET - Status: STARTING 2026-03-11 23:44:41.993008 CET - Status: STARTING 2026-03-11 23:44:44.607115 CET - Status: STARTING 2026-03-11 23:44:47.244352 CET - Status: STARTING 2026-03-11 23:44:49.864152 CET - Status: STARTING 2026-03-11 23:44:52.501967 CET - Status: STARTING 2026-03-11 23:44:55.140564 CET - Status: STARTING 2026-03-11 23:44:57.773424 CET - Status: STARTING 2026-03-11 23:45:00.401106 CET - Status: STARTING 2026-03-11 23:45:03.067884 CET - Status: STARTING 2026-03-11 23:45:05.700806 CET - Status: STARTING 2026-03-11 23:45:08.324611 CET - Status: STARTING 2026-03-11 23:45:10.949189 CET - Status: STARTING 2026-03-11 23:45:13.575105 CET - Status: STARTING 2026-03-11 23:45:16.207285 CET - Status: STARTING 2026-03-11 23:45:18.828758 CET - Status: STARTING 2026-03-11 23:45:21.471397 CET - Status: STARTING 2026-03-11 23:45:24.110646 CET - Status: STARTING 2026-03-11 23:45:26.755274 CET - Status: STARTING 2026-03-11 23:45:29.385351 CET - Status: UP 2026-03-11 23:45:29.385417 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kkfh1vv7exhr7zb7amth2tqn 2026-03-11 23:45:29.385452 CET - Check if resources are registered in experiment 2026-03-11 23:45:29.385622 CET - Run: slices experiment list-resources --format json tst-14ba0257 2026-03-11 23:45:29.976805 CET - Status (on expauth): UP 2026-03-11 23:45:29.976929 CET - Testing extend expires_at (all resources in experiment) 2026-03-11 23:45:29.977068 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-14ba0257 2026-03-11 23:45:34.008592 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-14ba0257 tst 2026-03-11 23:45:34.645492 CET - Testing extend expires_at (single resource in experiment) 2026-03-11 23:45:34.645664 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-14ba0257 2026-03-11 23:45:38.645862 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-14ba0257 tst 2026-03-11 23:45:39.273007 CET - Testing ssh login 2026-03-11 23:45:39.282919 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-14ba0257 tst 2026-03-11 23:45:39.964054 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-14ba0257 tst 2026-03-11 23:45:40.603944 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/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-14ba0257 tst 2026-03-11 23:45:40.604015 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-03-11 23:45:40.604033 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-11 23:45:40.604177 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-14ba0257 tst 2026-03-11 23:45:41.240750 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/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-14ba0257 tst 2026-03-11 23:45:41.240821 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-11 23:45:41.240840 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-11 23:45:41.240950 CET - Logging in using 'slices bi ssh' 2026-03-11 23:45:41.240972 CET - Forcing IPv4 only. 2026-03-11 23:45:41.241074 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-14ba0257 tst -- -4 uname -a 2026-03-11 23:45:41.922741 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/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-14ba0257 tst -- -4 uname -a 2026-03-11 23:45:41.922810 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/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-03-11 23:45:41.922826 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-14ba0257', 'tst', '--', '-4', 'uname', '-a'] 2026-03-11 23:45:41.922960 CET - Run: ssh-keygen -F taurus-11.lyon 2026-03-11 23:45:41.926490 CET - Run: ssh-keygen -F taurus-11.lyon:22 2026-03-11 23:45:41.929563 CET - Run: ssh-keygen -F access.grid5000.fr 2026-03-11 23:45:41.932572 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-03-11 23:45:41.935479 CET - Logging in using 'slices bi ssh' 2026-03-11 23:45:41.935549 CET - Forcing IPv6 only. 2026-03-11 23:45:41.935657 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-14ba0257 tst -- -6 uname -a 2026-03-11 23:45:42.567737 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/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-14ba0257 tst -- -6 uname -a 2026-03-11 23:45:42.567809 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/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-03-11 23:45:42.567826 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-14ba0257', 'tst', '--', '-6', 'uname', '-a'] 2026-03-11 23:45:42.567846 CET - Wait 5s before retry 2026-03-11 23:45:47.568044 CET - Forcing IPv6 only. 2026-03-11 23:45:48.190798 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/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-14ba0257 tst -- -6 uname -a 2026-03-11 23:45:48.190866 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/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-03-11 23:45:48.190883 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-14ba0257', 'tst', '--', '-6', 'uname', '-a'] 2026-03-11 23:45:48.190906 CET - Logging in using SSH over SSH proxy 2026-03-11 23:45:48.191029 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-14ba0257 tst 2026-03-11 23:45:48.805128 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/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-14ba0257 tst 2026-03-11 23:45:48.805198 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/248df31c-cc54-4d04-8088-e6e15d471507/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-11 23:45:48.805214 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-03-11 23:45:48.811196 CET - Destroying tst-14ba0257 tst 2026-03-11 23:45:48.811365 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-14ba0257 tst