2026-05-08 07:51:49.724903 | Job console starting 2026-05-08 07:51:49.745718 | Updating git repos 2026-05-08 07:51:49.797066 | Cloning repos into workspace 2026-05-08 07:51:49.902672 | Restoring repo states 2026-05-08 07:51:49.916137 | Merging changes 2026-05-08 07:51:50.557592 | Checking out repos 2026-05-08 07:51:50.619485 | Preparing playbooks 2026-05-08 07:51:51.540642 | Running Ansible setup 2026-05-08 07:51:56.318718 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-08 07:51:57.096792 | 2026-05-08 07:51:57.096965 | PLAY [Base pre] 2026-05-08 07:51:57.114908 | 2026-05-08 07:51:57.115063 | TASK [Setup log path fact] 2026-05-08 07:51:57.165206 | debian-bookworm | ok 2026-05-08 07:51:57.182688 | 2026-05-08 07:51:57.182880 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 07:51:57.213044 | debian-bookworm | ok 2026-05-08 07:51:57.226257 | 2026-05-08 07:51:57.226388 | TASK [emit-job-header : Print job information] 2026-05-08 07:51:57.266536 | # Job Information 2026-05-08 07:51:57.266884 | Ansible Version: 2.16.14 2026-05-08 07:51:57.266932 | Job: flake8 2026-05-08 07:51:57.266968 | Pipeline: check 2026-05-08 07:51:57.266992 | Executor: 521e9411259a 2026-05-08 07:51:57.267014 | Triggered by: https://github.com/osism/testbed/pull/2889 2026-05-08 07:51:57.267037 | Event ID: bfaf0af0-4ab2-11f1-96d6-b9656d5aaf89 2026-05-08 07:51:57.272642 | 2026-05-08 07:51:57.272767 | LOOP [emit-job-header : Print node information] 2026-05-08 07:51:57.453537 | debian-bookworm | ok: 2026-05-08 07:51:57.453839 | debian-bookworm | # Node Information 2026-05-08 07:51:57.453877 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-08 07:51:57.453903 | debian-bookworm | Hostname: debian 2026-05-08 07:51:57.453926 | debian-bookworm | Username: zuul 2026-05-08 07:51:57.453948 | debian-bookworm | Distro: Debian 12.13 2026-05-08 07:51:57.453972 | debian-bookworm | Provider: regiocloud-a 2026-05-08 07:51:57.453993 | debian-bookworm | Region: 2026-05-08 07:51:57.454015 | debian-bookworm | Label: debian-bookworm 2026-05-08 07:51:57.454035 | debian-bookworm | Product Name: OpenStack Nova 2026-05-08 07:51:57.454055 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec2:58e0 2026-05-08 07:51:57.476523 | 2026-05-08 07:51:57.476667 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-08 07:51:58.030989 | debian-bookworm -> localhost | changed 2026-05-08 07:51:58.046228 | 2026-05-08 07:51:58.046410 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-08 07:51:59.267943 | debian-bookworm -> localhost | changed 2026-05-08 07:51:59.285583 | 2026-05-08 07:51:59.285848 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-08 07:51:59.629383 | debian-bookworm -> localhost | ok 2026-05-08 07:51:59.640754 | 2026-05-08 07:51:59.640883 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-08 07:51:59.677053 | debian-bookworm | ok 2026-05-08 07:51:59.695013 | debian-bookworm | included: /var/lib/zuul/builds/96100dc837ad4f6692d991b32076b9fb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-08 07:51:59.701907 | 2026-05-08 07:51:59.702017 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-08 07:52:01.746339 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-08 07:52:01.746626 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/96100dc837ad4f6692d991b32076b9fb/work/96100dc837ad4f6692d991b32076b9fb_id_rsa 2026-05-08 07:52:01.746664 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/96100dc837ad4f6692d991b32076b9fb/work/96100dc837ad4f6692d991b32076b9fb_id_rsa.pub 2026-05-08 07:52:01.746692 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-08 07:52:01.746717 | debian-bookworm -> localhost | SHA256:pJDSMpin63B9JPkY6uwGEa1qbOHaUYx4rw0J7RfOxJ0 zuul-build-sshkey 2026-05-08 07:52:01.746740 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-08 07:52:01.746777 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-08 07:52:01.746800 | debian-bookworm -> localhost | | . | 2026-05-08 07:52:01.746822 | debian-bookworm -> localhost | |.o.. . | 2026-05-08 07:52:01.746874 | debian-bookworm -> localhost | |o==++. .. | 2026-05-08 07:52:01.746898 | debian-bookworm -> localhost | |=+++*oEo | 2026-05-08 07:52:01.746919 | debian-bookworm -> localhost | |==.B+.o S | 2026-05-08 07:52:01.746944 | debian-bookworm -> localhost | |o*=o=* | 2026-05-08 07:52:01.746966 | debian-bookworm -> localhost | |*oo*o o | 2026-05-08 07:52:01.746987 | debian-bookworm -> localhost | |+++ .. | 2026-05-08 07:52:01.747008 | debian-bookworm -> localhost | | ++ | 2026-05-08 07:52:01.747029 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-08 07:52:01.747087 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.503757 2026-05-08 07:52:01.754021 | 2026-05-08 07:52:01.754173 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-08 07:52:01.783976 | debian-bookworm | ok 2026-05-08 07:52:01.793860 | debian-bookworm | included: /var/lib/zuul/builds/96100dc837ad4f6692d991b32076b9fb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-08 07:52:01.804229 | 2026-05-08 07:52:01.804364 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-08 07:52:01.828892 | debian-bookworm | skipping: Conditional result was False 2026-05-08 07:52:01.835290 | 2026-05-08 07:52:01.835418 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-08 07:52:02.518209 | debian-bookworm | changed 2026-05-08 07:52:02.524244 | 2026-05-08 07:52:02.524363 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-08 07:52:02.803084 | debian-bookworm | ok 2026-05-08 07:52:02.809086 | 2026-05-08 07:52:02.809226 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-08 07:52:03.525941 | debian-bookworm | changed 2026-05-08 07:52:03.538943 | 2026-05-08 07:52:03.539215 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-08 07:52:04.303305 | debian-bookworm | changed 2026-05-08 07:52:04.310618 | 2026-05-08 07:52:04.310764 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-08 07:52:04.346054 | debian-bookworm | skipping: Conditional result was False 2026-05-08 07:52:04.361199 | 2026-05-08 07:52:04.361425 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-08 07:52:04.897479 | debian-bookworm -> localhost | changed 2026-05-08 07:52:04.913913 | 2026-05-08 07:52:04.914067 | TASK [add-build-sshkey : Add back temp key] 2026-05-08 07:52:05.321220 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/96100dc837ad4f6692d991b32076b9fb/work/96100dc837ad4f6692d991b32076b9fb_id_rsa (zuul-build-sshkey) 2026-05-08 07:52:05.321553 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013455 2026-05-08 07:52:05.333603 | 2026-05-08 07:52:05.333816 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-08 07:52:05.878344 | debian-bookworm | ok 2026-05-08 07:52:05.885253 | 2026-05-08 07:52:05.885406 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-08 07:52:05.912201 | debian-bookworm | skipping: Conditional result was False 2026-05-08 07:52:05.925257 | 2026-05-08 07:52:05.925408 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-08 07:52:06.425903 | debian-bookworm | ok 2026-05-08 07:52:06.437836 | 2026-05-08 07:52:06.438011 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-08 07:52:06.470649 | debian-bookworm | ok 2026-05-08 07:52:06.480216 | 2026-05-08 07:52:06.480387 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-08 07:52:06.799135 | debian-bookworm -> localhost | ok 2026-05-08 07:52:06.807631 | 2026-05-08 07:52:06.807790 | TASK [validate-host : Collect information about the host] 2026-05-08 07:52:08.066127 | debian-bookworm | ok 2026-05-08 07:52:08.090714 | 2026-05-08 07:52:08.090975 | TASK [validate-host : Sanitize hostname] 2026-05-08 07:52:08.306158 | debian-bookworm | ok 2026-05-08 07:52:08.359173 | 2026-05-08 07:52:08.359321 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-08 07:52:08.985440 | debian-bookworm -> localhost | changed 2026-05-08 07:52:08.996401 | 2026-05-08 07:52:08.996626 | TASK [validate-host : Collect information about zuul worker] 2026-05-08 07:52:09.438514 | debian-bookworm | ok 2026-05-08 07:52:09.443661 | 2026-05-08 07:52:09.443791 | TASK [validate-host : Write out all zuul information for each host] 2026-05-08 07:52:10.102506 | debian-bookworm -> localhost | changed 2026-05-08 07:52:10.115910 | 2026-05-08 07:52:10.116160 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-08 07:52:10.424045 | debian-bookworm | ok 2026-05-08 07:52:10.433439 | 2026-05-08 07:52:10.433610 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-08 07:52:11.608309 | debian-bookworm | changed: 2026-05-08 07:52:11.608587 | debian-bookworm | cd+++++++++ src/ 2026-05-08 07:52:11.608638 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-08 07:52:11.608672 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-08 07:52:11.608703 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-05-08 07:52:11.608732 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/96100dc837ad4f6692d991b32076b9fb/work/logs" 2026-05-08 07:52:37.756622 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/96100dc837ad4f6692d991b32076b9fb/work/artifacts" 2026-05-08 07:52:38.065182 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/96100dc837ad4f6692d991b32076b9fb/work/docs" 2026-05-08 07:52:38.083306 | 2026-05-08 07:52:38.083484 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-08 07:52:38.840052 | debian-bookworm | changed: 2026-05-08 07:52:38.840318 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-08 07:52:38.840362 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-08 07:52:38.840401 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-08 07:52:38.840458 | debian-bookworm | changed: All items complete 2026-05-08 07:52:38.840493 | 2026-05-08 07:52:39.428452 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 07:52:40.020501 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 07:52:40.044487 | 2026-05-08 07:52:40.044750 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-08 07:52:40.612750 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007582 2026-05-08 07:52:40.947911 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010622 2026-05-08 07:52:40.963472 | 2026-05-08 07:52:40.963613 | PLAY RECAP 2026-05-08 07:52:40.963677 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-08 07:52:40.963701 | 2026-05-08 07:52:41.133858 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-08 07:52:41.135780 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 07:52:41.919371 | 2026-05-08 07:52:41.919556 | PLAY [Base post] 2026-05-08 07:52:41.933558 | 2026-05-08 07:52:41.933701 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-08 07:52:42.515086 | debian-bookworm | changed 2026-05-08 07:52:42.533151 | 2026-05-08 07:52:42.533332 | PLAY RECAP 2026-05-08 07:52:42.533431 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-08 07:52:42.533534 | 2026-05-08 07:52:42.677703 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 07:52:42.679619 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-08 07:52:43.523128 | 2026-05-08 07:52:43.523312 | PLAY [Base post-logs] 2026-05-08 07:52:43.534474 | 2026-05-08 07:52:43.534629 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-08 07:52:44.028486 | localhost | changed 2026-05-08 07:52:44.039436 | 2026-05-08 07:52:44.039599 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-08 07:52:44.070770 | localhost | ok 2026-05-08 07:52:44.076915 | 2026-05-08 07:52:44.077039 | TASK [Set zuul-log-path fact] 2026-05-08 07:52:44.096996 | localhost | ok 2026-05-08 07:52:44.110495 | 2026-05-08 07:52:44.110658 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 07:52:44.136889 | localhost | ok 2026-05-08 07:52:44.140798 | 2026-05-08 07:52:44.140918 | TASK [upload-logs : Create log directories] 2026-05-08 07:52:44.665272 | localhost | changed 2026-05-08 07:52:44.668597 | 2026-05-08 07:52:44.668714 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-08 07:52:45.222898 | localhost -> localhost | ok: Runtime: 0:00:00.009133 2026-05-08 07:52:45.227307 | 2026-05-08 07:52:45.227428 | TASK [upload-logs : Upload logs to log server] 2026-05-08 07:52:45.786541 | localhost | Output suppressed because no_log was given 2026-05-08 07:52:45.790030 | 2026-05-08 07:52:45.790253 | LOOP [upload-logs : Compress console log and json output] 2026-05-08 07:52:45.860088 | localhost | skipping: Conditional result was False 2026-05-08 07:52:45.867273 | localhost | skipping: Conditional result was False 2026-05-08 07:52:45.874275 | 2026-05-08 07:52:45.874463 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-08 07:52:45.929023 | localhost | skipping: Conditional result was False 2026-05-08 07:52:45.929382 | 2026-05-08 07:52:45.934518 | localhost | skipping: Conditional result was False 2026-05-08 07:52:45.943073 | 2026-05-08 07:52:45.943415 | LOOP [upload-logs : Upload console log and json output]