2025-10-29 03:09:32.636977 | Job console starting 2025-10-29 03:09:32.669257 | Updating git repos 2025-10-29 03:09:32.719089 | Cloning repos into workspace 2025-10-29 03:09:32.815064 | Restoring repo states 2025-10-29 03:09:32.846392 | Merging changes 2025-10-29 03:09:32.846412 | Checking out repos 2025-10-29 03:09:32.922211 | Preparing playbooks 2025-10-29 03:09:34.315864 | Running Ansible setup 2025-10-29 03:09:39.148601 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-29 03:09:39.972759 | 2025-10-29 03:09:39.972961 | PLAY [Base pre] 2025-10-29 03:09:39.997504 | 2025-10-29 03:09:39.997649 | TASK [Setup log path fact] 2025-10-29 03:09:40.029189 | debian-bookworm | ok 2025-10-29 03:09:40.045438 | 2025-10-29 03:09:40.045614 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-29 03:09:40.077339 | debian-bookworm | ok 2025-10-29 03:09:40.090558 | 2025-10-29 03:09:40.090678 | TASK [emit-job-header : Print job information] 2025-10-29 03:09:40.129505 | # Job Information 2025-10-29 03:09:40.129685 | Ansible Version: 2.16.14 2025-10-29 03:09:40.129722 | Job: python-black 2025-10-29 03:09:40.129755 | Pipeline: periodic-daily 2025-10-29 03:09:40.129778 | Executor: 521e9411259a 2025-10-29 03:09:40.129799 | Triggered by: https://github.com/osism/openstack-image-manager 2025-10-29 03:09:40.129821 | Event ID: 1878df9d509349edb98817cc5f395934 2025-10-29 03:09:40.134750 | 2025-10-29 03:09:40.147009 | LOOP [emit-job-header : Print node information] 2025-10-29 03:09:40.344503 | debian-bookworm | ok: 2025-10-29 03:09:40.344772 | debian-bookworm | # Node Information 2025-10-29 03:09:40.344807 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-29 03:09:40.344835 | debian-bookworm | Hostname: debian 2025-10-29 03:09:40.344875 | debian-bookworm | Username: zuul 2025-10-29 03:09:40.344896 | debian-bookworm | Distro: Debian 12.12 2025-10-29 03:09:40.344966 | debian-bookworm | Provider: regiocloud-a 2025-10-29 03:09:40.344989 | debian-bookworm | Region: 2025-10-29 03:09:40.345010 | debian-bookworm | Label: debian-bookworm 2025-10-29 03:09:40.345030 | debian-bookworm | Product Name: OpenStack Nova 2025-10-29 03:09:40.345050 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7a:b44e 2025-10-29 03:09:40.359021 | 2025-10-29 03:09:40.359189 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-29 03:09:41.019249 | debian-bookworm -> localhost | changed 2025-10-29 03:09:41.027134 | 2025-10-29 03:09:41.027284 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-29 03:09:42.252431 | debian-bookworm -> localhost | changed 2025-10-29 03:09:42.263591 | 2025-10-29 03:09:42.263706 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-29 03:09:42.535837 | debian-bookworm -> localhost | ok 2025-10-29 03:09:42.542366 | 2025-10-29 03:09:42.542480 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-29 03:09:42.571571 | debian-bookworm | ok 2025-10-29 03:09:42.591579 | debian-bookworm | included: /var/lib/zuul/builds/d8bb9c58287e499ba0ab9c33a518b1ef/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-29 03:09:42.597766 | 2025-10-29 03:09:42.597864 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-29 03:09:44.038463 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-29 03:09:44.038709 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d8bb9c58287e499ba0ab9c33a518b1ef/work/d8bb9c58287e499ba0ab9c33a518b1ef_id_rsa 2025-10-29 03:09:44.038749 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d8bb9c58287e499ba0ab9c33a518b1ef/work/d8bb9c58287e499ba0ab9c33a518b1ef_id_rsa.pub 2025-10-29 03:09:44.038776 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-29 03:09:44.038801 | debian-bookworm -> localhost | SHA256:IEmaqW/QE7o/PAZdEylCaXbya9YHmWxypEkkR33y/nc zuul-build-sshkey 2025-10-29 03:09:44.038825 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-29 03:09:44.038881 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-29 03:09:44.038942 | debian-bookworm -> localhost | |.o++o. | 2025-10-29 03:09:44.038966 | debian-bookworm -> localhost | |.=+Bo= . | 2025-10-29 03:09:44.038987 | debian-bookworm -> localhost | |o.X.B.B | 2025-10-29 03:09:44.039007 | debian-bookworm -> localhost | | + *oO o | 2025-10-29 03:09:44.039027 | debian-bookworm -> localhost | |+.o.*.o S | 2025-10-29 03:09:44.039050 | debian-bookworm -> localhost | |.+.= . o | 2025-10-29 03:09:44.039071 | debian-bookworm -> localhost | |.o= . . | 2025-10-29 03:09:44.039091 | debian-bookworm -> localhost | | o= . . E | 2025-10-29 03:09:44.039112 | debian-bookworm -> localhost | | ..o . . | 2025-10-29 03:09:44.039132 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-29 03:09:44.039193 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.843234 2025-10-29 03:09:44.047018 | 2025-10-29 03:09:44.047131 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-29 03:09:44.082647 | debian-bookworm | ok 2025-10-29 03:09:44.096333 | debian-bookworm | included: /var/lib/zuul/builds/d8bb9c58287e499ba0ab9c33a518b1ef/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-29 03:09:44.108673 | 2025-10-29 03:09:44.108797 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-29 03:09:44.134057 | debian-bookworm | skipping: Conditional result was False 2025-10-29 03:09:44.147180 | 2025-10-29 03:09:44.147368 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-29 03:09:44.905834 | debian-bookworm | changed 2025-10-29 03:09:44.913138 | 2025-10-29 03:09:44.913255 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-29 03:09:45.177677 | debian-bookworm | ok 2025-10-29 03:09:45.191318 | 2025-10-29 03:09:45.191435 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-29 03:09:46.052495 | debian-bookworm | changed 2025-10-29 03:09:46.068282 | 2025-10-29 03:09:46.068424 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-29 03:09:46.731961 | debian-bookworm | changed 2025-10-29 03:09:46.744260 | 2025-10-29 03:09:46.744410 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-29 03:09:46.803944 | debian-bookworm | skipping: Conditional result was False 2025-10-29 03:09:46.815860 | 2025-10-29 03:09:46.816024 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-29 03:09:47.490415 | debian-bookworm -> localhost | changed 2025-10-29 03:09:47.501482 | 2025-10-29 03:09:47.501592 | TASK [add-build-sshkey : Add back temp key] 2025-10-29 03:09:47.808829 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d8bb9c58287e499ba0ab9c33a518b1ef/work/d8bb9c58287e499ba0ab9c33a518b1ef_id_rsa (zuul-build-sshkey) 2025-10-29 03:09:47.809133 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011074 2025-10-29 03:09:47.819086 | 2025-10-29 03:09:47.819199 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-29 03:09:48.287299 | debian-bookworm | ok 2025-10-29 03:09:48.294785 | 2025-10-29 03:09:48.294996 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-29 03:09:48.329655 | debian-bookworm | skipping: Conditional result was False 2025-10-29 03:09:48.351315 | 2025-10-29 03:09:48.351458 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-29 03:09:48.850040 | debian-bookworm | ok 2025-10-29 03:09:48.861368 | 2025-10-29 03:09:48.861479 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-29 03:09:48.901956 | debian-bookworm | ok 2025-10-29 03:09:48.909681 | 2025-10-29 03:09:48.909811 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-29 03:09:49.230001 | debian-bookworm -> localhost | ok 2025-10-29 03:09:49.238731 | 2025-10-29 03:09:49.238971 | TASK [validate-host : Collect information about the host] 2025-10-29 03:09:50.431732 | debian-bookworm | ok 2025-10-29 03:09:50.445421 | 2025-10-29 03:09:50.445555 | TASK [validate-host : Sanitize hostname] 2025-10-29 03:09:50.565824 | debian-bookworm | ok 2025-10-29 03:09:50.614870 | 2025-10-29 03:09:50.615046 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-29 03:09:51.229187 | debian-bookworm -> localhost | changed 2025-10-29 03:09:51.235471 | 2025-10-29 03:09:51.235597 | TASK [validate-host : Collect information about zuul worker] 2025-10-29 03:09:51.709986 | debian-bookworm | ok 2025-10-29 03:09:51.715640 | 2025-10-29 03:09:51.715753 | TASK [validate-host : Write out all zuul information for each host] 2025-10-29 03:09:52.412468 | debian-bookworm -> localhost | changed 2025-10-29 03:09:52.426993 | 2025-10-29 03:09:52.427141 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-29 03:09:52.716816 | debian-bookworm | ok 2025-10-29 03:09:52.724448 | 2025-10-29 03:09:52.724559 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-29 03:09:53.932166 | debian-bookworm | changed: 2025-10-29 03:09:53.932378 | debian-bookworm | cd+++++++++ src/ 2025-10-29 03:09:53.932413 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-29 03:09:53.932438 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-29 03:09:53.932461 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-29 03:09:53.932482 | debian-bookworm | localhost | ok: Runtime: 0:00:00.016596 2025-10-29 03:10:21.915191 | 2025-10-29 03:10:21.915281 | TASK [upload-logs : Upload logs to log server] 2025-10-29 03:10:22.339331 | localhost | Output suppressed because no_log was given 2025-10-29 03:10:22.340654 | 2025-10-29 03:10:22.340728 | LOOP [upload-logs : Compress console log and json output] 2025-10-29 03:10:22.375735 | localhost | skipping: Conditional result was False 2025-10-29 03:10:22.382572 | localhost | skipping: Conditional result was False 2025-10-29 03:10:22.386138 | 2025-10-29 03:10:22.386238 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-29 03:10:22.420003 | localhost | skipping: Conditional result was False 2025-10-29 03:10:22.420229 | 2025-10-29 03:10:22.425347 | localhost | skipping: Conditional result was False 2025-10-29 03:10:22.436319 | 2025-10-29 03:10:22.436527 | LOOP [upload-logs : Upload console log and json output]