Test run: - Start at Tue Sep 29 04:07:21 UTC 2026 - Docker image: "monitor-test-runner:scli-manual-manual" - Container name: "test-run-e08508cd-19c4-447a-ac1b-a8464248da6e" - Runner git commit: 3d31de04c823a30705ff3eab5a5f3c3f420ec99c 2026-09-25T10:35:24+02:00 Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Uninstalled 1 package in 0.78ms Installed 1 package in 1ms Run Test: slices-bi-singlenode-login 2026-09-29 04:07:24.772962 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-09-29 04:07:24.774294 UTC - ls -a /root/ /scripts/: '/root/:\n.\n..\n.bashrc\n.cache\n.local\n.profile\n.slices\n.wget-hsts\n\n/scripts/:\n.\n..\n.slices\nrun_test_runner.sh\n' 2026-09-29 04:07:24.774365 UTC - env: {'PATH': '/app/.venv/bin:/usr/local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/root/.local/bin/', 'COLUMNS': '200'} 2026-09-29 04:07:24.774476 UTC - which slices: /usr/local/bin/slices 2026-09-29 04:07:24.774499 UTC - Slices CLI exe: 'slices' 2026-09-29 04:07:24.774730 UTC - Run: slices --version 2026-09-29 04:07:28.516343 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-09-29 04:07:28.517241 UTC - Run: slices pubkey list --format text 2026-09-29 04:07:29.433415 UTC - Pubkey already registered 2026-09-29 04:07:29.433761 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-09-29 04:07:30.359557 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-09-29 04:07:30.359668 UTC - Check List Flavors 2026-09-29 04:07:30.359832 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 flavor list -f json 2026-09-29 04:07:31.496389 UTC - Check List DiskImages 2026-09-29 04:07:31.496666 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 diskimage list -f json 2026-09-29 04:07:32.314064 UTC - Requesting resources 2026-09-29 04:07:32.314684 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-09-29 04:07:32.314830 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 create tst --image 'Ubuntu 22.04.5' --flavor pc --duration 2h --experiment tst-384ad3d0 --user-data /tmp/tmpszu3lqcj 2026-09-29 04:07:33.734336 UTC - Resource ID: r_be-gent1-bi-baremetal1_01m3nnhcbqe7h9ggdq3a84recq 2026-09-29 04:07:33.734535 UTC - Waiting until resource ready 2026-09-29 04:07:35.734934 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-384ad3d0 tst 2026-09-29 04:07:37.085387 UTC - Status: IMAGING 2026-09-29 04:07:40.423510 UTC - Status: IMAGING 2026-09-29 04:07:44.917688 UTC - Status: IMAGING 2026-09-29 04:07:50.165962 UTC - Status: IMAGING 2026-09-29 04:07:55.615837 UTC - Status: IMAGING 2026-09-29 04:08:00.878318 UTC - Status: IMAGING 2026-09-29 04:08:05.499721 UTC - Status: IMAGING 2026-09-29 04:08:09.821504 UTC - Status: IMAGING 2026-09-29 04:08:13.489931 UTC - Status: IMAGING 2026-09-29 04:08:16.589359 UTC - Status: IMAGING 2026-09-29 04:08:19.557478 UTC - Status: IMAGING 2026-09-29 04:08:22.474791 UTC - Status: IMAGING 2026-09-29 04:08:25.442033 UTC - Status: IMAGING 2026-09-29 04:08:28.360959 UTC - Status: IMAGING 2026-09-29 04:08:31.428475 UTC - Status: IMAGING 2026-09-29 04:08:34.502967 UTC - Status: IMAGING 2026-09-29 04:08:37.781697 UTC - Status: IMAGING 2026-09-29 04:08:40.805652 UTC - Status: IMAGING 2026-09-29 04:08:44.026468 UTC - Status: IMAGING 2026-09-29 04:08:47.567055 UTC - Status: IMAGING 2026-09-29 04:08:51.008395 UTC - Status: IMAGING 2026-09-29 04:08:54.391219 UTC - Status: IMAGING 2026-09-29 04:08:57.720691 UTC - Status: IMAGING 2026-09-29 04:09:00.745349 UTC - Status: IMAGING 2026-09-29 04:09:06.682587 UTC - Status: IMAGING 2026-09-29 04:09:09.599624 UTC - Status: IMAGING 2026-09-29 04:09:12.516657 UTC - Status: IMAGING 2026-09-29 04:09:15.439318 UTC - Status: IMAGING 2026-09-29 04:09:18.407303 UTC - Status: IMAGING 2026-09-29 04:09:21.586074 UTC - Status: IMAGING 2026-09-29 04:09:24.602620 UTC - Status: IMAGING 2026-09-29 04:09:28.103840 UTC - Status: IMAGING 2026-09-29 04:09:31.641376 UTC - Status: IMAGING 2026-09-29 04:09:34.558091 UTC - Status: IMAGING 2026-09-29 04:09:37.475043 UTC - Status: IMAGING 2026-09-29 04:09:40.553347 UTC - Status: IMAGING 2026-09-29 04:09:43.632796 UTC - Status: IMAGING 2026-09-29 04:09:46.549196 UTC - Status: IMAGING 2026-09-29 04:09:49.415753 UTC - Status: IMAGING 2026-09-29 04:09:52.604022 UTC - Status: IMAGING 2026-09-29 04:09:55.526407 UTC - Status: IMAGING 2026-09-29 04:09:58.443196 UTC - Status: IMAGING 2026-09-29 04:10:01.592512 UTC - Status: IMAGING 2026-09-29 04:10:04.664449 UTC - Status: IMAGING 2026-09-29 04:10:07.913656 UTC - Status: IMAGING 2026-09-29 04:10:10.880875 UTC - Status: IMAGING 2026-09-29 04:10:14.058802 UTC - Status: IMAGING 2026-09-29 04:10:16.975625 UTC - Status: IMAGING 2026-09-29 04:10:19.943019 UTC - Status: IMAGING 2026-09-29 04:10:22.809416 UTC - Status: IMAGING 2026-09-29 04:10:25.676364 UTC - Status: IMAGING 2026-09-29 04:10:28.593970 UTC - Status: IMAGING 2026-09-29 04:10:31.511365 UTC - Status: STARTING 2026-09-29 04:10:34.479150 UTC - Status: STARTING 2026-09-29 04:10:37.497242 UTC - Status: UP 2026-09-29 04:10:37.497363 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01m3nnhc49e9fakwcekjsq45gg 2026-09-29 04:10:37.497419 UTC - Validate resources 2026-09-29 04:10:38.414410 UTC - The fields of the created resource were validated. 2026-09-29 04:10:38.414517 UTC - Check if resources are registered in experiment 2026-09-29 04:10:38.414682 UTC - Run: slices experiment list-resources --format json tst-384ad3d0 2026-09-29 04:10:39.280762 UTC - Status (on expauth): UP 2026-09-29 04:10:39.280923 UTC - Testing extend expires_at (all resources in experiment) 2026-09-29 04:10:39.281053 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 extend --duration 3h --experiment tst-384ad3d0 2026-09-29 04:10:42.402806 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-384ad3d0 tst 2026-09-29 04:10:43.470665 UTC - Run: slices experiment list-resources --format json tst-384ad3d0 2026-09-29 04:10:44.236749 UTC - expires_at (on expauth): 2026-09-29T07:10:00Z (correctly extended) 2026-09-29 04:10:44.236854 UTC - Testing extend expires_at (single resource in experiment) 2026-09-29 04:10:44.237050 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 extend tst --duration 4h --experiment tst-384ad3d0 2026-09-29 04:10:47.362043 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 list-resources --format json --experiment tst-384ad3d0 tst 2026-09-29 04:10:48.762761 UTC - Run: slices experiment list-resources --format json tst-384ad3d0 2026-09-29 04:10:49.630919 UTC - expires_at (on expauth): 2026-09-29T08:10:00Z (correctly extended) 2026-09-29 04:10:49.631080 UTC - Testing ssh login 2026-09-29 04:10:49.669788 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-384ad3d0 tst 2026-09-29 04:10:51.051299 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-384ad3d0 tst 2026-09-29 04:10:52.239513 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-384ad3d0 tst 2026-09-29 04:10:53.447886 UTC - Logging in using 'slices bi ssh' 2026-09-29 04:10:53.448006 UTC - Forcing IPv4 only. 2026-09-29 04:10:53.448154 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-384ad3d0 tst -- -4 uname -a 2026-09-29 04:10:55.075896 UTC - Forcing IPv4 only. 2026-09-29 04:10:55.076094 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-384ad3d0 tst -- -4 uptime 2026-09-29 04:10:56.831611 UTC - CLI SSH Test passed. 2026-09-29 04:10:56.831716 UTC - Uname: Linux tst.6edqnr.fed4fire-eu.wall1.ilabt.imec.be 5.15.0-122-generic #132-Ubuntu SMP Thu Aug 29 13:45:52 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux 2026-09-29 04:10:56.831749 UTC - Uptime: 06:10:56 up 1 min, 0 users, load average: 0.56, 0.22, 0.08 2026-09-29 04:10:56.831800 UTC - Logging in using 'slices bi ssh' 2026-09-29 04:10:56.831875 UTC - Forcing IPv6 only. 2026-09-29 04:10:56.832102 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-384ad3d0 tst -- -6 uname -a 2026-09-29 04:10:58.579357 UTC - Forcing IPv6 only. 2026-09-29 04:10:58.579559 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --show nothing --experiment tst-384ad3d0 tst -- -6 uptime 2026-09-29 04:11:00.246309 UTC - CLI SSH Test passed. 2026-09-29 04:11:00.246385 UTC - Uname: Linux tst.6edqnr.fed4fire-eu.wall1.ilabt.imec.be 5.15.0-122-generic #132-Ubuntu SMP Thu Aug 29 13:45:52 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux 2026-09-29 04:11:00.246405 UTC - Uptime: 06:11:00 up 1 min, 0 users, load average: 0.51, 0.22, 0.08 2026-09-29 04:11:00.246445 UTC - Logging in using SSH (extra test: ignore SSH proxy) 2026-09-29 04:11:00.247051 UTC - Added paramiko HostKeyEntry for n077-05.wall1.ilabt.imec.be 2026-09-29 04:11:00.247309 UTC - Added paramiko HostKeyEntry for n077-05.wall1.ilabt.imec.be 2026-09-29 04:11:00.247400 UTC - Added paramiko HostKeyEntry for n077-05.wall1.ilabt.imec.be 2026-09-29 04:11:00.247595 UTC - Connecting to n077-05.wall1.ilabt.imec.be:22 2026-09-29 04:11:00.567427 UTC - SSH Test output: 2026-09-29 04:11:00.567505 UTC - Uname: Linux tst.6edqnr.fed4fire-eu.wall1.ilabt.imec.be 5.15.0-122-generic #132-Ubuntu SMP Thu Aug 29 13:45:52 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux 2026-09-29 04:11:00.567526 UTC - Uptime: 06:11:00 up 1 min, 0 users, load average: 0.51, 0.22, 0.08 2026-09-29 04:11:00.672381 UTC - lsb_release: Ubuntu 22.04.5 LTS 2026-09-29 04:11:00.672464 UTC - lsb_release matches expected value 2026-09-29 04:11:00.672485 UTC - SSH Test passed. 2026-09-29 04:11:00.718104 UTC - Cloud-init user-data: Hello World. The time is now Tue, 29 Sep 2026 06:10:28 +0200! 2026-09-29 04:11:00.718275 UTC - Logging in using SSH over SSH proxy 2026-09-29 04:11:00.718447 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-384ad3d0 tst 2026-09-29 04:11:02.682163 UTC - Added paramiko HostKeyEntry for n077-05.wall1.ilabt.imec.be 2026-09-29 04:11:02.682317 UTC - Added paramiko HostKeyEntry for n077-05.wall1.ilabt.imec.be 2026-09-29 04:11:02.682368 UTC - Added paramiko HostKeyEntry for n077-05.wall1.ilabt.imec.be 2026-09-29 04:11:02.682653 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-09-29 04:11:02.682714 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-09-29 04:11:02.682849 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-09-29 04:11:02.682883 UTC - Connecting to proxy bastion2.slices-be.eu:22 2026-09-29 04:11:02.821871 UTC - Connecting to n077-05.wall1.ilabt.imec.be:22 over proxy 2026-09-29 04:11:03.168882 UTC - SSH Test output: 2026-09-29 04:11:03.168968 UTC - Uname: Linux tst.6edqnr.fed4fire-eu.wall1.ilabt.imec.be 5.15.0-122-generic #132-Ubuntu SMP Thu Aug 29 13:45:52 UTC 2024 x86_64 x86_64 x86_64 GNU/Linux 2026-09-29 04:11:03.168989 UTC - Uptime: 06:11:03 up 1 min, 0 users, load average: 0.51, 0.22, 0.08 2026-09-29 04:11:03.262427 UTC - lsb_release: Ubuntu 22.04.5 LTS 2026-09-29 04:11:03.262510 UTC - lsb_release matches expected value 2026-09-29 04:11:03.262530 UTC - SSH Test passed. 2026-09-29 04:11:03.267748 UTC - Cloud-init user-data: Hello World. The time is now Tue, 29 Sep 2026 06:10:28 +0200! 2026-09-29 04:11:03.290050 UTC - Testing ping connectivity 2026-09-29 04:11:03.290231 UTC - Run: ping -n -w 10 -W 2 -c 5 -i 0.2 10.2.65.35 2026-09-29 04:11:04.166588 UTC - Destroying tst-384ad3d0 tst 2026-09-29 04:11:04.166856 UTC - Run: slices bi --infra be-gent1-bi-baremetal1 destroy --experiment tst-384ad3d0 tst