2025-09-19 03:07:09.612271 | Job console starting 2025-09-19 03:07:09.621299 | Updating git repos 2025-09-19 03:07:09.643745 | Cloning repos into workspace 2025-09-19 03:07:09.672874 | Restoring repo states 2025-09-19 03:07:09.678097 | Merging changes 2025-09-19 03:07:09.678116 | Checking out repos 2025-09-19 03:07:09.708666 | Preparing playbooks 2025-09-19 03:07:10.395305 | Running Ansible setup 2025-09-19 03:07:14.784975 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-19 03:07:15.654761 | 2025-09-19 03:07:15.654961 | PLAY [Base pre] 2025-09-19 03:07:15.684491 | 2025-09-19 03:07:15.684658 | TASK [Setup log path fact] 2025-09-19 03:07:15.714172 | debian-bookworm | ok 2025-09-19 03:07:15.730425 | 2025-09-19 03:07:15.730573 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-19 03:07:15.781334 | debian-bookworm | ok 2025-09-19 03:07:15.791541 | 2025-09-19 03:07:15.791732 | TASK [emit-job-header : Print job information] 2025-09-19 03:07:15.832164 | # Job Information 2025-09-19 03:07:15.832367 | Ansible Version: 2.16.14 2025-09-19 03:07:15.832404 | Job: python-black 2025-09-19 03:07:15.832437 | Pipeline: periodic-daily 2025-09-19 03:07:15.832460 | Executor: 521e9411259a 2025-09-19 03:07:15.832481 | Triggered by: https://github.com/osism/rookify 2025-09-19 03:07:15.832505 | Event ID: c7ee26d76f304f908a6f59c8def479fe 2025-09-19 03:07:15.837652 | 2025-09-19 03:07:15.837777 | LOOP [emit-job-header : Print node information] 2025-09-19 03:07:15.947204 | debian-bookworm | ok: 2025-09-19 03:07:15.947482 | debian-bookworm | # Node Information 2025-09-19 03:07:15.947524 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-19 03:07:15.947551 | debian-bookworm | Hostname: debian 2025-09-19 03:07:15.947574 | debian-bookworm | Username: zuul 2025-09-19 03:07:15.947635 | debian-bookworm | Distro: Debian 12.12 2025-09-19 03:07:15.947662 | debian-bookworm | Provider: regiocloud-a 2025-09-19 03:07:15.947683 | debian-bookworm | Region: 2025-09-19 03:07:15.947705 | debian-bookworm | Label: debian-bookworm 2025-09-19 03:07:15.947725 | debian-bookworm | Product Name: OpenStack Nova 2025-09-19 03:07:15.947745 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe81:2d5e 2025-09-19 03:07:15.966203 | 2025-09-19 03:07:15.966330 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-19 03:07:16.509607 | debian-bookworm -> localhost | changed 2025-09-19 03:07:16.523497 | 2025-09-19 03:07:16.523721 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-19 03:07:17.863466 | debian-bookworm -> localhost | changed 2025-09-19 03:07:17.889765 | 2025-09-19 03:07:17.890123 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-19 03:07:18.137772 | debian-bookworm -> localhost | ok 2025-09-19 03:07:18.145017 | 2025-09-19 03:07:18.145122 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-19 03:07:18.163390 | debian-bookworm | ok 2025-09-19 03:07:18.181519 | debian-bookworm | included: /var/lib/zuul/builds/c3cce4279f094e48b48e54cbad47cd34/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-19 03:07:18.187948 | 2025-09-19 03:07:18.188067 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-19 03:07:20.089740 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-19 03:07:20.089944 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c3cce4279f094e48b48e54cbad47cd34/work/c3cce4279f094e48b48e54cbad47cd34_id_rsa 2025-09-19 03:07:20.089983 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c3cce4279f094e48b48e54cbad47cd34/work/c3cce4279f094e48b48e54cbad47cd34_id_rsa.pub 2025-09-19 03:07:20.090010 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-19 03:07:20.090036 | debian-bookworm -> localhost | SHA256:qEXpbDFOL/mtG6T6yV9PJ0LLiVFrWdNDeifVf07XcKI zuul-build-sshkey 2025-09-19 03:07:20.090059 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-19 03:07:20.090090 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-19 03:07:20.090112 | debian-bookworm -> localhost | | . o| 2025-09-19 03:07:20.090133 | debian-bookworm -> localhost | | . +o.o| 2025-09-19 03:07:20.090154 | debian-bookworm -> localhost | | * . +.=++| 2025-09-19 03:07:20.090175 | debian-bookworm -> localhost | | * * . +Eo +*| 2025-09-19 03:07:20.090196 | debian-bookworm -> localhost | | X S = oo| 2025-09-19 03:07:20.090220 | debian-bookworm -> localhost | | + = B o .| 2025-09-19 03:07:20.090241 | debian-bookworm -> localhost | | . . + B o . | 2025-09-19 03:07:20.090261 | debian-bookworm -> localhost | | o . + + o | 2025-09-19 03:07:20.090282 | debian-bookworm -> localhost | | ..+.+. . | 2025-09-19 03:07:20.090303 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-19 03:07:20.090353 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.436647 2025-09-19 03:07:20.096703 | 2025-09-19 03:07:20.096795 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-19 03:07:20.114034 | debian-bookworm | ok 2025-09-19 03:07:20.122777 | debian-bookworm | included: /var/lib/zuul/builds/c3cce4279f094e48b48e54cbad47cd34/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-19 03:07:20.131378 | 2025-09-19 03:07:20.131460 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-19 03:07:20.143922 | debian-bookworm | skipping: Conditional result was False 2025-09-19 03:07:20.149140 | 2025-09-19 03:07:20.149219 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-19 03:07:20.776539 | debian-bookworm | changed 2025-09-19 03:07:20.799020 | 2025-09-19 03:07:20.799149 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-19 03:07:21.011365 | debian-bookworm | ok 2025-09-19 03:07:21.020159 | 2025-09-19 03:07:21.020269 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-19 03:07:21.655726 | debian-bookworm | changed 2025-09-19 03:07:21.662891 | 2025-09-19 03:07:21.663013 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-19 03:07:22.291279 | debian-bookworm | changed 2025-09-19 03:07:22.296978 | 2025-09-19 03:07:22.297107 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-19 03:07:22.321198 | debian-bookworm | skipping: Conditional result was False 2025-09-19 03:07:22.327411 | 2025-09-19 03:07:22.327525 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-19 03:07:22.756118 | debian-bookworm -> localhost | changed 2025-09-19 03:07:22.766647 | 2025-09-19 03:07:22.766743 | TASK [add-build-sshkey : Add back temp key] 2025-09-19 03:07:23.094357 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c3cce4279f094e48b48e54cbad47cd34/work/c3cce4279f094e48b48e54cbad47cd34_id_rsa (zuul-build-sshkey) 2025-09-19 03:07:23.094712 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010715 2025-09-19 03:07:23.113450 | 2025-09-19 03:07:23.114963 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-19 03:07:23.508487 | debian-bookworm | ok 2025-09-19 03:07:23.514064 | 2025-09-19 03:07:23.514181 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-19 03:07:23.538042 | debian-bookworm | skipping: Conditional result was False 2025-09-19 03:07:23.548763 | 2025-09-19 03:07:23.548873 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-19 03:07:24.023371 | debian-bookworm | ok 2025-09-19 03:07:24.043137 | 2025-09-19 03:07:24.043285 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-19 03:07:24.080531 | debian-bookworm | ok 2025-09-19 03:07:24.088719 | 2025-09-19 03:07:24.088848 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-19 03:07:24.501353 | debian-bookworm -> localhost | ok 2025-09-19 03:07:24.527853 | 2025-09-19 03:07:24.528008 | TASK [validate-host : Collect information about the host] 2025-09-19 03:07:25.692350 | debian-bookworm | ok 2025-09-19 03:07:25.702850 | 2025-09-19 03:07:25.702975 | TASK [validate-host : Sanitize hostname] 2025-09-19 03:07:25.813661 | debian-bookworm | ok 2025-09-19 03:07:25.907953 | 2025-09-19 03:07:25.908099 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-19 03:07:26.675385 | debian-bookworm -> localhost | changed 2025-09-19 03:07:26.681353 | 2025-09-19 03:07:26.681468 | TASK [validate-host : Collect information about zuul worker] 2025-09-19 03:07:27.093270 | debian-bookworm | ok 2025-09-19 03:07:27.099744 | 2025-09-19 03:07:27.099887 | TASK [validate-host : Write out all zuul information for each host] 2025-09-19 03:07:27.629833 | debian-bookworm -> localhost | changed 2025-09-19 03:07:27.639843 | 2025-09-19 03:07:27.639958 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-19 03:07:27.913754 | debian-bookworm | ok 2025-09-19 03:07:27.919813 | 2025-09-19 03:07:27.919931 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-19 03:07:28.775812 | debian-bookworm | changed: 2025-09-19 03:07:28.776077 | debian-bookworm | cd+++++++++ src/ 2025-09-19 03:07:28.776115 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-19 03:07:28.776141 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-19 03:07:28.776164 | debian-bookworm | cd+++++++++ src/github.com/osism/rookify/ 2025-09-19 03:07:28.776184 | debian-bookworm | Containerfile 2025-09-19 03:07:28.776440 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007027 2025-09-19 03:07:51.939754 | 2025-09-19 03:07:51.939876 | TASK [upload-logs : Upload logs to log server] 2025-09-19 03:07:52.569448 | localhost | Output suppressed because no_log was given 2025-09-19 03:07:52.573114 | 2025-09-19 03:07:52.573276 | LOOP [upload-logs : Compress console log and json output] 2025-09-19 03:07:52.636060 | localhost | skipping: Conditional result was False 2025-09-19 03:07:52.642150 | localhost | skipping: Conditional result was False 2025-09-19 03:07:52.647963 | 2025-09-19 03:07:52.648115 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-19 03:07:52.696629 | localhost | skipping: Conditional result was False 2025-09-19 03:07:52.696909 | 2025-09-19 03:07:52.701436 | localhost | skipping: Conditional result was False 2025-09-19 03:07:52.706997 | 2025-09-19 03:07:52.707117 | LOOP [upload-logs : Upload console log and json output]