2025-12-28 03:22:49.289699 | Job console starting 2025-12-28 03:22:49.304722 | Updating git repos 2025-12-28 03:22:49.348857 | Cloning repos into workspace 2025-12-28 03:22:49.452703 | Restoring repo states 2025-12-28 03:22:49.467491 | Merging changes 2025-12-28 03:22:49.467533 | Checking out repos 2025-12-28 03:22:49.647413 | Preparing playbooks 2025-12-28 03:22:51.137653 | Running Ansible setup 2025-12-28 03:22:58.756543 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-28 03:23:01.751809 | 2025-12-28 03:23:01.752279 | PLAY [Base pre] 2025-12-28 03:23:01.860931 | 2025-12-28 03:23:01.861115 | TASK [Setup log path fact] 2025-12-28 03:23:01.960217 | debian-bookworm | ok 2025-12-28 03:23:02.059389 | 2025-12-28 03:23:02.060605 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-28 03:23:02.165504 | debian-bookworm | ok 2025-12-28 03:23:02.226912 | 2025-12-28 03:23:02.227118 | TASK [emit-job-header : Print job information] 2025-12-28 03:23:02.428757 | # Job Information 2025-12-28 03:23:02.428961 | Ansible Version: 2.16.14 2025-12-28 03:23:02.428998 | Job: python-black 2025-12-28 03:23:02.429031 | Pipeline: periodic-daily 2025-12-28 03:23:02.429055 | Executor: 521e9411259a 2025-12-28 03:23:02.429076 | Triggered by: https://github.com/osism/testbed 2025-12-28 03:23:02.429098 | Event ID: 1a570721e1c34cf6884188c958228fa7 2025-12-28 03:23:02.448248 | 2025-12-28 03:23:02.448407 | LOOP [emit-job-header : Print node information] 2025-12-28 03:23:02.901273 | debian-bookworm | ok: 2025-12-28 03:23:02.901546 | debian-bookworm | # Node Information 2025-12-28 03:23:02.901582 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-28 03:23:02.901608 | debian-bookworm | Hostname: debian 2025-12-28 03:23:02.901630 | debian-bookworm | Username: zuul 2025-12-28 03:23:02.901651 | debian-bookworm | Distro: Debian 12.12 2025-12-28 03:23:02.901676 | debian-bookworm | Provider: regiocloud-a 2025-12-28 03:23:02.901698 | debian-bookworm | Region: 2025-12-28 03:23:02.901720 | debian-bookworm | Label: debian-bookworm 2025-12-28 03:23:02.901740 | debian-bookworm | Product Name: OpenStack Nova 2025-12-28 03:23:02.901760 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7f:febd 2025-12-28 03:23:02.933516 | 2025-12-28 03:23:02.933679 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-28 03:23:04.356784 | debian-bookworm -> localhost | changed 2025-12-28 03:23:04.370557 | 2025-12-28 03:23:04.370719 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-28 03:23:07.203243 | debian-bookworm -> localhost | changed 2025-12-28 03:23:07.217990 | 2025-12-28 03:23:07.218173 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-28 03:23:07.706247 | debian-bookworm -> localhost | ok 2025-12-28 03:23:07.718906 | 2025-12-28 03:23:07.719092 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-28 03:23:07.759541 | debian-bookworm | ok 2025-12-28 03:23:07.795196 | debian-bookworm | included: /var/lib/zuul/builds/66f2fc520a874dcdbd94bac4caeac762/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-28 03:23:07.812308 | 2025-12-28 03:23:07.812441 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-28 03:23:09.261600 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-28 03:23:09.262026 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/66f2fc520a874dcdbd94bac4caeac762/work/66f2fc520a874dcdbd94bac4caeac762_id_rsa 2025-12-28 03:23:09.262080 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/66f2fc520a874dcdbd94bac4caeac762/work/66f2fc520a874dcdbd94bac4caeac762_id_rsa.pub 2025-12-28 03:23:09.262108 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-28 03:23:09.262152 | debian-bookworm -> localhost | SHA256:KhhU8B9C8k3MmEpJBdMlgpmVkhylHJpH+XwCQ1xIwPI zuul-build-sshkey 2025-12-28 03:23:09.262186 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-28 03:23:09.262331 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-28 03:23:09.262363 | debian-bookworm -> localhost | |+##%**o | 2025-12-28 03:23:09.262388 | debian-bookworm -> localhost | |X=%O++o | 2025-12-28 03:23:09.262411 | debian-bookworm -> localhost | |+*o*+ o | 2025-12-28 03:23:09.262432 | debian-bookworm -> localhost | | oE +o.. | 2025-12-28 03:23:09.262453 | debian-bookworm -> localhost | | . o. S | 2025-12-28 03:23:09.262540 | debian-bookworm -> localhost | | o . | 2025-12-28 03:23:09.262564 | debian-bookworm -> localhost | | . . . | 2025-12-28 03:23:09.262585 | debian-bookworm -> localhost | | . | 2025-12-28 03:23:09.262607 | debian-bookworm -> localhost | | | 2025-12-28 03:23:09.262638 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-28 03:23:09.262890 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.522172 2025-12-28 03:23:09.273940 | 2025-12-28 03:23:09.274071 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-28 03:23:09.367670 | debian-bookworm | ok 2025-12-28 03:23:09.401012 | debian-bookworm | included: /var/lib/zuul/builds/66f2fc520a874dcdbd94bac4caeac762/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-28 03:23:09.422227 | 2025-12-28 03:23:09.422371 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-28 03:23:09.478695 | debian-bookworm | skipping: Conditional result was False 2025-12-28 03:23:09.489590 | 2025-12-28 03:23:09.489750 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-28 03:23:10.769277 | debian-bookworm | changed 2025-12-28 03:23:10.786544 | 2025-12-28 03:23:10.786699 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-28 03:23:11.092555 | debian-bookworm | ok 2025-12-28 03:23:11.098743 | 2025-12-28 03:23:11.115036 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-28 03:23:12.000049 | debian-bookworm | changed 2025-12-28 03:23:12.018181 | 2025-12-28 03:23:12.018329 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-28 03:23:12.893383 | debian-bookworm | changed 2025-12-28 03:23:12.926090 | 2025-12-28 03:23:12.926265 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-28 03:23:12.987846 | debian-bookworm | skipping: Conditional result was False 2025-12-28 03:23:12.994703 | 2025-12-28 03:23:12.994936 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-28 03:23:14.588877 | debian-bookworm -> localhost | changed 2025-12-28 03:23:14.607551 | 2025-12-28 03:23:14.609108 | TASK [add-build-sshkey : Add back temp key] 2025-12-28 03:23:15.533473 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/66f2fc520a874dcdbd94bac4caeac762/work/66f2fc520a874dcdbd94bac4caeac762_id_rsa (zuul-build-sshkey) 2025-12-28 03:23:15.533678 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.038999 2025-12-28 03:23:15.566315 | 2025-12-28 03:23:15.566422 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-28 03:23:16.289678 | debian-bookworm | ok 2025-12-28 03:23:16.295579 | 2025-12-28 03:23:16.295685 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-28 03:23:16.328687 | debian-bookworm | skipping: Conditional result was False 2025-12-28 03:23:16.339698 | 2025-12-28 03:23:16.339806 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-28 03:23:17.042655 | debian-bookworm | ok 2025-12-28 03:23:17.059349 | 2025-12-28 03:23:17.059453 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-28 03:23:17.110544 | debian-bookworm | ok 2025-12-28 03:23:17.116034 | 2025-12-28 03:23:17.116148 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-28 03:23:17.730339 | debian-bookworm -> localhost | ok 2025-12-28 03:23:17.736093 | 2025-12-28 03:23:17.736214 | TASK [validate-host : Collect information about the host] 2025-12-28 03:23:19.347334 | debian-bookworm | ok 2025-12-28 03:23:19.368378 | 2025-12-28 03:23:19.368487 | TASK [validate-host : Sanitize hostname] 2025-12-28 03:23:19.482182 | debian-bookworm | ok 2025-12-28 03:23:19.595348 | 2025-12-28 03:23:19.595486 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-28 03:23:21.054396 | debian-bookworm -> localhost | changed 2025-12-28 03:23:21.075057 | 2025-12-28 03:23:21.075217 | TASK [validate-host : Collect information about zuul worker] 2025-12-28 03:23:21.840897 | debian-bookworm | ok 2025-12-28 03:23:21.849526 | 2025-12-28 03:23:21.855042 | TASK [validate-host : Write out all zuul information for each host] 2025-12-28 03:23:23.547835 | debian-bookworm -> localhost | changed 2025-12-28 03:23:23.567210 | 2025-12-28 03:23:23.567342 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-28 03:23:23.908884 | debian-bookworm | ok 2025-12-28 03:23:23.922610 | 2025-12-28 03:23:23.922787 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-28 03:23:25.688296 | debian-bookworm | changed: 2025-12-28 03:23:25.688470 | debian-bookworm | cd+++++++++ src/ 2025-12-28 03:23:25.688505 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-28 03:23:25.688530 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-28 03:23:25.688552 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-28 03:23:25.688572 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005309 2025-12-28 03:23:52.516743 | 2025-12-28 03:23:52.516867 | TASK [upload-logs : Upload logs to log server] 2025-12-28 03:23:53.168015 | localhost | Output suppressed because no_log was given 2025-12-28 03:23:53.169958 | 2025-12-28 03:23:53.170069 | LOOP [upload-logs : Compress console log and json output] 2025-12-28 03:23:53.229259 | localhost | skipping: Conditional result was False 2025-12-28 03:23:53.235908 | localhost | skipping: Conditional result was False 2025-12-28 03:23:53.246988 | 2025-12-28 03:23:53.247139 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-28 03:23:53.298069 | localhost | skipping: Conditional result was False 2025-12-28 03:23:53.298372 | 2025-12-28 03:23:53.306033 | localhost | skipping: Conditional result was False 2025-12-28 03:23:53.314087 | 2025-12-28 03:23:53.314245 | LOOP [upload-logs : Upload console log and json output]