Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 7.62s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 380ms 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 1.58s + 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.1 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-18 20:07:54.106580 UTC - Installing Slices CLI (latest stable version). 2026-07-18 20:07:54.106822 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-18 20:08:13.489132 UTC - Slices CLI installed. 2026-07-18 20:08:13.489562 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-18 20:08:13.491941 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-18 20:08:13.492890 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-18 20:08:13.493054 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-18 20:08:13.493084 UTC - Slices CLI exe: 'slices' 2026-07-18 20:08:13.493101 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-18 20:08:13.493233 UTC - Run: slices --version 2026-07-18 20:08:16.667374 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-18 20:08:16.667635 UTC - Run: slices pubkey list --format text 2026-07-18 20:08:22.447210 UTC - Pubkey already registered 2026-07-18 20:08:22.447457 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-18 20:08:26.489667 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-18 20:08:26.489891 UTC - Check List Flavors 2026-07-18 20:08:26.490044 UTC - Run: slices bi --infra hu-budapest-bi-vm1 flavor list -f json 2026-07-18 20:08:28.125560 UTC - Check List DiskImages 2026-07-18 20:08:28.125787 UTC - Run: slices bi --infra hu-budapest-bi-vm1 diskimage list -f json 2026-07-18 20:08:29.152940 UTC - Requesting resources 2026-07-18 20:08:29.153929 UTC - Run: slices bi --infra hu-budapest-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-9e38a54b 2026-07-18 20:08:32.850829 UTC - Resource ID: r_hu-budapest-bi-vm1_01kxvdgh1nf6g8krdgshsyqn9h 2026-07-18 20:08:32.851001 UTC - Waiting until resource ready 2026-07-18 20:08:34.851289 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-9e38a54b tst 2026-07-18 20:08:36.168505 UTC - Status: IMAGING 2026-07-18 20:08:39.688645 UTC - Status: IMAGING 2026-07-18 20:08:43.374237 UTC - Status: IMAGING 2026-07-18 20:08:46.328506 UTC - Status: IMAGING 2026-07-18 20:08:49.504707 UTC - Status: IMAGING 2026-07-18 20:08:52.433045 UTC - Status: IMAGING 2026-07-18 20:08:55.628192 UTC - Status: IMAGING 2026-07-18 20:08:59.284004 UTC - Status: IMAGING 2026-07-18 20:09:02.979142 UTC - Status: IMAGING 2026-07-18 20:09:05.795067 UTC - Status: IMAGING 2026-07-18 20:09:08.815856 UTC - Status: IMAGING 2026-07-18 20:09:11.851462 UTC - Status: IMAGING 2026-07-18 20:09:14.717916 UTC - Status: IMAGING 2026-07-18 20:09:17.584014 UTC - Status: IMAGING 2026-07-18 20:09:20.702423 UTC - Status: IMAGING 2026-07-18 20:09:23.626862 UTC - Status: IMAGING 2026-07-18 20:09:27.081142 UTC - Status: IMAGING 2026-07-18 20:09:31.323136 UTC - Status: IMAGING 2026-07-18 20:09:35.037733 UTC - Status: IMAGING 2026-07-18 20:09:38.658018 UTC - Status: IMAGING 2026-07-18 20:09:42.132043 UTC - Status: IMAGING 2026-07-18 20:09:45.640559 UTC - Status: UP 2026-07-18 20:09:45.640671 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxvdgfrmf8jv7665syzgwfpg 2026-07-18 20:09:45.640712 UTC - Validate resources 2026-07-18 20:09:46.691867 UTC - The fields of the created resource were validated. 2026-07-18 20:09:46.691962 UTC - Check if resources are registered in experiment 2026-07-18 20:09:46.692127 UTC - Run: slices experiment list-resources --format json tst-9e38a54b 2026-07-18 20:09:47.691146 UTC - Status (on expauth): UP 2026-07-18 20:09:47.691282 UTC - Testing extend expires_at (all resources in experiment) 2026-07-18 20:09:47.691418 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend --duration 3h --experiment tst-9e38a54b 2026-07-18 20:09:50.369550 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-9e38a54b tst 2026-07-18 20:09:52.640243 UTC - Run: slices experiment list-resources --format json tst-9e38a54b 2026-07-18 20:09:54.094758 UTC - expires_at (on expauth): 2026-07-18T23:09:00Z (correctly extended) 2026-07-18 20:09:54.094863 UTC - Testing extend expires_at (single resource in experiment) 2026-07-18 20:09:54.094999 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend tst --duration 4h --experiment tst-9e38a54b 2026-07-18 20:09:57.399313 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-9e38a54b tst 2026-07-18 20:09:58.214988 UTC - Run: slices experiment list-resources --format json tst-9e38a54b 2026-07-18 20:09:59.041568 UTC - expires_at (on expauth): 2026-07-19T00:09:00Z (correctly extended) 2026-07-18 20:09:59.041684 UTC - Testing ssh login 2026-07-18 20:09:59.061419 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-9e38a54b tst 2026-07-18 20:10:00.197433 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-9e38a54b tst 2026-07-18 20:10:01.629956 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-9e38a54b tst 2026-07-18 20:10:03.266171 UTC - Logging in using 'slices bi ssh' 2026-07-18 20:10:03.266239 UTC - Forcing IPv4 only. 2026-07-18 20:10:03.266377 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-9e38a54b tst -- -4 uname -a 2026-07-18 20:10:08.109064 UTC - Forcing IPv4 only. 2026-07-18 20:10:08.109375 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-9e38a54b tst -- -4 uptime 2026-07-18 20:10:10.780436 UTC - CLI SSH Test passed. 2026-07-18 20:10:10.780507 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-18 20:10:10.780526 UTC - Uptime: 20:10:10 up 1 min, 1 user, load average: 0.22, 0.07, 0.02 2026-07-18 20:10:10.780572 UTC - Logging in using SSH over SSH proxy 2026-07-18 20:10:10.780709 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-9e38a54b tst 2026-07-18 20:10:11.948378 UTC - Added paramiko HostKeyEntry for 192.168.0.19 2026-07-18 20:10:11.948497 UTC - Added paramiko HostKeyEntry for 192.168.0.19 2026-07-18 20:10:11.948652 UTC - Added paramiko HostKeyEntry for 192.168.0.19 2026-07-18 20:10:11.948902 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-18 20:10:11.948959 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-18 20:10:11.949065 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-18 20:10:11.949086 UTC - Connecting to proxy 193.225.251.128:22 2026-07-18 20:10:12.477347 UTC - Connecting to 192.168.0.19:22 over proxy 2026-07-18 20:10:13.254735 UTC - SSH Test output: 2026-07-18 20:10:13.254805 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-18 20:10:13.254827 UTC - Uptime: 20:10:13 up 1 min, 1 user, load average: 0.22, 0.07, 0.02 2026-07-18 20:10:13.403214 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-18 20:10:13.403286 UTC - lsb_release matches expected value 2026-07-18 20:10:13.403319 UTC - SSH Test passed. 2026-07-18 20:10:13.410426 UTC - Destroying tst-9e38a54b tst 2026-07-18 20:10:13.410599 UTC - Run: slices bi --infra hu-budapest-bi-vm1 destroy --experiment tst-9e38a54b tst