2025-09-24 03:01:24.189708 | Job console starting 2025-09-24 03:01:24.217641 | Updating git repos 2025-09-24 03:01:24.538645 | Cloning repos into workspace 2025-09-24 03:01:24.598360 | Restoring repo states 2025-09-24 03:01:24.615410 | Merging changes 2025-09-24 03:01:24.615424 | Checking out repos 2025-09-24 03:01:24.704952 | Preparing playbooks 2025-09-24 03:01:25.969681 | Running Ansible setup 2025-09-24 03:01:31.781553 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-24 03:01:33.252859 | 2025-09-24 03:01:33.252974 | PLAY [Base pre] 2025-09-24 03:01:33.304215 | 2025-09-24 03:01:33.304330 | TASK [Setup log path fact] 2025-09-24 03:01:33.336843 | debian-bookworm | ok 2025-09-24 03:01:33.366798 | 2025-09-24 03:01:33.366938 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-24 03:01:33.444801 | debian-bookworm | ok 2025-09-24 03:01:33.454595 | 2025-09-24 03:01:33.454683 | TASK [emit-job-header : Print job information] 2025-09-24 03:01:33.587416 | # Job Information 2025-09-24 03:01:33.587638 | Ansible Version: 2.16.14 2025-09-24 03:01:33.587670 | Job: python-black 2025-09-24 03:01:33.587700 | Pipeline: periodic-daily 2025-09-24 03:01:33.587723 | Executor: 521e9411259a 2025-09-24 03:01:33.587740 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-09-24 03:01:33.587760 | Event ID: a8285463faa740d9b38dd7f62a243705 2025-09-24 03:01:33.591799 | 2025-09-24 03:01:33.591903 | LOOP [emit-job-header : Print node information] 2025-09-24 03:01:33.902851 | debian-bookworm | ok: 2025-09-24 03:01:33.903066 | debian-bookworm | # Node Information 2025-09-24 03:01:33.903108 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-24 03:01:33.903144 | debian-bookworm | Hostname: debian 2025-09-24 03:01:33.903167 | debian-bookworm | Username: zuul 2025-09-24 03:01:33.903187 | debian-bookworm | Distro: Debian 12.12 2025-09-24 03:01:33.903210 | debian-bookworm | Provider: regiocloud-a 2025-09-24 03:01:33.903231 | debian-bookworm | Region: 2025-09-24 03:01:33.903252 | debian-bookworm | Label: debian-bookworm 2025-09-24 03:01:33.903273 | debian-bookworm | Product Name: OpenStack Nova 2025-09-24 03:01:33.903292 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe85:2f0c 2025-09-24 03:01:33.922033 | 2025-09-24 03:01:33.922148 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-24 03:01:35.000826 | debian-bookworm -> localhost | changed 2025-09-24 03:01:35.008454 | 2025-09-24 03:01:35.008626 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-24 03:01:37.665376 | debian-bookworm -> localhost | changed 2025-09-24 03:01:37.676880 | 2025-09-24 03:01:37.676969 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-24 03:01:38.361892 | debian-bookworm -> localhost | ok 2025-09-24 03:01:38.367604 | 2025-09-24 03:01:38.367698 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-24 03:01:38.420155 | debian-bookworm | ok 2025-09-24 03:01:38.451698 | debian-bookworm | included: /var/lib/zuul/builds/8d54fb1a14fb419681e1028aa2f732aa/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-24 03:01:38.459883 | 2025-09-24 03:01:38.459968 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-24 03:01:41.644405 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-24 03:01:41.644583 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8d54fb1a14fb419681e1028aa2f732aa/work/8d54fb1a14fb419681e1028aa2f732aa_id_rsa 2025-09-24 03:01:41.644615 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8d54fb1a14fb419681e1028aa2f732aa/work/8d54fb1a14fb419681e1028aa2f732aa_id_rsa.pub 2025-09-24 03:01:41.644637 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-24 03:01:41.644658 | debian-bookworm -> localhost | SHA256:tq3BRbx6nPEzkrckyqDMvj0f5shymbTbiKy9BT8fjgA zuul-build-sshkey 2025-09-24 03:01:41.644676 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-24 03:01:41.644702 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-24 03:01:41.644720 | debian-bookworm -> localhost | | | 2025-09-24 03:01:41.644737 | debian-bookworm -> localhost | | . | 2025-09-24 03:01:41.644754 | debian-bookworm -> localhost | | o | 2025-09-24 03:01:41.644770 | debian-bookworm -> localhost | | . . | 2025-09-24 03:01:41.644786 | debian-bookworm -> localhost | | E . S + | 2025-09-24 03:01:41.644806 | debian-bookworm -> localhost | | . o.o * = | 2025-09-24 03:01:41.644822 | debian-bookworm -> localhost | | ..=+O O * | 2025-09-24 03:01:41.644838 | debian-bookworm -> localhost | | =.B*& B = + | 2025-09-24 03:01:41.644855 | debian-bookworm -> localhost | | .o@=B+X . | 2025-09-24 03:01:41.644871 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-24 03:01:41.644912 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.712758 2025-09-24 03:01:41.649976 | 2025-09-24 03:01:41.650050 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-24 03:01:41.686165 | debian-bookworm | ok 2025-09-24 03:01:41.693482 | debian-bookworm | included: /var/lib/zuul/builds/8d54fb1a14fb419681e1028aa2f732aa/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-24 03:01:41.716653 | 2025-09-24 03:01:41.716726 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-24 03:01:41.741545 | debian-bookworm | skipping: Conditional result was False 2025-09-24 03:01:41.746049 | 2025-09-24 03:01:41.746132 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-24 03:01:42.509041 | debian-bookworm | changed 2025-09-24 03:01:42.513281 | 2025-09-24 03:01:42.513353 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-24 03:01:42.812714 | debian-bookworm | ok 2025-09-24 03:01:42.817092 | 2025-09-24 03:01:42.817194 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-24 03:01:43.348471 | debian-bookworm | changed 2025-09-24 03:01:43.354539 | 2025-09-24 03:01:43.354616 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-24 03:01:43.925228 | debian-bookworm | changed 2025-09-24 03:01:43.932014 | 2025-09-24 03:01:43.932110 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-24 03:01:43.954999 | debian-bookworm | skipping: Conditional result was False 2025-09-24 03:01:43.960898 | 2025-09-24 03:01:43.960988 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-24 03:01:44.344424 | debian-bookworm -> localhost | changed 2025-09-24 03:01:44.355951 | 2025-09-24 03:01:44.356054 | TASK [add-build-sshkey : Add back temp key] 2025-09-24 03:01:44.782691 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8d54fb1a14fb419681e1028aa2f732aa/work/8d54fb1a14fb419681e1028aa2f732aa_id_rsa (zuul-build-sshkey) 2025-09-24 03:01:44.782906 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014530 2025-09-24 03:01:44.790647 | 2025-09-24 03:01:44.790742 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-24 03:01:45.350777 | debian-bookworm | ok 2025-09-24 03:01:45.357673 | 2025-09-24 03:01:45.357769 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-24 03:01:45.400952 | debian-bookworm | skipping: Conditional result was False 2025-09-24 03:01:45.412062 | 2025-09-24 03:01:45.412172 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-24 03:01:45.995505 | debian-bookworm | ok 2025-09-24 03:01:46.011270 | 2025-09-24 03:01:46.011361 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-24 03:01:46.048593 | debian-bookworm | ok 2025-09-24 03:01:46.052923 | 2025-09-24 03:01:46.053013 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-24 03:01:46.586088 | debian-bookworm -> localhost | ok 2025-09-24 03:01:46.594407 | 2025-09-24 03:01:46.594560 | TASK [validate-host : Collect information about the host] 2025-09-24 03:01:47.899092 | debian-bookworm | ok 2025-09-24 03:01:47.939378 | 2025-09-24 03:01:47.939483 | TASK [validate-host : Sanitize hostname] 2025-09-24 03:01:48.078806 | debian-bookworm | ok 2025-09-24 03:01:48.195943 | 2025-09-24 03:01:48.196055 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-24 03:01:49.867261 | debian-bookworm -> localhost | changed 2025-09-24 03:01:49.872752 | 2025-09-24 03:01:49.872848 | TASK [validate-host : Collect information about zuul worker] 2025-09-24 03:01:50.692330 | debian-bookworm | ok 2025-09-24 03:01:50.698050 | 2025-09-24 03:01:50.698540 | TASK [validate-host : Write out all zuul information for each host] 2025-09-24 03:01:51.986554 | debian-bookworm -> localhost | changed 2025-09-24 03:01:51.995548 | 2025-09-24 03:01:51.995635 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-24 03:01:52.331685 | debian-bookworm | ok 2025-09-24 03:01:52.337099 | 2025-09-24 03:01:52.337202 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-24 03:01:53.272721 | debian-bookworm | changed: 2025-09-24 03:01:53.272868 | debian-bookworm | cd+++++++++ src/ 2025-09-24 03:01:53.272896 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-24 03:01:53.272916 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-24 03:01:53.272934 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-09-24 03:01:53.272951 | debian-bookworm | localhost | ok: Runtime: 0:00:00.025931 2025-09-24 03:02:24.642359 | 2025-09-24 03:02:24.642437 | TASK [upload-logs : Upload logs to log server] 2025-09-24 03:02:25.666473 | localhost | Output suppressed because no_log was given 2025-09-24 03:02:25.667791 | 2025-09-24 03:02:25.667863 | LOOP [upload-logs : Compress console log and json output] 2025-09-24 03:02:25.706329 | localhost | skipping: Conditional result was False 2025-09-24 03:02:25.710640 | localhost | skipping: Conditional result was False 2025-09-24 03:02:25.722700 | 2025-09-24 03:02:25.722785 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-24 03:02:25.803513 | localhost | skipping: Conditional result was False 2025-09-24 03:02:25.803765 | 2025-09-24 03:02:25.813638 | localhost | skipping: Conditional result was False 2025-09-24 03:02:25.817548 | 2025-09-24 03:02:25.817631 | LOOP [upload-logs : Upload console log and json output]