2026-05-04 14:16:45.706046 | Job console starting 2026-05-04 14:16:45.737139 | Updating git repos 2026-05-04 14:16:45.855033 | Cloning repos into workspace 2026-05-04 14:16:45.967011 | Restoring repo states 2026-05-04 14:16:46.022933 | Merging changes 2026-05-04 14:16:46.870310 | Checking out repos 2026-05-04 14:16:47.003037 | Preparing playbooks 2026-05-04 14:16:48.343928 | Running Ansible setup 2026-05-04 14:16:54.583562 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-04 14:16:55.537156 | 2026-05-04 14:16:55.537296 | PLAY [Base pre] 2026-05-04 14:16:55.593060 | 2026-05-04 14:16:55.593186 | TASK [Setup log path fact] 2026-05-04 14:16:55.622309 | debian-bookworm | ok 2026-05-04 14:16:55.665839 | 2026-05-04 14:16:55.665988 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-04 14:16:55.698393 | debian-bookworm | ok 2026-05-04 14:16:55.711611 | 2026-05-04 14:16:55.711727 | TASK [emit-job-header : Print job information] 2026-05-04 14:16:55.800345 | # Job Information 2026-05-04 14:16:55.800533 | Ansible Version: 2.16.14 2026-05-04 14:16:55.800568 | Job: python-black 2026-05-04 14:16:55.800599 | Pipeline: check 2026-05-04 14:16:55.800621 | Executor: 521e9411259a 2026-05-04 14:16:55.800642 | Triggered by: https://github.com/osism/python-osism/pull/2251 2026-05-04 14:16:55.800664 | Event ID: db523a30-47c3-11f1-837f-513dfc595796 2026-05-04 14:16:55.805451 | 2026-05-04 14:16:55.805606 | LOOP [emit-job-header : Print node information] 2026-05-04 14:16:55.915324 | debian-bookworm | ok: 2026-05-04 14:16:55.915465 | debian-bookworm | # Node Information 2026-05-04 14:16:55.915492 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-04 14:16:55.915536 | debian-bookworm | Hostname: debian 2026-05-04 14:16:55.915557 | debian-bookworm | Username: zuul 2026-05-04 14:16:55.915574 | debian-bookworm | Distro: Debian 12.13 2026-05-04 14:16:55.915595 | debian-bookworm | Provider: regiocloud-a 2026-05-04 14:16:55.915613 | debian-bookworm | Region: 2026-05-04 14:16:55.915630 | debian-bookworm | Label: debian-bookworm 2026-05-04 14:16:55.915647 | debian-bookworm | Product Name: OpenStack Nova 2026-05-04 14:16:55.915663 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5b:608c 2026-05-04 14:16:55.941154 | 2026-05-04 14:16:55.941272 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-04 14:16:56.956141 | debian-bookworm -> localhost | changed 2026-05-04 14:16:56.963130 | 2026-05-04 14:16:56.963244 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-04 14:16:58.779145 | debian-bookworm -> localhost | changed 2026-05-04 14:16:58.793828 | 2026-05-04 14:16:58.793935 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-04 14:16:59.636494 | debian-bookworm -> localhost | ok 2026-05-04 14:16:59.642586 | 2026-05-04 14:16:59.642692 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-04 14:16:59.672436 | debian-bookworm | ok 2026-05-04 14:16:59.688765 | debian-bookworm | included: /var/lib/zuul/builds/8577def448384cb0a46f5e6e72d0603f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-04 14:16:59.695914 | 2026-05-04 14:16:59.696009 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-04 14:17:02.403083 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-04 14:17:02.403307 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8577def448384cb0a46f5e6e72d0603f/work/8577def448384cb0a46f5e6e72d0603f_id_rsa 2026-05-04 14:17:02.403347 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8577def448384cb0a46f5e6e72d0603f/work/8577def448384cb0a46f5e6e72d0603f_id_rsa.pub 2026-05-04 14:17:02.403374 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-04 14:17:02.403399 | debian-bookworm -> localhost | SHA256:7O17T7hedPvDKCWkYhv0gFCMRegntw38VXsDt/gf3CA zuul-build-sshkey 2026-05-04 14:17:02.403423 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-04 14:17:02.403460 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-04 14:17:02.403483 | debian-bookworm -> localhost | | B+ | 2026-05-04 14:17:02.403505 | debian-bookworm -> localhost | | + . o . | 2026-05-04 14:17:02.403538 | debian-bookworm -> localhost | | . o . . = . | 2026-05-04 14:17:02.403559 | debian-bookworm -> localhost | | o * + . +E+. | 2026-05-04 14:17:02.403579 | debian-bookworm -> localhost | | + * S o o.+.o| 2026-05-04 14:17:02.403606 | debian-bookworm -> localhost | | . B + . = +o| 2026-05-04 14:17:02.403628 | debian-bookworm -> localhost | | . = . + *..| 2026-05-04 14:17:02.403647 | debian-bookworm -> localhost | | . . ..= +.| 2026-05-04 14:17:02.403668 | debian-bookworm -> localhost | | o++.. o| 2026-05-04 14:17:02.403689 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-04 14:17:02.403745 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.823582 2026-05-04 14:17:02.410172 | 2026-05-04 14:17:02.410277 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-04 14:17:02.440275 | debian-bookworm | ok 2026-05-04 14:17:02.491422 | debian-bookworm | included: /var/lib/zuul/builds/8577def448384cb0a46f5e6e72d0603f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-04 14:17:02.504499 | 2026-05-04 14:17:02.504626 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-04 14:17:02.548701 | debian-bookworm | skipping: Conditional result was False 2026-05-04 14:17:02.554746 | 2026-05-04 14:17:02.557143 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-04 14:17:03.328835 | debian-bookworm | changed 2026-05-04 14:17:03.338679 | 2026-05-04 14:17:03.338857 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-04 14:17:03.600148 | debian-bookworm | ok 2026-05-04 14:17:03.610730 | 2026-05-04 14:17:03.610849 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-04 14:17:04.278784 | debian-bookworm | changed 2026-05-04 14:17:04.285649 | 2026-05-04 14:17:04.285753 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-04 14:17:04.934797 | debian-bookworm | changed 2026-05-04 14:17:04.942985 | 2026-05-04 14:17:04.943101 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-04 14:17:04.958923 | debian-bookworm | skipping: Conditional result was False 2026-05-04 14:17:04.969365 | 2026-05-04 14:17:04.969507 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-04 14:17:05.582147 | debian-bookworm -> localhost | changed 2026-05-04 14:17:05.593842 | 2026-05-04 14:17:05.593946 | TASK [add-build-sshkey : Add back temp key] 2026-05-04 14:17:06.051255 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8577def448384cb0a46f5e6e72d0603f/work/8577def448384cb0a46f5e6e72d0603f_id_rsa (zuul-build-sshkey) 2026-05-04 14:17:06.051474 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.029275 2026-05-04 14:17:06.063500 | 2026-05-04 14:17:06.063622 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-04 14:17:06.466118 | debian-bookworm | ok 2026-05-04 14:17:06.475837 | 2026-05-04 14:17:06.475939 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-04 14:17:06.510891 | debian-bookworm | skipping: Conditional result was False 2026-05-04 14:17:06.523269 | 2026-05-04 14:17:06.523373 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-04 14:17:07.120364 | debian-bookworm | ok 2026-05-04 14:17:07.146476 | 2026-05-04 14:17:07.146649 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-04 14:17:07.204568 | debian-bookworm | ok 2026-05-04 14:17:07.210079 | 2026-05-04 14:17:07.210183 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-04 14:17:07.594012 | debian-bookworm -> localhost | ok 2026-05-04 14:17:07.600406 | 2026-05-04 14:17:07.600532 | TASK [validate-host : Collect information about the host] 2026-05-04 14:17:08.850049 | debian-bookworm | ok 2026-05-04 14:17:08.863723 | 2026-05-04 14:17:08.863862 | TASK [validate-host : Sanitize hostname] 2026-05-04 14:17:09.084865 | debian-bookworm | ok 2026-05-04 14:17:09.139955 | 2026-05-04 14:17:09.140101 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-04 14:17:09.973040 | debian-bookworm -> localhost | changed 2026-05-04 14:17:09.979340 | 2026-05-04 14:17:09.979461 | TASK [validate-host : Collect information about zuul worker] 2026-05-04 14:17:10.573756 | debian-bookworm | ok 2026-05-04 14:17:10.578720 | 2026-05-04 14:17:10.585127 | TASK [validate-host : Write out all zuul information for each host] 2026-05-04 14:17:11.948003 | debian-bookworm -> localhost | changed 2026-05-04 14:17:11.962605 | 2026-05-04 14:17:11.962752 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-04 14:17:12.320713 | debian-bookworm | ok 2026-05-04 14:17:12.330382 | 2026-05-04 14:17:12.330558 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-04 14:17:13.809951 | debian-bookworm | changed: 2026-05-04 14:17:13.810187 | debian-bookworm | cd+++++++++ src/ 2026-05-04 14:17:13.810222 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-04 14:17:13.810246 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-04 14:17:13.810267 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-04 14:17:13.810287 | debian-bookworm | Containerfile 2026-05-04 14:17:13.810422 | debian-bookworm | Containerfile 2026-05-04 14:17:13.832383 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/8577def448384cb0a46f5e6e72d0603f/work/logs" 2026-05-04 14:17:46.137631 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8577def448384cb0a46f5e6e72d0603f/work/artifacts" 2026-05-04 14:17:46.422746 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8577def448384cb0a46f5e6e72d0603f/work/docs" 2026-05-04 14:17:46.453908 | 2026-05-04 14:17:46.454068 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-04 14:17:47.359785 | debian-bookworm | changed: 2026-05-04 14:17:47.360082 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-04 14:17:47.360130 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-04 14:17:47.360172 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-04 14:17:47.360231 | debian-bookworm | changed: All items complete 2026-05-04 14:17:47.360267 | 2026-05-04 14:17:48.027897 | debian-bookworm | changed: .d..t...... ./ 2026-05-04 14:17:48.666238 | debian-bookworm | changed: .d..t...... ./ 2026-05-04 14:17:48.697034 | 2026-05-04 14:17:48.697239 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-04 14:17:49.336547 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007183 2026-05-04 14:17:49.611689 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.007136 2026-05-04 14:17:49.635878 | 2026-05-04 14:17:49.635984 | PLAY RECAP 2026-05-04 14:17:49.636037 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-04 14:17:49.636062 | 2026-05-04 14:17:49.808140 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-04 14:17:49.809019 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-04 14:17:50.616080 | 2026-05-04 14:17:50.616273 | PLAY [Base post] 2026-05-04 14:17:50.631107 | 2026-05-04 14:17:50.631276 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-04 14:17:51.273255 | debian-bookworm | changed 2026-05-04 14:17:51.286227 | 2026-05-04 14:17:51.286862 | PLAY RECAP 2026-05-04 14:17:51.286991 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-04 14:17:51.287057 | 2026-05-04 14:17:51.453194 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-04 14:17:51.454124 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-04 14:17:52.308308 | 2026-05-04 14:17:52.308489 | PLAY [Base post-logs] 2026-05-04 14:17:52.319516 | 2026-05-04 14:17:52.319694 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-04 14:17:52.910038 | localhost | changed 2026-05-04 14:17:52.922524 | 2026-05-04 14:17:52.922817 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-04 14:17:52.950181 | localhost | ok 2026-05-04 14:17:52.954669 | 2026-05-04 14:17:52.954790 | TASK [Set zuul-log-path fact] 2026-05-04 14:17:52.971309 | localhost | ok 2026-05-04 14:17:52.980385 | 2026-05-04 14:17:52.980513 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-04 14:17:53.006824 | localhost | ok 2026-05-04 14:17:53.010162 | 2026-05-04 14:17:53.010276 | TASK [upload-logs : Create log directories] 2026-05-04 14:17:53.515829 | localhost | changed 2026-05-04 14:17:53.519266 | 2026-05-04 14:17:53.519400 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-04 14:17:54.207275 | localhost -> localhost | ok: Runtime: 0:00:00.008751 2026-05-04 14:17:54.214081 | 2026-05-04 14:17:54.214241 | TASK [upload-logs : Upload logs to log server] 2026-05-04 14:17:54.815909 | localhost | Output suppressed because no_log was given 2026-05-04 14:17:54.817853 | 2026-05-04 14:17:54.817961 | LOOP [upload-logs : Compress console log and json output] 2026-05-04 14:17:54.887370 | localhost | skipping: Conditional result was False 2026-05-04 14:17:54.897194 | localhost | skipping: Conditional result was False 2026-05-04 14:17:54.903965 | 2026-05-04 14:17:54.904118 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-04 14:17:54.962623 | localhost | skipping: Conditional result was False 2026-05-04 14:17:54.963224 | 2026-05-04 14:17:54.968726 | localhost | skipping: Conditional result was False 2026-05-04 14:17:54.980233 | 2026-05-04 14:17:54.980405 | LOOP [upload-logs : Upload console log and json output]