2025-02-18 23:32:33.082454 | Job console starting... 2025-02-18 23:32:33.100440 | Updating repositories 2025-02-18 23:32:33.149440 | Preparing job workspace 2025-02-18 23:32:35.461267 | Running Ansible setup... 2025-02-18 23:32:41.184606 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-18 23:32:42.006818 | 2025-02-18 23:32:42.006948 | PLAY [Base pre] 2025-02-18 23:32:42.062099 | 2025-02-18 23:32:42.062230 | TASK [Setup log path fact] 2025-02-18 23:32:42.116924 | ubuntu-noble | ok 2025-02-18 23:32:42.141956 | 2025-02-18 23:32:42.142095 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 23:32:42.206529 | ubuntu-noble | ok 2025-02-18 23:32:42.218089 | 2025-02-18 23:32:42.218196 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 23:32:42.272662 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.285524 | 2025-02-18 23:32:42.285639 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 23:32:42.345028 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.352534 | 2025-02-18 23:32:42.352644 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-18 23:32:42.396720 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.403882 | 2025-02-18 23:32:42.403995 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-18 23:32:42.430815 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.438016 | 2025-02-18 23:32:42.438138 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-18 23:32:42.453848 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:42.468283 | 2025-02-18 23:32:42.468382 | TASK [emit-job-header : Print job information] 2025-02-18 23:32:42.532882 | # Job Information 2025-02-18 23:32:42.533135 | Ansible Version: 2.15.3 2025-02-18 23:32:42.533188 | Job: flake8 2025-02-18 23:32:42.533229 | Pipeline: check 2025-02-18 23:32:42.533260 | Executor: 7d211f194f6a 2025-02-18 23:32:42.533289 | Triggered by: https://github.com/osism/python-osism/pull/1200 2025-02-18 23:32:42.533317 | Event ID: 9bd4bea0-ee50-11ef-9c9c-0aabb8a8fae2 2025-02-18 23:32:42.541114 | 2025-02-18 23:32:42.541242 | LOOP [emit-job-header : Print node information] 2025-02-18 23:32:42.689726 | ubuntu-noble | ok: 2025-02-18 23:32:42.689885 | ubuntu-noble | # Node Information 2025-02-18 23:32:42.689917 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-18 23:32:42.689940 | ubuntu-noble | Hostname: ubuntu 2025-02-18 23:32:42.689961 | ubuntu-noble | Username: zuul 2025-02-18 23:32:42.689981 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-18 23:32:42.690000 | ubuntu-noble | Provider: regiocloud-a 2025-02-18 23:32:42.690019 | ubuntu-noble | Label: ubuntu-noble 2025-02-18 23:32:42.690061 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-18 23:32:42.690086 | ubuntu-noble | Interface IP: 81.163.192.54 2025-02-18 23:32:42.711814 | 2025-02-18 23:32:42.711915 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-18 23:32:43.478394 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:43.486186 | 2025-02-18 23:32:43.486278 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-18 23:32:44.572817 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:44.593629 | 2025-02-18 23:32:44.593720 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-18 23:32:44.881413 | ubuntu-noble -> localhost | ok 2025-02-18 23:32:44.888251 | 2025-02-18 23:32:44.888333 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-18 23:32:44.918756 | ubuntu-noble | ok 2025-02-18 23:32:44.945414 | ubuntu-noble | included: /var/lib/zuul/builds/3b758f39a284445e901a7290b0f1deb6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-18 23:32:44.970734 | 2025-02-18 23:32:44.970826 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-18 23:32:46.165815 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-18 23:32:46.165975 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/3b758f39a284445e901a7290b0f1deb6/work/3b758f39a284445e901a7290b0f1deb6_id_rsa 2025-02-18 23:32:46.166006 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/3b758f39a284445e901a7290b0f1deb6/work/3b758f39a284445e901a7290b0f1deb6_id_rsa.pub 2025-02-18 23:32:46.166027 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-18 23:32:46.166073 | ubuntu-noble -> localhost | SHA256:G2AXwDOYiYUnd7rkH3QKrWy07dtBkSd2/EigaZyLDCo zuul-build-sshkey 2025-02-18 23:32:46.166093 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-18 23:32:46.166115 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-18 23:32:46.166143 | ubuntu-noble -> localhost | | +.=..o | 2025-02-18 23:32:46.166161 | ubuntu-noble -> localhost | | + *.=+ = | 2025-02-18 23:32:46.166177 | ubuntu-noble -> localhost | | .+ +Oo* = | 2025-02-18 23:32:46.166193 | ubuntu-noble -> localhost | | . o=+o=.* o | 2025-02-18 23:32:46.166209 | ubuntu-noble -> localhost | |E =oB.oS . . | 2025-02-18 23:32:46.166225 | ubuntu-noble -> localhost | |. B +. o | 2025-02-18 23:32:46.166241 | ubuntu-noble -> localhost | | . o .o | 2025-02-18 23:32:46.166257 | ubuntu-noble -> localhost | | o. . | 2025-02-18 23:32:46.166273 | ubuntu-noble -> localhost | | ... | 2025-02-18 23:32:46.166289 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-18 23:32:46.166328 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.631615 2025-02-18 23:32:46.173385 | 2025-02-18 23:32:46.173462 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-18 23:32:46.232375 | ubuntu-noble | ok 2025-02-18 23:32:46.241443 | ubuntu-noble | included: /var/lib/zuul/builds/3b758f39a284445e901a7290b0f1deb6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-18 23:32:46.250024 | 2025-02-18 23:32:46.250108 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-18 23:32:46.273393 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:46.279310 | 2025-02-18 23:32:46.279388 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-18 23:32:46.927771 | ubuntu-noble | changed 2025-02-18 23:32:46.938459 | 2025-02-18 23:32:46.938541 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-18 23:32:47.234000 | ubuntu-noble | ok 2025-02-18 23:32:47.244763 | 2025-02-18 23:32:47.244871 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-18 23:32:47.963882 | ubuntu-noble | changed 2025-02-18 23:32:47.976160 | 2025-02-18 23:32:47.976381 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-18 23:32:48.752373 | ubuntu-noble | changed 2025-02-18 23:32:48.761976 | 2025-02-18 23:32:48.762117 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-18 23:32:48.796687 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:48.814750 | 2025-02-18 23:32:48.814852 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-18 23:32:49.232992 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:49.243925 | 2025-02-18 23:32:49.244011 | TASK [add-build-sshkey : Add back temp key] 2025-02-18 23:32:49.575838 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/3b758f39a284445e901a7290b0f1deb6/work/3b758f39a284445e901a7290b0f1deb6_id_rsa (zuul-build-sshkey) 2025-02-18 23:32:49.576034 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.017956 2025-02-18 23:32:49.583302 | 2025-02-18 23:32:49.583383 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-18 23:32:50.039623 | ubuntu-noble | ok 2025-02-18 23:32:50.044851 | 2025-02-18 23:32:50.044928 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-18 23:32:50.102392 | ubuntu-noble | skipping: Conditional result was False 2025-02-18 23:32:50.115671 | 2025-02-18 23:32:50.115756 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-18 23:32:50.591532 | ubuntu-noble | ok 2025-02-18 23:32:50.606347 | 2025-02-18 23:32:50.606443 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-18 23:32:50.651737 | ubuntu-noble | ok 2025-02-18 23:32:50.658330 | 2025-02-18 23:32:50.658413 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-18 23:32:50.956470 | ubuntu-noble -> localhost | ok 2025-02-18 23:32:50.964371 | 2025-02-18 23:32:50.971104 | TASK [validate-host : Collect information about the host] 2025-02-18 23:32:52.164999 | ubuntu-noble | ok 2025-02-18 23:32:52.184163 | 2025-02-18 23:32:52.184280 | TASK [validate-host : Sanitize hostname] 2025-02-18 23:32:52.268097 | ubuntu-noble | ok 2025-02-18 23:32:52.274341 | 2025-02-18 23:32:52.274436 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-18 23:32:52.777631 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:52.784229 | 2025-02-18 23:32:52.784326 | TASK [validate-host : Collect information about zuul worker] 2025-02-18 23:32:53.267214 | ubuntu-noble | ok 2025-02-18 23:32:53.274439 | 2025-02-18 23:32:53.274538 | TASK [validate-host : Write out all zuul information for each host] 2025-02-18 23:32:53.949027 | ubuntu-noble -> localhost | changed 2025-02-18 23:32:53.964790 | 2025-02-18 23:32:53.964889 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-18 23:32:54.253702 | ubuntu-noble | ok 2025-02-18 23:32:54.260745 | 2025-02-18 23:32:54.260837 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-18 23:32:55.561261 | ubuntu-noble | changed: 2025-02-18 23:32:55.561403 | ubuntu-noble | cd+++++++++ src/ 2025-02-18 23:32:55.561430 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-18 23:32:55.561449 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-18 23:32:55.561467 | ubuntu-noble | cd+++++++++ src/github.com/osism/python-osism/ 2025-02-18 23:32:55.561487 | ubuntu-noble | Containerfile 2025-02-18 23:32:55.561579 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.004767 2025-02-18 23:33:52.414074 | 2025-02-18 23:33:52.414245 | TASK [upload-logs : Upload logs to log server] 2025-02-18 23:33:53.018524 | localhost | Output suppressed because no_log was given 2025-02-18 23:33:53.023861 | 2025-02-18 23:33:53.023998 | LOOP [upload-logs : Compress console log and json output] 2025-02-18 23:33:53.101842 | localhost | skipping: Conditional result was False 2025-02-18 23:33:53.123547 | localhost | skipping: Conditional result was False 2025-02-18 23:33:53.134791 | 2025-02-18 23:33:53.135150 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-18 23:33:53.204898 | localhost | skipping: Conditional result was False 2025-02-18 23:33:53.205709 | 2025-02-18 23:33:53.217445 | localhost | skipping: Conditional result was False 2025-02-18 23:33:53.233681 | 2025-02-18 23:33:53.233830 | LOOP [upload-logs : Upload console log and json output]