2025-10-02 03:07:27.767616 | Job console starting 2025-10-02 03:07:27.786067 | Updating git repos 2025-10-02 03:07:27.809820 | Cloning repos into workspace 2025-10-02 03:07:27.853550 | Restoring repo states 2025-10-02 03:07:27.863632 | Merging changes 2025-10-02 03:07:27.863651 | Checking out repos 2025-10-02 03:07:27.906098 | Preparing playbooks 2025-10-02 03:07:28.852661 | Running Ansible setup 2025-10-02 03:07:34.666860 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-02 03:07:35.536510 | 2025-10-02 03:07:35.536671 | PLAY [Base pre] 2025-10-02 03:07:35.568312 | 2025-10-02 03:07:35.568537 | TASK [Setup log path fact] 2025-10-02 03:07:35.611402 | debian-bookworm | ok 2025-10-02 03:07:35.644916 | 2025-10-02 03:07:35.645875 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-02 03:07:35.679737 | debian-bookworm | ok 2025-10-02 03:07:35.693009 | 2025-10-02 03:07:35.693127 | TASK [emit-job-header : Print job information] 2025-10-02 03:07:35.781598 | # Job Information 2025-10-02 03:07:35.781786 | Ansible Version: 2.16.14 2025-10-02 03:07:35.781821 | Job: python-black 2025-10-02 03:07:35.781852 | Pipeline: periodic-daily 2025-10-02 03:07:35.781874 | Executor: 521e9411259a 2025-10-02 03:07:35.781895 | Triggered by: https://github.com/osism/openstack-project-manager 2025-10-02 03:07:35.781917 | Event ID: 4fd496163f7e4d1686e1b764b6054cd9 2025-10-02 03:07:35.786936 | 2025-10-02 03:07:35.787068 | LOOP [emit-job-header : Print node information] 2025-10-02 03:07:36.017213 | debian-bookworm | ok: 2025-10-02 03:07:36.017486 | debian-bookworm | # Node Information 2025-10-02 03:07:36.017526 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-02 03:07:36.017552 | debian-bookworm | Hostname: debian 2025-10-02 03:07:36.017575 | debian-bookworm | Username: zuul 2025-10-02 03:07:36.017595 | debian-bookworm | Distro: Debian 12.12 2025-10-02 03:07:36.017619 | debian-bookworm | Provider: regiocloud-a 2025-10-02 03:07:36.017640 | debian-bookworm | Region: 2025-10-02 03:07:36.017661 | debian-bookworm | Label: debian-bookworm 2025-10-02 03:07:36.017682 | debian-bookworm | Product Name: OpenStack Nova 2025-10-02 03:07:36.017702 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0b:3c48 2025-10-02 03:07:36.038555 | 2025-10-02 03:07:36.038693 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-02 03:07:36.784861 | debian-bookworm -> localhost | changed 2025-10-02 03:07:36.803213 | 2025-10-02 03:07:36.803572 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-02 03:07:38.934372 | debian-bookworm -> localhost | changed 2025-10-02 03:07:38.951564 | 2025-10-02 03:07:38.951675 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-02 03:07:39.430621 | debian-bookworm -> localhost | ok 2025-10-02 03:07:39.436484 | 2025-10-02 03:07:39.436688 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-02 03:07:39.466609 | debian-bookworm | ok 2025-10-02 03:07:39.488855 | debian-bookworm | included: /var/lib/zuul/builds/1d1fb328e946479c86203f069d07bf11/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-02 03:07:39.501604 | 2025-10-02 03:07:39.501701 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-02 03:07:41.945442 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-02 03:07:41.945613 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1d1fb328e946479c86203f069d07bf11/work/1d1fb328e946479c86203f069d07bf11_id_rsa 2025-10-02 03:07:41.945645 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1d1fb328e946479c86203f069d07bf11/work/1d1fb328e946479c86203f069d07bf11_id_rsa.pub 2025-10-02 03:07:41.945666 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-02 03:07:41.945685 | debian-bookworm -> localhost | SHA256:opiNr5F4awRhdWcxfcl7fpRXwQf1jlL0kPr9AkqXNIo zuul-build-sshkey 2025-10-02 03:07:41.945703 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-02 03:07:41.945729 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-02 03:07:41.945747 | debian-bookworm -> localhost | | .. . =o . . ==o| 2025-10-02 03:07:41.945764 | debian-bookworm -> localhost | |.. . o .. + ..++| 2025-10-02 03:07:41.945780 | debian-bookworm -> localhost | |.. . ... *| 2025-10-02 03:07:41.945797 | debian-bookworm -> localhost | |. .+o =.| 2025-10-02 03:07:41.945813 | debian-bookworm -> localhost | | . . S. o++o.o| 2025-10-02 03:07:41.945834 | debian-bookworm -> localhost | | ..* . .E o +o...| 2025-10-02 03:07:41.945850 | debian-bookworm -> localhost | |..B o . o .. .| 2025-10-02 03:07:41.945866 | debian-bookworm -> localhost | | ..+ . . .| 2025-10-02 03:07:41.945883 | debian-bookworm -> localhost | | .o.. . | 2025-10-02 03:07:41.945899 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-02 03:07:41.945937 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.836149 2025-10-02 03:07:41.951009 | 2025-10-02 03:07:41.951088 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-02 03:07:41.977433 | debian-bookworm | ok 2025-10-02 03:07:41.985564 | debian-bookworm | included: /var/lib/zuul/builds/1d1fb328e946479c86203f069d07bf11/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-02 03:07:41.992582 | 2025-10-02 03:07:41.992651 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-02 03:07:42.014950 | debian-bookworm | skipping: Conditional result was False 2025-10-02 03:07:42.019476 | 2025-10-02 03:07:42.019549 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-02 03:07:42.653549 | debian-bookworm | changed 2025-10-02 03:07:42.658631 | 2025-10-02 03:07:42.658713 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-02 03:07:42.922334 | debian-bookworm | ok 2025-10-02 03:07:42.928966 | 2025-10-02 03:07:42.929070 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-02 03:07:43.620011 | debian-bookworm | changed 2025-10-02 03:07:43.627109 | 2025-10-02 03:07:43.627224 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-02 03:07:44.467173 | debian-bookworm | changed 2025-10-02 03:07:44.472774 | 2025-10-02 03:07:44.472867 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-02 03:07:44.506774 | debian-bookworm | skipping: Conditional result was False 2025-10-02 03:07:44.514009 | 2025-10-02 03:07:44.514109 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-02 03:07:45.112908 | debian-bookworm -> localhost | changed 2025-10-02 03:07:45.126070 | 2025-10-02 03:07:45.126182 | TASK [add-build-sshkey : Add back temp key] 2025-10-02 03:07:45.433109 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1d1fb328e946479c86203f069d07bf11/work/1d1fb328e946479c86203f069d07bf11_id_rsa (zuul-build-sshkey) 2025-10-02 03:07:45.433327 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026313 2025-10-02 03:07:45.440703 | 2025-10-02 03:07:45.440808 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-02 03:07:45.905339 | debian-bookworm | ok 2025-10-02 03:07:45.918905 | 2025-10-02 03:07:45.919020 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-02 03:07:45.962197 | debian-bookworm | skipping: Conditional result was False 2025-10-02 03:07:45.972547 | 2025-10-02 03:07:45.972653 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-02 03:07:46.632533 | debian-bookworm | ok 2025-10-02 03:07:46.651065 | 2025-10-02 03:07:46.651182 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-02 03:07:46.710344 | debian-bookworm | ok 2025-10-02 03:07:46.715410 | 2025-10-02 03:07:46.715513 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-02 03:07:47.062049 | debian-bookworm -> localhost | ok 2025-10-02 03:07:47.068113 | 2025-10-02 03:07:47.068226 | TASK [validate-host : Collect information about the host] 2025-10-02 03:07:48.250623 | debian-bookworm | ok 2025-10-02 03:07:48.270893 | 2025-10-02 03:07:48.270994 | TASK [validate-host : Sanitize hostname] 2025-10-02 03:07:48.409965 | debian-bookworm | ok 2025-10-02 03:07:48.474789 | 2025-10-02 03:07:48.474911 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-02 03:07:49.185935 | debian-bookworm -> localhost | changed 2025-10-02 03:07:49.190566 | 2025-10-02 03:07:49.190646 | TASK [validate-host : Collect information about zuul worker] 2025-10-02 03:07:49.560965 | debian-bookworm | ok 2025-10-02 03:07:49.564758 | 2025-10-02 03:07:49.564835 | TASK [validate-host : Write out all zuul information for each host] 2025-10-02 03:07:50.117158 | debian-bookworm -> localhost | changed 2025-10-02 03:07:50.129857 | 2025-10-02 03:07:50.129960 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-02 03:07:50.389560 | debian-bookworm | ok 2025-10-02 03:07:50.393825 | 2025-10-02 03:07:50.393900 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-02 03:07:51.338300 | debian-bookworm | changed: 2025-10-02 03:07:51.338441 | debian-bookworm | cd+++++++++ src/ 2025-10-02 03:07:51.338468 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-02 03:07:51.338488 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-02 03:07:51.338505 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2025-10-02 03:07:51.338522 | debian-bookworm | localhost | ok: Runtime: 0:00:00.018269 2025-10-02 03:08:18.390591 | 2025-10-02 03:08:18.390698 | TASK [upload-logs : Upload logs to log server] 2025-10-02 03:08:19.364790 | localhost | Output suppressed because no_log was given 2025-10-02 03:08:19.366389 | 2025-10-02 03:08:19.366473 | LOOP [upload-logs : Compress console log and json output] 2025-10-02 03:08:19.446754 | localhost | skipping: Conditional result was False 2025-10-02 03:08:19.456657 | localhost | skipping: Conditional result was False 2025-10-02 03:08:19.461898 | 2025-10-02 03:08:19.461986 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-02 03:08:19.565766 | localhost | skipping: Conditional result was False 2025-10-02 03:08:19.565997 | 2025-10-02 03:08:19.579742 | localhost | skipping: Conditional result was False 2025-10-02 03:08:19.592228 | 2025-10-02 03:08:19.592328 | LOOP [upload-logs : Upload console log and json output]