2026-05-24 00:43:26.907542 | Job console starting 2026-05-24 00:43:26.919424 | Updating git repos 2026-05-24 00:43:26.967643 | Cloning repos into workspace 2026-05-24 00:43:27.027907 | Restoring repo states 2026-05-24 00:43:27.034957 | Merging changes 2026-05-24 00:43:27.642960 | Checking out repos 2026-05-24 00:43:27.744938 | Preparing playbooks 2026-05-24 00:43:29.243424 | Running Ansible setup 2026-05-24 00:43:34.297441 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-24 00:43:35.093694 | 2026-05-24 00:43:35.093887 | PLAY [Base pre] 2026-05-24 00:43:35.111728 | 2026-05-24 00:43:35.111893 | TASK [Setup log path fact] 2026-05-24 00:43:35.141707 | debian-bookworm | ok 2026-05-24 00:43:35.158545 | 2026-05-24 00:43:35.158697 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-24 00:43:35.188828 | debian-bookworm | ok 2026-05-24 00:43:35.200391 | 2026-05-24 00:43:35.200513 | TASK [emit-job-header : Print job information] 2026-05-24 00:43:35.250913 | # Job Information 2026-05-24 00:43:35.251129 | Ansible Version: 2.16.14 2026-05-24 00:43:35.251170 | Job: python-black 2026-05-24 00:43:35.251209 | Pipeline: check 2026-05-24 00:43:35.251236 | Executor: 521e9411259a 2026-05-24 00:43:35.251260 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1210 2026-05-24 00:43:35.251285 | Event ID: 7bd16a40-5709-11f1-93bc-776f86ca9e86 2026-05-24 00:43:35.257247 | 2026-05-24 00:43:35.257382 | LOOP [emit-job-header : Print node information] 2026-05-24 00:43:35.375222 | debian-bookworm | ok: 2026-05-24 00:43:35.375440 | debian-bookworm | # Node Information 2026-05-24 00:43:35.375483 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-24 00:43:35.375509 | debian-bookworm | Hostname: debian 2026-05-24 00:43:35.375531 | debian-bookworm | Username: zuul 2026-05-24 00:43:35.375552 | debian-bookworm | Distro: Debian 12.14 2026-05-24 00:43:35.375578 | debian-bookworm | Provider: regiocloud-a 2026-05-24 00:43:35.375599 | debian-bookworm | Region: 2026-05-24 00:43:35.375620 | debian-bookworm | Label: debian-bookworm 2026-05-24 00:43:35.375640 | debian-bookworm | Product Name: OpenStack Nova 2026-05-24 00:43:35.375659 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe85:76e9 2026-05-24 00:43:35.388369 | 2026-05-24 00:43:35.388519 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-24 00:43:35.901359 | debian-bookworm -> localhost | changed 2026-05-24 00:43:35.909003 | 2026-05-24 00:43:35.909134 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-24 00:43:37.068815 | debian-bookworm -> localhost | changed 2026-05-24 00:43:37.080125 | 2026-05-24 00:43:37.080259 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-24 00:43:37.432243 | debian-bookworm -> localhost | ok 2026-05-24 00:43:37.439084 | 2026-05-24 00:43:37.439230 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-24 00:43:37.493324 | debian-bookworm | ok 2026-05-24 00:43:37.509332 | debian-bookworm | included: /var/lib/zuul/builds/318dc20199574e959f712394737654dc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-24 00:43:37.518272 | 2026-05-24 00:43:37.518420 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-24 00:43:39.169829 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-24 00:43:39.170107 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/318dc20199574e959f712394737654dc/work/318dc20199574e959f712394737654dc_id_rsa 2026-05-24 00:43:39.170145 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/318dc20199574e959f712394737654dc/work/318dc20199574e959f712394737654dc_id_rsa.pub 2026-05-24 00:43:39.170171 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-24 00:43:39.170246 | debian-bookworm -> localhost | SHA256:0B3QXmrb5RHl5uwJ4cVCrAT2SYkwf1yjUzleKpi3kKs zuul-build-sshkey 2026-05-24 00:43:39.170271 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-24 00:43:39.170304 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-24 00:43:39.170326 | debian-bookworm -> localhost | | oo=+.o=...| 2026-05-24 00:43:39.170347 | debian-bookworm -> localhost | | .+o=+B++o | 2026-05-24 00:43:39.170367 | debian-bookworm -> localhost | | . .o*Xoo++o| 2026-05-24 00:43:39.170387 | debian-bookworm -> localhost | | . ==+oo*+ | 2026-05-24 00:43:39.170406 | debian-bookworm -> localhost | | S.+oo= .o| 2026-05-24 00:43:39.170435 | debian-bookworm -> localhost | | .... o..| 2026-05-24 00:43:39.170457 | debian-bookworm -> localhost | | . ..| 2026-05-24 00:43:39.170476 | debian-bookworm -> localhost | | E | 2026-05-24 00:43:39.170496 | debian-bookworm -> localhost | | | 2026-05-24 00:43:39.170516 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-24 00:43:39.170576 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.972389 2026-05-24 00:43:39.177398 | 2026-05-24 00:43:39.177522 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-24 00:43:39.206316 | debian-bookworm | ok 2026-05-24 00:43:39.215878 | debian-bookworm | included: /var/lib/zuul/builds/318dc20199574e959f712394737654dc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-24 00:43:39.225582 | 2026-05-24 00:43:39.225706 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-24 00:43:39.249905 | debian-bookworm | skipping: Conditional result was False 2026-05-24 00:43:39.256222 | 2026-05-24 00:43:39.256339 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-24 00:43:39.978380 | debian-bookworm | changed 2026-05-24 00:43:39.989494 | 2026-05-24 00:43:39.989629 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-24 00:43:40.253185 | debian-bookworm | ok 2026-05-24 00:43:40.259772 | 2026-05-24 00:43:40.259914 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-24 00:43:40.967661 | debian-bookworm | changed 2026-05-24 00:43:40.977209 | 2026-05-24 00:43:40.977337 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-24 00:43:41.702409 | debian-bookworm | changed 2026-05-24 00:43:41.708911 | 2026-05-24 00:43:41.715004 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-24 00:43:41.767178 | debian-bookworm | skipping: Conditional result was False 2026-05-24 00:43:41.780711 | 2026-05-24 00:43:41.780870 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-24 00:43:42.880596 | debian-bookworm -> localhost | changed 2026-05-24 00:43:42.898262 | 2026-05-24 00:43:42.898399 | TASK [add-build-sshkey : Add back temp key] 2026-05-24 00:43:43.699923 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/318dc20199574e959f712394737654dc/work/318dc20199574e959f712394737654dc_id_rsa (zuul-build-sshkey) 2026-05-24 00:43:43.700103 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016071 2026-05-24 00:43:43.706621 | 2026-05-24 00:43:43.706706 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-24 00:43:44.096815 | debian-bookworm | ok 2026-05-24 00:43:44.101256 | 2026-05-24 00:43:44.101434 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-24 00:43:44.126788 | debian-bookworm | skipping: Conditional result was False 2026-05-24 00:43:44.136954 | 2026-05-24 00:43:44.137051 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-24 00:43:44.658483 | debian-bookworm | ok 2026-05-24 00:43:44.670237 | 2026-05-24 00:43:44.670345 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-24 00:43:44.728022 | debian-bookworm | ok 2026-05-24 00:43:44.732034 | 2026-05-24 00:43:44.732105 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-24 00:43:45.139796 | debian-bookworm -> localhost | ok 2026-05-24 00:43:45.144922 | 2026-05-24 00:43:45.145003 | TASK [validate-host : Collect information about the host] 2026-05-24 00:43:46.352329 | debian-bookworm | ok 2026-05-24 00:43:46.378104 | 2026-05-24 00:43:46.378201 | TASK [validate-host : Sanitize hostname] 2026-05-24 00:43:46.639840 | debian-bookworm | ok 2026-05-24 00:43:46.707021 | 2026-05-24 00:43:46.707114 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-24 00:43:47.683175 | debian-bookworm -> localhost | changed 2026-05-24 00:43:47.688958 | 2026-05-24 00:43:47.689040 | TASK [validate-host : Collect information about zuul worker] 2026-05-24 00:43:48.366077 | debian-bookworm | ok 2026-05-24 00:43:48.369939 | 2026-05-24 00:43:48.370016 | TASK [validate-host : Write out all zuul information for each host] 2026-05-24 00:43:49.926385 | debian-bookworm -> localhost | changed 2026-05-24 00:43:49.933946 | 2026-05-24 00:43:49.934027 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-24 00:43:50.254593 | debian-bookworm | ok 2026-05-24 00:43:50.259205 | 2026-05-24 00:43:50.259295 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-24 00:43:51.513462 | debian-bookworm | changed: 2026-05-24 00:43:51.513686 | debian-bookworm | cd+++++++++ src/ 2026-05-24 00:43:51.513720 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-24 00:43:51.513741 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-24 00:43:51.513769 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-24 00:43:51.513788 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/318dc20199574e959f712394737654dc/work/logs" 2026-05-24 00:44:20.855408 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/318dc20199574e959f712394737654dc/work/artifacts" 2026-05-24 00:44:21.546526 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/318dc20199574e959f712394737654dc/work/docs" 2026-05-24 00:44:21.563043 | 2026-05-24 00:44:21.563160 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-24 00:44:22.795265 | debian-bookworm | changed: 2026-05-24 00:44:22.795490 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-24 00:44:22.795527 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-24 00:44:22.795557 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-24 00:44:22.795605 | debian-bookworm | changed: All items complete 2026-05-24 00:44:22.795633 | 2026-05-24 00:44:23.766269 | debian-bookworm | changed: .d..t...... ./ 2026-05-24 00:44:24.579633 | debian-bookworm | changed: .d..t...... ./ 2026-05-24 00:44:24.602679 | 2026-05-24 00:44:24.602945 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-24 00:44:25.376058 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006490 2026-05-24 00:44:25.692881 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.024874 2026-05-24 00:44:25.700350 | 2026-05-24 00:44:25.700412 | PLAY RECAP 2026-05-24 00:44:25.700451 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-24 00:44:25.700471 | 2026-05-24 00:44:25.907847 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-24 00:44:25.908461 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-24 00:44:26.804371 | 2026-05-24 00:44:26.804504 | PLAY [Base post] 2026-05-24 00:44:26.822536 | 2026-05-24 00:44:26.822656 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-24 00:44:27.399368 | debian-bookworm | changed 2026-05-24 00:44:27.405467 | 2026-05-24 00:44:27.405566 | PLAY RECAP 2026-05-24 00:44:27.405625 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-24 00:44:27.405686 | 2026-05-24 00:44:27.522559 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-24 00:44:27.523373 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-24 00:44:28.499084 | 2026-05-24 00:44:28.499230 | PLAY [Base post-logs] 2026-05-24 00:44:28.509514 | 2026-05-24 00:44:28.509645 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-24 00:44:28.991926 | localhost | changed 2026-05-24 00:44:29.001438 | 2026-05-24 00:44:29.001576 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-24 00:44:29.026445 | localhost | ok 2026-05-24 00:44:29.029268 | 2026-05-24 00:44:29.029351 | TASK [Set zuul-log-path fact] 2026-05-24 00:44:29.043797 | localhost | ok 2026-05-24 00:44:29.052203 | 2026-05-24 00:44:29.052312 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-24 00:44:29.076852 | localhost | ok 2026-05-24 00:44:29.079609 | 2026-05-24 00:44:29.079692 | TASK [upload-logs : Create log directories] 2026-05-24 00:44:29.623419 | localhost | changed 2026-05-24 00:44:29.625952 | 2026-05-24 00:44:29.626044 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-24 00:44:30.337653 | localhost -> localhost | ok: Runtime: 0:00:00.003672 2026-05-24 00:44:30.341359 | 2026-05-24 00:44:30.341461 | TASK [upload-logs : Upload logs to log server] 2026-05-24 00:44:31.006317 | localhost | Output suppressed because no_log was given 2026-05-24 00:44:31.008335 | 2026-05-24 00:44:31.008426 | LOOP [upload-logs : Compress console log and json output] 2026-05-24 00:44:31.070760 | localhost | skipping: Conditional result was False 2026-05-24 00:44:31.082187 | localhost | skipping: Conditional result was False 2026-05-24 00:44:31.085059 | 2026-05-24 00:44:31.085157 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-24 00:44:31.147026 | localhost | skipping: Conditional result was False 2026-05-24 00:44:31.147261 | 2026-05-24 00:44:31.162683 | localhost | skipping: Conditional result was False 2026-05-24 00:44:31.166511 | 2026-05-24 00:44:31.166607 | LOOP [upload-logs : Upload console log and json output]