2025-09-16 09:00:17.307262 | Job console starting 2025-09-16 09:00:17.319780 | Updating git repos 2025-09-16 09:00:17.347135 | Cloning repos into workspace 2025-09-16 09:00:17.406385 | Restoring repo states 2025-09-16 09:00:17.418022 | Merging changes 2025-09-16 09:00:17.929817 | Checking out repos 2025-09-16 09:00:17.980437 | Preparing playbooks 2025-09-16 09:00:18.592020 | Running Ansible setup 2025-09-16 09:00:22.805614 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-16 09:00:23.579414 | 2025-09-16 09:00:23.580020 | PLAY [Base pre] 2025-09-16 09:00:23.596321 | 2025-09-16 09:00:23.596442 | TASK [Setup log path fact] 2025-09-16 09:00:23.620252 | debian-bookworm | ok 2025-09-16 09:00:23.635252 | 2025-09-16 09:00:23.635391 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-16 09:00:23.670105 | debian-bookworm | ok 2025-09-16 09:00:23.683080 | 2025-09-16 09:00:23.683206 | TASK [emit-job-header : Print job information] 2025-09-16 09:00:23.732235 | # Job Information 2025-09-16 09:00:23.732409 | Ansible Version: 2.16.14 2025-09-16 09:00:23.732444 | Job: deb-packaging-build-open-iscsi-bookworm-backports 2025-09-16 09:00:23.732476 | Pipeline: check 2025-09-16 09:00:23.732499 | Executor: 521e9411259a 2025-09-16 09:00:23.732535 | Triggered by: https://github.com/osism/deb-packaging/pull/30 2025-09-16 09:00:23.732557 | Event ID: 8c269fc0-92db-11f0-828b-cdd8c4872433 2025-09-16 09:00:23.737500 | 2025-09-16 09:00:23.737654 | LOOP [emit-job-header : Print node information] 2025-09-16 09:00:23.869866 | debian-bookworm | ok: 2025-09-16 09:00:23.870061 | debian-bookworm | # Node Information 2025-09-16 09:00:23.870097 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-16 09:00:23.870124 | debian-bookworm | Hostname: debian 2025-09-16 09:00:23.870147 | debian-bookworm | Username: zuul 2025-09-16 09:00:23.870169 | debian-bookworm | Distro: Debian 12.12 2025-09-16 09:00:23.870193 | debian-bookworm | Provider: regiocloud-a 2025-09-16 09:00:23.870214 | debian-bookworm | Region: 2025-09-16 09:00:23.870235 | debian-bookworm | Label: debian-bookworm 2025-09-16 09:00:23.870255 | debian-bookworm | Product Name: OpenStack Nova 2025-09-16 09:00:23.870275 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9b:ecc6 2025-09-16 09:00:23.884578 | 2025-09-16 09:00:23.884715 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-16 09:00:24.344862 | debian-bookworm -> localhost | changed 2025-09-16 09:00:24.352365 | 2025-09-16 09:00:24.352493 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-16 09:00:25.349915 | debian-bookworm -> localhost | changed 2025-09-16 09:00:25.360933 | 2025-09-16 09:00:25.361057 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-16 09:00:25.650133 | debian-bookworm -> localhost | ok 2025-09-16 09:00:25.657043 | 2025-09-16 09:00:25.657160 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-16 09:00:25.686026 | debian-bookworm | ok 2025-09-16 09:00:25.703471 | debian-bookworm | included: /var/lib/zuul/builds/27fe7a489c4b4432af2dca04425be670/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-16 09:00:25.709804 | 2025-09-16 09:00:25.709907 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-16 09:00:27.188677 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-16 09:00:27.189130 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/27fe7a489c4b4432af2dca04425be670/work/27fe7a489c4b4432af2dca04425be670_id_rsa 2025-09-16 09:00:27.189229 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/27fe7a489c4b4432af2dca04425be670/work/27fe7a489c4b4432af2dca04425be670_id_rsa.pub 2025-09-16 09:00:27.189300 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-16 09:00:27.189365 | debian-bookworm -> localhost | SHA256:I3rrYQlnnQ8CAfnmrFto8XiULaL26R//povFD5YqAzU zuul-build-sshkey 2025-09-16 09:00:27.189446 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-16 09:00:27.189574 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-16 09:00:27.189642 | debian-bookworm -> localhost | | .o. | 2025-09-16 09:00:27.189699 | debian-bookworm -> localhost | | . . | 2025-09-16 09:00:27.189752 | debian-bookworm -> localhost | | .. | 2025-09-16 09:00:27.189804 | debian-bookworm -> localhost | | Eo+ . . | 2025-09-16 09:00:27.189856 | debian-bookworm -> localhost | | ++* * S | 2025-09-16 09:00:27.189948 | debian-bookworm -> localhost | | o Bo*.+.+ | 2025-09-16 09:00:27.190005 | debian-bookworm -> localhost | |..=.=.=* . | 2025-09-16 09:00:27.190054 | debian-bookworm -> localhost | |..o=.oBoo. | 2025-09-16 09:00:27.190105 | debian-bookworm -> localhost | | o=+=o+=o | 2025-09-16 09:00:27.190153 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-16 09:00:27.190259 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.980784 2025-09-16 09:00:27.201743 | 2025-09-16 09:00:27.201883 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-16 09:00:27.239068 | debian-bookworm | ok 2025-09-16 09:00:27.255010 | debian-bookworm | included: /var/lib/zuul/builds/27fe7a489c4b4432af2dca04425be670/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-16 09:00:27.265442 | 2025-09-16 09:00:27.265893 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-16 09:00:27.293422 | debian-bookworm | skipping: Conditional result was False 2025-09-16 09:00:27.307818 | 2025-09-16 09:00:27.307972 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-16 09:00:27.958622 | debian-bookworm | changed 2025-09-16 09:00:27.964916 | 2025-09-16 09:00:27.965026 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-16 09:00:28.229019 | debian-bookworm | ok 2025-09-16 09:00:28.237451 | 2025-09-16 09:00:28.237641 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-16 09:00:28.899098 | debian-bookworm | changed 2025-09-16 09:00:28.907424 | 2025-09-16 09:00:28.907551 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-16 09:00:29.526354 | debian-bookworm | changed 2025-09-16 09:00:29.531941 | 2025-09-16 09:00:29.532044 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-16 09:00:29.555522 | debian-bookworm | skipping: Conditional result was False 2025-09-16 09:00:29.561398 | 2025-09-16 09:00:29.561570 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-16 09:00:29.983930 | debian-bookworm -> localhost | changed 2025-09-16 09:00:29.995984 | 2025-09-16 09:00:29.996108 | TASK [add-build-sshkey : Add back temp key] 2025-09-16 09:00:30.313868 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/27fe7a489c4b4432af2dca04425be670/work/27fe7a489c4b4432af2dca04425be670_id_rsa (zuul-build-sshkey) 2025-09-16 09:00:30.314181 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011410 2025-09-16 09:00:30.322301 | 2025-09-16 09:00:30.322419 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-16 09:00:30.727703 | debian-bookworm | ok 2025-09-16 09:00:30.732771 | 2025-09-16 09:00:30.732880 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-16 09:00:30.767207 | debian-bookworm | skipping: Conditional result was False 2025-09-16 09:00:30.778197 | 2025-09-16 09:00:30.778309 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-16 09:00:31.227937 | debian-bookworm | ok 2025-09-16 09:00:31.240728 | 2025-09-16 09:00:31.240852 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-16 09:00:31.295964 | debian-bookworm | ok 2025-09-16 09:00:31.304743 | 2025-09-16 09:00:31.304976 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-16 09:00:31.605557 | debian-bookworm -> localhost | ok 2025-09-16 09:00:31.617744 | 2025-09-16 09:00:31.617901 | TASK [validate-host : Collect information about the host] 2025-09-16 09:00:32.749267 | debian-bookworm | ok 2025-09-16 09:00:32.759462 | 2025-09-16 09:00:32.759618 | TASK [validate-host : Sanitize hostname] 2025-09-16 09:00:32.860317 | debian-bookworm | ok 2025-09-16 09:00:32.917843 | 2025-09-16 09:00:32.917973 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-16 09:00:33.490957 | debian-bookworm -> localhost | changed 2025-09-16 09:00:33.501722 | 2025-09-16 09:00:33.501877 | TASK [validate-host : Collect information about zuul worker] 2025-09-16 09:00:33.930680 | debian-bookworm | ok 2025-09-16 09:00:33.937363 | 2025-09-16 09:00:33.937501 | TASK [validate-host : Write out all zuul information for each host] 2025-09-16 09:00:34.456660 | debian-bookworm -> localhost | changed 2025-09-16 09:00:34.473469 | 2025-09-16 09:00:34.473647 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-16 09:00:34.753474 | debian-bookworm | ok 2025-09-16 09:00:34.763482 | 2025-09-16 09:00:34.763694 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-16 09:00:35.552096 | debian-bookworm | changed: 2025-09-16 09:00:35.552300 | debian-bookworm | cd+++++++++ src/ 2025-09-16 09:00:35.552334 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-16 09:00:35.552358 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-16 09:00:35.552380 | debian-bookworm | cd+++++++++ src/github.com/osism/deb-packaging/ 2025-09-16 09:00:35.552399 | debian-bookworm | Containerfile 2025-09-16 09:00:35.556159 | debian-bookworm | cd+++++++++ src/github.com/osism/deb-packaging/files/ovs/ 2025-09-16 09:00:35.556176 | debian-bookworm | Containerfile 2025-09-16 09:00:35.556211 | debian-bookworm | cd+++++++++ src/github.com/osism/deb-packaging/files/ovs/files/ 2025-09-16 09:00:35.556228 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007378 2025-09-16 09:01:24.199103 | 2025-09-16 09:01:24.199218 | TASK [upload-logs : Upload logs to log server] 2025-09-16 09:01:24.765581 | localhost | Output suppressed because no_log was given 2025-09-16 09:01:24.769170 | 2025-09-16 09:01:24.769336 | LOOP [upload-logs : Compress console log and json output] 2025-09-16 09:01:24.819576 | localhost | skipping: Conditional result was False 2025-09-16 09:01:24.824496 | localhost | skipping: Conditional result was False 2025-09-16 09:01:24.830581 | 2025-09-16 09:01:24.830758 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-16 09:01:24.882158 | localhost | skipping: Conditional result was False 2025-09-16 09:01:24.882933 | 2025-09-16 09:01:24.886064 | localhost | skipping: Conditional result was False 2025-09-16 09:01:24.891166 | 2025-09-16 09:01:24.891338 | LOOP [upload-logs : Upload console log and json output]