2026-05-04 03:13:38.962774 | Job console starting
2026-05-04 03:13:38.979567 | Updating git repos
2026-05-04 03:13:39.019182 | Cloning repos into workspace
2026-05-04 03:13:39.073450 | Restoring repo states
2026-05-04 03:13:39.078503 | Merging changes
2026-05-04 03:13:39.078517 | Checking out repos
2026-05-04 03:13:39.113194 | Preparing playbooks
2026-05-04 03:13:39.924580 | Running Ansible setup
2026-05-04 03:13:45.049063 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-04 03:13:45.711645 | 
2026-05-04 03:13:45.711778 | PLAY [Base pre]
2026-05-04 03:13:45.727786 | 
2026-05-04 03:13:45.727908 | TASK [Setup log path fact]
2026-05-04 03:13:45.745942 | debian-bookworm | ok
2026-05-04 03:13:45.762111 | 
2026-05-04 03:13:45.762242 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-04 03:13:45.790093 | debian-bookworm | ok
2026-05-04 03:13:45.799847 | 
2026-05-04 03:13:45.799945 | TASK [emit-job-header : Print job information]
2026-05-04 03:13:45.838770 | # Job Information
2026-05-04 03:13:45.838957 | Ansible Version: 2.16.14
2026-05-04 03:13:45.838993 | Job: python-black
2026-05-04 03:13:45.839050 | Pipeline: periodic-daily
2026-05-04 03:13:45.839076 | Executor: 521e9411259a
2026-05-04 03:13:45.839097 | Triggered by: https://github.com/osism/cinder-driver-dm-clone
2026-05-04 03:13:45.839120 | Event ID: 0e08f087e350418db465a7d6c37df9c9
2026-05-04 03:13:45.845667 | 
2026-05-04 03:13:45.845775 | LOOP [emit-job-header : Print node information]
2026-05-04 03:13:45.947384 | debian-bookworm | ok:
2026-05-04 03:13:45.947527 | debian-bookworm | # Node Information
2026-05-04 03:13:45.947554 | debian-bookworm | Inventory Hostname: debian-bookworm
2026-05-04 03:13:45.947575 | debian-bookworm | Hostname: debian
2026-05-04 03:13:45.947593 | debian-bookworm | Username: zuul
2026-05-04 03:13:45.947610 | debian-bookworm | Distro: Debian 12.13
2026-05-04 03:13:45.947630 | debian-bookworm | Provider: regiocloud-a
2026-05-04 03:13:45.947648 | debian-bookworm | Region:
2026-05-04 03:13:45.947665 | debian-bookworm | Label: debian-bookworm
2026-05-04 03:13:45.947681 | debian-bookworm | Product Name: OpenStack Nova
2026-05-04 03:13:45.947697 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe93:2963
2026-05-04 03:13:45.961432 | 
2026-05-04 03:13:45.961529 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-04 03:13:46.486158 | debian-bookworm -> localhost | changed
2026-05-04 03:13:46.496626 | 
2026-05-04 03:13:46.496743 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-04 03:13:47.881005 | debian-bookworm -> localhost | changed
2026-05-04 03:13:47.892107 | 
2026-05-04 03:13:47.892216 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-04 03:13:48.306139 | debian-bookworm -> localhost | ok
2026-05-04 03:13:48.311120 | 
2026-05-04 03:13:48.311221 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-04 03:13:48.331360 | debian-bookworm | ok
2026-05-04 03:13:48.353491 | debian-bookworm | included: /var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-04 03:13:48.364813 | 
2026-05-04 03:13:48.364906 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-04 03:13:50.884973 | debian-bookworm -> localhost | Generating public/private rsa key pair.
2026-05-04 03:13:50.885180 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/work/88dd8ebe489d4820add6d690f9f37337_id_rsa
2026-05-04 03:13:50.885217 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/work/88dd8ebe489d4820add6d690f9f37337_id_rsa.pub
2026-05-04 03:13:50.885244 | debian-bookworm -> localhost | The key fingerprint is:
2026-05-04 03:13:50.885268 | debian-bookworm -> localhost | SHA256:7SV09vLR3Ulifa0HjfTRnjb0zhnOCR03x36RWfeOtcY zuul-build-sshkey
2026-05-04 03:13:50.885290 | debian-bookworm -> localhost | The key's randomart image is:
2026-05-04 03:13:50.885319 | debian-bookworm -> localhost | +---[RSA 3072]----+
2026-05-04 03:13:50.885341 | debian-bookworm -> localhost | |              .oB|
2026-05-04 03:13:50.885363 | debian-bookworm -> localhost | |             ..@X|
2026-05-04 03:13:50.885383 | debian-bookworm -> localhost | |          . oo==/|
2026-05-04 03:13:50.885403 | debian-bookworm -> localhost | |         o o.o+&@|
2026-05-04 03:13:50.885422 | debian-bookworm -> localhost | |        S o o XE%|
2026-05-04 03:13:50.885449 | debian-bookworm -> localhost | |         . o o.Bo|
2026-05-04 03:13:50.885470 | debian-bookworm -> localhost | |          .   .  |
2026-05-04 03:13:50.885492 | debian-bookworm -> localhost | |                 |
2026-05-04 03:13:50.885513 | debian-bookworm -> localhost | |                 |
2026-05-04 03:13:50.885533 | debian-bookworm -> localhost | +----[SHA256]-----+
2026-05-04 03:13:50.885582 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.803653
2026-05-04 03:13:50.892194 | 
2026-05-04 03:13:50.892291 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-04 03:13:50.910157 | debian-bookworm | ok
2026-05-04 03:13:50.922264 | debian-bookworm | included: /var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-04 03:13:50.931385 | 
2026-05-04 03:13:50.931479 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-04 03:13:50.945051 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:13:50.951756 | 
2026-05-04 03:13:50.951869 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-04 03:13:51.655703 | debian-bookworm | changed
2026-05-04 03:13:51.661231 | 
2026-05-04 03:13:51.661328 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-04 03:13:51.946745 | debian-bookworm | ok
2026-05-04 03:13:51.955842 | 
2026-05-04 03:13:51.955952 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-04 03:13:52.626864 | debian-bookworm | changed
2026-05-04 03:13:52.638004 | 
2026-05-04 03:13:52.638163 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-04 03:13:53.273908 | debian-bookworm | changed
2026-05-04 03:13:53.279316 | 
2026-05-04 03:13:53.279415 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-04 03:13:53.292153 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:13:53.298502 | 
2026-05-04 03:13:53.298606 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-04 03:13:53.933902 | debian-bookworm -> localhost | changed
2026-05-04 03:13:53.944386 | 
2026-05-04 03:13:53.944486 | TASK [add-build-sshkey : Add back temp key]
2026-05-04 03:13:54.347605 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/work/88dd8ebe489d4820add6d690f9f37337_id_rsa (zuul-build-sshkey)
2026-05-04 03:13:54.347813 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.033189
2026-05-04 03:13:54.356092 | 
2026-05-04 03:13:54.356197 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-04 03:13:54.814224 | debian-bookworm | ok
2026-05-04 03:13:54.823814 | 
2026-05-04 03:13:54.823970 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-04 03:13:54.849423 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:13:54.871265 | 
2026-05-04 03:13:54.871459 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-05-04 03:13:55.376518 | debian-bookworm | ok
2026-05-04 03:13:55.389859 | 
2026-05-04 03:13:55.389970 | TASK [validate-host : Define zuul_info_dir fact]
2026-05-04 03:13:55.422953 | debian-bookworm | ok
2026-05-04 03:13:55.433554 | 
2026-05-04 03:13:55.434385 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-05-04 03:13:55.972831 | debian-bookworm -> localhost | ok
2026-05-04 03:13:55.979612 | 
2026-05-04 03:13:55.979718 | TASK [validate-host : Collect information about the host]
2026-05-04 03:13:57.346753 | debian-bookworm | ok
2026-05-04 03:13:57.356816 | 
2026-05-04 03:13:57.356908 | TASK [validate-host : Sanitize hostname]
2026-05-04 03:13:57.482435 | debian-bookworm | ok
2026-05-04 03:13:57.530763 | 
2026-05-04 03:13:57.530901 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-05-04 03:13:58.288788 | debian-bookworm -> localhost | changed
2026-05-04 03:13:58.294708 | 
2026-05-04 03:13:58.294823 | TASK [validate-host : Collect information about zuul worker]
2026-05-04 03:13:58.826766 | debian-bookworm | ok
2026-05-04 03:13:58.832728 | 
2026-05-04 03:13:58.832845 | TASK [validate-host : Write out all zuul information for each host]
2026-05-04 03:13:59.346852 | debian-bookworm -> localhost | changed
2026-05-04 03:13:59.356859 | 
2026-05-04 03:13:59.356962 | TASK [prepare-workspace-log : Start zuul_console daemon.]
2026-05-04 03:13:59.635416 | debian-bookworm | ok
2026-05-04 03:13:59.645735 | 
2026-05-04 03:13:59.645889 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.]
2026-05-04 03:14:00.404509 | debian-bookworm | changed:
2026-05-04 03:14:00.404676 | debian-bookworm | cd+++++++++ src/
2026-05-04 03:14:00.404709 | debian-bookworm | cd+++++++++ src/github.com/
2026-05-04 03:14:00.404732 | debian-bookworm | cd+++++++++ src/github.com/osism/
2026-05-04 03:14:00.404753 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/
2026-05-04 03:14:00.404773 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.flake8
2026-05-04 03:14:00.404793 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.zuul.yaml
2026-05-04 03:14:00.404812 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/LICENSE
2026-05-04 03:14:00.404830 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/README.md
2026-05-04 03:14:00.404849 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/
2026-05-04 03:14:00.404867 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/HEAD
2026-05-04 03:14:00.404886 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/ORIG_HEAD
2026-05-04 03:14:00.404904 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config
2026-05-04 03:14:00.404922 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config.worktree
2026-05-04 03:14:00.404941 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/description
2026-05-04 03:14:00.404959 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/index
2026-05-04 03:14:00.404977 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/packed-refs
2026-05-04 03:14:00.404995 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/branches/
2026-05-04 03:14:00.405037 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/
2026-05-04 03:14:00.405058 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/applypatch-msg.sample
2026-05-04 03:14:00.405077 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/commit-msg.sample
2026-05-04 03:14:00.405096 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/fsmonitor-watchman.sample
2026-05-04 03:14:00.405114 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/post-update.sample
2026-05-04 03:14:00.405132 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-applypatch.sample
2026-05-04 03:14:00.405150 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-commit.sample
2026-05-04 03:14:00.405167 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-merge-commit.sample
2026-05-04 03:14:00.405185 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-push.sample
2026-05-04 03:14:00.405213 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-rebase.sample
2026-05-04 03:14:00.405232 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-receive.sample
2026-05-04 03:14:00.405249 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/prepare-commit-msg.sample
2026-05-04 03:14:00.405267 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/push-to-checkout.sample
2026-05-04 03:14:00.405284 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/update.sample
2026-05-04 03:14:00.405302 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/
2026-05-04 03:14:00.405319 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/exclude
2026-05-04 03:14:00.405337 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/
2026-05-04 03:14:00.405354 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/HEAD
2026-05-04 03:14:00.405371 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/
2026-05-04 03:14:00.405388 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/
2026-05-04 03:14:00.405405 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/main
2026-05-04 03:14:00.405422 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/
2026-05-04 03:14:00.405439 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/
2026-05-04 03:14:00.405457 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/HEAD
2026-05-04 03:14:00.405475 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/
2026-05-04 03:14:00.405492 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/
2026-05-04 03:14:00.405509 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/e2c2920ba926041df3295b3280def4c83c4039
2026-05-04 03:14:00.405528 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/
2026-05-04 03:14:00.405546 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/459297831c4ce0d7ea29ed8c9114ba146a8527
2026-05-04 03:14:00.405563 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/
2026-05-04 03:14:00.405581 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/39a1f80707e8577fc545424370aeb556127e44
2026-05-04 03:14:00.405598 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/
2026-05-04 03:14:00.405616 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/08e23220f1962907e5e2f9f2d15728a2a19980
2026-05-04 03:14:00.405633 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/
2026-05-04 03:14:00.405651 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/ecda1bd613e629b0ab9f19ddf304ab5f994d60
2026-05-04 03:14:00.405668 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/
2026-05-04 03:14:00.405685 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/5fb3f40bf64cf874cf6e30b8dd8325d3f72992
2026-05-04 03:14:00.405703 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/
2026-05-04 03:14:00.405720 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/3d086ae32b25aaf6ab01121e7c74a51a08211e
2026-05-04 03:14:00.405737 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/
2026-05-04 03:14:00.405757 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/955504dc1be4f034729e036aac7fd53d85d0e2
2026-05-04 03:14:00.405776 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/
2026-05-04 03:14:00.405793 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/a71bda7721ff0db72982e936c2ab41ce720042
2026-05-04 03:14:00.405810 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/info/
2026-05-04 03:14:00.405827 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/
2026-05-04 03:14:00.405845 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.idx
2026-05-04 03:14:00.405864 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.pack
2026-05-04 03:14:00.405882 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/refs/
2026-05-04 03:14:00.405899 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/
2026-05-04 03:14:00.405917 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/
2026-05-04 03:14:00.405935 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/
2026-05-04 03:14:00.405953 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/
2026-05-04 03:14:00.405971 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/__init__.py
2026-05-04 03:14:00.405989 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/dmsetup.py
2026-05-04 03:14:00.406007 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/driver.py
2026-05-04 03:14:00.417838 | 
2026-05-04 03:14:00.417954 | LOOP [ensure-output-dirs-present : Ensure Zuul output directories exist]
2026-05-04 03:14:00.722986 | debian-bookworm | changed: "logs"
2026-05-04 03:14:00.723217 | debian-bookworm | ok: All items complete
2026-05-04 03:14:00.723250 | 
2026-05-04 03:14:00.982880 | debian-bookworm | changed: "artifacts"
2026-05-04 03:14:01.217706 | debian-bookworm | changed: "docs"
2026-05-04 03:14:01.230144 | 
2026-05-04 03:14:01.230248 | TASK [diagnose-first-sudo : Ensure log directory exists]
2026-05-04 03:14:01.477119 | debian-bookworm | ok
2026-05-04 03:14:01.483559 | 
2026-05-04 03:14:01.483667 | TASK [diagnose-first-sudo : Probe first sudo invocation under strace]
2026-05-04 03:14:02.011655 | debian-bookworm | ok: Runtime: 0:00:00.072295
2026-05-04 03:14:02.020861 | 
2026-05-04 03:14:02.021054 | TASK [diagnose-first-sudo : Snapshot DNS / PAM / logind state (no become)]
2026-05-04 03:14:02.552091 | debian-bookworm | ok: Runtime: 0:00:00.076718
2026-05-04 03:14:02.561852 | 
2026-05-04 03:14:02.561935 | PLAY RECAP
2026-05-04 03:14:02.561983 | debian-bookworm | ok: 30 changed: 14 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-04 03:14:02.562195 | 
2026-05-04 03:14:02.800951 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-04 03:14:02.801805 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-04 03:14:03.751092 | 
2026-05-04 03:14:03.751224 | PLAY [Install Black and format code]
2026-05-04 03:14:03.796715 | 
2026-05-04 03:14:03.796850 | LOOP [Install python]
2026-05-04 03:14:03.837228 | debian-bookworm | ok: "ensure-python"
2026-05-04 03:14:03.844203 | debian-bookworm | ok: "ensure-pip"
2026-05-04 03:14:03.919520 | 
2026-05-04 03:14:03.919661 | TASK [ensure-python : Validate python_version value]
2026-05-04 03:14:03.965985 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:03.971949 | 
2026-05-04 03:14:03.972075 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-05-04 03:14:04.005179 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:04.011123 | 
2026-05-04 03:14:04.011227 | TASK [ensure-python : Pull in venv package]
2026-05-04 03:14:04.054419 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:04.060394 | 
2026-05-04 03:14:04.060493 | TASK [ensure-python : Set default RPM package name]
2026-05-04 03:14:04.083895 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:04.090209 | 
2026-05-04 03:14:04.090320 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9 and Python 3.9]
2026-05-04 03:14:04.124873 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:04.132075 | 
2026-05-04 03:14:04.132178 | TASK [ensure-python : Install RPM package]
2026-05-04 03:14:04.183415 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:04.189058 | 
2026-05-04 03:14:04.189159 | TASK [ensure-python : Install python using pyenv]
2026-05-04 03:14:04.202998 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:04.208711 | 
2026-05-04 03:14:04.208805 | TASK [ensure-python : Activate python using stow]
2026-05-04 03:14:04.232133 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:04.242235 | 
2026-05-04 03:14:04.242334 | TASK [ensure-pip : Check if pip is installed]
2026-05-04 03:14:05.295212 | debian-bookworm | ok: Runtime: 0:00:00.008360
2026-05-04 03:14:05.303178 | 
2026-05-04 03:14:05.303290 | LOOP [ensure-pip : Install pip from packages]
2026-05-04 03:14:05.328533 | debian-bookworm | ok: "/var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-05-04 03:14:05.328702 | debian-bookworm | ok: All items complete
2026-05-04 03:14:05.328735 | 
2026-05-04 03:14:05.348545 | debian-bookworm | included: /var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-05-04 03:14:05.369403 | 
2026-05-04 03:14:05.369522 | TASK [ensure-pip : Update package lists]
2026-05-04 03:14:09.777408 | debian-bookworm | changed
2026-05-04 03:14:09.782723 | 
2026-05-04 03:14:09.782854 | TASK [ensure-pip : Install Python 3 pip]
2026-05-04 03:14:15.283227 | debian-bookworm | changed
2026-05-04 03:14:15.289920 | 
2026-05-04 03:14:15.290030 | TASK [ensure-pip : Install Python 2 pip]
2026-05-04 03:14:15.393172 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:15.404016 | 
2026-05-04 03:14:15.404133 | TASK [ensure-pip : Ensure setuptools]
2026-05-04 03:14:15.451019 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:15.460461 | 
2026-05-04 03:14:15.460573 | TASK [ensure-pip : Check for ensurepip module]
2026-05-04 03:14:15.889904 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-05-04 03:14:15.890142 | debian-bookworm |                            [--altinstall] [--default-pip]
2026-05-04 03:14:15.890169 | debian-bookworm |
2026-05-04 03:14:15.890187 | debian-bookworm | options:
2026-05-04 03:14:15.890240 | debian-bookworm |   -h, --help     show this help message and exit
2026-05-04 03:14:15.890263 | debian-bookworm |   --version      Show the version of pip that is bundled with this Python.
2026-05-04 03:14:15.890278 | debian-bookworm |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-05-04 03:14:15.890325 | debian-bookworm |                  times.
2026-05-04 03:14:15.890353 | debian-bookworm |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-05-04 03:14:15.890368 | debian-bookworm |   --user         Install using the user scheme.
2026-05-04 03:14:15.890381 | debian-bookworm |   --root ROOT    Install everything relative to this alternate root directory.
2026-05-04 03:14:15.890393 | debian-bookworm |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-05-04 03:14:15.890405 | debian-bookworm |                  scripts (Default: pipX, pipX.Y, easy_install-X.Y).
2026-05-04 03:14:15.890416 | debian-bookworm |   --default-pip  Make a default pip install, installing the unqualified pip
2026-05-04 03:14:15.890428 | debian-bookworm |                  and easy_install in addition to the versioned scripts.
2026-05-04 03:14:16.035026 | debian-bookworm | ok: Runtime: 0:00:00.086700
2026-05-04 03:14:16.042135 | 
2026-05-04 03:14:16.042225 | TASK [ensure-pip : Ensure python3-venv]
2026-05-04 03:14:16.096185 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:16.107363 | 
2026-05-04 03:14:16.107471 | TASK [ensure-pip : Install pip from source]
2026-05-04 03:14:16.156866 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:16.163449 | 
2026-05-04 03:14:16.163561 | TASK [ensure-pip : Probe for venv python full path]
2026-05-04 03:14:16.514146 | debian-bookworm | /usr/bin/python3
2026-05-04 03:14:16.732965 | debian-bookworm | ok: Runtime: 0:00:00.008382
2026-05-04 03:14:16.744034 | 
2026-05-04 03:14:16.747462 | TASK [ensure-pip : Set host default]
2026-05-04 03:14:16.864221 | debian-bookworm | ok
2026-05-04 03:14:16.878921 | 
2026-05-04 03:14:16.879196 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-05-04 03:14:16.983181 | debian-bookworm | ok
2026-05-04 03:14:17.075159 | 
2026-05-04 03:14:17.075273 | TASK [python-black : Install black]
2026-05-04 03:14:24.584131 | debian-bookworm | changed
2026-05-04 03:14:24.595546 | 
2026-05-04 03:14:24.596070 | TASK [python-black : Format code with Black if there is nothing to exclude]
2026-05-04 03:14:25.377023 | debian-bookworm | All done! ✨ 🍰 ✨
2026-05-04 03:14:25.377194 | debian-bookworm | 3 files would be left unchanged.
2026-05-04 03:14:25.664647 | debian-bookworm | ok: Runtime: 0:00:00.473847
2026-05-04 03:14:25.669845 | 
2026-05-04 03:14:25.669936 | TASK [python-black : Format code with Black if there is an exclusion]
2026-05-04 03:14:26.244417 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:26.251113 | 
2026-05-04 03:14:26.251188 | PLAY RECAP
2026-05-04 03:14:26.251241 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2026-05-04 03:14:26.251267 | 
2026-05-04 03:14:26.592722 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-04 03:14:26.593522 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-04 03:14:27.679548 | 
2026-05-04 03:14:27.679674 | PLAY [Base post-fetch]
2026-05-04 03:14:27.692816 | 
2026-05-04 03:14:27.692930 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-04 03:14:27.762515 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:27.768166 | 
2026-05-04 03:14:27.768270 | TASK [fetch-output : Set log path for single node]
2026-05-04 03:14:27.837817 | debian-bookworm | ok
2026-05-04 03:14:27.843239 | 
2026-05-04 03:14:27.843328 | LOOP [fetch-output : Ensure local output dirs]
2026-05-04 03:14:28.590628 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/work/logs"
2026-05-04 03:14:28.867177 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/work/artifacts"
2026-05-04 03:14:29.109484 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/88dd8ebe489d4820add6d690f9f37337/work/docs"
2026-05-04 03:14:29.124619 | 
2026-05-04 03:14:29.124759 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-04 03:14:30.004847 | debian-bookworm | changed:
2026-05-04 03:14:30.009219 | debian-bookworm | >f+++++++++ sudo-debug.txt
2026-05-04 03:14:30.009294 | debian-bookworm | >f+++++++++ sudo-strace.log
2026-05-04 03:14:30.009324 | debian-bookworm | >f+++++++++ sudo-strace.log.time
2026-05-04 03:14:30.009372 | debian-bookworm | changed: All items complete
2026-05-04 03:14:30.009403 | 
2026-05-04 03:14:30.735680 | debian-bookworm | changed: .d..t...... ./
2026-05-04 03:14:31.526033 | debian-bookworm | changed: .d..t...... ./
2026-05-04 03:14:31.552229 | 
2026-05-04 03:14:31.552351 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-04 03:14:31.604516 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:31.612843 | debian-bookworm | skipping: Conditional result was False
2026-05-04 03:14:31.625053 | 
2026-05-04 03:14:31.625124 | PLAY RECAP
2026-05-04 03:14:31.625167 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-05-04 03:14:31.625188 | 
2026-05-04 03:14:31.746246 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-04 03:14:31.747044 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-04 03:14:32.444876 | 
2026-05-04 03:14:32.445024 | PLAY [Base post]
2026-05-04 03:14:32.457290 | 
2026-05-04 03:14:32.457410 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-04 03:14:33.054497 | debian-bookworm | changed
2026-05-04 03:14:33.059919 | 
2026-05-04 03:14:33.060033 | PLAY RECAP
2026-05-04 03:14:33.060085 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-04 03:14:33.060134 | 
2026-05-04 03:14:33.170019 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-04 03:14:33.170747 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-04 03:14:33.841791 | 
2026-05-04 03:14:33.841908 | PLAY [Base post-logs]
2026-05-04 03:14:33.850790 | 
2026-05-04 03:14:33.850909 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-04 03:14:34.374613 | localhost | changed
2026-05-04 03:14:34.382641 | 
2026-05-04 03:14:34.382760 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-04 03:14:34.437595 | localhost | ok
2026-05-04 03:14:34.440193 | 
2026-05-04 03:14:34.440269 | TASK [Set zuul-log-path fact]
2026-05-04 03:14:34.463952 | localhost | ok
2026-05-04 03:14:34.470485 | 
2026-05-04 03:14:34.470572 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-04 03:14:34.504547 | localhost | ok
2026-05-04 03:14:34.506881 | 
2026-05-04 03:14:34.506956 | TASK [upload-logs : Create log directories]
2026-05-04 03:14:35.211847 | localhost | changed
2026-05-04 03:14:35.214573 | 
2026-05-04 03:14:35.214653 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-04 03:14:35.873872 | localhost -> localhost | ok: Runtime: 0:00:00.005396
2026-05-04 03:14:35.878541 | 
2026-05-04 03:14:35.878642 | TASK [upload-logs : Upload logs to log server]
2026-05-04 03:14:36.449761 | localhost | Output suppressed because no_log was given
2026-05-04 03:14:36.454772 | 
2026-05-04 03:14:36.454890 | LOOP [upload-logs : Compress console log and json output]
2026-05-04 03:14:36.517320 | localhost | skipping: Conditional result was False
2026-05-04 03:14:36.540184 | localhost | skipping: Conditional result was False
2026-05-04 03:14:36.550488 | 
2026-05-04 03:14:36.550594 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-04 03:14:36.637072 | localhost | skipping: Conditional result was False
2026-05-04 03:14:36.637314 | 
2026-05-04 03:14:36.642144 | localhost | skipping: Conditional result was False
2026-05-04 03:14:36.647818 | 
2026-05-04 03:14:36.647910 | LOOP [upload-logs : Upload console log and json output]