2026-05-07 03:14:28.925328 | Job console starting
2026-05-07 03:14:28.938789 | Updating git repos
2026-05-07 03:14:28.960449 | Cloning repos into workspace
2026-05-07 03:14:28.987515 | Restoring repo states
2026-05-07 03:14:29.003510 | Merging changes
2026-05-07 03:14:29.003528 | Checking out repos
2026-05-07 03:14:29.052815 | Preparing playbooks
2026-05-07 03:14:30.121830 | Running Ansible setup
2026-05-07 03:14:36.585156 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-07 03:14:38.117393 | 
2026-05-07 03:14:38.117515 | PLAY [Base pre]
2026-05-07 03:14:38.144867 | 
2026-05-07 03:14:38.144971 | TASK [Setup log path fact]
2026-05-07 03:14:38.172351 | debian-bookworm | ok
2026-05-07 03:14:38.190727 | 
2026-05-07 03:14:38.190872 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-07 03:14:38.248053 | debian-bookworm | ok
2026-05-07 03:14:38.259998 | 
2026-05-07 03:14:38.260091 | TASK [emit-job-header : Print job information]
2026-05-07 03:14:38.329599 | # Job Information
2026-05-07 03:14:38.329739 | Ansible Version: 2.16.14
2026-05-07 03:14:38.329988 | Job: python-black
2026-05-07 03:14:38.330019 | Pipeline: periodic-daily
2026-05-07 03:14:38.330074 | Executor: 521e9411259a
2026-05-07 03:14:38.330094 | Triggered by: https://github.com/osism/cinder-driver-dm-clone
2026-05-07 03:14:38.330112 | Event ID: a6c06db4dc2a4c0f89d7c52edd639181
2026-05-07 03:14:38.339194 | 
2026-05-07 03:14:38.339299 | LOOP [emit-job-header : Print node information]
2026-05-07 03:14:38.503341 | debian-bookworm | ok:
2026-05-07 03:14:38.503497 | debian-bookworm | # Node Information
2026-05-07 03:14:38.503530 | debian-bookworm | Inventory Hostname: debian-bookworm
2026-05-07 03:14:38.503555 | debian-bookworm | Hostname: debian
2026-05-07 03:14:38.503576 | debian-bookworm | Username: zuul
2026-05-07 03:14:38.503597 | debian-bookworm | Distro: Debian 12.13
2026-05-07 03:14:38.503620 | debian-bookworm | Provider: regiocloud-a
2026-05-07 03:14:38.503640 | debian-bookworm | Region:
2026-05-07 03:14:38.503687 | debian-bookworm | Label: debian-bookworm
2026-05-07 03:14:38.503710 | debian-bookworm | Product Name: OpenStack Nova
2026-05-07 03:14:38.503729 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe89:2ec8
2026-05-07 03:14:38.515343 | 
2026-05-07 03:14:38.515438 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-07 03:14:39.412031 | debian-bookworm -> localhost | changed
2026-05-07 03:14:39.417993 | 
2026-05-07 03:14:39.418087 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-07 03:14:40.797060 | debian-bookworm -> localhost | changed
2026-05-07 03:14:40.806410 | 
2026-05-07 03:14:40.806505 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-07 03:14:41.213026 | debian-bookworm -> localhost | ok
2026-05-07 03:14:41.224163 | 
2026-05-07 03:14:41.224324 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-07 03:14:41.266116 | debian-bookworm | ok
2026-05-07 03:14:41.297918 | debian-bookworm | included: /var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-07 03:14:41.327610 | 
2026-05-07 03:14:41.327724 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-07 03:14:44.174456 | debian-bookworm -> localhost | Generating public/private rsa key pair.
2026-05-07 03:14:44.175260 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/work/3f60cc6fd3b249cf9443ad1b1b0ac345_id_rsa
2026-05-07 03:14:44.175320 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/work/3f60cc6fd3b249cf9443ad1b1b0ac345_id_rsa.pub
2026-05-07 03:14:44.175348 | debian-bookworm -> localhost | The key fingerprint is:
2026-05-07 03:14:44.175373 | debian-bookworm -> localhost | SHA256:uux8BHD9Opqopzu6130sZHBYND4/JGmyN2RkhdEb7Q8 zuul-build-sshkey
2026-05-07 03:14:44.175396 | debian-bookworm -> localhost | The key's randomart image is:
2026-05-07 03:14:44.175474 | debian-bookworm -> localhost | +---[RSA 3072]----+
2026-05-07 03:14:44.175550 | debian-bookworm -> localhost | |     .**..       |
2026-05-07 03:14:44.175574 | debian-bookworm -> localhost | |    .++o+ .      |
2026-05-07 03:14:44.175595 | debian-bookworm -> localhost | |    .=O .=       |
2026-05-07 03:14:44.175615 | debian-bookworm -> localhost | |    o*o=. E      |
2026-05-07 03:14:44.175636 | debian-bookworm -> localhost | |    .oo.S. o     |
2026-05-07 03:14:44.175664 | debian-bookworm -> localhost | |     .oo+.  .    |
2026-05-07 03:14:44.175685 | debian-bookworm -> localhost | |   . =.= .       |
2026-05-07 03:14:44.175707 | debian-bookworm -> localhost | |  o +o=.+        |
2026-05-07 03:14:44.175762 | debian-bookworm -> localhost | |o++* .=+         |
2026-05-07 03:14:44.175786 | debian-bookworm -> localhost | +----[SHA256]-----+
2026-05-07 03:14:44.175895 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.820805
2026-05-07 03:14:44.183294 | 
2026-05-07 03:14:44.183467 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-07 03:14:44.237775 | debian-bookworm | ok
2026-05-07 03:14:44.266789 | debian-bookworm | included: /var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-07 03:14:44.290235 | 
2026-05-07 03:14:44.290353 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-07 03:14:44.313579 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:14:44.319494 | 
2026-05-07 03:14:44.319603 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-07 03:14:45.123108 | debian-bookworm | changed
2026-05-07 03:14:45.133332 | 
2026-05-07 03:14:45.133441 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-07 03:14:45.417925 | debian-bookworm | ok
2026-05-07 03:14:45.448421 | 
2026-05-07 03:14:45.458712 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-07 03:14:46.377110 | debian-bookworm | changed
2026-05-07 03:14:46.383745 | 
2026-05-07 03:14:46.383876 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-07 03:14:47.164889 | debian-bookworm | changed
2026-05-07 03:14:47.178685 | 
2026-05-07 03:14:47.178806 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-07 03:14:47.214209 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:14:47.220417 | 
2026-05-07 03:14:47.220522 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-07 03:14:48.079829 | debian-bookworm -> localhost | changed
2026-05-07 03:14:48.091474 | 
2026-05-07 03:14:48.091585 | TASK [add-build-sshkey : Add back temp key]
2026-05-07 03:14:48.756174 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/work/3f60cc6fd3b249cf9443ad1b1b0ac345_id_rsa (zuul-build-sshkey)
2026-05-07 03:14:48.756388 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032135
2026-05-07 03:14:48.786723 | 
2026-05-07 03:14:48.789771 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-07 03:14:49.441985 | debian-bookworm | ok
2026-05-07 03:14:49.464124 | 
2026-05-07 03:14:49.464386 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-07 03:14:49.504841 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:14:49.523377 | 
2026-05-07 03:14:49.523489 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-05-07 03:14:49.998535 | debian-bookworm | ok
2026-05-07 03:14:50.010590 | 
2026-05-07 03:14:50.010695 | TASK [validate-host : Define zuul_info_dir fact]
2026-05-07 03:14:50.082503 | debian-bookworm | ok
2026-05-07 03:14:50.093286 | 
2026-05-07 03:14:50.093390 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-05-07 03:14:50.700209 | debian-bookworm -> localhost | ok
2026-05-07 03:14:50.706519 | 
2026-05-07 03:14:50.706624 | TASK [validate-host : Collect information about the host]
2026-05-07 03:14:52.173363 | debian-bookworm | ok
2026-05-07 03:14:52.191660 | 
2026-05-07 03:14:52.191767 | TASK [validate-host : Sanitize hostname]
2026-05-07 03:14:52.402342 | debian-bookworm | ok
2026-05-07 03:14:52.502296 | 
2026-05-07 03:14:52.502413 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-05-07 03:14:53.789426 | debian-bookworm -> localhost | changed
2026-05-07 03:14:53.797770 | 
2026-05-07 03:14:53.797928 | TASK [validate-host : Collect information about zuul worker]
2026-05-07 03:14:54.349084 | debian-bookworm | ok
2026-05-07 03:14:54.354137 | 
2026-05-07 03:14:54.354277 | TASK [validate-host : Write out all zuul information for each host]
2026-05-07 03:14:55.556602 | debian-bookworm -> localhost | changed
2026-05-07 03:14:55.571530 | 
2026-05-07 03:14:55.571668 | TASK [prepare-workspace-log : Start zuul_console daemon.]
2026-05-07 03:14:55.899057 | debian-bookworm | ok
2026-05-07 03:14:55.904862 | 
2026-05-07 03:14:55.904983 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.]
2026-05-07 03:14:56.912654 | debian-bookworm | changed:
2026-05-07 03:14:56.912949 | debian-bookworm | cd+++++++++ src/
2026-05-07 03:14:56.913009 | debian-bookworm | cd+++++++++ src/github.com/
2026-05-07 03:14:56.913049 | debian-bookworm | cd+++++++++ src/github.com/osism/
2026-05-07 03:14:56.913085 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/
2026-05-07 03:14:56.913117 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.flake8
2026-05-07 03:14:56.913235 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.zuul.yaml
2026-05-07 03:14:56.913276 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/LICENSE
2026-05-07 03:14:56.913309 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/README.md
2026-05-07 03:14:56.913341 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/
2026-05-07 03:14:56.913371 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/HEAD
2026-05-07 03:14:56.913401 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/ORIG_HEAD
2026-05-07 03:14:56.913431 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config
2026-05-07 03:14:56.913461 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config.worktree
2026-05-07 03:14:56.913492 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/description
2026-05-07 03:14:56.913523 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/index
2026-05-07 03:14:56.913553 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/packed-refs
2026-05-07 03:14:56.913583 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/branches/
2026-05-07 03:14:56.913612 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/
2026-05-07 03:14:56.913640 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/applypatch-msg.sample
2026-05-07 03:14:56.913671 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/commit-msg.sample
2026-05-07 03:14:56.913701 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/fsmonitor-watchman.sample
2026-05-07 03:14:56.913731 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/post-update.sample
2026-05-07 03:14:56.913761 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-applypatch.sample
2026-05-07 03:14:56.913790 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-commit.sample
2026-05-07 03:14:56.913831 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-merge-commit.sample
2026-05-07 03:14:56.913862 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-push.sample
2026-05-07 03:14:56.913905 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-rebase.sample
2026-05-07 03:14:56.913937 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-receive.sample
2026-05-07 03:14:56.913966 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/prepare-commit-msg.sample
2026-05-07 03:14:56.913995 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/push-to-checkout.sample
2026-05-07 03:14:56.914023 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/update.sample
2026-05-07 03:14:56.914053 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/
2026-05-07 03:14:56.914082 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/exclude
2026-05-07 03:14:56.914111 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/
2026-05-07 03:14:56.914139 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/HEAD
2026-05-07 03:14:56.914167 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/
2026-05-07 03:14:56.914195 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/
2026-05-07 03:14:56.914224 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/main
2026-05-07 03:14:56.914252 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/
2026-05-07 03:14:56.914281 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/
2026-05-07 03:14:56.914311 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/HEAD
2026-05-07 03:14:56.914340 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/
2026-05-07 03:14:56.914369 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/
2026-05-07 03:14:56.914398 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/e0c7c227616678a99e3704bf81f2c38d105608
2026-05-07 03:14:56.914431 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/
2026-05-07 03:14:56.914460 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/e2c2920ba926041df3295b3280def4c83c4039
2026-05-07 03:14:56.914488 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/
2026-05-07 03:14:56.914518 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/459297831c4ce0d7ea29ed8c9114ba146a8527
2026-05-07 03:14:56.914548 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/
2026-05-07 03:14:56.914577 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/9d518cd0ba589205707f1d3188a50d210b7da1
2026-05-07 03:14:56.914607 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/
2026-05-07 03:14:56.914636 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/64fde99e36ae8d2d7920ca9140505ae820cccd
2026-05-07 03:14:56.914665 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/
2026-05-07 03:14:56.914693 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/39a1f80707e8577fc545424370aeb556127e44
2026-05-07 03:14:56.914722 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/
2026-05-07 03:14:56.914751 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/89c92f3220c6de0136a61d8de5f8a2f5e9a5c7
2026-05-07 03:14:56.914780 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/
2026-05-07 03:14:56.914813 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/08e23220f1962907e5e2f9f2d15728a2a19980
2026-05-07 03:14:56.914874 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/
2026-05-07 03:14:56.919238 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/b6642d848334761d7184dd0a767f8e94684589
2026-05-07 03:14:56.919303 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/
2026-05-07 03:14:56.919343 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/ecda1bd613e629b0ab9f19ddf304ab5f994d60
2026-05-07 03:14:56.919379 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/
2026-05-07 03:14:56.919411 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/5fb3f40bf64cf874cf6e30b8dd8325d3f72992
2026-05-07 03:14:56.919442 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/
2026-05-07 03:14:56.919472 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/3d086ae32b25aaf6ab01121e7c74a51a08211e
2026-05-07 03:14:56.919504 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/
2026-05-07 03:14:56.919535 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/955504dc1be4f034729e036aac7fd53d85d0e2
2026-05-07 03:14:56.919566 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/
2026-05-07 03:14:56.919596 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/c3439d4d774c22776fb7720414c61d484e3076
2026-05-07 03:14:56.919626 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/
2026-05-07 03:14:56.919655 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/a71bda7721ff0db72982e936c2ab41ce720042
2026-05-07 03:14:56.919686 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/
2026-05-07 03:14:56.919716 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/65c35f918519fa197bc812e46536717dcbd580
2026-05-07 03:14:56.919746 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/info/
2026-05-07 03:14:56.919775 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/
2026-05-07 03:14:56.919805 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.idx
2026-05-07 03:14:56.919857 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.pack
2026-05-07 03:14:56.919889 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/refs/
2026-05-07 03:14:56.919919 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/
2026-05-07 03:14:56.919949 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/
2026-05-07 03:14:56.919979 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/add-to-project.yml
2026-05-07 03:14:56.920011 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/
2026-05-07 03:14:56.920043 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/
2026-05-07 03:14:56.920072 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/
2026-05-07 03:14:56.920101 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/
2026-05-07 03:14:56.920131 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/__init__.py
2026-05-07 03:14:56.920171 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/dmsetup.py
2026-05-07 03:14:56.920203 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/driver.py
2026-05-07 03:14:56.941744 | 
2026-05-07 03:14:56.941898 | LOOP [ensure-output-dirs-present : Ensure Zuul output directories exist]
2026-05-07 03:14:57.257895 | debian-bookworm | changed: "logs"
2026-05-07 03:14:57.258121 | debian-bookworm | ok: All items complete
2026-05-07 03:14:57.258150 | 
2026-05-07 03:14:57.490732 | debian-bookworm | changed: "artifacts"
2026-05-07 03:14:57.743493 | debian-bookworm | changed: "docs"
2026-05-07 03:14:57.757340 | 
2026-05-07 03:14:57.757446 | TASK [diagnose-first-sudo : Ensure log directory exists]
2026-05-07 03:14:58.044593 | debian-bookworm | ok
2026-05-07 03:14:58.049579 | 
2026-05-07 03:14:58.049666 | TASK [diagnose-first-sudo : Probe first sudo invocation under strace]
2026-05-07 03:14:58.600495 | debian-bookworm | ok: Runtime: 0:00:00.071998
2026-05-07 03:14:58.609398 | 
2026-05-07 03:14:58.609665 | TASK [diagnose-first-sudo : Snapshot DNS / PAM / logind state (no become)]
2026-05-07 03:14:59.168499 | debian-bookworm | ok: Runtime: 0:00:00.087535
2026-05-07 03:14:59.180464 | 
2026-05-07 03:14:59.180542 | PLAY RECAP
2026-05-07 03:14:59.180589 | debian-bookworm | ok: 30 changed: 14 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-07 03:14:59.180613 | 
2026-05-07 03:14:59.714220 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-07 03:14:59.715193 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-07 03:15:01.390676 | 
2026-05-07 03:15:01.390854 | PLAY [Install Black and format code]
2026-05-07 03:15:01.420523 | 
2026-05-07 03:15:01.420650 | LOOP [Install python]
2026-05-07 03:15:01.458772 | debian-bookworm | ok: "ensure-python"
2026-05-07 03:15:01.463377 | debian-bookworm | ok: "ensure-pip"
2026-05-07 03:15:01.557415 | 
2026-05-07 03:15:01.560786 | TASK [ensure-python : Validate python_version value]
2026-05-07 03:15:01.619276 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:01.625488 | 
2026-05-07 03:15:01.625600 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-05-07 03:15:01.659376 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:01.665021 | 
2026-05-07 03:15:01.665136 | TASK [ensure-python : Pull in venv package]
2026-05-07 03:15:01.708844 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:01.715657 | 
2026-05-07 03:15:01.715769 | TASK [ensure-python : Set default RPM package name]
2026-05-07 03:15:01.769454 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:01.775482 | 
2026-05-07 03:15:01.775604 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-05-07 03:15:01.869776 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:01.877145 | 
2026-05-07 03:15:01.877264 | TASK [ensure-python : Install RPM package]
2026-05-07 03:15:01.924860 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:01.937019 | 
2026-05-07 03:15:01.937144 | TASK [ensure-python : Install python using pyenv]
2026-05-07 03:15:01.960936 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:01.967489 | 
2026-05-07 03:15:01.967594 | TASK [ensure-python : Activate python using stow]
2026-05-07 03:15:02.017137 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:02.038169 | 
2026-05-07 03:15:02.038283 | TASK [ensure-pip : Check if pip is installed]
2026-05-07 03:15:03.161214 | debian-bookworm | ok: Runtime: 0:00:00.008335
2026-05-07 03:15:03.167390 | 
2026-05-07 03:15:03.167494 | LOOP [ensure-pip : Install pip from packages]
2026-05-07 03:15:03.196072 | debian-bookworm | ok: "/var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-05-07 03:15:03.196223 | debian-bookworm | ok: All items complete
2026-05-07 03:15:03.196250 | 
2026-05-07 03:15:03.209192 | debian-bookworm | included: /var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-05-07 03:15:03.218309 | 
2026-05-07 03:15:03.218414 | TASK [ensure-pip : Update package lists]
2026-05-07 03:15:07.703017 | debian-bookworm | changed
2026-05-07 03:15:07.708654 | 
2026-05-07 03:15:07.708772 | TASK [ensure-pip : Install Python 3 pip]
2026-05-07 03:15:13.083629 | debian-bookworm | changed
2026-05-07 03:15:13.090303 | 
2026-05-07 03:15:13.090408 | TASK [ensure-pip : Install Python 2 pip]
2026-05-07 03:15:13.187220 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:13.222169 | 
2026-05-07 03:15:13.222301 | TASK [ensure-pip : Ensure setuptools]
2026-05-07 03:15:13.269970 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:13.277130 | 
2026-05-07 03:15:13.277237 | TASK [ensure-pip : Check for ensurepip module]
2026-05-07 03:15:13.704947 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-05-07 03:15:13.705202 | debian-bookworm |                            [--altinstall] [--default-pip]
2026-05-07 03:15:13.705226 | debian-bookworm |
2026-05-07 03:15:13.705242 | debian-bookworm | options:
2026-05-07 03:15:13.705260 | debian-bookworm |   -h, --help     show this help message and exit
2026-05-07 03:15:13.705281 | debian-bookworm |   --version      Show the version of pip that is bundled with this Python.
2026-05-07 03:15:13.705295 | debian-bookworm |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-05-07 03:15:13.705341 | debian-bookworm |                  times.
2026-05-07 03:15:13.705368 | debian-bookworm |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-05-07 03:15:13.705382 | debian-bookworm |   --user         Install using the user scheme.
2026-05-07 03:15:13.705395 | debian-bookworm |   --root ROOT    Install everything relative to this alternate root directory.
2026-05-07 03:15:13.705407 | debian-bookworm |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-05-07 03:15:13.705419 | debian-bookworm |                  scripts (Default: pipX, pipX.Y, easy_install-X.Y).
2026-05-07 03:15:13.705430 | debian-bookworm |   --default-pip  Make a default pip install, installing the unqualified pip
2026-05-07 03:15:13.705441 | debian-bookworm |                  and easy_install in addition to the versioned scripts.
2026-05-07 03:15:13.835262 | debian-bookworm | ok: Runtime: 0:00:00.094161
2026-05-07 03:15:13.849315 | 
2026-05-07 03:15:13.849424 | TASK [ensure-pip : Ensure python3-venv]
2026-05-07 03:15:13.886848 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:13.893294 | 
2026-05-07 03:15:13.893437 | TASK [ensure-pip : Install pip from source]
2026-05-07 03:15:13.947612 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:13.955202 | 
2026-05-07 03:15:13.955352 | TASK [ensure-pip : Probe for venv python full path]
2026-05-07 03:15:14.374984 | debian-bookworm | /usr/bin/python3
2026-05-07 03:15:14.577681 | debian-bookworm | ok: Runtime: 0:00:00.008011
2026-05-07 03:15:14.583907 | 
2026-05-07 03:15:14.584003 | TASK [ensure-pip : Set host default]
2026-05-07 03:15:14.641919 | debian-bookworm | ok
2026-05-07 03:15:14.648020 | 
2026-05-07 03:15:14.648113 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-05-07 03:15:14.729039 | debian-bookworm | ok
2026-05-07 03:15:14.812916 | 
2026-05-07 03:15:14.813029 | TASK [python-black : Install black]
2026-05-07 03:15:21.967987 | debian-bookworm | changed
2026-05-07 03:15:21.973432 | 
2026-05-07 03:15:21.973540 | TASK [python-black : Format code with Black if there is nothing to exclude]
2026-05-07 03:15:22.781739 | debian-bookworm | All done! ✨ 🍰 ✨
2026-05-07 03:15:22.781920 | debian-bookworm | 3 files would be left unchanged.
2026-05-07 03:15:23.041136 | debian-bookworm | ok: Runtime: 0:00:00.425879
2026-05-07 03:15:23.045477 | 
2026-05-07 03:15:23.045560 | TASK [python-black : Format code with Black if there is an exclusion]
2026-05-07 03:15:23.584286 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:23.590199 | 
2026-05-07 03:15:23.590261 | PLAY RECAP
2026-05-07 03:15:23.590306 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2026-05-07 03:15:23.590326 | 
2026-05-07 03:15:24.181561 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-07 03:15:24.182200 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-07 03:15:25.149451 | 
2026-05-07 03:15:25.149586 | PLAY [Base post-fetch]
2026-05-07 03:15:25.179376 | 
2026-05-07 03:15:25.179498 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-07 03:15:25.274211 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:25.281393 | 
2026-05-07 03:15:25.281539 | TASK [fetch-output : Set log path for single node]
2026-05-07 03:15:25.352790 | debian-bookworm | ok
2026-05-07 03:15:25.357716 | 
2026-05-07 03:15:25.357828 | LOOP [fetch-output : Ensure local output dirs]
2026-05-07 03:15:26.030411 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/work/logs"
2026-05-07 03:15:26.295474 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/work/artifacts"
2026-05-07 03:15:26.560719 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3f60cc6fd3b249cf9443ad1b1b0ac345/work/docs"
2026-05-07 03:15:26.574504 | 
2026-05-07 03:15:26.574605 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-07 03:15:27.411351 | debian-bookworm | changed:
2026-05-07 03:15:27.411555 | debian-bookworm | .d..t...... ./
2026-05-07 03:15:27.411627 | debian-bookworm | >f+++++++++ sudo-debug.txt
2026-05-07 03:15:27.411660 | debian-bookworm | >f+++++++++ sudo-strace.log
2026-05-07 03:15:27.411686 | debian-bookworm | >f+++++++++ sudo-strace.log.time
2026-05-07 03:15:27.411726 | debian-bookworm | changed: All items complete
2026-05-07 03:15:27.411753 | 
2026-05-07 03:15:28.264139 | debian-bookworm | changed: .d..t...... ./
2026-05-07 03:15:28.994448 | debian-bookworm | changed: .d..t...... ./
2026-05-07 03:15:29.032332 | 
2026-05-07 03:15:29.032430 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-07 03:15:29.110926 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:29.120305 | debian-bookworm | skipping: Conditional result was False
2026-05-07 03:15:29.135535 | 
2026-05-07 03:15:29.135607 | PLAY RECAP
2026-05-07 03:15:29.135648 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-05-07 03:15:29.135669 | 
2026-05-07 03:15:29.527504 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-07 03:15:29.530297 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-07 03:15:30.774198 | 
2026-05-07 03:15:30.774319 | PLAY [Base post]
2026-05-07 03:15:30.792481 | 
2026-05-07 03:15:30.792588 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-07 03:15:31.387343 | debian-bookworm | changed
2026-05-07 03:15:31.396544 | 
2026-05-07 03:15:31.396656 | PLAY RECAP
2026-05-07 03:15:31.396716 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-07 03:15:31.396808 | 
2026-05-07 03:15:31.636992 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-07 03:15:31.637603 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-07 03:15:32.928803 | 
2026-05-07 03:15:32.928938 | PLAY [Base post-logs]
2026-05-07 03:15:32.960957 | 
2026-05-07 03:15:32.961087 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-07 03:15:33.724831 | localhost | changed
2026-05-07 03:15:33.734513 | 
2026-05-07 03:15:33.734695 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-07 03:15:33.779589 | localhost | ok
2026-05-07 03:15:33.782427 | 
2026-05-07 03:15:33.782510 | TASK [Set zuul-log-path fact]
2026-05-07 03:15:33.807350 | localhost | ok
2026-05-07 03:15:33.824546 | 
2026-05-07 03:15:33.824658 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-07 03:15:33.865892 | localhost | ok
2026-05-07 03:15:33.868809 | 
2026-05-07 03:15:33.868902 | TASK [upload-logs : Create log directories]
2026-05-07 03:15:34.816517 | localhost | changed
2026-05-07 03:15:34.819678 | 
2026-05-07 03:15:34.819910 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-07 03:15:35.801653 | localhost -> localhost | ok: Runtime: 0:00:00.003720
2026-05-07 03:15:35.804726 | 
2026-05-07 03:15:35.804840 | TASK [upload-logs : Upload logs to log server]
2026-05-07 03:15:36.502890 | localhost | Output suppressed because no_log was given
2026-05-07 03:15:36.505520 | 
2026-05-07 03:15:36.505608 | LOOP [upload-logs : Compress console log and json output]
2026-05-07 03:15:36.555123 | localhost | skipping: Conditional result was False
2026-05-07 03:15:36.560506 | localhost | skipping: Conditional result was False
2026-05-07 03:15:36.564795 | 
2026-05-07 03:15:36.564888 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-07 03:15:36.659261 | localhost | skipping: Conditional result was False
2026-05-07 03:15:36.659480 | 
2026-05-07 03:15:36.672789 | localhost | skipping: Conditional result was False
2026-05-07 03:15:36.682806 | 
2026-05-07 03:15:36.682977 | LOOP [upload-logs : Upload console log and json output]