2026-10-01 10:56:43.499259 | Job console starting 2026-10-01 10:56:43.524842 | Updating git repos 2026-10-01 10:56:43.596278 | Cloning repos into workspace 2026-10-01 10:56:43.679948 | Restoring repo states 2026-10-01 10:56:43.687116 | Merging changes 2026-10-01 10:56:44.370670 | Checking out repos 2026-10-01 10:56:44.439692 | Preparing playbooks 2026-10-01 10:56:45.725294 | Running Ansible setup 2026-10-01 10:56:49.926589 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-01 10:56:50.614092 | 2026-10-01 10:56:50.614234 | PLAY [Base pre] 2026-10-01 10:56:50.674813 | 2026-10-01 10:56:50.674941 | TASK [Setup log path fact] 2026-10-01 10:56:50.713675 | debian-bookworm | ok 2026-10-01 10:56:50.749997 | 2026-10-01 10:56:50.750132 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 10:56:50.788311 | debian-bookworm | ok 2026-10-01 10:56:50.804404 | 2026-10-01 10:56:50.804535 | TASK [emit-job-header : Print job information] 2026-10-01 10:56:50.872832 | # Job Information 2026-10-01 10:56:50.872985 | Ansible Version: 2.16.14 2026-10-01 10:56:50.873021 | Job: python-black 2026-10-01 10:56:50.873054 | Pipeline: check 2026-10-01 10:56:50.873077 | Executor: 521e9411259a 2026-10-01 10:56:50.873097 | Triggered by: https://github.com/osism/netbox-manager/pull/308 2026-10-01 10:56:50.873120 | Event ID: c2841760-bd86-11f1-9abf-a6ba0f568c45 2026-10-01 10:56:50.887973 | 2026-10-01 10:56:50.888072 | LOOP [emit-job-header : Print node information] 2026-10-01 10:56:51.073243 | debian-bookworm | ok: 2026-10-01 10:56:51.073425 | debian-bookworm | # Node Information 2026-10-01 10:56:51.073492 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-01 10:56:51.073522 | debian-bookworm | Hostname: debian 2026-10-01 10:56:51.073950 | debian-bookworm | Username: zuul 2026-10-01 10:56:51.073987 | debian-bookworm | Distro: Debian 12.15 2026-10-01 10:56:51.074012 | debian-bookworm | Provider: regiocloud-a 2026-10-01 10:56:51.074033 | debian-bookworm | Region: 2026-10-01 10:56:51.074055 | debian-bookworm | Label: debian-bookworm 2026-10-01 10:56:51.074076 | debian-bookworm | Product Name: OpenStack Nova 2026-10-01 10:56:51.074096 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe07:6c72 2026-10-01 10:56:51.092574 | 2026-10-01 10:56:51.092678 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-01 10:56:51.902282 | debian-bookworm -> localhost | changed 2026-10-01 10:56:51.908996 | 2026-10-01 10:56:51.909091 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-01 10:56:53.332494 | debian-bookworm -> localhost | changed 2026-10-01 10:56:53.341041 | 2026-10-01 10:56:53.341119 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-01 10:56:53.668970 | debian-bookworm -> localhost | ok 2026-10-01 10:56:53.673776 | 2026-10-01 10:56:53.673856 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-01 10:56:53.701574 | debian-bookworm | ok 2026-10-01 10:56:53.730682 | debian-bookworm | included: /var/lib/zuul/builds/9c0b83715a3a47c6b0495ac3edd4333f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-01 10:56:53.735527 | 2026-10-01 10:56:53.735598 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-01 10:56:55.393329 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-01 10:56:55.393495 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9c0b83715a3a47c6b0495ac3edd4333f/work/9c0b83715a3a47c6b0495ac3edd4333f_id_rsa 2026-10-01 10:56:55.393527 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9c0b83715a3a47c6b0495ac3edd4333f/work/9c0b83715a3a47c6b0495ac3edd4333f_id_rsa.pub 2026-10-01 10:56:55.393559 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-01 10:56:55.393582 | debian-bookworm -> localhost | SHA256:H42j6DwtpLOQGwj1z3ODCRxfJo6amq2NvVNDLsiNML4 zuul-build-sshkey 2026-10-01 10:56:55.393602 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-01 10:56:55.393628 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-01 10:56:55.393647 | debian-bookworm -> localhost | | | 2026-10-01 10:56:55.393666 | debian-bookworm -> localhost | | | 2026-10-01 10:56:55.393683 | debian-bookworm -> localhost | | . . . o | 2026-10-01 10:56:55.393699 | debian-bookworm -> localhost | |o. o.= + o | 2026-10-01 10:56:55.393715 | debian-bookworm -> localhost | |=ooo= o S + . | 2026-10-01 10:56:55.393735 | debian-bookworm -> localhost | |o=.=++.+ o o | 2026-10-01 10:56:55.393752 | debian-bookworm -> localhost | |. Bo +B.+ . | 2026-10-01 10:56:55.393768 | debian-bookworm -> localhost | | E.+oooo.. | 2026-10-01 10:56:55.393785 | debian-bookworm -> localhost | |=.*o.ooo | 2026-10-01 10:56:55.393802 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-01 10:56:55.393845 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.037119 2026-10-01 10:56:55.398805 | 2026-10-01 10:56:55.398878 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-01 10:56:55.415338 | debian-bookworm | ok 2026-10-01 10:56:55.435187 | debian-bookworm | included: /var/lib/zuul/builds/9c0b83715a3a47c6b0495ac3edd4333f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-01 10:56:55.441595 | 2026-10-01 10:56:55.441668 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-01 10:56:55.464379 | debian-bookworm | skipping: Conditional result was False 2026-10-01 10:56:55.468826 | 2026-10-01 10:56:55.468894 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-01 10:56:56.120643 | debian-bookworm | changed 2026-10-01 10:56:56.127184 | 2026-10-01 10:56:56.127264 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-01 10:56:56.429410 | debian-bookworm | ok 2026-10-01 10:56:56.436032 | 2026-10-01 10:56:56.436125 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-01 10:56:57.090496 | debian-bookworm | changed 2026-10-01 10:56:57.095974 | 2026-10-01 10:56:57.096064 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-01 10:56:57.797214 | debian-bookworm | changed 2026-10-01 10:56:57.802611 | 2026-10-01 10:56:57.802702 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-01 10:56:57.825863 | debian-bookworm | skipping: Conditional result was False 2026-10-01 10:56:57.831490 | 2026-10-01 10:56:57.831585 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-01 10:56:58.349540 | debian-bookworm -> localhost | changed 2026-10-01 10:56:58.360333 | 2026-10-01 10:56:58.360463 | TASK [add-build-sshkey : Add back temp key] 2026-10-01 10:56:58.648046 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9c0b83715a3a47c6b0495ac3edd4333f/work/9c0b83715a3a47c6b0495ac3edd4333f_id_rsa (zuul-build-sshkey) 2026-10-01 10:56:58.648257 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017163 2026-10-01 10:56:58.655251 | 2026-10-01 10:56:58.655337 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-01 10:56:59.094022 | debian-bookworm | ok 2026-10-01 10:56:59.098864 | 2026-10-01 10:56:59.098953 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-01 10:56:59.137778 | debian-bookworm | skipping: Conditional result was False 2026-10-01 10:56:59.147437 | 2026-10-01 10:56:59.147531 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-01 10:56:59.590600 | debian-bookworm | ok 2026-10-01 10:56:59.620927 | 2026-10-01 10:56:59.621032 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-01 10:56:59.648600 | debian-bookworm | ok 2026-10-01 10:56:59.653428 | 2026-10-01 10:56:59.653507 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-01 10:56:59.973240 | debian-bookworm -> localhost | ok 2026-10-01 10:56:59.979144 | 2026-10-01 10:56:59.979251 | TASK [validate-host : Collect information about the host] 2026-10-01 10:57:01.105885 | debian-bookworm | ok 2026-10-01 10:57:01.124442 | 2026-10-01 10:57:01.124544 | TASK [validate-host : Sanitize hostname] 2026-10-01 10:57:01.350462 | debian-bookworm | ok 2026-10-01 10:57:01.366314 | 2026-10-01 10:57:01.366422 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-01 10:57:01.940314 | debian-bookworm -> localhost | changed 2026-10-01 10:57:01.947383 | 2026-10-01 10:57:01.947483 | TASK [validate-host : Collect information about zuul worker] 2026-10-01 10:57:02.330544 | debian-bookworm | ok 2026-10-01 10:57:02.339380 | 2026-10-01 10:57:02.339495 | TASK [validate-host : Write out all zuul information for each host] 2026-10-01 10:57:02.902690 | debian-bookworm -> localhost | changed 2026-10-01 10:57:02.915888 | 2026-10-01 10:57:02.915992 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-01 10:57:03.273055 | debian-bookworm | ok 2026-10-01 10:57:03.279219 | 2026-10-01 10:57:03.279316 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-01 10:57:04.382873 | debian-bookworm | changed: 2026-10-01 10:57:04.383094 | debian-bookworm | cd+++++++++ src/ 2026-10-01 10:57:04.383132 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-01 10:57:04.383180 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-01 10:57:04.383204 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-manager/ 2026-10-01 10:57:04.383224 | debian-bookworm | netbox_manager/requirements.yml 2026-10-01 10:57:04.383505 | debian-bookworm | cL+++++++++ src/github.com/osism/netbox-manager/settings.toml.sample -> netbox_manager/settings.toml.sample 2026-10-01 10:57:04.383524 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/9c0b83715a3a47c6b0495ac3edd4333f/work/logs" 2026-10-01 10:58:11.069455 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9c0b83715a3a47c6b0495ac3edd4333f/work/artifacts" 2026-10-01 10:58:11.335727 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9c0b83715a3a47c6b0495ac3edd4333f/work/docs" 2026-10-01 10:58:11.346152 | 2026-10-01 10:58:11.346316 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-01 10:58:12.142408 | debian-bookworm | changed: 2026-10-01 10:58:12.142701 | debian-bookworm | .d..t...... ./ 2026-10-01 10:58:12.142745 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-01 10:58:12.142774 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-01 10:58:12.142800 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-01 10:58:12.142825 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-01 10:58:12.142850 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-01 10:58:12.142892 | debian-bookworm | changed: All items complete 2026-10-01 10:58:12.142922 | 2026-10-01 10:58:12.703206 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 10:58:13.252508 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 10:58:13.274824 | 2026-10-01 10:58:13.274966 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-01 10:58:13.617233 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.023423 2026-10-01 10:58:13.892583 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008668 2026-10-01 10:58:13.903530 | 2026-10-01 10:58:13.903623 | PLAY RECAP 2026-10-01 10:58:13.903677 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-01 10:58:13.903702 | 2026-10-01 10:58:14.029698 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-01 10:58:14.030558 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 10:58:14.733786 | 2026-10-01 10:58:14.733944 | PLAY [Base post] 2026-10-01 10:58:14.747045 | 2026-10-01 10:58:14.747217 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-01 10:58:15.338450 | debian-bookworm | changed 2026-10-01 10:58:15.347238 | 2026-10-01 10:58:15.347359 | PLAY RECAP 2026-10-01 10:58:15.347423 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-01 10:58:15.347486 | 2026-10-01 10:58:15.470651 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 10:58:15.471505 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-01 10:58:16.242619 | 2026-10-01 10:58:16.242788 | PLAY [Base post-logs] 2026-10-01 10:58:16.253660 | 2026-10-01 10:58:16.253804 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-01 10:58:16.758279 | localhost | changed 2026-10-01 10:58:16.776505 | 2026-10-01 10:58:16.776682 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-01 10:58:16.813666 | localhost | ok 2026-10-01 10:58:16.818845 | 2026-10-01 10:58:16.819007 | TASK [Set zuul-log-path fact] 2026-10-01 10:58:16.846691 | localhost | ok 2026-10-01 10:58:16.859488 | 2026-10-01 10:58:16.859627 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 10:58:16.896953 | localhost | ok 2026-10-01 10:58:16.904008 | 2026-10-01 10:58:16.904239 | TASK [upload-logs : Create log directories] 2026-10-01 10:58:17.413806 | localhost | changed 2026-10-01 10:58:17.419548 | 2026-10-01 10:58:17.419735 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-01 10:58:17.911650 | localhost -> localhost | ok: Runtime: 0:00:00.006859 2026-10-01 10:58:17.919645 | 2026-10-01 10:58:17.919815 | TASK [upload-logs : Upload logs to log server] 2026-10-01 10:58:18.465827 | localhost | Output suppressed because no_log was given 2026-10-01 10:58:18.469406 | 2026-10-01 10:58:18.469653 | LOOP [upload-logs : Compress console log and json output] 2026-10-01 10:58:18.522868 | localhost | skipping: Conditional result was False 2026-10-01 10:58:18.527915 | localhost | skipping: Conditional result was False 2026-10-01 10:58:18.540859 | 2026-10-01 10:58:18.541106 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-01 10:58:18.589239 | localhost | skipping: Conditional result was False 2026-10-01 10:58:18.589904 | 2026-10-01 10:58:18.593414 | localhost | skipping: Conditional result was False 2026-10-01 10:58:18.602594 | 2026-10-01 10:58:18.602819 | LOOP [upload-logs : Upload console log and json output]