2026-05-27 03:14:15.209974 | Job console starting
2026-05-27 03:14:15.228791 | Updating git repos
2026-05-27 03:14:15.261795 | Cloning repos into workspace
2026-05-27 03:14:15.324166 | Restoring repo states
2026-05-27 03:14:15.328851 | Merging changes
2026-05-27 03:14:15.328868 | Checking out repos
2026-05-27 03:14:15.384510 | Preparing playbooks
2026-05-27 03:14:16.508460 | Running Ansible setup
2026-05-27 03:14:21.056740 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-27 03:14:21.893101 | 
2026-05-27 03:14:21.893439 | PLAY [Base pre]
2026-05-27 03:14:21.927824 | 
2026-05-27 03:14:21.928023 | TASK [Setup log path fact]
2026-05-27 03:14:21.950503 | debian-bookworm | ok
2026-05-27 03:14:21.984733 | 
2026-05-27 03:14:21.984958 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-27 03:14:22.031065 | debian-bookworm | ok
2026-05-27 03:14:22.066871 | 
2026-05-27 03:14:22.067091 | TASK [emit-job-header : Print job information]
2026-05-27 03:14:22.149946 | # Job Information
2026-05-27 03:14:22.150181 | Ansible Version: 2.16.14
2026-05-27 03:14:22.150216 | Job: python-black
2026-05-27 03:14:22.150368 | Pipeline: periodic-daily
2026-05-27 03:14:22.150399 | Executor: 521e9411259a
2026-05-27 03:14:22.150423 | Triggered by: https://github.com/osism/cinder-driver-dm-clone
2026-05-27 03:14:22.150447 | Event ID: 8ae57afa115348c985c8009afd1c6969
2026-05-27 03:14:22.160030 | 
2026-05-27 03:14:22.160198 | LOOP [emit-job-header : Print node information]
2026-05-27 03:14:22.293388 | debian-bookworm | ok:
2026-05-27 03:14:22.293735 | debian-bookworm | # Node Information
2026-05-27 03:14:22.293774 | debian-bookworm | Inventory Hostname: debian-bookworm
2026-05-27 03:14:22.293799 | debian-bookworm | Hostname: debian
2026-05-27 03:14:22.293821 | debian-bookworm | Username: zuul
2026-05-27 03:14:22.293841 | debian-bookworm | Distro: Debian 12.14
2026-05-27 03:14:22.293869 | debian-bookworm | Provider: regiocloud-a
2026-05-27 03:14:22.293892 | debian-bookworm | Region:
2026-05-27 03:14:22.293914 | debian-bookworm | Label: debian-bookworm
2026-05-27 03:14:22.293934 | debian-bookworm | Product Name: OpenStack Nova
2026-05-27 03:14:22.293953 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6a:a6e7
2026-05-27 03:14:22.324217 | 
2026-05-27 03:14:22.324421 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-27 03:14:23.011621 | debian-bookworm -> localhost | changed
2026-05-27 03:14:23.021528 | 
2026-05-27 03:14:23.021680 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-27 03:14:24.471550 | debian-bookworm -> localhost | changed
2026-05-27 03:14:24.492378 | 
2026-05-27 03:14:24.492618 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-27 03:14:24.961713 | debian-bookworm -> localhost | ok
2026-05-27 03:14:24.968406 | 
2026-05-27 03:14:24.968552 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-27 03:14:25.003108 | debian-bookworm | ok
2026-05-27 03:14:25.020481 | debian-bookworm | included: /var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-27 03:14:25.032659 | 
2026-05-27 03:14:25.032856 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-27 03:14:26.765060 | debian-bookworm -> localhost | Generating public/private rsa key pair.
2026-05-27 03:14:26.765751 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/work/f2f3f9f49eb04c1aa0ad5ac4fd546284_id_rsa
2026-05-27 03:14:26.765812 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/work/f2f3f9f49eb04c1aa0ad5ac4fd546284_id_rsa.pub
2026-05-27 03:14:26.765870 | debian-bookworm -> localhost | The key fingerprint is:
2026-05-27 03:14:26.765897 | debian-bookworm -> localhost | SHA256:qXYp3NIoGzFcw1zVZvHQhpi8V/q7l4IhWLLoz+Jlq6s zuul-build-sshkey
2026-05-27 03:14:26.765920 | debian-bookworm -> localhost | The key's randomart image is:
2026-05-27 03:14:26.765964 | debian-bookworm -> localhost | +---[RSA 3072]----+
2026-05-27 03:14:26.765986 | debian-bookworm -> localhost | |        .o.+o+   |
2026-05-27 03:14:26.766008 | debian-bookworm -> localhost | |     o .  + =o+  |
2026-05-27 03:14:26.766028 | debian-bookworm -> localhost | |      =    + +.  |
2026-05-27 03:14:26.766302 | debian-bookworm -> localhost | |   . . o o. o    |
2026-05-27 03:14:26.766346 | debian-bookworm -> localhost | |    + . S  . .   |
2026-05-27 03:14:26.766380 | debian-bookworm -> localhost | |     = B o .  .  |
2026-05-27 03:14:26.766404 | debian-bookworm -> localhost | |    + Bo= . o  ..|
2026-05-27 03:14:26.766426 | debian-bookworm -> localhost | |     B++.  . ....|
2026-05-27 03:14:26.766448 | debian-bookworm -> localhost | |   E++=+      oo |
2026-05-27 03:14:26.766534 | debian-bookworm -> localhost | +----[SHA256]-----+
2026-05-27 03:14:26.766610 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.135485
2026-05-27 03:14:26.776729 | 
2026-05-27 03:14:26.776879 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-27 03:14:26.812887 | debian-bookworm | ok
2026-05-27 03:14:26.830233 | debian-bookworm | included: /var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-27 03:14:26.845894 | 
2026-05-27 03:14:26.846019 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-27 03:14:26.881929 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:26.894422 | 
2026-05-27 03:14:26.894662 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-27 03:14:27.841048 | debian-bookworm | changed
2026-05-27 03:14:27.859065 | 
2026-05-27 03:14:27.860618 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-27 03:14:28.347132 | debian-bookworm | ok
2026-05-27 03:14:28.353051 | 
2026-05-27 03:14:28.353172 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-27 03:14:29.140606 | debian-bookworm | changed
2026-05-27 03:14:29.163102 | 
2026-05-27 03:14:29.163276 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-27 03:14:30.118098 | debian-bookworm | changed
2026-05-27 03:14:30.136016 | 
2026-05-27 03:14:30.137973 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-27 03:14:30.251534 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:30.264903 | 
2026-05-27 03:14:30.265039 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-27 03:14:31.303811 | debian-bookworm -> localhost | changed
2026-05-27 03:14:31.315538 | 
2026-05-27 03:14:31.315670 | TASK [add-build-sshkey : Add back temp key]
2026-05-27 03:14:31.799577 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/work/f2f3f9f49eb04c1aa0ad5ac4fd546284_id_rsa (zuul-build-sshkey)
2026-05-27 03:14:31.799849 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032458
2026-05-27 03:14:31.808599 | 
2026-05-27 03:14:31.808723 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-27 03:14:32.330538 | debian-bookworm | ok
2026-05-27 03:14:32.344884 | 
2026-05-27 03:14:32.345059 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-27 03:14:32.389662 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:32.408095 | 
2026-05-27 03:14:32.408998 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-05-27 03:14:33.091379 | debian-bookworm | ok
2026-05-27 03:14:33.132772 | 
2026-05-27 03:14:33.132970 | TASK [validate-host : Define zuul_info_dir fact]
2026-05-27 03:14:33.179027 | debian-bookworm | ok
2026-05-27 03:14:33.201004 | 
2026-05-27 03:14:33.201199 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-05-27 03:14:33.725724 | debian-bookworm -> localhost | ok
2026-05-27 03:14:33.733941 | 
2026-05-27 03:14:33.734091 | TASK [validate-host : Collect information about the host]
2026-05-27 03:14:35.268109 | debian-bookworm | ok
2026-05-27 03:14:35.285663 | 
2026-05-27 03:14:35.285819 | TASK [validate-host : Sanitize hostname]
2026-05-27 03:14:35.442577 | debian-bookworm | ok
2026-05-27 03:14:35.537473 | 
2026-05-27 03:14:35.537701 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-05-27 03:14:36.525334 | debian-bookworm -> localhost | changed
2026-05-27 03:14:36.532461 | 
2026-05-27 03:14:36.532642 | TASK [validate-host : Collect information about zuul worker]
2026-05-27 03:14:37.141282 | debian-bookworm | ok
2026-05-27 03:14:37.146626 | 
2026-05-27 03:14:37.146730 | TASK [validate-host : Write out all zuul information for each host]
2026-05-27 03:14:37.648012 | debian-bookworm -> localhost | changed
2026-05-27 03:14:37.658142 | 
2026-05-27 03:14:37.658257 | TASK [prepare-workspace-log : Start zuul_console daemon.]
2026-05-27 03:14:37.909214 | debian-bookworm | ok
2026-05-27 03:14:37.914701 | 
2026-05-27 03:14:37.914793 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.]
2026-05-27 03:14:38.853592 | debian-bookworm | changed:
2026-05-27 03:14:38.853767 | debian-bookworm | cd+++++++++ src/
2026-05-27 03:14:38.853800 | debian-bookworm | cd+++++++++ src/github.com/
2026-05-27 03:14:38.853825 | debian-bookworm | cd+++++++++ src/github.com/osism/
2026-05-27 03:14:38.853847 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/
2026-05-27 03:14:38.853868 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.flake8
2026-05-27 03:14:38.853888 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.zuul.yaml
2026-05-27 03:14:38.853908 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/LICENSE
2026-05-27 03:14:38.853928 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/README.md
2026-05-27 03:14:38.853947 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/
2026-05-27 03:14:38.853966 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/HEAD
2026-05-27 03:14:38.853984 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/ORIG_HEAD
2026-05-27 03:14:38.854003 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config
2026-05-27 03:14:38.854021 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config.worktree
2026-05-27 03:14:38.854039 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/description
2026-05-27 03:14:38.854058 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/index
2026-05-27 03:14:38.854077 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/packed-refs
2026-05-27 03:14:38.854096 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/branches/
2026-05-27 03:14:38.854115 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/
2026-05-27 03:14:38.854132 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/applypatch-msg.sample
2026-05-27 03:14:38.854151 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/commit-msg.sample
2026-05-27 03:14:38.854169 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/fsmonitor-watchman.sample
2026-05-27 03:14:38.854187 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/post-update.sample
2026-05-27 03:14:38.854205 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-applypatch.sample
2026-05-27 03:14:38.854222 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-commit.sample
2026-05-27 03:14:38.854240 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-merge-commit.sample
2026-05-27 03:14:38.854258 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-push.sample
2026-05-27 03:14:38.854286 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-rebase.sample
2026-05-27 03:14:38.854305 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-receive.sample
2026-05-27 03:14:38.854323 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/prepare-commit-msg.sample
2026-05-27 03:14:38.854341 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/push-to-checkout.sample
2026-05-27 03:14:38.854359 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/update.sample
2026-05-27 03:14:38.854377 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/
2026-05-27 03:14:38.854395 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/exclude
2026-05-27 03:14:38.854413 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/
2026-05-27 03:14:38.854431 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/HEAD
2026-05-27 03:14:38.854448 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/
2026-05-27 03:14:38.854552 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/
2026-05-27 03:14:38.854575 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/main
2026-05-27 03:14:38.854596 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/
2026-05-27 03:14:38.854616 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/
2026-05-27 03:14:38.854635 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/HEAD
2026-05-27 03:14:38.854653 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/
2026-05-27 03:14:38.854672 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/
2026-05-27 03:14:38.854691 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/e0c7c227616678a99e3704bf81f2c38d105608
2026-05-27 03:14:38.854712 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/
2026-05-27 03:14:38.854731 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/e2c2920ba926041df3295b3280def4c83c4039
2026-05-27 03:14:38.854750 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/
2026-05-27 03:14:38.854770 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/459297831c4ce0d7ea29ed8c9114ba146a8527
2026-05-27 03:14:38.854790 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/
2026-05-27 03:14:38.854808 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/9d518cd0ba589205707f1d3188a50d210b7da1
2026-05-27 03:14:38.854827 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/
2026-05-27 03:14:38.854875 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/64fde99e36ae8d2d7920ca9140505ae820cccd
2026-05-27 03:14:38.854895 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/
2026-05-27 03:14:38.854914 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/39a1f80707e8577fc545424370aeb556127e44
2026-05-27 03:14:38.854932 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/
2026-05-27 03:14:38.854950 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/89c92f3220c6de0136a61d8de5f8a2f5e9a5c7
2026-05-27 03:14:38.854969 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/
2026-05-27 03:14:38.855034 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/08e23220f1962907e5e2f9f2d15728a2a19980
2026-05-27 03:14:38.855056 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/
2026-05-27 03:14:38.855130 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/b6642d848334761d7184dd0a767f8e94684589
2026-05-27 03:14:38.855151 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/
2026-05-27 03:14:38.855170 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/ecda1bd613e629b0ab9f19ddf304ab5f994d60
2026-05-27 03:14:38.855268 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/
2026-05-27 03:14:38.855295 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/5fb3f40bf64cf874cf6e30b8dd8325d3f72992
2026-05-27 03:14:38.855317 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/
2026-05-27 03:14:38.855338 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/3d086ae32b25aaf6ab01121e7c74a51a08211e
2026-05-27 03:14:38.855358 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/
2026-05-27 03:14:38.855377 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/955504dc1be4f034729e036aac7fd53d85d0e2
2026-05-27 03:14:38.855397 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/
2026-05-27 03:14:38.855416 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/c3439d4d774c22776fb7720414c61d484e3076
2026-05-27 03:14:38.855465 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/
2026-05-27 03:14:38.855511 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/a71bda7721ff0db72982e936c2ab41ce720042
2026-05-27 03:14:38.855534 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/
2026-05-27 03:14:38.855554 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/65c35f918519fa197bc812e46536717dcbd580
2026-05-27 03:14:38.855573 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/info/
2026-05-27 03:14:38.855592 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/
2026-05-27 03:14:38.855611 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.idx
2026-05-27 03:14:38.855632 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.pack
2026-05-27 03:14:38.855650 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/refs/
2026-05-27 03:14:38.855668 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/
2026-05-27 03:14:38.855687 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/
2026-05-27 03:14:38.855705 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/add-to-project.yml
2026-05-27 03:14:38.855725 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/
2026-05-27 03:14:38.855744 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/
2026-05-27 03:14:38.855763 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/
2026-05-27 03:14:38.855781 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/
2026-05-27 03:14:38.855799 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/__init__.py
2026-05-27 03:14:38.855823 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/dmsetup.py
2026-05-27 03:14:38.855842 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/driver.py
2026-05-27 03:14:38.876005 | 
2026-05-27 03:14:38.876104 | LOOP [ensure-output-dirs-present : Ensure Zuul output directories exist]
2026-05-27 03:14:39.286178 | debian-bookworm | changed: "logs"
2026-05-27 03:14:39.286402 | debian-bookworm | ok: All items complete
2026-05-27 03:14:39.286436 | 
2026-05-27 03:14:39.509332 | debian-bookworm | changed: "artifacts"
2026-05-27 03:14:39.714540 | debian-bookworm | changed: "docs"
2026-05-27 03:14:39.734461 | 
2026-05-27 03:14:39.734645 | TASK [diagnose-first-sudo : Ensure log directory exists]
2026-05-27 03:14:39.979077 | debian-bookworm | ok
2026-05-27 03:14:39.984305 | 
2026-05-27 03:14:39.984396 | TASK [diagnose-first-sudo : Probe first sudo invocation under strace]
2026-05-27 03:14:40.511227 | debian-bookworm | ok: Runtime: 0:00:00.061042
2026-05-27 03:14:40.517060 | 
2026-05-27 03:14:40.517176 | TASK [diagnose-first-sudo : Snapshot DNS / PAM / logind state (no become)]
2026-05-27 03:14:41.072432 | debian-bookworm | ok: Runtime: 0:00:00.112692
2026-05-27 03:14:41.082389 | 
2026-05-27 03:14:41.082512 | PLAY RECAP
2026-05-27 03:14:41.082589 | debian-bookworm | ok: 30 changed: 14 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-27 03:14:41.082627 | 
2026-05-27 03:14:41.279888 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-05-27 03:14:41.280774 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-27 03:14:42.059600 | 
2026-05-27 03:14:42.059749 | PLAY [Install Black and format code]
2026-05-27 03:14:42.085225 | 
2026-05-27 03:14:42.085412 | LOOP [Install python]
2026-05-27 03:14:42.107126 | debian-bookworm | ok: "ensure-python"
2026-05-27 03:14:42.110790 | debian-bookworm | ok: "ensure-pip"
2026-05-27 03:14:42.152276 | 
2026-05-27 03:14:42.152439 | TASK [ensure-python : Validate python_version value]
2026-05-27 03:14:42.176214 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:42.182567 | 
2026-05-27 03:14:42.182681 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-05-27 03:14:42.206050 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:42.212387 | 
2026-05-27 03:14:42.212509 | TASK [ensure-python : Pull in venv package]
2026-05-27 03:14:42.235661 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:42.243120 | 
2026-05-27 03:14:42.243224 | TASK [ensure-python : Set default RPM package name]
2026-05-27 03:14:42.266454 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:42.273181 | 
2026-05-27 03:14:42.273288 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-05-27 03:14:42.288987 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:42.298065 | 
2026-05-27 03:14:42.298183 | TASK [ensure-python : Install RPM package]
2026-05-27 03:14:42.322209 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:42.335776 | 
2026-05-27 03:14:42.335958 | TASK [ensure-python : Install python using pyenv]
2026-05-27 03:14:42.361366 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:42.369300 | 
2026-05-27 03:14:42.369454 | TASK [ensure-python : Activate python using stow]
2026-05-27 03:14:42.394428 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:42.404952 | 
2026-05-27 03:14:42.405694 | TASK [ensure-pip : Check if pip is installed]
2026-05-27 03:14:42.940080 | debian-bookworm | ok: Runtime: 0:00:00.005944
2026-05-27 03:14:42.950621 | 
2026-05-27 03:14:42.950749 | LOOP [ensure-pip : Install pip from packages]
2026-05-27 03:14:42.976443 | debian-bookworm | ok: "/var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-05-27 03:14:42.976663 | debian-bookworm | ok: All items complete
2026-05-27 03:14:42.976742 | 
2026-05-27 03:14:42.996593 | debian-bookworm | included: /var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-05-27 03:14:43.006670 | 
2026-05-27 03:14:43.006772 | TASK [ensure-pip : Update package lists]
2026-05-27 03:14:47.543570 | debian-bookworm | changed
2026-05-27 03:14:47.555081 | 
2026-05-27 03:14:47.555554 | TASK [ensure-pip : Install Python 3 pip]
2026-05-27 03:14:52.894197 | debian-bookworm | changed
2026-05-27 03:14:52.904180 | 
2026-05-27 03:14:52.904290 | TASK [ensure-pip : Install Python 2 pip]
2026-05-27 03:14:52.988894 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:52.995640 | 
2026-05-27 03:14:52.995767 | TASK [ensure-pip : Ensure setuptools]
2026-05-27 03:14:53.032207 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:53.041862 | 
2026-05-27 03:14:53.041978 | TASK [ensure-pip : Check for ensurepip module]
2026-05-27 03:14:53.540274 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-05-27 03:14:53.540439 | debian-bookworm |                            [--altinstall] [--default-pip]
2026-05-27 03:14:53.540460 | debian-bookworm |
2026-05-27 03:14:53.540475 | debian-bookworm | options:
2026-05-27 03:14:53.540492 | debian-bookworm |   -h, --help     show this help message and exit
2026-05-27 03:14:53.540513 | debian-bookworm |   --version      Show the version of pip that is bundled with this Python.
2026-05-27 03:14:53.540527 | debian-bookworm |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-05-27 03:14:53.540570 | debian-bookworm |                  times.
2026-05-27 03:14:53.540593 | debian-bookworm |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-05-27 03:14:53.540607 | debian-bookworm |   --user         Install using the user scheme.
2026-05-27 03:14:53.540620 | debian-bookworm |   --root ROOT    Install everything relative to this alternate root directory.
2026-05-27 03:14:53.540632 | debian-bookworm |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-05-27 03:14:53.540643 | debian-bookworm |                  scripts (Default: pipX, pipX.Y, easy_install-X.Y).
2026-05-27 03:14:53.540655 | debian-bookworm |   --default-pip  Make a default pip install, installing the unqualified pip
2026-05-27 03:14:53.540666 | debian-bookworm |                  and easy_install in addition to the versioned scripts.
2026-05-27 03:14:53.613720 | debian-bookworm | ok: Runtime: 0:00:00.107172
2026-05-27 03:14:53.658321 | 
2026-05-27 03:14:53.659048 | TASK [ensure-pip : Ensure python3-venv]
2026-05-27 03:14:53.703883 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:53.721828 | 
2026-05-27 03:14:53.722553 | TASK [ensure-pip : Install pip from source]
2026-05-27 03:14:53.755370 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:14:53.759967 | 
2026-05-27 03:14:53.760048 | TASK [ensure-pip : Probe for venv python full path]
2026-05-27 03:14:54.043258 | debian-bookworm | /usr/bin/python3
2026-05-27 03:14:54.316117 | debian-bookworm | ok: Runtime: 0:00:00.008516
2026-05-27 03:14:54.320802 | 
2026-05-27 03:14:54.320880 | TASK [ensure-pip : Set host default]
2026-05-27 03:14:54.460409 | debian-bookworm | ok
2026-05-27 03:14:54.465985 | 
2026-05-27 03:14:54.466115 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-05-27 03:14:54.563138 | debian-bookworm | ok
2026-05-27 03:14:54.623185 | 
2026-05-27 03:14:54.623284 | TASK [python-black : Install black]
2026-05-27 03:15:01.978543 | debian-bookworm | changed
2026-05-27 03:15:01.984459 | 
2026-05-27 03:15:01.984576 | TASK [python-black : Format code with Black if there is nothing to exclude]
2026-05-27 03:15:02.798314 | debian-bookworm | All done! ✨ 🍰 ✨
2026-05-27 03:15:02.798506 | debian-bookworm | 3 files would be left unchanged.
2026-05-27 03:15:03.018654 | debian-bookworm | ok: Runtime: 0:00:00.449489
2026-05-27 03:15:03.024376 | 
2026-05-27 03:15:03.024478 | TASK [python-black : Format code with Black if there is an exclusion]
2026-05-27 03:15:03.605867 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:15:03.622068 | 
2026-05-27 03:15:03.622177 | PLAY RECAP
2026-05-27 03:15:03.622235 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2026-05-27 03:15:03.622261 | 
2026-05-27 03:15:03.842934 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-05-27 03:15:03.843792 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-27 03:15:04.616540 | 
2026-05-27 03:15:04.616673 | PLAY [Base post-fetch]
2026-05-27 03:15:04.630771 | 
2026-05-27 03:15:04.630918 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-27 03:15:04.684885 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:15:04.690342 | 
2026-05-27 03:15:04.690458 | TASK [fetch-output : Set log path for single node]
2026-05-27 03:15:04.718879 | debian-bookworm | ok
2026-05-27 03:15:04.723785 | 
2026-05-27 03:15:04.723878 | LOOP [fetch-output : Ensure local output dirs]
2026-05-27 03:15:05.164514 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/work/logs"
2026-05-27 03:15:05.650037 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/work/artifacts"
2026-05-27 03:15:05.994400 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f2f3f9f49eb04c1aa0ad5ac4fd546284/work/docs"
2026-05-27 03:15:06.008579 | 
2026-05-27 03:15:06.008683 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-27 03:15:07.235171 | debian-bookworm | changed:
2026-05-27 03:15:07.235324 | debian-bookworm | .d..t...... ./
2026-05-27 03:15:07.235352 | debian-bookworm | >f+++++++++ sudo-debug.txt
2026-05-27 03:15:07.235377 | debian-bookworm | >f+++++++++ sudo-strace.log
2026-05-27 03:15:07.235399 | debian-bookworm | >f+++++++++ sudo-strace.log.time
2026-05-27 03:15:07.235431 | debian-bookworm | changed: All items complete
2026-05-27 03:15:07.235453 | 
2026-05-27 03:15:08.636438 | debian-bookworm | changed: .d..t...... ./
2026-05-27 03:15:09.381137 | debian-bookworm | changed: .d..t...... ./
2026-05-27 03:15:09.392850 | 
2026-05-27 03:15:09.392932 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-27 03:15:09.429563 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:15:09.434078 | debian-bookworm | skipping: Conditional result was False
2026-05-27 03:15:09.442616 | 
2026-05-27 03:15:09.442676 | PLAY RECAP
2026-05-27 03:15:09.442714 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-05-27 03:15:09.442734 | 
2026-05-27 03:15:09.544331 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-05-27 03:15:09.545107 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-27 03:15:10.386203 | 
2026-05-27 03:15:10.386335 | PLAY [Base post]
2026-05-27 03:15:10.407139 | 
2026-05-27 03:15:10.407325 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-27 03:15:11.193750 | debian-bookworm | changed
2026-05-27 03:15:11.211139 | 
2026-05-27 03:15:11.211249 | PLAY RECAP
2026-05-27 03:15:11.211311 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-27 03:15:11.211373 | 
2026-05-27 03:15:11.509572 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-05-27 03:15:11.510404 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-27 03:15:12.455921 | 
2026-05-27 03:15:12.456042 | PLAY [Base post-logs]
2026-05-27 03:15:12.464317 | 
2026-05-27 03:15:12.464404 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-27 03:15:12.895132 | localhost | changed
2026-05-27 03:15:12.902579 | 
2026-05-27 03:15:12.902685 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-27 03:15:12.926451 | localhost | ok
2026-05-27 03:15:12.928831 | 
2026-05-27 03:15:12.928900 | TASK [Set zuul-log-path fact]
2026-05-27 03:15:12.942188 | localhost | ok
2026-05-27 03:15:12.948091 | 
2026-05-27 03:15:12.948166 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-27 03:15:12.971640 | localhost | ok
2026-05-27 03:15:12.973922 | 
2026-05-27 03:15:12.973995 | TASK [upload-logs : Create log directories]
2026-05-27 03:15:14.069266 | localhost | changed
2026-05-27 03:15:14.072166 | 
2026-05-27 03:15:14.072267 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-27 03:15:14.839713 | localhost -> localhost | ok: Runtime: 0:00:00.003595
2026-05-27 03:15:14.843718 | 
2026-05-27 03:15:14.843827 | TASK [upload-logs : Upload logs to log server]
2026-05-27 03:15:16.211767 | localhost | Output suppressed because no_log was given
2026-05-27 03:15:16.213117 | 
2026-05-27 03:15:16.213190 | LOOP [upload-logs : Compress console log and json output]
2026-05-27 03:15:16.297611 | localhost | skipping: Conditional result was False
2026-05-27 03:15:16.307921 | localhost | skipping: Conditional result was False
2026-05-27 03:15:16.320124 | 
2026-05-27 03:15:16.320221 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-27 03:15:16.434852 | localhost | skipping: Conditional result was False
2026-05-27 03:15:16.435071 | 
2026-05-27 03:15:16.465658 | localhost | skipping: Conditional result was False
2026-05-27 03:15:16.482392 | 
2026-05-27 03:15:16.482509 | LOOP [upload-logs : Upload console log and json output]