Test run: - Start at Mon Sep 21 09:49:21 UTC 2026 - Docker image: "monitor-test-runner:scli-manual-manual" - Container name: "test-run-13a525ea-6450-450f-b515-9f317f57069e" - Runner git commit: b81e403a61c53e380fb69905a7df6b5141039e8a 2026-08-11T11:59:29+02:00 Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Uninstalled 1 package in 0.74ms Installed 1 package in 1ms Run Test: slices-bi-singlenode-login 2026-09-21 09:49:24.356155 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-21 09:49:24.358254 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-21 09:49:24.358319 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-21 09:49:24.358424 UTC - which slices: /usr/local/bin/slices 2026-09-21 09:49:24.358446 UTC - Slices CLI exe: 'slices' 2026-09-21 09:49:24.358648 UTC - Run: slices --version 2026-09-21 09:49:27.581605 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-21 09:49:27.581939 UTC - Run: slices pubkey list --format text 2026-09-21 09:49:28.398472 UTC - Pubkey already registered 2026-09-21 09:49:28.398920 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-09-21 09:49:29.065038 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-09-21 09:49:29.065164 UTC - Check List Flavors 2026-09-21 09:49:29.065350 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 flavor list -f json 2026-09-21 09:49:29.831340 UTC - Check List DiskImages 2026-09-21 09:49:29.831597 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 diskimage list -f json 2026-09-21 09:49:30.547927 UTC - Requesting resources 2026-09-21 09:49:30.548529 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 create tst --image debian13-min --flavor nova --duration 2h --experiment tst-eafb72dc 2026-09-21 09:49:31.916891 UTC - Resource ID: r_fr-lyon1-bi-baremetal1_01m31nxsq9ec0b8hk8fty9n8xg 2026-09-21 09:49:31.917062 UTC - Waiting until resource ready 2026-09-21 09:49:33.917495 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-eafb72dc tst 2026-09-21 09:49:34.683463 UTC - Status: IMAGING 2026-09-21 09:49:37.449877 UTC - Status: IMAGING 2026-09-21 09:49:40.266941 UTC - Status: IMAGING 2026-09-21 09:49:43.083665 UTC - Status: IMAGING 2026-09-21 09:49:45.900563 UTC - Status: IMAGING 2026-09-21 09:49:48.767730 UTC - Status: IMAGING 2026-09-21 09:49:51.584256 UTC - Status: IMAGING 2026-09-21 09:49:54.451330 UTC - Status: STARTING 2026-09-21 09:49:57.268113 UTC - Status: STARTING 2026-09-21 09:50:00.084928 UTC - Status: STARTING 2026-09-21 09:50:03.002105 UTC - Status: STARTING 2026-09-21 09:50:05.768696 UTC - Status: STARTING 2026-09-21 09:50:08.585547 UTC - Status: STARTING 2026-09-21 09:50:11.402076 UTC - Status: STARTING 2026-09-21 09:50:14.218898 UTC - Status: STARTING 2026-09-21 09:50:17.035614 UTC - Status: STARTING 2026-09-21 09:50:19.802284 UTC - Status: STARTING 2026-09-21 09:50:22.669190 UTC - Status: STARTING 2026-09-21 09:50:25.485899 UTC - Status: STARTING 2026-09-21 09:50:28.302443 UTC - Status: STARTING 2026-09-21 09:50:31.169932 UTC - Status: STARTING 2026-09-21 09:50:33.986411 UTC - Status: STARTING 2026-09-21 09:50:36.853547 UTC - Status: STARTING 2026-09-21 09:50:39.670165 UTC - Status: STARTING 2026-09-21 09:50:42.486853 UTC - Status: STARTING 2026-09-21 09:50:45.303609 UTC - Status: STARTING 2026-09-21 09:50:48.224417 UTC - Status: STARTING 2026-09-21 09:50:51.401633 UTC - Status: STARTING 2026-09-21 09:50:54.424344 UTC - Status: STARTING 2026-09-21 09:50:57.637273 UTC - Status: STARTING 2026-09-21 09:51:00.403523 UTC - Status: STARTING 2026-09-21 09:51:03.607788 UTC - Status: STARTING 2026-09-21 09:51:06.424104 UTC - Status: STARTING 2026-09-21 09:51:09.455895 UTC - Status: STARTING 2026-09-21 09:51:12.322351 UTC - Status: STARTING 2026-09-21 09:51:15.089868 UTC - Status: STARTING 2026-09-21 09:51:17.956094 UTC - Status: STARTING 2026-09-21 09:51:20.722834 UTC - Status: STARTING 2026-09-21 09:51:23.539116 UTC - Status: STARTING 2026-09-21 09:51:26.406394 UTC - Status: STARTING 2026-09-21 09:51:29.272658 UTC - Status: STARTING 2026-09-21 09:51:32.089948 UTC - Status: STARTING 2026-09-21 09:51:34.906432 UTC - Status: STARTING 2026-09-21 09:51:37.772672 UTC - Status: STARTING 2026-09-21 09:51:40.588712 UTC - Status: STARTING 2026-09-21 09:51:43.455822 UTC - Status: STARTING 2026-09-21 09:51:46.222082 UTC - Status: STARTING 2026-09-21 09:51:48.988937 UTC - Status: STARTING 2026-09-21 09:51:51.755520 UTC - Status: STARTING 2026-09-21 09:51:54.521953 UTC - Status: STARTING 2026-09-21 09:51:57.338672 UTC - Status: STARTING 2026-09-21 09:52:00.155233 UTC - Status: STARTING 2026-09-21 09:52:03.022510 UTC - Status: STARTING 2026-09-21 09:52:05.789559 UTC - Status: STARTING 2026-09-21 09:52:08.606665 UTC - Status: STARTING 2026-09-21 09:52:11.423401 UTC - Status: STARTING 2026-09-21 09:52:14.291730 UTC - Status: STARTING 2026-09-21 09:52:17.058273 UTC - Status: STARTING 2026-09-21 09:52:19.874797 UTC - Status: STARTING 2026-09-21 09:52:22.691465 UTC - Status: STARTING 2026-09-21 09:52:25.508933 UTC - Status: STARTING 2026-09-21 09:52:28.325794 UTC - Status: STARTING 2026-09-21 09:52:31.142569 UTC - Status: STARTING 2026-09-21 09:52:34.010066 UTC - Status: STARTING 2026-09-21 09:52:36.776836 UTC - Status: UP 2026-09-21 09:52:36.776921 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01m31nxsayfjkbrtb14ye926ha 2026-09-21 09:52:36.776999 UTC - Validate resources 2026-09-21 09:52:37.544016 UTC - The fields of the created resource were validated. 2026-09-21 09:52:37.544204 UTC - Check if resources are registered in experiment 2026-09-21 09:52:37.544537 UTC - Run: slices experiment list-resources --format json tst-eafb72dc 2026-09-21 09:52:38.261155 UTC - Status (on expauth): UP 2026-09-21 09:52:38.261383 UTC - Testing extend expires_at (all resources in experiment) 2026-09-21 09:52:38.261577 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend --duration 3h --experiment tst-eafb72dc 2026-09-21 09:52:41.987000 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-eafb72dc tst 2026-09-21 09:52:42.853704 UTC - Run: slices experiment list-resources --format json tst-eafb72dc 2026-09-21 09:52:43.670056 UTC - expires_at (on expauth): 2026-09-21T12:52:00Z (correctly extended) 2026-09-21 09:52:43.670160 UTC - Testing extend expires_at (single resource in experiment) 2026-09-21 09:52:43.670377 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 extend tst --duration 4h --experiment tst-eafb72dc 2026-09-21 09:52:47.445906 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 list-resources --format json --experiment tst-eafb72dc tst 2026-09-21 09:52:48.262382 UTC - Run: slices experiment list-resources --format json tst-eafb72dc 2026-09-21 09:52:48.928526 UTC - expires_at (on expauth): 2026-09-21T13:52:00Z (correctly extended) 2026-09-21 09:52:48.928750 UTC - Testing ssh login 2026-09-21 09:52:48.941246 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show ssh_config --experiment tst-eafb72dc tst 2026-09-21 09:52:49.758053 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-eafb72dc tst 2026-09-21 09:52:50.575918 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-eafb72dc tst 2026-09-21 09:52:51.392733 UTC - Logging in using 'slices bi ssh' 2026-09-21 09:52:51.392841 UTC - Forcing IPv4 only. 2026-09-21 09:52:51.392994 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-eafb72dc tst -- -4 uname -a 2026-09-21 09:52:53.612893 UTC - Forcing IPv4 only. 2026-09-21 09:52:53.613096 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-eafb72dc tst -- -4 uptime 2026-09-21 09:52:54.931085 UTC - CLI SSH Test passed. 2026-09-21 09:52:54.931183 UTC - Uname: Linux nova-14 6.12.107+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.107-1 (2026-08-29) x86_64 GNU/Linux 2026-09-21 09:52:54.931214 UTC - Uptime: 11:52:53 up 0 min, 1 user, load average: 1.57, 0.56, 0.20 2026-09-21 09:52:54.931271 UTC - Logging in using 'slices bi ssh' 2026-09-21 09:52:54.931342 UTC - Forcing IPv6 only. 2026-09-21 09:52:54.931508 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-eafb72dc tst -- -6 uname -a 2026-09-21 09:52:56.299845 UTC - Forcing IPv6 only. 2026-09-21 09:52:56.300111 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --show nothing --experiment tst-eafb72dc tst -- -6 uptime 2026-09-21 09:52:57.768536 UTC - CLI SSH Test passed. 2026-09-21 09:52:57.768624 UTC - Uname: Linux nova-14 6.12.107+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.107-1 (2026-08-29) x86_64 GNU/Linux 2026-09-21 09:52:57.768654 UTC - Uptime: 11:52:56 up 1 min, 1 user, load average: 1.44, 0.55, 0.20 2026-09-21 09:52:57.768739 UTC - Logging in using SSH over SSH proxy 2026-09-21 09:52:57.768932 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-eafb72dc tst 2026-09-21 09:52:58.686180 UTC - Added paramiko HostKeyEntry for nova-14.lyon 2026-09-21 09:52:58.686423 UTC - Added paramiko HostKeyEntry for nova-14.lyon 2026-09-21 09:52:58.686530 UTC - Added paramiko HostKeyEntry for nova-14.lyon 2026-09-21 09:52:58.686855 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-09-21 09:52:58.686954 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-09-21 09:52:58.687002 UTC - Added paramiko HostKeyEntry for access.grid5000.fr 2026-09-21 09:52:58.687020 UTC - Connecting to proxy access.grid5000.fr:22 2026-09-21 09:52:58.991400 UTC - Connecting to nova-14.lyon:22 over proxy 2026-09-21 09:52:59.493737 UTC - SSH Test output: 2026-09-21 09:52:59.493833 UTC - Uname: Linux nova-14 6.12.107+deb13-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.107-1 (2026-08-29) x86_64 GNU/Linux 2026-09-21 09:52:59.493864 UTC - Uptime: 11:52:58 up 1 min, 1 user, load average: 1.44, 0.55, 0.20 2026-09-21 09:52:59.603934 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-09-21 09:52:59.703406 UTC - /etc/debian_version: 13.6 2026-09-21 09:52:59.703479 UTC - lsb_release matches expected value 2026-09-21 09:52:59.703501 UTC - /etc/debian_version matches expected value 2026-09-21 09:52:59.703517 UTC - SSH Test passed. 2026-09-21 09:52:59.711055 UTC - Destroying tst-eafb72dc tst 2026-09-21 09:52:59.711296 UTC - Run: slices bi --infra fr-lyon1-bi-baremetal1 destroy --experiment tst-eafb72dc tst