2025-09-28 03:01:35.902071 | Job console starting 2025-09-28 03:01:35.919004 | Updating git repos 2025-09-28 03:01:35.947416 | Cloning repos into workspace 2025-09-28 03:01:36.022476 | Restoring repo states 2025-09-28 03:01:36.044462 | Merging changes 2025-09-28 03:01:36.044475 | Checking out repos 2025-09-28 03:01:36.143397 | Preparing playbooks 2025-09-28 03:01:37.636093 | Running Ansible setup 2025-09-28 03:01:43.463879 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-28 03:01:44.719970 | 2025-09-28 03:01:44.720111 | PLAY [Base pre] 2025-09-28 03:01:44.744935 | 2025-09-28 03:01:44.745053 | TASK [Setup log path fact] 2025-09-28 03:01:44.772856 | debian-bookworm | ok 2025-09-28 03:01:44.797398 | 2025-09-28 03:01:44.797520 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 03:01:44.855950 | debian-bookworm | ok 2025-09-28 03:01:44.871197 | 2025-09-28 03:01:44.871303 | TASK [emit-job-header : Print job information] 2025-09-28 03:01:44.957964 | # Job Information 2025-09-28 03:01:44.958122 | Ansible Version: 2.16.14 2025-09-28 03:01:44.958158 | Job: python-black 2025-09-28 03:01:44.958190 | Pipeline: periodic-daily 2025-09-28 03:01:44.958214 | Executor: 521e9411259a 2025-09-28 03:01:44.958234 | Triggered by: https://github.com/osism/netbox-manager 2025-09-28 03:01:44.958255 | Event ID: 129acb713eaf474db00548bdd157e9de 2025-09-28 03:01:44.963016 | 2025-09-28 03:01:44.963111 | LOOP [emit-job-header : Print node information] 2025-09-28 03:01:45.137911 | debian-bookworm | ok: 2025-09-28 03:01:45.138072 | debian-bookworm | # Node Information 2025-09-28 03:01:45.138104 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-28 03:01:45.138129 | debian-bookworm | Hostname: debian 2025-09-28 03:01:45.138151 | debian-bookworm | Username: zuul 2025-09-28 03:01:45.138172 | debian-bookworm | Distro: Debian 12.12 2025-09-28 03:01:45.138196 | debian-bookworm | Provider: regiocloud-a 2025-09-28 03:01:45.138217 | debian-bookworm | Region: 2025-09-28 03:01:45.138238 | debian-bookworm | Label: debian-bookworm 2025-09-28 03:01:45.138259 | debian-bookworm | Product Name: OpenStack Nova 2025-09-28 03:01:45.138279 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2a:78e7 2025-09-28 03:01:45.150425 | 2025-09-28 03:01:45.150526 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-28 03:01:45.805938 | debian-bookworm -> localhost | changed 2025-09-28 03:01:45.812757 | 2025-09-28 03:01:45.812864 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-28 03:01:47.287264 | debian-bookworm -> localhost | changed 2025-09-28 03:01:47.298916 | 2025-09-28 03:01:47.299010 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-28 03:01:47.882348 | debian-bookworm -> localhost | ok 2025-09-28 03:01:47.887320 | 2025-09-28 03:01:47.887402 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-28 03:01:47.923816 | debian-bookworm | ok 2025-09-28 03:01:47.947682 | debian-bookworm | included: /var/lib/zuul/builds/6ab2a33402014765b21d80def87788c2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-28 03:01:47.952458 | 2025-09-28 03:01:47.952534 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-28 03:01:49.501669 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-28 03:01:49.502005 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6ab2a33402014765b21d80def87788c2/work/6ab2a33402014765b21d80def87788c2_id_rsa 2025-09-28 03:01:49.502084 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6ab2a33402014765b21d80def87788c2/work/6ab2a33402014765b21d80def87788c2_id_rsa.pub 2025-09-28 03:01:49.502113 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-28 03:01:49.502138 | debian-bookworm -> localhost | SHA256:6tSxOVYMY4H9c5MK8g8f5olqYNc+LRGUZ10C16Wp/q8 zuul-build-sshkey 2025-09-28 03:01:49.502162 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-28 03:01:49.502192 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-28 03:01:49.502214 | debian-bookworm -> localhost | | o...ooo...| 2025-09-28 03:01:49.502236 | debian-bookworm -> localhost | | . +.o....o | 2025-09-28 03:01:49.502257 | debian-bookworm -> localhost | | .++ .o | 2025-09-28 03:01:49.502277 | debian-bookworm -> localhost | | ..o+o +. | 2025-09-28 03:01:49.502297 | debian-bookworm -> localhost | | +Soo+.. | 2025-09-28 03:01:49.502321 | debian-bookworm -> localhost | | o .o==+. | 2025-09-28 03:01:49.502341 | debian-bookworm -> localhost | | . oo.*X o. | 2025-09-28 03:01:49.502360 | debian-bookworm -> localhost | | o..=.* . | 2025-09-28 03:01:49.502381 | debian-bookworm -> localhost | | .o. o Eo.| 2025-09-28 03:01:49.502402 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-28 03:01:49.502449 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.921147 2025-09-28 03:01:49.509333 | 2025-09-28 03:01:49.509413 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-28 03:01:49.573307 | debian-bookworm | ok 2025-09-28 03:01:49.600346 | debian-bookworm | included: /var/lib/zuul/builds/6ab2a33402014765b21d80def87788c2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-28 03:01:49.627642 | 2025-09-28 03:01:49.628097 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-28 03:01:49.688250 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:01:49.695163 | 2025-09-28 03:01:49.695255 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-28 03:01:50.466444 | debian-bookworm | changed 2025-09-28 03:01:50.476527 | 2025-09-28 03:01:50.476622 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-28 03:01:50.773189 | debian-bookworm | ok 2025-09-28 03:01:50.784708 | 2025-09-28 03:01:50.785366 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-28 03:01:51.479245 | debian-bookworm | changed 2025-09-28 03:01:51.489696 | 2025-09-28 03:01:51.489803 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-28 03:01:52.295277 | debian-bookworm | changed 2025-09-28 03:01:52.300980 | 2025-09-28 03:01:52.301073 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-28 03:01:52.335596 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:01:52.341495 | 2025-09-28 03:01:52.341593 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-28 03:01:53.085106 | debian-bookworm -> localhost | changed 2025-09-28 03:01:53.095312 | 2025-09-28 03:01:53.095416 | TASK [add-build-sshkey : Add back temp key] 2025-09-28 03:01:53.362433 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6ab2a33402014765b21d80def87788c2/work/6ab2a33402014765b21d80def87788c2_id_rsa (zuul-build-sshkey) 2025-09-28 03:01:53.362713 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011795 2025-09-28 03:01:53.372121 | 2025-09-28 03:01:53.372219 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-28 03:01:53.713864 | debian-bookworm | ok 2025-09-28 03:01:53.717978 | 2025-09-28 03:01:53.718058 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-28 03:01:53.743842 | debian-bookworm | skipping: Conditional result was False 2025-09-28 03:01:53.754378 | 2025-09-28 03:01:53.754460 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-28 03:01:54.214805 | debian-bookworm | ok 2025-09-28 03:01:54.229447 | 2025-09-28 03:01:54.229538 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-28 03:01:54.281488 | debian-bookworm | ok 2025-09-28 03:01:54.285525 | 2025-09-28 03:01:54.285598 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-28 03:01:55.154127 | debian-bookworm -> localhost | ok 2025-09-28 03:01:55.164488 | 2025-09-28 03:01:55.164573 | TASK [validate-host : Collect information about the host] 2025-09-28 03:01:56.265906 | debian-bookworm | ok 2025-09-28 03:01:56.276047 | 2025-09-28 03:01:56.276132 | TASK [validate-host : Sanitize hostname] 2025-09-28 03:01:56.458615 | debian-bookworm | ok 2025-09-28 03:01:56.517984 | 2025-09-28 03:01:56.518080 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-28 03:01:57.865027 | debian-bookworm -> localhost | changed 2025-09-28 03:01:57.869568 | 2025-09-28 03:01:57.869647 | TASK [validate-host : Collect information about zuul worker] 2025-09-28 03:01:58.602237 | debian-bookworm | ok 2025-09-28 03:01:58.606221 | 2025-09-28 03:01:58.606302 | TASK [validate-host : Write out all zuul information for each host] 2025-09-28 03:02:00.284271 | debian-bookworm -> localhost | changed 2025-09-28 03:02:00.292034 | 2025-09-28 03:02:00.292122 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-28 03:02:00.634334 | debian-bookworm | ok 2025-09-28 03:02:00.640291 | 2025-09-28 03:02:00.640379 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-28 03:02:02.586358 | debian-bookworm | changed: 2025-09-28 03:02:02.586535 | debian-bookworm | cd+++++++++ src/ 2025-09-28 03:02:02.586570 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-28 03:02:02.586594 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-28 03:02:02.586616 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-manager/ 2025-09-28 03:02:02.586691 | debian-bookworm | netbox_manager/requirements.yml 2025-09-28 03:02:02.586987 | debian-bookworm | cL+++++++++ src/github.com/osism/netbox-manager/settings.toml.sample -> netbox_manager/settings.toml.sample 2025-09-28 03:02:02.587006 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-manager/.git/ 2025-09-28 03:02:02.587024 | debian-bookworm | localhost | ok: Runtime: 0:00:00.027540 2025-09-28 03:02:35.162883 | 2025-09-28 03:02:35.162970 | TASK [upload-logs : Upload logs to log server] 2025-09-28 03:02:36.752319 | localhost | Output suppressed because no_log was given 2025-09-28 03:02:36.753763 | 2025-09-28 03:02:36.753843 | LOOP [upload-logs : Compress console log and json output] 2025-09-28 03:02:36.909834 | localhost | skipping: Conditional result was False 2025-09-28 03:02:36.936534 | localhost | skipping: Conditional result was False 2025-09-28 03:02:36.943531 | 2025-09-28 03:02:36.943620 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-28 03:02:37.073984 | localhost | skipping: Conditional result was False 2025-09-28 03:02:37.074200 | 2025-09-28 03:02:37.101485 | localhost | skipping: Conditional result was False 2025-09-28 03:02:37.109628 | 2025-09-28 03:02:37.109746 | LOOP [upload-logs : Upload console log and json output]