2026-08-06 13:35:12.089841 | Job console starting 2026-08-06 13:35:12.106581 | Updating git repos 2026-08-06 13:35:12.181553 | Cloning repos into workspace 2026-08-06 13:35:12.235135 | Restoring repo states 2026-08-06 13:35:12.248879 | Merging changes 2026-08-06 13:35:13.401100 | Checking out repos 2026-08-06 13:35:13.489254 | Preparing playbooks 2026-08-06 13:35:14.760604 | Running Ansible setup 2026-08-06 13:35:20.551622 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-06 13:35:21.663169 | 2026-08-06 13:35:21.663328 | PLAY [Base pre] 2026-08-06 13:35:21.699102 | 2026-08-06 13:35:21.699256 | TASK [Setup log path fact] 2026-08-06 13:35:21.743161 | debian-bookworm | ok 2026-08-06 13:35:21.762444 | 2026-08-06 13:35:21.762597 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-06 13:35:21.809258 | debian-bookworm | ok 2026-08-06 13:35:21.833771 | 2026-08-06 13:35:21.833905 | TASK [emit-job-header : Print job information] 2026-08-06 13:35:21.904324 | # Job Information 2026-08-06 13:35:21.904517 | Ansible Version: 2.16.14 2026-08-06 13:35:21.904552 | Job: python-black 2026-08-06 13:35:21.904583 | Pipeline: check 2026-08-06 13:35:21.904606 | Executor: 521e9411259a 2026-08-06 13:35:21.904627 | Triggered by: https://github.com/osism/python-osism/pull/2583 2026-08-06 13:35:21.904649 | Event ID: 9d5ca950-919b-11f1-99e7-bb2cc733ba2a 2026-08-06 13:35:21.909671 | 2026-08-06 13:35:21.909793 | LOOP [emit-job-header : Print node information] 2026-08-06 13:35:22.090476 | debian-bookworm | ok: 2026-08-06 13:35:22.090669 | debian-bookworm | # Node Information 2026-08-06 13:35:22.090703 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-06 13:35:22.090729 | debian-bookworm | Hostname: debian 2026-08-06 13:35:22.090765 | debian-bookworm | Username: zuul 2026-08-06 13:35:22.090786 | debian-bookworm | Distro: Debian 12.15 2026-08-06 13:35:22.090810 | debian-bookworm | Provider: regiocloud-a 2026-08-06 13:35:22.090862 | debian-bookworm | Region: 2026-08-06 13:35:22.090894 | debian-bookworm | Label: debian-bookworm 2026-08-06 13:35:22.090935 | debian-bookworm | Product Name: OpenStack Nova 2026-08-06 13:35:22.091000 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe70:2aba 2026-08-06 13:35:22.110364 | 2026-08-06 13:35:22.110495 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-06 13:35:23.050202 | debian-bookworm -> localhost | changed 2026-08-06 13:35:23.058557 | 2026-08-06 13:35:23.058675 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-06 13:35:26.125608 | debian-bookworm -> localhost | changed 2026-08-06 13:35:26.137067 | 2026-08-06 13:35:26.139865 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-06 13:35:26.839737 | debian-bookworm -> localhost | ok 2026-08-06 13:35:26.845479 | 2026-08-06 13:35:26.845580 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-06 13:35:26.874719 | debian-bookworm | ok 2026-08-06 13:35:26.900204 | debian-bookworm | included: /var/lib/zuul/builds/c36e8b5c64bc48c3b1bb55ff51e707cc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-06 13:35:26.925211 | 2026-08-06 13:35:26.925345 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-06 13:35:30.439130 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-06 13:35:30.439355 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c36e8b5c64bc48c3b1bb55ff51e707cc/work/c36e8b5c64bc48c3b1bb55ff51e707cc_id_rsa 2026-08-06 13:35:30.439395 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c36e8b5c64bc48c3b1bb55ff51e707cc/work/c36e8b5c64bc48c3b1bb55ff51e707cc_id_rsa.pub 2026-08-06 13:35:30.439423 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-06 13:35:30.439449 | debian-bookworm -> localhost | SHA256:c821m28ejQkENu0gFGcfFqQhshJQt3Hhdbu+I6i4JJY zuul-build-sshkey 2026-08-06 13:35:30.439473 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-06 13:35:30.439507 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-06 13:35:30.439530 | debian-bookworm -> localhost | | .oo +.*oOo*. | 2026-08-06 13:35:30.439552 | debian-bookworm -> localhost | | o B.*.O.o | 2026-08-06 13:35:30.439573 | debian-bookworm -> localhost | | . o ...o+ . | 2026-08-06 13:35:30.439593 | debian-bookworm -> localhost | | . +.o . | 2026-08-06 13:35:30.439613 | debian-bookworm -> localhost | | S . = . | 2026-08-06 13:35:30.439636 | debian-bookworm -> localhost | | . o . . =.| 2026-08-06 13:35:30.439656 | debian-bookworm -> localhost | | E . . . =..| 2026-08-06 13:35:30.439676 | debian-bookworm -> localhost | | . o . . . .. .o| 2026-08-06 13:35:30.439697 | debian-bookworm -> localhost | | o... ... oo| 2026-08-06 13:35:30.439717 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-06 13:35:30.439794 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.404475 2026-08-06 13:35:30.446478 | 2026-08-06 13:35:30.446595 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-06 13:35:30.486331 | debian-bookworm | ok 2026-08-06 13:35:30.499033 | debian-bookworm | included: /var/lib/zuul/builds/c36e8b5c64bc48c3b1bb55ff51e707cc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-06 13:35:30.507652 | 2026-08-06 13:35:30.507765 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-06 13:35:30.542734 | debian-bookworm | skipping: Conditional result was False 2026-08-06 13:35:30.549088 | 2026-08-06 13:35:30.549198 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-06 13:35:31.289955 | debian-bookworm | changed 2026-08-06 13:35:31.299290 | 2026-08-06 13:35:31.299411 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-06 13:35:31.571290 | debian-bookworm | ok 2026-08-06 13:35:31.582382 | 2026-08-06 13:35:31.583174 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-06 13:35:32.318467 | debian-bookworm | changed 2026-08-06 13:35:32.324489 | 2026-08-06 13:35:32.324594 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-06 13:35:33.022367 | debian-bookworm | changed 2026-08-06 13:35:33.030437 | 2026-08-06 13:35:33.030543 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-06 13:35:33.094027 | debian-bookworm | skipping: Conditional result was False 2026-08-06 13:35:33.100382 | 2026-08-06 13:35:33.100496 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-06 13:35:34.437671 | debian-bookworm -> localhost | changed 2026-08-06 13:35:34.452331 | 2026-08-06 13:35:34.452458 | TASK [add-build-sshkey : Add back temp key] 2026-08-06 13:35:35.069218 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c36e8b5c64bc48c3b1bb55ff51e707cc/work/c36e8b5c64bc48c3b1bb55ff51e707cc_id_rsa (zuul-build-sshkey) 2026-08-06 13:35:35.069567 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022757 2026-08-06 13:35:35.079273 | 2026-08-06 13:35:35.079391 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-06 13:35:35.488228 | debian-bookworm | ok 2026-08-06 13:35:35.494680 | 2026-08-06 13:35:35.494812 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-06 13:35:35.522460 | debian-bookworm | skipping: Conditional result was False 2026-08-06 13:35:35.543926 | 2026-08-06 13:35:35.544045 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-06 13:35:36.325047 | debian-bookworm | ok 2026-08-06 13:35:36.344292 | 2026-08-06 13:35:36.344419 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-06 13:35:36.395389 | debian-bookworm | ok 2026-08-06 13:35:36.400450 | 2026-08-06 13:35:36.400542 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-06 13:35:37.020598 | debian-bookworm -> localhost | ok 2026-08-06 13:35:37.027092 | 2026-08-06 13:35:37.027191 | TASK [validate-host : Collect information about the host] 2026-08-06 13:35:38.183785 | debian-bookworm | ok 2026-08-06 13:35:38.209614 | 2026-08-06 13:35:38.209738 | TASK [validate-host : Sanitize hostname] 2026-08-06 13:35:38.424457 | debian-bookworm | ok 2026-08-06 13:35:38.429044 | 2026-08-06 13:35:38.429141 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-06 13:35:39.367793 | debian-bookworm -> localhost | changed 2026-08-06 13:35:39.373011 | 2026-08-06 13:35:39.373100 | TASK [validate-host : Collect information about zuul worker] 2026-08-06 13:35:39.950357 | debian-bookworm | ok 2026-08-06 13:35:39.956612 | 2026-08-06 13:35:39.956718 | TASK [validate-host : Write out all zuul information for each host] 2026-08-06 13:35:41.015289 | debian-bookworm -> localhost | changed 2026-08-06 13:35:41.024783 | 2026-08-06 13:35:41.024887 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-06 13:35:41.336781 | debian-bookworm | ok 2026-08-06 13:35:41.342295 | 2026-08-06 13:35:41.342389 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-06 13:35:42.513891 | debian-bookworm | changed: 2026-08-06 13:35:42.514140 | debian-bookworm | cd+++++++++ src/ 2026-08-06 13:35:42.514180 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-06 13:35:42.514208 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-06 13:35:42.514230 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-06 13:35:42.514252 | debian-bookworm | Containerfile 2026-08-06 13:35:42.514399 | debian-bookworm | Containerfile 2026-08-06 13:35:42.524016 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c36e8b5c64bc48c3b1bb55ff51e707cc/work/logs" 2026-08-06 13:36:56.330444 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c36e8b5c64bc48c3b1bb55ff51e707cc/work/artifacts" 2026-08-06 13:36:56.647532 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c36e8b5c64bc48c3b1bb55ff51e707cc/work/docs" 2026-08-06 13:36:56.681155 | 2026-08-06 13:36:56.681504 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-06 13:36:57.531884 | debian-bookworm | changed: 2026-08-06 13:36:57.533198 | debian-bookworm | .d..t...... ./ 2026-08-06 13:36:57.533261 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-06 13:36:57.533297 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-06 13:36:57.533329 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-06 13:36:57.533361 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-06 13:36:57.533390 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-06 13:36:57.533456 | debian-bookworm | changed: All items complete 2026-08-06 13:36:57.533491 | 2026-08-06 13:36:58.169542 | debian-bookworm | changed: .d..t...... ./ 2026-08-06 13:36:58.810381 | debian-bookworm | changed: .d..t...... ./ 2026-08-06 13:36:58.845582 | 2026-08-06 13:36:58.845773 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-06 13:36:59.239034 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.015565 2026-08-06 13:36:59.561928 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010699 2026-08-06 13:36:59.580733 | 2026-08-06 13:36:59.580964 | PLAY RECAP 2026-08-06 13:36:59.581061 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-06 13:36:59.581103 | 2026-08-06 13:36:59.813092 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-06 13:36:59.814097 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-06 13:37:00.627563 | 2026-08-06 13:37:00.627746 | PLAY [Base post] 2026-08-06 13:37:00.643583 | 2026-08-06 13:37:00.643730 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-06 13:37:01.335368 | debian-bookworm | changed 2026-08-06 13:37:01.345770 | 2026-08-06 13:37:01.345934 | PLAY RECAP 2026-08-06 13:37:01.346016 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-06 13:37:01.346102 | 2026-08-06 13:37:01.546468 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-06 13:37:01.548146 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-06 13:37:02.590727 | 2026-08-06 13:37:02.591005 | PLAY [Base post-logs] 2026-08-06 13:37:02.615911 | 2026-08-06 13:37:02.616143 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-06 13:37:03.271962 | localhost | changed 2026-08-06 13:37:03.283978 | 2026-08-06 13:37:03.284188 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-06 13:37:03.314631 | localhost | ok 2026-08-06 13:37:03.318450 | 2026-08-06 13:37:03.318571 | TASK [Set zuul-log-path fact] 2026-08-06 13:37:03.349003 | localhost | ok 2026-08-06 13:37:03.360585 | 2026-08-06 13:37:03.360742 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-06 13:37:03.389186 | localhost | ok 2026-08-06 13:37:03.393213 | 2026-08-06 13:37:03.393336 | TASK [upload-logs : Create log directories] 2026-08-06 13:37:03.958166 | localhost | changed 2026-08-06 13:37:03.961314 | 2026-08-06 13:37:03.961423 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-06 13:37:04.788259 | localhost -> localhost | ok: Runtime: 0:00:00.019851 2026-08-06 13:37:04.795024 | 2026-08-06 13:37:04.795163 | TASK [upload-logs : Upload logs to log server] 2026-08-06 13:37:05.573806 | localhost | Output suppressed because no_log was given 2026-08-06 13:37:05.578609 | 2026-08-06 13:37:05.578999 | LOOP [upload-logs : Compress console log and json output] 2026-08-06 13:37:05.660143 | localhost | skipping: Conditional result was False 2026-08-06 13:37:05.666761 | localhost | skipping: Conditional result was False 2026-08-06 13:37:05.671621 | 2026-08-06 13:37:05.671825 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-06 13:37:05.731091 | localhost | skipping: Conditional result was False 2026-08-06 13:37:05.731442 | 2026-08-06 13:37:05.736636 | localhost | skipping: Conditional result was False 2026-08-06 13:37:05.749725 | 2026-08-06 13:37:05.750426 | LOOP [upload-logs : Upload console log and json output]