2026-05-19 03:05:02.944269 | Job console starting 2026-05-19 03:05:02.952856 | Updating git repos 2026-05-19 03:05:02.998357 | Cloning repos into workspace 2026-05-19 03:05:03.044917 | Restoring repo states 2026-05-19 03:05:03.075185 | Merging changes 2026-05-19 03:05:03.075204 | Checking out repos 2026-05-19 03:05:03.193543 | Preparing playbooks 2026-05-19 03:05:05.221381 | Running Ansible setup 2026-05-19 03:05:12.857704 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-19 03:05:14.127792 | 2026-05-19 03:05:14.127945 | PLAY [Base pre] 2026-05-19 03:05:14.161051 | 2026-05-19 03:05:14.161181 | TASK [Setup log path fact] 2026-05-19 03:05:14.193342 | debian-bookworm | ok 2026-05-19 03:05:14.220484 | 2026-05-19 03:05:14.220626 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 03:05:14.274396 | debian-bookworm | ok 2026-05-19 03:05:14.290217 | 2026-05-19 03:05:14.290334 | TASK [emit-job-header : Print job information] 2026-05-19 03:05:14.425829 | # Job Information 2026-05-19 03:05:14.426024 | Ansible Version: 2.16.14 2026-05-19 03:05:14.426061 | Job: openstack-project-manager-mypy 2026-05-19 03:05:14.426095 | Pipeline: periodic-daily 2026-05-19 03:05:14.426118 | Executor: 521e9411259a 2026-05-19 03:05:14.426138 | Triggered by: https://github.com/osism/openstack-project-manager 2026-05-19 03:05:14.426160 | Event ID: 19e21bce72dc4f86868c8c88b1195455 2026-05-19 03:05:14.431750 | 2026-05-19 03:05:14.431862 | LOOP [emit-job-header : Print node information] 2026-05-19 03:05:14.579084 | debian-bookworm | ok: 2026-05-19 03:05:14.579412 | debian-bookworm | # Node Information 2026-05-19 03:05:14.579457 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-19 03:05:14.579484 | debian-bookworm | Hostname: debian 2026-05-19 03:05:14.579506 | debian-bookworm | Username: zuul 2026-05-19 03:05:14.579526 | debian-bookworm | Distro: Debian 12.14 2026-05-19 03:05:14.579549 | debian-bookworm | Provider: regiocloud-a 2026-05-19 03:05:14.579572 | debian-bookworm | Region: 2026-05-19 03:05:14.579593 | debian-bookworm | Label: debian-bookworm 2026-05-19 03:05:14.579613 | debian-bookworm | Product Name: OpenStack Nova 2026-05-19 03:05:14.579633 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec2:45a 2026-05-19 03:05:14.600231 | 2026-05-19 03:05:14.600334 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-19 03:05:15.338752 | debian-bookworm -> localhost | changed 2026-05-19 03:05:15.345866 | 2026-05-19 03:05:15.345985 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-19 03:05:18.310803 | debian-bookworm -> localhost | changed 2026-05-19 03:05:18.328359 | 2026-05-19 03:05:18.329315 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-19 03:05:18.965651 | debian-bookworm -> localhost | ok 2026-05-19 03:05:18.970709 | 2026-05-19 03:05:18.970806 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-19 03:05:19.023162 | debian-bookworm | ok 2026-05-19 03:05:19.103363 | debian-bookworm | included: /var/lib/zuul/builds/7dd6980fc71a483c9c84595031be172e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-19 03:05:19.123484 | 2026-05-19 03:05:19.123579 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-19 03:05:22.901547 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-19 03:05:22.901725 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7dd6980fc71a483c9c84595031be172e/work/7dd6980fc71a483c9c84595031be172e_id_rsa 2026-05-19 03:05:22.901758 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7dd6980fc71a483c9c84595031be172e/work/7dd6980fc71a483c9c84595031be172e_id_rsa.pub 2026-05-19 03:05:22.901781 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-19 03:05:22.901802 | debian-bookworm -> localhost | SHA256:IpqFkSBENb0XldKx57uzRQn3QEmAj/XZF7cabTJLKH8 zuul-build-sshkey 2026-05-19 03:05:22.901830 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-19 03:05:22.901850 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-19 03:05:22.901867 | debian-bookworm -> localhost | |=o.o. oo+.oo. | 2026-05-19 03:05:22.901885 | debian-bookworm -> localhost | |.. ... o +.... ..| 2026-05-19 03:05:22.901903 | debian-bookworm -> localhost | | o . o.+ooo+ +| 2026-05-19 03:05:22.901919 | debian-bookworm -> localhost | | o . . ooooB+=.| 2026-05-19 03:05:22.901964 | debian-bookworm -> localhost | | . o o S o..oB..| 2026-05-19 03:05:22.901985 | debian-bookworm -> localhost | | + . . .oE | 2026-05-19 03:05:22.902002 | debian-bookworm -> localhost | | o ... | 2026-05-19 03:05:22.902019 | debian-bookworm -> localhost | | .o | 2026-05-19 03:05:22.902037 | debian-bookworm -> localhost | | oo | 2026-05-19 03:05:22.902063 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-19 03:05:22.902108 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.363685 2026-05-19 03:05:22.910356 | 2026-05-19 03:05:22.910508 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-19 03:05:22.937435 | debian-bookworm | ok 2026-05-19 03:05:22.944962 | debian-bookworm | included: /var/lib/zuul/builds/7dd6980fc71a483c9c84595031be172e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-19 03:05:22.971169 | 2026-05-19 03:05:22.971279 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-19 03:05:22.985031 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:05:22.989887 | 2026-05-19 03:05:22.989995 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-19 03:05:23.689557 | debian-bookworm | changed 2026-05-19 03:05:23.699867 | 2026-05-19 03:05:23.699982 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-19 03:05:23.977072 | debian-bookworm | ok 2026-05-19 03:05:23.982444 | 2026-05-19 03:05:23.982541 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-19 03:05:24.751168 | debian-bookworm | changed 2026-05-19 03:05:24.764307 | 2026-05-19 03:05:24.764401 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-19 03:05:25.495534 | debian-bookworm | changed 2026-05-19 03:05:25.501160 | 2026-05-19 03:05:25.501252 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-19 03:05:25.525214 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:05:25.530772 | 2026-05-19 03:05:25.530950 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-19 03:05:26.695637 | debian-bookworm -> localhost | changed 2026-05-19 03:05:26.704779 | 2026-05-19 03:05:26.704868 | TASK [add-build-sshkey : Add back temp key] 2026-05-19 03:05:27.962792 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7dd6980fc71a483c9c84595031be172e/work/7dd6980fc71a483c9c84595031be172e_id_rsa (zuul-build-sshkey) 2026-05-19 03:05:27.963023 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020603 2026-05-19 03:05:27.971388 | 2026-05-19 03:05:27.971491 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-19 03:05:28.474561 | debian-bookworm | ok 2026-05-19 03:05:28.478749 | 2026-05-19 03:05:28.478859 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-19 03:05:28.512597 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:05:28.521515 | 2026-05-19 03:05:28.521622 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-19 03:05:28.952179 | debian-bookworm | ok 2026-05-19 03:05:28.966230 | 2026-05-19 03:05:28.966331 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-19 03:05:29.020812 | debian-bookworm | ok 2026-05-19 03:05:29.025142 | 2026-05-19 03:05:29.025240 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-19 03:05:29.738349 | debian-bookworm -> localhost | ok 2026-05-19 03:05:29.743564 | 2026-05-19 03:05:29.743655 | TASK [validate-host : Collect information about the host] 2026-05-19 03:05:31.165953 | debian-bookworm | ok 2026-05-19 03:05:31.178251 | 2026-05-19 03:05:31.178339 | TASK [validate-host : Sanitize hostname] 2026-05-19 03:05:31.331257 | debian-bookworm | ok 2026-05-19 03:05:31.432593 | 2026-05-19 03:05:31.432699 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-19 03:05:32.768796 | debian-bookworm -> localhost | changed 2026-05-19 03:05:32.774532 | 2026-05-19 03:05:32.775763 | TASK [validate-host : Collect information about zuul worker] 2026-05-19 03:05:33.308062 | debian-bookworm | ok 2026-05-19 03:05:33.319480 | 2026-05-19 03:05:33.319596 | TASK [validate-host : Write out all zuul information for each host] 2026-05-19 03:05:34.974454 | debian-bookworm -> localhost | changed 2026-05-19 03:05:34.987501 | 2026-05-19 03:05:34.987603 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-19 03:05:35.296609 | debian-bookworm | ok 2026-05-19 03:05:35.306868 | 2026-05-19 03:05:35.306990 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-19 03:05:36.673646 | debian-bookworm | changed: 2026-05-19 03:05:36.673824 | debian-bookworm | cd+++++++++ src/ 2026-05-19 03:05:36.673857 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-19 03:05:36.673881 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-19 03:05:36.673902 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2026-05-19 03:05:36.673935 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/7dd6980fc71a483c9c84595031be172e/work/logs" 2026-05-19 03:06:50.481591 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7dd6980fc71a483c9c84595031be172e/work/artifacts" 2026-05-19 03:06:51.171868 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7dd6980fc71a483c9c84595031be172e/work/docs" 2026-05-19 03:06:51.192953 | 2026-05-19 03:06:51.193058 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-19 03:06:52.207250 | debian-bookworm | changed: 2026-05-19 03:06:52.207425 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-19 03:06:52.207458 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-19 03:06:52.207488 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-19 03:06:52.207531 | debian-bookworm | changed: All items complete 2026-05-19 03:06:52.207558 | 2026-05-19 03:06:52.856605 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 03:06:53.814678 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 03:06:53.835187 | 2026-05-19 03:06:53.835334 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-19 03:06:53.904161 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:06:53.926619 | debian-bookworm | skipping: Conditional result was False 2026-05-19 03:06:53.951146 | 2026-05-19 03:06:53.951270 | PLAY RECAP 2026-05-19 03:06:53.951323 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-19 03:06:53.951348 | 2026-05-19 03:06:54.209436 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 03:06:54.210331 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 03:06:55.520105 | 2026-05-19 03:06:55.520249 | PLAY [Base post] 2026-05-19 03:06:55.570819 | 2026-05-19 03:06:55.571546 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-19 03:06:56.381618 | debian-bookworm | changed 2026-05-19 03:06:56.391963 | 2026-05-19 03:06:56.392076 | PLAY RECAP 2026-05-19 03:06:56.392137 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-19 03:06:56.392207 | 2026-05-19 03:06:56.632619 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 03:06:56.633362 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-19 03:06:57.793209 | 2026-05-19 03:06:57.793325 | PLAY [Base post-logs] 2026-05-19 03:06:57.813588 | 2026-05-19 03:06:57.813702 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-19 03:06:58.418443 | localhost | changed 2026-05-19 03:06:58.427227 | 2026-05-19 03:06:58.427347 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-19 03:06:58.484291 | localhost | ok 2026-05-19 03:06:58.486963 | 2026-05-19 03:06:58.487040 | TASK [Set zuul-log-path fact] 2026-05-19 03:06:58.511230 | localhost | ok 2026-05-19 03:06:58.517662 | 2026-05-19 03:06:58.517756 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 03:06:58.551999 | localhost | ok 2026-05-19 03:06:58.554351 | 2026-05-19 03:06:58.554426 | TASK [upload-logs : Create log directories] 2026-05-19 03:06:59.364085 | localhost | changed 2026-05-19 03:06:59.366222 | 2026-05-19 03:06:59.366299 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-19 03:07:00.540233 | localhost -> localhost | ok: Runtime: 0:00:00.004514 2026-05-19 03:07:00.543287 | 2026-05-19 03:07:00.543371 | TASK [upload-logs : Upload logs to log server] 2026-05-19 03:07:01.057748 | localhost | Output suppressed because no_log was given 2026-05-19 03:07:01.059709 | 2026-05-19 03:07:01.059832 | LOOP [upload-logs : Compress console log and json output] 2026-05-19 03:07:01.135482 | localhost | skipping: Conditional result was False 2026-05-19 03:07:01.148954 | localhost | skipping: Conditional result was False 2026-05-19 03:07:01.158467 | 2026-05-19 03:07:01.158609 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-19 03:07:01.196607 | localhost | skipping: Conditional result was False 2026-05-19 03:07:01.196853 | 2026-05-19 03:07:01.201961 | localhost | skipping: Conditional result was False 2026-05-19 03:07:01.204863 | 2026-05-19 03:07:01.204962 | LOOP [upload-logs : Upload console log and json output]