2025-04-29 03:02:11.444943 | Job console starting... 2025-04-29 03:02:11.467658 | Updating repositories 2025-04-29 03:02:11.536890 | Preparing job workspace 2025-04-29 03:02:13.518397 | Running Ansible setup... 2025-04-29 03:02:19.396323 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-29 03:02:20.662256 | 2025-04-29 03:02:20.662379 | PLAY [Base pre] 2025-04-29 03:02:20.710767 | 2025-04-29 03:02:20.710890 | TASK [Setup log path fact] 2025-04-29 03:02:20.766920 | ubuntu-noble | ok 2025-04-29 03:02:20.820273 | 2025-04-29 03:02:20.820402 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-29 03:02:20.909710 | ubuntu-noble | ok 2025-04-29 03:02:20.931622 | 2025-04-29 03:02:20.931722 | TASK [emit-job-header : Print job information] 2025-04-29 03:02:21.079202 | # Job Information 2025-04-29 03:02:21.079340 | Ansible Version: 2.15.3 2025-04-29 03:02:21.079368 | Job: python-black 2025-04-29 03:02:21.079393 | Pipeline: periodic-daily 2025-04-29 03:02:21.079410 | Executor: 7d211f194f6a 2025-04-29 03:02:21.079426 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-04-29 03:02:21.079442 | Event ID: 52477ea51e154ee491c5c88b9b87f3b6 2025-04-29 03:02:21.088638 | 2025-04-29 03:02:21.088734 | LOOP [emit-job-header : Print node information] 2025-04-29 03:02:21.495901 | ubuntu-noble | ok: 2025-04-29 03:02:21.496036 | ubuntu-noble | # Node Information 2025-04-29 03:02:21.496063 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-29 03:02:21.496083 | ubuntu-noble | Hostname: ubuntu 2025-04-29 03:02:21.496101 | ubuntu-noble | Username: zuul 2025-04-29 03:02:21.496118 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-29 03:02:21.496137 | ubuntu-noble | Provider: regiocloud-a 2025-04-29 03:02:21.496153 | ubuntu-noble | Label: ubuntu-noble 2025-04-29 03:02:21.496181 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-29 03:02:21.496198 | ubuntu-noble | Interface IP: 81.163.193.39 2025-04-29 03:02:21.531186 | 2025-04-29 03:02:21.531287 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-29 03:02:22.798085 | ubuntu-noble -> localhost | changed 2025-04-29 03:02:22.805523 | 2025-04-29 03:02:22.805639 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-29 03:02:25.376097 | ubuntu-noble -> localhost | changed 2025-04-29 03:02:25.387320 | 2025-04-29 03:02:25.387419 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-29 03:02:26.055231 | ubuntu-noble -> localhost | ok 2025-04-29 03:02:26.062933 | 2025-04-29 03:02:26.063032 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-29 03:02:26.112535 | ubuntu-noble | ok 2025-04-29 03:02:26.147369 | ubuntu-noble | included: /var/lib/zuul/builds/32ee8665d3b048a2b607d8702a71bd77/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-29 03:02:26.167609 | 2025-04-29 03:02:26.167706 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-29 03:02:27.394622 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-29 03:02:27.394766 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/32ee8665d3b048a2b607d8702a71bd77/work/32ee8665d3b048a2b607d8702a71bd77_id_rsa 2025-04-29 03:02:27.394794 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/32ee8665d3b048a2b607d8702a71bd77/work/32ee8665d3b048a2b607d8702a71bd77_id_rsa.pub 2025-04-29 03:02:27.394814 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-29 03:02:27.394833 | ubuntu-noble -> localhost | SHA256:9xsZsxVug4TFDboGbr1VhBYTBlwychOEt+GS8cKsxvM zuul-build-sshkey 2025-04-29 03:02:27.394851 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-29 03:02:27.394868 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-29 03:02:27.394885 | ubuntu-noble -> localhost | | .+O=O*. | 2025-04-29 03:02:27.394901 | ubuntu-noble -> localhost | | oo+O+o. | 2025-04-29 03:02:27.394918 | ubuntu-noble -> localhost | | o.*o+. o | 2025-04-29 03:02:27.394942 | ubuntu-noble -> localhost | | .*o+o + . | 2025-04-29 03:02:27.394959 | ubuntu-noble -> localhost | | . .So= = = | 2025-04-29 03:02:27.394974 | ubuntu-noble -> localhost | | =. o + B . | 2025-04-29 03:02:27.394994 | ubuntu-noble -> localhost | | . o . = | 2025-04-29 03:02:27.395010 | ubuntu-noble -> localhost | | E o | 2025-04-29 03:02:27.395026 | ubuntu-noble -> localhost | | . | 2025-04-29 03:02:27.395042 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-29 03:02:27.395079 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.107042 2025-04-29 03:02:27.401839 | 2025-04-29 03:02:27.401929 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-29 03:02:27.451974 | ubuntu-noble | ok 2025-04-29 03:02:27.470030 | ubuntu-noble | included: /var/lib/zuul/builds/32ee8665d3b048a2b607d8702a71bd77/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-29 03:02:27.487516 | 2025-04-29 03:02:27.487615 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-29 03:02:27.537765 | ubuntu-noble | skipping: Conditional result was False 2025-04-29 03:02:27.546527 | 2025-04-29 03:02:27.546640 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-29 03:02:28.458362 | ubuntu-noble | changed 2025-04-29 03:02:28.472502 | 2025-04-29 03:02:28.472598 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-29 03:02:28.784258 | ubuntu-noble | ok 2025-04-29 03:02:28.793938 | 2025-04-29 03:02:28.794039 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-29 03:02:29.484909 | ubuntu-noble | changed 2025-04-29 03:02:29.501194 | 2025-04-29 03:02:29.501303 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-29 03:02:30.225798 | ubuntu-noble | changed 2025-04-29 03:02:30.232649 | 2025-04-29 03:02:30.232743 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-29 03:02:30.267577 | ubuntu-noble | skipping: Conditional result was False 2025-04-29 03:02:30.275380 | 2025-04-29 03:02:30.275479 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-29 03:02:30.982357 | ubuntu-noble -> localhost | changed 2025-04-29 03:02:31.005339 | 2025-04-29 03:02:31.005447 | TASK [add-build-sshkey : Add back temp key] 2025-04-29 03:02:31.970555 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/32ee8665d3b048a2b607d8702a71bd77/work/32ee8665d3b048a2b607d8702a71bd77_id_rsa (zuul-build-sshkey) 2025-04-29 03:02:31.971181 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.028950 2025-04-29 03:02:31.980258 | 2025-04-29 03:02:31.980343 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-29 03:02:32.389765 | ubuntu-noble | ok 2025-04-29 03:02:32.401015 | 2025-04-29 03:02:32.401112 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-29 03:02:32.434944 | ubuntu-noble | skipping: Conditional result was False 2025-04-29 03:02:32.452223 | 2025-04-29 03:02:32.452315 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-29 03:02:32.901451 | ubuntu-noble | ok 2025-04-29 03:02:32.913673 | 2025-04-29 03:02:32.913768 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-29 03:02:32.942091 | ubuntu-noble | ok 2025-04-29 03:02:32.947301 | 2025-04-29 03:02:32.947379 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-29 03:02:33.240682 | ubuntu-noble -> localhost | ok 2025-04-29 03:02:33.246964 | 2025-04-29 03:02:33.247050 | TASK [validate-host : Collect information about the host] 2025-04-29 03:02:34.339455 | ubuntu-noble | ok 2025-04-29 03:02:34.356695 | 2025-04-29 03:02:34.356825 | TASK [validate-host : Sanitize hostname] 2025-04-29 03:02:34.430981 | ubuntu-noble | ok 2025-04-29 03:02:34.446087 | 2025-04-29 03:02:34.446370 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-29 03:02:35.403180 | ubuntu-noble -> localhost | changed 2025-04-29 03:02:35.410662 | 2025-04-29 03:02:35.410771 | TASK [validate-host : Collect information about zuul worker] 2025-04-29 03:02:35.900407 | ubuntu-noble | ok 2025-04-29 03:02:35.906318 | 2025-04-29 03:02:35.906407 | TASK [validate-host : Write out all zuul information for each host] 2025-04-29 03:02:36.475445 | ubuntu-noble -> localhost | changed 2025-04-29 03:02:36.487706 | 2025-04-29 03:02:36.487813 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-29 03:02:36.804480 | ubuntu-noble | ok 2025-04-29 03:02:36.818585 | 2025-04-29 03:02:36.818684 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-29 03:02:37.669666 | ubuntu-noble | changed: 2025-04-29 03:02:37.669824 | ubuntu-noble | cd+++++++++ src/ 2025-04-29 03:02:37.669858 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-29 03:02:37.669883 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-29 03:02:37.669904 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-04-29 03:02:37.669925 | ubuntu-noble | Containerfile 2025-04-29 03:02:37.670052 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007176 2025-04-29 03:03:09.371155 | 2025-04-29 03:03:09.371248 | TASK [upload-logs : Upload logs to log server] 2025-04-29 03:03:09.894915 | localhost | Output suppressed because no_log was given 2025-04-29 03:03:09.898577 | 2025-04-29 03:03:09.898817 | LOOP [upload-logs : Compress console log and json output] 2025-04-29 03:03:09.962915 | localhost | skipping: Conditional result was False 2025-04-29 03:03:09.977142 | localhost | skipping: Conditional result was False 2025-04-29 03:03:09.981614 | 2025-04-29 03:03:09.981709 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-29 03:03:10.039683 | localhost | skipping: Conditional result was False 2025-04-29 03:03:10.039977 | 2025-04-29 03:03:10.051648 | localhost | skipping: Conditional result was False 2025-04-29 03:03:10.060054 | 2025-04-29 03:03:10.060193 | LOOP [upload-logs : Upload console log and json output]