2025-04-18 03:01:41.626723 | Job console starting... 2025-04-18 03:01:41.635805 | Updating repositories 2025-04-18 03:01:42.228040 | Preparing job workspace 2025-04-18 03:01:44.280508 | Running Ansible setup... 2025-04-18 03:01:53.522798 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-18 03:01:55.146500 | 2025-04-18 03:01:55.146620 | PLAY [Base pre] 2025-04-18 03:01:55.209745 | 2025-04-18 03:01:55.209858 | TASK [Setup log path fact] 2025-04-18 03:01:55.255129 | ubuntu-noble | ok 2025-04-18 03:01:55.286138 | 2025-04-18 03:01:55.286254 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-18 03:01:55.366693 | ubuntu-noble | ok 2025-04-18 03:01:55.386522 | 2025-04-18 03:01:55.386624 | TASK [emit-job-header : Print job information] 2025-04-18 03:01:55.497140 | # Job Information 2025-04-18 03:01:55.497279 | Ansible Version: 2.15.3 2025-04-18 03:01:55.497306 | Job: python-black 2025-04-18 03:01:55.497331 | Pipeline: periodic-daily 2025-04-18 03:01:55.497349 | Executor: 7d211f194f6a 2025-04-18 03:01:55.497365 | Triggered by: https://github.com/osism/netbox-plugin-osism 2025-04-18 03:01:55.497380 | Event ID: 27909edbbace4ff8b899bc0f946fcf76 2025-04-18 03:01:55.507444 | 2025-04-18 03:01:55.507540 | LOOP [emit-job-header : Print node information] 2025-04-18 03:01:55.837270 | ubuntu-noble | ok: 2025-04-18 03:01:55.837484 | ubuntu-noble | # Node Information 2025-04-18 03:01:55.837522 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-18 03:01:55.837630 | ubuntu-noble | Hostname: ubuntu 2025-04-18 03:01:55.837650 | ubuntu-noble | Username: zuul 2025-04-18 03:01:55.837668 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-18 03:01:55.837687 | ubuntu-noble | Provider: regiocloud-a 2025-04-18 03:01:55.837703 | ubuntu-noble | Label: ubuntu-noble 2025-04-18 03:01:55.837721 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-18 03:01:55.837737 | ubuntu-noble | Interface IP: 81.163.193.93 2025-04-18 03:01:55.856847 | 2025-04-18 03:01:55.856972 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-18 03:01:56.516082 | ubuntu-noble -> localhost | changed 2025-04-18 03:01:56.529079 | 2025-04-18 03:01:56.535943 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-18 03:01:58.792073 | ubuntu-noble -> localhost | changed 2025-04-18 03:01:58.810322 | 2025-04-18 03:01:58.810428 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-18 03:01:59.265127 | ubuntu-noble -> localhost | ok 2025-04-18 03:01:59.272337 | 2025-04-18 03:01:59.272506 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-18 03:01:59.344280 | ubuntu-noble | ok 2025-04-18 03:01:59.377950 | ubuntu-noble | included: /var/lib/zuul/builds/4598693b45b949da838e54c684ebd6e1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-18 03:01:59.390848 | 2025-04-18 03:01:59.390963 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-18 03:02:01.001613 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-18 03:02:01.001839 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/4598693b45b949da838e54c684ebd6e1/work/4598693b45b949da838e54c684ebd6e1_id_rsa 2025-04-18 03:02:01.001878 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/4598693b45b949da838e54c684ebd6e1/work/4598693b45b949da838e54c684ebd6e1_id_rsa.pub 2025-04-18 03:02:01.001919 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-18 03:02:01.001943 | ubuntu-noble -> localhost | SHA256:bKk/XlXad8eRMM1qBG+dpUtEPfx4bUiVuyMQw37pTLA zuul-build-sshkey 2025-04-18 03:02:01.001966 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-18 03:02:01.001988 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-18 03:02:01.002009 | ubuntu-noble -> localhost | | ...+*o+| 2025-04-18 03:02:01.002029 | ubuntu-noble -> localhost | | =.o=B=| 2025-04-18 03:02:01.002049 | ubuntu-noble -> localhost | | . *+*B=| 2025-04-18 03:02:01.002082 | ubuntu-noble -> localhost | | . . E.@o+*| 2025-04-18 03:02:01.002103 | ubuntu-noble -> localhost | | S X oo*| 2025-04-18 03:02:01.002122 | ubuntu-noble -> localhost | | o . + +o| 2025-04-18 03:02:01.002146 | ubuntu-noble -> localhost | | . . . .| 2025-04-18 03:02:01.002166 | ubuntu-noble -> localhost | | ... | 2025-04-18 03:02:01.002187 | ubuntu-noble -> localhost | | .o. | 2025-04-18 03:02:01.002207 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-18 03:02:01.002262 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.428947 2025-04-18 03:02:01.010259 | 2025-04-18 03:02:01.010364 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-18 03:02:01.060113 | ubuntu-noble | ok 2025-04-18 03:02:01.083372 | ubuntu-noble | included: /var/lib/zuul/builds/4598693b45b949da838e54c684ebd6e1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-18 03:02:01.108570 | 2025-04-18 03:02:01.108675 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-18 03:02:01.132250 | ubuntu-noble | skipping: Conditional result was False 2025-04-18 03:02:01.138797 | 2025-04-18 03:02:01.138935 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-18 03:02:01.831745 | ubuntu-noble | changed 2025-04-18 03:02:01.843812 | 2025-04-18 03:02:01.843932 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-18 03:02:02.156126 | ubuntu-noble | ok 2025-04-18 03:02:02.165426 | 2025-04-18 03:02:02.165513 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-18 03:02:02.965687 | ubuntu-noble | changed 2025-04-18 03:02:02.974191 | 2025-04-18 03:02:02.974286 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-18 03:02:03.800509 | ubuntu-noble | changed 2025-04-18 03:02:03.818723 | 2025-04-18 03:02:03.818825 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-18 03:02:03.930450 | ubuntu-noble | skipping: Conditional result was False 2025-04-18 03:02:03.938688 | 2025-04-18 03:02:03.938777 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-18 03:02:05.204031 | ubuntu-noble -> localhost | changed 2025-04-18 03:02:05.221945 | 2025-04-18 03:02:05.222051 | TASK [add-build-sshkey : Add back temp key] 2025-04-18 03:02:06.426239 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/4598693b45b949da838e54c684ebd6e1/work/4598693b45b949da838e54c684ebd6e1_id_rsa (zuul-build-sshkey) 2025-04-18 03:02:06.426401 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016603 2025-04-18 03:02:06.434357 | 2025-04-18 03:02:06.434436 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-18 03:02:06.860251 | ubuntu-noble | ok 2025-04-18 03:02:06.873817 | 2025-04-18 03:02:06.873933 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-18 03:02:06.908592 | ubuntu-noble | skipping: Conditional result was False 2025-04-18 03:02:06.919694 | 2025-04-18 03:02:06.919780 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-18 03:02:07.333408 | ubuntu-noble | ok 2025-04-18 03:02:07.397469 | 2025-04-18 03:02:07.397788 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-18 03:02:07.486430 | ubuntu-noble | ok 2025-04-18 03:02:07.494074 | 2025-04-18 03:02:07.494161 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-18 03:02:08.451395 | ubuntu-noble -> localhost | ok 2025-04-18 03:02:08.462096 | 2025-04-18 03:02:08.462188 | TASK [validate-host : Collect information about the host] 2025-04-18 03:02:10.053252 | ubuntu-noble | ok 2025-04-18 03:02:10.066395 | 2025-04-18 03:02:10.066488 | TASK [validate-host : Sanitize hostname] 2025-04-18 03:02:10.126317 | ubuntu-noble | ok 2025-04-18 03:02:10.132313 | 2025-04-18 03:02:10.132429 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-18 03:02:11.005382 | ubuntu-noble -> localhost | changed 2025-04-18 03:02:11.012465 | 2025-04-18 03:02:11.012577 | TASK [validate-host : Collect information about zuul worker] 2025-04-18 03:02:11.589311 | ubuntu-noble | ok 2025-04-18 03:02:11.596151 | 2025-04-18 03:02:11.596252 | TASK [validate-host : Write out all zuul information for each host] 2025-04-18 03:02:12.397017 | ubuntu-noble -> localhost | changed 2025-04-18 03:02:12.414903 | 2025-04-18 03:02:12.415005 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-18 03:02:12.714096 | ubuntu-noble | ok 2025-04-18 03:02:12.729506 | 2025-04-18 03:02:12.729619 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-18 03:02:13.593025 | ubuntu-noble | changed: 2025-04-18 03:02:13.593195 | ubuntu-noble | cd+++++++++ src/ 2025-04-18 03:02:13.593225 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-18 03:02:13.593246 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-18 03:02:13.593264 | ubuntu-noble | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2025-04-18 03:02:13.593281 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007475 2025-04-18 03:02:45.189045 | 2025-04-18 03:02:45.189140 | TASK [upload-logs : Upload logs to log server] 2025-04-18 03:02:45.768417 | localhost | Output suppressed because no_log was given 2025-04-18 03:02:45.771254 | 2025-04-18 03:02:45.771341 | LOOP [upload-logs : Compress console log and json output] 2025-04-18 03:02:45.850103 | localhost | skipping: Conditional result was False 2025-04-18 03:02:45.872669 | localhost | skipping: Conditional result was False 2025-04-18 03:02:45.881669 | 2025-04-18 03:02:45.881772 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-18 03:02:45.984003 | localhost | skipping: Conditional result was False 2025-04-18 03:02:45.984234 | 2025-04-18 03:02:45.985224 | localhost | skipping: Conditional result was False 2025-04-18 03:02:45.990263 | 2025-04-18 03:02:45.990356 | LOOP [upload-logs : Upload console log and json output]