2025-05-26 21:49:47.432081 | Job console starting 2025-05-26 21:49:47.453345 | Updating git repos 2025-05-26 21:49:47.525027 | Cloning repos into workspace 2025-05-26 21:49:47.629862 | Restoring repo states 2025-05-26 21:49:47.662007 | Merging changes 2025-05-26 21:49:48.361865 | Checking out repos 2025-05-26 21:49:48.449719 | Preparing playbooks 2025-05-26 21:49:49.320356 | Running Ansible setup 2025-05-26 21:49:54.313991 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-26 21:49:55.654107 | 2025-05-26 21:49:55.654316 | PLAY [Base pre] 2025-05-26 21:49:55.673625 | 2025-05-26 21:49:55.673822 | TASK [Setup log path fact] 2025-05-26 21:49:55.694909 | debian-bookworm | ok 2025-05-26 21:49:55.714548 | 2025-05-26 21:49:55.714735 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-26 21:49:55.792158 | debian-bookworm | ok 2025-05-26 21:49:55.819748 | 2025-05-26 21:49:55.819900 | TASK [emit-job-header : Print job information] 2025-05-26 21:49:55.959798 | # Job Information 2025-05-26 21:49:55.960013 | Ansible Version: 2.16.14 2025-05-26 21:49:55.960048 | Job: python-black 2025-05-26 21:49:55.960080 | Pipeline: check 2025-05-26 21:49:55.960103 | Executor: 521e9411259a 2025-05-26 21:49:55.960125 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1866 2025-05-26 21:49:55.960148 | Event ID: 525fbdc0-3a7b-11f0-8aca-41e08fc5aa3b 2025-05-26 21:49:55.965144 | 2025-05-26 21:49:55.965318 | LOOP [emit-job-header : Print node information] 2025-05-26 21:49:56.286915 | debian-bookworm | ok: 2025-05-26 21:49:56.287194 | debian-bookworm | # Node Information 2025-05-26 21:49:56.287353 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-26 21:49:56.287385 | debian-bookworm | Hostname: debian 2025-05-26 21:49:56.287408 | debian-bookworm | Username: zuul 2025-05-26 21:49:56.287430 | debian-bookworm | Distro: Debian 12.11 2025-05-26 21:49:56.287454 | debian-bookworm | Provider: regiocloud-a 2025-05-26 21:49:56.287477 | debian-bookworm | Region: 2025-05-26 21:49:56.287497 | debian-bookworm | Label: debian-bookworm 2025-05-26 21:49:56.287516 | debian-bookworm | Product Name: OpenStack Nova 2025-05-26 21:49:56.287536 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedb:4840 2025-05-26 21:49:56.300377 | 2025-05-26 21:49:56.300521 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-26 21:49:57.875689 | debian-bookworm -> localhost | changed 2025-05-26 21:49:57.883730 | 2025-05-26 21:49:57.883866 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-26 21:50:00.361909 | debian-bookworm -> localhost | changed 2025-05-26 21:50:00.393984 | 2025-05-26 21:50:00.397815 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-26 21:50:01.459020 | debian-bookworm -> localhost | ok 2025-05-26 21:50:01.468410 | 2025-05-26 21:50:01.468558 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-26 21:50:01.522951 | debian-bookworm | ok 2025-05-26 21:50:01.578155 | debian-bookworm | included: /var/lib/zuul/builds/9f108ac3bae042a4a85be7dca0724296/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-26 21:50:01.589929 | 2025-05-26 21:50:01.590258 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-26 21:50:05.547365 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-26 21:50:05.547625 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9f108ac3bae042a4a85be7dca0724296/work/9f108ac3bae042a4a85be7dca0724296_id_rsa 2025-05-26 21:50:05.547666 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9f108ac3bae042a4a85be7dca0724296/work/9f108ac3bae042a4a85be7dca0724296_id_rsa.pub 2025-05-26 21:50:05.547692 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-26 21:50:05.547715 | debian-bookworm -> localhost | SHA256:5JGLUCPyHwPgtFWdfdjeHV0/xHwxNN47MkqQOcI/k84 zuul-build-sshkey 2025-05-26 21:50:05.547737 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-26 21:50:05.547768 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-26 21:50:05.547791 | debian-bookworm -> localhost | | +.+.+. o o +*=| 2025-05-26 21:50:05.547813 | debian-bookworm -> localhost | | o = +..o.= o o+B| 2025-05-26 21:50:05.547833 | debian-bookworm -> localhost | | o o oo+= o . +=| 2025-05-26 21:50:05.547853 | debian-bookworm -> localhost | | o *oo+ . . +| 2025-05-26 21:50:05.547873 | debian-bookworm -> localhost | | o S= . o o | 2025-05-26 21:50:05.547899 | debian-bookworm -> localhost | | o + . o .| 2025-05-26 21:50:05.547920 | debian-bookworm -> localhost | | E . | 2025-05-26 21:50:05.547939 | debian-bookworm -> localhost | | | 2025-05-26 21:50:05.547960 | debian-bookworm -> localhost | | | 2025-05-26 21:50:05.547980 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-26 21:50:05.548032 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.396327 2025-05-26 21:50:05.554936 | 2025-05-26 21:50:05.555066 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-26 21:50:05.626205 | debian-bookworm | ok 2025-05-26 21:50:05.675870 | debian-bookworm | included: /var/lib/zuul/builds/9f108ac3bae042a4a85be7dca0724296/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-26 21:50:05.706058 | 2025-05-26 21:50:05.706281 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-26 21:50:05.787526 | debian-bookworm | skipping: Conditional result was False 2025-05-26 21:50:05.795203 | 2025-05-26 21:50:05.795366 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-26 21:50:06.718704 | debian-bookworm | changed 2025-05-26 21:50:06.727623 | 2025-05-26 21:50:06.728108 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-26 21:50:07.013198 | debian-bookworm | ok 2025-05-26 21:50:07.021223 | 2025-05-26 21:50:07.022226 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-26 21:50:07.692496 | debian-bookworm | changed 2025-05-26 21:50:07.699768 | 2025-05-26 21:50:07.699936 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-26 21:50:08.332089 | debian-bookworm | changed 2025-05-26 21:50:08.341510 | 2025-05-26 21:50:08.345652 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-26 21:50:08.409605 | debian-bookworm | skipping: Conditional result was False 2025-05-26 21:50:08.416986 | 2025-05-26 21:50:08.417096 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-26 21:50:09.170676 | debian-bookworm -> localhost | changed 2025-05-26 21:50:09.186744 | 2025-05-26 21:50:09.186960 | TASK [add-build-sshkey : Add back temp key] 2025-05-26 21:50:09.772882 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9f108ac3bae042a4a85be7dca0724296/work/9f108ac3bae042a4a85be7dca0724296_id_rsa (zuul-build-sshkey) 2025-05-26 21:50:09.773131 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026585 2025-05-26 21:50:09.781192 | 2025-05-26 21:50:09.781320 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-26 21:50:10.431032 | debian-bookworm | ok 2025-05-26 21:50:10.439642 | 2025-05-26 21:50:10.439785 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-26 21:50:10.485105 | debian-bookworm | skipping: Conditional result was False 2025-05-26 21:50:10.504118 | 2025-05-26 21:50:10.504364 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-26 21:50:11.227671 | debian-bookworm | ok 2025-05-26 21:50:11.253590 | 2025-05-26 21:50:11.253750 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-26 21:50:11.350239 | debian-bookworm | ok 2025-05-26 21:50:11.364089 | 2025-05-26 21:50:11.364260 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-26 21:50:12.344162 | debian-bookworm -> localhost | ok 2025-05-26 21:50:12.354226 | 2025-05-26 21:50:12.354380 | TASK [validate-host : Collect information about the host] 2025-05-26 21:50:13.709450 | debian-bookworm | ok 2025-05-26 21:50:13.723231 | 2025-05-26 21:50:13.723336 | TASK [validate-host : Sanitize hostname] 2025-05-26 21:50:13.829547 | debian-bookworm | ok 2025-05-26 21:50:13.868456 | 2025-05-26 21:50:13.868578 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-26 21:50:14.768868 | debian-bookworm -> localhost | changed 2025-05-26 21:50:14.774283 | 2025-05-26 21:50:14.774382 | TASK [validate-host : Collect information about zuul worker] 2025-05-26 21:50:15.251882 | debian-bookworm | ok 2025-05-26 21:50:15.259381 | 2025-05-26 21:50:15.259487 | TASK [validate-host : Write out all zuul information for each host] 2025-05-26 21:50:16.022553 | debian-bookworm -> localhost | changed 2025-05-26 21:50:16.032032 | 2025-05-26 21:50:16.032125 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-26 21:50:16.324421 | debian-bookworm | ok 2025-05-26 21:50:16.329881 | 2025-05-26 21:50:16.329972 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-26 21:50:17.553270 | debian-bookworm | changed: 2025-05-26 21:50:17.553432 | debian-bookworm | cd+++++++++ src/ 2025-05-26 21:50:17.553461 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-26 21:50:17.553481 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-26 21:50:17.553500 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-05-26 21:50:17.553516 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004831 2025-05-26 21:50:44.752817 | 2025-05-26 21:50:44.752973 | TASK [upload-logs : Upload logs to log server] 2025-05-26 21:50:45.353113 | localhost | Output suppressed because no_log was given 2025-05-26 21:50:45.356458 | 2025-05-26 21:50:45.356625 | LOOP [upload-logs : Compress console log and json output] 2025-05-26 21:50:45.415700 | localhost | skipping: Conditional result was False 2025-05-26 21:50:45.420059 | localhost | skipping: Conditional result was False 2025-05-26 21:50:45.432963 | 2025-05-26 21:50:45.433309 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-26 21:50:45.486623 | localhost | skipping: Conditional result was False 2025-05-26 21:50:45.487296 | 2025-05-26 21:50:45.489751 | localhost | skipping: Conditional result was False 2025-05-26 21:50:45.497088 | 2025-05-26 21:50:45.497385 | LOOP [upload-logs : Upload console log and json output]