2025-11-01 16:41:37.072320 | Job console starting 2025-11-01 16:41:37.103464 | Updating git repos 2025-11-01 16:41:37.169438 | Cloning repos into workspace 2025-11-01 16:41:37.236371 | Restoring repo states 2025-11-01 16:41:37.259754 | Merging changes 2025-11-01 16:41:37.963901 | Checking out repos 2025-11-01 16:41:38.055932 | Preparing playbooks 2025-11-01 16:41:38.882399 | Running Ansible setup 2025-11-01 16:41:45.069609 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-01 16:41:46.107699 | 2025-11-01 16:41:46.107906 | PLAY [Base pre] 2025-11-01 16:41:46.125270 | 2025-11-01 16:41:46.125407 | TASK [Setup log path fact] 2025-11-01 16:41:46.167317 | debian-bookworm | ok 2025-11-01 16:41:46.191779 | 2025-11-01 16:41:46.191968 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-01 16:41:46.221803 | debian-bookworm | ok 2025-11-01 16:41:46.239802 | 2025-11-01 16:41:46.239970 | TASK [emit-job-header : Print job information] 2025-11-01 16:41:46.291278 | # Job Information 2025-11-01 16:41:46.291467 | Ansible Version: 2.16.14 2025-11-01 16:41:46.291502 | Job: ansible-collection-ensure-readme 2025-11-01 16:41:46.291534 | Pipeline: check 2025-11-01 16:41:46.291557 | Executor: 521e9411259a 2025-11-01 16:41:46.291577 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2017 2025-11-01 16:41:46.291599 | Event ID: 9c766f10-b741-11f0-98bf-495ffce3ab1b 2025-11-01 16:41:46.296631 | 2025-11-01 16:41:46.296757 | LOOP [emit-job-header : Print node information] 2025-11-01 16:41:46.447401 | debian-bookworm | ok: 2025-11-01 16:41:46.447590 | debian-bookworm | # Node Information 2025-11-01 16:41:46.447624 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-01 16:41:46.447649 | debian-bookworm | Hostname: debian 2025-11-01 16:41:46.447670 | debian-bookworm | Username: zuul 2025-11-01 16:41:46.447691 | debian-bookworm | Distro: Debian 12.12 2025-11-01 16:41:46.447714 | debian-bookworm | Provider: regiocloud-a 2025-11-01 16:41:46.447734 | debian-bookworm | Region: 2025-11-01 16:41:46.447755 | debian-bookworm | Label: debian-bookworm 2025-11-01 16:41:46.447775 | debian-bookworm | Product Name: OpenStack Nova 2025-11-01 16:41:46.447794 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefc:235d 2025-11-01 16:41:46.461614 | 2025-11-01 16:41:46.461748 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-01 16:41:47.070517 | debian-bookworm -> localhost | changed 2025-11-01 16:41:47.078196 | 2025-11-01 16:41:47.078318 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-01 16:41:48.631496 | debian-bookworm -> localhost | changed 2025-11-01 16:41:48.642935 | 2025-11-01 16:41:48.647766 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-01 16:41:49.024085 | debian-bookworm -> localhost | ok 2025-11-01 16:41:49.030491 | 2025-11-01 16:41:49.030615 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-01 16:41:49.061377 | debian-bookworm | ok 2025-11-01 16:41:49.089988 | debian-bookworm | included: /var/lib/zuul/builds/98b60632082f453590d92fd10cd06ba8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-01 16:41:49.096380 | 2025-11-01 16:41:49.096492 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-01 16:41:50.674482 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-01 16:41:50.674643 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/98b60632082f453590d92fd10cd06ba8/work/98b60632082f453590d92fd10cd06ba8_id_rsa 2025-11-01 16:41:50.674678 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/98b60632082f453590d92fd10cd06ba8/work/98b60632082f453590d92fd10cd06ba8_id_rsa.pub 2025-11-01 16:41:50.674700 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-01 16:41:50.674719 | debian-bookworm -> localhost | SHA256:IoUwZrvHTdW4l3Fb1/3Ik7Ot5hI5EzfAz7Q/VjMm5L0 zuul-build-sshkey 2025-11-01 16:41:50.674748 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-01 16:41:50.674767 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-01 16:41:50.674784 | debian-bookworm -> localhost | | = .o . o| 2025-11-01 16:41:50.674801 | debian-bookworm -> localhost | | o + . .. o +.o +| 2025-11-01 16:41:50.674842 | debian-bookworm -> localhost | | . . o . +oO.=.| 2025-11-01 16:41:50.674861 | debian-bookworm -> localhost | | o + . o oo%=o| 2025-11-01 16:41:50.674878 | debian-bookworm -> localhost | | . + o S. +oB=| 2025-11-01 16:41:50.674901 | debian-bookworm -> localhost | | . . . = .Eo| 2025-11-01 16:41:50.674918 | debian-bookworm -> localhost | | +...| 2025-11-01 16:41:50.674934 | debian-bookworm -> localhost | | . o | 2025-11-01 16:41:50.674951 | debian-bookworm -> localhost | | +. | 2025-11-01 16:41:50.674966 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-01 16:41:50.675008 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.989065 2025-11-01 16:41:50.680001 | 2025-11-01 16:41:50.680081 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-01 16:41:50.706207 | debian-bookworm | ok 2025-11-01 16:41:50.713497 | debian-bookworm | included: /var/lib/zuul/builds/98b60632082f453590d92fd10cd06ba8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-01 16:41:50.734727 | 2025-11-01 16:41:50.734843 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-01 16:41:50.758388 | debian-bookworm | skipping: Conditional result was False 2025-11-01 16:41:50.763380 | 2025-11-01 16:41:50.763454 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-01 16:41:51.758666 | debian-bookworm | changed 2025-11-01 16:41:51.763020 | 2025-11-01 16:41:51.763097 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-01 16:41:52.001172 | debian-bookworm | ok 2025-11-01 16:41:52.005731 | 2025-11-01 16:41:52.005818 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-01 16:41:52.626167 | debian-bookworm | changed 2025-11-01 16:41:52.635692 | 2025-11-01 16:41:52.635801 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-01 16:41:53.293028 | debian-bookworm | changed 2025-11-01 16:41:53.298138 | 2025-11-01 16:41:53.298225 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-01 16:41:53.313078 | debian-bookworm | skipping: Conditional result was False 2025-11-01 16:41:53.320209 | 2025-11-01 16:41:53.320318 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-01 16:41:53.810970 | debian-bookworm -> localhost | changed 2025-11-01 16:41:53.821215 | 2025-11-01 16:41:53.821310 | TASK [add-build-sshkey : Add back temp key] 2025-11-01 16:41:54.147027 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/98b60632082f453590d92fd10cd06ba8/work/98b60632082f453590d92fd10cd06ba8_id_rsa (zuul-build-sshkey) 2025-11-01 16:41:54.147233 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009340 2025-11-01 16:41:54.154519 | 2025-11-01 16:41:54.154619 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-01 16:41:54.556784 | debian-bookworm | ok 2025-11-01 16:41:54.565302 | 2025-11-01 16:41:54.565405 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-01 16:41:54.588333 | debian-bookworm | skipping: Conditional result was False 2025-11-01 16:41:54.598273 | 2025-11-01 16:41:54.598368 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-01 16:41:55.088032 | debian-bookworm | ok 2025-11-01 16:41:55.098013 | 2025-11-01 16:41:55.098115 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-01 16:41:55.125629 | debian-bookworm | ok 2025-11-01 16:41:55.130452 | 2025-11-01 16:41:55.130546 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-01 16:41:55.390726 | debian-bookworm -> localhost | ok 2025-11-01 16:41:55.396748 | 2025-11-01 16:41:55.396841 | TASK [validate-host : Collect information about the host] 2025-11-01 16:41:56.555940 | debian-bookworm | ok 2025-11-01 16:41:56.570252 | 2025-11-01 16:41:56.570357 | TASK [validate-host : Sanitize hostname] 2025-11-01 16:41:56.656578 | debian-bookworm | ok 2025-11-01 16:41:56.686387 | 2025-11-01 16:41:56.686485 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-01 16:41:57.133510 | debian-bookworm -> localhost | changed 2025-11-01 16:41:57.139048 | 2025-11-01 16:41:57.139144 | TASK [validate-host : Collect information about zuul worker] 2025-11-01 16:41:57.550194 | debian-bookworm | ok 2025-11-01 16:41:57.562888 | 2025-11-01 16:41:57.563030 | TASK [validate-host : Write out all zuul information for each host] 2025-11-01 16:41:58.201916 | debian-bookworm -> localhost | changed 2025-11-01 16:41:58.211145 | 2025-11-01 16:41:58.211234 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-01 16:41:58.490456 | debian-bookworm | ok 2025-11-01 16:41:58.495628 | 2025-11-01 16:41:58.495718 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-01 16:41:59.739532 | debian-bookworm | changed: 2025-11-01 16:41:59.739698 | debian-bookworm | cd+++++++++ src/ 2025-11-01 16:41:59.739731 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-01 16:41:59.739755 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-01 16:41:59.739776 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-11-01 16:41:59.739797 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006615 2025-11-01 16:42:17.706286 | 2025-11-01 16:42:17.706404 | TASK [upload-logs : Upload logs to log server] 2025-11-01 16:42:18.283911 | localhost | Output suppressed because no_log was given 2025-11-01 16:42:18.287528 | 2025-11-01 16:42:18.287710 | LOOP [upload-logs : Compress console log and json output] 2025-11-01 16:42:18.334472 | localhost | skipping: Conditional result was False 2025-11-01 16:42:18.339583 | localhost | skipping: Conditional result was False 2025-11-01 16:42:18.351758 | 2025-11-01 16:42:18.351991 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-01 16:42:18.396298 | localhost | skipping: Conditional result was False 2025-11-01 16:42:18.397734 | 2025-11-01 16:42:18.400602 | localhost | skipping: Conditional result was False 2025-11-01 16:42:18.414453 | 2025-11-01 16:42:18.414694 | LOOP [upload-logs : Upload console log and json output]