2026-09-24 23:41:21.201275 | Job console starting 2026-09-24 23:41:21.210730 | Updating git repos 2026-09-24 23:41:21.263656 | Cloning repos into workspace 2026-09-24 23:41:21.354025 | Restoring repo states 2026-09-24 23:41:21.398149 | Merging changes 2026-09-24 23:41:22.035762 | Checking out repos 2026-09-24 23:41:22.050572 | Preparing playbooks 2026-09-24 23:41:22.857631 | Running Ansible setup 2026-09-24 23:41:29.196814 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-24 23:41:30.344920 | 2026-09-24 23:41:30.345057 | PLAY [Base pre] 2026-09-24 23:41:30.401952 | 2026-09-24 23:41:30.402086 | TASK [Setup log path fact] 2026-09-24 23:41:30.419816 | debian-bookworm | ok 2026-09-24 23:41:30.436106 | 2026-09-24 23:41:30.436221 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-24 23:41:30.463564 | debian-bookworm | ok 2026-09-24 23:41:30.473135 | 2026-09-24 23:41:30.473228 | TASK [emit-job-header : Print job information] 2026-09-24 23:41:30.510974 | # Job Information 2026-09-24 23:41:30.511147 | Ansible Version: 2.16.14 2026-09-24 23:41:30.511183 | Job: python-black 2026-09-24 23:41:30.511213 | Pipeline: check 2026-09-24 23:41:30.511236 | Executor: 521e9411259a 2026-09-24 23:41:30.511257 | Triggered by: https://github.com/osism/generics/pull/609 2026-09-24 23:41:30.511280 | Event ID: 484199b0-b871-11f1-96bd-da83bc875806 2026-09-24 23:41:30.515959 | 2026-09-24 23:41:30.516071 | LOOP [emit-job-header : Print node information] 2026-09-24 23:41:30.641243 | debian-bookworm | ok: 2026-09-24 23:41:30.641474 | debian-bookworm | # Node Information 2026-09-24 23:41:30.641511 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-24 23:41:30.641533 | debian-bookworm | Hostname: debian 2026-09-24 23:41:30.641563 | debian-bookworm | Username: zuul 2026-09-24 23:41:30.641582 | debian-bookworm | Distro: Debian 12.15 2026-09-24 23:41:30.641607 | debian-bookworm | Provider: regiocloud-a 2026-09-24 23:41:30.641628 | debian-bookworm | Region: 2026-09-24 23:41:30.641646 | debian-bookworm | Label: debian-bookworm 2026-09-24 23:41:30.641663 | debian-bookworm | Product Name: OpenStack Nova 2026-09-24 23:41:30.641679 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2b:8933 2026-09-24 23:41:30.660716 | 2026-09-24 23:41:30.660823 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-24 23:41:31.325395 | debian-bookworm -> localhost | changed 2026-09-24 23:41:31.331738 | 2026-09-24 23:41:31.331835 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-24 23:41:32.894103 | debian-bookworm -> localhost | changed 2026-09-24 23:41:32.903115 | 2026-09-24 23:41:32.903202 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-24 23:41:33.281964 | debian-bookworm -> localhost | ok 2026-09-24 23:41:33.287699 | 2026-09-24 23:41:33.287784 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-24 23:41:33.325899 | debian-bookworm | ok 2026-09-24 23:41:33.340426 | debian-bookworm | included: /var/lib/zuul/builds/0592af0805d84eb8ba0e82444c792ef3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-24 23:41:33.345561 | 2026-09-24 23:41:33.345633 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-24 23:41:34.861436 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-24 23:41:34.861650 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0592af0805d84eb8ba0e82444c792ef3/work/0592af0805d84eb8ba0e82444c792ef3_id_rsa 2026-09-24 23:41:34.861692 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0592af0805d84eb8ba0e82444c792ef3/work/0592af0805d84eb8ba0e82444c792ef3_id_rsa.pub 2026-09-24 23:41:34.861720 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-24 23:41:34.861745 | debian-bookworm -> localhost | SHA256:ZkLjoNP41/z/y5+bafVdMADs+ihPYu8Ixz7QmxZhkh8 zuul-build-sshkey 2026-09-24 23:41:34.861769 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-24 23:41:34.861802 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-24 23:41:34.861824 | debian-bookworm -> localhost | | ... | 2026-09-24 23:41:34.861845 | debian-bookworm -> localhost | | . . | 2026-09-24 23:41:34.861865 | debian-bookworm -> localhost | | ..o . . | 2026-09-24 23:41:34.861885 | debian-bookworm -> localhost | | +o+E. . o | 2026-09-24 23:41:34.861905 | debian-bookworm -> localhost | | + .=ooS. o | 2026-09-24 23:41:34.861929 | debian-bookworm -> localhost | | o..+*. o| 2026-09-24 23:41:34.861949 | debian-bookworm -> localhost | | o.*++o =| 2026-09-24 23:41:34.861969 | debian-bookworm -> localhost | | **=... . .*| 2026-09-24 23:41:34.861990 | debian-bookworm -> localhost | | .o=+ ....=Bo| 2026-09-24 23:41:34.862009 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-24 23:41:34.862069 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.010088 2026-09-24 23:41:34.868264 | 2026-09-24 23:41:34.868349 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-24 23:41:34.911071 | debian-bookworm | ok 2026-09-24 23:41:34.932262 | debian-bookworm | included: /var/lib/zuul/builds/0592af0805d84eb8ba0e82444c792ef3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-24 23:41:34.983965 | 2026-09-24 23:41:34.984777 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-24 23:41:35.010768 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:41:35.018993 | 2026-09-24 23:41:35.019118 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-24 23:41:35.721928 | debian-bookworm | changed 2026-09-24 23:41:35.738278 | 2026-09-24 23:41:35.738392 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-24 23:41:36.032072 | debian-bookworm | ok 2026-09-24 23:41:36.037774 | 2026-09-24 23:41:36.037864 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-24 23:41:36.849122 | debian-bookworm | changed 2026-09-24 23:41:36.858391 | 2026-09-24 23:41:36.858489 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-24 23:41:37.519375 | debian-bookworm | changed 2026-09-24 23:41:37.531867 | 2026-09-24 23:41:37.531964 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-24 23:41:37.552211 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:41:37.561644 | 2026-09-24 23:41:37.561746 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-24 23:41:38.752081 | debian-bookworm -> localhost | changed 2026-09-24 23:41:38.783275 | 2026-09-24 23:41:38.783388 | TASK [add-build-sshkey : Add back temp key] 2026-09-24 23:41:40.186285 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0592af0805d84eb8ba0e82444c792ef3/work/0592af0805d84eb8ba0e82444c792ef3_id_rsa (zuul-build-sshkey) 2026-09-24 23:41:40.186531 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.044992 2026-09-24 23:41:40.194625 | 2026-09-24 23:41:40.194721 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-24 23:41:41.115283 | debian-bookworm | ok 2026-09-24 23:41:41.135725 | 2026-09-24 23:41:41.135863 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-24 23:41:41.220070 | debian-bookworm | skipping: Conditional result was False 2026-09-24 23:41:41.235865 | 2026-09-24 23:41:41.235960 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-24 23:41:41.771726 | debian-bookworm | ok 2026-09-24 23:41:41.782305 | 2026-09-24 23:41:41.782400 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-24 23:41:41.869779 | debian-bookworm | ok 2026-09-24 23:41:41.874063 | 2026-09-24 23:41:41.874141 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-24 23:41:42.753063 | debian-bookworm -> localhost | ok 2026-09-24 23:41:42.758830 | 2026-09-24 23:41:42.758916 | TASK [validate-host : Collect information about the host] 2026-09-24 23:41:44.797159 | debian-bookworm | ok 2026-09-24 23:41:44.822668 | 2026-09-24 23:41:44.822775 | TASK [validate-host : Sanitize hostname] 2026-09-24 23:41:44.995881 | debian-bookworm | ok 2026-09-24 23:41:44.999547 | 2026-09-24 23:41:44.999618 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-24 23:41:46.287998 | debian-bookworm -> localhost | changed 2026-09-24 23:41:46.292639 | 2026-09-24 23:41:46.292715 | TASK [validate-host : Collect information about zuul worker] 2026-09-24 23:41:46.869138 | debian-bookworm | ok 2026-09-24 23:41:46.873333 | 2026-09-24 23:41:46.873416 | TASK [validate-host : Write out all zuul information for each host] 2026-09-24 23:41:49.291269 | debian-bookworm -> localhost | changed 2026-09-24 23:41:49.299598 | 2026-09-24 23:41:49.299686 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-24 23:41:49.635497 | debian-bookworm | ok 2026-09-24 23:41:49.640219 | 2026-09-24 23:41:49.640300 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-24 23:41:51.251230 | debian-bookworm | changed: 2026-09-24 23:41:51.251415 | debian-bookworm | cd+++++++++ src/ 2026-09-24 23:41:51.251447 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-24 23:41:51.251470 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-24 23:41:51.251491 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-09-24 23:41:51.251510 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/0592af0805d84eb8ba0e82444c792ef3/work/logs" 2026-09-24 23:42:57.461764 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0592af0805d84eb8ba0e82444c792ef3/work/artifacts" 2026-09-24 23:42:57.729657 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0592af0805d84eb8ba0e82444c792ef3/work/docs" 2026-09-24 23:42:57.747692 | 2026-09-24 23:42:57.747910 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-24 23:42:58.530471 | debian-bookworm | changed: 2026-09-24 23:42:58.530751 | debian-bookworm | .d..t...... ./ 2026-09-24 23:42:58.530799 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-24 23:42:58.530834 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-24 23:42:58.530866 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-24 23:42:58.530896 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-24 23:42:58.530924 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-24 23:42:58.530973 | debian-bookworm | changed: All items complete 2026-09-24 23:42:58.531003 | 2026-09-24 23:42:59.065594 | debian-bookworm | changed: .d..t...... ./ 2026-09-24 23:42:59.656462 | debian-bookworm | changed: .d..t...... ./ 2026-09-24 23:42:59.686929 | 2026-09-24 23:42:59.687127 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-24 23:43:00.001855 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006000 2026-09-24 23:43:00.311272 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009572 2026-09-24 23:43:00.327061 | 2026-09-24 23:43:00.327155 | PLAY RECAP 2026-09-24 23:43:00.327207 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-24 23:43:00.327231 | 2026-09-24 23:43:00.471573 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-24 23:43:00.472441 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-24 23:43:01.281529 | 2026-09-24 23:43:01.281724 | PLAY [Base post] 2026-09-24 23:43:01.295765 | 2026-09-24 23:43:01.295888 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-24 23:43:01.885948 | debian-bookworm | changed 2026-09-24 23:43:01.896486 | 2026-09-24 23:43:01.896623 | PLAY RECAP 2026-09-24 23:43:01.896695 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-24 23:43:01.896785 | 2026-09-24 23:43:02.054862 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-24 23:43:02.055688 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-24 23:43:02.911463 | 2026-09-24 23:43:02.911627 | PLAY [Base post-logs] 2026-09-24 23:43:02.936018 | 2026-09-24 23:43:02.936211 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-24 23:43:03.750081 | localhost | changed 2026-09-24 23:43:03.765386 | 2026-09-24 23:43:03.765584 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-24 23:43:03.818072 | localhost | ok 2026-09-24 23:43:03.821809 | 2026-09-24 23:43:03.821920 | TASK [Set zuul-log-path fact] 2026-09-24 23:43:03.859507 | localhost | ok 2026-09-24 23:43:03.867922 | 2026-09-24 23:43:03.868071 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-24 23:43:03.893776 | localhost | ok 2026-09-24 23:43:03.896787 | 2026-09-24 23:43:03.896883 | TASK [upload-logs : Create log directories] 2026-09-24 23:43:04.453867 | localhost | changed 2026-09-24 23:43:04.456707 | 2026-09-24 23:43:04.456820 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-24 23:43:04.936819 | localhost -> localhost | ok: Runtime: 0:00:00.004146 2026-09-24 23:43:04.939923 | 2026-09-24 23:43:04.940001 | TASK [upload-logs : Upload logs to log server] 2026-09-24 23:43:05.551715 | localhost | Output suppressed because no_log was given 2026-09-24 23:43:05.553288 | 2026-09-24 23:43:05.553368 | LOOP [upload-logs : Compress console log and json output] 2026-09-24 23:43:05.595432 | localhost | skipping: Conditional result was False 2026-09-24 23:43:05.602368 | localhost | skipping: Conditional result was False 2026-09-24 23:43:05.608780 | 2026-09-24 23:43:05.608864 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-24 23:43:05.648135 | localhost | skipping: Conditional result was False 2026-09-24 23:43:05.648345 | 2026-09-24 23:43:05.654852 | localhost | skipping: Conditional result was False 2026-09-24 23:43:05.663836 | 2026-09-24 23:43:05.663935 | LOOP [upload-logs : Upload console log and json output]