Run Test: slices-bi-singlenode-login 2026-03-23 16:19:33.610581 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-23 16:19:36.981892 CET - Run: slices --version 2026-03-23 16:19:37.179985 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-23 16:19:37.180248 CET - Run: slices pubkey list --format text 2026-03-23 16:19:37.759189 CET - Pubkey already registered 2026-03-23 16:19:37.759403 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-23 16:19:38.283345 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-23 16:19:38.283515 CET - Check List Flavors 2026-03-23 16:19:38.283705 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-03-23 16:19:39.015615 CET - Check List DiskImages 2026-03-23 16:19:39.015813 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-03-23 16:19:39.622242 CET - Requesting resources 2026-03-23 16:19:39.622766 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian11-min --flavor taurus --duration 2h --experiment tst-74d759c7 2026-03-23 16:19:41.221403 CET - Resource ID: r_fr-lyon1-bi-baremetal1_01kmdmfgs6f6gajk06tdb3atdt 2026-03-23 16:19:41.221574 CET - Waiting until resource ready 2026-03-23 16:19:43.221988 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-74d759c7 tst 2026-03-23 16:19:43.870570 CET - Status: IMAGING 2026-03-23 16:19:46.560323 CET - Status: IMAGING 2026-03-23 16:19:49.231275 CET - Status: STARTING 2026-03-23 16:19:52.051205 CET - Status: STARTING 2026-03-23 16:19:54.799409 CET - Status: STARTING 2026-03-23 16:19:57.506014 CET - Status: STARTING 2026-03-23 16:20:00.221928 CET - Status: STARTING 2026-03-23 16:20:02.918808 CET - Status: STARTING 2026-03-23 16:20:05.676927 CET - Status: STARTING 2026-03-23 16:20:08.330947 CET - Status: STARTING 2026-03-23 16:20:12.003231 CET - Status: STARTING 2026-03-23 16:20:14.779441 CET - Status: STARTING 2026-03-23 16:20:17.644416 CET - Status: STARTING 2026-03-23 16:20:20.419320 CET - Status: STARTING 2026-03-23 16:20:23.189614 CET - Status: STARTING 2026-03-23 16:20:25.847860 CET - Status: STARTING 2026-03-23 16:20:28.682541 CET - Status: STARTING 2026-03-23 16:20:31.454980 CET - Status: STARTING 2026-03-23 16:20:34.108383 CET - Status: STARTING 2026-03-23 16:20:36.757158 CET - Status: STARTING 2026-03-23 16:20:40.459489 CET - Status: STARTING 2026-03-23 16:20:43.251544 CET - Status: STARTING 2026-03-23 16:20:46.047332 CET - Status: STARTING 2026-03-23 16:20:48.723551 CET - Status: STARTING 2026-03-23 16:20:51.388788 CET - Status: STARTING 2026-03-23 16:20:54.090817 CET - Status: STARTING 2026-03-23 16:20:56.748151 CET - Status: STARTING 2026-03-23 16:20:59.420243 CET - Status: STARTING 2026-03-23 16:21:02.081205 CET - Status: STARTING 2026-03-23 16:21:04.726693 CET - Status: STARTING 2026-03-23 16:21:07.373440 CET - Status: STARTING 2026-03-23 16:21:10.028312 CET - Status: STARTING 2026-03-23 16:21:12.675616 CET - Status: STARTING 2026-03-23 16:21:15.342641 CET - Status: STARTING 2026-03-23 16:21:18.014674 CET - Status: STARTING 2026-03-23 16:21:20.686778 CET - Status: STARTING 2026-03-23 16:21:23.352744 CET - Status: STARTING 2026-03-23 16:21:26.012665 CET - Status: STARTING 2026-03-23 16:21:28.667206 CET - Status: STARTING 2026-03-23 16:21:31.326699 CET - Status: STARTING 2026-03-23 16:21:33.982616 CET - Status: STARTING 2026-03-23 16:21:36.642545 CET - Status: STARTING 2026-03-23 16:21:39.285481 CET - Status: STARTING 2026-03-23 16:21:41.957454 CET - Status: STARTING 2026-03-23 16:21:44.599334 CET - Status: STARTING 2026-03-23 16:21:47.259561 CET - Status: STARTING 2026-03-23 16:21:49.925254 CET - Status: STARTING 2026-03-23 16:21:52.590308 CET - Status: STARTING 2026-03-23 16:21:55.231894 CET - Status: STARTING 2026-03-23 16:21:57.872353 CET - Status: STARTING 2026-03-23 16:22:00.515945 CET - Status: STARTING 2026-03-23 16:22:03.160165 CET - Status: STARTING 2026-03-23 16:22:05.815581 CET - Status: STARTING 2026-03-23 16:22:08.455764 CET - Status: STARTING 2026-03-23 16:22:11.103676 CET - Status: STARTING 2026-03-23 16:22:13.754744 CET - Status: STARTING 2026-03-23 16:22:16.402010 CET - Status: STARTING 2026-03-23 16:22:19.080474 CET - Status: STARTING 2026-03-23 16:22:21.725070 CET - Status: STARTING 2026-03-23 16:22:24.375800 CET - Status: STARTING 2026-03-23 16:22:27.023946 CET - Status: STARTING 2026-03-23 16:22:29.671925 CET - Status: STARTING 2026-03-23 16:22:32.323455 CET - Status: UP 2026-03-23 16:22:32.323499 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kmdmfg7vez4vj1p43qxfhy15 2026-03-23 16:22:32.323532 CET - Validate resources 2026-03-23 16:22:32.994844 CET - The fields of the created resource were validated. 2026-03-23 16:22:32.994901 CET - Check if resources are registered in experiment 2026-03-23 16:22:32.995097 CET - Run: slices experiment list-resources --format json tst-74d759c7 2026-03-23 16:22:33.619320 CET - Status (on expauth): UP 2026-03-23 16:22:33.619442 CET - Testing extend expires_at (all resources in experiment) 2026-03-23 16:22:33.619569 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-74d759c7 2026-03-23 16:22:37.676984 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-74d759c7 tst 2026-03-23 16:22:38.328270 CET - Testing extend expires_at (single resource in experiment) 2026-03-23 16:22:38.328449 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-74d759c7 2026-03-23 16:22:42.408351 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-74d759c7 tst 2026-03-23 16:22:43.066163 CET - Testing ssh login 2026-03-23 16:22:43.076485 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-74d759c7 tst 2026-03-23 16:22:43.743468 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-74d759c7 tst 2026-03-23 16:22:44.391178 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/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-74d759c7 tst 2026-03-23 16:22:44.391245 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/bi_ssh_serverkey.txt': No hostkeys in SSH info 2026-03-23 16:22:44.391262 CET - Error in test step 'Check SSH pubkey (resource)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-23 16:22:44.391397 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-74d759c7 tst 2026-03-23 16:22:45.046670 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/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-74d759c7 tst 2026-03-23 16:22:45.046737 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-23 16:22:45.046755 CET - Error in test step 'Check SSH pubkey (proxy)': No SSH hostkey found, but ignore_ssh_known_hosts=False 2026-03-23 16:22:45.046858 CET - Logging in using 'slices bi ssh' 2026-03-23 16:22:45.046879 CET - Forcing IPv4 only. 2026-03-23 16:22:45.046979 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-74d759c7 tst -- -4 uname -a 2026-03-23 16:22:45.730353 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/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-74d759c7 tst -- -4 uname -a 2026-03-23 16:22:45.730422 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/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-23 16:22:45.730439 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-74d759c7', 'tst', '--', '-4', 'uname', '-a'] 2026-03-23 16:22:45.730569 CET - Run: ssh-keygen -F taurus-15.lyon 2026-03-23 16:22:45.733978 CET - Run: ssh-keygen -F taurus-15.lyon:22 2026-03-23 16:22:45.737077 CET - Run: ssh-keygen -F access.grid5000.fr 2026-03-23 16:22:45.739991 CET - Run: ssh-keygen -F access.grid5000.fr:22 2026-03-23 16:22:45.742795 CET - Logging in using 'slices bi ssh' 2026-03-23 16:22:45.742854 CET - Forcing IPv6 only. 2026-03-23 16:22:45.742949 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-74d759c7 tst -- -6 uname -a 2026-03-23 16:22:46.378151 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/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-74d759c7 tst -- -6 uname -a 2026-03-23 16:22:46.378219 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/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-23 16:22:46.378236 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-74d759c7', 'tst', '--', '-6', 'uname', '-a'] 2026-03-23 16:22:46.378258 CET - Wait 5s before retry 2026-03-23 16:22:51.378453 CET - Forcing IPv6 only. 2026-03-23 16:22:52.086084 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/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-74d759c7 tst -- -6 uname -a 2026-03-23 16:22:52.086161 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/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-23 16:22:52.086179 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-74d759c7', 'tst', '--', '-6', 'uname', '-a'] 2026-03-23 16:22:52.086204 CET - Logging in using SSH over SSH proxy 2026-03-23 16:22:52.086331 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-74d759c7 tst 2026-03-23 16:22:52.733495 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/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-74d759c7 tst 2026-03-23 16:22:52.733560 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/46c738a5-1adb-4e95-b44d-e6b3fae71873/bi_ssh_proxykey.txt': No hostkeys in proxy SSH info 2026-03-23 16:22:52.733576 CET - Error in test step 'Ssh info proxy_pubkey_openssh': No SSH public keys in ComputeResource proxy SSH info. 2026-03-23 16:22:52.739693 CET - Destroying tst-74d759c7 tst 2026-03-23 16:22:52.739842 CET - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-74d759c7 tst