2026-05-09 03:08:43.496098 | Job console starting 2026-05-09 03:08:43.508508 | Updating git repos 2026-05-09 03:08:43.570760 | Cloning repos into workspace 2026-05-09 03:08:43.639433 | Restoring repo states 2026-05-09 03:08:43.660578 | Merging changes 2026-05-09 03:08:43.660599 | Checking out repos 2026-05-09 03:08:43.743205 | Preparing playbooks 2026-05-09 03:08:45.010610 | Running Ansible setup 2026-05-09 03:08:50.354404 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-09 03:08:51.308863 | 2026-05-09 03:08:51.308980 | PLAY [Base pre] 2026-05-09 03:08:51.329421 | 2026-05-09 03:08:51.329539 | TASK [Setup log path fact] 2026-05-09 03:08:51.356913 | debian-bookworm | ok 2026-05-09 03:08:51.376659 | 2026-05-09 03:08:51.376786 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 03:08:51.436500 | debian-bookworm | ok 2026-05-09 03:08:51.444591 | 2026-05-09 03:08:51.444684 | TASK [emit-job-header : Print job information] 2026-05-09 03:08:51.519137 | # Job Information 2026-05-09 03:08:51.519339 | Ansible Version: 2.16.14 2026-05-09 03:08:51.519427 | Job: python-black 2026-05-09 03:08:51.519463 | Pipeline: periodic-daily 2026-05-09 03:08:51.519484 | Executor: 521e9411259a 2026-05-09 03:08:51.519502 | Triggered by: https://github.com/osism/mappings 2026-05-09 03:08:51.519522 | Event ID: 76dd3a6b64a54cc788c6968e62652067 2026-05-09 03:08:51.523628 | 2026-05-09 03:08:51.523704 | LOOP [emit-job-header : Print node information] 2026-05-09 03:08:51.724637 | debian-bookworm | ok: 2026-05-09 03:08:51.725774 | debian-bookworm | # Node Information 2026-05-09 03:08:51.725854 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-09 03:08:51.725884 | debian-bookworm | Hostname: debian 2026-05-09 03:08:51.725907 | debian-bookworm | Username: zuul 2026-05-09 03:08:51.725929 | debian-bookworm | Distro: Debian 12.13 2026-05-09 03:08:51.725961 | debian-bookworm | Provider: regiocloud-a 2026-05-09 03:08:51.725987 | debian-bookworm | Region: 2026-05-09 03:08:51.726009 | debian-bookworm | Label: debian-bookworm 2026-05-09 03:08:51.726029 | debian-bookworm | Product Name: OpenStack Nova 2026-05-09 03:08:51.726198 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5b:c15d 2026-05-09 03:08:51.746027 | 2026-05-09 03:08:51.746143 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-09 03:08:52.771486 | debian-bookworm -> localhost | changed 2026-05-09 03:08:52.777438 | 2026-05-09 03:08:52.777529 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-09 03:08:55.043985 | debian-bookworm -> localhost | changed 2026-05-09 03:08:55.053121 | 2026-05-09 03:08:55.053213 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-09 03:08:55.400607 | debian-bookworm -> localhost | ok 2026-05-09 03:08:55.405817 | 2026-05-09 03:08:55.405906 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-09 03:08:55.435690 | debian-bookworm | ok 2026-05-09 03:08:55.467995 | debian-bookworm | included: /var/lib/zuul/builds/f95b585e925346b9b1c5a8e8ef793264/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-09 03:08:55.475507 | 2026-05-09 03:08:55.475611 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-09 03:08:58.039036 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-09 03:08:58.039254 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f95b585e925346b9b1c5a8e8ef793264/work/f95b585e925346b9b1c5a8e8ef793264_id_rsa 2026-05-09 03:08:58.039292 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f95b585e925346b9b1c5a8e8ef793264/work/f95b585e925346b9b1c5a8e8ef793264_id_rsa.pub 2026-05-09 03:08:58.039320 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-09 03:08:58.039344 | debian-bookworm -> localhost | SHA256:9/QaOCmFtgv2qDoLAswAOy/Yb5m8fOgKsA2rmU44+6c zuul-build-sshkey 2026-05-09 03:08:58.039366 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-09 03:08:58.039398 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-09 03:08:58.039421 | debian-bookworm -> localhost | |. | 2026-05-09 03:08:58.039443 | debian-bookworm -> localhost | |.. | 2026-05-09 03:08:58.039464 | debian-bookworm -> localhost | |+ | 2026-05-09 03:08:58.039484 | debian-bookworm -> localhost | |=+ . | 2026-05-09 03:08:58.039504 | debian-bookworm -> localhost | |*oo S o . | 2026-05-09 03:08:58.039527 | debian-bookworm -> localhost | |+* o o . + = . | 2026-05-09 03:08:58.039548 | debian-bookworm -> localhost | |O.. *.o o + o . | 2026-05-09 03:08:58.039568 | debian-bookworm -> localhost | |+B.ooo.+ o . o | 2026-05-09 03:08:58.039589 | debian-bookworm -> localhost | |*oEO=o. o . | 2026-05-09 03:08:58.039609 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-09 03:08:58.039664 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.884245 2026-05-09 03:08:58.045815 | 2026-05-09 03:08:58.045907 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-09 03:08:58.065718 | debian-bookworm | ok 2026-05-09 03:08:58.074496 | debian-bookworm | included: /var/lib/zuul/builds/f95b585e925346b9b1c5a8e8ef793264/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-09 03:08:58.084830 | 2026-05-09 03:08:58.084918 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-09 03:08:58.098970 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:08:58.105212 | 2026-05-09 03:08:58.105319 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-09 03:08:58.927511 | debian-bookworm | changed 2026-05-09 03:08:58.934941 | 2026-05-09 03:08:58.935060 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-09 03:08:59.205914 | debian-bookworm | ok 2026-05-09 03:08:59.210955 | 2026-05-09 03:08:59.211062 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-09 03:08:59.968227 | debian-bookworm | changed 2026-05-09 03:08:59.974083 | 2026-05-09 03:08:59.974176 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-09 03:09:00.692415 | debian-bookworm | changed 2026-05-09 03:09:00.699536 | 2026-05-09 03:09:00.699638 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-09 03:09:00.723336 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:09:00.731677 | 2026-05-09 03:09:00.731786 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-09 03:09:01.177604 | debian-bookworm -> localhost | changed 2026-05-09 03:09:01.192992 | 2026-05-09 03:09:01.193097 | TASK [add-build-sshkey : Add back temp key] 2026-05-09 03:09:01.571420 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f95b585e925346b9b1c5a8e8ef793264/work/f95b585e925346b9b1c5a8e8ef793264_id_rsa (zuul-build-sshkey) 2026-05-09 03:09:01.571637 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009619 2026-05-09 03:09:01.579749 | 2026-05-09 03:09:01.579849 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-09 03:09:01.974257 | debian-bookworm | ok 2026-05-09 03:09:01.989704 | 2026-05-09 03:09:01.989810 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-09 03:09:02.012930 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:09:02.024233 | 2026-05-09 03:09:02.024343 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-09 03:09:02.517374 | debian-bookworm | ok 2026-05-09 03:09:02.538796 | 2026-05-09 03:09:02.538921 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-09 03:09:02.577219 | debian-bookworm | ok 2026-05-09 03:09:02.582584 | 2026-05-09 03:09:02.582675 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-09 03:09:02.872776 | debian-bookworm -> localhost | ok 2026-05-09 03:09:02.878136 | 2026-05-09 03:09:02.878218 | TASK [validate-host : Collect information about the host] 2026-05-09 03:09:04.043751 | debian-bookworm | ok 2026-05-09 03:09:04.052786 | 2026-05-09 03:09:04.052876 | TASK [validate-host : Sanitize hostname] 2026-05-09 03:09:04.154935 | debian-bookworm | ok 2026-05-09 03:09:04.199099 | 2026-05-09 03:09:04.199479 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-09 03:09:04.928915 | debian-bookworm -> localhost | changed 2026-05-09 03:09:04.935685 | 2026-05-09 03:09:04.935787 | TASK [validate-host : Collect information about zuul worker] 2026-05-09 03:09:05.374723 | debian-bookworm | ok 2026-05-09 03:09:05.383949 | 2026-05-09 03:09:05.384096 | TASK [validate-host : Write out all zuul information for each host] 2026-05-09 03:09:06.164203 | debian-bookworm -> localhost | changed 2026-05-09 03:09:06.176267 | 2026-05-09 03:09:06.176368 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-09 03:09:06.453399 | debian-bookworm | ok 2026-05-09 03:09:06.469446 | 2026-05-09 03:09:06.469563 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-09 03:09:07.627417 | debian-bookworm | changed: 2026-05-09 03:09:07.627661 | debian-bookworm | cd+++++++++ src/ 2026-05-09 03:09:07.627697 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-09 03:09:07.627721 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-09 03:09:07.627742 | debian-bookworm | cd+++++++++ src/github.com/osism/mappings/ 2026-05-09 03:09:07.627763 | debian-bookworm | Containerfile 2026-05-09 03:09:07.627838 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/f95b585e925346b9b1c5a8e8ef793264/work/logs" 2026-05-09 03:09:36.279883 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f95b585e925346b9b1c5a8e8ef793264/work/artifacts" 2026-05-09 03:09:36.691606 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f95b585e925346b9b1c5a8e8ef793264/work/docs" 2026-05-09 03:09:36.700773 | 2026-05-09 03:09:36.700870 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-09 03:09:37.627764 | debian-bookworm | changed: 2026-05-09 03:09:37.628000 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-09 03:09:37.628040 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-09 03:09:37.628072 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-09 03:09:37.628118 | debian-bookworm | changed: All items complete 2026-05-09 03:09:37.628145 | 2026-05-09 03:09:38.573196 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 03:09:39.435441 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 03:09:39.453405 | 2026-05-09 03:09:39.453540 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-09 03:09:39.478529 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:09:39.482344 | debian-bookworm | skipping: Conditional result was False 2026-05-09 03:09:39.496457 | 2026-05-09 03:09:39.496562 | PLAY RECAP 2026-05-09 03:09:39.496616 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-09 03:09:39.496641 | 2026-05-09 03:09:39.774703 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-09 03:09:39.775368 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 03:09:40.862369 | 2026-05-09 03:09:40.862522 | PLAY [Base post] 2026-05-09 03:09:40.877785 | 2026-05-09 03:09:40.877910 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-09 03:09:41.585742 | debian-bookworm | changed 2026-05-09 03:09:41.594198 | 2026-05-09 03:09:41.594300 | PLAY RECAP 2026-05-09 03:09:41.594362 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-09 03:09:41.594423 | 2026-05-09 03:09:41.765281 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 03:09:41.766259 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-09 03:09:42.849692 | 2026-05-09 03:09:42.849950 | PLAY [Base post-logs] 2026-05-09 03:09:42.885618 | 2026-05-09 03:09:42.885763 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-09 03:09:43.824155 | localhost | changed 2026-05-09 03:09:43.846619 | 2026-05-09 03:09:43.846788 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-09 03:09:43.894727 | localhost | ok 2026-05-09 03:09:43.898404 | 2026-05-09 03:09:43.898506 | TASK [Set zuul-log-path fact] 2026-05-09 03:09:43.923821 | localhost | ok 2026-05-09 03:09:43.932507 | 2026-05-09 03:09:43.932644 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 03:09:43.973360 | localhost | ok 2026-05-09 03:09:43.976536 | 2026-05-09 03:09:43.976632 | TASK [upload-logs : Create log directories] 2026-05-09 03:09:44.791996 | localhost | changed 2026-05-09 03:09:44.794745 | 2026-05-09 03:09:44.794930 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-09 03:09:45.271568 | localhost -> localhost | ok: Runtime: 0:00:00.027940 2026-05-09 03:09:45.275979 | 2026-05-09 03:09:45.276086 | TASK [upload-logs : Upload logs to log server] 2026-05-09 03:09:45.987661 | localhost | Output suppressed because no_log was given 2026-05-09 03:09:45.989775 | 2026-05-09 03:09:45.989862 | LOOP [upload-logs : Compress console log and json output] 2026-05-09 03:09:46.046019 | localhost | skipping: Conditional result was False 2026-05-09 03:09:46.054664 | localhost | skipping: Conditional result was False 2026-05-09 03:09:46.066170 | 2026-05-09 03:09:46.066291 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-09 03:09:46.112431 | localhost | skipping: Conditional result was False 2026-05-09 03:09:46.112694 | 2026-05-09 03:09:46.116279 | localhost | skipping: Conditional result was False 2026-05-09 03:09:46.122888 | 2026-05-09 03:09:46.123012 | LOOP [upload-logs : Upload console log and json output]