2025-08-01 03:15:08.070541 | Job console starting 2025-08-01 03:15:08.086784 | Updating git repos 2025-08-01 03:15:08.118465 | Cloning repos into workspace 2025-08-01 03:15:08.170849 | Restoring repo states 2025-08-01 03:15:08.180831 | Merging changes 2025-08-01 03:15:08.180848 | Checking out repos 2025-08-01 03:15:08.231232 | Preparing playbooks 2025-08-01 03:15:09.114815 | Running Ansible setup 2025-08-01 03:15:14.122385 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-01 03:15:15.310028 | 2025-08-01 03:15:15.310707 | PLAY [Base pre] 2025-08-01 03:15:15.329416 | 2025-08-01 03:15:15.329562 | TASK [Setup log path fact] 2025-08-01 03:15:15.359986 | debian-bookworm | ok 2025-08-01 03:15:15.410249 | 2025-08-01 03:15:15.410425 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-01 03:15:15.485957 | debian-bookworm | ok 2025-08-01 03:15:15.496545 | 2025-08-01 03:15:15.496663 | TASK [emit-job-header : Print job information] 2025-08-01 03:15:15.546754 | # Job Information 2025-08-01 03:15:15.547046 | Ansible Version: 2.16.14 2025-08-01 03:15:15.547088 | Job: python-black 2025-08-01 03:15:15.547120 | Pipeline: periodic-daily 2025-08-01 03:15:15.547142 | Executor: 521e9411259a 2025-08-01 03:15:15.547162 | Triggered by: https://github.com/osism/node-image 2025-08-01 03:15:15.547185 | Event ID: 59ef5d8af6df44b7b19a4d7eba37a220 2025-08-01 03:15:15.552721 | 2025-08-01 03:15:15.552847 | LOOP [emit-job-header : Print node information] 2025-08-01 03:15:15.776827 | debian-bookworm | ok: 2025-08-01 03:15:15.777075 | debian-bookworm | # Node Information 2025-08-01 03:15:15.777112 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-01 03:15:15.777137 | debian-bookworm | Hostname: debian 2025-08-01 03:15:15.777158 | debian-bookworm | Username: zuul 2025-08-01 03:15:15.777179 | debian-bookworm | Distro: Debian 12.11 2025-08-01 03:15:15.777203 | debian-bookworm | Provider: regiocloud-a 2025-08-01 03:15:15.777224 | debian-bookworm | Region: 2025-08-01 03:15:15.777244 | debian-bookworm | Label: debian-bookworm 2025-08-01 03:15:15.777264 | debian-bookworm | Product Name: OpenStack Nova 2025-08-01 03:15:15.777284 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fece:cacf 2025-08-01 03:15:15.802718 | 2025-08-01 03:15:15.802880 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-01 03:15:16.576555 | debian-bookworm -> localhost | changed 2025-08-01 03:15:16.584149 | 2025-08-01 03:15:16.584280 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-01 03:15:19.247071 | debian-bookworm -> localhost | changed 2025-08-01 03:15:19.272899 | 2025-08-01 03:15:19.273068 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-01 03:15:19.951014 | debian-bookworm -> localhost | ok 2025-08-01 03:15:19.970652 | 2025-08-01 03:15:19.970803 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-01 03:15:20.031440 | debian-bookworm | ok 2025-08-01 03:15:20.125090 | debian-bookworm | included: /var/lib/zuul/builds/002d2c66ae464b14a43eea6cdb1bfe50/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-01 03:15:20.144947 | 2025-08-01 03:15:20.145085 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-01 03:15:22.724029 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-01 03:15:22.724228 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/002d2c66ae464b14a43eea6cdb1bfe50/work/002d2c66ae464b14a43eea6cdb1bfe50_id_rsa 2025-08-01 03:15:22.724266 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/002d2c66ae464b14a43eea6cdb1bfe50/work/002d2c66ae464b14a43eea6cdb1bfe50_id_rsa.pub 2025-08-01 03:15:22.724293 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-01 03:15:22.724318 | debian-bookworm -> localhost | SHA256:+nfBPSQwYme35NXuIBxZ6nocaatCEtWutpXUbDPPYWU zuul-build-sshkey 2025-08-01 03:15:22.724341 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-01 03:15:22.724372 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-01 03:15:22.724394 | debian-bookworm -> localhost | | . o.. | 2025-08-01 03:15:22.724416 | debian-bookworm -> localhost | | + * =.. E| 2025-08-01 03:15:22.724436 | debian-bookworm -> localhost | | o = X.+ + | 2025-08-01 03:15:22.724455 | debian-bookworm -> localhost | | . o.%.= .| 2025-08-01 03:15:22.724475 | debian-bookworm -> localhost | | .So +=@ + | 2025-08-01 03:15:22.724499 | debian-bookworm -> localhost | | ..+ o+oo= .| 2025-08-01 03:15:22.724520 | debian-bookworm -> localhost | | .+ o. +. . | 2025-08-01 03:15:22.724540 | debian-bookworm -> localhost | | .o .o. | 2025-08-01 03:15:22.724561 | debian-bookworm -> localhost | | .o.. | 2025-08-01 03:15:22.724581 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-01 03:15:22.724628 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.288067 2025-08-01 03:15:22.730668 | 2025-08-01 03:15:22.730753 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-01 03:15:22.765593 | debian-bookworm | ok 2025-08-01 03:15:22.781345 | debian-bookworm | included: /var/lib/zuul/builds/002d2c66ae464b14a43eea6cdb1bfe50/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-01 03:15:22.792099 | 2025-08-01 03:15:22.792186 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-01 03:15:22.805236 | debian-bookworm | skipping: Conditional result was False 2025-08-01 03:15:22.818557 | 2025-08-01 03:15:22.818694 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-01 03:15:23.399394 | debian-bookworm | changed 2025-08-01 03:15:23.413046 | 2025-08-01 03:15:23.413153 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-01 03:15:23.677589 | debian-bookworm | ok 2025-08-01 03:15:23.684223 | 2025-08-01 03:15:23.684369 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-01 03:15:24.318276 | debian-bookworm | changed 2025-08-01 03:15:24.328507 | 2025-08-01 03:15:24.328637 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-01 03:15:24.964856 | debian-bookworm | changed 2025-08-01 03:15:24.970073 | 2025-08-01 03:15:24.970161 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-01 03:15:25.009348 | debian-bookworm | skipping: Conditional result was False 2025-08-01 03:15:25.015114 | 2025-08-01 03:15:25.015212 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-01 03:15:25.583205 | debian-bookworm -> localhost | changed 2025-08-01 03:15:25.593254 | 2025-08-01 03:15:25.593346 | TASK [add-build-sshkey : Add back temp key] 2025-08-01 03:15:25.879459 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/002d2c66ae464b14a43eea6cdb1bfe50/work/002d2c66ae464b14a43eea6cdb1bfe50_id_rsa (zuul-build-sshkey) 2025-08-01 03:15:25.879668 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009548 2025-08-01 03:15:25.887179 | 2025-08-01 03:15:25.887279 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-01 03:15:26.248507 | debian-bookworm | ok 2025-08-01 03:15:26.258050 | 2025-08-01 03:15:26.258154 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-01 03:15:26.281037 | debian-bookworm | skipping: Conditional result was False 2025-08-01 03:15:26.291191 | 2025-08-01 03:15:26.291291 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-01 03:15:26.806645 | debian-bookworm | ok 2025-08-01 03:15:26.824685 | 2025-08-01 03:15:26.825002 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-01 03:15:26.866334 | debian-bookworm | ok 2025-08-01 03:15:26.874320 | 2025-08-01 03:15:26.874416 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-01 03:15:27.188115 | debian-bookworm -> localhost | ok 2025-08-01 03:15:27.194785 | 2025-08-01 03:15:27.194933 | TASK [validate-host : Collect information about the host] 2025-08-01 03:15:28.643801 | debian-bookworm | ok 2025-08-01 03:15:28.661789 | 2025-08-01 03:15:28.661962 | TASK [validate-host : Sanitize hostname] 2025-08-01 03:15:28.905070 | debian-bookworm | ok 2025-08-01 03:15:29.081256 | 2025-08-01 03:15:29.082002 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-01 03:15:30.409732 | debian-bookworm -> localhost | changed 2025-08-01 03:15:30.415824 | 2025-08-01 03:15:30.415977 | TASK [validate-host : Collect information about zuul worker] 2025-08-01 03:15:30.917230 | debian-bookworm | ok 2025-08-01 03:15:30.923161 | 2025-08-01 03:15:30.923257 | TASK [validate-host : Write out all zuul information for each host] 2025-08-01 03:15:31.557896 | debian-bookworm -> localhost | changed 2025-08-01 03:15:31.573405 | 2025-08-01 03:15:31.573504 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-01 03:15:31.863659 | debian-bookworm | ok 2025-08-01 03:15:31.869078 | 2025-08-01 03:15:31.869169 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-01 03:15:33.805418 | debian-bookworm | changed: 2025-08-01 03:15:33.805587 | debian-bookworm | cd+++++++++ src/ 2025-08-01 03:15:33.805622 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-01 03:15:33.805646 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-01 03:15:33.805668 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-08-01 03:15:33.805688 | debian-bookworm | Containerfile 2025-08-01 03:15:33.805824 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005203 2025-08-01 03:15:59.613260 | 2025-08-01 03:15:59.613386 | TASK [upload-logs : Upload logs to log server] 2025-08-01 03:16:00.343464 | localhost | Output suppressed because no_log was given 2025-08-01 03:16:00.345987 | 2025-08-01 03:16:00.346103 | LOOP [upload-logs : Compress console log and json output] 2025-08-01 03:16:00.399923 | localhost | skipping: Conditional result was False 2025-08-01 03:16:00.413903 | localhost | skipping: Conditional result was False 2025-08-01 03:16:00.431135 | 2025-08-01 03:16:00.431264 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-01 03:16:00.505499 | localhost | skipping: Conditional result was False 2025-08-01 03:16:00.506017 | 2025-08-01 03:16:00.507822 | localhost | skipping: Conditional result was False 2025-08-01 03:16:00.511740 | 2025-08-01 03:16:00.511848 | LOOP [upload-logs : Upload console log and json output]