2025-08-31 03:08:14.144582 | Job console starting 2025-08-31 03:08:14.160088 | Updating git repos 2025-08-31 03:08:14.191154 | Cloning repos into workspace 2025-08-31 03:08:14.225594 | Restoring repo states 2025-08-31 03:08:14.240011 | Merging changes 2025-08-31 03:08:14.240027 | Checking out repos 2025-08-31 03:08:14.305344 | Preparing playbooks 2025-08-31 03:08:15.004449 | Running Ansible setup 2025-08-31 03:08:19.056233 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-31 03:08:19.809835 | 2025-08-31 03:08:19.809959 | PLAY [Base pre] 2025-08-31 03:08:19.824481 | 2025-08-31 03:08:19.824593 | TASK [Setup log path fact] 2025-08-31 03:08:19.843406 | debian-bookworm | ok 2025-08-31 03:08:19.857419 | 2025-08-31 03:08:19.857537 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-31 03:08:19.885947 | debian-bookworm | ok 2025-08-31 03:08:19.895883 | 2025-08-31 03:08:19.895979 | TASK [emit-job-header : Print job information] 2025-08-31 03:08:19.935056 | # Job Information 2025-08-31 03:08:19.935207 | Ansible Version: 2.16.14 2025-08-31 03:08:19.935240 | Job: python-black 2025-08-31 03:08:19.935271 | Pipeline: periodic-daily 2025-08-31 03:08:19.935293 | Executor: 521e9411259a 2025-08-31 03:08:19.935313 | Triggered by: https://github.com/osism/openstack-project-manager 2025-08-31 03:08:19.935335 | Event ID: 5eb1f4c816f14608b1966152a159873d 2025-08-31 03:08:19.941246 | 2025-08-31 03:08:19.941344 | LOOP [emit-job-header : Print node information] 2025-08-31 03:08:20.042827 | debian-bookworm | ok: 2025-08-31 03:08:20.043059 | debian-bookworm | # Node Information 2025-08-31 03:08:20.043094 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-31 03:08:20.043120 | debian-bookworm | Hostname: debian 2025-08-31 03:08:20.043142 | debian-bookworm | Username: zuul 2025-08-31 03:08:20.043162 | debian-bookworm | Distro: Debian 12.11 2025-08-31 03:08:20.043186 | debian-bookworm | Provider: regiocloud-a 2025-08-31 03:08:20.043207 | debian-bookworm | Region: 2025-08-31 03:08:20.043227 | debian-bookworm | Label: debian-bookworm 2025-08-31 03:08:20.043247 | debian-bookworm | Product Name: OpenStack Nova 2025-08-31 03:08:20.043267 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feab:2ef9 2025-08-31 03:08:20.056839 | 2025-08-31 03:08:20.056955 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-31 03:08:20.642314 | debian-bookworm -> localhost | changed 2025-08-31 03:08:20.648979 | 2025-08-31 03:08:20.649077 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-31 03:08:21.728541 | debian-bookworm -> localhost | changed 2025-08-31 03:08:21.739826 | 2025-08-31 03:08:21.739960 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-31 03:08:22.071309 | debian-bookworm -> localhost | ok 2025-08-31 03:08:22.077954 | 2025-08-31 03:08:22.078091 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-31 03:08:22.107125 | debian-bookworm | ok 2025-08-31 03:08:22.125325 | debian-bookworm | included: /var/lib/zuul/builds/4e88e2c59aba422fba1de354049a422f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-31 03:08:22.131776 | 2025-08-31 03:08:22.131894 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-31 03:08:23.396794 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-31 03:08:23.397070 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4e88e2c59aba422fba1de354049a422f/work/4e88e2c59aba422fba1de354049a422f_id_rsa 2025-08-31 03:08:23.397112 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4e88e2c59aba422fba1de354049a422f/work/4e88e2c59aba422fba1de354049a422f_id_rsa.pub 2025-08-31 03:08:23.397138 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-31 03:08:23.397162 | debian-bookworm -> localhost | SHA256:wCeycs6iPrr0na9DEMWp6NKdnwyf0FmHjB/E4MG7P3I zuul-build-sshkey 2025-08-31 03:08:23.397184 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-31 03:08:23.397215 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-31 03:08:23.397237 | debian-bookworm -> localhost | | oo+o | 2025-08-31 03:08:23.397259 | debian-bookworm -> localhost | | . =..o | 2025-08-31 03:08:23.397280 | debian-bookworm -> localhost | | . + ==.. | 2025-08-31 03:08:23.397300 | debian-bookworm -> localhost | | . o oo+= . | 2025-08-31 03:08:23.397321 | debian-bookworm -> localhost | |....+o =So | 2025-08-31 03:08:23.397351 | debian-bookworm -> localhost | |...==.+ . | 2025-08-31 03:08:23.397374 | debian-bookworm -> localhost | |... +* + | 2025-08-31 03:08:23.397394 | debian-bookworm -> localhost | |.o....O E | 2025-08-31 03:08:23.397415 | debian-bookworm -> localhost | |*o.. +++ . | 2025-08-31 03:08:23.397435 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-31 03:08:23.397492 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.684354 2025-08-31 03:08:23.404247 | 2025-08-31 03:08:23.404368 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-31 03:08:23.438527 | debian-bookworm | ok 2025-08-31 03:08:23.452657 | debian-bookworm | included: /var/lib/zuul/builds/4e88e2c59aba422fba1de354049a422f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-31 03:08:23.463606 | 2025-08-31 03:08:23.463735 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-31 03:08:23.487667 | debian-bookworm | skipping: Conditional result was False 2025-08-31 03:08:23.493667 | 2025-08-31 03:08:23.493800 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-31 03:08:24.261780 | debian-bookworm | changed 2025-08-31 03:08:24.268524 | 2025-08-31 03:08:24.268622 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-31 03:08:24.525103 | debian-bookworm | ok 2025-08-31 03:08:24.537129 | 2025-08-31 03:08:24.537332 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-31 03:08:25.235216 | debian-bookworm | changed 2025-08-31 03:08:25.244354 | 2025-08-31 03:08:25.244451 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-31 03:08:25.870164 | debian-bookworm | changed 2025-08-31 03:08:25.875865 | 2025-08-31 03:08:25.875955 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-31 03:08:25.901516 | debian-bookworm | skipping: Conditional result was False 2025-08-31 03:08:25.908518 | 2025-08-31 03:08:25.908611 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-31 03:08:26.388786 | debian-bookworm -> localhost | changed 2025-08-31 03:08:26.402368 | 2025-08-31 03:08:26.402459 | TASK [add-build-sshkey : Add back temp key] 2025-08-31 03:08:26.715003 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4e88e2c59aba422fba1de354049a422f/work/4e88e2c59aba422fba1de354049a422f_id_rsa (zuul-build-sshkey) 2025-08-31 03:08:26.715449 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012841 2025-08-31 03:08:26.731204 | 2025-08-31 03:08:26.731338 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-31 03:08:27.136993 | debian-bookworm | ok 2025-08-31 03:08:27.141801 | 2025-08-31 03:08:27.141888 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-31 03:08:27.174808 | debian-bookworm | skipping: Conditional result was False 2025-08-31 03:08:27.185822 | 2025-08-31 03:08:27.185938 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-31 03:08:27.611845 | debian-bookworm | ok 2025-08-31 03:08:27.627082 | 2025-08-31 03:08:27.627184 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-31 03:08:27.654580 | debian-bookworm | ok 2025-08-31 03:08:27.660737 | 2025-08-31 03:08:27.660829 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-31 03:08:27.898116 | debian-bookworm -> localhost | ok 2025-08-31 03:08:27.905674 | 2025-08-31 03:08:27.905797 | TASK [validate-host : Collect information about the host] 2025-08-31 03:08:29.012241 | debian-bookworm | ok 2025-08-31 03:08:29.024326 | 2025-08-31 03:08:29.024430 | TASK [validate-host : Sanitize hostname] 2025-08-31 03:08:29.134344 | debian-bookworm | ok 2025-08-31 03:08:29.165329 | 2025-08-31 03:08:29.165434 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-31 03:08:29.730498 | debian-bookworm -> localhost | changed 2025-08-31 03:08:29.738758 | 2025-08-31 03:08:29.738893 | TASK [validate-host : Collect information about zuul worker] 2025-08-31 03:08:30.170440 | debian-bookworm | ok 2025-08-31 03:08:30.180230 | 2025-08-31 03:08:30.180434 | TASK [validate-host : Write out all zuul information for each host] 2025-08-31 03:08:31.089170 | debian-bookworm -> localhost | changed 2025-08-31 03:08:31.105945 | 2025-08-31 03:08:31.106067 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-31 03:08:31.402921 | debian-bookworm | ok 2025-08-31 03:08:31.413838 | 2025-08-31 03:08:31.413973 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-31 03:08:33.003997 | debian-bookworm | changed: 2025-08-31 03:08:33.004429 | debian-bookworm | cd+++++++++ src/ 2025-08-31 03:08:33.004478 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-31 03:08:33.004503 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-31 03:08:33.004524 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2025-08-31 03:08:33.004545 | debian-bookworm | : Failed to establish a new connection: [Errno -3] Temporary failure in name resolution')': /packages/a5/b5/f485e1bbe31f768e2e5210f52ea3f432256201289fd1a3c0afda693776b0/black-24.8.0-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.manylinux_2_28_x86_64.whl\n WARNING: Retrying (Retry(total=3, connect=None, read=None, redirect=None, status=None)) after connection broken by 'NewConnectionError(': Failed to establish a new connection: [Errno -3] Temporary failure in name resolution')': /packages/a5/b5/f485e1bbe31f768e2e5210f52ea3f432256201289fd1a3c0afda693776b0/black-24.8.0-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.manylinux_2_28_x86_64.whl\n WARNING: Retrying (Retry(total=2, connect=None, read=None, redirect=None, status=None)) after connection broken by 'NewConnectionError(': Failed to establish a new connection: [Errno -3] Temporary failure in name resolution')': /packages/a5/b5/f485e1bbe31f768e2e5210f52ea3f432256201289fd1a3c0afda693776b0/black-24.8.0-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.manylinux_2_28_x86_64.whl\n WARNING: Retrying (Retry(total=1, connect=None, read=None, redirect=None, status=None)) after connection broken by 'NewConnectionError(': Failed to establish a new connection: [Errno -3] Temporary failure in name resolution')': /packages/a5/b5/f485e1bbe31f768e2e5210f52ea3f432256201289fd1a3c0afda693776b0/black-24.8.0-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.manylinux_2_28_x86_64.whl\n WARNING: Retrying (Retry(total=0, connect=None, read=None, redirect=None, status=None)) after connection broken by 'NewConnectionError(': Failed to establish a new connection: [Errno -3] Temporary failure in name resolution')': /packages/a5/b5/f485e1bbe31f768e2e5210f52ea3f432256201289fd1a3c0afda693776b0/black-24.8.0-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.manylinux_2_28_x86_64.whl\nERROR: Could not install packages due to an OSError: HTTPSConnectionPool(host='files.pythonhosted.org', port=443): Max retries exceeded with url: /packages/a5/b5/f485e1bbe31f768e2e5210f52ea3f432256201289fd1a3c0afda693776b0/black-24.8.0-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.manylinux_2_28_x86_64.whl (Caused by NewConnectionError(': Failed to establish a new connection: [Errno -3] Temporary failure in name resolution'))\n\n" 2025-08-31 03:09:12.505747 | debian-bookworm | } failure 2025-08-31 03:09:12.509312 | 2025-08-31 03:09:12.509411 | PLAY RECAP 2025-08-31 03:09:12.509468 | debian-bookworm | ok: 8 changed: 5 unreachable: 0 failed: 1 skipped: 12 rescued: 0 ignored: 0 2025-08-31 03:09:12.509496 | 2025-08-31 03:09:12.819821 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/python-black/run.yml@main] 2025-08-31 03:09:12.820734 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-31 03:09:13.893338 | 2025-08-31 03:09:13.893499 | PLAY [Base post] 2025-08-31 03:09:13.917224 | 2025-08-31 03:09:13.917381 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-31 03:09:14.540898 | debian-bookworm | changed 2025-08-31 03:09:14.550996 | 2025-08-31 03:09:14.551111 | PLAY RECAP 2025-08-31 03:09:14.551173 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-31 03:09:14.551234 | 2025-08-31 03:09:14.900418 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-31 03:09:14.901346 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-31 03:09:16.190649 | 2025-08-31 03:09:16.190955 | PLAY [Base post-logs] 2025-08-31 03:09:16.201660 | 2025-08-31 03:09:16.201806 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-31 03:09:16.707196 | localhost | changed 2025-08-31 03:09:16.722599 | 2025-08-31 03:09:16.722776 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-31 03:09:16.772696 | localhost | ok 2025-08-31 03:09:16.775788 | 2025-08-31 03:09:16.775869 | TASK [Set zuul-log-path fact] 2025-08-31 03:09:16.800736 | localhost | ok 2025-08-31 03:09:16.808781 | 2025-08-31 03:09:16.808880 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-31 03:09:16.853160 | localhost | ok 2025-08-31 03:09:16.856115 | 2025-08-31 03:09:16.856199 | TASK [upload-logs : Create log directories] 2025-08-31 03:09:17.448480 | localhost | changed 2025-08-31 03:09:17.451599 | 2025-08-31 03:09:17.451707 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-31 03:09:18.221191 | localhost -> localhost | ok: Runtime: 0:00:00.027459 2025-08-31 03:09:18.225008 | 2025-08-31 03:09:18.225085 | TASK [upload-logs : Upload logs to log server] 2025-08-31 03:09:19.118471 | localhost | Output suppressed because no_log was given 2025-08-31 03:09:19.120846 | 2025-08-31 03:09:19.120943 | LOOP [upload-logs : Compress console log and json output] 2025-08-31 03:09:19.161255 | localhost | skipping: Conditional result was False 2025-08-31 03:09:19.166358 | localhost | skipping: Conditional result was False 2025-08-31 03:09:19.176535 | 2025-08-31 03:09:19.176634 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-31 03:09:19.218488 | localhost | skipping: Conditional result was False 2025-08-31 03:09:19.218721 | 2025-08-31 03:09:19.223807 | localhost | skipping: Conditional result was False 2025-08-31 03:09:19.226767 | 2025-08-31 03:09:19.226951 | LOOP [upload-logs : Upload console log and json output]