2025-09-16 03:15:33.281233 | Job console starting 2025-09-16 03:15:33.290110 | Updating git repos 2025-09-16 03:15:33.311186 | Cloning repos into workspace 2025-09-16 03:15:33.338364 | Restoring repo states 2025-09-16 03:15:33.342958 | Merging changes 2025-09-16 03:15:33.342976 | Checking out repos 2025-09-16 03:15:33.376403 | Preparing playbooks 2025-09-16 03:15:34.012708 | Running Ansible setup 2025-09-16 03:15:38.354889 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-16 03:15:39.103832 | 2025-09-16 03:15:39.104009 | PLAY [Base pre] 2025-09-16 03:15:39.120700 | 2025-09-16 03:15:39.120873 | TASK [Setup log path fact] 2025-09-16 03:15:39.142148 | debian-bookworm | ok 2025-09-16 03:15:39.157400 | 2025-09-16 03:15:39.157548 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-16 03:15:39.197269 | debian-bookworm | ok 2025-09-16 03:15:39.207091 | 2025-09-16 03:15:39.207208 | TASK [emit-job-header : Print job information] 2025-09-16 03:15:39.246116 | # Job Information 2025-09-16 03:15:39.246298 | Ansible Version: 2.16.14 2025-09-16 03:15:39.246333 | Job: python-black 2025-09-16 03:15:39.246364 | Pipeline: periodic-daily 2025-09-16 03:15:39.246387 | Executor: 521e9411259a 2025-09-16 03:15:39.246407 | Triggered by: https://github.com/osism/node-image 2025-09-16 03:15:39.246430 | Event ID: e1d893c8c77845e39f31c9f3537cd81d 2025-09-16 03:15:39.251330 | 2025-09-16 03:15:39.251441 | LOOP [emit-job-header : Print node information] 2025-09-16 03:15:39.355921 | debian-bookworm | ok: 2025-09-16 03:15:39.356183 | debian-bookworm | # Node Information 2025-09-16 03:15:39.356218 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-16 03:15:39.356243 | debian-bookworm | Hostname: debian 2025-09-16 03:15:39.356266 | debian-bookworm | Username: zuul 2025-09-16 03:15:39.356287 | debian-bookworm | Distro: Debian 12.12 2025-09-16 03:15:39.356309 | debian-bookworm | Provider: regiocloud-a 2025-09-16 03:15:39.356330 | debian-bookworm | Region: 2025-09-16 03:15:39.356351 | debian-bookworm | Label: debian-bookworm 2025-09-16 03:15:39.356371 | debian-bookworm | Product Name: OpenStack Nova 2025-09-16 03:15:39.356391 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feba:ccf1 2025-09-16 03:15:39.379844 | 2025-09-16 03:15:39.379991 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-16 03:15:39.863460 | debian-bookworm -> localhost | changed 2025-09-16 03:15:39.885329 | 2025-09-16 03:15:39.885571 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-16 03:15:41.049532 | debian-bookworm -> localhost | changed 2025-09-16 03:15:41.072736 | 2025-09-16 03:15:41.072945 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-16 03:15:41.331963 | debian-bookworm -> localhost | ok 2025-09-16 03:15:41.346544 | 2025-09-16 03:15:41.346719 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-16 03:15:41.384520 | debian-bookworm | ok 2025-09-16 03:15:41.407346 | debian-bookworm | included: /var/lib/zuul/builds/d5ab599a1862447c963632a9a9d45626/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-16 03:15:41.413565 | 2025-09-16 03:15:41.413659 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-16 03:15:42.964052 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-16 03:15:42.964320 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d5ab599a1862447c963632a9a9d45626/work/d5ab599a1862447c963632a9a9d45626_id_rsa 2025-09-16 03:15:42.964364 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d5ab599a1862447c963632a9a9d45626/work/d5ab599a1862447c963632a9a9d45626_id_rsa.pub 2025-09-16 03:15:42.964391 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-16 03:15:42.964416 | debian-bookworm -> localhost | SHA256:NCp3f+PtW9gyRj4ie0GAgw22vv/t63lDXgtxDYE4MYs zuul-build-sshkey 2025-09-16 03:15:42.964439 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-16 03:15:42.964471 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-16 03:15:42.964495 | debian-bookworm -> localhost | | o+ .oo ... | 2025-09-16 03:15:42.964519 | debian-bookworm -> localhost | | ...+.+o. . | 2025-09-16 03:15:42.964539 | debian-bookworm -> localhost | | . E..o ..| 2025-09-16 03:15:42.964559 | debian-bookworm -> localhost | | . o . .. ..| 2025-09-16 03:15:42.964579 | debian-bookworm -> localhost | | . + S . + | 2025-09-16 03:15:42.964602 | debian-bookworm -> localhost | | o o . .+.o.| 2025-09-16 03:15:42.964624 | debian-bookworm -> localhost | | . o ++O.+| 2025-09-16 03:15:42.964644 | debian-bookworm -> localhost | | . *.*+* | 2025-09-16 03:15:42.964664 | debian-bookworm -> localhost | | ..o+B++o | 2025-09-16 03:15:42.964684 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-16 03:15:42.964746 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.936625 2025-09-16 03:15:42.975859 | 2025-09-16 03:15:42.976114 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-16 03:15:43.008932 | debian-bookworm | ok 2025-09-16 03:15:43.032212 | debian-bookworm | included: /var/lib/zuul/builds/d5ab599a1862447c963632a9a9d45626/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-16 03:15:43.046648 | 2025-09-16 03:15:43.046780 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-16 03:15:43.073935 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:15:43.083163 | 2025-09-16 03:15:43.083495 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-16 03:15:43.748504 | debian-bookworm | changed 2025-09-16 03:15:43.762776 | 2025-09-16 03:15:43.762967 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-16 03:15:44.117780 | debian-bookworm | ok 2025-09-16 03:15:44.129271 | 2025-09-16 03:15:44.129413 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-16 03:15:44.945558 | debian-bookworm | changed 2025-09-16 03:15:44.957311 | 2025-09-16 03:15:44.957457 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-16 03:15:45.631292 | debian-bookworm | changed 2025-09-16 03:15:45.641193 | 2025-09-16 03:15:45.641327 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-16 03:15:45.677013 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:15:45.683913 | 2025-09-16 03:15:45.684034 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-16 03:15:46.430538 | debian-bookworm -> localhost | changed 2025-09-16 03:15:46.441638 | 2025-09-16 03:15:46.441761 | TASK [add-build-sshkey : Add back temp key] 2025-09-16 03:15:47.265874 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d5ab599a1862447c963632a9a9d45626/work/d5ab599a1862447c963632a9a9d45626_id_rsa (zuul-build-sshkey) 2025-09-16 03:15:47.266128 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.037838 2025-09-16 03:15:47.274293 | 2025-09-16 03:15:47.274418 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-16 03:15:47.878975 | debian-bookworm | ok 2025-09-16 03:15:47.885537 | 2025-09-16 03:15:47.885657 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-16 03:15:47.925188 | debian-bookworm | skipping: Conditional result was False 2025-09-16 03:15:47.936007 | 2025-09-16 03:15:47.936132 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-16 03:15:48.425997 | debian-bookworm | ok 2025-09-16 03:15:48.437717 | 2025-09-16 03:15:48.437860 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-16 03:15:48.467758 | debian-bookworm | ok 2025-09-16 03:15:48.473100 | 2025-09-16 03:15:48.473223 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-16 03:15:48.958717 | debian-bookworm -> localhost | ok 2025-09-16 03:15:48.965608 | 2025-09-16 03:15:48.965725 | TASK [validate-host : Collect information about the host] 2025-09-16 03:15:50.496911 | debian-bookworm | ok 2025-09-16 03:15:50.513538 | 2025-09-16 03:15:50.513664 | TASK [validate-host : Sanitize hostname] 2025-09-16 03:15:50.745059 | debian-bookworm | ok 2025-09-16 03:15:50.864619 | 2025-09-16 03:15:50.864727 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-16 03:15:51.941649 | debian-bookworm -> localhost | changed 2025-09-16 03:15:51.947060 | 2025-09-16 03:15:51.947148 | TASK [validate-host : Collect information about zuul worker] 2025-09-16 03:15:52.512602 | debian-bookworm | ok 2025-09-16 03:15:52.516391 | 2025-09-16 03:15:52.516474 | TASK [validate-host : Write out all zuul information for each host] 2025-09-16 03:15:53.565579 | debian-bookworm -> localhost | changed 2025-09-16 03:15:53.573340 | 2025-09-16 03:15:53.573417 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-16 03:15:53.851792 | debian-bookworm | ok 2025-09-16 03:15:53.856184 | 2025-09-16 03:15:53.856260 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-16 03:15:55.739629 | debian-bookworm | changed: 2025-09-16 03:15:55.739769 | debian-bookworm | cd+++++++++ src/ 2025-09-16 03:15:55.739808 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-16 03:15:55.739828 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-16 03:15:55.739845 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-09-16 03:15:55.739862 | debian-bookworm | Containerfile 2025-09-16 03:15:55.739969 | debian-bookworm | localhost | ok: Runtime: 0:00:00.022766 2025-09-16 03:16:22.722237 | 2025-09-16 03:16:22.722329 | TASK [upload-logs : Upload logs to log server] 2025-09-16 03:16:23.671209 | localhost | Output suppressed because no_log was given 2025-09-16 03:16:23.672798 | 2025-09-16 03:16:23.672881 | LOOP [upload-logs : Compress console log and json output] 2025-09-16 03:16:23.714370 | localhost | skipping: Conditional result was False 2025-09-16 03:16:23.718980 | localhost | skipping: Conditional result was False 2025-09-16 03:16:23.729339 | 2025-09-16 03:16:23.729435 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-16 03:16:23.769447 | localhost | skipping: Conditional result was False 2025-09-16 03:16:23.769687 | 2025-09-16 03:16:23.782868 | localhost | skipping: Conditional result was False 2025-09-16 03:16:23.795304 | 2025-09-16 03:16:23.795403 | LOOP [upload-logs : Upload console log and json output]