Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.20s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 244ms 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 671ms + 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.dev189+g506e4860f (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-28 04:49:28.337858 UTC - Installing Slices CLI (latest stable version). 2026-07-28 04:49:28.338091 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-28 04:49:33.619968 UTC - Slices CLI installed. 2026-07-28 04:49:33.620369 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-28 04:49:33.622965 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-28 04:49:33.623033 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-28 04:49:33.623098 UTC - which slices: /app/.venv/bin/slices 2026-07-28 04:49:33.623117 UTC - Slices CLI exe: 'slices' 2026-07-28 04:49:33.623132 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-28 04:49:33.623257 UTC - Run: slices --version 2026-07-28 04:49:36.295076 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-28 04:49:36.295364 UTC - Run: slices pubkey list --format text 2026-07-28 04:49:37.062436 UTC - Pubkey already registered 2026-07-28 04:49:37.062701 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-28 04:49:37.728125 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-28 04:49:37.728264 UTC - Check List Flavors 2026-07-28 04:49:37.728487 UTC - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-07-28 04:49:38.794879 UTC - Check List DiskImages 2026-07-28 04:49:38.795070 UTC - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-07-28 04:49:39.511787 UTC - Requesting resources 2026-07-28 04:49:39.512644 UTC - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Debian 13.1' --flavor tiny --duration 2h --experiment tst-131e65de 2026-07-28 04:49:41.380771 UTC - Resource ID: r_be-gent1-bi-vm1_01kykgx7vcfgctjabyffxvxvzq 2026-07-28 04:49:41.380939 UTC - Waiting until resource ready 2026-07-28 04:49:43.381302 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-131e65de tst 2026-07-28 04:49:44.096822 UTC - Status: IMAGING 2026-07-28 04:49:46.762773 UTC - Status: IMAGING 2026-07-28 04:49:49.529195 UTC - Status: IMAGING 2026-07-28 04:49:52.346681 UTC - Status: BOOTING 2026-07-28 04:49:55.062868 UTC - Status: BOOTING 2026-07-28 04:49:57.778939 UTC - Status: BOOTING 2026-07-28 04:50:00.495219 UTC - Status: BOOTING 2026-07-28 04:50:03.211892 UTC - Status: INITIALIZING 2026-07-28 04:50:05.927755 UTC - Status: UP 2026-07-28 04:50:05.927848 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kykgx7c8ed18cr3x120azbq6 2026-07-28 04:50:05.927890 UTC - Validate resources 2026-07-28 04:50:06.645050 UTC - The fields of the created resource were validated. 2026-07-28 04:50:06.645140 UTC - Check if resources are registered in experiment 2026-07-28 04:50:06.645293 UTC - Run: slices experiment list-resources --format json tst-131e65de 2026-07-28 04:50:07.310959 UTC - Status (on expauth): UP 2026-07-28 04:50:07.311097 UTC - Testing extend expires_at (all resources in experiment) 2026-07-28 04:50:07.311228 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-131e65de 2026-07-28 04:50:09.481547 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-131e65de tst 2026-07-28 04:50:10.198278 UTC - Run: slices experiment list-resources --format json tst-131e65de 2026-07-28 04:50:10.864588 UTC - expires_at (on expauth): 2026-07-28T07:50:00Z (correctly extended) 2026-07-28 04:50:10.864743 UTC - Testing extend expires_at (single resource in experiment) 2026-07-28 04:50:10.864942 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-131e65de 2026-07-28 04:50:12.984273 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-131e65de tst 2026-07-28 04:50:13.700693 UTC - Run: slices experiment list-resources --format json tst-131e65de 2026-07-28 04:50:14.316669 UTC - expires_at (on expauth): 2026-07-28T08:50:00Z (correctly extended) 2026-07-28 04:50:14.316840 UTC - Testing ssh login 2026-07-28 04:50:14.330493 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-131e65de tst 2026-07-28 04:50:15.097025 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-131e65de tst 2026-07-28 04:50:15.863673 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-131e65de tst 2026-07-28 04:50:16.579845 UTC - Logging in using 'slices bi ssh' 2026-07-28 04:50:16.579953 UTC - Forcing IPv4 only. 2026-07-28 04:50:16.580121 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-131e65de tst -- -4 uname -a 2026-07-28 04:50:17.546494 UTC - Forcing IPv4 only. 2026-07-28 04:50:17.546689 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-131e65de tst -- -4 uptime 2026-07-28 04:50:18.362652 UTC - CLI SSH Test passed. 2026-07-28 04:50:18.362724 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-28 04:50:18.362744 UTC - Uptime: 06:50:17 up 0 min, 1 user, load average: 0.12, 0.03, 0.01 2026-07-28 04:50:18.362778 UTC - Logging in using SSH (extra test: ignore SSH proxy) 2026-07-28 04:50:18.363239 UTC - Added paramiko HostKeyEntry for 10.10.220.142 2026-07-28 04:50:18.363434 UTC - Added paramiko HostKeyEntry for 10.10.220.142 2026-07-28 04:50:18.363494 UTC - Added paramiko HostKeyEntry for 10.10.220.142 2026-07-28 04:50:18.363671 UTC - Connecting to 10.10.220.142:22 2026-07-28 04:50:18.614962 UTC - SSH Test output: 2026-07-28 04:50:18.615032 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-28 04:50:18.615052 UTC - Uptime: 06:50:18 up 0 min, 1 user, load average: 0.12, 0.03, 0.01 2026-07-28 04:50:18.667359 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-07-28 04:50:18.715120 UTC - /etc/debian_version: 13.1 2026-07-28 04:50:18.715195 UTC - lsb_release matches expected value 2026-07-28 04:50:18.715215 UTC - /etc/debian_version matches expected value 2026-07-28 04:50:18.715230 UTC - SSH Test passed. 2026-07-28 04:50:18.715316 UTC - Logging in using SSH over SSH proxy 2026-07-28 04:50:18.715472 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-131e65de tst 2026-07-28 04:50:19.531627 UTC - Added paramiko HostKeyEntry for 10.10.220.142 2026-07-28 04:50:19.531777 UTC - Added paramiko HostKeyEntry for 10.10.220.142 2026-07-28 04:50:19.531828 UTC - Added paramiko HostKeyEntry for 10.10.220.142 2026-07-28 04:50:19.532083 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-28 04:50:19.532139 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-28 04:50:19.532252 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-28 04:50:19.532283 UTC - Connecting to proxy bastion2.slices-be.eu:22 2026-07-28 04:50:19.802269 UTC - Connecting to 10.10.220.142:22 over proxy 2026-07-28 04:50:20.046034 UTC - SSH Test output: 2026-07-28 04:50:20.046121 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-28 04:50:20.046148 UTC - Uptime: 06:50:19 up 0 min, 2 users, load average: 0.19, 0.05, 0.01 2026-07-28 04:50:20.099300 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-07-28 04:50:20.145037 UTC - /etc/debian_version: 13.1 2026-07-28 04:50:20.145127 UTC - lsb_release matches expected value 2026-07-28 04:50:20.145153 UTC - /etc/debian_version matches expected value 2026-07-28 04:50:20.145174 UTC - SSH Test passed. 2026-07-28 04:50:20.152272 UTC - Destroying tst-131e65de tst 2026-07-28 04:50:20.152470 UTC - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-131e65de tst