2025-03-16 01:56:26.324698 | Job console starting... 2025-03-16 01:56:26.354172 | Updating repositories 2025-03-16 01:56:26.397399 | Preparing job workspace 2025-03-16 01:56:27.868197 | Running Ansible setup... 2025-03-16 01:56:32.857304 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-16 01:56:33.580517 | 2025-03-16 01:56:33.580643 | PLAY [Base pre] 2025-03-16 01:56:33.618456 | 2025-03-16 01:56:33.618737 | TASK [Setup log path fact] 2025-03-16 01:56:33.638577 | ubuntu-noble | ok 2025-03-16 01:56:33.661079 | 2025-03-16 01:56:33.661225 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-16 01:56:33.731951 | ubuntu-noble | ok 2025-03-16 01:56:33.738293 | 2025-03-16 01:56:33.738385 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-16 01:56:33.772468 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 01:56:33.779290 | 2025-03-16 01:56:33.779390 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-16 01:56:33.823508 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 01:56:33.830517 | 2025-03-16 01:56:33.830615 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-16 01:56:33.854478 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 01:56:33.861317 | 2025-03-16 01:56:33.861417 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-16 01:56:33.875890 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 01:56:33.882931 | 2025-03-16 01:56:33.883025 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-16 01:56:33.916790 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 01:56:33.930898 | 2025-03-16 01:56:33.931000 | TASK [emit-job-header : Print job information] 2025-03-16 01:56:34.030300 | # Job Information 2025-03-16 01:56:34.030450 | Ansible Version: 2.15.3 2025-03-16 01:56:34.030481 | Job: flake8 2025-03-16 01:56:34.030510 | Pipeline: check 2025-03-16 01:56:34.030531 | Executor: 7d211f194f6a 2025-03-16 01:56:34.030550 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/715 2025-03-16 01:56:34.030567 | Event ID: d7ecffc0-0209-11f0-910e-3f14b7905e30 2025-03-16 01:56:34.036948 | 2025-03-16 01:56:34.037043 | LOOP [emit-job-header : Print node information] 2025-03-16 01:56:34.183986 | ubuntu-noble | ok: 2025-03-16 01:56:34.184306 | ubuntu-noble | # Node Information 2025-03-16 01:56:34.184350 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-16 01:56:34.184376 | ubuntu-noble | Hostname: ubuntu 2025-03-16 01:56:34.184421 | ubuntu-noble | Username: zuul 2025-03-16 01:56:34.184442 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-16 01:56:34.184462 | ubuntu-noble | Provider: regiocloud-a 2025-03-16 01:56:34.184482 | ubuntu-noble | Label: ubuntu-noble 2025-03-16 01:56:34.184501 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-16 01:56:34.184521 | ubuntu-noble | Interface IP: 81.163.193.89 2025-03-16 01:56:34.206497 | 2025-03-16 01:56:34.206592 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-16 01:56:34.627094 | ubuntu-noble -> localhost | changed 2025-03-16 01:56:34.634801 | 2025-03-16 01:56:34.634894 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-16 01:56:35.539843 | ubuntu-noble -> localhost | changed 2025-03-16 01:56:35.552668 | 2025-03-16 01:56:35.552766 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-16 01:56:35.779599 | ubuntu-noble -> localhost | ok 2025-03-16 01:56:35.788614 | 2025-03-16 01:56:35.788724 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-16 01:56:35.829506 | ubuntu-noble | ok 2025-03-16 01:56:35.846797 | ubuntu-noble | included: /var/lib/zuul/builds/15ec338e44f14d73a2f8d200b09b6942/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-16 01:56:35.852802 | 2025-03-16 01:56:35.852877 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-16 01:56:36.481842 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-16 01:56:36.482429 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/15ec338e44f14d73a2f8d200b09b6942/work/15ec338e44f14d73a2f8d200b09b6942_id_rsa 2025-03-16 01:56:36.482541 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/15ec338e44f14d73a2f8d200b09b6942/work/15ec338e44f14d73a2f8d200b09b6942_id_rsa.pub 2025-03-16 01:56:36.482616 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-16 01:56:36.482682 | ubuntu-noble -> localhost | SHA256:gsj+YvJ0DtDVxtiviCipRU8ty3bs1ic9EcUmMj8d1sA zuul-build-sshkey 2025-03-16 01:56:36.482750 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-16 01:56:36.482823 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-16 01:56:36.482886 | ubuntu-noble -> localhost | | o.o | 2025-03-16 01:56:36.482943 | ubuntu-noble -> localhost | | = o . E . | 2025-03-16 01:56:36.482998 | ubuntu-noble -> localhost | | o = + * . | 2025-03-16 01:56:36.483055 | ubuntu-noble -> localhost | | o o + . + . | 2025-03-16 01:56:36.483109 | ubuntu-noble -> localhost | |. = + o S o | 2025-03-16 01:56:36.483216 | ubuntu-noble -> localhost | | * = = o . | 2025-03-16 01:56:36.483282 | ubuntu-noble -> localhost | |+ * B +. . . | 2025-03-16 01:56:36.483342 | ubuntu-noble -> localhost | |+oo* o. o + | 2025-03-16 01:56:36.483398 | ubuntu-noble -> localhost | |.+..o.. o . | 2025-03-16 01:56:36.483454 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-16 01:56:36.483587 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.154301 2025-03-16 01:56:36.502505 | 2025-03-16 01:56:36.502621 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-16 01:56:36.532699 | ubuntu-noble | ok 2025-03-16 01:56:36.544278 | ubuntu-noble | included: /var/lib/zuul/builds/15ec338e44f14d73a2f8d200b09b6942/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-16 01:56:36.554104 | 2025-03-16 01:56:36.554210 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-16 01:56:36.577933 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 01:56:36.585581 | 2025-03-16 01:56:36.585664 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-16 01:56:37.396884 | ubuntu-noble | changed 2025-03-16 01:56:37.407461 | 2025-03-16 01:56:37.407574 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-16 01:56:37.748149 | ubuntu-noble | ok 2025-03-16 01:56:37.755120 | 2025-03-16 01:56:37.755214 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-16 01:56:38.534425 | ubuntu-noble | changed 2025-03-16 01:56:38.542548 | 2025-03-16 01:56:38.542661 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-16 01:56:39.362190 | ubuntu-noble | changed 2025-03-16 01:56:39.370936 | 2025-03-16 01:56:39.371057 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-16 01:56:39.406242 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 01:56:39.422549 | 2025-03-16 01:56:39.422702 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-16 01:56:39.854861 | ubuntu-noble -> localhost | changed 2025-03-16 01:56:39.870699 | 2025-03-16 01:56:39.870811 | TASK [add-build-sshkey : Add back temp key] 2025-03-16 01:56:40.158082 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/15ec338e44f14d73a2f8d200b09b6942/work/15ec338e44f14d73a2f8d200b09b6942_id_rsa (zuul-build-sshkey) 2025-03-16 01:56:40.158297 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.017634 2025-03-16 01:56:40.165762 | 2025-03-16 01:56:40.165854 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-16 01:56:40.647234 | ubuntu-noble | ok 2025-03-16 01:56:40.653558 | 2025-03-16 01:56:40.653645 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-16 01:56:40.684610 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 01:56:40.697179 | 2025-03-16 01:56:40.697273 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-16 01:56:41.166078 | ubuntu-noble | ok 2025-03-16 01:56:41.178640 | 2025-03-16 01:56:41.178735 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-16 01:56:41.227118 | ubuntu-noble | ok 2025-03-16 01:56:41.235722 | 2025-03-16 01:56:41.235817 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-16 01:56:41.483705 | ubuntu-noble -> localhost | ok 2025-03-16 01:56:41.496212 | 2025-03-16 01:56:41.496342 | TASK [validate-host : Collect information about the host] 2025-03-16 01:56:42.746912 | ubuntu-noble | ok 2025-03-16 01:56:42.760948 | 2025-03-16 01:56:42.761044 | TASK [validate-host : Sanitize hostname] 2025-03-16 01:56:42.852737 | ubuntu-noble | ok 2025-03-16 01:56:42.858461 | 2025-03-16 01:56:42.858546 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-16 01:56:43.375997 | ubuntu-noble -> localhost | changed 2025-03-16 01:56:43.382640 | 2025-03-16 01:56:43.382733 | TASK [validate-host : Collect information about zuul worker] 2025-03-16 01:56:43.865050 | ubuntu-noble | ok 2025-03-16 01:56:43.875427 | 2025-03-16 01:56:43.875576 | TASK [validate-host : Write out all zuul information for each host] 2025-03-16 01:56:44.348348 | ubuntu-noble -> localhost | changed 2025-03-16 01:56:44.361674 | 2025-03-16 01:56:44.361771 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-16 01:56:44.754434 | ubuntu-noble | ok 2025-03-16 01:56:44.763015 | 2025-03-16 01:56:44.763119 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-16 01:56:45.630330 | ubuntu-noble | changed: 2025-03-16 01:56:45.630492 | ubuntu-noble | cd+++++++++ src/ 2025-03-16 01:56:45.630613 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-16 01:56:45.630641 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-16 01:56:45.630663 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-03-16 01:56:45.630684 | ubuntu-noble | Containerfile 2025-03-16 01:56:45.630814 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.029068 2025-03-16 01:57:27.414647 | 2025-03-16 01:57:27.414741 | TASK [upload-logs : Upload logs to log server] 2025-03-16 01:57:28.462247 | localhost | Output suppressed because no_log was given 2025-03-16 01:57:28.466170 | 2025-03-16 01:57:28.466270 | LOOP [upload-logs : Compress console log and json output] 2025-03-16 01:57:28.583823 | localhost | skipping: Conditional result was False 2025-03-16 01:57:28.614748 | localhost | skipping: Conditional result was False 2025-03-16 01:57:28.632244 | 2025-03-16 01:57:28.632338 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-16 01:57:28.780073 | localhost | skipping: Conditional result was False 2025-03-16 01:57:28.780423 | 2025-03-16 01:57:28.789985 | localhost | skipping: Conditional result was False 2025-03-16 01:57:28.798465 | 2025-03-16 01:57:28.798565 | LOOP [upload-logs : Upload console log and json output]