2026-05-20 03:07:02.226373 | Job console starting 2026-05-20 03:07:02.234131 | Updating git repos 2026-05-20 03:07:02.280304 | Cloning repos into workspace 2026-05-20 03:07:02.343433 | Restoring repo states 2026-05-20 03:07:02.367999 | Merging changes 2026-05-20 03:07:02.368015 | Checking out repos 2026-05-20 03:07:02.433305 | Preparing playbooks 2026-05-20 03:07:03.855936 | Running Ansible setup 2026-05-20 03:07:09.993427 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-20 03:07:11.556759 | 2026-05-20 03:07:11.556893 | PLAY [Base pre] 2026-05-20 03:07:11.592563 | 2026-05-20 03:07:11.592702 | TASK [Setup log path fact] 2026-05-20 03:07:11.621347 | debian-bookworm | ok 2026-05-20 03:07:11.648339 | 2026-05-20 03:07:11.648481 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-20 03:07:11.692109 | debian-bookworm | ok 2026-05-20 03:07:11.705659 | 2026-05-20 03:07:11.705775 | TASK [emit-job-header : Print job information] 2026-05-20 03:07:11.803256 | # Job Information 2026-05-20 03:07:11.803574 | Ansible Version: 2.16.14 2026-05-20 03:07:11.803703 | Job: python-black 2026-05-20 03:07:11.803777 | Pipeline: periodic-daily 2026-05-20 03:07:11.803825 | Executor: 521e9411259a 2026-05-20 03:07:11.803868 | Triggered by: https://github.com/osism/generics 2026-05-20 03:07:11.803913 | Event ID: 833015b3e7fe42cb92b6393d3fa7e532 2026-05-20 03:07:11.812088 | 2026-05-20 03:07:11.812239 | LOOP [emit-job-header : Print node information] 2026-05-20 03:07:11.915875 | debian-bookworm | ok: 2026-05-20 03:07:11.916041 | debian-bookworm | # Node Information 2026-05-20 03:07:11.916074 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-20 03:07:11.916099 | debian-bookworm | Hostname: debian 2026-05-20 03:07:11.916121 | debian-bookworm | Username: zuul 2026-05-20 03:07:11.916141 | debian-bookworm | Distro: Debian 12.14 2026-05-20 03:07:11.916164 | debian-bookworm | Provider: regiocloud-a 2026-05-20 03:07:11.916185 | debian-bookworm | Region: 2026-05-20 03:07:11.916205 | debian-bookworm | Label: debian-bookworm 2026-05-20 03:07:11.916224 | debian-bookworm | Product Name: OpenStack Nova 2026-05-20 03:07:11.916244 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0f:1a40 2026-05-20 03:07:11.929315 | 2026-05-20 03:07:11.929418 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-20 03:07:12.427646 | debian-bookworm -> localhost | changed 2026-05-20 03:07:12.434445 | 2026-05-20 03:07:12.434548 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-20 03:07:14.241462 | debian-bookworm -> localhost | changed 2026-05-20 03:07:14.255257 | 2026-05-20 03:07:14.255376 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-20 03:07:14.681833 | debian-bookworm -> localhost | ok 2026-05-20 03:07:14.687811 | 2026-05-20 03:07:14.687914 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-20 03:07:14.728132 | debian-bookworm | ok 2026-05-20 03:07:14.754256 | debian-bookworm | included: /var/lib/zuul/builds/9a3c7c04e65445f68b6f8e5a5d1b4593/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-20 03:07:14.780723 | 2026-05-20 03:07:14.780832 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-20 03:07:16.831799 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-20 03:07:16.832027 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9a3c7c04e65445f68b6f8e5a5d1b4593/work/9a3c7c04e65445f68b6f8e5a5d1b4593_id_rsa 2026-05-20 03:07:16.832063 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9a3c7c04e65445f68b6f8e5a5d1b4593/work/9a3c7c04e65445f68b6f8e5a5d1b4593_id_rsa.pub 2026-05-20 03:07:16.832090 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-20 03:07:16.832113 | debian-bookworm -> localhost | SHA256:80W0JkCgrAuoF4++YKEC1No1G0E6E2AcMDJGVsE9Ezg zuul-build-sshkey 2026-05-20 03:07:16.832137 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-20 03:07:16.832174 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-20 03:07:16.832197 | debian-bookworm -> localhost | |OB=+=+ooo . | 2026-05-20 03:07:16.832220 | debian-bookworm -> localhost | |=+.Eo=. . . . | 2026-05-20 03:07:16.832241 | debian-bookworm -> localhost | | . =++o . + | 2026-05-20 03:07:16.832261 | debian-bookworm -> localhost | |o o.+ + + | 2026-05-20 03:07:16.832282 | debian-bookworm -> localhost | |+oo. . S . | 2026-05-20 03:07:16.832310 | debian-bookworm -> localhost | |+..= o . | 2026-05-20 03:07:16.832332 | debian-bookworm -> localhost | |=.+ . . | 2026-05-20 03:07:16.832352 | debian-bookworm -> localhost | |o+ | 2026-05-20 03:07:16.832373 | debian-bookworm -> localhost | | o. | 2026-05-20 03:07:16.832394 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-20 03:07:16.832448 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.499769 2026-05-20 03:07:16.839128 | 2026-05-20 03:07:16.839241 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-20 03:07:16.877777 | debian-bookworm | ok 2026-05-20 03:07:16.887477 | debian-bookworm | included: /var/lib/zuul/builds/9a3c7c04e65445f68b6f8e5a5d1b4593/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-20 03:07:16.896934 | 2026-05-20 03:07:16.897033 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-20 03:07:16.936933 | debian-bookworm | skipping: Conditional result was False 2026-05-20 03:07:16.943064 | 2026-05-20 03:07:16.943172 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-20 03:07:17.609822 | debian-bookworm | changed 2026-05-20 03:07:17.628109 | 2026-05-20 03:07:17.628319 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-20 03:07:17.920455 | debian-bookworm | ok 2026-05-20 03:07:17.936698 | 2026-05-20 03:07:17.944121 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-20 03:07:18.742985 | debian-bookworm | changed 2026-05-20 03:07:18.750938 | 2026-05-20 03:07:18.751039 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-20 03:07:19.443487 | debian-bookworm | changed 2026-05-20 03:07:19.449744 | 2026-05-20 03:07:19.449830 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-20 03:07:19.483329 | debian-bookworm | skipping: Conditional result was False 2026-05-20 03:07:19.489514 | 2026-05-20 03:07:19.489648 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-20 03:07:20.373405 | debian-bookworm -> localhost | changed 2026-05-20 03:07:20.382633 | 2026-05-20 03:07:20.382734 | TASK [add-build-sshkey : Add back temp key] 2026-05-20 03:07:20.778385 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9a3c7c04e65445f68b6f8e5a5d1b4593/work/9a3c7c04e65445f68b6f8e5a5d1b4593_id_rsa (zuul-build-sshkey) 2026-05-20 03:07:20.778575 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.034176 2026-05-20 03:07:20.785746 | 2026-05-20 03:07:20.785835 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-20 03:07:21.183447 | debian-bookworm | ok 2026-05-20 03:07:21.190761 | 2026-05-20 03:07:21.190933 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-20 03:07:21.225032 | debian-bookworm | skipping: Conditional result was False 2026-05-20 03:07:21.238392 | 2026-05-20 03:07:21.238501 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-20 03:07:21.646218 | debian-bookworm | ok 2026-05-20 03:07:21.658690 | 2026-05-20 03:07:21.658795 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-20 03:07:21.691716 | debian-bookworm | ok 2026-05-20 03:07:21.699176 | 2026-05-20 03:07:21.699299 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-20 03:07:21.979742 | debian-bookworm -> localhost | ok 2026-05-20 03:07:21.985911 | 2026-05-20 03:07:21.986006 | TASK [validate-host : Collect information about the host] 2026-05-20 03:07:23.034919 | debian-bookworm | ok 2026-05-20 03:07:23.045982 | 2026-05-20 03:07:23.046094 | TASK [validate-host : Sanitize hostname] 2026-05-20 03:07:23.134774 | debian-bookworm | ok 2026-05-20 03:07:23.173080 | 2026-05-20 03:07:23.173197 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-20 03:07:23.698102 | debian-bookworm -> localhost | changed 2026-05-20 03:07:23.707961 | 2026-05-20 03:07:23.708144 | TASK [validate-host : Collect information about zuul worker] 2026-05-20 03:07:24.144011 | debian-bookworm | ok 2026-05-20 03:07:24.156399 | 2026-05-20 03:07:24.166960 | TASK [validate-host : Write out all zuul information for each host] 2026-05-20 03:07:24.783750 | debian-bookworm -> localhost | changed 2026-05-20 03:07:24.795129 | 2026-05-20 03:07:24.795244 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-20 03:07:25.081936 | debian-bookworm | ok 2026-05-20 03:07:25.087959 | 2026-05-20 03:07:25.088082 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-20 03:07:26.107228 | debian-bookworm | changed: 2026-05-20 03:07:26.112756 | debian-bookworm | cd+++++++++ src/ 2026-05-20 03:07:26.113383 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-20 03:07:26.114021 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-20 03:07:26.114101 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-20 03:07:26.114128 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/9a3c7c04e65445f68b6f8e5a5d1b4593/work/logs" 2026-05-20 03:07:53.407026 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9a3c7c04e65445f68b6f8e5a5d1b4593/work/artifacts" 2026-05-20 03:07:53.723394 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9a3c7c04e65445f68b6f8e5a5d1b4593/work/docs" 2026-05-20 03:07:53.748764 | 2026-05-20 03:07:53.749115 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-20 03:07:54.542616 | debian-bookworm | changed: 2026-05-20 03:07:54.543100 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-20 03:07:54.543154 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-20 03:07:54.543187 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-20 03:07:54.543243 | debian-bookworm | changed: All items complete 2026-05-20 03:07:54.543269 | 2026-05-20 03:07:55.163926 | debian-bookworm | changed: .d..t...... ./ 2026-05-20 03:07:55.873528 | debian-bookworm | changed: .d..t...... ./ 2026-05-20 03:07:55.891922 | 2026-05-20 03:07:55.892106 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-20 03:07:55.921626 | debian-bookworm | skipping: Conditional result was False 2026-05-20 03:07:55.926725 | debian-bookworm | skipping: Conditional result was False 2026-05-20 03:07:55.941289 | 2026-05-20 03:07:55.941421 | PLAY RECAP 2026-05-20 03:07:55.941487 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-20 03:07:55.941513 | 2026-05-20 03:07:56.131783 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-20 03:07:56.132671 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-20 03:07:56.960968 | 2026-05-20 03:07:56.961147 | PLAY [Base post] 2026-05-20 03:07:56.985452 | 2026-05-20 03:07:56.985629 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-20 03:07:57.653057 | debian-bookworm | changed 2026-05-20 03:07:57.659897 | 2026-05-20 03:07:57.660022 | PLAY RECAP 2026-05-20 03:07:57.660086 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 03:07:57.660151 | 2026-05-20 03:07:57.852549 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-20 03:07:57.853500 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-20 03:07:58.672304 | 2026-05-20 03:07:58.672494 | PLAY [Base post-logs] 2026-05-20 03:07:58.683950 | 2026-05-20 03:07:58.684113 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-20 03:07:59.167432 | localhost | changed 2026-05-20 03:07:59.178262 | 2026-05-20 03:07:59.178426 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-20 03:07:59.227260 | localhost | ok 2026-05-20 03:07:59.235808 | 2026-05-20 03:07:59.236001 | TASK [Set zuul-log-path fact] 2026-05-20 03:07:59.255285 | localhost | ok 2026-05-20 03:07:59.267493 | 2026-05-20 03:07:59.267641 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-20 03:07:59.304559 | localhost | ok 2026-05-20 03:07:59.307869 | 2026-05-20 03:07:59.307979 | TASK [upload-logs : Create log directories] 2026-05-20 03:07:59.877872 | localhost | changed 2026-05-20 03:07:59.880820 | 2026-05-20 03:07:59.880929 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-20 03:08:00.610561 | localhost -> localhost | ok: Runtime: 0:00:00.035154 2026-05-20 03:08:00.615833 | 2026-05-20 03:08:00.615983 | TASK [upload-logs : Upload logs to log server] 2026-05-20 03:08:01.396006 | localhost | Output suppressed because no_log was given 2026-05-20 03:08:01.398151 | 2026-05-20 03:08:01.398268 | LOOP [upload-logs : Compress console log and json output] 2026-05-20 03:08:01.464220 | localhost | skipping: Conditional result was False 2026-05-20 03:08:01.470670 | localhost | skipping: Conditional result was False 2026-05-20 03:08:01.478431 | 2026-05-20 03:08:01.478640 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-20 03:08:01.586618 | localhost | skipping: Conditional result was False 2026-05-20 03:08:01.586961 | 2026-05-20 03:08:01.596318 | localhost | skipping: Conditional result was False 2026-05-20 03:08:01.607902 | 2026-05-20 03:08:01.608081 | LOOP [upload-logs : Upload console log and json output]