2026-04-29 03:15:44.772693 | Job console starting
2026-04-29 03:15:44.786327 | Updating git repos
2026-04-29 03:15:44.840211 | Cloning repos into workspace
2026-04-29 03:15:44.887215 | Restoring repo states
2026-04-29 03:15:44.909452 | Merging changes
2026-04-29 03:15:44.909469 | Checking out repos
2026-04-29 03:15:44.971686 | Preparing playbooks
2026-04-29 03:15:46.217163 | Running Ansible setup
2026-04-29 03:15:50.547749 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-04-29 03:15:51.216508 | 
2026-04-29 03:15:51.216638 | PLAY [Base pre]
2026-04-29 03:15:51.234264 | 
2026-04-29 03:15:51.234377 | TASK [Setup log path fact]
2026-04-29 03:15:51.262916 | debian-bookworm | ok
2026-04-29 03:15:51.282825 | 
2026-04-29 03:15:51.282973 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-29 03:15:51.320656 | debian-bookworm | ok
2026-04-29 03:15:51.330130 | 
2026-04-29 03:15:51.330232 | TASK [emit-job-header : Print job information]
2026-04-29 03:15:51.358968 | # Job Information
2026-04-29 03:15:51.359176 | Ansible Version: 2.16.14
2026-04-29 03:15:51.359212 | Job: python-black
2026-04-29 03:15:51.359246 | Pipeline: periodic-daily
2026-04-29 03:15:51.359269 | Executor: 521e9411259a
2026-04-29 03:15:51.359291 | Triggered by: https://github.com/osism/cinder-driver-dm-clone
2026-04-29 03:15:51.359314 | Event ID: 06460e738595488ba2ae820fef51a7af
2026-04-29 03:15:51.364208 | 
2026-04-29 03:15:51.364322 | LOOP [emit-job-header : Print node information]
2026-04-29 03:15:51.478895 | debian-bookworm | ok:
2026-04-29 03:15:51.479063 | debian-bookworm | # Node Information
2026-04-29 03:15:51.479099 | debian-bookworm | Inventory Hostname: debian-bookworm
2026-04-29 03:15:51.479126 | debian-bookworm | Hostname: debian
2026-04-29 03:15:51.479149 | debian-bookworm | Username: zuul
2026-04-29 03:15:51.479171 | debian-bookworm | Distro: Debian 12.13
2026-04-29 03:15:51.479194 | debian-bookworm | Provider: regiocloud-a
2026-04-29 03:15:51.479215 | debian-bookworm | Region:
2026-04-29 03:15:51.479236 | debian-bookworm | Label: debian-bookworm
2026-04-29 03:15:51.479257 | debian-bookworm | Product Name: OpenStack Nova
2026-04-29 03:15:51.479277 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3a:c314
2026-04-29 03:15:51.490567 | 
2026-04-29 03:15:51.490674 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-29 03:15:51.941702 | debian-bookworm -> localhost | changed
2026-04-29 03:15:51.948488 | 
2026-04-29 03:15:51.948592 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-29 03:15:53.438606 | debian-bookworm -> localhost | changed
2026-04-29 03:15:53.461426 | 
2026-04-29 03:15:53.461894 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-29 03:15:53.903853 | debian-bookworm -> localhost | ok
2026-04-29 03:15:53.909828 | 
2026-04-29 03:15:53.909932 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-29 03:15:53.939452 | debian-bookworm | ok
2026-04-29 03:15:53.957037 | debian-bookworm | included: /var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-29 03:15:53.963510 | 
2026-04-29 03:15:53.963615 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-29 03:15:55.321673 | debian-bookworm -> localhost | Generating public/private rsa key pair.
2026-04-29 03:15:55.321969 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/work/f41ce205ea384dad9afb795c5150cb48_id_rsa
2026-04-29 03:15:55.322011 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/work/f41ce205ea384dad9afb795c5150cb48_id_rsa.pub
2026-04-29 03:15:55.322038 | debian-bookworm -> localhost | The key fingerprint is:
2026-04-29 03:15:55.322063 | debian-bookworm -> localhost | SHA256:GSnnaVvobJ0gv0zkZn6JU9ObN8VpXxJ3Jaez4t1I0r0 zuul-build-sshkey
2026-04-29 03:15:55.322085 | debian-bookworm -> localhost | The key's randomart image is:
2026-04-29 03:15:55.322116 | debian-bookworm -> localhost | +---[RSA 3072]----+
2026-04-29 03:15:55.322138 | debian-bookworm -> localhost | |                 |
2026-04-29 03:15:55.322159 | debian-bookworm -> localhost | |         .    . o|
2026-04-29 03:15:55.322180 | debian-bookworm -> localhost | |      . +      +.|
2026-04-29 03:15:55.322200 | debian-bookworm -> localhost | |       + =    + o|
2026-04-29 03:15:55.322219 | debian-bookworm -> localhost | |      . S .. . Bo|
2026-04-29 03:15:55.322241 | debian-bookworm -> localhost | |       O =o.+ =o=|
2026-04-29 03:15:55.322261 | debian-bookworm -> localhost | |        @oo+ B.=+|
2026-04-29 03:15:55.322281 | debian-bookworm -> localhost | |       Bo.o + =Eo|
2026-04-29 03:15:55.322302 | debian-bookworm -> localhost | |        +o   . . |
2026-04-29 03:15:55.322322 | debian-bookworm -> localhost | +----[SHA256]-----+
2026-04-29 03:15:55.322377 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.651682
2026-04-29 03:15:55.329544 | 
2026-04-29 03:15:55.329637 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-29 03:15:55.357403 | debian-bookworm | ok
2026-04-29 03:15:55.369443 | debian-bookworm | included: /var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-29 03:15:55.379211 | 
2026-04-29 03:15:55.379308 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-29 03:15:55.392434 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:15:55.400131 | 
2026-04-29 03:15:55.400258 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-29 03:15:56.044792 | debian-bookworm | changed
2026-04-29 03:15:56.050250 | 
2026-04-29 03:15:56.050332 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-29 03:15:56.271709 | debian-bookworm | ok
2026-04-29 03:15:56.278103 | 
2026-04-29 03:15:56.278195 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-29 03:15:56.895101 | debian-bookworm | changed
2026-04-29 03:15:56.901845 | 
2026-04-29 03:15:56.901939 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-29 03:15:57.507276 | debian-bookworm | changed
2026-04-29 03:15:57.512580 | 
2026-04-29 03:15:57.512664 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-29 03:15:57.525364 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:15:57.531431 | 
2026-04-29 03:15:57.531529 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-29 03:15:57.983285 | debian-bookworm -> localhost | changed
2026-04-29 03:15:57.996666 | 
2026-04-29 03:15:57.996794 | TASK [add-build-sshkey : Add back temp key]
2026-04-29 03:15:58.348463 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/work/f41ce205ea384dad9afb795c5150cb48_id_rsa (zuul-build-sshkey)
2026-04-29 03:15:58.348814 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015704
2026-04-29 03:15:58.358920 | 
2026-04-29 03:15:58.359018 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-29 03:15:58.823690 | debian-bookworm | ok
2026-04-29 03:15:58.831158 | 
2026-04-29 03:15:58.831260 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-29 03:15:58.879944 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:15:58.891935 | 
2026-04-29 03:15:58.892036 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-04-29 03:15:59.406384 | debian-bookworm | ok
2026-04-29 03:15:59.421248 | 
2026-04-29 03:15:59.421359 | TASK [validate-host : Define zuul_info_dir fact]
2026-04-29 03:15:59.502280 | debian-bookworm | ok
2026-04-29 03:15:59.507703 | 
2026-04-29 03:15:59.507819 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-04-29 03:16:00.051238 | debian-bookworm -> localhost | ok
2026-04-29 03:16:00.058173 | 
2026-04-29 03:16:00.058280 | TASK [validate-host : Collect information about the host]
2026-04-29 03:16:01.208513 | debian-bookworm | ok
2026-04-29 03:16:01.241732 | 
2026-04-29 03:16:01.241869 | TASK [validate-host : Sanitize hostname]
2026-04-29 03:16:01.352322 | debian-bookworm | ok
2026-04-29 03:16:01.386894 | 
2026-04-29 03:16:01.387032 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-04-29 03:16:02.383167 | debian-bookworm -> localhost | changed
2026-04-29 03:16:02.389785 | 
2026-04-29 03:16:02.389889 | TASK [validate-host : Collect information about zuul worker]
2026-04-29 03:16:02.827252 | debian-bookworm | ok
2026-04-29 03:16:02.831857 | 
2026-04-29 03:16:02.831947 | TASK [validate-host : Write out all zuul information for each host]
2026-04-29 03:16:03.654267 | debian-bookworm -> localhost | changed
2026-04-29 03:16:03.666861 | 
2026-04-29 03:16:03.666963 | TASK [prepare-workspace-log : Start zuul_console daemon.]
2026-04-29 03:16:03.952501 | debian-bookworm | ok
2026-04-29 03:16:03.957930 | 
2026-04-29 03:16:03.958022 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.]
2026-04-29 03:16:04.961427 | debian-bookworm | changed:
2026-04-29 03:16:04.961601 | debian-bookworm | cd+++++++++ src/
2026-04-29 03:16:04.961636 | debian-bookworm | cd+++++++++ src/github.com/
2026-04-29 03:16:04.961660 | debian-bookworm | cd+++++++++ src/github.com/osism/
2026-04-29 03:16:04.961681 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/
2026-04-29 03:16:04.961702 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.flake8
2026-04-29 03:16:04.961722 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.zuul.yaml
2026-04-29 03:16:04.961751 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/LICENSE
2026-04-29 03:16:04.961771 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/README.md
2026-04-29 03:16:04.961789 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/
2026-04-29 03:16:04.961807 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/HEAD
2026-04-29 03:16:04.961827 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/ORIG_HEAD
2026-04-29 03:16:04.961854 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config
2026-04-29 03:16:04.961873 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/config.worktree
2026-04-29 03:16:04.961892 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/description
2026-04-29 03:16:04.961910 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/index
2026-04-29 03:16:04.961928 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/packed-refs
2026-04-29 03:16:04.961946 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/branches/
2026-04-29 03:16:04.961964 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/
2026-04-29 03:16:04.961982 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/applypatch-msg.sample
2026-04-29 03:16:04.962001 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/commit-msg.sample
2026-04-29 03:16:04.962019 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/fsmonitor-watchman.sample
2026-04-29 03:16:04.962037 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/post-update.sample
2026-04-29 03:16:04.962055 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-applypatch.sample
2026-04-29 03:16:04.962074 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-commit.sample
2026-04-29 03:16:04.962091 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-merge-commit.sample
2026-04-29 03:16:04.962109 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-push.sample
2026-04-29 03:16:04.962136 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-rebase.sample
2026-04-29 03:16:04.962155 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/pre-receive.sample
2026-04-29 03:16:04.962173 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/prepare-commit-msg.sample
2026-04-29 03:16:04.962190 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/push-to-checkout.sample
2026-04-29 03:16:04.962208 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/hooks/update.sample
2026-04-29 03:16:04.962225 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/
2026-04-29 03:16:04.962243 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/info/exclude
2026-04-29 03:16:04.962261 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/
2026-04-29 03:16:04.962278 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/HEAD
2026-04-29 03:16:04.962296 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/
2026-04-29 03:16:04.962313 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/
2026-04-29 03:16:04.962331 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/heads/main
2026-04-29 03:16:04.962348 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/
2026-04-29 03:16:04.962366 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/
2026-04-29 03:16:04.962384 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/logs/refs/remotes/origin/HEAD
2026-04-29 03:16:04.962401 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/
2026-04-29 03:16:04.962421 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/
2026-04-29 03:16:04.962445 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/14/e2c2920ba926041df3295b3280def4c83c4039
2026-04-29 03:16:04.962468 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/
2026-04-29 03:16:04.962486 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/20/459297831c4ce0d7ea29ed8c9114ba146a8527
2026-04-29 03:16:04.962504 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/
2026-04-29 03:16:04.968261 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/53/39a1f80707e8577fc545424370aeb556127e44
2026-04-29 03:16:04.968350 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/
2026-04-29 03:16:04.968381 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/80/08e23220f1962907e5e2f9f2d15728a2a19980
2026-04-29 03:16:04.968404 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/
2026-04-29 03:16:04.968425 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/95/ecda1bd613e629b0ab9f19ddf304ab5f994d60
2026-04-29 03:16:04.968446 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/
2026-04-29 03:16:04.968465 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b2/5fb3f40bf64cf874cf6e30b8dd8325d3f72992
2026-04-29 03:16:04.968485 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/
2026-04-29 03:16:04.968504 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/b7/3d086ae32b25aaf6ab01121e7c74a51a08211e
2026-04-29 03:16:04.968523 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/
2026-04-29 03:16:04.968551 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/ca/955504dc1be4f034729e036aac7fd53d85d0e2
2026-04-29 03:16:04.968571 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/
2026-04-29 03:16:04.968590 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/f1/a71bda7721ff0db72982e936c2ab41ce720042
2026-04-29 03:16:04.968609 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/info/
2026-04-29 03:16:04.968628 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/
2026-04-29 03:16:04.968646 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.idx
2026-04-29 03:16:04.968669 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/objects/pack/pack-fa180ec00da9f01d74bd13ec6c07652e2e797814.pack
2026-04-29 03:16:04.968688 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/.git/refs/
2026-04-29 03:16:04.968707 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/
2026-04-29 03:16:04.968727 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/
2026-04-29 03:16:04.968761 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/
2026-04-29 03:16:04.968781 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/
2026-04-29 03:16:04.968801 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/__init__.py
2026-04-29 03:16:04.968820 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/dmsetup.py
2026-04-29 03:16:04.968839 | debian-bookworm | <f+++++++++ src/github.com/osism/cinder-driver-dm-clone/cinder/volume/drivers/dmclone/driver.py
2026-04-29 03:16:04.977656 | 
2026-04-29 03:16:04.977776 | LOOP [ensure-output-dirs-present : Ensure Zuul output directories exist]
2026-04-29 03:16:05.302993 | debian-bookworm | changed: "logs"
2026-04-29 03:16:05.303237 | debian-bookworm | ok: All items complete
2026-04-29 03:16:05.303275 | 
2026-04-29 03:16:05.540792 | debian-bookworm | changed: "artifacts"
2026-04-29 03:16:05.720872 | debian-bookworm | changed: "docs"
2026-04-29 03:16:05.739973 | 
2026-04-29 03:16:05.740086 | TASK [diagnose-first-sudo : Ensure log directory exists]
2026-04-29 03:16:05.967482 | debian-bookworm | ok
2026-04-29 03:16:05.974695 | 
2026-04-29 03:16:05.974813 | TASK [diagnose-first-sudo : Probe first sudo invocation under strace]
2026-04-29 03:16:06.507149 | debian-bookworm | ok: Runtime: 0:00:00.061242
2026-04-29 03:16:06.512886 | 
2026-04-29 03:16:06.512999 | TASK [diagnose-first-sudo : Snapshot DNS / PAM / logind state (no become)]
2026-04-29 03:16:07.060992 | debian-bookworm | ok: Runtime: 0:00:00.085532
2026-04-29 03:16:07.066670 | 
2026-04-29 03:16:07.066776 | PLAY RECAP
2026-04-29 03:16:07.066845 | debian-bookworm | ok: 30 changed: 14 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-29 03:16:07.066872 | 
2026-04-29 03:16:07.303996 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main]
2026-04-29 03:16:07.304776 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-04-29 03:16:08.079916 | 
2026-04-29 03:16:08.080046 | PLAY [Install Black and format code]
2026-04-29 03:16:08.126548 | 
2026-04-29 03:16:08.126667 | LOOP [Install python]
2026-04-29 03:16:08.161156 | debian-bookworm | ok: "ensure-python"
2026-04-29 03:16:08.172026 | debian-bookworm | ok: "ensure-pip"
2026-04-29 03:16:08.258586 | 
2026-04-29 03:16:08.258727 | TASK [ensure-python : Validate python_version value]
2026-04-29 03:16:08.304711 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:08.310697 | 
2026-04-29 03:16:08.310817 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-04-29 03:16:08.343962 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:08.349550 | 
2026-04-29 03:16:08.349652 | TASK [ensure-python : Pull in venv package]
2026-04-29 03:16:08.392769 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:08.398932 | 
2026-04-29 03:16:08.399046 | TASK [ensure-python : Set default RPM package name]
2026-04-29 03:16:08.438470 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:08.444177 | 
2026-04-29 03:16:08.444286 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9 and Python 3.9]
2026-04-29 03:16:08.497976 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:08.505375 | 
2026-04-29 03:16:08.505483 | TASK [ensure-python : Install RPM package]
2026-04-29 03:16:08.548473 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:08.554343 | 
2026-04-29 03:16:08.554440 | TASK [ensure-python : Install python using pyenv]
2026-04-29 03:16:08.587468 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:08.593975 | 
2026-04-29 03:16:08.594084 | TASK [ensure-python : Activate python using stow]
2026-04-29 03:16:08.647235 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:08.657603 | 
2026-04-29 03:16:08.657718 | TASK [ensure-pip : Check if pip is installed]
2026-04-29 03:16:09.234529 | debian-bookworm | ok: Runtime: 0:00:00.005953
2026-04-29 03:16:09.240696 | 
2026-04-29 03:16:09.240830 | LOOP [ensure-pip : Install pip from packages]
2026-04-29 03:16:09.267240 | debian-bookworm | ok: "/var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-04-29 03:16:09.267445 | debian-bookworm | ok: All items complete
2026-04-29 03:16:09.267478 | 
2026-04-29 03:16:09.284378 | debian-bookworm | included: /var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-04-29 03:16:09.298451 | 
2026-04-29 03:16:09.298558 | TASK [ensure-pip : Update package lists]
2026-04-29 03:16:13.252548 | debian-bookworm | changed
2026-04-29 03:16:13.259000 | 
2026-04-29 03:16:13.259113 | TASK [ensure-pip : Install Python 3 pip]
2026-04-29 03:16:17.811014 | debian-bookworm | changed
2026-04-29 03:16:17.818730 | 
2026-04-29 03:16:17.818857 | TASK [ensure-pip : Install Python 2 pip]
2026-04-29 03:16:17.862544 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:17.877928 | 
2026-04-29 03:16:17.878086 | TASK [ensure-pip : Ensure setuptools]
2026-04-29 03:16:17.892108 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:17.908814 | 
2026-04-29 03:16:17.908957 | TASK [ensure-pip : Check for ensurepip module]
2026-04-29 03:16:18.223828 | debian-bookworm | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-04-29 03:16:18.223968 | debian-bookworm |                            [--altinstall] [--default-pip]
2026-04-29 03:16:18.223987 | debian-bookworm |
2026-04-29 03:16:18.224009 | debian-bookworm | options:
2026-04-29 03:16:18.224034 | debian-bookworm |   -h, --help     show this help message and exit
2026-04-29 03:16:18.224062 | debian-bookworm |   --version      Show the version of pip that is bundled with this Python.
2026-04-29 03:16:18.224081 | debian-bookworm |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-04-29 03:16:18.224132 | debian-bookworm |                  times.
2026-04-29 03:16:18.224166 | debian-bookworm |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-04-29 03:16:18.224186 | debian-bookworm |   --user         Install using the user scheme.
2026-04-29 03:16:18.224203 | debian-bookworm |   --root ROOT    Install everything relative to this alternate root directory.
2026-04-29 03:16:18.224214 | debian-bookworm |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-04-29 03:16:18.224225 | debian-bookworm |                  scripts (Default: pipX, pipX.Y, easy_install-X.Y).
2026-04-29 03:16:18.224235 | debian-bookworm |   --default-pip  Make a default pip install, installing the unqualified pip
2026-04-29 03:16:18.224245 | debian-bookworm |                  and easy_install in addition to the versioned scripts.
2026-04-29 03:16:18.439287 | debian-bookworm | ok: Runtime: 0:00:00.087174
2026-04-29 03:16:18.445241 | 
2026-04-29 03:16:18.445327 | TASK [ensure-pip : Ensure python3-venv]
2026-04-29 03:16:18.468293 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:18.473862 | 
2026-04-29 03:16:18.473952 | TASK [ensure-pip : Install pip from source]
2026-04-29 03:16:18.497180 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:18.510336 | 
2026-04-29 03:16:18.510485 | TASK [ensure-pip : Probe for venv python full path]
2026-04-29 03:16:18.764842 | debian-bookworm | /usr/bin/python3
2026-04-29 03:16:19.041893 | debian-bookworm | ok: Runtime: 0:00:00.007020
2026-04-29 03:16:19.054796 | 
2026-04-29 03:16:19.054968 | TASK [ensure-pip : Set host default]
2026-04-29 03:16:19.133205 | debian-bookworm | ok
2026-04-29 03:16:19.142059 | 
2026-04-29 03:16:19.142185 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-04-29 03:16:19.205138 | debian-bookworm | ok
2026-04-29 03:16:19.252702 | 
2026-04-29 03:16:19.252816 | TASK [python-black : Install black]
2026-04-29 03:16:25.679228 | debian-bookworm | changed
2026-04-29 03:16:25.687104 | 
2026-04-29 03:16:25.687214 | TASK [python-black : Format code with Black if there is nothing to exclude]
2026-04-29 03:16:26.310006 | debian-bookworm | All done! ✨ 🍰 ✨
2026-04-29 03:16:26.310080 | debian-bookworm | 3 files would be left unchanged.
2026-04-29 03:16:26.718635 | debian-bookworm | ok: Runtime: 0:00:00.420407
2026-04-29 03:16:26.731120 | 
2026-04-29 03:16:26.731309 | TASK [python-black : Format code with Black if there is an exclusion]
2026-04-29 03:16:27.263048 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:27.278881 | 
2026-04-29 03:16:27.279013 | PLAY RECAP
2026-04-29 03:16:27.279102 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 0 skipped: 13 rescued: 0 ignored: 0
2026-04-29 03:16:27.279147 | 
2026-04-29 03:16:27.387486 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main]
2026-04-29 03:16:27.388811 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-04-29 03:16:28.100523 | 
2026-04-29 03:16:28.100649 | PLAY [Base post-fetch]
2026-04-29 03:16:28.115518 | 
2026-04-29 03:16:28.115663 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-29 03:16:28.171421 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:28.178767 | 
2026-04-29 03:16:28.178911 | TASK [fetch-output : Set log path for single node]
2026-04-29 03:16:28.207944 | debian-bookworm | ok
2026-04-29 03:16:28.213610 | 
2026-04-29 03:16:28.213711 | LOOP [fetch-output : Ensure local output dirs]
2026-04-29 03:16:28.942252 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/work/logs"
2026-04-29 03:16:29.350769 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/work/artifacts"
2026-04-29 03:16:29.641432 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f41ce205ea384dad9afb795c5150cb48/work/docs"
2026-04-29 03:16:29.660047 | 
2026-04-29 03:16:29.660149 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-29 03:16:30.522110 | debian-bookworm | changed:
2026-04-29 03:16:30.522309 | debian-bookworm | .d..t...... ./
2026-04-29 03:16:30.522344 | debian-bookworm | >f+++++++++ sudo-debug.txt
2026-04-29 03:16:30.522373 | debian-bookworm | >f+++++++++ sudo-strace.log
2026-04-29 03:16:30.522400 | debian-bookworm | >f+++++++++ sudo-strace.log.time
2026-04-29 03:16:30.522449 | debian-bookworm | changed: All items complete
2026-04-29 03:16:30.522476 | 
2026-04-29 03:16:31.095590 | debian-bookworm | changed: .d..t...... ./
2026-04-29 03:16:31.651868 | debian-bookworm | changed: .d..t...... ./
2026-04-29 03:16:31.673556 | 
2026-04-29 03:16:31.673660 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-29 03:16:31.695916 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:31.701355 | debian-bookworm | skipping: Conditional result was False
2026-04-29 03:16:31.715532 | 
2026-04-29 03:16:31.715613 | PLAY RECAP
2026-04-29 03:16:31.715663 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-04-29 03:16:31.715688 | 
2026-04-29 03:16:31.828020 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main]
2026-04-29 03:16:31.829017 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-04-29 03:16:32.566417 | 
2026-04-29 03:16:32.566549 | PLAY [Base post]
2026-04-29 03:16:32.588585 | 
2026-04-29 03:16:32.588709 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-29 03:16:33.092850 | debian-bookworm | changed
2026-04-29 03:16:33.099039 | 
2026-04-29 03:16:33.099136 | PLAY RECAP
2026-04-29 03:16:33.099193 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-29 03:16:33.099254 | 
2026-04-29 03:16:33.212453 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main]
2026-04-29 03:16:33.213203 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-29 03:16:34.047336 | 
2026-04-29 03:16:34.047472 | PLAY [Base post-logs]
2026-04-29 03:16:34.057127 | 
2026-04-29 03:16:34.057238 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-29 03:16:34.537108 | localhost | changed
2026-04-29 03:16:34.547051 | 
2026-04-29 03:16:34.547178 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-29 03:16:34.581001 | localhost | ok
2026-04-29 03:16:34.583844 | 
2026-04-29 03:16:34.583929 | TASK [Set zuul-log-path fact]
2026-04-29 03:16:34.598267 | localhost | ok
2026-04-29 03:16:34.605457 | 
2026-04-29 03:16:34.605551 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-29 03:16:34.629806 | localhost | ok
2026-04-29 03:16:34.632536 | 
2026-04-29 03:16:34.632625 | TASK [upload-logs : Create log directories]
2026-04-29 03:16:35.094508 | localhost | changed
2026-04-29 03:16:35.097977 | 
2026-04-29 03:16:35.098160 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-29 03:16:35.654011 | localhost -> localhost | ok: Runtime: 0:00:00.015555
2026-04-29 03:16:35.657665 | 
2026-04-29 03:16:35.657796 | TASK [upload-logs : Upload logs to log server]
2026-04-29 03:16:36.251251 | localhost | Output suppressed because no_log was given
2026-04-29 03:16:36.254720 | 
2026-04-29 03:16:36.254891 | LOOP [upload-logs : Compress console log and json output]
2026-04-29 03:16:36.294733 | localhost | skipping: Conditional result was False
2026-04-29 03:16:36.300363 | localhost | skipping: Conditional result was False
2026-04-29 03:16:36.310884 | 
2026-04-29 03:16:36.310985 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-29 03:16:36.351971 | localhost | skipping: Conditional result was False
2026-04-29 03:16:36.352191 | 
2026-04-29 03:16:36.356603 | localhost | skipping: Conditional result was False
2026-04-29 03:16:36.366583 | 
2026-04-29 03:16:36.366689 | LOOP [upload-logs : Upload console log and json output]