Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.38s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 338ms 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 545ms + 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.3 + 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.0 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-13 04:07:18.089194 UTC - Installing Slices CLI (latest stable version). 2026-07-13 04:07:18.089455 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-13 04:07:25.925184 UTC - Slices CLI installed. 2026-07-13 04:07:25.926204 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-13 04:07:25.929013 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-13 04:07:25.930766 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-13 04:07:25.930911 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-13 04:07:25.930940 UTC - Slices CLI exe: 'slices' 2026-07-13 04:07:25.930958 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-13 04:07:25.931091 UTC - Run: slices --version 2026-07-13 04:07:31.120589 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-13 04:07:31.120912 UTC - Run: slices pubkey list --format text 2026-07-13 04:07:33.763340 UTC - Pubkey already registered 2026-07-13 04:07:33.773926 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-13 04:07:34.593579 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-13 04:07:34.593682 UTC - Check List Flavors 2026-07-13 04:07:34.593833 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-13 04:07:35.969526 UTC - Check List DiskImages 2026-07-13 04:07:35.969749 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-13 04:07:36.738008 UTC - Requesting resources 2026-07-13 04:07:36.738788 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-564fecfc 2026-07-13 04:07:40.210510 UTC - Resource ID: r_ch-geneva-bi-vm1_01kxcthgq7f3hb52h2spjd1efx 2026-07-13 04:07:40.210659 UTC - Waiting until resource ready 2026-07-13 04:07:42.211032 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-564fecfc tst 2026-07-13 04:07:42.978702 UTC - Status: IMAGING 2026-07-13 04:07:45.794722 UTC - Status: IMAGING 2026-07-13 04:07:48.560890 UTC - Status: IMAGING 2026-07-13 04:07:51.326619 UTC - Status: IMAGING 2026-07-13 04:07:54.094893 UTC - Status: IMAGING 2026-07-13 04:07:56.861124 UTC - Status: IMAGING 2026-07-13 04:07:59.890187 UTC - Status: IMAGING 2026-07-13 04:08:02.756765 UTC - Status: IMAGING 2026-07-13 04:08:05.522611 UTC - Status: IMAGING 2026-07-13 04:08:08.338771 UTC - Status: IMAGING 2026-07-13 04:08:12.398685 UTC - Status: IMAGING 2026-07-13 04:08:16.990149 UTC - Status: IMAGING 2026-07-13 04:08:20.401569 UTC - Status: IMAGING 2026-07-13 04:08:23.565602 UTC - Status: IMAGING 2026-07-13 04:08:27.064477 UTC - Status: IMAGING 2026-07-13 04:08:30.251137 UTC - Status: IMAGING 2026-07-13 04:08:33.123846 UTC - Status: IMAGING 2026-07-13 04:08:36.390685 UTC - Status: IMAGING 2026-07-13 04:08:39.356941 UTC - Status: IMAGING 2026-07-13 04:08:42.585640 UTC - Status: IMAGING 2026-07-13 04:08:45.793915 UTC - Status: IMAGING 2026-07-13 04:08:48.770637 UTC - Status: IMAGING 2026-07-13 04:08:51.536617 UTC - Status: IMAGING 2026-07-13 04:08:54.654644 UTC - Status: IMAGING 2026-07-13 04:08:57.739935 UTC - Status: IMAGING 2026-07-13 04:09:01.222906 UTC - Status: IMAGING 2026-07-13 04:09:05.009086 UTC - Status: IMAGING 2026-07-13 04:09:08.378682 UTC - Status: IMAGING 2026-07-13 04:09:11.355740 UTC - Status: IMAGING 2026-07-13 04:09:15.093587 UTC - Status: IMAGING 2026-07-13 04:09:18.498926 UTC - Status: IMAGING 2026-07-13 04:09:22.531213 UTC - Status: IMAGING 2026-07-13 04:09:26.256615 UTC - Status: IMAGING 2026-07-13 04:09:30.313341 UTC - Status: UP 2026-07-13 04:09:30.313432 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxcthfjnfxjsh0sgkrehzjrf 2026-07-13 04:09:30.313476 UTC - Validate resources 2026-07-13 04:09:31.963316 UTC - "slices bi list-resources" returned resource without private IPv4 address, but with a public IPv4 address. As test_allow_public_ipv4_instead_of_private is set, that is acceptable. 2026-07-13 04:09:31.963388 UTC - The fields of the created resource were validated. 2026-07-13 04:09:31.963442 UTC - Check if resources are registered in experiment 2026-07-13 04:09:31.963611 UTC - Run: slices experiment list-resources --format json tst-564fecfc 2026-07-13 04:09:33.383425 UTC - Status (on expauth): UP 2026-07-13 04:09:33.383583 UTC - Testing extend expires_at (all resources in experiment) 2026-07-13 04:09:33.383716 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-564fecfc 2026-07-13 04:09:36.872600 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-564fecfc tst 2026-07-13 04:09:38.014763 UTC - Run: slices experiment list-resources --format json tst-564fecfc 2026-07-13 04:09:39.561922 UTC - expires_at (on expauth): 2026-07-13T07:09:00Z (correctly extended) 2026-07-13 04:09:39.562015 UTC - Testing extend expires_at (single resource in experiment) 2026-07-13 04:09:39.562184 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-564fecfc 2026-07-13 04:09:42.623525 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-564fecfc tst 2026-07-13 04:09:44.307328 UTC - Run: slices experiment list-resources --format json tst-564fecfc 2026-07-13 04:09:45.305310 UTC - expires_at (on expauth): 2026-07-13T08:09:00Z (correctly extended) 2026-07-13 04:09:45.305460 UTC - Testing ssh login 2026-07-13 04:09:45.315582 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-564fecfc tst 2026-07-13 04:09:46.081118 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-564fecfc tst 2026-07-13 04:09:46.946774 UTC - Logging in using 'slices bi ssh' 2026-07-13 04:09:46.946862 UTC - Forcing IPv4 only. 2026-07-13 04:09:46.947005 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-564fecfc tst -- -4 uname -a 2026-07-13 04:09:50.521248 UTC - Forcing IPv4 only. 2026-07-13 04:09:50.521460 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-564fecfc tst -- -4 uptime 2026-07-13 04:09:51.790097 UTC - CLI SSH Test passed. 2026-07-13 04:09:51.790163 UTC - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-b6fa97cc-9ea7-4f9b-9541-f0 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-13 04:09:51.790181 UTC - Uptime: 04:09:51 up 1 min, 2 users, load average: 0.13, 0.05, 0.02 2026-07-13 04:09:51.790215 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-07-13 04:09:51.790712 UTC - Added paramiko HostKeyEntry for 5.53.108.124 2026-07-13 04:09:51.790799 UTC - Added paramiko HostKeyEntry for 5.53.108.124 2026-07-13 04:09:51.790946 UTC - Added paramiko HostKeyEntry for 5.53.108.124 2026-07-13 04:09:51.791117 UTC - Connecting to 5.53.108.124:22 2026-07-13 04:09:52.361923 UTC - SSH Test output: 2026-07-13 04:09:52.361994 UTC - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-b6fa97cc-9ea7-4f9b-9541-f0 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-13 04:09:52.362015 UTC - Uptime: 04:09:52 up 1 min, 1 user, load average: 0.13, 0.05, 0.02 2026-07-13 04:09:52.459640 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-13 04:09:52.459719 UTC - lsb_release matches expected value 2026-07-13 04:09:52.459741 UTC - SSH Test passed. 2026-07-13 04:09:52.459825 UTC - Skip SSH proxy test because no jump proxy 2026-07-13 04:09:52.467733 UTC - Destroying tst-564fecfc tst 2026-07-13 04:09:52.467919 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-564fecfc tst