2026-05-03 00:38:29.011594 | Job console starting 2026-05-03 00:38:29.067698 | Updating git repos 2026-05-03 00:38:29.094185 | Cloning repos into workspace 2026-05-03 00:38:29.155822 | Restoring repo states 2026-05-03 00:38:29.184245 | Merging changes 2026-05-03 00:38:29.825843 | Checking out repos 2026-05-03 00:38:29.904790 | Preparing playbooks 2026-05-03 00:38:31.023318 | Running Ansible setup 2026-05-03 00:38:37.415998 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-03 00:38:38.047568 | 2026-05-03 00:38:38.047692 | PLAY [Base pre] 2026-05-03 00:38:38.068666 | 2026-05-03 00:38:38.068777 | TASK [Setup log path fact] 2026-05-03 00:38:38.086156 | debian-bookworm | ok 2026-05-03 00:38:38.099245 | 2026-05-03 00:38:38.099350 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 00:38:38.126147 | debian-bookworm | ok 2026-05-03 00:38:38.135958 | 2026-05-03 00:38:38.136055 | TASK [emit-job-header : Print job information] 2026-05-03 00:38:38.183533 | # Job Information 2026-05-03 00:38:38.183675 | Ansible Version: 2.16.14 2026-05-03 00:38:38.183704 | Job: python-black 2026-05-03 00:38:38.183730 | Pipeline: check 2026-05-03 00:38:38.183749 | Executor: 521e9411259a 2026-05-03 00:38:38.183766 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1212 2026-05-03 00:38:38.183783 | Event ID: 41c54560-4688-11f1-96e9-8a4de364ff8d 2026-05-03 00:38:38.188444 | 2026-05-03 00:38:38.188538 | LOOP [emit-job-header : Print node information] 2026-05-03 00:38:38.312824 | debian-bookworm | ok: 2026-05-03 00:38:38.312990 | debian-bookworm | # Node Information 2026-05-03 00:38:38.313025 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-03 00:38:38.313051 | debian-bookworm | Hostname: debian 2026-05-03 00:38:38.313072 | debian-bookworm | Username: zuul 2026-05-03 00:38:38.313092 | debian-bookworm | Distro: Debian 12.13 2026-05-03 00:38:38.313117 | debian-bookworm | Provider: regiocloud-a 2026-05-03 00:38:38.313139 | debian-bookworm | Region: 2026-05-03 00:38:38.313159 | debian-bookworm | Label: debian-bookworm 2026-05-03 00:38:38.313178 | debian-bookworm | Product Name: OpenStack Nova 2026-05-03 00:38:38.313197 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe02:eae5 2026-05-03 00:38:38.326533 | 2026-05-03 00:38:38.326646 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-03 00:38:39.078553 | debian-bookworm -> localhost | changed 2026-05-03 00:38:39.086920 | 2026-05-03 00:38:39.087054 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-03 00:38:40.442056 | debian-bookworm -> localhost | changed 2026-05-03 00:38:40.454221 | 2026-05-03 00:38:40.454359 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-03 00:38:41.056542 | debian-bookworm -> localhost | ok 2026-05-03 00:38:41.063764 | 2026-05-03 00:38:41.063910 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-03 00:38:41.107307 | debian-bookworm | ok 2026-05-03 00:38:41.124839 | debian-bookworm | included: /var/lib/zuul/builds/ebfadf78e38a43c3bfad69db4b2a5cbd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-03 00:38:41.131302 | 2026-05-03 00:38:41.131425 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-03 00:38:46.442662 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-03 00:38:46.442981 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ebfadf78e38a43c3bfad69db4b2a5cbd/work/ebfadf78e38a43c3bfad69db4b2a5cbd_id_rsa 2026-05-03 00:38:46.443020 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ebfadf78e38a43c3bfad69db4b2a5cbd/work/ebfadf78e38a43c3bfad69db4b2a5cbd_id_rsa.pub 2026-05-03 00:38:46.443047 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-03 00:38:46.443071 | debian-bookworm -> localhost | SHA256:42gKV5+/u+4yzaTNSBclx5OGbt9MQjQlAJ+z7ZHjtlI zuul-build-sshkey 2026-05-03 00:38:46.443094 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-03 00:38:46.443129 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-03 00:38:46.443150 | debian-bookworm -> localhost | | ...=+o. | 2026-05-03 00:38:46.443172 | debian-bookworm -> localhost | | .o.Oo | 2026-05-03 00:38:46.443191 | debian-bookworm -> localhost | | .+* . | 2026-05-03 00:38:46.443211 | debian-bookworm -> localhost | | ++... | 2026-05-03 00:38:46.443230 | debian-bookworm -> localhost | | . S..o== | 2026-05-03 00:38:46.443257 | debian-bookworm -> localhost | | . +.oooEoo | 2026-05-03 00:38:46.443276 | debian-bookworm -> localhost | | . . o.+X .+ | 2026-05-03 00:38:46.443295 | debian-bookworm -> localhost | | o o =.*. . | 2026-05-03 00:38:46.443315 | debian-bookworm -> localhost | | . =B=. | 2026-05-03 00:38:46.443335 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-03 00:38:46.443429 | debian-bookworm -> localhost | ok: Runtime: 0:00:04.437473 2026-05-03 00:38:46.450418 | 2026-05-03 00:38:46.450540 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-03 00:38:46.503970 | debian-bookworm | ok 2026-05-03 00:38:46.525462 | debian-bookworm | included: /var/lib/zuul/builds/ebfadf78e38a43c3bfad69db4b2a5cbd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-03 00:38:46.537988 | 2026-05-03 00:38:46.538120 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-03 00:38:46.584778 | debian-bookworm | skipping: Conditional result was False 2026-05-03 00:38:46.591361 | 2026-05-03 00:38:46.591534 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-03 00:38:47.490733 | debian-bookworm | changed 2026-05-03 00:38:47.501779 | 2026-05-03 00:38:47.501924 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-03 00:38:47.851866 | debian-bookworm | ok 2026-05-03 00:38:47.857691 | 2026-05-03 00:38:47.857816 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-03 00:38:48.731107 | debian-bookworm | changed 2026-05-03 00:38:48.753581 | 2026-05-03 00:38:48.753952 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-03 00:38:49.574479 | debian-bookworm | changed 2026-05-03 00:38:49.587906 | 2026-05-03 00:38:49.588021 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-03 00:38:49.630159 | debian-bookworm | skipping: Conditional result was False 2026-05-03 00:38:49.638403 | 2026-05-03 00:38:49.638522 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-03 00:38:50.404346 | debian-bookworm -> localhost | changed 2026-05-03 00:38:50.414921 | 2026-05-03 00:38:50.415031 | TASK [add-build-sshkey : Add back temp key] 2026-05-03 00:38:50.848240 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ebfadf78e38a43c3bfad69db4b2a5cbd/work/ebfadf78e38a43c3bfad69db4b2a5cbd_id_rsa (zuul-build-sshkey) 2026-05-03 00:38:50.848464 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014747 2026-05-03 00:38:50.856096 | 2026-05-03 00:38:50.856194 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-03 00:38:51.258016 | debian-bookworm | ok 2026-05-03 00:38:51.270454 | 2026-05-03 00:38:51.270567 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-03 00:38:51.303793 | debian-bookworm | skipping: Conditional result was False 2026-05-03 00:38:51.313781 | 2026-05-03 00:38:51.313885 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-03 00:38:51.873330 | debian-bookworm | ok 2026-05-03 00:38:51.897620 | 2026-05-03 00:38:51.897737 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-03 00:38:51.935527 | debian-bookworm | ok 2026-05-03 00:38:51.940407 | 2026-05-03 00:38:51.940504 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-03 00:38:52.395259 | debian-bookworm -> localhost | ok 2026-05-03 00:38:52.401397 | 2026-05-03 00:38:52.401507 | TASK [validate-host : Collect information about the host] 2026-05-03 00:38:53.767195 | debian-bookworm | ok 2026-05-03 00:38:53.794211 | 2026-05-03 00:38:53.794319 | TASK [validate-host : Sanitize hostname] 2026-05-03 00:38:54.044119 | debian-bookworm | ok 2026-05-03 00:38:54.105977 | 2026-05-03 00:38:54.106071 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-03 00:38:55.154708 | debian-bookworm -> localhost | changed 2026-05-03 00:38:55.159288 | 2026-05-03 00:38:55.159366 | TASK [validate-host : Collect information about zuul worker] 2026-05-03 00:38:55.800982 | debian-bookworm | ok 2026-05-03 00:38:55.804761 | 2026-05-03 00:38:55.804835 | TASK [validate-host : Write out all zuul information for each host] 2026-05-03 00:38:56.941833 | debian-bookworm -> localhost | changed 2026-05-03 00:38:56.949760 | 2026-05-03 00:38:56.949853 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-03 00:38:57.264558 | debian-bookworm | ok 2026-05-03 00:38:57.269983 | 2026-05-03 00:38:57.270085 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-03 00:38:58.462577 | debian-bookworm | changed: 2026-05-03 00:38:58.462772 | debian-bookworm | cd+++++++++ src/ 2026-05-03 00:38:58.462806 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-03 00:38:58.462844 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-03 00:38:58.462869 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-03 00:38:58.462891 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/ebfadf78e38a43c3bfad69db4b2a5cbd/work/logs" 2026-05-03 00:39:26.161621 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ebfadf78e38a43c3bfad69db4b2a5cbd/work/artifacts" 2026-05-03 00:39:26.499082 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ebfadf78e38a43c3bfad69db4b2a5cbd/work/docs" 2026-05-03 00:39:26.522344 | 2026-05-03 00:39:26.522525 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-03 00:39:27.385325 | debian-bookworm | changed: 2026-05-03 00:39:27.385609 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-03 00:39:27.385647 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-03 00:39:27.385682 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-03 00:39:27.385728 | debian-bookworm | changed: All items complete 2026-05-03 00:39:27.385752 | 2026-05-03 00:39:28.008559 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 00:39:28.591840 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 00:39:28.617041 | 2026-05-03 00:39:28.617177 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-03 00:39:29.198687 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006775 2026-05-03 00:39:29.510059 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.007558 2026-05-03 00:39:29.532492 | 2026-05-03 00:39:29.532795 | PLAY RECAP 2026-05-03 00:39:29.533060 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-03 00:39:29.533100 | 2026-05-03 00:39:29.747550 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-03 00:39:29.749680 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 00:39:30.538098 | 2026-05-03 00:39:30.538280 | PLAY [Base post] 2026-05-03 00:39:30.557192 | 2026-05-03 00:39:30.557352 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-03 00:39:31.192076 | debian-bookworm | changed 2026-05-03 00:39:31.201583 | 2026-05-03 00:39:31.201796 | PLAY RECAP 2026-05-03 00:39:31.201869 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-03 00:39:31.201937 | 2026-05-03 00:39:31.473819 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 00:39:31.476102 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-03 00:39:32.420890 | 2026-05-03 00:39:32.421083 | PLAY [Base post-logs] 2026-05-03 00:39:32.433021 | 2026-05-03 00:39:32.433194 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-03 00:39:32.972292 | localhost | changed 2026-05-03 00:39:32.998468 | 2026-05-03 00:39:32.998694 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-03 00:39:33.044901 | localhost | ok 2026-05-03 00:39:33.048826 | 2026-05-03 00:39:33.048970 | TASK [Set zuul-log-path fact] 2026-05-03 00:39:33.076070 | localhost | ok 2026-05-03 00:39:33.085646 | 2026-05-03 00:39:33.085783 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 00:39:33.114047 | localhost | ok 2026-05-03 00:39:33.117919 | 2026-05-03 00:39:33.118044 | TASK [upload-logs : Create log directories] 2026-05-03 00:39:33.635072 | localhost | changed 2026-05-03 00:39:33.638170 | 2026-05-03 00:39:33.638288 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-03 00:39:34.240557 | localhost -> localhost | ok: Runtime: 0:00:00.006537 2026-05-03 00:39:34.246258 | 2026-05-03 00:39:34.246467 | TASK [upload-logs : Upload logs to log server] 2026-05-03 00:39:34.914566 | localhost | Output suppressed because no_log was given 2026-05-03 00:39:34.916622 | 2026-05-03 00:39:34.916737 | LOOP [upload-logs : Compress console log and json output] 2026-05-03 00:39:34.987271 | localhost | skipping: Conditional result was False 2026-05-03 00:39:34.988294 | localhost | skipping: Conditional result was False 2026-05-03 00:39:34.992623 | 2026-05-03 00:39:34.992757 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-03 00:39:35.052197 | localhost | skipping: Conditional result was False 2026-05-03 00:39:35.052602 | 2026-05-03 00:39:35.061214 | localhost | skipping: Conditional result was False 2026-05-03 00:39:35.071540 | 2026-05-03 00:39:35.071693 | LOOP [upload-logs : Upload console log and json output]