2025-03-15 18:36:46.665951 | Job console starting... 2025-03-15 18:36:46.683929 | Updating repositories 2025-03-15 18:36:46.708606 | Preparing job workspace 2025-03-15 18:36:48.507529 | Running Ansible setup... 2025-03-15 18:36:53.856334 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-15 18:36:54.747727 | 2025-03-15 18:36:54.747889 | PLAY [Base pre] 2025-03-15 18:36:54.777747 | 2025-03-15 18:36:54.777899 | TASK [Setup log path fact] 2025-03-15 18:36:54.809125 | ubuntu-noble | ok 2025-03-15 18:36:54.832054 | 2025-03-15 18:36:54.832198 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-15 18:36:54.894276 | ubuntu-noble | ok 2025-03-15 18:36:54.901073 | 2025-03-15 18:36:54.901194 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-15 18:36:54.960049 | ubuntu-noble | skipping: Conditional result was False 2025-03-15 18:36:54.967605 | 2025-03-15 18:36:54.967731 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-15 18:36:55.013116 | ubuntu-noble | skipping: Conditional result was False 2025-03-15 18:36:55.020631 | 2025-03-15 18:36:55.020757 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-15 18:36:55.045169 | ubuntu-noble | skipping: Conditional result was False 2025-03-15 18:36:55.052606 | 2025-03-15 18:36:55.052738 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-15 18:36:55.079062 | ubuntu-noble | skipping: Conditional result was False 2025-03-15 18:36:55.091437 | 2025-03-15 18:36:55.095688 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-15 18:36:55.131208 | ubuntu-noble | skipping: Conditional result was False 2025-03-15 18:36:55.147203 | 2025-03-15 18:36:55.147318 | TASK [emit-job-header : Print job information] 2025-03-15 18:36:55.219714 | # Job Information 2025-03-15 18:36:55.219900 | Ansible Version: 2.15.3 2025-03-15 18:36:55.219932 | Job: flake8 2025-03-15 18:36:55.219961 | Pipeline: check 2025-03-15 18:36:55.219982 | Executor: 7d211f194f6a 2025-03-15 18:36:55.220001 | Triggered by: https://github.com/osism/zuul-jobs/pull/151 2025-03-15 18:36:55.220020 | Event ID: 6d75fad0-01cc-11f0-8dad-9d56451cb857 2025-03-15 18:36:55.226476 | 2025-03-15 18:36:55.226630 | LOOP [emit-job-header : Print node information] 2025-03-15 18:36:55.433844 | ubuntu-noble | ok: 2025-03-15 18:36:55.434048 | ubuntu-noble | # Node Information 2025-03-15 18:36:55.434084 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-15 18:36:55.434108 | ubuntu-noble | Hostname: ubuntu 2025-03-15 18:36:55.434130 | ubuntu-noble | Username: zuul 2025-03-15 18:36:55.434151 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-15 18:36:55.434171 | ubuntu-noble | Provider: regiocloud-a 2025-03-15 18:36:55.434191 | ubuntu-noble | Label: ubuntu-noble 2025-03-15 18:36:55.434211 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-15 18:36:55.436057 | ubuntu-noble | Interface IP: 81.163.193.109 2025-03-15 18:36:55.474744 | 2025-03-15 18:36:55.474946 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-15 18:36:56.197870 | ubuntu-noble -> localhost | changed 2025-03-15 18:36:56.205747 | 2025-03-15 18:36:56.205834 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-15 18:36:57.149503 | ubuntu-noble -> localhost | changed 2025-03-15 18:36:57.160229 | 2025-03-15 18:36:57.160315 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-15 18:36:57.406370 | ubuntu-noble -> localhost | ok 2025-03-15 18:36:57.413152 | 2025-03-15 18:36:57.413235 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-15 18:36:57.432042 | ubuntu-noble | ok 2025-03-15 18:36:57.446373 | ubuntu-noble | included: /var/lib/zuul/builds/72fef15809334ca69f525de0808c0a4a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-15 18:36:57.453251 | 2025-03-15 18:36:57.453318 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-15 18:36:58.105739 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-15 18:36:58.106053 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/72fef15809334ca69f525de0808c0a4a/work/72fef15809334ca69f525de0808c0a4a_id_rsa 2025-03-15 18:36:58.106122 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/72fef15809334ca69f525de0808c0a4a/work/72fef15809334ca69f525de0808c0a4a_id_rsa.pub 2025-03-15 18:36:58.106171 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-15 18:36:58.106215 | ubuntu-noble -> localhost | SHA256:6f4n8So4phvpKh+yxz09YQWewTKPAxFMbs2HJrMmVqQ zuul-build-sshkey 2025-03-15 18:36:58.106257 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-15 18:36:58.106304 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-15 18:36:58.106346 | ubuntu-noble -> localhost | | o++ . | 2025-03-15 18:36:58.106384 | ubuntu-noble -> localhost | | .=oo.+ | 2025-03-15 18:36:58.106422 | ubuntu-noble -> localhost | | E=o=*.+ | 2025-03-15 18:36:58.106460 | ubuntu-noble -> localhost | | ..=o.+ .. | 2025-03-15 18:36:58.106534 | ubuntu-noble -> localhost | |..o . .S | 2025-03-15 18:36:58.106576 | ubuntu-noble -> localhost | |.o .o. . | 2025-03-15 18:36:58.106615 | ubuntu-noble -> localhost | |....oo o. o | 2025-03-15 18:36:58.106654 | ubuntu-noble -> localhost | |.oooo.*.. . o | 2025-03-15 18:36:58.106692 | ubuntu-noble -> localhost | |.+o.+= o.oo+ | 2025-03-15 18:36:58.106729 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-15 18:36:58.106811 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.198544 2025-03-15 18:36:58.120173 | 2025-03-15 18:36:58.120291 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-15 18:36:58.159858 | ubuntu-noble | ok 2025-03-15 18:36:58.174161 | ubuntu-noble | included: /var/lib/zuul/builds/72fef15809334ca69f525de0808c0a4a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-15 18:36:58.183378 | 2025-03-15 18:36:58.183457 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-15 18:36:58.217616 | ubuntu-noble | skipping: Conditional result was False 2025-03-15 18:36:58.227214 | 2025-03-15 18:36:58.227296 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-15 18:36:58.980441 | ubuntu-noble | changed 2025-03-15 18:36:58.986041 | 2025-03-15 18:36:58.986110 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-15 18:36:59.325704 | ubuntu-noble | ok 2025-03-15 18:36:59.335382 | 2025-03-15 18:36:59.335523 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-15 18:37:00.183355 | ubuntu-noble | changed 2025-03-15 18:37:00.193616 | 2025-03-15 18:37:00.193724 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-15 18:37:01.004737 | ubuntu-noble | changed 2025-03-15 18:37:01.014989 | 2025-03-15 18:37:01.015225 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-15 18:37:01.039681 | ubuntu-noble | skipping: Conditional result was False 2025-03-15 18:37:01.058774 | 2025-03-15 18:37:01.058886 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-15 18:37:01.431041 | ubuntu-noble -> localhost | changed 2025-03-15 18:37:01.445581 | 2025-03-15 18:37:01.445682 | TASK [add-build-sshkey : Add back temp key] 2025-03-15 18:37:01.785553 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/72fef15809334ca69f525de0808c0a4a/work/72fef15809334ca69f525de0808c0a4a_id_rsa (zuul-build-sshkey) 2025-03-15 18:37:01.785757 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013712 2025-03-15 18:37:01.794436 | 2025-03-15 18:37:01.794538 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-15 18:37:02.279374 | ubuntu-noble | ok 2025-03-15 18:37:02.288542 | 2025-03-15 18:37:02.288648 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-15 18:37:02.312688 | ubuntu-noble | skipping: Conditional result was False 2025-03-15 18:37:02.328591 | 2025-03-15 18:37:02.328685 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-15 18:37:02.774259 | ubuntu-noble | ok 2025-03-15 18:37:02.787452 | 2025-03-15 18:37:02.787569 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-15 18:37:02.827604 | ubuntu-noble | ok 2025-03-15 18:37:02.833963 | 2025-03-15 18:37:02.834048 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-15 18:37:03.098809 | ubuntu-noble -> localhost | ok 2025-03-15 18:37:03.106151 | 2025-03-15 18:37:03.106239 | TASK [validate-host : Collect information about the host] 2025-03-15 18:37:04.361222 | ubuntu-noble | ok 2025-03-15 18:37:04.373339 | 2025-03-15 18:37:04.373428 | TASK [validate-host : Sanitize hostname] 2025-03-15 18:37:04.440349 | ubuntu-noble | ok 2025-03-15 18:37:04.449178 | 2025-03-15 18:37:04.449286 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-15 18:37:04.932503 | ubuntu-noble -> localhost | changed 2025-03-15 18:37:04.940062 | 2025-03-15 18:37:04.940156 | TASK [validate-host : Collect information about zuul worker] 2025-03-15 18:37:05.439594 | ubuntu-noble | ok 2025-03-15 18:37:05.450256 | 2025-03-15 18:37:05.450430 | TASK [validate-host : Write out all zuul information for each host] 2025-03-15 18:37:06.103055 | ubuntu-noble -> localhost | changed 2025-03-15 18:37:06.126749 | 2025-03-15 18:37:06.126887 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-15 18:37:06.493270 | ubuntu-noble | ok 2025-03-15 18:37:06.501579 | 2025-03-15 18:37:06.501704 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-15 18:37:07.506847 | ubuntu-noble | changed: 2025-03-15 18:37:07.507079 | ubuntu-noble | cd+++++++++ src/ 2025-03-15 18:37:07.507132 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-15 18:37:07.507161 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-15 18:37:07.507183 | ubuntu-noble | cd+++++++++ src/github.com/osism/zuul-jobs/ 2025-03-15 18:37:07.507203 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.009464 2025-03-15 18:37:43.656436 | 2025-03-15 18:37:43.656543 | TASK [upload-logs : Upload logs to log server] 2025-03-15 18:37:44.203699 | localhost | Output suppressed because no_log was given 2025-03-15 18:37:44.209559 | 2025-03-15 18:37:44.210203 | LOOP [upload-logs : Compress console log and json output] 2025-03-15 18:37:44.317055 | localhost | skipping: Conditional result was False 2025-03-15 18:37:44.338470 | localhost | skipping: Conditional result was False 2025-03-15 18:37:44.343110 | 2025-03-15 18:37:44.343188 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-15 18:37:44.436676 | localhost | skipping: Conditional result was False 2025-03-15 18:37:44.437241 | 2025-03-15 18:37:44.450725 | localhost | skipping: Conditional result was False 2025-03-15 18:37:44.458324 | 2025-03-15 18:37:44.458409 | LOOP [upload-logs : Upload console log and json output]