2025-03-23 19:38:02.704422 | Job console starting... 2025-03-23 19:38:02.755148 | Updating repositories 2025-03-23 19:38:02.850183 | Preparing job workspace 2025-03-23 19:38:05.231684 | Running Ansible setup... 2025-03-23 19:38:13.037571 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-23 19:38:14.630130 | 2025-03-23 19:38:14.630245 | PLAY [Base pre] 2025-03-23 19:38:14.681503 | 2025-03-23 19:38:14.681638 | TASK [Setup log path fact] 2025-03-23 19:38:14.725501 | ubuntu-noble | ok 2025-03-23 19:38:14.864253 | 2025-03-23 19:38:14.865603 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-23 19:38:14.948708 | ubuntu-noble | ok 2025-03-23 19:38:15.035171 | 2025-03-23 19:38:15.035794 | TASK [emit-job-header : Print job information] 2025-03-23 19:38:15.110571 | # Job Information 2025-03-23 19:38:15.110710 | Ansible Version: 2.15.3 2025-03-23 19:38:15.110740 | Job: container-image-python-osism-build 2025-03-23 19:38:15.110808 | Pipeline: check 2025-03-23 19:38:15.110832 | Executor: 7d211f194f6a 2025-03-23 19:38:15.110850 | Triggered by: https://github.com/osism/python-osism/pull/1240 2025-03-23 19:38:15.110876 | Event ID: 4ff1e7a0-081e-11f0-96a1-35b49cb61a2f 2025-03-23 19:38:15.127150 | 2025-03-23 19:38:15.127263 | LOOP [emit-job-header : Print node information] 2025-03-23 19:38:15.323790 | ubuntu-noble | ok: 2025-03-23 19:38:15.325042 | ubuntu-noble | # Node Information 2025-03-23 19:38:15.325369 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-23 19:38:15.325504 | ubuntu-noble | Hostname: ubuntu 2025-03-23 19:38:15.326000 | ubuntu-noble | Username: zuul 2025-03-23 19:38:15.326113 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-23 19:38:15.326397 | ubuntu-noble | Provider: regiocloud-a 2025-03-23 19:38:15.326443 | ubuntu-noble | Label: ubuntu-noble 2025-03-23 19:38:15.326762 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-23 19:38:15.327203 | ubuntu-noble | Interface IP: 81.163.193.225 2025-03-23 19:38:15.399362 | 2025-03-23 19:38:15.400126 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-23 19:38:16.308337 | ubuntu-noble -> localhost | changed 2025-03-23 19:38:16.327004 | 2025-03-23 19:38:16.327424 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-23 19:38:17.665789 | ubuntu-noble -> localhost | changed 2025-03-23 19:38:17.681360 | 2025-03-23 19:38:17.681456 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-23 19:38:18.056810 | ubuntu-noble -> localhost | ok 2025-03-23 19:38:18.062785 | 2025-03-23 19:38:18.062874 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-23 19:38:18.101220 | ubuntu-noble | ok 2025-03-23 19:38:18.132018 | ubuntu-noble | included: /var/lib/zuul/builds/779f25b66b51496fad5d94cf9c444c33/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-23 19:38:18.145529 | 2025-03-23 19:38:18.145620 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-23 19:38:19.127998 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-23 19:38:19.128207 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/779f25b66b51496fad5d94cf9c444c33/work/779f25b66b51496fad5d94cf9c444c33_id_rsa 2025-03-23 19:38:19.128249 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/779f25b66b51496fad5d94cf9c444c33/work/779f25b66b51496fad5d94cf9c444c33_id_rsa.pub 2025-03-23 19:38:19.128279 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-23 19:38:19.128307 | ubuntu-noble -> localhost | SHA256:2RwtFTVizJYXl4+CkRocXoc5oqtBn24xMIkd9VCNjLM zuul-build-sshkey 2025-03-23 19:38:19.128333 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-23 19:38:19.128358 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-23 19:38:19.128397 | ubuntu-noble -> localhost | | .o=o+.**++.o| 2025-03-23 19:38:19.128425 | ubuntu-noble -> localhost | | . o+*.B==..+ | 2025-03-23 19:38:19.128448 | ubuntu-noble -> localhost | | o o +o+o=.. ..| 2025-03-23 19:38:19.128481 | ubuntu-noble -> localhost | | . * E .+.o. . .| 2025-03-23 19:38:19.128506 | ubuntu-noble -> localhost | | . + oS o . | 2025-03-23 19:38:19.128549 | ubuntu-noble -> localhost | | . * | 2025-03-23 19:38:19.128584 | ubuntu-noble -> localhost | | + o | 2025-03-23 19:38:19.128610 | ubuntu-noble -> localhost | | . o | 2025-03-23 19:38:19.128636 | ubuntu-noble -> localhost | | . | 2025-03-23 19:38:19.128661 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-23 19:38:19.128718 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.373064 2025-03-23 19:38:19.137741 | 2025-03-23 19:38:19.137837 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-23 19:38:19.158005 | ubuntu-noble | ok 2025-03-23 19:38:19.168934 | ubuntu-noble | included: /var/lib/zuul/builds/779f25b66b51496fad5d94cf9c444c33/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-23 19:38:19.179335 | 2025-03-23 19:38:19.179610 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-23 19:38:19.215170 | ubuntu-noble | skipping: Conditional result was False 2025-03-23 19:38:19.236497 | 2025-03-23 19:38:19.236651 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-23 19:38:20.029775 | ubuntu-noble | changed 2025-03-23 19:38:20.036948 | 2025-03-23 19:38:20.037033 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-23 19:38:20.363775 | ubuntu-noble | ok 2025-03-23 19:38:20.373864 | 2025-03-23 19:38:20.373952 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-23 19:38:21.142652 | ubuntu-noble | changed 2025-03-23 19:38:21.149860 | 2025-03-23 19:38:21.149950 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-23 19:38:21.920528 | ubuntu-noble | changed 2025-03-23 19:38:21.939100 | 2025-03-23 19:38:21.939334 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-23 19:38:21.971961 | ubuntu-noble | skipping: Conditional result was False 2025-03-23 19:38:21.984922 | 2025-03-23 19:38:21.985028 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-23 19:38:22.459777 | ubuntu-noble -> localhost | changed 2025-03-23 19:38:22.490389 | 2025-03-23 19:38:22.490503 | TASK [add-build-sshkey : Add back temp key] 2025-03-23 19:38:22.841039 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/779f25b66b51496fad5d94cf9c444c33/work/779f25b66b51496fad5d94cf9c444c33_id_rsa (zuul-build-sshkey) 2025-03-23 19:38:22.841513 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014998 2025-03-23 19:38:22.855974 | 2025-03-23 19:38:22.856096 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-23 19:38:23.266218 | ubuntu-noble | ok 2025-03-23 19:38:23.272827 | 2025-03-23 19:38:23.272922 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-23 19:38:23.306668 | ubuntu-noble | skipping: Conditional result was False 2025-03-23 19:38:23.361741 | 2025-03-23 19:38:23.361834 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-23 19:38:23.809687 | ubuntu-noble | ok 2025-03-23 19:38:23.824902 | 2025-03-23 19:38:23.825005 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-23 19:38:23.854682 | ubuntu-noble | ok 2025-03-23 19:38:23.861207 | 2025-03-23 19:38:23.861299 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-23 19:38:24.182096 | ubuntu-noble -> localhost | ok 2025-03-23 19:38:24.189308 | 2025-03-23 19:38:24.189400 | TASK [validate-host : Collect information about the host] 2025-03-23 19:38:25.543010 | ubuntu-noble | ok 2025-03-23 19:38:25.555211 | 2025-03-23 19:38:25.555309 | TASK [validate-host : Sanitize hostname] 2025-03-23 19:38:25.614480 | ubuntu-noble | ok 2025-03-23 19:38:25.620512 | 2025-03-23 19:38:25.620611 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-23 19:38:26.288245 | ubuntu-noble -> localhost | changed 2025-03-23 19:38:26.297993 | 2025-03-23 19:38:26.298110 | TASK [validate-host : Collect information about zuul worker] 2025-03-23 19:38:26.798891 | ubuntu-noble | ok 2025-03-23 19:38:26.806022 | 2025-03-23 19:38:26.806138 | TASK [validate-host : Write out all zuul information for each host] 2025-03-23 19:38:27.755930 | ubuntu-noble -> localhost | changed 2025-03-23 19:38:27.773254 | 2025-03-23 19:38:27.773384 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-23 19:38:28.128095 | ubuntu-noble | ok 2025-03-23 19:38:28.145558 | 2025-03-23 19:38:28.145660 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-23 19:38:29.215976 | ubuntu-noble | changed: 2025-03-23 19:38:29.216172 | ubuntu-noble | cd+++++++++ src/ 2025-03-23 19:38:29.216219 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-23 19:38:29.216252 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-23 19:38:29.216279 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-03-23 19:38:29.216304 | ubuntu-noble | Containerfile 2025-03-23 19:38:29.216497 | ubuntu-noble | [builder 4/4] RUN <>> RUN <>> set -e 2025-03-23 19:40:31.227249 | ubuntu-noble | 11 | >>> set -x 2025-03-23 19:40:31.227254 | ubuntu-noble | 12 | >>> 2025-03-23 19:40:31.227259 | ubuntu-noble | 13 | >>> # install required packages 2025-03-23 19:40:31.227267 | ubuntu-noble | 14 | >>> apt-get update 2025-03-23 19:40:31.227273 | ubuntu-noble | 15 | >>> apt-get install -y --no-install-recommends \ 2025-03-23 19:40:31.227279 | ubuntu-noble | 16 | >>> build-essential \ 2025-03-23 19:40:31.227284 | ubuntu-noble | 17 | >>> gcc \ 2025-03-23 19:40:31.227289 | ubuntu-noble | 18 | >>> git \ 2025-03-23 19:40:31.227294 | ubuntu-noble | 19 | >>> libldap2-dev \ 2025-03-23 19:40:31.227299 | ubuntu-noble | 20 | >>> libsasl2-dev 2025-03-23 19:40:31.227304 | ubuntu-noble | 21 | >>> 2025-03-23 19:40:31.227309 | ubuntu-noble | 22 | >>> # install python packages 2025-03-23 19:40:31.227315 | ubuntu-noble | 23 | >>> mkdir /wheels 2025-03-23 19:40:31.227319 | ubuntu-noble | 24 | >>> uv pip --no-cache-dir install -U 'pip==25.0.1' 2025-03-23 19:40:31.227325 | ubuntu-noble | 25 | >>> uv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.txt 2025-03-23 19:40:31.227331 | ubuntu-noble | 26 | >>> uv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.ansible.txt 2025-03-23 19:40:31.227337 | ubuntu-noble | 27 | >>> uv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.openstack-image-manager.txt 2025-03-23 19:40:31.227343 | ubuntu-noble | 28 | >>> uv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.openstack-flavor-manager.txt 2025-03-23 19:40:31.227348 | ubuntu-noble | 29 | >>> uv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.netbox-manager.txt 2025-03-23 19:40:31.227353 | ubuntu-noble | 30 | >>> 2025-03-23 19:40:31.227359 | ubuntu-noble | 31 | >>> # install openstack-project-manager 2025-03-23 19:40:31.227378 | ubuntu-noble | 32 | >>> git clone --depth 1 https://github.com/osism/openstack-project-manager.git /openstack-project-manager 2025-03-23 19:40:31.227426 | ubuntu-noble | 33 | >>> uv wheel --no-cache-dir --wheel-dir=/wheels -r /openstack-project-manager/requirements.txt 2025-03-23 19:40:31.227432 | ubuntu-noble | 34 | >>> rm -rf /openstack-project-manager/.git 2025-03-23 19:40:31.227437 | ubuntu-noble | 35 | >>> 2025-03-23 19:40:31.227442 | ubuntu-noble | 36 | >>> # install openstack-simple-stress 2025-03-23 19:40:31.227448 | ubuntu-noble | 37 | >>> git clone --depth 1 https://github.com/osism/openstack-simple-stress.git /openstack-simple-stress 2025-03-23 19:40:31.227453 | ubuntu-noble | 38 | >>> uv wheel --no-cache-dir --wheel-dir=/wheels -r /openstack-simple-stress/requirements.txt 2025-03-23 19:40:31.227458 | ubuntu-noble | 39 | >>> rm -rf /osism/openstack-simple-stress/.git 2025-03-23 19:40:31.227464 | ubuntu-noble | 40 | >>> EOF 2025-03-23 19:40:31.227469 | ubuntu-noble | 41 | 2025-03-23 19:40:31.227475 | ubuntu-noble | -------------------- 2025-03-23 19:40:31.227481 | ubuntu-noble | ERROR: failed to solve: process "/bin/bash -o pipefail -c set -e\nset -x\n\n# install required packages\napt-get update\napt-get install -y --no-install-recommends \\\n build-essential \\\n gcc \\\n git \\\n libldap2-dev \\\n libsasl2-dev\n\n# install python packages\nmkdir /wheels\nuv pip --no-cache-dir install -U 'pip==25.0.1'\nuv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.txt\nuv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.ansible.txt\nuv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.openstack-image-manager.txt\nuv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.openstack-flavor-manager.txt\nuv wheel --no-cache-dir --wheel-dir=/wheels -r /src/requirements.netbox-manager.txt\n\n# install openstack-project-manager\ngit clone --depth 1 https://github.com/osism/openstack-project-manager.git /openstack-project-manager\nuv wheel --no-cache-dir --wheel-dir=/wheels -r /openstack-project-manager/requirements.txt\nrm -rf /openstack-project-manager/.git\n\n# install openstack-simple-stress\ngit clone --depth 1 https://github.com/osism/openstack-simple-stress.git /openstack-simple-stress\nuv wheel --no-cache-dir --wheel-dir=/wheels -r /openstack-simple-stress/requirements.txt\nrm -rf /osism/openstack-simple-stress/.git\n" did not complete successfully: exit code: 2 2025-03-23 19:40:31.302154 | ubuntu-noble | ERROR 2025-03-23 19:40:31.302411 | ubuntu-noble | { 2025-03-23 19:40:31.302473 | ubuntu-noble | "delta": "0:00:36.899288", 2025-03-23 19:40:31.302515 | ubuntu-noble | "end": "2025-03-23 19:40:31.229189", 2025-03-23 19:40:31.302572 | ubuntu-noble | "msg": "non-zero return code", 2025-03-23 19:40:31.302608 | ubuntu-noble | "rc": 1, 2025-03-23 19:40:31.302643 | ubuntu-noble | "start": "2025-03-23 19:39:54.329901" 2025-03-23 19:40:31.302681 | ubuntu-noble | } failure 2025-03-23 19:40:31.315213 | 2025-03-23 19:40:31.315380 | PLAY RECAP 2025-03-23 19:40:31.315448 | ubuntu-noble | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0 2025-03-23 19:40:31.315481 | 2025-03-23 19:40:31.423220 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/python-osism/playbooks/build.yml@main] 2025-03-23 19:40:31.426354 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-23 19:40:32.146319 | 2025-03-23 19:40:32.146472 | PLAY [Base post] 2025-03-23 19:40:32.171467 | 2025-03-23 19:40:32.171632 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-03-23 19:40:33.060695 | ubuntu-noble | changed 2025-03-23 19:40:33.094331 | 2025-03-23 19:40:33.094461 | PLAY RECAP 2025-03-23 19:40:33.094549 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-03-23 19:40:33.094615 | 2025-03-23 19:40:33.212813 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-03-23 19:40:33.218624 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-03-23 19:40:34.096348 | 2025-03-23 19:40:34.096570 | PLAY [Base post-logs] 2025-03-23 19:40:34.112691 | 2025-03-23 19:40:34.112837 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-03-23 19:40:34.721388 | localhost | changed 2025-03-23 19:40:34.726286 | 2025-03-23 19:40:34.726441 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-03-23 19:40:34.765522 | localhost | ok 2025-03-23 19:40:34.771637 | 2025-03-23 19:40:34.771744 | TASK [Set zuul-log-path fact] 2025-03-23 19:40:34.788374 | localhost | ok 2025-03-23 19:40:34.798676 | 2025-03-23 19:40:34.798787 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-23 19:40:34.825484 | localhost | ok 2025-03-23 19:40:34.831253 | 2025-03-23 19:40:34.831357 | TASK [upload-logs : Create log directories] 2025-03-23 19:40:35.393895 | localhost | changed 2025-03-23 19:40:35.398351 | 2025-03-23 19:40:35.398461 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-03-23 19:40:35.905839 | localhost -> localhost | ok: Runtime: 0:00:00.009228 2025-03-23 19:40:35.911623 | 2025-03-23 19:40:35.911751 | TASK [upload-logs : Upload logs to log server] 2025-03-23 19:40:36.509119 | localhost | Output suppressed because no_log was given 2025-03-23 19:40:36.513205 | 2025-03-23 19:40:36.513380 | LOOP [upload-logs : Compress console log and json output] 2025-03-23 19:40:36.579796 | localhost | skipping: Conditional result was False 2025-03-23 19:40:36.598316 | localhost | skipping: Conditional result was False 2025-03-23 19:40:36.616295 | 2025-03-23 19:40:36.616568 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-23 19:40:36.677003 | localhost | skipping: Conditional result was False 2025-03-23 19:40:36.677265 | 2025-03-23 19:40:36.698051 | localhost | skipping: Conditional result was False 2025-03-23 19:40:36.707372 | 2025-03-23 19:40:36.707474 | LOOP [upload-logs : Upload console log and json output]