2025-01-21 22:13:29.531078 | Job console starting... 2025-01-21 22:13:29.543487 | Updating repositories 2025-01-21 22:13:29.596368 | Preparing job workspace 2025-01-21 22:13:30.996081 | Running Ansible setup... 2025-01-21 22:13:35.978457 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-21 22:13:36.858817 | 2025-01-21 22:13:36.858998 | PLAY [Base pre] 2025-01-21 22:13:36.921735 | 2025-01-21 22:13:36.921971 | TASK [Setup log path fact] 2025-01-21 22:13:36.974898 | ubuntu-noble | ok 2025-01-21 22:13:37.019867 | 2025-01-21 22:13:37.020044 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 22:13:37.113405 | ubuntu-noble | ok 2025-01-21 22:13:37.120954 | 2025-01-21 22:13:37.121081 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 22:13:37.156978 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:37.165213 | 2025-01-21 22:13:37.165349 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 22:13:37.220551 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:37.228169 | 2025-01-21 22:13:37.228294 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-21 22:13:37.252786 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:37.260206 | 2025-01-21 22:13:37.260330 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-21 22:13:37.284698 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:37.292162 | 2025-01-21 22:13:37.292291 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-21 22:13:37.326969 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:37.343428 | 2025-01-21 22:13:37.343609 | TASK [emit-job-header : Print job information] 2025-01-21 22:13:37.405767 | # Job Information 2025-01-21 22:13:37.405949 | Ansible Version: 2.15.3 2025-01-21 22:13:37.405982 | Job: flake8 2025-01-21 22:13:37.406011 | Pipeline: check 2025-01-21 22:13:37.406032 | Executor: 7d211f194f6a 2025-01-21 22:13:37.406050 | Triggered by: https://github.com/osism/openstack-project-manager/pull/212 2025-01-21 22:13:37.406068 | Event ID: e4d49ed0-d844-11ef-8ecf-a73350ea066d 2025-01-21 22:13:37.414463 | 2025-01-21 22:13:37.414645 | LOOP [emit-job-header : Print node information] 2025-01-21 22:13:37.579051 | ubuntu-noble | ok: 2025-01-21 22:13:37.579295 | ubuntu-noble | # Node Information 2025-01-21 22:13:37.579337 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-21 22:13:37.579386 | ubuntu-noble | Hostname: ubuntu 2025-01-21 22:13:37.579408 | ubuntu-noble | Username: zuul 2025-01-21 22:13:37.579429 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-21 22:13:37.579449 | ubuntu-noble | Provider: regiocloud-a 2025-01-21 22:13:37.579470 | ubuntu-noble | Label: ubuntu-noble 2025-01-21 22:13:37.579489 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-21 22:13:37.579510 | ubuntu-noble | Interface IP: 81.163.193.44 2025-01-21 22:13:37.597835 | 2025-01-21 22:13:37.597989 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-21 22:13:38.217464 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:38.227459 | 2025-01-21 22:13:38.227616 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-21 22:13:39.708294 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:39.732017 | 2025-01-21 22:13:39.732183 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-21 22:13:40.307876 | ubuntu-noble -> localhost | ok 2025-01-21 22:13:40.316113 | 2025-01-21 22:13:40.316264 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-21 22:13:40.394925 | ubuntu-noble | ok 2025-01-21 22:13:40.411973 | ubuntu-noble | included: /var/lib/zuul/builds/17541379309343049a287f06ef29e507/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-21 22:13:40.420095 | 2025-01-21 22:13:40.420218 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-21 22:13:41.823364 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-21 22:13:41.823647 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/17541379309343049a287f06ef29e507/work/17541379309343049a287f06ef29e507_id_rsa 2025-01-21 22:13:41.823689 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/17541379309343049a287f06ef29e507/work/17541379309343049a287f06ef29e507_id_rsa.pub 2025-01-21 22:13:41.823715 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-21 22:13:41.823739 | ubuntu-noble -> localhost | SHA256:0a1/KkD8nrtWTwJ/D9LgXI8XOJg5zo1mNbVnJbuU828 zuul-build-sshkey 2025-01-21 22:13:41.823761 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-21 22:13:41.823786 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-21 22:13:41.823807 | ubuntu-noble -> localhost | | | 2025-01-21 22:13:41.823827 | ubuntu-noble -> localhost | | . . ...| 2025-01-21 22:13:41.823847 | ubuntu-noble -> localhost | | .. . = o+o| 2025-01-21 22:13:41.823866 | ubuntu-noble -> localhost | | o..*.=*oo| 2025-01-21 22:13:41.823886 | ubuntu-noble -> localhost | | .S.+===oBo| 2025-01-21 22:13:41.823906 | ubuntu-noble -> localhost | | . .BB.B +| 2025-01-21 22:13:41.823926 | ubuntu-noble -> localhost | | ooo.*.+.| 2025-01-21 22:13:41.823946 | ubuntu-noble -> localhost | | = o. E| 2025-01-21 22:13:41.823965 | ubuntu-noble -> localhost | | .o+. . | 2025-01-21 22:13:41.823984 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-21 22:13:41.824034 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.480048 2025-01-21 22:13:41.833603 | 2025-01-21 22:13:41.833769 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-21 22:13:41.864960 | ubuntu-noble | ok 2025-01-21 22:13:41.877010 | ubuntu-noble | included: /var/lib/zuul/builds/17541379309343049a287f06ef29e507/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-21 22:13:41.886897 | 2025-01-21 22:13:41.887004 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-21 22:13:41.911638 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:41.919364 | 2025-01-21 22:13:41.919575 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-21 22:13:42.641016 | ubuntu-noble | changed 2025-01-21 22:13:42.652604 | 2025-01-21 22:13:42.652742 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-21 22:13:42.960146 | ubuntu-noble | ok 2025-01-21 22:13:42.969674 | 2025-01-21 22:13:42.969800 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-21 22:13:43.712428 | ubuntu-noble | changed 2025-01-21 22:13:43.723019 | 2025-01-21 22:13:43.723341 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-21 22:13:44.434260 | ubuntu-noble | changed 2025-01-21 22:13:44.442117 | 2025-01-21 22:13:44.442238 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-21 22:13:44.477448 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:44.490311 | 2025-01-21 22:13:44.490459 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-21 22:13:44.937284 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:44.964164 | 2025-01-21 22:13:44.964325 | TASK [add-build-sshkey : Add back temp key] 2025-01-21 22:13:45.383896 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/17541379309343049a287f06ef29e507/work/17541379309343049a287f06ef29e507_id_rsa (zuul-build-sshkey) 2025-01-21 22:13:45.384123 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014615 2025-01-21 22:13:45.391466 | 2025-01-21 22:13:45.391597 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-21 22:13:45.781275 | ubuntu-noble | ok 2025-01-21 22:13:45.788143 | 2025-01-21 22:13:45.788262 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-21 22:13:45.823610 | ubuntu-noble | skipping: Conditional result was False 2025-01-21 22:13:45.837480 | 2025-01-21 22:13:45.837635 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-21 22:13:46.311627 | ubuntu-noble | ok 2025-01-21 22:13:46.327782 | 2025-01-21 22:13:46.327910 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-21 22:13:46.373494 | ubuntu-noble | ok 2025-01-21 22:13:46.388061 | 2025-01-21 22:13:46.388235 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-21 22:13:46.711831 | ubuntu-noble -> localhost | ok 2025-01-21 22:13:46.720265 | 2025-01-21 22:13:46.720380 | TASK [validate-host : Collect information about the host] 2025-01-21 22:13:47.874953 | ubuntu-noble | ok 2025-01-21 22:13:47.891495 | 2025-01-21 22:13:47.891687 | TASK [validate-host : Sanitize hostname] 2025-01-21 22:13:47.968457 | ubuntu-noble | ok 2025-01-21 22:13:47.977399 | 2025-01-21 22:13:47.977554 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-21 22:13:48.569228 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:48.590337 | 2025-01-21 22:13:48.590569 | TASK [validate-host : Collect information about zuul worker] 2025-01-21 22:13:49.043324 | ubuntu-noble | ok 2025-01-21 22:13:49.051879 | 2025-01-21 22:13:49.052016 | TASK [validate-host : Write out all zuul information for each host] 2025-01-21 22:13:49.630169 | ubuntu-noble -> localhost | changed 2025-01-21 22:13:49.650749 | 2025-01-21 22:13:49.650887 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-21 22:13:49.946467 | ubuntu-noble | ok 2025-01-21 22:13:49.956859 | 2025-01-21 22:13:49.957000 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-21 22:13:50.722861 | ubuntu-noble | changed: 2025-01-21 22:13:50.723166 | ubuntu-noble | cd+++++++++ src/ 2025-01-21 22:13:50.723220 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-21 22:13:50.723261 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-21 22:13:50.723298 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2025-01-21 22:13:50.723333 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007973 2025-01-21 22:14:27.248745 | 2025-01-21 22:14:27.248910 | TASK [upload-logs : Upload logs to log server] 2025-01-21 22:14:27.833267 | localhost | Output suppressed because no_log was given 2025-01-21 22:14:27.838636 | 2025-01-21 22:14:27.838796 | LOOP [upload-logs : Compress console log and json output] 2025-01-21 22:14:27.918598 | localhost | skipping: Conditional result was False 2025-01-21 22:14:27.937750 | localhost | skipping: Conditional result was False 2025-01-21 22:14:27.954394 | 2025-01-21 22:14:27.954635 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-21 22:14:28.019235 | localhost | skipping: Conditional result was False 2025-01-21 22:14:28.019902 | 2025-01-21 22:14:28.030374 | localhost | skipping: Conditional result was False 2025-01-21 22:14:28.037823 | 2025-01-21 22:14:28.037993 | LOOP [upload-logs : Upload console log and json output]