2025-11-05 08:25:40.093774 | Job console starting 2025-11-05 08:25:40.106874 | Updating git repos 2025-11-05 08:25:40.177239 | Cloning repos into workspace 2025-11-05 08:25:40.226340 | Restoring repo states 2025-11-05 08:25:40.237662 | Merging changes 2025-11-05 08:25:40.846894 | Checking out repos 2025-11-05 08:25:40.906546 | Preparing playbooks 2025-11-05 08:25:41.843193 | Running Ansible setup 2025-11-05 08:25:46.849842 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-05 08:25:47.727036 | 2025-11-05 08:25:47.727201 | PLAY [Base pre] 2025-11-05 08:25:47.743422 | 2025-11-05 08:25:47.743566 | TASK [Setup log path fact] 2025-11-05 08:25:47.772408 | debian-bookworm | ok 2025-11-05 08:25:47.787530 | 2025-11-05 08:25:47.787664 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-05 08:25:47.816622 | debian-bookworm | ok 2025-11-05 08:25:47.826616 | 2025-11-05 08:25:47.826728 | TASK [emit-job-header : Print job information] 2025-11-05 08:25:47.865187 | # Job Information 2025-11-05 08:25:47.865364 | Ansible Version: 2.16.14 2025-11-05 08:25:47.865398 | Job: flake8 2025-11-05 08:25:47.865432 | Pipeline: check 2025-11-05 08:25:47.865455 | Executor: 521e9411259a 2025-11-05 08:25:47.865475 | Triggered by: https://github.com/osism/python-osism/pull/1790 2025-11-05 08:25:47.865497 | Event ID: fe5fb3d0-ba20-11f0-8c27-db8402e8650e 2025-11-05 08:25:47.870423 | 2025-11-05 08:25:47.870534 | LOOP [emit-job-header : Print node information] 2025-11-05 08:25:47.972074 | debian-bookworm | ok: 2025-11-05 08:25:47.972278 | debian-bookworm | # Node Information 2025-11-05 08:25:47.972313 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-05 08:25:47.972339 | debian-bookworm | Hostname: debian 2025-11-05 08:25:47.972362 | debian-bookworm | Username: zuul 2025-11-05 08:25:47.972383 | debian-bookworm | Distro: Debian 12.12 2025-11-05 08:25:47.972407 | debian-bookworm | Provider: regiocloud-a 2025-11-05 08:25:47.972427 | debian-bookworm | Region: 2025-11-05 08:25:47.972448 | debian-bookworm | Label: debian-bookworm 2025-11-05 08:25:47.972468 | debian-bookworm | Product Name: OpenStack Nova 2025-11-05 08:25:47.972487 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feed:fd49 2025-11-05 08:25:47.985206 | 2025-11-05 08:25:47.985331 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-05 08:25:48.644296 | debian-bookworm -> localhost | changed 2025-11-05 08:25:48.649885 | 2025-11-05 08:25:48.649973 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-05 08:25:50.437782 | debian-bookworm -> localhost | changed 2025-11-05 08:25:50.448083 | 2025-11-05 08:25:50.448182 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-05 08:25:50.821756 | debian-bookworm -> localhost | ok 2025-11-05 08:25:50.827833 | 2025-11-05 08:25:50.827934 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-05 08:25:50.875734 | debian-bookworm | ok 2025-11-05 08:25:50.903717 | debian-bookworm | included: /var/lib/zuul/builds/d4fdd8478c994250abbb816b3d9e7391/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-05 08:25:50.916298 | 2025-11-05 08:25:50.916427 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-05 08:25:53.273033 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-05 08:25:53.273210 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d4fdd8478c994250abbb816b3d9e7391/work/d4fdd8478c994250abbb816b3d9e7391_id_rsa 2025-11-05 08:25:53.273242 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d4fdd8478c994250abbb816b3d9e7391/work/d4fdd8478c994250abbb816b3d9e7391_id_rsa.pub 2025-11-05 08:25:53.273265 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-05 08:25:53.273285 | debian-bookworm -> localhost | SHA256:TIYgSIYARGrJsstftQyA5fWG4NTr9o29AqEQ89T7w9M zuul-build-sshkey 2025-11-05 08:25:53.273304 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-05 08:25:53.273330 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-05 08:25:53.273348 | debian-bookworm -> localhost | |X*.++. | 2025-11-05 08:25:53.273366 | debian-bookworm -> localhost | |*oBoo+o. | 2025-11-05 08:25:53.273383 | debian-bookworm -> localhost | |o==+ .+oo | 2025-11-05 08:25:53.273399 | debian-bookworm -> localhost | |oo ..+.+ | 2025-11-05 08:25:53.273416 | debian-bookworm -> localhost | |. . o.+.S | 2025-11-05 08:25:53.273439 | debian-bookworm -> localhost | |.. . ++=.E | 2025-11-05 08:25:53.273455 | debian-bookworm -> localhost | |.. ..oo* | 2025-11-05 08:25:53.273471 | debian-bookworm -> localhost | | . . + o | 2025-11-05 08:25:53.273488 | debian-bookworm -> localhost | | . ... | 2025-11-05 08:25:53.273505 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-05 08:25:53.273550 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.766409 2025-11-05 08:25:53.279152 | 2025-11-05 08:25:53.279223 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-05 08:25:53.305147 | debian-bookworm | ok 2025-11-05 08:25:53.312249 | debian-bookworm | included: /var/lib/zuul/builds/d4fdd8478c994250abbb816b3d9e7391/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-05 08:25:53.327200 | 2025-11-05 08:25:53.327263 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-05 08:25:53.359498 | debian-bookworm | skipping: Conditional result was False 2025-11-05 08:25:53.363804 | 2025-11-05 08:25:53.363881 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-05 08:25:54.168039 | debian-bookworm | changed 2025-11-05 08:25:54.172185 | 2025-11-05 08:25:54.172255 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-05 08:25:54.426017 | debian-bookworm | ok 2025-11-05 08:25:54.430319 | 2025-11-05 08:25:54.430390 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-05 08:25:55.076518 | debian-bookworm | changed 2025-11-05 08:25:55.092044 | 2025-11-05 08:25:55.092199 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-05 08:25:55.732539 | debian-bookworm | changed 2025-11-05 08:25:55.737705 | 2025-11-05 08:25:55.737791 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-05 08:25:55.750737 | debian-bookworm | skipping: Conditional result was False 2025-11-05 08:25:55.756276 | 2025-11-05 08:25:55.756358 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-05 08:25:56.172664 | debian-bookworm -> localhost | changed 2025-11-05 08:25:56.187954 | 2025-11-05 08:25:56.188060 | TASK [add-build-sshkey : Add back temp key] 2025-11-05 08:25:56.475497 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d4fdd8478c994250abbb816b3d9e7391/work/d4fdd8478c994250abbb816b3d9e7391_id_rsa (zuul-build-sshkey) 2025-11-05 08:25:56.475699 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015016 2025-11-05 08:25:56.483082 | 2025-11-05 08:25:56.483177 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-05 08:25:56.859070 | debian-bookworm | ok 2025-11-05 08:25:56.864022 | 2025-11-05 08:25:56.864109 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-05 08:25:56.896795 | debian-bookworm | skipping: Conditional result was False 2025-11-05 08:25:56.908358 | 2025-11-05 08:25:56.908455 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-05 08:25:57.326101 | debian-bookworm | ok 2025-11-05 08:25:57.344711 | 2025-11-05 08:25:57.344876 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-05 08:25:57.372567 | debian-bookworm | ok 2025-11-05 08:25:57.377615 | 2025-11-05 08:25:57.377719 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-05 08:25:57.763953 | debian-bookworm -> localhost | ok 2025-11-05 08:25:57.770005 | 2025-11-05 08:25:57.770098 | TASK [validate-host : Collect information about the host] 2025-11-05 08:25:58.853489 | debian-bookworm | ok 2025-11-05 08:25:58.863464 | 2025-11-05 08:25:58.863556 | TASK [validate-host : Sanitize hostname] 2025-11-05 08:25:58.972630 | debian-bookworm | ok 2025-11-05 08:25:59.039588 | 2025-11-05 08:25:59.039691 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-05 08:25:59.713254 | debian-bookworm -> localhost | changed 2025-11-05 08:25:59.719355 | 2025-11-05 08:25:59.719450 | TASK [validate-host : Collect information about zuul worker] 2025-11-05 08:26:00.130082 | debian-bookworm | ok 2025-11-05 08:26:00.134417 | 2025-11-05 08:26:00.134509 | TASK [validate-host : Write out all zuul information for each host] 2025-11-05 08:26:00.673187 | debian-bookworm -> localhost | changed 2025-11-05 08:26:00.682522 | 2025-11-05 08:26:00.682618 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-05 08:26:00.975074 | debian-bookworm | ok 2025-11-05 08:26:00.982673 | 2025-11-05 08:26:00.982752 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-05 08:26:02.041611 | debian-bookworm | changed: 2025-11-05 08:26:02.041781 | debian-bookworm | cd+++++++++ src/ 2025-11-05 08:26:02.041827 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-05 08:26:02.041853 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-05 08:26:02.041875 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-05 08:26:02.041895 | debian-bookworm | Containerfile 2025-11-05 08:26:02.042009 | debian-bookworm | Containerfile 2025-11-05 08:26:02.046633 | debian-bookworm | 200 characters) 2025-11-05 08:26:40.420885 | debian-bookworm | osism/tasks/conductor/sonic/interface.py:1111:17: F541 f-string is missing placeholders 2025-11-05 08:26:40.420931 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/interface.py Result: 1 2025-11-05 08:26:40.860413 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/cache.py Runtime: 0:00:00.185893 2025-11-05 08:26:41.278620 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/set.py Runtime: 0:00:00.171975 2025-11-05 08:26:41.828740 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/compute.py Runtime: 0:00:00.275475 2025-11-05 08:26:42.274601 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/lock.py Runtime: 0:00:00.177517 2025-11-05 08:26:42.743293 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/console.py Runtime: 0:00:00.195007 2025-11-05 08:26:43.182301 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/wait.py Runtime: 0:00:00.186365 2025-11-05 08:26:43.739489 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/manage.py Runtime: 0:00:00.310283 2025-11-05 08:26:44.270639 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/baremetal.py Runtime: 0:00:00.297132 2025-11-05 08:26:44.731860 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/container.py Runtime: 0:00:00.188006 2025-11-05 08:26:45.209512 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/log.py Runtime: 0:00:00.205777 2025-11-05 08:26:45.709436 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/status.py Runtime: 0:00:00.210139 2025-11-05 08:26:46.169597 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/volume.py Runtime: 0:00:00.200601 2025-11-05 08:26:46.622138 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/__init__.py Runtime: 0:00:00.180785 2025-11-05 08:26:47.131937 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/apply.py Runtime: 0:00:00.236140 2025-11-05 08:26:47.584381 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/noset.py Runtime: 0:00:00.176959 2025-11-05 08:26:48.058851 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/get.py Runtime: 0:00:00.215380 2025-11-05 08:26:48.655510 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/sonic.py Runtime: 0:00:00.340341 2025-11-05 08:26:49.117390 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/sync.py Runtime: 0:00:00.201409 2025-11-05 08:26:49.572315 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/validate.py Runtime: 0:00:00.194103 2025-11-05 08:26:50.006875 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/redfish.py Runtime: 0:00:00.198945 2025-11-05 08:26:50.463754 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/compose.py Runtime: 0:00:00.186374 2025-11-05 08:26:50.892010 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/service.py Runtime: 0:00:00.177128 2025-11-05 08:26:51.332261 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/task.py Runtime: 0:00:00.169058 2025-11-05 08:26:51.791940 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/stress.py Runtime: 0:00:00.200032 2025-11-05 08:26:52.211196 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/configuration.py Runtime: 0:00:00.163777 2025-11-05 08:26:52.696931 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/server.py Runtime: 0:00:00.207679 2025-11-05 08:26:53.167297 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/netbox.py Runtime: 0:00:00.199076 2025-11-05 08:26:53.609429 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/reconciler.py Runtime: 0:00:00.178358 2025-11-05 08:26:54.020098 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/vault.py Runtime: 0:00:00.169340 2025-11-05 08:26:54.489477 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/worker.py Runtime: 0:00:00.165574 2025-11-05 08:26:54.904935 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/files/redfishMockupCreate.py Runtime: 0:00:00.230518 failure 2025-11-05 08:26:54.950658 | 2025-11-05 08:26:54.950754 | PLAY RECAP 2025-11-05 08:26:54.950827 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 1 skipped: 12 rescued: 0 ignored: 0 2025-11-05 08:26:54.950892 | 2025-11-05 08:26:55.087099 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/flake8/run.yaml@main] 2025-11-05 08:26:55.088384 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-05 08:26:55.810360 | 2025-11-05 08:26:55.810508 | PLAY [Base post] 2025-11-05 08:26:55.823909 | 2025-11-05 08:26:55.824036 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-05 08:26:56.408475 | debian-bookworm | changed 2025-11-05 08:26:56.418310 | 2025-11-05 08:26:56.418431 | PLAY RECAP 2025-11-05 08:26:56.418505 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-05 08:26:56.418583 | 2025-11-05 08:26:56.532113 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-05 08:26:56.534104 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-05 08:26:57.293590 | 2025-11-05 08:26:57.293742 | PLAY [Base post-logs] 2025-11-05 08:26:57.304373 | 2025-11-05 08:26:57.304501 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-05 08:26:57.760855 | localhost | changed 2025-11-05 08:26:57.777242 | 2025-11-05 08:26:57.777417 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-05 08:26:57.806429 | localhost | ok 2025-11-05 08:26:57.813220 | 2025-11-05 08:26:57.813391 | TASK [Set zuul-log-path fact] 2025-11-05 08:26:57.830967 | localhost | ok 2025-11-05 08:26:57.842417 | 2025-11-05 08:26:57.842542 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-05 08:26:57.869947 | localhost | ok 2025-11-05 08:26:57.877846 | 2025-11-05 08:26:57.878048 | TASK [upload-logs : Create log directories] 2025-11-05 08:26:58.364029 | localhost | changed 2025-11-05 08:26:58.366908 | 2025-11-05 08:26:58.367028 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-05 08:26:58.857033 | localhost -> localhost | ok: Runtime: 0:00:00.006838 2025-11-05 08:26:58.861269 | 2025-11-05 08:26:58.861387 | TASK [upload-logs : Upload logs to log server] 2025-11-05 08:26:59.453173 | localhost | Output suppressed because no_log was given 2025-11-05 08:26:59.456931 | 2025-11-05 08:26:59.457121 | LOOP [upload-logs : Compress console log and json output] 2025-11-05 08:26:59.514900 | localhost | skipping: Conditional result was False 2025-11-05 08:26:59.519740 | localhost | skipping: Conditional result was False 2025-11-05 08:26:59.532387 | 2025-11-05 08:26:59.532610 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-05 08:26:59.577173 | localhost | skipping: Conditional result was False 2025-11-05 08:26:59.577867 | 2025-11-05 08:26:59.581743 | localhost | skipping: Conditional result was False 2025-11-05 08:26:59.596073 | 2025-11-05 08:26:59.596302 | LOOP [upload-logs : Upload console log and json output]