Run Test: slices-bi-singlenode-login 2026-06-20 00:08:52.146051 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmprbty9xge.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-20 00:09:07.547852 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/d5b97791-f7ee-40e8-a66c-064c3c36daab/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-20 00:09:15.729048 CEST - Run: slices --version 2026-06-20 00:09:15.943353 CEST - version: Slices CLI v2026.1.2 Slices CLI core v1.2.4 Slices CLI ai v1.1.0 Slices CLI bi v2.2.0 Slices clientlib bi v6.1.1 Slices clientlib ai v1.0.0 Slices clientlib core v5.5.1 2026-06-20 00:09:15.943676 CEST - Run: slices pubkey list --format text 2026-06-20 00:09:16.508708 CEST - Pubkey already registered 2026-06-20 00:09:16.508978 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-20 00:09:17.074122 CEST - Refreshed infrastructure list. Total: 23 entries. 2026-06-20 00:09:17.074260 CEST - Check List Flavors 2026-06-20 00:09:17.074446 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 flavor list -f json 2026-06-20 00:09:17.639693 CEST - Check List DiskImages 2026-06-20 00:09:17.639883 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 diskimage list -f json 2026-06-20 00:09:18.205144 CEST - Requesting resources 2026-06-20 00:09:18.205477 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-06-20 00:09:18.205605 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 create tst --image 'Ubuntu 22.04.5' --flavor pc --duration 2h --experiment tst-97e9bb90 --user-data /tmp/tmp5cuenop7 2026-06-20 00:09:19.923060 CEST - Resource ID: r_be-gent1-bi-baremetal1_01kvgywvddfg0the9vnb1ns1ym 2026-06-20 00:09:19.923216 CEST - Waiting until resource ready 2026-06-20 00:09:21.923591 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-97e9bb90 tst 2026-06-20 00:09:22.589140 CEST - Status: IMAGING 2026-06-20 00:09:25.305014 CEST - Status: IMAGING 2026-06-20 00:09:27.970582 CEST - Status: IMAGING 2026-06-20 00:09:30.636649 CEST - Status: IMAGING 2026-06-20 00:09:33.352404 CEST - Status: IMAGING 2026-06-20 00:09:36.068297 CEST - Status: IMAGING 2026-06-20 00:09:38.784250 CEST - Status: IMAGING 2026-06-20 00:09:41.500074 CEST - Status: IMAGING 2026-06-20 00:09:44.216005 CEST - Status: IMAGING 2026-06-20 00:09:48.335207 CEST - Status: IMAGING 2026-06-20 00:09:52.954217 CEST - Status: IMAGING 2026-06-20 00:09:58.276829 CEST - Status: IMAGING 2026-06-20 00:10:02.797682 CEST - Status: IMAGING 2026-06-20 00:10:07.723101 CEST - Status: IMAGING 2026-06-20 00:10:12.743899 CEST - Status: IMAGING 2026-06-20 00:10:17.614104 CEST - Status: IMAGING 2026-06-20 00:10:22.684896 CEST - Status: IMAGING 2026-06-20 00:10:28.513418 CEST - Status: IMAGING 2026-06-20 00:10:33.192190 CEST - Status: IMAGING 2026-06-20 00:10:37.711457 CEST - Status: IMAGING 2026-06-20 00:10:42.330707 CEST - Status: IMAGING 2026-06-20 00:10:46.850552 CEST - Status: IMAGING 2026-06-20 00:10:51.370297 CEST - Status: IMAGING 2026-06-20 00:10:54.737751 CEST - Status: IMAGING 2026-06-20 00:10:57.453620 CEST - Status: IMAGING 2026-06-20 00:11:00.169436 CEST - Status: IMAGING 2026-06-20 00:11:02.935713 CEST - Status: IMAGING 2026-06-20 00:11:05.651568 CEST - Status: IMAGING 2026-06-20 00:11:08.417608 CEST - Status: IMAGING 2026-06-20 00:11:11.183778 CEST - Status: IMAGING 2026-06-20 00:11:13.900549 CEST - Status: IMAGING 2026-06-20 00:11:16.616587 CEST - Status: IMAGING 2026-06-20 00:11:19.332428 CEST - Status: IMAGING 2026-06-20 00:11:22.098453 CEST - Status: IMAGING 2026-06-20 00:11:24.914643 CEST - Status: IMAGING 2026-06-20 00:11:27.680973 CEST - Status: IMAGING 2026-06-20 00:11:30.547409 CEST - Status: IMAGING 2026-06-20 00:11:33.263473 CEST - Status: IMAGING 2026-06-20 00:11:36.029537 CEST - Status: IMAGING 2026-06-20 00:11:38.745422 CEST - Status: IMAGING 2026-06-20 00:11:41.511649 CEST - Status: IMAGING 2026-06-20 00:11:44.227706 CEST - Status: IMAGING 2026-06-20 00:11:46.994196 CEST - Status: IMAGING 2026-06-20 00:11:49.710306 CEST - Status: IMAGING 2026-06-20 00:11:52.426804 CEST - Status: IMAGING 2026-06-20 00:11:55.142778 CEST - Status: IMAGING 2026-06-20 00:11:57.858706 CEST - Status: IMAGING 2026-06-20 00:12:00.574604 CEST - Status: IMAGING 2026-06-20 00:12:03.290673 CEST - Status: IMAGING 2026-06-20 00:12:06.006537 CEST - Status: IMAGING 2026-06-20 00:12:08.772565 CEST - Status: IMAGING 2026-06-20 00:12:11.538991 CEST - Status: IMAGING 2026-06-20 00:12:14.304966 CEST - Status: IMAGING 2026-06-20 00:12:17.020827 CEST - Status: STARTING 2026-06-20 00:12:19.736676 CEST - Status: STARTING 2026-06-20 00:12:22.452574 CEST - Status: STARTING 2026-06-20 00:12:25.168540 CEST - Status: STARTING 2026-06-20 00:12:27.884563 CEST - Status: UP 2026-06-20 00:12:27.884642 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kvgywtt3egzb7v3nxe9v48sp 2026-06-20 00:12:27.884679 CEST - Validate resources 2026-06-20 00:12:28.600525 CEST - The fields of the created resource were validated. 2026-06-20 00:12:28.600610 CEST - Check if resources are registered in experiment 2026-06-20 00:12:28.600789 CEST - Run: slices experiment list-resources --format json tst-97e9bb90 2026-06-20 00:12:29.216223 CEST - Status (on expauth): UP 2026-06-20 00:12:29.216378 CEST - Testing extend expires_at (all resources in experiment) 2026-06-20 00:12:29.216530 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 extend --duration 3h --experiment tst-97e9bb90 2026-06-20 00:12:34.994463 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-97e9bb90 tst 2026-06-20 00:12:35.710289 CEST - Run: slices experiment list-resources --format json tst-97e9bb90 2026-06-20 00:12:36.325625 CEST - expires_at (on expauth): 2026-06-20T01:12:00Z (correctly extended) 2026-06-20 00:12:36.325715 CEST - Testing extend expires_at (single resource in experiment) 2026-06-20 00:12:36.325857 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 extend tst --duration 4h --experiment tst-97e9bb90 2026-06-20 00:12:40.299444 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-97e9bb90 tst 2026-06-20 00:12:41.065656 CEST - Run: slices experiment list-resources --format json tst-97e9bb90 2026-06-20 00:12:41.680900 CEST - expires_at (on expauth): 2026-06-20T02:12:00Z (correctly extended) 2026-06-20 00:12:41.681023 CEST - Testing ssh login 2026-06-20 00:12:41.690946 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-97e9bb90 tst 2026-06-20 00:12:42.356242 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-97e9bb90 tst 2026-06-20 00:12:43.071874 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-97e9bb90 tst 2026-06-20 00:12:43.737435 CEST - Logging in using 'slices bi ssh' 2026-06-20 00:12:43.737518 CEST - Forcing IPv4 only. 2026-06-20 00:12:43.737651 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-97e9bb90 tst -- -4 uname -a 2026-06-20 00:12:44.603449 CEST - Forcing IPv4 only. 2026-06-20 00:12:44.603650 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-97e9bb90 tst -- -4 uptime 2026-06-20 00:12:45.470340 CEST - CLI SSH Test passed. 2026-06-20 00:12:45.470415 CEST - Uname: Linux tst.hxuavl.fed4fire-eu.wall1.ilabt.imec.be 5.15.0-122-generic #132-Ubuntu SMP Thu Aug 29 13:45:52 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux 2026-06-20 00:12:45.470442 CEST - Uptime: 00:12:45 up 1 min, 0 users, load average: 0.12, 0.05, 0.02 2026-06-20 00:12:45.470471 CEST - Logging in using 'slices bi ssh' 2026-06-20 00:12:45.470531 CEST - Forcing IPv6 only. 2026-06-20 00:12:45.470649 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-97e9bb90 tst -- -6 uname -a 2026-06-20 00:12:46.286365 CEST - Forcing IPv6 only. 2026-06-20 00:12:46.286582 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-97e9bb90 tst -- -6 uptime 2026-06-20 00:12:47.102248 CEST - CLI SSH Test passed. 2026-06-20 00:12:47.102321 CEST - Uname: Linux tst.hxuavl.fed4fire-eu.wall1.ilabt.imec.be 5.15.0-122-generic #132-Ubuntu SMP Thu Aug 29 13:45:52 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux 2026-06-20 00:12:47.102339 CEST - Uptime: 00:12:47 up 1 min, 0 users, load average: 0.12, 0.05, 0.02 2026-06-20 00:12:47.102373 CEST - Logging in using SSH (extra test: ignore SSH proxy) 2026-06-20 00:12:47.102790 CEST - Added paramiko HostKeyEntry for n079-16.wall1.ilabt.imec.be 2026-06-20 00:12:47.102978 CEST - Added paramiko HostKeyEntry for n079-16.wall1.ilabt.imec.be 2026-06-20 00:12:47.103046 CEST - Added paramiko HostKeyEntry for n079-16.wall1.ilabt.imec.be 2026-06-20 00:12:47.103195 CEST - Connecting to n079-16.wall1.ilabt.imec.be:22 2026-06-20 00:12:47.407025 CEST - SSH Test output: 2026-06-20 00:12:47.407093 CEST - Uname: Linux tst.hxuavl.fed4fire-eu.wall1.ilabt.imec.be 5.15.0-122-generic #132-Ubuntu SMP Thu Aug 29 13:45:52 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux 2026-06-20 00:12:47.407111 CEST - Uptime: 00:12:47 up 1 min, 0 users, load average: 0.12, 0.05, 0.02 2026-06-20 00:12:47.510381 CEST - lsb_release: Ubuntu 22.04.5 LTS 2026-06-20 00:12:47.510453 CEST - lsb_release matches expected value 2026-06-20 00:12:47.510470 CEST - SSH Test passed. 2026-06-20 00:12:47.513973 CEST - Cloud-init user-data: Hello World. The time is now Sat, 20 Jun 2026 00:12:15 +0200! 2026-06-20 00:12:47.514065 CEST - Logging in using SSH over SSH proxy 2026-06-20 00:12:47.514197 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-97e9bb90 tst 2026-06-20 00:12:48.229772 CEST - Added paramiko HostKeyEntry for n079-16.wall1.ilabt.imec.be 2026-06-20 00:12:48.229924 CEST - Added paramiko HostKeyEntry for n079-16.wall1.ilabt.imec.be 2026-06-20 00:12:48.229975 CEST - Added paramiko HostKeyEntry for n079-16.wall1.ilabt.imec.be 2026-06-20 00:12:48.230189 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-20 00:12:48.230236 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-20 00:12:48.230334 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-20 00:12:48.230351 CEST - Connecting to proxy bastion2.slices-be.eu:22 2026-06-20 00:12:48.475953 CEST - Connecting to n079-16.wall1.ilabt.imec.be:22 over proxy 2026-06-20 00:12:48.763153 CEST - SSH Test output: 2026-06-20 00:12:48.763224 CEST - Uname: Linux tst.hxuavl.fed4fire-eu.wall1.ilabt.imec.be 5.15.0-122-generic #132-Ubuntu SMP Thu Aug 29 13:45:52 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux 2026-06-20 00:12:48.763244 CEST - Uptime: 00:12:48 up 1 min, 0 users, load average: 0.11, 0.05, 0.02 2026-06-20 00:12:48.832055 CEST - lsb_release: Ubuntu 22.04.5 LTS 2026-06-20 00:12:48.832128 CEST - lsb_release matches expected value 2026-06-20 00:12:48.832145 CEST - SSH Test passed. 2026-06-20 00:12:48.877171 CEST - Cloud-init user-data: Hello World. The time is now Sat, 20 Jun 2026 00:12:15 +0200! 2026-06-20 00:12:48.883503 CEST - Testing ping connectivity 2026-06-20 00:12:48.883661 CEST - Run: ping -n -w 10 -W 2 -c 5 -i 0.2 10.2.64.225 2026-06-20 00:12:49.749410 CEST - Destroying tst-97e9bb90 tst 2026-06-20 00:12:49.749762 CEST - Run: slices bi --infra be-gent1-bi-baremetal1 destroy --experiment tst-97e9bb90 tst 2026-06-20 00:13:49.759426 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/d5b97791-f7ee-40e8-a66c-064c3c36daab/step_Destroy_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra be-gent1-bi-baremetal1 destroy --experiment tst-97e9bb90 tst 2026-06-20 00:13:49.759609 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/d5b97791-f7ee-40e8-a66c-064c3c36daab/destroy.txt': 10.0% / task starting 10.0% - task starting 30.0% \ task starting 30.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting 60.0% - task starting 60.0% \ task starting 60.0% | task starting 60.0% / task starting ***Terminating process due to timeout*** ***Process terminated*** 2026-06-20 00:13:49.759673 CEST - Error in test step 'Destroy': "slices bi destroy" failed (return value is -15) 2026-06-20 00:13:49.759718 CEST - Step 'Destroy' took 60.01 seconds, which is longer than the warning threshold of 15 seconds