2026-10-02 23:53:03.503656 | Job console starting 2026-10-02 23:53:03.512938 | Updating git repos 2026-10-02 23:53:03.563820 | Cloning repos into workspace 2026-10-02 23:53:03.635816 | Restoring repo states 2026-10-02 23:53:03.662970 | Merging changes 2026-10-02 23:53:04.393544 | Checking out repos 2026-10-02 23:53:04.463281 | Preparing playbooks 2026-10-02 23:53:05.282191 | Running Ansible setup 2026-10-02 23:53:09.934713 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-02 23:53:10.721544 | 2026-10-02 23:53:10.721783 | PLAY [Base pre] 2026-10-02 23:53:10.739724 | 2026-10-02 23:53:10.739867 | TASK [Setup log path fact] 2026-10-02 23:53:10.759088 | debian-bookworm | ok 2026-10-02 23:53:10.776069 | 2026-10-02 23:53:10.776211 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-02 23:53:10.804901 | debian-bookworm | ok 2026-10-02 23:53:10.814843 | 2026-10-02 23:53:10.814952 | TASK [emit-job-header : Print job information] 2026-10-02 23:53:10.854896 | # Job Information 2026-10-02 23:53:10.855098 | Ansible Version: 2.16.14 2026-10-02 23:53:10.855141 | Job: python-black 2026-10-02 23:53:10.855182 | Pipeline: check 2026-10-02 23:53:10.855211 | Executor: 521e9411259a 2026-10-02 23:53:10.855237 | Triggered by: https://github.com/osism/pulpfiction/pull/9 2026-10-02 23:53:10.855266 | Event ID: 4d1f1dd0-bebc-11f1-8a5d-fed63a351ef0 2026-10-02 23:53:10.861011 | 2026-10-02 23:53:10.861129 | LOOP [emit-job-header : Print node information] 2026-10-02 23:53:10.975653 | debian-bookworm | ok: 2026-10-02 23:53:10.975893 | debian-bookworm | # Node Information 2026-10-02 23:53:10.975935 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-02 23:53:10.975967 | debian-bookworm | Hostname: debian 2026-10-02 23:53:10.975994 | debian-bookworm | Username: zuul 2026-10-02 23:53:10.976020 | debian-bookworm | Distro: Debian 12.15 2026-10-02 23:53:10.976051 | debian-bookworm | Provider: regiocloud-a 2026-10-02 23:53:10.976078 | debian-bookworm | Region: 2026-10-02 23:53:10.976105 | debian-bookworm | Label: debian-bookworm 2026-10-02 23:53:10.976131 | debian-bookworm | Product Name: OpenStack Nova 2026-10-02 23:53:10.976156 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefe:8d12 2026-10-02 23:53:10.989694 | 2026-10-02 23:53:10.989818 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-02 23:53:11.644112 | debian-bookworm -> localhost | changed 2026-10-02 23:53:11.651912 | 2026-10-02 23:53:11.652036 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-02 23:53:13.024063 | debian-bookworm -> localhost | changed 2026-10-02 23:53:13.039451 | 2026-10-02 23:53:13.039581 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-02 23:53:13.347622 | debian-bookworm -> localhost | ok 2026-10-02 23:53:13.354262 | 2026-10-02 23:53:13.354384 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-02 23:53:13.385405 | debian-bookworm | ok 2026-10-02 23:53:13.423166 | debian-bookworm | included: /var/lib/zuul/builds/2767defaa6594aa3ba8e14cec0e625a0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-02 23:53:13.429789 | 2026-10-02 23:53:13.429890 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-02 23:53:14.273469 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-02 23:53:14.273720 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2767defaa6594aa3ba8e14cec0e625a0/work/2767defaa6594aa3ba8e14cec0e625a0_id_rsa 2026-10-02 23:53:14.273762 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2767defaa6594aa3ba8e14cec0e625a0/work/2767defaa6594aa3ba8e14cec0e625a0_id_rsa.pub 2026-10-02 23:53:14.273789 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-02 23:53:14.273814 | debian-bookworm -> localhost | SHA256:WrVGz5Nn9vcIvTQmfvfmrDAsS1veH/nYLFFH0UQmsrU zuul-build-sshkey 2026-10-02 23:53:14.273836 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-02 23:53:14.273872 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-02 23:53:14.273893 | debian-bookworm -> localhost | | . o+*| 2026-10-02 23:53:14.273915 | debian-bookworm -> localhost | | + +o| 2026-10-02 23:53:14.273935 | debian-bookworm -> localhost | | o . E. | 2026-10-02 23:53:14.273955 | debian-bookworm -> localhost | | o + . o| 2026-10-02 23:53:14.273975 | debian-bookworm -> localhost | | S o = +..| 2026-10-02 23:53:14.274003 | debian-bookworm -> localhost | | o . . *...| 2026-10-02 23:53:14.274023 | debian-bookworm -> localhost | | . o B =+o| 2026-10-02 23:53:14.274042 | debian-bookworm -> localhost | | . B OoOB| 2026-10-02 23:53:14.274063 | debian-bookworm -> localhost | | o o.*B@| 2026-10-02 23:53:14.274083 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-02 23:53:14.274134 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.332075 2026-10-02 23:53:14.280760 | 2026-10-02 23:53:14.280862 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-02 23:53:14.309267 | debian-bookworm | ok 2026-10-02 23:53:14.319432 | debian-bookworm | included: /var/lib/zuul/builds/2767defaa6594aa3ba8e14cec0e625a0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-02 23:53:14.327643 | 2026-10-02 23:53:14.327737 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-02 23:53:14.351139 | debian-bookworm | skipping: Conditional result was False 2026-10-02 23:53:14.356859 | 2026-10-02 23:53:14.356958 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-02 23:53:15.110260 | debian-bookworm | changed 2026-10-02 23:53:15.119784 | 2026-10-02 23:53:15.119930 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-02 23:53:15.435141 | debian-bookworm | ok 2026-10-02 23:53:15.441692 | 2026-10-02 23:53:15.441799 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-02 23:53:16.182901 | debian-bookworm | changed 2026-10-02 23:53:16.188895 | 2026-10-02 23:53:16.189020 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-02 23:53:16.922097 | debian-bookworm | changed 2026-10-02 23:53:16.929886 | 2026-10-02 23:53:16.930012 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-02 23:53:16.964415 | debian-bookworm | skipping: Conditional result was False 2026-10-02 23:53:16.979308 | 2026-10-02 23:53:16.979508 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-02 23:53:17.448739 | debian-bookworm -> localhost | changed 2026-10-02 23:53:17.462253 | 2026-10-02 23:53:17.462368 | TASK [add-build-sshkey : Add back temp key] 2026-10-02 23:53:17.806547 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2767defaa6594aa3ba8e14cec0e625a0/work/2767defaa6594aa3ba8e14cec0e625a0_id_rsa (zuul-build-sshkey) 2026-10-02 23:53:17.807131 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012200 2026-10-02 23:53:17.823852 | 2026-10-02 23:53:17.824006 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-02 23:53:18.292713 | debian-bookworm | ok 2026-10-02 23:53:18.298462 | 2026-10-02 23:53:18.298575 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-02 23:53:18.326116 | debian-bookworm | skipping: Conditional result was False 2026-10-02 23:53:18.336787 | 2026-10-02 23:53:18.336896 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-02 23:53:18.851860 | debian-bookworm | ok 2026-10-02 23:53:18.863569 | 2026-10-02 23:53:18.863689 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-02 23:53:18.901526 | debian-bookworm | ok 2026-10-02 23:53:18.909135 | 2026-10-02 23:53:18.909253 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-02 23:53:19.216698 | debian-bookworm -> localhost | ok 2026-10-02 23:53:19.223497 | 2026-10-02 23:53:19.223604 | TASK [validate-host : Collect information about the host] 2026-10-02 23:53:20.489883 | debian-bookworm | ok 2026-10-02 23:53:20.502015 | 2026-10-02 23:53:20.502133 | TASK [validate-host : Sanitize hostname] 2026-10-02 23:53:20.672119 | debian-bookworm | ok 2026-10-02 23:53:20.677231 | 2026-10-02 23:53:20.677344 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-02 23:53:21.255344 | debian-bookworm -> localhost | changed 2026-10-02 23:53:21.262921 | 2026-10-02 23:53:21.263037 | TASK [validate-host : Collect information about zuul worker] 2026-10-02 23:53:21.729981 | debian-bookworm | ok 2026-10-02 23:53:21.741018 | 2026-10-02 23:53:21.741167 | TASK [validate-host : Write out all zuul information for each host] 2026-10-02 23:53:22.386375 | debian-bookworm -> localhost | changed 2026-10-02 23:53:22.396945 | 2026-10-02 23:53:22.397151 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-02 23:53:22.722617 | debian-bookworm | ok 2026-10-02 23:53:22.728558 | 2026-10-02 23:53:22.728670 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-02 23:53:23.538278 | debian-bookworm | changed: 2026-10-02 23:53:23.538515 | debian-bookworm | cd+++++++++ src/ 2026-10-02 23:53:23.538553 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-02 23:53:23.538577 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-02 23:53:23.545342 | debian-bookworm | cd+++++++++ src/github.com/osism/pulpfiction/ 2026-10-02 23:53:23.545461 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2767defaa6594aa3ba8e14cec0e625a0/work/logs" 2026-10-02 23:54:28.337099 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2767defaa6594aa3ba8e14cec0e625a0/work/artifacts" 2026-10-02 23:54:28.594292 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2767defaa6594aa3ba8e14cec0e625a0/work/docs" 2026-10-02 23:54:28.606048 | 2026-10-02 23:54:28.606165 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-02 23:54:29.393751 | debian-bookworm | changed: 2026-10-02 23:54:29.394127 | debian-bookworm | .d..t...... ./ 2026-10-02 23:54:29.394195 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-02 23:54:29.394239 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-02 23:54:29.394278 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-02 23:54:29.394315 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-02 23:54:29.394350 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-02 23:54:29.394407 | debian-bookworm | changed: All items complete 2026-10-02 23:54:29.394467 | 2026-10-02 23:54:29.926062 | debian-bookworm | changed: .d..t...... ./ 2026-10-02 23:54:30.472444 | debian-bookworm | changed: .d..t...... ./ 2026-10-02 23:54:30.503775 | 2026-10-02 23:54:30.503912 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-02 23:54:30.844393 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009967 2026-10-02 23:54:31.107978 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009328 2026-10-02 23:54:31.124576 | 2026-10-02 23:54:31.124701 | PLAY RECAP 2026-10-02 23:54:31.124779 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-02 23:54:31.124818 | 2026-10-02 23:54:31.248935 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-02 23:54:31.249794 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-02 23:54:31.948585 | 2026-10-02 23:54:31.948753 | PLAY [Base post] 2026-10-02 23:54:31.962268 | 2026-10-02 23:54:31.962401 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-02 23:54:32.556783 | debian-bookworm | changed 2026-10-02 23:54:32.566405 | 2026-10-02 23:54:32.566535 | PLAY RECAP 2026-10-02 23:54:32.566609 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-02 23:54:32.566686 | 2026-10-02 23:54:32.678799 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-02 23:54:32.679632 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-02 23:54:33.473257 | 2026-10-02 23:54:33.473436 | PLAY [Base post-logs] 2026-10-02 23:54:33.483890 | 2026-10-02 23:54:33.484015 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-02 23:54:33.905304 | localhost | changed 2026-10-02 23:54:33.915329 | 2026-10-02 23:54:33.915510 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-02 23:54:33.941065 | localhost | ok 2026-10-02 23:54:33.944119 | 2026-10-02 23:54:33.944217 | TASK [Set zuul-log-path fact] 2026-10-02 23:54:33.959188 | localhost | ok 2026-10-02 23:54:33.966952 | 2026-10-02 23:54:33.967059 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-02 23:54:33.991610 | localhost | ok 2026-10-02 23:54:33.994569 | 2026-10-02 23:54:33.994669 | TASK [upload-logs : Create log directories] 2026-10-02 23:54:34.478773 | localhost | changed 2026-10-02 23:54:34.482249 | 2026-10-02 23:54:34.482363 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-02 23:54:34.975574 | localhost -> localhost | ok: Runtime: 0:00:00.006524 2026-10-02 23:54:34.992696 | 2026-10-02 23:54:34.992852 | TASK [upload-logs : Upload logs to log server] 2026-10-02 23:54:35.531931 | localhost | Output suppressed because no_log was given 2026-10-02 23:54:35.536161 | 2026-10-02 23:54:35.536379 | LOOP [upload-logs : Compress console log and json output] 2026-10-02 23:54:35.595237 | localhost | skipping: Conditional result was False 2026-10-02 23:54:35.600343 | localhost | skipping: Conditional result was False 2026-10-02 23:54:35.608668 | 2026-10-02 23:54:35.608910 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-02 23:54:35.654133 | localhost | skipping: Conditional result was False 2026-10-02 23:54:35.654681 | 2026-10-02 23:54:35.658778 | localhost | skipping: Conditional result was False 2026-10-02 23:54:35.672102 | 2026-10-02 23:54:35.672330 | LOOP [upload-logs : Upload console log and json output]