2025-02-04 04:42:04.109974 | Job console starting... 2025-02-04 04:42:04.119077 | Updating repositories 2025-02-04 04:42:04.189481 | Preparing job workspace 2025-02-04 04:42:06.618120 | Running Ansible setup... 2025-02-04 04:42:12.414420 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-04 04:42:13.338393 | 2025-02-04 04:42:13.338527 | PLAY [Base pre] 2025-02-04 04:42:13.412073 | 2025-02-04 04:42:13.412203 | TASK [Setup log path fact] 2025-02-04 04:42:13.462473 | ubuntu-noble | ok 2025-02-04 04:42:13.507806 | 2025-02-04 04:42:13.507946 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-04 04:42:13.599423 | ubuntu-noble | ok 2025-02-04 04:42:13.608508 | 2025-02-04 04:42:13.608623 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-04 04:42:13.683652 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 04:42:13.690900 | 2025-02-04 04:42:13.691010 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-04 04:42:13.776613 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 04:42:13.784071 | 2025-02-04 04:42:13.784173 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-04 04:42:13.828919 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 04:42:13.836536 | 2025-02-04 04:42:13.836647 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-04 04:42:13.860735 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 04:42:13.867702 | 2025-02-04 04:42:13.867801 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-04 04:42:13.892798 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 04:42:13.913904 | 2025-02-04 04:42:13.914014 | TASK [emit-job-header : Print job information] 2025-02-04 04:42:13.982467 | # Job Information 2025-02-04 04:42:13.982653 | Ansible Version: 2.15.3 2025-02-04 04:42:13.982687 | Job: python-black 2025-02-04 04:42:13.982716 | Pipeline: check 2025-02-04 04:42:13.982737 | Executor: 7d211f194f6a 2025-02-04 04:42:13.982756 | Triggered by: https://github.com/osism/cfg-generics/pull/512 2025-02-04 04:42:13.982774 | Event ID: 5cbcae20-e2b2-11ef-8a7f-c13f863ecb07 2025-02-04 04:42:13.993617 | 2025-02-04 04:42:13.993714 | LOOP [emit-job-header : Print node information] 2025-02-04 04:42:14.152166 | ubuntu-noble | ok: 2025-02-04 04:42:14.152500 | ubuntu-noble | # Node Information 2025-02-04 04:42:14.152551 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-04 04:42:14.152588 | ubuntu-noble | Hostname: ubuntu 2025-02-04 04:42:14.152612 | ubuntu-noble | Username: zuul 2025-02-04 04:42:14.152633 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-04 04:42:14.152653 | ubuntu-noble | Provider: regiocloud-a 2025-02-04 04:42:14.152672 | ubuntu-noble | Label: ubuntu-noble 2025-02-04 04:42:14.152692 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-04 04:42:14.152711 | ubuntu-noble | Interface IP: 81.163.192.148 2025-02-04 04:42:14.169414 | 2025-02-04 04:42:14.169517 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-04 04:42:14.865515 | ubuntu-noble -> localhost | changed 2025-02-04 04:42:14.873711 | 2025-02-04 04:42:14.873813 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-04 04:42:16.232877 | ubuntu-noble -> localhost | changed 2025-02-04 04:42:16.259724 | 2025-02-04 04:42:16.259833 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-04 04:42:16.596307 | ubuntu-noble -> localhost | ok 2025-02-04 04:42:16.602823 | 2025-02-04 04:42:16.602905 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-04 04:42:16.634277 | ubuntu-noble | ok 2025-02-04 04:42:16.651116 | ubuntu-noble | included: /var/lib/zuul/builds/671cc23dfa144d0ebe8d89aa39623c08/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-04 04:42:16.657496 | 2025-02-04 04:42:16.657593 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-04 04:42:17.531472 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-04 04:42:17.531672 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/671cc23dfa144d0ebe8d89aa39623c08/work/671cc23dfa144d0ebe8d89aa39623c08_id_rsa 2025-02-04 04:42:17.531705 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/671cc23dfa144d0ebe8d89aa39623c08/work/671cc23dfa144d0ebe8d89aa39623c08_id_rsa.pub 2025-02-04 04:42:17.531726 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-04 04:42:17.531744 | ubuntu-noble -> localhost | SHA256:klfSYMxXrsmjq38BN8DFuJ+cxCa7cXmUmuk3tsjXQV4 zuul-build-sshkey 2025-02-04 04:42:17.531763 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-04 04:42:17.531783 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-04 04:42:17.531800 | ubuntu-noble -> localhost | | +o+... | 2025-02-04 04:42:17.531816 | ubuntu-noble -> localhost | | .*oo. | 2025-02-04 04:42:17.531831 | ubuntu-noble -> localhost | | .=o .. | 2025-02-04 04:42:17.531847 | ubuntu-noble -> localhost | | .++*oo . E| 2025-02-04 04:42:17.531862 | ubuntu-noble -> localhost | | o SX=X o . | 2025-02-04 04:42:17.531877 | ubuntu-noble -> localhost | | oo.%.. o | 2025-02-04 04:42:17.531893 | ubuntu-noble -> localhost | | .= o . . | 2025-02-04 04:42:17.531908 | ubuntu-noble -> localhost | | .oo.= . | 2025-02-04 04:42:17.531924 | ubuntu-noble -> localhost | | .oo.o+.o | 2025-02-04 04:42:17.531939 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-04 04:42:17.531978 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.281464 2025-02-04 04:42:17.538772 | 2025-02-04 04:42:17.538856 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-04 04:42:17.583813 | ubuntu-noble | ok 2025-02-04 04:42:17.600274 | ubuntu-noble | included: /var/lib/zuul/builds/671cc23dfa144d0ebe8d89aa39623c08/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-04 04:42:17.617858 | 2025-02-04 04:42:17.618133 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-04 04:42:17.663541 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 04:42:17.669527 | 2025-02-04 04:42:17.669622 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-04 04:42:18.391917 | ubuntu-noble | changed 2025-02-04 04:42:18.401043 | 2025-02-04 04:42:18.401145 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-04 04:42:18.701495 | ubuntu-noble | ok 2025-02-04 04:42:18.709254 | 2025-02-04 04:42:18.709353 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-04 04:42:19.483361 | ubuntu-noble | changed 2025-02-04 04:42:19.490927 | 2025-02-04 04:42:19.491019 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-04 04:42:20.246931 | ubuntu-noble | changed 2025-02-04 04:42:20.256039 | 2025-02-04 04:42:20.256138 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-04 04:42:20.283806 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 04:42:20.295321 | 2025-02-04 04:42:20.295416 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-04 04:42:20.893303 | ubuntu-noble -> localhost | changed 2025-02-04 04:42:20.913002 | 2025-02-04 04:42:20.913143 | TASK [add-build-sshkey : Add back temp key] 2025-02-04 04:42:21.439020 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/671cc23dfa144d0ebe8d89aa39623c08/work/671cc23dfa144d0ebe8d89aa39623c08_id_rsa (zuul-build-sshkey) 2025-02-04 04:42:21.439342 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008498 2025-02-04 04:42:21.453337 | 2025-02-04 04:42:21.453434 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-04 04:42:21.881077 | ubuntu-noble | ok 2025-02-04 04:42:21.887833 | 2025-02-04 04:42:21.887932 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-04 04:42:21.912879 | ubuntu-noble | skipping: Conditional result was False 2025-02-04 04:42:21.926001 | 2025-02-04 04:42:21.926098 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-04 04:42:22.382318 | ubuntu-noble | ok 2025-02-04 04:42:22.402356 | 2025-02-04 04:42:22.402459 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-04 04:42:22.441652 | ubuntu-noble | ok 2025-02-04 04:42:22.452600 | 2025-02-04 04:42:22.452695 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-04 04:42:22.836144 | ubuntu-noble -> localhost | ok 2025-02-04 04:42:22.844179 | 2025-02-04 04:42:22.844275 | TASK [validate-host : Collect information about the host] 2025-02-04 04:42:24.049361 | ubuntu-noble | ok 2025-02-04 04:42:24.061721 | 2025-02-04 04:42:24.061848 | TASK [validate-host : Sanitize hostname] 2025-02-04 04:42:24.133874 | ubuntu-noble | ok 2025-02-04 04:42:24.140210 | 2025-02-04 04:42:24.140321 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-04 04:42:24.888995 | ubuntu-noble -> localhost | changed 2025-02-04 04:42:24.901071 | 2025-02-04 04:42:24.901214 | TASK [validate-host : Collect information about zuul worker] 2025-02-04 04:42:25.428463 | ubuntu-noble | ok 2025-02-04 04:42:25.435203 | 2025-02-04 04:42:25.435314 | TASK [validate-host : Write out all zuul information for each host] 2025-02-04 04:42:26.061786 | ubuntu-noble -> localhost | changed 2025-02-04 04:42:26.074448 | 2025-02-04 04:42:26.074604 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-04 04:42:26.403293 | ubuntu-noble | ok 2025-02-04 04:42:26.416033 | 2025-02-04 04:42:26.416162 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-04 04:42:27.419760 | ubuntu-noble | changed: 2025-02-04 04:42:27.419956 | ubuntu-noble | cd+++++++++ src/ 2025-02-04 04:42:27.419989 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-04 04:42:27.420013 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-04 04:42:27.420034 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-generics/ 2025-02-04 04:42:27.420054 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008152 2025-02-04 04:42:59.320806 | 2025-02-04 04:42:59.320925 | TASK [upload-logs : Upload logs to log server] 2025-02-04 04:42:59.948161 | localhost | Output suppressed because no_log was given 2025-02-04 04:42:59.952756 | 2025-02-04 04:42:59.952899 | LOOP [upload-logs : Compress console log and json output] 2025-02-04 04:43:00.023318 | localhost | skipping: Conditional result was False 2025-02-04 04:43:00.044478 | localhost | skipping: Conditional result was False 2025-02-04 04:43:00.054419 | 2025-02-04 04:43:00.054556 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-04 04:43:00.139500 | localhost | skipping: Conditional result was False 2025-02-04 04:43:00.139820 | 2025-02-04 04:43:00.157262 | localhost | skipping: Conditional result was False 2025-02-04 04:43:00.164967 | 2025-02-04 04:43:00.165147 | LOOP [upload-logs : Upload console log and json output]