2025-09-23 03:18:20.510870 | Job console starting 2025-09-23 03:18:20.528557 | Updating git repos 2025-09-23 03:18:20.563236 | Cloning repos into workspace 2025-09-23 03:18:20.639252 | Restoring repo states 2025-09-23 03:18:20.656054 | Merging changes 2025-09-23 03:18:20.656081 | Checking out repos 2025-09-23 03:18:20.723934 | Preparing playbooks 2025-09-23 03:18:21.603534 | Running Ansible setup 2025-09-23 03:18:26.591784 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-23 03:18:27.279944 | 2025-09-23 03:18:27.280060 | PLAY [Base pre] 2025-09-23 03:18:27.294293 | 2025-09-23 03:18:27.294389 | TASK [Setup log path fact] 2025-09-23 03:18:27.321922 | debian-bookworm | ok 2025-09-23 03:18:27.336050 | 2025-09-23 03:18:27.336181 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-23 03:18:27.364039 | debian-bookworm | ok 2025-09-23 03:18:27.373127 | 2025-09-23 03:18:27.373223 | TASK [emit-job-header : Print job information] 2025-09-23 03:18:27.400638 | # Job Information 2025-09-23 03:18:27.400775 | Ansible Version: 2.16.14 2025-09-23 03:18:27.400810 | Job: python-black 2025-09-23 03:18:27.400842 | Pipeline: periodic-daily 2025-09-23 03:18:27.400865 | Executor: 521e9411259a 2025-09-23 03:18:27.400886 | Triggered by: https://github.com/osism/node-image 2025-09-23 03:18:27.400908 | Event ID: 87a90e048f3e495aace5679ae0d4f398 2025-09-23 03:18:27.405436 | 2025-09-23 03:18:27.405521 | LOOP [emit-job-header : Print node information] 2025-09-23 03:18:27.499167 | debian-bookworm | ok: 2025-09-23 03:18:27.499456 | debian-bookworm | # Node Information 2025-09-23 03:18:27.499502 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-23 03:18:27.499533 | debian-bookworm | Hostname: debian 2025-09-23 03:18:27.499562 | debian-bookworm | Username: zuul 2025-09-23 03:18:27.499587 | debian-bookworm | Distro: Debian 12.12 2025-09-23 03:18:27.499616 | debian-bookworm | Provider: regiocloud-a 2025-09-23 03:18:27.499644 | debian-bookworm | Region: 2025-09-23 03:18:27.499669 | debian-bookworm | Label: debian-bookworm 2025-09-23 03:18:27.499693 | debian-bookworm | Product Name: OpenStack Nova 2025-09-23 03:18:27.499717 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefd:359 2025-09-23 03:18:27.510077 | 2025-09-23 03:18:27.510199 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-23 03:18:27.897978 | debian-bookworm -> localhost | changed 2025-09-23 03:18:27.903576 | 2025-09-23 03:18:27.903666 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-23 03:18:28.860342 | debian-bookworm -> localhost | changed 2025-09-23 03:18:28.873788 | 2025-09-23 03:18:28.873888 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-23 03:18:29.181812 | debian-bookworm -> localhost | ok 2025-09-23 03:18:29.187873 | 2025-09-23 03:18:29.187978 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-23 03:18:29.216259 | debian-bookworm | ok 2025-09-23 03:18:29.232830 | debian-bookworm | included: /var/lib/zuul/builds/019a2f05c0ef48a9b64247107d234c4f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-23 03:18:29.238640 | 2025-09-23 03:18:29.238731 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-23 03:18:30.082589 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-23 03:18:30.082798 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/019a2f05c0ef48a9b64247107d234c4f/work/019a2f05c0ef48a9b64247107d234c4f_id_rsa 2025-09-23 03:18:30.082864 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/019a2f05c0ef48a9b64247107d234c4f/work/019a2f05c0ef48a9b64247107d234c4f_id_rsa.pub 2025-09-23 03:18:30.082894 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-23 03:18:30.082920 | debian-bookworm -> localhost | SHA256:fw199yBwMqOOw1IVbfwSVYoY3caYt3DinZoq0/SKJwA zuul-build-sshkey 2025-09-23 03:18:30.082943 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-23 03:18:30.082972 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-23 03:18:30.082995 | debian-bookworm -> localhost | | o+ *... | 2025-09-23 03:18:30.083017 | debian-bookworm -> localhost | | +@.*. | 2025-09-23 03:18:30.083037 | debian-bookworm -> localhost | | oo*Xoo | 2025-09-23 03:18:30.083057 | debian-bookworm -> localhost | | E . .o*=. | 2025-09-23 03:18:30.083077 | debian-bookworm -> localhost | | . . S +o o o| 2025-09-23 03:18:30.083103 | debian-bookworm -> localhost | | .o o..o + oo| 2025-09-23 03:18:30.083124 | debian-bookworm -> localhost | | ..+o.o. . . .| 2025-09-23 03:18:30.083174 | debian-bookworm -> localhost | | .+o+ .. | 2025-09-23 03:18:30.083202 | debian-bookworm -> localhost | | .=.. | 2025-09-23 03:18:30.083224 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-23 03:18:30.083273 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.392575 2025-09-23 03:18:30.089325 | 2025-09-23 03:18:30.089411 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-23 03:18:30.107654 | debian-bookworm | ok 2025-09-23 03:18:30.118647 | debian-bookworm | included: /var/lib/zuul/builds/019a2f05c0ef48a9b64247107d234c4f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-23 03:18:30.127029 | 2025-09-23 03:18:30.127112 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-23 03:18:30.140157 | debian-bookworm | skipping: Conditional result was False 2025-09-23 03:18:30.146694 | 2025-09-23 03:18:30.146792 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-23 03:18:30.811317 | debian-bookworm | changed 2025-09-23 03:18:30.818133 | 2025-09-23 03:18:30.818231 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-23 03:18:31.099370 | debian-bookworm | ok 2025-09-23 03:18:31.104655 | 2025-09-23 03:18:31.104745 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-23 03:18:31.768052 | debian-bookworm | changed 2025-09-23 03:18:31.773422 | 2025-09-23 03:18:31.773494 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-23 03:18:32.405303 | debian-bookworm | changed 2025-09-23 03:18:32.410512 | 2025-09-23 03:18:32.410607 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-23 03:18:32.437231 | debian-bookworm | skipping: Conditional result was False 2025-09-23 03:18:32.443433 | 2025-09-23 03:18:32.443530 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-23 03:18:32.835603 | debian-bookworm -> localhost | changed 2025-09-23 03:18:32.845641 | 2025-09-23 03:18:32.845731 | TASK [add-build-sshkey : Add back temp key] 2025-09-23 03:18:33.112132 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/019a2f05c0ef48a9b64247107d234c4f/work/019a2f05c0ef48a9b64247107d234c4f_id_rsa (zuul-build-sshkey) 2025-09-23 03:18:33.112620 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012916 2025-09-23 03:18:33.125609 | 2025-09-23 03:18:33.125717 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-23 03:18:33.495014 | debian-bookworm | ok 2025-09-23 03:18:33.499834 | 2025-09-23 03:18:33.499915 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-23 03:18:33.523419 | debian-bookworm | skipping: Conditional result was False 2025-09-23 03:18:33.532830 | 2025-09-23 03:18:33.532911 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-23 03:18:33.969902 | debian-bookworm | ok 2025-09-23 03:18:33.982143 | 2025-09-23 03:18:33.982255 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-23 03:18:34.012489 | debian-bookworm | ok 2025-09-23 03:18:34.018634 | 2025-09-23 03:18:34.018735 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-23 03:18:34.402889 | debian-bookworm -> localhost | ok 2025-09-23 03:18:34.415835 | 2025-09-23 03:18:34.416006 | TASK [validate-host : Collect information about the host] 2025-09-23 03:18:35.562754 | debian-bookworm | ok 2025-09-23 03:18:35.573723 | 2025-09-23 03:18:35.573840 | TASK [validate-host : Sanitize hostname] 2025-09-23 03:18:35.697429 | debian-bookworm | ok 2025-09-23 03:18:35.753175 | 2025-09-23 03:18:35.753350 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-23 03:18:36.380254 | debian-bookworm -> localhost | changed 2025-09-23 03:18:36.386201 | 2025-09-23 03:18:36.386322 | TASK [validate-host : Collect information about zuul worker] 2025-09-23 03:18:36.978774 | debian-bookworm | ok 2025-09-23 03:18:36.986767 | 2025-09-23 03:18:36.986946 | TASK [validate-host : Write out all zuul information for each host] 2025-09-23 03:18:37.540037 | debian-bookworm -> localhost | changed 2025-09-23 03:18:37.557654 | 2025-09-23 03:18:37.557801 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-23 03:18:37.857619 | debian-bookworm | ok 2025-09-23 03:18:37.866771 | 2025-09-23 03:18:37.866910 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-23 03:18:39.496238 | debian-bookworm | changed: 2025-09-23 03:18:39.496452 | debian-bookworm | cd+++++++++ src/ 2025-09-23 03:18:39.496488 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-23 03:18:39.496512 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-23 03:18:39.496534 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-09-23 03:18:39.496554 | debian-bookworm | Containerfile 2025-09-23 03:18:39.496686 | debian-bookworm | localhost | ok: Runtime: 0:00:00.063636 2025-09-23 03:19:08.165873 | 2025-09-23 03:19:08.165997 | TASK [upload-logs : Upload logs to log server] 2025-09-23 03:19:09.223380 | localhost | Output suppressed because no_log was given 2025-09-23 03:19:09.224739 | 2025-09-23 03:19:09.224810 | LOOP [upload-logs : Compress console log and json output] 2025-09-23 03:19:09.363641 | localhost | skipping: Conditional result was False 2025-09-23 03:19:09.377201 | localhost | skipping: Conditional result was False 2025-09-23 03:19:09.386574 | 2025-09-23 03:19:09.386762 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-23 03:19:09.619452 | localhost | skipping: Conditional result was False 2025-09-23 03:19:09.619715 | 2025-09-23 03:19:09.629008 | localhost | skipping: Conditional result was False 2025-09-23 03:19:09.637350 | 2025-09-23 03:19:09.637531 | LOOP [upload-logs : Upload console log and json output]