2026-07-01 21:02:31.459375 | Job console starting 2026-07-01 21:02:31.468104 | Updating git repos 2026-07-01 21:02:31.531892 | Cloning repos into workspace 2026-07-01 21:02:31.666957 | Restoring repo states 2026-07-01 21:02:31.706655 | Merging changes 2026-07-01 21:02:32.819675 | Checking out repos 2026-07-01 21:02:32.986480 | Preparing playbooks 2026-07-01 21:02:34.655143 | Running Ansible setup 2026-07-01 21:02:39.493969 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-01 21:02:40.798745 | 2026-07-01 21:02:40.798945 | PLAY [Base pre] 2026-07-01 21:02:40.855019 | 2026-07-01 21:02:40.855165 | TASK [Setup log path fact] 2026-07-01 21:02:40.884774 | debian-bookworm | ok 2026-07-01 21:02:40.916470 | 2026-07-01 21:02:40.916635 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-01 21:02:40.968503 | debian-bookworm | ok 2026-07-01 21:02:40.985473 | 2026-07-01 21:02:40.985597 | TASK [emit-job-header : Print job information] 2026-07-01 21:02:41.055545 | # Job Information 2026-07-01 21:02:41.055723 | Ansible Version: 2.16.14 2026-07-01 21:02:41.055758 | Job: hadolint 2026-07-01 21:02:41.055790 | Pipeline: check 2026-07-01 21:02:41.055812 | Executor: 521e9411259a 2026-07-01 21:02:41.055834 | Triggered by: https://github.com/osism/python-osism/pull/2159 2026-07-01 21:02:41.055856 | Event ID: 0ad1fb70-7590-11f1-9318-1530eb4853af 2026-07-01 21:02:41.063062 | 2026-07-01 21:02:41.063204 | LOOP [emit-job-header : Print node information] 2026-07-01 21:02:41.213002 | debian-bookworm | ok: 2026-07-01 21:02:41.213306 | debian-bookworm | # Node Information 2026-07-01 21:02:41.213349 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-01 21:02:41.213374 | debian-bookworm | Hostname: debian 2026-07-01 21:02:41.213396 | debian-bookworm | Username: zuul 2026-07-01 21:02:41.213415 | debian-bookworm | Distro: Debian 12.14 2026-07-01 21:02:41.213441 | debian-bookworm | Provider: regiocloud-a 2026-07-01 21:02:41.213462 | debian-bookworm | Region: 2026-07-01 21:02:41.213483 | debian-bookworm | Label: debian-bookworm 2026-07-01 21:02:41.213503 | debian-bookworm | Product Name: OpenStack Nova 2026-07-01 21:02:41.213522 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7b:ad80 2026-07-01 21:02:41.231544 | 2026-07-01 21:02:41.231672 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-01 21:02:43.021868 | debian-bookworm -> localhost | changed 2026-07-01 21:02:43.031322 | 2026-07-01 21:02:43.031538 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-01 21:02:45.864315 | debian-bookworm -> localhost | changed 2026-07-01 21:02:45.878306 | 2026-07-01 21:02:45.878473 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-01 21:02:46.400321 | debian-bookworm -> localhost | ok 2026-07-01 21:02:46.406702 | 2026-07-01 21:02:46.406816 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-01 21:02:46.446775 | debian-bookworm | ok 2026-07-01 21:02:46.470553 | debian-bookworm | included: /var/lib/zuul/builds/7c761e2afdfa48efa0a32228e8318776/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-01 21:02:46.503776 | 2026-07-01 21:02:46.504524 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-01 21:02:51.026176 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-01 21:02:51.026378 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7c761e2afdfa48efa0a32228e8318776/work/7c761e2afdfa48efa0a32228e8318776_id_rsa 2026-07-01 21:02:51.026410 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7c761e2afdfa48efa0a32228e8318776/work/7c761e2afdfa48efa0a32228e8318776_id_rsa.pub 2026-07-01 21:02:51.026431 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-01 21:02:51.026451 | debian-bookworm -> localhost | SHA256:NUML0u1wk/0KFuBzwjuqWrAx2eB+N+a2tdh3bB8ZGpc zuul-build-sshkey 2026-07-01 21:02:51.026469 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-01 21:02:51.026493 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-01 21:02:51.026511 | debian-bookworm -> localhost | | ..oo.o | 2026-07-01 21:02:51.026529 | debian-bookworm -> localhost | | +oo*.. | 2026-07-01 21:02:51.026545 | debian-bookworm -> localhost | | . =+*o . | 2026-07-01 21:02:51.026561 | debian-bookworm -> localhost | | . + *+o .. | 2026-07-01 21:02:51.026577 | debian-bookworm -> localhost | | * . S. ...E | 2026-07-01 21:02:51.026602 | debian-bookworm -> localhost | | . = . . .+ o | 2026-07-01 21:02:51.026633 | debian-bookworm -> localhost | | o o = . .. o | 2026-07-01 21:02:51.026651 | debian-bookworm -> localhost | | o =.= .. + . | 2026-07-01 21:02:51.026668 | debian-bookworm -> localhost | | ....+.o. o .. | 2026-07-01 21:02:51.026685 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-01 21:02:51.026728 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.264568 2026-07-01 21:02:51.032649 | 2026-07-01 21:02:51.032751 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-01 21:02:51.070169 | debian-bookworm | ok 2026-07-01 21:02:51.092421 | debian-bookworm | included: /var/lib/zuul/builds/7c761e2afdfa48efa0a32228e8318776/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-01 21:02:51.114041 | 2026-07-01 21:02:51.114159 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-01 21:02:51.147414 | debian-bookworm | skipping: Conditional result was False 2026-07-01 21:02:51.152692 | 2026-07-01 21:02:51.152788 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-01 21:02:52.092049 | debian-bookworm | changed 2026-07-01 21:02:52.129512 | 2026-07-01 21:02:52.129689 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-01 21:02:52.515283 | debian-bookworm | ok 2026-07-01 21:02:52.521941 | 2026-07-01 21:02:52.522040 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-01 21:02:53.428712 | debian-bookworm | changed 2026-07-01 21:02:53.433981 | 2026-07-01 21:02:53.434078 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-01 21:02:54.165839 | debian-bookworm | changed 2026-07-01 21:02:54.170605 | 2026-07-01 21:02:54.170749 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-01 21:02:54.184310 | debian-bookworm | skipping: Conditional result was False 2026-07-01 21:02:54.190362 | 2026-07-01 21:02:54.190469 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-01 21:02:54.807937 | debian-bookworm -> localhost | changed 2026-07-01 21:02:54.827311 | 2026-07-01 21:02:54.827633 | TASK [add-build-sshkey : Add back temp key] 2026-07-01 21:02:55.360292 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7c761e2afdfa48efa0a32228e8318776/work/7c761e2afdfa48efa0a32228e8318776_id_rsa (zuul-build-sshkey) 2026-07-01 21:02:55.360518 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.053639 2026-07-01 21:02:55.368406 | 2026-07-01 21:02:55.368523 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-01 21:02:56.008674 | debian-bookworm | ok 2026-07-01 21:02:56.019041 | 2026-07-01 21:02:56.019282 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-01 21:02:56.076842 | debian-bookworm | skipping: Conditional result was False 2026-07-01 21:02:56.087397 | 2026-07-01 21:02:56.087508 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-01 21:02:56.763277 | debian-bookworm | ok 2026-07-01 21:02:56.772084 | 2026-07-01 21:02:56.772177 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-01 21:02:56.799064 | debian-bookworm | ok 2026-07-01 21:02:56.803284 | 2026-07-01 21:02:56.803365 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-01 21:02:57.150773 | debian-bookworm -> localhost | ok 2026-07-01 21:02:57.156089 | 2026-07-01 21:02:57.156168 | TASK [validate-host : Collect information about the host] 2026-07-01 21:02:58.187523 | debian-bookworm | ok 2026-07-01 21:02:58.212040 | 2026-07-01 21:02:58.212373 | TASK [validate-host : Sanitize hostname] 2026-07-01 21:02:58.468041 | debian-bookworm | ok 2026-07-01 21:02:58.475698 | 2026-07-01 21:02:58.475811 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-01 21:02:59.174512 | debian-bookworm -> localhost | changed 2026-07-01 21:02:59.180124 | 2026-07-01 21:02:59.180225 | TASK [validate-host : Collect information about zuul worker] 2026-07-01 21:02:59.566250 | debian-bookworm | ok 2026-07-01 21:02:59.570901 | 2026-07-01 21:02:59.570998 | TASK [validate-host : Write out all zuul information for each host] 2026-07-01 21:03:00.730977 | debian-bookworm -> localhost | changed 2026-07-01 21:03:00.754207 | 2026-07-01 21:03:00.754388 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-01 21:03:01.085104 | debian-bookworm | ok 2026-07-01 21:03:01.106123 | 2026-07-01 21:03:01.106364 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-01 21:03:04.124443 | debian-bookworm | changed: 2026-07-01 21:03:04.124682 | debian-bookworm | cd+++++++++ src/ 2026-07-01 21:03:04.124724 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-01 21:03:04.124758 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-01 21:03:04.124787 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-01 21:03:04.124808 | debian-bookworm | Containerfile 2026-07-01 21:03:04.124939 | debian-bookworm | Containerfile 2026-07-01 21:03:04.250273 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/7c761e2afdfa48efa0a32228e8318776/work/logs" 2026-07-01 21:03:52.474565 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7c761e2afdfa48efa0a32228e8318776/work/artifacts" 2026-07-01 21:03:52.802966 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/7c761e2afdfa48efa0a32228e8318776/work/docs" 2026-07-01 21:03:52.827810 | 2026-07-01 21:03:52.827983 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-01 21:03:53.710112 | debian-bookworm | changed: 2026-07-01 21:03:53.710596 | debian-bookworm | .d..t...... ./ 2026-07-01 21:03:53.710667 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-01 21:03:53.710712 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-01 21:03:53.710751 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-01 21:03:53.710789 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-01 21:03:53.710826 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-01 21:03:53.710964 | debian-bookworm | changed: All items complete 2026-07-01 21:03:53.711012 | 2026-07-01 21:03:54.312382 | debian-bookworm | changed: .d..t...... ./ 2026-07-01 21:03:54.930252 | debian-bookworm | changed: .d..t...... ./ 2026-07-01 21:03:54.952488 | 2026-07-01 21:03:54.952688 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-01 21:03:55.336619 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007114 2026-07-01 21:03:55.707585 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.007706 2026-07-01 21:03:55.722909 | 2026-07-01 21:03:55.723055 | PLAY RECAP 2026-07-01 21:03:55.723114 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-01 21:03:55.723140 | 2026-07-01 21:03:55.886439 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-01 21:03:55.888601 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-01 21:03:56.773874 | 2026-07-01 21:03:56.774077 | PLAY [Base post] 2026-07-01 21:03:56.788939 | 2026-07-01 21:03:56.789101 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-01 21:03:57.382039 | debian-bookworm | changed 2026-07-01 21:03:57.389553 | 2026-07-01 21:03:57.389735 | PLAY RECAP 2026-07-01 21:03:57.390072 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-01 21:03:57.390174 | 2026-07-01 21:03:57.554654 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-01 21:03:57.556905 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-01 21:03:58.585784 | 2026-07-01 21:03:58.586004 | PLAY [Base post-logs] 2026-07-01 21:03:58.599059 | 2026-07-01 21:03:58.599423 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-01 21:03:59.135152 | localhost | changed 2026-07-01 21:03:59.151376 | 2026-07-01 21:03:59.151592 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-01 21:03:59.184328 | localhost | ok 2026-07-01 21:03:59.193886 | 2026-07-01 21:03:59.194076 | TASK [Set zuul-log-path fact] 2026-07-01 21:03:59.227522 | localhost | ok 2026-07-01 21:03:59.236287 | 2026-07-01 21:03:59.236422 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-01 21:03:59.273009 | localhost | ok 2026-07-01 21:03:59.277601 | 2026-07-01 21:03:59.277744 | TASK [upload-logs : Create log directories] 2026-07-01 21:03:59.833619 | localhost | changed 2026-07-01 21:03:59.840862 | 2026-07-01 21:03:59.840986 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-01 21:04:00.408391 | localhost -> localhost | ok: Runtime: 0:00:00.006336 2026-07-01 21:04:00.413111 | 2026-07-01 21:04:00.413289 | TASK [upload-logs : Upload logs to log server] 2026-07-01 21:04:01.125484 | localhost | Output suppressed because no_log was given 2026-07-01 21:04:01.127687 | 2026-07-01 21:04:01.127803 | LOOP [upload-logs : Compress console log and json output] 2026-07-01 21:04:01.184815 | localhost | skipping: Conditional result was False 2026-07-01 21:04:01.195927 | localhost | skipping: Conditional result was False 2026-07-01 21:04:01.199721 | 2026-07-01 21:04:01.199855 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-01 21:04:01.257714 | localhost | skipping: Conditional result was False 2026-07-01 21:04:01.258137 | 2026-07-01 21:04:01.263029 | localhost | skipping: Conditional result was False 2026-07-01 21:04:01.273038 | 2026-07-01 21:04:01.273226 | LOOP [upload-logs : Upload console log and json output]