2025-11-28 14:34:07.264591 | Job console starting 2025-11-28 14:34:07.294098 | Updating git repos 2025-11-28 14:34:07.395634 | Cloning repos into workspace 2025-11-28 14:34:07.513785 | Restoring repo states 2025-11-28 14:34:07.570243 | Merging changes 2025-11-28 14:34:08.334050 | Checking out repos 2025-11-28 14:34:08.399544 | Preparing playbooks 2025-11-28 14:34:10.052229 | Running Ansible setup 2025-11-28 14:34:19.288199 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-28 14:34:21.806249 | 2025-11-28 14:34:21.806436 | PLAY [Base pre] 2025-11-28 14:34:21.872764 | 2025-11-28 14:34:21.872937 | TASK [Setup log path fact] 2025-11-28 14:34:21.896345 | debian-bookworm | ok 2025-11-28 14:34:21.924227 | 2025-11-28 14:34:21.924403 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-28 14:34:21.954749 | debian-bookworm | ok 2025-11-28 14:34:21.999964 | 2025-11-28 14:34:22.000141 | TASK [emit-job-header : Print job information] 2025-11-28 14:34:22.060281 | # Job Information 2025-11-28 14:34:22.060476 | Ansible Version: 2.16.14 2025-11-28 14:34:22.060510 | Job: python-black 2025-11-28 14:34:22.060544 | Pipeline: check 2025-11-28 14:34:22.060567 | Executor: 521e9411259a 2025-11-28 14:34:22.060588 | Triggered by: https://github.com/osism/python-osism/pull/1857 2025-11-28 14:34:22.060610 | Event ID: 462da660-cc67-11f0-85ee-72e2408f8e95 2025-11-28 14:34:22.065989 | 2025-11-28 14:34:22.066174 | LOOP [emit-job-header : Print node information] 2025-11-28 14:34:22.301106 | debian-bookworm | ok: 2025-11-28 14:34:22.302906 | debian-bookworm | # Node Information 2025-11-28 14:34:22.302986 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-28 14:34:22.303014 | debian-bookworm | Hostname: debian 2025-11-28 14:34:22.303051 | debian-bookworm | Username: zuul 2025-11-28 14:34:22.303073 | debian-bookworm | Distro: Debian 12.12 2025-11-28 14:34:22.303097 | debian-bookworm | Provider: regiocloud-a 2025-11-28 14:34:22.303119 | debian-bookworm | Region: 2025-11-28 14:34:22.303140 | debian-bookworm | Label: debian-bookworm 2025-11-28 14:34:22.303160 | debian-bookworm | Product Name: OpenStack Nova 2025-11-28 14:34:22.303180 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0f:212c 2025-11-28 14:34:22.322563 | 2025-11-28 14:34:22.322705 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-28 14:34:23.931911 | debian-bookworm -> localhost | changed 2025-11-28 14:34:23.938482 | 2025-11-28 14:34:23.938583 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-28 14:34:25.981673 | debian-bookworm -> localhost | changed 2025-11-28 14:34:25.990452 | 2025-11-28 14:34:25.990541 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-28 14:34:26.563784 | debian-bookworm -> localhost | ok 2025-11-28 14:34:26.568703 | 2025-11-28 14:34:26.568801 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-28 14:34:26.605468 | debian-bookworm | ok 2025-11-28 14:34:26.637655 | debian-bookworm | included: /var/lib/zuul/builds/fad2ebacb8f54bfd88e39871137a8183/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-28 14:34:26.648071 | 2025-11-28 14:34:26.648163 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-28 14:34:30.093619 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-28 14:34:30.093808 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fad2ebacb8f54bfd88e39871137a8183/work/fad2ebacb8f54bfd88e39871137a8183_id_rsa 2025-11-28 14:34:30.093848 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fad2ebacb8f54bfd88e39871137a8183/work/fad2ebacb8f54bfd88e39871137a8183_id_rsa.pub 2025-11-28 14:34:30.093876 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-28 14:34:30.093901 | debian-bookworm -> localhost | SHA256:9nGGuZxRF6FNa3N7LdOToMNhGCeAkqdEevvdDIQSn/E zuul-build-sshkey 2025-11-28 14:34:30.093924 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-28 14:34:30.093955 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-28 14:34:30.093978 | debian-bookworm -> localhost | | .o.....o . +. | 2025-11-28 14:34:30.094000 | debian-bookworm -> localhost | | .+oo= = + o | 2025-11-28 14:34:30.094021 | debian-bookworm -> localhost | | ..o++ E . oo.* .| 2025-11-28 14:34:30.094058 | debian-bookworm -> localhost | | ..o . o+oo.++| 2025-11-28 14:34:30.094080 | debian-bookworm -> localhost | | . .S =+o o++| 2025-11-28 14:34:30.094105 | debian-bookworm -> localhost | | . ..+o B. oo| 2025-11-28 14:34:30.094128 | debian-bookworm -> localhost | | . . o= | 2025-11-28 14:34:30.094149 | debian-bookworm -> localhost | | | 2025-11-28 14:34:30.094171 | debian-bookworm -> localhost | | | 2025-11-28 14:34:30.094193 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-28 14:34:30.094241 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.012526 2025-11-28 14:34:30.101457 | 2025-11-28 14:34:30.101570 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-28 14:34:30.150464 | debian-bookworm | ok 2025-11-28 14:34:30.157913 | debian-bookworm | included: /var/lib/zuul/builds/fad2ebacb8f54bfd88e39871137a8183/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-28 14:34:30.172589 | 2025-11-28 14:34:30.172704 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-28 14:34:30.195955 | debian-bookworm | skipping: Conditional result was False 2025-11-28 14:34:30.201553 | 2025-11-28 14:34:30.201647 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-28 14:34:30.846506 | debian-bookworm | changed 2025-11-28 14:34:30.859824 | 2025-11-28 14:34:30.859920 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-28 14:34:31.102426 | debian-bookworm | ok 2025-11-28 14:34:31.157534 | 2025-11-28 14:34:31.157698 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-28 14:34:31.818157 | debian-bookworm | changed 2025-11-28 14:34:31.825482 | 2025-11-28 14:34:31.825583 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-28 14:34:32.512365 | debian-bookworm | changed 2025-11-28 14:34:32.528698 | 2025-11-28 14:34:32.528800 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-28 14:34:32.577263 | debian-bookworm | skipping: Conditional result was False 2025-11-28 14:34:32.583057 | 2025-11-28 14:34:32.583154 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-28 14:34:33.619303 | debian-bookworm -> localhost | changed 2025-11-28 14:34:33.630101 | 2025-11-28 14:34:33.630204 | TASK [add-build-sshkey : Add back temp key] 2025-11-28 14:34:34.210467 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fad2ebacb8f54bfd88e39871137a8183/work/fad2ebacb8f54bfd88e39871137a8183_id_rsa (zuul-build-sshkey) 2025-11-28 14:34:34.210644 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015446 2025-11-28 14:34:34.216982 | 2025-11-28 14:34:34.217074 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-28 14:34:34.796267 | debian-bookworm | ok 2025-11-28 14:34:34.803742 | 2025-11-28 14:34:34.803874 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-28 14:34:34.825834 | debian-bookworm | skipping: Conditional result was False 2025-11-28 14:34:34.846306 | 2025-11-28 14:34:34.846406 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-28 14:34:35.472598 | debian-bookworm | ok 2025-11-28 14:34:35.488595 | 2025-11-28 14:34:35.488701 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-28 14:34:35.553463 | debian-bookworm | ok 2025-11-28 14:34:35.558358 | 2025-11-28 14:34:35.558450 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-28 14:34:36.190697 | debian-bookworm -> localhost | ok 2025-11-28 14:34:36.202754 | 2025-11-28 14:34:36.202868 | TASK [validate-host : Collect information about the host] 2025-11-28 14:34:37.329555 | debian-bookworm | ok 2025-11-28 14:34:37.354308 | 2025-11-28 14:34:37.354414 | TASK [validate-host : Sanitize hostname] 2025-11-28 14:34:37.476886 | debian-bookworm | ok 2025-11-28 14:34:37.518108 | 2025-11-28 14:34:37.518216 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-28 14:34:38.540992 | debian-bookworm -> localhost | changed 2025-11-28 14:34:38.546396 | 2025-11-28 14:34:38.546485 | TASK [validate-host : Collect information about zuul worker] 2025-11-28 14:34:39.149615 | debian-bookworm | ok 2025-11-28 14:34:39.154008 | 2025-11-28 14:34:39.154137 | TASK [validate-host : Write out all zuul information for each host] 2025-11-28 14:34:40.099799 | debian-bookworm -> localhost | changed 2025-11-28 14:34:40.113216 | 2025-11-28 14:34:40.113371 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-28 14:34:40.389516 | debian-bookworm | ok 2025-11-28 14:34:40.394623 | 2025-11-28 14:34:40.394715 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-28 14:34:41.859513 | debian-bookworm | changed: 2025-11-28 14:34:41.859685 | debian-bookworm | cd+++++++++ src/ 2025-11-28 14:34:41.859719 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-28 14:34:41.859742 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-28 14:34:41.859764 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-28 14:34:41.859784 | debian-bookworm | Containerfile 2025-11-28 14:34:41.859892 | debian-bookworm | Containerfile 2025-11-28 14:34:41.899253 | debian-bookworm | localhost | ok: Runtime: 0:00:00.022171 2025-11-28 14:35:15.415906 | 2025-11-28 14:35:15.416013 | TASK [upload-logs : Upload logs to log server] 2025-11-28 14:35:16.532337 | localhost | Output suppressed because no_log was given 2025-11-28 14:35:16.533803 | 2025-11-28 14:35:16.533880 | LOOP [upload-logs : Compress console log and json output] 2025-11-28 14:35:16.672334 | localhost | skipping: Conditional result was False 2025-11-28 14:35:16.696838 | localhost | skipping: Conditional result was False 2025-11-28 14:35:16.702369 | 2025-11-28 14:35:16.702490 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-28 14:35:16.796379 | localhost | skipping: Conditional result was False 2025-11-28 14:35:16.796614 | 2025-11-28 14:35:16.830270 | localhost | skipping: Conditional result was False 2025-11-28 14:35:16.841028 | 2025-11-28 14:35:16.841123 | LOOP [upload-logs : Upload console log and json output]