2025-08-08 15:49:43.303381 | Job console starting 2025-08-08 15:49:43.324759 | Updating git repos 2025-08-08 15:49:43.373102 | Cloning repos into workspace 2025-08-08 15:49:43.429763 | Restoring repo states 2025-08-08 15:49:43.440753 | Merging changes 2025-08-08 15:49:43.946595 | Checking out repos 2025-08-08 15:49:43.994808 | Preparing playbooks 2025-08-08 15:49:44.589279 | Running Ansible setup 2025-08-08 15:51:09.007847 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-08 15:51:09.750508 | 2025-08-08 15:51:09.750667 | PLAY [Base pre] 2025-08-08 15:51:09.766353 | 2025-08-08 15:51:09.766475 | TASK [Setup log path fact] 2025-08-08 15:51:09.803495 | debian-bookworm | ok 2025-08-08 15:51:09.823025 | 2025-08-08 15:51:09.823149 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-08 15:51:09.865134 | debian-bookworm | ok 2025-08-08 15:51:09.876254 | 2025-08-08 15:51:09.876354 | TASK [emit-job-header : Print job information] 2025-08-08 15:51:09.931826 | # Job Information 2025-08-08 15:51:09.932155 | Ansible Version: 2.16.14 2025-08-08 15:51:09.932230 | Job: flake8 2025-08-08 15:51:09.932298 | Pipeline: check 2025-08-08 15:51:09.932347 | Executor: 521e9411259a 2025-08-08 15:51:09.932392 | Triggered by: https://github.com/osism/container-images/pull/800 2025-08-08 15:51:09.932444 | Event ID: 488d7f70-746f-11f0-8edb-996f10f16c01 2025-08-08 15:51:09.939888 | 2025-08-08 15:51:09.940068 | LOOP [emit-job-header : Print node information] 2025-08-08 15:51:10.048595 | debian-bookworm | ok: 2025-08-08 15:51:10.048867 | debian-bookworm | # Node Information 2025-08-08 15:51:10.048905 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-08 15:51:10.048932 | debian-bookworm | Hostname: debian 2025-08-08 15:51:10.048956 | debian-bookworm | Username: zuul 2025-08-08 15:51:10.048977 | debian-bookworm | Distro: Debian 12.11 2025-08-08 15:51:10.049001 | debian-bookworm | Provider: regiocloud-a 2025-08-08 15:51:10.049065 | debian-bookworm | Region: 2025-08-08 15:51:10.049088 | debian-bookworm | Label: debian-bookworm 2025-08-08 15:51:10.049109 | debian-bookworm | Product Name: OpenStack Nova 2025-08-08 15:51:10.049130 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefd:fed8 2025-08-08 15:51:10.076707 | 2025-08-08 15:51:10.076875 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-08 15:51:10.537893 | debian-bookworm -> localhost | changed 2025-08-08 15:51:10.545314 | 2025-08-08 15:51:10.545431 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-08 15:51:11.614985 | debian-bookworm -> localhost | changed 2025-08-08 15:51:11.625974 | 2025-08-08 15:51:11.626134 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-08 15:51:11.913295 | debian-bookworm -> localhost | ok 2025-08-08 15:51:11.926801 | 2025-08-08 15:51:11.927005 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-08 15:51:11.956155 | debian-bookworm | ok 2025-08-08 15:51:11.973381 | debian-bookworm | included: /var/lib/zuul/builds/f1f8bc47ff2c4b4795bd93b41ecbb900/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-08 15:51:11.979410 | 2025-08-08 15:51:11.979509 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-08 15:51:13.404560 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-08 15:51:13.405223 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f1f8bc47ff2c4b4795bd93b41ecbb900/work/f1f8bc47ff2c4b4795bd93b41ecbb900_id_rsa 2025-08-08 15:51:13.405346 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f1f8bc47ff2c4b4795bd93b41ecbb900/work/f1f8bc47ff2c4b4795bd93b41ecbb900_id_rsa.pub 2025-08-08 15:51:13.405426 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-08 15:51:13.405497 | debian-bookworm -> localhost | SHA256:lYmx93RU6YjVmO5PeZr77kaJzgiMbD56BzPx7unnpg4 zuul-build-sshkey 2025-08-08 15:51:13.405562 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-08 15:51:13.405649 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-08 15:51:13.405713 | debian-bookworm -> localhost | | . =.o| 2025-08-08 15:51:13.405777 | debian-bookworm -> localhost | | + o = o | 2025-08-08 15:51:13.405837 | debian-bookworm -> localhost | | o = = + | 2025-08-08 15:51:13.405894 | debian-bookworm -> localhost | | . o + + . | 2025-08-08 15:51:13.405954 | debian-bookworm -> localhost | | . S o . o| 2025-08-08 15:51:13.406066 | debian-bookworm -> localhost | | B + o +o| 2025-08-08 15:51:13.406138 | debian-bookworm -> localhost | | oE= . + o+.| 2025-08-08 15:51:13.406196 | debian-bookworm -> localhost | | +.o.+ oo..| 2025-08-08 15:51:13.406257 | debian-bookworm -> localhost | | .o **=. .*+| 2025-08-08 15:51:13.406318 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-08 15:51:13.406470 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.911728 2025-08-08 15:51:13.419932 | 2025-08-08 15:51:13.420102 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-08 15:51:13.456096 | debian-bookworm | ok 2025-08-08 15:51:13.470357 | debian-bookworm | included: /var/lib/zuul/builds/f1f8bc47ff2c4b4795bd93b41ecbb900/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-08 15:51:13.480776 | 2025-08-08 15:51:13.480871 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-08 15:51:13.504243 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:51:13.512489 | 2025-08-08 15:51:13.512616 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-08 15:51:14.176359 | debian-bookworm | changed 2025-08-08 15:51:14.183988 | 2025-08-08 15:51:14.184150 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-08 15:51:14.453663 | debian-bookworm | ok 2025-08-08 15:51:14.462518 | 2025-08-08 15:51:14.462652 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-08 15:51:15.116686 | debian-bookworm | changed 2025-08-08 15:51:15.128172 | 2025-08-08 15:51:15.128314 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-08 15:51:15.802665 | debian-bookworm | changed 2025-08-08 15:51:15.810813 | 2025-08-08 15:51:15.810974 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-08 15:51:15.836018 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:51:15.844748 | 2025-08-08 15:51:15.844886 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-08 15:51:16.284465 | debian-bookworm -> localhost | changed 2025-08-08 15:51:16.301467 | 2025-08-08 15:51:16.301633 | TASK [add-build-sshkey : Add back temp key] 2025-08-08 15:51:16.672143 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f1f8bc47ff2c4b4795bd93b41ecbb900/work/f1f8bc47ff2c4b4795bd93b41ecbb900_id_rsa (zuul-build-sshkey) 2025-08-08 15:51:16.672696 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019498 2025-08-08 15:51:16.687796 | 2025-08-08 15:51:16.687947 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-08 15:51:17.099895 | debian-bookworm | ok 2025-08-08 15:51:17.107567 | 2025-08-08 15:51:17.107713 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-08 15:51:17.142695 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:51:17.163586 | 2025-08-08 15:51:17.163743 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-08 15:51:17.596989 | debian-bookworm | ok 2025-08-08 15:51:17.614090 | 2025-08-08 15:51:17.614231 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-08 15:51:17.658529 | debian-bookworm | ok 2025-08-08 15:51:17.665973 | 2025-08-08 15:51:17.666115 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-08 15:51:17.964000 | debian-bookworm -> localhost | ok 2025-08-08 15:51:17.977097 | 2025-08-08 15:51:17.977242 | TASK [validate-host : Collect information about the host] 2025-08-08 15:51:59.107198 | debian-bookworm | ok 2025-08-08 15:51:59.124374 | 2025-08-08 15:51:59.124509 | TASK [validate-host : Sanitize hostname] 2025-08-08 15:51:59.228228 | debian-bookworm | ok 2025-08-08 15:51:59.264568 | 2025-08-08 15:51:59.264720 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-08 15:51:59.849397 | debian-bookworm -> localhost | changed 2025-08-08 15:51:59.862588 | 2025-08-08 15:51:59.862735 | TASK [validate-host : Collect information about zuul worker] 2025-08-08 15:52:00.274465 | debian-bookworm | ok 2025-08-08 15:52:00.282209 | 2025-08-08 15:52:00.282358 | TASK [validate-host : Write out all zuul information for each host] 2025-08-08 15:52:00.857688 | debian-bookworm -> localhost | changed 2025-08-08 15:52:00.877213 | 2025-08-08 15:52:00.877359 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-08 15:52:01.145086 | debian-bookworm | ok 2025-08-08 15:52:01.153401 | 2025-08-08 15:52:01.153589 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-08 15:52:02.031459 | debian-bookworm | changed: 2025-08-08 15:52:02.031746 | debian-bookworm | cd+++++++++ src/ 2025-08-08 15:52:02.031803 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-08 15:52:02.031844 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-08 15:52:02.031880 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ 2025-08-08 15:52:02.031913 | debian-bookworm | Containerfile 2025-08-08 15:52:02.041103 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ansible-lint/files/ 2025-08-08 15:52:02.041128 | debian-bookworm | Containerfile 2025-08-08 15:52:02.041377 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ara-server/files/ 2025-08-08 15:52:02.041398 | debian-bookworm | Containerfile 2025-08-08 15:52:02.041501 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ceph-daemon/files/ 2025-08-08 15:52:02.041521 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ceph-daemon/files/bin/ 2025-08-08 15:52:02.041543 | debian-bookworm | Containerfile 2025-08-08 15:52:02.042362 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/cephclient/files/ 2025-08-08 15:52:02.042384 | debian-bookworm | Containerfile 2025-08-08 15:52:02.042472 | debian-bookworm | Containerfile 2025-08-08 15:52:02.042580 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/dnsmasq-osism/ 2025-08-08 15:52:02.042602 | debian-bookworm | Containerfile 2025-08-08 15:52:02.042644 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/gnmic/ 2025-08-08 15:52:02.042665 | debian-bookworm | Containerfile 2025-08-08 15:52:02.042706 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/homer/ 2025-08-08 15:52:02.042727 | debian-bookworm | Containerfile 2025-08-08 15:52:02.042768 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/homer/files/ 2025-08-08 15:52:02.042790 | debian-bookworm | Containerfile 2025-08-08 15:52:02.043372 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/lloadd/ 2025-08-08 15:52:02.043392 | debian-bookworm | Containerfile 2025-08-08 15:52:02.043433 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/netbox/ 2025-08-08 15:52:02.043454 | debian-bookworm | Containerfile 2025-08-08 15:52:02.043496 | debian-bookworm | Containerfile 2025-08-08 15:52:02.043616 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/nexus/files/ 2025-08-08 15:52:02.043634 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/nexus/files/scripts/ 2025-08-08 15:52:02.043653 | debian-bookworm | Containerfile 2025-08-08 15:52:02.043845 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/openstackclient/files/ 2025-08-08 15:52:02.043864 | debian-bookworm | Containerfile 2025-08-08 15:52:02.043963 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/prometheus-redfish-exporter/files/ 2025-08-08 15:52:02.043983 | debian-bookworm | Containerfile 2025-08-08 15:52:02.044074 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/rsync/ 2025-08-08 15:52:02.044093 | debian-bookworm | Containerfile 2025-08-08 15:52:02.044131 | debian-bookworm | Containerfile 2025-08-08 15:52:02.044263 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/seed/files/ 2025-08-08 15:52:02.044281 | debian-bookworm | Containerfile 2025-08-08 15:52:02.044469 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/tempest/files/ 2025-08-08 15:52:02.044487 | debian-bookworm | Containerfile 2025-08-08 15:52:02.055721 | 2025-08-08 15:52:02.055809 | PLAY RECAP 2025-08-08 15:52:02.055861 | debian-bookworm | ok: 26 changed: 11 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-08-08 15:52:02.055887 | 2025-08-08 15:52:02.187351 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-08 15:52:02.189307 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/flake8/run.yaml@main] 2025-08-08 15:52:02.891679 | 2025-08-08 15:52:02.891826 | PLAY [Run flake8] 2025-08-08 15:52:02.906631 | 2025-08-08 15:52:02.906740 | LOOP [Install python] 2025-08-08 15:52:02.940695 | debian-bookworm | ok: "ensure-python" 2025-08-08 15:52:02.947974 | debian-bookworm | ok: "ensure-pip" 2025-08-08 15:52:02.994278 | 2025-08-08 15:52:02.994402 | TASK [ensure-python : Validate python_version value] 2025-08-08 15:52:03.028327 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:52:03.034385 | 2025-08-08 15:52:03.034485 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2025-08-08 15:52:03.058188 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:52:03.063691 | 2025-08-08 15:52:03.063797 | TASK [ensure-python : Pull in venv package] 2025-08-08 15:52:03.087076 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:52:03.092876 | 2025-08-08 15:52:03.092979 | TASK [ensure-python : Set default RPM package name] 2025-08-08 15:52:03.116324 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:52:03.121780 | 2025-08-08 15:52:03.121884 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9 and Python 3.9] 2025-08-08 15:52:03.155223 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:52:03.162357 | 2025-08-08 15:52:03.162465 | TASK [ensure-python : Install RPM package] 2025-08-08 15:52:03.186095 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:52:03.191724 | 2025-08-08 15:52:03.191824 | TASK [ensure-python : Install python using pyenv] 2025-08-08 15:52:03.215169 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:52:03.220742 | 2025-08-08 15:52:03.220838 | TASK [ensure-python : Activate python using stow] 2025-08-08 15:52:03.254276 | debian-bookworm | skipping: Conditional result was False 2025-08-08 15:52:03.264599 | 2025-08-08 15:52:03.264709 | TASK [ensure-pip : Check if pip is installed] 2025-08-08 15:52:03.797709 | debian-bookworm | ok: Runtime: 0:00:00.007386 2025-08-08 15:52:03.809720 | 2025-08-08 15:52:03.809874 | LOOP [ensure-pip : Install pip from packages] 2025-08-08 15:52:03.854572 | debian-bookworm | ok: "/var/lib/zuul/builds/f1f8bc47ff2c4b4795bd93b41ecbb900/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2025-08-08 15:52:03.854886 | debian-bookworm | ok: All items complete 2025-08-08 15:52:03.854946 | 2025-08-08 15:52:03.877349 | debian-bookworm | included: /var/lib/zuul/builds/f1f8bc47ff2c4b4795bd93b41ecbb900/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2025-08-08 15:52:03.889314 | 2025-08-08 15:52:03.889427 | TASK [ensure-pip : Update package lists] 2025-08-08 15:54:16.257377 | debian-bookworm | ERROR 2025-08-08 15:54:16.257770 | debian-bookworm | { 2025-08-08 15:54:16.257833 | debian-bookworm | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2025-08-08 15:54:16.257873 | debian-bookworm | } failure 2025-08-08 15:54:16.263485 | 2025-08-08 15:54:16.263602 | PLAY RECAP 2025-08-08 15:54:16.263672 | debian-bookworm | ok: 2 changed: 1 unreachable: 0 failed: 1 skipped: 8 rescued: 0 ignored: 0 2025-08-08 15:54:16.263705 | 2025-08-08 15:54:16.402586 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/flake8/run.yaml@main] 2025-08-08 15:54:16.404901 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-08 15:54:17.128114 | 2025-08-08 15:54:17.128287 | PLAY [Base post] 2025-08-08 15:54:17.141911 | 2025-08-08 15:54:17.142115 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-08 15:54:17.706151 | debian-bookworm | changed 2025-08-08 15:54:17.715746 | 2025-08-08 15:54:17.715869 | PLAY RECAP 2025-08-08 15:54:17.715960 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-08 15:54:17.716040 | 2025-08-08 15:54:17.830793 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-08 15:54:17.835359 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-08 15:54:18.599625 | 2025-08-08 15:54:18.599791 | PLAY [Base post-logs] 2025-08-08 15:54:18.610074 | 2025-08-08 15:54:18.610202 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-08 15:54:19.061377 | localhost | changed 2025-08-08 15:54:19.071396 | 2025-08-08 15:54:19.071545 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-08 15:54:19.107424 | localhost | ok 2025-08-08 15:54:19.111607 | 2025-08-08 15:54:19.111726 | TASK [Set zuul-log-path fact] 2025-08-08 15:54:19.128713 | localhost | ok 2025-08-08 15:54:19.138195 | 2025-08-08 15:54:19.138308 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-08 15:54:19.163687 | localhost | ok 2025-08-08 15:54:19.167065 | 2025-08-08 15:54:19.167172 | TASK [upload-logs : Create log directories] 2025-08-08 15:54:19.643361 | localhost | changed 2025-08-08 15:54:19.648837 | 2025-08-08 15:54:19.649015 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-08 15:54:20.140617 | localhost -> localhost | ok: Runtime: 0:00:00.006781 2025-08-08 15:54:20.151566 | 2025-08-08 15:54:20.151764 | TASK [upload-logs : Upload logs to log server] 2025-08-08 15:54:20.694937 | localhost | Output suppressed because no_log was given 2025-08-08 15:54:20.696828 | 2025-08-08 15:54:20.696936 | LOOP [upload-logs : Compress console log and json output] 2025-08-08 15:54:20.741636 | localhost | skipping: Conditional result was False 2025-08-08 15:54:20.749387 | localhost | skipping: Conditional result was False 2025-08-08 15:54:20.756680 | 2025-08-08 15:54:20.756896 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-08 15:54:20.812847 | localhost | skipping: Conditional result was False 2025-08-08 15:54:20.813573 | 2025-08-08 15:54:20.816369 | localhost | skipping: Conditional result was False 2025-08-08 15:54:20.829496 | 2025-08-08 15:54:20.829746 | LOOP [upload-logs : Upload console log and json output]