2026-05-29 03:04:22.658865 | Job console starting 2026-05-29 03:04:22.671982 | Updating git repos 2026-05-29 03:04:22.700401 | Cloning repos into workspace 2026-05-29 03:04:22.740741 | Restoring repo states 2026-05-29 03:04:22.744637 | Merging changes 2026-05-29 03:04:22.744649 | Checking out repos 2026-05-29 03:04:22.791265 | Preparing playbooks 2026-05-29 03:04:24.338928 | Running Ansible setup 2026-05-29 03:04:29.456393 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-29 03:04:30.825396 | 2026-05-29 03:04:30.825523 | PLAY [Base pre] 2026-05-29 03:04:30.848473 | 2026-05-29 03:04:30.848602 | TASK [Setup log path fact] 2026-05-29 03:04:30.900414 | debian-bookworm | ok 2026-05-29 03:04:30.920291 | 2026-05-29 03:04:30.920425 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 03:04:30.949678 | debian-bookworm | ok 2026-05-29 03:04:30.961369 | 2026-05-29 03:04:30.961480 | TASK [emit-job-header : Print job information] 2026-05-29 03:04:31.009795 | # Job Information 2026-05-29 03:04:31.009966 | Ansible Version: 2.16.14 2026-05-29 03:04:31.009999 | Job: openstack-project-manager-mypy 2026-05-29 03:04:31.010033 | Pipeline: periodic-daily 2026-05-29 03:04:31.010056 | Executor: 521e9411259a 2026-05-29 03:04:31.010076 | Triggered by: https://github.com/osism/openstack-project-manager 2026-05-29 03:04:31.010099 | Event ID: d1c9358f3813472cbfdb927dab2a6b37 2026-05-29 03:04:31.015532 | 2026-05-29 03:04:31.015652 | LOOP [emit-job-header : Print node information] 2026-05-29 03:04:31.136598 | debian-bookworm | ok: 2026-05-29 03:04:31.136772 | debian-bookworm | # Node Information 2026-05-29 03:04:31.136809 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-29 03:04:31.136833 | debian-bookworm | Hostname: debian 2026-05-29 03:04:31.137048 | debian-bookworm | Username: zuul 2026-05-29 03:04:31.137091 | debian-bookworm | Distro: Debian 12.14 2026-05-29 03:04:31.137118 | debian-bookworm | Provider: regiocloud-a 2026-05-29 03:04:31.137141 | debian-bookworm | Region: 2026-05-29 03:04:31.137163 | debian-bookworm | Label: debian-bookworm 2026-05-29 03:04:31.137185 | debian-bookworm | Product Name: OpenStack Nova 2026-05-29 03:04:31.137205 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee6:8e6 2026-05-29 03:04:31.155050 | 2026-05-29 03:04:31.155207 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-29 03:04:31.891372 | debian-bookworm -> localhost | changed 2026-05-29 03:04:31.901239 | 2026-05-29 03:04:31.901439 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-29 03:04:33.455736 | debian-bookworm -> localhost | changed 2026-05-29 03:04:33.466027 | 2026-05-29 03:04:33.466122 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-29 03:04:33.793778 | debian-bookworm -> localhost | ok 2026-05-29 03:04:33.800492 | 2026-05-29 03:04:33.800594 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-29 03:04:33.831581 | debian-bookworm | ok 2026-05-29 03:04:33.852076 | debian-bookworm | included: /var/lib/zuul/builds/5979edddf44e4134b345b3a933cd4bda/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-29 03:04:33.867057 | 2026-05-29 03:04:33.867286 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-29 03:04:35.315599 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-29 03:04:35.315824 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5979edddf44e4134b345b3a933cd4bda/work/5979edddf44e4134b345b3a933cd4bda_id_rsa 2026-05-29 03:04:35.315864 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5979edddf44e4134b345b3a933cd4bda/work/5979edddf44e4134b345b3a933cd4bda_id_rsa.pub 2026-05-29 03:04:35.315892 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-29 03:04:35.315918 | debian-bookworm -> localhost | SHA256:+fgEAnvc0FBxnnM/cLjr+pbDFFhMG+lppw8/bb2CFGY zuul-build-sshkey 2026-05-29 03:04:35.315951 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-29 03:04:35.315974 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-29 03:04:35.315995 | debian-bookworm -> localhost | | ..o..oo. | 2026-05-29 03:04:35.316016 | debian-bookworm -> localhost | | o o .++ | 2026-05-29 03:04:35.316037 | debian-bookworm -> localhost | | . . . ++=.. | 2026-05-29 03:04:35.316057 | debian-bookworm -> localhost | | + o ..E==. | 2026-05-29 03:04:35.316078 | debian-bookworm -> localhost | | . + S o.o+o | 2026-05-29 03:04:35.316104 | debian-bookworm -> localhost | | . . + .+. . | 2026-05-29 03:04:35.316125 | debian-bookworm -> localhost | | . +oo= ..| 2026-05-29 03:04:35.316145 | debian-bookworm -> localhost | | o o=.+ +| 2026-05-29 03:04:35.316166 | debian-bookworm -> localhost | | o+o..+.| 2026-05-29 03:04:35.316187 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-29 03:04:35.316235 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.834429 2026-05-29 03:04:35.322377 | 2026-05-29 03:04:35.322479 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-29 03:04:35.339870 | debian-bookworm | ok 2026-05-29 03:04:35.348728 | debian-bookworm | included: /var/lib/zuul/builds/5979edddf44e4134b345b3a933cd4bda/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-29 03:04:35.357345 | 2026-05-29 03:04:35.357441 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-29 03:04:35.380544 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:35.386199 | 2026-05-29 03:04:35.386307 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-29 03:04:36.030294 | debian-bookworm | changed 2026-05-29 03:04:36.035682 | 2026-05-29 03:04:36.035787 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-29 03:04:36.333106 | debian-bookworm | ok 2026-05-29 03:04:36.345478 | 2026-05-29 03:04:36.345593 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-29 03:04:37.095948 | debian-bookworm | changed 2026-05-29 03:04:37.101680 | 2026-05-29 03:04:37.101765 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-29 03:04:37.773426 | debian-bookworm | changed 2026-05-29 03:04:37.786006 | 2026-05-29 03:04:37.786115 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-29 03:04:37.819230 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:37.824963 | 2026-05-29 03:04:37.825060 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-29 03:04:38.324915 | debian-bookworm -> localhost | changed 2026-05-29 03:04:38.336659 | 2026-05-29 03:04:38.336765 | TASK [add-build-sshkey : Add back temp key] 2026-05-29 03:04:38.606393 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5979edddf44e4134b345b3a933cd4bda/work/5979edddf44e4134b345b3a933cd4bda_id_rsa (zuul-build-sshkey) 2026-05-29 03:04:38.606618 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008163 2026-05-29 03:04:38.614500 | 2026-05-29 03:04:38.614603 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-29 03:04:39.024338 | debian-bookworm | ok 2026-05-29 03:04:39.041243 | 2026-05-29 03:04:39.041358 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-29 03:04:39.064540 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:04:39.075041 | 2026-05-29 03:04:39.075151 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-29 03:04:39.577743 | debian-bookworm | ok 2026-05-29 03:04:39.589247 | 2026-05-29 03:04:39.589369 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-29 03:04:39.638119 | debian-bookworm | ok 2026-05-29 03:04:39.642937 | 2026-05-29 03:04:39.643024 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-29 03:04:40.042497 | debian-bookworm -> localhost | ok 2026-05-29 03:04:40.048880 | 2026-05-29 03:04:40.048968 | TASK [validate-host : Collect information about the host] 2026-05-29 03:04:41.139720 | debian-bookworm | ok 2026-05-29 03:04:41.152961 | 2026-05-29 03:04:41.153066 | TASK [validate-host : Sanitize hostname] 2026-05-29 03:04:41.244886 | debian-bookworm | ok 2026-05-29 03:04:41.285163 | 2026-05-29 03:04:41.285297 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-29 03:04:41.872309 | debian-bookworm -> localhost | changed 2026-05-29 03:04:41.879471 | 2026-05-29 03:04:41.879582 | TASK [validate-host : Collect information about zuul worker] 2026-05-29 03:04:42.329769 | debian-bookworm | ok 2026-05-29 03:04:42.339162 | 2026-05-29 03:04:42.339360 | TASK [validate-host : Write out all zuul information for each host] 2026-05-29 03:04:42.917387 | debian-bookworm -> localhost | changed 2026-05-29 03:04:42.927876 | 2026-05-29 03:04:42.928012 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-29 03:04:43.210360 | debian-bookworm | ok 2026-05-29 03:04:43.218368 | 2026-05-29 03:04:43.218514 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-29 03:04:44.066337 | debian-bookworm | changed: 2026-05-29 03:04:44.066561 | debian-bookworm | cd+++++++++ src/ 2026-05-29 03:04:44.066597 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-29 03:04:44.066621 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-29 03:04:44.066642 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2026-05-29 03:04:44.066662 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/5979edddf44e4134b345b3a933cd4bda/work/logs" 2026-05-29 03:05:57.727800 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5979edddf44e4134b345b3a933cd4bda/work/artifacts" 2026-05-29 03:05:58.046071 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5979edddf44e4134b345b3a933cd4bda/work/docs" 2026-05-29 03:05:58.062587 | 2026-05-29 03:05:58.062695 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-29 03:05:59.004742 | debian-bookworm | changed: 2026-05-29 03:05:59.004925 | debian-bookworm | .d..t...... ./ 2026-05-29 03:05:59.004961 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-29 03:05:59.004992 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-29 03:05:59.005019 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-29 03:05:59.005066 | debian-bookworm | changed: All items complete 2026-05-29 03:05:59.005089 | 2026-05-29 03:05:59.949711 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 03:06:00.588205 | debian-bookworm | changed: .d..t...... ./ 2026-05-29 03:06:00.608721 | 2026-05-29 03:06:00.608826 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-29 03:06:00.631266 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:06:00.636441 | debian-bookworm | skipping: Conditional result was False 2026-05-29 03:06:00.647951 | 2026-05-29 03:06:00.648024 | PLAY RECAP 2026-05-29 03:06:00.648089 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-29 03:06:00.648112 | 2026-05-29 03:06:00.785094 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-29 03:06:00.785807 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 03:06:01.676807 | 2026-05-29 03:06:01.676933 | PLAY [Base post] 2026-05-29 03:06:01.693660 | 2026-05-29 03:06:01.693780 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-29 03:06:02.483673 | debian-bookworm | changed 2026-05-29 03:06:02.494227 | 2026-05-29 03:06:02.494324 | PLAY RECAP 2026-05-29 03:06:02.494382 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-29 03:06:02.494443 | 2026-05-29 03:06:02.692253 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-29 03:06:02.692969 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-29 03:06:03.618127 | 2026-05-29 03:06:03.618257 | PLAY [Base post-logs] 2026-05-29 03:06:03.660336 | 2026-05-29 03:06:03.660475 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-29 03:06:04.139296 | localhost | changed 2026-05-29 03:06:04.153152 | 2026-05-29 03:06:04.153302 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-29 03:06:04.180128 | localhost | ok 2026-05-29 03:06:04.185648 | 2026-05-29 03:06:04.185801 | TASK [Set zuul-log-path fact] 2026-05-29 03:06:04.201660 | localhost | ok 2026-05-29 03:06:04.209428 | 2026-05-29 03:06:04.209524 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-29 03:06:04.234327 | localhost | ok 2026-05-29 03:06:04.238063 | 2026-05-29 03:06:04.238150 | TASK [upload-logs : Create log directories] 2026-05-29 03:06:04.729701 | localhost | changed 2026-05-29 03:06:04.735368 | 2026-05-29 03:06:04.735469 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-29 03:06:05.260816 | localhost -> localhost | ok: Runtime: 0:00:00.003896 2026-05-29 03:06:05.264500 | 2026-05-29 03:06:05.264594 | TASK [upload-logs : Upload logs to log server] 2026-05-29 03:06:05.875648 | localhost | Output suppressed because no_log was given 2026-05-29 03:06:05.878822 | 2026-05-29 03:06:05.878962 | LOOP [upload-logs : Compress console log and json output] 2026-05-29 03:06:05.937429 | localhost | skipping: Conditional result was False 2026-05-29 03:06:05.946112 | localhost | skipping: Conditional result was False 2026-05-29 03:06:05.957790 | 2026-05-29 03:06:05.957894 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-29 03:06:06.019596 | localhost | skipping: Conditional result was False 2026-05-29 03:06:06.019808 | 2026-05-29 03:06:06.026774 | localhost | skipping: Conditional result was False 2026-05-29 03:06:06.033523 | 2026-05-29 03:06:06.033678 | LOOP [upload-logs : Upload console log and json output]