Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 6.21s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 381ms 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 955ms + 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.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-25 20:09:32.549061 UTC - Installing Slices CLI (latest stable version). 2026-07-25 20:09:32.549285 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-25 20:09:39.111427 UTC - Slices CLI installed. 2026-07-25 20:09:39.112417 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-25 20:09:39.114969 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-25 20:09:39.115990 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-25 20:09:39.116115 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-25 20:09:39.116142 UTC - Slices CLI exe: 'slices' 2026-07-25 20:09:39.116158 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-25 20:09:39.116268 UTC - Run: slices --version 2026-07-25 20:09:42.500700 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-25 20:09:42.501012 UTC - Run: slices pubkey list --format text 2026-07-25 20:09:43.520213 UTC - Pubkey already registered 2026-07-25 20:09:43.520778 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-25 20:09:44.897469 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-25 20:09:44.897558 UTC - Check List Flavors 2026-07-25 20:09:44.897693 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-25 20:09:45.888583 UTC - Check List DiskImages 2026-07-25 20:09:45.888801 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-25 20:09:47.462320 UTC - Requesting resources 2026-07-25 20:09:47.462989 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-3974e5d1 2026-07-25 20:09:49.088913 UTC - Resource ID: r_ch-geneva-bi-vm1_01kydebwhneh1rtga8m6b1ebz9 2026-07-25 20:09:49.089064 UTC - Waiting until resource ready 2026-07-25 20:09:51.089403 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-3974e5d1 tst 2026-07-25 20:09:52.410450 UTC - Status: IMAGING 2026-07-25 20:09:55.749123 UTC - Status: IMAGING 2026-07-25 20:09:58.744004 UTC - Status: IMAGING 2026-07-25 20:10:02.741694 UTC - Status: IMAGING 2026-07-25 20:10:06.191161 UTC - Status: IMAGING 2026-07-25 20:10:10.156638 UTC - Status: IMAGING 2026-07-25 20:10:13.137916 UTC - Status: IMAGING 2026-07-25 20:10:16.167964 UTC - Status: IMAGING 2026-07-25 20:10:20.354615 UTC - Status: IMAGING 2026-07-25 20:10:23.815122 UTC - Status: IMAGING 2026-07-25 20:10:28.627074 UTC - Status: IMAGING 2026-07-25 20:10:32.806021 UTC - Status: IMAGING 2026-07-25 20:10:36.127203 UTC - Status: IMAGING 2026-07-25 20:10:40.131961 UTC - Status: IMAGING 2026-07-25 20:10:44.081261 UTC - Status: IMAGING 2026-07-25 20:10:47.613617 UTC - Status: IMAGING 2026-07-25 20:10:51.457795 UTC - Status: IMAGING 2026-07-25 20:10:55.062529 UTC - Status: IMAGING 2026-07-25 20:10:59.148068 UTC - Status: IMAGING 2026-07-25 20:11:03.048554 UTC - Status: IMAGING 2026-07-25 20:11:06.892304 UTC - Status: IMAGING 2026-07-25 20:11:10.933275 UTC - Status: IMAGING 2026-07-25 20:11:14.982321 UTC - Status: IMAGING 2026-07-25 20:11:19.929049 UTC - Status: IMAGING 2026-07-25 20:11:24.388560 UTC - Status: IMAGING 2026-07-25 20:11:27.825119 UTC - Status: IMAGING 2026-07-25 20:11:31.698795 UTC - Status: IMAGING 2026-07-25 20:11:35.505277 UTC - Status: IMAGING 2026-07-25 20:11:39.134048 UTC - Status: IMAGING 2026-07-25 20:11:42.669938 UTC - Status: UP 2026-07-25 20:11:42.670021 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kydebw2vfy2sztagxh23hsb4 2026-07-25 20:11:42.670062 UTC - Validate resources 2026-07-25 20:11:45.348521 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-25 20:11:45.348626 UTC - The fields of the created resource were validated. 2026-07-25 20:11:45.348665 UTC - Check if resources are registered in experiment 2026-07-25 20:11:45.348973 UTC - Run: slices experiment list-resources --format json tst-3974e5d1 2026-07-25 20:11:47.395087 UTC - Status (on expauth): UP 2026-07-25 20:11:47.395217 UTC - Testing extend expires_at (all resources in experiment) 2026-07-25 20:11:47.395380 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-3974e5d1 2026-07-25 20:11:50.021767 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-3974e5d1 tst 2026-07-25 20:11:52.002036 UTC - Run: slices experiment list-resources --format json tst-3974e5d1 2026-07-25 20:11:53.126148 UTC - expires_at (on expauth): 2026-07-25T23:11:00Z (correctly extended) 2026-07-25 20:11:53.126260 UTC - Testing extend expires_at (single resource in experiment) 2026-07-25 20:11:53.126407 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-3974e5d1 2026-07-25 20:11:54.919437 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-3974e5d1 tst 2026-07-25 20:11:56.159939 UTC - Run: slices experiment list-resources --format json tst-3974e5d1 2026-07-25 20:11:57.227730 UTC - expires_at (on expauth): 2026-07-26T00:11:00Z (correctly extended) 2026-07-25 20:11:57.227843 UTC - Testing ssh login 2026-07-25 20:11:57.245875 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-3974e5d1 tst 2026-07-25 20:11:58.111879 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-3974e5d1 tst 2026-07-25 20:11:58.977611 UTC - Logging in using 'slices bi ssh' 2026-07-25 20:11:58.977686 UTC - Forcing IPv4 only. 2026-07-25 20:11:58.977808 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-3974e5d1 tst -- -4 uname -a 2026-07-25 20:12:01.999312 UTC - Forcing IPv4 only. 2026-07-25 20:12:01.999512 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-3974e5d1 tst -- -4 uptime 2026-07-25 20:12:03.266351 UTC - CLI SSH Test passed. 2026-07-25 20:12:03.266453 UTC - Uname: Linux 9524f874-af0c-4a76-a2a6-5351b52bb50f-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-25 20:12:03.266475 UTC - Uptime: 20:12:03 up 1 min, 1 user, load average: 0.14, 0.05, 0.02 2026-07-25 20:12:03.266515 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-07-25 20:12:03.267186 UTC - Added paramiko HostKeyEntry for 5.53.108.204 2026-07-25 20:12:03.267330 UTC - Added paramiko HostKeyEntry for 5.53.108.204 2026-07-25 20:12:03.267517 UTC - Added paramiko HostKeyEntry for 5.53.108.204 2026-07-25 20:12:03.267748 UTC - Connecting to 5.53.108.204:22 2026-07-25 20:12:03.821856 UTC - SSH Test output: 2026-07-25 20:12:03.821929 UTC - Uname: Linux 9524f874-af0c-4a76-a2a6-5351b52bb50f-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-25 20:12:03.821950 UTC - Uptime: 20:12:03 up 1 min, 1 user, load average: 0.14, 0.05, 0.02 2026-07-25 20:12:03.919366 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-25 20:12:03.919445 UTC - lsb_release matches expected value 2026-07-25 20:12:03.919465 UTC - SSH Test passed. 2026-07-25 20:12:03.919552 UTC - Skip SSH proxy test because no jump proxy 2026-07-25 20:12:03.927536 UTC - Destroying tst-3974e5d1 tst 2026-07-25 20:12:03.927732 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-3974e5d1 tst