2026-08-16 03:19:28.983202 | Job console starting 2026-08-16 03:19:28.995910 | Updating git repos 2026-08-16 03:19:29.022141 | Cloning repos into workspace 2026-08-16 03:19:29.076978 | Restoring repo states 2026-08-16 03:19:29.086440 | Merging changes 2026-08-16 03:19:29.086463 | Checking out repos 2026-08-16 03:19:29.129867 | Preparing playbooks 2026-08-16 03:19:31.025889 | Running Ansible setup 2026-08-16 03:19:36.249512 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-16 03:19:37.404038 | 2026-08-16 03:19:37.404453 | PLAY [Base pre] 2026-08-16 03:19:37.442505 | 2026-08-16 03:19:37.442648 | TASK [Setup log path fact] 2026-08-16 03:19:37.507989 | debian-bookworm | ok 2026-08-16 03:19:37.573818 | 2026-08-16 03:19:37.574611 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-16 03:19:37.642393 | debian-bookworm | ok 2026-08-16 03:19:37.669564 | 2026-08-16 03:19:37.669688 | TASK [emit-job-header : Print job information] 2026-08-16 03:19:37.751160 | # Job Information 2026-08-16 03:19:37.751400 | Ansible Version: 2.16.14 2026-08-16 03:19:37.751438 | Job: python-black 2026-08-16 03:19:37.751471 | Pipeline: periodic-daily 2026-08-16 03:19:37.751493 | Executor: 521e9411259a 2026-08-16 03:19:37.751514 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2026-08-16 03:19:37.751535 | Event ID: e0f615a0c9f544ed8d395d74a71f2aec 2026-08-16 03:19:37.759415 | 2026-08-16 03:19:37.759537 | LOOP [emit-job-header : Print node information] 2026-08-16 03:19:37.881598 | debian-bookworm | ok: 2026-08-16 03:19:37.882345 | debian-bookworm | # Node Information 2026-08-16 03:19:37.882393 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-16 03:19:37.882427 | debian-bookworm | Hostname: debian 2026-08-16 03:19:37.882456 | debian-bookworm | Username: zuul 2026-08-16 03:19:37.882482 | debian-bookworm | Distro: Debian 12.15 2026-08-16 03:19:37.882513 | debian-bookworm | Provider: regiocloud-a 2026-08-16 03:19:37.882541 | debian-bookworm | Region: 2026-08-16 03:19:37.882569 | debian-bookworm | Label: debian-bookworm 2026-08-16 03:19:37.882595 | debian-bookworm | Product Name: OpenStack Nova 2026-08-16 03:19:37.882621 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0a:27a0 2026-08-16 03:19:37.900047 | 2026-08-16 03:19:37.900175 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-16 03:19:38.783136 | debian-bookworm -> localhost | changed 2026-08-16 03:19:38.791645 | 2026-08-16 03:19:38.791762 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-16 03:19:40.257151 | debian-bookworm -> localhost | changed 2026-08-16 03:19:40.266422 | 2026-08-16 03:19:40.266512 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-16 03:19:40.503685 | debian-bookworm -> localhost | ok 2026-08-16 03:19:40.517547 | 2026-08-16 03:19:40.517662 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-16 03:19:40.545949 | debian-bookworm | ok 2026-08-16 03:19:40.564217 | debian-bookworm | included: /var/lib/zuul/builds/03ba0bd046c14f4184dde7addfc41bf3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-16 03:19:40.573046 | 2026-08-16 03:19:40.573127 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-16 03:19:41.481527 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-16 03:19:41.481757 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/03ba0bd046c14f4184dde7addfc41bf3/work/03ba0bd046c14f4184dde7addfc41bf3_id_rsa 2026-08-16 03:19:41.481795 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/03ba0bd046c14f4184dde7addfc41bf3/work/03ba0bd046c14f4184dde7addfc41bf3_id_rsa.pub 2026-08-16 03:19:41.481822 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-16 03:19:41.481846 | debian-bookworm -> localhost | SHA256:i8C8OiOt5yyMkgbRO03ExH03Nu9faABLZ8aEgHLC4Fo zuul-build-sshkey 2026-08-16 03:19:41.481868 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-16 03:19:41.481900 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-16 03:19:41.481922 | debian-bookworm -> localhost | | .*.. ... +. | 2026-08-16 03:19:41.481943 | debian-bookworm -> localhost | | . B + . O = | 2026-08-16 03:19:41.481964 | debian-bookworm -> localhost | | .E. + . + X | 2026-08-16 03:19:41.481983 | debian-bookworm -> localhost | |.o.o. . o | 2026-08-16 03:19:41.482001 | debian-bookworm -> localhost | |.. ++ S . . . | 2026-08-16 03:19:41.482027 | debian-bookworm -> localhost | |. o .o . . . o .| 2026-08-16 03:19:41.482048 | debian-bookworm -> localhost | |+o .. . . o . | 2026-08-16 03:19:41.482067 | debian-bookworm -> localhost | |*+=. . | 2026-08-16 03:19:41.482088 | debian-bookworm -> localhost | |+*+o | 2026-08-16 03:19:41.482109 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-16 03:19:41.482158 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.450113 2026-08-16 03:19:41.488589 | 2026-08-16 03:19:41.488677 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-16 03:19:41.529591 | debian-bookworm | ok 2026-08-16 03:19:41.548288 | debian-bookworm | included: /var/lib/zuul/builds/03ba0bd046c14f4184dde7addfc41bf3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-16 03:19:41.556741 | 2026-08-16 03:19:41.556836 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-16 03:19:41.590414 | debian-bookworm | skipping: Conditional result was False 2026-08-16 03:19:41.597552 | 2026-08-16 03:19:41.597650 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-16 03:19:42.260842 | debian-bookworm | changed 2026-08-16 03:19:42.266205 | 2026-08-16 03:19:42.266334 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-16 03:19:42.525521 | debian-bookworm | ok 2026-08-16 03:19:42.541873 | 2026-08-16 03:19:42.542125 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-16 03:19:43.219584 | debian-bookworm | changed 2026-08-16 03:19:43.225974 | 2026-08-16 03:19:43.226079 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-16 03:19:43.848480 | debian-bookworm | changed 2026-08-16 03:19:43.854447 | 2026-08-16 03:19:43.854576 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-16 03:19:43.878234 | debian-bookworm | skipping: Conditional result was False 2026-08-16 03:19:43.883401 | 2026-08-16 03:19:43.883482 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-16 03:19:44.407844 | debian-bookworm -> localhost | changed 2026-08-16 03:19:44.424082 | 2026-08-16 03:19:44.424472 | TASK [add-build-sshkey : Add back temp key] 2026-08-16 03:19:44.774920 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/03ba0bd046c14f4184dde7addfc41bf3/work/03ba0bd046c14f4184dde7addfc41bf3_id_rsa (zuul-build-sshkey) 2026-08-16 03:19:44.775158 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022533 2026-08-16 03:19:44.783046 | 2026-08-16 03:19:44.783148 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-16 03:19:45.228826 | debian-bookworm | ok 2026-08-16 03:19:45.234319 | 2026-08-16 03:19:45.234415 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-16 03:19:45.257325 | debian-bookworm | skipping: Conditional result was False 2026-08-16 03:19:45.267478 | 2026-08-16 03:19:45.267573 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-16 03:19:45.672166 | debian-bookworm | ok 2026-08-16 03:19:45.690374 | 2026-08-16 03:19:45.693918 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-16 03:19:45.736127 | debian-bookworm | ok 2026-08-16 03:19:45.741523 | 2026-08-16 03:19:45.741624 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-16 03:19:46.067781 | debian-bookworm -> localhost | ok 2026-08-16 03:19:46.074135 | 2026-08-16 03:19:46.074226 | TASK [validate-host : Collect information about the host] 2026-08-16 03:19:47.219924 | debian-bookworm | ok 2026-08-16 03:19:47.240502 | 2026-08-16 03:19:47.240726 | TASK [validate-host : Sanitize hostname] 2026-08-16 03:19:47.603170 | debian-bookworm | ok 2026-08-16 03:19:47.607814 | 2026-08-16 03:19:47.607931 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-16 03:19:48.199686 | debian-bookworm -> localhost | changed 2026-08-16 03:19:48.207096 | 2026-08-16 03:19:48.207206 | TASK [validate-host : Collect information about zuul worker] 2026-08-16 03:19:48.609524 | debian-bookworm | ok 2026-08-16 03:19:48.614106 | 2026-08-16 03:19:48.614199 | TASK [validate-host : Write out all zuul information for each host] 2026-08-16 03:19:49.080328 | debian-bookworm -> localhost | changed 2026-08-16 03:19:49.089559 | 2026-08-16 03:19:49.089644 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-16 03:19:49.350160 | debian-bookworm | ok 2026-08-16 03:19:49.355683 | 2026-08-16 03:19:49.355778 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-16 03:19:50.255874 | debian-bookworm | changed: 2026-08-16 03:19:50.256055 | debian-bookworm | cd+++++++++ src/ 2026-08-16 03:19:50.256089 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-16 03:19:50.256114 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-16 03:19:50.256136 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2026-08-16 03:19:50.256157 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/03ba0bd046c14f4184dde7addfc41bf3/work/logs" 2026-08-16 03:20:52.971264 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/03ba0bd046c14f4184dde7addfc41bf3/work/artifacts" 2026-08-16 03:20:53.246126 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/03ba0bd046c14f4184dde7addfc41bf3/work/docs" 2026-08-16 03:20:53.258184 | 2026-08-16 03:20:53.258312 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-16 03:20:53.976475 | debian-bookworm | changed: 2026-08-16 03:20:53.976665 | debian-bookworm | .d..t...... ./ 2026-08-16 03:20:53.976693 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-16 03:20:53.976723 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-16 03:20:53.976742 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-16 03:20:53.976759 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-16 03:20:53.976776 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-16 03:20:53.976810 | debian-bookworm | changed: All items complete 2026-08-16 03:20:53.976831 | 2026-08-16 03:20:54.486172 | debian-bookworm | changed: .d..t...... ./ 2026-08-16 03:20:55.022085 | debian-bookworm | changed: .d..t...... ./ 2026-08-16 03:20:55.035318 | 2026-08-16 03:20:55.035435 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-16 03:20:55.058089 | debian-bookworm | skipping: Conditional result was False 2026-08-16 03:20:55.064003 | debian-bookworm | skipping: Conditional result was False 2026-08-16 03:20:55.080450 | 2026-08-16 03:20:55.080539 | PLAY RECAP 2026-08-16 03:20:55.080592 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-16 03:20:55.080618 | 2026-08-16 03:20:55.210043 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-16 03:20:55.215195 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-16 03:20:55.925882 | 2026-08-16 03:20:55.926054 | PLAY [Base post] 2026-08-16 03:20:55.939067 | 2026-08-16 03:20:55.939200 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-16 03:20:56.520856 | debian-bookworm | changed 2026-08-16 03:20:56.528835 | 2026-08-16 03:20:56.528949 | PLAY RECAP 2026-08-16 03:20:56.529015 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-16 03:20:56.529084 | 2026-08-16 03:20:56.637904 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-16 03:20:56.638971 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-16 03:20:57.455488 | 2026-08-16 03:20:57.455628 | PLAY [Base post-logs] 2026-08-16 03:20:57.465511 | 2026-08-16 03:20:57.465623 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-16 03:20:57.926657 | localhost | changed 2026-08-16 03:20:57.934582 | 2026-08-16 03:20:57.934701 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-16 03:20:57.964958 | localhost | ok 2026-08-16 03:20:57.967474 | 2026-08-16 03:20:57.967548 | TASK [Set zuul-log-path fact] 2026-08-16 03:20:57.982353 | localhost | ok 2026-08-16 03:20:57.991227 | 2026-08-16 03:20:57.991500 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-16 03:20:58.016213 | localhost | ok 2026-08-16 03:20:58.019860 | 2026-08-16 03:20:58.019949 | TASK [upload-logs : Create log directories] 2026-08-16 03:20:58.760000 | localhost | changed 2026-08-16 03:20:58.766514 | 2026-08-16 03:20:58.766617 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-16 03:20:59.461717 | localhost -> localhost | ok: Runtime: 0:00:00.004304 2026-08-16 03:20:59.465247 | 2026-08-16 03:20:59.465321 | TASK [upload-logs : Upload logs to log server] 2026-08-16 03:21:00.155835 | localhost | Output suppressed because no_log was given 2026-08-16 03:21:00.158384 | 2026-08-16 03:21:00.158496 | LOOP [upload-logs : Compress console log and json output] 2026-08-16 03:21:00.222722 | localhost | skipping: Conditional result was False 2026-08-16 03:21:00.229291 | localhost | skipping: Conditional result was False 2026-08-16 03:21:00.237624 | 2026-08-16 03:21:00.237792 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-16 03:21:00.297979 | localhost | skipping: Conditional result was False 2026-08-16 03:21:00.298340 | 2026-08-16 03:21:00.306059 | localhost | skipping: Conditional result was False 2026-08-16 03:21:00.316192 | 2026-08-16 03:21:00.316371 | LOOP [upload-logs : Upload console log and json output]