2026-05-02 03:12:51.352096 | Job console starting
2026-05-02 03:12:51.361912 | Updating git repos
2026-05-02 03:12:51.388503 | Cloning repos into workspace
2026-05-02 03:12:51.433743 | Restoring repo states
2026-05-02 03:12:51.446029 | Merging changes
2026-05-02 03:12:51.446045 | Checking out repos
2026-05-02 03:12:51.519465 | Preparing playbooks
2026-05-02 03:12:52.236120 | Running Ansible setup
2026-05-02 03:12:56.895108 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-02 03:12:57.516658 | 
2026-05-02 03:12:57.516781 | PLAY [Base pre]
2026-05-02 03:12:57.530616 | 
2026-05-02 03:12:57.530735 | TASK [Setup log path fact]
2026-05-02 03:12:57.547832 | debian-bookworm | ok
2026-05-02 03:12:57.560702 | 
2026-05-02 03:12:57.560823 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-02 03:12:57.607823 | debian-bookworm | ok
2026-05-02 03:12:57.619601 | 
2026-05-02 03:12:57.619699 | TASK [emit-job-header : Print job information]
2026-05-02 03:12:57.665404 | # Job Information
2026-05-02 03:12:57.665555 | Ansible Version: 2.16.14
2026-05-02 03:12:57.665583 | Job: python-black
2026-05-02 03:12:57.665609 | Pipeline: periodic-daily
2026-05-02 03:12:57.665628 | Executor: 521e9411259a
2026-05-02 03:12:57.665645 | Triggered by: https://github.com/osism/cinder-driver-dm-clone
2026-05-02 03:12:57.665664 | Event ID: 2591bc16ee4f47b4b5c95ae33e0829e4
2026-05-02 03:12:57.669687 | 
2026-05-02 03:12:57.669785 | LOOP [emit-job-header : Print node information]
2026-05-02 03:12:57.796858 | debian-bookworm | ok:
2026-05-02 03:12:57.797050 | debian-bookworm | # Node Information
2026-05-02 03:12:57.797085 | debian-bookworm | Inventory Hostname: debian-bookworm
2026-05-02 03:12:57.797111 | debian-bookworm | Hostname: debian
2026-05-02 03:12:57.797134 | debian-bookworm | Username: zuul
2026-05-02 03:12:57.797154 | debian-bookworm | Distro: Debian 12.13
2026-05-02 03:12:57.797178 | debian-bookworm | Provider: regiocloud-a
2026-05-02 03:12:57.797203 | debian-bookworm | Region:
2026-05-02 03:12:57.797225 | debian-bookworm | Label: debian-bookworm
2026-05-02 03:12:57.797245 | debian-bookworm | Product Name: OpenStack Nova
2026-05-02 03:12:57.797264 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe79:e128
2026-05-02 03:12:57.807509 | 
2026-05-02 03:12:57.807614 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-02 03:12:58.469742 | debian-bookworm -> localhost | changed
2026-05-02 03:12:58.478044 | 
2026-05-02 03:12:58.478140 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-02 03:12:59.536115 | debian-bookworm -> localhost | changed
2026-05-02 03:12:59.547207 | 
2026-05-02 03:12:59.547319 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-02 03:12:59.864304 | debian-bookworm -> localhost | ok
2026-05-02 03:12:59.870234 | 
2026-05-02 03:12:59.870353 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-02 03:12:59.924228 | debian-bookworm | ok
2026-05-02 03:12:59.939715 | debian-bookworm | included: /var/lib/zuul/builds/34174311b88046a7bae642505b768db2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-02 03:12:59.946936 | 
2026-05-02 03:12:59.947041 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-02 03:13:01.165488 | debian-bookworm -> localhost | Generating public/private rsa key pair.
2026-05-02 03:13:01.165719 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/34174311b88046a7bae642505b768db2/work/34174311b88046a7bae642505b768db2_id_rsa
2026-05-02 03:13:01.165760 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/34174311b88046a7bae642505b768db2/work/34174311b88046a7bae642505b768db2_id_rsa.pub
2026-05-02 03:13:01.165787 | debian-bookworm -> localhost | The key fingerprint is:
2026-05-02 03:13:01.165811 | debian-bookworm -> localhost | SHA256:nrHbESzqvdUjWxMu3ta8tbM15Ga8qpyZtWvl7kMkdXQ zuul-build-sshkey
2026-05-02 03:13:01.165833 | debian-bookworm -> localhost | The key's randomart image is:
2026-05-02 03:13:01.165864 | debian-bookworm -> localhost | +---[RSA 3072]----+
2026-05-02 03:13:01.165887 | debian-bookworm -> localhost | |               .E|
2026-05-02 03:13:01.165908 | debian-bookworm -> localhost | |               .o|
2026-05-02 03:13:01.165927 | debian-bookworm -> localhost | |              . .|
2026-05-02 03:13:01.165948 | debian-bookworm -> localhost | |         .   . . |
2026-05-02 03:13:01.165968 | debian-bookworm -> localhost | |        S o . o. |
2026-05-02 03:13:01.165997 | debian-bookworm -> localhost | |       o = + .+o |
2026-05-02 03:13:01.166018 | debian-bookworm -> localhost | |      . + = *++*o|
2026-05-02 03:13:01.166038 | debian-bookworm -> localhost | |     . . =.B*+*==|
2026-05-02 03:13:01.166059 | debian-bookworm -> localhost | |      . +.+B++*B+|
2026-05-02 03:13:01.166079 | debian-bookworm -> localhost | +----[SHA256]-----+
2026-05-02 03:13:01.166132 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.625896
2026-05-02 03:13:01.172421 | 
2026-05-02 03:13:01.172529 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-02 03:13:01.200654 | debian-bookworm | ok
2026-05-02 03:13:01.209467 | debian-bookworm | included: /var/lib/zuul/builds/34174311b88046a7bae642505b768db2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-02 03:13:01.219943 | 
2026-05-02 03:13:01.220327 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-02 03:13:01.233573 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:01.239298 | 
2026-05-02 03:13:01.239403 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-02 03:13:02.052871 | debian-bookworm | changed
2026-05-02 03:13:02.062580 | 
2026-05-02 03:13:02.062686 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-02 03:13:02.346655 | debian-bookworm | ok
2026-05-02 03:13:02.358771 | 
2026-05-02 03:13:02.359040 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-02 03:13:03.163530 | debian-bookworm | changed
2026-05-02 03:13:03.170371 | 
2026-05-02 03:13:03.170469 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-02 03:13:03.860512 | debian-bookworm | changed
2026-05-02 03:13:03.869348 | 
2026-05-02 03:13:03.869517 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-02 03:13:03.893231 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:03.902997 | 
2026-05-02 03:13:03.903122 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-02 03:13:04.409550 | debian-bookworm -> localhost | changed
2026-05-02 03:13:04.420556 | 
2026-05-02 03:13:04.420655 | TASK [add-build-sshkey : Add back temp key]
2026-05-02 03:13:04.823349 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/34174311b88046a7bae642505b768db2/work/34174311b88046a7bae642505b768db2_id_rsa (zuul-build-sshkey)
2026-05-02 03:13:04.823628 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017233
2026-05-02 03:13:04.831953 | 
2026-05-02 03:13:04.832063 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-02 03:13:05.216950 | debian-bookworm | ok
2026-05-02 03:13:05.225738 | 
2026-05-02 03:13:05.225853 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-02 03:13:05.263009 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:05.279486 | 
2026-05-02 03:13:05.279612 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-05-02 03:13:05.812735 | debian-bookworm | ok
2026-05-02 03:13:05.840087 | 
2026-05-02 03:13:05.840208 | TASK [validate-host : Define zuul_info_dir fact]
2026-05-02 03:13:05.889560 | debian-bookworm | ok
2026-05-02 03:13:05.894543 | 
2026-05-02 03:13:05.894652 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-05-02 03:13:06.238561 | debian-bookworm -> localhost | ok
2026-05-02 03:13:06.245388 | 
2026-05-02 03:13:06.245494 | TASK [validate-host : Collect information about the host]
2026-05-02 03:13:07.389142 | debian-bookworm | ok
2026-05-02 03:13:07.403819 | 
2026-05-02 03:13:07.403953 | TASK [validate-host : Sanitize hostname]
2026-05-02 03:13:07.504177 | debian-bookworm | ok
2026-05-02 03:13:07.538685 | 
2026-05-02 03:13:07.538807 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-05-02 03:13:08.097804 | debian-bookworm -> localhost | changed
2026-05-02 03:13:08.103856 | 
2026-05-02 03:13:08.103954 | TASK [validate-host : Collect information about zuul worker]
2026-05-02 03:13:08.507880 | debian-bookworm | ok
2026-05-02 03:13:08.512887 | 
2026-05-02 03:13:08.512991 | TASK [validate-host : Write out all zuul information for each host]
2026-05-02 03:13:09.123383 | debian-bookworm -> localhost | changed
2026-05-02 03:13:09.132774 | 
2026-05-02 03:13:09.132875 | TASK [prepare-workspace-log : Start zuul_console daemon.]
2026-05-02 03:13:09.405229 | debian-bookworm | ok
2026-05-02 03:13:09.411134 | 
2026-05-02 03:13:09.411241 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.]
2026-05-02 03:13:10.167540 | debian-bookworm | changed:
2026-05-02 03:13:10.167916 | debian-bookworm | cd+++++++++ src/
2026-05-02 03:13:10.167959 | debian-bookworm | cd+++++++++ src/github.com/
2026-05-02 03:13:10.168000 | debian-bookworm | cd+++++++++ src/github.com/osism/
2026-05-02 03:13:10.168037 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/
2026-05-02 03:13:10.168068 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.flake8
2026-05-02 03:13:10.168089 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.zuul.yaml
2026-05-02 03:13:10.168110 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/LICENSE
2026-05-02 03:13:10.168130 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/README.md
2026-05-02 03:13:10.168297 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/
2026-05-02 03:13:10.168320 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/HEAD
2026-05-02 03:13:10.168342 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/ORIG_HEAD
2026-05-02 03:13:10.168395 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config
2026-05-02 03:13:10.168416 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config.worktree
2026-05-02 03:13:10.168437 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/description
2026-05-02 03:13:10.168457 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/index
2026-05-02 03:13:10.168477 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/packed-refs
2026-05-02 03:13:10.168497 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/branches/
2026-05-02 03:13:10.168516 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/
2026-05-02 03:13:10.168535 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/applypatch-msg.sample
2026-05-02 03:13:10.168556 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/commit-msg.sample
2026-05-02 03:13:10.168575 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/fsmonitor-watchman.sample
2026-05-02 03:13:10.168768 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/post-update.sample
2026-05-02 03:13:10.168804 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-applypatch.sample
2026-05-02 03:13:10.168828 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-commit.sample
2026-05-02 03:13:10.168849 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-merge-commit.sample
2026-05-02 03:13:10.168870 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-push.sample
2026-05-02 03:13:10.168899 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-rebase.sample
2026-05-02 03:13:10.168920 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-receive.sample
2026-05-02 03:13:10.168940 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/prepare-commit-msg.sample
2026-05-02 03:13:10.168959 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/push-to-checkout.sample
2026-05-02 03:13:10.168978 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/update.sample
2026-05-02 03:13:10.168997 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/
2026-05-02 03:13:10.169016 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/exclude
2026-05-02 03:13:10.169035 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/
2026-05-02 03:13:10.169053 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/HEAD
2026-05-02 03:13:10.169072 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/
2026-05-02 03:13:10.169090 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/
2026-05-02 03:13:10.169109 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/main
2026-05-02 03:13:10.169127 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/
2026-05-02 03:13:10.169145 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/
2026-05-02 03:13:10.169164 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/HEAD
2026-05-02 03:13:10.169182 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/
2026-05-02 03:13:10.169201 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/
2026-05-02 03:13:10.169220 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/e2c2920ba926041df3295b3280def4c83c4039
2026-05-02 03:13:10.169241 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/
2026-05-02 03:13:10.169260 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/459297831c4ce0d7ea29ed8c9114ba146a8527
2026-05-02 03:13:10.169279 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/
2026-05-02 03:13:10.169297 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/39a1f80707e8577fc545424370aeb556127e44
2026-05-02 03:13:10.169317 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/
2026-05-02 03:13:10.169336 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/08e23220f1962907e5e2f9f2d15728a2a19980
2026-05-02 03:13:10.169366 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/
2026-05-02 03:13:10.169386 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/ecda1bd613e629b0ab9f19ddf304ab5f994d60
2026-05-02 03:13:10.169516 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/
2026-05-02 03:13:10.169541 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/5fb3f40bf64cf874cf6e30b8dd8325d3f72992
2026-05-02 03:13:10.169561 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/
2026-05-02 03:13:10.169581 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/3d086ae32b25aaf6ab01121e7c74a51a08211e
2026-05-02 03:13:10.169600 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/
2026-05-02 03:13:10.169625 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/955504dc1be4f034729e036aac7fd53d85d0e2
2026-05-02 03:13:10.169644 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/
2026-05-02 03:13:10.169663 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/a71bda7721ff0db72982e936c2ab41ce720042
2026-05-02 03:13:10.169682 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/info/
2026-05-02 03:13:10.169700 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/
2026-05-02 03:13:10.169719 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.idx
2026-05-02 03:13:10.169740 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.pack
2026-05-02 03:13:10.169759 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/refs/
2026-05-02 03:13:10.169778 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/
2026-05-02 03:13:10.169797 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/
2026-05-02 03:13:10.169816 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/
2026-05-02 03:13:10.169835 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/
2026-05-02 03:13:10.169854 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/__init__.py
2026-05-02 03:13:10.169873 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/dmsetup.py
2026-05-02 03:13:10.169892 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/driver.py
2026-05-02 03:13:10.181510 | 
2026-05-02 03:13:10.181611 | LOOP [ensure-output-dirs-present : Ensure Zuul output directories exist]
2026-05-02 03:13:10.499506 | debian-bookworm | changed: "logs"
2026-05-02 03:13:10.500490 | debian-bookworm | ok: All items complete
2026-05-02 03:13:10.500552 | 
2026-05-02 03:13:10.725784 | debian-bookworm | changed: "artifacts"
2026-05-02 03:13:10.972935 | debian-bookworm | changed: "docs"
2026-05-02 03:13:10.983490 | 
2026-05-02 03:13:10.983604 | TASK [diagnose-first-sudo : Ensure log directory exists]
2026-05-02 03:13:11.243600 | debian-bookworm | ok
2026-05-02 03:13:11.249498 | 
2026-05-02 03:13:11.249594 | TASK [diagnose-first-sudo : Probe first sudo invocation under strace]
2026-05-02 03:13:11.777912 | debian-bookworm | ok: Runtime: 0:00:00.075569
2026-05-02 03:13:11.788460 | 
2026-05-02 03:13:11.789107 | TASK [diagnose-first-sudo : Snapshot DNS / PAM / logind state (no become)]
2026-05-02 03:13:12.316805 | debian-bookworm | ok: Runtime: 0:00:00.118937
2026-05-02 03:13:12.327220 | 
2026-05-02 03:13:12.327381 | PLAY RECAP
2026-05-02 03:13:12.327438 | debian-bookworm | ok: 30 changed: 14 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-02 03:13:12.327466 | 
2026-05-02 03:13:12.510510 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-02 03:13:12.511572 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-02 03:13:13.443989 | 
2026-05-02 03:13:13.444136 | PLAY [Install Black and format code]
2026-05-02 03:13:13.458582 | 
2026-05-02 03:13:13.458702 | LOOP [Install python]
2026-05-02 03:13:13.492394 | debian-bookworm | ok: "ensure-python"
2026-05-02 03:13:13.497200 | debian-bookworm | ok: "ensure-pip"
2026-05-02 03:13:13.547082 | 
2026-05-02 03:13:13.547233 | TASK [ensure-python : Validate python_version value]
2026-05-02 03:13:13.570952 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:13.576859 | 
2026-05-02 03:13:13.576959 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-05-02 03:13:13.600392 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:13.605910 | 
2026-05-02 03:13:13.606010 | TASK [ensure-python : Pull in venv package]
2026-05-02 03:13:13.629476 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:13.635471 | 
2026-05-02 03:13:13.635586 | TASK [ensure-python : Set default RPM package name]
2026-05-02 03:13:13.659315 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:13.665161 | 
2026-05-02 03:13:13.665287 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9 and Python 3.9]
2026-05-02 03:13:13.689016 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:13.698199 | 
2026-05-02 03:13:13.698341 | TASK [ensure-python : Install RPM package]
2026-05-02 03:13:13.722666 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:13.729129 | 
2026-05-02 03:13:13.729241 | TASK [ensure-python : Install python using pyenv]
2026-05-02 03:13:13.742702 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:13.748097 | 
2026-05-02 03:13:13.748182 | TASK [ensure-python : Activate python using stow]
2026-05-02 03:13:13.785685 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:13.804020 | 
2026-05-02 03:13:13.804154 | TASK [ensure-pip : Check if pip is installed]
2026-05-02 03:13:14.349424 | debian-bookworm | ok: Runtime: 0:00:00.006717
2026-05-02 03:13:14.354730 | 
2026-05-02 03:13:14.357943 | LOOP [ensure-pip : Install pip from packages]
2026-05-02 03:13:14.405036 | debian-bookworm | ok: "/var/lib/zuul/builds/34174311b88046a7bae642505b768db2/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-05-02 03:13:14.405303 | debian-bookworm | ok: All items complete
2026-05-02 03:13:14.405341 | 
2026-05-02 03:13:14.422569 | debian-bookworm | included: /var/lib/zuul/builds/34174311b88046a7bae642505b768db2/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-05-02 03:13:14.441863 | 
2026-05-02 03:13:14.441981 | TASK [ensure-pip : Update package lists]
2026-05-02 03:13:19.201563 | debian-bookworm | changed
2026-05-02 03:13:19.209034 | 
2026-05-02 03:13:19.209135 | TASK [ensure-pip : Install Python 3 pip]
2026-05-02 03:13:24.546394 | debian-bookworm | changed
2026-05-02 03:13:24.553013 | 
2026-05-02 03:13:24.553134 | TASK [ensure-pip : Install Python 2 pip]
2026-05-02 03:13:24.607091 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:24.613371 | 
2026-05-02 03:13:24.613500 | TASK [ensure-pip : Ensure setuptools]
2026-05-02 03:13:24.628345 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:24.662109 | 
2026-05-02 03:13:24.662276 | TASK [ensure-pip : Check for ensurepip module]
2026-05-02 03:13:25.061561 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-05-02 03:13:25.061776 | debian-bookworm |                            [--altinstall] [--default-pip]
2026-05-02 03:13:25.061801 | debian-bookworm |
2026-05-02 03:13:25.061817 | debian-bookworm | options:
2026-05-02 03:13:25.061836 | debian-bookworm |   -h, --help     show this help message and exit
2026-05-02 03:13:25.061856 | debian-bookworm |   --version      Show the version of pip that is bundled with this Python.
2026-05-02 03:13:25.061871 | debian-bookworm |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-05-02 03:13:25.061916 | debian-bookworm |                  times.
2026-05-02 03:13:25.061941 | debian-bookworm |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-05-02 03:13:25.061957 | debian-bookworm |   --user         Install using the user scheme.
2026-05-02 03:13:25.061970 | debian-bookworm |   --root ROOT    Install everything relative to this alternate root directory.
2026-05-02 03:13:25.061982 | debian-bookworm |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-05-02 03:13:25.061994 | debian-bookworm |                  scripts (Default: pipX, pipX.Y, easy_install-X.Y).
2026-05-02 03:13:25.062005 | debian-bookworm |   --default-pip  Make a default pip install, installing the unqualified pip
2026-05-02 03:13:25.062017 | debian-bookworm |                  and easy_install in addition to the versioned scripts.
2026-05-02 03:13:25.205129 | debian-bookworm | ok: Runtime: 0:00:00.132674
2026-05-02 03:13:25.221362 | 
2026-05-02 03:13:25.221595 | TASK [ensure-pip : Ensure python3-venv]
2026-05-02 03:13:25.257908 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:25.271245 | 
2026-05-02 03:13:25.271434 | TASK [ensure-pip : Install pip from source]
2026-05-02 03:13:25.297155 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:25.303267 | 
2026-05-02 03:13:25.303388 | TASK [ensure-pip : Probe for venv python full path]
2026-05-02 03:13:25.604495 | debian-bookworm | /usr/bin/python3
2026-05-02 03:13:25.847416 | debian-bookworm | ok: Runtime: 0:00:00.012076
2026-05-02 03:13:25.859184 | 
2026-05-02 03:13:25.859345 | TASK [ensure-pip : Set host default]
2026-05-02 03:13:25.931794 | debian-bookworm | ok
2026-05-02 03:13:25.939975 | 
2026-05-02 03:13:25.940106 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-05-02 03:13:26.000216 | debian-bookworm | ok
2026-05-02 03:13:26.059354 | 
2026-05-02 03:13:26.059489 | TASK [python-black : Install black]
2026-05-02 03:13:33.256778 | debian-bookworm | changed
2026-05-02 03:13:33.264285 | 
2026-05-02 03:13:33.264430 | TASK [python-black : Format code with Black if there is nothing to exclude]
2026-05-02 03:13:33.997664 | debian-bookworm | All done! ✨ 🍰 ✨
2026-05-02 03:13:33.997820 | debian-bookworm | 3 files would be left unchanged.
2026-05-02 03:13:34.310917 | debian-bookworm | ok: Runtime: 0:00:00.472719
2026-05-02 03:13:34.316998 | 
2026-05-02 03:13:34.317240 | TASK [python-black : Format code with Black if there is an exclusion]
2026-05-02 03:13:34.846564 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:34.867008 | 
2026-05-02 03:13:34.867154 | PLAY RECAP
2026-05-02 03:13:34.867249 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2026-05-02 03:13:34.867295 | 
2026-05-02 03:13:34.995137 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-02 03:13:34.995928 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-02 03:13:35.784585 | 
2026-05-02 03:13:35.784737 | PLAY [Base post-fetch]
2026-05-02 03:13:35.799202 | 
2026-05-02 03:13:35.799343 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-02 03:13:35.853779 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:35.859518 | 
2026-05-02 03:13:35.859650 | TASK [fetch-output : Set log path for single node]
2026-05-02 03:13:35.889537 | debian-bookworm | ok
2026-05-02 03:13:35.894736 | 
2026-05-02 03:13:35.894896 | LOOP [fetch-output : Ensure local output dirs]
2026-05-02 03:13:36.383109 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/34174311b88046a7bae642505b768db2/work/logs"
2026-05-02 03:13:36.642293 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/34174311b88046a7bae642505b768db2/work/artifacts"
2026-05-02 03:13:36.992195 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/34174311b88046a7bae642505b768db2/work/docs"
2026-05-02 03:13:37.012808 | 
2026-05-02 03:13:37.012926 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-02 03:13:37.779813 | debian-bookworm | changed:
2026-05-02 03:13:37.780645 | debian-bookworm | >f+++++++++ sudo-debug.txt
2026-05-02 03:13:37.780702 | debian-bookworm | >f+++++++++ sudo-strace.log
2026-05-02 03:13:37.780739 | debian-bookworm | >f+++++++++ sudo-strace.log.time
2026-05-02 03:13:37.780793 | debian-bookworm | changed: All items complete
2026-05-02 03:13:37.782465 | 
2026-05-02 03:13:38.329463 | debian-bookworm | changed: .d..t...... ./
2026-05-02 03:13:38.882943 | debian-bookworm | changed: .d..t...... ./
2026-05-02 03:13:38.902330 | 
2026-05-02 03:13:38.902451 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-02 03:13:38.926349 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:38.929908 | debian-bookworm | skipping: Conditional result was False
2026-05-02 03:13:38.943937 | 
2026-05-02 03:13:38.944009 | PLAY RECAP
2026-05-02 03:13:38.944058 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-05-02 03:13:38.944082 | 
2026-05-02 03:13:39.042304 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-02 03:13:39.043121 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-02 03:13:39.787885 | 
2026-05-02 03:13:39.788030 | PLAY [Base post]
2026-05-02 03:13:39.802212 | 
2026-05-02 03:13:39.802364 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-02 03:13:40.368720 | debian-bookworm | changed
2026-05-02 03:13:40.374960 | 
2026-05-02 03:13:40.375060 | PLAY RECAP
2026-05-02 03:13:40.375122 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-02 03:13:40.375182 | 
2026-05-02 03:13:40.476489 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-02 03:13:40.478020 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-02 03:13:41.252301 | 
2026-05-02 03:13:41.252479 | PLAY [Base post-logs]
2026-05-02 03:13:41.262644 | 
2026-05-02 03:13:41.262789 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-02 03:13:41.716903 | localhost | changed
2026-05-02 03:13:41.728574 | 
2026-05-02 03:13:41.728737 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-02 03:13:41.766603 | localhost | ok
2026-05-02 03:13:41.778261 | 
2026-05-02 03:13:41.778661 | TASK [Set zuul-log-path fact]
2026-05-02 03:13:41.808930 | localhost | ok
2026-05-02 03:13:41.831162 | 
2026-05-02 03:13:41.831419 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-02 03:13:41.872385 | localhost | ok
2026-05-02 03:13:41.880914 | 
2026-05-02 03:13:41.881124 | TASK [upload-logs : Create log directories]
2026-05-02 03:13:42.467034 | localhost | changed
2026-05-02 03:13:42.471768 | 
2026-05-02 03:13:42.471992 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-02 03:13:43.222097 | localhost -> localhost | ok: Runtime: 0:00:00.022834
2026-05-02 03:13:43.234823 | 
2026-05-02 03:13:43.235015 | TASK [upload-logs : Upload logs to log server]
2026-05-02 03:13:44.097788 | localhost | Output suppressed because no_log was given
2026-05-02 03:13:44.099688 | 
2026-05-02 03:13:44.099778 | LOOP [upload-logs : Compress console log and json output]
2026-05-02 03:13:44.161337 | localhost | skipping: Conditional result was False
2026-05-02 03:13:44.169327 | localhost | skipping: Conditional result was False
2026-05-02 03:13:44.176486 | 
2026-05-02 03:13:44.176594 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-02 03:13:44.263162 | localhost | skipping: Conditional result was False
2026-05-02 03:13:44.263600 | 
2026-05-02 03:13:44.273006 | localhost | skipping: Conditional result was False
2026-05-02 03:13:44.277792 | 
2026-05-02 03:13:44.277921 | LOOP [upload-logs : Upload console log and json output]