2025-08-26 20:08:57.688715 | Job console starting 2025-08-26 20:08:57.702005 | Updating git repos 2025-08-26 20:08:57.743946 | Cloning repos into workspace 2025-08-26 20:08:57.843103 | Restoring repo states 2025-08-26 20:08:57.853547 | Merging changes 2025-08-26 20:08:58.472942 | Checking out repos 2025-08-26 20:08:58.520583 | Preparing playbooks 2025-08-26 20:08:59.160406 | Running Ansible setup 2025-08-26 20:09:04.786012 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-26 20:09:05.981825 | 2025-08-26 20:09:05.982022 | PLAY [Base pre] 2025-08-26 20:09:06.009467 | 2025-08-26 20:09:06.009626 | TASK [Setup log path fact] 2025-08-26 20:09:06.039023 | debian-bookworm | ok 2025-08-26 20:09:06.054449 | 2025-08-26 20:09:06.054599 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-26 20:09:06.085308 | debian-bookworm | ok 2025-08-26 20:09:06.096397 | 2025-08-26 20:09:06.096528 | TASK [emit-job-header : Print job information] 2025-08-26 20:09:06.148844 | # Job Information 2025-08-26 20:09:06.149215 | Ansible Version: 2.16.14 2025-08-26 20:09:06.149321 | Job: python-black 2025-08-26 20:09:06.149932 | Pipeline: check 2025-08-26 20:09:06.150189 | Executor: 521e9411259a 2025-08-26 20:09:06.151142 | Triggered by: https://github.com/osism/python-osism/pull/1683 2025-08-26 20:09:06.151231 | Event ID: 65d84130-82b8-11f0-8b64-eb9be22708c5 2025-08-26 20:09:06.163608 | 2025-08-26 20:09:06.163740 | LOOP [emit-job-header : Print node information] 2025-08-26 20:09:06.276860 | debian-bookworm | ok: 2025-08-26 20:09:06.277215 | debian-bookworm | # Node Information 2025-08-26 20:09:06.277320 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-26 20:09:06.277362 | debian-bookworm | Hostname: debian 2025-08-26 20:09:06.277414 | debian-bookworm | Username: zuul 2025-08-26 20:09:06.277442 | debian-bookworm | Distro: Debian 12.11 2025-08-26 20:09:06.277467 | debian-bookworm | Provider: regiocloud-a 2025-08-26 20:09:06.277488 | debian-bookworm | Region: 2025-08-26 20:09:06.277510 | debian-bookworm | Label: debian-bookworm 2025-08-26 20:09:06.277529 | debian-bookworm | Product Name: OpenStack Nova 2025-08-26 20:09:06.277550 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7d:b700 2025-08-26 20:09:06.297992 | 2025-08-26 20:09:06.298161 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-26 20:09:06.884645 | debian-bookworm -> localhost | changed 2025-08-26 20:09:06.905438 | 2025-08-26 20:09:06.905642 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-26 20:09:08.495417 | debian-bookworm -> localhost | changed 2025-08-26 20:09:08.514867 | 2025-08-26 20:09:08.515068 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-26 20:09:08.862441 | debian-bookworm -> localhost | ok 2025-08-26 20:09:08.869183 | 2025-08-26 20:09:08.869408 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-26 20:09:08.898160 | debian-bookworm | ok 2025-08-26 20:09:08.926183 | debian-bookworm | included: /var/lib/zuul/builds/a44c3026e4934bd8b326bdf33e9a180a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-26 20:09:08.944726 | 2025-08-26 20:09:08.945435 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-26 20:09:10.637367 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-26 20:09:10.637562 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a44c3026e4934bd8b326bdf33e9a180a/work/a44c3026e4934bd8b326bdf33e9a180a_id_rsa 2025-08-26 20:09:10.637602 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a44c3026e4934bd8b326bdf33e9a180a/work/a44c3026e4934bd8b326bdf33e9a180a_id_rsa.pub 2025-08-26 20:09:10.637629 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-26 20:09:10.637655 | debian-bookworm -> localhost | SHA256:u6hVDvvm8V/vEj+Y8DiG4RrlKnf95v+mqmYABkdkEIs zuul-build-sshkey 2025-08-26 20:09:10.637678 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-26 20:09:10.637712 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-26 20:09:10.637735 | debian-bookworm -> localhost | | o=+ | 2025-08-26 20:09:10.637757 | debian-bookworm -> localhost | | ..o. | 2025-08-26 20:09:10.637777 | debian-bookworm -> localhost | | E .o | 2025-08-26 20:09:10.637798 | debian-bookworm -> localhost | | o | 2025-08-26 20:09:10.637818 | debian-bookworm -> localhost | | ...S. | 2025-08-26 20:09:10.637843 | debian-bookworm -> localhost | | =+o . . | 2025-08-26 20:09:10.637864 | debian-bookworm -> localhost | | o.=o+ + +o | 2025-08-26 20:09:10.637885 | debian-bookworm -> localhost | | o ++Bo= *.oo| 2025-08-26 20:09:10.637906 | debian-bookworm -> localhost | | ..+=*o+oB+o**| 2025-08-26 20:09:10.637926 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-26 20:09:10.637976 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.845643 2025-08-26 20:09:10.644242 | 2025-08-26 20:09:10.644335 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-26 20:09:10.687149 | debian-bookworm | ok 2025-08-26 20:09:10.700745 | debian-bookworm | included: /var/lib/zuul/builds/a44c3026e4934bd8b326bdf33e9a180a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-26 20:09:10.719978 | 2025-08-26 20:09:10.720077 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-26 20:09:10.753261 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:09:10.764265 | 2025-08-26 20:09:10.764368 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-26 20:09:11.574651 | debian-bookworm | changed 2025-08-26 20:09:11.581326 | 2025-08-26 20:09:11.581422 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-26 20:09:11.848234 | debian-bookworm | ok 2025-08-26 20:09:11.852773 | 2025-08-26 20:09:11.852859 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-26 20:09:12.569801 | debian-bookworm | changed 2025-08-26 20:09:12.575271 | 2025-08-26 20:09:12.575355 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-26 20:09:13.279823 | debian-bookworm | changed 2025-08-26 20:09:13.289770 | 2025-08-26 20:09:13.289866 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-26 20:09:13.327424 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:09:13.334387 | 2025-08-26 20:09:13.334487 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-26 20:09:13.673189 | debian-bookworm -> localhost | changed 2025-08-26 20:09:13.681503 | 2025-08-26 20:09:13.681579 | TASK [add-build-sshkey : Add back temp key] 2025-08-26 20:09:13.936177 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a44c3026e4934bd8b326bdf33e9a180a/work/a44c3026e4934bd8b326bdf33e9a180a_id_rsa (zuul-build-sshkey) 2025-08-26 20:09:13.936355 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015726 2025-08-26 20:09:13.942604 | 2025-08-26 20:09:13.942679 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-26 20:09:14.402503 | debian-bookworm | ok 2025-08-26 20:09:14.407368 | 2025-08-26 20:09:14.407456 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-26 20:09:14.430365 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:09:14.440347 | 2025-08-26 20:09:14.440439 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-26 20:09:14.945674 | debian-bookworm | ok 2025-08-26 20:09:14.962454 | 2025-08-26 20:09:14.962563 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-26 20:09:14.992629 | debian-bookworm | ok 2025-08-26 20:09:15.002516 | 2025-08-26 20:09:15.002617 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-26 20:09:15.268753 | debian-bookworm -> localhost | ok 2025-08-26 20:09:15.291428 | 2025-08-26 20:09:15.291554 | TASK [validate-host : Collect information about the host] 2025-08-26 20:09:16.385960 | debian-bookworm | ok 2025-08-26 20:09:16.401526 | 2025-08-26 20:09:16.401651 | TASK [validate-host : Sanitize hostname] 2025-08-26 20:09:16.512212 | debian-bookworm | ok 2025-08-26 20:09:16.625704 | 2025-08-26 20:09:16.625796 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-26 20:09:17.487418 | debian-bookworm -> localhost | changed 2025-08-26 20:09:17.494446 | 2025-08-26 20:09:17.494567 | TASK [validate-host : Collect information about zuul worker] 2025-08-26 20:09:17.939916 | debian-bookworm | ok 2025-08-26 20:09:17.948640 | 2025-08-26 20:09:17.948810 | TASK [validate-host : Write out all zuul information for each host] 2025-08-26 20:09:19.264869 | debian-bookworm -> localhost | changed 2025-08-26 20:09:19.274514 | 2025-08-26 20:09:19.274617 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-26 20:09:19.535241 | debian-bookworm | ok 2025-08-26 20:09:19.540459 | 2025-08-26 20:09:19.540547 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-26 20:09:20.722178 | debian-bookworm | changed: 2025-08-26 20:09:20.722348 | debian-bookworm | cd+++++++++ src/ 2025-08-26 20:09:20.722382 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-26 20:09:20.722406 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-26 20:09:20.722428 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-26 20:09:20.722448 | debian-bookworm | Containerfile 2025-08-26 20:09:20.722562 | debian-bookworm | Containerfile 2025-08-26 20:09:20.730969 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006319 2025-08-26 20:09:49.273197 | 2025-08-26 20:09:49.273322 | TASK [upload-logs : Upload logs to log server] 2025-08-26 20:09:49.882096 | localhost | Output suppressed because no_log was given 2025-08-26 20:09:49.884643 | 2025-08-26 20:09:49.884774 | LOOP [upload-logs : Compress console log and json output] 2025-08-26 20:09:49.947107 | localhost | skipping: Conditional result was False 2025-08-26 20:09:49.949829 | localhost | skipping: Conditional result was False 2025-08-26 20:09:49.956450 | 2025-08-26 20:09:49.956609 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-26 20:09:50.006235 | localhost | skipping: Conditional result was False 2025-08-26 20:09:50.006615 | 2025-08-26 20:09:50.012360 | localhost | skipping: Conditional result was False 2025-08-26 20:09:50.015822 | 2025-08-26 20:09:50.015934 | LOOP [upload-logs : Upload console log and json output]