2025-07-12 03:01:23.030464 | Job console starting 2025-07-12 03:01:23.051405 | Updating git repos 2025-07-12 03:01:23.409168 | Cloning repos into workspace 2025-07-12 03:01:23.520270 | Restoring repo states 2025-07-12 03:01:23.530339 | Merging changes 2025-07-12 03:01:23.530352 | Checking out repos 2025-07-12 03:01:23.657019 | Preparing playbooks 2025-07-12 03:01:25.183362 | Running Ansible setup 2025-07-12 03:01:31.281095 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-12 03:01:33.052637 | 2025-07-12 03:01:33.053244 | PLAY [Base pre] 2025-07-12 03:01:33.088484 | 2025-07-12 03:01:33.088597 | TASK [Setup log path fact] 2025-07-12 03:01:33.106061 | debian-bookworm | ok 2025-07-12 03:01:33.130738 | 2025-07-12 03:01:33.131396 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-12 03:01:33.261045 | debian-bookworm | ok 2025-07-12 03:01:33.328433 | 2025-07-12 03:01:33.338816 | TASK [emit-job-header : Print job information] 2025-07-12 03:01:33.457474 | # Job Information 2025-07-12 03:01:33.457610 | Ansible Version: 2.16.14 2025-07-12 03:01:33.457640 | Job: python-black 2025-07-12 03:01:33.457668 | Pipeline: periodic-daily 2025-07-12 03:01:33.457689 | Executor: 521e9411259a 2025-07-12 03:01:33.457706 | Triggered by: https://github.com/osism/pulpfiction 2025-07-12 03:01:33.457755 | Event ID: 744fbf6b58484578b4699169698c7837 2025-07-12 03:01:33.462131 | 2025-07-12 03:01:33.462222 | LOOP [emit-job-header : Print node information] 2025-07-12 03:01:33.842584 | debian-bookworm | ok: 2025-07-12 03:01:33.842776 | debian-bookworm | # Node Information 2025-07-12 03:01:33.842806 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-12 03:01:33.842827 | debian-bookworm | Hostname: debian 2025-07-12 03:01:33.842860 | debian-bookworm | Username: zuul 2025-07-12 03:01:33.842878 | debian-bookworm | Distro: Debian 12.11 2025-07-12 03:01:33.842897 | debian-bookworm | Provider: regiocloud-a 2025-07-12 03:01:33.842915 | debian-bookworm | Region: 2025-07-12 03:01:33.842933 | debian-bookworm | Label: debian-bookworm 2025-07-12 03:01:33.842949 | debian-bookworm | Product Name: OpenStack Nova 2025-07-12 03:01:33.842965 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9a:ca3d 2025-07-12 03:01:33.858968 | 2025-07-12 03:01:33.859069 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-12 03:01:35.247035 | debian-bookworm -> localhost | changed 2025-07-12 03:01:35.266684 | 2025-07-12 03:01:35.266791 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-12 03:01:37.929567 | debian-bookworm -> localhost | changed 2025-07-12 03:01:37.938494 | 2025-07-12 03:01:37.938585 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-12 03:01:38.771799 | debian-bookworm -> localhost | ok 2025-07-12 03:01:38.778970 | 2025-07-12 03:01:38.779110 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-12 03:01:38.901145 | debian-bookworm | ok 2025-07-12 03:01:38.948218 | debian-bookworm | included: /var/lib/zuul/builds/5bc0087c162144b08cee76a2526c633b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-12 03:01:38.968499 | 2025-07-12 03:01:38.968603 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-12 03:01:43.117559 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-12 03:01:43.117768 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5bc0087c162144b08cee76a2526c633b/work/5bc0087c162144b08cee76a2526c633b_id_rsa 2025-07-12 03:01:43.117816 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5bc0087c162144b08cee76a2526c633b/work/5bc0087c162144b08cee76a2526c633b_id_rsa.pub 2025-07-12 03:01:43.117852 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-12 03:01:43.117881 | debian-bookworm -> localhost | SHA256:NTidDSN9eJDn3fUCpRy6MpbM+xUp23Rtfc/NjTS5I9o zuul-build-sshkey 2025-07-12 03:01:43.117901 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-12 03:01:43.117928 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-12 03:01:43.117946 | debian-bookworm -> localhost | | ..++... | 2025-07-12 03:01:43.117965 | debian-bookworm -> localhost | | ++B=o .| 2025-07-12 03:01:43.117982 | debian-bookworm -> localhost | | o *=+o .o| 2025-07-12 03:01:43.117998 | debian-bookworm -> localhost | | o + o..oo+| 2025-07-12 03:01:43.118015 | debian-bookworm -> localhost | | S o + =.=| 2025-07-12 03:01:43.118036 | debian-bookworm -> localhost | | . + = + B=| 2025-07-12 03:01:43.118053 | debian-bookworm -> localhost | | . . + + *| 2025-07-12 03:01:43.118069 | debian-bookworm -> localhost | | . + . . | 2025-07-12 03:01:43.118100 | debian-bookworm -> localhost | | o E | 2025-07-12 03:01:43.118119 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-12 03:01:43.118178 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.257034 2025-07-12 03:01:43.124786 | 2025-07-12 03:01:43.124876 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-12 03:01:43.206805 | debian-bookworm | ok 2025-07-12 03:01:43.221515 | debian-bookworm | included: /var/lib/zuul/builds/5bc0087c162144b08cee76a2526c633b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-12 03:01:43.244835 | 2025-07-12 03:01:43.244932 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-12 03:01:43.304743 | debian-bookworm | skipping: Conditional result was False 2025-07-12 03:01:43.322711 | 2025-07-12 03:01:43.322805 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-12 03:01:44.620243 | debian-bookworm | changed 2025-07-12 03:01:44.625865 | 2025-07-12 03:01:44.625953 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-12 03:01:44.912678 | debian-bookworm | ok 2025-07-12 03:01:44.958939 | 2025-07-12 03:01:44.959048 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-12 03:01:45.782667 | debian-bookworm | changed 2025-07-12 03:01:45.810810 | 2025-07-12 03:01:45.810936 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-12 03:01:46.579822 | debian-bookworm | changed 2025-07-12 03:01:46.595895 | 2025-07-12 03:01:46.597546 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-12 03:01:46.705824 | debian-bookworm | skipping: Conditional result was False 2025-07-12 03:01:46.711726 | 2025-07-12 03:01:46.711823 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-12 03:01:47.889653 | debian-bookworm -> localhost | changed 2025-07-12 03:01:47.898171 | 2025-07-12 03:01:47.898258 | TASK [add-build-sshkey : Add back temp key] 2025-07-12 03:01:48.929136 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5bc0087c162144b08cee76a2526c633b/work/5bc0087c162144b08cee76a2526c633b_id_rsa (zuul-build-sshkey) 2025-07-12 03:01:48.929324 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.039703 2025-07-12 03:01:48.935651 | 2025-07-12 03:01:48.935737 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-12 03:01:49.874793 | debian-bookworm | ok 2025-07-12 03:01:49.879269 | 2025-07-12 03:01:49.879345 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-12 03:01:49.956040 | debian-bookworm | skipping: Conditional result was False 2025-07-12 03:01:49.964721 | 2025-07-12 03:01:49.964804 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-12 03:01:50.757170 | debian-bookworm | ok 2025-07-12 03:01:50.774546 | 2025-07-12 03:01:50.774657 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-12 03:01:50.839983 | debian-bookworm | ok 2025-07-12 03:01:50.845488 | 2025-07-12 03:01:50.845586 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-12 03:01:51.677726 | debian-bookworm -> localhost | ok 2025-07-12 03:01:51.682788 | 2025-07-12 03:01:51.682895 | TASK [validate-host : Collect information about the host] 2025-07-12 03:01:53.022781 | debian-bookworm | ok 2025-07-12 03:01:53.032233 | 2025-07-12 03:01:53.032318 | TASK [validate-host : Sanitize hostname] 2025-07-12 03:01:53.220854 | debian-bookworm | ok 2025-07-12 03:01:53.281025 | 2025-07-12 03:01:53.281137 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-12 03:01:54.618448 | debian-bookworm -> localhost | changed 2025-07-12 03:01:54.623116 | 2025-07-12 03:01:54.623197 | TASK [validate-host : Collect information about zuul worker] 2025-07-12 03:01:55.368100 | debian-bookworm | ok 2025-07-12 03:01:55.371784 | 2025-07-12 03:01:55.371863 | TASK [validate-host : Write out all zuul information for each host] 2025-07-12 03:01:56.576396 | debian-bookworm -> localhost | changed 2025-07-12 03:01:56.584393 | 2025-07-12 03:01:56.584522 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-12 03:01:56.823194 | debian-bookworm | ok 2025-07-12 03:01:56.838671 | 2025-07-12 03:01:56.838756 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-12 03:01:58.073278 | debian-bookworm | changed: 2025-07-12 03:01:58.073421 | debian-bookworm | cd+++++++++ src/ 2025-07-12 03:01:58.073449 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-12 03:01:58.073469 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-12 03:01:58.073487 | debian-bookworm | cd+++++++++ src/github.com/osism/pulpfiction/ 2025-07-12 03:01:58.073504 | debian-bookworm | localhost | ok: Runtime: 0:00:00.018256 2025-07-12 03:02:29.601239 | 2025-07-12 03:02:29.601445 | TASK [upload-logs : Upload logs to log server] 2025-07-12 03:02:31.161034 | localhost | Output suppressed because no_log was given 2025-07-12 03:02:31.163510 | 2025-07-12 03:02:31.163624 | LOOP [upload-logs : Compress console log and json output] 2025-07-12 03:02:31.277396 | localhost | skipping: Conditional result was False 2025-07-12 03:02:31.287291 | localhost | skipping: Conditional result was False 2025-07-12 03:02:31.295751 | 2025-07-12 03:02:31.295890 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-12 03:02:31.400056 | localhost | skipping: Conditional result was False 2025-07-12 03:02:31.400405 | 2025-07-12 03:02:31.423354 | localhost | skipping: Conditional result was False 2025-07-12 03:02:31.431645 | 2025-07-12 03:02:31.431803 | LOOP [upload-logs : Upload console log and json output]