2025-09-23 03:04:47.863302 | Job console starting 2025-09-23 03:04:47.883853 | Updating git repos 2025-09-23 03:04:47.945745 | Cloning repos into workspace 2025-09-23 03:04:48.047274 | Restoring repo states 2025-09-23 03:04:48.079521 | Merging changes 2025-09-23 03:04:48.079565 | Checking out repos 2025-09-23 03:04:48.153553 | Preparing playbooks 2025-09-23 03:04:48.947469 | Running Ansible setup 2025-09-23 03:04:53.885991 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-23 03:04:54.666957 | 2025-09-23 03:04:54.667080 | PLAY [Base pre] 2025-09-23 03:04:54.700935 | 2025-09-23 03:04:54.701057 | TASK [Setup log path fact] 2025-09-23 03:04:54.729923 | debian-bookworm | ok 2025-09-23 03:04:54.754502 | 2025-09-23 03:04:54.754650 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-23 03:04:54.803928 | debian-bookworm | ok 2025-09-23 03:04:54.817593 | 2025-09-23 03:04:54.817699 | TASK [emit-job-header : Print job information] 2025-09-23 03:04:54.855625 | # Job Information 2025-09-23 03:04:54.855774 | Ansible Version: 2.16.14 2025-09-23 03:04:54.855808 | Job: python-black 2025-09-23 03:04:54.855839 | Pipeline: periodic-daily 2025-09-23 03:04:54.855863 | Executor: 521e9411259a 2025-09-23 03:04:54.855884 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2025-09-23 03:04:54.855907 | Event ID: 57185ea1110348eb97e2695e4151599f 2025-09-23 03:04:54.860509 | 2025-09-23 03:04:54.860608 | LOOP [emit-job-header : Print node information] 2025-09-23 03:04:54.962707 | debian-bookworm | ok: 2025-09-23 03:04:54.963023 | debian-bookworm | # Node Information 2025-09-23 03:04:54.963071 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-23 03:04:54.963098 | debian-bookworm | Hostname: debian 2025-09-23 03:04:54.963122 | debian-bookworm | Username: zuul 2025-09-23 03:04:54.963144 | debian-bookworm | Distro: Debian 12.12 2025-09-23 03:04:54.963169 | debian-bookworm | Provider: regiocloud-a 2025-09-23 03:04:54.963191 | debian-bookworm | Region: 2025-09-23 03:04:54.963214 | debian-bookworm | Label: debian-bookworm 2025-09-23 03:04:54.963234 | debian-bookworm | Product Name: OpenStack Nova 2025-09-23 03:04:54.963253 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb0:95e2 2025-09-23 03:04:54.974352 | 2025-09-23 03:04:54.974459 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-23 03:04:55.514495 | debian-bookworm -> localhost | changed 2025-09-23 03:04:55.521350 | 2025-09-23 03:04:55.521452 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-23 03:04:56.590905 | debian-bookworm -> localhost | changed 2025-09-23 03:04:56.602548 | 2025-09-23 03:04:56.602656 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-23 03:04:56.900340 | debian-bookworm -> localhost | ok 2025-09-23 03:04:56.906193 | 2025-09-23 03:04:56.906292 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-23 03:04:56.924408 | debian-bookworm | ok 2025-09-23 03:04:56.942454 | debian-bookworm | included: /var/lib/zuul/builds/26f4e7f9487748e388c161cc69483c7e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-23 03:04:56.948175 | 2025-09-23 03:04:56.948269 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-23 03:04:57.993890 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-23 03:04:57.994079 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/26f4e7f9487748e388c161cc69483c7e/work/26f4e7f9487748e388c161cc69483c7e_id_rsa 2025-09-23 03:04:57.994117 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/26f4e7f9487748e388c161cc69483c7e/work/26f4e7f9487748e388c161cc69483c7e_id_rsa.pub 2025-09-23 03:04:57.994144 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-23 03:04:57.994171 | debian-bookworm -> localhost | SHA256:kSWaw5CSU475WmAWnp1Crbf/t2Q1Oef+0sF+5A8Nwn4 zuul-build-sshkey 2025-09-23 03:04:57.994193 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-23 03:04:57.994223 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-23 03:04:57.994245 | debian-bookworm -> localhost | | o+o. . . | 2025-09-23 03:04:57.994267 | debian-bookworm -> localhost | | o+Bo+ o + | 2025-09-23 03:04:57.994287 | debian-bookworm -> localhost | | X++ = o | 2025-09-23 03:04:57.994308 | debian-bookworm -> localhost | | o.+. . . . . | 2025-09-23 03:04:57.994328 | debian-bookworm -> localhost | | .o. S B + | 2025-09-23 03:04:57.994352 | debian-bookworm -> localhost | | o. o * =.| 2025-09-23 03:04:57.994372 | debian-bookworm -> localhost | | . . o . E+o| 2025-09-23 03:04:57.994392 | debian-bookworm -> localhost | | . o. o.o+| 2025-09-23 03:04:57.994412 | debian-bookworm -> localhost | | ..... .o=| 2025-09-23 03:04:57.994432 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-23 03:04:57.994485 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.449638 2025-09-23 03:04:58.000651 | 2025-09-23 03:04:58.000746 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-23 03:04:58.029732 | debian-bookworm | ok 2025-09-23 03:04:58.042901 | debian-bookworm | included: /var/lib/zuul/builds/26f4e7f9487748e388c161cc69483c7e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-23 03:04:58.058320 | 2025-09-23 03:04:58.058419 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-23 03:04:58.085266 | debian-bookworm | skipping: Conditional result was False 2025-09-23 03:04:58.090870 | 2025-09-23 03:04:58.090964 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-23 03:04:59.023143 | debian-bookworm | changed 2025-09-23 03:04:59.035001 | 2025-09-23 03:04:59.035133 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-23 03:04:59.327592 | debian-bookworm | ok 2025-09-23 03:04:59.339505 | 2025-09-23 03:04:59.339633 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-23 03:05:00.049979 | debian-bookworm | changed 2025-09-23 03:05:00.058965 | 2025-09-23 03:05:00.059066 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-23 03:05:00.715935 | debian-bookworm | changed 2025-09-23 03:05:00.721214 | 2025-09-23 03:05:00.721303 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-23 03:05:00.734564 | debian-bookworm | skipping: Conditional result was False 2025-09-23 03:05:00.741176 | 2025-09-23 03:05:00.741277 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-23 03:05:01.256207 | debian-bookworm -> localhost | changed 2025-09-23 03:05:01.267574 | 2025-09-23 03:05:01.267678 | TASK [add-build-sshkey : Add back temp key] 2025-09-23 03:05:01.646019 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/26f4e7f9487748e388c161cc69483c7e/work/26f4e7f9487748e388c161cc69483c7e_id_rsa (zuul-build-sshkey) 2025-09-23 03:05:01.646295 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018397 2025-09-23 03:05:01.654794 | 2025-09-23 03:05:01.654947 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-23 03:05:02.090400 | debian-bookworm | ok 2025-09-23 03:05:02.098197 | 2025-09-23 03:05:02.098325 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-23 03:05:02.122744 | debian-bookworm | skipping: Conditional result was False 2025-09-23 03:05:02.137299 | 2025-09-23 03:05:02.137420 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-23 03:05:02.519831 | debian-bookworm | ok 2025-09-23 03:05:02.529924 | 2025-09-23 03:05:02.530017 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-23 03:05:02.558017 | debian-bookworm | ok 2025-09-23 03:05:02.563272 | 2025-09-23 03:05:02.563359 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-23 03:05:02.818272 | debian-bookworm -> localhost | ok 2025-09-23 03:05:02.824391 | 2025-09-23 03:05:02.824487 | TASK [validate-host : Collect information about the host] 2025-09-23 03:05:03.883759 | debian-bookworm | ok 2025-09-23 03:05:03.893553 | 2025-09-23 03:05:03.893647 | TASK [validate-host : Sanitize hostname] 2025-09-23 03:05:03.972114 | debian-bookworm | ok 2025-09-23 03:05:04.001126 | 2025-09-23 03:05:04.001220 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-23 03:05:04.775168 | debian-bookworm -> localhost | changed 2025-09-23 03:05:04.784973 | 2025-09-23 03:05:04.785111 | TASK [validate-host : Collect information about zuul worker] 2025-09-23 03:05:05.241618 | debian-bookworm | ok 2025-09-23 03:05:05.246568 | 2025-09-23 03:05:05.246686 | TASK [validate-host : Write out all zuul information for each host] 2025-09-23 03:05:05.813717 | debian-bookworm -> localhost | changed 2025-09-23 03:05:05.824629 | 2025-09-23 03:05:05.824749 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-23 03:05:06.114945 | debian-bookworm | ok 2025-09-23 03:05:06.123737 | 2025-09-23 03:05:06.123870 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-23 03:05:06.881634 | debian-bookworm | changed: 2025-09-23 03:05:06.881850 | debian-bookworm | cd+++++++++ src/ 2025-09-23 03:05:06.881888 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-23 03:05:06.881915 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-23 03:05:06.881940 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2025-09-23 03:05:06.881962 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009658 2025-09-23 03:05:34.013551 | 2025-09-23 03:05:34.013666 | TASK [upload-logs : Upload logs to log server] 2025-09-23 03:05:34.609796 | localhost | Output suppressed because no_log was given 2025-09-23 03:05:34.620049 | 2025-09-23 03:05:34.620242 | LOOP [upload-logs : Compress console log and json output] 2025-09-23 03:05:34.671205 | localhost | skipping: Conditional result was False 2025-09-23 03:05:34.677113 | localhost | skipping: Conditional result was False 2025-09-23 03:05:34.689192 | 2025-09-23 03:05:34.689316 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-23 03:05:34.735396 | localhost | skipping: Conditional result was False 2025-09-23 03:05:34.735669 | 2025-09-23 03:05:34.742170 | localhost | skipping: Conditional result was False 2025-09-23 03:05:34.747114 | 2025-09-23 03:05:34.747332 | LOOP [upload-logs : Upload console log and json output]