2026-06-09 03:09:30.827190 | Job console starting 2026-06-09 03:09:30.843842 | Updating git repos 2026-06-09 03:09:31.115293 | Cloning repos into workspace 2026-06-09 03:09:31.278240 | Restoring repo states 2026-06-09 03:09:31.344381 | Merging changes 2026-06-09 03:09:31.344404 | Checking out repos 2026-06-09 03:09:31.743340 | Preparing playbooks 2026-06-09 03:09:33.990690 | Running Ansible setup 2026-06-09 03:09:40.073665 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-09 03:09:42.133873 | 2026-06-09 03:09:42.134107 | PLAY [Base pre] 2026-06-09 03:09:42.208696 | 2026-06-09 03:09:42.209098 | TASK [Setup log path fact] 2026-06-09 03:09:42.277046 | debian-bookworm | ok 2026-06-09 03:09:42.345808 | 2026-06-09 03:09:42.346063 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 03:09:42.438301 | debian-bookworm | ok 2026-06-09 03:09:42.462322 | 2026-06-09 03:09:42.462504 | TASK [emit-job-header : Print job information] 2026-06-09 03:09:42.583979 | # Job Information 2026-06-09 03:09:42.584214 | Ansible Version: 2.16.14 2026-06-09 03:09:42.584251 | Job: python-black 2026-06-09 03:09:42.584284 | Pipeline: periodic-daily 2026-06-09 03:09:42.584308 | Executor: 521e9411259a 2026-06-09 03:09:42.584329 | Triggered by: https://github.com/osism/python-osism 2026-06-09 03:09:42.584351 | Event ID: 7c9cb957d7d14c8cb9629adf17d656c2 2026-06-09 03:09:42.590201 | 2026-06-09 03:09:42.590339 | LOOP [emit-job-header : Print node information] 2026-06-09 03:09:42.844735 | debian-bookworm | ok: 2026-06-09 03:09:42.850417 | debian-bookworm | # Node Information 2026-06-09 03:09:42.850526 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-09 03:09:42.850557 | debian-bookworm | Hostname: debian 2026-06-09 03:09:42.850581 | debian-bookworm | Username: zuul 2026-06-09 03:09:42.850603 | debian-bookworm | Distro: Debian 12.14 2026-06-09 03:09:42.850627 | debian-bookworm | Provider: regiocloud-a 2026-06-09 03:09:42.850649 | debian-bookworm | Region: 2026-06-09 03:09:42.850671 | debian-bookworm | Label: debian-bookworm 2026-06-09 03:09:42.850690 | debian-bookworm | Product Name: OpenStack Nova 2026-06-09 03:09:42.850711 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee3:7218 2026-06-09 03:09:42.882812 | 2026-06-09 03:09:42.883032 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-09 03:09:44.379592 | debian-bookworm -> localhost | changed 2026-06-09 03:09:44.387872 | 2026-06-09 03:09:44.388015 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-09 03:09:47.508385 | debian-bookworm -> localhost | changed 2026-06-09 03:09:47.563897 | 2026-06-09 03:09:47.564099 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-09 03:09:48.539545 | debian-bookworm -> localhost | ok 2026-06-09 03:09:48.549367 | 2026-06-09 03:09:48.549722 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-09 03:09:48.654308 | debian-bookworm | ok 2026-06-09 03:09:48.736329 | debian-bookworm | included: /var/lib/zuul/builds/bf91b7b3dd2f4badaed50b537bcbbf1f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-09 03:09:48.753268 | 2026-06-09 03:09:48.753739 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-09 03:09:51.515089 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-09 03:09:51.515293 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bf91b7b3dd2f4badaed50b537bcbbf1f/work/bf91b7b3dd2f4badaed50b537bcbbf1f_id_rsa 2026-06-09 03:09:51.515333 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bf91b7b3dd2f4badaed50b537bcbbf1f/work/bf91b7b3dd2f4badaed50b537bcbbf1f_id_rsa.pub 2026-06-09 03:09:51.515361 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-09 03:09:51.515387 | debian-bookworm -> localhost | SHA256:em741kbIZw2l0HqRTZmLgOfHgrh5mYAz0z+R4rarL9k zuul-build-sshkey 2026-06-09 03:09:51.515410 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-09 03:09:51.515441 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-09 03:09:51.515464 | debian-bookworm -> localhost | | . . +.o | 2026-06-09 03:09:51.515487 | debian-bookworm -> localhost | | . + + = | 2026-06-09 03:09:51.515507 | debian-bookworm -> localhost | | o . = = = . | 2026-06-09 03:09:51.515528 | debian-bookworm -> localhost | | = = + + B . | 2026-06-09 03:09:51.515550 | debian-bookworm -> localhost | | = * =S= o | 2026-06-09 03:09:51.515575 | debian-bookworm -> localhost | | = *.o + . | 2026-06-09 03:09:51.515596 | debian-bookworm -> localhost | | + o.o.= | 2026-06-09 03:09:51.515617 | debian-bookworm -> localhost | | o E .oo o | 2026-06-09 03:09:51.515650 | debian-bookworm -> localhost | | .+o. +o. | 2026-06-09 03:09:51.515674 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-09 03:09:51.515728 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.212864 2026-06-09 03:09:51.522056 | 2026-06-09 03:09:51.522149 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-09 03:09:51.554435 | debian-bookworm | ok 2026-06-09 03:09:51.580310 | debian-bookworm | included: /var/lib/zuul/builds/bf91b7b3dd2f4badaed50b537bcbbf1f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-09 03:09:51.608224 | 2026-06-09 03:09:51.608339 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-09 03:09:51.645369 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:09:51.655895 | 2026-06-09 03:09:51.656020 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-09 03:09:52.727826 | debian-bookworm | changed 2026-06-09 03:09:52.738038 | 2026-06-09 03:09:52.738147 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-09 03:09:53.064279 | debian-bookworm | ok 2026-06-09 03:09:53.070328 | 2026-06-09 03:09:53.070447 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-09 03:09:53.868461 | debian-bookworm | changed 2026-06-09 03:09:53.874644 | 2026-06-09 03:09:53.874724 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-09 03:09:54.585312 | debian-bookworm | changed 2026-06-09 03:09:54.589891 | 2026-06-09 03:09:54.589970 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-09 03:09:54.624789 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:09:54.630790 | 2026-06-09 03:09:54.630900 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-09 03:09:55.555079 | debian-bookworm -> localhost | changed 2026-06-09 03:09:55.563747 | 2026-06-09 03:09:55.563832 | TASK [add-build-sshkey : Add back temp key] 2026-06-09 03:09:56.068628 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bf91b7b3dd2f4badaed50b537bcbbf1f/work/bf91b7b3dd2f4badaed50b537bcbbf1f_id_rsa (zuul-build-sshkey) 2026-06-09 03:09:56.068832 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011575 2026-06-09 03:09:56.079839 | 2026-06-09 03:09:56.079935 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-09 03:09:56.641368 | debian-bookworm | ok 2026-06-09 03:09:56.646202 | 2026-06-09 03:09:56.646282 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-09 03:09:56.696922 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:09:56.709362 | 2026-06-09 03:09:56.709553 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-09 03:09:57.276077 | debian-bookworm | ok 2026-06-09 03:09:57.295046 | 2026-06-09 03:09:57.295214 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-09 03:09:57.379726 | debian-bookworm | ok 2026-06-09 03:09:57.383959 | 2026-06-09 03:09:57.384032 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-09 03:09:57.881922 | debian-bookworm -> localhost | ok 2026-06-09 03:09:57.887237 | 2026-06-09 03:09:57.887312 | TASK [validate-host : Collect information about the host] 2026-06-09 03:09:59.336959 | debian-bookworm | ok 2026-06-09 03:09:59.366165 | 2026-06-09 03:09:59.366300 | TASK [validate-host : Sanitize hostname] 2026-06-09 03:09:59.543190 | debian-bookworm | ok 2026-06-09 03:09:59.607095 | 2026-06-09 03:09:59.607202 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-09 03:10:00.503089 | debian-bookworm -> localhost | changed 2026-06-09 03:10:00.511207 | 2026-06-09 03:10:00.511524 | TASK [validate-host : Collect information about zuul worker] 2026-06-09 03:10:00.918056 | debian-bookworm | ok 2026-06-09 03:10:00.925672 | 2026-06-09 03:10:00.925794 | TASK [validate-host : Write out all zuul information for each host] 2026-06-09 03:10:01.720449 | debian-bookworm -> localhost | changed 2026-06-09 03:10:01.728150 | 2026-06-09 03:10:01.728230 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-09 03:10:02.078845 | debian-bookworm | ok 2026-06-09 03:10:02.085121 | 2026-06-09 03:10:02.085215 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-09 03:10:03.562210 | debian-bookworm | changed: 2026-06-09 03:10:03.562523 | debian-bookworm | cd+++++++++ src/ 2026-06-09 03:10:03.562564 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-09 03:10:03.562590 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-09 03:10:03.562612 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-06-09 03:10:03.562670 | debian-bookworm | Containerfile 2026-06-09 03:10:03.562854 | debian-bookworm | Containerfile 2026-06-09 03:10:03.578227 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/bf91b7b3dd2f4badaed50b537bcbbf1f/work/logs" 2026-06-09 03:10:36.735860 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/bf91b7b3dd2f4badaed50b537bcbbf1f/work/artifacts" 2026-06-09 03:10:37.395466 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/bf91b7b3dd2f4badaed50b537bcbbf1f/work/docs" 2026-06-09 03:10:37.405624 | 2026-06-09 03:10:37.405740 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-09 03:10:38.480166 | debian-bookworm | changed: 2026-06-09 03:10:38.480347 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-09 03:10:38.480376 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-09 03:10:38.480400 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-09 03:10:38.480436 | debian-bookworm | changed: All items complete 2026-06-09 03:10:38.480453 | 2026-06-09 03:10:39.468846 | debian-bookworm | changed: .d..t...... ./ 2026-06-09 03:10:40.552637 | debian-bookworm | changed: .d..t...... ./ 2026-06-09 03:10:40.577783 | 2026-06-09 03:10:40.577907 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-09 03:10:40.664690 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:10:40.684460 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:10:40.695114 | 2026-06-09 03:10:40.695205 | PLAY RECAP 2026-06-09 03:10:40.695257 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-09 03:10:40.695283 | 2026-06-09 03:10:41.075057 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-09 03:10:41.075869 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 03:10:43.558303 | 2026-06-09 03:10:43.558418 | PLAY [Base post] 2026-06-09 03:10:43.582475 | 2026-06-09 03:10:43.585800 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-09 03:10:44.617791 | debian-bookworm | changed 2026-06-09 03:10:44.623073 | 2026-06-09 03:10:44.623152 | PLAY RECAP 2026-06-09 03:10:44.623199 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-09 03:10:44.623248 | 2026-06-09 03:10:44.991653 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 03:10:44.992355 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-09 03:10:46.778403 | 2026-06-09 03:10:46.778552 | PLAY [Base post-logs] 2026-06-09 03:10:46.797361 | 2026-06-09 03:10:46.797491 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-09 03:10:47.742445 | localhost | changed 2026-06-09 03:10:47.750247 | 2026-06-09 03:10:47.750358 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-09 03:10:47.804882 | localhost | ok 2026-06-09 03:10:47.807761 | 2026-06-09 03:10:47.807833 | TASK [Set zuul-log-path fact] 2026-06-09 03:10:47.842028 | localhost | ok 2026-06-09 03:10:47.851771 | 2026-06-09 03:10:47.851859 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 03:10:47.911426 | localhost | ok 2026-06-09 03:10:47.914095 | 2026-06-09 03:10:47.914169 | TASK [upload-logs : Create log directories] 2026-06-09 03:10:48.801981 | localhost | changed 2026-06-09 03:10:48.804320 | 2026-06-09 03:10:48.804431 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-09 03:10:49.711220 | localhost -> localhost | ok: Runtime: 0:00:00.017680 2026-06-09 03:10:49.715091 | 2026-06-09 03:10:49.715181 | TASK [upload-logs : Upload logs to log server] 2026-06-09 03:10:50.584970 | localhost | Output suppressed because no_log was given 2026-06-09 03:10:50.586727 | 2026-06-09 03:10:50.586805 | LOOP [upload-logs : Compress console log and json output] 2026-06-09 03:10:50.738096 | localhost | skipping: Conditional result was False 2026-06-09 03:10:50.743407 | localhost | skipping: Conditional result was False 2026-06-09 03:10:50.753872 | 2026-06-09 03:10:50.753971 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-09 03:10:50.866475 | localhost | skipping: Conditional result was False 2026-06-09 03:10:50.866750 | 2026-06-09 03:10:50.878551 | localhost | skipping: Conditional result was False 2026-06-09 03:10:50.900216 | 2026-06-09 03:10:50.900318 | LOOP [upload-logs : Upload console log and json output]