Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.36s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 175ms warning: Failed to hardlink files; falling back to full copy. This may lead to degraded performance. If the cache and target directories are on different filesystems, hardlinking may not be supported. If this is intentional, set `export UV_LINK_MODE=copy` or use `--link-mode=copy` to suppress this warning. Installed 32 packages in 625ms + annotated-types==0.7.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.6.17 + cffi==2.1.0 + cryptography==49.0.0 + dnspython==2.8.0 + h11==0.16.0 + httpcore==1.0.9 + httpx==0.28.1 + httpx-oauth==0.17.0 + idna==3.18 + invoke==3.0.3 + joserfc==1.7.4 + msgspec==0.21.1 + packaging==26.2 + paramiko==4.0.0 + pycparser==3.0 + pydantic==2.13.4 + pydantic-core==2.46.4 + pyjwt==2.13.0 + pynacl==1.6.2 + pytz==2026.2 + pyyaml==6.0.3 + slices-clientlib-bi==5.1.2 + slices-clientlib-core==5.6.0 + slices-monitor-test-runner==0.1.dev187+g005dd054e (from file:///app) + tomli-w==1.2.0 + tomlkit==0.15.1 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-20 20:15:15.607171 UTC - Installing Slices CLI (latest stable version). 2026-07-20 20:15:15.607378 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-20 20:15:21.185564 UTC - Slices CLI installed. 2026-07-20 20:15:21.185812 UTC - PATH: {'PATH': '/app/.venv/bin:/usr/local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/root/.local/bin/:/root/slices-cli-venv/bin', 'COLUMNS': '200'} 2026-07-20 20:15:21.187060 UTC - ls -a /root/ /scripts/ (error 2): None b"ls: cannot access '/scripts/': No such file or directory\n/root/:\n.\n..\n.cache\n.local\n.slices\nrun_test_runner.sh\nslices-cli-venv\n" 2026-07-20 20:15:21.187892 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-20 20:15:21.188025 UTC - OS release: PRETTY_NAME="Debian GNU/Linux 13 (trixie)" NAME="Debian GNU/Linux" VERSION_ID="13" VERSION="13 (trixie)" VERSION_CODENAME=trixie DEBIAN_VERSION_FULL=13.5 ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" 2026-07-20 20:15:21.188054 UTC - Slices CLI exe: 'slices' 2026-07-20 20:15:21.188073 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-20 20:15:21.188223 UTC - Run: slices --version 2026-07-20 20:15:23.808239 UTC - 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-07-20 20:15:23.808618 UTC - Run: slices pubkey list --format text 2026-07-20 20:15:24.774965 UTC - Pubkey already registered 2026-07-20 20:15:24.775304 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-20 20:15:25.440813 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-20 20:15:25.440946 UTC - Check List Flavors 2026-07-20 20:15:25.441135 UTC - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-07-20 20:15:27.119666 UTC - Check List DiskImages 2026-07-20 20:15:27.119870 UTC - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-07-20 20:15:27.861418 UTC - Requesting resources 2026-07-20 20:15:27.861902 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-20 20:15:27.862024 UTC - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-d2c605fa --user-data /tmp/tmp6b1bz6o1 2026-07-20 20:15:31.887603 UTC - Resource ID: r_be-gent1-bi-vm1_01ky0jpr9vebhrs918t35zc2gy 2026-07-20 20:15:31.888172 UTC - Waiting until resource ready 2026-07-20 20:15:33.888790 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-d2c605fa tst 2026-07-20 20:15:36.742561 UTC - Status: IMAGING 2026-07-20 20:15:40.128517 UTC - Status: IMAGING 2026-07-20 20:15:43.528591 UTC - Status: BOOTING 2026-07-20 20:15:46.731448 UTC - Status: BOOTING 2026-07-20 20:15:49.548945 UTC - Status: BOOTING 2026-07-20 20:15:52.314964 UTC - Status: BOOTING 2026-07-20 20:15:55.364404 UTC - Status: INITIALIZING 2026-07-20 20:15:58.763326 UTC - Status: UP 2026-07-20 20:15:58.763396 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01ky0jpq8femqb7tw15v1qq0ng 2026-07-20 20:15:58.763438 UTC - Validate resources 2026-07-20 20:16:00.157939 UTC - The fields of the created resource were validated. 2026-07-20 20:16:00.158033 UTC - Check if resources are registered in experiment 2026-07-20 20:16:00.158177 UTC - Run: slices experiment list-resources --format json tst-d2c605fa 2026-07-20 20:16:01.232429 UTC - Status (on expauth): UP 2026-07-20 20:16:01.232597 UTC - Testing extend expires_at (all resources in experiment) 2026-07-20 20:16:01.232740 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-d2c605fa 2026-07-20 20:16:05.164908 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-d2c605fa tst 2026-07-20 20:16:06.461223 UTC - Run: slices experiment list-resources --format json tst-d2c605fa 2026-07-20 20:16:07.813171 UTC - expires_at (on expauth): 2026-07-20T23:16:00Z (correctly extended) 2026-07-20 20:16:07.813442 UTC - Testing extend expires_at (single resource in experiment) 2026-07-20 20:16:07.813621 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-d2c605fa 2026-07-20 20:16:11.657607 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-d2c605fa tst 2026-07-20 20:16:12.794791 UTC - Run: slices experiment list-resources --format json tst-d2c605fa 2026-07-20 20:16:13.857471 UTC - expires_at (on expauth): 2026-07-21T00:16:00Z (correctly extended) 2026-07-20 20:16:13.858018 UTC - Testing ssh login 2026-07-20 20:16:13.893341 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d2c605fa tst 2026-07-20 20:16:15.446590 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d2c605fa tst 2026-07-20 20:16:16.731430 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-d2c605fa tst 2026-07-20 20:16:18.071503 UTC - Logging in using 'slices bi ssh' 2026-07-20 20:16:18.071795 UTC - Forcing IPv4 only. 2026-07-20 20:16:18.072049 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-d2c605fa tst -- -4 uname -a 2026-07-20 20:16:19.644973 UTC - Forcing IPv4 only. 2026-07-20 20:16:19.645174 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-d2c605fa tst -- -4 uptime 2026-07-20 20:16:20.989153 UTC - CLI SSH Test passed. 2026-07-20 20:16:20.989222 UTC - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-07-20 20:16:20.989241 UTC - Uptime: 22:16:20 up 0 min, 1 user, load average: 0.05, 0.01, 0.00 2026-07-20 20:16:20.989272 UTC - Logging in using SSH (extra test: ignore SSH proxy) 2026-07-20 20:16:20.989765 UTC - Added paramiko HostKeyEntry for 10.10.221.236 2026-07-20 20:16:20.989960 UTC - Added paramiko HostKeyEntry for 10.10.221.236 2026-07-20 20:16:20.990020 UTC - Added paramiko HostKeyEntry for 10.10.221.236 2026-07-20 20:16:20.990189 UTC - Connecting to 10.10.221.236:22 2026-07-20 20:16:21.229762 UTC - SSH Test output: 2026-07-20 20:16:21.229827 UTC - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-07-20 20:16:21.229850 UTC - Uptime: 22:16:20 up 0 min, 1 user, load average: 0.05, 0.01, 0.00 2026-07-20 20:16:21.278859 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-20 20:16:21.278927 UTC - lsb_release matches expected value 2026-07-20 20:16:21.278947 UTC - SSH Test passed. 2026-07-20 20:16:21.322965 UTC - Cloud-init user-data: Hello World. The time is now Mon, 20 Jul 2026 22:15:55 +0200! 2026-07-20 20:16:21.323091 UTC - Logging in using SSH over SSH proxy 2026-07-20 20:16:21.323230 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-d2c605fa tst 2026-07-20 20:16:22.389969 UTC - Added paramiko HostKeyEntry for 10.10.221.236 2026-07-20 20:16:22.390119 UTC - Added paramiko HostKeyEntry for 10.10.221.236 2026-07-20 20:16:22.390174 UTC - Added paramiko HostKeyEntry for 10.10.221.236 2026-07-20 20:16:22.390394 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-20 20:16:22.390447 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-20 20:16:22.390560 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-20 20:16:22.390581 UTC - Connecting to proxy bastion2.slices-be.eu:22 2026-07-20 20:16:22.663327 UTC - Connecting to 10.10.221.236:22 over proxy 2026-07-20 20:16:22.908001 UTC - SSH Test output: 2026-07-20 20:16:22.908077 UTC - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-07-20 20:16:22.908097 UTC - Uptime: 22:16:22 up 0 min, 2 users, load average: 0.05, 0.01, 0.00 2026-07-20 20:16:22.959948 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-20 20:16:22.960039 UTC - lsb_release matches expected value 2026-07-20 20:16:22.960059 UTC - SSH Test passed. 2026-07-20 20:16:23.007650 UTC - Cloud-init user-data: Hello World. The time is now Mon, 20 Jul 2026 22:15:55 +0200! 2026-07-20 20:16:23.016383 UTC - Destroying tst-d2c605fa tst 2026-07-20 20:16:23.016749 UTC - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-d2c605fa tst