Run Test: slices-bi-singlenode-login 2026-06-14 17:59:30.699638 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmpbe9v51zo.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-14 17:59:35.927002 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/fe97aaea-de82-4257-ba33-97ce236c1baa/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-14 17:59:44.012700 CEST - Run: slices --version 2026-06-14 17:59:44.227423 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-14 17:59:44.227735 CEST - Run: slices pubkey list --format text 2026-06-14 17:59:44.793004 CEST - Pubkey already registered 2026-06-14 17:59:44.793218 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-14 17:59:45.408886 CEST - Refreshed infrastructure list. Total: 23 entries. 2026-06-14 17:59:45.409038 CEST - Check List Flavors 2026-06-14 17:59:45.410030 CEST - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-06-14 17:59:46.026741 CEST - Check List DiskImages 2026-06-14 17:59:46.027673 CEST - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-06-14 17:59:46.593555 CEST - Requesting resources 2026-06-14 17:59:46.593952 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-06-14 17:59:46.594065 CEST - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Debian 13.1' --flavor tiny --duration 2h --experiment tst-5bf5e2d0 --user-data /tmp/tmpf7le61mv 2026-06-14 17:59:48.262512 CEST - Resource ID: r_be-gent1-bi-vm1_01kv3drmcxe12bksptvgda9whr 2026-06-14 17:59:48.262643 CEST - Waiting until resource ready 2026-06-14 17:59:50.263065 CEST - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-5bf5e2d0 tst 2026-06-14 17:59:50.978907 CEST - Status: IMAGING 2026-06-14 17:59:53.745467 CEST - Status: IMAGING 2026-06-14 17:59:56.411438 CEST - Status: IMAGING 2026-06-14 17:59:59.127767 CEST - Status: IMAGING 2026-06-14 18:00:01.844299 CEST - Status: IMAGING 2026-06-14 18:00:04.560621 CEST - Status: BOOTING 2026-06-14 18:00:07.277370 CEST - Status: BOOTING 2026-06-14 18:00:10.094065 CEST - Status: BOOTING 2026-06-14 18:00:12.860356 CEST - Status: BOOTING 2026-06-14 18:00:15.727478 CEST - Status: UP 2026-06-14 18:00:15.727573 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kv3drkvdedja0h8hpvzsdh86 2026-06-14 18:00:15.727618 CEST - Validate resources 2026-06-14 18:00:16.443937 CEST - The fields of the created resource were validated. 2026-06-14 18:00:16.444024 CEST - Check if resources are registered in experiment 2026-06-14 18:00:16.444208 CEST - Run: slices experiment list-resources --format json tst-5bf5e2d0 2026-06-14 18:00:17.109976 CEST - Status (on expauth): BOOTING 2026-06-14 18:00:19.725854 CEST - Status (on expauth): BOOTING 2026-06-14 18:00:22.341702 CEST - Status (on expauth): UP 2026-06-14 18:00:22.341783 CEST - "slices experiment list-resources" was not ready immediately. 2026-06-14 18:00:22.341819 CEST - It was ready after: 5.897704 seconds. (Note: used wait steps of 2s) 2026-06-14 18:00:22.341918 CEST - Testing extend expires_at (all resources in experiment) 2026-06-14 18:00:22.342044 CEST - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-5bf5e2d0 2026-06-14 18:00:24.511561 CEST - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-5bf5e2d0 tst 2026-06-14 18:00:25.227636 CEST - Run: slices experiment list-resources --format json tst-5bf5e2d0 2026-06-14 18:00:25.843263 CEST - expires_at (on expauth): 2026-06-14T19:00:00Z (correctly extended) 2026-06-14 18:00:25.843343 CEST - Testing extend expires_at (single resource in experiment) 2026-06-14 18:00:25.843512 CEST - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-5bf5e2d0 2026-06-14 18:00:27.461784 CEST - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-5bf5e2d0 tst 2026-06-14 18:00:28.177934 CEST - Run: slices experiment list-resources --format json tst-5bf5e2d0 2026-06-14 18:00:28.843614 CEST - expires_at (on expauth): 2026-06-14T20:00:00Z (correctly extended) 2026-06-14 18:00:28.843728 CEST - Testing ssh login 2026-06-14 18:00:28.856505 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-5bf5e2d0 tst 2026-06-14 18:00:29.572483 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-5bf5e2d0 tst 2026-06-14 18:00:30.288297 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-5bf5e2d0 tst 2026-06-14 18:00:31.003961 CEST - Logging in using 'slices bi ssh' 2026-06-14 18:00:31.004026 CEST - Forcing IPv4 only. 2026-06-14 18:00:31.004154 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-5bf5e2d0 tst -- -4 uname -a 2026-06-14 18:00:31.970530 CEST - Forcing IPv4 only. 2026-06-14 18:00:31.970696 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-5bf5e2d0 tst -- -4 uptime 2026-06-14 18:00:32.736386 CEST - CLI SSH Test passed. 2026-06-14 18:00:32.736441 CEST - Uname: Linux tst 6.12.48+deb13-cloud-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.48-1 (2025-09-20) x86_64 GNU/Linux 2026-06-14 18:00:32.736456 CEST - Uptime: 18:00:31 up 0 min, 1 user, load average: 0.00, 0.00, 0.00 2026-06-14 18:00:32.736485 CEST - Logging in using SSH (extra test: ignore SSH proxy) 2026-06-14 18:00:32.736926 CEST - Added paramiko HostKeyEntry for 10.10.214.233 2026-06-14 18:00:32.737093 CEST - Added paramiko HostKeyEntry for 10.10.214.233 2026-06-14 18:00:32.737144 CEST - Added paramiko HostKeyEntry for 10.10.214.233 2026-06-14 18:00:32.737294 CEST - Connecting to 10.10.214.233:22 2026-06-14 18:00:32.954996 CEST - SSH Test output: 2026-06-14 18:00:32.955049 CEST - Uname: Linux tst 6.12.48+deb13-cloud-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.48-1 (2025-09-20) x86_64 GNU/Linux 2026-06-14 18:00:32.955063 CEST - Uptime: 18:00:31 up 0 min, 1 user, load average: 0.00, 0.00, 0.00 2026-06-14 18:00:33.003413 CEST - lsb_release: Debian GNU/Linux 13 (trixie) 2026-06-14 18:00:33.051081 CEST - /etc/debian_version: 13.1 2026-06-14 18:00:33.051136 CEST - lsb_release matches expected value 2026-06-14 18:00:33.051150 CEST - /etc/debian_version matches expected value 2026-06-14 18:00:33.051160 CEST - SSH Test passed. 2026-06-14 18:00:33.095213 CEST - Cloud-init user-data: Hello World. The time is now Sun, 14 Jun 2026 18:00:13 +0200! 2026-06-14 18:00:33.095331 CEST - Logging in using SSH over SSH proxy 2026-06-14 18:00:33.095491 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-5bf5e2d0 tst 2026-06-14 18:00:33.811434 CEST - Added paramiko HostKeyEntry for 10.10.214.233 2026-06-14 18:00:33.811586 CEST - Added paramiko HostKeyEntry for 10.10.214.233 2026-06-14 18:00:33.811635 CEST - Added paramiko HostKeyEntry for 10.10.214.233 2026-06-14 18:00:33.811887 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-14 18:00:33.811934 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-14 18:00:33.812028 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-14 18:00:33.812043 CEST - Connecting to proxy bastion2.slices-be.eu:22 2026-06-14 18:00:34.169044 CEST - Connecting to 10.10.214.233:22 over proxy 2026-06-14 18:00:34.797782 CEST - SSH Test output: 2026-06-14 18:00:34.797833 CEST - Uname: Linux tst 6.12.48+deb13-cloud-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.48-1 (2025-09-20) x86_64 GNU/Linux 2026-06-14 18:00:34.797850 CEST - Uptime: 18:00:33 up 0 min, 2 users, load average: 0.00, 0.00, 0.00 2026-06-14 18:00:34.854685 CEST - lsb_release: Debian GNU/Linux 13 (trixie) 2026-06-14 18:00:34.902300 CEST - /etc/debian_version: 13.1 2026-06-14 18:00:34.902352 CEST - lsb_release matches expected value 2026-06-14 18:00:34.902365 CEST - /etc/debian_version matches expected value 2026-06-14 18:00:34.902374 CEST - SSH Test passed. 2026-06-14 18:00:34.907048 CEST - Cloud-init user-data: Hello World. The time is now Sun, 14 Jun 2026 18:00:13 +0200! 2026-06-14 18:00:34.913975 CEST - Destroying tst-5bf5e2d0 tst 2026-06-14 18:00:34.914146 CEST - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-5bf5e2d0 tst