2025-10-07 03:02:28.514269 | Job console starting 2025-10-07 03:02:28.523266 | Updating git repos 2025-10-07 03:02:28.564297 | Cloning repos into workspace 2025-10-07 03:02:28.610408 | Restoring repo states 2025-10-07 03:02:28.617675 | Merging changes 2025-10-07 03:02:28.617689 | Checking out repos 2025-10-07 03:02:28.695538 | Preparing playbooks 2025-10-07 03:02:29.425436 | Running Ansible setup 2025-10-07 03:02:34.215878 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-07 03:02:35.340428 | 2025-10-07 03:02:35.340609 | PLAY [Base pre] 2025-10-07 03:02:35.385033 | 2025-10-07 03:02:35.385195 | TASK [Setup log path fact] 2025-10-07 03:02:35.411248 | debian-bookworm | ok 2025-10-07 03:02:35.443980 | 2025-10-07 03:02:35.444142 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-07 03:02:35.538039 | debian-bookworm | ok 2025-10-07 03:02:35.553962 | 2025-10-07 03:02:35.554093 | TASK [emit-job-header : Print job information] 2025-10-07 03:02:35.623936 | # Job Information 2025-10-07 03:02:35.624131 | Ansible Version: 2.16.14 2025-10-07 03:02:35.624168 | Job: python-black 2025-10-07 03:02:35.624200 | Pipeline: periodic-daily 2025-10-07 03:02:35.624223 | Executor: 521e9411259a 2025-10-07 03:02:35.624244 | Triggered by: https://github.com/osism/node-image 2025-10-07 03:02:35.624266 | Event ID: 574cdb795ac54230ae8f656ace1ff62a 2025-10-07 03:02:35.629305 | 2025-10-07 03:02:35.629415 | LOOP [emit-job-header : Print node information] 2025-10-07 03:02:35.816991 | debian-bookworm | ok: 2025-10-07 03:02:35.817154 | debian-bookworm | # Node Information 2025-10-07 03:02:35.817182 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-07 03:02:35.817202 | debian-bookworm | Hostname: debian 2025-10-07 03:02:35.817220 | debian-bookworm | Username: zuul 2025-10-07 03:02:35.817238 | debian-bookworm | Distro: Debian 12.12 2025-10-07 03:02:35.817257 | debian-bookworm | Provider: regiocloud-a 2025-10-07 03:02:35.817273 | debian-bookworm | Region: 2025-10-07 03:02:35.817291 | debian-bookworm | Label: debian-bookworm 2025-10-07 03:02:35.817307 | debian-bookworm | Product Name: OpenStack Nova 2025-10-07 03:02:35.817324 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4a:49f5 2025-10-07 03:02:35.842089 | 2025-10-07 03:02:35.842201 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-07 03:02:36.784285 | debian-bookworm -> localhost | changed 2025-10-07 03:02:36.789915 | 2025-10-07 03:02:36.790006 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-07 03:02:38.460532 | debian-bookworm -> localhost | changed 2025-10-07 03:02:38.469026 | 2025-10-07 03:02:38.469114 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-07 03:02:38.990666 | debian-bookworm -> localhost | ok 2025-10-07 03:02:38.995640 | 2025-10-07 03:02:38.995735 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-07 03:02:39.032657 | debian-bookworm | ok 2025-10-07 03:02:39.047508 | debian-bookworm | included: /var/lib/zuul/builds/31cd504302eb41308accb7a0bc01e855/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-07 03:02:39.052830 | 2025-10-07 03:02:39.052910 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-07 03:02:41.256446 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-07 03:02:41.256619 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/31cd504302eb41308accb7a0bc01e855/work/31cd504302eb41308accb7a0bc01e855_id_rsa 2025-10-07 03:02:41.256652 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/31cd504302eb41308accb7a0bc01e855/work/31cd504302eb41308accb7a0bc01e855_id_rsa.pub 2025-10-07 03:02:41.256674 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-07 03:02:41.256694 | debian-bookworm -> localhost | SHA256:fegDEneQu5SFzCrPpe+Jw48zhJoCBlHu9ogM6YI77TU zuul-build-sshkey 2025-10-07 03:02:41.256723 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-07 03:02:41.256749 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-07 03:02:41.256767 | debian-bookworm -> localhost | | .. o.o | 2025-10-07 03:02:41.256784 | debian-bookworm -> localhost | |.. =.. | 2025-10-07 03:02:41.256801 | debian-bookworm -> localhost | | .. ...+. | 2025-10-07 03:02:41.256817 | debian-bookworm -> localhost | |.o . .o=o . | 2025-10-07 03:02:41.256833 | debian-bookworm -> localhost | |+ o =.+S.o . | 2025-10-07 03:02:41.256856 | debian-bookworm -> localhost | |*+ o. =..o . | 2025-10-07 03:02:41.256873 | debian-bookworm -> localhost | |*+.oEo . o | 2025-10-07 03:02:41.256889 | debian-bookworm -> localhost | |+.+. .=o.. . | 2025-10-07 03:02:41.256906 | debian-bookworm -> localhost | |.+. o*+ | 2025-10-07 03:02:41.256923 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-07 03:02:41.256965 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.518053 2025-10-07 03:02:41.261972 | 2025-10-07 03:02:41.262055 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-07 03:02:41.302188 | debian-bookworm | ok 2025-10-07 03:02:41.316211 | debian-bookworm | included: /var/lib/zuul/builds/31cd504302eb41308accb7a0bc01e855/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-07 03:02:41.324056 | 2025-10-07 03:02:41.324142 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-07 03:02:41.347661 | debian-bookworm | skipping: Conditional result was False 2025-10-07 03:02:41.355418 | 2025-10-07 03:02:41.355501 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-07 03:02:41.933644 | debian-bookworm | changed 2025-10-07 03:02:41.938019 | 2025-10-07 03:02:41.938094 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-07 03:02:42.161167 | debian-bookworm | ok 2025-10-07 03:02:42.165768 | 2025-10-07 03:02:42.165850 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-07 03:02:42.762533 | debian-bookworm | changed 2025-10-07 03:02:42.774671 | 2025-10-07 03:02:42.774818 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-07 03:02:43.438416 | debian-bookworm | changed 2025-10-07 03:02:43.444590 | 2025-10-07 03:02:43.444678 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-07 03:02:43.488377 | debian-bookworm | skipping: Conditional result was False 2025-10-07 03:02:43.495038 | 2025-10-07 03:02:43.495122 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-07 03:02:44.220490 | debian-bookworm -> localhost | changed 2025-10-07 03:02:44.231388 | 2025-10-07 03:02:44.231492 | TASK [add-build-sshkey : Add back temp key] 2025-10-07 03:02:44.641813 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/31cd504302eb41308accb7a0bc01e855/work/31cd504302eb41308accb7a0bc01e855_id_rsa (zuul-build-sshkey) 2025-10-07 03:02:44.642015 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.028802 2025-10-07 03:02:44.649458 | 2025-10-07 03:02:44.649548 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-07 03:02:45.021661 | debian-bookworm | ok 2025-10-07 03:02:45.025648 | 2025-10-07 03:02:45.025743 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-07 03:02:45.038808 | debian-bookworm | skipping: Conditional result was False 2025-10-07 03:02:45.053325 | 2025-10-07 03:02:45.053403 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-07 03:02:45.392497 | debian-bookworm | ok 2025-10-07 03:02:45.415742 | 2025-10-07 03:02:45.415837 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-07 03:02:45.442604 | debian-bookworm | ok 2025-10-07 03:02:45.446581 | 2025-10-07 03:02:45.446652 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-07 03:02:46.062468 | debian-bookworm -> localhost | ok 2025-10-07 03:02:46.068862 | 2025-10-07 03:02:46.068959 | TASK [validate-host : Collect information about the host] 2025-10-07 03:02:47.235510 | debian-bookworm | ok 2025-10-07 03:02:47.260070 | 2025-10-07 03:02:47.260175 | TASK [validate-host : Sanitize hostname] 2025-10-07 03:02:47.383668 | debian-bookworm | ok 2025-10-07 03:02:47.412762 | 2025-10-07 03:02:47.412864 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-07 03:02:48.033989 | debian-bookworm -> localhost | changed 2025-10-07 03:02:48.040284 | 2025-10-07 03:02:48.041597 | TASK [validate-host : Collect information about zuul worker] 2025-10-07 03:02:48.503085 | debian-bookworm | ok 2025-10-07 03:02:48.507777 | 2025-10-07 03:02:48.507867 | TASK [validate-host : Write out all zuul information for each host] 2025-10-07 03:02:48.996057 | debian-bookworm -> localhost | changed 2025-10-07 03:02:49.011078 | 2025-10-07 03:02:49.011189 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-07 03:02:49.286207 | debian-bookworm | ok 2025-10-07 03:02:49.294868 | 2025-10-07 03:02:49.294982 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-07 03:02:51.178417 | debian-bookworm | changed: 2025-10-07 03:02:51.178576 | debian-bookworm | cd+++++++++ src/ 2025-10-07 03:02:51.178608 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-07 03:02:51.178632 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-07 03:02:51.178653 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-10-07 03:02:51.178673 | debian-bookworm | Containerfile 2025-10-07 03:02:51.178816 | debian-bookworm | localhost | ok: Runtime: 0:00:00.029073 2025-10-07 03:03:18.644495 | 2025-10-07 03:03:18.644575 | TASK [upload-logs : Upload logs to log server] 2025-10-07 03:03:19.652479 | localhost | Output suppressed because no_log was given 2025-10-07 03:03:19.653812 | 2025-10-07 03:03:19.653886 | LOOP [upload-logs : Compress console log and json output] 2025-10-07 03:03:19.744481 | localhost | skipping: Conditional result was False 2025-10-07 03:03:19.767401 | localhost | skipping: Conditional result was False 2025-10-07 03:03:19.771759 | 2025-10-07 03:03:19.771843 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-07 03:03:19.846791 | localhost | skipping: Conditional result was False 2025-10-07 03:03:19.847116 | 2025-10-07 03:03:19.856006 | localhost | skipping: Conditional result was False 2025-10-07 03:03:19.861107 | 2025-10-07 03:03:19.861187 | LOOP [upload-logs : Upload console log and json output]