2026-09-01 03:15:04.256956 | Job console starting
2026-09-01 03:15:04.267438 | Updating git repos
2026-09-01 03:15:04.295760 | Cloning repos into workspace
2026-09-01 03:15:04.363453 | Restoring repo states
2026-09-01 03:15:04.378307 | Merging changes
2026-09-01 03:15:04.378322 | Checking out repos
2026-09-01 03:15:04.438425 | Preparing playbooks
2026-09-01 03:15:05.709176 | Running Ansible setup
2026-09-01 03:15:10.690248 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-09-01 03:15:11.662927 | 
2026-09-01 03:15:11.663204 | PLAY [Base pre]
2026-09-01 03:15:11.681569 | 
2026-09-01 03:15:11.681665 | TASK [Setup log path fact]
2026-09-01 03:15:11.720194 | debian-bookworm | ok
2026-09-01 03:15:11.744822 | 
2026-09-01 03:15:11.744931 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-01 03:15:11.772659 | debian-bookworm | ok
2026-09-01 03:15:11.796884 | 
2026-09-01 03:15:11.796978 | TASK [emit-job-header : Print job information]
2026-09-01 03:15:11.848444 | # Job Information
2026-09-01 03:15:11.848621 | Ansible Version: 2.16.14
2026-09-01 03:15:11.848654 | Job: python-black
2026-09-01 03:15:11.848682 | Pipeline: periodic-daily
2026-09-01 03:15:11.848701 | Executor: 521e9411259a
2026-09-01 03:15:11.848719 | Triggered by: https://github.com/osism/cinder-driver-dm-clone
2026-09-01 03:15:11.848737 | Event ID: 19b090d6732e4b038226924c83d31cd0
2026-09-01 03:15:11.857361 | 
2026-09-01 03:15:11.857507 | LOOP [emit-job-header : Print node information]
2026-09-01 03:15:12.008126 | debian-bookworm | ok:
2026-09-01 03:15:12.008327 | debian-bookworm | # Node Information
2026-09-01 03:15:12.008359 | debian-bookworm | Inventory Hostname: debian-bookworm
2026-09-01 03:15:12.008380 | debian-bookworm | Hostname: debian
2026-09-01 03:15:12.008399 | debian-bookworm | Username: zuul
2026-09-01 03:15:12.008416 | debian-bookworm | Distro: Debian 12.15
2026-09-01 03:15:12.008436 | debian-bookworm | Provider: regiocloud-a
2026-09-01 03:15:12.008453 | debian-bookworm | Region:
2026-09-01 03:15:12.008471 | debian-bookworm | Label: debian-bookworm
2026-09-01 03:15:12.008486 | debian-bookworm | Product Name: OpenStack Nova
2026-09-01 03:15:12.008613 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe82:a1c4
2026-09-01 03:15:12.026033 | 
2026-09-01 03:15:12.026128 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-01 03:15:12.829835 | debian-bookworm -> localhost | changed
2026-09-01 03:15:12.835502 | 
2026-09-01 03:15:12.835612 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-01 03:15:13.680687 | debian-bookworm -> localhost | changed
2026-09-01 03:15:13.689256 | 
2026-09-01 03:15:13.689341 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-01 03:15:14.005259 | debian-bookworm -> localhost | ok
2026-09-01 03:15:14.011104 | 
2026-09-01 03:15:14.011201 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-01 03:15:14.030669 | debian-bookworm | ok
2026-09-01 03:15:14.051350 | debian-bookworm | included: /var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-01 03:15:14.069606 | 
2026-09-01 03:15:14.069726 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-01 03:15:14.870958 | debian-bookworm -> localhost | Generating public/private rsa key pair.
2026-09-01 03:15:14.871117 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/work/0f64acf609104a7087889a132bd4195d_id_rsa
2026-09-01 03:15:14.871148 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/work/0f64acf609104a7087889a132bd4195d_id_rsa.pub
2026-09-01 03:15:14.871170 | debian-bookworm -> localhost | The key fingerprint is:
2026-09-01 03:15:14.871189 | debian-bookworm -> localhost | SHA256:Xx4iODmP2UNA/52WoCSh1vxI4WtXB2GyxHz3nGG8TLI zuul-build-sshkey
2026-09-01 03:15:14.871208 | debian-bookworm -> localhost | The key's randomart image is:
2026-09-01 03:15:14.871231 | debian-bookworm -> localhost | +---[RSA 3072]----+
2026-09-01 03:15:14.871250 | debian-bookworm -> localhost | |      +oo +. .   |
2026-09-01 03:15:14.871267 | debian-bookworm -> localhost | |     * =o+..o =  |
2026-09-01 03:15:14.871284 | debian-bookworm -> localhost | |    o B +.o..O + |
2026-09-01 03:15:14.871300 | debian-bookworm -> localhost | |   . . X + +Eo*  |
2026-09-01 03:15:14.871316 | debian-bookworm -> localhost | |      O S o B    |
2026-09-01 03:15:14.871336 | debian-bookworm -> localhost | |     . X o = .   |
2026-09-01 03:15:14.871353 | debian-bookworm -> localhost | |      o + . .    |
2026-09-01 03:15:14.871370 | debian-bookworm -> localhost | |         .       |
2026-09-01 03:15:14.871386 | debian-bookworm -> localhost | |                 |
2026-09-01 03:15:14.871403 | debian-bookworm -> localhost | +----[SHA256]-----+
2026-09-01 03:15:14.871442 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.247090
2026-09-01 03:15:14.876480 | 
2026-09-01 03:15:14.876567 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-01 03:15:14.895557 | debian-bookworm | ok
2026-09-01 03:15:14.903550 | debian-bookworm | included: /var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-01 03:15:14.911713 | 
2026-09-01 03:15:14.911778 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-01 03:15:14.923924 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:14.928355 | 
2026-09-01 03:15:14.928426 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-01 03:15:15.522851 | debian-bookworm | changed
2026-09-01 03:15:15.527223 | 
2026-09-01 03:15:15.527295 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-01 03:15:15.749602 | debian-bookworm | ok
2026-09-01 03:15:15.755601 | 
2026-09-01 03:15:15.755696 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-01 03:15:16.363359 | debian-bookworm | changed
2026-09-01 03:15:16.371063 | 
2026-09-01 03:15:16.371170 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-01 03:15:16.993565 | debian-bookworm | changed
2026-09-01 03:15:16.999346 | 
2026-09-01 03:15:16.999444 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-01 03:15:17.022617 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:17.029449 | 
2026-09-01 03:15:17.029566 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-01 03:15:17.406152 | debian-bookworm -> localhost | changed
2026-09-01 03:15:17.417005 | 
2026-09-01 03:15:17.417097 | TASK [add-build-sshkey : Add back temp key]
2026-09-01 03:15:17.684029 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/work/0f64acf609104a7087889a132bd4195d_id_rsa (zuul-build-sshkey)
2026-09-01 03:15:17.684232 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008804
2026-09-01 03:15:17.691842 | 
2026-09-01 03:15:17.691932 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-01 03:15:18.053560 | debian-bookworm | ok
2026-09-01 03:15:18.058667 | 
2026-09-01 03:15:18.058752 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-01 03:15:18.081560 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:18.090919 | 
2026-09-01 03:15:18.091005 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-09-01 03:15:18.478283 | debian-bookworm | ok
2026-09-01 03:15:18.492733 | 
2026-09-01 03:15:18.492831 | TASK [validate-host : Define zuul_info_dir fact]
2026-09-01 03:15:18.534208 | debian-bookworm | ok
2026-09-01 03:15:18.541956 | 
2026-09-01 03:15:18.542068 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-09-01 03:15:18.792044 | debian-bookworm -> localhost | ok
2026-09-01 03:15:18.797994 | 
2026-09-01 03:15:18.798078 | TASK [validate-host : Collect information about the host]
2026-09-01 03:15:19.858081 | debian-bookworm | ok
2026-09-01 03:15:19.874579 | 
2026-09-01 03:15:19.874678 | TASK [validate-host : Sanitize hostname]
2026-09-01 03:15:19.985566 | debian-bookworm | ok
2026-09-01 03:15:19.989718 | 
2026-09-01 03:15:19.989798 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-09-01 03:15:20.488016 | debian-bookworm -> localhost | changed
2026-09-01 03:15:20.497657 | 
2026-09-01 03:15:20.497757 | TASK [validate-host : Collect information about zuul worker]
2026-09-01 03:15:20.868186 | debian-bookworm | ok
2026-09-01 03:15:20.872928 | 
2026-09-01 03:15:20.873017 | TASK [validate-host : Write out all zuul information for each host]
2026-09-01 03:15:21.505955 | debian-bookworm -> localhost | changed
2026-09-01 03:15:21.515565 | 
2026-09-01 03:15:21.515652 | TASK [prepare-workspace-log : Start zuul_console daemon.]
2026-09-01 03:15:21.764200 | debian-bookworm | ok
2026-09-01 03:15:21.769838 | 
2026-09-01 03:15:21.769930 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.]
2026-09-01 03:15:22.491088 | debian-bookworm | changed:
2026-09-01 03:15:22.491254 | debian-bookworm | cd+++++++++ src/
2026-09-01 03:15:22.491286 | debian-bookworm | cd+++++++++ src/github.com/
2026-09-01 03:15:22.491310 | debian-bookworm | cd+++++++++ src/github.com/osism/
2026-09-01 03:15:22.491331 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/
2026-09-01 03:15:22.491351 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.flake8
2026-09-01 03:15:22.491371 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.zuul.yaml
2026-09-01 03:15:22.491389 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/LICENSE
2026-09-01 03:15:22.491408 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/README.md
2026-09-01 03:15:22.491426 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/
2026-09-01 03:15:22.491444 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/HEAD
2026-09-01 03:15:22.491462 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/ORIG_HEAD
2026-09-01 03:15:22.491480 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config
2026-09-01 03:15:22.491498 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config.worktree
2026-09-01 03:15:22.491516 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/description
2026-09-01 03:15:22.491545 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/index
2026-09-01 03:15:22.491564 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/packed-refs
2026-09-01 03:15:22.492167 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/branches/
2026-09-01 03:15:22.492200 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/
2026-09-01 03:15:22.492223 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/applypatch-msg.sample
2026-09-01 03:15:22.492244 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/commit-msg.sample
2026-09-01 03:15:22.492264 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/fsmonitor-watchman.sample
2026-09-01 03:15:22.492283 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/post-update.sample
2026-09-01 03:15:22.492302 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-applypatch.sample
2026-09-01 03:15:22.492319 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-commit.sample
2026-09-01 03:15:22.492337 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-merge-commit.sample
2026-09-01 03:15:22.492354 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-push.sample
2026-09-01 03:15:22.492381 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-rebase.sample
2026-09-01 03:15:22.492400 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-receive.sample
2026-09-01 03:15:22.492417 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/prepare-commit-msg.sample
2026-09-01 03:15:22.492435 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/push-to-checkout.sample
2026-09-01 03:15:22.492452 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/update.sample
2026-09-01 03:15:22.492469 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/
2026-09-01 03:15:22.492487 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/exclude
2026-09-01 03:15:22.492505 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/
2026-09-01 03:15:22.492523 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/HEAD
2026-09-01 03:15:22.492567 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/
2026-09-01 03:15:22.492587 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/
2026-09-01 03:15:22.492605 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/main
2026-09-01 03:15:22.492624 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/
2026-09-01 03:15:22.492641 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/
2026-09-01 03:15:22.492659 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/HEAD
2026-09-01 03:15:22.492677 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/
2026-09-01 03:15:22.492695 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/
2026-09-01 03:15:22.492713 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/0d/e0c7c227616678a99e3704bf81f2c38d105608
2026-09-01 03:15:22.492732 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/
2026-09-01 03:15:22.492749 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/e2c2920ba926041df3295b3280def4c83c4039
2026-09-01 03:15:22.492766 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/16/
2026-09-01 03:15:22.492784 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/16/8cf2de59161d16aca84230f01985a42905a7b0
2026-09-01 03:15:22.492802 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/
2026-09-01 03:15:22.492821 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/459297831c4ce0d7ea29ed8c9114ba146a8527
2026-09-01 03:15:22.492839 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/37/
2026-09-01 03:15:22.492857 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/37/d152c74c15b82ebab993b79af43200da60ef63
2026-09-01 03:15:22.492875 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/
2026-09-01 03:15:22.492892 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/41/9d518cd0ba589205707f1d3188a50d210b7da1
2026-09-01 03:15:22.492910 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/
2026-09-01 03:15:22.492928 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/42/64fde99e36ae8d2d7920ca9140505ae820cccd
2026-09-01 03:15:22.492945 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/
2026-09-01 03:15:22.492966 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/39a1f80707e8577fc545424370aeb556127e44
2026-09-01 03:15:22.492984 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/72/
2026-09-01 03:15:22.493002 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/72/a77304fbd7bb1407dcf01703e9f57b6ff59f76
2026-09-01 03:15:22.493019 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7b/
2026-09-01 03:15:22.493036 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7b/ad2a812a0be73ef3cd7df5f43b238475833ae4
2026-09-01 03:15:22.493054 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/
2026-09-01 03:15:22.493071 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/7d/89c92f3220c6de0136a61d8de5f8a2f5e9a5c7
2026-09-01 03:15:22.493088 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/
2026-09-01 03:15:22.493107 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/08e23220f1962907e5e2f9f2d15728a2a19980
2026-09-01 03:15:22.493125 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/
2026-09-01 03:15:22.493143 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/94/b6642d848334761d7184dd0a767f8e94684589
2026-09-01 03:15:22.493161 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/
2026-09-01 03:15:22.493179 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/ecda1bd613e629b0ab9f19ddf304ab5f994d60
2026-09-01 03:15:22.493196 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/9c/
2026-09-01 03:15:22.493214 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/9c/7974bee70a28d009863af8608cd591403a5af2
2026-09-01 03:15:22.493231 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/a0/
2026-09-01 03:15:22.493249 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/a0/b64b06f000655fc695c453dec57090d919a1c3
2026-09-01 03:15:22.493266 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/
2026-09-01 03:15:22.493283 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/5fb3f40bf64cf874cf6e30b8dd8325d3f72992
2026-09-01 03:15:22.493301 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/
2026-09-01 03:15:22.493318 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/3d086ae32b25aaf6ab01121e7c74a51a08211e
2026-09-01 03:15:22.493335 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/
2026-09-01 03:15:22.493353 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/955504dc1be4f034729e036aac7fd53d85d0e2
2026-09-01 03:15:22.493370 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/
2026-09-01 03:15:22.493387 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/cb/c3439d4d774c22776fb7720414c61d484e3076
2026-09-01 03:15:22.493405 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/
2026-09-01 03:15:22.493422 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/a71bda7721ff0db72982e936c2ab41ce720042
2026-09-01 03:15:22.493440 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f4/
2026-09-01 03:15:22.493457 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f4/a41ab7a35441b30d48c1078e463392c292def3
2026-09-01 03:15:22.493485 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/
2026-09-01 03:15:22.493515 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/fb/65c35f918519fa197bc812e46536717dcbd580
2026-09-01 03:15:22.493556 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/info/
2026-09-01 03:15:22.493585 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/
2026-09-01 03:15:22.493605 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.idx
2026-09-01 03:15:22.493624 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.pack
2026-09-01 03:15:22.493642 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/refs/
2026-09-01 03:15:22.493659 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/
2026-09-01 03:15:22.493677 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/
2026-09-01 03:15:22.493694 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.github/workflows/add-to-project.yml
2026-09-01 03:15:22.493712 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/
2026-09-01 03:15:22.493730 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/
2026-09-01 03:15:22.493747 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/
2026-09-01 03:15:22.493764 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/
2026-09-01 03:15:22.493782 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/__init__.py
2026-09-01 03:15:22.493799 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/dmsetup.py
2026-09-01 03:15:22.493817 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/driver.py
2026-09-01 03:15:22.502885 | 
2026-09-01 03:15:22.502986 | LOOP [ensure-output-dirs-present : Ensure Zuul output directories exist]
2026-09-01 03:15:22.766950 | debian-bookworm | changed: "logs"
2026-09-01 03:15:22.767154 | debian-bookworm | ok: All items complete
2026-09-01 03:15:22.767185 | 
2026-09-01 03:15:22.972294 | debian-bookworm | changed: "artifacts"
2026-09-01 03:15:23.196958 | debian-bookworm | changed: "docs"
2026-09-01 03:15:23.212665 | 
2026-09-01 03:15:23.212767 | TASK [diagnose-first-sudo : Ensure log directory exists]
2026-09-01 03:15:23.441356 | debian-bookworm | ok
2026-09-01 03:15:23.446251 | 
2026-09-01 03:15:23.446336 | TASK [diagnose-first-sudo : Probe first sudo invocation under strace]
2026-09-01 03:15:23.972212 | debian-bookworm | ok: Runtime: 0:00:00.054799
2026-09-01 03:15:23.984210 | 
2026-09-01 03:15:23.984365 | TASK [diagnose-first-sudo : Snapshot DNS / PAM / logind state (no become)]
2026-09-01 03:15:24.517545 | debian-bookworm | ok: Runtime: 0:00:00.118547
2026-09-01 03:15:24.525034 | 
2026-09-01 03:15:24.525121 | TASK [diagnose-network : Ensure log directory exists]
2026-09-01 03:15:24.774927 | debian-bookworm | ok
2026-09-01 03:15:24.780805 | 
2026-09-01 03:15:24.780897 | TASK [diagnose-network : Snapshot dual-stack network state (pre)]
2026-09-01 03:15:36.165035 | debian-bookworm | ok: Runtime: 0:00:05.955314
2026-09-01 03:15:36.172758 | 
2026-09-01 03:15:36.172882 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)]
2026-09-01 03:15:36.234026 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:36.242733 | 
2026-09-01 03:15:36.242899 | TASK [diagnose-network : Probe container network namespace (teardown)]
2026-09-01 03:15:36.299243 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:36.307661 | 
2026-09-01 03:15:36.307755 | PLAY RECAP
2026-09-01 03:15:36.308030 | debian-bookworm | ok: 32 changed: 12 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-09-01 03:15:36.308077 | 
2026-09-01 03:15:36.609077 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-09-01 03:15:36.609976 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-09-01 03:15:37.503706 | 
2026-09-01 03:15:37.503915 | PLAY [Install Black and format code]
2026-09-01 03:15:37.523210 | 
2026-09-01 03:15:37.523351 | LOOP [Install python]
2026-09-01 03:15:37.569928 | debian-bookworm | ok: "ensure-python"
2026-09-01 03:15:37.587733 | debian-bookworm | ok: "ensure-pip"
2026-09-01 03:15:37.650499 | 
2026-09-01 03:15:37.650686 | TASK [ensure-python : Validate python_version value]
2026-09-01 03:15:37.698122 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:37.707590 | 
2026-09-01 03:15:37.707730 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-09-01 03:15:37.742365 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:37.749370 | 
2026-09-01 03:15:37.749501 | TASK [ensure-python : Pull in venv package]
2026-09-01 03:15:37.790942 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:37.799177 | 
2026-09-01 03:15:37.799339 | TASK [ensure-python : Set default RPM package name]
2026-09-01 03:15:37.824944 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:37.830611 | 
2026-09-01 03:15:37.830727 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-09-01 03:15:37.875847 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:37.884906 | 
2026-09-01 03:15:37.885040 | TASK [ensure-python : Install RPM package]
2026-09-01 03:15:37.928910 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:37.946634 | 
2026-09-01 03:15:37.946767 | TASK [ensure-python : Install python using pyenv]
2026-09-01 03:15:37.986546 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:37.994788 | 
2026-09-01 03:15:37.994923 | TASK [ensure-python : Activate python using stow]
2026-09-01 03:15:38.041747 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:38.059742 | 
2026-09-01 03:15:38.059874 | TASK [ensure-pip : Check if pip is installed]
2026-09-01 03:15:39.140552 | debian-bookworm | ok: Runtime: 0:00:00.007638
2026-09-01 03:15:39.145096 | 
2026-09-01 03:15:39.145175 | LOOP [ensure-pip : Install pip from packages]
2026-09-01 03:15:39.165233 | debian-bookworm | ok: "/var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-09-01 03:15:39.165464 | debian-bookworm | ok: All items complete
2026-09-01 03:15:39.165509 | 
2026-09-01 03:15:39.173114 | debian-bookworm | included: /var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-09-01 03:15:39.182411 | 
2026-09-01 03:15:39.182490 | TASK [ensure-pip : Update package lists]
2026-09-01 03:15:43.008206 | debian-bookworm | changed
2026-09-01 03:15:43.017972 | 
2026-09-01 03:15:43.018081 | TASK [ensure-pip : Install Python 3 pip]
2026-09-01 03:15:47.619133 | debian-bookworm | changed
2026-09-01 03:15:47.625620 | 
2026-09-01 03:15:47.625709 | TASK [ensure-pip : Install Python 2 pip]
2026-09-01 03:15:47.700127 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:47.705909 | 
2026-09-01 03:15:47.706084 | TASK [ensure-pip : Ensure setuptools]
2026-09-01 03:15:47.729043 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:47.736118 | 
2026-09-01 03:15:47.736204 | TASK [ensure-pip : Check for ensurepip module]
2026-09-01 03:15:48.057106 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-09-01 03:15:48.057312 | debian-bookworm |                            [--altinstall] [--default-pip]
2026-09-01 03:15:48.057349 | debian-bookworm |
2026-09-01 03:15:48.057373 | debian-bookworm | options:
2026-09-01 03:15:48.057402 | debian-bookworm |   -h, --help     show this help message and exit
2026-09-01 03:15:48.057434 | debian-bookworm |   --version      Show the version of pip that is bundled with this Python.
2026-09-01 03:15:48.057459 | debian-bookworm |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-09-01 03:15:48.057525 | debian-bookworm |                  times.
2026-09-01 03:15:48.057564 | debian-bookworm |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-09-01 03:15:48.057588 | debian-bookworm |   --user         Install using the user scheme.
2026-09-01 03:15:48.057611 | debian-bookworm |   --root ROOT    Install everything relative to this alternate root directory.
2026-09-01 03:15:48.057629 | debian-bookworm |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-09-01 03:15:48.057641 | debian-bookworm |                  scripts (Default: pipX, pipX.Y, easy_install-X.Y).
2026-09-01 03:15:48.057652 | debian-bookworm |   --default-pip  Make a default pip install, installing the unqualified pip
2026-09-01 03:15:48.057664 | debian-bookworm |                  and easy_install in addition to the versioned scripts.
2026-09-01 03:15:48.272487 | debian-bookworm | ok: Runtime: 0:00:00.083299
2026-09-01 03:15:48.278219 | 
2026-09-01 03:15:48.278306 | TASK [ensure-pip : Ensure python3-venv]
2026-09-01 03:15:48.291236 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:48.297264 | 
2026-09-01 03:15:48.297363 | TASK [ensure-pip : Install pip from source]
2026-09-01 03:15:48.311466 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:48.316643 | 
2026-09-01 03:15:48.316725 | TASK [ensure-pip : Probe for venv python full path]
2026-09-01 03:15:48.639882 | debian-bookworm | /usr/bin/python3
2026-09-01 03:15:48.844473 | debian-bookworm | ok: Runtime: 0:00:00.007329
2026-09-01 03:15:48.859201 | 
2026-09-01 03:15:48.859367 | TASK [ensure-pip : Set host default]
2026-09-01 03:15:48.922371 | debian-bookworm | ok
2026-09-01 03:15:48.930152 | 
2026-09-01 03:15:48.930283 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-09-01 03:15:48.983204 | debian-bookworm | ok
2026-09-01 03:15:49.019065 | 
2026-09-01 03:15:49.019156 | TASK [python-black : Install black]
2026-09-01 03:15:55.471707 | debian-bookworm | changed
2026-09-01 03:15:55.485370 | 
2026-09-01 03:15:55.485466 | TASK [python-black : Format code with Black if there is nothing to exclude]
2026-09-01 03:15:56.176858 | debian-bookworm | All done! ✨ 🍰 ✨
2026-09-01 03:15:56.176943 | debian-bookworm | 3 files would be left unchanged.
2026-09-01 03:15:56.518309 | debian-bookworm | ok: Runtime: 0:00:00.419148
2026-09-01 03:15:56.527573 | 
2026-09-01 03:15:56.527663 | TASK [python-black : Format code with Black if there is an exclusion]
2026-09-01 03:15:57.074781 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:15:57.084691 | 
2026-09-01 03:15:57.084790 | PLAY RECAP
2026-09-01 03:15:57.084848 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2026-09-01 03:15:57.084873 | 
2026-09-01 03:15:57.271058 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-09-01 03:15:57.272010 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-09-01 03:15:58.124936 | 
2026-09-01 03:15:58.125096 | PLAY [Base post-fetch]
2026-09-01 03:15:58.139437 | 
2026-09-01 03:15:58.139583 | TASK [diagnose-network : Ensure log directory exists]
2026-09-01 03:15:58.513359 | debian-bookworm | ok
2026-09-01 03:15:58.521946 | 
2026-09-01 03:15:58.522103 | TASK [diagnose-network : Snapshot dual-stack network state (post)]
2026-09-01 03:16:10.256567 | debian-bookworm | ok: Runtime: 0:00:05.939244
2026-09-01 03:16:10.263205 | 
2026-09-01 03:16:10.263333 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)]
2026-09-01 03:16:16.489585 | debian-bookworm | ok: Runtime: 0:00:00.008751
2026-09-01 03:16:16.494231 | 
2026-09-01 03:16:16.494316 | TASK [diagnose-network : Probe container network namespace (teardown)]
2026-09-01 03:16:22.649552 | debian-bookworm | ok: Runtime: 0:00:00.008484
2026-09-01 03:16:22.664940 | 
2026-09-01 03:16:22.665436 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-01 03:16:22.706260 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:16:22.711227 | 
2026-09-01 03:16:22.711325 | TASK [fetch-output : Set log path for single node]
2026-09-01 03:16:22.740188 | debian-bookworm | ok
2026-09-01 03:16:22.744313 | 
2026-09-01 03:16:22.744396 | LOOP [fetch-output : Ensure local output dirs]
2026-09-01 03:16:23.093822 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/work/logs"
2026-09-01 03:16:23.352996 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/work/artifacts"
2026-09-01 03:16:23.564820 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0f64acf609104a7087889a132bd4195d/work/docs"
2026-09-01 03:16:23.578048 | 
2026-09-01 03:16:23.578138 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-01 03:16:24.286178 | debian-bookworm | changed:
2026-09-01 03:16:24.286335 | debian-bookworm | .d..t...... ./
2026-09-01 03:16:24.286362 | debian-bookworm | >f+++++++++ net-debug.post.txt
2026-09-01 03:16:24.286382 | debian-bookworm | >f+++++++++ net-debug.pre.txt
2026-09-01 03:16:24.286399 | debian-bookworm | >f+++++++++ sudo-debug.txt
2026-09-01 03:16:24.286415 | debian-bookworm | >f+++++++++ sudo-strace.log
2026-09-01 03:16:24.286432 | debian-bookworm | >f+++++++++ sudo-strace.log.time
2026-09-01 03:16:24.286465 | debian-bookworm | changed: All items complete
2026-09-01 03:16:24.286486 | 
2026-09-01 03:16:24.980963 | debian-bookworm | changed: .d..t...... ./
2026-09-01 03:16:25.796494 | debian-bookworm | changed: .d..t...... ./
2026-09-01 03:16:25.823567 | 
2026-09-01 03:16:25.823660 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-01 03:16:25.849954 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:16:25.854761 | debian-bookworm | skipping: Conditional result was False
2026-09-01 03:16:25.868781 | 
2026-09-01 03:16:25.868845 | PLAY RECAP
2026-09-01 03:16:25.868886 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-09-01 03:16:25.868905 | 
2026-09-01 03:16:26.031748 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-09-01 03:16:26.032372 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-09-01 03:16:27.260301 | 
2026-09-01 03:16:27.260414 | PLAY [Base post]
2026-09-01 03:16:27.284680 | 
2026-09-01 03:16:27.284791 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-01 03:16:27.930671 | debian-bookworm | changed
2026-09-01 03:16:27.937200 | 
2026-09-01 03:16:27.937288 | PLAY RECAP
2026-09-01 03:16:27.937344 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-01 03:16:27.937435 | 
2026-09-01 03:16:28.032730 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-09-01 03:16:28.033441 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-01 03:16:28.737929 | 
2026-09-01 03:16:28.738040 | PLAY [Base post-logs]
2026-09-01 03:16:28.762367 | 
2026-09-01 03:16:28.762474 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-01 03:16:29.688838 | localhost | changed
2026-09-01 03:16:29.702635 | 
2026-09-01 03:16:29.702768 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-01 03:16:29.728418 | localhost | ok
2026-09-01 03:16:29.731938 | 
2026-09-01 03:16:29.732027 | TASK [Set zuul-log-path fact]
2026-09-01 03:16:29.746202 | localhost | ok
2026-09-01 03:16:29.753554 | 
2026-09-01 03:16:29.753646 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-01 03:16:29.777839 | localhost | ok
2026-09-01 03:16:29.780582 | 
2026-09-01 03:16:29.780664 | TASK [upload-logs : Create log directories]
2026-09-01 03:16:30.447888 | localhost | changed
2026-09-01 03:16:30.449967 | 
2026-09-01 03:16:30.450040 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-01 03:16:30.988932 | localhost -> localhost | ok: Runtime: 0:00:00.005369
2026-09-01 03:16:30.995068 | 
2026-09-01 03:16:30.995165 | TASK [upload-logs : Upload logs to log server]
2026-09-01 03:16:31.733763 | localhost | Output suppressed because no_log was given
2026-09-01 03:16:31.735110 | 
2026-09-01 03:16:31.735178 | LOOP [upload-logs : Compress console log and json output]
2026-09-01 03:16:31.783486 | localhost | skipping: Conditional result was False
2026-09-01 03:16:31.788563 | localhost | skipping: Conditional result was False
2026-09-01 03:16:31.799681 | 
2026-09-01 03:16:31.799768 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-01 03:16:31.868031 | localhost | skipping: Conditional result was False
2026-09-01 03:16:31.868227 | 
2026-09-01 03:16:31.879611 | localhost | skipping: Conditional result was False
2026-09-01 03:16:31.884317 | 
2026-09-01 03:16:31.884394 | LOOP [upload-logs : Upload console log and json output]