2025-12-02 16:46:52.230249 | Job console starting 2025-12-02 16:46:52.254210 | Updating git repos 2025-12-02 16:46:52.312528 | Cloning repos into workspace 2025-12-02 16:46:52.428828 | Restoring repo states 2025-12-02 16:46:52.452071 | Merging changes 2025-12-02 16:46:53.062338 | Checking out repos 2025-12-02 16:46:53.221492 | Preparing playbooks 2025-12-02 16:46:54.332985 | Running Ansible setup 2025-12-02 16:47:01.127885 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-02 16:47:02.307396 | 2025-12-02 16:47:02.307602 | PLAY [Base pre] 2025-12-02 16:47:02.337442 | 2025-12-02 16:47:02.337641 | TASK [Setup log path fact] 2025-12-02 16:47:02.357645 | debian-bookworm | ok 2025-12-02 16:47:02.384306 | 2025-12-02 16:47:02.384478 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 16:47:02.445062 | debian-bookworm | ok 2025-12-02 16:47:02.462176 | 2025-12-02 16:47:02.462322 | TASK [emit-job-header : Print job information] 2025-12-02 16:47:02.512001 | # Job Information 2025-12-02 16:47:02.512196 | Ansible Version: 2.16.14 2025-12-02 16:47:02.512231 | Job: python-black 2025-12-02 16:47:02.512265 | Pipeline: check 2025-12-02 16:47:02.512288 | Executor: 521e9411259a 2025-12-02 16:47:02.512308 | Triggered by: https://github.com/osism/python-osism/pull/1872 2025-12-02 16:47:02.512330 | Event ID: 7acd6970-cf9e-11f0-816a-7a78e4dcf3ff 2025-12-02 16:47:02.520547 | 2025-12-02 16:47:02.520696 | LOOP [emit-job-header : Print node information] 2025-12-02 16:47:02.750133 | debian-bookworm | ok: 2025-12-02 16:47:02.750413 | debian-bookworm | # Node Information 2025-12-02 16:47:02.750453 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-02 16:47:02.750479 | debian-bookworm | Hostname: debian 2025-12-02 16:47:02.750520 | debian-bookworm | Username: zuul 2025-12-02 16:47:02.750542 | debian-bookworm | Distro: Debian 12.12 2025-12-02 16:47:02.750565 | debian-bookworm | Provider: regiocloud-a 2025-12-02 16:47:02.750586 | debian-bookworm | Region: 2025-12-02 16:47:02.750608 | debian-bookworm | Label: debian-bookworm 2025-12-02 16:47:02.750628 | debian-bookworm | Product Name: OpenStack Nova 2025-12-02 16:47:02.750647 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feda:9bf6 2025-12-02 16:47:02.774171 | 2025-12-02 16:47:02.774321 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-02 16:47:03.809230 | debian-bookworm -> localhost | changed 2025-12-02 16:47:03.820928 | 2025-12-02 16:47:03.821093 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-02 16:47:05.722631 | debian-bookworm -> localhost | changed 2025-12-02 16:47:05.735804 | 2025-12-02 16:47:05.735941 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-02 16:47:06.460624 | debian-bookworm -> localhost | ok 2025-12-02 16:47:06.467348 | 2025-12-02 16:47:06.467484 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-02 16:47:06.516930 | debian-bookworm | ok 2025-12-02 16:47:06.549403 | debian-bookworm | included: /var/lib/zuul/builds/544da68d2d444d16bea88482d53d1051/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-02 16:47:06.557170 | 2025-12-02 16:47:06.557292 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-02 16:47:08.403974 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-02 16:47:08.404540 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/544da68d2d444d16bea88482d53d1051/work/544da68d2d444d16bea88482d53d1051_id_rsa 2025-12-02 16:47:08.404637 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/544da68d2d444d16bea88482d53d1051/work/544da68d2d444d16bea88482d53d1051_id_rsa.pub 2025-12-02 16:47:08.404668 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-02 16:47:08.404693 | debian-bookworm -> localhost | SHA256:dCKnUE7W17UoL0M/dvCIDb0HKNT5jJWMEBfg5PRL5pA zuul-build-sshkey 2025-12-02 16:47:08.404716 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-02 16:47:08.404752 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-02 16:47:08.404774 | debian-bookworm -> localhost | | +.B=o* o. | 2025-12-02 16:47:08.404796 | debian-bookworm -> localhost | | = *.+=o=. . | 2025-12-02 16:47:08.404817 | debian-bookworm -> localhost | | . o E.X== . | 2025-12-02 16:47:08.405032 | debian-bookworm -> localhost | | . = X.Oo* | 2025-12-02 16:47:08.405094 | debian-bookworm -> localhost | | . S * O + | 2025-12-02 16:47:08.405136 | debian-bookworm -> localhost | | + + | 2025-12-02 16:47:08.405160 | debian-bookworm -> localhost | | | 2025-12-02 16:47:08.405181 | debian-bookworm -> localhost | | | 2025-12-02 16:47:08.405203 | debian-bookworm -> localhost | | | 2025-12-02 16:47:08.405224 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-02 16:47:08.405296 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.992881 2025-12-02 16:47:08.416128 | 2025-12-02 16:47:08.416309 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-02 16:47:08.452913 | debian-bookworm | ok 2025-12-02 16:47:08.468746 | debian-bookworm | included: /var/lib/zuul/builds/544da68d2d444d16bea88482d53d1051/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-02 16:47:08.488564 | 2025-12-02 16:47:08.495719 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-02 16:47:08.539987 | debian-bookworm | skipping: Conditional result was False 2025-12-02 16:47:08.546627 | 2025-12-02 16:47:08.546745 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-02 16:47:09.337822 | debian-bookworm | changed 2025-12-02 16:47:09.345995 | 2025-12-02 16:47:09.346132 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-02 16:47:09.599694 | debian-bookworm | ok 2025-12-02 16:47:09.608807 | 2025-12-02 16:47:09.608945 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-02 16:47:10.309392 | debian-bookworm | changed 2025-12-02 16:47:10.316846 | 2025-12-02 16:47:10.316972 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-02 16:47:10.992651 | debian-bookworm | changed 2025-12-02 16:47:10.998634 | 2025-12-02 16:47:10.998756 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-02 16:47:11.033275 | debian-bookworm | skipping: Conditional result was False 2025-12-02 16:47:11.051290 | 2025-12-02 16:47:11.051525 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-02 16:47:11.697234 | debian-bookworm -> localhost | changed 2025-12-02 16:47:11.711128 | 2025-12-02 16:47:11.711292 | TASK [add-build-sshkey : Add back temp key] 2025-12-02 16:47:12.427647 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/544da68d2d444d16bea88482d53d1051/work/544da68d2d444d16bea88482d53d1051_id_rsa (zuul-build-sshkey) 2025-12-02 16:47:12.427941 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.034431 2025-12-02 16:47:12.436526 | 2025-12-02 16:47:12.436674 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-02 16:47:12.967824 | debian-bookworm | ok 2025-12-02 16:47:12.977513 | 2025-12-02 16:47:12.977665 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-02 16:47:13.021975 | debian-bookworm | skipping: Conditional result was False 2025-12-02 16:47:13.034024 | 2025-12-02 16:47:13.034274 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-02 16:47:13.490538 | debian-bookworm | ok 2025-12-02 16:47:13.509000 | 2025-12-02 16:47:13.509165 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-02 16:47:13.573333 | debian-bookworm | ok 2025-12-02 16:47:13.579429 | 2025-12-02 16:47:13.579582 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-02 16:47:14.006785 | debian-bookworm -> localhost | ok 2025-12-02 16:47:14.014236 | 2025-12-02 16:47:14.014365 | TASK [validate-host : Collect information about the host] 2025-12-02 16:47:15.252980 | debian-bookworm | ok 2025-12-02 16:47:15.267585 | 2025-12-02 16:47:15.267715 | TASK [validate-host : Sanitize hostname] 2025-12-02 16:47:15.382528 | debian-bookworm | ok 2025-12-02 16:47:15.429371 | 2025-12-02 16:47:15.429537 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-02 16:47:16.215425 | debian-bookworm -> localhost | changed 2025-12-02 16:47:16.222153 | 2025-12-02 16:47:16.222288 | TASK [validate-host : Collect information about zuul worker] 2025-12-02 16:47:16.804042 | debian-bookworm | ok 2025-12-02 16:47:16.809068 | 2025-12-02 16:47:16.809191 | TASK [validate-host : Write out all zuul information for each host] 2025-12-02 16:47:17.700684 | debian-bookworm -> localhost | changed 2025-12-02 16:47:17.714681 | 2025-12-02 16:47:17.714849 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-02 16:47:18.013626 | debian-bookworm | ok 2025-12-02 16:47:18.028462 | 2025-12-02 16:47:18.028639 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-02 16:47:19.500659 | debian-bookworm | changed: 2025-12-02 16:47:19.500966 | debian-bookworm | cd+++++++++ src/ 2025-12-02 16:47:19.501008 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-02 16:47:19.501033 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-02 16:47:19.501055 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-02 16:47:19.501075 | debian-bookworm | Containerfile 2025-12-02 16:47:19.501189 | debian-bookworm | Containerfile 2025-12-02 16:47:19.578184 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007123 2025-12-02 16:47:47.477349 | 2025-12-02 16:47:47.477545 | TASK [upload-logs : Upload logs to log server] 2025-12-02 16:47:48.042902 | localhost | Output suppressed because no_log was given 2025-12-02 16:47:48.045434 | 2025-12-02 16:47:48.045580 | LOOP [upload-logs : Compress console log and json output] 2025-12-02 16:47:48.108951 | localhost | skipping: Conditional result was False 2025-12-02 16:47:48.114273 | localhost | skipping: Conditional result was False 2025-12-02 16:47:48.126623 | 2025-12-02 16:47:48.126909 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-02 16:47:48.186006 | localhost | skipping: Conditional result was False 2025-12-02 16:47:48.186335 | 2025-12-02 16:47:48.203029 | localhost | skipping: Conditional result was False 2025-12-02 16:47:48.211707 | 2025-12-02 16:47:48.211980 | LOOP [upload-logs : Upload console log and json output]