Run Test: slices-bi-singlenode-login 2026-06-22 08:01:06.274097 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmpdqjopvcx.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-22 08:01:12.701892 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/f7c7c525-9428-4fc7-a4ba-c4bb75370078/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-22 08:01:54.400540 CEST - Run: slices --version 2026-06-22 08:01:58.077228 CEST - 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-06-22 08:01:58.077492 CEST - Run: slices pubkey list --format text 2026-06-22 08:02:00.854295 CEST - Pubkey already registered 2026-06-22 08:02:00.854542 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-22 08:02:01.469729 CEST - Refreshed infrastructure list. Total: 23 entries. 2026-06-22 08:02:01.469853 CEST - Check List Flavors 2026-06-22 08:02:01.470005 CEST - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-06-22 08:02:02.335571 CEST - Check List DiskImages 2026-06-22 08:02:02.335744 CEST - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-06-22 08:02:03.051369 CEST - Requesting resources 2026-06-22 08:02:03.051868 CEST - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-d507bb3e 2026-06-22 08:02:04.869144 CEST - Resource ID: r_be-gent1-bi-vm1_01kvpyqxh2f4zbpnb2tka7js5y 2026-06-22 08:02:04.869324 CEST - Waiting until resource ready 2026-06-22 08:02:06.869660 CEST - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-d507bb3e tst 2026-06-22 08:02:10.255386 CEST - Status: IMAGING 2026-06-22 08:02:17.633154 CEST - Status: BOOTING 2026-06-22 08:02:23.815554 CEST - Status: BOOTING 2026-06-22 08:02:33.547687 CEST - Status: UP 2026-06-22 08:02:33.547786 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kvpyqwyvfy5vhmtzd782n519 2026-06-22 08:02:33.547828 CEST - Validate resources 2026-06-22 08:02:40.232227 CEST - The fields of the created resource were validated. 2026-06-22 08:02:40.232309 CEST - Step 'Validate resources' took 6.68 seconds, which is longer than the warning threshold of 5 seconds 2026-06-22 08:02:40.232338 CEST - Check if resources are registered in experiment 2026-06-22 08:02:40.232481 CEST - Run: slices experiment list-resources --format json tst-d507bb3e 2026-06-22 08:02:46.869376 CEST - Status (on expauth): UP 2026-06-22 08:02:46.869529 CEST - Testing extend expires_at (all resources in experiment) 2026-06-22 08:02:46.869660 CEST - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-d507bb3e 2026-06-22 08:02:54.222449 CEST - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-d507bb3e tst 2026-06-22 08:03:01.707795 CEST - Run: slices experiment list-resources --format json tst-d507bb3e 2026-06-22 08:03:08.997958 CEST - expires_at (on expauth): 2026-06-22T09:02:00Z (correctly extended) 2026-06-22 08:03:08.998047 CEST - Testing extend expires_at (single resource in experiment) 2026-06-22 08:03:08.998215 CEST - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-d507bb3e 2026-06-22 08:03:09.575426 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/f7c7c525-9428-4fc7-a4ba-c4bb75370078/step_Checkextendexpire_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-d507bb3e 2026-06-22 08:03:09.575525 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/f7c7c525-9428-4fc7-a4ba-c4bb75370078/experiment-extend-all.txt': Extending Experiment container from 2026-06-22 10:02 CEST to 2026-06-22 11:02 CEST... Extending the resources only on infrastructure be-gent1-bi-vm1. Use slices bi experiment list-resources to verify other infrastructures. 10.0% / task starting ♻ Resources on infrastructure be-gent1-bi-vm1 now expire on 2026-06-22 11:02 CEST. Overview of extended resources in experiment tst-d507bb3e ┏━━━━━━━━━━━━━━━┳━━━━━━━━━━━━━━━━━┳━━━━━━┳━━━━━━━━┳━━━━━━━━━━━━━┳━━━━━━━━━━━━━━━━━━━━━━━┳━━━━━━━━━━━━━━━━━━━━━━━┓ ┃ Friendly Name ┃ Infra ┃ Type ┃ Status ┃ Description ┃ Created At ┃ Expires At ┃ ┡━━━━━━━━━━━━━━━╇━━━━━━━━━━━━━━━━━╇━━━━━━╇━━━━━━━━╇━━━━━━━━━━━━━╇━━━━━━━━━━━━━━━━━━━━━━━╇━━━━━━━━━━━━━━━━━━━━━━━┩ │ tst │ be-gent1-bi-vm1 │ vm │ up │ Minimal VM │ 2026-06-22 08:02 CEST │ 2026-06-22 11:02 CEST │ └───────────────┴─────────────────┴──────┴────────┴─────────────┴───────────────────────┴───────────────────────┘ 2026-06-22 08:03:09.575582 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/f7c7c525-9428-4fc7-a4ba-c4bb75370078/step_Checkextendexpire_command_2.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-d507bb3e tst 2026-06-22 08:03:09.575641 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/f7c7c525-9428-4fc7-a4ba-c4bb75370078/list-bi-resources-after-extend_json.txt': [ { "cluster_id": "default", "created_at": "2026-06-22T06:02:04.698920Z", "disk_image_id": "image_be-gent1-bi-vm1_1nercx939p9jrs9eagt0pa5az9", "experiment_id": "exp_expauth.ilabt.imec.be_01kvpyqwyvfy5vhmtzd782n519", "expires_at": "2026-06-22T09:02:00Z", "flavor_id": "flavor_be-gent1-bi-vm1_01hz4zw0nmf2ytgck5k0e9mj52", "friendly_name": "tst", "id": "r_be-gent1-bi-vm1_01kvpyqxh2f4zbpnb2tka7js5y", "network_interfaces": [], "private_ipv4": "10.10.211.111", "private_ipv6": null, "public_ipv4": null, "public_ipv6": null, "ssh_authorized_keys": [ "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINNiZPtQkfCEsc1x2QSwNWekfhWwWZbOvpE8hE0dH253 Wim (ftester) Van de Meerssche" ], "ssh_logins": [ { "host": "10.10.211.111", "port": 22, "username": "ubuntu", "host_keys": [ "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCmMA4NCOUXFDnGRlkTlSisJ/cf7GdtCFsxW2lRz2q/myZCH4qB65TlXeAGkJQxq143cd0wL3tjAfRoF/h4ClOqjNqaIJVUZ4WcARFhKH+uvPJ+UCBn0PZqFXFJ4Rns8vWY1w9WKRkJKXgki5r9M2VAffoFElHjX/i/QJTIeu2mMFalXmbWNdrwzzUXfuv8oxjBigXc7xEwLbT1wWws5Ci4WNzfNvclIeiEz+IawjfkSzgliGaNEC1VOXrfUqhTkLDgxi9N2K5fFeuvgvcEmUQ29tRzYSYQAgoDHdXen/rZmrAWKLJbhcWDFhoaM9Hp5/MBkMDvWbB8wd0L+QVIHs2DHgqQjfsjWa78Hd0ZdGPLo7BokFfHJ5I4quyAfxMQxLkI+p21A64w0EuNprAKPjZsHHZJWtyqH7/OfssNv2BoDxezF+sfAJU5Tkdlufa4FLphZxrsnsH7OzbZ66tyWz671LUHkcb5L8SChbbj/Yynmh7R4MWHOJ5eqGKcHoZkw0M= root@tst\n", "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBMQa8E/mUC27LeeGa85688+bGyFgiG60Thc5JLbvuYcs7D15UNjLYwEl/yjCGw8SS8Dz6UoMQ098mo2G1UJhzJc= root@tst\n", "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIPsWvPxiwPhmmatgfqFvtLkBZV16IzJP+Sg8B7kedbFZ root@tst\n" ], "description": null, "jump_proxy": { "host": "bastion2.slices-be.eu", "port": 22, "username": "proxy", "host_keys": [ "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBJN6TYSYhsur8SQrT+Q5KBigBIHodnmiQ/eNuv1zw2Gei71Msqzrp+0bSfTt6zHXAL8a81Cuj0NeMhEDPTtm18A= root@debian12", "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIADM/d3pY5i3JP964CEHS7QtHeZbQhTpOaBW2tXMxWiE root@debian12", "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCXQNkuP2CF6sEH4q51SL/U3GNHG5aItlyF2dgYkuSSEhc+yQAhNok9IbVY9Bif7pRDnUfwZWTtGLTyYPKtqecEfaVJWshGxIZgujUPhWCoyfnJyTFWT2Rf1BC/JXUKE1M7ry06/F/7MHWQrkH+CBosfMZ3AHiWAULulDfWQD62cT5oDA2wV5usHF81G07ETYD89vcrlx/n6w5tsn9h0gtUah3RkAmLd/oZaIeMkvNFhHhmcRJGPLiJQyFx2oVkXnW76RpBS8QoDfEMJNEofT3ErE8v+j7SRNhs/dC0BVbyoEPMSKx8VN5+1K8vYxwfSJ9H8Uqk/vi26vvXxorIH1tZtQdCHT7PEYv8bCX2s4vnD1IR2AVtjpJ7zVV3k6vsCivTDrWV2JrTYbW/3DFG/VIQ9lpqne2ymKpplIK+0EEWZc496BdlC74/i9LwttJ0KxTuQ8ZalG21asSR29pL/Wx1Bqj/Fvmgv3o5jWbjlt3lVzhMxLLDmMX4wZuLGcQYA90= root@debian12" ], "description": null, "jump_proxy": null } } ], "status": "up", "terminated_at": null, "userdata": null, "console_url": "https://console-gent1.slices-be.eu/exp_expauth.ilabt.imec.be_01kvpyqwyvfy5vhmtzd782n519/r_be-gent1-bi-vm1_01kvpyqxh2f4zbpnb2tka7js5y/", "machine_id": null, "failure_reason": null, "infra_id": "be-gent1-bi-vm1", "machine_name": null } ] 2026-06-22 08:03:09.575687 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/f7c7c525-9428-4fc7-a4ba-c4bb75370078/step_Checkextendexpire_command_3.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices experiment list-resources --format json tst-d507bb3e 2026-06-22 08:03:09.575726 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/f7c7c525-9428-4fc7-a4ba-c4bb75370078/experiment-list-resources-after-extend.txt': [ { "id": "r_be-gent1-bi-vm1_01kvpyqxh2f4zbpnb2tka7js5y", "created_at": "2026-06-22T06:02:04.698920Z", "created_by": "user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g", "experiment_id": "exp_expauth.ilabt.imec.be_01kvpyqwyvfy5vhmtzd782n519", "friendly_name": "tst", "project_id": "proj_account.ilabt.imec.be_5pzabws7n79ydsagfg3vntg590", "service_id": "bi", "infra_id": "be-gent1-bi-vm1", "status": "up", "type": "vm", "description": "Minimal VM", "expires_at": "2026-06-22T09:02:00Z", "terminated_at": null, "terminated_by": null } ] 2026-06-22 08:03:09.575758 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/f7c7c525-9428-4fc7-a4ba-c4bb75370078/step_Checkextendexpire_command_4.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-d507bb3e 2026-06-22 08:03:09.575795 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/f7c7c525-9428-4fc7-a4ba-c4bb75370078/experiment-extend-resource.txt': Traceback (most recent call last): File "/opt/slices-monitor-worker/slices-cli-venv/bin/slices", line 10, in sys.exit(main()) ~~~~^^ File "/opt/slices-monitor-worker/slices-cli-venv/lib/python3.14/site-packages/slices_cli/main.py", line 171, in main exec_subcommand(arg) ~~~~~~~~~~~~~~~^^^^^ File "/opt/slices-monitor-worker/slices-cli-venv/lib/python3.14/site-packages/slices_cli/child_exec.py", line 15, in exec_subcommand subcommand = find_subcommand(command) File "/opt/slices-monitor-worker/slices-cli-venv/lib/python3.14/site-packages/slices_cli/find_subcommands.py", line 326, in find_subcommand all = find_subcommands() File "/opt/slices-monitor-worker/slices-cli-venv/lib/python3.14/site-packages/slices_cli/find_subcommands.py", line 246, in find_subcommands core_subcommands = find_core_subcommands() File "/opt/slices-monitor-worker/slices-cli-venv/lib/python3.14/site-packages/slices_cli/find_subcommands.py", line 122, in find_core_subcommands cached_manifest = get_cached_subcommand_manifest(slices_core_path, "core") File "/opt/slices-monitor-worker/slices-cli-venv/lib/python3.14/site-packages/slices_cli/cache.py", line 42, in get_cached_subcommand_manifest f.unlink() ~~~~~~~~^^ File "/opt/uv-python-installs/cpython-3.14.1-linux-x86_64-gnu/lib/python3.14/pathlib/__init__.py", line 1042, in unlink os.unlink(self) ~~~~~~~~~^^^^^^ FileNotFoundError: [Errno 2] No such file or directory: '/root/.slices/cache/cache_subcommand_manifest_core.json' 2026-06-22 08:03:09.575816 CEST - Error in test step 'Check extend expire': "slices bi extend" failed 2026-06-22 08:03:09.575858 CEST - Testing ssh login 2026-06-22 08:03:09.612094 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d507bb3e tst 2026-06-22 08:03:17.006800 CEST - Step 'Ssh info ssh_config' took 7.39 seconds, which is longer than the warning threshold of 5 seconds 2026-06-22 08:03:17.007030 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d507bb3e tst 2026-06-22 08:03:24.251099 CEST - Step 'Check SSH pubkey (resource)' took 7.24 seconds, which is longer than the warning threshold of 5 seconds 2026-06-22 08:03:24.251298 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-d507bb3e tst 2026-06-22 08:03:31.683788 CEST - Step 'Check SSH pubkey (proxy)' took 7.43 seconds, which is longer than the warning threshold of 5 seconds 2026-06-22 08:03:31.683911 CEST - Logging in using 'slices bi ssh' 2026-06-22 08:03:31.683942 CEST - Forcing IPv4 only. 2026-06-22 08:03:31.684069 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-d507bb3e tst -- -4 uname -a 2026-06-22 08:03:39.016676 CEST - Forcing IPv4 only. 2026-06-22 08:03:39.016880 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-d507bb3e tst -- -4 uptime 2026-06-22 08:03:44.849279 CEST - CLI SSH Test passed. 2026-06-22 08:03:44.849349 CEST - Uname: Linux tst 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-06-22 08:03:44.849367 CEST - Uptime: 08:03:44 up 1 min, 1 user, load average: 0.12, 0.04, 0.01 2026-06-22 08:03:44.849397 CEST - Logging in using SSH (extra test: ignore SSH proxy) 2026-06-22 08:03:44.849812 CEST - Added paramiko HostKeyEntry for 10.10.211.111 2026-06-22 08:03:44.850973 CEST - Added paramiko HostKeyEntry for 10.10.211.111 2026-06-22 08:03:44.851148 CEST - Added paramiko HostKeyEntry for 10.10.211.111 2026-06-22 08:03:44.851314 CEST - Connecting to 10.10.211.111:22 2026-06-22 08:03:45.148499 CEST - SSH Test output: 2026-06-22 08:03:45.148585 CEST - Uname: Linux tst 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-06-22 08:03:45.148608 CEST - Uptime: 08:03:45 up 1 min, 1 user, load average: 0.12, 0.04, 0.01 2026-06-22 08:03:45.198423 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-22 08:03:45.198499 CEST - lsb_release matches expected value 2026-06-22 08:03:45.198525 CEST - SSH Test passed. 2026-06-22 08:03:45.198612 CEST - Logging in using SSH over SSH proxy 2026-06-22 08:03:45.198755 CEST - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-d507bb3e tst 2026-06-22 08:03:52.040185 CEST - Step 'Ssh info proxy_pubkey_openssh' took 6.84 seconds, which is longer than the warning threshold of 5 seconds 2026-06-22 08:03:52.040581 CEST - Added paramiko HostKeyEntry for 10.10.211.111 2026-06-22 08:03:52.040731 CEST - Added paramiko HostKeyEntry for 10.10.211.111 2026-06-22 08:03:52.040782 CEST - Added paramiko HostKeyEntry for 10.10.211.111 2026-06-22 08:03:52.040988 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-22 08:03:52.041030 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-22 08:03:52.041129 CEST - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-06-22 08:03:52.041145 CEST - Connecting to proxy bastion2.slices-be.eu:22 2026-06-22 08:03:52.367843 CEST - Connecting to 10.10.211.111:22 over proxy 2026-06-22 08:03:52.669288 CEST - SSH Test output: 2026-06-22 08:03:52.669351 CEST - Uname: Linux tst 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-06-22 08:03:52.669368 CEST - Uptime: 08:03:52 up 1 min, 2 users, load average: 0.11, 0.04, 0.01 2026-06-22 08:03:52.722030 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-22 08:03:52.722101 CEST - lsb_release matches expected value 2026-06-22 08:03:52.722117 CEST - SSH Test passed. 2026-06-22 08:03:52.750976 CEST - Destroying tst-d507bb3e tst 2026-06-22 08:03:52.751203 CEST - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-d507bb3e tst