2025-09-22 03:11:32.529184 | Job console starting 2025-09-22 03:11:32.541250 | Updating git repos 2025-09-22 03:11:32.579309 | Cloning repos into workspace 2025-09-22 03:11:32.649538 | Restoring repo states 2025-09-22 03:11:32.662154 | Merging changes 2025-09-22 03:11:32.662176 | Checking out repos 2025-09-22 03:11:32.731249 | Preparing playbooks 2025-09-22 03:11:33.514704 | Running Ansible setup 2025-09-22 03:11:38.025289 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-22 03:11:38.779494 | 2025-09-22 03:11:38.779645 | PLAY [Base pre] 2025-09-22 03:11:38.795242 | 2025-09-22 03:11:38.795385 | TASK [Setup log path fact] 2025-09-22 03:11:38.828387 | debian-bookworm | ok 2025-09-22 03:11:38.843257 | 2025-09-22 03:11:38.843407 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-22 03:11:38.872602 | debian-bookworm | ok 2025-09-22 03:11:38.882184 | 2025-09-22 03:11:38.882288 | TASK [emit-job-header : Print job information] 2025-09-22 03:11:38.929822 | # Job Information 2025-09-22 03:11:38.930078 | Ansible Version: 2.16.14 2025-09-22 03:11:38.930142 | Job: python-black 2025-09-22 03:11:38.930200 | Pipeline: periodic-daily 2025-09-22 03:11:38.930240 | Executor: 521e9411259a 2025-09-22 03:11:38.930277 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-09-22 03:11:38.930337 | Event ID: 9043a7d075a6443191105692018c4bbf 2025-09-22 03:11:38.938104 | 2025-09-22 03:11:38.938249 | LOOP [emit-job-header : Print node information] 2025-09-22 03:11:39.057732 | debian-bookworm | ok: 2025-09-22 03:11:39.058019 | debian-bookworm | # Node Information 2025-09-22 03:11:39.058080 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-22 03:11:39.058125 | debian-bookworm | Hostname: debian 2025-09-22 03:11:39.058165 | debian-bookworm | Username: zuul 2025-09-22 03:11:39.058202 | debian-bookworm | Distro: Debian 12.12 2025-09-22 03:11:39.058243 | debian-bookworm | Provider: regiocloud-a 2025-09-22 03:11:39.058280 | debian-bookworm | Region: 2025-09-22 03:11:39.058333 | debian-bookworm | Label: debian-bookworm 2025-09-22 03:11:39.058369 | debian-bookworm | Product Name: OpenStack Nova 2025-09-22 03:11:39.058404 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5b:3b37 2025-09-22 03:11:39.084409 | 2025-09-22 03:11:39.084556 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-22 03:11:39.565767 | debian-bookworm -> localhost | changed 2025-09-22 03:11:39.581993 | 2025-09-22 03:11:39.582165 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-22 03:11:40.663868 | debian-bookworm -> localhost | changed 2025-09-22 03:11:40.685070 | 2025-09-22 03:11:40.685205 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-22 03:11:40.982829 | debian-bookworm -> localhost | ok 2025-09-22 03:11:40.989153 | 2025-09-22 03:11:40.989268 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-22 03:11:41.019251 | debian-bookworm | ok 2025-09-22 03:11:41.038079 | debian-bookworm | included: /var/lib/zuul/builds/ab5ff7fdd03e4709baa42fbad5a1ecb9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-22 03:11:41.044149 | 2025-09-22 03:11:41.044248 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-22 03:11:42.344460 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-22 03:11:42.344731 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ab5ff7fdd03e4709baa42fbad5a1ecb9/work/ab5ff7fdd03e4709baa42fbad5a1ecb9_id_rsa 2025-09-22 03:11:42.344782 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ab5ff7fdd03e4709baa42fbad5a1ecb9/work/ab5ff7fdd03e4709baa42fbad5a1ecb9_id_rsa.pub 2025-09-22 03:11:42.344816 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-22 03:11:42.344848 | debian-bookworm -> localhost | SHA256:bDLpo2Y8zTUGFDqt5NOe1rmwFl3FI9fyLPW5PZsZ3Ko zuul-build-sshkey 2025-09-22 03:11:42.344878 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-22 03:11:42.344920 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-22 03:11:42.344950 | debian-bookworm -> localhost | | .. . . | 2025-09-22 03:11:42.344979 | debian-bookworm -> localhost | | o. . * o | 2025-09-22 03:11:42.345006 | debian-bookworm -> localhost | | +.. + * ..| 2025-09-22 03:11:42.345032 | debian-bookworm -> localhost | | o +.o . . o..| 2025-09-22 03:11:42.345058 | debian-bookworm -> localhost | | + =oS. .. +| 2025-09-22 03:11:42.345089 | debian-bookworm -> localhost | | +.*=. =o| 2025-09-22 03:11:42.345116 | debian-bookworm -> localhost | | . oB+o. .*| 2025-09-22 03:11:42.345143 | debian-bookworm -> localhost | | =o++ . .+ | 2025-09-22 03:11:42.345170 | debian-bookworm -> localhost | | o.o. . E. | 2025-09-22 03:11:42.345196 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-22 03:11:42.345269 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.813037 2025-09-22 03:11:42.353400 | 2025-09-22 03:11:42.353527 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-22 03:11:42.385611 | debian-bookworm | ok 2025-09-22 03:11:42.399896 | debian-bookworm | included: /var/lib/zuul/builds/ab5ff7fdd03e4709baa42fbad5a1ecb9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-22 03:11:42.409437 | 2025-09-22 03:11:42.409548 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-22 03:11:42.424102 | debian-bookworm | skipping: Conditional result was False 2025-09-22 03:11:42.430083 | 2025-09-22 03:11:42.430187 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-22 03:11:43.050773 | debian-bookworm | changed 2025-09-22 03:11:43.060025 | 2025-09-22 03:11:43.060160 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-22 03:11:43.325149 | debian-bookworm | ok 2025-09-22 03:11:43.330871 | 2025-09-22 03:11:43.330979 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-22 03:11:44.039692 | debian-bookworm | changed 2025-09-22 03:11:44.050439 | 2025-09-22 03:11:44.050597 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-22 03:11:44.760391 | debian-bookworm | changed 2025-09-22 03:11:44.767526 | 2025-09-22 03:11:44.767640 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-22 03:11:44.791038 | debian-bookworm | skipping: Conditional result was False 2025-09-22 03:11:44.796897 | 2025-09-22 03:11:44.796997 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-22 03:11:45.247812 | debian-bookworm -> localhost | changed 2025-09-22 03:11:45.274147 | 2025-09-22 03:11:45.274372 | TASK [add-build-sshkey : Add back temp key] 2025-09-22 03:11:45.645666 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ab5ff7fdd03e4709baa42fbad5a1ecb9/work/ab5ff7fdd03e4709baa42fbad5a1ecb9_id_rsa (zuul-build-sshkey) 2025-09-22 03:11:45.646235 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023598 2025-09-22 03:11:45.668903 | 2025-09-22 03:11:45.669048 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-22 03:11:46.088356 | debian-bookworm | ok 2025-09-22 03:11:46.094486 | 2025-09-22 03:11:46.094605 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-22 03:11:46.129146 | debian-bookworm | skipping: Conditional result was False 2025-09-22 03:11:46.147156 | 2025-09-22 03:11:46.147288 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-22 03:11:46.592146 | debian-bookworm | ok 2025-09-22 03:11:46.604177 | 2025-09-22 03:11:46.604289 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-22 03:11:46.647224 | debian-bookworm | ok 2025-09-22 03:11:46.653744 | 2025-09-22 03:11:46.653860 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-22 03:11:46.952277 | debian-bookworm -> localhost | ok 2025-09-22 03:11:46.965500 | 2025-09-22 03:11:46.965636 | TASK [validate-host : Collect information about the host] 2025-09-22 03:11:48.080481 | debian-bookworm | ok 2025-09-22 03:11:48.093145 | 2025-09-22 03:11:48.093261 | TASK [validate-host : Sanitize hostname] 2025-09-22 03:11:48.226507 | debian-bookworm | ok 2025-09-22 03:11:48.307943 | 2025-09-22 03:11:48.308072 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-22 03:11:49.271867 | debian-bookworm -> localhost | changed 2025-09-22 03:11:49.279937 | 2025-09-22 03:11:49.280059 | TASK [validate-host : Collect information about zuul worker] 2025-09-22 03:11:49.810973 | debian-bookworm | ok 2025-09-22 03:11:49.820469 | 2025-09-22 03:11:49.820628 | TASK [validate-host : Write out all zuul information for each host] 2025-09-22 03:11:50.416903 | debian-bookworm -> localhost | changed 2025-09-22 03:11:50.433510 | 2025-09-22 03:11:50.433645 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-22 03:11:50.730651 | debian-bookworm | ok 2025-09-22 03:11:50.739260 | 2025-09-22 03:11:50.739419 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-22 03:11:51.641415 | debian-bookworm | changed: 2025-09-22 03:11:51.641721 | debian-bookworm | cd+++++++++ src/ 2025-09-22 03:11:51.641783 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-22 03:11:51.641826 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-22 03:11:51.641864 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-09-22 03:11:51.641901 | debian-bookworm | Containerfile 2025-09-22 03:11:51.642133 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008367 2025-09-22 03:12:15.787625 | 2025-09-22 03:12:15.787744 | TASK [upload-logs : Upload logs to log server] 2025-09-22 03:12:16.336724 | localhost | Output suppressed because no_log was given 2025-09-22 03:12:16.339104 | 2025-09-22 03:12:16.339230 | LOOP [upload-logs : Compress console log and json output] 2025-09-22 03:12:16.397156 | localhost | skipping: Conditional result was False 2025-09-22 03:12:16.403237 | localhost | skipping: Conditional result was False 2025-09-22 03:12:16.409078 | 2025-09-22 03:12:16.409250 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-22 03:12:16.453999 | localhost | skipping: Conditional result was False 2025-09-22 03:12:16.454298 | 2025-09-22 03:12:16.459336 | localhost | skipping: Conditional result was False 2025-09-22 03:12:16.471239 | 2025-09-22 03:12:16.471557 | LOOP [upload-logs : Upload console log and json output]