2026-05-06 03:01:41.784148 | Job console starting 2026-05-06 03:01:41.791137 | Updating git repos 2026-05-06 03:01:41.942816 | Cloning repos into workspace 2026-05-06 03:01:42.012450 | Restoring repo states 2026-05-06 03:01:42.030247 | Merging changes 2026-05-06 03:01:42.030260 | Checking out repos 2026-05-06 03:01:42.106771 | Preparing playbooks 2026-05-06 03:01:43.371500 | Running Ansible setup 2026-05-06 03:01:49.908720 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-06 03:01:51.269231 | 2026-05-06 03:01:51.269385 | PLAY [Base pre] 2026-05-06 03:01:51.317565 | 2026-05-06 03:01:51.317694 | TASK [Setup log path fact] 2026-05-06 03:01:51.359023 | debian-bookworm | ok 2026-05-06 03:01:51.381223 | 2026-05-06 03:01:51.381382 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-06 03:01:51.423754 | debian-bookworm | ok 2026-05-06 03:01:51.436145 | 2026-05-06 03:01:51.436275 | TASK [emit-job-header : Print job information] 2026-05-06 03:01:51.499038 | # Job Information 2026-05-06 03:01:51.499181 | Ansible Version: 2.16.14 2026-05-06 03:01:51.499209 | Job: python-black 2026-05-06 03:01:51.499235 | Pipeline: periodic-daily 2026-05-06 03:01:51.499262 | Executor: 521e9411259a 2026-05-06 03:01:51.499280 | Triggered by: https://github.com/osism/openstack-configuration-reference 2026-05-06 03:01:51.499298 | Event ID: 18f0e500ed43456d9bb9cd69ebc6391f 2026-05-06 03:01:51.503582 | 2026-05-06 03:01:51.503747 | LOOP [emit-job-header : Print node information] 2026-05-06 03:01:51.743480 | debian-bookworm | ok: 2026-05-06 03:01:51.743645 | debian-bookworm | # Node Information 2026-05-06 03:01:51.743679 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-06 03:01:51.743705 | debian-bookworm | Hostname: debian 2026-05-06 03:01:51.743728 | debian-bookworm | Username: zuul 2026-05-06 03:01:51.743750 | debian-bookworm | Distro: Debian 12.13 2026-05-06 03:01:51.743774 | debian-bookworm | Provider: regiocloud-a 2026-05-06 03:01:51.743796 | debian-bookworm | Region: 2026-05-06 03:01:51.743817 | debian-bookworm | Label: debian-bookworm 2026-05-06 03:01:51.743837 | debian-bookworm | Product Name: OpenStack Nova 2026-05-06 03:01:51.743857 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe71:ba0c 2026-05-06 03:01:51.760466 | 2026-05-06 03:01:51.760567 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-06 03:01:53.115230 | debian-bookworm -> localhost | changed 2026-05-06 03:01:53.120884 | 2026-05-06 03:01:53.120974 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-06 03:01:55.151843 | debian-bookworm -> localhost | changed 2026-05-06 03:01:55.161882 | 2026-05-06 03:01:55.161976 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-06 03:01:55.779801 | debian-bookworm -> localhost | ok 2026-05-06 03:01:55.784961 | 2026-05-06 03:01:55.785059 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-06 03:01:55.834320 | debian-bookworm | ok 2026-05-06 03:01:55.895680 | debian-bookworm | included: /var/lib/zuul/builds/1aa8df0474004e0f9b50d7baa7125723/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-06 03:01:55.909200 | 2026-05-06 03:01:55.909336 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-06 03:02:00.810380 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-06 03:02:00.810549 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1aa8df0474004e0f9b50d7baa7125723/work/1aa8df0474004e0f9b50d7baa7125723_id_rsa 2026-05-06 03:02:00.810579 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1aa8df0474004e0f9b50d7baa7125723/work/1aa8df0474004e0f9b50d7baa7125723_id_rsa.pub 2026-05-06 03:02:00.810601 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-06 03:02:00.810620 | debian-bookworm -> localhost | SHA256:AXJhzgKirCpao7dlhfcoSDJ68UKKVf+7btpigBr6HRE zuul-build-sshkey 2026-05-06 03:02:00.810648 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-06 03:02:00.810667 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-06 03:02:00.810684 | debian-bookworm -> localhost | |. . . =. | 2026-05-06 03:02:00.810702 | debian-bookworm -> localhost | |o. . * . | 2026-05-06 03:02:00.810718 | debian-bookworm -> localhost | |.. E o . | 2026-05-06 03:02:00.810734 | debian-bookworm -> localhost | |. . = . | 2026-05-06 03:02:00.810750 | debian-bookworm -> localhost | |+ =.o + S | 2026-05-06 03:02:00.810769 | debian-bookworm -> localhost | |=B.+.+ + | 2026-05-06 03:02:00.810786 | debian-bookworm -> localhost | |Bo* *.. o | 2026-05-06 03:02:00.810802 | debian-bookworm -> localhost | |=+.* oo... | 2026-05-06 03:02:00.810819 | debian-bookworm -> localhost | |ooo....==. | 2026-05-06 03:02:00.810852 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-06 03:02:00.810894 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.897532 2026-05-06 03:02:00.816106 | 2026-05-06 03:02:00.816203 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-06 03:02:00.863131 | debian-bookworm | ok 2026-05-06 03:02:00.871853 | debian-bookworm | included: /var/lib/zuul/builds/1aa8df0474004e0f9b50d7baa7125723/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-06 03:02:00.900633 | 2026-05-06 03:02:00.900738 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-06 03:02:00.963388 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:02:00.968299 | 2026-05-06 03:02:00.968402 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-06 03:02:01.906051 | debian-bookworm | changed 2026-05-06 03:02:01.912345 | 2026-05-06 03:02:01.912545 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-06 03:02:02.194652 | debian-bookworm | ok 2026-05-06 03:02:02.201075 | 2026-05-06 03:02:02.201176 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-06 03:02:02.918367 | debian-bookworm | changed 2026-05-06 03:02:02.926333 | 2026-05-06 03:02:02.926445 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-06 03:02:03.693076 | debian-bookworm | changed 2026-05-06 03:02:03.701330 | 2026-05-06 03:02:03.701440 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-06 03:02:03.737018 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:02:03.743641 | 2026-05-06 03:02:03.743738 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-06 03:02:04.904458 | debian-bookworm -> localhost | changed 2026-05-06 03:02:04.921047 | 2026-05-06 03:02:04.921161 | TASK [add-build-sshkey : Add back temp key] 2026-05-06 03:02:05.574218 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1aa8df0474004e0f9b50d7baa7125723/work/1aa8df0474004e0f9b50d7baa7125723_id_rsa (zuul-build-sshkey) 2026-05-06 03:02:05.574452 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026071 2026-05-06 03:02:05.582422 | 2026-05-06 03:02:05.582529 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-06 03:02:05.930388 | debian-bookworm | ok 2026-05-06 03:02:05.937000 | 2026-05-06 03:02:05.937108 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-06 03:02:05.960439 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:02:05.977615 | 2026-05-06 03:02:05.977814 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-06 03:02:06.583626 | debian-bookworm | ok 2026-05-06 03:02:06.612155 | 2026-05-06 03:02:06.612279 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-06 03:02:06.661975 | debian-bookworm | ok 2026-05-06 03:02:06.666812 | 2026-05-06 03:02:06.674575 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-06 03:02:07.267719 | debian-bookworm -> localhost | ok 2026-05-06 03:02:07.284581 | 2026-05-06 03:02:07.284685 | TASK [validate-host : Collect information about the host] 2026-05-06 03:02:09.068593 | debian-bookworm | ok 2026-05-06 03:02:09.104607 | 2026-05-06 03:02:09.104717 | TASK [validate-host : Sanitize hostname] 2026-05-06 03:02:09.278598 | debian-bookworm | ok 2026-05-06 03:02:09.363060 | 2026-05-06 03:02:09.363162 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-06 03:02:10.712047 | debian-bookworm -> localhost | changed 2026-05-06 03:02:10.726984 | 2026-05-06 03:02:10.727102 | TASK [validate-host : Collect information about zuul worker] 2026-05-06 03:02:11.397131 | debian-bookworm | ok 2026-05-06 03:02:11.401185 | 2026-05-06 03:02:11.401269 | TASK [validate-host : Write out all zuul information for each host] 2026-05-06 03:02:12.871791 | debian-bookworm -> localhost | changed 2026-05-06 03:02:12.879466 | 2026-05-06 03:02:12.879559 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-06 03:02:13.176614 | debian-bookworm | ok 2026-05-06 03:02:13.181436 | 2026-05-06 03:02:13.181519 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-06 03:02:14.520119 | debian-bookworm | changed: 2026-05-06 03:02:14.520266 | debian-bookworm | cd+++++++++ src/ 2026-05-06 03:02:14.520293 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-06 03:02:14.520313 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-06 03:02:14.520341 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-configuration-reference/ 2026-05-06 03:02:14.520359 | debian-bookworm | Containerfile 2026-05-06 03:02:14.520455 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/1aa8df0474004e0f9b50d7baa7125723/work/logs" 2026-05-06 03:02:43.355975 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/1aa8df0474004e0f9b50d7baa7125723/work/artifacts" 2026-05-06 03:02:44.057672 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/1aa8df0474004e0f9b50d7baa7125723/work/docs" 2026-05-06 03:02:44.069641 | 2026-05-06 03:02:44.069742 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-06 03:02:45.094800 | debian-bookworm | changed: 2026-05-06 03:02:45.095115 | debian-bookworm | .d..t...... ./ 2026-05-06 03:02:45.095154 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-06 03:02:45.095185 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-06 03:02:45.095212 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-06 03:02:45.095253 | debian-bookworm | changed: All items complete 2026-05-06 03:02:45.095279 | 2026-05-06 03:02:46.015417 | debian-bookworm | changed: .d..t...... ./ 2026-05-06 03:02:46.568526 | debian-bookworm | changed: .d..t...... ./ 2026-05-06 03:02:46.581225 | 2026-05-06 03:02:46.581320 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-06 03:02:46.634732 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:02:46.640446 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:02:46.663837 | 2026-05-06 03:02:46.663918 | PLAY RECAP 2026-05-06 03:02:46.663959 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-06 03:02:46.663981 | 2026-05-06 03:02:46.875502 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-06 03:02:46.876692 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-06 03:02:48.816694 | 2026-05-06 03:02:48.816829 | PLAY [Base post] 2026-05-06 03:02:48.847949 | 2026-05-06 03:02:48.848079 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-06 03:02:49.664799 | debian-bookworm | changed 2026-05-06 03:02:49.685430 | 2026-05-06 03:02:49.688209 | PLAY RECAP 2026-05-06 03:02:49.689348 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-06 03:02:49.690371 | 2026-05-06 03:02:49.921118 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-06 03:02:49.921846 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-06 03:02:51.559941 | 2026-05-06 03:02:51.560074 | PLAY [Base post-logs] 2026-05-06 03:02:51.581113 | 2026-05-06 03:02:51.581243 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-06 03:02:52.416547 | localhost | changed 2026-05-06 03:02:52.424211 | 2026-05-06 03:02:52.424323 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-06 03:02:52.492752 | localhost | ok 2026-05-06 03:02:52.495151 | 2026-05-06 03:02:52.495231 | TASK [Set zuul-log-path fact] 2026-05-06 03:02:52.519954 | localhost | ok 2026-05-06 03:02:52.527497 | 2026-05-06 03:02:52.527607 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-06 03:02:52.597088 | localhost | ok 2026-05-06 03:02:52.599467 | 2026-05-06 03:02:52.599544 | TASK [upload-logs : Create log directories] 2026-05-06 03:02:53.921296 | localhost | changed 2026-05-06 03:02:53.923452 | 2026-05-06 03:02:53.923551 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-06 03:02:54.665894 | localhost -> localhost | ok: Runtime: 0:00:00.006086 2026-05-06 03:02:54.669108 | 2026-05-06 03:02:54.669191 | TASK [upload-logs : Upload logs to log server] 2026-05-06 03:02:55.402442 | localhost | Output suppressed because no_log was given 2026-05-06 03:02:55.407594 | 2026-05-06 03:02:55.407699 | LOOP [upload-logs : Compress console log and json output] 2026-05-06 03:02:55.491081 | localhost | skipping: Conditional result was False 2026-05-06 03:02:55.508796 | localhost | skipping: Conditional result was False 2026-05-06 03:02:55.514137 | 2026-05-06 03:02:55.514237 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-06 03:02:55.589046 | localhost | skipping: Conditional result was False 2026-05-06 03:02:55.589265 | 2026-05-06 03:02:55.612099 | localhost | skipping: Conditional result was False 2026-05-06 03:02:55.615946 | 2026-05-06 03:02:55.616055 | LOOP [upload-logs : Upload console log and json output]