2025-06-24 03:04:33.891849 | Job console starting 2025-06-24 03:04:33.902736 | Updating git repos 2025-06-24 03:04:33.928046 | Cloning repos into workspace 2025-06-24 03:04:33.965655 | Restoring repo states 2025-06-24 03:04:33.969390 | Merging changes 2025-06-24 03:04:33.969407 | Checking out repos 2025-06-24 03:04:34.032882 | Preparing playbooks 2025-06-24 03:04:34.845016 | Running Ansible setup 2025-06-24 03:04:39.952164 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-24 03:04:40.856846 | 2025-06-24 03:04:40.856971 | PLAY [Base pre] 2025-06-24 03:04:40.872114 | 2025-06-24 03:04:40.872229 | TASK [Setup log path fact] 2025-06-24 03:04:40.895625 | debian-bookworm | ok 2025-06-24 03:04:40.919679 | 2025-06-24 03:04:40.919801 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-24 03:04:40.997156 | debian-bookworm | ok 2025-06-24 03:04:41.028063 | 2025-06-24 03:04:41.028201 | TASK [emit-job-header : Print job information] 2025-06-24 03:04:41.086019 | # Job Information 2025-06-24 03:04:41.086192 | Ansible Version: 2.16.14 2025-06-24 03:04:41.086226 | Job: python-black 2025-06-24 03:04:41.086258 | Pipeline: periodic-daily 2025-06-24 03:04:41.086281 | Executor: 521e9411259a 2025-06-24 03:04:41.086301 | Triggered by: https://github.com/osism/netbox-plugin-osism 2025-06-24 03:04:41.086323 | Event ID: 2069ac27d8b840c7a1f5ce2ed9975477 2025-06-24 03:04:41.092684 | 2025-06-24 03:04:41.092783 | LOOP [emit-job-header : Print node information] 2025-06-24 03:04:41.192548 | debian-bookworm | ok: 2025-06-24 03:04:41.192706 | debian-bookworm | # Node Information 2025-06-24 03:04:41.192739 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-24 03:04:41.192764 | debian-bookworm | Hostname: debian 2025-06-24 03:04:41.192785 | debian-bookworm | Username: zuul 2025-06-24 03:04:41.192806 | debian-bookworm | Distro: Debian 12.11 2025-06-24 03:04:41.192829 | debian-bookworm | Provider: regiocloud-a 2025-06-24 03:04:41.192851 | debian-bookworm | Region: 2025-06-24 03:04:41.192871 | debian-bookworm | Label: debian-bookworm 2025-06-24 03:04:41.192891 | debian-bookworm | Product Name: OpenStack Nova 2025-06-24 03:04:41.192911 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea6:c29c 2025-06-24 03:04:41.211957 | 2025-06-24 03:04:41.212073 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-24 03:04:41.972667 | debian-bookworm -> localhost | changed 2025-06-24 03:04:41.979445 | 2025-06-24 03:04:41.979554 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-24 03:04:43.297856 | debian-bookworm -> localhost | changed 2025-06-24 03:04:43.309224 | 2025-06-24 03:04:43.309339 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-24 03:04:43.568431 | debian-bookworm -> localhost | ok 2025-06-24 03:04:43.574363 | 2025-06-24 03:04:43.574474 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-24 03:04:43.611414 | debian-bookworm | ok 2025-06-24 03:04:43.632204 | debian-bookworm | included: /var/lib/zuul/builds/30f74d159fac46a3b095e2bb59c75959/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-24 03:04:43.638332 | 2025-06-24 03:04:43.638435 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-24 03:04:44.954038 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-24 03:04:44.954370 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/30f74d159fac46a3b095e2bb59c75959/work/30f74d159fac46a3b095e2bb59c75959_id_rsa 2025-06-24 03:04:44.954437 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/30f74d159fac46a3b095e2bb59c75959/work/30f74d159fac46a3b095e2bb59c75959_id_rsa.pub 2025-06-24 03:04:44.954480 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-24 03:04:44.954522 | debian-bookworm -> localhost | SHA256:xIq69q6d8kP7GEv+3323xYJPRrPO28nYdkoPA/yRFD8 zuul-build-sshkey 2025-06-24 03:04:44.954559 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-24 03:04:44.954617 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-24 03:04:44.954656 | debian-bookworm -> localhost | | . | 2025-06-24 03:04:44.954694 | debian-bookworm -> localhost | | . o | 2025-06-24 03:04:44.954729 | debian-bookworm -> localhost | | o .E.| 2025-06-24 03:04:44.954764 | debian-bookworm -> localhost | | . o . . ..| 2025-06-24 03:04:44.954798 | debian-bookworm -> localhost | | . . S o = | 2025-06-24 03:04:44.954861 | debian-bookworm -> localhost | | .. = = | 2025-06-24 03:04:44.954902 | debian-bookworm -> localhost | | ..o. . X o| 2025-06-24 03:04:44.954937 | debian-bookworm -> localhost | | o=o= . . B=B=| 2025-06-24 03:04:44.954974 | debian-bookworm -> localhost | | .o*X+o.. . .oBO=| 2025-06-24 03:04:44.955010 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-24 03:04:44.955110 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.808672 2025-06-24 03:04:44.963977 | 2025-06-24 03:04:44.964129 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-24 03:04:44.985263 | debian-bookworm | ok 2025-06-24 03:04:44.996047 | debian-bookworm | included: /var/lib/zuul/builds/30f74d159fac46a3b095e2bb59c75959/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-24 03:04:45.006320 | 2025-06-24 03:04:45.006429 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-24 03:04:45.030372 | debian-bookworm | skipping: Conditional result was False 2025-06-24 03:04:45.037179 | 2025-06-24 03:04:45.037279 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-24 03:04:45.584184 | debian-bookworm | changed 2025-06-24 03:04:45.590404 | 2025-06-24 03:04:45.590497 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-24 03:04:45.810466 | debian-bookworm | ok 2025-06-24 03:04:45.815885 | 2025-06-24 03:04:45.815989 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-24 03:04:46.421980 | debian-bookworm | changed 2025-06-24 03:04:46.431917 | 2025-06-24 03:04:46.432028 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-24 03:04:47.046371 | debian-bookworm | changed 2025-06-24 03:04:47.059113 | 2025-06-24 03:04:47.059226 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-24 03:04:47.092360 | debian-bookworm | skipping: Conditional result was False 2025-06-24 03:04:47.098323 | 2025-06-24 03:04:47.098419 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-24 03:04:47.590698 | debian-bookworm -> localhost | changed 2025-06-24 03:04:47.601002 | 2025-06-24 03:04:47.601117 | TASK [add-build-sshkey : Add back temp key] 2025-06-24 03:04:47.903776 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/30f74d159fac46a3b095e2bb59c75959/work/30f74d159fac46a3b095e2bb59c75959_id_rsa (zuul-build-sshkey) 2025-06-24 03:04:47.903995 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009848 2025-06-24 03:04:47.911407 | 2025-06-24 03:04:47.911508 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-24 03:04:48.288994 | debian-bookworm | ok 2025-06-24 03:04:48.293778 | 2025-06-24 03:04:48.293866 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-24 03:04:48.327169 | debian-bookworm | skipping: Conditional result was False 2025-06-24 03:04:48.340107 | 2025-06-24 03:04:48.340217 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-24 03:04:48.757697 | debian-bookworm | ok 2025-06-24 03:04:48.777765 | 2025-06-24 03:04:48.777876 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-24 03:04:48.835261 | debian-bookworm | ok 2025-06-24 03:04:48.840326 | 2025-06-24 03:04:48.840433 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-24 03:04:49.207327 | debian-bookworm -> localhost | ok 2025-06-24 03:04:49.213446 | 2025-06-24 03:04:49.213539 | TASK [validate-host : Collect information about the host] 2025-06-24 03:04:50.384946 | debian-bookworm | ok 2025-06-24 03:04:50.402737 | 2025-06-24 03:04:50.402926 | TASK [validate-host : Sanitize hostname] 2025-06-24 03:04:50.574346 | debian-bookworm | ok 2025-06-24 03:04:50.672257 | 2025-06-24 03:04:50.672389 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-24 03:04:51.616972 | debian-bookworm -> localhost | changed 2025-06-24 03:04:51.622420 | 2025-06-24 03:04:51.622523 | TASK [validate-host : Collect information about zuul worker] 2025-06-24 03:04:52.176521 | debian-bookworm | ok 2025-06-24 03:04:52.181123 | 2025-06-24 03:04:52.181231 | TASK [validate-host : Write out all zuul information for each host] 2025-06-24 03:04:52.924923 | debian-bookworm -> localhost | changed 2025-06-24 03:04:52.934573 | 2025-06-24 03:04:52.934670 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-24 03:04:53.205418 | debian-bookworm | ok 2025-06-24 03:04:53.217181 | 2025-06-24 03:04:53.217282 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-24 03:04:54.108012 | debian-bookworm | changed: 2025-06-24 03:04:54.108187 | debian-bookworm | cd+++++++++ src/ 2025-06-24 03:04:54.108223 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-24 03:04:54.108248 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-24 03:04:54.108271 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2025-06-24 03:04:54.108291 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006004 2025-06-24 03:05:21.183346 | 2025-06-24 03:05:21.183478 | TASK [upload-logs : Upload logs to log server] 2025-06-24 03:05:21.863842 | localhost | Output suppressed because no_log was given 2025-06-24 03:05:21.865753 | 2025-06-24 03:05:21.865865 | LOOP [upload-logs : Compress console log and json output] 2025-06-24 03:05:21.953445 | localhost | skipping: Conditional result was False 2025-06-24 03:05:21.967256 | localhost | skipping: Conditional result was False 2025-06-24 03:05:21.976281 | 2025-06-24 03:05:21.976471 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-24 03:05:22.037804 | localhost | skipping: Conditional result was False 2025-06-24 03:05:22.038413 | 2025-06-24 03:05:22.043669 | localhost | skipping: Conditional result was False 2025-06-24 03:05:22.056464 | 2025-06-24 03:05:22.056668 | LOOP [upload-logs : Upload console log and json output]