2025-08-29 06:50:40.442881 | Job console starting 2025-08-29 06:50:40.468948 | Updating git repos 2025-08-29 06:50:40.526934 | Cloning repos into workspace 2025-08-29 06:50:40.649559 | Restoring repo states 2025-08-29 06:50:40.708087 | Merging changes 2025-08-29 06:50:41.570226 | Checking out repos 2025-08-29 06:50:41.653791 | Preparing playbooks 2025-08-29 06:50:43.213676 | Running Ansible setup 2025-08-29 06:52:07.908843 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-29 06:52:08.634443 | 2025-08-29 06:52:08.634616 | PLAY [Base pre] 2025-08-29 06:52:08.650373 | 2025-08-29 06:52:08.650527 | TASK [Setup log path fact] 2025-08-29 06:52:08.679807 | debian-bookworm | ok 2025-08-29 06:52:08.694490 | 2025-08-29 06:52:08.694612 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-29 06:52:08.741752 | debian-bookworm | ok 2025-08-29 06:52:08.755290 | 2025-08-29 06:52:08.755405 | TASK [emit-job-header : Print job information] 2025-08-29 06:52:08.800112 | # Job Information 2025-08-29 06:52:08.800347 | Ansible Version: 2.16.14 2025-08-29 06:52:08.800407 | Job: yamllint 2025-08-29 06:52:08.800464 | Pipeline: check 2025-08-29 06:52:08.800524 | Executor: 521e9411259a 2025-08-29 06:52:08.800564 | Triggered by: https://github.com/osism/container-images/pull/817 2025-08-29 06:52:08.800603 | Event ID: 73d5cda0-84a4-11f0-8d7a-255b49e9f0d5 2025-08-29 06:52:08.808260 | 2025-08-29 06:52:08.808395 | LOOP [emit-job-header : Print node information] 2025-08-29 06:52:08.909392 | debian-bookworm | ok: 2025-08-29 06:52:08.909588 | debian-bookworm | # Node Information 2025-08-29 06:52:08.909623 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-29 06:52:08.909647 | debian-bookworm | Hostname: debian 2025-08-29 06:52:08.909669 | debian-bookworm | Username: zuul 2025-08-29 06:52:08.909690 | debian-bookworm | Distro: Debian 12.11 2025-08-29 06:52:08.909715 | debian-bookworm | Provider: regiocloud-a 2025-08-29 06:52:08.909736 | debian-bookworm | Region: 2025-08-29 06:52:08.909757 | debian-bookworm | Label: debian-bookworm 2025-08-29 06:52:08.909776 | debian-bookworm | Product Name: OpenStack Nova 2025-08-29 06:52:08.909795 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe81:b43d 2025-08-29 06:52:08.935908 | 2025-08-29 06:52:08.936067 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-29 06:52:09.427692 | debian-bookworm -> localhost | changed 2025-08-29 06:52:09.443325 | 2025-08-29 06:52:09.443514 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-29 06:52:10.483224 | debian-bookworm -> localhost | changed 2025-08-29 06:52:10.501970 | 2025-08-29 06:52:10.502098 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-29 06:52:10.799852 | debian-bookworm -> localhost | ok 2025-08-29 06:52:10.814495 | 2025-08-29 06:52:10.814696 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-29 06:52:10.849538 | debian-bookworm | ok 2025-08-29 06:52:10.869360 | debian-bookworm | included: /var/lib/zuul/builds/ef5e1738796d48e9a365ec5e3dedd238/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-29 06:52:10.875462 | 2025-08-29 06:52:10.875613 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-29 06:52:11.740547 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-29 06:52:11.741040 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ef5e1738796d48e9a365ec5e3dedd238/work/ef5e1738796d48e9a365ec5e3dedd238_id_rsa 2025-08-29 06:52:11.741152 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ef5e1738796d48e9a365ec5e3dedd238/work/ef5e1738796d48e9a365ec5e3dedd238_id_rsa.pub 2025-08-29 06:52:11.741228 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-29 06:52:11.741296 | debian-bookworm -> localhost | SHA256:bjLAtfwSIBnFNavHBtB1/73/xGcnbEzM11ld1LKskC0 zuul-build-sshkey 2025-08-29 06:52:11.741359 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-29 06:52:11.741447 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-29 06:52:11.741534 | debian-bookworm -> localhost | | o+.o+ . .+| 2025-08-29 06:52:11.741597 | debian-bookworm -> localhost | | +o + . . +| 2025-08-29 06:52:11.741655 | debian-bookworm -> localhost | | o o o .o . oo| 2025-08-29 06:52:11.741711 | debian-bookworm -> localhost | | o B . E..+o +| 2025-08-29 06:52:11.741766 | debian-bookworm -> localhost | | + B S o..=.o| 2025-08-29 06:52:11.741844 | debian-bookworm -> localhost | | + + .+ + | 2025-08-29 06:52:11.741901 | debian-bookworm -> localhost | | + + * *| 2025-08-29 06:52:11.741956 | debian-bookworm -> localhost | | = . =o| 2025-08-29 06:52:11.742015 | debian-bookworm -> localhost | | +| 2025-08-29 06:52:11.742073 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-29 06:52:11.742213 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.364718 2025-08-29 06:52:11.756076 | 2025-08-29 06:52:11.756220 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-29 06:52:11.792318 | debian-bookworm | ok 2025-08-29 06:52:11.805551 | debian-bookworm | included: /var/lib/zuul/builds/ef5e1738796d48e9a365ec5e3dedd238/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-29 06:52:11.815170 | 2025-08-29 06:52:11.815272 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-29 06:52:11.839098 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:52:11.846936 | 2025-08-29 06:52:11.847060 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-29 06:52:12.511973 | debian-bookworm | changed 2025-08-29 06:52:12.519878 | 2025-08-29 06:52:12.520007 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-29 06:52:12.789870 | debian-bookworm | ok 2025-08-29 06:52:12.798188 | 2025-08-29 06:52:12.798328 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-29 06:52:13.493623 | debian-bookworm | changed 2025-08-29 06:52:13.505088 | 2025-08-29 06:52:13.505225 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-29 06:52:14.236688 | debian-bookworm | changed 2025-08-29 06:52:14.245044 | 2025-08-29 06:52:14.245173 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-29 06:52:14.270138 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:52:14.283183 | 2025-08-29 06:52:14.283341 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-29 06:52:14.744563 | debian-bookworm -> localhost | changed 2025-08-29 06:52:14.765870 | 2025-08-29 06:52:14.766026 | TASK [add-build-sshkey : Add back temp key] 2025-08-29 06:52:15.206329 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ef5e1738796d48e9a365ec5e3dedd238/work/ef5e1738796d48e9a365ec5e3dedd238_id_rsa (zuul-build-sshkey) 2025-08-29 06:52:15.206931 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018407 2025-08-29 06:52:15.226156 | 2025-08-29 06:52:15.226287 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-29 06:52:15.635597 | debian-bookworm | ok 2025-08-29 06:52:15.644737 | 2025-08-29 06:52:15.644902 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-29 06:52:15.680643 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:52:15.697116 | 2025-08-29 06:52:15.697230 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-29 06:52:16.153179 | debian-bookworm | ok 2025-08-29 06:52:16.175004 | 2025-08-29 06:52:16.175240 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-29 06:52:16.221834 | debian-bookworm | ok 2025-08-29 06:52:16.229863 | 2025-08-29 06:52:16.229993 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-29 06:52:16.548990 | debian-bookworm -> localhost | ok 2025-08-29 06:52:16.563325 | 2025-08-29 06:52:16.563518 | TASK [validate-host : Collect information about the host] 2025-08-29 06:52:57.765369 | debian-bookworm | ok 2025-08-29 06:52:57.782816 | 2025-08-29 06:52:57.782996 | TASK [validate-host : Sanitize hostname] 2025-08-29 06:52:57.891554 | debian-bookworm | ok 2025-08-29 06:52:57.932465 | 2025-08-29 06:52:57.932611 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-29 06:52:58.492661 | debian-bookworm -> localhost | changed 2025-08-29 06:52:58.507589 | 2025-08-29 06:52:58.507772 | TASK [validate-host : Collect information about zuul worker] 2025-08-29 06:52:58.939679 | debian-bookworm | ok 2025-08-29 06:52:58.947596 | 2025-08-29 06:52:58.947746 | TASK [validate-host : Write out all zuul information for each host] 2025-08-29 06:52:59.490582 | debian-bookworm -> localhost | changed 2025-08-29 06:52:59.510993 | 2025-08-29 06:52:59.511171 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-29 06:52:59.791095 | debian-bookworm | ok 2025-08-29 06:52:59.800580 | 2025-08-29 06:52:59.800728 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-29 06:53:00.700926 | debian-bookworm | changed: 2025-08-29 06:53:00.701146 | debian-bookworm | cd+++++++++ src/ 2025-08-29 06:53:00.701187 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-29 06:53:00.701217 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-29 06:53:00.701242 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ 2025-08-29 06:53:00.701266 | debian-bookworm | Containerfile 2025-08-29 06:53:00.707354 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ansible-lint/files/ 2025-08-29 06:53:00.707371 | debian-bookworm | Containerfile 2025-08-29 06:53:00.707602 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ara-server/files/ 2025-08-29 06:53:00.707620 | debian-bookworm | Containerfile 2025-08-29 06:53:00.707709 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ceph-daemon/files/ 2025-08-29 06:53:00.707726 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ceph-daemon/files/bin/ 2025-08-29 06:53:00.707744 | debian-bookworm | Containerfile 2025-08-29 06:53:00.708415 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/cephclient/files/ 2025-08-29 06:53:00.708432 | debian-bookworm | Containerfile 2025-08-29 06:53:00.708546 | debian-bookworm | Containerfile 2025-08-29 06:53:00.708639 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/dnsmasq-osism/ 2025-08-29 06:53:00.708657 | debian-bookworm | Containerfile 2025-08-29 06:53:00.708693 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/gnmic/ 2025-08-29 06:53:00.708714 | debian-bookworm | Containerfile 2025-08-29 06:53:00.708749 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/homer/ 2025-08-29 06:53:00.708767 | debian-bookworm | Containerfile 2025-08-29 06:53:00.708803 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/homer/files/ 2025-08-29 06:53:00.708821 | debian-bookworm | Containerfile 2025-08-29 06:53:00.709257 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/lloadd/ 2025-08-29 06:53:00.709275 | debian-bookworm | Containerfile 2025-08-29 06:53:00.709312 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/netbox/ 2025-08-29 06:53:00.709330 | debian-bookworm | Containerfile 2025-08-29 06:53:00.709364 | debian-bookworm | Containerfile 2025-08-29 06:53:00.709468 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/nexus/files/ 2025-08-29 06:53:00.709511 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/nexus/files/scripts/ 2025-08-29 06:53:00.709532 | debian-bookworm | Containerfile 2025-08-29 06:53:00.709715 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/openstackclient/files/ 2025-08-29 06:53:00.709732 | debian-bookworm | Containerfile 2025-08-29 06:53:00.709820 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/prometheus-redfish-exporter/files/ 2025-08-29 06:53:00.709837 | debian-bookworm | Containerfile 2025-08-29 06:53:00.709907 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/rsync/ 2025-08-29 06:53:00.709928 | debian-bookworm | Containerfile 2025-08-29 06:53:00.709963 | debian-bookworm | Containerfile 2025-08-29 06:53:00.710086 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/seed/files/ 2025-08-29 06:53:00.710104 | debian-bookworm | Containerfile 2025-08-29 06:53:00.710279 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/tempest/files/ 2025-08-29 06:53:00.710296 | debian-bookworm | Containerfile 2025-08-29 06:53:00.719572 | 2025-08-29 06:53:00.719654 | PLAY RECAP 2025-08-29 06:53:00.719705 | debian-bookworm | ok: 26 changed: 11 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-08-29 06:53:00.719730 | 2025-08-29 06:53:00.842011 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-29 06:53:00.843353 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/yamllint/run.yaml@main] 2025-08-29 06:53:01.553133 | 2025-08-29 06:53:01.553298 | PLAY [Run yamllint] 2025-08-29 06:53:01.568606 | 2025-08-29 06:53:01.568741 | LOOP [Install python] 2025-08-29 06:53:01.597861 | debian-bookworm | ok: "ensure-python" 2025-08-29 06:53:01.607909 | debian-bookworm | ok: "ensure-pip" 2025-08-29 06:53:01.655013 | 2025-08-29 06:53:01.655155 | TASK [ensure-python : Validate python_version value] 2025-08-29 06:53:01.679114 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:53:01.685241 | 2025-08-29 06:53:01.685349 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2025-08-29 06:53:01.709012 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:53:01.717098 | 2025-08-29 06:53:01.717228 | TASK [ensure-python : Pull in venv package] 2025-08-29 06:53:01.741359 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:53:01.747385 | 2025-08-29 06:53:01.747509 | TASK [ensure-python : Set default RPM package name] 2025-08-29 06:53:01.771145 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:53:01.776640 | 2025-08-29 06:53:01.776749 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9 and Python 3.9] 2025-08-29 06:53:01.810085 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:53:01.817555 | 2025-08-29 06:53:01.817681 | TASK [ensure-python : Install RPM package] 2025-08-29 06:53:01.842528 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:53:01.848357 | 2025-08-29 06:53:01.848468 | TASK [ensure-python : Install python using pyenv] 2025-08-29 06:53:01.863364 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:53:01.869121 | 2025-08-29 06:53:01.869222 | TASK [ensure-python : Activate python using stow] 2025-08-29 06:53:01.892709 | debian-bookworm | skipping: Conditional result was False 2025-08-29 06:53:01.902929 | 2025-08-29 06:53:01.903030 | TASK [ensure-pip : Check if pip is installed] 2025-08-29 06:53:02.434818 | debian-bookworm | ok: Runtime: 0:00:00.007790 2025-08-29 06:53:02.446474 | 2025-08-29 06:53:02.446670 | LOOP [ensure-pip : Install pip from packages] 2025-08-29 06:53:02.493333 | debian-bookworm | ok: "/var/lib/zuul/builds/ef5e1738796d48e9a365ec5e3dedd238/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2025-08-29 06:53:02.493623 | debian-bookworm | ok: All items complete 2025-08-29 06:53:02.493680 | 2025-08-29 06:53:02.514656 | debian-bookworm | included: /var/lib/zuul/builds/ef5e1738796d48e9a365ec5e3dedd238/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2025-08-29 06:53:02.526308 | 2025-08-29 06:53:02.526420 | TASK [ensure-pip : Update package lists] 2025-08-29 06:55:14.859765 | debian-bookworm | ERROR 2025-08-29 06:55:14.860243 | debian-bookworm | { 2025-08-29 06:55:14.860324 | debian-bookworm | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2025-08-29 06:55:14.860375 | debian-bookworm | } failure 2025-08-29 06:55:14.862304 | 2025-08-29 06:55:14.862420 | PLAY RECAP 2025-08-29 06:55:14.862560 | debian-bookworm | ok: 2 changed: 1 unreachable: 0 failed: 1 skipped: 8 rescued: 0 ignored: 0 2025-08-29 06:55:14.862609 | 2025-08-29 06:55:15.016270 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/yamllint/run.yaml@main] 2025-08-29 06:55:15.018224 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-29 06:55:15.736073 | 2025-08-29 06:55:15.736243 | PLAY [Base post] 2025-08-29 06:55:15.749898 | 2025-08-29 06:55:15.750051 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-29 06:55:16.333698 | debian-bookworm | changed 2025-08-29 06:55:16.343006 | 2025-08-29 06:55:16.343137 | PLAY RECAP 2025-08-29 06:55:16.343214 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-29 06:55:16.343288 | 2025-08-29 06:55:16.457958 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-29 06:55:16.458806 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-29 06:55:17.221758 | 2025-08-29 06:55:17.221921 | PLAY [Base post-logs] 2025-08-29 06:55:17.232236 | 2025-08-29 06:55:17.232365 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-29 06:55:17.666252 | localhost | changed 2025-08-29 06:55:17.684288 | 2025-08-29 06:55:17.684452 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-29 06:55:17.722906 | localhost | ok 2025-08-29 06:55:17.729175 | 2025-08-29 06:55:17.729340 | TASK [Set zuul-log-path fact] 2025-08-29 06:55:17.757945 | localhost | ok 2025-08-29 06:55:17.772621 | 2025-08-29 06:55:17.772756 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-29 06:55:17.809324 | localhost | ok 2025-08-29 06:55:17.814196 | 2025-08-29 06:55:17.814340 | TASK [upload-logs : Create log directories] 2025-08-29 06:55:18.319443 | localhost | changed 2025-08-29 06:55:18.323633 | 2025-08-29 06:55:18.323781 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-29 06:55:18.816496 | localhost -> localhost | ok: Runtime: 0:00:00.006786 2025-08-29 06:55:18.825363 | 2025-08-29 06:55:18.825573 | TASK [upload-logs : Upload logs to log server] 2025-08-29 06:55:19.382985 | localhost | Output suppressed because no_log was given 2025-08-29 06:55:19.386666 | 2025-08-29 06:55:19.386894 | LOOP [upload-logs : Compress console log and json output] 2025-08-29 06:55:19.445720 | localhost | skipping: Conditional result was False 2025-08-29 06:55:19.450777 | localhost | skipping: Conditional result was False 2025-08-29 06:55:19.458345 | 2025-08-29 06:55:19.458613 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-29 06:55:19.505298 | localhost | skipping: Conditional result was False 2025-08-29 06:55:19.505937 | 2025-08-29 06:55:19.509493 | localhost | skipping: Conditional result was False 2025-08-29 06:55:19.523005 | 2025-08-29 06:55:19.523259 | LOOP [upload-logs : Upload console log and json output]