2025-10-25 03:15:41.961942 | Job console starting 2025-10-25 03:15:41.973354 | Updating git repos 2025-10-25 03:15:42.001140 | Cloning repos into workspace 2025-10-25 03:15:42.051975 | Restoring repo states 2025-10-25 03:15:42.055797 | Merging changes 2025-10-25 03:15:42.055809 | Checking out repos 2025-10-25 03:15:42.127819 | Preparing playbooks 2025-10-25 03:15:42.881888 | Running Ansible setup 2025-10-25 03:15:48.318769 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-25 03:15:49.129725 | 2025-10-25 03:15:49.129832 | PLAY [Base pre] 2025-10-25 03:15:49.149249 | 2025-10-25 03:15:49.149353 | TASK [Setup log path fact] 2025-10-25 03:15:49.165982 | debian-bookworm | ok 2025-10-25 03:15:49.178630 | 2025-10-25 03:15:49.178729 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-25 03:15:49.210463 | debian-bookworm | ok 2025-10-25 03:15:49.218067 | 2025-10-25 03:15:49.218155 | TASK [emit-job-header : Print job information] 2025-10-25 03:15:49.255735 | # Job Information 2025-10-25 03:15:49.255862 | Ansible Version: 2.16.14 2025-10-25 03:15:49.256760 | Job: python-black 2025-10-25 03:15:49.258186 | Pipeline: periodic-daily 2025-10-25 03:15:49.258517 | Executor: 521e9411259a 2025-10-25 03:15:49.258545 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2025-10-25 03:15:49.258564 | Event ID: 18a60238809e461597fcce3a588ec932 2025-10-25 03:15:49.262712 | 2025-10-25 03:15:49.262788 | LOOP [emit-job-header : Print node information] 2025-10-25 03:15:49.340976 | debian-bookworm | ok: 2025-10-25 03:15:49.341812 | debian-bookworm | # Node Information 2025-10-25 03:15:49.341844 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-25 03:15:49.341866 | debian-bookworm | Hostname: debian 2025-10-25 03:15:49.341886 | debian-bookworm | Username: zuul 2025-10-25 03:15:49.341904 | debian-bookworm | Distro: Debian 12.12 2025-10-25 03:15:49.341924 | debian-bookworm | Provider: regiocloud-a 2025-10-25 03:15:49.341942 | debian-bookworm | Region: 2025-10-25 03:15:49.341959 | debian-bookworm | Label: debian-bookworm 2025-10-25 03:15:49.341975 | debian-bookworm | Product Name: OpenStack Nova 2025-10-25 03:15:49.341991 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe09:d0fe 2025-10-25 03:15:49.362644 | 2025-10-25 03:15:49.362733 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-25 03:15:50.059401 | debian-bookworm -> localhost | changed 2025-10-25 03:15:50.064943 | 2025-10-25 03:15:50.065027 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-25 03:15:51.613032 | debian-bookworm -> localhost | changed 2025-10-25 03:15:51.622009 | 2025-10-25 03:15:51.622090 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-25 03:15:52.008189 | debian-bookworm -> localhost | ok 2025-10-25 03:15:52.013213 | 2025-10-25 03:15:52.013309 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-25 03:15:52.039662 | debian-bookworm | ok 2025-10-25 03:15:52.061203 | debian-bookworm | included: /var/lib/zuul/builds/6d1ef0a89fdd413baddfea48c0290017/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-25 03:15:52.073193 | 2025-10-25 03:15:52.073296 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-25 03:15:54.942883 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-25 03:15:54.943057 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6d1ef0a89fdd413baddfea48c0290017/work/6d1ef0a89fdd413baddfea48c0290017_id_rsa 2025-10-25 03:15:54.943091 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6d1ef0a89fdd413baddfea48c0290017/work/6d1ef0a89fdd413baddfea48c0290017_id_rsa.pub 2025-10-25 03:15:54.943114 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-25 03:15:54.943133 | debian-bookworm -> localhost | SHA256:fNy+iKgcOUnNKw0IAi9YsbWMFAx7TL61Xno+PYDWAg8 zuul-build-sshkey 2025-10-25 03:15:54.943152 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-25 03:15:54.943178 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-25 03:15:54.943196 | debian-bookworm -> localhost | |oo*o. | 2025-10-25 03:15:54.943214 | debian-bookworm -> localhost | |oO.= . | 2025-10-25 03:15:54.943255 | debian-bookworm -> localhost | |* B + | 2025-10-25 03:15:54.943272 | debian-bookworm -> localhost | |.+E+ + . . . | 2025-10-25 03:15:54.943289 | debian-bookworm -> localhost | | o++o+ S o . | 2025-10-25 03:15:54.943309 | debian-bookworm -> localhost | | o=Bo. . . | 2025-10-25 03:15:54.943326 | debian-bookworm -> localhost | | .O.+o . | 2025-10-25 03:15:54.943342 | debian-bookworm -> localhost | | . *..o. . . | 2025-10-25 03:15:54.943359 | debian-bookworm -> localhost | | o.o.... . | 2025-10-25 03:15:54.943376 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-25 03:15:54.943416 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.098870 2025-10-25 03:15:54.957492 | 2025-10-25 03:15:54.957578 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-25 03:15:54.988829 | debian-bookworm | ok 2025-10-25 03:15:55.010788 | debian-bookworm | included: /var/lib/zuul/builds/6d1ef0a89fdd413baddfea48c0290017/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-25 03:15:55.027317 | 2025-10-25 03:15:55.028111 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-25 03:15:55.051475 | debian-bookworm | skipping: Conditional result was False 2025-10-25 03:15:55.066662 | 2025-10-25 03:15:55.067198 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-25 03:15:55.986458 | debian-bookworm | changed 2025-10-25 03:15:55.990704 | 2025-10-25 03:15:55.990780 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-25 03:15:56.276054 | debian-bookworm | ok 2025-10-25 03:15:56.288011 | 2025-10-25 03:15:56.288116 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-25 03:15:57.012604 | debian-bookworm | changed 2025-10-25 03:15:57.022725 | 2025-10-25 03:15:57.022825 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-25 03:15:57.768514 | debian-bookworm | changed 2025-10-25 03:15:57.773973 | 2025-10-25 03:15:57.774058 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-25 03:15:57.787066 | debian-bookworm | skipping: Conditional result was False 2025-10-25 03:15:57.792582 | 2025-10-25 03:15:57.792702 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-25 03:15:58.167925 | debian-bookworm -> localhost | changed 2025-10-25 03:15:58.178453 | 2025-10-25 03:15:58.178541 | TASK [add-build-sshkey : Add back temp key] 2025-10-25 03:15:58.504595 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6d1ef0a89fdd413baddfea48c0290017/work/6d1ef0a89fdd413baddfea48c0290017_id_rsa (zuul-build-sshkey) 2025-10-25 03:15:58.504803 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008136 2025-10-25 03:15:58.513361 | 2025-10-25 03:15:58.513446 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-25 03:15:58.887397 | debian-bookworm | ok 2025-10-25 03:15:58.892468 | 2025-10-25 03:15:58.892571 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-25 03:15:58.919180 | debian-bookworm | skipping: Conditional result was False 2025-10-25 03:15:58.929144 | 2025-10-25 03:15:58.929257 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-25 03:15:59.345734 | debian-bookworm | ok 2025-10-25 03:15:59.358166 | 2025-10-25 03:15:59.358272 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-25 03:15:59.396620 | debian-bookworm | ok 2025-10-25 03:15:59.402463 | 2025-10-25 03:15:59.402546 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-25 03:15:59.723714 | debian-bookworm -> localhost | ok 2025-10-25 03:15:59.729701 | 2025-10-25 03:15:59.729796 | TASK [validate-host : Collect information about the host] 2025-10-25 03:16:00.836772 | debian-bookworm | ok 2025-10-25 03:16:00.846600 | 2025-10-25 03:16:00.846697 | TASK [validate-host : Sanitize hostname] 2025-10-25 03:16:00.925914 | debian-bookworm | ok 2025-10-25 03:16:00.952912 | 2025-10-25 03:16:00.953009 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-25 03:16:01.390141 | debian-bookworm -> localhost | changed 2025-10-25 03:16:01.395788 | 2025-10-25 03:16:01.395882 | TASK [validate-host : Collect information about zuul worker] 2025-10-25 03:16:01.804152 | debian-bookworm | ok 2025-10-25 03:16:01.811448 | 2025-10-25 03:16:01.811572 | TASK [validate-host : Write out all zuul information for each host] 2025-10-25 03:16:02.269945 | debian-bookworm -> localhost | changed 2025-10-25 03:16:02.282236 | 2025-10-25 03:16:02.282330 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-25 03:16:02.550075 | debian-bookworm | ok 2025-10-25 03:16:02.560678 | 2025-10-25 03:16:02.560805 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-25 03:16:03.347358 | debian-bookworm | changed: 2025-10-25 03:16:03.347610 | debian-bookworm | cd+++++++++ src/ 2025-10-25 03:16:03.347664 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-25 03:16:03.347703 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-25 03:16:03.347739 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2025-10-25 03:16:03.347771 | debian-bookworm | localhost | ok: Runtime: 0:00:00.026830 2025-10-25 03:16:31.175057 | 2025-10-25 03:16:31.175142 | TASK [upload-logs : Upload logs to log server] 2025-10-25 03:16:32.047583 | localhost | Output suppressed because no_log was given 2025-10-25 03:16:32.048994 | 2025-10-25 03:16:32.049068 | LOOP [upload-logs : Compress console log and json output] 2025-10-25 03:16:32.119699 | localhost | skipping: Conditional result was False 2025-10-25 03:16:32.132475 | localhost | skipping: Conditional result was False 2025-10-25 03:16:32.134935 | 2025-10-25 03:16:32.135012 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-25 03:16:32.242441 | localhost | skipping: Conditional result was False 2025-10-25 03:16:32.242651 | 2025-10-25 03:16:32.251754 | localhost | skipping: Conditional result was False 2025-10-25 03:16:32.255556 | 2025-10-25 03:16:32.255648 | LOOP [upload-logs : Upload console log and json output]