2026-04-16 09:00:26.112136 | Job console starting 2026-04-16 09:00:26.129129 | Updating git repos 2026-04-16 09:00:26.149115 | Cloning repos into workspace 2026-04-16 09:00:26.198949 | Restoring repo states 2026-04-16 09:00:26.208083 | Merging changes 2026-04-16 09:00:26.682438 | Checking out repos 2026-04-16 09:00:26.713271 | Preparing playbooks 2026-04-16 09:00:27.334106 | Running Ansible setup 2026-04-16 09:00:33.391963 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-16 09:00:34.228245 | 2026-04-16 09:00:34.228430 | PLAY [Base pre] 2026-04-16 09:00:34.251915 | 2026-04-16 09:00:34.252068 | TASK [Setup log path fact] 2026-04-16 09:00:34.293057 | noble | ok 2026-04-16 09:00:34.330449 | 2026-04-16 09:00:34.330618 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-16 09:00:34.372790 | noble | ok 2026-04-16 09:00:34.395046 | 2026-04-16 09:00:34.395184 | TASK [emit-job-header : Print job information] 2026-04-16 09:00:34.438606 | # Job Information 2026-04-16 09:00:34.438808 | Ansible Version: 2.16.14 2026-04-16 09:00:34.438865 | Job: openstack-ironic-images-build-osism-vyos 2026-04-16 09:00:34.438900 | Pipeline: check 2026-04-16 09:00:34.438923 | Executor: 521e9411259a 2026-04-16 09:00:34.438943 | Triggered by: https://github.com/osism/openstack-ironic-images/pull/200 2026-04-16 09:00:34.438966 | Event ID: 46f6f240-3972-11f1-8ff7-62f27c5eeda0 2026-04-16 09:00:34.446795 | 2026-04-16 09:00:34.446966 | LOOP [emit-job-header : Print node information] 2026-04-16 09:00:34.573120 | noble | ok: 2026-04-16 09:00:34.573393 | noble | # Node Information 2026-04-16 09:00:34.573432 | noble | Inventory Hostname: noble 2026-04-16 09:00:34.573458 | noble | Hostname: ubuntu 2026-04-16 09:00:34.573480 | noble | Username: zuul 2026-04-16 09:00:34.573501 | noble | Distro: Ubuntu 24.04 2026-04-16 09:00:34.573529 | noble | Provider: regiocloud-a 2026-04-16 09:00:34.573551 | noble | Region: 2026-04-16 09:00:34.573572 | noble | Label: ubuntu-noble-uefi 2026-04-16 09:00:34.573592 | noble | Product Name: OpenStack Nova 2026-04-16 09:00:34.573612 | noble | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb9:1055 2026-04-16 09:00:34.593682 | 2026-04-16 09:00:34.593878 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-16 09:00:35.206443 | noble -> localhost | changed 2026-04-16 09:00:35.215510 | 2026-04-16 09:00:35.215644 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-16 09:00:36.745725 | noble -> localhost | changed 2026-04-16 09:00:36.760322 | 2026-04-16 09:00:36.760455 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-16 09:00:37.063451 | noble -> localhost | ok 2026-04-16 09:00:37.071915 | 2026-04-16 09:00:37.072045 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-16 09:00:37.110875 | noble | ok 2026-04-16 09:00:37.127853 | noble | included: /var/lib/zuul/builds/f654b45474184306bea4b886224603d5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-16 09:00:37.136706 | 2026-04-16 09:00:37.136813 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-16 09:00:38.451028 | noble -> localhost | Generating public/private rsa key pair. 2026-04-16 09:00:38.451279 | noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f654b45474184306bea4b886224603d5/work/f654b45474184306bea4b886224603d5_id_rsa 2026-04-16 09:00:38.451322 | noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f654b45474184306bea4b886224603d5/work/f654b45474184306bea4b886224603d5_id_rsa.pub 2026-04-16 09:00:38.451350 | noble -> localhost | The key fingerprint is: 2026-04-16 09:00:38.451378 | noble -> localhost | SHA256:7q8cH9Kj1CbW93R7bxZE5Eo0DsSUBa4XtvndYm7sL58 zuul-build-sshkey 2026-04-16 09:00:38.451402 | noble -> localhost | The key's randomart image is: 2026-04-16 09:00:38.451424 | noble -> localhost | +---[RSA 3072]----+ 2026-04-16 09:00:38.451445 | noble -> localhost | | +=++.. | 2026-04-16 09:00:38.451528 | noble -> localhost | | .o+ o. | 2026-04-16 09:00:38.451554 | noble -> localhost | | + o.. | 2026-04-16 09:00:38.451574 | noble -> localhost | | o = .. | 2026-04-16 09:00:38.451594 | noble -> localhost | | S. + .. | 2026-04-16 09:00:38.451624 | noble -> localhost | | . +. . ...| 2026-04-16 09:00:38.451645 | noble -> localhost | | B B .o+.+| 2026-04-16 09:00:38.451664 | noble -> localhost | | = B + =+o*| 2026-04-16 09:00:38.451685 | noble -> localhost | | =oo o+E*| 2026-04-16 09:00:38.451705 | noble -> localhost | +----[SHA256]-----+ 2026-04-16 09:00:38.451764 | noble -> localhost | ok: Runtime: 0:00:00.785400 2026-04-16 09:00:38.459360 | 2026-04-16 09:00:38.459472 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-16 09:00:38.512943 | noble | ok 2026-04-16 09:00:38.531087 | noble | included: /var/lib/zuul/builds/f654b45474184306bea4b886224603d5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-16 09:00:38.541084 | 2026-04-16 09:00:38.541194 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-16 09:00:38.575164 | noble | skipping: Conditional result was False 2026-04-16 09:00:38.590041 | 2026-04-16 09:00:38.590197 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-16 09:00:39.249008 | noble | changed 2026-04-16 09:00:39.261109 | 2026-04-16 09:00:39.261359 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-16 09:00:39.547156 | noble | ok 2026-04-16 09:00:39.553552 | 2026-04-16 09:00:39.553664 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-16 09:00:40.288040 | noble | changed 2026-04-16 09:00:40.294468 | 2026-04-16 09:00:40.294586 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-16 09:00:41.079953 | noble | changed 2026-04-16 09:00:41.093554 | 2026-04-16 09:00:41.093688 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-16 09:00:41.121073 | noble | skipping: Conditional result was False 2026-04-16 09:00:41.128989 | 2026-04-16 09:00:41.129114 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-16 09:00:41.751936 | noble -> localhost | changed 2026-04-16 09:00:41.766448 | 2026-04-16 09:00:41.766577 | TASK [add-build-sshkey : Add back temp key] 2026-04-16 09:00:42.114675 | noble -> localhost | Identity added: /var/lib/zuul/builds/f654b45474184306bea4b886224603d5/work/f654b45474184306bea4b886224603d5_id_rsa (zuul-build-sshkey) 2026-04-16 09:00:42.115214 | noble -> localhost | ok: Runtime: 0:00:00.019557 2026-04-16 09:00:42.129173 | 2026-04-16 09:00:42.129328 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-16 09:00:42.581911 | noble | ok 2026-04-16 09:00:42.590699 | 2026-04-16 09:00:42.590888 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-16 09:00:42.625243 | noble | skipping: Conditional result was False 2026-04-16 09:00:42.686748 | 2026-04-16 09:00:42.686922 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-16 09:00:43.109960 | noble | ok 2026-04-16 09:00:43.130411 | 2026-04-16 09:00:43.130548 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-16 09:00:43.193767 | noble | ok 2026-04-16 09:00:43.207143 | 2026-04-16 09:00:43.207310 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-16 09:00:43.660353 | noble -> localhost | ok 2026-04-16 09:00:43.669298 | 2026-04-16 09:00:43.669426 | TASK [validate-host : Collect information about the host] 2026-04-16 09:00:45.141205 | noble | ok 2026-04-16 09:00:45.167217 | 2026-04-16 09:00:45.167417 | TASK [validate-host : Sanitize hostname] 2026-04-16 09:00:45.242923 | noble | ok 2026-04-16 09:00:45.249108 | 2026-04-16 09:00:45.249231 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-16 09:00:45.847095 | noble -> localhost | changed 2026-04-16 09:00:45.854080 | 2026-04-16 09:00:45.854205 | TASK [validate-host : Collect information about zuul worker] 2026-04-16 09:00:46.354452 | noble | ok 2026-04-16 09:00:46.369470 | 2026-04-16 09:00:46.369643 | TASK [validate-host : Write out all zuul information for each host] 2026-04-16 09:00:47.268415 | noble -> localhost | changed 2026-04-16 09:00:47.282879 | 2026-04-16 09:00:47.283002 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-16 09:00:47.605384 | noble | ok 2026-04-16 09:00:47.611825 | 2026-04-16 09:00:47.611951 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-16 09:00:48.532787 | noble | changed: 2026-04-16 09:00:48.533072 | noble | cd+++++++++ src/ 2026-04-16 09:00:48.533113 | noble | cd+++++++++ src/github.com/ 2026-04-16 09:00:48.533140 | noble | cd+++++++++ src/github.com/osism/ 2026-04-16 09:00:48.533164 | noble | cd+++++++++ src/github.com/osism/openstack-ironic-images/ 2026-04-16 09:00:48.533186 | noble | localhost | ok: "/var/lib/zuul/builds/f654b45474184306bea4b886224603d5/work/logs" 2026-04-16 09:06:39.362012 | noble -> localhost | changed: "/var/lib/zuul/builds/f654b45474184306bea4b886224603d5/work/artifacts" 2026-04-16 09:06:39.640206 | noble -> localhost | changed: "/var/lib/zuul/builds/f654b45474184306bea4b886224603d5/work/docs" 2026-04-16 09:06:39.658351 | 2026-04-16 09:06:39.658565 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-16 09:06:41.040978 | noble | changed: 2026-04-16 09:06:41.041425 | noble | .d..t...... ./ 2026-04-16 09:06:41.041489 | noble | >f+++++++++ osism-vyos.log 2026-04-16 09:06:41.041557 | noble | changed: All items complete 2026-04-16 09:06:41.041590 | 2026-04-16 09:06:42.002539 | noble | changed: .d..t...... ./ 2026-04-16 09:06:42.960388 | noble | changed: .d..t...... ./ 2026-04-16 09:06:42.996415 | 2026-04-16 09:06:42.996554 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-16 09:06:43.857838 | noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.020840 2026-04-16 09:06:44.705007 | noble -> localhost | ok: Item: docs Runtime: 0:00:00.018301 2026-04-16 09:06:44.718646 | 2026-04-16 09:06:44.718797 | PLAY RECAP 2026-04-16 09:06:44.719220 | noble | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-16 09:06:44.719277 | 2026-04-16 09:06:44.901969 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-04-16 09:06:44.903053 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-16 09:06:45.978978 | 2026-04-16 09:06:45.979154 | PLAY [Base post] 2026-04-16 09:06:46.013700 | 2026-04-16 09:06:46.013903 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-16 09:06:46.603005 | noble | changed 2026-04-16 09:06:46.620686 | 2026-04-16 09:06:46.620849 | PLAY RECAP 2026-04-16 09:06:46.620917 | noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-16 09:06:46.620981 | 2026-04-16 09:06:46.796695 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-16 09:06:46.797619 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-16 09:06:47.847794 | 2026-04-16 09:06:47.847995 | PLAY [Base post-logs] 2026-04-16 09:06:47.869640 | 2026-04-16 09:06:47.869917 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-16 09:06:48.429373 | localhost | changed 2026-04-16 09:06:48.445854 | 2026-04-16 09:06:48.446031 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-16 09:06:48.485095 | localhost | ok 2026-04-16 09:06:48.488515 | 2026-04-16 09:06:48.488628 | TASK [Set zuul-log-path fact] 2026-04-16 09:06:48.506283 | localhost | ok 2026-04-16 09:06:48.526336 | 2026-04-16 09:06:48.526616 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-16 09:06:48.560668 | localhost | ok 2026-04-16 09:06:48.568116 | 2026-04-16 09:06:48.568503 | TASK [upload-logs : Create log directories] 2026-04-16 09:06:49.163177 | localhost | changed 2026-04-16 09:06:49.166005 | 2026-04-16 09:06:49.166110 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-16 09:06:49.752160 | localhost -> localhost | ok: Runtime: 0:00:00.014231 2026-04-16 09:06:49.757380 | 2026-04-16 09:06:49.757506 | TASK [upload-logs : Upload logs to log server] 2026-04-16 09:06:50.401644 | localhost | Output suppressed because no_log was given 2026-04-16 09:06:50.404209 | 2026-04-16 09:06:50.404330 | LOOP [upload-logs : Compress console log and json output] 2026-04-16 09:06:50.468508 | localhost | skipping: Conditional result was False 2026-04-16 09:06:50.476245 | localhost | skipping: Conditional result was False 2026-04-16 09:06:50.482692 | 2026-04-16 09:06:50.482862 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-16 09:06:50.539440 | localhost | skipping: Conditional result was False 2026-04-16 09:06:50.540919 | 2026-04-16 09:06:50.546068 | localhost | skipping: Conditional result was False 2026-04-16 09:06:50.552463 | 2026-04-16 09:06:50.552581 | LOOP [upload-logs : Upload console log and json output]