2026-08-25 03:14:14.918155 | Job console starting
2026-08-25 03:14:14.941345 | Updating git repos
2026-08-25 03:14:14.968825 | Cloning repos into workspace
2026-08-25 03:14:15.013113 | Restoring repo states
2026-08-25 03:14:15.023375 | Merging changes
2026-08-25 03:14:15.023399 | Checking out repos
2026-08-25 03:14:15.057204 | Preparing playbooks
2026-08-25 03:14:16.762100 | Running Ansible setup
2026-08-25 03:14:22.664777 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-08-25 03:14:23.399456 | 
2026-08-25 03:14:23.399703 | PLAY [Base pre]
2026-08-25 03:14:23.420564 | 
2026-08-25 03:14:23.420744 | TASK [Setup log path fact]
2026-08-25 03:14:23.466408 | debian-bookworm | ok
2026-08-25 03:14:23.484343 | 
2026-08-25 03:14:23.484538 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-25 03:14:23.516140 | debian-bookworm | ok
2026-08-25 03:14:23.527388 | 
2026-08-25 03:14:23.527545 | TASK [emit-job-header : Print job information]
2026-08-25 03:14:23.571310 | # Job Information
2026-08-25 03:14:23.571649 | Ansible Version: 2.16.14
2026-08-25 03:14:23.571694 | Job: python-black
2026-08-25 03:14:23.571734 | Pipeline: periodic-daily
2026-08-25 03:14:23.571757 | Executor: 521e9411259a
2026-08-25 03:14:23.571778 | Triggered by: https://github.com/osism/cinder-driver-dm-clone
2026-08-25 03:14:23.571801 | Event ID: bbb14b33d8f54f98b5dc48b5ac00a922
2026-08-25 03:14:23.577233 | 
2026-08-25 03:14:23.577375 | LOOP [emit-job-header : Print node information]
2026-08-25 03:14:23.694687 | debian-bookworm | ok:
2026-08-25 03:14:23.695055 | debian-bookworm | # Node Information
2026-08-25 03:14:23.695093 | debian-bookworm | Inventory Hostname: debian-bookworm
2026-08-25 03:14:23.695120 | debian-bookworm | Hostname: debian
2026-08-25 03:14:23.695143 | debian-bookworm | Username: zuul
2026-08-25 03:14:23.695164 | debian-bookworm | Distro: Debian 12.15
2026-08-25 03:14:23.695188 | debian-bookworm | Provider: regiocloud-a
2026-08-25 03:14:23.695209 | debian-bookworm | Region:
2026-08-25 03:14:23.695230 | debian-bookworm | Label: debian-bookworm
2026-08-25 03:14:23.695250 | debian-bookworm | Product Name: OpenStack Nova
2026-08-25 03:14:23.695270 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe85:483d
2026-08-25 03:14:23.717327 | 
2026-08-25 03:14:23.717502 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-25 03:14:24.643806 | debian-bookworm -> localhost | changed
2026-08-25 03:14:24.658422 | 
2026-08-25 03:14:24.658655 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-25 03:14:26.788066 | debian-bookworm -> localhost | changed
2026-08-25 03:14:26.799412 | 
2026-08-25 03:14:26.799523 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-25 03:14:27.270404 | debian-bookworm -> localhost | ok
2026-08-25 03:14:27.276824 | 
2026-08-25 03:14:27.276928 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-25 03:14:27.307115 | debian-bookworm | ok
2026-08-25 03:14:27.334085 | debian-bookworm | included: /var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-25 03:14:27.339970 | 
2026-08-25 03:14:27.340121 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-25 03:14:29.880646 | debian-bookworm -> localhost | Generating public/private rsa key pair.
2026-08-25 03:14:29.880852 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/work/a380b8488d9e404e82532164127b2429_id_rsa
2026-08-25 03:14:29.880890 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/work/a380b8488d9e404e82532164127b2429_id_rsa.pub
2026-08-25 03:14:29.880917 | debian-bookworm -> localhost | The key fingerprint is:
2026-08-25 03:14:29.880941 | debian-bookworm -> localhost | SHA256:3Da8zBGnR0BOoC2ukPT6ajlfzmg//tviIq+4wFpbLjM zuul-build-sshkey
2026-08-25 03:14:29.880964 | debian-bookworm -> localhost | The key's randomart image is:
2026-08-25 03:14:29.880998 | debian-bookworm -> localhost | +---[RSA 3072]----+
2026-08-25 03:14:29.881020 | debian-bookworm -> localhost | |        .o+      |
2026-08-25 03:14:29.881041 | debian-bookworm -> localhost | |       o o .     |
2026-08-25 03:14:29.881062 | debian-bookworm -> localhost | |  .   o . o o    |
2026-08-25 03:14:29.881082 | debian-bookworm -> localhost | | . o . o o =     |
2026-08-25 03:14:29.881101 | debian-bookworm -> localhost | |  o . . S B .    |
2026-08-25 03:14:29.881125 | debian-bookworm -> localhost | |.  o .   + =     |
2026-08-25 03:14:29.881146 | debian-bookworm -> localhost | |..o.o .   +      |
2026-08-25 03:14:29.881165 | debian-bookworm -> localhost | |.oE*o=o ..       |
2026-08-25 03:14:29.881185 | debian-bookworm -> localhost | |..=X***=+o.      |
2026-08-25 03:14:29.881205 | debian-bookworm -> localhost | +----[SHA256]-----+
2026-08-25 03:14:29.881259 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.705977
2026-08-25 03:14:29.889948 | 
2026-08-25 03:14:29.890186 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-25 03:14:29.935859 | debian-bookworm | ok
2026-08-25 03:14:29.970714 | debian-bookworm | included: /var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-25 03:14:29.990951 | 
2026-08-25 03:14:29.991415 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-25 03:14:30.031165 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:30.037982 | 
2026-08-25 03:14:30.038091 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-25 03:14:30.915473 | debian-bookworm | changed
2026-08-25 03:14:30.921483 | 
2026-08-25 03:14:30.921561 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-25 03:14:31.169419 | debian-bookworm | ok
2026-08-25 03:14:31.195821 | 
2026-08-25 03:14:31.196343 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-25 03:14:31.956983 | debian-bookworm | changed
2026-08-25 03:14:31.962170 | 
2026-08-25 03:14:31.962261 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-25 03:14:32.594433 | debian-bookworm | changed
2026-08-25 03:14:32.599869 | 
2026-08-25 03:14:32.599959 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-25 03:14:32.623677 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:32.629806 | 
2026-08-25 03:14:32.629901 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-25 03:14:33.107159 | debian-bookworm -> localhost | changed
2026-08-25 03:14:33.123967 | 
2026-08-25 03:14:33.124080 | TASK [add-build-sshkey : Add back temp key]
2026-08-25 03:14:33.786199 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/work/a380b8488d9e404e82532164127b2429_id_rsa (zuul-build-sshkey)
2026-08-25 03:14:33.786429 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011451
2026-08-25 03:14:33.793871 | 
2026-08-25 03:14:33.793968 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-25 03:14:34.208285 | debian-bookworm | ok
2026-08-25 03:14:34.217975 | 
2026-08-25 03:14:34.218116 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-25 03:14:34.244208 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:34.255971 | 
2026-08-25 03:14:34.256093 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-08-25 03:14:34.688810 | debian-bookworm | ok
2026-08-25 03:14:34.702249 | 
2026-08-25 03:14:34.702551 | TASK [validate-host : Define zuul_info_dir fact]
2026-08-25 03:14:34.730622 | debian-bookworm | ok
2026-08-25 03:14:34.736116 | 
2026-08-25 03:14:34.736203 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-08-25 03:14:35.135836 | debian-bookworm -> localhost | ok
2026-08-25 03:14:35.142110 | 
2026-08-25 03:14:35.142199 | TASK [validate-host : Collect information about the host]
2026-08-25 03:14:36.527707 | debian-bookworm | ok
2026-08-25 03:14:36.573749 | 
2026-08-25 03:14:36.573930 | TASK [validate-host : Sanitize hostname]
2026-08-25 03:14:36.829525 | debian-bookworm | ok
2026-08-25 03:14:36.834801 | 
2026-08-25 03:14:36.834941 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-08-25 03:14:37.742288 | debian-bookworm -> localhost | changed
2026-08-25 03:14:37.748216 | 
2026-08-25 03:14:37.748313 | TASK [validate-host : Collect information about zuul worker]
2026-08-25 03:14:38.371734 | debian-bookworm | ok
2026-08-25 03:14:38.376717 | 
2026-08-25 03:14:38.376816 | TASK [validate-host : Write out all zuul information for each host]
2026-08-25 03:14:39.259271 | debian-bookworm -> localhost | changed
2026-08-25 03:14:39.272344 | 
2026-08-25 03:14:39.272433 | TASK [prepare-workspace-log : Start zuul_console daemon.]
2026-08-25 03:14:39.582058 | debian-bookworm | ok
2026-08-25 03:14:39.586805 | 
2026-08-25 03:14:39.586916 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.]
2026-08-25 03:14:40.471677 | debian-bookworm | changed:
2026-08-25 03:14:40.471845 | debian-bookworm | cd+++++++++ src/
2026-08-25 03:14:40.471872 | debian-bookworm | cd+++++++++ src/github.com/
2026-08-25 03:14:40.471892 | debian-bookworm | cd+++++++++ src/github.com/osism/
2026-08-25 03:14:40.471909 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/
2026-08-25 03:14:40.471926 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.flake8
2026-08-25 03:14:40.471942 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.zuul.yaml
2026-08-25 03:14:40.471958 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/LICENSE
2026-08-25 03:14:40.471974 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/README.md
2026-08-25 03:14:40.471989 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/
2026-08-25 03:14:40.472004 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/HEAD
2026-08-25 03:14:40.472018 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/ORIG_HEAD
2026-08-25 03:14:40.472033 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config
2026-08-25 03:14:40.472048 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config.worktree
2026-08-25 03:14:40.472063 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/description
2026-08-25 03:14:40.472079 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/index
2026-08-25 03:14:40.472094 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/packed-refs
2026-08-25 03:14:40.472109 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/branches/
2026-08-25 03:14:40.472124 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/
2026-08-25 03:14:40.472138 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/applypatch-msg.sample
2026-08-25 03:14:40.472153 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/commit-msg.sample
2026-08-25 03:14:40.472168 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/fsmonitor-watchman.sample
2026-08-25 03:14:40.472182 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/post-update.sample
2026-08-25 03:14:40.472197 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-applypatch.sample
2026-08-25 03:14:40.472211 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-commit.sample
2026-08-25 03:14:40.472226 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-merge-commit.sample
2026-08-25 03:14:40.472240 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-push.sample
2026-08-25 03:14:40.472263 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-rebase.sample
2026-08-25 03:14:40.472278 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-receive.sample
2026-08-25 03:14:40.472293 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/prepare-commit-msg.sample
2026-08-25 03:14:40.472307 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/push-to-checkout.sample
2026-08-25 03:14:40.472322 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/update.sample
2026-08-25 03:14:40.472337 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/
2026-08-25 03:14:40.472351 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/exclude
2026-08-25 03:14:40.472366 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/
2026-08-25 03:14:40.472380 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/HEAD
2026-08-25 03:14:40.472394 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/
2026-08-25 03:14:40.472408 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/
2026-08-25 03:14:40.472422 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/main
2026-08-25 03:14:40.472436 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/
2026-08-25 03:14:40.472450 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/
2026-08-25 03:14:40.472465 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/HEAD
2026-08-25 03:14:40.472479 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/
2026-08-25 03:14:40.472494 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/
2026-08-25 03:14:40.472508 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/e0c7c227616678a99e3704bf81f2c38d105608
2026-08-25 03:14:40.472523 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/
2026-08-25 03:14:40.472537 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/e2c2920ba926041df3295b3280def4c83c4039
2026-08-25 03:14:40.472561 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/16/
2026-08-25 03:14:40.472577 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/16/8cf2de59161d16aca84230f01985a42905a7b0
2026-08-25 03:14:40.472593 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/
2026-08-25 03:14:40.472607 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/459297831c4ce0d7ea29ed8c9114ba146a8527
2026-08-25 03:14:40.472622 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/37/
2026-08-25 03:14:40.472637 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/37/d152c74c15b82ebab993b79af43200da60ef63
2026-08-25 03:14:40.472652 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/
2026-08-25 03:14:40.472666 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/9d518cd0ba589205707f1d3188a50d210b7da1
2026-08-25 03:14:40.472681 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/
2026-08-25 03:14:40.472695 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/64fde99e36ae8d2d7920ca9140505ae820cccd
2026-08-25 03:14:40.472709 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/
2026-08-25 03:14:40.472727 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/39a1f80707e8577fc545424370aeb556127e44
2026-08-25 03:14:40.472742 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/72/
2026-08-25 03:14:40.472756 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/72/a77304fbd7bb1407dcf01703e9f57b6ff59f76
2026-08-25 03:14:40.472771 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7b/
2026-08-25 03:14:40.472785 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7b/ad2a812a0be73ef3cd7df5f43b238475833ae4
2026-08-25 03:14:40.472799 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/
2026-08-25 03:14:40.472813 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/89c92f3220c6de0136a61d8de5f8a2f5e9a5c7
2026-08-25 03:14:40.472828 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/
2026-08-25 03:14:40.472842 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/08e23220f1962907e5e2f9f2d15728a2a19980
2026-08-25 03:14:40.472857 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/
2026-08-25 03:14:40.472871 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/b6642d848334761d7184dd0a767f8e94684589
2026-08-25 03:14:40.472886 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/
2026-08-25 03:14:40.472900 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/ecda1bd613e629b0ab9f19ddf304ab5f994d60
2026-08-25 03:14:40.472915 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/9c/
2026-08-25 03:14:40.472929 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/9c/7974bee70a28d009863af8608cd591403a5af2
2026-08-25 03:14:40.472944 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/a0/
2026-08-25 03:14:40.472958 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/a0/b64b06f000655fc695c453dec57090d919a1c3
2026-08-25 03:14:40.472972 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/
2026-08-25 03:14:40.472987 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/5fb3f40bf64cf874cf6e30b8dd8325d3f72992
2026-08-25 03:14:40.473001 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/
2026-08-25 03:14:40.473015 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/3d086ae32b25aaf6ab01121e7c74a51a08211e
2026-08-25 03:14:40.473030 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/
2026-08-25 03:14:40.473044 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/955504dc1be4f034729e036aac7fd53d85d0e2
2026-08-25 03:14:40.473059 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/
2026-08-25 03:14:40.473073 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/c3439d4d774c22776fb7720414c61d484e3076
2026-08-25 03:14:40.473088 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/
2026-08-25 03:14:40.473148 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/a71bda7721ff0db72982e936c2ab41ce720042
2026-08-25 03:14:40.473169 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f4/
2026-08-25 03:14:40.473186 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f4/a41ab7a35441b30d48c1078e463392c292def3
2026-08-25 03:14:40.473204 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/
2026-08-25 03:14:40.473219 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/65c35f918519fa197bc812e46536717dcbd580
2026-08-25 03:14:40.473234 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/info/
2026-08-25 03:14:40.473249 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/
2026-08-25 03:14:40.473264 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.idx
2026-08-25 03:14:40.473279 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.pack
2026-08-25 03:14:40.473293 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/refs/
2026-08-25 03:14:40.473308 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/
2026-08-25 03:14:40.473323 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/
2026-08-25 03:14:40.473337 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/add-to-project.yml
2026-08-25 03:14:40.473351 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/
2026-08-25 03:14:40.473366 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/
2026-08-25 03:14:40.473380 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/
2026-08-25 03:14:40.473394 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/
2026-08-25 03:14:40.473409 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/__init__.py
2026-08-25 03:14:40.473423 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/dmsetup.py
2026-08-25 03:14:40.473438 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/driver.py
2026-08-25 03:14:40.480666 | 
2026-08-25 03:14:40.480746 | LOOP [ensure-output-dirs-present : Ensure Zuul output directories exist]
2026-08-25 03:14:40.810731 | debian-bookworm | changed: "logs"
2026-08-25 03:14:40.811957 | debian-bookworm | ok: All items complete
2026-08-25 03:14:40.812027 | 
2026-08-25 03:14:41.032777 | debian-bookworm | changed: "artifacts"
2026-08-25 03:14:41.259568 | debian-bookworm | changed: "docs"
2026-08-25 03:14:41.269919 | 
2026-08-25 03:14:41.270029 | TASK [diagnose-first-sudo : Ensure log directory exists]
2026-08-25 03:14:41.525753 | debian-bookworm | ok
2026-08-25 03:14:41.532956 | 
2026-08-25 03:14:41.533075 | TASK [diagnose-first-sudo : Probe first sudo invocation under strace]
2026-08-25 03:14:42.063205 | debian-bookworm | ok: Runtime: 0:00:00.063682
2026-08-25 03:14:42.078410 | 
2026-08-25 03:14:42.078886 | TASK [diagnose-first-sudo : Snapshot DNS / PAM / logind state (no become)]
2026-08-25 03:14:42.608465 | debian-bookworm | ok: Runtime: 0:00:00.102911
2026-08-25 03:14:42.615936 | 
2026-08-25 03:14:42.616023 | TASK [diagnose-network : Ensure log directory exists]
2026-08-25 03:14:42.866027 | debian-bookworm | ok
2026-08-25 03:14:42.873365 | 
2026-08-25 03:14:42.873515 | TASK [diagnose-network : Snapshot dual-stack network state (pre)]
2026-08-25 03:14:54.486358 | debian-bookworm | ok: Runtime: 0:00:05.966087
2026-08-25 03:14:54.496259 | 
2026-08-25 03:14:54.496424 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)]
2026-08-25 03:14:54.554760 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:54.560695 | 
2026-08-25 03:14:54.560831 | TASK [diagnose-network : Probe container network namespace (teardown)]
2026-08-25 03:14:54.617336 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:54.624951 | 
2026-08-25 03:14:54.625072 | PLAY RECAP
2026-08-25 03:14:54.625129 | debian-bookworm | ok: 32 changed: 12 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-08-25 03:14:54.625157 | 
2026-08-25 03:14:54.918381 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-08-25 03:14:54.919422 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-08-25 03:14:56.040694 | 
2026-08-25 03:14:56.040892 | PLAY [Install Black and format code]
2026-08-25 03:14:56.103295 | 
2026-08-25 03:14:56.103498 | LOOP [Install python]
2026-08-25 03:14:56.137798 | debian-bookworm | ok: "ensure-python"
2026-08-25 03:14:56.163290 | debian-bookworm | ok: "ensure-pip"
2026-08-25 03:14:56.263441 | 
2026-08-25 03:14:56.263662 | TASK [ensure-python : Validate python_version value]
2026-08-25 03:14:56.323644 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:56.330579 | 
2026-08-25 03:14:56.330727 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-08-25 03:14:56.395884 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:56.402741 | 
2026-08-25 03:14:56.402919 | TASK [ensure-python : Pull in venv package]
2026-08-25 03:14:56.461633 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:56.470099 | 
2026-08-25 03:14:56.470267 | TASK [ensure-python : Set default RPM package name]
2026-08-25 03:14:56.537824 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:56.546371 | 
2026-08-25 03:14:56.546592 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-08-25 03:14:56.624349 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:56.639043 | 
2026-08-25 03:14:56.639772 | TASK [ensure-python : Install RPM package]
2026-08-25 03:14:56.733870 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:56.746297 | 
2026-08-25 03:14:56.746958 | TASK [ensure-python : Install python using pyenv]
2026-08-25 03:14:56.789810 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:56.800272 | 
2026-08-25 03:14:56.801041 | TASK [ensure-python : Activate python using stow]
2026-08-25 03:14:56.842431 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:14:56.870753 | 
2026-08-25 03:14:56.871282 | TASK [ensure-pip : Check if pip is installed]
2026-08-25 03:14:57.939319 | debian-bookworm | ok: Runtime: 0:00:00.008878
2026-08-25 03:14:57.945079 | 
2026-08-25 03:14:57.945198 | LOOP [ensure-pip : Install pip from packages]
2026-08-25 03:14:58.003612 | debian-bookworm | ok: "/var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-08-25 03:14:58.003798 | debian-bookworm | ok: All items complete
2026-08-25 03:14:58.003830 | 
2026-08-25 03:14:58.022921 | debian-bookworm | included: /var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-08-25 03:14:58.051760 | 
2026-08-25 03:14:58.051875 | TASK [ensure-pip : Update package lists]
2026-08-25 03:15:02.373118 | debian-bookworm | changed
2026-08-25 03:15:02.378991 | 
2026-08-25 03:15:02.379556 | TASK [ensure-pip : Install Python 3 pip]
2026-08-25 03:15:07.779707 | debian-bookworm | changed
2026-08-25 03:15:07.791434 | 
2026-08-25 03:15:07.791597 | TASK [ensure-pip : Install Python 2 pip]
2026-08-25 03:15:07.947171 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:15:07.955421 | 
2026-08-25 03:15:07.955589 | TASK [ensure-pip : Ensure setuptools]
2026-08-25 03:15:07.980910 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:15:07.989839 | 
2026-08-25 03:15:07.989984 | TASK [ensure-pip : Check for ensurepip module]
2026-08-25 03:15:08.352446 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-08-25 03:15:08.352624 | debian-bookworm |                            [--altinstall] [--default-pip]
2026-08-25 03:15:08.352642 | debian-bookworm |
2026-08-25 03:15:08.352657 | debian-bookworm | options:
2026-08-25 03:15:08.352674 | debian-bookworm |   -h, --help     show this help message and exit
2026-08-25 03:15:08.352693 | debian-bookworm |   --version      Show the version of pip that is bundled with this Python.
2026-08-25 03:15:08.352706 | debian-bookworm |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-08-25 03:15:08.352747 | debian-bookworm |                  times.
2026-08-25 03:15:08.352769 | debian-bookworm |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-08-25 03:15:08.352781 | debian-bookworm |   --user         Install using the user scheme.
2026-08-25 03:15:08.352792 | debian-bookworm |   --root ROOT    Install everything relative to this alternate root directory.
2026-08-25 03:15:08.352803 | debian-bookworm |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-08-25 03:15:08.352813 | debian-bookworm |                  scripts (Default: pipX, pipX.Y, easy_install-X.Y).
2026-08-25 03:15:08.352823 | debian-bookworm |   --default-pip  Make a default pip install, installing the unqualified pip
2026-08-25 03:15:08.352833 | debian-bookworm |                  and easy_install in addition to the versioned scripts.
2026-08-25 03:15:08.528431 | debian-bookworm | ok: Runtime: 0:00:00.091120
2026-08-25 03:15:08.547729 | 
2026-08-25 03:15:08.547903 | TASK [ensure-pip : Ensure python3-venv]
2026-08-25 03:15:08.614201 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:15:08.630481 | 
2026-08-25 03:15:08.630681 | TASK [ensure-pip : Install pip from source]
2026-08-25 03:15:08.710741 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:15:08.730571 | 
2026-08-25 03:15:08.730741 | TASK [ensure-pip : Probe for venv python full path]
2026-08-25 03:15:09.195346 | debian-bookworm | /usr/bin/python3
2026-08-25 03:15:09.318055 | debian-bookworm | ok: Runtime: 0:00:00.008924
2026-08-25 03:15:09.324609 | 
2026-08-25 03:15:09.324758 | TASK [ensure-pip : Set host default]
2026-08-25 03:15:09.433948 | debian-bookworm | ok
2026-08-25 03:15:09.444129 | 
2026-08-25 03:15:09.444280 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-08-25 03:15:09.571242 | debian-bookworm | ok
2026-08-25 03:15:09.689573 | 
2026-08-25 03:15:09.689731 | TASK [python-black : Install black]
2026-08-25 03:15:17.280229 | debian-bookworm | changed
2026-08-25 03:15:17.286395 | 
2026-08-25 03:15:17.286554 | TASK [python-black : Format code with Black if there is nothing to exclude]
2026-08-25 03:15:18.092142 | debian-bookworm | All done! ✨ 🍰 ✨
2026-08-25 03:15:18.092442 | debian-bookworm | 3 files would be left unchanged.
2026-08-25 03:15:18.326035 | debian-bookworm | ok: Runtime: 0:00:00.547157
2026-08-25 03:15:18.336418 | 
2026-08-25 03:15:18.336642 | TASK [python-black : Format code with Black if there is an exclusion]
2026-08-25 03:15:18.871556 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:15:18.889977 | 
2026-08-25 03:15:18.890096 | PLAY RECAP
2026-08-25 03:15:18.890205 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2026-08-25 03:15:18.890236 | 
2026-08-25 03:15:19.059421 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-08-25 03:15:19.060421 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-08-25 03:15:20.028834 | 
2026-08-25 03:15:20.029032 | PLAY [Base post-fetch]
2026-08-25 03:15:20.059679 | 
2026-08-25 03:15:20.059871 | TASK [diagnose-network : Ensure log directory exists]
2026-08-25 03:15:20.551875 | debian-bookworm | ok
2026-08-25 03:15:20.560754 | 
2026-08-25 03:15:20.560931 | TASK [diagnose-network : Snapshot dual-stack network state (post)]
2026-08-25 03:15:32.441609 | debian-bookworm | ok: Runtime: 0:00:05.955539
2026-08-25 03:15:32.451993 | 
2026-08-25 03:15:32.452163 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)]
2026-08-25 03:15:38.538346 | debian-bookworm | ok: Runtime: 0:00:00.008754
2026-08-25 03:15:38.552236 | 
2026-08-25 03:15:38.552404 | TASK [diagnose-network : Probe container network namespace (teardown)]
2026-08-25 03:15:44.725742 | debian-bookworm | ok: Runtime: 0:00:00.009262
2026-08-25 03:15:44.745877 | 
2026-08-25 03:15:44.746035 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-25 03:15:44.840678 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:15:44.849038 | 
2026-08-25 03:15:44.849191 | TASK [fetch-output : Set log path for single node]
2026-08-25 03:15:44.911411 | debian-bookworm | ok
2026-08-25 03:15:44.917347 | 
2026-08-25 03:15:44.917510 | LOOP [fetch-output : Ensure local output dirs]
2026-08-25 03:15:45.546589 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/work/logs"
2026-08-25 03:15:46.650369 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/work/artifacts"
2026-08-25 03:15:47.657542 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a380b8488d9e404e82532164127b2429/work/docs"
2026-08-25 03:15:47.671626 | 
2026-08-25 03:15:47.671775 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-25 03:15:49.096284 | debian-bookworm | changed:
2026-08-25 03:15:49.096489 | debian-bookworm | .d..t...... ./
2026-08-25 03:15:49.096523 | debian-bookworm | >f+++++++++ net-debug.post.txt
2026-08-25 03:15:49.096547 | debian-bookworm | >f+++++++++ net-debug.pre.txt
2026-08-25 03:15:49.096567 | debian-bookworm | >f+++++++++ sudo-debug.txt
2026-08-25 03:15:49.096588 | debian-bookworm | >f+++++++++ sudo-strace.log
2026-08-25 03:15:49.096608 | debian-bookworm | >f+++++++++ sudo-strace.log.time
2026-08-25 03:15:49.096646 | debian-bookworm | changed: All items complete
2026-08-25 03:15:49.096669 | 
2026-08-25 03:15:49.858236 | debian-bookworm | changed: .d..t...... ./
2026-08-25 03:15:50.442192 | debian-bookworm | changed: .d..t...... ./
2026-08-25 03:15:50.466182 | 
2026-08-25 03:15:50.466323 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-25 03:15:50.488757 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:15:50.492246 | debian-bookworm | skipping: Conditional result was False
2026-08-25 03:15:50.507317 | 
2026-08-25 03:15:50.507391 | PLAY RECAP
2026-08-25 03:15:50.507445 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-08-25 03:15:50.507483 | 
2026-08-25 03:15:50.646440 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-08-25 03:15:50.647280 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-08-25 03:15:51.702622 | 
2026-08-25 03:15:51.702779 | PLAY [Base post]
2026-08-25 03:15:51.733057 | 
2026-08-25 03:15:51.733205 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-25 03:15:52.521168 | debian-bookworm | changed
2026-08-25 03:15:52.533448 | 
2026-08-25 03:15:52.533617 | PLAY RECAP
2026-08-25 03:15:52.533677 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-25 03:15:52.533738 | 
2026-08-25 03:15:52.754517 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-08-25 03:15:52.755428 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-25 03:15:53.529405 | 
2026-08-25 03:15:53.529608 | PLAY [Base post-logs]
2026-08-25 03:15:53.540958 | 
2026-08-25 03:15:53.541104 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-25 03:15:54.379128 | localhost | changed
2026-08-25 03:15:54.396440 | 
2026-08-25 03:15:54.396655 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-25 03:15:54.462197 | localhost | ok
2026-08-25 03:15:54.465594 | 
2026-08-25 03:15:54.465717 | TASK [Set zuul-log-path fact]
2026-08-25 03:15:54.502423 | localhost | ok
2026-08-25 03:15:54.512570 | 
2026-08-25 03:15:54.512703 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-25 03:15:54.603546 | localhost | ok
2026-08-25 03:15:54.607200 | 
2026-08-25 03:15:54.607313 | TASK [upload-logs : Create log directories]
2026-08-25 03:15:55.438861 | localhost | changed
2026-08-25 03:15:55.453918 | 
2026-08-25 03:15:55.454051 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-25 03:15:56.389495 | localhost -> localhost | ok: Runtime: 0:00:00.004635
2026-08-25 03:15:56.394108 | 
2026-08-25 03:15:56.394190 | TASK [upload-logs : Upload logs to log server]
2026-08-25 03:15:57.198293 | localhost | Output suppressed because no_log was given
2026-08-25 03:15:57.199761 | 
2026-08-25 03:15:57.199836 | LOOP [upload-logs : Compress console log and json output]
2026-08-25 03:15:57.316307 | localhost | skipping: Conditional result was False
2026-08-25 03:15:57.351169 | localhost | skipping: Conditional result was False
2026-08-25 03:15:57.369963 | 
2026-08-25 03:15:57.370057 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-25 03:15:57.464366 | localhost | skipping: Conditional result was False
2026-08-25 03:15:57.464761 | 
2026-08-25 03:15:57.482106 | localhost | skipping: Conditional result was False
2026-08-25 03:15:57.487023 | 
2026-08-25 03:15:57.487113 | LOOP [upload-logs : Upload console log and json output]