2026-07-06 07:00:22.003093 | Job console starting 2026-07-06 07:00:22.028831 | Updating git repos 2026-07-06 07:00:22.108054 | Cloning repos into workspace 2026-07-06 07:00:22.378598 | Restoring repo states 2026-07-06 07:00:22.419304 | Merging changes 2026-07-06 07:00:23.476515 | Checking out repos 2026-07-06 07:00:23.564856 | Preparing playbooks 2026-07-06 07:00:26.082229 | Running Ansible setup 2026-07-06 07:00:32.070760 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-06 07:00:33.650509 | 2026-07-06 07:00:33.650645 | PLAY [Base pre] 2026-07-06 07:00:33.705450 | 2026-07-06 07:00:33.705585 | TASK [Setup log path fact] 2026-07-06 07:00:33.744047 | debian-bookworm | ok 2026-07-06 07:00:33.774201 | 2026-07-06 07:00:33.774347 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-06 07:00:33.832713 | debian-bookworm | ok 2026-07-06 07:00:33.851553 | 2026-07-06 07:00:33.851672 | TASK [emit-job-header : Print job information] 2026-07-06 07:00:33.920253 | # Job Information 2026-07-06 07:00:33.920426 | Ansible Version: 2.16.14 2026-07-06 07:00:33.920461 | Job: python-osism-test-setup 2026-07-06 07:00:33.920494 | Pipeline: check 2026-07-06 07:00:33.920517 | Executor: 521e9411259a 2026-07-06 07:00:33.920538 | Triggered by: https://github.com/osism/python-osism/pull/2438 2026-07-06 07:00:33.920561 | Event ID: 522287d0-7908-11f1-9a4d-0925546d439a 2026-07-06 07:00:33.925438 | 2026-07-06 07:00:33.925542 | LOOP [emit-job-header : Print node information] 2026-07-06 07:00:34.180042 | debian-bookworm | ok: 2026-07-06 07:00:34.180213 | debian-bookworm | # Node Information 2026-07-06 07:00:34.180246 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-06 07:00:34.180271 | debian-bookworm | Hostname: debian 2026-07-06 07:00:34.180293 | debian-bookworm | Username: zuul 2026-07-06 07:00:34.180313 | debian-bookworm | Distro: Debian 12.14 2026-07-06 07:00:34.180336 | debian-bookworm | Provider: regiocloud-a 2026-07-06 07:00:34.180356 | debian-bookworm | Region: 2026-07-06 07:00:34.180378 | debian-bookworm | Label: debian-bookworm 2026-07-06 07:00:34.180398 | debian-bookworm | Product Name: OpenStack Nova 2026-07-06 07:00:34.180418 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8d:eb92 2026-07-06 07:00:34.190544 | 2026-07-06 07:00:34.190664 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-06 07:00:35.254175 | debian-bookworm -> localhost | changed 2026-07-06 07:00:35.261521 | 2026-07-06 07:00:35.261639 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-06 07:00:37.459420 | debian-bookworm -> localhost | changed 2026-07-06 07:00:37.477643 | 2026-07-06 07:00:37.477763 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-06 07:00:38.377834 | debian-bookworm -> localhost | ok 2026-07-06 07:00:38.384106 | 2026-07-06 07:00:38.384215 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-06 07:00:38.424655 | debian-bookworm | ok 2026-07-06 07:00:38.466041 | debian-bookworm | included: /var/lib/zuul/builds/b31fe6d055db40ca9f80b3de173557b8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-06 07:00:38.485477 | 2026-07-06 07:00:38.487171 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-06 07:00:41.200100 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-06 07:00:41.200300 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b31fe6d055db40ca9f80b3de173557b8/work/b31fe6d055db40ca9f80b3de173557b8_id_rsa 2026-07-06 07:00:41.200339 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b31fe6d055db40ca9f80b3de173557b8/work/b31fe6d055db40ca9f80b3de173557b8_id_rsa.pub 2026-07-06 07:00:41.200367 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-06 07:00:41.200392 | debian-bookworm -> localhost | SHA256:CoUgEd00liSGmCmgvNwo/XHdqiMFc0KqbcXOtJCmst4 zuul-build-sshkey 2026-07-06 07:00:41.200414 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-06 07:00:41.200444 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-06 07:00:41.200466 | debian-bookworm -> localhost | |BB++=. | 2026-07-06 07:00:41.200488 | debian-bookworm -> localhost | |Oo.++o | 2026-07-06 07:00:41.200509 | debian-bookworm -> localhost | |o. =. . | 2026-07-06 07:00:41.200529 | debian-bookworm -> localhost | |..O B... . | 2026-07-06 07:00:41.200549 | debian-bookworm -> localhost | |.O.Bo*. S . | 2026-07-06 07:00:41.200574 | debian-bookworm -> localhost | |= o.++.. . | 2026-07-06 07:00:41.200596 | debian-bookworm -> localhost | |.o ... . | 2026-07-06 07:00:41.200616 | debian-bookworm -> localhost | |. . . .. | 2026-07-06 07:00:41.200637 | debian-bookworm -> localhost | |.. E ... | 2026-07-06 07:00:41.200658 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-06 07:00:41.200712 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.746256 2026-07-06 07:00:41.207222 | 2026-07-06 07:00:41.207320 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-06 07:00:41.238708 | debian-bookworm | ok 2026-07-06 07:00:41.256096 | debian-bookworm | included: /var/lib/zuul/builds/b31fe6d055db40ca9f80b3de173557b8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-06 07:00:41.276041 | 2026-07-06 07:00:41.276213 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-06 07:00:41.292654 | debian-bookworm | skipping: Conditional result was False 2026-07-06 07:00:41.298718 | 2026-07-06 07:00:41.298821 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-06 07:00:41.997810 | debian-bookworm | changed 2026-07-06 07:00:42.004232 | 2026-07-06 07:00:42.004330 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-06 07:00:42.299123 | debian-bookworm | ok 2026-07-06 07:00:42.308353 | 2026-07-06 07:00:42.308472 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-06 07:00:43.141310 | debian-bookworm | changed 2026-07-06 07:00:43.154993 | 2026-07-06 07:00:43.155173 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-06 07:00:43.878149 | debian-bookworm | changed 2026-07-06 07:00:43.889988 | 2026-07-06 07:00:43.890098 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-06 07:00:43.939446 | debian-bookworm | skipping: Conditional result was False 2026-07-06 07:00:43.946250 | 2026-07-06 07:00:43.946391 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-06 07:00:44.633335 | debian-bookworm -> localhost | changed 2026-07-06 07:00:44.645723 | 2026-07-06 07:00:44.645833 | TASK [add-build-sshkey : Add back temp key] 2026-07-06 07:00:45.580946 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b31fe6d055db40ca9f80b3de173557b8/work/b31fe6d055db40ca9f80b3de173557b8_id_rsa (zuul-build-sshkey) 2026-07-06 07:00:45.581188 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.049151 2026-07-06 07:00:45.588841 | 2026-07-06 07:00:45.588967 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-06 07:00:46.189308 | debian-bookworm | ok 2026-07-06 07:00:46.198112 | 2026-07-06 07:00:46.198316 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-06 07:00:46.224671 | debian-bookworm | skipping: Conditional result was False 2026-07-06 07:00:46.234760 | 2026-07-06 07:00:46.234927 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-06 07:00:46.697232 | debian-bookworm | ok 2026-07-06 07:00:46.719353 | 2026-07-06 07:00:46.719451 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-06 07:00:46.759800 | debian-bookworm | ok 2026-07-06 07:00:46.764144 | 2026-07-06 07:00:46.764231 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-06 07:00:47.215219 | debian-bookworm -> localhost | ok 2026-07-06 07:00:47.221093 | 2026-07-06 07:00:47.221183 | TASK [validate-host : Collect information about the host] 2026-07-06 07:00:48.392698 | debian-bookworm | ok 2026-07-06 07:00:48.423558 | 2026-07-06 07:00:48.423667 | TASK [validate-host : Sanitize hostname] 2026-07-06 07:00:48.664749 | debian-bookworm | ok 2026-07-06 07:00:48.669904 | 2026-07-06 07:00:48.670004 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-06 07:00:49.510267 | debian-bookworm -> localhost | changed 2026-07-06 07:00:49.515262 | 2026-07-06 07:00:49.515350 | TASK [validate-host : Collect information about zuul worker] 2026-07-06 07:00:49.926765 | debian-bookworm | ok 2026-07-06 07:00:49.930725 | 2026-07-06 07:00:49.931326 | TASK [validate-host : Write out all zuul information for each host] 2026-07-06 07:00:50.697256 | debian-bookworm -> localhost | changed 2026-07-06 07:00:50.705151 | 2026-07-06 07:00:50.705242 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-06 07:00:51.006373 | debian-bookworm | ok 2026-07-06 07:00:51.011844 | 2026-07-06 07:00:51.011942 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-06 07:00:52.357177 | debian-bookworm | changed: 2026-07-06 07:00:52.358145 | debian-bookworm | cd+++++++++ src/ 2026-07-06 07:00:52.358601 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-06 07:00:52.358809 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-06 07:00:52.359143 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-06 07:00:52.359325 | debian-bookworm | Containerfile 2026-07-06 07:00:52.361092 | debian-bookworm | Containerfile 2026-07-06 07:00:52.441732 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b31fe6d055db40ca9f80b3de173557b8/work/logs" 2026-07-06 07:03:34.181306 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b31fe6d055db40ca9f80b3de173557b8/work/artifacts" 2026-07-06 07:03:34.469123 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b31fe6d055db40ca9f80b3de173557b8/work/docs" 2026-07-06 07:03:34.481582 | 2026-07-06 07:03:34.481749 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-06 07:03:35.362545 | debian-bookworm | changed: 2026-07-06 07:03:35.362992 | debian-bookworm | .d..t...... ./ 2026-07-06 07:03:35.363066 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-06 07:03:35.363110 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-06 07:03:35.363147 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-06 07:03:35.363184 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-06 07:03:35.363220 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-06 07:03:35.363289 | debian-bookworm | changed: All items complete 2026-07-06 07:03:35.363330 | 2026-07-06 07:03:35.980377 | debian-bookworm | changed: .d..t...... ./ 2026-07-06 07:03:36.578088 | debian-bookworm | changed: .d..t...... ./ 2026-07-06 07:03:36.594587 | 2026-07-06 07:03:36.594770 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-06 07:03:37.005865 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011417 2026-07-06 07:03:37.314261 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011384 2026-07-06 07:03:37.337356 | 2026-07-06 07:03:37.337538 | PLAY RECAP 2026-07-06 07:03:37.337628 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-06 07:03:37.337670 | 2026-07-06 07:03:37.497879 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-06 07:03:37.500014 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-06 07:03:38.296070 | 2026-07-06 07:03:38.296285 | PLAY [Base post] 2026-07-06 07:03:38.311279 | 2026-07-06 07:03:38.311440 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-06 07:03:39.177145 | debian-bookworm | changed 2026-07-06 07:03:39.186383 | 2026-07-06 07:03:39.186530 | PLAY RECAP 2026-07-06 07:03:39.186609 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-06 07:03:39.186687 | 2026-07-06 07:03:39.340341 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-06 07:03:39.342680 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-06 07:03:40.162268 | 2026-07-06 07:03:40.162479 | PLAY [Base post-logs] 2026-07-06 07:03:40.174456 | 2026-07-06 07:03:40.174661 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-06 07:03:40.675125 | localhost | changed 2026-07-06 07:03:40.697715 | 2026-07-06 07:03:40.697980 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-06 07:03:40.737999 | localhost | ok 2026-07-06 07:03:40.747588 | 2026-07-06 07:03:40.747813 | TASK [Set zuul-log-path fact] 2026-07-06 07:03:40.779122 | localhost | ok 2026-07-06 07:03:40.794711 | 2026-07-06 07:03:40.794909 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-06 07:03:40.833504 | localhost | ok 2026-07-06 07:03:40.840981 | 2026-07-06 07:03:40.841165 | TASK [upload-logs : Create log directories] 2026-07-06 07:03:41.411225 | localhost | changed 2026-07-06 07:03:41.415541 | 2026-07-06 07:03:41.415675 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-06 07:03:41.999952 | localhost -> localhost | ok: Runtime: 0:00:00.005258 2026-07-06 07:03:42.008860 | 2026-07-06 07:03:42.009086 | TASK [upload-logs : Upload logs to log server] 2026-07-06 07:03:42.647195 | localhost | Output suppressed because no_log was given 2026-07-06 07:03:42.649509 | 2026-07-06 07:03:42.649677 | LOOP [upload-logs : Compress console log and json output] 2026-07-06 07:03:42.701951 | localhost | skipping: Conditional result was False 2026-07-06 07:03:42.707499 | localhost | skipping: Conditional result was False 2026-07-06 07:03:42.720296 | 2026-07-06 07:03:42.720561 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-06 07:03:42.786417 | localhost | skipping: Conditional result was False 2026-07-06 07:03:42.787208 | 2026-07-06 07:03:42.791213 | localhost | skipping: Conditional result was False 2026-07-06 07:03:42.803854 | 2026-07-06 07:03:42.804090 | LOOP [upload-logs : Upload console log and json output]