2025-09-02 12:50:17.075905 | Job console starting 2025-09-02 12:50:17.115121 | Updating git repos 2025-09-02 12:50:17.167115 | Cloning repos into workspace 2025-09-02 12:50:17.267908 | Restoring repo states 2025-09-02 12:50:17.292123 | Merging changes 2025-09-02 12:50:17.902522 | Checking out repos 2025-09-02 12:50:17.981678 | Preparing playbooks 2025-09-02 12:50:19.027266 | Running Ansible setup 2025-09-02 12:50:23.821008 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-02 12:50:24.907188 | 2025-09-02 12:50:24.907348 | PLAY [Base pre] 2025-09-02 12:50:24.929261 | 2025-09-02 12:50:24.929414 | TASK [Setup log path fact] 2025-09-02 12:50:24.948333 | debian-bookworm | ok 2025-09-02 12:50:24.964341 | 2025-09-02 12:50:24.964499 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-02 12:50:24.993806 | debian-bookworm | ok 2025-09-02 12:50:25.003677 | 2025-09-02 12:50:25.003799 | TASK [emit-job-header : Print job information] 2025-09-02 12:50:25.042567 | # Job Information 2025-09-02 12:50:25.042779 | Ansible Version: 2.16.14 2025-09-02 12:50:25.042813 | Job: python-black 2025-09-02 12:50:25.042865 | Pipeline: check 2025-09-02 12:50:25.042888 | Executor: 521e9411259a 2025-09-02 12:50:25.042908 | Triggered by: https://github.com/osism/openstack-image-manager/pull/952 2025-09-02 12:50:25.042929 | Event ID: 5b1529a0-87fb-11f0-8e56-8151185e8214 2025-09-02 12:50:25.047809 | 2025-09-02 12:50:25.047934 | LOOP [emit-job-header : Print node information] 2025-09-02 12:50:25.198529 | debian-bookworm | ok: 2025-09-02 12:50:25.198913 | debian-bookworm | # Node Information 2025-09-02 12:50:25.198988 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-02 12:50:25.199034 | debian-bookworm | Hostname: debian 2025-09-02 12:50:25.199074 | debian-bookworm | Username: zuul 2025-09-02 12:50:25.199113 | debian-bookworm | Distro: Debian 12.11 2025-09-02 12:50:25.199158 | debian-bookworm | Provider: regiocloud-a 2025-09-02 12:50:25.199198 | debian-bookworm | Region: 2025-09-02 12:50:25.199237 | debian-bookworm | Label: debian-bookworm 2025-09-02 12:50:25.199272 | debian-bookworm | Product Name: OpenStack Nova 2025-09-02 12:50:25.199307 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea9:869a 2025-09-02 12:50:25.219658 | 2025-09-02 12:50:25.219798 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-02 12:50:25.769902 | debian-bookworm -> localhost | changed 2025-09-02 12:50:25.777551 | 2025-09-02 12:50:25.777695 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-02 12:50:27.066083 | debian-bookworm -> localhost | changed 2025-09-02 12:50:27.079546 | 2025-09-02 12:50:27.079703 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-02 12:50:27.479358 | debian-bookworm -> localhost | ok 2025-09-02 12:50:27.485755 | 2025-09-02 12:50:27.485900 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-02 12:50:27.536115 | debian-bookworm | ok 2025-09-02 12:50:27.554560 | debian-bookworm | included: /var/lib/zuul/builds/1c6d02a4ad6047be9fad97fa3dbc9943/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-02 12:50:27.560863 | 2025-09-02 12:50:27.560975 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-02 12:50:28.916204 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-02 12:50:28.916382 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1c6d02a4ad6047be9fad97fa3dbc9943/work/1c6d02a4ad6047be9fad97fa3dbc9943_id_rsa 2025-09-02 12:50:28.916419 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1c6d02a4ad6047be9fad97fa3dbc9943/work/1c6d02a4ad6047be9fad97fa3dbc9943_id_rsa.pub 2025-09-02 12:50:28.916444 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-02 12:50:28.916468 | debian-bookworm -> localhost | SHA256:Sv42DbbtCqBDaThL2zEst3jM4SKhzvwfBMxekLseXr0 zuul-build-sshkey 2025-09-02 12:50:28.916490 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-02 12:50:28.916521 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-02 12:50:28.916543 | debian-bookworm -> localhost | | .. | 2025-09-02 12:50:28.916564 | debian-bookworm -> localhost | | o.. | 2025-09-02 12:50:28.916610 | debian-bookworm -> localhost | | +.. | 2025-09-02 12:50:28.916632 | debian-bookworm -> localhost | | .ooo | 2025-09-02 12:50:28.916653 | debian-bookworm -> localhost | |+o+Bo.o S | 2025-09-02 12:50:28.916679 | debian-bookworm -> localhost | |o*X+*= oo | 2025-09-02 12:50:28.916699 | debian-bookworm -> localhost | |++=Bo.+..= | 2025-09-02 12:50:28.916719 | debian-bookworm -> localhost | |= o+ .E+ o | 2025-09-02 12:50:28.916739 | debian-bookworm -> localhost | | +.... .o+. | 2025-09-02 12:50:28.916760 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-02 12:50:28.916813 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.573438 2025-09-02 12:50:28.922694 | 2025-09-02 12:50:28.922783 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-02 12:50:28.957710 | debian-bookworm | ok 2025-09-02 12:50:28.966193 | debian-bookworm | included: /var/lib/zuul/builds/1c6d02a4ad6047be9fad97fa3dbc9943/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-02 12:50:28.980966 | 2025-09-02 12:50:28.981089 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-02 12:50:28.995275 | debian-bookworm | skipping: Conditional result was False 2025-09-02 12:50:29.002925 | 2025-09-02 12:50:29.003348 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-02 12:50:29.601078 | debian-bookworm | changed 2025-09-02 12:50:29.607884 | 2025-09-02 12:50:29.607991 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-02 12:50:29.857748 | debian-bookworm | ok 2025-09-02 12:50:29.866014 | 2025-09-02 12:50:29.866110 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-02 12:50:30.531934 | debian-bookworm | changed 2025-09-02 12:50:30.549353 | 2025-09-02 12:50:30.550817 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-02 12:50:31.214845 | debian-bookworm | changed 2025-09-02 12:50:31.220207 | 2025-09-02 12:50:31.220295 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-02 12:50:31.242887 | debian-bookworm | skipping: Conditional result was False 2025-09-02 12:50:31.249204 | 2025-09-02 12:50:31.249293 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-02 12:50:31.627319 | debian-bookworm -> localhost | changed 2025-09-02 12:50:31.638803 | 2025-09-02 12:50:31.638924 | TASK [add-build-sshkey : Add back temp key] 2025-09-02 12:50:31.925622 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1c6d02a4ad6047be9fad97fa3dbc9943/work/1c6d02a4ad6047be9fad97fa3dbc9943_id_rsa (zuul-build-sshkey) 2025-09-02 12:50:31.925833 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020320 2025-09-02 12:50:31.933146 | 2025-09-02 12:50:31.933236 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-02 12:50:32.284303 | debian-bookworm | ok 2025-09-02 12:50:32.289211 | 2025-09-02 12:50:32.289303 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-02 12:50:32.312254 | debian-bookworm | skipping: Conditional result was False 2025-09-02 12:50:32.323891 | 2025-09-02 12:50:32.324031 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-02 12:50:32.746771 | debian-bookworm | ok 2025-09-02 12:50:32.757809 | 2025-09-02 12:50:32.757907 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-02 12:50:32.793725 | debian-bookworm | ok 2025-09-02 12:50:32.804070 | 2025-09-02 12:50:32.804179 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-02 12:50:33.090890 | debian-bookworm -> localhost | ok 2025-09-02 12:50:33.096878 | 2025-09-02 12:50:33.096963 | TASK [validate-host : Collect information about the host] 2025-09-02 12:50:34.090488 | debian-bookworm | ok 2025-09-02 12:50:34.101709 | 2025-09-02 12:50:34.101816 | TASK [validate-host : Sanitize hostname] 2025-09-02 12:50:34.214147 | debian-bookworm | ok 2025-09-02 12:50:34.248937 | 2025-09-02 12:50:34.249083 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-02 12:50:34.778592 | debian-bookworm -> localhost | changed 2025-09-02 12:50:34.786269 | 2025-09-02 12:50:34.786403 | TASK [validate-host : Collect information about zuul worker] 2025-09-02 12:50:35.190304 | debian-bookworm | ok 2025-09-02 12:50:35.195395 | 2025-09-02 12:50:35.195511 | TASK [validate-host : Write out all zuul information for each host] 2025-09-02 12:50:35.787286 | debian-bookworm -> localhost | changed 2025-09-02 12:50:35.798352 | 2025-09-02 12:50:35.798467 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-02 12:50:36.065318 | debian-bookworm | ok 2025-09-02 12:50:36.075228 | 2025-09-02 12:50:36.075364 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-02 12:50:37.288690 | debian-bookworm | changed: 2025-09-02 12:50:37.288896 | debian-bookworm | cd+++++++++ src/ 2025-09-02 12:50:37.288933 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-02 12:50:37.288957 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-02 12:50:37.288979 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-09-02 12:50:37.288999 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007866 2025-09-02 12:51:01.867250 | 2025-09-02 12:51:01.867369 | TASK [upload-logs : Upload logs to log server] 2025-09-02 12:51:02.379135 | localhost | Output suppressed because no_log was given 2025-09-02 12:51:02.381128 | 2025-09-02 12:51:02.381242 | LOOP [upload-logs : Compress console log and json output] 2025-09-02 12:51:02.427449 | localhost | skipping: Conditional result was False 2025-09-02 12:51:02.433442 | localhost | skipping: Conditional result was False 2025-09-02 12:51:02.437311 | 2025-09-02 12:51:02.437418 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-02 12:51:02.481739 | localhost | skipping: Conditional result was False 2025-09-02 12:51:02.482083 | 2025-09-02 12:51:02.487632 | localhost | skipping: Conditional result was False 2025-09-02 12:51:02.494694 | 2025-09-02 12:51:02.494819 | LOOP [upload-logs : Upload console log and json output]