2026-05-21 03:13:56.452573 | Job console starting 2026-05-21 03:13:56.473894 | Updating git repos 2026-05-21 03:13:56.570064 | Cloning repos into workspace 2026-05-21 03:13:56.696916 | Restoring repo states 2026-05-21 03:13:56.749130 | Merging changes 2026-05-21 03:13:56.749148 | Checking out repos 2026-05-21 03:13:57.072272 | Preparing playbooks 2026-05-21 03:13:58.647994 | Running Ansible setup 2026-05-21 03:14:03.375331 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 03:14:04.068444 | 2026-05-21 03:14:04.068569 | PLAY [Base pre] 2026-05-21 03:14:04.084412 | 2026-05-21 03:14:04.084519 | TASK [Setup log path fact] 2026-05-21 03:14:04.112567 | debian-bookworm | ok 2026-05-21 03:14:04.127680 | 2026-05-21 03:14:04.127792 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 03:14:04.166729 | debian-bookworm | ok 2026-05-21 03:14:04.176526 | 2026-05-21 03:14:04.176626 | TASK [emit-job-header : Print job information] 2026-05-21 03:14:04.214823 | # Job Information 2026-05-21 03:14:04.214995 | Ansible Version: 2.16.14 2026-05-21 03:14:04.215038 | Job: python-black 2026-05-21 03:14:04.215070 | Pipeline: periodic-daily 2026-05-21 03:14:04.215093 | Executor: 521e9411259a 2026-05-21 03:14:04.215114 | Triggered by: https://github.com/osism/ansible-collection-services 2026-05-21 03:14:04.215135 | Event ID: 4409a85da52940fdaf7c374d8fe3d82c 2026-05-21 03:14:04.219801 | 2026-05-21 03:14:04.219882 | LOOP [emit-job-header : Print node information] 2026-05-21 03:14:04.336819 | debian-bookworm | ok: 2026-05-21 03:14:04.337107 | debian-bookworm | # Node Information 2026-05-21 03:14:04.337171 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-21 03:14:04.337219 | debian-bookworm | Hostname: debian 2026-05-21 03:14:04.337261 | debian-bookworm | Username: zuul 2026-05-21 03:14:04.337301 | debian-bookworm | Distro: Debian 12.14 2026-05-21 03:14:04.337346 | debian-bookworm | Provider: regiocloud-a 2026-05-21 03:14:04.337385 | debian-bookworm | Region: 2026-05-21 03:14:04.337426 | debian-bookworm | Label: debian-bookworm 2026-05-21 03:14:04.337463 | debian-bookworm | Product Name: OpenStack Nova 2026-05-21 03:14:04.337501 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5e:41dd 2026-05-21 03:14:04.357642 | 2026-05-21 03:14:04.357787 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-21 03:14:04.825946 | debian-bookworm -> localhost | changed 2026-05-21 03:14:04.833646 | 2026-05-21 03:14:04.833759 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-21 03:14:05.923585 | debian-bookworm -> localhost | changed 2026-05-21 03:14:05.939759 | 2026-05-21 03:14:05.939906 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-21 03:14:06.345724 | debian-bookworm -> localhost | ok 2026-05-21 03:14:06.361305 | 2026-05-21 03:14:06.361576 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-21 03:14:06.421582 | debian-bookworm | ok 2026-05-21 03:14:06.465340 | debian-bookworm | included: /var/lib/zuul/builds/c8fd301125584d5d845850edc29a83d5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-21 03:14:06.471986 | 2026-05-21 03:14:06.472139 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-21 03:14:08.938790 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-21 03:14:08.939135 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c8fd301125584d5d845850edc29a83d5/work/c8fd301125584d5d845850edc29a83d5_id_rsa 2026-05-21 03:14:08.939184 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c8fd301125584d5d845850edc29a83d5/work/c8fd301125584d5d845850edc29a83d5_id_rsa.pub 2026-05-21 03:14:08.939207 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-21 03:14:08.939227 | debian-bookworm -> localhost | SHA256:qMDUbwgF2QHS9TUEQedagPAJKPFnGfbsXDvFT3nmpIo zuul-build-sshkey 2026-05-21 03:14:08.939246 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-21 03:14:08.939272 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-21 03:14:08.939371 | debian-bookworm -> localhost | |o+=B*+=+= | 2026-05-21 03:14:08.939396 | debian-bookworm -> localhost | |ooo*oB = o . | 2026-05-21 03:14:08.939414 | debian-bookworm -> localhost | |. + B + + o o + | 2026-05-21 03:14:08.939431 | debian-bookworm -> localhost | | o + = = o o * | 2026-05-21 03:14:08.939447 | debian-bookworm -> localhost | | o . B S o . | 2026-05-21 03:14:08.939468 | debian-bookworm -> localhost | | . o o . | 2026-05-21 03:14:08.939485 | debian-bookworm -> localhost | | . E . | 2026-05-21 03:14:08.939501 | debian-bookworm -> localhost | | | 2026-05-21 03:14:08.939519 | debian-bookworm -> localhost | | | 2026-05-21 03:14:08.939535 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-21 03:14:08.939717 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.941741 2026-05-21 03:14:08.946297 | 2026-05-21 03:14:08.946376 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-21 03:14:09.007178 | debian-bookworm | ok 2026-05-21 03:14:09.036128 | debian-bookworm | included: /var/lib/zuul/builds/c8fd301125584d5d845850edc29a83d5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-21 03:14:09.083537 | 2026-05-21 03:14:09.083641 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-21 03:14:09.152191 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:14:09.159804 | 2026-05-21 03:14:09.160067 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-21 03:14:10.169548 | debian-bookworm | changed 2026-05-21 03:14:10.191738 | 2026-05-21 03:14:10.191851 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-21 03:14:10.525876 | debian-bookworm | ok 2026-05-21 03:14:10.533761 | 2026-05-21 03:14:10.533867 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-21 03:14:11.195295 | debian-bookworm | changed 2026-05-21 03:14:11.205525 | 2026-05-21 03:14:11.205652 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-21 03:14:11.903702 | debian-bookworm | changed 2026-05-21 03:14:11.910002 | 2026-05-21 03:14:11.910109 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-21 03:14:11.949240 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:14:11.956202 | 2026-05-21 03:14:11.956307 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-21 03:14:12.657144 | debian-bookworm -> localhost | changed 2026-05-21 03:14:12.668933 | 2026-05-21 03:14:12.669054 | TASK [add-build-sshkey : Add back temp key] 2026-05-21 03:14:13.009313 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c8fd301125584d5d845850edc29a83d5/work/c8fd301125584d5d845850edc29a83d5_id_rsa (zuul-build-sshkey) 2026-05-21 03:14:13.011948 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010255 2026-05-21 03:14:13.029105 | 2026-05-21 03:14:13.029251 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-21 03:14:13.432931 | debian-bookworm | ok 2026-05-21 03:14:13.439318 | 2026-05-21 03:14:13.439428 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-21 03:14:13.463546 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:14:13.477287 | 2026-05-21 03:14:13.477405 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-21 03:14:13.898119 | debian-bookworm | ok 2026-05-21 03:14:13.918406 | 2026-05-21 03:14:13.918529 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-21 03:14:13.971389 | debian-bookworm | ok 2026-05-21 03:14:13.976476 | 2026-05-21 03:14:13.976571 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-21 03:14:14.548785 | debian-bookworm -> localhost | ok 2026-05-21 03:14:14.555405 | 2026-05-21 03:14:14.555501 | TASK [validate-host : Collect information about the host] 2026-05-21 03:14:15.913986 | debian-bookworm | ok 2026-05-21 03:14:15.941159 | 2026-05-21 03:14:15.941331 | TASK [validate-host : Sanitize hostname] 2026-05-21 03:14:16.157644 | debian-bookworm | ok 2026-05-21 03:14:16.214029 | 2026-05-21 03:14:16.214197 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-21 03:14:17.110470 | debian-bookworm -> localhost | changed 2026-05-21 03:14:17.117211 | 2026-05-21 03:14:17.117337 | TASK [validate-host : Collect information about zuul worker] 2026-05-21 03:14:17.536329 | debian-bookworm | ok 2026-05-21 03:14:17.544727 | 2026-05-21 03:14:17.544859 | TASK [validate-host : Write out all zuul information for each host] 2026-05-21 03:14:19.492225 | debian-bookworm -> localhost | changed 2026-05-21 03:14:19.511128 | 2026-05-21 03:14:19.511230 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-21 03:14:19.825299 | debian-bookworm | ok 2026-05-21 03:14:19.829786 | 2026-05-21 03:14:19.829871 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-21 03:14:22.284622 | debian-bookworm | changed: 2026-05-21 03:14:22.284786 | debian-bookworm | cd+++++++++ src/ 2026-05-21 03:14:22.284814 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-21 03:14:22.284834 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-21 03:14:22.284852 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-05-21 03:14:22.284868 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c8fd301125584d5d845850edc29a83d5/work/logs" 2026-05-21 03:14:55.341996 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c8fd301125584d5d845850edc29a83d5/work/artifacts" 2026-05-21 03:14:55.710688 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c8fd301125584d5d845850edc29a83d5/work/docs" 2026-05-21 03:14:55.725442 | 2026-05-21 03:14:55.725561 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-21 03:14:56.783790 | debian-bookworm | changed: 2026-05-21 03:14:56.784028 | debian-bookworm | .d..t...... ./ 2026-05-21 03:14:56.784068 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-21 03:14:56.784093 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-21 03:14:56.784115 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-21 03:14:56.784158 | debian-bookworm | changed: All items complete 2026-05-21 03:14:56.784181 | 2026-05-21 03:14:57.339837 | debian-bookworm | changed: .d..t...... ./ 2026-05-21 03:14:57.901781 | debian-bookworm | changed: .d..t...... ./ 2026-05-21 03:14:57.928934 | 2026-05-21 03:14:57.930264 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-21 03:14:57.950783 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:14:57.953215 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:14:57.968637 | 2026-05-21 03:14:57.968697 | PLAY RECAP 2026-05-21 03:14:57.968736 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-21 03:14:57.968757 | 2026-05-21 03:14:58.046639 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-21 03:14:58.047310 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 03:14:58.874805 | 2026-05-21 03:14:58.874950 | PLAY [Base post] 2026-05-21 03:14:58.887543 | 2026-05-21 03:14:58.887644 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-21 03:14:59.440130 | debian-bookworm | changed 2026-05-21 03:14:59.445536 | 2026-05-21 03:14:59.445613 | PLAY RECAP 2026-05-21 03:14:59.445664 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 03:14:59.445715 | 2026-05-21 03:14:59.522781 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 03:14:59.523516 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-21 03:15:00.328334 | 2026-05-21 03:15:00.328474 | PLAY [Base post-logs] 2026-05-21 03:15:00.338413 | 2026-05-21 03:15:00.338536 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-21 03:15:00.780727 | localhost | changed 2026-05-21 03:15:00.790522 | 2026-05-21 03:15:00.790668 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-21 03:15:00.816054 | localhost | ok 2026-05-21 03:15:00.819295 | 2026-05-21 03:15:00.819382 | TASK [Set zuul-log-path fact] 2026-05-21 03:15:00.833758 | localhost | ok 2026-05-21 03:15:00.844289 | 2026-05-21 03:15:00.844400 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 03:15:00.879302 | localhost | ok 2026-05-21 03:15:00.882752 | 2026-05-21 03:15:00.882888 | TASK [upload-logs : Create log directories] 2026-05-21 03:15:01.557728 | localhost | changed 2026-05-21 03:15:01.560521 | 2026-05-21 03:15:01.560619 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-21 03:15:02.060947 | localhost -> localhost | ok: Runtime: 0:00:00.026168 2026-05-21 03:15:02.065510 | 2026-05-21 03:15:02.065612 | TASK [upload-logs : Upload logs to log server] 2026-05-21 03:15:02.684265 | localhost | Output suppressed because no_log was given 2026-05-21 03:15:02.686048 | 2026-05-21 03:15:02.686168 | LOOP [upload-logs : Compress console log and json output] 2026-05-21 03:15:02.748029 | localhost | skipping: Conditional result was False 2026-05-21 03:15:02.755284 | localhost | skipping: Conditional result was False 2026-05-21 03:15:02.762984 | 2026-05-21 03:15:02.763107 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-21 03:15:02.803735 | localhost | skipping: Conditional result was False 2026-05-21 03:15:02.803983 | 2026-05-21 03:15:02.810414 | localhost | skipping: Conditional result was False 2026-05-21 03:15:02.819293 | 2026-05-21 03:15:02.819412 | LOOP [upload-logs : Upload console log and json output]