2025-09-10 02:51:03.925804 | Job console starting 2025-09-10 02:51:03.940996 | Updating git repos 2025-09-10 02:51:03.969056 | Cloning repos into workspace 2025-09-10 02:51:04.024748 | Restoring repo states 2025-09-10 02:51:04.035187 | Merging changes 2025-09-10 02:51:04.558775 | Checking out repos 2025-09-10 02:51:04.615730 | Preparing playbooks 2025-09-10 02:51:05.312194 | Running Ansible setup 2025-09-10 02:52:29.690786 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-10 02:52:30.466069 | 2025-09-10 02:52:30.466219 | PLAY [Base pre] 2025-09-10 02:52:30.481832 | 2025-09-10 02:52:30.481955 | TASK [Setup log path fact] 2025-09-10 02:52:30.510864 | debian-bookworm | ok 2025-09-10 02:52:30.525506 | 2025-09-10 02:52:30.525635 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-10 02:52:30.567858 | debian-bookworm | ok 2025-09-10 02:52:30.579205 | 2025-09-10 02:52:30.579312 | TASK [emit-job-header : Print job information] 2025-09-10 02:52:30.634480 | # Job Information 2025-09-10 02:52:30.634753 | Ansible Version: 2.16.14 2025-09-10 02:52:30.634816 | Job: flake8 2025-09-10 02:52:30.634904 | Pipeline: check 2025-09-10 02:52:30.634944 | Executor: 521e9411259a 2025-09-10 02:52:30.634981 | Triggered by: https://github.com/osism/container-images/pull/821 2025-09-10 02:52:30.635019 | Event ID: f8d6cea0-8df0-11f0-8978-7ba7c81f864d 2025-09-10 02:52:30.642521 | 2025-09-10 02:52:30.642666 | LOOP [emit-job-header : Print node information] 2025-09-10 02:52:30.781422 | debian-bookworm | ok: 2025-09-10 02:52:30.781750 | debian-bookworm | # Node Information 2025-09-10 02:52:30.781816 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-10 02:52:30.781869 | debian-bookworm | Hostname: debian 2025-09-10 02:52:30.781920 | debian-bookworm | Username: zuul 2025-09-10 02:52:30.781963 | debian-bookworm | Distro: Debian 12.12 2025-09-10 02:52:30.782010 | debian-bookworm | Provider: regiocloud-a 2025-09-10 02:52:30.782052 | debian-bookworm | Region: 2025-09-10 02:52:30.782095 | debian-bookworm | Label: debian-bookworm 2025-09-10 02:52:30.782135 | debian-bookworm | Product Name: OpenStack Nova 2025-09-10 02:52:30.782175 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec6:eff7 2025-09-10 02:52:30.803995 | 2025-09-10 02:52:30.804143 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-10 02:52:31.319357 | debian-bookworm -> localhost | changed 2025-09-10 02:52:31.327724 | 2025-09-10 02:52:31.327863 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-10 02:52:32.414460 | debian-bookworm -> localhost | changed 2025-09-10 02:52:32.425598 | 2025-09-10 02:52:32.425725 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-10 02:52:32.738657 | debian-bookworm -> localhost | ok 2025-09-10 02:52:32.752759 | 2025-09-10 02:52:32.752931 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-10 02:52:32.790160 | debian-bookworm | ok 2025-09-10 02:52:32.812160 | debian-bookworm | included: /var/lib/zuul/builds/fe6e9661054549ff869e0805a63a809a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-10 02:52:32.818410 | 2025-09-10 02:52:32.818536 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-10 02:52:33.645697 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-10 02:52:33.646191 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fe6e9661054549ff869e0805a63a809a/work/fe6e9661054549ff869e0805a63a809a_id_rsa 2025-09-10 02:52:33.646288 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fe6e9661054549ff869e0805a63a809a/work/fe6e9661054549ff869e0805a63a809a_id_rsa.pub 2025-09-10 02:52:33.646355 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-10 02:52:33.646414 | debian-bookworm -> localhost | SHA256:+Z3xi17RAp+DWuw04vHQGXOV/i9nHkWaDgvEiE3vuLc zuul-build-sshkey 2025-09-10 02:52:33.646504 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-10 02:52:33.646581 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-10 02:52:33.646638 | debian-bookworm -> localhost | | . o| 2025-09-10 02:52:33.646693 | debian-bookworm -> localhost | | + + o | 2025-09-10 02:52:33.646761 | debian-bookworm -> localhost | | . o + + o .| 2025-09-10 02:52:33.646879 | debian-bookworm -> localhost | | = o O B | 2025-09-10 02:52:33.646941 | debian-bookworm -> localhost | | S * @ O +| 2025-09-10 02:52:33.647005 | debian-bookworm -> localhost | | + % O +o| 2025-09-10 02:52:33.647058 | debian-bookworm -> localhost | | . = * +..| 2025-09-10 02:52:33.647108 | debian-bookworm -> localhost | | . . o..=| 2025-09-10 02:52:33.647161 | debian-bookworm -> localhost | | E.o .=.| 2025-09-10 02:52:33.647210 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-10 02:52:33.647346 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.312268 2025-09-10 02:52:33.659891 | 2025-09-10 02:52:33.660049 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-10 02:52:33.697183 | debian-bookworm | ok 2025-09-10 02:52:33.710604 | debian-bookworm | included: /var/lib/zuul/builds/fe6e9661054549ff869e0805a63a809a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-10 02:52:33.720806 | 2025-09-10 02:52:33.720904 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-10 02:52:33.744231 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:52:33.754243 | 2025-09-10 02:52:33.754372 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-10 02:52:34.420613 | debian-bookworm | changed 2025-09-10 02:52:34.429301 | 2025-09-10 02:52:34.429433 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-10 02:52:34.692496 | debian-bookworm | ok 2025-09-10 02:52:34.700709 | 2025-09-10 02:52:34.700839 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-10 02:52:35.378043 | debian-bookworm | changed 2025-09-10 02:52:35.388169 | 2025-09-10 02:52:35.388289 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-10 02:52:36.063163 | debian-bookworm | changed 2025-09-10 02:52:36.071197 | 2025-09-10 02:52:36.071331 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-10 02:52:36.098006 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:52:36.110396 | 2025-09-10 02:52:36.110603 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-10 02:52:36.571938 | debian-bookworm -> localhost | changed 2025-09-10 02:52:36.591919 | 2025-09-10 02:52:36.592052 | TASK [add-build-sshkey : Add back temp key] 2025-09-10 02:52:36.951644 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fe6e9661054549ff869e0805a63a809a/work/fe6e9661054549ff869e0805a63a809a_id_rsa (zuul-build-sshkey) 2025-09-10 02:52:36.951973 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019747 2025-09-10 02:52:36.961637 | 2025-09-10 02:52:36.961779 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-10 02:52:37.382208 | debian-bookworm | ok 2025-09-10 02:52:37.390321 | 2025-09-10 02:52:37.390509 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-10 02:52:37.417675 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:52:37.437083 | 2025-09-10 02:52:37.437236 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-10 02:52:37.869360 | debian-bookworm | ok 2025-09-10 02:52:37.885111 | 2025-09-10 02:52:37.885257 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-10 02:52:37.931035 | debian-bookworm | ok 2025-09-10 02:52:37.938531 | 2025-09-10 02:52:37.938660 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-10 02:52:38.247632 | debian-bookworm -> localhost | ok 2025-09-10 02:52:38.255392 | 2025-09-10 02:52:38.255539 | TASK [validate-host : Collect information about the host] 2025-09-10 02:53:19.424602 | debian-bookworm | ok 2025-09-10 02:53:19.438924 | 2025-09-10 02:53:19.439045 | TASK [validate-host : Sanitize hostname] 2025-09-10 02:53:19.557835 | debian-bookworm | ok 2025-09-10 02:53:19.607014 | 2025-09-10 02:53:19.607177 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-10 02:53:20.193825 | debian-bookworm -> localhost | changed 2025-09-10 02:53:20.206637 | 2025-09-10 02:53:20.206801 | TASK [validate-host : Collect information about zuul worker] 2025-09-10 02:53:20.629047 | debian-bookworm | ok 2025-09-10 02:53:20.636923 | 2025-09-10 02:53:20.637085 | TASK [validate-host : Write out all zuul information for each host] 2025-09-10 02:53:21.222194 | debian-bookworm -> localhost | changed 2025-09-10 02:53:21.239251 | 2025-09-10 02:53:21.239378 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-10 02:53:21.522442 | debian-bookworm | ok 2025-09-10 02:53:21.531510 | 2025-09-10 02:53:21.531625 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-10 02:53:22.419903 | debian-bookworm | changed: 2025-09-10 02:53:22.420198 | debian-bookworm | cd+++++++++ src/ 2025-09-10 02:53:22.420259 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-10 02:53:22.420301 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-10 02:53:22.420337 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ 2025-09-10 02:53:22.420373 | debian-bookworm | Containerfile 2025-09-10 02:53:22.433082 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ansible-lint/files/ 2025-09-10 02:53:22.433103 | debian-bookworm | Containerfile 2025-09-10 02:53:22.433383 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ara-server/files/ 2025-09-10 02:53:22.433405 | debian-bookworm | Containerfile 2025-09-10 02:53:22.433528 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ceph-daemon/files/ 2025-09-10 02:53:22.433550 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/ceph-daemon/files/bin/ 2025-09-10 02:53:22.433571 | debian-bookworm | Containerfile 2025-09-10 02:53:22.434373 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/cephclient/files/ 2025-09-10 02:53:22.434394 | debian-bookworm | Containerfile 2025-09-10 02:53:22.434508 | debian-bookworm | Containerfile 2025-09-10 02:53:22.434614 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/dnsmasq-osism/ 2025-09-10 02:53:22.434634 | debian-bookworm | Containerfile 2025-09-10 02:53:22.434676 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/gnmic/ 2025-09-10 02:53:22.434697 | debian-bookworm | Containerfile 2025-09-10 02:53:22.434739 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/homer/ 2025-09-10 02:53:22.434764 | debian-bookworm | Containerfile 2025-09-10 02:53:22.434806 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/homer/files/ 2025-09-10 02:53:22.434828 | debian-bookworm | Containerfile 2025-09-10 02:53:22.435346 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/lloadd/ 2025-09-10 02:53:22.435365 | debian-bookworm | Containerfile 2025-09-10 02:53:22.435404 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/netbox/ 2025-09-10 02:53:22.435422 | debian-bookworm | Containerfile 2025-09-10 02:53:22.435557 | debian-bookworm | Containerfile 2025-09-10 02:53:22.435676 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/nexus/files/ 2025-09-10 02:53:22.435695 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/nexus/files/scripts/ 2025-09-10 02:53:22.435714 | debian-bookworm | Containerfile 2025-09-10 02:53:22.435903 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/openstackclient/files/ 2025-09-10 02:53:22.435922 | debian-bookworm | Containerfile 2025-09-10 02:53:22.436018 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/prometheus-redfish-exporter/files/ 2025-09-10 02:53:22.436038 | debian-bookworm | Containerfile 2025-09-10 02:53:22.436115 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/rsync/ 2025-09-10 02:53:22.436134 | debian-bookworm | Containerfile 2025-09-10 02:53:22.436172 | debian-bookworm | Containerfile 2025-09-10 02:53:22.436310 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/seed/files/ 2025-09-10 02:53:22.436329 | debian-bookworm | Containerfile 2025-09-10 02:53:22.436532 | debian-bookworm | cd+++++++++ src/github.com/osism/container-images/tempest/files/ 2025-09-10 02:53:22.436551 | debian-bookworm | Containerfile 2025-09-10 02:53:22.456955 | 2025-09-10 02:53:22.457129 | PLAY RECAP 2025-09-10 02:53:22.457220 | debian-bookworm | ok: 26 changed: 11 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-09-10 02:53:22.457263 | 2025-09-10 02:53:22.640693 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-10 02:53:22.642683 | RUN START: [untrusted : github.com/osism/zuul-jobs/playbooks/flake8/run.yaml@main] 2025-09-10 02:53:23.345277 | 2025-09-10 02:53:23.345422 | PLAY [Run flake8] 2025-09-10 02:53:23.360140 | 2025-09-10 02:53:23.360256 | LOOP [Install python] 2025-09-10 02:53:23.389743 | debian-bookworm | ok: "ensure-python" 2025-09-10 02:53:23.395640 | debian-bookworm | ok: "ensure-pip" 2025-09-10 02:53:23.437373 | 2025-09-10 02:53:23.437533 | TASK [ensure-python : Validate python_version value] 2025-09-10 02:53:23.472398 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:53:23.480630 | 2025-09-10 02:53:23.480756 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2025-09-10 02:53:23.505706 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:53:23.517229 | 2025-09-10 02:53:23.517387 | TASK [ensure-python : Pull in venv package] 2025-09-10 02:53:23.542648 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:53:23.551866 | 2025-09-10 02:53:23.551994 | TASK [ensure-python : Set default RPM package name] 2025-09-10 02:53:23.576224 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:53:23.588917 | 2025-09-10 02:53:23.589101 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9 and Python 3.9] 2025-09-10 02:53:23.614575 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:53:23.630923 | 2025-09-10 02:53:23.631091 | TASK [ensure-python : Install RPM package] 2025-09-10 02:53:23.656030 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:53:23.671056 | 2025-09-10 02:53:23.671244 | TASK [ensure-python : Install python using pyenv] 2025-09-10 02:53:23.686503 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:53:23.695572 | 2025-09-10 02:53:23.695723 | TASK [ensure-python : Activate python using stow] 2025-09-10 02:53:23.720273 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:53:23.741731 | 2025-09-10 02:53:23.741879 | TASK [ensure-pip : Check if pip is installed] 2025-09-10 02:53:24.278041 | debian-bookworm | ok: Runtime: 0:00:00.009099 2025-09-10 02:53:24.293264 | 2025-09-10 02:53:24.293522 | LOOP [ensure-pip : Install pip from packages] 2025-09-10 02:53:24.339127 | debian-bookworm | ok: "/var/lib/zuul/builds/fe6e9661054549ff869e0805a63a809a/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2025-09-10 02:53:24.339412 | debian-bookworm | ok: All items complete 2025-09-10 02:53:24.339485 | 2025-09-10 02:53:24.362009 | debian-bookworm | included: /var/lib/zuul/builds/fe6e9661054549ff869e0805a63a809a/untrusted/project_2/github.com/osism/openinfra-zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2025-09-10 02:53:24.374810 | 2025-09-10 02:53:24.374961 | TASK [ensure-pip : Update package lists] 2025-09-10 02:55:36.708831 | debian-bookworm | ERROR 2025-09-10 02:55:36.709087 | debian-bookworm | { 2025-09-10 02:55:36.709133 | debian-bookworm | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2025-09-10 02:55:36.709163 | debian-bookworm | } failure 2025-09-10 02:55:36.711210 | 2025-09-10 02:55:36.711277 | PLAY RECAP 2025-09-10 02:55:36.712667 | debian-bookworm | ok: 2 changed: 1 unreachable: 0 failed: 1 skipped: 8 rescued: 0 ignored: 0 2025-09-10 02:55:36.712731 | 2025-09-10 02:55:36.824758 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/flake8/run.yaml@main] 2025-09-10 02:55:36.826938 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-10 02:55:37.643634 | 2025-09-10 02:55:37.643763 | PLAY [Base post] 2025-09-10 02:55:37.655378 | 2025-09-10 02:55:37.655503 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-10 02:55:38.168120 | debian-bookworm | changed 2025-09-10 02:55:38.174398 | 2025-09-10 02:55:38.174496 | PLAY RECAP 2025-09-10 02:55:38.174555 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-10 02:55:38.174615 | 2025-09-10 02:55:38.272417 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-10 02:55:38.273196 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-10 02:55:39.063604 | 2025-09-10 02:55:39.063718 | PLAY [Base post-logs] 2025-09-10 02:55:39.088726 | 2025-09-10 02:55:39.088859 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-10 02:55:39.449655 | localhost | changed 2025-09-10 02:55:39.467073 | 2025-09-10 02:55:39.467372 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-10 02:55:39.505501 | localhost | ok 2025-09-10 02:55:39.511389 | 2025-09-10 02:55:39.511653 | TASK [Set zuul-log-path fact] 2025-09-10 02:55:39.539145 | localhost | ok 2025-09-10 02:55:39.554745 | 2025-09-10 02:55:39.557355 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-10 02:55:39.597494 | localhost | ok 2025-09-10 02:55:39.604262 | 2025-09-10 02:55:39.604399 | TASK [upload-logs : Create log directories] 2025-09-10 02:55:40.014599 | localhost | changed 2025-09-10 02:55:40.017114 | 2025-09-10 02:55:40.017198 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-10 02:55:40.529235 | localhost -> localhost | ok: Runtime: 0:00:00.021601 2025-09-10 02:55:40.532943 | 2025-09-10 02:55:40.533034 | TASK [upload-logs : Upload logs to log server] 2025-09-10 02:55:41.034074 | localhost | Output suppressed because no_log was given 2025-09-10 02:55:41.037764 | 2025-09-10 02:55:41.037916 | LOOP [upload-logs : Compress console log and json output] 2025-09-10 02:55:41.089294 | localhost | skipping: Conditional result was False 2025-09-10 02:55:41.096295 | localhost | skipping: Conditional result was False 2025-09-10 02:55:41.109655 | 2025-09-10 02:55:41.109873 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-10 02:55:41.163547 | localhost | skipping: Conditional result was False 2025-09-10 02:55:41.163777 | 2025-09-10 02:55:41.169697 | localhost | skipping: Conditional result was False 2025-09-10 02:55:41.174571 | 2025-09-10 02:55:41.174700 | LOOP [upload-logs : Upload console log and json output]