2025-01-15 19:21:49.466199 | Job console starting... 2025-01-15 19:21:49.500800 | Updating repositories 2025-01-15 19:21:49.555777 | Preparing job workspace 2025-01-15 19:21:52.645961 | Running Ansible setup... 2025-01-15 19:21:59.925423 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-15 19:22:01.139950 | 2025-01-15 19:22:01.140072 | PLAY [Base pre] 2025-01-15 19:22:01.192398 | 2025-01-15 19:22:01.192522 | TASK [Setup log path fact] 2025-01-15 19:22:01.231473 | ubuntu-noble | ok 2025-01-15 19:22:01.257742 | 2025-01-15 19:22:01.257864 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-15 19:22:01.335172 | ubuntu-noble | ok 2025-01-15 19:22:01.340674 | 2025-01-15 19:22:01.340760 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-15 19:22:01.424917 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:01.430973 | 2025-01-15 19:22:01.431064 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-15 19:22:01.535161 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:01.541865 | 2025-01-15 19:22:01.541999 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-15 19:22:01.603885 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:01.609857 | 2025-01-15 19:22:01.609985 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-15 19:22:01.670793 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:01.676662 | 2025-01-15 19:22:01.676749 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-15 19:22:01.740785 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:01.760236 | 2025-01-15 19:22:01.760341 | TASK [emit-job-header : Print job information] 2025-01-15 19:22:01.870140 | # Job Information 2025-01-15 19:22:01.870273 | Ansible Version: 2.15.3 2025-01-15 19:22:01.870299 | Job: hadolint 2025-01-15 19:22:01.870323 | Pipeline: check 2025-01-15 19:22:01.870340 | Executor: 7d211f194f6a 2025-01-15 19:22:01.870356 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/695 2025-01-15 19:22:01.870371 | Event ID: f2fa0280-d375-11ef-8c68-9d0ebf6485c1 2025-01-15 19:22:01.875722 | 2025-01-15 19:22:01.875801 | LOOP [emit-job-header : Print node information] 2025-01-15 19:22:02.228883 | ubuntu-noble | ok: 2025-01-15 19:22:02.229022 | ubuntu-noble | # Node Information 2025-01-15 19:22:02.229049 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-15 19:22:02.229069 | ubuntu-noble | Hostname: ubuntu 2025-01-15 19:22:02.229086 | ubuntu-noble | Username: zuul 2025-01-15 19:22:02.229103 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-15 19:22:02.229119 | ubuntu-noble | Provider: regiocloud-a 2025-01-15 19:22:02.229135 | ubuntu-noble | Label: ubuntu-noble 2025-01-15 19:22:02.229151 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-15 19:22:02.229168 | ubuntu-noble | Interface IP: 81.163.192.70 2025-01-15 19:22:02.261002 | 2025-01-15 19:22:02.261095 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-15 19:22:03.209527 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:03.216432 | 2025-01-15 19:22:03.216509 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-15 19:22:04.727845 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:04.742838 | 2025-01-15 19:22:04.742956 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-15 19:22:05.255759 | ubuntu-noble -> localhost | ok 2025-01-15 19:22:05.263005 | 2025-01-15 19:22:05.263105 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-15 19:22:05.342610 | ubuntu-noble | ok 2025-01-15 19:22:05.369995 | ubuntu-noble | included: /var/lib/zuul/builds/cbae991226074dceaf7aa989412007e7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-15 19:22:05.394563 | 2025-01-15 19:22:05.394676 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-15 19:22:06.517312 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-15 19:22:06.517506 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/cbae991226074dceaf7aa989412007e7/work/cbae991226074dceaf7aa989412007e7_id_rsa 2025-01-15 19:22:06.517538 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/cbae991226074dceaf7aa989412007e7/work/cbae991226074dceaf7aa989412007e7_id_rsa.pub 2025-01-15 19:22:06.517558 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-15 19:22:06.517577 | ubuntu-noble -> localhost | SHA256:vmoTDzfaBL22nhXUR9fmm7Y8BcpSKqnjL1TPROlhU/M zuul-build-sshkey 2025-01-15 19:22:06.517596 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-15 19:22:06.517616 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-15 19:22:06.517634 | ubuntu-noble -> localhost | | oo . o| 2025-01-15 19:22:06.517662 | ubuntu-noble -> localhost | | *. + .o| 2025-01-15 19:22:06.517679 | ubuntu-noble -> localhost | | . +.o. Eo | 2025-01-15 19:22:06.517695 | ubuntu-noble -> localhost | | . o.o ... .| 2025-01-15 19:22:06.517710 | ubuntu-noble -> localhost | | oS*.+ . .o| 2025-01-15 19:22:06.517725 | ubuntu-noble -> localhost | | +.O =.o +.| 2025-01-15 19:22:06.517741 | ubuntu-noble -> localhost | | . @.+.. o o| 2025-01-15 19:22:06.517756 | ubuntu-noble -> localhost | | B ++ + | 2025-01-15 19:22:06.517772 | ubuntu-noble -> localhost | | ooB= .| 2025-01-15 19:22:06.517787 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-15 19:22:06.517825 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.361505 2025-01-15 19:22:06.524359 | 2025-01-15 19:22:06.524443 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-15 19:22:06.553432 | ubuntu-noble | ok 2025-01-15 19:22:06.594493 | ubuntu-noble | included: /var/lib/zuul/builds/cbae991226074dceaf7aa989412007e7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-15 19:22:06.610687 | 2025-01-15 19:22:06.610780 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-15 19:22:06.660011 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:06.669333 | 2025-01-15 19:22:06.669430 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-15 19:22:07.465798 | ubuntu-noble | changed 2025-01-15 19:22:07.471493 | 2025-01-15 19:22:07.471570 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-15 19:22:07.758845 | ubuntu-noble | ok 2025-01-15 19:22:07.764445 | 2025-01-15 19:22:07.764521 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-15 19:22:08.534985 | ubuntu-noble | changed 2025-01-15 19:22:08.544067 | 2025-01-15 19:22:08.544180 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-15 19:22:09.253726 | ubuntu-noble | changed 2025-01-15 19:22:09.264127 | 2025-01-15 19:22:09.264234 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-15 19:22:09.288740 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:09.301516 | 2025-01-15 19:22:09.301622 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-15 19:22:09.762804 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:09.801857 | 2025-01-15 19:22:09.801963 | TASK [add-build-sshkey : Add back temp key] 2025-01-15 19:22:10.291445 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/cbae991226074dceaf7aa989412007e7/work/cbae991226074dceaf7aa989412007e7_id_rsa (zuul-build-sshkey) 2025-01-15 19:22:10.291638 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014136 2025-01-15 19:22:10.298938 | 2025-01-15 19:22:10.299323 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-15 19:22:10.675161 | ubuntu-noble | ok 2025-01-15 19:22:10.682574 | 2025-01-15 19:22:10.682696 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-15 19:22:10.739234 | ubuntu-noble | skipping: Conditional result was False 2025-01-15 19:22:10.758181 | 2025-01-15 19:22:10.758290 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-15 19:22:11.380230 | ubuntu-noble | ok 2025-01-15 19:22:11.410886 | 2025-01-15 19:22:11.410998 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-15 19:22:11.497771 | ubuntu-noble | ok 2025-01-15 19:22:11.504620 | 2025-01-15 19:22:11.504733 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-15 19:22:11.947175 | ubuntu-noble -> localhost | ok 2025-01-15 19:22:11.954141 | 2025-01-15 19:22:11.954314 | TASK [validate-host : Collect information about the host] 2025-01-15 19:22:13.188824 | ubuntu-noble | ok 2025-01-15 19:22:13.215136 | 2025-01-15 19:22:13.215252 | TASK [validate-host : Sanitize hostname] 2025-01-15 19:22:13.301982 | ubuntu-noble | ok 2025-01-15 19:22:13.313476 | 2025-01-15 19:22:13.313582 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-15 19:22:13.948451 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:13.961228 | 2025-01-15 19:22:13.961329 | TASK [validate-host : Collect information about zuul worker] 2025-01-15 19:22:14.490151 | ubuntu-noble | ok 2025-01-15 19:22:14.496018 | 2025-01-15 19:22:14.496110 | TASK [validate-host : Write out all zuul information for each host] 2025-01-15 19:22:15.528558 | ubuntu-noble -> localhost | changed 2025-01-15 19:22:15.545734 | 2025-01-15 19:22:15.545834 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-15 19:22:15.889219 | ubuntu-noble | ok 2025-01-15 19:22:15.901153 | 2025-01-15 19:22:15.901244 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-15 19:22:16.932113 | ubuntu-noble | changed: 2025-01-15 19:22:16.932253 | ubuntu-noble | cd+++++++++ src/ 2025-01-15 19:22:16.932280 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-15 19:22:16.932300 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-15 19:22:16.932318 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-01-15 19:22:16.932335 | ubuntu-noble | Containerfile 2025-01-15 19:22:16.932442 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006456 2025-01-15 19:22:24.873005 | 2025-01-15 19:22:24.873146 | TASK [upload-logs : Upload logs to log server] 2025-01-15 19:22:25.390153 | localhost | Output suppressed because no_log was given 2025-01-15 19:22:25.393016 | 2025-01-15 19:22:25.393100 | LOOP [upload-logs : Compress console log and json output] 2025-01-15 19:22:25.455889 | localhost | skipping: Conditional result was False 2025-01-15 19:22:25.490319 | localhost | skipping: Conditional result was False 2025-01-15 19:22:25.501153 | 2025-01-15 19:22:25.501249 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-15 19:22:25.559938 | localhost | skipping: Conditional result was False 2025-01-15 19:22:25.560408 | 2025-01-15 19:22:25.570405 | localhost | skipping: Conditional result was False 2025-01-15 19:22:25.578414 | 2025-01-15 19:22:25.578501 | LOOP [upload-logs : Upload console log and json output]