2026-09-07 03:01:54.783208 | Job console starting 2026-09-07 03:01:54.791838 | Updating git repos 2026-09-07 03:01:54.863704 | Cloning repos into workspace 2026-09-07 03:01:54.954026 | Restoring repo states 2026-09-07 03:01:54.986266 | Merging changes 2026-09-07 03:01:54.986276 | Checking out repos 2026-09-07 03:01:55.048860 | Preparing playbooks 2026-09-07 03:01:56.218310 | Running Ansible setup 2026-09-07 03:02:01.793884 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-07 03:02:02.719466 | 2026-09-07 03:02:02.719596 | PLAY [Base pre] 2026-09-07 03:02:02.733423 | 2026-09-07 03:02:02.733510 | TASK [Setup log path fact] 2026-09-07 03:02:02.749994 | debian-bookworm | ok 2026-09-07 03:02:02.762770 | 2026-09-07 03:02:02.762874 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 03:02:02.809295 | debian-bookworm | ok 2026-09-07 03:02:02.817377 | 2026-09-07 03:02:02.817468 | TASK [emit-job-header : Print job information] 2026-09-07 03:02:02.873744 | # Job Information 2026-09-07 03:02:02.873879 | Ansible Version: 2.16.14 2026-09-07 03:02:02.873907 | Job: python-black 2026-09-07 03:02:02.873935 | Pipeline: periodic-daily 2026-09-07 03:02:02.873953 | Executor: 521e9411259a 2026-09-07 03:02:02.873970 | Triggered by: https://github.com/osism/ansible-collection-validations 2026-09-07 03:02:02.873988 | Event ID: ddf4cf41710a4d40a66e4d5697d8a315 2026-09-07 03:02:02.878096 | 2026-09-07 03:02:02.878174 | LOOP [emit-job-header : Print node information] 2026-09-07 03:02:02.993372 | debian-bookworm | ok: 2026-09-07 03:02:02.993600 | debian-bookworm | # Node Information 2026-09-07 03:02:02.993644 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-07 03:02:02.993673 | debian-bookworm | Hostname: debian 2026-09-07 03:02:02.993696 | debian-bookworm | Username: zuul 2026-09-07 03:02:02.993718 | debian-bookworm | Distro: Debian 12.15 2026-09-07 03:02:02.993743 | debian-bookworm | Provider: regiocloud-a 2026-09-07 03:02:02.993766 | debian-bookworm | Region: 2026-09-07 03:02:02.993789 | debian-bookworm | Label: debian-bookworm 2026-09-07 03:02:02.993810 | debian-bookworm | Product Name: OpenStack Nova 2026-09-07 03:02:02.993831 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febc:734d 2026-09-07 03:02:03.014303 | 2026-09-07 03:02:03.014412 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-07 03:02:03.411737 | debian-bookworm -> localhost | changed 2026-09-07 03:02:03.418040 | 2026-09-07 03:02:03.428185 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-07 03:02:04.459314 | debian-bookworm -> localhost | changed 2026-09-07 03:02:04.468056 | 2026-09-07 03:02:04.468141 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-07 03:02:04.683238 | debian-bookworm -> localhost | ok 2026-09-07 03:02:04.692642 | 2026-09-07 03:02:04.692894 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-07 03:02:04.723278 | debian-bookworm | ok 2026-09-07 03:02:04.745355 | debian-bookworm | included: /var/lib/zuul/builds/a28467c4b6b14c79ba570dbc24042361/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-07 03:02:04.751312 | 2026-09-07 03:02:04.751384 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-07 03:02:07.161804 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-07 03:02:07.162005 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a28467c4b6b14c79ba570dbc24042361/work/a28467c4b6b14c79ba570dbc24042361_id_rsa 2026-09-07 03:02:07.162043 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a28467c4b6b14c79ba570dbc24042361/work/a28467c4b6b14c79ba570dbc24042361_id_rsa.pub 2026-09-07 03:02:07.162069 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-07 03:02:07.162093 | debian-bookworm -> localhost | SHA256:cpsKvNeu8vg6pyU7S6CV6opxd7VgrrOdlUNGMnfrx7U zuul-build-sshkey 2026-09-07 03:02:07.162116 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-07 03:02:07.162145 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-07 03:02:07.162167 | debian-bookworm -> localhost | | | 2026-09-07 03:02:07.162189 | debian-bookworm -> localhost | | | 2026-09-07 03:02:07.162209 | debian-bookworm -> localhost | | o o . | 2026-09-07 03:02:07.162228 | debian-bookworm -> localhost | | . = . . | 2026-09-07 03:02:07.162248 | debian-bookworm -> localhost | | + + S . . | 2026-09-07 03:02:07.162270 | debian-bookworm -> localhost | | + o o B * . . . | 2026-09-07 03:02:07.162291 | debian-bookworm -> localhost | |+ . * +.B . o E | 2026-09-07 03:02:07.162312 | debian-bookworm -> localhost | |oo o=@o+.. . | 2026-09-07 03:02:07.162333 | debian-bookworm -> localhost | |+. X#Bo. | 2026-09-07 03:02:07.162353 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-07 03:02:07.162402 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.751167 2026-09-07 03:02:07.171897 | 2026-09-07 03:02:07.172014 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-07 03:02:07.189672 | debian-bookworm | ok 2026-09-07 03:02:07.197703 | debian-bookworm | included: /var/lib/zuul/builds/a28467c4b6b14c79ba570dbc24042361/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-07 03:02:07.204046 | 2026-09-07 03:02:07.204110 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-07 03:02:07.216432 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:02:07.221275 | 2026-09-07 03:02:07.221344 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-07 03:02:07.835941 | debian-bookworm | changed 2026-09-07 03:02:07.844512 | 2026-09-07 03:02:07.844639 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-07 03:02:08.101125 | debian-bookworm | ok 2026-09-07 03:02:08.110653 | 2026-09-07 03:02:08.110758 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-07 03:02:08.747421 | debian-bookworm | changed 2026-09-07 03:02:08.753274 | 2026-09-07 03:02:08.753493 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-07 03:02:09.358448 | debian-bookworm | changed 2026-09-07 03:02:09.368605 | 2026-09-07 03:02:09.368719 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-07 03:02:09.393495 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:02:09.402193 | 2026-09-07 03:02:09.402306 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-07 03:02:09.861261 | debian-bookworm -> localhost | changed 2026-09-07 03:02:09.871409 | 2026-09-07 03:02:09.871504 | TASK [add-build-sshkey : Add back temp key] 2026-09-07 03:02:10.191413 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a28467c4b6b14c79ba570dbc24042361/work/a28467c4b6b14c79ba570dbc24042361_id_rsa (zuul-build-sshkey) 2026-09-07 03:02:10.191646 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011964 2026-09-07 03:02:10.199201 | 2026-09-07 03:02:10.199292 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-07 03:02:10.560860 | debian-bookworm | ok 2026-09-07 03:02:10.566044 | 2026-09-07 03:02:10.566136 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-07 03:02:10.589047 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:02:10.601811 | 2026-09-07 03:02:10.601906 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-07 03:02:11.063237 | debian-bookworm | ok 2026-09-07 03:02:11.075372 | 2026-09-07 03:02:11.075479 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-07 03:02:11.124532 | debian-bookworm | ok 2026-09-07 03:02:11.129383 | 2026-09-07 03:02:11.129468 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-07 03:02:11.634950 | debian-bookworm -> localhost | ok 2026-09-07 03:02:11.641576 | 2026-09-07 03:02:11.641669 | TASK [validate-host : Collect information about the host] 2026-09-07 03:02:12.701947 | debian-bookworm | ok 2026-09-07 03:02:12.713381 | 2026-09-07 03:02:12.713461 | TASK [validate-host : Sanitize hostname] 2026-09-07 03:02:12.822969 | debian-bookworm | ok 2026-09-07 03:02:12.826447 | 2026-09-07 03:02:12.826540 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-07 03:02:13.402290 | debian-bookworm -> localhost | changed 2026-09-07 03:02:13.407881 | 2026-09-07 03:02:13.407974 | TASK [validate-host : Collect information about zuul worker] 2026-09-07 03:02:13.918496 | debian-bookworm | ok 2026-09-07 03:02:13.922925 | 2026-09-07 03:02:13.923047 | TASK [validate-host : Write out all zuul information for each host] 2026-09-07 03:02:14.354353 | debian-bookworm -> localhost | changed 2026-09-07 03:02:14.370192 | 2026-09-07 03:02:14.370282 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-07 03:02:14.698201 | debian-bookworm | ok 2026-09-07 03:02:14.707505 | 2026-09-07 03:02:14.707682 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-07 03:02:15.599137 | debian-bookworm | changed: 2026-09-07 03:02:15.599310 | debian-bookworm | cd+++++++++ src/ 2026-09-07 03:02:15.599345 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-07 03:02:15.599370 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-07 03:02:15.599391 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2026-09-07 03:02:15.599411 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/a28467c4b6b14c79ba570dbc24042361/work/logs" 2026-09-07 03:03:17.693555 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a28467c4b6b14c79ba570dbc24042361/work/artifacts" 2026-09-07 03:03:18.267514 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a28467c4b6b14c79ba570dbc24042361/work/docs" 2026-09-07 03:03:18.288077 | 2026-09-07 03:03:18.288180 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-07 03:03:19.137291 | debian-bookworm | changed: 2026-09-07 03:03:19.137470 | debian-bookworm | .d..t...... ./ 2026-09-07 03:03:19.137516 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-07 03:03:19.137550 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-07 03:03:19.137572 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-07 03:03:19.137593 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-07 03:03:19.137614 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-07 03:03:19.137650 | debian-bookworm | changed: All items complete 2026-09-07 03:03:19.137726 | 2026-09-07 03:03:19.716995 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 03:03:20.565123 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 03:03:20.590549 | 2026-09-07 03:03:20.590656 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-07 03:03:20.610573 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:03:20.614215 | debian-bookworm | skipping: Conditional result was False 2026-09-07 03:03:20.626558 | 2026-09-07 03:03:20.626627 | PLAY RECAP 2026-09-07 03:03:20.626676 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-09-07 03:03:20.626701 | 2026-09-07 03:03:20.769619 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-07 03:03:20.770349 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 03:03:21.624146 | 2026-09-07 03:03:21.624245 | PLAY [Base post] 2026-09-07 03:03:21.634018 | 2026-09-07 03:03:21.634117 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-07 03:03:22.223338 | debian-bookworm | changed 2026-09-07 03:03:22.229618 | 2026-09-07 03:03:22.229707 | PLAY RECAP 2026-09-07 03:03:22.229764 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-07 03:03:22.229827 | 2026-09-07 03:03:22.450526 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 03:03:22.451267 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-07 03:03:23.508465 | 2026-09-07 03:03:23.508623 | PLAY [Base post-logs] 2026-09-07 03:03:23.535635 | 2026-09-07 03:03:23.535764 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-07 03:03:24.281737 | localhost | changed 2026-09-07 03:03:24.290799 | 2026-09-07 03:03:24.293158 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-07 03:03:24.345733 | localhost | ok 2026-09-07 03:03:24.348515 | 2026-09-07 03:03:24.348597 | TASK [Set zuul-log-path fact] 2026-09-07 03:03:24.372838 | localhost | ok 2026-09-07 03:03:24.380044 | 2026-09-07 03:03:24.380134 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 03:03:24.425559 | localhost | ok 2026-09-07 03:03:24.428430 | 2026-09-07 03:03:24.428528 | TASK [upload-logs : Create log directories] 2026-09-07 03:03:24.983154 | localhost | changed 2026-09-07 03:03:24.985242 | 2026-09-07 03:03:24.985312 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-07 03:03:25.680187 | localhost -> localhost | ok: Runtime: 0:00:00.021157 2026-09-07 03:03:25.683152 | 2026-09-07 03:03:25.683230 | TASK [upload-logs : Upload logs to log server] 2026-09-07 03:03:26.306253 | localhost | Output suppressed because no_log was given 2026-09-07 03:03:26.307664 | 2026-09-07 03:03:26.307741 | LOOP [upload-logs : Compress console log and json output] 2026-09-07 03:03:26.400431 | localhost | skipping: Conditional result was False 2026-09-07 03:03:26.410614 | localhost | skipping: Conditional result was False 2026-09-07 03:03:26.426172 | 2026-09-07 03:03:26.426261 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-07 03:03:26.481680 | localhost | skipping: Conditional result was False 2026-09-07 03:03:26.481924 | 2026-09-07 03:03:26.490618 | localhost | skipping: Conditional result was False 2026-09-07 03:03:26.494148 | 2026-09-07 03:03:26.494235 | LOOP [upload-logs : Upload console log and json output]