2026-05-09 01:15:18.308728 | Job console starting 2026-05-09 01:15:18.322627 | Updating git repos 2026-05-09 01:15:18.373965 | Cloning repos into workspace 2026-05-09 01:15:18.423435 | Restoring repo states 2026-05-09 01:15:18.482572 | Merging changes 2026-05-09 01:15:19.071695 | Checking out repos 2026-05-09 01:15:19.119426 | Preparing playbooks 2026-05-09 01:15:20.565235 | Running Ansible setup 2026-05-09 01:16:46.664182 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-09 01:16:47.514384 | 2026-05-09 01:16:47.514563 | PLAY [Base pre] 2026-05-09 01:16:47.540880 | 2026-05-09 01:16:47.541042 | TASK [Setup log path fact] 2026-05-09 01:16:47.560299 | debian-bookworm | ok 2026-05-09 01:16:47.577244 | 2026-05-09 01:16:47.577446 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 01:16:47.606483 | debian-bookworm | ok 2026-05-09 01:16:47.616712 | 2026-05-09 01:16:47.616851 | TASK [emit-job-header : Print job information] 2026-05-09 01:16:47.656542 | # Job Information 2026-05-09 01:16:47.656741 | Ansible Version: 2.16.14 2026-05-09 01:16:47.656776 | Job: python-black 2026-05-09 01:16:47.656808 | Pipeline: check 2026-05-09 01:16:47.656831 | Executor: 521e9411259a 2026-05-09 01:16:47.656852 | Triggered by: https://github.com/osism/container-image-kolla-ansible/pull/898 2026-05-09 01:16:47.656875 | Event ID: 842124e0-4b44-11f1-826a-f044d112d49b 2026-05-09 01:16:47.661860 | 2026-05-09 01:16:47.661976 | LOOP [emit-job-header : Print node information] 2026-05-09 01:16:47.771869 | debian-bookworm | ok: 2026-05-09 01:16:47.772082 | debian-bookworm | # Node Information 2026-05-09 01:16:47.772118 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-09 01:16:47.772144 | debian-bookworm | Hostname: debian 2026-05-09 01:16:47.772166 | debian-bookworm | Username: zuul 2026-05-09 01:16:47.772187 | debian-bookworm | Distro: Debian 12.13 2026-05-09 01:16:47.772211 | debian-bookworm | Provider: regiocloud-a 2026-05-09 01:16:47.772232 | debian-bookworm | Region: 2026-05-09 01:16:47.772253 | debian-bookworm | Label: debian-bookworm 2026-05-09 01:16:47.772288 | debian-bookworm | Product Name: OpenStack Nova 2026-05-09 01:16:47.772308 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec3:2d21 2026-05-09 01:16:47.788406 | 2026-05-09 01:16:47.788554 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-09 01:16:48.273644 | debian-bookworm -> localhost | changed 2026-05-09 01:16:48.282357 | 2026-05-09 01:16:48.282502 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-09 01:16:49.432382 | debian-bookworm -> localhost | changed 2026-05-09 01:16:49.444503 | 2026-05-09 01:16:49.444631 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-09 01:16:49.722730 | debian-bookworm -> localhost | ok 2026-05-09 01:16:49.732155 | 2026-05-09 01:16:49.732329 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-09 01:16:49.778114 | debian-bookworm | ok 2026-05-09 01:16:49.796107 | debian-bookworm | included: /var/lib/zuul/builds/5ef48ed8d46b465bbd6cce867f7cb71b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-09 01:16:49.802792 | 2026-05-09 01:16:49.802960 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-09 01:16:51.346036 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-09 01:16:51.346615 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5ef48ed8d46b465bbd6cce867f7cb71b/work/5ef48ed8d46b465bbd6cce867f7cb71b_id_rsa 2026-05-09 01:16:51.346767 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5ef48ed8d46b465bbd6cce867f7cb71b/work/5ef48ed8d46b465bbd6cce867f7cb71b_id_rsa.pub 2026-05-09 01:16:51.346953 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-09 01:16:51.347034 | debian-bookworm -> localhost | SHA256:Qo2K2Vu/V8J430WI5ktP8bxSnqvpG4/VXOw0ex2Ob9g zuul-build-sshkey 2026-05-09 01:16:51.347130 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-09 01:16:51.347194 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-09 01:16:51.347255 | debian-bookworm -> localhost | | | 2026-05-09 01:16:51.347399 | debian-bookworm -> localhost | | o | 2026-05-09 01:16:51.347461 | debian-bookworm -> localhost | | o . . . | 2026-05-09 01:16:51.347519 | debian-bookworm -> localhost | | + o o o..| 2026-05-09 01:16:51.347575 | debian-bookworm -> localhost | | o o o So o B+| 2026-05-09 01:16:51.347654 | debian-bookworm -> localhost | | o o. + + +=@| 2026-05-09 01:16:51.347716 | debian-bookworm -> localhost | | . .. = B==O| 2026-05-09 01:16:51.347774 | debian-bookworm -> localhost | | .. ooXE.| 2026-05-09 01:16:51.347834 | debian-bookworm -> localhost | | .. .*=+.| 2026-05-09 01:16:51.347894 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-09 01:16:51.348044 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.002146 2026-05-09 01:16:51.366858 | 2026-05-09 01:16:51.367042 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-09 01:16:51.401385 | debian-bookworm | ok 2026-05-09 01:16:51.413841 | debian-bookworm | included: /var/lib/zuul/builds/5ef48ed8d46b465bbd6cce867f7cb71b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-09 01:16:51.425149 | 2026-05-09 01:16:51.425294 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-09 01:16:51.450928 | debian-bookworm | skipping: Conditional result was False 2026-05-09 01:16:51.457299 | 2026-05-09 01:16:51.457414 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-09 01:16:52.100980 | debian-bookworm | changed 2026-05-09 01:16:52.109383 | 2026-05-09 01:16:52.109514 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-09 01:16:52.402295 | debian-bookworm | ok 2026-05-09 01:16:52.411670 | 2026-05-09 01:16:52.411846 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-09 01:16:53.093842 | debian-bookworm | changed 2026-05-09 01:16:53.103661 | 2026-05-09 01:16:53.103816 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-09 01:16:53.777239 | debian-bookworm | changed 2026-05-09 01:16:53.783548 | 2026-05-09 01:16:53.783671 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-09 01:16:53.817712 | debian-bookworm | skipping: Conditional result was False 2026-05-09 01:16:53.827297 | 2026-05-09 01:16:53.827440 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-09 01:16:54.309819 | debian-bookworm -> localhost | changed 2026-05-09 01:16:54.321467 | 2026-05-09 01:16:54.321610 | TASK [add-build-sshkey : Add back temp key] 2026-05-09 01:16:54.703673 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5ef48ed8d46b465bbd6cce867f7cb71b/work/5ef48ed8d46b465bbd6cce867f7cb71b_id_rsa (zuul-build-sshkey) 2026-05-09 01:16:54.704175 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019678 2026-05-09 01:16:54.720807 | 2026-05-09 01:16:54.720962 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-09 01:16:55.138356 | debian-bookworm | ok 2026-05-09 01:16:55.148797 | 2026-05-09 01:16:55.148969 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-09 01:16:55.184626 | debian-bookworm | skipping: Conditional result was False 2026-05-09 01:16:55.206421 | 2026-05-09 01:16:55.206579 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-09 01:16:55.675088 | debian-bookworm | ok 2026-05-09 01:16:55.690191 | 2026-05-09 01:16:55.690378 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-09 01:16:55.734951 | debian-bookworm | ok 2026-05-09 01:16:55.743228 | 2026-05-09 01:16:55.743402 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-09 01:16:56.062465 | debian-bookworm -> localhost | ok 2026-05-09 01:16:56.070118 | 2026-05-09 01:16:56.070248 | TASK [validate-host : Collect information about the host] 2026-05-09 01:17:37.273021 | debian-bookworm | ok 2026-05-09 01:17:37.283596 | 2026-05-09 01:17:37.283724 | TASK [validate-host : Sanitize hostname] 2026-05-09 01:17:37.413794 | debian-bookworm | ok 2026-05-09 01:17:37.489540 | 2026-05-09 01:17:37.489740 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-09 01:17:38.094217 | debian-bookworm -> localhost | changed 2026-05-09 01:17:38.109142 | 2026-05-09 01:17:38.109333 | TASK [validate-host : Collect information about zuul worker] 2026-05-09 01:17:38.540996 | debian-bookworm | ok 2026-05-09 01:17:38.548612 | 2026-05-09 01:17:38.548773 | TASK [validate-host : Write out all zuul information for each host] 2026-05-09 01:17:39.131581 | debian-bookworm -> localhost | changed 2026-05-09 01:17:39.145959 | 2026-05-09 01:17:39.146127 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-09 01:17:39.447555 | debian-bookworm | ok 2026-05-09 01:17:39.460722 | 2026-05-09 01:17:39.460900 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-09 01:17:40.366985 | debian-bookworm | changed: 2026-05-09 01:17:40.367330 | debian-bookworm | cd+++++++++ src/ 2026-05-09 01:17:40.367394 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-09 01:17:40.367436 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-09 01:17:40.367474 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2026-05-09 01:17:40.367510 | debian-bookworm | Containerfile 2026-05-09 01:17:40.367770 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/5ef48ed8d46b465bbd6cce867f7cb71b/work/logs" 2026-05-09 01:22:04.875505 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5ef48ed8d46b465bbd6cce867f7cb71b/work/artifacts" 2026-05-09 01:22:05.164289 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5ef48ed8d46b465bbd6cce867f7cb71b/work/docs" 2026-05-09 01:22:05.191741 | 2026-05-09 01:22:05.191924 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-09 01:22:06.013761 | debian-bookworm | changed: 2026-05-09 01:22:06.014170 | debian-bookworm | .d..t...... ./ 2026-05-09 01:22:06.014247 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-09 01:22:06.014310 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-09 01:22:06.014366 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-09 01:22:06.014440 | debian-bookworm | changed: All items complete 2026-05-09 01:22:06.014483 | 2026-05-09 01:22:06.599774 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 01:22:07.183807 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 01:22:07.211526 | 2026-05-09 01:22:07.211676 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-09 01:22:07.771284 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011059 2026-05-09 01:22:08.070361 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.012132 2026-05-09 01:22:08.094685 | 2026-05-09 01:22:08.094874 | PLAY RECAP 2026-05-09 01:22:08.094963 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-09 01:22:08.095005 | 2026-05-09 01:22:08.235355 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-09 01:22:08.236216 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 01:22:08.982559 | 2026-05-09 01:22:08.982733 | PLAY [Base post] 2026-05-09 01:22:08.996984 | 2026-05-09 01:22:08.997131 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-09 01:22:09.573661 | debian-bookworm | changed 2026-05-09 01:22:09.583444 | 2026-05-09 01:22:09.583590 | PLAY RECAP 2026-05-09 01:22:09.583667 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-09 01:22:09.583741 | 2026-05-09 01:22:09.725351 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 01:22:09.727448 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-09 01:22:10.527776 | 2026-05-09 01:22:10.528013 | PLAY [Base post-logs] 2026-05-09 01:22:10.539104 | 2026-05-09 01:22:10.539293 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-09 01:22:11.099395 | localhost | changed 2026-05-09 01:22:11.118168 | 2026-05-09 01:22:11.118387 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-09 01:22:11.158627 | localhost | ok 2026-05-09 01:22:11.165071 | 2026-05-09 01:22:11.165259 | TASK [Set zuul-log-path fact] 2026-05-09 01:22:11.195172 | localhost | ok 2026-05-09 01:22:11.211221 | 2026-05-09 01:22:11.211443 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 01:22:11.238556 | localhost | ok 2026-05-09 01:22:11.243087 | 2026-05-09 01:22:11.243272 | TASK [upload-logs : Create log directories] 2026-05-09 01:22:11.778249 | localhost | changed 2026-05-09 01:22:11.781611 | 2026-05-09 01:22:11.781738 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-09 01:22:12.332271 | localhost -> localhost | ok: Runtime: 0:00:00.007123 2026-05-09 01:22:12.337989 | 2026-05-09 01:22:12.338241 | TASK [upload-logs : Upload logs to log server] 2026-05-09 01:22:12.925732 | localhost | Output suppressed because no_log was given 2026-05-09 01:22:12.930292 | 2026-05-09 01:22:12.930635 | LOOP [upload-logs : Compress console log and json output] 2026-05-09 01:22:12.993083 | localhost | skipping: Conditional result was False 2026-05-09 01:22:12.998256 | localhost | skipping: Conditional result was False 2026-05-09 01:22:13.012348 | 2026-05-09 01:22:13.012518 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-09 01:22:13.060725 | localhost | skipping: Conditional result was False 2026-05-09 01:22:13.061645 | 2026-05-09 01:22:13.064518 | localhost | skipping: Conditional result was False 2026-05-09 01:22:13.071448 | 2026-05-09 01:22:13.071642 | LOOP [upload-logs : Upload console log and json output]