Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.42s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 209ms 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 461ms + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + cffi==2.1.1 + cryptography==50.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.3 + 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.3.post1 + pyyaml==6.0.3 + slices-clientlib-bi==5.1.2 + slices-clientlib-core==5.6.0 + slices-monitor-test-runner==0.1.dev192+gcac2d3fe6 (from file:///app) + tomli-w==1.2.0 + tomlkit==0.15.1 + typing-extensions==4.16.0 + typing-inspection==0.4.3 Run Test: slices-bi-singlenode-login 2026-08-10 13:29:26.249559 UTC - Installing Slices CLI (latest, with --pre). 2026-08-10 13:29:26.249777 UTC - Run: /usr/local/bin/uv pip install --pre --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-10 13:29:33.080336 UTC - Slices CLI installed. 2026-08-10 13:29:33.080985 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-08-10 13:29:33.082553 UTC - ls -a /root/ /scripts/ (error 2): None ls: cannot access '/scripts/': No such file or directory /root/: . .. .cache .local .slices run_test_runner.sh slices-cli-venv 2026-08-10 13:29:33.082644 UTC - env: {'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-08-10 13:29:33.082744 UTC - which slices: /app/.venv/bin/slices 2026-08-10 13:29:33.082781 UTC - Slices CLI exe: 'slices' 2026-08-10 13:29:33.082806 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-10 13:29:33.083029 UTC - Run: slices --version 2026-08-10 13:29:35.956763 UTC - version: Slices CLI v2026.2.0b6 Slices CLI core v1.2.6 Slices CLI ai v1.1.0 Slices CLI bi v2.2.1 Slices clientlib bi v6.1.1 Slices clientlib core v5.6.0 Slices clientlib ai v1.0.0 2026-08-10 13:29:35.957189 UTC - Run: slices pubkey list --format text 2026-08-10 13:29:36.672832 UTC - Pubkey already registered 2026-08-10 13:29:36.673113 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-10 13:29:37.288536 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-10 13:29:37.288634 UTC - Check List Flavors 2026-08-10 13:29:37.288853 UTC - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-08-10 13:29:38.004634 UTC - Check List DiskImages 2026-08-10 13:29:38.004859 UTC - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-08-10 13:29:38.670260 UTC - Requesting resources 2026-08-10 13:29:38.670765 UTC - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-717e2307 2026-08-10 13:29:39.686953 UTC - Resource ID: r_be-gent1-bi-vm1_01kznxtnyjf3p80bmqr9gynybd 2026-08-10 13:29:39.687157 UTC - Waiting until resource ready 2026-08-10 13:29:41.687590 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-717e2307 tst 2026-08-10 13:29:42.403328 UTC - Status: IMAGING 2026-08-10 13:29:45.119519 UTC - Status: IMAGING 2026-08-10 13:29:47.986590 UTC - Status: IMAGING 2026-08-10 13:29:50.702743 UTC - Status: BOOTING 2026-08-10 13:29:53.469275 UTC - Status: BOOTING 2026-08-10 13:29:56.185464 UTC - Status: BOOTING 2026-08-10 13:29:58.901664 UTC - Status: BOOTING 2026-08-10 13:30:01.668273 UTC - Status: BOOTING 2026-08-10 13:30:04.434943 UTC - Status: UP 2026-08-10 13:30:04.435051 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kznxtnqte05szwvegjn9z0mm 2026-08-10 13:30:04.435101 UTC - Validate resources 2026-08-10 13:30:05.252006 UTC - The fields of the created resource were validated. 2026-08-10 13:30:05.252141 UTC - Check if resources are registered in experiment 2026-08-10 13:30:05.252336 UTC - Run: slices experiment list-resources --format json tst-717e2307 2026-08-10 13:30:05.918265 UTC - Status (on expauth): INITIALIZING 2026-08-10 13:30:08.585176 UTC - Status (on expauth): INITIALIZING 2026-08-10 13:30:11.251360 UTC - Status (on expauth): INITIALIZING 2026-08-10 13:30:13.917263 UTC - Status (on expauth): INITIALIZING 2026-08-10 13:30:16.633569 UTC - Status (on expauth): UP 2026-08-10 13:30:16.633662 UTC - "slices experiment list-resources" was not ready immediately. 2026-08-10 13:30:16.633705 UTC - It was ready after: 11.381458 seconds. (Note: used wait steps of 2s) 2026-08-10 13:30:16.633789 UTC - Testing extend expires_at (all resources in experiment) 2026-08-10 13:30:16.633948 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-717e2307 2026-08-10 13:30:18.000784 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-717e2307 tst 2026-08-10 13:30:18.719763 UTC - Run: slices experiment list-resources --format json tst-717e2307 2026-08-10 13:30:19.387184 UTC - expires_at (on expauth): 2026-08-10T15:29:00Z (not yet extended) 2026-08-10 13:30:22.103936 UTC - expires_at (on expauth): 2026-08-10T15:29:00Z (not yet extended) 2026-08-10 13:30:24.770220 UTC - expires_at (on expauth): 2026-08-10T15:29:00Z (not yet extended) 2026-08-10 13:30:27.436162 UTC - expires_at (on expauth): 2026-08-10T15:29:00Z (not yet extended) 2026-08-10 13:30:30.102010 UTC - expires_at (on expauth): 2026-08-10T16:30:00Z (correctly extended) 2026-08-10 13:30:30.102123 UTC - "slices experiment list-resources" was not updated immediately after extend expires_at. 2026-08-10 13:30:30.102150 UTC - It was updated after: 11.382471 seconds. (Note: used wait steps of 2s) 2026-08-10 13:30:30.102189 UTC - Testing extend expires_at (single resource in experiment) 2026-08-10 13:30:30.102380 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-717e2307 2026-08-10 13:30:31.572603 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-717e2307 tst 2026-08-10 13:30:32.338903 UTC - Run: slices experiment list-resources --format json tst-717e2307 2026-08-10 13:30:33.005146 UTC - expires_at (on expauth): 2026-08-10T17:30:00Z (correctly extended) 2026-08-10 13:30:33.005327 UTC - Testing ssh login 2026-08-10 13:30:33.020606 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-717e2307 tst 2026-08-10 13:30:33.837819 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-717e2307 tst 2026-08-10 13:30:34.654298 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-717e2307 tst 2026-08-10 13:30:35.470291 UTC - Logging in using 'slices bi ssh' 2026-08-10 13:30:35.470367 UTC - Forcing IPv4 only. 2026-08-10 13:30:35.470492 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-717e2307 tst -- -4 uname -a 2026-08-10 13:30:36.887918 UTC - Forcing IPv4 only. 2026-08-10 13:30:36.888145 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-717e2307 tst -- -4 uptime 2026-08-10 13:30:37.804013 UTC - CLI SSH Test passed. 2026-08-10 13:30:37.804111 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-08-10 13:30:37.804132 UTC - Uptime: 15:30:37 up 0 min, 1 user, load average: 0.04, 0.01, 0.00 2026-08-10 13:30:37.804165 UTC - Logging in using SSH (extra test: ignore SSH proxy) 2026-08-10 13:30:37.804596 UTC - Added paramiko HostKeyEntry for 10.10.214.72 2026-08-10 13:30:37.804793 UTC - Added paramiko HostKeyEntry for 10.10.214.72 2026-08-10 13:30:37.804856 UTC - Added paramiko HostKeyEntry for 10.10.214.72 2026-08-10 13:30:37.805056 UTC - Connecting to 10.10.214.72:22 2026-08-10 13:30:38.039042 UTC - SSH Test output: 2026-08-10 13:30:38.039132 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-08-10 13:30:38.039157 UTC - Uptime: 15:30:37 up 0 min, 1 user, load average: 0.04, 0.01, 0.00 2026-08-10 13:30:38.088880 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-10 13:30:38.088985 UTC - lsb_release matches expected value 2026-08-10 13:30:38.089020 UTC - SSH Test passed. 2026-08-10 13:30:38.089122 UTC - Logging in using SSH over SSH proxy 2026-08-10 13:30:38.089323 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-717e2307 tst 2026-08-10 13:30:38.906109 UTC - Added paramiko HostKeyEntry for 10.10.214.72 2026-08-10 13:30:38.906309 UTC - Added paramiko HostKeyEntry for 10.10.214.72 2026-08-10 13:30:38.906370 UTC - Added paramiko HostKeyEntry for 10.10.214.72 2026-08-10 13:30:38.906668 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-08-10 13:30:38.906728 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-08-10 13:30:38.906834 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-08-10 13:30:38.906855 UTC - Connecting to proxy bastion2.slices-be.eu:22 2026-08-10 13:30:39.201706 UTC - Connecting to 10.10.214.72:22 over proxy 2026-08-10 13:30:39.493408 UTC - SSH Test output: 2026-08-10 13:30:39.493508 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-08-10 13:30:39.493528 UTC - Uptime: 15:30:39 up 0 min, 2 users, load average: 0.04, 0.01, 0.00 2026-08-10 13:30:39.547614 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-10 13:30:39.547756 UTC - lsb_release matches expected value 2026-08-10 13:30:39.547798 UTC - SSH Test passed. 2026-08-10 13:30:39.556786 UTC - Destroying tst-717e2307 tst 2026-08-10 13:30:39.557046 UTC - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-717e2307 tst