2025-11-26 19:51:13.792211 | Job console starting 2025-11-26 19:51:13.806498 | Updating git repos 2025-11-26 19:51:13.888419 | Cloning repos into workspace 2025-11-26 19:51:13.937592 | Restoring repo states 2025-11-26 19:51:13.951836 | Merging changes 2025-11-26 19:51:14.598003 | Checking out repos 2025-11-26 19:51:14.662915 | Preparing playbooks 2025-11-26 19:51:15.647154 | Running Ansible setup 2025-11-26 19:52:40.659455 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-26 19:52:41.445475 | 2025-11-26 19:52:41.445650 | PLAY [Base pre] 2025-11-26 19:52:41.462774 | 2025-11-26 19:52:41.462949 | TASK [Setup log path fact] 2025-11-26 19:52:41.484122 | debian-bookworm | ok 2025-11-26 19:52:41.500828 | 2025-11-26 19:52:41.500978 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-26 19:52:41.530706 | debian-bookworm | ok 2025-11-26 19:52:41.540559 | 2025-11-26 19:52:41.540670 | TASK [emit-job-header : Print job information] 2025-11-26 19:52:41.606905 | # Job Information 2025-11-26 19:52:41.607264 | Ansible Version: 2.16.14 2025-11-26 19:52:41.607365 | Job: flake8 2025-11-26 19:52:41.607438 | Pipeline: check 2025-11-26 19:52:41.607486 | Executor: 521e9411259a 2025-11-26 19:52:41.607530 | Triggered by: https://github.com/osism/container-images/pull/797 2025-11-26 19:52:41.607576 | Event ID: 3d3a92a0-cb01-11f0-914a-224b4f0791a8 2025-11-26 19:52:41.616477 | 2025-11-26 19:52:41.616655 | LOOP [emit-job-header : Print node information] 2025-11-26 19:52:41.741622 | debian-bookworm | ok: 2025-11-26 19:52:41.741991 | debian-bookworm | # Node Information 2025-11-26 19:52:41.742077 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-26 19:52:41.742148 | debian-bookworm | Hostname: debian 2025-11-26 19:52:41.742212 | debian-bookworm | Username: zuul 2025-11-26 19:52:41.742276 | debian-bookworm | Distro: Debian 12.12 2025-11-26 19:52:41.742401 | debian-bookworm | Provider: regiocloud-a 2025-11-26 19:52:41.742469 | debian-bookworm | Region: 2025-11-26 19:52:41.742531 | debian-bookworm | Label: debian-bookworm 2025-11-26 19:52:41.742591 | debian-bookworm | Product Name: OpenStack Nova 2025-11-26 19:52:41.742651 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feae:4442 2025-11-26 19:52:41.762536 | 2025-11-26 19:52:41.762683 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-26 19:52:42.305144 | debian-bookworm -> localhost | changed 2025-11-26 19:52:42.312923 | 2025-11-26 19:52:42.313054 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-26 19:52:43.397828 | debian-bookworm -> localhost | changed 2025-11-26 19:52:43.409290 | 2025-11-26 19:52:43.409490 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-26 19:52:43.779809 | debian-bookworm -> localhost | ok 2025-11-26 19:52:43.792625 | 2025-11-26 19:52:43.792813 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-26 19:52:43.821063 | debian-bookworm | ok 2025-11-26 19:52:43.843263 | debian-bookworm | included: /var/lib/zuul/builds/b4abd9cf206e4ef4833579b7dd33e917/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-26 19:52:43.852090 | 2025-11-26 19:52:43.852202 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-26 19:52:45.278975 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-26 19:52:45.279261 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b4abd9cf206e4ef4833579b7dd33e917/work/b4abd9cf206e4ef4833579b7dd33e917_id_rsa 2025-11-26 19:52:45.279315 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b4abd9cf206e4ef4833579b7dd33e917/work/b4abd9cf206e4ef4833579b7dd33e917_id_rsa.pub 2025-11-26 19:52:45.279370 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-26 19:52:45.279402 | debian-bookworm -> localhost | SHA256:L4g64Rf97wX9ewfUJkriZoFa9ym+RebSmSRQNgAY1uE zuul-build-sshkey 2025-11-26 19:52:45.279432 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-26 19:52:45.279475 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-26 19:52:45.279505 | debian-bookworm -> localhost | | o+oo..+ | 2025-11-26 19:52:45.279534 | debian-bookworm -> localhost | | .... o . | 2025-11-26 19:52:45.279561 | debian-bookworm -> localhost | | E .. . | 2025-11-26 19:52:45.279587 | debian-bookworm -> localhost | | o.+.. o o| 2025-11-26 19:52:45.279613 | debian-bookworm -> localhost | | . oSoo==+ o | 2025-11-26 19:52:45.279643 | debian-bookworm -> localhost | | . ..o. .=O++. | 2025-11-26 19:52:45.279671 | debian-bookworm -> localhost | | . ......+o.B .. | 2025-11-26 19:52:45.279697 | debian-bookworm -> localhost | | o.. ...+ .o| 2025-11-26 19:52:45.279725 | debian-bookworm -> localhost | | .o o+. ...| 2025-11-26 19:52:45.279753 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-26 19:52:45.279824 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.894237 2025-11-26 19:52:45.288208 | 2025-11-26 19:52:45.288391 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-26 19:52:45.320173 | debian-bookworm | ok 2025-11-26 19:52:45.333350 | debian-bookworm | included: /var/lib/zuul/builds/b4abd9cf206e4ef4833579b7dd33e917/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-26 19:52:45.343667 | 2025-11-26 19:52:45.343814 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-26 19:52:45.368080 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:52:45.375179 | 2025-11-26 19:52:45.375289 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-26 19:52:46.064724 | debian-bookworm | changed 2025-11-26 19:52:46.072459 | 2025-11-26 19:52:46.072597 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-26 19:52:46.361126 | debian-bookworm | ok 2025-11-26 19:52:46.370208 | 2025-11-26 19:52:46.370400 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-26 19:52:47.101300 | debian-bookworm | changed 2025-11-26 19:52:47.111818 | 2025-11-26 19:52:47.111958 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-26 19:52:47.800999 | debian-bookworm | changed 2025-11-26 19:52:47.807109 | 2025-11-26 19:52:47.807236 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-26 19:52:47.830978 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:52:47.838175 | 2025-11-26 19:52:47.838287 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-26 19:52:48.317163 | debian-bookworm -> localhost | changed 2025-11-26 19:52:48.328630 | 2025-11-26 19:52:48.328754 | TASK [add-build-sshkey : Add back temp key] 2025-11-26 19:52:48.719739 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b4abd9cf206e4ef4833579b7dd33e917/work/b4abd9cf206e4ef4833579b7dd33e917_id_rsa (zuul-build-sshkey) 2025-11-26 19:52:48.720424 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021446 2025-11-26 19:52:48.736052 | 2025-11-26 19:52:48.736209 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-26 19:52:49.196538 | debian-bookworm | ok 2025-11-26 19:52:49.201983 | 2025-11-26 19:52:49.202121 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-26 19:52:49.236637 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:52:49.251067 | 2025-11-26 19:52:49.251203 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-26 19:52:49.702532 | debian-bookworm | ok 2025-11-26 19:52:49.716951 | 2025-11-26 19:52:49.717082 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-26 19:52:49.747499 | debian-bookworm | ok 2025-11-26 19:52:49.752831 | 2025-11-26 19:52:49.752936 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-26 19:52:50.071621 | debian-bookworm -> localhost | ok 2025-11-26 19:52:50.086861 | 2025-11-26 19:52:50.087050 | TASK [validate-host : Collect information about the host] 2025-11-26 19:53:31.370675 | debian-bookworm | ok 2025-11-26 19:53:31.385479 | 2025-11-26 19:53:31.385610 | TASK [validate-host : Sanitize hostname] 2025-11-26 19:53:31.524831 | debian-bookworm | ok 2025-11-26 19:53:31.571378 | 2025-11-26 19:53:31.571525 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-26 19:53:32.174927 | debian-bookworm -> localhost | changed 2025-11-26 19:53:32.188361 | 2025-11-26 19:53:32.188566 | TASK [validate-host : Collect information about zuul worker] 2025-11-26 19:53:32.681782 | debian-bookworm | ok 2025-11-26 19:53:32.689877 | 2025-11-26 19:53:32.690068 | TASK [validate-host : Write out all zuul information for each host] 2025-11-26 19:53:33.303361 | debian-bookworm -> localhost | changed 2025-11-26 19:53:33.325848 | 2025-11-26 19:53:33.325987 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-26 19:53:33.634545 | debian-bookworm | ok 2025-11-26 19:53:33.643588 | 2025-11-26 19:53:33.643717 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-26 19:53:34.546358 | debian-bookworm | changed: 2025-11-26 19:53:34.546729 | debian-bookworm | cd+++++++++ src/ 2025-11-26 19:53:34.546786 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-26 19:53:34.546822 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-26 19:53:34.546892 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ 2025-11-26 19:53:34.546923 | debian-bookworm | Containerfile 2025-11-26 19:53:34.556984 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ansible-lint/ 2025-11-26 19:53:34.557024 | debian-bookworm | Containerfile 2025-11-26 19:53:34.557106 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ansible-lint/files/ 2025-11-26 19:53:34.557146 | debian-bookworm | Containerfile 2025-11-26 19:53:34.557663 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ara-server/files/ 2025-11-26 19:53:34.557704 | debian-bookworm | Containerfile 2025-11-26 19:53:34.557912 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ceph-daemon/files/ 2025-11-26 19:53:34.557952 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ceph-daemon/files/bin/ 2025-11-26 19:53:34.557992 | debian-bookworm | Containerfile 2025-11-26 19:53:34.559660 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/cephclient/files/ 2025-11-26 19:53:34.559701 | debian-bookworm | Containerfile 2025-11-26 19:53:34.559864 | debian-bookworm | Containerfile 2025-11-26 19:53:34.560153 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/dnsmasq-osism/ 2025-11-26 19:53:34.560237 | debian-bookworm | Containerfile 2025-11-26 19:53:34.560337 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/gnmic/ 2025-11-26 19:53:34.560378 | debian-bookworm | Containerfile 2025-11-26 19:53:34.560459 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/homer/ 2025-11-26 19:53:34.560507 | debian-bookworm | Containerfile 2025-11-26 19:53:34.560611 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/homer/files/ 2025-11-26 19:53:34.560661 | debian-bookworm | Containerfile 2025-11-26 19:53:34.561731 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/lloadd/ 2025-11-26 19:53:34.561771 | debian-bookworm | Containerfile 2025-11-26 19:53:34.561853 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/netbox/ 2025-11-26 19:53:34.561910 | debian-bookworm | Containerfile 2025-11-26 19:53:34.562007 | debian-bookworm | Containerfile 2025-11-26 19:53:34.562305 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/nexus/files/ 2025-11-26 19:53:34.562342 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/nexus/files/scripts/ 2025-11-26 19:53:34.562378 | debian-bookworm | Containerfile 2025-11-26 19:53:34.562745 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/openstackclient/files/ 2025-11-26 19:53:34.562783 | debian-bookworm | Containerfile 2025-11-26 19:53:34.563023 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/prometheus-redfish-exporter/files/ 2025-11-26 19:53:34.563060 | debian-bookworm | Containerfile 2025-11-26 19:53:34.563401 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/rsync/ 2025-11-26 19:53:34.563442 | debian-bookworm | Containerfile 2025-11-26 19:53:34.563521 | debian-bookworm | Containerfile 2025-11-26 19:53:34.563791 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/seed/files/ 2025-11-26 19:53:34.563828 | debian-bookworm | Containerfile 2025-11-26 19:53:34.564221 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/tempest/files/ 2025-11-26 19:53:34.564259 | debian-bookworm | Containerfile 2025-11-26 19:53:34.578541 | 2025-11-26 19:53:34.578649 | PLAY RECAP 2025-11-26 19:53:34.578711 | debian-bookworm | ok: 26 changed: 11 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-11-26 19:53:34.578739 | 2025-11-26 19:53:34.716081 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-26 19:53:34.718828 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/flake8/run.yaml@main] 2025-11-26 19:53:35.460404 | 2025-11-26 19:53:35.460565 | PLAY [Run flake8] 2025-11-26 19:53:35.475695 | 2025-11-26 19:53:35.475814 | LOOP [Install python] 2025-11-26 19:53:35.516473 | debian-bookworm | ok: "ensure-python" 2025-11-26 19:53:35.525032 | debian-bookworm | ok: "ensure-pip" 2025-11-26 19:53:35.577566 | 2025-11-26 19:53:35.577710 | TASK [ensure-python : Validate python_version value] 2025-11-26 19:53:35.612304 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:53:35.626519 | 2025-11-26 19:53:35.626692 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2025-11-26 19:53:35.652194 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:53:35.661116 | 2025-11-26 19:53:35.661380 | TASK [ensure-python : Pull in venv package] 2025-11-26 19:53:35.686513 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:53:35.699328 | 2025-11-26 19:53:35.699501 | TASK [ensure-python : Set default RPM package name] 2025-11-26 19:53:35.735020 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:53:35.744759 | 2025-11-26 19:53:35.744935 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9 and Python 3.9] 2025-11-26 19:53:35.780603 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:53:35.794006 | 2025-11-26 19:53:35.794225 | TASK [ensure-python : Install RPM package] 2025-11-26 19:53:35.829648 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:53:35.840114 | 2025-11-26 19:53:35.840362 | TASK [ensure-python : Install python using pyenv] 2025-11-26 19:53:35.855935 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:53:35.866073 | 2025-11-26 19:53:35.866274 | TASK [ensure-python : Activate python using stow] 2025-11-26 19:53:35.890828 | debian-bookworm | skipping: Conditional result was False 2025-11-26 19:53:35.910778 | 2025-11-26 19:53:35.910940 | TASK [ensure-pip : Check if pip is installed] 2025-11-26 19:53:36.445083 | debian-bookworm | ok: Runtime: 0:00:00.009574 2025-11-26 19:53:36.458410 | 2025-11-26 19:53:36.458605 | LOOP [ensure-pip : Install pip from packages] 2025-11-26 19:53:36.506760 | debian-bookworm | ok: "/var/lib/zuul/builds/b4abd9cf206e4ef4833579b7dd33e917/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2025-11-26 19:53:36.507106 | debian-bookworm | ok: All items complete 2025-11-26 19:53:36.507183 | 2025-11-26 19:53:36.528609 | debian-bookworm | included: /var/lib/zuul/builds/b4abd9cf206e4ef4833579b7dd33e917/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2025-11-26 19:53:36.539877 | 2025-11-26 19:53:36.539989 | TASK [ensure-pip : Update package lists] 2025-11-26 19:55:48.902810 | debian-bookworm | ERROR 2025-11-26 19:55:48.903455 | debian-bookworm | { 2025-11-26 19:55:48.903521 | debian-bookworm | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2025-11-26 19:55:48.903564 | debian-bookworm | } failure 2025-11-26 19:55:48.906622 | 2025-11-26 19:55:48.906757 | PLAY RECAP 2025-11-26 19:55:48.906829 | debian-bookworm | ok: 2 changed: 1 unreachable: 0 failed: 1 skipped: 8 rescued: 0 ignored: 0 2025-11-26 19:55:48.906938 | 2025-11-26 19:55:49.103367 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/flake8/run.yaml@main] 2025-11-26 19:55:49.106198 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-26 19:55:50.009124 | 2025-11-26 19:55:50.009299 | PLAY [Base post] 2025-11-26 19:55:50.025306 | 2025-11-26 19:55:50.025458 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-26 19:55:50.649892 | debian-bookworm | changed 2025-11-26 19:55:50.660277 | 2025-11-26 19:55:50.660448 | PLAY RECAP 2025-11-26 19:55:50.660546 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-26 19:55:50.660644 | 2025-11-26 19:55:50.792352 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-26 19:55:50.794415 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-26 19:55:51.705553 | 2025-11-26 19:55:51.705732 | PLAY [Base post-logs] 2025-11-26 19:55:51.717839 | 2025-11-26 19:55:51.718017 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-26 19:55:52.189347 | localhost | changed 2025-11-26 19:55:52.204534 | 2025-11-26 19:55:52.205051 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-26 19:55:52.247584 | localhost | ok 2025-11-26 19:55:52.253382 | 2025-11-26 19:55:52.253518 | TASK [Set zuul-log-path fact] 2025-11-26 19:55:52.281149 | localhost | ok 2025-11-26 19:55:52.291636 | 2025-11-26 19:55:52.291789 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-26 19:55:52.330096 | localhost | ok 2025-11-26 19:55:52.336790 | 2025-11-26 19:55:52.337008 | TASK [upload-logs : Create log directories] 2025-11-26 19:55:52.873709 | localhost | changed 2025-11-26 19:55:52.876554 | 2025-11-26 19:55:52.876664 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-26 19:55:53.492577 | localhost -> localhost | ok: Runtime: 0:00:00.007713 2025-11-26 19:55:53.502263 | 2025-11-26 19:55:53.502456 | TASK [upload-logs : Upload logs to log server] 2025-11-26 19:55:54.127708 | localhost | Output suppressed because no_log was given 2025-11-26 19:55:54.129646 | 2025-11-26 19:55:54.129757 | LOOP [upload-logs : Compress console log and json output] 2025-11-26 19:55:54.178446 | localhost | skipping: Conditional result was False 2025-11-26 19:55:54.184811 | localhost | skipping: Conditional result was False 2025-11-26 19:55:54.192715 | 2025-11-26 19:55:54.192923 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-26 19:55:54.247119 | localhost | skipping: Conditional result was False 2025-11-26 19:55:54.247638 | 2025-11-26 19:55:54.249401 | localhost | skipping: Conditional result was False 2025-11-26 19:55:54.255902 | 2025-11-26 19:55:54.256107 | LOOP [upload-logs : Upload console log and json output]