2025-11-05 08:17:50.234052 | Job console starting 2025-11-05 08:17:50.252992 | Updating git repos 2025-11-05 08:17:50.319578 | Cloning repos into workspace 2025-11-05 08:17:50.362646 | Restoring repo states 2025-11-05 08:17:50.374973 | Merging changes 2025-11-05 08:17:50.950329 | Checking out repos 2025-11-05 08:17:51.020686 | Preparing playbooks 2025-11-05 08:17:51.912642 | Running Ansible setup 2025-11-05 08:17:57.023989 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-05 08:17:57.699975 | 2025-11-05 08:17:57.700161 | PLAY [Base pre] 2025-11-05 08:17:57.716936 | 2025-11-05 08:17:57.717055 | TASK [Setup log path fact] 2025-11-05 08:17:57.741239 | debian-bookworm | ok 2025-11-05 08:17:57.759863 | 2025-11-05 08:17:57.759980 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-05 08:17:57.788194 | debian-bookworm | ok 2025-11-05 08:17:57.797396 | 2025-11-05 08:17:57.797492 | TASK [emit-job-header : Print job information] 2025-11-05 08:17:57.825363 | # Job Information 2025-11-05 08:17:57.825563 | Ansible Version: 2.16.14 2025-11-05 08:17:57.825598 | Job: flake8 2025-11-05 08:17:57.825645 | Pipeline: check 2025-11-05 08:17:57.825668 | Executor: 521e9411259a 2025-11-05 08:17:57.825690 | Triggered by: https://github.com/osism/python-osism/pull/1790 2025-11-05 08:17:57.825712 | Event ID: e648d250-ba1f-11f0-8d3e-439ee8d32069 2025-11-05 08:17:57.830534 | 2025-11-05 08:17:57.830641 | LOOP [emit-job-header : Print node information] 2025-11-05 08:17:57.943961 | debian-bookworm | ok: 2025-11-05 08:17:57.944145 | debian-bookworm | # Node Information 2025-11-05 08:17:57.944181 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-05 08:17:57.944206 | debian-bookworm | Hostname: debian 2025-11-05 08:17:57.944229 | debian-bookworm | Username: zuul 2025-11-05 08:17:57.944251 | debian-bookworm | Distro: Debian 12.12 2025-11-05 08:17:57.944275 | debian-bookworm | Provider: regiocloud-a 2025-11-05 08:17:57.944295 | debian-bookworm | Region: 2025-11-05 08:17:57.944317 | debian-bookworm | Label: debian-bookworm 2025-11-05 08:17:57.944337 | debian-bookworm | Product Name: OpenStack Nova 2025-11-05 08:17:57.944357 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe55:31c0 2025-11-05 08:17:57.961913 | 2025-11-05 08:17:57.962022 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-05 08:17:58.772174 | debian-bookworm -> localhost | changed 2025-11-05 08:17:58.778763 | 2025-11-05 08:17:58.779071 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-05 08:18:00.339558 | debian-bookworm -> localhost | changed 2025-11-05 08:18:00.347932 | 2025-11-05 08:18:00.348017 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-05 08:18:00.760565 | debian-bookworm -> localhost | ok 2025-11-05 08:18:00.765497 | 2025-11-05 08:18:00.765583 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-05 08:18:00.792525 | debian-bookworm | ok 2025-11-05 08:18:00.825658 | debian-bookworm | included: /var/lib/zuul/builds/e94fda16b3dd4f97b129112c6eea9525/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-05 08:18:00.830566 | 2025-11-05 08:18:00.830643 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-05 08:18:01.783663 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-05 08:18:01.783822 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e94fda16b3dd4f97b129112c6eea9525/work/e94fda16b3dd4f97b129112c6eea9525_id_rsa 2025-11-05 08:18:01.783853 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e94fda16b3dd4f97b129112c6eea9525/work/e94fda16b3dd4f97b129112c6eea9525_id_rsa.pub 2025-11-05 08:18:01.783874 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-05 08:18:01.783894 | debian-bookworm -> localhost | SHA256:BYihKT1lfvOQyDK4Mjss8uicFKAO9XR6ei876+D8bR4 zuul-build-sshkey 2025-11-05 08:18:01.783912 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-05 08:18:01.783936 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-05 08:18:01.783955 | debian-bookworm -> localhost | | +o .. | 2025-11-05 08:18:01.783973 | debian-bookworm -> localhost | | o B.... . | 2025-11-05 08:18:01.783989 | debian-bookworm -> localhost | |+ O = * . | 2025-11-05 08:18:01.784005 | debian-bookworm -> localhost | |o+ * + + . | 2025-11-05 08:18:01.784021 | debian-bookworm -> localhost | |*. o . S | 2025-11-05 08:18:01.784042 | debian-bookworm -> localhost | |=o. o | 2025-11-05 08:18:01.784059 | debian-bookworm -> localhost | |=+ o . E | 2025-11-05 08:18:01.784076 | debian-bookworm -> localhost | |=+.o ooo.. | 2025-11-05 08:18:01.784103 | debian-bookworm -> localhost | |o+. oo=B+ | 2025-11-05 08:18:01.784120 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-05 08:18:01.784162 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.303297 2025-11-05 08:18:01.789373 | 2025-11-05 08:18:01.789451 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-05 08:18:01.815624 | debian-bookworm | ok 2025-11-05 08:18:01.826479 | debian-bookworm | included: /var/lib/zuul/builds/e94fda16b3dd4f97b129112c6eea9525/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-05 08:18:01.836104 | 2025-11-05 08:18:01.836182 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-05 08:18:01.848481 | debian-bookworm | skipping: Conditional result was False 2025-11-05 08:18:01.853198 | 2025-11-05 08:18:01.853270 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-05 08:18:02.561058 | debian-bookworm | changed 2025-11-05 08:18:02.565362 | 2025-11-05 08:18:02.565435 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-05 08:18:02.814502 | debian-bookworm | ok 2025-11-05 08:18:02.818900 | 2025-11-05 08:18:02.819027 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-05 08:18:03.560156 | debian-bookworm | changed 2025-11-05 08:18:03.568122 | 2025-11-05 08:18:03.568196 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-05 08:18:04.241052 | debian-bookworm | changed 2025-11-05 08:18:04.245510 | 2025-11-05 08:18:04.245577 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-05 08:18:04.269841 | debian-bookworm | skipping: Conditional result was False 2025-11-05 08:18:04.274409 | 2025-11-05 08:18:04.274477 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-05 08:18:04.652854 | debian-bookworm -> localhost | changed 2025-11-05 08:18:04.661651 | 2025-11-05 08:18:04.661725 | TASK [add-build-sshkey : Add back temp key] 2025-11-05 08:18:04.899127 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e94fda16b3dd4f97b129112c6eea9525/work/e94fda16b3dd4f97b129112c6eea9525_id_rsa (zuul-build-sshkey) 2025-11-05 08:18:04.899299 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017065 2025-11-05 08:18:04.906154 | 2025-11-05 08:18:04.906236 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-05 08:18:05.257257 | debian-bookworm | ok 2025-11-05 08:18:05.265307 | 2025-11-05 08:18:05.265417 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-05 08:18:05.288660 | debian-bookworm | skipping: Conditional result was False 2025-11-05 08:18:05.297642 | 2025-11-05 08:18:05.297712 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-05 08:18:05.696611 | debian-bookworm | ok 2025-11-05 08:18:05.705723 | 2025-11-05 08:18:05.705797 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-05 08:18:05.744651 | debian-bookworm | ok 2025-11-05 08:18:05.750165 | 2025-11-05 08:18:05.750248 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-05 08:18:06.035934 | debian-bookworm -> localhost | ok 2025-11-05 08:18:06.051520 | 2025-11-05 08:18:06.051618 | TASK [validate-host : Collect information about the host] 2025-11-05 08:18:07.135161 | debian-bookworm | ok 2025-11-05 08:18:07.145355 | 2025-11-05 08:18:07.145455 | TASK [validate-host : Sanitize hostname] 2025-11-05 08:18:07.256536 | debian-bookworm | ok 2025-11-05 08:18:07.293425 | 2025-11-05 08:18:07.293524 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-05 08:18:07.936580 | debian-bookworm -> localhost | changed 2025-11-05 08:18:07.941987 | 2025-11-05 08:18:07.942079 | TASK [validate-host : Collect information about zuul worker] 2025-11-05 08:18:08.346767 | debian-bookworm | ok 2025-11-05 08:18:08.351131 | 2025-11-05 08:18:08.351213 | TASK [validate-host : Write out all zuul information for each host] 2025-11-05 08:18:08.848322 | debian-bookworm -> localhost | changed 2025-11-05 08:18:08.857204 | 2025-11-05 08:18:08.857299 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-05 08:18:09.151776 | debian-bookworm | ok 2025-11-05 08:18:09.156855 | 2025-11-05 08:18:09.156943 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-05 08:18:10.122859 | debian-bookworm | changed: 2025-11-05 08:18:10.123020 | debian-bookworm | cd+++++++++ src/ 2025-11-05 08:18:10.123053 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-05 08:18:10.123077 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-05 08:18:10.123109 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-05 08:18:10.123129 | debian-bookworm | Containerfile 2025-11-05 08:18:10.123241 | debian-bookworm | Containerfile 2025-11-05 08:18:10.127878 | debian-bookworm | 200 characters) 2025-11-05 08:18:46.512620 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/interface.py Result: 1 2025-11-05 08:18:46.951769 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/cache.py Runtime: 0:00:00.179602 2025-11-05 08:18:47.375957 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/set.py Runtime: 0:00:00.171079 2025-11-05 08:18:47.875293 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/compute.py Runtime: 0:00:00.258784 2025-11-05 08:18:48.292902 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/lock.py Runtime: 0:00:00.174889 2025-11-05 08:18:48.711332 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/console.py Runtime: 0:00:00.180604 2025-11-05 08:18:49.158189 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/wait.py Runtime: 0:00:00.181397 2025-11-05 08:18:49.700976 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/manage.py Runtime: 0:00:00.288810 2025-11-05 08:18:50.232413 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/baremetal.py Runtime: 0:00:00.288793 2025-11-05 08:18:50.639495 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/container.py Runtime: 0:00:00.167960 2025-11-05 08:18:51.067622 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/log.py Runtime: 0:00:00.177401 2025-11-05 08:18:51.518500 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/status.py Runtime: 0:00:00.198554 2025-11-05 08:18:51.952251 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/volume.py Runtime: 0:00:00.194542 2025-11-05 08:18:52.362287 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/__init__.py Runtime: 0:00:00.157239 2025-11-05 08:18:52.825789 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/apply.py Runtime: 0:00:00.218956 2025-11-05 08:18:53.287833 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/noset.py Runtime: 0:00:00.210843 2025-11-05 08:18:53.736439 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/get.py Runtime: 0:00:00.202566 2025-11-05 08:18:54.330163 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/sonic.py Runtime: 0:00:00.335559 2025-11-05 08:18:54.741820 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/sync.py Runtime: 0:00:00.170540 2025-11-05 08:18:55.162541 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/validate.py Runtime: 0:00:00.178149 2025-11-05 08:18:55.609512 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/redfish.py Runtime: 0:00:00.191892 2025-11-05 08:18:56.012058 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/compose.py Runtime: 0:00:00.167761 2025-11-05 08:18:56.415965 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/service.py Runtime: 0:00:00.166859 2025-11-05 08:18:56.851364 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/task.py Runtime: 0:00:00.187803 2025-11-05 08:18:57.319549 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/stress.py Runtime: 0:00:00.204800 2025-11-05 08:18:57.743222 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/configuration.py Runtime: 0:00:00.175791 2025-11-05 08:18:58.169845 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/server.py Runtime: 0:00:00.202797 2025-11-05 08:18:58.601864 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/netbox.py Runtime: 0:00:00.202787 2025-11-05 08:18:58.999949 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/reconciler.py Runtime: 0:00:00.164194 2025-11-05 08:18:59.434024 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/vault.py Runtime: 0:00:00.171976 2025-11-05 08:18:59.900078 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/worker.py Runtime: 0:00:00.166248 2025-11-05 08:19:00.320472 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/files/redfishMockupCreate.py Runtime: 0:00:00.239973 failure 2025-11-05 08:19:00.381110 | 2025-11-05 08:19:00.381217 | PLAY RECAP 2025-11-05 08:19:00.381290 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 1 skipped: 12 rescued: 0 ignored: 0 2025-11-05 08:19:00.381319 | 2025-11-05 08:19:00.515599 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/flake8/run.yaml@main] 2025-11-05 08:19:00.516504 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-05 08:19:01.285744 | 2025-11-05 08:19:01.285899 | PLAY [Base post] 2025-11-05 08:19:01.299416 | 2025-11-05 08:19:01.299543 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-05 08:19:01.855264 | debian-bookworm | changed 2025-11-05 08:19:01.864213 | 2025-11-05 08:19:01.864357 | PLAY RECAP 2025-11-05 08:19:01.864459 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-05 08:19:01.864566 | 2025-11-05 08:19:01.975907 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-05 08:19:01.976783 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-05 08:19:02.724882 | 2025-11-05 08:19:02.725035 | PLAY [Base post-logs] 2025-11-05 08:19:02.735121 | 2025-11-05 08:19:02.735249 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-05 08:19:03.196724 | localhost | changed 2025-11-05 08:19:03.206905 | 2025-11-05 08:19:03.207049 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-05 08:19:03.245321 | localhost | ok 2025-11-05 08:19:03.251912 | 2025-11-05 08:19:03.252060 | TASK [Set zuul-log-path fact] 2025-11-05 08:19:03.281930 | localhost | ok 2025-11-05 08:19:03.294767 | 2025-11-05 08:19:03.294910 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-05 08:19:03.329917 | localhost | ok 2025-11-05 08:19:03.334443 | 2025-11-05 08:19:03.334588 | TASK [upload-logs : Create log directories] 2025-11-05 08:19:03.807044 | localhost | changed 2025-11-05 08:19:03.809937 | 2025-11-05 08:19:03.810043 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-05 08:19:04.301326 | localhost -> localhost | ok: Runtime: 0:00:00.006717 2025-11-05 08:19:04.306582 | 2025-11-05 08:19:04.306730 | TASK [upload-logs : Upload logs to log server] 2025-11-05 08:19:04.862268 | localhost | Output suppressed because no_log was given 2025-11-05 08:19:04.866767 | 2025-11-05 08:19:04.867078 | LOOP [upload-logs : Compress console log and json output] 2025-11-05 08:19:04.924943 | localhost | skipping: Conditional result was False 2025-11-05 08:19:04.929133 | localhost | skipping: Conditional result was False 2025-11-05 08:19:04.942296 | 2025-11-05 08:19:04.942515 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-05 08:19:04.988127 | localhost | skipping: Conditional result was False 2025-11-05 08:19:04.988662 | 2025-11-05 08:19:04.992142 | localhost | skipping: Conditional result was False 2025-11-05 08:19:05.005409 | 2025-11-05 08:19:05.005628 | LOOP [upload-logs : Upload console log and json output]