2026-08-29 10:18:51.156157 | Job console starting 2026-08-29 10:18:51.171750 | Updating git repos 2026-08-29 10:18:51.291969 | Cloning repos into workspace 2026-08-29 10:18:51.411844 | Restoring repo states 2026-08-29 10:18:51.449367 | Merging changes 2026-08-29 10:18:52.482276 | Checking out repos 2026-08-29 10:18:52.521817 | Preparing playbooks 2026-08-29 10:18:53.462423 | Running Ansible setup 2026-08-29 10:18:58.204390 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-29 10:18:59.184355 | 2026-08-29 10:18:59.184575 | PLAY [Base pre] 2026-08-29 10:18:59.207254 | 2026-08-29 10:18:59.207432 | TASK [Setup log path fact] 2026-08-29 10:18:59.240798 | debian-bookworm | ok 2026-08-29 10:18:59.267941 | 2026-08-29 10:18:59.268115 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-29 10:18:59.298986 | debian-bookworm | ok 2026-08-29 10:18:59.310095 | 2026-08-29 10:18:59.310232 | TASK [emit-job-header : Print job information] 2026-08-29 10:18:59.351062 | # Job Information 2026-08-29 10:18:59.351378 | Ansible Version: 2.16.14 2026-08-29 10:18:59.351419 | Job: python-black 2026-08-29 10:18:59.351453 | Pipeline: check 2026-08-29 10:18:59.351476 | Executor: 521e9411259a 2026-08-29 10:18:59.351497 | Triggered by: https://github.com/osism/python-osism/pull/2581 2026-08-29 10:18:59.351519 | Event ID: e5462c10-a392-11f1-8115-a7758c2e6f3c 2026-08-29 10:18:59.359181 | 2026-08-29 10:18:59.359414 | LOOP [emit-job-header : Print node information] 2026-08-29 10:18:59.474757 | debian-bookworm | ok: 2026-08-29 10:18:59.475240 | debian-bookworm | # Node Information 2026-08-29 10:18:59.475288 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-29 10:18:59.475315 | debian-bookworm | Hostname: debian 2026-08-29 10:18:59.475337 | debian-bookworm | Username: zuul 2026-08-29 10:18:59.475359 | debian-bookworm | Distro: Debian 12.15 2026-08-29 10:18:59.475382 | debian-bookworm | Provider: regiocloud-a 2026-08-29 10:18:59.475404 | debian-bookworm | Region: 2026-08-29 10:18:59.475425 | debian-bookworm | Label: debian-bookworm 2026-08-29 10:18:59.475446 | debian-bookworm | Product Name: OpenStack Nova 2026-08-29 10:18:59.475465 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe14:f3e2 2026-08-29 10:18:59.495330 | 2026-08-29 10:18:59.495491 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-29 10:19:00.266155 | debian-bookworm -> localhost | changed 2026-08-29 10:19:00.288501 | 2026-08-29 10:19:00.288765 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-29 10:19:01.576281 | debian-bookworm -> localhost | changed 2026-08-29 10:19:01.593178 | 2026-08-29 10:19:01.593476 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-29 10:19:01.950236 | debian-bookworm -> localhost | ok 2026-08-29 10:19:01.965613 | 2026-08-29 10:19:01.965845 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-29 10:19:02.001921 | debian-bookworm | ok 2026-08-29 10:19:02.022049 | debian-bookworm | included: /var/lib/zuul/builds/119d913446ad4195b318a2f002eb9f67/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-29 10:19:02.029161 | 2026-08-29 10:19:02.029276 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-29 10:19:06.885839 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-29 10:19:06.886084 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/119d913446ad4195b318a2f002eb9f67/work/119d913446ad4195b318a2f002eb9f67_id_rsa 2026-08-29 10:19:06.886124 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/119d913446ad4195b318a2f002eb9f67/work/119d913446ad4195b318a2f002eb9f67_id_rsa.pub 2026-08-29 10:19:06.886151 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-29 10:19:06.886176 | debian-bookworm -> localhost | SHA256:/dIyoSYH/ZSkQCSQeg6K08g0G8uMS5HNJ5x5bUu+RvY zuul-build-sshkey 2026-08-29 10:19:06.886199 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-29 10:19:06.886253 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-29 10:19:06.886276 | debian-bookworm -> localhost | | .o..o | 2026-08-29 10:19:06.886298 | debian-bookworm -> localhost | | . o | 2026-08-29 10:19:06.886318 | debian-bookworm -> localhost | | .= o o . | 2026-08-29 10:19:06.886339 | debian-bookworm -> localhost | |o*.B o * + . | 2026-08-29 10:19:06.886359 | debian-bookworm -> localhost | |O** + = S = | 2026-08-29 10:19:06.886387 | debian-bookworm -> localhost | |*Bo * + + | 2026-08-29 10:19:06.886408 | debian-bookworm -> localhost | |.o + * = o | 2026-08-29 10:19:06.886429 | debian-bookworm -> localhost | |. * E + | 2026-08-29 10:19:06.886449 | debian-bookworm -> localhost | | . | 2026-08-29 10:19:06.886469 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-29 10:19:06.886519 | debian-bookworm -> localhost | ok: Runtime: 0:00:04.173699 2026-08-29 10:19:06.898026 | 2026-08-29 10:19:06.898139 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-29 10:19:06.951897 | debian-bookworm | ok 2026-08-29 10:19:06.969247 | debian-bookworm | included: /var/lib/zuul/builds/119d913446ad4195b318a2f002eb9f67/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-29 10:19:06.996422 | 2026-08-29 10:19:06.996545 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-29 10:19:07.040358 | debian-bookworm | skipping: Conditional result was False 2026-08-29 10:19:07.054046 | 2026-08-29 10:19:07.056989 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-29 10:19:08.295948 | debian-bookworm | changed 2026-08-29 10:19:08.300459 | 2026-08-29 10:19:08.300549 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-29 10:19:08.625121 | debian-bookworm | ok 2026-08-29 10:19:08.629759 | 2026-08-29 10:19:08.629847 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-29 10:19:09.484174 | debian-bookworm | changed 2026-08-29 10:19:09.488715 | 2026-08-29 10:19:09.488808 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-29 10:19:10.305237 | debian-bookworm | changed 2026-08-29 10:19:10.310717 | 2026-08-29 10:19:10.310810 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-29 10:19:10.373449 | debian-bookworm | skipping: Conditional result was False 2026-08-29 10:19:10.379478 | 2026-08-29 10:19:10.379581 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-29 10:19:11.410962 | debian-bookworm -> localhost | changed 2026-08-29 10:19:11.425510 | 2026-08-29 10:19:11.425618 | TASK [add-build-sshkey : Add back temp key] 2026-08-29 10:19:12.159585 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/119d913446ad4195b318a2f002eb9f67/work/119d913446ad4195b318a2f002eb9f67_id_rsa (zuul-build-sshkey) 2026-08-29 10:19:12.160702 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019293 2026-08-29 10:19:12.167469 | 2026-08-29 10:19:12.167551 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-29 10:19:12.996125 | debian-bookworm | ok 2026-08-29 10:19:13.008507 | 2026-08-29 10:19:13.008630 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-29 10:19:13.049175 | debian-bookworm | skipping: Conditional result was False 2026-08-29 10:19:13.059891 | 2026-08-29 10:19:13.060008 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-29 10:19:13.695814 | debian-bookworm | ok 2026-08-29 10:19:13.712589 | 2026-08-29 10:19:13.712715 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-29 10:19:13.744667 | debian-bookworm | ok 2026-08-29 10:19:13.749599 | 2026-08-29 10:19:13.749689 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-29 10:19:14.025906 | debian-bookworm -> localhost | ok 2026-08-29 10:19:14.032624 | 2026-08-29 10:19:14.032760 | TASK [validate-host : Collect information about the host] 2026-08-29 10:19:15.321423 | debian-bookworm | ok 2026-08-29 10:19:15.361178 | 2026-08-29 10:19:15.361332 | TASK [validate-host : Sanitize hostname] 2026-08-29 10:19:15.729519 | debian-bookworm | ok 2026-08-29 10:19:15.733759 | 2026-08-29 10:19:15.733846 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-29 10:19:16.410774 | debian-bookworm -> localhost | changed 2026-08-29 10:19:16.416367 | 2026-08-29 10:19:16.416460 | TASK [validate-host : Collect information about zuul worker] 2026-08-29 10:19:16.809948 | debian-bookworm | ok 2026-08-29 10:19:16.813956 | 2026-08-29 10:19:16.814055 | TASK [validate-host : Write out all zuul information for each host] 2026-08-29 10:19:17.478766 | debian-bookworm -> localhost | changed 2026-08-29 10:19:17.491236 | 2026-08-29 10:19:17.491336 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-29 10:19:17.773617 | debian-bookworm | ok 2026-08-29 10:19:17.779252 | 2026-08-29 10:19:17.779360 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-29 10:19:19.546853 | debian-bookworm | changed: 2026-08-29 10:19:19.547038 | debian-bookworm | cd+++++++++ src/ 2026-08-29 10:19:19.547068 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-29 10:19:19.547088 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-29 10:19:19.547106 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-29 10:19:19.547123 | debian-bookworm | Containerfile 2026-08-29 10:19:19.547233 | debian-bookworm | Containerfile 2026-08-29 10:19:19.557859 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/119d913446ad4195b318a2f002eb9f67/work/logs" 2026-08-29 10:20:35.715240 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/119d913446ad4195b318a2f002eb9f67/work/artifacts" 2026-08-29 10:20:36.012814 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/119d913446ad4195b318a2f002eb9f67/work/docs" 2026-08-29 10:20:36.037141 | 2026-08-29 10:20:36.037321 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-29 10:20:36.845870 | debian-bookworm | changed: 2026-08-29 10:20:36.846309 | debian-bookworm | .d..t...... ./ 2026-08-29 10:20:36.846386 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-29 10:20:36.846435 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-29 10:20:36.846478 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-29 10:20:36.846521 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-29 10:20:36.846627 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-29 10:20:36.846736 | debian-bookworm | changed: All items complete 2026-08-29 10:20:36.846794 | 2026-08-29 10:20:37.483556 | debian-bookworm | changed: .d..t...... ./ 2026-08-29 10:20:38.098777 | debian-bookworm | changed: .d..t...... ./ 2026-08-29 10:20:38.112818 | 2026-08-29 10:20:38.112971 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-29 10:20:38.461206 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009075 2026-08-29 10:20:38.767577 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009802 2026-08-29 10:20:38.791733 | 2026-08-29 10:20:38.791903 | PLAY RECAP 2026-08-29 10:20:38.791983 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-29 10:20:38.792019 | 2026-08-29 10:20:38.949536 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-29 10:20:38.950438 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-29 10:20:39.840016 | 2026-08-29 10:20:39.840239 | PLAY [Base post] 2026-08-29 10:20:39.856720 | 2026-08-29 10:20:39.856928 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-29 10:20:40.508802 | debian-bookworm | changed 2026-08-29 10:20:40.519317 | 2026-08-29 10:20:40.519453 | PLAY RECAP 2026-08-29 10:20:40.519532 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-29 10:20:40.519607 | 2026-08-29 10:20:40.684960 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-29 10:20:40.687019 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-29 10:20:41.591331 | 2026-08-29 10:20:41.591576 | PLAY [Base post-logs] 2026-08-29 10:20:41.606193 | 2026-08-29 10:20:41.606376 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-29 10:20:42.103844 | localhost | changed 2026-08-29 10:20:42.120034 | 2026-08-29 10:20:42.120226 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-29 10:20:42.167414 | localhost | ok 2026-08-29 10:20:42.172144 | 2026-08-29 10:20:42.172278 | TASK [Set zuul-log-path fact] 2026-08-29 10:20:42.193624 | localhost | ok 2026-08-29 10:20:42.206054 | 2026-08-29 10:20:42.206189 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-29 10:20:42.242989 | localhost | ok 2026-08-29 10:20:42.246727 | 2026-08-29 10:20:42.246873 | TASK [upload-logs : Create log directories] 2026-08-29 10:20:42.819133 | localhost | changed 2026-08-29 10:20:42.825344 | 2026-08-29 10:20:42.825513 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-29 10:20:43.456166 | localhost -> localhost | ok: Runtime: 0:00:00.005850 2026-08-29 10:20:43.460715 | 2026-08-29 10:20:43.460937 | TASK [upload-logs : Upload logs to log server] 2026-08-29 10:20:44.097685 | localhost | Output suppressed because no_log was given 2026-08-29 10:20:44.099954 | 2026-08-29 10:20:44.100071 | LOOP [upload-logs : Compress console log and json output] 2026-08-29 10:20:44.165153 | localhost | skipping: Conditional result was False 2026-08-29 10:20:44.188601 | localhost | skipping: Conditional result was False 2026-08-29 10:20:44.202952 | 2026-08-29 10:20:44.203106 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-29 10:20:44.257786 | localhost | skipping: Conditional result was False 2026-08-29 10:20:44.258092 | 2026-08-29 10:20:44.266050 | localhost | skipping: Conditional result was False 2026-08-29 10:20:44.273953 | 2026-08-29 10:20:44.274078 | LOOP [upload-logs : Upload console log and json output]