2026-10-01 18:38:34.653436 | Job console starting 2026-10-01 18:38:34.663390 | Updating git repos 2026-10-01 18:38:34.690374 | Cloning repos into workspace 2026-10-01 18:38:34.754056 | Restoring repo states 2026-10-01 18:38:34.762882 | Merging changes 2026-10-01 18:38:35.861135 | Checking out repos 2026-10-01 18:38:35.920309 | Preparing playbooks 2026-10-01 18:38:36.938936 | Running Ansible setup 2026-10-01 18:38:42.492546 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-01 18:38:43.583883 | 2026-10-01 18:38:43.584010 | PLAY [Base pre] 2026-10-01 18:38:43.599479 | 2026-10-01 18:38:43.599580 | TASK [Setup log path fact] 2026-10-01 18:38:43.626407 | debian-bookworm | ok 2026-10-01 18:38:43.641407 | 2026-10-01 18:38:43.641509 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 18:38:43.668362 | debian-bookworm | ok 2026-10-01 18:38:43.676610 | 2026-10-01 18:38:43.676725 | TASK [emit-job-header : Print job information] 2026-10-01 18:38:43.704628 | # Job Information 2026-10-01 18:38:43.704850 | Ansible Version: 2.16.14 2026-10-01 18:38:43.704883 | Job: mypy 2026-10-01 18:38:43.704913 | Pipeline: check 2026-10-01 18:38:43.704936 | Executor: 521e9411259a 2026-10-01 18:38:43.704954 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1246 2026-10-01 18:38:43.704973 | Event ID: ed295800-bdc6-11f1-9f5c-9273be43048a 2026-10-01 18:38:43.717742 | 2026-10-01 18:38:43.717849 | LOOP [emit-job-header : Print node information] 2026-10-01 18:38:43.857268 | debian-bookworm | ok: 2026-10-01 18:38:43.857456 | debian-bookworm | # Node Information 2026-10-01 18:38:43.857489 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-01 18:38:43.857512 | debian-bookworm | Hostname: debian 2026-10-01 18:38:43.857531 | debian-bookworm | Username: zuul 2026-10-01 18:38:43.857560 | debian-bookworm | Distro: Debian 12.15 2026-10-01 18:38:43.857583 | debian-bookworm | Provider: regiocloud-a 2026-10-01 18:38:43.857601 | debian-bookworm | Region: 2026-10-01 18:38:43.857620 | debian-bookworm | Label: debian-bookworm 2026-10-01 18:38:43.857636 | debian-bookworm | Product Name: OpenStack Nova 2026-10-01 18:38:43.857652 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe50:dd51 2026-10-01 18:38:43.875099 | 2026-10-01 18:38:43.875198 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-01 18:38:44.462635 | debian-bookworm -> localhost | changed 2026-10-01 18:38:44.469291 | 2026-10-01 18:38:44.469383 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-01 18:38:46.654811 | debian-bookworm -> localhost | changed 2026-10-01 18:38:46.663703 | 2026-10-01 18:38:46.663793 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-01 18:38:47.366406 | debian-bookworm -> localhost | ok 2026-10-01 18:38:47.371517 | 2026-10-01 18:38:47.371652 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-01 18:38:47.419827 | debian-bookworm | ok 2026-10-01 18:38:47.476096 | debian-bookworm | included: /var/lib/zuul/builds/f78ced0254e54e758a9821d640e292f7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-01 18:38:47.513031 | 2026-10-01 18:38:47.513134 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-01 18:38:50.635603 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-01 18:38:50.635803 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f78ced0254e54e758a9821d640e292f7/work/f78ced0254e54e758a9821d640e292f7_id_rsa 2026-10-01 18:38:50.635836 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f78ced0254e54e758a9821d640e292f7/work/f78ced0254e54e758a9821d640e292f7_id_rsa.pub 2026-10-01 18:38:50.635857 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-01 18:38:50.635878 | debian-bookworm -> localhost | SHA256:CSvl0lapl4nKPucCEBIJ7/Obx1UhIiNALaT88Z7ts6I zuul-build-sshkey 2026-10-01 18:38:50.635897 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-01 18:38:50.635923 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-01 18:38:50.635941 | debian-bookworm -> localhost | |B*. | 2026-10-01 18:38:50.635959 | debian-bookworm -> localhost | |*o..o . ... | 2026-10-01 18:38:50.635976 | debian-bookworm -> localhost | |oooo oo.o. . | 2026-10-01 18:38:50.635992 | debian-bookworm -> localhost | |... o+ * +. | 2026-10-01 18:38:50.636009 | debian-bookworm -> localhost | | .o.o.B S. | 2026-10-01 18:38:50.636029 | debian-bookworm -> localhost | | .+.=o.. | 2026-10-01 18:38:50.636046 | debian-bookworm -> localhost | | .++ o | 2026-10-01 18:38:50.636063 | debian-bookworm -> localhost | | .o+=. | 2026-10-01 18:38:50.636080 | debian-bookworm -> localhost | | E=*ooo | 2026-10-01 18:38:50.636096 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-01 18:38:50.636140 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.114915 2026-10-01 18:38:50.641152 | 2026-10-01 18:38:50.641235 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-01 18:38:50.679538 | debian-bookworm | ok 2026-10-01 18:38:50.696234 | debian-bookworm | included: /var/lib/zuul/builds/f78ced0254e54e758a9821d640e292f7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-01 18:38:50.710862 | 2026-10-01 18:38:50.713644 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-01 18:38:50.766652 | debian-bookworm | skipping: Conditional result was False 2026-10-01 18:38:50.771369 | 2026-10-01 18:38:50.771452 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-01 18:38:51.571179 | debian-bookworm | changed 2026-10-01 18:38:51.575570 | 2026-10-01 18:38:51.575651 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-01 18:38:51.919942 | debian-bookworm | ok 2026-10-01 18:38:51.927408 | 2026-10-01 18:38:51.927494 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-01 18:38:52.804724 | debian-bookworm | changed 2026-10-01 18:38:52.808962 | 2026-10-01 18:38:52.809038 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-01 18:38:53.672530 | debian-bookworm | changed 2026-10-01 18:38:53.677096 | 2026-10-01 18:38:53.677175 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-01 18:38:53.715491 | debian-bookworm | skipping: Conditional result was False 2026-10-01 18:38:53.720995 | 2026-10-01 18:38:53.721107 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-01 18:38:54.763943 | debian-bookworm -> localhost | changed 2026-10-01 18:38:54.777272 | 2026-10-01 18:38:54.777360 | TASK [add-build-sshkey : Add back temp key] 2026-10-01 18:38:55.490826 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f78ced0254e54e758a9821d640e292f7/work/f78ced0254e54e758a9821d640e292f7_id_rsa (zuul-build-sshkey) 2026-10-01 18:38:55.491001 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021440 2026-10-01 18:38:55.497080 | 2026-10-01 18:38:55.497171 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-01 18:38:56.121125 | debian-bookworm | ok 2026-10-01 18:38:56.125715 | 2026-10-01 18:38:56.125799 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-01 18:38:56.165933 | debian-bookworm | skipping: Conditional result was False 2026-10-01 18:38:56.180153 | 2026-10-01 18:38:56.180240 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-01 18:38:56.662643 | debian-bookworm | ok 2026-10-01 18:38:56.675961 | 2026-10-01 18:38:56.676052 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-01 18:38:56.728430 | debian-bookworm | ok 2026-10-01 18:38:56.734895 | 2026-10-01 18:38:56.734985 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-01 18:38:57.433485 | debian-bookworm -> localhost | ok 2026-10-01 18:38:57.438755 | 2026-10-01 18:38:57.438843 | TASK [validate-host : Collect information about the host] 2026-10-01 18:38:58.991339 | debian-bookworm | ok 2026-10-01 18:38:59.008568 | 2026-10-01 18:38:59.009230 | TASK [validate-host : Sanitize hostname] 2026-10-01 18:38:59.226897 | debian-bookworm | ok 2026-10-01 18:38:59.238711 | 2026-10-01 18:38:59.238807 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-01 18:39:00.571830 | debian-bookworm -> localhost | changed 2026-10-01 18:39:00.576883 | 2026-10-01 18:39:00.576958 | TASK [validate-host : Collect information about zuul worker] 2026-10-01 18:39:00.987286 | debian-bookworm | ok 2026-10-01 18:39:00.991009 | 2026-10-01 18:39:00.991086 | TASK [validate-host : Write out all zuul information for each host] 2026-10-01 18:39:01.563221 | debian-bookworm -> localhost | changed 2026-10-01 18:39:01.573290 | 2026-10-01 18:39:01.573484 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-01 18:39:01.896283 | debian-bookworm | ok 2026-10-01 18:39:01.900890 | 2026-10-01 18:39:01.900961 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-01 18:39:02.848099 | debian-bookworm | changed: 2026-10-01 18:39:02.848255 | debian-bookworm | cd+++++++++ src/ 2026-10-01 18:39:02.848284 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-01 18:39:02.848306 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-01 18:39:02.848324 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-10-01 18:39:02.848342 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/f78ced0254e54e758a9821d640e292f7/work/logs" 2026-10-01 18:40:40.914306 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f78ced0254e54e758a9821d640e292f7/work/artifacts" 2026-10-01 18:40:41.184845 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f78ced0254e54e758a9821d640e292f7/work/docs" 2026-10-01 18:40:41.198145 | 2026-10-01 18:40:41.198267 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-01 18:40:41.961245 | debian-bookworm | changed: 2026-10-01 18:40:41.961487 | debian-bookworm | .d..t...... ./ 2026-10-01 18:40:41.961525 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-01 18:40:41.961682 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-01 18:40:41.961748 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-01 18:40:41.961775 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-01 18:40:41.961799 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-01 18:40:41.961846 | debian-bookworm | changed: All items complete 2026-10-01 18:40:41.961876 | 2026-10-01 18:40:42.520137 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 18:40:43.070261 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 18:40:43.100741 | 2026-10-01 18:40:43.100879 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-01 18:40:43.421223 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005915 2026-10-01 18:40:43.690428 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.007916 2026-10-01 18:40:43.702445 | 2026-10-01 18:40:43.702538 | PLAY RECAP 2026-10-01 18:40:43.702602 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-01 18:40:43.702630 | 2026-10-01 18:40:43.821009 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-01 18:40:43.821886 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 18:40:44.563010 | 2026-10-01 18:40:44.563159 | PLAY [Base post] 2026-10-01 18:40:44.576557 | 2026-10-01 18:40:44.576722 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-01 18:40:45.149886 | debian-bookworm | changed 2026-10-01 18:40:45.159885 | 2026-10-01 18:40:45.160018 | PLAY RECAP 2026-10-01 18:40:45.160107 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-01 18:40:45.160190 | 2026-10-01 18:40:45.280073 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 18:40:45.280927 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-01 18:40:46.062271 | 2026-10-01 18:40:46.062432 | PLAY [Base post-logs] 2026-10-01 18:40:46.073211 | 2026-10-01 18:40:46.073351 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-01 18:40:46.515481 | localhost | changed 2026-10-01 18:40:46.529923 | 2026-10-01 18:40:46.530082 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-01 18:40:46.569079 | localhost | ok 2026-10-01 18:40:46.572786 | 2026-10-01 18:40:46.572893 | TASK [Set zuul-log-path fact] 2026-10-01 18:40:46.598351 | localhost | ok 2026-10-01 18:40:46.607142 | 2026-10-01 18:40:46.607255 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 18:40:46.632918 | localhost | ok 2026-10-01 18:40:46.638114 | 2026-10-01 18:40:46.638270 | TASK [upload-logs : Create log directories] 2026-10-01 18:40:47.126720 | localhost | changed 2026-10-01 18:40:47.129503 | 2026-10-01 18:40:47.129658 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-01 18:40:47.611321 | localhost -> localhost | ok: Runtime: 0:00:00.004853 2026-10-01 18:40:47.621673 | 2026-10-01 18:40:47.622000 | TASK [upload-logs : Upload logs to log server] 2026-10-01 18:40:48.250241 | localhost | Output suppressed because no_log was given 2026-10-01 18:40:48.254547 | 2026-10-01 18:40:48.254810 | LOOP [upload-logs : Compress console log and json output] 2026-10-01 18:40:48.320285 | localhost | skipping: Conditional result was False 2026-10-01 18:40:48.325273 | localhost | skipping: Conditional result was False 2026-10-01 18:40:48.334153 | 2026-10-01 18:40:48.334261 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-01 18:40:48.377230 | localhost | skipping: Conditional result was False 2026-10-01 18:40:48.377877 | 2026-10-01 18:40:48.381231 | localhost | skipping: Conditional result was False 2026-10-01 18:40:48.394713 | 2026-10-01 18:40:48.394923 | LOOP [upload-logs : Upload console log and json output]