2025-10-25 03:09:17.307358 | Job console starting 2025-10-25 03:09:17.317185 | Updating git repos 2025-10-25 03:09:17.362402 | Cloning repos into workspace 2025-10-25 03:09:17.444617 | Restoring repo states 2025-10-25 03:09:17.468470 | Merging changes 2025-10-25 03:09:17.468491 | Checking out repos 2025-10-25 03:09:17.577101 | Preparing playbooks 2025-10-25 03:09:18.786050 | Running Ansible setup 2025-10-25 03:09:23.089433 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-25 03:09:24.170703 | 2025-10-25 03:09:24.170868 | PLAY [Base pre] 2025-10-25 03:09:24.183954 | 2025-10-25 03:09:24.184051 | TASK [Setup log path fact] 2025-10-25 03:09:24.216657 | debian-bookworm | ok 2025-10-25 03:09:24.268879 | 2025-10-25 03:09:24.269000 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-25 03:09:24.312951 | debian-bookworm | ok 2025-10-25 03:09:24.331520 | 2025-10-25 03:09:24.331626 | TASK [emit-job-header : Print job information] 2025-10-25 03:09:24.426334 | # Job Information 2025-10-25 03:09:24.426460 | Ansible Version: 2.16.14 2025-10-25 03:09:24.426488 | Job: python-black 2025-10-25 03:09:24.426514 | Pipeline: periodic-daily 2025-10-25 03:09:24.426533 | Executor: 521e9411259a 2025-10-25 03:09:24.426550 | Triggered by: https://github.com/osism/netbox-plugin-osism 2025-10-25 03:09:24.426568 | Event ID: 2fcc0ca166ed4d95b88fa6dd2607dc2d 2025-10-25 03:09:24.431885 | 2025-10-25 03:09:24.431969 | LOOP [emit-job-header : Print node information] 2025-10-25 03:09:24.582592 | debian-bookworm | ok: 2025-10-25 03:09:24.582784 | debian-bookworm | # Node Information 2025-10-25 03:09:24.582816 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-25 03:09:24.582864 | debian-bookworm | Hostname: debian 2025-10-25 03:09:24.582884 | debian-bookworm | Username: zuul 2025-10-25 03:09:24.582901 | debian-bookworm | Distro: Debian 12.12 2025-10-25 03:09:24.582921 | debian-bookworm | Provider: regiocloud-a 2025-10-25 03:09:24.582939 | debian-bookworm | Region: 2025-10-25 03:09:24.582956 | debian-bookworm | Label: debian-bookworm 2025-10-25 03:09:24.582972 | debian-bookworm | Product Name: OpenStack Nova 2025-10-25 03:09:24.582988 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe55:9874 2025-10-25 03:09:24.603733 | 2025-10-25 03:09:24.603843 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-25 03:09:25.197702 | debian-bookworm -> localhost | changed 2025-10-25 03:09:25.203417 | 2025-10-25 03:09:25.203510 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-25 03:09:26.475483 | debian-bookworm -> localhost | changed 2025-10-25 03:09:26.484065 | 2025-10-25 03:09:26.484145 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-25 03:09:26.843993 | debian-bookworm -> localhost | ok 2025-10-25 03:09:26.848799 | 2025-10-25 03:09:26.848877 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-25 03:09:26.875011 | debian-bookworm | ok 2025-10-25 03:09:26.888878 | debian-bookworm | included: /var/lib/zuul/builds/f592b23aaa084595a90513d1aef6cb27/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-25 03:09:26.893563 | 2025-10-25 03:09:26.893634 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-25 03:09:27.801213 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-25 03:09:27.801406 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f592b23aaa084595a90513d1aef6cb27/work/f592b23aaa084595a90513d1aef6cb27_id_rsa 2025-10-25 03:09:27.801443 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f592b23aaa084595a90513d1aef6cb27/work/f592b23aaa084595a90513d1aef6cb27_id_rsa.pub 2025-10-25 03:09:27.801469 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-25 03:09:27.801494 | debian-bookworm -> localhost | SHA256:sRj8psQHreShRdFMIliOFds7ZCHj2On3IzySX3n7vcI zuul-build-sshkey 2025-10-25 03:09:27.801516 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-25 03:09:27.801545 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-25 03:09:27.801567 | debian-bookworm -> localhost | | oB.==. | 2025-10-25 03:09:27.801589 | debian-bookworm -> localhost | | .B X +o | 2025-10-25 03:09:27.801609 | debian-bookworm -> localhost | | o * @ o | 2025-10-25 03:09:27.801629 | debian-bookworm -> localhost | | . O O o | 2025-10-25 03:09:27.801649 | debian-bookworm -> localhost | | o X S | 2025-10-25 03:09:27.801675 | debian-bookworm -> localhost | | = * . | 2025-10-25 03:09:27.801696 | debian-bookworm -> localhost | | o = = .. | 2025-10-25 03:09:27.801716 | debian-bookworm -> localhost | | o + o .E. | 2025-10-25 03:09:27.801765 | debian-bookworm -> localhost | | . ....o. | 2025-10-25 03:09:27.801788 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-25 03:09:27.801835 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.498097 2025-10-25 03:09:27.808012 | 2025-10-25 03:09:27.808100 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-25 03:09:27.835336 | debian-bookworm | ok 2025-10-25 03:09:27.844427 | debian-bookworm | included: /var/lib/zuul/builds/f592b23aaa084595a90513d1aef6cb27/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-25 03:09:27.853130 | 2025-10-25 03:09:27.853215 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-25 03:09:27.866184 | debian-bookworm | skipping: Conditional result was False 2025-10-25 03:09:27.872488 | 2025-10-25 03:09:27.872585 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-25 03:09:28.551127 | debian-bookworm | changed 2025-10-25 03:09:28.563088 | 2025-10-25 03:09:28.563189 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-25 03:09:28.822908 | debian-bookworm | ok 2025-10-25 03:09:28.831424 | 2025-10-25 03:09:28.831553 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-25 03:09:29.486359 | debian-bookworm | changed 2025-10-25 03:09:29.503030 | 2025-10-25 03:09:29.503137 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-25 03:09:30.169631 | debian-bookworm | changed 2025-10-25 03:09:30.173936 | 2025-10-25 03:09:30.174008 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-25 03:09:30.196977 | debian-bookworm | skipping: Conditional result was False 2025-10-25 03:09:30.201664 | 2025-10-25 03:09:30.201757 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-25 03:09:30.579073 | debian-bookworm -> localhost | changed 2025-10-25 03:09:30.589616 | 2025-10-25 03:09:30.589728 | TASK [add-build-sshkey : Add back temp key] 2025-10-25 03:09:31.166027 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f592b23aaa084595a90513d1aef6cb27/work/f592b23aaa084595a90513d1aef6cb27_id_rsa (zuul-build-sshkey) 2025-10-25 03:09:31.166230 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027784 2025-10-25 03:09:31.173508 | 2025-10-25 03:09:31.173600 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-25 03:09:31.591132 | debian-bookworm | ok 2025-10-25 03:09:31.595878 | 2025-10-25 03:09:31.595961 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-25 03:09:31.618654 | debian-bookworm | skipping: Conditional result was False 2025-10-25 03:09:31.628242 | 2025-10-25 03:09:31.628328 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-25 03:09:32.029436 | debian-bookworm | ok 2025-10-25 03:09:32.039632 | 2025-10-25 03:09:32.039762 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-25 03:09:32.082512 | debian-bookworm | ok 2025-10-25 03:09:32.090663 | 2025-10-25 03:09:32.090787 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-25 03:09:32.392385 | debian-bookworm -> localhost | ok 2025-10-25 03:09:32.398476 | 2025-10-25 03:09:32.398560 | TASK [validate-host : Collect information about the host] 2025-10-25 03:09:33.429542 | debian-bookworm | ok 2025-10-25 03:09:33.448653 | 2025-10-25 03:09:33.449014 | TASK [validate-host : Sanitize hostname] 2025-10-25 03:09:33.582152 | debian-bookworm | ok 2025-10-25 03:09:33.619113 | 2025-10-25 03:09:33.622896 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-25 03:09:34.542420 | debian-bookworm -> localhost | changed 2025-10-25 03:09:34.548184 | 2025-10-25 03:09:34.548293 | TASK [validate-host : Collect information about zuul worker] 2025-10-25 03:09:35.054154 | debian-bookworm | ok 2025-10-25 03:09:35.062464 | 2025-10-25 03:09:35.062659 | TASK [validate-host : Write out all zuul information for each host] 2025-10-25 03:09:36.063424 | debian-bookworm -> localhost | changed 2025-10-25 03:09:36.080748 | 2025-10-25 03:09:36.082975 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-25 03:09:36.349429 | debian-bookworm | ok 2025-10-25 03:09:36.355489 | 2025-10-25 03:09:36.355577 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-25 03:09:37.297041 | debian-bookworm | changed: 2025-10-25 03:09:37.297205 | debian-bookworm | cd+++++++++ src/ 2025-10-25 03:09:37.297239 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-25 03:09:37.297264 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-25 03:09:37.297286 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2025-10-25 03:09:37.297306 | debian-bookworm | localhost | ok: Runtime: 0:00:00.016833 2025-10-25 03:10:04.565481 | 2025-10-25 03:10:04.565569 | TASK [upload-logs : Upload logs to log server] 2025-10-25 03:10:05.387034 | localhost | Output suppressed because no_log was given 2025-10-25 03:10:05.388367 | 2025-10-25 03:10:05.388440 | LOOP [upload-logs : Compress console log and json output] 2025-10-25 03:10:05.457800 | localhost | skipping: Conditional result was False 2025-10-25 03:10:05.468732 | localhost | skipping: Conditional result was False 2025-10-25 03:10:05.473699 | 2025-10-25 03:10:05.473786 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-25 03:10:05.509985 | localhost | skipping: Conditional result was False 2025-10-25 03:10:05.510180 | 2025-10-25 03:10:05.513913 | localhost | skipping: Conditional result was False 2025-10-25 03:10:05.519421 | 2025-10-25 03:10:05.519499 | LOOP [upload-logs : Upload console log and json output]