2025-12-06 16:46:12.454960 | Job console starting 2025-12-06 16:46:12.497669 | Updating git repos 2025-12-06 16:46:12.544486 | Cloning repos into workspace 2025-12-06 16:46:12.613104 | Restoring repo states 2025-12-06 16:46:12.622270 | Merging changes 2025-12-06 16:46:13.343424 | Checking out repos 2025-12-06 16:46:13.463429 | Preparing playbooks 2025-12-06 16:46:15.180756 | Running Ansible setup 2025-12-06 16:46:24.466641 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-06 16:46:26.786562 | 2025-12-06 16:46:26.786747 | PLAY [Base pre] 2025-12-06 16:46:26.838115 | 2025-12-06 16:46:26.838285 | TASK [Setup log path fact] 2025-12-06 16:46:26.895522 | debian-bookworm | ok 2025-12-06 16:46:26.926717 | 2025-12-06 16:46:26.934988 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-06 16:46:27.007420 | debian-bookworm | ok 2025-12-06 16:46:27.038315 | 2025-12-06 16:46:27.042985 | TASK [emit-job-header : Print job information] 2025-12-06 16:46:27.122050 | # Job Information 2025-12-06 16:46:27.122369 | Ansible Version: 2.16.14 2025-12-06 16:46:27.122408 | Job: python-black 2025-12-06 16:46:27.122448 | Pipeline: check 2025-12-06 16:46:27.122475 | Executor: 521e9411259a 2025-12-06 16:46:27.122496 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/798 2025-12-06 16:46:27.122518 | Event ID: 0c725300-d2c3-11f0-97e8-7a9a807708cf 2025-12-06 16:46:27.130152 | 2025-12-06 16:46:27.130293 | LOOP [emit-job-header : Print node information] 2025-12-06 16:46:27.376804 | debian-bookworm | ok: 2025-12-06 16:46:27.377085 | debian-bookworm | # Node Information 2025-12-06 16:46:27.377124 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-06 16:46:27.377150 | debian-bookworm | Hostname: debian 2025-12-06 16:46:27.377172 | debian-bookworm | Username: zuul 2025-12-06 16:46:27.377192 | debian-bookworm | Distro: Debian 12.12 2025-12-06 16:46:27.377216 | debian-bookworm | Provider: regiocloud-a 2025-12-06 16:46:27.377236 | debian-bookworm | Region: 2025-12-06 16:46:27.377257 | debian-bookworm | Label: debian-bookworm 2025-12-06 16:46:27.377277 | debian-bookworm | Product Name: OpenStack Nova 2025-12-06 16:46:27.377296 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0d:fb96 2025-12-06 16:46:27.401768 | 2025-12-06 16:46:27.401920 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-06 16:46:28.972381 | debian-bookworm -> localhost | changed 2025-12-06 16:46:28.980112 | 2025-12-06 16:46:28.980256 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-06 16:46:33.050846 | debian-bookworm -> localhost | changed 2025-12-06 16:46:33.063129 | 2025-12-06 16:46:33.063344 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-06 16:46:34.222985 | debian-bookworm -> localhost | ok 2025-12-06 16:46:34.231457 | 2025-12-06 16:46:34.231602 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-06 16:46:34.291651 | debian-bookworm | ok 2025-12-06 16:46:34.351555 | debian-bookworm | included: /var/lib/zuul/builds/eed4f209f75544f383002d89aec2baf9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-06 16:46:34.365433 | 2025-12-06 16:46:34.365565 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-06 16:46:38.952797 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-06 16:46:38.953057 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/eed4f209f75544f383002d89aec2baf9/work/eed4f209f75544f383002d89aec2baf9_id_rsa 2025-12-06 16:46:38.953098 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/eed4f209f75544f383002d89aec2baf9/work/eed4f209f75544f383002d89aec2baf9_id_rsa.pub 2025-12-06 16:46:38.953124 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-06 16:46:38.953147 | debian-bookworm -> localhost | SHA256:jFQxSpjNM0Vnr89ts9rN0eiJXjec3Eo7lElmngNTLUw zuul-build-sshkey 2025-12-06 16:46:38.953168 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-06 16:46:38.953203 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-06 16:46:38.953225 | debian-bookworm -> localhost | | =.o*.o oE. | 2025-12-06 16:46:38.953246 | debian-bookworm -> localhost | | o.=o + . + .| 2025-12-06 16:46:38.953265 | debian-bookworm -> localhost | | oo .. . | 2025-12-06 16:46:38.953284 | debian-bookworm -> localhost | | . o .o + | 2025-12-06 16:46:38.953304 | debian-bookworm -> localhost | | . S . B + | 2025-12-06 16:46:38.953325 | debian-bookworm -> localhost | | o .X.+| 2025-12-06 16:46:38.953344 | debian-bookworm -> localhost | | o.BB+| 2025-12-06 16:46:38.953363 | debian-bookworm -> localhost | | B.Xo| 2025-12-06 16:46:38.953383 | debian-bookworm -> localhost | | .+.B.o| 2025-12-06 16:46:38.953402 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-06 16:46:38.953461 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.592223 2025-12-06 16:46:38.961491 | 2025-12-06 16:46:38.961636 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-06 16:46:39.015415 | debian-bookworm | ok 2025-12-06 16:46:39.037629 | debian-bookworm | included: /var/lib/zuul/builds/eed4f209f75544f383002d89aec2baf9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-06 16:46:39.104483 | 2025-12-06 16:46:39.104637 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-06 16:46:39.151441 | debian-bookworm | skipping: Conditional result was False 2025-12-06 16:46:39.159036 | 2025-12-06 16:46:39.159183 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-06 16:46:40.279640 | debian-bookworm | changed 2025-12-06 16:46:40.289033 | 2025-12-06 16:46:40.289165 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-06 16:46:40.567647 | debian-bookworm | ok 2025-12-06 16:46:40.574158 | 2025-12-06 16:46:40.574295 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-06 16:46:41.347174 | debian-bookworm | changed 2025-12-06 16:46:41.367395 | 2025-12-06 16:46:41.367547 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-06 16:46:42.212694 | debian-bookworm | changed 2025-12-06 16:46:42.219188 | 2025-12-06 16:46:42.219333 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-06 16:46:42.282913 | debian-bookworm | skipping: Conditional result was False 2025-12-06 16:46:42.290233 | 2025-12-06 16:46:42.290383 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-06 16:46:43.997278 | debian-bookworm -> localhost | changed 2025-12-06 16:46:44.051590 | 2025-12-06 16:46:44.051789 | TASK [add-build-sshkey : Add back temp key] 2025-12-06 16:46:45.375727 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/eed4f209f75544f383002d89aec2baf9/work/eed4f209f75544f383002d89aec2baf9_id_rsa (zuul-build-sshkey) 2025-12-06 16:46:45.376072 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.040099 2025-12-06 16:46:45.430459 | 2025-12-06 16:46:45.430666 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-06 16:46:46.031693 | debian-bookworm | ok 2025-12-06 16:46:46.041567 | 2025-12-06 16:46:46.041727 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-06 16:46:46.096324 | debian-bookworm | skipping: Conditional result was False 2025-12-06 16:46:46.110797 | 2025-12-06 16:46:46.111277 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-06 16:46:46.956531 | debian-bookworm | ok 2025-12-06 16:46:47.010715 | 2025-12-06 16:46:47.010884 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-06 16:46:47.060363 | debian-bookworm | ok 2025-12-06 16:46:47.066026 | 2025-12-06 16:46:47.066159 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-06 16:46:47.962979 | debian-bookworm -> localhost | ok 2025-12-06 16:46:47.970296 | 2025-12-06 16:46:47.970475 | TASK [validate-host : Collect information about the host] 2025-12-06 16:46:49.663494 | debian-bookworm | ok 2025-12-06 16:46:49.726363 | 2025-12-06 16:46:49.726514 | TASK [validate-host : Sanitize hostname] 2025-12-06 16:46:50.047933 | debian-bookworm | ok 2025-12-06 16:46:50.201534 | 2025-12-06 16:46:50.201706 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-06 16:46:51.887615 | debian-bookworm -> localhost | changed 2025-12-06 16:46:51.893930 | 2025-12-06 16:46:51.894057 | TASK [validate-host : Collect information about zuul worker] 2025-12-06 16:46:52.855009 | debian-bookworm | ok 2025-12-06 16:46:52.860272 | 2025-12-06 16:46:52.860399 | TASK [validate-host : Write out all zuul information for each host] 2025-12-06 16:46:54.982232 | debian-bookworm -> localhost | changed 2025-12-06 16:46:55.000483 | 2025-12-06 16:46:55.000634 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-06 16:46:55.342608 | debian-bookworm | ok 2025-12-06 16:46:55.361945 | 2025-12-06 16:46:55.362090 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-06 16:46:57.177287 | debian-bookworm | changed: 2025-12-06 16:46:57.177530 | debian-bookworm | cd+++++++++ src/ 2025-12-06 16:46:57.177567 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-06 16:46:57.177592 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-06 16:46:57.177614 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-12-06 16:46:57.177634 | debian-bookworm | Containerfile 2025-12-06 16:46:57.177794 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005812 2025-12-06 16:47:26.305903 | 2025-12-06 16:47:26.306055 | TASK [upload-logs : Upload logs to log server] 2025-12-06 16:47:26.987458 | localhost | Output suppressed because no_log was given 2025-12-06 16:47:26.992128 | 2025-12-06 16:47:26.992347 | LOOP [upload-logs : Compress console log and json output] 2025-12-06 16:47:27.060063 | localhost | skipping: Conditional result was False 2025-12-06 16:47:27.065932 | localhost | skipping: Conditional result was False 2025-12-06 16:47:27.074116 | 2025-12-06 16:47:27.074250 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-06 16:47:27.126386 | localhost | skipping: Conditional result was False 2025-12-06 16:47:27.126723 | 2025-12-06 16:47:27.132589 | localhost | skipping: Conditional result was False 2025-12-06 16:47:27.149525 | 2025-12-06 16:47:27.149659 | LOOP [upload-logs : Upload console log and json output]