2026-05-31 03:15:29.793098 | Job console starting 2026-05-31 03:15:29.821784 | Updating git repos 2026-05-31 03:15:29.873676 | Cloning repos into workspace 2026-05-31 03:15:29.914459 | Restoring repo states 2026-05-31 03:15:29.925806 | Merging changes 2026-05-31 03:15:29.925826 | Checking out repos 2026-05-31 03:15:30.030653 | Preparing playbooks 2026-05-31 03:15:31.491574 | Running Ansible setup 2026-05-31 03:15:37.407729 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-31 03:15:38.078711 | 2026-05-31 03:15:38.078890 | PLAY [Base pre] 2026-05-31 03:15:38.094705 | 2026-05-31 03:15:38.094828 | TASK [Setup log path fact] 2026-05-31 03:15:38.124145 | debian-bookworm | ok 2026-05-31 03:15:38.140415 | 2026-05-31 03:15:38.140533 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-31 03:15:38.167212 | debian-bookworm | ok 2026-05-31 03:15:38.175380 | 2026-05-31 03:15:38.175463 | TASK [emit-job-header : Print job information] 2026-05-31 03:15:38.260694 | # Job Information 2026-05-31 03:15:38.260870 | Ansible Version: 2.16.14 2026-05-31 03:15:38.260909 | Job: python-black 2026-05-31 03:15:38.260944 | Pipeline: periodic-daily 2026-05-31 03:15:38.260969 | Executor: 521e9411259a 2026-05-31 03:15:38.260991 | Triggered by: https://github.com/osism/netbox-plugin-osism 2026-05-31 03:15:38.261026 | Event ID: 67aa1d7621184dfe8e8900165b1844ea 2026-05-31 03:15:38.265892 | 2026-05-31 03:15:38.265987 | LOOP [emit-job-header : Print node information] 2026-05-31 03:15:38.503503 | debian-bookworm | ok: 2026-05-31 03:15:38.503767 | debian-bookworm | # Node Information 2026-05-31 03:15:38.503809 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-31 03:15:38.503835 | debian-bookworm | Hostname: debian 2026-05-31 03:15:38.503858 | debian-bookworm | Username: zuul 2026-05-31 03:15:38.503879 | debian-bookworm | Distro: Debian 12.14 2026-05-31 03:15:38.503902 | debian-bookworm | Provider: regiocloud-a 2026-05-31 03:15:38.503924 | debian-bookworm | Region: 2026-05-31 03:15:38.503944 | debian-bookworm | Label: debian-bookworm 2026-05-31 03:15:38.503965 | debian-bookworm | Product Name: OpenStack Nova 2026-05-31 03:15:38.503984 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe25:5d6e 2026-05-31 03:15:38.525264 | 2026-05-31 03:15:38.525387 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-31 03:15:39.522328 | debian-bookworm -> localhost | changed 2026-05-31 03:15:39.528035 | 2026-05-31 03:15:39.528125 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-31 03:15:41.621693 | debian-bookworm -> localhost | changed 2026-05-31 03:15:41.640354 | 2026-05-31 03:15:41.640472 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-31 03:15:42.447047 | debian-bookworm -> localhost | ok 2026-05-31 03:15:42.453324 | 2026-05-31 03:15:42.453421 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-31 03:15:42.508431 | debian-bookworm | ok 2026-05-31 03:15:42.545250 | debian-bookworm | included: /var/lib/zuul/builds/b5ef0948d727459598869d5410c13915/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-31 03:15:42.584702 | 2026-05-31 03:15:42.584847 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-31 03:15:44.655803 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-31 03:15:44.656069 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b5ef0948d727459598869d5410c13915/work/b5ef0948d727459598869d5410c13915_id_rsa 2026-05-31 03:15:44.656108 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b5ef0948d727459598869d5410c13915/work/b5ef0948d727459598869d5410c13915_id_rsa.pub 2026-05-31 03:15:44.656135 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-31 03:15:44.656161 | debian-bookworm -> localhost | SHA256:iLdY82AEdRPHmz7p4ueBPTcES2MBZjpd2Ntg5Yl3Vrw zuul-build-sshkey 2026-05-31 03:15:44.656182 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-31 03:15:44.656217 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-31 03:15:44.656238 | debian-bookworm -> localhost | | ... B*+.. ..| 2026-05-31 03:15:44.656259 | debian-bookworm -> localhost | | . *.+=+ . ..| 2026-05-31 03:15:44.656279 | debian-bookworm -> localhost | | + ..**+ o .| 2026-05-31 03:15:44.656298 | debian-bookworm -> localhost | | o o o+=.o E | 2026-05-31 03:15:44.656317 | debian-bookworm -> localhost | | . B S.... | 2026-05-31 03:15:44.656344 | debian-bookworm -> localhost | | = = o+. | 2026-05-31 03:15:44.656365 | debian-bookworm -> localhost | | . . o.+.o | 2026-05-31 03:15:44.656385 | debian-bookworm -> localhost | | . o+ . | 2026-05-31 03:15:44.656406 | debian-bookworm -> localhost | | ..+. | 2026-05-31 03:15:44.656426 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-31 03:15:44.656485 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.136215 2026-05-31 03:15:44.663022 | 2026-05-31 03:15:44.663125 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-31 03:15:44.727698 | debian-bookworm | ok 2026-05-31 03:15:44.746102 | debian-bookworm | included: /var/lib/zuul/builds/b5ef0948d727459598869d5410c13915/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-31 03:15:44.766186 | 2026-05-31 03:15:44.766303 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-31 03:15:44.813438 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:15:44.819730 | 2026-05-31 03:15:44.819843 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-31 03:15:45.748588 | debian-bookworm | changed 2026-05-31 03:15:45.767374 | 2026-05-31 03:15:45.767505 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-31 03:15:46.060051 | debian-bookworm | ok 2026-05-31 03:15:46.066128 | 2026-05-31 03:15:46.066244 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-31 03:15:46.858598 | debian-bookworm | changed 2026-05-31 03:15:46.866333 | 2026-05-31 03:15:46.866434 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-31 03:15:47.840888 | debian-bookworm | changed 2026-05-31 03:15:47.846466 | 2026-05-31 03:15:47.846556 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-31 03:15:47.898139 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:15:47.904242 | 2026-05-31 03:15:47.904335 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-31 03:15:48.711850 | debian-bookworm -> localhost | changed 2026-05-31 03:15:48.726123 | 2026-05-31 03:15:48.726238 | TASK [add-build-sshkey : Add back temp key] 2026-05-31 03:15:49.408940 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b5ef0948d727459598869d5410c13915/work/b5ef0948d727459598869d5410c13915_id_rsa (zuul-build-sshkey) 2026-05-31 03:15:49.409196 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019355 2026-05-31 03:15:49.417976 | 2026-05-31 03:15:49.418170 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-31 03:15:50.144416 | debian-bookworm | ok 2026-05-31 03:15:50.152324 | 2026-05-31 03:15:50.152448 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-31 03:15:50.185798 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:15:50.195783 | 2026-05-31 03:15:50.195879 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-31 03:15:50.732890 | debian-bookworm | ok 2026-05-31 03:15:50.749283 | 2026-05-31 03:15:50.749777 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-31 03:15:50.807412 | debian-bookworm | ok 2026-05-31 03:15:50.811583 | 2026-05-31 03:15:50.811660 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-31 03:15:51.592264 | debian-bookworm -> localhost | ok 2026-05-31 03:15:51.597677 | 2026-05-31 03:15:51.597766 | TASK [validate-host : Collect information about the host] 2026-05-31 03:15:53.245496 | debian-bookworm | ok 2026-05-31 03:15:53.271592 | 2026-05-31 03:15:53.271702 | TASK [validate-host : Sanitize hostname] 2026-05-31 03:15:53.545461 | debian-bookworm | ok 2026-05-31 03:15:53.616311 | 2026-05-31 03:15:53.616419 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-31 03:15:54.511678 | debian-bookworm -> localhost | changed 2026-05-31 03:15:54.525297 | 2026-05-31 03:15:54.525417 | TASK [validate-host : Collect information about zuul worker] 2026-05-31 03:15:54.994795 | debian-bookworm | ok 2026-05-31 03:15:55.001807 | 2026-05-31 03:15:55.001914 | TASK [validate-host : Write out all zuul information for each host] 2026-05-31 03:15:55.737703 | debian-bookworm -> localhost | changed 2026-05-31 03:15:55.749057 | 2026-05-31 03:15:55.749179 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-31 03:15:56.064269 | debian-bookworm | ok 2026-05-31 03:15:56.074388 | 2026-05-31 03:15:56.074509 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-31 03:15:57.074649 | debian-bookworm | changed: 2026-05-31 03:15:57.075785 | debian-bookworm | cd+++++++++ src/ 2026-05-31 03:15:57.076758 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-31 03:15:57.076806 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-31 03:15:57.076829 | debian-bookworm | cd+++++++++ src/github.com/osism/netbox-plugin-osism/ 2026-05-31 03:15:57.076848 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b5ef0948d727459598869d5410c13915/work/logs" 2026-05-31 03:16:25.559394 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b5ef0948d727459598869d5410c13915/work/artifacts" 2026-05-31 03:16:25.814550 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b5ef0948d727459598869d5410c13915/work/docs" 2026-05-31 03:16:25.834047 | 2026-05-31 03:16:25.834171 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-31 03:16:26.867478 | debian-bookworm | changed: 2026-05-31 03:16:26.867686 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-31 03:16:26.867721 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-31 03:16:26.867752 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-31 03:16:26.867798 | debian-bookworm | changed: All items complete 2026-05-31 03:16:26.867826 | 2026-05-31 03:16:27.448808 | debian-bookworm | changed: .d..t...... ./ 2026-05-31 03:16:28.068614 | debian-bookworm | changed: .d..t...... ./ 2026-05-31 03:16:28.084131 | 2026-05-31 03:16:28.084243 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-31 03:16:28.118194 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:16:28.126603 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:16:28.157512 | 2026-05-31 03:16:28.157617 | PLAY RECAP 2026-05-31 03:16:28.157672 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-31 03:16:28.157698 | 2026-05-31 03:16:28.265363 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-31 03:16:28.266126 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-31 03:16:29.096635 | 2026-05-31 03:16:29.096794 | PLAY [Base post] 2026-05-31 03:16:29.109730 | 2026-05-31 03:16:29.109863 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-31 03:16:29.736368 | debian-bookworm | changed 2026-05-31 03:16:29.746302 | 2026-05-31 03:16:29.746407 | PLAY RECAP 2026-05-31 03:16:29.746469 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-31 03:16:29.746535 | 2026-05-31 03:16:29.892202 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-31 03:16:29.892975 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-31 03:16:30.685586 | 2026-05-31 03:16:30.685783 | PLAY [Base post-logs] 2026-05-31 03:16:30.697238 | 2026-05-31 03:16:30.697391 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-31 03:16:31.274639 | localhost | changed 2026-05-31 03:16:31.286784 | 2026-05-31 03:16:31.287118 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-31 03:16:31.315051 | localhost | ok 2026-05-31 03:16:31.319016 | 2026-05-31 03:16:31.319171 | TASK [Set zuul-log-path fact] 2026-05-31 03:16:31.336552 | localhost | ok 2026-05-31 03:16:31.346769 | 2026-05-31 03:16:31.347046 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-31 03:16:31.374626 | localhost | ok 2026-05-31 03:16:31.378244 | 2026-05-31 03:16:31.378376 | TASK [upload-logs : Create log directories] 2026-05-31 03:16:31.981867 | localhost | changed 2026-05-31 03:16:31.985363 | 2026-05-31 03:16:31.985507 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-31 03:16:32.584878 | localhost -> localhost | ok: Runtime: 0:00:00.006123 2026-05-31 03:16:32.594753 | 2026-05-31 03:16:32.595168 | TASK [upload-logs : Upload logs to log server] 2026-05-31 03:16:33.238351 | localhost | Output suppressed because no_log was given 2026-05-31 03:16:33.241677 | 2026-05-31 03:16:33.241823 | LOOP [upload-logs : Compress console log and json output] 2026-05-31 03:16:33.329845 | localhost | skipping: Conditional result was False 2026-05-31 03:16:33.336486 | localhost | skipping: Conditional result was False 2026-05-31 03:16:33.348014 | 2026-05-31 03:16:33.349547 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-31 03:16:33.419373 | localhost | skipping: Conditional result was False 2026-05-31 03:16:33.419669 | 2026-05-31 03:16:33.424496 | localhost | skipping: Conditional result was False 2026-05-31 03:16:33.429674 | 2026-05-31 03:16:33.429847 | LOOP [upload-logs : Upload console log and json output]