2025-12-04 03:05:46.188058 | Job console starting 2025-12-04 03:05:46.199515 | Updating git repos 2025-12-04 03:05:46.239195 | Cloning repos into workspace 2025-12-04 03:05:46.390193 | Restoring repo states 2025-12-04 03:05:46.421138 | Merging changes 2025-12-04 03:05:46.421160 | Checking out repos 2025-12-04 03:05:46.503305 | Preparing playbooks 2025-12-04 03:05:48.478168 | Running Ansible setup 2025-12-04 03:05:55.397664 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-04 03:05:56.388179 | 2025-12-04 03:05:56.388355 | PLAY [Base pre] 2025-12-04 03:05:56.410484 | 2025-12-04 03:05:56.410691 | TASK [Setup log path fact] 2025-12-04 03:05:56.445421 | debian-bookworm | ok 2025-12-04 03:05:56.463442 | 2025-12-04 03:05:56.463610 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-04 03:05:56.497950 | debian-bookworm | ok 2025-12-04 03:05:56.514149 | 2025-12-04 03:05:56.514287 | TASK [emit-job-header : Print job information] 2025-12-04 03:05:56.566401 | # Job Information 2025-12-04 03:05:56.566601 | Ansible Version: 2.16.14 2025-12-04 03:05:56.566736 | Job: python-black 2025-12-04 03:05:56.566782 | Pipeline: periodic-daily 2025-12-04 03:05:56.566809 | Executor: 521e9411259a 2025-12-04 03:05:56.566854 | Triggered by: https://github.com/osism/netbox-plugin-osism 2025-12-04 03:05:56.566880 | Event ID: 43a297e00d874473b1611c7cbd8085f5 2025-12-04 03:05:56.572205 | 2025-12-04 03:05:56.572340 | LOOP [emit-job-header : Print node information] 2025-12-04 03:05:56.759564 | debian-bookworm | ok: 2025-12-04 03:05:56.759804 | debian-bookworm | # Node Information 2025-12-04 03:05:56.759841 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-04 03:05:56.759950 | debian-bookworm | Hostname: debian 2025-12-04 03:05:56.759975 | debian-bookworm | Username: zuul 2025-12-04 03:05:56.759997 | debian-bookworm | Distro: Debian 12.12 2025-12-04 03:05:56.760021 | debian-bookworm | Provider: regiocloud-a 2025-12-04 03:05:56.760043 | debian-bookworm | Region: 2025-12-04 03:05:56.760065 | debian-bookworm | Label: debian-bookworm 2025-12-04 03:05:56.760085 | debian-bookworm | Product Name: OpenStack Nova 2025-12-04 03:05:56.760105 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe50:cb3a 2025-12-04 03:05:56.783905 | 2025-12-04 03:05:56.784140 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-04 03:05:57.302376 | debian-bookworm -> localhost | changed 2025-12-04 03:05:57.312289 | 2025-12-04 03:05:57.312441 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-04 03:05:58.677400 | debian-bookworm -> localhost | changed 2025-12-04 03:05:58.691112 | 2025-12-04 03:05:58.691258 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-04 03:05:59.040476 | debian-bookworm -> localhost | ok 2025-12-04 03:05:59.048071 | 2025-12-04 03:05:59.048214 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-04 03:05:59.105338 | debian-bookworm | ok 2025-12-04 03:05:59.130644 | debian-bookworm | included: /var/lib/zuul/builds/ca2f710cf2af495c95950339affb58b1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-04 03:05:59.137414 | 2025-12-04 03:05:59.137553 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-04 03:06:00.749484 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-04 03:06:00.749752 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ca2f710cf2af495c95950339affb58b1/work/ca2f710cf2af495c95950339affb58b1_id_rsa 2025-12-04 03:06:00.749796 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ca2f710cf2af495c95950339affb58b1/work/ca2f710cf2af495c95950339affb58b1_id_rsa.pub 2025-12-04 03:06:00.749823 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-04 03:06:00.749847 | debian-bookworm -> localhost | SHA256:xpPTmIXflsZp5y3iVbTa5jONVgK/0Mo8B3IDt0M5AX4 zuul-build-sshkey 2025-12-04 03:06:00.749870 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-04 03:06:00.749906 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-04 03:06:00.749928 | debian-bookworm -> localhost | | .. | 2025-12-04 03:06:00.749951 | debian-bookworm -> localhost | | o . | 2025-12-04 03:06:00.749971 | debian-bookworm -> localhost | | . o Eo .| 2025-12-04 03:06:00.749991 | debian-bookworm -> localhost | | . B.+*o ..| 2025-12-04 03:06:00.750012 | debian-bookworm -> localhost | | S o+O*...| 2025-12-04 03:06:00.750036 | debian-bookworm -> localhost | | . o.+Bo*o.| 2025-12-04 03:06:00.750057 | debian-bookworm -> localhost | | =.B+Bo| 2025-12-04 03:06:00.750077 | debian-bookworm -> localhost | | .=oB+.| 2025-12-04 03:06:00.750098 | debian-bookworm -> localhost | | .+ .o| 2025-12-04 03:06:00.750119 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-04 03:06:00.750178 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.832852 2025-12-04 03:06:00.758518 | 2025-12-04 03:06:00.758680 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-04 03:06:00.852458 | debian-bookworm | ok 2025-12-04 03:06:00.918726 | debian-bookworm | included: /var/lib/zuul/builds/ca2f710cf2af495c95950339affb58b1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-04 03:06:01.047890 | 2025-12-04 03:06:01.048749 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-04 03:06:01.137852 | debian-bookworm | skipping: Conditional result was False 2025-12-04 03:06:01.147722 | 2025-12-04 03:06:01.147965 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-04 03:06:02.083965 | debian-bookworm | changed 2025-12-04 03:06:02.090056 | 2025-12-04 03:06:02.090185 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-04 03:06:02.410783 | debian-bookworm | ok 2025-12-04 03:06:02.419199 | 2025-12-04 03:06:02.419328 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-04 03:06:03.264113 | debian-bookworm | changed 2025-12-04 03:06:03.284026 | 2025-12-04 03:06:03.284179 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-04 03:06:04.242349 | debian-bookworm | changed 2025-12-04 03:06:04.288109 | 2025-12-04 03:06:04.288260 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-04 03:06:04.332709 | debian-bookworm | skipping: Conditional result was False 2025-12-04 03:06:04.339657 | 2025-12-04 03:06:04.339789 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-04 03:06:05.152673 | debian-bookworm -> localhost | changed 2025-12-04 03:06:05.164261 | 2025-12-04 03:06:05.164394 | TASK [add-build-sshkey : Add back temp key] 2025-12-04 03:06:05.953204 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ca2f710cf2af495c95950339affb58b1/work/ca2f710cf2af495c95950339affb58b1_id_rsa (zuul-build-sshkey) 2025-12-04 03:06:05.953477 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.029935 2025-12-04 03:06:05.962055 | 2025-12-04 03:06:05.962184 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-04 03:06:06.474253 | debian-bookworm | ok 2025-12-04 03:06:06.480944 | 2025-12-04 03:06:06.481077 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-04 03:06:06.525522 | debian-bookworm | skipping: Conditional result was False 2025-12-04 03:06:06.537016 | 2025-12-04 03:06:06.537149 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-04 03:06:07.202154 | debian-bookworm | ok 2025-12-04 03:06:07.225540 | 2025-12-04 03:06:07.225703 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-04 03:06:07.300529 | debian-bookworm | ok 2025-12-04 03:06:07.317234 | 2025-12-04 03:06:07.317440 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-04 03:06:08.265905 | debian-bookworm -> localhost | ok 2025-12-04 03:06:08.272833 | 2025-12-04 03:06:08.273022 | TASK [validate-host : Collect information about the host] 2025-12-04 03:06:09.611582 | debian-bookworm | ok 2025-12-04 03:06:09.624257 | 2025-12-04 03:06:09.624418 | TASK [validate-host : Sanitize hostname] 2025-12-04 03:06:09.879856 | debian-bookworm | ok 2025-12-04 03:06:09.971151 | 2025-12-04 03:06:09.971300 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-04 03:06:11.227712 | debian-bookworm -> localhost | changed 2025-12-04 03:06:11.234341 | 2025-12-04 03:06:11.234471 | TASK [validate-host : Collect information about zuul worker] 2025-12-04 03:06:11.932828 | debian-bookworm | ok 2025-12-04 03:06:11.940687 | 2025-12-04 03:06:11.940837 | TASK [validate-host : Write out all zuul information for each host] 2025-12-04 03:06:12.825039 | debian-bookworm -> localhost | changed 2025-12-04 03:06:12.835696 | 2025-12-04 03:06:12.835835 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-04 03:06:13.115313 | debian-bookworm | ok 2025-12-04 03:06:13.128306 | 2025-12-04 03:06:13.128442 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-04 03:06:14.579516 | debian-bookworm | changed: 2025-12-04 03:06:14.579745 | debian-bookworm | cd+++++++++ src/ 2025-12-04 03:06:14.579783 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-04 03:06:14.579808 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-04 03:06:14.579832 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2025-12-04 03:06:14.579853 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010801 2025-12-04 03:06:42.712049 | 2025-12-04 03:06:42.712203 | TASK [upload-logs : Upload logs to log server] 2025-12-04 03:06:43.320316 | localhost | Output suppressed because no_log was given 2025-12-04 03:06:43.322381 | 2025-12-04 03:06:43.322488 | LOOP [upload-logs : Compress console log and json output] 2025-12-04 03:06:43.375708 | localhost | skipping: Conditional result was False 2025-12-04 03:06:43.384911 | localhost | skipping: Conditional result was False 2025-12-04 03:06:43.390429 | 2025-12-04 03:06:43.390589 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-04 03:06:43.462406 | localhost | skipping: Conditional result was False 2025-12-04 03:06:43.462739 | 2025-12-04 03:06:43.470175 | localhost | skipping: Conditional result was False 2025-12-04 03:06:43.476364 | 2025-12-04 03:06:43.476504 | LOOP [upload-logs : Upload console log and json output]