2026-01-29 09:48:28.820503 | Job console starting 2026-01-29 09:48:28.837182 | Updating git repos 2026-01-29 09:48:28.909199 | Cloning repos into workspace 2026-01-29 09:48:28.966452 | Restoring repo states 2026-01-29 09:48:28.981749 | Merging changes 2026-01-29 09:48:29.734753 | Checking out repos 2026-01-29 09:48:29.860624 | Preparing playbooks 2026-01-29 09:48:30.957844 | Running Ansible setup 2026-01-29 09:48:37.525296 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-29 09:48:38.939592 | 2026-01-29 09:48:38.939748 | PLAY [Base pre] 2026-01-29 09:48:38.955761 | 2026-01-29 09:48:38.955911 | TASK [Setup log path fact] 2026-01-29 09:48:38.975222 | debian-bookworm | ok 2026-01-29 09:48:38.991733 | 2026-01-29 09:48:38.991900 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 09:48:39.062459 | debian-bookworm | ok 2026-01-29 09:48:39.073291 | 2026-01-29 09:48:39.073428 | TASK [emit-job-header : Print job information] 2026-01-29 09:48:39.153172 | # Job Information 2026-01-29 09:48:39.153371 | Ansible Version: 2.16.14 2026-01-29 09:48:39.153407 | Job: flake8 2026-01-29 09:48:39.153439 | Pipeline: check 2026-01-29 09:48:39.153463 | Executor: 521e9411259a 2026-01-29 09:48:39.153484 | Triggered by: https://github.com/osism/python-osism/pull/1975 2026-01-29 09:48:39.153507 | Event ID: a4688400-fcf7-11f0-8479-38afdd44da2f 2026-01-29 09:48:39.158551 | 2026-01-29 09:48:39.158673 | LOOP [emit-job-header : Print node information] 2026-01-29 09:48:39.356048 | debian-bookworm | ok: 2026-01-29 09:48:39.357039 | debian-bookworm | # Node Information 2026-01-29 09:48:39.357085 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-29 09:48:39.357135 | debian-bookworm | Hostname: debian 2026-01-29 09:48:39.357158 | debian-bookworm | Username: zuul 2026-01-29 09:48:39.357179 | debian-bookworm | Distro: Debian 12.13 2026-01-29 09:48:39.357208 | debian-bookworm | Provider: regiocloud-a 2026-01-29 09:48:39.357230 | debian-bookworm | Region: 2026-01-29 09:48:39.357252 | debian-bookworm | Label: debian-bookworm 2026-01-29 09:48:39.357271 | debian-bookworm | Product Name: OpenStack Nova 2026-01-29 09:48:39.357291 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec9:5951 2026-01-29 09:48:39.370548 | 2026-01-29 09:48:39.370690 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 09:48:40.522001 | debian-bookworm -> localhost | changed 2026-01-29 09:48:40.529669 | 2026-01-29 09:48:40.529808 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 09:48:42.256123 | debian-bookworm -> localhost | changed 2026-01-29 09:48:42.264532 | 2026-01-29 09:48:42.264621 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 09:48:42.583825 | debian-bookworm -> localhost | ok 2026-01-29 09:48:42.588681 | 2026-01-29 09:48:42.588764 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 09:48:42.635669 | debian-bookworm | ok 2026-01-29 09:48:42.659579 | debian-bookworm | included: /var/lib/zuul/builds/397d3bef71aa43e78b493c8118bc54f6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 09:48:42.664326 | 2026-01-29 09:48:42.664406 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 09:48:44.826192 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-29 09:48:44.826375 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/397d3bef71aa43e78b493c8118bc54f6/work/397d3bef71aa43e78b493c8118bc54f6_id_rsa 2026-01-29 09:48:44.826407 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/397d3bef71aa43e78b493c8118bc54f6/work/397d3bef71aa43e78b493c8118bc54f6_id_rsa.pub 2026-01-29 09:48:44.826429 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-29 09:48:44.826450 | debian-bookworm -> localhost | SHA256:DnHAvZOQ1FbnCxqZKM4etSp7gzoKAMP4VvXWUCVbnEs zuul-build-sshkey 2026-01-29 09:48:44.826469 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-29 09:48:44.826494 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-29 09:48:44.826512 | debian-bookworm -> localhost | | o++.o+o+. | 2026-01-29 09:48:44.826529 | debian-bookworm -> localhost | |o .+++= *E | 2026-01-29 09:48:44.826545 | debian-bookworm -> localhost | |+. o +oBo+... | 2026-01-29 09:48:44.826561 | debian-bookworm -> localhost | |.o + o =+o ... | 2026-01-29 09:48:44.826578 | debian-bookworm -> localhost | |. o + o S. . | 2026-01-29 09:48:44.826597 | debian-bookworm -> localhost | |.. . o o | 2026-01-29 09:48:44.826614 | debian-bookworm -> localhost | |. ..o . | 2026-01-29 09:48:44.826631 | debian-bookworm -> localhost | |o .oo | 2026-01-29 09:48:44.826650 | debian-bookworm -> localhost | |+o.. . | 2026-01-29 09:48:44.826667 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-29 09:48:44.826705 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.458661 2026-01-29 09:48:44.831738 | 2026-01-29 09:48:44.831811 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 09:48:44.858494 | debian-bookworm | ok 2026-01-29 09:48:44.866536 | debian-bookworm | included: /var/lib/zuul/builds/397d3bef71aa43e78b493c8118bc54f6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 09:48:44.874253 | 2026-01-29 09:48:44.874324 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 09:48:44.896839 | debian-bookworm | skipping: Conditional result was False 2026-01-29 09:48:44.902036 | 2026-01-29 09:48:44.902144 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 09:48:45.537452 | debian-bookworm | changed 2026-01-29 09:48:45.548733 | 2026-01-29 09:48:45.548819 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 09:48:45.803845 | debian-bookworm | ok 2026-01-29 09:48:45.815171 | 2026-01-29 09:48:45.815285 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 09:48:46.471708 | debian-bookworm | changed 2026-01-29 09:48:46.483822 | 2026-01-29 09:48:46.483967 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 09:48:47.089963 | debian-bookworm | changed 2026-01-29 09:48:47.095254 | 2026-01-29 09:48:47.095348 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 09:48:47.125231 | debian-bookworm | skipping: Conditional result was False 2026-01-29 09:48:47.131258 | 2026-01-29 09:48:47.131350 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 09:48:47.740150 | debian-bookworm -> localhost | changed 2026-01-29 09:48:47.762683 | 2026-01-29 09:48:47.762789 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 09:48:48.136382 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/397d3bef71aa43e78b493c8118bc54f6/work/397d3bef71aa43e78b493c8118bc54f6_id_rsa (zuul-build-sshkey) 2026-01-29 09:48:48.136627 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013855 2026-01-29 09:48:48.145580 | 2026-01-29 09:48:48.145686 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 09:48:48.557188 | debian-bookworm | ok 2026-01-29 09:48:48.564157 | 2026-01-29 09:48:48.564245 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 09:48:48.586995 | debian-bookworm | skipping: Conditional result was False 2026-01-29 09:48:48.595079 | 2026-01-29 09:48:48.595173 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 09:48:48.975050 | debian-bookworm | ok 2026-01-29 09:48:48.989641 | 2026-01-29 09:48:48.989748 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 09:48:49.037456 | debian-bookworm | ok 2026-01-29 09:48:49.055380 | 2026-01-29 09:48:49.055488 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 09:48:49.443374 | debian-bookworm -> localhost | ok 2026-01-29 09:48:49.449926 | 2026-01-29 09:48:49.450020 | TASK [validate-host : Collect information about the host] 2026-01-29 09:48:50.642203 | debian-bookworm | ok 2026-01-29 09:48:50.671531 | 2026-01-29 09:48:50.671640 | TASK [validate-host : Sanitize hostname] 2026-01-29 09:48:50.780386 | debian-bookworm | ok 2026-01-29 09:48:50.810472 | 2026-01-29 09:48:50.810571 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 09:48:51.637400 | debian-bookworm -> localhost | changed 2026-01-29 09:48:51.643065 | 2026-01-29 09:48:51.643190 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 09:48:52.033448 | debian-bookworm | ok 2026-01-29 09:48:52.037898 | 2026-01-29 09:48:52.037992 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 09:48:52.565686 | debian-bookworm -> localhost | changed 2026-01-29 09:48:52.574586 | 2026-01-29 09:48:52.574678 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-29 09:48:52.857885 | debian-bookworm | ok 2026-01-29 09:48:52.863079 | 2026-01-29 09:48:52.863184 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-29 09:48:53.932814 | debian-bookworm | changed: 2026-01-29 09:48:53.932967 | debian-bookworm | cd+++++++++ src/ 2026-01-29 09:48:53.932995 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-29 09:48:53.933015 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-29 09:48:53.933033 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-29 09:48:53.933049 | debian-bookworm | Containerfile 2026-01-29 09:48:53.933185 | debian-bookworm | Containerfile 2026-01-29 09:48:53.949417 | debian-bookworm | 200 characters) 2026-01-29 09:49:28.194214 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/migrate.py Result: 1 2026-01-29 09:49:28.817412 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/baremetal.py Runtime: 0:00:00.365900 2026-01-29 09:49:29.250597 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/worker.py Runtime: 0:00:00.172590 2026-01-29 09:49:29.652552 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/configuration.py Runtime: 0:00:00.162806 2026-01-29 09:49:30.200239 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/manage.py Runtime: 0:00:00.310150 2026-01-29 09:49:30.683286 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/apply.py Runtime: 0:00:00.213531 2026-01-29 09:49:31.261941 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/sonic.py Runtime: 0:00:00.328656 2026-01-29 09:49:31.691204 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/lock.py Runtime: 0:00:00.171095 2026-01-29 09:49:32.086455 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/stress.py Runtime: 0:00:00.178633 2026-01-29 09:49:32.635474 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/netbox.py Runtime: 0:00:00.275925 2026-01-29 09:49:33.069096 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/commands/octavia.py Runtime: 0:00:00.167311 2026-01-29 09:49:33.510045 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/utils/ssh.py Runtime: 0:00:00.195787 2026-01-29 09:49:33.975730 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/utils/__init__.py Runtime: 0:00:00.224964 2026-01-29 09:49:34.401268 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/utils/rabbitmq.py Runtime: 0:00:00.183180 2026-01-29 09:49:34.819324 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/reconciler.py Runtime: 0:00:00.164404 2026-01-29 09:49:35.230420 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/ceph.py Runtime: 0:00:00.162256 2026-01-29 09:49:35.657199 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/kubernetes.py Runtime: 0:00:00.178152 2026-01-29 09:49:36.065626 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor.py Runtime: 0:00:00.160135 2026-01-29 09:49:36.473225 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/ansible.py Runtime: 0:00:00.166595 2026-01-29 09:49:36.943004 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/__init__.py Runtime: 0:00:00.213872 2026-01-29 09:49:37.337085 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/kolla.py Runtime: 0:00:00.163064 2026-01-29 09:49:37.820369 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/openstack.py Runtime: 0:00:00.237275 2026-01-29 09:49:38.264953 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/netbox.py Runtime: 0:00:00.201412 2026-01-29 09:49:38.729977 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/redfish.py Runtime: 0:00:00.200680 2026-01-29 09:49:39.165457 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/config.py Runtime: 0:00:00.188728 2026-01-29 09:49:39.672519 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/ironic.py Runtime: 0:00:00.257376 2026-01-29 09:49:40.091350 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/__init__.py Runtime: 0:00:00.177891 2026-01-29 09:49:40.544381 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/utils.py Runtime: 0:00:00.199402 2026-01-29 09:49:41.006892 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/netbox.py Runtime: 0:00:00.222417 2026-01-29 09:49:41.421413 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/bgp.py Runtime: 0:00:00.166098 2026-01-29 09:49:41.932114 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/connections.py Runtime: 0:00:00.241574 2026-01-29 09:49:42.393041 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/sync.py Runtime: 0:00:00.199315 2026-01-29 09:49:42.944689 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/interface.py Runtime: 0:00:00.298650 2026-01-29 09:49:43.376490 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/exporter.py Runtime: 0:00:00.187777 2026-01-29 09:49:44.031693 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/config_generator.py Runtime: 0:00:00.408806 2026-01-29 09:49:44.426554 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/__init__.py Runtime: 0:00:00.159853 2026-01-29 09:49:44.894259 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/cache.py Runtime: 0:00:00.168616 2026-01-29 09:49:45.264056 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/device.py Runtime: 0:00:00.170432 2026-01-29 09:49:45.689892 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/tasks/conductor/sonic/constants.py Runtime: 0:00:00.175113 2026-01-29 09:49:46.136029 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/services/websocket_manager.py Runtime: 0:00:00.201338 2026-01-29 09:49:46.576209 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/services/event_bridge.py Runtime: 0:00:00.193169 2026-01-29 09:49:47.040707 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/services/listener.py Runtime: 0:00:00.229303 2026-01-29 09:49:47.441332 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/osism/services/__init__.py Runtime: 0:00:00.157835 2026-01-29 09:49:47.905956 | debian-bookworm | ok: Item: src/github.com/osism/python-osism/files/redfishMockupCreate.py Runtime: 0:00:00.226156 failure 2026-01-29 09:49:47.966729 | 2026-01-29 09:49:47.966889 | PLAY RECAP 2026-01-29 09:49:47.967037 | debian-bookworm | ok: 10 changed: 6 unreachable: 0 failed: 1 skipped: 12 rescued: 0 ignored: 0 2026-01-29 09:49:47.967068 | 2026-01-29 09:49:48.157736 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/flake8/run.yaml@main] 2026-01-29 09:49:48.158659 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-29 09:49:48.867715 | 2026-01-29 09:49:48.867874 | PLAY [Base post] 2026-01-29 09:49:48.881162 | 2026-01-29 09:49:48.881287 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-29 09:49:49.484048 | debian-bookworm | changed 2026-01-29 09:49:49.494665 | 2026-01-29 09:49:49.494803 | PLAY RECAP 2026-01-29 09:49:49.494963 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-29 09:49:49.495047 | 2026-01-29 09:49:49.620023 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-29 09:49:49.621455 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-29 09:49:50.386420 | 2026-01-29 09:49:50.386586 | PLAY [Base post-logs] 2026-01-29 09:49:50.397317 | 2026-01-29 09:49:50.397454 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-29 09:49:50.849808 | localhost | changed 2026-01-29 09:49:50.860296 | 2026-01-29 09:49:50.860449 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-29 09:49:50.887518 | localhost | ok 2026-01-29 09:49:50.890559 | 2026-01-29 09:49:50.890663 | TASK [Set zuul-log-path fact] 2026-01-29 09:49:50.905248 | localhost | ok 2026-01-29 09:49:50.913081 | 2026-01-29 09:49:50.913209 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 09:49:50.948543 | localhost | ok 2026-01-29 09:49:50.953034 | 2026-01-29 09:49:50.953222 | TASK [upload-logs : Create log directories] 2026-01-29 09:49:51.462807 | localhost | changed 2026-01-29 09:49:51.468937 | 2026-01-29 09:49:51.469099 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-29 09:49:51.982744 | localhost -> localhost | ok: Runtime: 0:00:00.006811 2026-01-29 09:49:51.991731 | 2026-01-29 09:49:51.991932 | TASK [upload-logs : Upload logs to log server] 2026-01-29 09:49:52.537745 | localhost | Output suppressed because no_log was given 2026-01-29 09:49:52.540992 | 2026-01-29 09:49:52.541151 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 09:49:52.596877 | localhost | skipping: Conditional result was False 2026-01-29 09:49:52.601879 | localhost | skipping: Conditional result was False 2026-01-29 09:49:52.614571 | 2026-01-29 09:49:52.614786 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 09:49:52.660234 | localhost | skipping: Conditional result was False 2026-01-29 09:49:52.660918 | 2026-01-29 09:49:52.664236 | localhost | skipping: Conditional result was False 2026-01-29 09:49:52.678228 | 2026-01-29 09:49:52.678449 | LOOP [upload-logs : Upload console log and json output]