2026-09-14 03:02:05.424588 | Job console starting 2026-09-14 03:02:05.431621 | Updating git repos 2026-09-14 03:02:05.473532 | Cloning repos into workspace 2026-09-14 03:02:05.522286 | Restoring repo states 2026-09-14 03:02:05.543687 | Merging changes 2026-09-14 03:02:05.543703 | Checking out repos 2026-09-14 03:02:05.634453 | Preparing playbooks 2026-09-14 03:02:06.832549 | Running Ansible setup 2026-09-14 03:02:11.862618 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-14 03:02:12.609136 | 2026-09-14 03:02:12.609293 | PLAY [Base pre] 2026-09-14 03:02:12.631938 | 2026-09-14 03:02:12.632054 | TASK [Setup log path fact] 2026-09-14 03:02:12.670871 | debian-bookworm | ok 2026-09-14 03:02:12.702868 | 2026-09-14 03:02:12.703004 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-14 03:02:12.740961 | debian-bookworm | ok 2026-09-14 03:02:12.761701 | 2026-09-14 03:02:12.761813 | TASK [emit-job-header : Print job information] 2026-09-14 03:02:12.811405 | # Job Information 2026-09-14 03:02:12.811560 | Ansible Version: 2.16.14 2026-09-14 03:02:12.811595 | Job: python-black 2026-09-14 03:02:12.811628 | Pipeline: periodic-daily 2026-09-14 03:02:12.811651 | Executor: 521e9411259a 2026-09-14 03:02:12.811671 | Triggered by: https://github.com/osism/openstack-image-manager 2026-09-14 03:02:12.811693 | Event ID: be16b8d4e43c491f8654e7ee5e84e6dd 2026-09-14 03:02:12.816478 | 2026-09-14 03:02:12.816569 | LOOP [emit-job-header : Print node information] 2026-09-14 03:02:12.991343 | debian-bookworm | ok: 2026-09-14 03:02:12.991543 | debian-bookworm | # Node Information 2026-09-14 03:02:12.991591 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-14 03:02:12.991618 | debian-bookworm | Hostname: debian 2026-09-14 03:02:12.991641 | debian-bookworm | Username: zuul 2026-09-14 03:02:12.991662 | debian-bookworm | Distro: Debian 12.15 2026-09-14 03:02:12.991688 | debian-bookworm | Provider: regiocloud-a 2026-09-14 03:02:12.991709 | debian-bookworm | Region: 2026-09-14 03:02:12.991729 | debian-bookworm | Label: debian-bookworm 2026-09-14 03:02:12.991749 | debian-bookworm | Product Name: OpenStack Nova 2026-09-14 03:02:12.991769 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee9:e763 2026-09-14 03:02:13.004096 | 2026-09-14 03:02:13.004198 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-14 03:02:13.867648 | debian-bookworm -> localhost | changed 2026-09-14 03:02:13.874514 | 2026-09-14 03:02:13.874616 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-14 03:02:15.278809 | debian-bookworm -> localhost | changed 2026-09-14 03:02:15.297701 | 2026-09-14 03:02:15.297798 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-14 03:02:15.744600 | debian-bookworm -> localhost | ok 2026-09-14 03:02:15.751027 | 2026-09-14 03:02:15.751115 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-14 03:02:15.800076 | debian-bookworm | ok 2026-09-14 03:02:15.838881 | debian-bookworm | included: /var/lib/zuul/builds/ec8a9c77d1e248fd90e3c71960a107cf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-14 03:02:15.850389 | 2026-09-14 03:02:15.850473 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-14 03:02:19.922975 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-14 03:02:19.923190 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ec8a9c77d1e248fd90e3c71960a107cf/work/ec8a9c77d1e248fd90e3c71960a107cf_id_rsa 2026-09-14 03:02:19.923240 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ec8a9c77d1e248fd90e3c71960a107cf/work/ec8a9c77d1e248fd90e3c71960a107cf_id_rsa.pub 2026-09-14 03:02:19.923268 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-14 03:02:19.923292 | debian-bookworm -> localhost | SHA256:SSyK5E674l9CRMjtWQPk8N7chGXuC9IDgZIm3iSGR08 zuul-build-sshkey 2026-09-14 03:02:19.923314 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-14 03:02:19.923344 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-14 03:02:19.923367 | debian-bookworm -> localhost | |o+*=E o | 2026-09-14 03:02:19.923389 | debian-bookworm -> localhost | |=B*=.o=. | 2026-09-14 03:02:19.923409 | debian-bookworm -> localhost | |*.*=+.ooo | 2026-09-14 03:02:19.923428 | debian-bookworm -> localhost | | +o==.+o . | 2026-09-14 03:02:19.923448 | debian-bookworm -> localhost | | ++.* oS | 2026-09-14 03:02:19.923474 | debian-bookworm -> localhost | | o... o . | 2026-09-14 03:02:19.923496 | debian-bookworm -> localhost | | o. . . | 2026-09-14 03:02:19.923517 | debian-bookworm -> localhost | |. .o | 2026-09-14 03:02:19.923537 | debian-bookworm -> localhost | |.oo. | 2026-09-14 03:02:19.923558 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-14 03:02:19.923616 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.112777 2026-09-14 03:02:19.930565 | 2026-09-14 03:02:19.930660 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-14 03:02:19.968832 | debian-bookworm | ok 2026-09-14 03:02:19.983049 | debian-bookworm | included: /var/lib/zuul/builds/ec8a9c77d1e248fd90e3c71960a107cf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-14 03:02:20.003237 | 2026-09-14 03:02:20.003337 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-14 03:02:20.041541 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:02:20.047117 | 2026-09-14 03:02:20.047210 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-14 03:02:20.672830 | debian-bookworm | changed 2026-09-14 03:02:20.679740 | 2026-09-14 03:02:20.679830 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-14 03:02:20.924125 | debian-bookworm | ok 2026-09-14 03:02:20.928977 | 2026-09-14 03:02:20.929108 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-14 03:02:21.517998 | debian-bookworm | changed 2026-09-14 03:02:21.523279 | 2026-09-14 03:02:21.523377 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-14 03:02:22.122508 | debian-bookworm | changed 2026-09-14 03:02:22.127954 | 2026-09-14 03:02:22.128049 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-14 03:02:22.141416 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:02:22.148978 | 2026-09-14 03:02:22.149085 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-14 03:02:22.533475 | debian-bookworm -> localhost | changed 2026-09-14 03:02:22.542210 | 2026-09-14 03:02:22.542296 | TASK [add-build-sshkey : Add back temp key] 2026-09-14 03:02:22.869408 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ec8a9c77d1e248fd90e3c71960a107cf/work/ec8a9c77d1e248fd90e3c71960a107cf_id_rsa (zuul-build-sshkey) 2026-09-14 03:02:22.869656 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014068 2026-09-14 03:02:22.875989 | 2026-09-14 03:02:22.876071 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-14 03:02:23.442598 | debian-bookworm | ok 2026-09-14 03:02:23.450520 | 2026-09-14 03:02:23.450605 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-14 03:02:23.473130 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:02:23.496700 | 2026-09-14 03:02:23.496799 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-14 03:02:23.938056 | debian-bookworm | ok 2026-09-14 03:02:23.964288 | 2026-09-14 03:02:23.964402 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-14 03:02:24.012280 | debian-bookworm | ok 2026-09-14 03:02:24.016601 | 2026-09-14 03:02:24.016689 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-14 03:02:24.477740 | debian-bookworm -> localhost | ok 2026-09-14 03:02:24.483840 | 2026-09-14 03:02:24.483930 | TASK [validate-host : Collect information about the host] 2026-09-14 03:02:25.595616 | debian-bookworm | ok 2026-09-14 03:02:25.613987 | 2026-09-14 03:02:25.614088 | TASK [validate-host : Sanitize hostname] 2026-09-14 03:02:25.749132 | debian-bookworm | ok 2026-09-14 03:02:25.753526 | 2026-09-14 03:02:25.753619 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-14 03:02:26.201862 | debian-bookworm -> localhost | changed 2026-09-14 03:02:26.206575 | 2026-09-14 03:02:26.206659 | TASK [validate-host : Collect information about zuul worker] 2026-09-14 03:02:26.547881 | debian-bookworm | ok 2026-09-14 03:02:26.551594 | 2026-09-14 03:02:26.551673 | TASK [validate-host : Write out all zuul information for each host] 2026-09-14 03:02:27.645569 | debian-bookworm -> localhost | changed 2026-09-14 03:02:27.654692 | 2026-09-14 03:02:27.654780 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-14 03:02:27.926646 | debian-bookworm | ok 2026-09-14 03:02:27.931791 | 2026-09-14 03:02:27.931880 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-14 03:02:28.775766 | debian-bookworm | changed: 2026-09-14 03:02:28.775927 | debian-bookworm | cd+++++++++ src/ 2026-09-14 03:02:28.775961 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-14 03:02:28.775986 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-14 03:02:28.776008 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-09-14 03:02:28.776028 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/ec8a9c77d1e248fd90e3c71960a107cf/work/logs" 2026-09-14 03:03:30.131677 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ec8a9c77d1e248fd90e3c71960a107cf/work/artifacts" 2026-09-14 03:03:30.458821 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ec8a9c77d1e248fd90e3c71960a107cf/work/docs" 2026-09-14 03:03:30.471331 | 2026-09-14 03:03:30.471441 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-14 03:03:31.297288 | debian-bookworm | changed: 2026-09-14 03:03:31.297545 | debian-bookworm | .d..t...... ./ 2026-09-14 03:03:31.297677 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-14 03:03:31.297700 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-14 03:03:31.297718 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-14 03:03:31.297736 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-14 03:03:31.297752 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-14 03:03:31.297790 | debian-bookworm | changed: All items complete 2026-09-14 03:03:31.297813 | 2026-09-14 03:03:31.900322 | debian-bookworm | changed: .d..t...... ./ 2026-09-14 03:03:32.380956 | debian-bookworm | changed: .d..t...... ./ 2026-09-14 03:03:32.397996 | 2026-09-14 03:03:32.398085 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-14 03:03:32.417022 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:03:32.419633 | debian-bookworm | skipping: Conditional result was False 2026-09-14 03:03:32.426715 | 2026-09-14 03:03:32.426785 | PLAY RECAP 2026-09-14 03:03:32.426826 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-14 03:03:32.426852 | 2026-09-14 03:03:32.507659 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-14 03:03:32.508375 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-14 03:03:33.251425 | 2026-09-14 03:03:33.251549 | PLAY [Base post] 2026-09-14 03:03:33.261579 | 2026-09-14 03:03:33.261672 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-14 03:03:33.774724 | debian-bookworm | changed 2026-09-14 03:03:33.784921 | 2026-09-14 03:03:33.785044 | PLAY RECAP 2026-09-14 03:03:33.785137 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-14 03:03:33.785255 | 2026-09-14 03:03:33.857273 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-14 03:03:33.858074 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-14 03:03:34.587286 | 2026-09-14 03:03:34.587409 | PLAY [Base post-logs] 2026-09-14 03:03:34.597418 | 2026-09-14 03:03:34.597594 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-14 03:03:34.989068 | localhost | changed 2026-09-14 03:03:34.998720 | 2026-09-14 03:03:34.998893 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-14 03:03:35.033640 | localhost | ok 2026-09-14 03:03:35.037288 | 2026-09-14 03:03:35.037388 | TASK [Set zuul-log-path fact] 2026-09-14 03:03:35.053624 | localhost | ok 2026-09-14 03:03:35.068373 | 2026-09-14 03:03:35.068630 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-14 03:03:35.097280 | localhost | ok 2026-09-14 03:03:35.103406 | 2026-09-14 03:03:35.103545 | TASK [upload-logs : Create log directories] 2026-09-14 03:03:35.526907 | localhost | changed 2026-09-14 03:03:35.530074 | 2026-09-14 03:03:35.530161 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-14 03:03:35.975452 | localhost -> localhost | ok: Runtime: 0:00:00.006495 2026-09-14 03:03:35.981007 | 2026-09-14 03:03:35.981141 | TASK [upload-logs : Upload logs to log server] 2026-09-14 03:03:36.527113 | localhost | Output suppressed because no_log was given 2026-09-14 03:03:36.528937 | 2026-09-14 03:03:36.529076 | LOOP [upload-logs : Compress console log and json output] 2026-09-14 03:03:36.573378 | localhost | skipping: Conditional result was False 2026-09-14 03:03:36.584372 | localhost | skipping: Conditional result was False 2026-09-14 03:03:36.594661 | 2026-09-14 03:03:36.594764 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-14 03:03:36.642851 | localhost | skipping: Conditional result was False 2026-09-14 03:03:36.643071 | 2026-09-14 03:03:36.647696 | localhost | skipping: Conditional result was False 2026-09-14 03:03:36.660002 | 2026-09-14 03:03:36.660093 | LOOP [upload-logs : Upload console log and json output]