2025-10-06 17:04:31.202024 | Job console starting 2025-10-06 17:04:31.224366 | Updating git repos 2025-10-06 17:04:31.279147 | Cloning repos into workspace 2025-10-06 17:04:31.344696 | Restoring repo states 2025-10-06 17:04:31.355948 | Merging changes 2025-10-06 17:04:31.355966 | Checking out repos 2025-10-06 17:04:31.422462 | Preparing playbooks 2025-10-06 17:04:32.171309 | Running Ansible setup 2025-10-06 17:04:36.234461 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-06 17:04:36.972041 | 2025-10-06 17:04:36.972181 | PLAY [Base pre] 2025-10-06 17:04:36.987362 | 2025-10-06 17:04:36.987468 | TASK [Setup log path fact] 2025-10-06 17:04:37.028878 | debian-bookworm | ok 2025-10-06 17:04:37.046717 | 2025-10-06 17:04:37.046848 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-06 17:04:37.076296 | debian-bookworm | ok 2025-10-06 17:04:37.085590 | 2025-10-06 17:04:37.085677 | TASK [emit-job-header : Print job information] 2025-10-06 17:04:37.123646 | # Job Information 2025-10-06 17:04:37.123797 | Ansible Version: 2.16.14 2025-10-06 17:04:37.123830 | Job: container-image-kolla-ansible-push-2024.2 2025-10-06 17:04:37.123864 | Pipeline: post 2025-10-06 17:04:37.123887 | Executor: 521e9411259a 2025-10-06 17:04:37.123906 | Triggered by: https://github.com/osism/container-image-kolla-ansible/commit/37a26c5795df26cdbe20f5a3f3c7c15632c8ae93 2025-10-06 17:04:37.123928 | Event ID: 82ca02cc-a2d6-11f0-813a-125045f4136d 2025-10-06 17:04:37.128585 | 2025-10-06 17:04:37.128674 | LOOP [emit-job-header : Print node information] 2025-10-06 17:04:37.233477 | debian-bookworm | ok: 2025-10-06 17:04:37.233676 | debian-bookworm | # Node Information 2025-10-06 17:04:37.233711 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-06 17:04:37.233737 | debian-bookworm | Hostname: debian 2025-10-06 17:04:37.233759 | debian-bookworm | Username: zuul 2025-10-06 17:04:37.233779 | debian-bookworm | Distro: Debian 12.12 2025-10-06 17:04:37.233802 | debian-bookworm | Provider: regiocloud-a 2025-10-06 17:04:37.233822 | debian-bookworm | Region: 2025-10-06 17:04:37.233843 | debian-bookworm | Label: debian-bookworm 2025-10-06 17:04:37.233862 | debian-bookworm | Product Name: OpenStack Nova 2025-10-06 17:04:37.233881 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecc:48c5 2025-10-06 17:04:37.260921 | 2025-10-06 17:04:37.261070 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-06 17:04:37.663796 | debian-bookworm -> localhost | changed 2025-10-06 17:04:37.670876 | 2025-10-06 17:04:37.670973 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-06 17:04:38.602257 | debian-bookworm -> localhost | changed 2025-10-06 17:04:38.620095 | 2025-10-06 17:04:38.620446 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-06 17:04:38.950297 | debian-bookworm -> localhost | ok 2025-10-06 17:04:38.962129 | 2025-10-06 17:04:38.962935 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-06 17:04:38.994719 | debian-bookworm | ok 2025-10-06 17:04:39.013132 | debian-bookworm | included: /var/lib/zuul/builds/1b158c79846a42789c57b0ce980df370/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-06 17:04:39.019543 | 2025-10-06 17:04:39.019627 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-06 17:04:40.093191 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-06 17:04:40.093702 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1b158c79846a42789c57b0ce980df370/work/1b158c79846a42789c57b0ce980df370_id_rsa 2025-10-06 17:04:40.093806 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1b158c79846a42789c57b0ce980df370/work/1b158c79846a42789c57b0ce980df370_id_rsa.pub 2025-10-06 17:04:40.093878 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-06 17:04:40.093943 | debian-bookworm -> localhost | SHA256:6zwWyHx5Dlp0weLz9XVek8wfhWcys1YubRpjzty7QlU zuul-build-sshkey 2025-10-06 17:04:40.094027 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-06 17:04:40.094117 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-06 17:04:40.094177 | debian-bookworm -> localhost | | . . | 2025-10-06 17:04:40.094237 | debian-bookworm -> localhost | | . o = E| 2025-10-06 17:04:40.094294 | debian-bookworm -> localhost | | . . . o@+| 2025-10-06 17:04:40.094349 | debian-bookworm -> localhost | | + . . BBB| 2025-10-06 17:04:40.094405 | debian-bookworm -> localhost | | o oS= . B.X*| 2025-10-06 17:04:40.094471 | debian-bookworm -> localhost | | + *.o .* +| 2025-10-06 17:04:40.094529 | debian-bookworm -> localhost | | +.= . .| 2025-10-06 17:04:40.094585 | debian-bookworm -> localhost | | .oo . . . | 2025-10-06 17:04:40.094644 | debian-bookworm -> localhost | | .o. ...| 2025-10-06 17:04:40.094701 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-06 17:04:40.094827 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.362471 2025-10-06 17:04:40.108233 | 2025-10-06 17:04:40.108357 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-06 17:04:40.139742 | debian-bookworm | ok 2025-10-06 17:04:40.149950 | debian-bookworm | included: /var/lib/zuul/builds/1b158c79846a42789c57b0ce980df370/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-06 17:04:40.159265 | 2025-10-06 17:04:40.159369 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-06 17:04:40.183654 | debian-bookworm | skipping: Conditional result was False 2025-10-06 17:04:40.190372 | 2025-10-06 17:04:40.190482 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-06 17:04:40.887755 | debian-bookworm | changed 2025-10-06 17:04:40.895310 | 2025-10-06 17:04:40.895421 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-06 17:04:41.153692 | debian-bookworm | ok 2025-10-06 17:04:41.167240 | 2025-10-06 17:04:41.167548 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-06 17:04:41.826872 | debian-bookworm | changed 2025-10-06 17:04:41.836095 | 2025-10-06 17:04:41.836226 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-06 17:04:42.496310 | debian-bookworm | changed 2025-10-06 17:04:42.505870 | 2025-10-06 17:04:42.505988 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-06 17:04:42.531990 | debian-bookworm | skipping: Conditional result was False 2025-10-06 17:04:42.539308 | 2025-10-06 17:04:42.539426 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-06 17:04:43.508811 | debian-bookworm -> localhost | changed 2025-10-06 17:04:43.541625 | 2025-10-06 17:04:43.541791 | TASK [add-build-sshkey : Add back temp key] 2025-10-06 17:04:44.165310 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1b158c79846a42789c57b0ce980df370/work/1b158c79846a42789c57b0ce980df370_id_rsa (zuul-build-sshkey) 2025-10-06 17:04:44.165628 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017830 2025-10-06 17:04:44.175252 | 2025-10-06 17:04:44.175368 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-06 17:04:44.631481 | debian-bookworm | ok 2025-10-06 17:04:44.641673 | 2025-10-06 17:04:44.641805 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-06 17:04:44.666750 | debian-bookworm | skipping: Conditional result was False 2025-10-06 17:04:44.677325 | 2025-10-06 17:04:44.677430 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-06 17:04:45.159374 | debian-bookworm | ok 2025-10-06 17:04:45.172472 | 2025-10-06 17:04:45.172597 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-06 17:04:45.223824 | debian-bookworm | ok 2025-10-06 17:04:45.233127 | 2025-10-06 17:04:45.233258 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-06 17:04:45.730264 | debian-bookworm -> localhost | ok 2025-10-06 17:04:45.737513 | 2025-10-06 17:04:45.737626 | TASK [validate-host : Collect information about the host] 2025-10-06 17:04:47.199270 | debian-bookworm | ok 2025-10-06 17:04:47.210226 | 2025-10-06 17:04:47.210347 | TASK [validate-host : Sanitize hostname] 2025-10-06 17:04:47.319393 | debian-bookworm | ok 2025-10-06 17:04:47.373306 | 2025-10-06 17:04:47.373495 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-06 17:04:47.970044 | debian-bookworm -> localhost | changed 2025-10-06 17:04:47.987622 | 2025-10-06 17:04:47.987763 | TASK [validate-host : Collect information about zuul worker] 2025-10-06 17:04:48.556905 | debian-bookworm | ok 2025-10-06 17:04:48.574397 | 2025-10-06 17:04:48.574576 | TASK [validate-host : Write out all zuul information for each host] 2025-10-06 17:04:49.504439 | debian-bookworm -> localhost | changed 2025-10-06 17:04:49.515220 | 2025-10-06 17:04:49.515355 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-06 17:04:49.772563 | debian-bookworm | ok 2025-10-06 17:04:49.778584 | 2025-10-06 17:04:49.778691 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-06 17:04:51.208486 | debian-bookworm | changed: 2025-10-06 17:04:51.208659 | debian-bookworm | cd+++++++++ src/ 2025-10-06 17:04:51.208696 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-06 17:04:51.208720 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-06 17:04:51.208742 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-10-06 17:04:51.208762 | debian-bookworm | Containerfile 2025-10-06 17:04:51.208892 | debian-bookworm | 2025-10-06 17:13:18.489474 | debian-bookworm | ERROR 2025-10-06 17:13:18.489983 | debian-bookworm | { 2025-10-06 17:13:18.490095 | debian-bookworm | "delta": "0:00:20.813559", 2025-10-06 17:13:18.490168 | debian-bookworm | "end": "2025-10-06 17:13:18.045963", 2025-10-06 17:13:18.490238 | debian-bookworm | "msg": "non-zero return code", 2025-10-06 17:13:18.490295 | debian-bookworm | "rc": 1, 2025-10-06 17:13:18.490349 | debian-bookworm | "start": "2025-10-06 17:12:57.232404" 2025-10-06 17:13:18.490401 | debian-bookworm | } failure 2025-10-06 17:13:18.494221 | 2025-10-06 17:13:18.494378 | PLAY RECAP 2025-10-06 17:13:18.494515 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-10-06 17:13:18.494584 | 2025-10-06 17:13:18.632168 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-10-06 17:13:18.633819 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-06 17:13:19.359465 | 2025-10-06 17:13:19.359654 | PLAY [Base post] 2025-10-06 17:13:19.373485 | 2025-10-06 17:13:19.373632 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-06 17:13:20.247305 | debian-bookworm | changed 2025-10-06 17:13:20.255235 | 2025-10-06 17:13:20.255344 | PLAY RECAP 2025-10-06 17:13:20.255406 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-06 17:13:20.255467 | 2025-10-06 17:13:20.378188 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-06 17:13:20.380726 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-06 17:13:21.187572 | 2025-10-06 17:13:21.187754 | PLAY [Base post-logs] 2025-10-06 17:13:21.198507 | 2025-10-06 17:13:21.198682 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-06 17:13:21.649430 | localhost | changed 2025-10-06 17:13:21.659570 | 2025-10-06 17:13:21.659742 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-06 17:13:21.695275 | localhost | ok 2025-10-06 17:13:21.699105 | 2025-10-06 17:13:21.699211 | TASK [Set zuul-log-path fact] 2025-10-06 17:13:21.714100 | localhost | ok 2025-10-06 17:13:21.722695 | 2025-10-06 17:13:21.722803 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-06 17:13:21.758411 | localhost | ok 2025-10-06 17:13:21.764170 | 2025-10-06 17:13:21.764311 | TASK [upload-logs : Create log directories] 2025-10-06 17:13:22.349763 | localhost | changed 2025-10-06 17:13:22.352797 | 2025-10-06 17:13:22.352908 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-06 17:13:22.833024 | localhost -> localhost | ok: Runtime: 0:00:00.006840 2025-10-06 17:13:22.837640 | 2025-10-06 17:13:22.837765 | TASK [upload-logs : Upload logs to log server] 2025-10-06 17:13:23.361386 | localhost | Output suppressed because no_log was given 2025-10-06 17:13:23.364538 | 2025-10-06 17:13:23.364711 | LOOP [upload-logs : Compress console log and json output] 2025-10-06 17:13:23.417718 | localhost | skipping: Conditional result was False 2025-10-06 17:13:23.422930 | localhost | skipping: Conditional result was False 2025-10-06 17:13:23.436986 | 2025-10-06 17:13:23.437170 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-06 17:13:23.490819 | localhost | skipping: Conditional result was False 2025-10-06 17:13:23.491406 | 2025-10-06 17:13:23.494886 | localhost | skipping: Conditional result was False 2025-10-06 17:13:23.508438 | 2025-10-06 17:13:23.508734 | LOOP [upload-logs : Upload console log and json output]