2025-01-08 22:21:33.538522 | Job console starting... 2025-01-08 22:21:33.551175 | Updating repositories 2025-01-08 22:21:33.586773 | Preparing job workspace 2025-01-08 22:21:35.131331 | Running Ansible setup... 2025-01-08 22:21:40.860846 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-08 22:21:41.973248 | 2025-01-08 22:21:41.976246 | PLAY [Base pre] 2025-01-08 22:21:42.020962 | 2025-01-08 22:21:42.021124 | TASK [Setup log path fact] 2025-01-08 22:21:42.092281 | ubuntu-noble | ok 2025-01-08 22:21:42.140765 | 2025-01-08 22:21:42.140942 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 22:21:42.291315 | ubuntu-noble | ok 2025-01-08 22:21:42.304100 | 2025-01-08 22:21:42.304217 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 22:21:42.379958 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 22:21:42.392758 | 2025-01-08 22:21:42.392870 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 22:21:42.485416 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 22:21:42.528378 | 2025-01-08 22:21:42.528961 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 22:21:42.577835 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 22:21:42.603047 | 2025-01-08 22:21:42.603858 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 22:21:42.670843 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 22:21:42.706286 | 2025-01-08 22:21:42.706998 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 22:21:42.755732 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 22:21:42.820865 | 2025-01-08 22:21:42.821572 | TASK [emit-job-header : Print job information] 2025-01-08 22:21:42.890271 | # Job Information 2025-01-08 22:21:42.890433 | Ansible Version: 2.15.3 2025-01-08 22:21:42.890467 | Job: flake8 2025-01-08 22:21:42.890495 | Pipeline: check 2025-01-08 22:21:42.890516 | Executor: 7d211f194f6a 2025-01-08 22:21:42.890534 | Triggered by: https://github.com/osism/openstack-image-manager/pull/870 2025-01-08 22:21:42.890552 | Event ID: e4a0eb70-ce0e-11ef-8a67-bbf7be1d7144 2025-01-08 22:21:42.897075 | 2025-01-08 22:21:42.897168 | LOOP [emit-job-header : Print node information] 2025-01-08 22:21:43.069740 | ubuntu-noble | ok: 2025-01-08 22:21:43.069897 | ubuntu-noble | # Node Information 2025-01-08 22:21:43.069946 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-08 22:21:43.069970 | ubuntu-noble | Hostname: ubuntu 2025-01-08 22:21:43.069991 | ubuntu-noble | Username: zuul 2025-01-08 22:21:43.070011 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-08 22:21:43.070030 | ubuntu-noble | Provider: regiocloud-a 2025-01-08 22:21:43.070050 | ubuntu-noble | Label: ubuntu-noble 2025-01-08 22:21:43.070069 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-08 22:21:43.070089 | ubuntu-noble | Interface IP: 81.163.192.187 2025-01-08 22:21:43.095685 | 2025-01-08 22:21:43.095797 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-08 22:21:43.623586 | ubuntu-noble -> localhost | changed 2025-01-08 22:21:43.630281 | 2025-01-08 22:21:43.630361 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-08 22:21:44.643996 | ubuntu-noble -> localhost | changed 2025-01-08 22:21:44.655227 | 2025-01-08 22:21:44.655316 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-08 22:21:44.922949 | ubuntu-noble -> localhost | ok 2025-01-08 22:21:44.932180 | 2025-01-08 22:21:44.932277 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-08 22:21:44.963300 | ubuntu-noble | ok 2025-01-08 22:21:44.980531 | ubuntu-noble | included: /var/lib/zuul/builds/4f99c95252dc49f6883a6c4570ed775a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-08 22:21:44.988428 | 2025-01-08 22:21:44.988506 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-08 22:21:45.849066 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-08 22:21:45.849228 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/4f99c95252dc49f6883a6c4570ed775a/work/4f99c95252dc49f6883a6c4570ed775a_id_rsa 2025-01-08 22:21:45.849258 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/4f99c95252dc49f6883a6c4570ed775a/work/4f99c95252dc49f6883a6c4570ed775a_id_rsa.pub 2025-01-08 22:21:45.849278 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-08 22:21:45.849296 | ubuntu-noble -> localhost | SHA256:6wt0zNbJ9fhbEOftCEREgoOioeJlsNoNHbLdH3K1KXo zuul-build-sshkey 2025-01-08 22:21:45.849313 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-08 22:21:45.849333 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-08 22:21:45.849350 | ubuntu-noble -> localhost | | . ..o+ | 2025-01-08 22:21:45.849367 | ubuntu-noble -> localhost | | .o o . o .o | 2025-01-08 22:21:45.849383 | ubuntu-noble -> localhost | | .oB + o oo . .| 2025-01-08 22:21:45.849398 | ubuntu-noble -> localhost | |o.+oo oo+oo+ o +.| 2025-01-08 22:21:45.849414 | ubuntu-noble -> localhost | |+.oo .=So+ o o o| 2025-01-08 22:21:45.849429 | ubuntu-noble -> localhost | |... ...oE. o + | 2025-01-08 22:21:45.849445 | ubuntu-noble -> localhost | | ... o o| 2025-01-08 22:21:45.849461 | ubuntu-noble -> localhost | | o o | 2025-01-08 22:21:45.849478 | ubuntu-noble -> localhost | | o. . | 2025-01-08 22:21:45.849493 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-08 22:21:45.849530 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.387463 2025-01-08 22:21:45.855797 | 2025-01-08 22:21:45.855875 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-08 22:21:45.880458 | ubuntu-noble | ok 2025-01-08 22:21:45.894430 | ubuntu-noble | included: /var/lib/zuul/builds/4f99c95252dc49f6883a6c4570ed775a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-08 22:21:45.902531 | 2025-01-08 22:21:45.902621 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-08 22:21:45.937534 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 22:21:45.953009 | 2025-01-08 22:21:45.953152 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-08 22:21:46.725853 | ubuntu-noble | changed 2025-01-08 22:21:46.733114 | 2025-01-08 22:21:46.733208 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-08 22:21:47.046188 | ubuntu-noble | ok 2025-01-08 22:21:47.056732 | 2025-01-08 22:21:47.056835 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-08 22:21:47.782332 | ubuntu-noble | changed 2025-01-08 22:21:47.791804 | 2025-01-08 22:21:47.792004 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-08 22:21:48.535295 | ubuntu-noble | changed 2025-01-08 22:21:48.545893 | 2025-01-08 22:21:48.546026 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-08 22:21:48.581956 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 22:21:48.593366 | 2025-01-08 22:21:48.593467 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-08 22:21:48.986083 | ubuntu-noble -> localhost | changed 2025-01-08 22:21:48.999830 | 2025-01-08 22:21:48.999937 | TASK [add-build-sshkey : Add back temp key] 2025-01-08 22:21:49.341400 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/4f99c95252dc49f6883a6c4570ed775a/work/4f99c95252dc49f6883a6c4570ed775a_id_rsa (zuul-build-sshkey) 2025-01-08 22:21:49.341722 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009289 2025-01-08 22:21:49.351007 | 2025-01-08 22:21:49.351103 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-08 22:21:49.826495 | ubuntu-noble | ok 2025-01-08 22:21:49.837326 | 2025-01-08 22:21:49.837430 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-08 22:21:49.865195 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 22:21:49.881895 | 2025-01-08 22:21:49.882014 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-08 22:21:50.364484 | ubuntu-noble | ok 2025-01-08 22:21:50.403660 | 2025-01-08 22:21:50.403770 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-08 22:21:50.444013 | ubuntu-noble | ok 2025-01-08 22:21:50.450354 | 2025-01-08 22:21:50.450440 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-08 22:21:50.722293 | ubuntu-noble -> localhost | ok 2025-01-08 22:21:50.730058 | 2025-01-08 22:21:50.730158 | TASK [validate-host : Collect information about the host] 2025-01-08 22:21:51.962183 | ubuntu-noble | ok 2025-01-08 22:21:51.974069 | 2025-01-08 22:21:51.974165 | TASK [validate-host : Sanitize hostname] 2025-01-08 22:21:52.043175 | ubuntu-noble | ok 2025-01-08 22:21:52.049790 | 2025-01-08 22:21:52.049889 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-08 22:21:52.610759 | ubuntu-noble -> localhost | changed 2025-01-08 22:21:52.617588 | 2025-01-08 22:21:52.617703 | TASK [validate-host : Collect information about zuul worker] 2025-01-08 22:21:53.086927 | ubuntu-noble | ok 2025-01-08 22:21:53.098331 | 2025-01-08 22:21:53.098436 | TASK [validate-host : Write out all zuul information for each host] 2025-01-08 22:21:53.626295 | ubuntu-noble -> localhost | changed 2025-01-08 22:21:53.638325 | 2025-01-08 22:21:53.638416 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-08 22:21:53.948330 | ubuntu-noble | ok 2025-01-08 22:21:53.955947 | 2025-01-08 22:21:53.956142 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-08 22:21:54.834661 | ubuntu-noble | changed: 2025-01-08 22:21:54.834823 | ubuntu-noble | cd+++++++++ src/ 2025-01-08 22:21:54.834854 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-08 22:21:54.834878 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-08 22:21:54.834899 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-01-08 22:21:54.834918 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.004268 2025-01-08 22:22:32.579841 | 2025-01-08 22:22:32.579994 | TASK [upload-logs : Upload logs to log server] 2025-01-08 22:22:33.169537 | localhost | Output suppressed because no_log was given 2025-01-08 22:22:33.173682 | 2025-01-08 22:22:33.173803 | LOOP [upload-logs : Compress console log and json output] 2025-01-08 22:22:33.324048 | localhost | skipping: Conditional result was False 2025-01-08 22:22:33.333019 | localhost | skipping: Conditional result was False 2025-01-08 22:22:33.343040 | 2025-01-08 22:22:33.343228 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-08 22:22:33.436369 | localhost | skipping: Conditional result was False 2025-01-08 22:22:33.436729 | 2025-01-08 22:22:33.437596 | localhost | skipping: Conditional result was False 2025-01-08 22:22:33.444683 | 2025-01-08 22:22:33.444804 | LOOP [upload-logs : Upload console log and json output]