2025-09-08 03:05:40.635223 | Job console starting 2025-09-08 03:05:40.648721 | Updating git repos 2025-09-08 03:05:40.728178 | Cloning repos into workspace 2025-09-08 03:05:40.795241 | Restoring repo states 2025-09-08 03:05:40.811215 | Merging changes 2025-09-08 03:05:40.811230 | Checking out repos 2025-09-08 03:05:40.919455 | Preparing playbooks 2025-09-08 03:05:42.125767 | Running Ansible setup 2025-09-08 03:05:47.716033 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-08 03:05:49.402239 | 2025-09-08 03:05:49.402409 | PLAY [Base pre] 2025-09-08 03:05:49.452686 | 2025-09-08 03:05:49.452842 | TASK [Setup log path fact] 2025-09-08 03:05:49.494747 | debian-bookworm | ok 2025-09-08 03:05:49.554979 | 2025-09-08 03:05:49.555151 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-08 03:05:49.595511 | debian-bookworm | ok 2025-09-08 03:05:49.610190 | 2025-09-08 03:05:49.610337 | TASK [emit-job-header : Print job information] 2025-09-08 03:05:49.712365 | # Job Information 2025-09-08 03:05:49.712543 | Ansible Version: 2.16.14 2025-09-08 03:05:49.712579 | Job: python-black 2025-09-08 03:05:49.712610 | Pipeline: periodic-daily 2025-09-08 03:05:49.712633 | Executor: 521e9411259a 2025-09-08 03:05:49.712654 | Triggered by: https://github.com/osism/rookify 2025-09-08 03:05:49.712675 | Event ID: 9d3af4aea632484fa26bcc0256d913be 2025-09-08 03:05:49.727803 | 2025-09-08 03:05:49.727925 | LOOP [emit-job-header : Print node information] 2025-09-08 03:05:49.957580 | debian-bookworm | ok: 2025-09-08 03:05:49.957743 | debian-bookworm | # Node Information 2025-09-08 03:05:49.957776 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-08 03:05:49.957801 | debian-bookworm | Hostname: debian 2025-09-08 03:05:49.957823 | debian-bookworm | Username: zuul 2025-09-08 03:05:49.957843 | debian-bookworm | Distro: Debian 12.12 2025-09-08 03:05:49.957866 | debian-bookworm | Provider: regiocloud-a 2025-09-08 03:05:49.957887 | debian-bookworm | Region: 2025-09-08 03:05:49.957907 | debian-bookworm | Label: debian-bookworm 2025-09-08 03:05:49.957927 | debian-bookworm | Product Name: OpenStack Nova 2025-09-08 03:05:49.957947 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaf:8982 2025-09-08 03:05:49.990157 | 2025-09-08 03:05:49.990292 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-08 03:05:50.972174 | debian-bookworm -> localhost | changed 2025-09-08 03:05:50.980821 | 2025-09-08 03:05:50.980962 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-08 03:05:53.265342 | debian-bookworm -> localhost | changed 2025-09-08 03:05:53.274594 | 2025-09-08 03:05:53.274686 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-08 03:05:53.656034 | debian-bookworm -> localhost | ok 2025-09-08 03:05:53.662193 | 2025-09-08 03:05:53.662297 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-08 03:05:53.712129 | debian-bookworm | ok 2025-09-08 03:05:53.746391 | debian-bookworm | included: /var/lib/zuul/builds/2dca016bec314c23b4391e563f192c97/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-08 03:05:53.760708 | 2025-09-08 03:05:53.760809 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-08 03:05:56.738202 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-08 03:05:56.738451 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2dca016bec314c23b4391e563f192c97/work/2dca016bec314c23b4391e563f192c97_id_rsa 2025-09-08 03:05:56.738493 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2dca016bec314c23b4391e563f192c97/work/2dca016bec314c23b4391e563f192c97_id_rsa.pub 2025-09-08 03:05:56.738520 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-08 03:05:56.738544 | debian-bookworm -> localhost | SHA256:j6LwYoVdIExxQAM0xlJtmrDinZAYd8q1qRLkCXz6Ocg zuul-build-sshkey 2025-09-08 03:05:56.738567 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-08 03:05:56.738636 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-08 03:05:56.738659 | debian-bookworm -> localhost | |=XB+. | 2025-09-08 03:05:56.738681 | debian-bookworm -> localhost | |*+=+* | 2025-09-08 03:05:56.738702 | debian-bookworm -> localhost | |**=O + | 2025-09-08 03:05:56.738722 | debian-bookworm -> localhost | |=*= o . | 2025-09-08 03:05:56.738742 | debian-bookworm -> localhost | |+.=+o. S | 2025-09-08 03:05:56.738769 | debian-bookworm -> localhost | |.Eo*o o | 2025-09-08 03:05:56.738789 | debian-bookworm -> localhost | | .... . . . | 2025-09-08 03:05:56.738809 | debian-bookworm -> localhost | | oo . . | 2025-09-08 03:05:56.738844 | debian-bookworm -> localhost | | . .o | 2025-09-08 03:05:56.738867 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-08 03:05:56.738925 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.947052 2025-09-08 03:05:56.746175 | 2025-09-08 03:05:56.746272 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-08 03:05:56.790042 | debian-bookworm | ok 2025-09-08 03:05:56.799486 | debian-bookworm | included: /var/lib/zuul/builds/2dca016bec314c23b4391e563f192c97/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-08 03:05:56.809132 | 2025-09-08 03:05:56.809216 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-08 03:05:56.832954 | debian-bookworm | skipping: Conditional result was False 2025-09-08 03:05:56.838539 | 2025-09-08 03:05:56.838623 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-08 03:05:57.609539 | debian-bookworm | changed 2025-09-08 03:05:57.617977 | 2025-09-08 03:05:57.618079 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-08 03:05:57.871125 | debian-bookworm | ok 2025-09-08 03:05:57.880636 | 2025-09-08 03:05:57.880735 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-08 03:05:58.515179 | debian-bookworm | changed 2025-09-08 03:05:58.522966 | 2025-09-08 03:05:58.523104 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-08 03:05:59.296518 | debian-bookworm | changed 2025-09-08 03:05:59.315860 | 2025-09-08 03:05:59.315964 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-08 03:05:59.384475 | debian-bookworm | skipping: Conditional result was False 2025-09-08 03:05:59.391920 | 2025-09-08 03:05:59.392026 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-08 03:06:00.262616 | debian-bookworm -> localhost | changed 2025-09-08 03:06:00.273364 | 2025-09-08 03:06:00.273458 | TASK [add-build-sshkey : Add back temp key] 2025-09-08 03:06:01.079078 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2dca016bec314c23b4391e563f192c97/work/2dca016bec314c23b4391e563f192c97_id_rsa (zuul-build-sshkey) 2025-09-08 03:06:01.079345 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010939 2025-09-08 03:06:01.087104 | 2025-09-08 03:06:01.087205 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-08 03:06:01.756395 | debian-bookworm | ok 2025-09-08 03:06:01.764994 | 2025-09-08 03:06:01.765089 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-08 03:06:01.793749 | debian-bookworm | skipping: Conditional result was False 2025-09-08 03:06:01.807621 | 2025-09-08 03:06:01.807750 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-08 03:06:02.325992 | debian-bookworm | ok 2025-09-08 03:06:02.356590 | 2025-09-08 03:06:02.356725 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-08 03:06:02.406962 | debian-bookworm | ok 2025-09-08 03:06:02.411922 | 2025-09-08 03:06:02.412021 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-08 03:06:03.102787 | debian-bookworm -> localhost | ok 2025-09-08 03:06:03.108292 | 2025-09-08 03:06:03.108388 | TASK [validate-host : Collect information about the host] 2025-09-08 03:06:04.240215 | debian-bookworm | ok 2025-09-08 03:06:04.269189 | 2025-09-08 03:06:04.269296 | TASK [validate-host : Sanitize hostname] 2025-09-08 03:06:04.438787 | debian-bookworm | ok 2025-09-08 03:06:04.510243 | 2025-09-08 03:06:04.510364 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-08 03:06:05.227319 | debian-bookworm -> localhost | changed 2025-09-08 03:06:05.233592 | 2025-09-08 03:06:05.233686 | TASK [validate-host : Collect information about zuul worker] 2025-09-08 03:06:05.653604 | debian-bookworm | ok 2025-09-08 03:06:05.657464 | 2025-09-08 03:06:05.657543 | TASK [validate-host : Write out all zuul information for each host] 2025-09-08 03:06:06.257432 | debian-bookworm -> localhost | changed 2025-09-08 03:06:06.273864 | 2025-09-08 03:06:06.273985 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-08 03:06:06.552870 | debian-bookworm | ok 2025-09-08 03:06:06.557342 | 2025-09-08 03:06:06.557421 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-08 03:06:07.315458 | debian-bookworm | changed: 2025-09-08 03:06:07.315625 | debian-bookworm | cd+++++++++ src/ 2025-09-08 03:06:07.315658 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-08 03:06:07.315682 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-08 03:06:07.315704 | debian-bookworm | cd+++++++++ src/github.com/osism/rookify/ 2025-09-08 03:06:07.315724 | debian-bookworm | Containerfile 2025-09-08 03:06:07.315873 | debian-bookworm | localhost | ok: Runtime: 0:00:00.018268 2025-09-08 03:06:34.233636 | 2025-09-08 03:06:34.233727 | TASK [upload-logs : Upload logs to log server] 2025-09-08 03:06:35.845555 | localhost | Output suppressed because no_log was given 2025-09-08 03:06:35.846946 | 2025-09-08 03:06:35.847023 | LOOP [upload-logs : Compress console log and json output] 2025-09-08 03:06:35.936519 | localhost | skipping: Conditional result was False 2025-09-08 03:06:35.943336 | localhost | skipping: Conditional result was False 2025-09-08 03:06:35.955596 | 2025-09-08 03:06:35.955692 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-08 03:06:36.070977 | localhost | skipping: Conditional result was False 2025-09-08 03:06:36.071921 | 2025-09-08 03:06:36.076984 | localhost | skipping: Conditional result was False 2025-09-08 03:06:36.083990 | 2025-09-08 03:06:36.084091 | LOOP [upload-logs : Upload console log and json output]