2026-09-25 04:04:38.274344 | Job console starting 2026-09-25 04:04:38.287497 | Updating git repos 2026-09-25 04:04:38.343407 | Cloning repos into workspace 2026-09-25 04:04:38.447241 | Restoring repo states 2026-09-25 04:04:38.481754 | Merging changes 2026-09-25 04:04:39.412455 | Checking out repos 2026-09-25 04:04:39.511685 | Preparing playbooks 2026-09-25 04:04:40.831270 | Running Ansible setup 2026-09-25 04:04:46.650534 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-25 04:04:47.448374 | 2026-09-25 04:04:47.448490 | PLAY [Base pre] 2026-09-25 04:04:47.466841 | 2026-09-25 04:04:47.466943 | TASK [Setup log path fact] 2026-09-25 04:04:47.483946 | debian-bookworm | ok 2026-09-25 04:04:47.505667 | 2026-09-25 04:04:47.505781 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-25 04:04:47.562944 | debian-bookworm | ok 2026-09-25 04:04:47.577889 | 2026-09-25 04:04:47.578139 | TASK [emit-job-header : Print job information] 2026-09-25 04:04:47.625177 | # Job Information 2026-09-25 04:04:47.625312 | Ansible Version: 2.16.14 2026-09-25 04:04:47.625341 | Job: python-black 2026-09-25 04:04:47.625367 | Pipeline: check 2026-09-25 04:04:47.625386 | Executor: 521e9411259a 2026-09-25 04:04:47.625403 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2162 2026-09-25 04:04:47.625422 | Event ID: 0edaedf0-b896-11f1-89df-12aafb2bf586 2026-09-25 04:04:47.630062 | 2026-09-25 04:04:47.630149 | LOOP [emit-job-header : Print node information] 2026-09-25 04:04:47.743138 | debian-bookworm | ok: 2026-09-25 04:04:47.743281 | debian-bookworm | # Node Information 2026-09-25 04:04:47.743309 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-25 04:04:47.743330 | debian-bookworm | Hostname: debian 2026-09-25 04:04:47.743348 | debian-bookworm | Username: zuul 2026-09-25 04:04:47.743365 | debian-bookworm | Distro: Debian 12.15 2026-09-25 04:04:47.743384 | debian-bookworm | Provider: regiocloud-a 2026-09-25 04:04:47.743401 | debian-bookworm | Region: 2026-09-25 04:04:47.743418 | debian-bookworm | Label: debian-bookworm 2026-09-25 04:04:47.743434 | debian-bookworm | Product Name: OpenStack Nova 2026-09-25 04:04:47.743450 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec8:ca33 2026-09-25 04:04:47.754245 | 2026-09-25 04:04:47.754358 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-25 04:04:48.363270 | debian-bookworm -> localhost | changed 2026-09-25 04:04:48.378380 | 2026-09-25 04:04:48.378493 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-25 04:04:50.263218 | debian-bookworm -> localhost | changed 2026-09-25 04:04:50.278404 | 2026-09-25 04:04:50.278506 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-25 04:04:50.699043 | debian-bookworm -> localhost | ok 2026-09-25 04:04:50.707578 | 2026-09-25 04:04:50.707680 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-25 04:04:50.738077 | debian-bookworm | ok 2026-09-25 04:04:50.768057 | debian-bookworm | included: /var/lib/zuul/builds/b76c5de5105b450783ed1be8eb57f670/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-25 04:04:50.794731 | 2026-09-25 04:04:50.794869 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-25 04:04:52.867238 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-25 04:04:52.867412 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b76c5de5105b450783ed1be8eb57f670/work/b76c5de5105b450783ed1be8eb57f670_id_rsa 2026-09-25 04:04:52.867446 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b76c5de5105b450783ed1be8eb57f670/work/b76c5de5105b450783ed1be8eb57f670_id_rsa.pub 2026-09-25 04:04:52.867468 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-25 04:04:52.867489 | debian-bookworm -> localhost | SHA256:m2KC1NIuNEAKaeONg2iR864p7JZ7jEypTBMB+DBvgD8 zuul-build-sshkey 2026-09-25 04:04:52.867507 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-25 04:04:52.867533 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-25 04:04:52.867551 | debian-bookworm -> localhost | |*o. | 2026-09-25 04:04:52.867569 | debian-bookworm -> localhost | |@B | 2026-09-25 04:04:52.867586 | debian-bookworm -> localhost | |BBO | 2026-09-25 04:04:52.867603 | debian-bookworm -> localhost | |oBE= | 2026-09-25 04:04:52.867769 | debian-bookworm -> localhost | |..X.o S | 2026-09-25 04:04:52.867826 | debian-bookworm -> localhost | | B * o | 2026-09-25 04:04:52.867847 | debian-bookworm -> localhost | |B X o o o | 2026-09-25 04:04:52.867865 | debian-bookworm -> localhost | |oX + o . | 2026-09-25 04:04:52.867884 | debian-bookworm -> localhost | |+oo | 2026-09-25 04:04:52.867901 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-25 04:04:52.867952 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.299476 2026-09-25 04:04:52.873207 | 2026-09-25 04:04:52.873280 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-25 04:04:52.910521 | debian-bookworm | ok 2026-09-25 04:04:52.919620 | debian-bookworm | included: /var/lib/zuul/builds/b76c5de5105b450783ed1be8eb57f670/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-25 04:04:52.929338 | 2026-09-25 04:04:52.929416 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-25 04:04:52.942769 | debian-bookworm | skipping: Conditional result was False 2026-09-25 04:04:52.950900 | 2026-09-25 04:04:52.950982 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-25 04:04:53.646270 | debian-bookworm | changed 2026-09-25 04:04:53.666197 | 2026-09-25 04:04:53.666290 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-25 04:04:53.955883 | debian-bookworm | ok 2026-09-25 04:04:53.960475 | 2026-09-25 04:04:53.960557 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-25 04:04:54.880322 | debian-bookworm | changed 2026-09-25 04:04:54.884633 | 2026-09-25 04:04:54.888333 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-25 04:04:55.652091 | debian-bookworm | changed 2026-09-25 04:04:55.659505 | 2026-09-25 04:04:55.659636 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-25 04:04:55.695750 | debian-bookworm | skipping: Conditional result was False 2026-09-25 04:04:55.700701 | 2026-09-25 04:04:55.700778 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-25 04:04:56.285111 | debian-bookworm -> localhost | changed 2026-09-25 04:04:56.295689 | 2026-09-25 04:04:56.295782 | TASK [add-build-sshkey : Add back temp key] 2026-09-25 04:04:56.671415 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b76c5de5105b450783ed1be8eb57f670/work/b76c5de5105b450783ed1be8eb57f670_id_rsa (zuul-build-sshkey) 2026-09-25 04:04:56.671598 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009610 2026-09-25 04:04:56.677656 | 2026-09-25 04:04:56.677742 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-25 04:04:57.087512 | debian-bookworm | ok 2026-09-25 04:04:57.091686 | 2026-09-25 04:04:57.091761 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-25 04:04:57.138467 | debian-bookworm | skipping: Conditional result was False 2026-09-25 04:04:57.150974 | 2026-09-25 04:04:57.151064 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-25 04:04:57.639856 | debian-bookworm | ok 2026-09-25 04:04:57.653903 | 2026-09-25 04:04:57.653997 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-25 04:04:57.717745 | debian-bookworm | ok 2026-09-25 04:04:57.722851 | 2026-09-25 04:04:57.722936 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-25 04:04:58.293746 | debian-bookworm -> localhost | ok 2026-09-25 04:04:58.298913 | 2026-09-25 04:04:58.298986 | TASK [validate-host : Collect information about the host] 2026-09-25 04:04:59.729232 | debian-bookworm | ok 2026-09-25 04:04:59.747685 | 2026-09-25 04:04:59.747784 | TASK [validate-host : Sanitize hostname] 2026-09-25 04:04:59.940399 | debian-bookworm | ok 2026-09-25 04:04:59.952039 | 2026-09-25 04:04:59.952146 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-25 04:05:00.942645 | debian-bookworm -> localhost | changed 2026-09-25 04:05:00.947535 | 2026-09-25 04:05:00.947614 | TASK [validate-host : Collect information about zuul worker] 2026-09-25 04:05:01.393319 | debian-bookworm | ok 2026-09-25 04:05:01.397129 | 2026-09-25 04:05:01.397206 | TASK [validate-host : Write out all zuul information for each host] 2026-09-25 04:05:02.220575 | debian-bookworm -> localhost | changed 2026-09-25 04:05:02.230010 | 2026-09-25 04:05:02.230104 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-25 04:05:02.467538 | debian-bookworm | ok 2026-09-25 04:05:02.472144 | 2026-09-25 04:05:02.472219 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-25 04:05:03.763377 | debian-bookworm | changed: 2026-09-25 04:05:03.763536 | debian-bookworm | cd+++++++++ src/ 2026-09-25 04:05:03.763565 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-25 04:05:03.763586 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-25 04:05:03.763603 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-09-25 04:05:03.763620 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b76c5de5105b450783ed1be8eb57f670/work/logs" 2026-09-25 04:06:04.936249 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b76c5de5105b450783ed1be8eb57f670/work/artifacts" 2026-09-25 04:06:05.242297 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b76c5de5105b450783ed1be8eb57f670/work/docs" 2026-09-25 04:06:05.256935 | 2026-09-25 04:06:05.257063 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-25 04:06:06.096244 | debian-bookworm | changed: 2026-09-25 04:06:06.096473 | debian-bookworm | .d..t...... ./ 2026-09-25 04:06:06.096511 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-25 04:06:06.096536 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-25 04:06:06.096559 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-25 04:06:06.096580 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-25 04:06:06.096600 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-25 04:06:06.096638 | debian-bookworm | changed: All items complete 2026-09-25 04:06:06.096666 | 2026-09-25 04:06:06.666250 | debian-bookworm | changed: .d..t...... ./ 2026-09-25 04:06:07.247268 | debian-bookworm | changed: .d..t...... ./ 2026-09-25 04:06:07.264185 | 2026-09-25 04:06:07.264309 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-25 04:06:07.636410 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006397 2026-09-25 04:06:08.024777 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.017314 2026-09-25 04:06:08.038019 | 2026-09-25 04:06:08.038188 | PLAY RECAP 2026-09-25 04:06:08.038242 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-25 04:06:08.038268 | 2026-09-25 04:06:08.179675 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-25 04:06:08.180592 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-25 04:06:08.938024 | 2026-09-25 04:06:08.938188 | PLAY [Base post] 2026-09-25 04:06:08.956101 | 2026-09-25 04:06:08.956246 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-25 04:06:09.538772 | debian-bookworm | changed 2026-09-25 04:06:09.546120 | 2026-09-25 04:06:09.546238 | PLAY RECAP 2026-09-25 04:06:09.546300 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-25 04:06:09.546363 | 2026-09-25 04:06:09.708569 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-25 04:06:09.709526 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-25 04:06:10.690720 | 2026-09-25 04:06:10.690916 | PLAY [Base post-logs] 2026-09-25 04:06:10.702025 | 2026-09-25 04:06:10.702160 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-25 04:06:11.089755 | localhost | changed 2026-09-25 04:06:11.104819 | 2026-09-25 04:06:11.104990 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-25 04:06:11.130047 | localhost | ok 2026-09-25 04:06:11.133140 | 2026-09-25 04:06:11.133230 | TASK [Set zuul-log-path fact] 2026-09-25 04:06:11.147204 | localhost | ok 2026-09-25 04:06:11.154549 | 2026-09-25 04:06:11.154648 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-25 04:06:11.178691 | localhost | ok 2026-09-25 04:06:11.181403 | 2026-09-25 04:06:11.181482 | TASK [upload-logs : Create log directories] 2026-09-25 04:06:11.631277 | localhost | changed 2026-09-25 04:06:11.633731 | 2026-09-25 04:06:11.633816 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-25 04:06:12.040574 | localhost -> localhost | ok: Runtime: 0:00:00.014046 2026-09-25 04:06:12.044324 | 2026-09-25 04:06:12.044414 | TASK [upload-logs : Upload logs to log server] 2026-09-25 04:06:12.529699 | localhost | Output suppressed because no_log was given 2026-09-25 04:06:12.531428 | 2026-09-25 04:06:12.531511 | LOOP [upload-logs : Compress console log and json output] 2026-09-25 04:06:12.585007 | localhost | skipping: Conditional result was False 2026-09-25 04:06:12.594177 | localhost | skipping: Conditional result was False 2026-09-25 04:06:12.601902 | 2026-09-25 04:06:12.601987 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-25 04:06:12.639548 | localhost | skipping: Conditional result was False 2026-09-25 04:06:12.639789 | 2026-09-25 04:06:12.645991 | localhost | skipping: Conditional result was False 2026-09-25 04:06:12.656412 | 2026-09-25 04:06:12.656495 | LOOP [upload-logs : Upload console log and json output]