2025-10-12 03:13:42.148745 | Job console starting 2025-10-12 03:13:42.157078 | Updating git repos 2025-10-12 03:13:42.191565 | Cloning repos into workspace 2025-10-12 03:13:42.292925 | Restoring repo states 2025-10-12 03:13:42.305924 | Merging changes 2025-10-12 03:13:42.305940 | Checking out repos 2025-10-12 03:13:42.377549 | Preparing playbooks 2025-10-12 03:13:43.331309 | Running Ansible setup 2025-10-12 03:13:48.363775 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-12 03:13:49.292864 | 2025-10-12 03:13:49.292977 | PLAY [Base pre] 2025-10-12 03:13:49.314155 | 2025-10-12 03:13:49.314261 | TASK [Setup log path fact] 2025-10-12 03:13:49.355467 | debian-bookworm | ok 2025-10-12 03:13:49.375331 | 2025-10-12 03:13:49.375476 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-12 03:13:49.423053 | debian-bookworm | ok 2025-10-12 03:13:49.430740 | 2025-10-12 03:13:49.430855 | TASK [emit-job-header : Print job information] 2025-10-12 03:13:49.485455 | # Job Information 2025-10-12 03:13:49.485586 | Ansible Version: 2.16.14 2025-10-12 03:13:49.485614 | Job: python-black 2025-10-12 03:13:49.485641 | Pipeline: periodic-daily 2025-10-12 03:13:49.485660 | Executor: 521e9411259a 2025-10-12 03:13:49.485676 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-10-12 03:13:49.485693 | Event ID: 8a4ac61cc1204a1fa0b7670c75d45bb7 2025-10-12 03:13:49.489668 | 2025-10-12 03:13:49.489750 | LOOP [emit-job-header : Print node information] 2025-10-12 03:13:49.730368 | debian-bookworm | ok: 2025-10-12 03:13:49.730519 | debian-bookworm | # Node Information 2025-10-12 03:13:49.730549 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-12 03:13:49.730570 | debian-bookworm | Hostname: debian 2025-10-12 03:13:49.730587 | debian-bookworm | Username: zuul 2025-10-12 03:13:49.730604 | debian-bookworm | Distro: Debian 12.12 2025-10-12 03:13:49.730623 | debian-bookworm | Provider: regiocloud-a 2025-10-12 03:13:49.730640 | debian-bookworm | Region: 2025-10-12 03:13:49.730657 | debian-bookworm | Label: debian-bookworm 2025-10-12 03:13:49.730674 | debian-bookworm | Product Name: OpenStack Nova 2025-10-12 03:13:49.730690 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe27:ae9f 2025-10-12 03:13:49.742005 | 2025-10-12 03:13:49.742104 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-12 03:13:50.522380 | debian-bookworm -> localhost | changed 2025-10-12 03:13:50.528888 | 2025-10-12 03:13:50.528979 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-12 03:13:51.898329 | debian-bookworm -> localhost | changed 2025-10-12 03:13:51.912626 | 2025-10-12 03:13:51.912726 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-12 03:13:52.268469 | debian-bookworm -> localhost | ok 2025-10-12 03:13:52.279908 | 2025-10-12 03:13:52.280006 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-12 03:13:52.306392 | debian-bookworm | ok 2025-10-12 03:13:52.323212 | debian-bookworm | included: /var/lib/zuul/builds/e0c6c0b4b05d43a3845822c9b2a75a52/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-12 03:13:52.327946 | 2025-10-12 03:13:52.328017 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-12 03:13:54.137782 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-12 03:13:54.137969 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e0c6c0b4b05d43a3845822c9b2a75a52/work/e0c6c0b4b05d43a3845822c9b2a75a52_id_rsa 2025-10-12 03:13:54.138006 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e0c6c0b4b05d43a3845822c9b2a75a52/work/e0c6c0b4b05d43a3845822c9b2a75a52_id_rsa.pub 2025-10-12 03:13:54.138032 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-12 03:13:54.138056 | debian-bookworm -> localhost | SHA256:snLGvUj+Gwalg3sGX3qPE5ynXqr5r6eaDqYZrUu0qFc zuul-build-sshkey 2025-10-12 03:13:54.138079 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-12 03:13:54.138108 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-12 03:13:54.138130 | debian-bookworm -> localhost | | | 2025-10-12 03:13:54.138151 | debian-bookworm -> localhost | | | 2025-10-12 03:13:54.138171 | debian-bookworm -> localhost | | . | 2025-10-12 03:13:54.138190 | debian-bookworm -> localhost | | . o | 2025-10-12 03:13:54.138210 | debian-bookworm -> localhost | | . o =.S. | 2025-10-12 03:13:54.138232 | debian-bookworm -> localhost | | o oE= O+ . | 2025-10-12 03:13:54.138252 | debian-bookworm -> localhost | |. +.* @ =+. | 2025-10-12 03:13:54.138272 | debian-bookworm -> localhost | |...* X *oB. | 2025-10-12 03:13:54.138293 | debian-bookworm -> localhost | |..=. .O*@Bo | 2025-10-12 03:13:54.138312 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-12 03:13:54.138387 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.937716 2025-10-12 03:13:54.144559 | 2025-10-12 03:13:54.144651 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-12 03:13:54.184621 | debian-bookworm | ok 2025-10-12 03:13:54.194177 | debian-bookworm | included: /var/lib/zuul/builds/e0c6c0b4b05d43a3845822c9b2a75a52/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-12 03:13:54.205014 | 2025-10-12 03:13:54.205098 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-12 03:13:54.239241 | debian-bookworm | skipping: Conditional result was False 2025-10-12 03:13:54.244968 | 2025-10-12 03:13:54.245058 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-12 03:13:55.059507 | debian-bookworm | changed 2025-10-12 03:13:55.063987 | 2025-10-12 03:13:55.064062 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-12 03:13:55.366399 | debian-bookworm | ok 2025-10-12 03:13:55.376644 | 2025-10-12 03:13:55.376765 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-12 03:13:56.033553 | debian-bookworm | changed 2025-10-12 03:13:56.045036 | 2025-10-12 03:13:56.045140 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-12 03:13:56.674987 | debian-bookworm | changed 2025-10-12 03:13:56.684008 | 2025-10-12 03:13:56.684096 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-12 03:13:56.707007 | debian-bookworm | skipping: Conditional result was False 2025-10-12 03:13:56.711906 | 2025-10-12 03:13:56.711982 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-12 03:13:57.110531 | debian-bookworm -> localhost | changed 2025-10-12 03:13:57.118978 | 2025-10-12 03:13:57.119073 | TASK [add-build-sshkey : Add back temp key] 2025-10-12 03:13:57.474161 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e0c6c0b4b05d43a3845822c9b2a75a52/work/e0c6c0b4b05d43a3845822c9b2a75a52_id_rsa (zuul-build-sshkey) 2025-10-12 03:13:57.474396 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008073 2025-10-12 03:13:57.481346 | 2025-10-12 03:13:57.481429 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-12 03:13:57.878162 | debian-bookworm | ok 2025-10-12 03:13:57.882464 | 2025-10-12 03:13:57.882548 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-12 03:13:57.905110 | debian-bookworm | skipping: Conditional result was False 2025-10-12 03:13:57.913390 | 2025-10-12 03:13:57.913476 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-12 03:13:58.333640 | debian-bookworm | ok 2025-10-12 03:13:58.341979 | 2025-10-12 03:13:58.342063 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-12 03:13:58.381586 | debian-bookworm | ok 2025-10-12 03:13:58.387982 | 2025-10-12 03:13:58.388079 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-12 03:13:58.633013 | debian-bookworm -> localhost | ok 2025-10-12 03:13:58.638086 | 2025-10-12 03:13:58.638156 | TASK [validate-host : Collect information about the host] 2025-10-12 03:13:59.718533 | debian-bookworm | ok 2025-10-12 03:13:59.729880 | 2025-10-12 03:13:59.729974 | TASK [validate-host : Sanitize hostname] 2025-10-12 03:13:59.808517 | debian-bookworm | ok 2025-10-12 03:13:59.864737 | 2025-10-12 03:13:59.864828 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-12 03:14:00.417860 | debian-bookworm -> localhost | changed 2025-10-12 03:14:00.422383 | 2025-10-12 03:14:00.422464 | TASK [validate-host : Collect information about zuul worker] 2025-10-12 03:14:00.816424 | debian-bookworm | ok 2025-10-12 03:14:00.821134 | 2025-10-12 03:14:00.821224 | TASK [validate-host : Write out all zuul information for each host] 2025-10-12 03:14:01.463939 | debian-bookworm -> localhost | changed 2025-10-12 03:14:01.475601 | 2025-10-12 03:14:01.475691 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-12 03:14:01.731590 | debian-bookworm | ok 2025-10-12 03:14:01.739968 | 2025-10-12 03:14:01.740088 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-12 03:14:02.609166 | debian-bookworm | changed: 2025-10-12 03:14:02.609348 | debian-bookworm | cd+++++++++ src/ 2025-10-12 03:14:02.609383 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-12 03:14:02.609407 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-12 03:14:02.609429 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-10-12 03:14:02.609449 | debian-bookworm | Containerfile 2025-10-12 03:14:02.609580 | debian-bookworm | localhost | ok: Runtime: 0:00:00.035777 2025-10-12 03:14:28.408671 | 2025-10-12 03:14:28.408752 | TASK [upload-logs : Upload logs to log server] 2025-10-12 03:14:29.121150 | localhost | Output suppressed because no_log was given 2025-10-12 03:14:29.122989 | 2025-10-12 03:14:29.123071 | LOOP [upload-logs : Compress console log and json output] 2025-10-12 03:14:29.173632 | localhost | skipping: Conditional result was False 2025-10-12 03:14:29.190400 | localhost | skipping: Conditional result was False 2025-10-12 03:14:29.200569 | 2025-10-12 03:14:29.200664 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-12 03:14:29.286119 | localhost | skipping: Conditional result was False 2025-10-12 03:14:29.286910 | 2025-10-12 03:14:29.295832 | localhost | skipping: Conditional result was False 2025-10-12 03:14:29.308533 | 2025-10-12 03:14:29.308614 | LOOP [upload-logs : Upload console log and json output]