2026-09-11 03:21:45.766778 | Job console starting
2026-09-11 03:21:45.795073 | Updating git repos
2026-09-11 03:21:45.851615 | Cloning repos into workspace
2026-09-11 03:21:45.922908 | Restoring repo states
2026-09-11 03:21:45.958103 | Merging changes
2026-09-11 03:21:45.958124 | Checking out repos
2026-09-11 03:21:46.075983 | Preparing playbooks
2026-09-11 03:21:47.243955 | Running Ansible setup
2026-09-11 03:21:51.808931 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-09-11 03:21:52.543541 | 
2026-09-11 03:21:52.543659 | PLAY [Base pre]
2026-09-11 03:21:52.560433 | 
2026-09-11 03:21:52.560534 | TASK [Setup log path fact]
2026-09-11 03:21:52.590411 | debian-bookworm | ok
2026-09-11 03:21:52.609541 | 
2026-09-11 03:21:52.609673 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-11 03:21:52.637321 | debian-bookworm | ok
2026-09-11 03:21:52.646650 | 
2026-09-11 03:21:52.646748 | TASK [emit-job-header : Print job information]
2026-09-11 03:21:52.685244 | # Job Information
2026-09-11 03:21:52.685384 | Ansible Version: 2.16.14
2026-09-11 03:21:52.685418 | Job: python-black
2026-09-11 03:21:52.685449 | Pipeline: periodic-daily
2026-09-11 03:21:52.685472 | Executor: 521e9411259a
2026-09-11 03:21:52.685492 | Triggered by: https://github.com/osism/mappings
2026-09-11 03:21:52.685513 | Event ID: 1ff5444149eb42ccb2885c11bad590ac
2026-09-11 03:21:52.690203 | 
2026-09-11 03:21:52.690292 | LOOP [emit-job-header : Print node information]
2026-09-11 03:21:52.795812 | debian-bookworm | ok:
2026-09-11 03:21:52.796031 | debian-bookworm | # Node Information
2026-09-11 03:21:52.796070 | debian-bookworm | Inventory Hostname: debian-bookworm
2026-09-11 03:21:52.796097 | debian-bookworm | Hostname: debian
2026-09-11 03:21:52.796120 | debian-bookworm | Username: zuul
2026-09-11 03:21:52.796141 | debian-bookworm | Distro: Debian 12.15
2026-09-11 03:21:52.796167 | debian-bookworm | Provider: regiocloud-a
2026-09-11 03:21:52.796188 | debian-bookworm | Region:
2026-09-11 03:21:52.796209 | debian-bookworm | Label: debian-bookworm
2026-09-11 03:21:52.796229 | debian-bookworm | Product Name: OpenStack Nova
2026-09-11 03:21:52.796248 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe91:beb6
2026-09-11 03:21:52.815161 | 
2026-09-11 03:21:52.815267 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-11 03:21:53.355392 | debian-bookworm -> localhost | changed
2026-09-11 03:21:53.362434 | 
2026-09-11 03:21:53.362535 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-11 03:21:54.432167 | debian-bookworm -> localhost | changed
2026-09-11 03:21:54.442264 | 
2026-09-11 03:21:54.442349 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-11 03:21:54.829317 | debian-bookworm -> localhost | ok
2026-09-11 03:21:54.835437 | 
2026-09-11 03:21:54.835544 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-11 03:21:54.865139 | debian-bookworm | ok
2026-09-11 03:21:54.882268 | debian-bookworm | included: /var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-11 03:21:54.888181 | 
2026-09-11 03:21:54.888264 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-11 03:21:57.279787 | debian-bookworm -> localhost | Generating public/private rsa key pair.
2026-09-11 03:21:57.280071 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/work/8ef9611dc4b349a59483fb5e7906765b_id_rsa
2026-09-11 03:21:57.280113 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/work/8ef9611dc4b349a59483fb5e7906765b_id_rsa.pub
2026-09-11 03:21:57.280140 | debian-bookworm -> localhost | The key fingerprint is:
2026-09-11 03:21:57.280164 | debian-bookworm -> localhost | SHA256:HWdyCXDHctTjkfKTU8Nv523r7OLEtsPlPqORwtMZ26Y zuul-build-sshkey
2026-09-11 03:21:57.280186 | debian-bookworm -> localhost | The key's randomart image is:
2026-09-11 03:21:57.280216 | debian-bookworm -> localhost | +---[RSA 3072]----+
2026-09-11 03:21:57.280240 | debian-bookworm -> localhost | |        ..ooo... |
2026-09-11 03:21:57.280262 | debian-bookworm -> localhost | |         ..o+.=o.|
2026-09-11 03:21:57.280282 | debian-bookworm -> localhost | |          oo=+ =o|
2026-09-11 03:21:57.280303 | debian-bookworm -> localhost | |         . *  * +|
2026-09-11 03:21:57.280323 | debian-bookworm -> localhost | |        S .  . =o|
2026-09-11 03:21:57.280347 | debian-bookworm -> localhost | |          . o *.+|
2026-09-11 03:21:57.280368 | debian-bookworm -> localhost | |           +.Xo+.|
2026-09-11 03:21:57.280388 | debian-bookworm -> localhost | |            =+*= |
2026-09-11 03:21:57.280408 | debian-bookworm -> localhost | |            .EB=o|
2026-09-11 03:21:57.280428 | debian-bookworm -> localhost | +----[SHA256]-----+
2026-09-11 03:21:57.280486 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.688716
2026-09-11 03:21:57.287250 | 
2026-09-11 03:21:57.287347 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-11 03:21:57.319282 | debian-bookworm | ok
2026-09-11 03:21:57.336082 | debian-bookworm | included: /var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-11 03:21:57.346830 | 
2026-09-11 03:21:57.346936 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-11 03:21:57.371818 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:21:57.378457 | 
2026-09-11 03:21:57.378545 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-11 03:21:58.175094 | debian-bookworm | changed
2026-09-11 03:21:58.181461 | 
2026-09-11 03:21:58.181570 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-11 03:21:58.411396 | debian-bookworm | ok
2026-09-11 03:21:58.421845 | 
2026-09-11 03:21:58.421961 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-11 03:21:59.090974 | debian-bookworm | changed
2026-09-11 03:21:59.095353 | 
2026-09-11 03:21:59.095432 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-11 03:21:59.691013 | debian-bookworm | changed
2026-09-11 03:21:59.697251 | 
2026-09-11 03:21:59.697345 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-11 03:21:59.720496 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:21:59.727249 | 
2026-09-11 03:21:59.727342 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-11 03:22:00.322847 | debian-bookworm -> localhost | changed
2026-09-11 03:22:00.343191 | 
2026-09-11 03:22:00.343299 | TASK [add-build-sshkey : Add back temp key]
2026-09-11 03:22:00.895456 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/work/8ef9611dc4b349a59483fb5e7906765b_id_rsa (zuul-build-sshkey)
2026-09-11 03:22:00.895668 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010649
2026-09-11 03:22:00.902831 | 
2026-09-11 03:22:00.903006 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-11 03:22:01.300042 | debian-bookworm | ok
2026-09-11 03:22:01.304949 | 
2026-09-11 03:22:01.305034 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-11 03:22:01.327979 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:01.337948 | 
2026-09-11 03:22:01.338032 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-09-11 03:22:01.761741 | debian-bookworm | ok
2026-09-11 03:22:01.775403 | 
2026-09-11 03:22:01.775498 | TASK [validate-host : Define zuul_info_dir fact]
2026-09-11 03:22:01.803182 | debian-bookworm | ok
2026-09-11 03:22:01.807927 | 
2026-09-11 03:22:01.808010 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-09-11 03:22:02.103111 | debian-bookworm -> localhost | ok
2026-09-11 03:22:02.109804 | 
2026-09-11 03:22:02.109908 | TASK [validate-host : Collect information about the host]
2026-09-11 03:22:03.232954 | debian-bookworm | ok
2026-09-11 03:22:03.260062 | 
2026-09-11 03:22:03.260183 | TASK [validate-host : Sanitize hostname]
2026-09-11 03:22:03.445623 | debian-bookworm | ok
2026-09-11 03:22:03.449545 | 
2026-09-11 03:22:03.449629 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-09-11 03:22:04.070093 | debian-bookworm -> localhost | changed
2026-09-11 03:22:04.074676 | 
2026-09-11 03:22:04.074752 | TASK [validate-host : Collect information about zuul worker]
2026-09-11 03:22:04.527405 | debian-bookworm | ok
2026-09-11 03:22:04.531116 | 
2026-09-11 03:22:04.531192 | TASK [validate-host : Write out all zuul information for each host]
2026-09-11 03:22:05.104694 | debian-bookworm -> localhost | changed
2026-09-11 03:22:05.116812 | 
2026-09-11 03:22:05.116971 | TASK [prepare-workspace-log : Start zuul_console daemon.]
2026-09-11 03:22:05.388505 | debian-bookworm | ok
2026-09-11 03:22:05.398923 | 
2026-09-11 03:22:05.399021 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.]
2026-09-11 03:22:06.513787 | debian-bookworm | changed:
2026-09-11 03:22:06.513984 | debian-bookworm | cd+++++++++ src/
2026-09-11 03:22:06.514018 | debian-bookworm | cd+++++++++ src/github.com/
2026-09-11 03:22:06.514042 | debian-bookworm | cd+++++++++ src/github.com/osism/
2026-09-11 03:22:06.514062 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/
2026-09-11 03:22:06.514082 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.flake8
2026-09-11 03:22:06.514101 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.zuul.yaml
2026-09-11 03:22:06.514120 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/Containerfile
2026-09-11 03:22:06.514138 | debian-bookworm | cL+++++++++ src/github.com/osism/mappings/Dockerfile -> Containerfile
2026-09-11 03:22:06.514158 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/LICENSE
2026-09-11 03:22:06.514176 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/Pipfile
2026-09-11 03:22:06.514194 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/Pipfile.lock
2026-09-11 03:22:06.514212 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/README.md
2026-09-11 03:22:06.514230 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/generate.py
2026-09-11 03:22:06.514248 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/mapping1.yml
2026-09-11 03:22:06.514267 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/mapping2.yml
2026-09-11 03:22:06.514285 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/
2026-09-11 03:22:06.514303 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/HEAD
2026-09-11 03:22:06.514322 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/ORIG_HEAD
2026-09-11 03:22:06.514339 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/config
2026-09-11 03:22:06.514357 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/config.worktree
2026-09-11 03:22:06.514375 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/description
2026-09-11 03:22:06.514392 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/index
2026-09-11 03:22:06.514411 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/packed-refs
2026-09-11 03:22:06.514428 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/branches/
2026-09-11 03:22:06.514446 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/hooks/
2026-09-11 03:22:06.514463 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/applypatch-msg.sample
2026-09-11 03:22:06.514481 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/commit-msg.sample
2026-09-11 03:22:06.514499 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/fsmonitor-watchman.sample
2026-09-11 03:22:06.514516 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/post-update.sample
2026-09-11 03:22:06.514543 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/pre-applypatch.sample
2026-09-11 03:22:06.514561 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/pre-commit.sample
2026-09-11 03:22:06.514579 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/pre-merge-commit.sample
2026-09-11 03:22:06.514597 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/pre-push.sample
2026-09-11 03:22:06.514614 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/pre-rebase.sample
2026-09-11 03:22:06.514631 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/pre-receive.sample
2026-09-11 03:22:06.514649 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/prepare-commit-msg.sample
2026-09-11 03:22:06.514666 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/push-to-checkout.sample
2026-09-11 03:22:06.514683 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/hooks/update.sample
2026-09-11 03:22:06.514701 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/info/
2026-09-11 03:22:06.514719 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/info/exclude
2026-09-11 03:22:06.514736 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/logs/
2026-09-11 03:22:06.514754 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/logs/HEAD
2026-09-11 03:22:06.514771 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/logs/refs/
2026-09-11 03:22:06.514789 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/logs/refs/heads/
2026-09-11 03:22:06.514806 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/logs/refs/heads/main
2026-09-11 03:22:06.514824 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/logs/refs/remotes/
2026-09-11 03:22:06.514841 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/logs/refs/remotes/origin/
2026-09-11 03:22:06.514859 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/logs/refs/remotes/origin/HEAD
2026-09-11 03:22:06.514900 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/objects/
2026-09-11 03:22:06.514921 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/objects/2c/
2026-09-11 03:22:06.514939 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/2c/eb4ee05ecbdc8887131b922b552784e651a87e
2026-09-11 03:22:06.514958 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/objects/77/
2026-09-11 03:22:06.514976 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/77/cf911707ec72e102184c1e90dba956cbbba584
2026-09-11 03:22:06.514995 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/objects/82/
2026-09-11 03:22:06.515012 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/82/20ce3aafa5a749737b6b4b149e48772644635b
2026-09-11 03:22:06.515030 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/objects/a2/
2026-09-11 03:22:06.515048 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/a2/86dc81a61fbdecb16a86033cc9d7d45ddbf759
2026-09-11 03:22:06.515065 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/objects/b8/
2026-09-11 03:22:06.515083 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/b8/2b95f4137a84a0ee21776f97af752dc55f0729
2026-09-11 03:22:06.515100 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/objects/cc/
2026-09-11 03:22:06.515117 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/cc/94c3d422e8946679935071cca6169d5cdab166
2026-09-11 03:22:06.515135 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/objects/info/
2026-09-11 03:22:06.515152 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/info/commit-graph
2026-09-11 03:22:06.515170 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/info/packs
2026-09-11 03:22:06.515190 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/objects/pack/
2026-09-11 03:22:06.515209 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/pack/pack-890abbdb21f6d51f8ab5f3af4c77b31486f85fe4.idx
2026-09-11 03:22:06.515227 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/pack/pack-890abbdb21f6d51f8ab5f3af4c77b31486f85fe4.pack
2026-09-11 03:22:06.515246 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/pack/pack-a9ecc4fafabe97a0ac4eb739f8465a4f9b4eb744.idx
2026-09-11 03:22:06.515263 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/pack/pack-a9ecc4fafabe97a0ac4eb739f8465a4f9b4eb744.pack
2026-09-11 03:22:06.515281 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/pack/pack-c2cf33bd2fd2736f261b0f56275aa9d895b5dea7.idx
2026-09-11 03:22:06.515299 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/pack/pack-c2cf33bd2fd2736f261b0f56275aa9d895b5dea7.pack
2026-09-11 03:22:06.515316 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/pack/pack-f3db9358996d582e77e28a7244e017a6d60b640d.idx
2026-09-11 03:22:06.515334 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.git/objects/pack/pack-f3db9358996d582e77e28a7244e017a6d60b640d.pack
2026-09-11 03:22:06.515352 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.git/refs/
2026-09-11 03:22:06.515369 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.github/
2026-09-11 03:22:06.515386 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.github/renovate.json
2026-09-11 03:22:06.515404 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/.github/workflows/
2026-09-11 03:22:06.515421 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.github/workflows/add-to-project.yml
2026-09-11 03:22:06.515439 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/.github/workflows/update-mappings.yml
2026-09-11 03:22:06.515457 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/scripts/
2026-09-11 03:22:06.515474 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/scripts/update-mappings-with-docker.sh
2026-09-11 03:22:06.515492 | debian-bookworm | <f+++++++++ src/github.com/osism/mappings/scripts/update-mappings.sh
2026-09-11 03:22:06.528562 | 
2026-09-11 03:22:06.528651 | LOOP [ensure-output-dirs-present : Ensure Zuul output directories exist]
2026-09-11 03:22:06.830377 | debian-bookworm | changed: "logs"
2026-09-11 03:22:06.830583 | debian-bookworm | ok: All items complete
2026-09-11 03:22:06.830613 | 
2026-09-11 03:22:07.041395 | debian-bookworm | changed: "artifacts"
2026-09-11 03:22:07.296159 | debian-bookworm | changed: "docs"
2026-09-11 03:22:07.320554 | 
2026-09-11 03:22:07.320675 | TASK [diagnose-first-sudo : Ensure log directory exists]
2026-09-11 03:22:07.629136 | debian-bookworm | ok
2026-09-11 03:22:07.634470 | 
2026-09-11 03:22:07.634749 | TASK [diagnose-first-sudo : Probe first sudo invocation under strace]
2026-09-11 03:22:08.199723 | debian-bookworm | ok: Runtime: 0:00:00.073219
2026-09-11 03:22:08.204635 | 
2026-09-11 03:22:08.204731 | TASK [diagnose-first-sudo : Snapshot DNS / PAM / logind state (no become)]
2026-09-11 03:22:08.725252 | debian-bookworm | ok: Runtime: 0:00:00.120800
2026-09-11 03:22:08.732505 | 
2026-09-11 03:22:08.732582 | TASK [diagnose-network : Ensure log directory exists]
2026-09-11 03:22:09.012121 | debian-bookworm | ok
2026-09-11 03:22:09.019659 | 
2026-09-11 03:22:09.019771 | TASK [diagnose-network : Snapshot dual-stack network state (pre)]
2026-09-11 03:22:20.538538 | debian-bookworm | ok: Runtime: 0:00:06.383058
2026-09-11 03:22:20.543038 | 
2026-09-11 03:22:20.543126 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)]
2026-09-11 03:22:20.580918 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:20.586684 | 
2026-09-11 03:22:20.586785 | TASK [diagnose-network : Probe container network namespace (teardown)]
2026-09-11 03:22:20.631843 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:20.636691 | 
2026-09-11 03:22:20.636786 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)]
2026-09-11 03:22:20.939653 | debian-bookworm | VERDICT=healthy reason=ping-answered lost=0/3
2026-09-11 03:22:21.178706 | debian-bookworm | ok: Runtime: 0:00:00.010075
2026-09-11 03:22:21.197442 | 
2026-09-11 03:22:21.197614 | TASK [diagnose-network : Abort the pre-run on a fully isolated node]
2026-09-11 03:22:21.277849 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:21.288135 | 
2026-09-11 03:22:21.288294 | PLAY RECAP
2026-09-11 03:22:21.288450 | debian-bookworm | ok: 33 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 0
2026-09-11 03:22:21.288488 | 
2026-09-11 03:22:21.387312 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-09-11 03:22:21.388019 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-09-11 03:22:21.934835 | 
2026-09-11 03:22:21.934959 | PLAY [Install Black and format code]
2026-09-11 03:22:21.946245 | 
2026-09-11 03:22:21.946322 | LOOP [Install python]
2026-09-11 03:22:21.975088 | debian-bookworm | ok: "ensure-python"
2026-09-11 03:22:21.979509 | debian-bookworm | ok: "ensure-pip"
2026-09-11 03:22:22.016224 | 
2026-09-11 03:22:22.016319 | TASK [ensure-python : Validate python_version value]
2026-09-11 03:22:22.059576 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:22.064604 | 
2026-09-11 03:22:22.064689 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-09-11 03:22:22.087913 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:22.092839 | 
2026-09-11 03:22:22.092954 | TASK [ensure-python : Pull in venv package]
2026-09-11 03:22:22.127557 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:22.133623 | 
2026-09-11 03:22:22.133710 | TASK [ensure-python : Set default RPM package name]
2026-09-11 03:22:22.157164 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:22.162600 | 
2026-09-11 03:22:22.162687 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-09-11 03:22:22.185941 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:22.191644 | 
2026-09-11 03:22:22.191723 | TASK [ensure-python : Install RPM package]
2026-09-11 03:22:22.215673 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:22.222738 | 
2026-09-11 03:22:22.222832 | TASK [ensure-python : Install python using pyenv]
2026-09-11 03:22:22.249776 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:22.267200 | 
2026-09-11 03:22:22.267306 | TASK [ensure-python : Activate python using stow]
2026-09-11 03:22:22.301095 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:22.312188 | 
2026-09-11 03:22:22.312283 | TASK [ensure-pip : Check if pip is installed]
2026-09-11 03:22:22.844809 | debian-bookworm | ok: Runtime: 0:00:00.008412
2026-09-11 03:22:22.854816 | 
2026-09-11 03:22:22.854990 | LOOP [ensure-pip : Install pip from packages]
2026-09-11 03:22:22.901996 | debian-bookworm | ok: "/var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-09-11 03:22:22.902235 | debian-bookworm | ok: All items complete
2026-09-11 03:22:22.902278 | 
2026-09-11 03:22:22.913139 | debian-bookworm | included: /var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-09-11 03:22:22.923108 | 
2026-09-11 03:22:22.923210 | TASK [ensure-pip : Update package lists]
2026-09-11 03:22:27.441835 | debian-bookworm | changed
2026-09-11 03:22:27.448716 | 
2026-09-11 03:22:27.448837 | TASK [ensure-pip : Install Python 3 pip]
2026-09-11 03:22:32.832217 | debian-bookworm | changed
2026-09-11 03:22:32.856705 | 
2026-09-11 03:22:32.856912 | TASK [ensure-pip : Install Python 2 pip]
2026-09-11 03:22:32.953413 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:32.966671 | 
2026-09-11 03:22:32.966807 | TASK [ensure-pip : Ensure setuptools]
2026-09-11 03:22:32.992129 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:33.000340 | 
2026-09-11 03:22:33.000455 | TASK [ensure-pip : Check for ensurepip module]
2026-09-11 03:22:33.357796 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-09-11 03:22:33.358022 | debian-bookworm |                            [--altinstall] [--default-pip]
2026-09-11 03:22:33.358054 | debian-bookworm |
2026-09-11 03:22:33.358077 | debian-bookworm | options:
2026-09-11 03:22:33.358103 | debian-bookworm |   -h, --help     show this help message and exit
2026-09-11 03:22:33.358133 | debian-bookworm |   --version      Show the version of pip that is bundled with this Python.
2026-09-11 03:22:33.358155 | debian-bookworm |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-09-11 03:22:33.358262 | debian-bookworm |                  times.
2026-09-11 03:22:33.358302 | debian-bookworm |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-09-11 03:22:33.358324 | debian-bookworm |   --user         Install using the user scheme.
2026-09-11 03:22:33.358343 | debian-bookworm |   --root ROOT    Install everything relative to this alternate root directory.
2026-09-11 03:22:33.358363 | debian-bookworm |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-09-11 03:22:33.358381 | debian-bookworm |                  scripts (Default: pipX, pipX.Y, easy_install-X.Y).
2026-09-11 03:22:33.358400 | debian-bookworm |   --default-pip  Make a default pip install, installing the unqualified pip
2026-09-11 03:22:33.358419 | debian-bookworm |                  and easy_install in addition to the versioned scripts.
2026-09-11 03:22:33.540474 | debian-bookworm | ok: Runtime: 0:00:00.095241
2026-09-11 03:22:33.552401 | 
2026-09-11 03:22:33.552512 | TASK [ensure-pip : Ensure python3-venv]
2026-09-11 03:22:33.576682 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:33.582766 | 
2026-09-11 03:22:33.582889 | TASK [ensure-pip : Install pip from source]
2026-09-11 03:22:33.596284 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:33.602306 | 
2026-09-11 03:22:33.602413 | TASK [ensure-pip : Probe for venv python full path]
2026-09-11 03:22:33.897796 | debian-bookworm | /usr/bin/python3
2026-09-11 03:22:34.156656 | debian-bookworm | ok: Runtime: 0:00:00.009051
2026-09-11 03:22:34.162902 | 
2026-09-11 03:22:34.163010 | TASK [ensure-pip : Set host default]
2026-09-11 03:22:34.233013 | debian-bookworm | ok
2026-09-11 03:22:34.239128 | 
2026-09-11 03:22:34.239244 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-09-11 03:22:34.312004 | debian-bookworm | ok
2026-09-11 03:22:34.371132 | 
2026-09-11 03:22:34.371266 | TASK [python-black : Install black]
2026-09-11 03:22:41.676710 | debian-bookworm | changed
2026-09-11 03:22:41.685470 | 
2026-09-11 03:22:41.685677 | TASK [python-black : Format code with Black if there is nothing to exclude]
2026-09-11 03:22:42.183551 | debian-bookworm | All done! ✨ 🍰 ✨
2026-09-11 03:22:42.183698 | debian-bookworm | 1 file would be left unchanged.
2026-09-11 03:22:42.717632 | debian-bookworm | ok: Runtime: 0:00:00.243194
2026-09-11 03:22:42.723398 | 
2026-09-11 03:22:42.723518 | TASK [python-black : Format code with Black if there is an exclusion]
2026-09-11 03:22:43.275439 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:22:43.283958 | 
2026-09-11 03:22:43.284069 | PLAY RECAP
2026-09-11 03:22:43.284153 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2026-09-11 03:22:43.284199 | 
2026-09-11 03:22:43.567296 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-09-11 03:22:43.568484 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-09-11 03:22:44.511931 | 
2026-09-11 03:22:44.512124 | PLAY [Base post-fetch]
2026-09-11 03:22:44.548165 | 
2026-09-11 03:22:44.548319 | TASK [diagnose-network : Ensure log directory exists]
2026-09-11 03:22:44.943807 | debian-bookworm | ok
2026-09-11 03:22:44.952832 | 
2026-09-11 03:22:44.953025 | TASK [diagnose-network : Snapshot dual-stack network state (post)]
2026-09-11 03:22:56.838702 | debian-bookworm | ok: Runtime: 0:00:05.977638
2026-09-11 03:22:56.848211 | 
2026-09-11 03:22:56.848358 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)]
2026-09-11 03:23:02.872610 | debian-bookworm | ok: Runtime: 0:00:00.005662
2026-09-11 03:23:02.881146 | 
2026-09-11 03:23:02.881332 | TASK [diagnose-network : Probe container network namespace (teardown)]
2026-09-11 03:23:08.902575 | debian-bookworm | ok: Runtime: 0:00:00.009618
2026-09-11 03:23:08.911221 | 
2026-09-11 03:23:08.911354 | TASK [diagnose-network : Evaluate node isolation verdict (pre-run gate)]
2026-09-11 03:23:09.450631 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:23:09.465794 | 
2026-09-11 03:23:09.465978 | TASK [diagnose-network : Abort the pre-run on a fully isolated node]
2026-09-11 03:23:09.522011 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:23:09.542895 | 
2026-09-11 03:23:09.543035 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-11 03:23:09.598098 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:23:09.611409 | 
2026-09-11 03:23:09.611661 | TASK [fetch-output : Set log path for single node]
2026-09-11 03:23:09.659446 | debian-bookworm | ok
2026-09-11 03:23:09.670305 | 
2026-09-11 03:23:09.670454 | LOOP [fetch-output : Ensure local output dirs]
2026-09-11 03:23:09.979727 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/work/logs"
2026-09-11 03:23:10.232764 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/work/artifacts"
2026-09-11 03:23:10.505543 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8ef9611dc4b349a59483fb5e7906765b/work/docs"
2026-09-11 03:23:10.520159 | 
2026-09-11 03:23:10.520338 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-11 03:23:11.341429 | debian-bookworm | changed:
2026-09-11 03:23:11.341781 | debian-bookworm | .d..t...... ./
2026-09-11 03:23:11.341841 | debian-bookworm | >f+++++++++ net-debug.post.txt
2026-09-11 03:23:11.341902 | debian-bookworm | >f+++++++++ net-debug.pre.txt
2026-09-11 03:23:11.341938 | debian-bookworm | >f+++++++++ sudo-debug.txt
2026-09-11 03:23:11.341973 | debian-bookworm | >f+++++++++ sudo-strace.log
2026-09-11 03:23:11.342006 | debian-bookworm | >f+++++++++ sudo-strace.log.time
2026-09-11 03:23:11.342064 | debian-bookworm | changed: All items complete
2026-09-11 03:23:11.342103 | 
2026-09-11 03:23:11.927692 | debian-bookworm | changed: .d..t...... ./
2026-09-11 03:23:12.509607 | debian-bookworm | changed: .d..t...... ./
2026-09-11 03:23:12.532662 | 
2026-09-11 03:23:12.532789 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-11 03:23:12.570387 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:23:12.574220 | debian-bookworm | skipping: Conditional result was False
2026-09-11 03:23:12.592636 | 
2026-09-11 03:23:12.592722 | PLAY RECAP
2026-09-11 03:23:12.592906 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0
2026-09-11 03:23:12.592949 | 
2026-09-11 03:23:12.744938 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-09-11 03:23:12.747285 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-09-11 03:23:13.484661 | 
2026-09-11 03:23:13.484808 | PLAY [Base post]
2026-09-11 03:23:13.498227 | 
2026-09-11 03:23:13.498347 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-11 03:23:14.086860 | debian-bookworm | changed
2026-09-11 03:23:14.095900 | 
2026-09-11 03:23:14.096017 | PLAY RECAP
2026-09-11 03:23:14.096093 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 03:23:14.096168 | 
2026-09-11 03:23:14.228824 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-09-11 03:23:14.229730 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-11 03:23:15.087150 | 
2026-09-11 03:23:15.087377 | PLAY [Base post-logs]
2026-09-11 03:23:15.098811 | 
2026-09-11 03:23:15.098963 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-11 03:23:15.554746 | localhost | changed
2026-09-11 03:23:15.573410 | 
2026-09-11 03:23:15.573668 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-11 03:23:15.602775 | localhost | ok
2026-09-11 03:23:15.608001 | 
2026-09-11 03:23:15.608156 | TASK [Set zuul-log-path fact]
2026-09-11 03:23:15.625650 | localhost | ok
2026-09-11 03:23:15.637743 | 
2026-09-11 03:23:15.638084 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-11 03:23:15.665074 | localhost | ok
2026-09-11 03:23:15.670232 | 
2026-09-11 03:23:15.670379 | TASK [upload-logs : Create log directories]
2026-09-11 03:23:16.186135 | localhost | changed
2026-09-11 03:23:16.189283 | 
2026-09-11 03:23:16.189399 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-11 03:23:16.694796 | localhost -> localhost | ok: Runtime: 0:00:00.008225
2026-09-11 03:23:16.703373 | 
2026-09-11 03:23:16.703556 | TASK [upload-logs : Upload logs to log server]
2026-09-11 03:23:17.326078 | localhost | Output suppressed because no_log was given
2026-09-11 03:23:17.328337 | 
2026-09-11 03:23:17.328461 | LOOP [upload-logs : Compress console log and json output]
2026-09-11 03:23:17.378015 | localhost | skipping: Conditional result was False
2026-09-11 03:23:17.383778 | localhost | skipping: Conditional result was False
2026-09-11 03:23:17.391079 | 
2026-09-11 03:23:17.391322 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-11 03:23:17.437015 | localhost | skipping: Conditional result was False
2026-09-11 03:23:17.437298 | 
2026-09-11 03:23:17.442154 | localhost | skipping: Conditional result was False
2026-09-11 03:23:17.456107 | 
2026-09-11 03:23:17.456364 | LOOP [upload-logs : Upload console log and json output]