2025-03-14 11:27:05.816202 | Job console starting... 2025-03-14 11:27:05.840604 | Updating repositories 2025-03-14 11:27:05.915572 | Preparing job workspace 2025-03-14 11:27:07.958700 | Running Ansible setup... 2025-03-14 11:27:13.651714 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-14 11:27:15.016942 | 2025-03-14 11:27:15.017090 | PLAY [Base pre] 2025-03-14 11:27:15.090602 | 2025-03-14 11:27:15.090727 | TASK [Setup log path fact] 2025-03-14 11:27:15.131671 | ubuntu-noble | ok 2025-03-14 11:27:15.180840 | 2025-03-14 11:27:15.180964 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-14 11:27:15.281202 | ubuntu-noble | ok 2025-03-14 11:27:15.286867 | 2025-03-14 11:27:15.286948 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-14 11:27:15.381193 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 11:27:15.386925 | 2025-03-14 11:27:15.387016 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-14 11:27:15.521879 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 11:27:15.528337 | 2025-03-14 11:27:15.528448 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-14 11:27:15.594668 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 11:27:15.600502 | 2025-03-14 11:27:15.600589 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-14 11:27:15.643777 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 11:27:15.650548 | 2025-03-14 11:27:15.650632 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-14 11:27:15.694407 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 11:27:15.706856 | 2025-03-14 11:27:15.706962 | TASK [emit-job-header : Print job information] 2025-03-14 11:27:15.798793 | # Job Information 2025-03-14 11:27:15.799067 | Ansible Version: 2.15.3 2025-03-14 11:27:15.799113 | Job: python-black 2025-03-14 11:27:15.799139 | Pipeline: check 2025-03-14 11:27:15.799164 | Executor: 7d211f194f6a 2025-03-14 11:27:15.799191 | Triggered by: https://github.com/osism/python-osism/pull/1227 2025-03-14 11:27:15.799270 | Event ID: 3ddcae50-00c7-11f0-9c91-ea9e25248d7b 2025-03-14 11:27:15.809441 | 2025-03-14 11:27:15.809524 | LOOP [emit-job-header : Print node information] 2025-03-14 11:27:16.045442 | ubuntu-noble | ok: 2025-03-14 11:27:16.045574 | ubuntu-noble | # Node Information 2025-03-14 11:27:16.045602 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-14 11:27:16.045621 | ubuntu-noble | Hostname: ubuntu 2025-03-14 11:27:16.045638 | ubuntu-noble | Username: zuul 2025-03-14 11:27:16.045655 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-14 11:27:16.045671 | ubuntu-noble | Provider: regiocloud-a 2025-03-14 11:27:16.045686 | ubuntu-noble | Label: ubuntu-noble 2025-03-14 11:27:16.045702 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-14 11:27:16.045718 | ubuntu-noble | Interface IP: 81.163.192.157 2025-03-14 11:27:16.067871 | 2025-03-14 11:27:16.067958 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-14 11:27:17.125721 | ubuntu-noble -> localhost | changed 2025-03-14 11:27:17.132212 | 2025-03-14 11:27:17.132290 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-14 11:27:19.049018 | ubuntu-noble -> localhost | changed 2025-03-14 11:27:19.060358 | 2025-03-14 11:27:19.060457 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-14 11:27:19.716644 | ubuntu-noble -> localhost | ok 2025-03-14 11:27:19.722815 | 2025-03-14 11:27:19.722900 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-14 11:27:19.791411 | ubuntu-noble | ok 2025-03-14 11:27:19.835782 | ubuntu-noble | included: /var/lib/zuul/builds/3ccf13131d0e49059f65b734dc9eea04/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-14 11:27:19.853213 | 2025-03-14 11:27:19.853301 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-14 11:27:21.701419 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-14 11:27:21.701692 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/3ccf13131d0e49059f65b734dc9eea04/work/3ccf13131d0e49059f65b734dc9eea04_id_rsa 2025-03-14 11:27:21.701800 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/3ccf13131d0e49059f65b734dc9eea04/work/3ccf13131d0e49059f65b734dc9eea04_id_rsa.pub 2025-03-14 11:27:21.701828 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-14 11:27:21.701886 | ubuntu-noble -> localhost | SHA256:sMWV0B7LRg9Lrkv4AGYuGLfAlwunCPlzayBNgXaOA40 zuul-build-sshkey 2025-03-14 11:27:21.701910 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-14 11:27:21.701932 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-14 11:27:21.701970 | ubuntu-noble -> localhost | | + .o.. | 2025-03-14 11:27:21.702043 | ubuntu-noble -> localhost | |E.o. . .B | 2025-03-14 11:27:21.702063 | ubuntu-noble -> localhost | |+.+.. . o* * | 2025-03-14 11:27:21.702095 | ubuntu-noble -> localhost | |==o=+ + B . | 2025-03-14 11:27:21.702149 | ubuntu-noble -> localhost | |oO*=....So | 2025-03-14 11:27:21.702168 | ubuntu-noble -> localhost | |+.B.o o o | 2025-03-14 11:27:21.702186 | ubuntu-noble -> localhost | | . = . + . | 2025-03-14 11:27:21.702204 | ubuntu-noble -> localhost | | o o | 2025-03-14 11:27:21.702288 | ubuntu-noble -> localhost | | . | 2025-03-14 11:27:21.702313 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-14 11:27:21.702396 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.747460 2025-03-14 11:27:21.712869 | 2025-03-14 11:27:21.713014 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-14 11:27:21.772730 | ubuntu-noble | ok 2025-03-14 11:27:21.800403 | ubuntu-noble | included: /var/lib/zuul/builds/3ccf13131d0e49059f65b734dc9eea04/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-14 11:27:21.813971 | 2025-03-14 11:27:21.814267 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-14 11:27:21.867291 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 11:27:21.877899 | 2025-03-14 11:27:21.878011 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-14 11:27:22.808737 | ubuntu-noble | changed 2025-03-14 11:27:22.826540 | 2025-03-14 11:27:22.826906 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-14 11:27:23.172883 | ubuntu-noble | ok 2025-03-14 11:27:23.181206 | 2025-03-14 11:27:23.181304 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-14 11:27:23.934395 | ubuntu-noble | changed 2025-03-14 11:27:23.942546 | 2025-03-14 11:27:23.942648 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-14 11:27:24.782637 | ubuntu-noble | changed 2025-03-14 11:27:24.821454 | 2025-03-14 11:27:24.821586 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-14 11:27:24.837448 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 11:27:24.855251 | 2025-03-14 11:27:24.855411 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-14 11:27:25.288802 | ubuntu-noble -> localhost | changed 2025-03-14 11:27:25.318815 | 2025-03-14 11:27:25.318926 | TASK [add-build-sshkey : Add back temp key] 2025-03-14 11:27:25.849337 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/3ccf13131d0e49059f65b734dc9eea04/work/3ccf13131d0e49059f65b734dc9eea04_id_rsa (zuul-build-sshkey) 2025-03-14 11:27:25.851817 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.023997 2025-03-14 11:27:25.873668 | 2025-03-14 11:27:25.873982 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-14 11:27:26.316064 | ubuntu-noble | ok 2025-03-14 11:27:26.328202 | 2025-03-14 11:27:26.328308 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-14 11:27:26.389755 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 11:27:26.438946 | 2025-03-14 11:27:26.439039 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-14 11:27:26.976591 | ubuntu-noble | ok 2025-03-14 11:27:26.995957 | 2025-03-14 11:27:26.996053 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-14 11:27:27.034343 | ubuntu-noble | ok 2025-03-14 11:27:27.040823 | 2025-03-14 11:27:27.040951 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-14 11:27:27.278510 | ubuntu-noble -> localhost | ok 2025-03-14 11:27:27.284784 | 2025-03-14 11:27:27.284870 | TASK [validate-host : Collect information about the host] 2025-03-14 11:27:28.509302 | ubuntu-noble | ok 2025-03-14 11:27:28.520697 | 2025-03-14 11:27:28.520785 | TASK [validate-host : Sanitize hostname] 2025-03-14 11:27:28.579769 | ubuntu-noble | ok 2025-03-14 11:27:28.590782 | 2025-03-14 11:27:28.590862 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-14 11:27:29.108311 | ubuntu-noble -> localhost | changed 2025-03-14 11:27:29.122926 | 2025-03-14 11:27:29.123041 | TASK [validate-host : Collect information about zuul worker] 2025-03-14 11:27:29.590228 | ubuntu-noble | ok 2025-03-14 11:27:29.596794 | 2025-03-14 11:27:29.597170 | TASK [validate-host : Write out all zuul information for each host] 2025-03-14 11:27:30.392020 | ubuntu-noble -> localhost | changed 2025-03-14 11:27:30.404946 | 2025-03-14 11:27:30.405032 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-14 11:27:30.830332 | ubuntu-noble | ok 2025-03-14 11:27:30.838314 | 2025-03-14 11:27:30.838403 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-14 11:27:32.019469 | ubuntu-noble | changed: 2025-03-14 11:27:32.019719 | ubuntu-noble | cd+++++++++ src/ 2025-03-14 11:27:32.019761 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-14 11:27:32.019795 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-14 11:27:32.019906 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-03-14 11:27:32.019930 | ubuntu-noble | Containerfile 2025-03-14 11:27:32.020146 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006610 2025-03-14 11:28:10.729560 | 2025-03-14 11:28:10.729671 | TASK [upload-logs : Upload logs to log server] 2025-03-14 11:28:11.290731 | localhost | Output suppressed because no_log was given 2025-03-14 11:28:11.296052 | 2025-03-14 11:28:11.296221 | LOOP [upload-logs : Compress console log and json output] 2025-03-14 11:28:11.368945 | localhost | skipping: Conditional result was False 2025-03-14 11:28:11.386362 | localhost | skipping: Conditional result was False 2025-03-14 11:28:11.402216 | 2025-03-14 11:28:11.402396 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-14 11:28:11.470065 | localhost | skipping: Conditional result was False 2025-03-14 11:28:11.470747 | 2025-03-14 11:28:11.481919 | localhost | skipping: Conditional result was False 2025-03-14 11:28:11.492500 | 2025-03-14 11:28:11.492719 | LOOP [upload-logs : Upload console log and json output]