2026-05-28 03:12:37.390522 | Job console starting
2026-05-28 03:12:37.401871 | Updating git repos
2026-05-28 03:12:37.622267 | Cloning repos into workspace
2026-05-28 03:12:37.718582 | Restoring repo states
2026-05-28 03:12:37.732988 | Merging changes
2026-05-28 03:12:37.733001 | Checking out repos
2026-05-28 03:12:37.835136 | Preparing playbooks
2026-05-28 03:12:39.015163 | Running Ansible setup
2026-05-28 03:12:43.801466 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-28 03:12:44.647486 | 
2026-05-28 03:12:44.647606 | PLAY [Base pre]
2026-05-28 03:12:44.662143 | 
2026-05-28 03:12:44.662249 | TASK [Setup log path fact]
2026-05-28 03:12:44.678767 | debian-bookworm | ok
2026-05-28 03:12:44.691864 | 
2026-05-28 03:12:44.691970 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-28 03:12:44.718523 | debian-bookworm | ok
2026-05-28 03:12:44.726659 | 
2026-05-28 03:12:44.726753 | TASK [emit-job-header : Print job information]
2026-05-28 03:12:44.755407 | # Job Information
2026-05-28 03:12:44.755608 | Ansible Version: 2.16.14
2026-05-28 03:12:44.755653 | Job: python-black
2026-05-28 03:12:44.755686 | Pipeline: periodic-daily
2026-05-28 03:12:44.755709 | Executor: 521e9411259a
2026-05-28 03:12:44.755727 | Triggered by: https://github.com/osism/cinder-driver-dm-clone
2026-05-28 03:12:44.755745 | Event ID: d16d8d3948814ddaa6d0ba3e0fbb9dde
2026-05-28 03:12:44.759869 | 
2026-05-28 03:12:44.759964 | LOOP [emit-job-header : Print node information]
2026-05-28 03:12:44.851694 | debian-bookworm | ok:
2026-05-28 03:12:44.851857 | debian-bookworm | # Node Information
2026-05-28 03:12:44.851890 | debian-bookworm | Inventory Hostname: debian-bookworm
2026-05-28 03:12:44.851915 | debian-bookworm | Hostname: debian
2026-05-28 03:12:44.851937 | debian-bookworm | Username: zuul
2026-05-28 03:12:44.851957 | debian-bookworm | Distro: Debian 12.14
2026-05-28 03:12:44.851982 | debian-bookworm | Provider: regiocloud-a
2026-05-28 03:12:44.852003 | debian-bookworm | Region:
2026-05-28 03:12:44.852023 | debian-bookworm | Label: debian-bookworm
2026-05-28 03:12:44.852043 | debian-bookworm | Product Name: OpenStack Nova
2026-05-28 03:12:44.852062 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe53:2d3d
2026-05-28 03:12:44.864932 | 
2026-05-28 03:12:44.865034 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-28 03:12:45.413698 | debian-bookworm -> localhost | changed
2026-05-28 03:12:45.420762 | 
2026-05-28 03:12:45.420869 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-28 03:12:46.517540 | debian-bookworm -> localhost | changed
2026-05-28 03:12:46.534257 | 
2026-05-28 03:12:46.534410 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-28 03:12:46.803318 | debian-bookworm -> localhost | ok
2026-05-28 03:12:46.813845 | 
2026-05-28 03:12:46.813955 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-28 03:12:46.846152 | debian-bookworm | ok
2026-05-28 03:12:46.867694 | debian-bookworm | included: /var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-28 03:12:46.886307 | 
2026-05-28 03:12:46.886399 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-28 03:12:48.458491 | debian-bookworm -> localhost | Generating public/private rsa key pair.
2026-05-28 03:12:48.458693 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/work/d2a4fc131bca4c9f8be32bd7917323af_id_rsa
2026-05-28 03:12:48.458732 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/work/d2a4fc131bca4c9f8be32bd7917323af_id_rsa.pub
2026-05-28 03:12:48.458760 | debian-bookworm -> localhost | The key fingerprint is:
2026-05-28 03:12:48.458784 | debian-bookworm -> localhost | SHA256:06uzKccH1lTtl+kZhj+Xf1lqhI8gvCjpFdDOJ1tQOJ0 zuul-build-sshkey
2026-05-28 03:12:48.458806 | debian-bookworm -> localhost | The key's randomart image is:
2026-05-28 03:12:48.458871 | debian-bookworm -> localhost | +---[RSA 3072]----+
2026-05-28 03:12:48.458898 | debian-bookworm -> localhost | |       o..   .   |
2026-05-28 03:12:48.458921 | debian-bookworm -> localhost | |     .o.E   . .  |
2026-05-28 03:12:48.458942 | debian-bookworm -> localhost | |    . o.   . .. o|
2026-05-28 03:12:48.458962 | debian-bookworm -> localhost | |     + . ..  ..=.|
2026-05-28 03:12:48.458983 | debian-bookworm -> localhost | |      =.So.  .+.+|
2026-05-28 03:12:48.459008 | debian-bookworm -> localhost | |       *=.o.. .*o|
2026-05-28 03:12:48.459029 | debian-bookworm -> localhost | |     .o+ +.. + .*|
2026-05-28 03:12:48.459048 | debian-bookworm -> localhost | |    o.o =o. . +.o|
2026-05-28 03:12:48.459070 | debian-bookworm -> localhost | |   ... o++   .  .|
2026-05-28 03:12:48.459089 | debian-bookworm -> localhost | +----[SHA256]-----+
2026-05-28 03:12:48.459141 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.121872
2026-05-28 03:12:48.466321 | 
2026-05-28 03:12:48.466417 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-28 03:12:48.495236 | debian-bookworm | ok
2026-05-28 03:12:48.508026 | debian-bookworm | included: /var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-28 03:12:48.524910 | 
2026-05-28 03:12:48.525018 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-28 03:12:48.539769 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:12:48.547508 | 
2026-05-28 03:12:48.547629 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-28 03:12:49.290362 | debian-bookworm | changed
2026-05-28 03:12:49.300006 | 
2026-05-28 03:12:49.300110 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-28 03:12:49.555708 | debian-bookworm | ok
2026-05-28 03:12:49.560941 | 
2026-05-28 03:12:49.561027 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-28 03:12:50.196521 | debian-bookworm | changed
2026-05-28 03:12:50.210228 | 
2026-05-28 03:12:50.210344 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-28 03:12:51.025196 | debian-bookworm | changed
2026-05-28 03:12:51.043480 | 
2026-05-28 03:12:51.043623 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-28 03:12:51.114220 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:12:51.123507 | 
2026-05-28 03:12:51.123673 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-28 03:12:52.159691 | debian-bookworm -> localhost | changed
2026-05-28 03:12:52.176310 | 
2026-05-28 03:12:52.176455 | TASK [add-build-sshkey : Add back temp key]
2026-05-28 03:12:52.691383 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/work/d2a4fc131bca4c9f8be32bd7917323af_id_rsa (zuul-build-sshkey)
2026-05-28 03:12:52.691684 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012936
2026-05-28 03:12:52.729213 | 
2026-05-28 03:12:52.729381 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-28 03:12:53.197472 | debian-bookworm | ok
2026-05-28 03:12:53.216678 | 
2026-05-28 03:12:53.216828 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-28 03:12:53.261230 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:12:53.275986 | 
2026-05-28 03:12:53.276137 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-05-28 03:12:53.836081 | debian-bookworm | ok
2026-05-28 03:12:53.846201 | 
2026-05-28 03:12:53.846301 | TASK [validate-host : Define zuul_info_dir fact]
2026-05-28 03:12:53.889094 | debian-bookworm | ok
2026-05-28 03:12:53.893480 | 
2026-05-28 03:12:53.893579 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-05-28 03:12:54.515819 | debian-bookworm -> localhost | ok
2026-05-28 03:12:54.521879 | 
2026-05-28 03:12:54.521973 | TASK [validate-host : Collect information about the host]
2026-05-28 03:12:55.770779 | debian-bookworm | ok
2026-05-28 03:12:55.787261 | 
2026-05-28 03:12:55.792787 | TASK [validate-host : Sanitize hostname]
2026-05-28 03:12:55.984815 | debian-bookworm | ok
2026-05-28 03:12:56.081020 | 
2026-05-28 03:12:56.081134 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-05-28 03:12:57.024933 | debian-bookworm -> localhost | changed
2026-05-28 03:12:57.033353 | 
2026-05-28 03:12:57.033458 | TASK [validate-host : Collect information about zuul worker]
2026-05-28 03:12:57.509595 | debian-bookworm | ok
2026-05-28 03:12:57.514178 | 
2026-05-28 03:12:57.514268 | TASK [validate-host : Write out all zuul information for each host]
2026-05-28 03:12:58.495594 | debian-bookworm -> localhost | changed
2026-05-28 03:12:58.506883 | 
2026-05-28 03:12:58.506983 | TASK [prepare-workspace-log : Start zuul_console daemon.]
2026-05-28 03:12:58.806751 | debian-bookworm | ok
2026-05-28 03:12:58.812067 | 
2026-05-28 03:12:58.812158 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.]
2026-05-28 03:12:59.834067 | debian-bookworm | changed:
2026-05-28 03:12:59.834232 | debian-bookworm | cd+++++++++ src/
2026-05-28 03:12:59.834266 | debian-bookworm | cd+++++++++ src/github.com/
2026-05-28 03:12:59.834289 | debian-bookworm | cd+++++++++ src/github.com/osism/
2026-05-28 03:12:59.834311 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/
2026-05-28 03:12:59.834331 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.flake8
2026-05-28 03:12:59.834350 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.zuul.yaml
2026-05-28 03:12:59.834370 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/LICENSE
2026-05-28 03:12:59.834388 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/README.md
2026-05-28 03:12:59.834407 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/
2026-05-28 03:12:59.834425 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/HEAD
2026-05-28 03:12:59.834443 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/ORIG_HEAD
2026-05-28 03:12:59.834461 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config
2026-05-28 03:12:59.834479 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config.worktree
2026-05-28 03:12:59.834498 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/description
2026-05-28 03:12:59.834517 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/index
2026-05-28 03:12:59.834536 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/packed-refs
2026-05-28 03:12:59.834555 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/branches/
2026-05-28 03:12:59.834573 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/
2026-05-28 03:12:59.834592 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/applypatch-msg.sample
2026-05-28 03:12:59.834621 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/commit-msg.sample
2026-05-28 03:12:59.834641 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/fsmonitor-watchman.sample
2026-05-28 03:12:59.835225 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/post-update.sample
2026-05-28 03:12:59.835277 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-applypatch.sample
2026-05-28 03:12:59.835302 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-commit.sample
2026-05-28 03:12:59.835324 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-merge-commit.sample
2026-05-28 03:12:59.835345 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-push.sample
2026-05-28 03:12:59.835375 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-rebase.sample
2026-05-28 03:12:59.835816 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-receive.sample
2026-05-28 03:12:59.836225 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/prepare-commit-msg.sample
2026-05-28 03:12:59.836384 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/push-to-checkout.sample
2026-05-28 03:12:59.836552 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/update.sample
2026-05-28 03:12:59.836579 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/
2026-05-28 03:12:59.836602 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/exclude
2026-05-28 03:12:59.836795 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/
2026-05-28 03:12:59.836826 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/HEAD
2026-05-28 03:12:59.836849 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/
2026-05-28 03:12:59.836868 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/
2026-05-28 03:12:59.836887 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/main
2026-05-28 03:12:59.836906 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/
2026-05-28 03:12:59.836925 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/
2026-05-28 03:12:59.836943 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/HEAD
2026-05-28 03:12:59.836962 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/
2026-05-28 03:12:59.836981 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/
2026-05-28 03:12:59.837000 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/e0c7c227616678a99e3704bf81f2c38d105608
2026-05-28 03:12:59.837021 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/
2026-05-28 03:12:59.837039 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/e2c2920ba926041df3295b3280def4c83c4039
2026-05-28 03:12:59.837057 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/
2026-05-28 03:12:59.837076 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/459297831c4ce0d7ea29ed8c9114ba146a8527
2026-05-28 03:12:59.837094 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/
2026-05-28 03:12:59.837112 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/9d518cd0ba589205707f1d3188a50d210b7da1
2026-05-28 03:12:59.837131 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/
2026-05-28 03:12:59.837148 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/64fde99e36ae8d2d7920ca9140505ae820cccd
2026-05-28 03:12:59.837166 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/
2026-05-28 03:12:59.837183 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/39a1f80707e8577fc545424370aeb556127e44
2026-05-28 03:12:59.837202 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/
2026-05-28 03:12:59.837219 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/89c92f3220c6de0136a61d8de5f8a2f5e9a5c7
2026-05-28 03:12:59.837237 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/
2026-05-28 03:12:59.837261 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/08e23220f1962907e5e2f9f2d15728a2a19980
2026-05-28 03:12:59.837280 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/
2026-05-28 03:12:59.837298 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/b6642d848334761d7184dd0a767f8e94684589
2026-05-28 03:12:59.837316 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/
2026-05-28 03:12:59.837334 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/ecda1bd613e629b0ab9f19ddf304ab5f994d60
2026-05-28 03:12:59.837352 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/
2026-05-28 03:12:59.837369 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/5fb3f40bf64cf874cf6e30b8dd8325d3f72992
2026-05-28 03:12:59.837387 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/
2026-05-28 03:12:59.837405 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/3d086ae32b25aaf6ab01121e7c74a51a08211e
2026-05-28 03:12:59.837423 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/
2026-05-28 03:12:59.837442 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/955504dc1be4f034729e036aac7fd53d85d0e2
2026-05-28 03:12:59.837460 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/
2026-05-28 03:12:59.837477 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/c3439d4d774c22776fb7720414c61d484e3076
2026-05-28 03:12:59.837495 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/
2026-05-28 03:12:59.837513 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/a71bda7721ff0db72982e936c2ab41ce720042
2026-05-28 03:12:59.837530 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/
2026-05-28 03:12:59.837548 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/65c35f918519fa197bc812e46536717dcbd580
2026-05-28 03:12:59.837566 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/info/
2026-05-28 03:12:59.837583 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/
2026-05-28 03:12:59.837601 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.idx
2026-05-28 03:12:59.837648 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.pack
2026-05-28 03:12:59.837668 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/refs/
2026-05-28 03:12:59.837687 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/
2026-05-28 03:12:59.837705 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/
2026-05-28 03:12:59.837723 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/add-to-project.yml
2026-05-28 03:12:59.837743 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/
2026-05-28 03:12:59.837762 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/
2026-05-28 03:12:59.837780 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/
2026-05-28 03:12:59.837798 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/
2026-05-28 03:12:59.837816 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/__init__.py
2026-05-28 03:12:59.837837 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/dmsetup.py
2026-05-28 03:12:59.837856 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/driver.py
2026-05-28 03:12:59.878807 | 
2026-05-28 03:12:59.879443 | LOOP [ensure-output-dirs-present : Ensure Zuul output directories exist]
2026-05-28 03:13:00.321264 | debian-bookworm | changed: "logs"
2026-05-28 03:13:00.321510 | debian-bookworm | ok: All items complete
2026-05-28 03:13:00.321546 | 
2026-05-28 03:13:00.606969 | debian-bookworm | changed: "artifacts"
2026-05-28 03:13:00.868493 | debian-bookworm | changed: "docs"
2026-05-28 03:13:00.895021 | 
2026-05-28 03:13:00.895138 | TASK [diagnose-first-sudo : Ensure log directory exists]
2026-05-28 03:13:01.217989 | debian-bookworm | ok
2026-05-28 03:13:01.225158 | 
2026-05-28 03:13:01.225256 | TASK [diagnose-first-sudo : Probe first sudo invocation under strace]
2026-05-28 03:13:01.808247 | debian-bookworm | ok: Runtime: 0:00:00.073014
2026-05-28 03:13:01.821052 | 
2026-05-28 03:13:01.821166 | TASK [diagnose-first-sudo : Snapshot DNS / PAM / logind state (no become)]
2026-05-28 03:13:02.432936 | debian-bookworm | ok: Runtime: 0:00:00.116901
2026-05-28 03:13:02.441977 | 
2026-05-28 03:13:02.442057 | PLAY RECAP
2026-05-28 03:13:02.442105 | debian-bookworm | ok: 30 changed: 14 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-28 03:13:02.442130 | 
2026-05-28 03:13:02.880543 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-28 03:13:02.881374 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-28 03:13:04.746189 | 
2026-05-28 03:13:04.746312 | PLAY [Install Black and format code]
2026-05-28 03:13:04.794099 | 
2026-05-28 03:13:04.794223 | LOOP [Install python]
2026-05-28 03:13:04.825344 | debian-bookworm | ok: "ensure-python"
2026-05-28 03:13:04.831196 | debian-bookworm | ok: "ensure-pip"
2026-05-28 03:13:04.926491 | 
2026-05-28 03:13:04.926633 | TASK [ensure-python : Validate python_version value]
2026-05-28 03:13:04.950428 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:04.955588 | 
2026-05-28 03:13:04.955699 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-05-28 03:13:04.994173 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:04.998819 | 
2026-05-28 03:13:05.004200 | TASK [ensure-python : Pull in venv package]
2026-05-28 03:13:05.047457 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:05.052440 | 
2026-05-28 03:13:05.052534 | TASK [ensure-python : Set default RPM package name]
2026-05-28 03:13:05.095914 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:05.117796 | 
2026-05-28 03:13:05.117907 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-05-28 03:13:05.146072 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:05.152944 | 
2026-05-28 03:13:05.153041 | TASK [ensure-python : Install RPM package]
2026-05-28 03:13:05.207948 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:05.213401 | 
2026-05-28 03:13:05.213499 | TASK [ensure-python : Install python using pyenv]
2026-05-28 03:13:05.257720 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:05.262898 | 
2026-05-28 03:13:05.262983 | TASK [ensure-python : Activate python using stow]
2026-05-28 03:13:05.316181 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:05.329585 | 
2026-05-28 03:13:05.329710 | TASK [ensure-pip : Check if pip is installed]
2026-05-28 03:13:06.386485 | debian-bookworm | ok: Runtime: 0:00:00.008646
2026-05-28 03:13:06.391205 | 
2026-05-28 03:13:06.391307 | LOOP [ensure-pip : Install pip from packages]
2026-05-28 03:13:06.441906 | debian-bookworm | ok: "/var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-05-28 03:13:06.442106 | debian-bookworm | ok: All items complete
2026-05-28 03:13:06.442141 | 
2026-05-28 03:13:06.454731 | debian-bookworm | included: /var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-05-28 03:13:06.491266 | 
2026-05-28 03:13:06.491380 | TASK [ensure-pip : Update package lists]
2026-05-28 03:13:11.392504 | debian-bookworm | changed
2026-05-28 03:13:11.397456 | 
2026-05-28 03:13:11.397541 | TASK [ensure-pip : Install Python 3 pip]
2026-05-28 03:13:16.838538 | debian-bookworm | changed
2026-05-28 03:13:16.843355 | 
2026-05-28 03:13:16.843432 | TASK [ensure-pip : Install Python 2 pip]
2026-05-28 03:13:16.883255 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:16.889422 | 
2026-05-28 03:13:16.889535 | TASK [ensure-pip : Ensure setuptools]
2026-05-28 03:13:16.905101 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:16.910963 | 
2026-05-28 03:13:16.911038 | TASK [ensure-pip : Check for ensurepip module]
2026-05-28 03:13:17.262357 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-05-28 03:13:17.262546 | debian-bookworm |                            [--altinstall] [--default-pip]
2026-05-28 03:13:17.262562 | debian-bookworm |
2026-05-28 03:13:17.262573 | debian-bookworm | options:
2026-05-28 03:13:17.262586 | debian-bookworm |   -h, --help     show this help message and exit
2026-05-28 03:13:17.262600 | debian-bookworm |   --version      Show the version of pip that is bundled with this Python.
2026-05-28 03:13:17.262611 | debian-bookworm |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-05-28 03:13:17.262645 | debian-bookworm |                  times.
2026-05-28 03:13:17.262663 | debian-bookworm |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-05-28 03:13:17.262673 | debian-bookworm |   --user         Install using the user scheme.
2026-05-28 03:13:17.262682 | debian-bookworm |   --root ROOT    Install everything relative to this alternate root directory.
2026-05-28 03:13:17.262691 | debian-bookworm |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-05-28 03:13:17.262699 | debian-bookworm |                  scripts (Default: pipX, pipX.Y, easy_install-X.Y).
2026-05-28 03:13:17.262706 | debian-bookworm |   --default-pip  Make a default pip install, installing the unqualified pip
2026-05-28 03:13:17.262714 | debian-bookworm |                  and easy_install in addition to the versioned scripts.
2026-05-28 03:13:17.437749 | debian-bookworm | ok: Runtime: 0:00:00.085814
2026-05-28 03:13:17.443791 | 
2026-05-28 03:13:17.443874 | TASK [ensure-pip : Ensure python3-venv]
2026-05-28 03:13:17.456949 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:17.463364 | 
2026-05-28 03:13:17.463471 | TASK [ensure-pip : Install pip from source]
2026-05-28 03:13:17.481604 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:17.487729 | 
2026-05-28 03:13:17.487834 | TASK [ensure-pip : Probe for venv python full path]
2026-05-28 03:13:17.800536 | debian-bookworm | /usr/bin/python3
2026-05-28 03:13:18.040146 | debian-bookworm | ok: Runtime: 0:00:00.009031
2026-05-28 03:13:18.045595 | 
2026-05-28 03:13:18.045683 | TASK [ensure-pip : Set host default]
2026-05-28 03:13:18.111098 | debian-bookworm | ok
2026-05-28 03:13:18.119522 | 
2026-05-28 03:13:18.119684 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-05-28 03:13:18.176832 | debian-bookworm | ok
2026-05-28 03:13:18.215182 | 
2026-05-28 03:13:18.215432 | TASK [python-black : Install black]
2026-05-28 03:13:25.733968 | debian-bookworm | changed
2026-05-28 03:13:25.740125 | 
2026-05-28 03:13:25.740255 | TASK [python-black : Format code with Black if there is nothing to exclude]
2026-05-28 03:13:26.518517 | debian-bookworm | All done! ✨ 🍰 ✨
2026-05-28 03:13:26.518711 | debian-bookworm | 3 files would be left unchanged.
2026-05-28 03:13:26.786353 | debian-bookworm | ok: Runtime: 0:00:00.482566
2026-05-28 03:13:26.792291 | 
2026-05-28 03:13:26.792418 | TASK [python-black : Format code with Black if there is an exclusion]
2026-05-28 03:13:27.356645 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:27.385356 | 
2026-05-28 03:13:27.385461 | PLAY RECAP
2026-05-28 03:13:27.385518 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2026-05-28 03:13:27.385544 | 
2026-05-28 03:13:27.561646 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-28 03:13:27.562542 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-28 03:13:28.462211 | 
2026-05-28 03:13:28.462389 | PLAY [Base post-fetch]
2026-05-28 03:13:28.478927 | 
2026-05-28 03:13:28.479071 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-28 03:13:28.524039 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:28.530017 | 
2026-05-28 03:13:28.530203 | TASK [fetch-output : Set log path for single node]
2026-05-28 03:13:28.570984 | debian-bookworm | ok
2026-05-28 03:13:28.577077 | 
2026-05-28 03:13:28.577217 | LOOP [fetch-output : Ensure local output dirs]
2026-05-28 03:13:29.162749 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/work/logs"
2026-05-28 03:13:29.570250 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/work/artifacts"
2026-05-28 03:13:29.929162 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d2a4fc131bca4c9f8be32bd7917323af/work/docs"
2026-05-28 03:13:29.942942 | 
2026-05-28 03:13:29.943112 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-28 03:13:30.847906 | debian-bookworm | changed:
2026-05-28 03:13:30.848148 | debian-bookworm | >f+++++++++ sudo-debug.txt
2026-05-28 03:13:30.848185 | debian-bookworm | >f+++++++++ sudo-strace.log
2026-05-28 03:13:30.848215 | debian-bookworm | >f+++++++++ sudo-strace.log.time
2026-05-28 03:13:30.848260 | debian-bookworm | changed: All items complete
2026-05-28 03:13:30.848287 | 
2026-05-28 03:13:31.586331 | debian-bookworm | changed: .d..t...... ./
2026-05-28 03:13:32.419457 | debian-bookworm | changed: .d..t...... ./
2026-05-28 03:13:32.446525 | 
2026-05-28 03:13:32.446697 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-28 03:13:32.498752 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:32.507221 | debian-bookworm | skipping: Conditional result was False
2026-05-28 03:13:32.522224 | 
2026-05-28 03:13:32.522332 | PLAY RECAP
2026-05-28 03:13:32.522385 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-05-28 03:13:32.522411 | 
2026-05-28 03:13:32.912332 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-28 03:13:32.913417 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-28 03:13:33.947916 | 
2026-05-28 03:13:33.948090 | PLAY [Base post]
2026-05-28 03:13:33.964521 | 
2026-05-28 03:13:33.964702 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-28 03:13:34.745090 | debian-bookworm | changed
2026-05-28 03:13:34.753411 | 
2026-05-28 03:13:34.753510 | PLAY RECAP
2026-05-28 03:13:34.753599 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-28 03:13:34.753662 | 
2026-05-28 03:13:34.950889 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-28 03:13:34.951758 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-28 03:13:35.804096 | 
2026-05-28 03:13:35.804224 | PLAY [Base post-logs]
2026-05-28 03:13:35.813800 | 
2026-05-28 03:13:35.813913 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-28 03:13:36.190801 | localhost | changed
2026-05-28 03:13:36.200123 | 
2026-05-28 03:13:36.200225 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-28 03:13:36.224267 | localhost | ok
2026-05-28 03:13:36.226622 | 
2026-05-28 03:13:36.226692 | TASK [Set zuul-log-path fact]
2026-05-28 03:13:36.240037 | localhost | ok
2026-05-28 03:13:36.246052 | 
2026-05-28 03:13:36.246710 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-28 03:13:36.270585 | localhost | ok
2026-05-28 03:13:36.272836 | 
2026-05-28 03:13:36.272907 | TASK [upload-logs : Create log directories]
2026-05-28 03:13:36.722532 | localhost | changed
2026-05-28 03:13:36.731414 | 
2026-05-28 03:13:36.731525 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-28 03:13:37.261465 | localhost -> localhost | ok: Runtime: 0:00:00.009687
2026-05-28 03:13:37.268075 | 
2026-05-28 03:13:37.268352 | TASK [upload-logs : Upload logs to log server]
2026-05-28 03:13:37.803353 | localhost | Output suppressed because no_log was given
2026-05-28 03:13:37.804951 | 
2026-05-28 03:13:37.805032 | LOOP [upload-logs : Compress console log and json output]
2026-05-28 03:13:37.847411 | localhost | skipping: Conditional result was False
2026-05-28 03:13:37.853279 | localhost | skipping: Conditional result was False
2026-05-28 03:13:37.861388 | 
2026-05-28 03:13:37.861493 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-28 03:13:37.904169 | localhost | skipping: Conditional result was False
2026-05-28 03:13:37.904439 | 
2026-05-28 03:13:37.909239 | localhost | skipping: Conditional result was False
2026-05-28 03:13:37.916932 | 
2026-05-28 03:13:37.917032 | LOOP [upload-logs : Upload console log and json output]