2026-05-30 03:06:37.985105 | Job console starting 2026-05-30 03:06:37.994244 | Updating git repos 2026-05-30 03:06:38.036127 | Cloning repos into workspace 2026-05-30 03:06:38.074811 | Restoring repo states 2026-05-30 03:06:38.091168 | Merging changes 2026-05-30 03:06:38.091189 | Checking out repos 2026-05-30 03:06:38.150794 | Preparing playbooks 2026-05-30 03:06:39.860211 | Running Ansible setup 2026-05-30 03:06:46.091075 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-30 03:06:47.097433 | 2026-05-30 03:06:47.097561 | PLAY [Base pre] 2026-05-30 03:06:47.131173 | 2026-05-30 03:06:47.131280 | TASK [Setup log path fact] 2026-05-30 03:06:47.158450 | debian-bookworm | ok 2026-05-30 03:06:47.178877 | 2026-05-30 03:06:47.179229 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-30 03:06:47.212932 | debian-bookworm | ok 2026-05-30 03:06:47.231101 | 2026-05-30 03:06:47.231444 | TASK [emit-job-header : Print job information] 2026-05-30 03:06:47.285395 | # Job Information 2026-05-30 03:06:47.285565 | Ansible Version: 2.16.14 2026-05-30 03:06:47.285600 | Job: python-black 2026-05-30 03:06:47.285634 | Pipeline: periodic-daily 2026-05-30 03:06:47.285657 | Executor: 521e9411259a 2026-05-30 03:06:47.285677 | Triggered by: https://github.com/osism/generics 2026-05-30 03:06:47.285698 | Event ID: f2385e381f364f389d2591f573722cb7 2026-05-30 03:06:47.290564 | 2026-05-30 03:06:47.290658 | LOOP [emit-job-header : Print node information] 2026-05-30 03:06:47.425630 | debian-bookworm | ok: 2026-05-30 03:06:47.425838 | debian-bookworm | # Node Information 2026-05-30 03:06:47.425875 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-30 03:06:47.425901 | debian-bookworm | Hostname: debian 2026-05-30 03:06:47.425923 | debian-bookworm | Username: zuul 2026-05-30 03:06:47.426074 | debian-bookworm | Distro: Debian 12.14 2026-05-30 03:06:47.426115 | debian-bookworm | Provider: regiocloud-a 2026-05-30 03:06:47.426139 | debian-bookworm | Region: 2026-05-30 03:06:47.426161 | debian-bookworm | Label: debian-bookworm 2026-05-30 03:06:47.426182 | debian-bookworm | Product Name: OpenStack Nova 2026-05-30 03:06:47.426202 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecb:8085 2026-05-30 03:06:47.439108 | 2026-05-30 03:06:47.439238 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-30 03:06:47.970894 | debian-bookworm -> localhost | changed 2026-05-30 03:06:47.978110 | 2026-05-30 03:06:47.978215 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-30 03:06:49.416371 | debian-bookworm -> localhost | changed 2026-05-30 03:06:49.428458 | 2026-05-30 03:06:49.428566 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-30 03:06:49.825860 | debian-bookworm -> localhost | ok 2026-05-30 03:06:49.833226 | 2026-05-30 03:06:49.833340 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-30 03:06:49.873677 | debian-bookworm | ok 2026-05-30 03:06:49.910330 | debian-bookworm | included: /var/lib/zuul/builds/ee50b7ca14c04cbab64d43f4ffd6f792/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-30 03:06:49.927427 | 2026-05-30 03:06:49.927587 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-30 03:06:51.583933 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-30 03:06:51.584453 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ee50b7ca14c04cbab64d43f4ffd6f792/work/ee50b7ca14c04cbab64d43f4ffd6f792_id_rsa 2026-05-30 03:06:51.584581 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ee50b7ca14c04cbab64d43f4ffd6f792/work/ee50b7ca14c04cbab64d43f4ffd6f792_id_rsa.pub 2026-05-30 03:06:51.584662 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-30 03:06:51.584732 | debian-bookworm -> localhost | SHA256:Lheb7ms2uOgwI+ORnvEBFo7kEpq7ggtQ7iQPVa5TCo4 zuul-build-sshkey 2026-05-30 03:06:51.584799 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-30 03:06:51.584909 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-30 03:06:51.584978 | debian-bookworm -> localhost | | . | 2026-05-30 03:06:51.585042 | debian-bookworm -> localhost | | o | 2026-05-30 03:06:51.585103 | debian-bookworm -> localhost | |ooo o | 2026-05-30 03:06:51.585162 | debian-bookworm -> localhost | |OB.+ | 2026-05-30 03:06:51.585222 | debian-bookworm -> localhost | |E** S | 2026-05-30 03:06:51.585287 | debian-bookworm -> localhost | |+Bo. . + | 2026-05-30 03:06:51.585348 | debian-bookworm -> localhost | |*+*. ..= | 2026-05-30 03:06:51.585408 | debian-bookworm -> localhost | |*+=+...++ | 2026-05-30 03:06:51.585470 | debian-bookworm -> localhost | |+= oo .=+o | 2026-05-30 03:06:51.585531 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-30 03:06:51.585676 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.029029 2026-05-30 03:06:51.599777 | 2026-05-30 03:06:51.599972 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-30 03:06:51.645729 | debian-bookworm | ok 2026-05-30 03:06:51.658763 | debian-bookworm | included: /var/lib/zuul/builds/ee50b7ca14c04cbab64d43f4ffd6f792/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-30 03:06:51.683281 | 2026-05-30 03:06:51.683379 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-30 03:06:51.697360 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:06:51.702958 | 2026-05-30 03:06:51.703050 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-30 03:06:52.483843 | debian-bookworm | changed 2026-05-30 03:06:52.490898 | 2026-05-30 03:06:52.490992 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-30 03:06:52.794741 | debian-bookworm | ok 2026-05-30 03:06:52.803813 | 2026-05-30 03:06:52.803940 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-30 03:06:53.515676 | debian-bookworm | changed 2026-05-30 03:06:53.522335 | 2026-05-30 03:06:53.522427 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-30 03:06:54.117589 | debian-bookworm | changed 2026-05-30 03:06:54.124014 | 2026-05-30 03:06:54.124112 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-30 03:06:54.147930 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:06:54.154253 | 2026-05-30 03:06:54.154528 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-30 03:06:55.014921 | debian-bookworm -> localhost | changed 2026-05-30 03:06:55.028173 | 2026-05-30 03:06:55.028289 | TASK [add-build-sshkey : Add back temp key] 2026-05-30 03:06:55.649170 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ee50b7ca14c04cbab64d43f4ffd6f792/work/ee50b7ca14c04cbab64d43f4ffd6f792_id_rsa (zuul-build-sshkey) 2026-05-30 03:06:55.649528 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014816 2026-05-30 03:06:55.660525 | 2026-05-30 03:06:55.660648 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-30 03:06:56.166693 | debian-bookworm | ok 2026-05-30 03:06:56.172287 | 2026-05-30 03:06:56.172584 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-30 03:06:56.208453 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:06:56.233169 | 2026-05-30 03:06:56.233282 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-30 03:06:56.721427 | debian-bookworm | ok 2026-05-30 03:06:56.734697 | 2026-05-30 03:06:56.734955 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-30 03:06:56.776911 | debian-bookworm | ok 2026-05-30 03:06:56.782541 | 2026-05-30 03:06:56.782662 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-30 03:06:57.257904 | debian-bookworm -> localhost | ok 2026-05-30 03:06:57.273764 | 2026-05-30 03:06:57.273953 | TASK [validate-host : Collect information about the host] 2026-05-30 03:06:58.571487 | debian-bookworm | ok 2026-05-30 03:06:58.599537 | 2026-05-30 03:06:58.599699 | TASK [validate-host : Sanitize hostname] 2026-05-30 03:06:58.840094 | debian-bookworm | ok 2026-05-30 03:06:58.957916 | 2026-05-30 03:06:58.963416 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-30 03:06:59.911539 | debian-bookworm -> localhost | changed 2026-05-30 03:06:59.917850 | 2026-05-30 03:06:59.917980 | TASK [validate-host : Collect information about zuul worker] 2026-05-30 03:07:00.476565 | debian-bookworm | ok 2026-05-30 03:07:00.489245 | 2026-05-30 03:07:00.489391 | TASK [validate-host : Write out all zuul information for each host] 2026-05-30 03:07:01.721655 | debian-bookworm -> localhost | changed 2026-05-30 03:07:01.731280 | 2026-05-30 03:07:01.731388 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-30 03:07:02.005298 | debian-bookworm | ok 2026-05-30 03:07:02.014873 | 2026-05-30 03:07:02.014988 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-30 03:07:03.398885 | debian-bookworm | changed: 2026-05-30 03:07:03.399334 | debian-bookworm | cd+++++++++ src/ 2026-05-30 03:07:03.399378 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-30 03:07:03.399405 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-30 03:07:03.399428 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-30 03:07:03.399450 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/ee50b7ca14c04cbab64d43f4ffd6f792/work/logs" 2026-05-30 03:07:30.209815 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ee50b7ca14c04cbab64d43f4ffd6f792/work/artifacts" 2026-05-30 03:07:30.591369 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ee50b7ca14c04cbab64d43f4ffd6f792/work/docs" 2026-05-30 03:07:30.610496 | 2026-05-30 03:07:30.610657 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-30 03:07:31.684878 | debian-bookworm | changed: 2026-05-30 03:07:31.685169 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-30 03:07:31.685207 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-30 03:07:31.685237 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-30 03:07:31.685285 | debian-bookworm | changed: All items complete 2026-05-30 03:07:31.685312 | 2026-05-30 03:07:32.262074 | debian-bookworm | changed: .d..t...... ./ 2026-05-30 03:07:33.075848 | debian-bookworm | changed: .d..t...... ./ 2026-05-30 03:07:33.096581 | 2026-05-30 03:07:33.096750 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-30 03:07:33.171331 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:07:33.185955 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:07:33.202654 | 2026-05-30 03:07:33.202814 | PLAY RECAP 2026-05-30 03:07:33.202894 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-30 03:07:33.202920 | 2026-05-30 03:07:33.583582 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-30 03:07:33.584460 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-30 03:07:34.812832 | 2026-05-30 03:07:34.812982 | PLAY [Base post] 2026-05-30 03:07:34.827585 | 2026-05-30 03:07:34.827701 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-30 03:07:35.379216 | debian-bookworm | changed 2026-05-30 03:07:35.386440 | 2026-05-30 03:07:35.386551 | PLAY RECAP 2026-05-30 03:07:35.386614 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-30 03:07:35.386676 | 2026-05-30 03:07:35.558603 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-30 03:07:35.559374 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-30 03:07:36.516539 | 2026-05-30 03:07:36.516685 | PLAY [Base post-logs] 2026-05-30 03:07:36.526245 | 2026-05-30 03:07:36.526357 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-30 03:07:37.003345 | localhost | changed 2026-05-30 03:07:37.014994 | 2026-05-30 03:07:37.015137 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-30 03:07:37.040975 | localhost | ok 2026-05-30 03:07:37.048684 | 2026-05-30 03:07:37.048821 | TASK [Set zuul-log-path fact] 2026-05-30 03:07:37.085467 | localhost | ok 2026-05-30 03:07:37.106854 | 2026-05-30 03:07:37.106966 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-30 03:07:37.132191 | localhost | ok 2026-05-30 03:07:37.136006 | 2026-05-30 03:07:37.136116 | TASK [upload-logs : Create log directories] 2026-05-30 03:07:37.863574 | localhost | changed 2026-05-30 03:07:37.866283 | 2026-05-30 03:07:37.866380 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-30 03:07:39.016166 | localhost -> localhost | ok: Runtime: 0:00:00.004716 2026-05-30 03:07:39.020071 | 2026-05-30 03:07:39.020173 | TASK [upload-logs : Upload logs to log server] 2026-05-30 03:07:39.705676 | localhost | Output suppressed because no_log was given 2026-05-30 03:07:39.707402 | 2026-05-30 03:07:39.707489 | LOOP [upload-logs : Compress console log and json output] 2026-05-30 03:07:39.794242 | localhost | skipping: Conditional result was False 2026-05-30 03:07:39.804276 | localhost | skipping: Conditional result was False 2026-05-30 03:07:39.813970 | 2026-05-30 03:07:39.814101 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-30 03:07:39.908077 | localhost | skipping: Conditional result was False 2026-05-30 03:07:39.908354 | 2026-05-30 03:07:39.920258 | localhost | skipping: Conditional result was False 2026-05-30 03:07:39.923521 | 2026-05-30 03:07:39.923615 | LOOP [upload-logs : Upload console log and json output]