2025-03-25 15:25:18.490270 | Job console starting... 2025-03-25 15:25:18.502118 | Updating repositories 2025-03-25 15:25:18.526336 | Preparing job workspace 2025-03-25 15:25:19.798992 | Running Ansible setup... 2025-03-25 15:25:24.980656 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-25 15:25:25.631612 | 2025-03-25 15:25:25.631730 | PLAY [Base pre] 2025-03-25 15:25:25.659400 | 2025-03-25 15:25:25.659508 | TASK [Setup log path fact] 2025-03-25 15:25:25.681160 | ubuntu-noble-large | ok 2025-03-25 15:25:25.699332 | 2025-03-25 15:25:25.699455 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-25 15:25:25.741296 | ubuntu-noble-large | ok 2025-03-25 15:25:25.754382 | 2025-03-25 15:25:25.754484 | TASK [emit-job-header : Print job information] 2025-03-25 15:25:25.826201 | # Job Information 2025-03-25 15:25:25.826415 | Ansible Version: 2.15.3 2025-03-25 15:25:25.826464 | Job: ci-image-build 2025-03-25 15:25:25.826510 | Pipeline: check 2025-03-25 15:25:25.826543 | Executor: 7d211f194f6a 2025-03-25 15:25:25.826572 | Triggered by: https://github.com/osism/ci-image/pull/59 2025-03-25 15:25:25.826601 | Event ID: 02459a40-098d-11f0-924e-4a951015fce8 2025-03-25 15:25:25.834902 | 2025-03-25 15:25:25.835034 | LOOP [emit-job-header : Print node information] 2025-03-25 15:25:25.988224 | ubuntu-noble-large | ok: 2025-03-25 15:25:25.988528 | ubuntu-noble-large | # Node Information 2025-03-25 15:25:25.988570 | ubuntu-noble-large | Inventory Hostname: ubuntu-noble-large 2025-03-25 15:25:25.988595 | ubuntu-noble-large | Hostname: ubuntu 2025-03-25 15:25:25.988616 | ubuntu-noble-large | Username: zuul 2025-03-25 15:25:25.988635 | ubuntu-noble-large | Distro: Ubuntu 24.04 2025-03-25 15:25:25.988659 | ubuntu-noble-large | Provider: regiocloud-a 2025-03-25 15:25:25.988679 | ubuntu-noble-large | Label: ubuntu-noble-large 2025-03-25 15:25:25.988699 | ubuntu-noble-large | Product Name: OpenStack Nova 2025-03-25 15:25:25.988719 | ubuntu-noble-large | Interface IP: 81.163.193.165 2025-03-25 15:25:26.021570 | 2025-03-25 15:25:26.021708 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-25 15:25:26.497695 | ubuntu-noble-large -> localhost | changed 2025-03-25 15:25:26.513763 | 2025-03-25 15:25:26.513900 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-25 15:25:27.555758 | ubuntu-noble-large -> localhost | changed 2025-03-25 15:25:27.575757 | 2025-03-25 15:25:27.575883 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-25 15:25:27.856181 | ubuntu-noble-large -> localhost | ok 2025-03-25 15:25:27.864131 | 2025-03-25 15:25:27.864260 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-25 15:25:27.897919 | ubuntu-noble-large | ok 2025-03-25 15:25:27.914341 | ubuntu-noble-large | included: /var/lib/zuul/builds/fbdf592bcbe940e3a8557bdb479817eb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-25 15:25:27.922098 | 2025-03-25 15:25:27.922199 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-25 15:25:28.616430 | ubuntu-noble-large -> localhost | Generating public/private rsa key pair. 2025-03-25 15:25:28.616968 | ubuntu-noble-large -> localhost | Your identification has been saved in /var/lib/zuul/builds/fbdf592bcbe940e3a8557bdb479817eb/work/fbdf592bcbe940e3a8557bdb479817eb_id_rsa 2025-03-25 15:25:28.617101 | ubuntu-noble-large -> localhost | Your public key has been saved in /var/lib/zuul/builds/fbdf592bcbe940e3a8557bdb479817eb/work/fbdf592bcbe940e3a8557bdb479817eb_id_rsa.pub 2025-03-25 15:25:28.617176 | ubuntu-noble-large -> localhost | The key fingerprint is: 2025-03-25 15:25:28.617243 | ubuntu-noble-large -> localhost | SHA256:LrkDoLKIZ/fSAmi7USKZRU69x7V9ndVP6KXbq2YibsY zuul-build-sshkey 2025-03-25 15:25:28.617306 | ubuntu-noble-large -> localhost | The key's randomart image is: 2025-03-25 15:25:28.617365 | ubuntu-noble-large -> localhost | +---[RSA 3072]----+ 2025-03-25 15:25:28.617425 | ubuntu-noble-large -> localhost | | o. ..| 2025-03-25 15:25:28.617501 | ubuntu-noble-large -> localhost | | + . . . =| 2025-03-25 15:25:28.617560 | ubuntu-noble-large -> localhost | | o o . o o *.| 2025-03-25 15:25:28.617616 | ubuntu-noble-large -> localhost | | +. . o . . . = .| 2025-03-25 15:25:28.617671 | ubuntu-noble-large -> localhost | |++ o . S . o | 2025-03-25 15:25:28.617728 | ubuntu-noble-large -> localhost | |=.+ . o . .| 2025-03-25 15:25:28.617801 | ubuntu-noble-large -> localhost | |=o.. oo o .| 2025-03-25 15:25:28.617858 | ubuntu-noble-large -> localhost | |+.+ + oo E . o . | 2025-03-25 15:25:28.617915 | ubuntu-noble-large -> localhost | | +.. +o.+.. +.. | 2025-03-25 15:25:28.618002 | ubuntu-noble-large -> localhost | +----[SHA256]-----+ 2025-03-25 15:25:28.618150 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.186610 2025-03-25 15:25:28.633718 | 2025-03-25 15:25:28.633853 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-25 15:25:28.675415 | ubuntu-noble-large | ok 2025-03-25 15:25:28.689437 | ubuntu-noble-large | included: /var/lib/zuul/builds/fbdf592bcbe940e3a8557bdb479817eb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-25 15:25:28.700819 | 2025-03-25 15:25:28.701287 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-25 15:25:28.740933 | ubuntu-noble-large | skipping: Conditional result was False 2025-03-25 15:25:28.748508 | 2025-03-25 15:25:28.748611 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-25 15:25:29.559146 | ubuntu-noble-large | changed 2025-03-25 15:25:29.566403 | 2025-03-25 15:25:29.566512 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-25 15:25:29.913683 | ubuntu-noble-large | ok 2025-03-25 15:25:29.921015 | 2025-03-25 15:25:29.921129 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-25 15:25:30.810158 | ubuntu-noble-large | changed 2025-03-25 15:25:30.819949 | 2025-03-25 15:25:30.820191 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-25 15:25:31.780413 | ubuntu-noble-large | changed 2025-03-25 15:25:31.790729 | 2025-03-25 15:25:31.790850 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-25 15:25:31.826424 | ubuntu-noble-large | skipping: Conditional result was False 2025-03-25 15:25:31.839268 | 2025-03-25 15:25:31.839399 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-25 15:25:32.294038 | ubuntu-noble-large -> localhost | changed 2025-03-25 15:25:32.309531 | 2025-03-25 15:25:32.309655 | TASK [add-build-sshkey : Add back temp key] 2025-03-25 15:25:32.694085 | ubuntu-noble-large -> localhost | Identity added: /var/lib/zuul/builds/fbdf592bcbe940e3a8557bdb479817eb/work/fbdf592bcbe940e3a8557bdb479817eb_id_rsa (zuul-build-sshkey) 2025-03-25 15:25:32.694541 | ubuntu-noble-large -> localhost | ok: Runtime: 0:00:00.017716 2025-03-25 15:25:32.712111 | 2025-03-25 15:25:32.712250 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-25 15:25:33.191764 | ubuntu-noble-large | ok 2025-03-25 15:25:33.201234 | 2025-03-25 15:25:33.201357 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-25 15:25:33.248275 | ubuntu-noble-large | skipping: Conditional result was False 2025-03-25 15:25:33.316647 | 2025-03-25 15:25:33.316767 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-25 15:25:33.782586 | ubuntu-noble-large | ok 2025-03-25 15:25:33.796213 | 2025-03-25 15:25:33.796335 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-25 15:25:33.839653 | ubuntu-noble-large | ok 2025-03-25 15:25:33.846876 | 2025-03-25 15:25:33.846998 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-25 15:25:34.158504 | ubuntu-noble-large -> localhost | ok 2025-03-25 15:25:34.176607 | 2025-03-25 15:25:34.176757 | TASK [validate-host : Collect information about the host] 2025-03-25 15:25:35.516527 | ubuntu-noble-large | ok 2025-03-25 15:25:35.531266 | 2025-03-25 15:25:35.531380 | TASK [validate-host : Sanitize hostname] 2025-03-25 15:25:35.605190 | ubuntu-noble-large | ok 2025-03-25 15:25:35.614425 | 2025-03-25 15:25:35.614545 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-25 15:25:36.171252 | ubuntu-noble-large -> localhost | changed 2025-03-25 15:25:36.183694 | 2025-03-25 15:25:36.183816 | TASK [validate-host : Collect information about zuul worker] 2025-03-25 15:25:36.704677 | ubuntu-noble-large | ok 2025-03-25 15:25:36.714036 | 2025-03-25 15:25:36.714171 | TASK [validate-host : Write out all zuul information for each host] 2025-03-25 15:25:37.262634 | ubuntu-noble-large -> localhost | changed 2025-03-25 15:25:37.284058 | 2025-03-25 15:25:37.284196 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-25 15:25:37.633024 | ubuntu-noble-large | ok 2025-03-25 15:25:37.642949 | 2025-03-25 15:25:37.643125 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-25 15:25:38.448557 | ubuntu-noble-large | changed: 2025-03-25 15:25:38.448874 | ubuntu-noble-large | cd+++++++++ src/ 2025-03-25 15:25:38.448945 | ubuntu-noble-large | cd+++++++++ src/github.com/ 2025-03-25 15:25:38.449049 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/ 2025-03-25 15:25:38.449095 | ubuntu-noble-large | cd+++++++++ src/github.com/osism/ci-image/ 2025-03-25 15:25:38.449138 | ubuntu-noble-large | To install Python packages system-wide, try apt install 2025-03-25 15:26:00.437011 | ubuntu-noble-large | python3-xyz, where xyz is the package you are trying to 2025-03-25 15:26:00.437020 | ubuntu-noble-large | install. 2025-03-25 15:26:00.437028 | ubuntu-noble-large | 2025-03-25 15:26:00.437045 | ubuntu-noble-large | If you wish to install a non-Debian-packaged Python package, 2025-03-25 15:26:00.437058 | ubuntu-noble-large | create a virtual environment using python3 -m venv path/to/venv. 2025-03-25 15:26:00.437068 | ubuntu-noble-large | Then use path/to/venv/bin/python and path/to/venv/bin/pip. Make 2025-03-25 15:26:00.437078 | ubuntu-noble-large | sure you have python3-full installed. 2025-03-25 15:26:00.437087 | ubuntu-noble-large | 2025-03-25 15:26:00.437148 | ubuntu-noble-large | If you wish to install a non-Debian packaged Python application, 2025-03-25 15:26:00.437164 | ubuntu-noble-large | it may be easiest to use pipx install xyz, which will manage a 2025-03-25 15:26:00.437173 | ubuntu-noble-large | virtual environment for you. Make sure you have pipx installed. 2025-03-25 15:26:00.437183 | ubuntu-noble-large | 2025-03-25 15:26:00.437193 | ubuntu-noble-large | See /usr/share/doc/python3.12/README.venv for more information. 2025-03-25 15:26:00.437221 | ubuntu-noble-large | 2025-03-25 15:26:00.437232 | ubuntu-noble-large | note: If you believe this is a mistake, please contact your Python installation or OS distribution provider. You can override this, at the risk of breaking your Python installation or OS, by passing --break-system-packages. 2025-03-25 15:26:00.437247 | ubuntu-noble-large | hint: See PEP 668 for the detailed specification. 2025-03-25 15:26:00.844194 | ubuntu-noble-large | ERROR 2025-03-25 15:26:00.844637 | ubuntu-noble-large | { 2025-03-25 15:26:00.844752 | ubuntu-noble-large | "delta": "0:00:00.784941", 2025-03-25 15:26:00.844826 | ubuntu-noble-large | "end": "2025-03-25 15:26:00.437793", 2025-03-25 15:26:00.844889 | ubuntu-noble-large | "msg": "non-zero return code", 2025-03-25 15:26:00.844949 | ubuntu-noble-large | "rc": 1, 2025-03-25 15:26:00.845031 | ubuntu-noble-large | "start": "2025-03-25 15:25:59.652852" 2025-03-25 15:26:00.845088 | ubuntu-noble-large | } failure 2025-03-25 15:26:00.849874 | 2025-03-25 15:26:00.850072 | PLAY RECAP 2025-03-25 15:26:00.850217 | ubuntu-noble-large | ok: 8 changed: 5 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2025-03-25 15:26:00.850300 | 2025-03-25 15:26:00.976050 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/ci-image/playbooks/pre.yml@main] 2025-03-25 15:26:00.978848 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-25 15:26:01.675883 | 2025-03-25 15:26:01.676076 | PLAY [Base post] 2025-03-25 15:26:01.704304 | 2025-03-25 15:26:01.704454 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-03-25 15:26:02.394808 | ubuntu-noble-large | changed 2025-03-25 15:26:02.429022 | 2025-03-25 15:26:02.429137 | PLAY RECAP 2025-03-25 15:26:02.429200 | ubuntu-noble-large | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-03-25 15:26:02.429263 | 2025-03-25 15:26:02.541973 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-25 15:26:02.548073 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-03-25 15:26:03.275594 | 2025-03-25 15:26:03.275740 | PLAY [Base post-logs] 2025-03-25 15:26:03.291484 | 2025-03-25 15:26:03.291609 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-03-25 15:26:03.741879 | localhost | changed 2025-03-25 15:26:03.748161 | 2025-03-25 15:26:03.748333 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-03-25 15:26:03.779815 | localhost | ok 2025-03-25 15:26:03.790745 | 2025-03-25 15:26:03.790884 | TASK [Set zuul-log-path fact] 2025-03-25 15:26:03.809359 | localhost | ok 2025-03-25 15:26:03.820116 | 2025-03-25 15:26:03.820220 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-25 15:26:03.852641 | localhost | ok 2025-03-25 15:26:03.864162 | 2025-03-25 15:26:03.864321 | TASK [upload-logs : Create log directories] 2025-03-25 15:26:04.374748 | localhost | changed 2025-03-25 15:26:04.381911 | 2025-03-25 15:26:04.382087 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-03-25 15:26:04.887810 | localhost -> localhost | ok: Runtime: 0:00:00.004994 2025-03-25 15:26:04.899457 | 2025-03-25 15:26:04.899623 | TASK [upload-logs : Upload logs to log server] 2025-03-25 15:26:05.449443 | localhost | Output suppressed because no_log was given 2025-03-25 15:26:05.452834 | 2025-03-25 15:26:05.452945 | LOOP [upload-logs : Compress console log and json output] 2025-03-25 15:26:05.516499 | localhost | skipping: Conditional result was False 2025-03-25 15:26:05.532898 | localhost | skipping: Conditional result was False 2025-03-25 15:26:05.542978 | 2025-03-25 15:26:05.543085 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-25 15:26:05.606856 | localhost | skipping: Conditional result was False 2025-03-25 15:26:05.607587 | 2025-03-25 15:26:05.638678 | localhost | skipping: Conditional result was False 2025-03-25 15:26:05.649515 | 2025-03-25 15:26:05.649702 | LOOP [upload-logs : Upload console log and json output]