Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 3.86s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 200ms 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 616ms + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + 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.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.2 Run Test: slices-bi-singlenode-login 2026-07-30 04:55:55.868979 UTC - Installing Slices CLI (latest stable version). 2026-07-30 04:55:55.869329 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-30 04:56:02.881905 UTC - Slices CLI installed. 2026-07-30 04:56:02.884167 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-30 04:56:02.889490 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-07-30 04:56:02.889565 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-07-30 04:56:02.889637 UTC - which slices: /app/.venv/bin/slices 2026-07-30 04:56:02.889657 UTC - Slices CLI exe: 'slices' 2026-07-30 04:56:02.889674 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-30 04:56:02.889808 UTC - Run: slices --version 2026-07-30 04:56:06.241951 UTC - version: Slices CLI v2026.1.3 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-07-30 04:56:06.242248 UTC - Run: slices pubkey list --format text 2026-07-30 04:56:07.007730 UTC - Pubkey already registered 2026-07-30 04:56:07.007994 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-30 04:56:07.676363 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-30 04:56:07.676460 UTC - Check List Flavors 2026-07-30 04:56:07.676599 UTC - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-07-30 04:56:08.442512 UTC - Check List DiskImages 2026-07-30 04:56:08.442859 UTC - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-07-30 04:56:09.259709 UTC - Requesting resources 2026-07-30 04:56:09.260237 UTC - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Debian 13.1' --flavor tiny --duration 2h --experiment tst-45203838 2026-07-30 04:56:10.630906 UTC - Resource ID: r_be-gent1-bi-vm1_01kyrp2hx0e6xtysjjpqhw509t 2026-07-30 04:56:10.631081 UTC - Waiting until resource ready 2026-07-30 04:56:12.631557 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-45203838 tst 2026-07-30 04:56:13.447862 UTC - Status: IMAGING 2026-07-30 04:56:16.213819 UTC - Status: IMAGING 2026-07-30 04:56:18.936521 UTC - Status: IMAGING 2026-07-30 04:56:21.803036 UTC - Status: BOOTING 2026-07-30 04:56:24.571458 UTC - Status: BOOTING 2026-07-30 04:56:27.544875 UTC - Status: BOOTING 2026-07-30 04:56:30.363752 UTC - Status: BOOTING 2026-07-30 04:56:33.131955 UTC - Status: UP 2026-07-30 04:56:33.132225 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kyrp2hmrfd9td9g8jvykrvfr 2026-07-30 04:56:33.132332 UTC - Validate resources 2026-07-30 04:56:33.899493 UTC - The fields of the created resource were validated. 2026-07-30 04:56:33.899591 UTC - Check if resources are registered in experiment 2026-07-30 04:56:33.899739 UTC - Run: slices experiment list-resources --format json tst-45203838 2026-07-30 04:56:34.565785 UTC - Status (on expauth): UP 2026-07-30 04:56:34.565983 UTC - Testing extend expires_at (all resources in experiment) 2026-07-30 04:56:34.566143 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-45203838 2026-07-30 04:56:36.033151 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-45203838 tst 2026-07-30 04:56:36.957469 UTC - Run: slices experiment list-resources --format json tst-45203838 2026-07-30 04:56:37.727174 UTC - expires_at (on expauth): 2026-07-30T07:56:00Z (correctly extended) 2026-07-30 04:56:37.727403 UTC - Testing extend expires_at (single resource in experiment) 2026-07-30 04:56:37.727571 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-45203838 2026-07-30 04:56:39.295420 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-45203838 tst 2026-07-30 04:56:40.218024 UTC - Run: slices experiment list-resources --format json tst-45203838 2026-07-30 04:56:40.884274 UTC - expires_at (on expauth): 2026-07-30T08:56:00Z (correctly extended) 2026-07-30 04:56:40.884694 UTC - Testing ssh login 2026-07-30 04:56:40.902087 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-45203838 tst 2026-07-30 04:56:41.719125 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-45203838 tst 2026-07-30 04:56:42.589194 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-45203838 tst 2026-07-30 04:56:43.556023 UTC - Logging in using 'slices bi ssh' 2026-07-30 04:56:43.556096 UTC - Forcing IPv4 only. 2026-07-30 04:56:43.556213 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-45203838 tst -- -4 uname -a 2026-07-30 04:56:44.679612 UTC - Forcing IPv4 only. 2026-07-30 04:56:44.679786 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-45203838 tst -- -4 uptime 2026-07-30 04:56:45.796329 UTC - CLI SSH Test passed. 2026-07-30 04:56:45.796432 UTC - 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-07-30 04:56:45.796463 UTC - Uptime: 06:56:45 up 0 min, 1 user, load average: 0.06, 0.02, 0.00 2026-07-30 04:56:45.796503 UTC - Logging in using SSH (extra test: ignore SSH proxy) 2026-07-30 04:56:45.797030 UTC - Added paramiko HostKeyEntry for 10.10.217.87 2026-07-30 04:56:45.797216 UTC - Added paramiko HostKeyEntry for 10.10.217.87 2026-07-30 04:56:45.797273 UTC - Added paramiko HostKeyEntry for 10.10.217.87 2026-07-30 04:56:45.797460 UTC - Connecting to 10.10.217.87:22 2026-07-30 04:56:46.028207 UTC - SSH Test output: 2026-07-30 04:56:46.028283 UTC - 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-07-30 04:56:46.028337 UTC - Uptime: 06:56:45 up 0 min, 1 user, load average: 0.06, 0.02, 0.00 2026-07-30 04:56:46.080043 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-07-30 04:56:46.124519 UTC - /etc/debian_version: 13.1 2026-07-30 04:56:46.124640 UTC - lsb_release matches expected value 2026-07-30 04:56:46.124673 UTC - /etc/debian_version matches expected value 2026-07-30 04:56:46.124696 UTC - SSH Test passed. 2026-07-30 04:56:46.124849 UTC - Logging in using SSH over SSH proxy 2026-07-30 04:56:46.125064 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-45203838 tst 2026-07-30 04:56:47.097962 UTC - Added paramiko HostKeyEntry for 10.10.217.87 2026-07-30 04:56:47.098111 UTC - Added paramiko HostKeyEntry for 10.10.217.87 2026-07-30 04:56:47.098163 UTC - Added paramiko HostKeyEntry for 10.10.217.87 2026-07-30 04:56:47.098417 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-30 04:56:47.098475 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-30 04:56:47.098585 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-30 04:56:47.098607 UTC - Connecting to proxy bastion2.slices-be.eu:22 2026-07-30 04:56:47.365008 UTC - Connecting to 10.10.217.87:22 over proxy 2026-07-30 04:56:47.600823 UTC - SSH Test output: 2026-07-30 04:56:47.600911 UTC - 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-07-30 04:56:47.600932 UTC - Uptime: 06:56:47 up 0 min, 2 users, load average: 0.06, 0.02, 0.00 2026-07-30 04:56:47.652940 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-07-30 04:56:47.700498 UTC - /etc/debian_version: 13.1 2026-07-30 04:56:47.700585 UTC - lsb_release matches expected value 2026-07-30 04:56:47.700616 UTC - /etc/debian_version matches expected value 2026-07-30 04:56:47.700639 UTC - SSH Test passed. 2026-07-30 04:56:47.709732 UTC - Destroying tst-45203838 tst 2026-07-30 04:56:47.709934 UTC - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-45203838 tst