Run Test: slices-bi-singlenode-login 2026-02-28 23:02:37.958935 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-02-28 23:02:40.942961 CET - Run: slices --version 2026-02-28 23:02:41.120028 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:02:41.120263 CET - Run: slices pubkey list --format text 2026-02-28 23:02:41.682085 CET - Pubkey already registered 2026-02-28 23:02:41.682296 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-02-28 23:02:42.178560 CET - Refreshed infrastructure list. Total: 22 entries. 2026-02-28 23:02:42.178653 CET - Check List Flavors 2026-02-28 23:02:42.178876 CET - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-02-28 23:02:44.767276 CET - Check List DiskImages 2026-02-28 23:02:44.767452 CET - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-02-28 23:02:45.466988 CET - Requesting resources 2026-02-28 23:02:45.467439 CET - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-f9d647db --user-data /tmp/tmpd3bv7g9r 2026-02-28 23:02:51.698160 CET - Resource ID: r_gr-volos-bi-vm1_01kjk4d79bfm9v5tk3ybfnzwrr 2026-02-28 23:02:51.698337 CET - Waiting until resource ready 2026-02-28 23:02:53.698744 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-f9d647db tst 2026-02-28 23:02:54.493828 CET - Status: IMAGING 2026-02-28 23:02:57.303830 CET - Status: IMAGING 2026-02-28 23:03:00.086271 CET - Status: IMAGING 2026-02-28 23:03:02.869578 CET - Status: BOOTING 2026-02-28 23:03:05.652635 CET - Status: BOOTING 2026-02-28 23:03:08.435843 CET - Status: BOOTING 2026-02-28 23:03:11.214757 CET - Status: BOOTING 2026-02-28 23:03:13.997904 CET - Status: BOOTING 2026-02-28 23:03:16.776444 CET - Status: BOOTING 2026-02-28 23:03:19.559376 CET - Status: BOOTING 2026-02-28 23:03:22.348901 CET - Status: BOOTING 2026-02-28 23:03:25.138978 CET - Status: BOOTING 2026-02-28 23:03:27.922089 CET - Status: BOOTING 2026-02-28 23:03:30.706921 CET - Status: BOOTING 2026-02-28 23:03:33.488350 CET - Status: BOOTING 2026-02-28 23:03:36.260728 CET - Status: BOOTING 2026-02-28 23:03:39.055516 CET - Status: BOOTING 2026-02-28 23:03:41.866080 CET - Status: BOOTING 2026-02-28 23:03:44.653392 CET - Status: BOOTING 2026-02-28 23:03:47.436825 CET - Status: BOOTING 2026-02-28 23:03:50.221918 CET - Status: BOOTING 2026-02-28 23:03:53.005777 CET - Status: BOOTING 2026-02-28 23:03:55.793554 CET - Status: BOOTING 2026-02-28 23:03:58.587622 CET - Status: BOOTING 2026-02-28 23:04:01.385451 CET - Status: BOOTING 2026-02-28 23:04:04.171025 CET - Status: BOOTING 2026-02-28 23:04:06.967385 CET - Status: BOOTING 2026-02-28 23:04:09.753722 CET - Status: BOOTING 2026-02-28 23:04:12.549188 CET - Status: BOOTING 2026-02-28 23:04:15.335616 CET - Status: BOOTING 2026-02-28 23:04:18.122996 CET - Status: BOOTING 2026-02-28 23:04:20.926306 CET - Status: BOOTING 2026-02-28 23:04:23.719530 CET - Status: BOOTING 2026-02-28 23:04:26.562813 CET - Status: BOOTING 2026-02-28 23:04:29.359591 CET - Status: BOOTING 2026-02-28 23:04:32.161753 CET - Status: BOOTING 2026-02-28 23:04:34.961168 CET - Status: BOOTING 2026-02-28 23:04:37.757581 CET - Status: BOOTING 2026-02-28 23:04:40.552205 CET - Status: BOOTING 2026-02-28 23:04:43.347055 CET - Status: BOOTING 2026-02-28 23:04:46.126933 CET - Status: BOOTING 2026-02-28 23:04:48.902074 CET - Status: BOOTING 2026-02-28 23:04:51.708016 CET - Status: UP 2026-02-28 23:04:51.708072 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kjk4d24ne4gaj31fra0d52sc 2026-02-28 23:04:51.708116 CET - Check if resources are registered in experiment 2026-02-28 23:04:51.708364 CET - Run: slices experiment list-resources --format json tst-f9d647db 2026-02-28 23:04:52.342515 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/01cde2c5-0419-4968-93eb-e1319b36a074/step_Checkexperimentprint-resources_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices experiment list-resources --format json tst-f9d647db 2026-02-28 23:04:52.342585 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/01cde2c5-0419-4968-93eb-e1319b36a074/experiment-list-resources.txt': [] 2026-02-28 23:04:52.342605 CET - Error in test step 'Check experiment print-resources': "slices experiment list-resources" returned 0 resources instead of 1 2026-02-28 23:04:52.342697 CET - Testing extend expires_at (all resources in experiment) 2026-02-28 23:04:52.342817 CET - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-f9d647db 2026-02-28 23:04:54.577524 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/01cde2c5-0419-4968-93eb-e1319b36a074/step_Checkextendexpire_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-f9d647db 2026-02-28 23:04:54.577611 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/01cde2c5-0419-4968-93eb-e1319b36a074/experiment-extend-all.txt': Extending Experiment container from 2026-03-01 01:02 CET to 2026-03-01 02:04 CET... Extending the resources only on infrastructure gr-volos-bi-vm1. Use slices bi experiment list-resources to verify other infrastructures. ♻ Resources on infrastructure gr-volos-bi-vm1 now expire on 2026-03-01 02:04 CET. Infrastructure gr-volos-bi-vm1 reported successful resource extend. An additional resource status check indicated that the extend was actually not successful! ❌ Please contact support with the following details: Experiment ID: exp_expauth.ilabt.imec.be_01kjk4d24ne4gaj31fra0d52sc Requested Expire: 2026-03-01 02:04 CET Actual Experiment Expire: 2026-03-01 02:04 CET ✔ Overview of extended resources in experiment tst-f9d647db ┏━━━━━━━━┳━━━━━━━━┳━━━━━━━━┳━━━━━━┳━━━━━━━━┳━━━━━━━━┳━━━━━━━━┳━━━━━━━━┳━━━━━━━━┓ ┃ ┃ ┃ ┃ ┃ ┃ ┃ ┃ Expir… ┃ Expir… ┃ ┃ ┃ Frien… ┃ ┃ ┃ ┃ ┃ Creat… ┃ At ┃ At ┃ ┃ ID ┃ Name ┃ Infra ┃ Type ┃ Status ┃ Descr… ┃ At ┃ (BI) ┃ (ExpA… ┃ ┡━━━━━━━━╇━━━━━━━━╇━━━━━━━━╇━━━━━━╇━━━━━━━━╇━━━━━━━━╇━━━━━━━━╇━━━━━━━━╇━━━━━━━━┩ │ r_gr-… │ tst │ gr-vo… │ │ up │ │ 2026-… │ 2026-… │ MISSI… │ │ │ │ │ │ │ │ 23:02 │ 02:04 │ │ │ │ │ │ │ │ │ CET │ CET ✔ │ │ └────────┴────────┴────────┴──────┴────────┴────────┴────────┴────────┴────────┘ Warning: The info shown by `slices experiment list-resources` may not (yet) be up to date. Details stored at: /root/.slices/cli_error_details/err_2026-02-28T22:04:54+00:00.txt 2026-02-28 23:04:54.577634 CET - Error in test step 'Check extend expire': "slices bi extend" failed 2026-02-28 23:04:54.577655 CET - Testing ssh login 2026-02-28 23:04:54.587301 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-f9d647db tst 2026-02-28 23:04:55.489939 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-f9d647db tst 2026-02-28 23:04:56.388841 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-f9d647db tst 2026-02-28 23:04:57.300051 CET - Logging in using 'slices bi ssh' 2026-02-28 23:04:57.300104 CET - Forcing IPv4 only. 2026-02-28 23:04:57.300246 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-f9d647db tst -- -4 uname -a 2026-02-28 23:04:58.419951 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/01cde2c5-0419-4968-93eb-e1319b36a074/step_Sshloginviaslices-cliIPv4only_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-f9d647db tst -- -4 uname -a 2026-02-28 23:04:58.420019 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/01cde2c5-0419-4968-93eb-e1319b36a074/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:04:58.420035 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', 'gr-volos-bi-vm1', 'ssh', '--show', 'nothing', '--experiment', 'tst-f9d647db', 'tst', '--', '-4', 'uname', '-a'] 2026-02-28 23:04:58.420158 CET - Run: ssh-keygen -F 10.64.45.186 2026-02-28 23:04:58.423512 CET - Run: ssh-keygen -F 10.64.45.186:22 2026-02-28 23:04:58.426575 CET - Run: ssh-keygen -F 194.177.207.42 2026-02-28 23:04:58.429486 CET - Run: ssh-keygen -F 194.177.207.42:11122 2026-02-28 23:04:58.432305 CET - Logging in using SSH over SSH proxy 2026-02-28 23:04:58.432423 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-f9d647db tst 2026-02-28 23:04:59.347508 CET - Added paramiko HostKeyEntry for 10.64.45.186 2026-02-28 23:04:59.347599 CET - Added paramiko HostKeyEntry for 10.64.45.186 2026-02-28 23:04:59.347733 CET - Added paramiko HostKeyEntry for 10.64.45.186 2026-02-28 23:04:59.348022 CET - Added paramiko HostKeyEntry for 194.177.207.42 2026-02-28 23:04:59.348044 CET - Connecting to proxy 194.177.207.42:22 2026-02-28 23:05:01.351695 CET - Error in test step 'Ssh login (with proxy)': timed out 2026-02-28 23:05:01.351748 CET - Wait 5s before retry 2026-02-28 23:05:06.352069 CET - Added paramiko HostKeyEntry for 10.64.45.186 2026-02-28 23:05:06.352144 CET - Added paramiko HostKeyEntry for 10.64.45.186 2026-02-28 23:05:06.352253 CET - Added paramiko HostKeyEntry for 10.64.45.186 2026-02-28 23:05:06.352539 CET - Added paramiko HostKeyEntry for 194.177.207.42 2026-02-28 23:05:06.352555 CET - Connecting to proxy 194.177.207.42:22 2026-02-28 23:05:08.355669 CET - Error in test step 'Ssh login (with proxy) (Retry 1)': timed out 2026-02-28 23:05:08.361647 CET - Destroying tst-f9d647db tst 2026-02-28 23:05:08.361806 CET - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-f9d647db tst