Run Test: slices-bi-singlenode-login 2026-03-01 16:09:29.667681 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-01 16:09:32.430112 CET - Run: slices --version 2026-03-01 16:09:32.607903 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-03-01 16:09:32.608146 CET - Run: slices pubkey list --format text 2026-03-01 16:09:33.147259 CET - Pubkey already registered 2026-03-01 16:09:33.147466 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-01 16:09:33.633782 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-01 16:09:33.633929 CET - Check List Flavors 2026-03-01 16:09:33.634170 CET - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-03-01 16:09:36.171191 CET - Check List DiskImages 2026-03-01 16:09:36.171380 CET - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-03-01 16:09:36.875784 CET - Requesting resources 2026-03-01 16:09:36.876246 CET - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-1f832dbc --user-data /tmp/tmp403tl5f7 2026-03-01 16:09:39.507398 CET - Resource ID: r_gr-volos-bi-vm1_01kjmz5b5mf5897e209y7y6a5j 2026-03-01 16:09:39.507511 CET - Waiting until resource ready 2026-03-01 16:09:41.507917 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-1f832dbc tst 2026-03-01 16:09:42.303223 CET - Status: IMAGING 2026-03-01 16:09:45.099767 CET - Status: IMAGING 2026-03-01 16:09:47.882860 CET - Status: IMAGING 2026-03-01 16:09:50.657348 CET - Status: BOOTING 2026-03-01 16:09:53.444123 CET - Status: BOOTING 2026-03-01 16:09:56.244875 CET - Status: BOOTING 2026-03-01 16:09:59.031462 CET - Status: BOOTING 2026-03-01 16:10:01.832819 CET - Status: BOOTING 2026-03-01 16:10:04.619374 CET - Status: BOOTING 2026-03-01 16:10:07.405273 CET - Status: BOOTING 2026-03-01 16:10:10.261354 CET - Status: BOOTING 2026-03-01 16:10:13.067035 CET - Status: BOOTING 2026-03-01 16:10:15.848125 CET - Status: BOOTING 2026-03-01 16:10:18.637905 CET - Status: BOOTING 2026-03-01 16:10:21.420490 CET - Status: BOOTING 2026-03-01 16:10:24.212623 CET - Status: BOOTING 2026-03-01 16:10:26.989215 CET - Status: BOOTING 2026-03-01 16:10:29.779507 CET - Status: BOOTING 2026-03-01 16:10:32.623849 CET - Status: BOOTING 2026-03-01 16:10:35.408150 CET - Status: BOOTING 2026-03-01 16:10:38.200276 CET - Status: BOOTING 2026-03-01 16:10:40.974559 CET - Status: BOOTING 2026-03-01 16:10:43.761499 CET - Status: BOOTING 2026-03-01 16:10:46.561574 CET - Status: BOOTING 2026-03-01 16:10:49.351131 CET - Status: BOOTING 2026-03-01 16:10:52.178403 CET - Status: BOOTING 2026-03-01 16:10:54.964221 CET - Status: BOOTING 2026-03-01 16:10:57.748738 CET - Status: BOOTING 2026-03-01 16:11:00.540860 CET - Status: BOOTING 2026-03-01 16:11:03.321822 CET - Status: BOOTING 2026-03-01 16:11:06.156096 CET - Status: BOOTING 2026-03-01 16:11:08.947624 CET - Status: BOOTING 2026-03-01 16:11:11.734762 CET - Status: BOOTING 2026-03-01 16:11:14.522395 CET - Status: BOOTING 2026-03-01 16:11:17.346667 CET - Status: BOOTING 2026-03-01 16:11:20.136950 CET - Status: BOOTING 2026-03-01 16:11:22.908398 CET - Status: BOOTING 2026-03-01 16:11:25.695291 CET - Status: BOOTING 2026-03-01 16:11:28.486451 CET - Status: BOOTING 2026-03-01 16:11:31.279620 CET - Status: BOOTING 2026-03-01 16:11:34.065543 CET - Status: BOOTING 2026-03-01 16:11:36.857392 CET - Status: BOOTING 2026-03-01 16:11:39.649081 CET - Status: UP 2026-03-01 16:11:39.649127 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kjmz59hre9as8ss5qkn8q9fp 2026-03-01 16:11:39.649159 CET - Check if resources are registered in experiment 2026-03-01 16:11:39.649358 CET - Run: slices experiment list-resources --format json tst-1f832dbc 2026-03-01 16:11:40.243346 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/631d52f5-6c53-487f-852f-ea4304333461/step_Checkexperimentprint-resources_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices experiment list-resources --format json tst-1f832dbc 2026-03-01 16:11:40.243430 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/631d52f5-6c53-487f-852f-ea4304333461/experiment-list-resources.txt': [] 2026-03-01 16:11:40.243447 CET - Error in test step 'Check experiment print-resources': "slices experiment list-resources" returned 0 resources instead of 1 2026-03-01 16:11:40.243550 CET - Testing extend expires_at (all resources in experiment) 2026-03-01 16:11:40.243656 CET - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-1f832dbc 2026-03-01 16:11:42.519333 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/631d52f5-6c53-487f-852f-ea4304333461/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-1f832dbc 2026-03-01 16:11:42.519426 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/631d52f5-6c53-487f-852f-ea4304333461/experiment-extend-all.txt': Extending Experiment container from 2026-03-01 18:09 CET to 2026-03-01 19:11 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 19:11 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_01kjmz59hre9as8ss5qkn8q9fp Requested Expire: 2026-03-01 19:11 CET Actual Experiment Expire: 2026-03-01 19:11 CET ✔ Overview of extended resources in experiment tst-1f832dbc ┏━━━━━━━━┳━━━━━━━━┳━━━━━━━━┳━━━━━━┳━━━━━━━━┳━━━━━━━━┳━━━━━━━━┳━━━━━━━━┳━━━━━━━━┓ ┃ ┃ ┃ ┃ ┃ ┃ ┃ ┃ Expir… ┃ Expir… ┃ ┃ ┃ Frien… ┃ ┃ ┃ ┃ ┃ Creat… ┃ At ┃ At ┃ ┃ ID ┃ Name ┃ Infra ┃ Type ┃ Status ┃ Descr… ┃ At ┃ (BI) ┃ (ExpA… ┃ ┡━━━━━━━━╇━━━━━━━━╇━━━━━━━━╇━━━━━━╇━━━━━━━━╇━━━━━━━━╇━━━━━━━━╇━━━━━━━━╇━━━━━━━━┩ │ r_gr-… │ tst │ gr-vo… │ │ up │ │ 2026-… │ 2026-… │ MISSI… │ │ │ │ │ │ │ │ 16:09 │ 19:11 │ │ │ │ │ │ │ │ │ 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-03-01T15:11:42+00:00.txt 2026-03-01 16:11:42.519449 CET - Error in test step 'Check extend expire': "slices bi extend" failed 2026-03-01 16:11:42.519470 CET - Testing ssh login 2026-03-01 16:11:42.529104 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-1f832dbc tst 2026-03-01 16:11:43.425737 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-1f832dbc tst 2026-03-01 16:11:44.317437 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-1f832dbc tst 2026-03-01 16:11:45.214296 CET - Logging in using 'slices bi ssh' 2026-03-01 16:11:45.214348 CET - Forcing IPv4 only. 2026-03-01 16:11:45.214482 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-1f832dbc tst -- -4 uname -a 2026-03-01 16:11:46.320422 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/631d52f5-6c53-487f-852f-ea4304333461/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-1f832dbc tst -- -4 uname -a 2026-03-01 16:11:46.320494 CET - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/631d52f5-6c53-487f-852f-ea4304333461/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-01 16:11:46.320511 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-1f832dbc', 'tst', '--', '-4', 'uname', '-a'] 2026-03-01 16:11:46.320636 CET - Run: ssh-keygen -F 10.64.45.193 2026-03-01 16:11:46.324091 CET - Run: ssh-keygen -F 10.64.45.193:22 2026-03-01 16:11:46.327149 CET - Run: ssh-keygen -F 194.177.207.42 2026-03-01 16:11:46.330050 CET - Run: ssh-keygen -F 194.177.207.42:11122 2026-03-01 16:11:46.332889 CET - Logging in using SSH over SSH proxy 2026-03-01 16:11:46.333041 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-1f832dbc tst 2026-03-01 16:11:47.236878 CET - Added paramiko HostKeyEntry for 10.64.45.193 2026-03-01 16:11:47.236971 CET - Added paramiko HostKeyEntry for 10.64.45.193 2026-03-01 16:11:47.237103 CET - Added paramiko HostKeyEntry for 10.64.45.193 2026-03-01 16:11:47.237341 CET - Added paramiko HostKeyEntry for 194.177.207.42 2026-03-01 16:11:47.237356 CET - Connecting to proxy 194.177.207.42:22 2026-03-01 16:11:49.241420 CET - Error in test step 'Ssh login (with proxy)': timed out 2026-03-01 16:11:49.241471 CET - Wait 5s before retry 2026-03-01 16:11:54.241815 CET - Added paramiko HostKeyEntry for 10.64.45.193 2026-03-01 16:11:54.241904 CET - Added paramiko HostKeyEntry for 10.64.45.193 2026-03-01 16:11:54.242025 CET - Added paramiko HostKeyEntry for 10.64.45.193 2026-03-01 16:11:54.242314 CET - Added paramiko HostKeyEntry for 194.177.207.42 2026-03-01 16:11:54.242331 CET - Connecting to proxy 194.177.207.42:22 2026-03-01 16:11:56.245527 CET - Error in test step 'Ssh login (with proxy) (Retry 1)': timed out 2026-03-01 16:11:56.252269 CET - Destroying tst-1f832dbc tst 2026-03-01 16:11:56.252463 CET - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-1f832dbc tst