2025-08-05 07:23:39.620476 | Job console starting 2025-08-05 07:23:39.638664 | Updating git repos 2025-08-05 07:23:39.681470 | Cloning repos into workspace 2025-08-05 07:23:39.765438 | Restoring repo states 2025-08-05 07:23:39.785658 | Merging changes 2025-08-05 07:23:40.304849 | Checking out repos 2025-08-05 07:23:40.360590 | Preparing playbooks 2025-08-05 07:23:41.523740 | Running Ansible setup 2025-08-05 07:23:46.471344 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-05 07:23:47.490038 | 2025-08-05 07:23:47.490200 | PLAY [Base pre] 2025-08-05 07:23:47.513700 | 2025-08-05 07:23:47.513850 | TASK [Setup log path fact] 2025-08-05 07:23:47.545265 | debian-bookworm | ok 2025-08-05 07:23:47.583366 | 2025-08-05 07:23:47.583540 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-05 07:23:47.635817 | debian-bookworm | ok 2025-08-05 07:23:47.658025 | 2025-08-05 07:23:47.658165 | TASK [emit-job-header : Print job information] 2025-08-05 07:23:47.718260 | # Job Information 2025-08-05 07:23:47.718540 | Ansible Version: 2.16.14 2025-08-05 07:23:47.718577 | Job: python-black 2025-08-05 07:23:47.718630 | Pipeline: check 2025-08-05 07:23:47.718659 | Executor: 521e9411259a 2025-08-05 07:23:47.718680 | Triggered by: https://github.com/osism/openstack-image-manager/pull/943 2025-08-05 07:23:47.718702 | Event ID: 16bd6270-71cd-11f0-943b-488702cbce2f 2025-08-05 07:23:47.736073 | 2025-08-05 07:23:47.736211 | LOOP [emit-job-header : Print node information] 2025-08-05 07:23:47.879447 | debian-bookworm | ok: 2025-08-05 07:23:47.879740 | debian-bookworm | # Node Information 2025-08-05 07:23:47.879780 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-05 07:23:47.879807 | debian-bookworm | Hostname: debian 2025-08-05 07:23:47.879829 | debian-bookworm | Username: zuul 2025-08-05 07:23:47.879851 | debian-bookworm | Distro: Debian 12.11 2025-08-05 07:23:47.879877 | debian-bookworm | Provider: regiocloud-a 2025-08-05 07:23:47.879898 | debian-bookworm | Region: 2025-08-05 07:23:47.879919 | debian-bookworm | Label: debian-bookworm 2025-08-05 07:23:47.879939 | debian-bookworm | Product Name: OpenStack Nova 2025-08-05 07:23:47.879959 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feef:4efc 2025-08-05 07:23:47.892434 | 2025-08-05 07:23:47.892569 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-05 07:23:48.716395 | debian-bookworm -> localhost | changed 2025-08-05 07:23:48.724029 | 2025-08-05 07:23:48.724157 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-05 07:23:50.618746 | debian-bookworm -> localhost | changed 2025-08-05 07:23:50.638151 | 2025-08-05 07:23:50.638333 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-05 07:23:50.997455 | debian-bookworm -> localhost | ok 2025-08-05 07:23:51.003389 | 2025-08-05 07:23:51.003490 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-05 07:23:51.021204 | debian-bookworm | ok 2025-08-05 07:23:51.039141 | debian-bookworm | included: /var/lib/zuul/builds/deaf7c789bd2449c9a38517ad023a3d1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-05 07:23:51.046295 | 2025-08-05 07:23:51.046383 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-05 07:23:52.240752 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-05 07:23:52.241220 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/deaf7c789bd2449c9a38517ad023a3d1/work/deaf7c789bd2449c9a38517ad023a3d1_id_rsa 2025-08-05 07:23:52.241329 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/deaf7c789bd2449c9a38517ad023a3d1/work/deaf7c789bd2449c9a38517ad023a3d1_id_rsa.pub 2025-08-05 07:23:52.241407 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-05 07:23:52.241480 | debian-bookworm -> localhost | SHA256:AFTvifn/ArVIR3eIxTkoBTz6EVzOSM0vdi7wwNBO/t0 zuul-build-sshkey 2025-08-05 07:23:52.241544 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-05 07:23:52.241653 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-05 07:23:52.241722 | debian-bookworm -> localhost | | .o..+o*o=.o | 2025-08-05 07:23:52.241787 | debian-bookworm -> localhost | | ..oO+* * . | 2025-08-05 07:23:52.241846 | debian-bookworm -> localhost | | .Bo=oo o | 2025-08-05 07:23:52.241905 | debian-bookworm -> localhost | | .=O.= o | 2025-08-05 07:23:52.241962 | debian-bookworm -> localhost | | ooS@ * . | 2025-08-05 07:23:52.242022 | debian-bookworm -> localhost | | .+ = o E | 2025-08-05 07:23:52.242080 | debian-bookworm -> localhost | | .. . | 2025-08-05 07:23:52.242136 | debian-bookworm -> localhost | | .. | 2025-08-05 07:23:52.242197 | debian-bookworm -> localhost | | .o. | 2025-08-05 07:23:52.242256 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-05 07:23:52.242393 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.473014 2025-08-05 07:23:52.267293 | 2025-08-05 07:23:52.267393 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-05 07:23:52.306873 | debian-bookworm | ok 2025-08-05 07:23:52.318311 | debian-bookworm | included: /var/lib/zuul/builds/deaf7c789bd2449c9a38517ad023a3d1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-05 07:23:52.330895 | 2025-08-05 07:23:52.330982 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-05 07:23:52.382674 | debian-bookworm | skipping: Conditional result was False 2025-08-05 07:23:52.388503 | 2025-08-05 07:23:52.388599 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-05 07:23:52.987719 | debian-bookworm | changed 2025-08-05 07:23:52.994719 | 2025-08-05 07:23:52.994798 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-05 07:23:53.269816 | debian-bookworm | ok 2025-08-05 07:23:53.277114 | 2025-08-05 07:23:53.277203 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-05 07:23:53.962538 | debian-bookworm | changed 2025-08-05 07:23:53.969995 | 2025-08-05 07:23:53.970099 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-05 07:23:54.595504 | debian-bookworm | changed 2025-08-05 07:23:54.610322 | 2025-08-05 07:23:54.610417 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-05 07:23:54.633116 | debian-bookworm | skipping: Conditional result was False 2025-08-05 07:23:54.638218 | 2025-08-05 07:23:54.638300 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-05 07:23:54.987190 | debian-bookworm -> localhost | changed 2025-08-05 07:23:55.008819 | 2025-08-05 07:23:55.008923 | TASK [add-build-sshkey : Add back temp key] 2025-08-05 07:23:55.351535 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/deaf7c789bd2449c9a38517ad023a3d1/work/deaf7c789bd2449c9a38517ad023a3d1_id_rsa (zuul-build-sshkey) 2025-08-05 07:23:55.351783 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013304 2025-08-05 07:23:55.359241 | 2025-08-05 07:23:55.359336 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-05 07:23:55.782918 | debian-bookworm | ok 2025-08-05 07:23:55.810686 | 2025-08-05 07:23:55.810903 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-05 07:23:55.836223 | debian-bookworm | skipping: Conditional result was False 2025-08-05 07:23:55.848220 | 2025-08-05 07:23:55.848337 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-05 07:23:56.248394 | debian-bookworm | ok 2025-08-05 07:23:56.259036 | 2025-08-05 07:23:56.259133 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-05 07:23:56.287287 | debian-bookworm | ok 2025-08-05 07:23:56.292240 | 2025-08-05 07:23:56.292343 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-05 07:23:56.620489 | debian-bookworm -> localhost | ok 2025-08-05 07:23:56.627350 | 2025-08-05 07:23:56.627478 | TASK [validate-host : Collect information about the host] 2025-08-05 07:23:57.916894 | debian-bookworm | ok 2025-08-05 07:23:57.928194 | 2025-08-05 07:23:57.928327 | TASK [validate-host : Sanitize hostname] 2025-08-05 07:23:58.070192 | debian-bookworm | ok 2025-08-05 07:23:58.123443 | 2025-08-05 07:23:58.123598 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-05 07:23:58.873531 | debian-bookworm -> localhost | changed 2025-08-05 07:23:58.879860 | 2025-08-05 07:23:58.879991 | TASK [validate-host : Collect information about zuul worker] 2025-08-05 07:23:59.319178 | debian-bookworm | ok 2025-08-05 07:23:59.329038 | 2025-08-05 07:23:59.329195 | TASK [validate-host : Write out all zuul information for each host] 2025-08-05 07:24:00.270002 | debian-bookworm -> localhost | changed 2025-08-05 07:24:00.280357 | 2025-08-05 07:24:00.280484 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-05 07:24:00.557357 | debian-bookworm | ok 2025-08-05 07:24:00.565717 | 2025-08-05 07:24:00.565850 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-05 07:24:01.648500 | debian-bookworm | changed: 2025-08-05 07:24:01.648728 | debian-bookworm | cd+++++++++ src/ 2025-08-05 07:24:01.648763 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-05 07:24:01.648787 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-05 07:24:01.648809 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-08-05 07:24:01.648830 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007953 2025-08-05 07:24:26.762288 | 2025-08-05 07:24:26.762462 | TASK [upload-logs : Upload logs to log server] 2025-08-05 07:24:27.301209 | localhost | Output suppressed because no_log was given 2025-08-05 07:24:27.303106 | 2025-08-05 07:24:27.303216 | LOOP [upload-logs : Compress console log and json output] 2025-08-05 07:24:27.349762 | localhost | skipping: Conditional result was False 2025-08-05 07:24:27.357810 | localhost | skipping: Conditional result was False 2025-08-05 07:24:27.370544 | 2025-08-05 07:24:27.370675 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-05 07:24:27.425004 | localhost | skipping: Conditional result was False 2025-08-05 07:24:27.426254 | 2025-08-05 07:24:27.433568 | localhost | skipping: Conditional result was False 2025-08-05 07:24:27.438088 | 2025-08-05 07:24:27.438202 | LOOP [upload-logs : Upload console log and json output]