2025-09-05 18:30:12.691114 | Job console starting 2025-09-05 18:30:12.713812 | Updating git repos 2025-09-05 18:30:12.823283 | Cloning repos into workspace 2025-09-05 18:30:12.918735 | Restoring repo states 2025-09-05 18:30:12.928379 | Merging changes 2025-09-05 18:30:13.540077 | Checking out repos 2025-09-05 18:30:13.575522 | Preparing playbooks 2025-09-05 18:30:14.538520 | Running Ansible setup 2025-09-05 18:30:22.315961 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-05 18:30:23.849306 | 2025-09-05 18:30:23.849435 | PLAY [Base pre] 2025-09-05 18:30:23.900951 | 2025-09-05 18:30:23.901083 | TASK [Setup log path fact] 2025-09-05 18:30:23.933688 | debian-bookworm | ok 2025-09-05 18:30:23.964332 | 2025-09-05 18:30:23.964460 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-05 18:30:24.049996 | debian-bookworm | ok 2025-09-05 18:30:24.078482 | 2025-09-05 18:30:24.078627 | TASK [emit-job-header : Print job information] 2025-09-05 18:30:24.178145 | # Job Information 2025-09-05 18:30:24.178298 | Ansible Version: 2.16.14 2025-09-05 18:30:24.178334 | Job: hadolint 2025-09-05 18:30:24.178368 | Pipeline: check 2025-09-05 18:30:24.178391 | Executor: 521e9411259a 2025-09-05 18:30:24.178412 | Triggered by: https://github.com/osism/python-osism/pull/1712 2025-09-05 18:30:24.178434 | Event ID: 5581dc30-8a86-11f0-996d-38d648a83188 2025-09-05 18:30:24.183927 | 2025-09-05 18:30:24.184019 | LOOP [emit-job-header : Print node information] 2025-09-05 18:30:24.395687 | debian-bookworm | ok: 2025-09-05 18:30:24.395827 | debian-bookworm | # Node Information 2025-09-05 18:30:24.395857 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-05 18:30:24.395878 | debian-bookworm | Hostname: debian 2025-09-05 18:30:24.395896 | debian-bookworm | Username: zuul 2025-09-05 18:30:24.395913 | debian-bookworm | Distro: Debian 12.11 2025-09-05 18:30:24.395942 | debian-bookworm | Provider: regiocloud-a 2025-09-05 18:30:24.395962 | debian-bookworm | Region: 2025-09-05 18:30:24.395978 | debian-bookworm | Label: debian-bookworm 2025-09-05 18:30:24.395995 | debian-bookworm | Product Name: OpenStack Nova 2025-09-05 18:30:24.396011 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe56:a2ad 2025-09-05 18:30:24.409824 | 2025-09-05 18:30:24.409934 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-05 18:30:25.598467 | debian-bookworm -> localhost | changed 2025-09-05 18:30:25.611482 | 2025-09-05 18:30:25.611598 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-05 18:30:27.525799 | debian-bookworm -> localhost | changed 2025-09-05 18:30:27.534147 | 2025-09-05 18:30:27.534231 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-05 18:30:28.153741 | debian-bookworm -> localhost | ok 2025-09-05 18:30:28.159438 | 2025-09-05 18:30:28.159578 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-05 18:30:28.226702 | debian-bookworm | ok 2025-09-05 18:30:28.242475 | debian-bookworm | included: /var/lib/zuul/builds/6248dc753b0743138286f7395ce443c1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-05 18:30:28.249003 | 2025-09-05 18:30:28.249087 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-05 18:30:31.974903 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-05 18:30:31.975098 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6248dc753b0743138286f7395ce443c1/work/6248dc753b0743138286f7395ce443c1_id_rsa 2025-09-05 18:30:31.975146 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6248dc753b0743138286f7395ce443c1/work/6248dc753b0743138286f7395ce443c1_id_rsa.pub 2025-09-05 18:30:31.975174 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-05 18:30:31.975204 | debian-bookworm -> localhost | SHA256:KqVpq85m2kTZKfZoN5ZB/26DPhfHZywjR9T63SDbP1Q zuul-build-sshkey 2025-09-05 18:30:31.975229 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-05 18:30:31.975260 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-05 18:30:31.975283 | debian-bookworm -> localhost | | . | 2025-09-05 18:30:31.975305 | debian-bookworm -> localhost | | . . | 2025-09-05 18:30:31.975325 | debian-bookworm -> localhost | | . . . | 2025-09-05 18:30:31.975345 | debian-bookworm -> localhost | | + o o . . E| 2025-09-05 18:30:31.975365 | debian-bookworm -> localhost | | = + o So o = o.| 2025-09-05 18:30:31.975389 | debian-bookworm -> localhost | | o + * oo * * o..| 2025-09-05 18:30:31.975409 | debian-bookworm -> localhost | | + @ ...= = .. | 2025-09-05 18:30:31.975429 | debian-bookworm -> localhost | | =o+ +o.+ ..| 2025-09-05 18:30:31.975451 | debian-bookworm -> localhost | |.==....+.. .| 2025-09-05 18:30:31.975471 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-05 18:30:31.975529 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.529899 2025-09-05 18:30:31.982414 | 2025-09-05 18:30:31.982542 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-05 18:30:32.041722 | debian-bookworm | ok 2025-09-05 18:30:32.059158 | debian-bookworm | included: /var/lib/zuul/builds/6248dc753b0743138286f7395ce443c1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-05 18:30:32.072933 | 2025-09-05 18:30:32.073028 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-05 18:30:32.096028 | debian-bookworm | skipping: Conditional result was False 2025-09-05 18:30:32.101859 | 2025-09-05 18:30:32.101949 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-05 18:30:32.792355 | debian-bookworm | changed 2025-09-05 18:30:32.797557 | 2025-09-05 18:30:32.797641 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-05 18:30:33.057818 | debian-bookworm | ok 2025-09-05 18:30:33.063062 | 2025-09-05 18:30:33.063149 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-05 18:30:33.814813 | debian-bookworm | changed 2025-09-05 18:30:33.820365 | 2025-09-05 18:30:33.820443 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-05 18:30:34.660883 | debian-bookworm | changed 2025-09-05 18:30:34.665287 | 2025-09-05 18:30:34.665366 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-05 18:30:34.715334 | debian-bookworm | skipping: Conditional result was False 2025-09-05 18:30:34.720138 | 2025-09-05 18:30:34.720216 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-05 18:30:35.638718 | debian-bookworm -> localhost | changed 2025-09-05 18:30:35.667936 | 2025-09-05 18:30:35.668034 | TASK [add-build-sshkey : Add back temp key] 2025-09-05 18:30:36.447100 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6248dc753b0743138286f7395ce443c1/work/6248dc753b0743138286f7395ce443c1_id_rsa (zuul-build-sshkey) 2025-09-05 18:30:36.447281 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010498 2025-09-05 18:30:36.457854 | 2025-09-05 18:30:36.457942 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-05 18:30:36.961731 | debian-bookworm | ok 2025-09-05 18:30:36.970163 | 2025-09-05 18:30:36.970250 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-05 18:30:37.011992 | debian-bookworm | skipping: Conditional result was False 2025-09-05 18:30:37.024742 | 2025-09-05 18:30:37.024827 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-05 18:30:37.819711 | debian-bookworm | ok 2025-09-05 18:30:37.828280 | 2025-09-05 18:30:37.828369 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-05 18:30:37.875262 | debian-bookworm | ok 2025-09-05 18:30:37.879374 | 2025-09-05 18:30:37.879447 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-05 18:30:38.510989 | debian-bookworm -> localhost | ok 2025-09-05 18:30:38.516564 | 2025-09-05 18:30:38.516646 | TASK [validate-host : Collect information about the host] 2025-09-05 18:30:39.829062 | debian-bookworm | ok 2025-09-05 18:30:39.841178 | 2025-09-05 18:30:39.841266 | TASK [validate-host : Sanitize hostname] 2025-09-05 18:30:39.928918 | debian-bookworm | ok 2025-09-05 18:30:39.956181 | 2025-09-05 18:30:39.956270 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-05 18:30:41.306450 | debian-bookworm -> localhost | changed 2025-09-05 18:30:41.321154 | 2025-09-05 18:30:41.321239 | TASK [validate-host : Collect information about zuul worker] 2025-09-05 18:30:41.886667 | debian-bookworm | ok 2025-09-05 18:30:41.890640 | 2025-09-05 18:30:41.890726 | TASK [validate-host : Write out all zuul information for each host] 2025-09-05 18:30:42.769622 | debian-bookworm -> localhost | changed 2025-09-05 18:30:42.777110 | 2025-09-05 18:30:42.777191 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-05 18:30:43.098599 | debian-bookworm | ok 2025-09-05 18:30:43.103443 | 2025-09-05 18:30:43.103546 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-05 18:30:44.766492 | debian-bookworm | changed: 2025-09-05 18:30:44.766650 | debian-bookworm | cd+++++++++ src/ 2025-09-05 18:30:44.766722 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-05 18:30:44.766797 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-05 18:30:44.766818 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-09-05 18:30:44.766899 | debian-bookworm | Containerfile 2025-09-05 18:30:44.766998 | debian-bookworm | Containerfile 2025-09-05 18:30:44.804762 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004327 2025-09-05 18:30:53.594817 | 2025-09-05 18:30:53.594928 | TASK [upload-logs : Upload logs to log server] 2025-09-05 18:30:54.108659 | localhost | Output suppressed because no_log was given 2025-09-05 18:30:54.110355 | 2025-09-05 18:30:54.110442 | LOOP [upload-logs : Compress console log and json output] 2025-09-05 18:30:54.172513 | localhost | skipping: Conditional result was False 2025-09-05 18:30:54.177851 | localhost | skipping: Conditional result was False 2025-09-05 18:30:54.185953 | 2025-09-05 18:30:54.186041 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-05 18:30:54.236877 | localhost | skipping: Conditional result was False 2025-09-05 18:30:54.237097 | 2025-09-05 18:30:54.242149 | localhost | skipping: Conditional result was False 2025-09-05 18:30:54.255068 | 2025-09-05 18:30:54.255277 | LOOP [upload-logs : Upload console log and json output]