2025-05-27 18:05:56.772988 | Job console starting 2025-05-27 18:05:56.782773 | Updating git repos 2025-05-27 18:05:56.817130 | Cloning repos into workspace 2025-05-27 18:05:56.868903 | Restoring repo states 2025-05-27 18:05:56.901193 | Merging changes 2025-05-27 18:05:57.570814 | Checking out repos 2025-05-27 18:05:57.670786 | Preparing playbooks 2025-05-27 18:05:58.781551 | Running Ansible setup 2025-05-27 18:06:04.239891 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-27 18:06:05.104935 | 2025-05-27 18:06:05.105116 | PLAY [Base pre] 2025-05-27 18:06:05.121240 | 2025-05-27 18:06:05.121426 | TASK [Setup log path fact] 2025-05-27 18:06:05.143320 | debian-bookworm | ok 2025-05-27 18:06:05.166752 | 2025-05-27 18:06:05.166953 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-27 18:06:05.229459 | debian-bookworm | ok 2025-05-27 18:06:05.257567 | 2025-05-27 18:06:05.257717 | TASK [emit-job-header : Print job information] 2025-05-27 18:06:05.334591 | # Job Information 2025-05-27 18:06:05.334798 | Ansible Version: 2.16.14 2025-05-27 18:06:05.334852 | Job: python-black 2025-05-27 18:06:05.334887 | Pipeline: check 2025-05-27 18:06:05.334911 | Executor: 521e9411259a 2025-05-27 18:06:05.334932 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1872 2025-05-27 18:06:05.334956 | Event ID: 37484fc0-3b25-11f0-9092-35082055e8d6 2025-05-27 18:06:05.344629 | 2025-05-27 18:06:05.344803 | LOOP [emit-job-header : Print node information] 2025-05-27 18:06:05.628049 | debian-bookworm | ok: 2025-05-27 18:06:05.628400 | debian-bookworm | # Node Information 2025-05-27 18:06:05.628450 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-27 18:06:05.628477 | debian-bookworm | Hostname: debian 2025-05-27 18:06:05.628500 | debian-bookworm | Username: zuul 2025-05-27 18:06:05.628521 | debian-bookworm | Distro: Debian 12.11 2025-05-27 18:06:05.628545 | debian-bookworm | Provider: regiocloud-a 2025-05-27 18:06:05.628566 | debian-bookworm | Region: 2025-05-27 18:06:05.628587 | debian-bookworm | Label: debian-bookworm 2025-05-27 18:06:05.628605 | debian-bookworm | Product Name: OpenStack Nova 2025-05-27 18:06:05.628625 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe19:b1eb 2025-05-27 18:06:05.652426 | 2025-05-27 18:06:05.652580 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-27 18:06:06.279744 | debian-bookworm -> localhost | changed 2025-05-27 18:06:06.287548 | 2025-05-27 18:06:06.287687 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-27 18:06:08.375758 | debian-bookworm -> localhost | changed 2025-05-27 18:06:08.400315 | 2025-05-27 18:06:08.400938 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-27 18:06:09.279346 | debian-bookworm -> localhost | ok 2025-05-27 18:06:09.290579 | 2025-05-27 18:06:09.291029 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-27 18:06:09.345859 | debian-bookworm | ok 2025-05-27 18:06:09.484984 | debian-bookworm | included: /var/lib/zuul/builds/812a76f09e5d450887fcfe603f15f9ad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-27 18:06:09.503714 | 2025-05-27 18:06:09.503866 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-27 18:06:13.571360 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-27 18:06:13.571603 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/812a76f09e5d450887fcfe603f15f9ad/work/812a76f09e5d450887fcfe603f15f9ad_id_rsa 2025-05-27 18:06:13.571644 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/812a76f09e5d450887fcfe603f15f9ad/work/812a76f09e5d450887fcfe603f15f9ad_id_rsa.pub 2025-05-27 18:06:13.571671 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-27 18:06:13.571696 | debian-bookworm -> localhost | SHA256:eApoOh6DQLzt2jN7a6XzfbJx4MvXI3RXlgneWSDq7Z4 zuul-build-sshkey 2025-05-27 18:06:13.571718 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-27 18:06:13.571755 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-27 18:06:13.571777 | debian-bookworm -> localhost | | . .. | 2025-05-27 18:06:13.571800 | debian-bookworm -> localhost | |. . o .| 2025-05-27 18:06:13.571821 | debian-bookworm -> localhost | | o . . o =| 2025-05-27 18:06:13.571841 | debian-bookworm -> localhost | |. o. . . . . =o| 2025-05-27 18:06:13.571861 | debian-bookworm -> localhost | |..o.. . S.. . ..| 2025-05-27 18:06:13.571886 | debian-bookworm -> localhost | |oo. . +. .o . . | 2025-05-27 18:06:13.571907 | debian-bookworm -> localhost | |+o . + o..+ . | 2025-05-27 18:06:13.571927 | debian-bookworm -> localhost | |..=o = o.+= + | 2025-05-27 18:06:13.571948 | debian-bookworm -> localhost | | o o*.+. == E . | 2025-05-27 18:06:13.571968 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-27 18:06:13.572022 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.343212 2025-05-27 18:06:13.578729 | 2025-05-27 18:06:13.578889 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-27 18:06:13.665722 | debian-bookworm | ok 2025-05-27 18:06:13.687515 | debian-bookworm | included: /var/lib/zuul/builds/812a76f09e5d450887fcfe603f15f9ad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-27 18:06:13.721937 | 2025-05-27 18:06:13.722090 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-27 18:06:13.782309 | debian-bookworm | skipping: Conditional result was False 2025-05-27 18:06:13.792002 | 2025-05-27 18:06:13.792231 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-27 18:06:14.566627 | debian-bookworm | changed 2025-05-27 18:06:14.615224 | 2025-05-27 18:06:14.616434 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-27 18:06:14.909059 | debian-bookworm | ok 2025-05-27 18:06:14.918056 | 2025-05-27 18:06:14.918678 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-27 18:06:15.689369 | debian-bookworm | changed 2025-05-27 18:06:15.696474 | 2025-05-27 18:06:15.696581 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-27 18:06:16.328531 | debian-bookworm | changed 2025-05-27 18:06:16.338189 | 2025-05-27 18:06:16.338299 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-27 18:06:16.372219 | debian-bookworm | skipping: Conditional result was False 2025-05-27 18:06:16.379444 | 2025-05-27 18:06:16.379553 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-27 18:06:17.044311 | debian-bookworm -> localhost | changed 2025-05-27 18:06:17.065824 | 2025-05-27 18:06:17.065946 | TASK [add-build-sshkey : Add back temp key] 2025-05-27 18:06:17.589258 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/812a76f09e5d450887fcfe603f15f9ad/work/812a76f09e5d450887fcfe603f15f9ad_id_rsa (zuul-build-sshkey) 2025-05-27 18:06:17.589503 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015430 2025-05-27 18:06:17.596961 | 2025-05-27 18:06:17.597061 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-27 18:06:18.114823 | debian-bookworm | ok 2025-05-27 18:06:18.126705 | 2025-05-27 18:06:18.127817 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-27 18:06:18.212133 | debian-bookworm | skipping: Conditional result was False 2025-05-27 18:06:18.256903 | 2025-05-27 18:06:18.257076 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-27 18:06:18.859427 | debian-bookworm | ok 2025-05-27 18:06:18.879925 | 2025-05-27 18:06:18.881393 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-27 18:06:18.997483 | debian-bookworm | ok 2025-05-27 18:06:19.007558 | 2025-05-27 18:06:19.007702 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-27 18:06:19.605456 | debian-bookworm -> localhost | ok 2025-05-27 18:06:19.612571 | 2025-05-27 18:06:19.612711 | TASK [validate-host : Collect information about the host] 2025-05-27 18:06:21.207883 | debian-bookworm | ok 2025-05-27 18:06:21.218341 | 2025-05-27 18:06:21.218485 | TASK [validate-host : Sanitize hostname] 2025-05-27 18:06:21.370814 | debian-bookworm | ok 2025-05-27 18:06:21.419532 | 2025-05-27 18:06:21.419672 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-27 18:06:22.501867 | debian-bookworm -> localhost | changed 2025-05-27 18:06:22.508978 | 2025-05-27 18:06:22.509113 | TASK [validate-host : Collect information about zuul worker] 2025-05-27 18:06:22.973611 | debian-bookworm | ok 2025-05-27 18:06:22.978664 | 2025-05-27 18:06:22.978791 | TASK [validate-host : Write out all zuul information for each host] 2025-05-27 18:06:23.778437 | debian-bookworm -> localhost | changed 2025-05-27 18:06:23.788950 | 2025-05-27 18:06:23.789088 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-27 18:06:24.104331 | debian-bookworm | ok 2025-05-27 18:06:24.110376 | 2025-05-27 18:06:24.110506 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-27 18:06:25.415771 | debian-bookworm | changed: 2025-05-27 18:06:25.415949 | debian-bookworm | cd+++++++++ src/ 2025-05-27 18:06:25.415983 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-27 18:06:25.416007 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-27 18:06:25.416029 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-05-27 18:06:25.416050 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008368 2025-05-27 18:06:51.747451 | 2025-05-27 18:06:51.747580 | TASK [upload-logs : Upload logs to log server] 2025-05-27 18:06:52.384555 | localhost | Output suppressed because no_log was given 2025-05-27 18:06:52.387188 | 2025-05-27 18:06:52.387323 | LOOP [upload-logs : Compress console log and json output] 2025-05-27 18:06:52.449449 | localhost | skipping: Conditional result was False 2025-05-27 18:06:52.457861 | localhost | skipping: Conditional result was False 2025-05-27 18:06:52.466162 | 2025-05-27 18:06:52.466389 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-27 18:06:52.536852 | localhost | skipping: Conditional result was False 2025-05-27 18:06:52.537851 | 2025-05-27 18:06:52.554052 | localhost | skipping: Conditional result was False 2025-05-27 18:06:52.567291 | 2025-05-27 18:06:52.567424 | LOOP [upload-logs : Upload console log and json output]