2026-06-10 13:16:23.837174 | Job console starting
2026-06-10 13:16:23.944281 | Updating git repos
2026-06-10 13:16:24.674841 | Cloning repos into workspace
2026-06-10 13:16:26.991333 | Restoring repo states
2026-06-10 13:16:27.014764 | Merging changes
2026-06-10 13:16:28.097279 | Checking out repos
2026-06-10 13:16:28.912867 | Preparing playbooks
2026-06-10 13:16:33.529778 | Running Ansible setup
2026-06-10 13:16:45.544170 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-06-10 13:16:46.132761 | 
2026-06-10 13:16:46.132890 | PLAY [localhost]
2026-06-10 13:16:46.140503 | 
2026-06-10 13:16:46.140573 | TASK [Gathering Facts]
2026-06-10 13:16:48.197218 | localhost | ok
2026-06-10 13:16:48.206188 | 
2026-06-10 13:16:48.206299 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-10 13:16:48.663965 | localhost -> localhost | changed
2026-06-10 13:16:48.673238 | 
2026-06-10 13:16:48.673388 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-10 13:16:49.718462 | localhost -> localhost | changed
2026-06-10 13:16:49.732440 | 
2026-06-10 13:16:49.732721 | TASK [Setup log path fact]
2026-06-10 13:16:49.756988 | localhost | ok
2026-06-10 13:16:49.776491 | 
2026-06-10 13:16:49.776638 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-10 13:16:49.818690 | localhost | ok
2026-06-10 13:16:49.831492 | 
2026-06-10 13:16:49.831812 | TASK [emit-job-header : Print job information]
2026-06-10 13:16:49.908691 | # Job Information
2026-06-10 13:16:49.909031 | Ansible Version: 2.16.18
2026-06-10 13:16:49.909096 | Job: edpm-ansible-molecule-edpm_frr
2026-06-10 13:16:49.909141 | Pipeline: github-check
2026-06-10 13:16:49.909181 | Executor: 38.129.56.84
2026-06-10 13:16:49.909220 | Triggered by: https://github.com/openstack-k8s-operators/edpm-ansible/pull/1188
2026-06-10 13:16:49.909267 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/25e/rdoproject.org/25eb16df8eda45028d472ebbf6cc8aa3/
2026-06-10 13:16:49.909308 | Event ID: 64c811f0-64ce-11f1-9c16-e28ccd763d97
2026-06-10 13:16:49.915677 | 
2026-06-10 13:16:49.915824 | LOOP [emit-job-header : Print node information]
2026-06-10 13:16:50.024046 | localhost | ok:
2026-06-10 13:16:50.024523 | localhost | # Node Information
2026-06-10 13:16:50.024591 | localhost | Inventory Hostname: controller
2026-06-10 13:16:50.024644 | localhost | Hostname: np0000069751
2026-06-10 13:16:50.024686 | localhost | Username: zuul
2026-06-10 13:16:50.024729 | localhost | Distro: CentOS 9
2026-06-10 13:16:50.024766 | localhost | Provider: vexxhost-nodepool-tripleo
2026-06-10 13:16:50.024802 | localhost | Region: RegionOne
2026-06-10 13:16:50.024837 | localhost | Label: cloud-centos-9-stream-tripleo
2026-06-10 13:16:50.024915 | localhost | Product Name: OpenStack Nova
2026-06-10 13:16:50.024953 | localhost | Interface IP: 38.102.83.50
2026-06-10 13:16:50.044889 | 
2026-06-10 13:16:50.045063 | PLAY [all]
2026-06-10 13:16:50.056495 | 
2026-06-10 13:16:50.056626 | TASK [Gather network facts]
2026-06-10 13:16:50.532629 | controller | ok
2026-06-10 13:16:50.546677 | 
2026-06-10 13:16:50.546832 | TASK [include_role : start-zuul-console]
2026-06-10 13:16:50.583703 | controller | ok
2026-06-10 13:16:50.604377 | 
2026-06-10 13:16:50.604527 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-06-10 13:16:51.057074 | controller | ok
2026-06-10 13:16:51.070743 | 
2026-06-10 13:16:51.070960 | TASK [include_role : add-build-sshkey]
2026-06-10 13:16:51.105605 | controller | ok
2026-06-10 13:16:51.127715 | 
2026-06-10 13:16:51.127945 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-10 13:16:51.458364 | controller -> localhost | ok
2026-06-10 13:16:51.467691 | 
2026-06-10 13:16:51.467841 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-10 13:16:51.512139 | controller | ok
2026-06-10 13:16:51.540657 | controller | included: /var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-10 13:16:51.548884 | 
2026-06-10 13:16:51.548966 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-10 13:16:52.363057 | controller -> localhost | Generating public/private rsa key pair.
2026-06-10 13:16:52.363431 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/25eb16df8eda45028d472ebbf6cc8aa3_id_rsa
2026-06-10 13:16:52.363515 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/25eb16df8eda45028d472ebbf6cc8aa3_id_rsa.pub
2026-06-10 13:16:52.363582 | controller -> localhost | The key fingerprint is:
2026-06-10 13:16:52.363633 | controller -> localhost | SHA256:dZWUXnY9qfDo62l5P6DI+nKnKSw03QurzWV0mTnUeTM zuul-build-sshkey
2026-06-10 13:16:52.363675 | controller -> localhost | The key's randomart image is:
2026-06-10 13:16:52.363714 | controller -> localhost | +---[RSA 3072]----+
2026-06-10 13:16:52.363753 | controller -> localhost | |             .ooo|
2026-06-10 13:16:52.363792 | controller -> localhost | |           ...+o=|
2026-06-10 13:16:52.363831 | controller -> localhost | |          ..=+.Eo|
2026-06-10 13:16:52.363917 | controller -> localhost | |         ..o+oo o|
2026-06-10 13:16:52.363963 | controller -> localhost | |      . S..*     |
2026-06-10 13:16:52.364001 | controller -> localhost | |     o o......   |
2026-06-10 13:16:52.364039 | controller -> localhost | |    . o +oo + .  |
2026-06-10 13:16:52.364080 | controller -> localhost | |     .o=o=.*.. . |
2026-06-10 13:16:52.364120 | controller -> localhost | |     .o+*+=o. ...|
2026-06-10 13:16:52.364158 | controller -> localhost | +----[SHA256]-----+
2026-06-10 13:16:52.364272 | controller -> localhost | ok: Runtime: 0:00:00.261376
2026-06-10 13:16:52.372437 | 
2026-06-10 13:16:52.372582 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-10 13:16:52.407388 | controller | ok
2026-06-10 13:16:52.425135 | controller | included: /var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-10 13:16:52.439676 | 
2026-06-10 13:16:52.439788 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-10 13:16:52.465910 | controller | skipping: Conditional result was False
2026-06-10 13:16:52.472500 | 
2026-06-10 13:16:52.472598 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-10 13:16:52.940807 | controller | changed
2026-06-10 13:16:52.948225 | 
2026-06-10 13:16:52.948357 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-10 13:16:53.193433 | controller | ok
2026-06-10 13:16:53.200918 | 
2026-06-10 13:16:53.201051 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-10 13:16:53.943981 | controller | changed
2026-06-10 13:16:53.951311 | 
2026-06-10 13:16:53.951443 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-10 13:16:54.694083 | controller | changed
2026-06-10 13:16:54.702015 | 
2026-06-10 13:16:54.702148 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-10 13:16:54.739237 | controller | skipping: Conditional result was False
2026-06-10 13:16:54.748223 | 
2026-06-10 13:16:54.748417 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-10 13:16:55.231233 | controller -> localhost | changed
2026-06-10 13:16:55.246980 | 
2026-06-10 13:16:55.247175 | TASK [add-build-sshkey : Add back temp key]
2026-06-10 13:16:55.605600 | controller -> localhost | Identity added: /var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/25eb16df8eda45028d472ebbf6cc8aa3_id_rsa (zuul-build-sshkey)
2026-06-10 13:16:55.606058 | controller -> localhost | ok: Runtime: 0:00:00.012248
2026-06-10 13:16:55.615996 | 
2026-06-10 13:16:55.616132 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-10 13:16:56.015284 | controller | ok
2026-06-10 13:16:56.023000 | 
2026-06-10 13:16:56.023175 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-10 13:16:56.060521 | controller | skipping: Conditional result was False
2026-06-10 13:16:56.075282 | 
2026-06-10 13:16:56.075425 | TASK [include_role : validate-host]
2026-06-10 13:16:56.110359 | controller | ok
2026-06-10 13:16:56.144595 | 
2026-06-10 13:16:56.144696 | TASK [validate-host : Define zuul_info_dir fact]
2026-06-10 13:16:56.186010 | controller | ok
2026-06-10 13:16:56.192792 | 
2026-06-10 13:16:56.192952 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-06-10 13:16:56.493296 | controller -> localhost | ok
2026-06-10 13:16:56.502732 | 
2026-06-10 13:16:56.502895 | TASK [validate-host : Collect information about the host]
2026-06-10 13:16:57.148903 | controller | ok
2026-06-10 13:16:57.165991 | 
2026-06-10 13:16:57.166170 | TASK [validate-host : Sanitize hostname]
2026-06-10 13:16:57.250214 | controller | ok
2026-06-10 13:16:57.257761 | 
2026-06-10 13:16:57.257976 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-06-10 13:16:57.823724 | controller -> localhost | changed
2026-06-10 13:16:57.838656 | 
2026-06-10 13:16:57.838839 | TASK [validate-host : Collect information about zuul worker]
2026-06-10 13:16:58.336831 | controller | ok
2026-06-10 13:16:58.344709 | 
2026-06-10 13:16:58.344872 | TASK [validate-host : Write out all zuul information for each host]
2026-06-10 13:16:58.897505 | controller -> localhost | changed
2026-06-10 13:16:58.911668 | 
2026-06-10 13:16:58.911879 | TASK [include_role : prepare-workspace-openshift]
2026-06-10 13:16:58.938344 | controller | skipping: Conditional result was False
2026-06-10 13:16:58.947110 | 
2026-06-10 13:16:58.947236 | TASK [include_role : remove-zuul-sshkey]
2026-06-10 13:16:58.973743 | controller | skipping: Conditional result was False
2026-06-10 13:16:58.982992 | 
2026-06-10 13:16:58.983132 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-10 13:16:59.222150 | controller | ok: "logs"
2026-06-10 13:16:59.222643 | controller | ok: All items complete
2026-06-10 13:16:59.222708 | 
2026-06-10 13:16:59.406200 | controller | ok: "artifacts"
2026-06-10 13:16:59.604727 | controller | ok: "docs"
2026-06-10 13:16:59.620016 | 
2026-06-10 13:16:59.620182 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-10 13:16:59.923239 | controller | changed: "logs"
2026-06-10 13:17:00.125807 | controller | changed: "artifacts"
2026-06-10 13:17:00.325228 | controller | changed: "docs"
2026-06-10 13:17:00.339290 | 
2026-06-10 13:17:00.339401 | PLAY RECAP
2026-06-10 13:17:00.339488 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-10 13:17:00.339545 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-10 13:17:00.339585 | 
2026-06-10 13:17:00.474264 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-06-10 13:17:00.476598 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-06-10 13:17:01.124420 | 
2026-06-10 13:17:01.124527 | PLAY [all]
2026-06-10 13:17:01.134385 | 
2026-06-10 13:17:01.134456 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-06-10 13:17:01.213504 | controller | ok
2026-06-10 13:17:01.218423 | 
2026-06-10 13:17:01.218523 | TASK [mirror-info-fork : Create /etc/ci]
2026-06-10 13:17:01.687805 | controller | changed
2026-06-10 13:17:01.697617 | 
2026-06-10 13:17:01.697811 | TASK [mirror-info-fork : Install ci_mirror script]
2026-06-10 13:17:02.755188 | controller | changed
2026-06-10 13:17:02.765453 | 
2026-06-10 13:17:02.765569 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2026-06-10 13:17:03.300895 | controller | changed:
2026-06-10 13:17:03.301409 | controller | {
2026-06-10 13:17:03.301473 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2026-06-10 13:17:03.301540 | controller | }
2026-06-10 13:17:03.527234 | controller | changed:
2026-06-10 13:17:03.527389 | controller | {
2026-06-10 13:17:03.527443 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2026-06-10 13:17:03.527486 | controller | }
2026-06-10 13:17:03.774945 | controller | changed:
2026-06-10 13:17:03.775087 | controller | {
2026-06-10 13:17:03.775111 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2026-06-10 13:17:03.775129 | controller | }
2026-06-10 13:17:04.023678 | controller | changed:
2026-06-10 13:17:04.023839 | controller | {
2026-06-10 13:17:04.023928 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2026-06-10 13:17:04.023971 | controller | }
2026-06-10 13:17:04.265887 | controller | changed:
2026-06-10 13:17:04.266141 | controller | {
2026-06-10 13:17:04.266203 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2026-06-10 13:17:04.266244 | controller | }
2026-06-10 13:17:04.507547 | controller | changed:
2026-06-10 13:17:04.507711 | controller | {
2026-06-10 13:17:04.507763 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2026-06-10 13:17:04.507803 | controller | }
2026-06-10 13:17:04.800374 | controller | changed:
2026-06-10 13:17:04.800540 | controller | {
2026-06-10 13:17:04.800590 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen"
2026-06-10 13:17:04.800630 | controller | }
2026-06-10 13:17:05.045899 | controller | changed:
2026-06-10 13:17:05.046061 | controller | {
2026-06-10 13:17:05.046113 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora"
2026-06-10 13:17:05.046169 | controller | }
2026-06-10 13:17:05.291684 | controller | changed:
2026-06-10 13:17:05.291831 | controller | {
2026-06-10 13:17:05.291913 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2026-06-10 13:17:05.291955 | controller | }
2026-06-10 13:17:05.549212 | controller | changed:
2026-06-10 13:17:05.549541 | controller | {
2026-06-10 13:17:05.549605 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2026-06-10 13:17:05.549650 | controller | }
2026-06-10 13:17:05.786580 | controller | changed:
2026-06-10 13:17:05.786745 | controller | {
2026-06-10 13:17:05.786795 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2026-06-10 13:17:05.786834 | controller | }
2026-06-10 13:17:06.018275 | controller | changed:
2026-06-10 13:17:06.018536 | controller | {
2026-06-10 13:17:06.018608 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2026-06-10 13:17:06.018656 | controller | }
2026-06-10 13:17:06.262308 | controller | changed:
2026-06-10 13:17:06.262532 | controller | {
2026-06-10 13:17:06.262592 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com"
2026-06-10 13:17:06.262634 | controller | }
2026-06-10 13:17:06.550504 | controller | changed:
2026-06-10 13:17:06.550659 | controller | {
2026-06-10 13:17:06.550710 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2026-06-10 13:17:06.550751 | controller | }
2026-06-10 13:17:06.761239 | controller | changed:
2026-06-10 13:17:06.761442 | controller | {
2026-06-10 13:17:06.761506 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2026-06-10 13:17:06.761556 | controller | }
2026-06-10 13:17:07.001480 | controller | changed:
2026-06-10 13:17:07.001617 | controller | {
2026-06-10 13:17:07.001667 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2026-06-10 13:17:07.001708 | controller | }
2026-06-10 13:17:07.244934 | controller | changed:
2026-06-10 13:17:07.245147 | controller | {
2026-06-10 13:17:07.245199 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com"
2026-06-10 13:17:07.245241 | controller | }
2026-06-10 13:17:07.499666 | controller | changed:
2026-06-10 13:17:07.499802 | controller | {
2026-06-10 13:17:07.499886 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb"
2026-06-10 13:17:07.499953 | controller | }
2026-06-10 13:17:07.738091 | controller | changed:
2026-06-10 13:17:07.738231 | controller | {
2026-06-10 13:17:07.738288 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2026-06-10 13:17:07.738341 | controller | }
2026-06-10 13:17:08.049491 | controller | changed:
2026-06-10 13:17:08.049654 | controller | {
2026-06-10 13:17:08.049708 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2026-06-10 13:17:08.049753 | controller | }
2026-06-10 13:17:08.294085 | controller | changed:
2026-06-10 13:17:08.294294 | controller | {
2026-06-10 13:17:08.294345 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2026-06-10 13:17:08.294386 | controller | }
2026-06-10 13:17:08.519765 | controller | changed:
2026-06-10 13:17:08.519949 | controller | {
2026-06-10 13:17:08.520000 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2026-06-10 13:17:08.520040 | controller | }
2026-06-10 13:17:08.761497 | controller | changed:
2026-06-10 13:17:08.761694 | controller | {
2026-06-10 13:17:08.761761 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com"
2026-06-10 13:17:08.761812 | controller | }
2026-06-10 13:17:09.030932 | controller | changed:
2026-06-10 13:17:09.031094 | controller | {
2026-06-10 13:17:09.031142 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2026-06-10 13:17:09.031182 | controller | }
2026-06-10 13:17:09.277444 | controller | changed:
2026-06-10 13:17:09.277601 | controller | {
2026-06-10 13:17:09.277649 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2026-06-10 13:17:09.277688 | controller | }
2026-06-10 13:17:09.499549 | controller | changed:
2026-06-10 13:17:09.499775 | controller | {
2026-06-10 13:17:09.499831 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2026-06-10 13:17:09.499905 | controller | }
2026-06-10 13:17:09.534214 | 
2026-06-10 13:17:09.534402 | TASK [Set timezone to UTC]
2026-06-10 13:17:10.097389 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2026-06-10 13:17:10.106186 | 
2026-06-10 13:17:10.106346 | TASK [Create nodepool directory]
2026-06-10 13:17:10.403748 | controller | changed
2026-06-10 13:17:10.410334 | 
2026-06-10 13:17:10.410456 | TASK [Create nodepool sub_nodes file]
2026-06-10 13:17:11.173641 | controller | changed
2026-06-10 13:17:11.181203 | 
2026-06-10 13:17:11.181544 | TASK [Create nodepool sub_nodes_private file]
2026-06-10 13:17:11.885802 | controller | changed
2026-06-10 13:17:11.893521 | 
2026-06-10 13:17:11.893644 | LOOP [Populate nodepool sub_nodes file]
2026-06-10 13:17:11.941130 | 
2026-06-10 13:17:11.941436 | LOOP [Populate nodepool sub_nodes_private file]
2026-06-10 13:17:11.985238 | 
2026-06-10 13:17:11.985485 | TASK [Create nodepool primary file]
2026-06-10 13:17:12.021429 | controller | skipping: Conditional result was False
2026-06-10 13:17:12.029615 | 
2026-06-10 13:17:12.029745 | TASK [Create nodepool node_private for this node]
2026-06-10 13:17:12.740872 | controller | changed
2026-06-10 13:17:12.745842 | 
2026-06-10 13:17:12.746068 | LOOP [Copy ssh keys to nodepool directory]
2026-06-10 13:17:13.160051 | controller | ok: Item: id_rsa Runtime: 0:00:00.005278
2026-06-10 13:17:13.174244 | 
2026-06-10 13:17:13.372662 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.003479
2026-06-10 13:17:13.389365 | 
2026-06-10 13:17:13.389539 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2026-06-10 13:17:14.063659 | controller | changed
2026-06-10 13:17:14.071164 | 
2026-06-10 13:17:14.071329 | TASK [Validate sudoers config after edits]
2026-06-10 13:17:14.361640 | controller | /etc/sudoers: parsed OK
2026-06-10 13:17:14.361714 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2026-06-10 13:17:14.361738 | controller | /etc/sudoers.d/zuul: parsed OK
2026-06-10 13:17:14.361754 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2026-06-10 13:17:14.618756 | controller | ok: Runtime: 0:00:00.007558
2026-06-10 13:17:14.626893 | 
2026-06-10 13:17:14.627054 | TASK [Show the environment passed in to job shell scripts]
2026-06-10 13:17:14.905678 | controller | SHELL=/bin/bash
2026-06-10 13:17:14.905783 | controller | ZUUL_PROJECT=openstack-k8s-operators/edpm-ansible
2026-06-10 13:17:14.905794 | controller | ZUUL_SHORT_PROJECT_NAME=edpm-ansible
2026-06-10 13:17:14.905804 | controller | ZUUL_CHANGES=openstack-k8s-operators/edpm-ansible:main:refs/changes/88/1188/38484009bd61ab2f31ba8b1a9e562b434578f8d3
2026-06-10 13:17:14.905811 | controller | PWD=/home/zuul
2026-06-10 13:17:14.905817 | controller | ZUUL_PIPELINE=github-check
2026-06-10 13:17:14.905826 | controller | LOGNAME=zuul
2026-06-10 13:17:14.905832 | controller | XDG_SESSION_TYPE=tty
2026-06-10 13:17:14.905837 | controller | _=/usr/bin/env
2026-06-10 13:17:14.905846 | controller | MOTD_SHOWN=pam
2026-06-10 13:17:14.905851 | controller | HOME=/home/zuul
2026-06-10 13:17:14.905856 | controller | LANG=en_US.UTF-8
2026-06-10 13:17:14.905862 | controller | SSH_CONNECTION=38.129.56.84 36770 38.102.83.50 22
2026-06-10 13:17:14.905870 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET
2026-06-10 13:17:14.905877 | controller | ZUUL_CHANGE_IDS=1188,38484009bd61ab2f31ba8b1a9e562b434578f8d3
2026-06-10 13:17:14.905882 | controller | WORKSPACE=/home/zuul/workspace
2026-06-10 13:17:14.905888 | controller | XDG_SESSION_CLASS=user
2026-06-10 13:17:14.905893 | controller | SELINUX_ROLE_REQUESTED=
2026-06-10 13:17:14.905898 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2026-06-10 13:17:14.905904 | controller | USER=zuul
2026-06-10 13:17:14.905909 | controller | ZUUL_VOTING=True
2026-06-10 13:17:14.905914 | controller | BUILD_TIMEOUT=1800000
2026-06-10 13:17:14.905919 | controller | SELINUX_USE_CURRENT_RANGE=
2026-06-10 13:17:14.905924 | controller | SHLVL=1
2026-06-10 13:17:14.905930 | controller | ZUUL_PATCHSET=38484009bd61ab2f31ba8b1a9e562b434578f8d3
2026-06-10 13:17:14.905937 | controller | XDG_SESSION_ID=1
2026-06-10 13:17:14.905944 | controller | ZUUL_BRANCH=main
2026-06-10 13:17:14.905952 | controller | XDG_RUNTIME_DIR=/run/user/1000
2026-06-10 13:17:14.905959 | controller | SSH_CLIENT=38.129.56.84 36770 22
2026-06-10 13:17:14.905972 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2026-06-10 13:17:14.905979 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2026-06-10 13:17:14.905987 | controller | which_declare=declare -f
2026-06-10 13:17:14.905995 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-06-10 13:17:14.906002 | controller | SELINUX_LEVEL_REQUESTED=
2026-06-10 13:17:14.906011 | controller | ZUUL_CHANGE=1188
2026-06-10 13:17:14.906019 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2026-06-10 13:17:14.906028 | controller | ZUUL_UUID=25eb16df8eda45028d472ebbf6cc8aa3
2026-06-10 13:17:14.906034 | controller | BASH_FUNC_which%%=() {  ( alias;
2026-06-10 13:17:14.906040 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2026-06-10 13:17:14.906046 | controller | }
2026-06-10 13:17:15.174623 | controller | ok: Runtime: 0:00:00.005184
2026-06-10 13:17:15.184429 | 
2026-06-10 13:17:15.184610 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2026-06-10 13:17:15.210695 | controller | skipping: Conditional result was False
2026-06-10 13:17:15.219270 | 
2026-06-10 13:17:15.219429 | TASK [Symlink /home/zuul-worker/workspace]
2026-06-10 13:17:15.757307 | controller | skipping: Conditional result was False
2026-06-10 13:17:15.766075 | 
2026-06-10 13:17:15.766233 | TASK [Ensure legacy workspace directory]
2026-06-10 13:17:15.991729 | controller | changed
2026-06-10 13:17:15.994279 | 
2026-06-10 13:17:15.994375 | PLAY RECAP
2026-06-10 13:17:15.994455 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-10 13:17:15.994496 | 
2026-06-10 13:17:16.136559 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-06-10 13:17:16.138999 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-06-10 13:17:16.760651 | 
2026-06-10 13:17:16.760759 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2026-06-10 13:17:16.771416 | 
2026-06-10 13:17:16.771483 | TASK [Create zuul-output directory]
2026-06-10 13:17:17.169269 | controller | changed
2026-06-10 13:17:17.177344 | 
2026-06-10 13:17:17.177482 | TASK [Slurp Zuul inventory test]
2026-06-10 13:17:17.608827 | controller -> localhost | ok
2026-06-10 13:17:17.614590 | 
2026-06-10 13:17:17.614658 | TASK [Save zuul inventory]
2026-06-10 13:17:18.707291 | controller | changed
2026-06-10 13:17:18.716099 | 
2026-06-10 13:17:18.716258 | TASK [Save zuul vars without the change_message]
2026-06-10 13:17:19.502641 | controller | changed
2026-06-10 13:17:19.505271 | 
2026-06-10 13:17:19.505371 | PLAY RECAP
2026-06-10 13:17:19.505456 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-10 13:17:19.505497 | 
2026-06-10 13:17:19.641927 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-06-10 13:17:19.643099 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-06-10 13:17:20.317377 | 
2026-06-10 13:17:20.317492 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2026-06-10 13:17:20.328965 | 
2026-06-10 13:17:20.329047 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2026-06-10 13:17:20.356699 | controller | ok
2026-06-10 13:17:20.371074 | 
2026-06-10 13:17:20.371150 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-06-10 13:17:20.416045 | controller | skipping: Conditional result was False
2026-06-10 13:17:20.421231 | 
2026-06-10 13:17:20.421301 | TASK [mirror-info-fork : Create /etc/ci]
2026-06-10 13:17:20.920709 | controller | ok
2026-06-10 13:17:20.929937 | 
2026-06-10 13:17:20.930098 | TASK [mirror-info-fork : Install ci_mirror script]
2026-06-10 13:17:21.809953 | controller | ok
2026-06-10 13:17:21.824752 | 
2026-06-10 13:17:21.824914 | TASK [Prepare workspace]
2026-06-10 13:17:21.849223 | controller | ok
2026-06-10 13:17:21.883737 | 
2026-06-10 13:17:21.883949 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-10 13:17:22.262531 | controller | ok
2026-06-10 13:17:22.274997 | 
2026-06-10 13:17:22.275189 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-10 13:17:24.877604 | controller | Output suppressed because no_log was given
2026-06-10 13:17:24.891443 | 
2026-06-10 13:17:24.891619 | LOOP [Create zuul-output directory]
2026-06-10 13:17:25.164481 | controller | changed: "/home/zuul/ci-framework-data/logs"
2026-06-10 13:17:25.370386 | controller | ok: "/home/zuul/zuul-output/logs"
2026-06-10 13:17:25.387115 | 
2026-06-10 13:17:25.387222 | TASK [Install required packages]
2026-06-10 13:18:22.039386 | controller | changed
2026-06-10 13:18:22.044553 | 
2026-06-10 13:18:22.044647 | TASK [Install venv]
2026-06-10 13:19:34.891685 | controller | changed
2026-06-10 13:19:34.901712 | 
2026-06-10 13:19:34.901818 | PLAY RECAP
2026-06-10 13:19:34.901884 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-10 13:19:34.901909 | 
2026-06-10 13:19:35.018632 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-06-10 13:19:35.021325 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-06-10 13:19:35.669846 | 
2026-06-10 13:19:35.670024 | PLAY [Run ci/playbooks/molecule-test.yml]
2026-06-10 13:19:35.685437 | 
2026-06-10 13:19:35.685534 | TASK [Gather required facts]
2026-06-10 13:19:37.792274 | controller | ok
2026-06-10 13:19:37.796255 | 
2026-06-10 13:19:37.796326 | TASK [Load environment var if instructed to]
2026-06-10 13:19:37.820560 | controller | skipping: Conditional result was False
2026-06-10 13:19:37.824529 | 
2026-06-10 13:19:37.824594 | TASK [Ensure group_vars dir exists]
2026-06-10 13:19:39.821514 | controller | changed
2026-06-10 13:19:39.831048 | 
2026-06-10 13:19:39.831194 | TASK [Print related variables]
2026-06-10 13:19:39.883641 | controller | ok:
2026-06-10 13:19:39.884077 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_edpm_ansible.yml
2026-06-10 13:19:39.884177 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/roles/edpm_frr
2026-06-10 13:19:39.894523 | 
2026-06-10 13:19:39.894643 | TASK [Run molecule]
2026-06-10 13:19:41.107796 | controller | WARNING  Driver podman does not provide a schema.
2026-06-10 13:19:41.111294 | controller | INFO     Performing prerun with role_name_check=0...
2026-06-10 13:19:41.974224 | controller | INFO     Running default > dependency
2026-06-10 13:19:41.975056 | controller | WARNING  Skipping, missing the requirements file.
2026-06-10 13:19:42.735758 | controller | [WARNING]: The specified collections path
2026-06-10 13:19:42.735830 | controller | '/home/zuul/.cache/molecule/edpm_frr/default/collections' is not part of the
2026-06-10 13:19:42.736162 | controller | configured Ansible collections paths '/home/zuul/.cache/ansible-compat/8075a4/c
2026-06-10 13:19:42.736298 | controller | ollections:/home/zuul/.ansible/collections:/usr/share/ansible/collections'. The
2026-06-10 13:19:42.736467 | controller | installed collection will not be picked up in an Ansible run, unless within a
2026-06-10 13:19:42.736562 | controller | playbook-adjacent collections directory.
2026-06-10 13:19:49.483540 | controller | Starting galaxy collection install process
2026-06-10 13:19:49.483666 | controller | Process install dependency map
2026-06-10 13:19:49.483872 | controller | Starting collection install process
2026-06-10 13:19:49.484106 | controller | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-general-13.0.1.tar.gz to /home/zuul/.ansible/tmp/ansible-local-29848_4q30wnw/tmpjp8tv0_6/community-general-13.0.1-ci0hf0pm
2026-06-10 13:19:49.484352 | controller | Installing 'community.general:13.0.1' to '/home/zuul/.cache/molecule/edpm_frr/default/collections/ansible_collections/community/general'
2026-06-10 13:19:49.484703 | controller | community.general:13.0.1 was installed successfully
2026-06-10 13:19:49.536694 | controller | INFO     Dependency completed successfully.
2026-06-10 13:19:49.562233 | controller | INFO     Running default > destroy
2026-06-10 13:19:49.565443 | controller | INFO     Sanity checks: 'podman'
2026-06-10 13:19:50.538381 | controller |
2026-06-10 13:19:50.538538 | controller | PLAY [Destroy] *****************************************************************
2026-06-10 13:19:50.539032 | controller |
2026-06-10 13:19:50.539092 | controller | TASK [Get passwd entries for USER env] *****************************************
2026-06-10 13:19:50.539102 | controller | Wednesday 10 June 2026  13:19:50 +0000 (0:00:00.014)       0:00:00.014 ********
2026-06-10 13:19:50.914513 | controller | ok: [localhost]
2026-06-10 13:19:50.914562 | controller |
2026-06-10 13:19:50.914576 | controller | TASK [Get shell async_dir] *****************************************************
2026-06-10 13:19:50.914588 | controller | Wednesday 10 June 2026  13:19:50 +0000 (0:00:00.376)       0:00:00.391 ********
2026-06-10 13:19:50.994028 | controller | ok: [localhost]
2026-06-10 13:19:50.994058 | controller |
2026-06-10 13:19:50.994065 | controller | TASK [Set async_dir for HOME env] **********************************************
2026-06-10 13:19:50.994071 | controller | Wednesday 10 June 2026  13:19:50 +0000 (0:00:00.079)       0:00:00.470 ********
2026-06-10 13:19:51.069687 | controller | skipping: [localhost]
2026-06-10 13:19:51.069714 | controller |
2026-06-10 13:19:51.069719 | controller | TASK [Destroy molecule instance(s)] ********************************************
2026-06-10 13:19:51.069725 | controller | Wednesday 10 June 2026  13:19:51 +0000 (0:00:00.075)       0:00:00.546 ********
2026-06-10 13:19:51.582377 | controller | changed: [localhost] => (item={'command': '/sbin/init', 'dockerfile': '../../../../molecule/common/Containerfile.j2', 'image': 'ubi9/ubi-init', 'name': 'instance', 'privileged': True, 'registry': {'url': 'registry.access.redhat.com'}, 'ulimits': ['host']})
2026-06-10 13:19:51.582408 | controller |
2026-06-10 13:19:51.582415 | controller | TASK [Wait for instance(s) deletion to complete] *******************************
2026-06-10 13:19:51.582422 | controller | Wednesday 10 June 2026  13:19:51 +0000 (0:00:00.513)       0:00:01.059 ********
2026-06-10 13:19:57.279840 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (300 retries left).
2026-06-10 13:19:57.279883 | controller | changed: [localhost] => (item={'failed': 0, 'started': 1, 'finished': 0, 'ansible_job_id': 'j398702251713.29891', 'results_file': '/home/zuul/.ansible_async/j398702251713.29891', 'changed': True, 'item': {'command': '/sbin/init', 'dockerfile': '../../../../molecule/common/Containerfile.j2', 'image': 'ubi9/ubi-init', 'name': 'instance', 'privileged': True, 'registry': {'url': 'registry.access.redhat.com'}, 'ulimits': ['host']}, 'ansible_loop_var': 'item'})
2026-06-10 13:19:57.279907 | controller |
2026-06-10 13:19:57.279925 | controller | TASK [Delete podman network dedicated to this scenario] ************************
2026-06-10 13:19:57.279934 | controller | Wednesday 10 June 2026  13:19:57 +0000 (0:00:05.696)       0:00:06.756 ********
2026-06-10 13:19:57.336450 | controller | skipping: [localhost] => (item=instance: None specified)
2026-06-10 13:19:57.336480 | controller | skipping: [localhost]
2026-06-10 13:19:57.336485 | controller |
2026-06-10 13:19:57.336489 | controller | PLAY RECAP *********************************************************************
2026-06-10 13:19:57.338447 | controller | localhost                  : ok=4    changed=2    unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2026-06-10 13:19:57.338460 | controller |
2026-06-10 13:19:57.338466 | controller | Wednesday 10 June 2026  13:19:57 +0000 (0:00:00.057)       0:00:06.813 ********
2026-06-10 13:19:57.338470 | controller | ===============================================================================
2026-06-10 13:19:57.338473 | controller | Wait for instance(s) deletion to complete ------------------------------- 5.70s
2026-06-10 13:19:57.338477 | controller | Destroy molecule instance(s) -------------------------------------------- 0.51s
2026-06-10 13:19:57.338481 | controller | Get passwd entries for USER env ----------------------------------------- 0.38s
2026-06-10 13:19:57.338485 | controller | Get shell async_dir ----------------------------------------------------- 0.08s
2026-06-10 13:19:57.338488 | controller | Set async_dir for HOME env ---------------------------------------------- 0.08s
2026-06-10 13:19:57.338634 | controller | Delete podman network dedicated to this scenario ------------------------ 0.06s
2026-06-10 13:19:57.415670 | controller | INFO     Running default > create
2026-06-10 13:19:57.890010 | controller |
2026-06-10 13:19:57.890140 | controller | PLAY [Create] ******************************************************************
2026-06-10 13:19:57.890257 | controller |
2026-06-10 13:19:57.890394 | controller | TASK [Get podman executable path] **********************************************
2026-06-10 13:19:57.890514 | controller | Wednesday 10 June 2026  13:19:57 +0000 (0:00:00.014)       0:00:00.014 ********
2026-06-10 13:19:58.184571 | controller | ok: [localhost]
2026-06-10 13:19:58.184599 | controller |
2026-06-10 13:19:58.184604 | controller | TASK [Register podman executable path] *****************************************
2026-06-10 13:19:58.184610 | controller | Wednesday 10 June 2026  13:19:58 +0000 (0:00:00.294)       0:00:00.308 ********
2026-06-10 13:19:58.227351 | controller | ok: [localhost]
2026-06-10 13:19:58.227446 | controller |
2026-06-10 13:19:58.227518 | controller | TASK [Get passwd entries for USER env] *****************************************
2026-06-10 13:19:58.227544 | controller | Wednesday 10 June 2026  13:19:58 +0000 (0:00:00.043)       0:00:00.351 ********
2026-06-10 13:19:58.607336 | controller | ok: [localhost]
2026-06-10 13:19:58.607369 | controller |
2026-06-10 13:19:58.607376 | controller | TASK [Get shell async_dir] *****************************************************
2026-06-10 13:19:58.607383 | controller | Wednesday 10 June 2026  13:19:58 +0000 (0:00:00.379)       0:00:00.731 ********
2026-06-10 13:19:58.650437 | controller | ok: [localhost]
2026-06-10 13:19:58.650944 | controller |
2026-06-10 13:19:58.650981 | controller | TASK [Set async_dir for HOME env] **********************************************
2026-06-10 13:19:58.650991 | controller | Wednesday 10 June 2026  13:19:58 +0000 (0:00:00.043)       0:00:00.774 ********
2026-06-10 13:19:58.711709 | controller | skipping: [localhost]
2026-06-10 13:19:58.711740 | controller |
2026-06-10 13:19:58.711753 | controller | TASK [Log into a container registry] *******************************************
2026-06-10 13:19:58.711758 | controller | Wednesday 10 June 2026  13:19:58 +0000 (0:00:00.061)       0:00:00.835 ********
2026-06-10 13:19:58.780426 | controller | skipping: [localhost] => (item="instance registry username: None specified")
2026-06-10 13:19:58.780461 | controller | skipping: [localhost]
2026-06-10 13:19:58.780469 | controller |
2026-06-10 13:19:58.780689 | controller | TASK [Check presence of custom Dockerfiles] ************************************
2026-06-10 13:19:58.781089 | controller | Wednesday 10 June 2026  13:19:58 +0000 (0:00:00.067)       0:00:00.903 ********
2026-06-10 13:19:59.181685 | controller | ok: [localhost] => (item=Dockerfile: ../../../../molecule/common/Containerfile.j2)
2026-06-10 13:19:59.181879 | controller |
2026-06-10 13:19:59.182056 | controller | TASK [Create Dockerfiles from image names] *************************************
2026-06-10 13:19:59.182219 | controller | Wednesday 10 June 2026  13:19:59 +0000 (0:00:00.401)       0:00:01.305 ********
2026-06-10 13:19:59.662376 | controller | changed: [localhost] => (item="Dockerfile: ../../../../molecule/common/Containerfile.j2; Image: ubi9/ubi-init")
2026-06-10 13:19:59.662412 | controller |
2026-06-10 13:19:59.662841 | controller | TASK [Discover local Podman images] ********************************************
2026-06-10 13:19:59.662912 | controller | Wednesday 10 June 2026  13:19:59 +0000 (0:00:00.478)       0:00:01.784 ********
2026-06-10 13:20:00.045357 | controller | ok: [localhost] => (item=instance)
2026-06-10 13:20:00.045388 | controller |
2026-06-10 13:20:00.045707 | controller | TASK [Build an Ansible compatible image] ***************************************
2026-06-10 13:20:00.045739 | controller | Wednesday 10 June 2026  13:20:00 +0000 (0:00:00.385)       0:00:02.169 ********
2026-06-10 13:20:32.000399 | controller | ok: [localhost] => (item=ubi9/ubi-init)
2026-06-10 13:20:32.000424 | controller |
2026-06-10 13:20:32.000430 | controller | TASK [Determine the CMD directives] ********************************************
2026-06-10 13:20:32.000493 | controller | Wednesday 10 June 2026  13:20:31 +0000 (0:00:31.955)       0:00:34.124 ********
2026-06-10 13:20:32.091476 | controller | ok: [localhost] => (item="instance command: /sbin/init")
2026-06-10 13:20:32.092075 | controller |
2026-06-10 13:20:32.092100 | controller | TASK [Remove possible pre-existing containers] *********************************
2026-06-10 13:20:32.092111 | controller | Wednesday 10 June 2026  13:20:32 +0000 (0:00:00.090)       0:00:34.215 ********
2026-06-10 13:20:32.406429 | controller | changed: [localhost]
2026-06-10 13:20:32.406751 | controller |
2026-06-10 13:20:32.406790 | controller | TASK [Discover local podman networks] ******************************************
2026-06-10 13:20:32.406797 | controller | Wednesday 10 June 2026  13:20:32 +0000 (0:00:00.315)       0:00:34.530 ********
2026-06-10 13:20:32.454447 | controller | skipping: [localhost] => (item=instance: None specified)
2026-06-10 13:20:32.454480 | controller | skipping: [localhost]
2026-06-10 13:20:32.454487 | controller |
2026-06-10 13:20:32.454493 | controller | TASK [Create podman network dedicated to this scenario] ************************
2026-06-10 13:20:32.454503 | controller | Wednesday 10 June 2026  13:20:32 +0000 (0:00:00.047)       0:00:34.578 ********
2026-06-10 13:20:32.491397 | controller | skipping: [localhost]
2026-06-10 13:20:32.491417 | controller |
2026-06-10 13:20:32.491423 | controller | TASK [Create molecule instance(s)] *********************************************
2026-06-10 13:20:32.491506 | controller | Wednesday 10 June 2026  13:20:32 +0000 (0:00:00.036)       0:00:34.614 ********
2026-06-10 13:20:32.874412 | controller | changed: [localhost] => (item=instance)
2026-06-10 13:20:32.874444 | controller |
2026-06-10 13:20:32.874634 | controller | TASK [Wait for instance(s) creation to complete] *******************************
2026-06-10 13:20:32.874664 | controller | Wednesday 10 June 2026  13:20:32 +0000 (0:00:00.383)       0:00:34.998 ********
2026-06-10 13:20:38.847483 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) creation to complete (300 retries left).
2026-06-10 13:20:38.847528 | controller | changed: [localhost] => (item=instance)
2026-06-10 13:20:38.848346 | controller |
2026-06-10 13:20:38.848372 | controller | PLAY RECAP *********************************************************************
2026-06-10 13:20:38.848383 | controller | localhost                  : ok=12   changed=4    unreachable=0    failed=0    skipped=4    rescued=0    ignored=0
2026-06-10 13:20:38.848391 | controller |
2026-06-10 13:20:38.848399 | controller | Wednesday 10 June 2026  13:20:38 +0000 (0:00:05.971)       0:00:40.970 ********
2026-06-10 13:20:38.848408 | controller | ===============================================================================
2026-06-10 13:20:38.848416 | controller | Build an Ansible compatible image -------------------------------------- 31.96s
2026-06-10 13:20:38.848423 | controller | Wait for instance(s) creation to complete ------------------------------- 5.97s
2026-06-10 13:20:38.850054 | controller | Create Dockerfiles from image names ------------------------------------- 0.48s
2026-06-10 13:20:38.850092 | controller | Check presence of custom Dockerfiles ------------------------------------ 0.40s
2026-06-10 13:20:38.850103 | controller | Discover local Podman images -------------------------------------------- 0.39s
2026-06-10 13:20:38.850108 | controller | Create molecule instance(s) --------------------------------------------- 0.38s
2026-06-10 13:20:38.850113 | controller | Get passwd entries for USER env ----------------------------------------- 0.38s
2026-06-10 13:20:38.850117 | controller | Remove possible pre-existing containers --------------------------------- 0.32s
2026-06-10 13:20:38.850121 | controller | Get podman executable path ---------------------------------------------- 0.29s
2026-06-10 13:20:38.850124 | controller | Determine the CMD directives -------------------------------------------- 0.09s
2026-06-10 13:20:38.850129 | controller | Log into a container registry ------------------------------------------- 0.07s
2026-06-10 13:20:38.850133 | controller | Set async_dir for HOME env ---------------------------------------------- 0.06s
2026-06-10 13:20:38.850138 | controller | Discover local podman networks ------------------------------------------ 0.05s
2026-06-10 13:20:38.850143 | controller | Get shell async_dir ----------------------------------------------------- 0.04s
2026-06-10 13:20:38.850148 | controller | Register podman executable path ----------------------------------------- 0.04s
2026-06-10 13:20:38.850153 | controller | Create podman network dedicated to this scenario ------------------------ 0.04s
2026-06-10 13:20:38.937985 | controller | INFO     Running default > prepare
2026-06-10 13:20:39.438453 | controller |
2026-06-10 13:20:39.438841 | controller | PLAY [Prepare] *****************************************************************
2026-06-10 13:20:39.439092 | controller |
2026-06-10 13:20:39.439309 | controller | TASK [Gathering Facts] *********************************************************
2026-06-10 13:20:39.439507 | controller | Wednesday 10 June 2026  13:20:39 +0000 (0:00:00.013)       0:00:00.013 ********
2026-06-10 13:20:45.801428 | controller | ok: [instance]
2026-06-10 13:20:45.801462 | controller |
2026-06-10 13:20:45.801482 | controller | TASK [../../../../molecule/common/test_deps : Validating arguments against arg spec 'main' - The main entry point for the test_deps role.] ***
2026-06-10 13:20:45.801488 | controller | Wednesday 10 June 2026  13:20:45 +0000 (0:00:06.363)       0:00:06.376 ********
2026-06-10 13:20:45.826974 | controller | ok: [instance]
2026-06-10 13:20:45.827003 | controller |
2026-06-10 13:20:45.827008 | controller | TASK [../../../../molecule/common/test_deps : Gather facts if they don't exist] ***
2026-06-10 13:20:45.827012 | controller | Wednesday 10 June 2026  13:20:45 +0000 (0:00:00.023)       0:00:06.399 ********
2026-06-10 13:20:45.846306 | controller | skipping: [instance]
2026-06-10 13:20:45.846332 | controller |
2026-06-10 13:20:45.846337 | controller | TASK [../../../../molecule/common/test_deps : Gather variables for each operating system] ***
2026-06-10 13:20:45.846342 | controller | Wednesday 10 June 2026  13:20:45 +0000 (0:00:00.022)       0:00:06.421 ********
2026-06-10 13:20:45.890848 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/common/test_deps/vars/redhat-9.yml)
2026-06-10 13:20:45.890875 | controller |
2026-06-10 13:20:45.890880 | controller | TASK [../../../../molecule/common/test_deps : Detect mirrors file] *************
2026-06-10 13:20:45.890885 | controller | Wednesday 10 June 2026  13:20:45 +0000 (0:00:00.044)       0:00:06.466 ********
2026-06-10 13:21:22.771415 | controller | ok: [instance]
2026-06-10 13:21:22.771453 | controller |
2026-06-10 13:21:22.771714 | controller | TASK [../../../../molecule/common/test_deps : Disable ubi host subscription-manager integration] ***
2026-06-10 13:21:22.771733 | controller | Wednesday 10 June 2026  13:21:22 +0000 (0:00:36.879)       0:00:43.346 ********
2026-06-10 13:21:25.218256 | controller | changed: [instance]
2026-06-10 13:21:25.218309 | controller |
2026-06-10 13:21:25.218315 | controller | TASK [../../../../molecule/common/test_deps : Remove ubi 9 repos] **************
2026-06-10 13:21:25.218322 | controller | Wednesday 10 June 2026  13:21:25 +0000 (0:00:02.447)       0:00:45.793 ********
2026-06-10 13:21:27.493297 | controller | changed: [instance]
2026-06-10 13:21:27.493359 | controller |
2026-06-10 13:21:27.493368 | controller | TASK [../../../../molecule/common/test_deps : Fetch latest repo version] *******
2026-06-10 13:21:27.493375 | controller | Wednesday 10 June 2026  13:21:27 +0000 (0:00:02.274)       0:00:48.067 ********
2026-06-10 13:21:33.875916 | controller | ok: [instance]
2026-06-10 13:21:33.875975 | controller |
2026-06-10 13:21:33.876005 | controller | TASK [../../../../molecule/common/test_deps : Create default repo file] ********
2026-06-10 13:21:33.876013 | controller | Wednesday 10 June 2026  13:21:33 +0000 (0:00:06.382)       0:00:54.450 ********
2026-06-10 13:21:36.025669 | controller | changed: [instance]
2026-06-10 13:21:36.025739 | controller |
2026-06-10 13:21:36.025746 | controller | TASK [../../../../molecule/common/test_deps : Install repo-setup pre-requirements] ***
2026-06-10 13:21:36.025752 | controller | Wednesday 10 June 2026  13:21:36 +0000 (0:00:02.150)       0:00:56.600 ********
2026-06-10 13:21:38.617247 | controller | ok: [instance]
2026-06-10 13:21:38.617486 | controller |
2026-06-10 13:21:38.617748 | controller | TASK [../../../../molecule/common/test_deps : Get repo-setup repository] *******
2026-06-10 13:21:38.617959 | controller | Wednesday 10 June 2026  13:21:38 +0000 (0:00:02.591)       0:00:59.192 ********
2026-06-10 13:21:40.480200 | controller | changed: [instance]
2026-06-10 13:21:40.480281 | controller |
2026-06-10 13:21:40.480613 | controller | TASK [../../../../molecule/common/test_deps : Install repo-setup] **************
2026-06-10 13:21:40.480645 | controller | Wednesday 10 June 2026  13:21:40 +0000 (0:00:01.863)       0:01:01.056 ********
2026-06-10 13:21:42.432425 | controller | changed: [instance]
2026-06-10 13:21:42.432476 | controller |
2026-06-10 13:21:42.432491 | controller | TASK [../../../../molecule/common/test_deps : Create repos] ********************
2026-06-10 13:21:42.432505 | controller | Wednesday 10 June 2026  13:21:42 +0000 (0:00:01.950)       0:01:03.006 ********
2026-06-10 13:21:43.951626 | controller | changed: [instance]
2026-06-10 13:21:43.951667 | controller |
2026-06-10 13:21:43.951678 | controller | TASK [../../../../molecule/common/test_deps : Look for redhat-release rpm] *****
2026-06-10 13:21:43.951687 | controller | Wednesday 10 June 2026  13:21:43 +0000 (0:00:01.520)       0:01:04.526 ********
2026-06-10 13:21:44.922968 | controller | changed: [instance]
2026-06-10 13:21:44.923020 | controller |
2026-06-10 13:21:44.923037 | controller | TASK [../../../../molecule/common/test_deps : Workaround of redhat-release binary on ubi9] ***
2026-06-10 13:21:44.923051 | controller | Wednesday 10 June 2026  13:21:44 +0000 (0:00:00.970)       0:01:05.497 ********
2026-06-10 13:21:46.406413 | controller | changed: [instance]
2026-06-10 13:21:46.406464 | controller |
2026-06-10 13:21:46.406479 | controller | TASK [../../../../molecule/common/test_deps : Install edpm packages] ***********
2026-06-10 13:21:46.406491 | controller | Wednesday 10 June 2026  13:21:46 +0000 (0:00:01.483)       0:01:06.981 ********
2026-06-10 13:22:33.570582 | controller | changed: [instance]
2026-06-10 13:22:33.570618 | controller |
2026-06-10 13:22:33.570624 | controller | TASK [../../../../molecule/common/test_deps : Install selinux python libs] *****
2026-06-10 13:22:33.570628 | controller | Wednesday 10 June 2026  13:22:33 +0000 (0:00:47.164)       0:01:54.146 ********
2026-06-10 13:22:46.670404 | controller | ok: [instance]
2026-06-10 13:22:46.670437 | controller |
2026-06-10 13:22:46.670448 | controller | TASK [../../../../molecule/common/test_deps : Install python yaml libs] ********
2026-06-10 13:22:46.670459 | controller | Wednesday 10 June 2026  13:22:46 +0000 (0:00:13.099)       0:02:07.245 ********
2026-06-10 13:22:48.819664 | controller | ok: [instance]
2026-06-10 13:22:48.819688 | controller |
2026-06-10 13:22:48.819693 | controller | TASK [../../../../molecule/common/test_deps : Install extra packages] **********
2026-06-10 13:22:48.819697 | controller | Wednesday 10 June 2026  13:22:48 +0000 (0:00:02.150)       0:02:09.395 ********
2026-06-10 13:23:14.552059 | controller | changed: [instance]
2026-06-10 13:23:14.552085 | controller |
2026-06-10 13:23:14.552090 | controller | TASK [../../../../molecule/common/test_deps : Check for /etc/ansible/facts.d/bootc.fact] ***
2026-06-10 13:23:14.552095 | controller | Wednesday 10 June 2026  13:23:14 +0000 (0:00:25.732)       0:02:35.127 ********
2026-06-10 13:23:15.332446 | controller | ok: [instance]
2026-06-10 13:23:15.332482 | controller |
2026-06-10 13:23:15.332487 | controller | TASK [../../../../molecule/common/test_deps : Create /etc/ansible/facts.d] *****
2026-06-10 13:23:15.332492 | controller | Wednesday 10 June 2026  13:23:15 +0000 (0:00:00.780)       0:02:35.907 ********
2026-06-10 13:23:16.087839 | controller | changed: [instance]
2026-06-10 13:23:16.088083 | controller |
2026-06-10 13:23:16.088122 | controller | TASK [../../../../molecule/common/test_deps : Create /etc/ansible/facts.d/bootc.fact] ***
2026-06-10 13:23:16.088128 | controller | Wednesday 10 June 2026  13:23:16 +0000 (0:00:00.755)       0:02:36.663 ********
2026-06-10 13:23:17.667651 | controller | changed: [instance]
2026-06-10 13:23:17.667677 | controller |
2026-06-10 13:23:17.667683 | controller | TASK [ansible.builtin.include_role : osp.edpm.env_data] ************************
2026-06-10 13:23:17.667687 | controller | Wednesday 10 June 2026  13:23:17 +0000 (0:00:01.579)       0:02:38.243 ********
2026-06-10 13:23:17.691862 | controller |
2026-06-10 13:23:17.691908 | controller | TASK [osp.edpm.env_data : Validating arguments against arg spec 'main' - The main entry point for the osp.edpm.env_data role.] ***
2026-06-10 13:23:17.691914 | controller | Wednesday 10 June 2026  13:23:17 +0000 (0:00:00.024)       0:02:38.267 ********
2026-06-10 13:23:17.709351 | controller | ok: [instance]
2026-06-10 13:23:17.709366 | controller |
2026-06-10 13:23:17.709371 | controller | TASK [osp.edpm.env_data : Gather all installed packages] ***********************
2026-06-10 13:23:17.709375 | controller | Wednesday 10 June 2026  13:23:17 +0000 (0:00:00.017)       0:02:38.285 ********
2026-06-10 13:23:18.921359 | controller | ok: [instance]
2026-06-10 13:23:18.921392 | controller |
2026-06-10 13:23:18.921536 | controller | TASK [osp.edpm.env_data : Gather repository list] ******************************
2026-06-10 13:23:18.921593 | controller | Wednesday 10 June 2026  13:23:18 +0000 (0:00:01.212)       0:02:39.497 ********
2026-06-10 13:23:20.033609 | controller | ok: [instance]
2026-06-10 13:23:20.033638 | controller |
2026-06-10 13:23:20.033643 | controller | TASK [osp.edpm.env_data : Output installed packages] ***************************
2026-06-10 13:23:20.033650 | controller | Wednesday 10 June 2026  13:23:20 +0000 (0:00:01.111)       0:02:40.609 ********
2026-06-10 13:23:20.107467 | controller | ok: [instance] =>
2026-06-10 13:23:20.107516 | controller |   msg:
2026-06-10 13:23:20.107526 | controller |   - gpg-pubkey
2026-06-10 13:23:20.107534 | controller |   - setup
2026-06-10 13:23:20.107542 | controller |   - filesystem
2026-06-10 13:23:20.107550 | controller |   - tzdata
2026-06-10 13:23:20.107558 | controller |   - basesystem
2026-06-10 13:23:20.107566 | controller |   - python3-setuptools-wheel
2026-06-10 13:23:20.107574 | controller |   - pcre2-syntax
2026-06-10 13:23:20.107582 | controller |   - ncurses-base
2026-06-10 13:23:20.107590 | controller |   - ncurses-libs
2026-06-10 13:23:20.107598 | controller |   - bash
2026-06-10 13:23:20.107605 | controller |   - libgcc
2026-06-10 13:23:20.109374 | controller |   - glibc-minimal-langpack
2026-06-10 13:23:20.109407 | controller |   - glibc-common
2026-06-10 13:23:20.109414 | controller |   - glibc
2026-06-10 13:23:20.109419 | controller |   - zlib
2026-06-10 13:23:20.109424 | controller |   - bzip2-libs
2026-06-10 13:23:20.109429 | controller |   - xz-libs
2026-06-10 13:23:20.109434 | controller |   - libzstd
2026-06-10 13:23:20.109438 | controller |   - sqlite-libs
2026-06-10 13:23:20.109456 | controller |   - libgpg-error
2026-06-10 13:23:20.109461 | controller |   - libxml2
2026-06-10 13:23:20.109465 | controller |   - libattr
2026-06-10 13:23:20.109470 | controller |   - libacl
2026-06-10 13:23:20.109474 | controller |   - libcap
2026-06-10 13:23:20.109479 | controller |   - libffi
2026-06-10 13:23:20.109483 | controller |   - libstdc++
2026-06-10 13:23:20.109491 | controller |   - popt
2026-06-10 13:23:20.109643 | controller |   - crypto-policies
2026-06-10 13:23:20.109798 | controller |   - json-c
2026-06-10 13:23:20.109962 | controller |   - keyutils-libs
2026-06-10 13:23:20.110119 | controller |   - libcom_err
2026-06-10 13:23:20.110307 | controller |   - libtasn1
2026-06-10 13:23:20.110440 | controller |   - libuuid
2026-06-10 13:23:20.110600 | controller |   - libxcrypt
2026-06-10 13:23:20.110762 | controller |   - lua-libs
2026-06-10 13:23:20.110922 | controller |   - readline
2026-06-10 13:23:20.111086 | controller |   - p11-kit
2026-06-10 13:23:20.111253 | controller |   - libassuan
2026-06-10 13:23:20.111426 | controller |   - elfutils-libelf
2026-06-10 13:23:20.111596 | controller |   - file-libs
2026-06-10 13:23:20.111767 | controller |   - expat
2026-06-10 13:23:20.111951 | controller |   - gdbm-libs
2026-06-10 13:23:20.112133 | controller |   - gmp
2026-06-10 13:23:20.112339 | controller |   - libsepol
2026-06-10 13:23:20.112530 | controller |   - libsigsegv
2026-06-10 13:23:20.112710 | controller |   - libsmartcols
2026-06-10 13:23:20.112906 | controller |   - libunistring
2026-06-10 13:23:20.113090 | controller |   - pcre
2026-06-10 13:23:20.113292 | controller |   - grep
2026-06-10 13:23:20.113501 | controller |   - libidn2
2026-06-10 13:23:20.113688 | controller |   - mpfr
2026-06-10 13:23:20.113867 | controller |   - gawk
2026-06-10 13:23:20.114049 | controller |   - libcomps
2026-06-10 13:23:20.114232 | controller |   - keyutils
2026-06-10 13:23:20.114436 | controller |   - attr
2026-06-10 13:23:20.114621 | controller |   - libgcrypt
2026-06-10 13:23:20.114800 | controller |   - libksba
2026-06-10 13:23:20.114980 | controller |   - alternatives
2026-06-10 13:23:20.115170 | controller |   - p11-kit-trust
2026-06-10 13:23:20.115386 | controller |   - libcap-ng
2026-06-10 13:23:20.115572 | controller |   - audit-libs
2026-06-10 13:23:20.115755 | controller |   - libgomp
2026-06-10 13:23:20.115936 | controller |   - libnghttp2
2026-06-10 13:23:20.116109 | controller |   - libtool-ltdl
2026-06-10 13:23:20.116317 | controller |   - libverto
2026-06-10 13:23:20.116507 | controller |   - libyaml
2026-06-10 13:23:20.116692 | controller |   - lz4-libs
2026-06-10 13:23:20.116878 | controller |   - nettle
2026-06-10 13:23:20.117096 | controller |   - gnutls
2026-06-10 13:23:20.117305 | controller |   - npth
2026-06-10 13:23:20.117497 | controller |   - pcre2
2026-06-10 13:23:20.117692 | controller |   - libselinux
2026-06-10 13:23:20.117964 | controller |   - coreutils-single
2026-06-10 13:23:20.118165 | controller |   - sed
2026-06-10 13:23:20.118374 | controller |   - libblkid
2026-06-10 13:23:20.118561 | controller |   - libmount
2026-06-10 13:23:20.118754 | controller |   - glib2
2026-06-10 13:23:20.118929 | controller |   - json-glib
2026-06-10 13:23:20.119093 | controller |   - openssl-fips-provider-so
2026-06-10 13:23:20.119299 | controller |   - openssl-fips-provider
2026-06-10 13:23:20.119497 | controller |   - findutils
2026-06-10 13:23:20.119689 | controller |   - ca-certificates
2026-06-10 13:23:20.119880 | controller |   - openssl-libs
2026-06-10 13:23:20.120066 | controller |   - krb5-libs
2026-06-10 13:23:20.120253 | controller |   - libcurl-minimal
2026-06-10 13:23:20.120471 | controller |   - curl-minimal
2026-06-10 13:23:20.120663 | controller |   - cyrus-sasl-lib
2026-06-10 13:23:20.120860 | controller |   - libarchive
2026-06-10 13:23:20.121087 | controller |   - rpm
2026-06-10 13:23:20.121307 | controller |   - rpm-libs
2026-06-10 13:23:20.121503 | controller |   - libmodulemd
2026-06-10 13:23:20.121682 | controller |   - libsolv
2026-06-10 13:23:20.121866 | controller |   - libevent
2026-06-10 13:23:20.122062 | controller |   - librhsm
2026-06-10 13:23:20.122256 | controller |   - python3-pip-wheel
2026-06-10 13:23:20.122476 | controller |   - python3
2026-06-10 13:23:20.122666 | controller |   - python3-libs
2026-06-10 13:23:20.122843 | controller |   - python3-libcomps
2026-06-10 13:23:20.122974 | controller |   - shadow-utils
2026-06-10 13:23:20.123330 | controller |   - openldap
2026-06-10 13:23:20.123895 | controller |   - gnupg2
2026-06-10 13:23:20.124136 | controller |   - gpgme
2026-06-10 13:23:20.124404 | controller |   - librepo
2026-06-10 13:23:20.124683 | controller |   - libdnf
2026-06-10 13:23:20.125155 | controller |   - python3-libdnf
2026-06-10 13:23:20.125508 | controller |   - python3-hawkey
2026-06-10 13:23:20.125763 | controller |   - python3-gpg
2026-06-10 13:23:20.126006 | controller |   - tpm2-tss
2026-06-10 13:23:20.126229 | controller |   - ima-evm-utils
2026-06-10 13:23:20.126482 | controller |   - rpm-sign-libs
2026-06-10 13:23:20.126717 | controller |   - elfutils-default-yama-scope
2026-06-10 13:23:20.126940 | controller |   - elfutils-libs
2026-06-10 13:23:20.127162 | controller |   - rpm-build-libs
2026-06-10 13:23:20.127422 | controller |   - python3-rpm
2026-06-10 13:23:20.127757 | controller |   - libreport-filesystem
2026-06-10 13:23:20.127989 | controller |   - dnf-data
2026-06-10 13:23:20.128213 | controller |   - python3-dnf
2026-06-10 13:23:20.128470 | controller |   - dnf
2026-06-10 13:23:20.128703 | controller |   - fonts-filesystem
2026-06-10 13:23:20.128956 | controller |   - dejavu-sans-fonts
2026-06-10 13:23:20.129185 | controller |   - langpacks-core-font-en
2026-06-10 13:23:20.129488 | controller |   - langpacks-core-en
2026-06-10 13:23:20.129738 | controller |   - langpacks-en
2026-06-10 13:23:20.130030 | controller |   - yum
2026-06-10 13:23:20.130276 | controller |   - libdnf-plugin-subscription-manager
2026-06-10 13:23:20.130558 | controller |   - crypto-policies-scripts
2026-06-10 13:23:20.130786 | controller |   - gzip
2026-06-10 13:23:20.131044 | controller |   - tar
2026-06-10 13:23:20.131284 | controller |   - vim-minimal
2026-06-10 13:23:20.131557 | controller |   - gdb-gdbserver
2026-06-10 13:23:20.131786 | controller |   - rootfiles
2026-06-10 13:23:20.132014 | controller |   - python3-six
2026-06-10 13:23:20.132243 | controller |   - python3-dateutil
2026-06-10 13:23:20.132501 | controller |   - dmidecode
2026-06-10 13:23:20.132737 | controller |   - python3-iniparse
2026-06-10 13:23:20.132999 | controller |   - subscription-manager-rhsm-certificates
2026-06-10 13:23:20.133232 | controller |   - python3-setuptools
2026-06-10 13:23:20.133490 | controller |   - python3-idna
2026-06-10 13:23:20.133721 | controller |   - libfdisk
2026-06-10 13:23:20.133981 | controller |   - cracklib
2026-06-10 13:23:20.134236 | controller |   - cracklib-dicts
2026-06-10 13:23:20.134496 | controller |   - python3-inotify
2026-06-10 13:23:20.134730 | controller |   - dbus-libs
2026-06-10 13:23:20.134955 | controller |   - python3-dbus
2026-06-10 13:23:20.135181 | controller |   - python3-systemd
2026-06-10 13:23:20.135444 | controller |   - util-linux-core
2026-06-10 13:23:20.135673 | controller |   - which
2026-06-10 13:23:20.135899 | controller |   - python3-pysocks
2026-06-10 13:23:20.136141 | controller |   - python3-urllib3
2026-06-10 13:23:20.136403 | controller |   - python3-librepo
2026-06-10 13:23:20.136637 | controller |   - python3-decorator
2026-06-10 13:23:20.136864 | controller |   - python3-chardet
2026-06-10 13:23:20.137149 | controller |   - python3-requests
2026-06-10 13:23:20.137427 | controller |   - python3-cloud-what
2026-06-10 13:23:20.137687 | controller |   - python3-subscription-manager-rhsm
2026-06-10 13:23:20.137961 | controller |   - psmisc
2026-06-10 13:23:20.138210 | controller |   - openssl
2026-06-10 13:23:20.138497 | controller |   - libutempter
2026-06-10 13:23:20.138738 | controller |   - libseccomp
2026-06-10 13:23:20.138968 | controller |   - libmnl
2026-06-10 13:23:20.139195 | controller |   - libeconf
2026-06-10 13:23:20.139459 | controller |   - libdb
2026-06-10 13:23:20.139692 | controller |   - pam
2026-06-10 13:23:20.139945 | controller |   - libpwquality
2026-06-10 13:23:20.140203 | controller |   - util-linux
2026-06-10 13:23:20.140467 | controller |   - libuser
2026-06-10 13:23:20.140704 | controller |   - passwd
2026-06-10 13:23:20.140943 | controller |   - usermode
2026-06-10 13:23:20.141181 | controller |   - virt-what
2026-06-10 13:23:20.141437 | controller |   - libbpf
2026-06-10 13:23:20.141703 | controller |   - iproute
2026-06-10 13:23:20.141917 | controller |   - kmod-libs
2026-06-10 13:23:20.142150 | controller |   - gobject-introspection
2026-06-10 13:23:20.142424 | controller |   - python3-gobject-base-noarch
2026-06-10 13:23:20.142696 | controller |   - python3-gobject-base
2026-06-10 13:23:20.142909 | controller |   - acl
2026-06-10 13:23:20.143141 | controller |   - dbus
2026-06-10 13:23:20.143411 | controller |   - dbus-common
2026-06-10 13:23:20.143660 | controller |   - dbus-broker
2026-06-10 13:23:20.143951 | controller |   - python3-dnf-plugins-core
2026-06-10 13:23:20.144176 | controller |   - subscription-manager
2026-06-10 13:23:20.144438 | controller |   - procps-ng
2026-06-10 13:23:20.144686 | controller |   - libxcrypt-compat
2026-06-10 13:23:20.144904 | controller |   - openssh
2026-06-10 13:23:20.145164 | controller |   - ncurses
2026-06-10 13:23:20.145422 | controller |   - libselinux-utils
2026-06-10 13:23:20.145658 | controller |   - libedit
2026-06-10 13:23:20.145882 | controller |   - libcbor
2026-06-10 13:23:20.146108 | controller |   - libfido2
2026-06-10 13:23:20.146368 | controller |   - openssh-clients
2026-06-10 13:23:20.146615 | controller |   - less
2026-06-10 13:23:20.146838 | controller |   - git-core
2026-06-10 13:23:20.147074 | controller |   - git-core-doc
2026-06-10 13:23:20.147357 | controller |   - groff-base
2026-06-10 13:23:20.147583 | controller |   - perl-Digest
2026-06-10 13:23:20.147820 | controller |   - perl-Digest-MD5
2026-06-10 13:23:20.148039 | controller |   - perl-B
2026-06-10 13:23:20.148502 | controller |   - perl-FileHandle
2026-06-10 13:23:20.148869 | controller |   - perl-Data-Dumper
2026-06-10 13:23:20.149039 | controller |   - perl-libnet
2026-06-10 13:23:20.149167 | controller |   - perl-AutoLoader
2026-06-10 13:23:20.149283 | controller |   - perl-base
2026-06-10 13:23:20.149408 | controller |   - perl-URI
2026-06-10 13:23:20.149516 | controller |   - perl-Time-Local
2026-06-10 13:23:20.149618 | controller |   - perl-Mozilla-CA
2026-06-10 13:23:20.149742 | controller |   - perl-if
2026-06-10 13:23:20.149840 | controller |   - perl-IO-Socket-IP
2026-06-10 13:23:20.149963 | controller |   - perl-File-Path
2026-06-10 13:23:20.150128 | controller |   - perl-Pod-Escapes
2026-06-10 13:23:20.150243 | controller |   - perl-Text-Tabs+Wrap
2026-06-10 13:23:20.150364 | controller |   - perl-IO-Socket-SSL
2026-06-10 13:23:20.150471 | controller |   - perl-Net-SSLeay
2026-06-10 13:23:20.150573 | controller |   - perl-Term-ANSIColor
2026-06-10 13:23:20.150723 | controller |   - perl-Class-Struct
2026-06-10 13:23:20.150819 | controller |   - perl-POSIX
2026-06-10 13:23:20.150961 | controller |   - perl-IPC-Open3
2026-06-10 13:23:20.151047 | controller |   - perl-subs
2026-06-10 13:23:20.151150 | controller |   - perl-File-Temp
2026-06-10 13:23:20.151254 | controller |   - perl-Term-Cap
2026-06-10 13:23:20.151388 | controller |   - perl-HTTP-Tiny
2026-06-10 13:23:20.151500 | controller |   - perl-Pod-Simple
2026-06-10 13:23:20.151605 | controller |   - perl-Socket
2026-06-10 13:23:20.151715 | controller |   - perl-SelectSaver
2026-06-10 13:23:20.151821 | controller |   - perl-Symbol
2026-06-10 13:23:20.151925 | controller |   - perl-File-stat
2026-06-10 13:23:20.152028 | controller |   - perl-podlators
2026-06-10 13:23:20.152132 | controller |   - perl-Pod-Perldoc
2026-06-10 13:23:20.152235 | controller |   - perl-Text-ParseWords
2026-06-10 13:23:20.152373 | controller |   - perl-Fcntl
2026-06-10 13:23:20.152489 | controller |   - perl-mro
2026-06-10 13:23:20.152594 | controller |   - perl-IO
2026-06-10 13:23:20.152699 | controller |   - perl-overloading
2026-06-10 13:23:20.152803 | controller |   - perl-Pod-Usage
2026-06-10 13:23:20.152906 | controller |   - perl-MIME-Base64
2026-06-10 13:23:20.153031 | controller |   - perl-Scalar-List-Utils
2026-06-10 13:23:20.153132 | controller |   - perl-constant
2026-06-10 13:23:20.153235 | controller |   - perl-parent
2026-06-10 13:23:20.153368 | controller |   - perl-Errno
2026-06-10 13:23:20.153485 | controller |   - perl-File-Basename
2026-06-10 13:23:20.153589 | controller |   - perl-Getopt-Std
2026-06-10 13:23:20.153692 | controller |   - perl-Storable
2026-06-10 13:23:20.153795 | controller |   - perl-overload
2026-06-10 13:23:20.153899 | controller |   - perl-vars
2026-06-10 13:23:20.154002 | controller |   - perl-Getopt-Long
2026-06-10 13:23:20.154107 | controller |   - perl-Carp
2026-06-10 13:23:20.154210 | controller |   - perl-Exporter
2026-06-10 13:23:20.154339 | controller |   - perl-PathTools
2026-06-10 13:23:20.154451 | controller |   - perl-NDBM_File
2026-06-10 13:23:20.154555 | controller |   - perl-Encode
2026-06-10 13:23:20.154672 | controller |   - perl-libs
2026-06-10 13:23:20.154776 | controller |   - perl-interpreter
2026-06-10 13:23:20.154879 | controller |   - perl-Error
2026-06-10 13:23:20.154983 | controller |   - perl-DynaLoader
2026-06-10 13:23:20.155093 | controller |   - perl-TermReadKey
2026-06-10 13:23:20.155202 | controller |   - perl-lib
2026-06-10 13:23:20.155331 | controller |   - perl-Git
2026-06-10 13:23:20.155441 | controller |   - git
2026-06-10 13:23:20.155545 | controller |   - diffutils
2026-06-10 13:23:20.155651 | controller |   - policycoreutils
2026-06-10 13:23:20.155755 | controller |   - selinux-policy
2026-06-10 13:23:20.155859 | controller |   - selinux-policy-targeted
2026-06-10 13:23:20.155965 | controller |   - rpm-plugin-selinux
2026-06-10 13:23:20.156070 | controller |   - python3-pip
2026-06-10 13:23:20.156176 | controller |   - python3-libselinux
2026-06-10 13:23:20.156300 | controller |   - sudo
2026-06-10 13:23:20.156416 | controller |   - systemd-libs
2026-06-10 13:23:20.156527 | controller |   - python3-pbr
2026-06-10 13:23:20.156630 | controller |   - python3-pyyaml
2026-06-10 13:23:20.156732 | controller |   - kmod
2026-06-10 13:23:20.156841 | controller |   - python3-netaddr
2026-06-10 13:23:20.156962 | controller |   - chkconfig
2026-06-10 13:23:20.157069 | controller |   - NetworkManager-config-server
2026-06-10 13:23:20.157171 | controller |   - python3-stevedore
2026-06-10 13:23:20.157317 | controller |   - NetworkManager-libnm
2026-06-10 13:23:20.157434 | controller |   - python3-pyudev
2026-06-10 13:23:20.157537 | controller |   - systemd-rpm-macros
2026-06-10 13:23:20.157687 | controller |   - systemd-pam
2026-06-10 13:23:20.157800 | controller |   - systemd
2026-06-10 13:23:20.157850 | controller |   - iputils
2026-06-10 13:23:20.157951 | controller |   - device-mapper-libs
2026-06-10 13:23:20.158058 | controller |   - device-mapper
2026-06-10 13:23:20.158161 | controller |   - cryptsetup-libs
2026-06-10 13:23:20.158274 | controller |   - initscripts-service
2026-06-10 13:23:20.158399 | controller |   - python3-setools
2026-06-10 13:23:20.158508 | controller |   - protobuf-c
2026-06-10 13:23:20.158618 | controller |   - unbound-libs
2026-06-10 13:23:20.158719 | controller |   - numactl-libs
2026-06-10 13:23:20.158822 | controller |   - libnl3
2026-06-10 13:23:20.158923 | controller |   - libibverbs
2026-06-10 13:23:20.159024 | controller |   - libndp
2026-06-10 13:23:20.159132 | controller |   - kbd-misc
2026-06-10 13:23:20.159235 | controller |   - kbd-legacy
2026-06-10 13:23:20.159364 | controller |   - kbd
2026-06-10 13:23:20.159473 | controller |   - systemd-udev
2026-06-10 13:23:20.159581 | controller |   - NetworkManager
2026-06-10 13:23:20.159680 | controller |   - nmstate-libs
2026-06-10 13:23:20.159782 | controller |   - nmstate
2026-06-10 13:23:20.159885 | controller |   - jansson
2026-06-10 13:23:20.159989 | controller |   - NetworkManager-ovs
2026-06-10 13:23:20.160091 | controller |   - python3-libnmstate
2026-06-10 13:23:20.160194 | controller |   - initscripts-rename-device
2026-06-10 13:23:20.160326 | controller |   - initscripts
2026-06-10 13:23:20.160462 | controller |   - hostname
2026-06-10 13:23:20.160574 | controller |   - ethtool
2026-06-10 13:23:20.160677 | controller |   - dhcp-common
2026-06-10 13:23:20.160780 | controller |   - centos-gpg-keys
2026-06-10 13:23:20.160881 | controller |   - centos-stream-repos
2026-06-10 13:23:20.161011 | controller |   - bc
2026-06-10 13:23:20.161118 | controller |   - python3-pyrsistent
2026-06-10 13:23:20.161220 | controller |   - python3-psutil
2026-06-10 13:23:20.161368 | controller |   - python3-audit
2026-06-10 13:23:20.161485 | controller |   - python3-attrs
2026-06-10 13:23:20.161592 | controller |   - python3-jsonschema
2026-06-10 13:23:20.161707 | controller |   - mstflint
2026-06-10 13:23:20.161826 | controller |   - libmaxminddb
2026-06-10 13:23:20.161932 | controller |   - geolite2-country
2026-06-10 13:23:20.162038 | controller |   - geolite2-city
2026-06-10 13:23:20.162142 | controller |   - ipcalc
2026-06-10 13:23:20.162258 | controller |   - openstack-network-scripts
2026-06-10 13:23:20.162403 | controller |   - openstack-network-scripts-openvswitch3.4
2026-06-10 13:23:20.162583 | controller |   - dhcp-client
2026-06-10 13:23:20.162686 | controller |   - checkpolicy
2026-06-10 13:23:20.162790 | controller |   - python3-wrapt
2026-06-10 13:23:20.162893 | controller |   - python3-debtcollector
2026-06-10 13:23:20.163007 | controller |   - python3-rfc3986
2026-06-10 13:23:20.163127 | controller |   - python3-pyroute2
2026-06-10 13:23:20.163240 | controller |   - python3-pyparsing
2026-06-10 13:23:20.163375 | controller |   - python3-packaging
2026-06-10 13:23:20.163486 | controller |   - python3-iso8601
2026-06-10 13:23:20.163590 | controller |   - python3-fasteners
2026-06-10 13:23:20.163693 | controller |   - python3-distro
2026-06-10 13:23:20.163801 | controller |   - python-oslo-utils-lang
2026-06-10 13:23:20.163906 | controller |   - python-oslo-i18n-lang
2026-06-10 13:23:20.164023 | controller |   - python3-oslo-i18n
2026-06-10 13:23:20.164117 | controller |   - python3-oslo-utils
2026-06-10 13:23:20.164218 | controller |   - python3-oslo-config
2026-06-10 13:23:20.164344 | controller |   - python-oslo-concurrency-lang
2026-06-10 13:23:20.164453 | controller |   - python3-oslo-concurrency
2026-06-10 13:23:20.164555 | controller |   - libsemanage
2026-06-10 13:23:20.164658 | controller |   - python3-libsemanage
2026-06-10 13:23:20.164761 | controller |   - python3-policycoreutils
2026-06-10 13:23:20.164865 | controller |   - policycoreutils-python-utils
2026-06-10 13:23:20.164987 | controller |   - openvswitch-selinux-extra-policy
2026-06-10 13:23:20.165095 | controller |   - openvswitch3.4
2026-06-10 13:23:20.165198 | controller |   - rdo-openvswitch
2026-06-10 13:23:20.165314 | controller |   - os-net-config
2026-06-10 13:23:20.165430 | controller |   - centos-stream-release
2026-06-10 13:23:20.165533 | controller |   - container-selinux
2026-06-10 13:23:20.165636 | controller |   - fuse3-libs
2026-06-10 13:23:20.165737 | controller |   - libnftnl
2026-06-10 13:23:20.165841 | controller |   - passt-selinux
2026-06-10 13:23:20.165942 | controller |   - passt
2026-06-10 13:23:20.166043 | controller |   - yajl
2026-06-10 13:23:20.166144 | controller |   - libslirp
2026-06-10 13:23:20.166245 | controller |   - slirp4netns
2026-06-10 13:23:20.166380 | controller |   - libnet
2026-06-10 13:23:20.166489 | controller |   - conmon
2026-06-10 13:23:20.166592 | controller |   - aardvark-dns
2026-06-10 13:23:20.166695 | controller |   - shadow-utils-subid
2026-06-10 13:23:20.166797 | controller |   - libnfnetlink
2026-06-10 13:23:20.166899 | controller |   - libnetfilter_conntrack
2026-06-10 13:23:20.167003 | controller |   - iptables-libs
2026-06-10 13:23:20.167110 | controller |   - iptables-nft
2026-06-10 13:23:20.167213 | controller |   - criu
2026-06-10 13:23:20.167332 | controller |   - criu-libs
2026-06-10 13:23:20.167440 | controller |   - crun
2026-06-10 13:23:20.167543 | controller |   - netavark
2026-06-10 13:23:20.167652 | controller |   - nftables
2026-06-10 13:23:20.167756 | controller |   - fuse-common
2026-06-10 13:23:20.167858 | controller |   - fuse3
2026-06-10 13:23:20.167967 | controller |   - fuse-overlayfs
2026-06-10 13:23:20.168070 | controller |   - containers-common
2026-06-10 13:23:20.168172 | controller |   - podman
2026-06-10 13:23:20.168273 | controller |
2026-06-10 13:23:20.168404 | controller | TASK [osp.edpm.env_data : Output installed repositories] ***********************
2026-06-10 13:23:20.168519 | controller | Wednesday 10 June 2026  13:23:20 +0000 (0:00:00.072)       0:02:40.682 ********
2026-06-10 13:23:20.168733 | controller | ok: [instance] =>
2026-06-10 13:23:20.168830 | controller |   msg: |-
2026-06-10 13:23:20.168934 | controller |     #### REPOSITORIES
2026-06-10 13:23:20.169066 | controller |     Updating Subscription Management repositories.
2026-06-10 13:23:20.169181 | controller |     Unable to read consumer identity
2026-06-10 13:23:20.169294 | controller |
2026-06-10 13:23:20.169406 | controller |     This system is not registered with an entitlement server. You can use subscription-manager to register.
2026-06-10 13:23:20.169503 | controller |
2026-06-10 13:23:20.169607 | controller |     repo id                            repo name
2026-06-10 13:23:20.169710 | controller |     appstream                          CentOS Stream 9 - AppStream
2026-06-10 13:23:20.169814 | controller |     baseos                             CentOS Stream 9 - BaseOS
2026-06-10 13:23:20.169918 | controller |     centos9-nfv-ovs                    NFV SIG OpenvSwitch
2026-06-10 13:23:20.170022 | controller |     centos9-opstools                   centos9-opstools
2026-06-10 13:23:20.170123 | controller |     centos9-rabbitmq                   centos9-rabbitmq
2026-06-10 13:23:20.170226 | controller |     centos9-storage                    centos9-storage
2026-06-10 13:23:20.170364 | controller |     delorean-component-barbican        delorean-python-castellan-609f4ea667df386849930cf61d875b5c9e16abbb
2026-06-10 13:23:20.170477 | controller |     delorean-component-baremetal       delorean-openstack-ironic-c525a16b06266b6b474c99b13301d5b4409e92a0
2026-06-10 13:23:20.170586 | controller |     delorean-component-cinder          delorean-openstack-cinder-92c645f1f1e913b5b1cd8ad0227a251f03adec04
2026-06-10 13:23:20.170692 | controller |     delorean-component-clients         delorean-ansible-collections-openstack-f584c54dfd03e81c1e9c30e2d22f19d2d17a4353
2026-06-10 13:23:20.170796 | controller |     delorean-component-cloudops        delorean-openstack-ceilometer-60803e710e7f5b3cd6b1f2175bc41b67ac456667
2026-06-10 13:23:20.170906 | controller |     delorean-component-common          delorean-openstack-kolla-e7bd46dad0b62ff151667be2a6f5c8a7be41911e
2026-06-10 13:23:20.171011 | controller |     delorean-component-compute         delorean-openstack-nova-3e7017eb2952d5258d96e27b6c16aae1ed472b21
2026-06-10 13:23:20.171117 | controller |     delorean-component-designate       delorean-openstack-designate-82652559ea8641b11c4227f0e9cf273b4c567b96
2026-06-10 13:23:20.171222 | controller |     delorean-component-glance          delorean-openstack-glance-e055873be4079bc9d37165cf75de5495603133b0
2026-06-10 13:23:20.171357 | controller |     delorean-component-keystone        delorean-openstack-keystone-4f1b7e96e38463d5fcd9143446b408bc4c0360d1
2026-06-10 13:23:20.171473 | controller |     delorean-component-manila          delorean-openstack-manila-70623bb84e7880f7f2f750bda2774e5e5151c900
2026-06-10 13:23:20.171579 | controller |     delorean-component-network         delorean-python-networking-mlnx-7139a7f0bce9d6a1f5fe919f623386a55396229d
2026-06-10 13:23:20.171685 | controller |     delorean-component-octavia         delorean-openstack-octavia-e981d3e172b8e4471f97251afc491141f06ec867
2026-06-10 13:23:20.171791 | controller |     delorean-component-optimize        delorean-openstack-watcher-71470dac73abba9e5dcf284462b4e1d167777745
2026-06-10 13:23:20.171917 | controller |     delorean-component-podified        delorean-python-tcib-9aecfe867ca44ca276dd228be612c156cf3842f7
2026-06-10 13:23:20.172041 | controller |     delorean-component-puppet          delorean-puppet-ceph-9b6c881f94cc890560eb6739d709712a0438389a
2026-06-10 13:23:20.172150 | controller |     delorean-component-swift           delorean-openstack-swift-e10c2bafcb8fc80929bce3e064fee5f86a49e718
2026-06-10 13:23:20.172259 | controller |     delorean-component-tempest         delorean-python-mistral-tests-tempest-900580c9530660d21ca20063459f673803b7a299
2026-06-10 13:23:20.172396 | controller |     delorean-component-ui              delorean-python-django-horizon-915b939b342dc65f46cca345b93deaaee675e778
2026-06-10 13:23:20.172509 | controller |     delorean-master-build-deps         dlrn-master-build-deps
2026-06-10 13:23:20.172618 | controller |     delorean-master-testing            dlrn-master-testing
2026-06-10 13:23:20.172726 | controller |     epel-low-priority                  Extra Packages for Enterprise Linux 9 - x86_64
2026-06-10 13:23:20.172832 | controller |     extras-common                      CentOS Stream 9 - Extras packages
2026-06-10 13:23:20.172936 | controller |     repo-setup-centos-appstream        repo-setup-centos-appstream
2026-06-10 13:23:20.173061 | controller |     repo-setup-centos-baseos           repo-setup-centos-baseos
2026-06-10 13:23:20.173168 | controller |     repo-setup-centos-highavailability repo-setup-centos-highavailability
2026-06-10 13:23:20.173342 | controller |     repo-setup-centos-powertools       repo-setup-centos-powertools
2026-06-10 13:23:20.173448 | controller |
2026-06-10 13:23:20.173554 | controller | TASK [Ensure /etc/localtime exists] ********************************************
2026-06-10 13:23:20.173659 | controller | Wednesday 10 June 2026  13:23:20 +0000 (0:00:00.053)       0:02:40.735 ********
2026-06-10 13:23:21.046289 | controller | changed: [instance]
2026-06-10 13:23:21.046319 | controller |
2026-06-10 13:23:21.046324 | controller | TASK [Force systemd to reread configs] *****************************************
2026-06-10 13:23:21.046329 | controller | Wednesday 10 June 2026  13:23:21 +0000 (0:00:00.885)       0:02:41.621 ********
2026-06-10 13:23:22.558427 | controller | ok: [instance]
2026-06-10 13:23:22.558491 | controller |
2026-06-10 13:23:22.560363 | controller | PLAY RECAP *********************************************************************
2026-06-10 13:23:22.560380 | controller | instance                   : ok=28   changed=13   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-06-10 13:23:22.560385 | controller |
2026-06-10 13:23:22.560389 | controller | Wednesday 10 June 2026  13:23:22 +0000 (0:00:01.512)       0:02:43.133 ********
2026-06-10 13:23:22.560392 | controller | ===============================================================================
2026-06-10 13:23:22.560409 | controller | ../../../../molecule/common/test_deps : Install edpm packages ---------- 47.16s
2026-06-10 13:23:22.560422 | controller | ../../../../molecule/common/test_deps : Detect mirrors file ------------ 36.88s
2026-06-10 13:23:22.560426 | controller | ../../../../molecule/common/test_deps : Install extra packages --------- 25.73s
2026-06-10 13:23:22.560429 | controller | ../../../../molecule/common/test_deps : Install selinux python libs ---- 13.10s
2026-06-10 13:23:22.560433 | controller | ../../../../molecule/common/test_deps : Fetch latest repo version ------- 6.38s
2026-06-10 13:23:22.563759 | controller | Gathering Facts --------------------------------------------------------- 6.36s
2026-06-10 13:23:22.563800 | controller | ../../../../molecule/common/test_deps : Install repo-setup pre-requirements --- 2.59s
2026-06-10 13:23:22.563811 | controller | ../../../../molecule/common/test_deps : Disable ubi host subscription-manager integration --- 2.45s
2026-06-10 13:23:22.563820 | controller | ../../../../molecule/common/test_deps : Remove ubi 9 repos -------------- 2.27s
2026-06-10 13:23:22.563828 | controller | ../../../../molecule/common/test_deps : Create default repo file -------- 2.15s
2026-06-10 13:23:22.563836 | controller | ../../../../molecule/common/test_deps : Install python yaml libs -------- 2.15s
2026-06-10 13:23:22.563845 | controller | ../../../../molecule/common/test_deps : Install repo-setup -------------- 1.95s
2026-06-10 13:23:22.563853 | controller | ../../../../molecule/common/test_deps : Get repo-setup repository ------- 1.86s
2026-06-10 13:23:22.563861 | controller | ../../../../molecule/common/test_deps : Create /etc/ansible/facts.d/bootc.fact --- 1.58s
2026-06-10 13:23:22.563869 | controller | ../../../../molecule/common/test_deps : Create repos -------------------- 1.52s
2026-06-10 13:23:22.563877 | controller | Force systemd to reread configs ----------------------------------------- 1.51s
2026-06-10 13:23:22.563885 | controller | ../../../../molecule/common/test_deps : Workaround of redhat-release binary on ubi9 --- 1.48s
2026-06-10 13:23:22.563893 | controller | osp.edpm.env_data : Gather all installed packages ----------------------- 1.21s
2026-06-10 13:23:22.563901 | controller | osp.edpm.env_data : Gather repository list ------------------------------ 1.11s
2026-06-10 13:23:22.563909 | controller | ../../../../molecule/common/test_deps : Look for redhat-release rpm ----- 0.97s
2026-06-10 13:23:22.645739 | controller | INFO     Running default > converge
2026-06-10 13:23:23.163109 | controller |
2026-06-10 13:23:23.163363 | controller | PLAY [Converge] ****************************************************************
2026-06-10 13:23:23.163500 | controller |
2026-06-10 13:23:23.163683 | controller | TASK [Download required role packages] *****************************************
2026-06-10 13:23:23.163886 | controller | Wednesday 10 June 2026  13:23:23 +0000 (0:00:00.083)       0:00:00.083 ********
2026-06-10 13:23:23.223418 | controller |
2026-06-10 13:23:23.223612 | controller | TASK [osp.edpm.edpm_frr : Download needed container images] ********************
2026-06-10 13:23:23.223754 | controller | Wednesday 10 June 2026  13:23:23 +0000 (0:00:00.060)       0:00:00.144 ********
2026-06-10 13:23:29.782144 | controller | changed: [instance] => (item=quay.io/podified-antelope-centos9/openstack-frr:current-podified)
2026-06-10 13:23:29.782174 | controller |
2026-06-10 13:23:29.782180 | controller | TASK [ansible.builtin.include_role : osp.edpm.edpm_frr] ************************
2026-06-10 13:23:29.782184 | controller | Wednesday 10 June 2026  13:23:29 +0000 (0:00:06.558)       0:00:06.702 ********
2026-06-10 13:23:29.867387 | controller |
2026-06-10 13:23:29.867416 | controller | TASK [osp.edpm.edpm_frr : Validating arguments against arg spec 'main' - The main entry point for the edpm_frr role.] ***
2026-06-10 13:23:29.867421 | controller | Wednesday 10 June 2026  13:23:29 +0000 (0:00:00.084)       0:00:06.787 ********
2026-06-10 13:23:29.926802 | controller | ok: [instance]
2026-06-10 13:23:29.926830 | controller |
2026-06-10 13:23:29.926835 | controller | TASK [osp.edpm.edpm_frr : Gather user fact] ************************************
2026-06-10 13:23:29.926839 | controller | Wednesday 10 June 2026  13:23:29 +0000 (0:00:00.059)       0:00:06.847 ********
2026-06-10 13:23:31.067135 | controller | ok: [instance]
2026-06-10 13:23:31.067162 | controller |
2026-06-10 13:23:31.067167 | controller | TASK [osp.edpm.edpm_frr : Create persistent directories] ***********************
2026-06-10 13:23:31.067208 | controller | Wednesday 10 June 2026  13:23:31 +0000 (0:00:01.140)       0:00:07.987 ********
2026-06-10 13:23:33.864464 | controller | changed: [instance] => (item={'path': '/var/lib/openstack/frr', 'setype': 'container_file_t', 'mode': '0750'})
2026-06-10 13:23:33.864505 | controller | changed: [instance] => (item={'path': '/run/frr', 'setype': 'container_file_t', 'mode': '0755'})
2026-06-10 13:23:33.864510 | controller | changed: [instance] => (item={'path': '/var/lib/edpm-config/firewall', 'setype': 'container_file_t', 'mode': '0750'})
2026-06-10 13:23:33.864515 | controller |
2026-06-10 13:23:33.864754 | controller | TASK [osp.edpm.edpm_frr : Ensure /run/frr is present upon reboot] **************
2026-06-10 13:23:33.864786 | controller | Wednesday 10 June 2026  13:23:33 +0000 (0:00:02.796)       0:00:10.784 ********
2026-06-10 13:23:35.925738 | controller | changed: [instance]
2026-06-10 13:23:35.925766 | controller |
2026-06-10 13:23:35.925772 | controller | TASK [osp.edpm.edpm_frr : Gather SELinux fact if needed] ***********************
2026-06-10 13:23:35.925776 | controller | Wednesday 10 June 2026  13:23:35 +0000 (0:00:02.061)       0:00:12.846 ********
2026-06-10 13:23:36.008347 | controller | skipping: [instance]
2026-06-10 13:23:36.008388 | controller |
2026-06-10 13:23:36.008393 | controller | TASK [osp.edpm.edpm_frr : Create directory /var/lib/openstack/frr] *************
2026-06-10 13:23:36.008397 | controller | Wednesday 10 June 2026  13:23:36 +0000 (0:00:00.082)       0:00:12.928 ********
2026-06-10 13:23:37.077308 | controller | changed: [instance]
2026-06-10 13:23:37.077347 | controller |
2026-06-10 13:23:37.077357 | controller | TASK [osp.edpm.edpm_frr : Inject firewall rules for frr BGP and BFD] ***********
2026-06-10 13:23:37.077366 | controller | Wednesday 10 June 2026  13:23:37 +0000 (0:00:01.068)       0:00:13.997 ********
2026-06-10 13:23:38.023791 | controller | changed: [instance]
2026-06-10 13:23:38.023828 | controller |
2026-06-10 13:23:38.023835 | controller | TASK [Configure firewall for frr BGP and BFD] **********************************
2026-06-10 13:23:38.023841 | controller | Wednesday 10 June 2026  13:23:38 +0000 (0:00:00.946)       0:00:14.944 ********
2026-06-10 13:23:38.094736 | controller |
2026-06-10 13:23:38.094774 | controller | TASK [osp.edpm.edpm_nftables : Create snippets directory] **********************
2026-06-10 13:23:38.094780 | controller | Wednesday 10 June 2026  13:23:38 +0000 (0:00:00.071)       0:00:15.015 ********
2026-06-10 13:23:38.947628 | controller | ok: [instance]
2026-06-10 13:23:38.947654 | controller |
2026-06-10 13:23:38.947660 | controller | TASK [osp.edpm.edpm_nftables : Push default ruleset snipet] ********************
2026-06-10 13:23:38.947664 | controller | Wednesday 10 June 2026  13:23:38 +0000 (0:00:00.853)       0:00:15.868 ********
2026-06-10 13:23:41.511795 | controller | changed: [instance]
2026-06-10 13:23:41.511822 | controller |
2026-06-10 13:23:41.511828 | controller | TASK [osp.edpm.edpm_nftables : Write user rules snippet] ***********************
2026-06-10 13:23:41.511832 | controller | Wednesday 10 June 2026  13:23:41 +0000 (0:00:02.563)       0:00:18.432 ********
2026-06-10 13:23:43.265722 | controller | changed: [instance]
2026-06-10 13:23:43.265759 | controller |
2026-06-10 13:23:43.265767 | controller | TASK [osp.edpm.edpm_nftables : Push empty ruleset] *****************************
2026-06-10 13:23:43.265774 | controller | Wednesday 10 June 2026  13:23:43 +0000 (0:00:01.753)       0:00:20.185 ********
2026-06-10 13:23:45.297328 | controller | changed: [instance]
2026-06-10 13:23:45.297362 | controller |
2026-06-10 13:23:45.297369 | controller | TASK [osp.edpm.edpm_nftables : Load empty ruleset] *****************************
2026-06-10 13:23:45.297376 | controller | Wednesday 10 June 2026  13:23:45 +0000 (0:00:02.031)       0:00:22.217 ********
2026-06-10 13:23:46.592800 | controller | changed: [instance]
2026-06-10 13:23:46.592844 | controller |
2026-06-10 13:23:46.592856 | controller | TASK [osp.edpm.edpm_nftables : Delete iptables-compat tables if load failed due to bare chains] ***
2026-06-10 13:23:46.592866 | controller | Wednesday 10 June 2026  13:23:46 +0000 (0:00:01.294)       0:00:23.512 ********
2026-06-10 13:23:46.693495 | controller | skipping: [instance] => (item=inet filter)
2026-06-10 13:23:46.693529 | controller | skipping: [instance] => (item=inet raw)
2026-06-10 13:23:46.693535 | controller | skipping: [instance] => (item=inet nat)
2026-06-10 13:23:46.694451 | controller | skipping: [instance] => (item=ip filter)
2026-06-10 13:23:46.694535 | controller | skipping: [instance] => (item=ip raw)
2026-06-10 13:23:46.694554 | controller | skipping: [instance] => (item=ip nat)
2026-06-10 13:23:46.694961 | controller | skipping: [instance] => (item=ip6 filter)
2026-06-10 13:23:46.695400 | controller | skipping: [instance] => (item=ip6 raw)
2026-06-10 13:23:46.695711 | controller | skipping: [instance]
2026-06-10 13:23:46.695938 | controller |
2026-06-10 13:23:46.696205 | controller | TASK [osp.edpm.edpm_nftables : Retry loading empty ruleset after cleanup] ******
2026-06-10 13:23:46.696544 | controller | Wednesday 10 June 2026  13:23:46 +0000 (0:00:00.100)       0:00:23.613 ********
2026-06-10 13:23:46.739703 | controller | skipping: [instance]
2026-06-10 13:23:46.740002 | controller |
2026-06-10 13:23:46.740366 | controller | TASK [osp.edpm.edpm_nftables : Get current nftables content] *******************
2026-06-10 13:23:46.740648 | controller | Wednesday 10 June 2026  13:23:46 +0000 (0:00:00.047)       0:00:23.660 ********
2026-06-10 13:23:47.772543 | controller | changed: [instance]
2026-06-10 13:23:47.772586 | controller |
2026-06-10 13:23:47.773084 | controller | TASK [osp.edpm.edpm_nftables : Load firewall snippets] *************************
2026-06-10 13:23:47.773156 | controller | Wednesday 10 June 2026  13:23:47 +0000 (0:00:01.032)       0:00:24.692 ********
2026-06-10 13:23:48.743867 | controller | ok: [instance]
2026-06-10 13:23:48.743891 | controller |
2026-06-10 13:23:48.743896 | controller | TASK [osp.edpm.edpm_nftables : Generate chain jumps] ***************************
2026-06-10 13:23:48.743900 | controller | Wednesday 10 June 2026  13:23:48 +0000 (0:00:00.972)       0:00:25.664 ********
2026-06-10 13:23:50.943399 | controller | changed: [instance]
2026-06-10 13:23:50.943441 | controller |
2026-06-10 13:23:50.943452 | controller | TASK [osp.edpm.edpm_nftables : Generate chain jumps] ***************************
2026-06-10 13:23:50.943461 | controller | Wednesday 10 June 2026  13:23:50 +0000 (0:00:02.198)       0:00:27.862 ********
2026-06-10 13:23:52.948464 | controller | changed: [instance]
2026-06-10 13:23:52.948499 | controller |
2026-06-10 13:23:52.948505 | controller | TASK [osp.edpm.edpm_nftables : Generate nft flushes] ***************************
2026-06-10 13:23:52.948510 | controller | Wednesday 10 June 2026  13:23:52 +0000 (0:00:02.006)       0:00:29.869 ********
2026-06-10 13:23:54.967629 | controller | changed: [instance]
2026-06-10 13:23:54.967685 | controller |
2026-06-10 13:23:54.967819 | controller | TASK [osp.edpm.edpm_nftables : Generate nft edpm chains] ***********************
2026-06-10 13:23:54.967944 | controller | Wednesday 10 June 2026  13:23:54 +0000 (0:00:02.018)       0:00:31.887 ********
2026-06-10 13:23:57.144584 | controller | changed: [instance]
2026-06-10 13:23:57.144625 | controller |
2026-06-10 13:23:57.144647 | controller | TASK [osp.edpm.edpm_nftables : Generate nft ruleset in static file] ************
2026-06-10 13:23:57.144657 | controller | Wednesday 10 June 2026  13:23:57 +0000 (0:00:02.176)       0:00:34.064 ********
2026-06-10 13:23:59.184472 | controller | changed: [instance]
2026-06-10 13:23:59.184777 | controller |
2026-06-10 13:23:59.184811 | controller | TASK [osp.edpm.edpm_nftables : Create a sentinel file when nft rules are changed] ***
2026-06-10 13:23:59.184819 | controller | Wednesday 10 June 2026  13:23:59 +0000 (0:00:02.040)       0:00:36.105 ********
2026-06-10 13:24:00.167225 | controller | changed: [instance]
2026-06-10 13:24:00.167252 | controller |
2026-06-10 13:24:00.167257 | controller | TASK [osp.edpm.edpm_nftables : Validate all of the generated content before loading] ***
2026-06-10 13:24:00.167278 | controller | Wednesday 10 June 2026  13:24:00 +0000 (0:00:00.982)       0:00:37.087 ********
2026-06-10 13:24:01.352236 | controller | changed: [instance]
2026-06-10 13:24:01.352316 | controller |
2026-06-10 13:24:01.352332 | controller | TASK [osp.edpm.edpm_nftables : Ensure we load our different nft rulesets on boot] ***
2026-06-10 13:24:01.352345 | controller | Wednesday 10 June 2026  13:24:01 +0000 (0:00:01.184)       0:00:38.272 ********
2026-06-10 13:24:02.654564 | controller | changed: [instance]
2026-06-10 13:24:02.654607 | controller |
2026-06-10 13:24:02.654613 | controller | TASK [Apply firewall for frr BGP and BFD] **************************************
2026-06-10 13:24:02.654619 | controller | Wednesday 10 June 2026  13:24:02 +0000 (0:00:01.302)       0:00:39.574 ********
2026-06-10 13:24:02.744433 | controller |
2026-06-10 13:24:02.744479 | controller | TASK [osp.edpm.edpm_nftables : Inject our custom chains in nftables] ***********
2026-06-10 13:24:02.744490 | controller | Wednesday 10 June 2026  13:24:02 +0000 (0:00:00.090)       0:00:39.664 ********
2026-06-10 13:24:03.745361 | controller | changed: [instance]
2026-06-10 13:24:03.745392 | controller |
2026-06-10 13:24:03.745405 | controller | TASK [osp.edpm.edpm_nftables : Check if rules are changed] *********************
2026-06-10 13:24:03.745636 | controller | Wednesday 10 June 2026  13:24:03 +0000 (0:00:01.000)       0:00:40.665 ********
2026-06-10 13:24:04.749509 | controller | ok: [instance]
2026-06-10 13:24:04.749555 | controller |
2026-06-10 13:24:04.749565 | controller | TASK [osp.edpm.edpm_nftables : Reload ruleset] *********************************
2026-06-10 13:24:04.749679 | controller | Wednesday 10 June 2026  13:24:04 +0000 (0:00:01.003)       0:00:41.669 ********
2026-06-10 13:24:05.685507 | controller | changed: [instance]
2026-06-10 13:24:05.685545 | controller |
2026-06-10 13:24:05.685556 | controller | TASK [osp.edpm.edpm_nftables : Delete nft_ruleset_changed file] ****************
2026-06-10 13:24:05.685565 | controller | Wednesday 10 June 2026  13:24:05 +0000 (0:00:00.936)       0:00:42.605 ********
2026-06-10 13:24:06.836081 | controller | changed: [instance]
2026-06-10 13:24:06.836109 | controller |
2026-06-10 13:24:06.836117 | controller | TASK [osp.edpm.edpm_frr : Identify the real interfaces via os-net-config] ******
2026-06-10 13:24:06.836123 | controller | Wednesday 10 June 2026  13:24:06 +0000 (0:00:01.150)       0:00:43.756 ********
2026-06-10 13:24:08.284421 | controller | changed: [instance]
2026-06-10 13:24:08.284464 | controller |
2026-06-10 13:24:08.284474 | controller | TASK [osp.edpm.edpm_frr : Os-net-config from json] *****************************
2026-06-10 13:24:08.284482 | controller | Wednesday 10 June 2026  13:24:08 +0000 (0:00:01.448)       0:00:45.204 ********
2026-06-10 13:24:08.327473 | controller | ok: [instance]
2026-06-10 13:24:08.327525 | controller |
2026-06-10 13:24:08.327537 | controller | TASK [osp.edpm.edpm_frr : Assert either edpm_frr_bgp_peers or edpm_frr_bgp_uplinks configured] ***
2026-06-10 13:24:08.327547 | controller | Wednesday 10 June 2026  13:24:08 +0000 (0:00:00.042)       0:00:45.247 ********
2026-06-10 13:24:08.411443 | controller | ok: [instance] => changed=false
2026-06-10 13:24:08.411477 | controller |   msg: All assertions passed
2026-06-10 13:24:08.411488 | controller |
2026-06-10 13:24:08.411880 | controller | TASK [osp.edpm.edpm_frr : Construct FRR uplink interfaces from os-net-config mappings] ***
2026-06-10 13:24:08.411906 | controller | Wednesday 10 June 2026  13:24:08 +0000 (0:00:00.083)       0:00:45.331 ********
2026-06-10 13:24:08.481343 | controller | skipping: [instance]
2026-06-10 13:24:08.481376 | controller |
2026-06-10 13:24:08.481386 | controller | TASK [osp.edpm.edpm_frr : Failed to construct FRR uplink interfaces] ***********
2026-06-10 13:24:08.481396 | controller | Wednesday 10 June 2026  13:24:08 +0000 (0:00:00.069)       0:00:45.401 ********
2026-06-10 13:24:08.542066 | controller | skipping: [instance]
2026-06-10 13:24:08.542360 | controller |
2026-06-10 13:24:08.542576 | controller | TASK [osp.edpm.edpm_frr : Gather facts if they don't exist] ********************
2026-06-10 13:24:08.542760 | controller | Wednesday 10 June 2026  13:24:08 +0000 (0:00:00.061)       0:00:45.462 ********
2026-06-10 13:24:08.610779 | controller | skipping: [instance]
2026-06-10 13:24:08.611080 | controller |
2026-06-10 13:24:08.611422 | controller | TASK [osp.edpm.edpm_frr : Configure FRR] ***************************************
2026-06-10 13:24:08.611712 | controller | Wednesday 10 June 2026  13:24:08 +0000 (0:00:00.068)       0:00:45.531 ********
2026-06-10 13:24:10.583865 | controller | changed: [instance]
2026-06-10 13:24:10.583890 | controller |
2026-06-10 13:24:10.583895 | controller | TASK [osp.edpm.edpm_frr : Configure FRR daemons] *******************************
2026-06-10 13:24:10.583899 | controller | Wednesday 10 June 2026  13:24:10 +0000 (0:00:01.973)       0:00:47.504 ********
2026-06-10 13:24:12.489105 | controller | changed: [instance]
2026-06-10 13:24:12.489131 | controller |
2026-06-10 13:24:12.489138 | controller | TASK [osp.edpm.edpm_frr : Set role path for template resolution] ***************
2026-06-10 13:24:12.489144 | controller | Wednesday 10 June 2026  13:24:12 +0000 (0:00:01.905)       0:00:49.409 ********
2026-06-10 13:24:12.531439 | controller | ok: [instance]
2026-06-10 13:24:12.531472 | controller |
2026-06-10 13:24:12.531478 | controller | TASK [Run frr container] *******************************************************
2026-06-10 13:24:12.531483 | controller | Wednesday 10 June 2026  13:24:12 +0000 (0:00:00.042)       0:00:49.452 ********
2026-06-10 13:24:12.616534 | controller |
2026-06-10 13:24:12.616567 | controller | TASK [osp.edpm.edpm_container_standalone : Validating arguments against arg spec 'main' - The main entry point for the edpm_container_standalone role.] ***
2026-06-10 13:24:12.616589 | controller | Wednesday 10 June 2026  13:24:12 +0000 (0:00:00.085)       0:00:49.537 ********
2026-06-10 13:24:12.691379 | controller | ok: [instance]
2026-06-10 13:24:12.691503 | controller |
2026-06-10 13:24:12.691510 | controller | TASK [osp.edpm.edpm_container_standalone : Ensure /var/lib/edpm-config exists with correct ownership] ***
2026-06-10 13:24:12.691516 | controller | Wednesday 10 June 2026  13:24:12 +0000 (0:00:00.074)       0:00:49.612 ********
2026-06-10 13:24:13.626524 | controller | changed: [instance]
2026-06-10 13:24:13.626554 | controller |
2026-06-10 13:24:13.626560 | controller | TASK [osp.edpm.edpm_container_standalone : Ensure directory exists: /var/lib/kolla/config_files] ***
2026-06-10 13:24:13.626575 | controller | Wednesday 10 June 2026  13:24:13 +0000 (0:00:00.934)       0:00:50.546 ********
2026-06-10 13:24:14.553157 | controller | changed: [instance]
2026-06-10 13:24:14.553197 | controller |
2026-06-10 13:24:14.553208 | controller | TASK [osp.edpm.edpm_container_standalone : Create kolla config files] **********
2026-06-10 13:24:14.553218 | controller | Wednesday 10 June 2026  13:24:14 +0000 (0:00:00.925)       0:00:51.472 ********
2026-06-10 13:24:16.446536 | controller | changed: [instance] => (item={'key': 'frr', 'value': {'command': 'bash -c $* -- eval if [ -f /usr/libexec/frr/frrinit.sh ]; then /usr/libexec/frr/frrinit.sh start; else /usr/lib/frr/frr start; fi  && exec /bin/sleep infinity', 'config_files': [{'source': '/var/lib/kolla/config_files/src/etc/frr/*', 'dest': '/etc/frr/', 'merge': True, 'preserve_properties': True}], 'permissions': [{'path': '/run/frr', 'owner': 'frr:frrvty', 'recurse': True}]}})
2026-06-10 13:24:16.446566 | controller |
2026-06-10 13:24:16.446572 | controller | TASK [osp.edpm.edpm_container_standalone : Deploy containers via Quadlet: [ frr ]] ***
2026-06-10 13:24:16.446577 | controller | Wednesday 10 June 2026  13:24:16 +0000 (0:00:01.894)       0:00:53.367 ********
2026-06-10 13:24:16.515424 | controller | included: /home/zuul/.cache/ansible-compat/8075a4/collections/ansible_collections/osp/edpm/roles/edpm_container_standalone/tasks/quadlet.yml for instance
2026-06-10 13:24:16.515458 | controller |
2026-06-10 13:24:16.515627 | controller | TASK [osp.edpm.edpm_container_standalone : Ensure quadlet directory exists] ****
2026-06-10 13:24:16.515648 | controller | Wednesday 10 June 2026  13:24:16 +0000 (0:00:00.069)       0:00:53.436 ********
2026-06-10 13:24:17.367021 | controller | ok: [instance]
2026-06-10 13:24:17.367048 | controller |
2026-06-10 13:24:17.367053 | controller | TASK [osp.edpm.edpm_container_standalone : Ensure quadlet staging directory exists] ***
2026-06-10 13:24:17.367057 | controller | Wednesday 10 June 2026  13:24:17 +0000 (0:00:00.850)       0:00:54.287 ********
2026-06-10 13:24:18.265391 | controller | changed: [instance]
2026-06-10 13:24:18.265665 | controller |
2026-06-10 13:24:18.265693 | controller | TASK [osp.edpm.edpm_container_standalone : Render Quadlet templates for frr] ***
2026-06-10 13:24:18.265698 | controller | Wednesday 10 June 2026  13:24:18 +0000 (0:00:00.898)       0:00:55.185 ********
2026-06-10 13:24:20.018708 | controller | changed: [instance] => (item=frr)
2026-06-10 13:24:20.018734 | controller |
2026-06-10 13:24:20.018739 | controller | TASK [osp.edpm.edpm_container_standalone : Compute and inject config hashes for frr] ***
2026-06-10 13:24:20.018744 | controller | Wednesday 10 June 2026  13:24:20 +0000 (0:00:01.753)       0:00:56.939 ********
2026-06-10 13:24:20.896218 | controller | ok: [instance]
2026-06-10 13:24:20.896244 | controller |
2026-06-10 13:24:20.896249 | controller | TASK [osp.edpm.edpm_container_standalone : Deploy Quadlet .container files for frr] ***
2026-06-10 13:24:20.896253 | controller | Wednesday 10 June 2026  13:24:20 +0000 (0:00:00.877)       0:00:57.816 ********
2026-06-10 13:24:21.696019 | controller | changed: [instance] => (item=frr)
2026-06-10 13:24:21.696045 | controller |
2026-06-10 13:24:21.696050 | controller | TASK [osp.edpm.edpm_container_standalone : Identify changed containers] ********
2026-06-10 13:24:21.696054 | controller | Wednesday 10 June 2026  13:24:21 +0000 (0:00:00.800)       0:00:58.616 ********
2026-06-10 13:24:21.747654 | controller | ok: [instance]
2026-06-10 13:24:21.747681 | controller |
2026-06-10 13:24:21.747687 | controller | TASK [osp.edpm.edpm_container_standalone : Reload systemd daemon for quadlet generator] ***
2026-06-10 13:24:21.747692 | controller | Wednesday 10 June 2026  13:24:21 +0000 (0:00:00.051)       0:00:58.668 ********
2026-06-10 13:24:23.050651 | controller | ok: [instance]
2026-06-10 13:24:23.050740 | controller |
2026-06-10 13:24:23.050752 | controller | TASK [osp.edpm.edpm_container_standalone : Restart changed Quadlet containers for frr] ***
2026-06-10 13:24:23.050762 | controller | Wednesday 10 June 2026  13:24:23 +0000 (0:00:01.302)       0:00:59.970 ********
2026-06-10 13:24:24.340868 | controller | changed: [instance] => (item=frr)
2026-06-10 13:24:24.340895 | controller |
2026-06-10 13:24:24.340900 | controller | TASK [osp.edpm.edpm_container_standalone : Create config dir /var/lib/edpm-config/container-startup-config/frr] ***
2026-06-10 13:24:24.340904 | controller | Wednesday 10 June 2026  13:24:24 +0000 (0:00:01.290)       0:01:01.261 ********
2026-06-10 13:24:24.399374 | controller | skipping: [instance]
2026-06-10 13:24:24.399417 | controller |
2026-06-10 13:24:24.399426 | controller | TASK [osp.edpm.edpm_container_standalone : Render container definitions: [frr ]] ***
2026-06-10 13:24:24.399439 | controller | Wednesday 10 June 2026  13:24:24 +0000 (0:00:00.058)       0:01:01.320 ********
2026-06-10 13:24:24.452136 | controller | skipping: [instance]
2026-06-10 13:24:24.452163 | controller |
2026-06-10 13:24:24.452168 | controller | TASK [Run containers: [ frr ]] *************************************************
2026-06-10 13:24:24.452172 | controller | Wednesday 10 June 2026  13:24:24 +0000 (0:00:00.052)       0:01:01.372 ********
2026-06-10 13:24:24.505844 | controller | skipping: [instance]
2026-06-10 13:24:24.506496 | controller |
2026-06-10 13:24:24.506515 | controller | TASK [osp.edpm.edpm_container_standalone : Update service state file] **********
2026-06-10 13:24:24.506524 | controller | Wednesday 10 June 2026  13:24:24 +0000 (0:00:00.053)       0:01:01.426 ********
2026-06-10 13:24:24.599424 | controller | included: /home/zuul/.cache/ansible-compat/8075a4/collections/ansible_collections/osp/edpm/roles/edpm_container_standalone/tasks/state_file_update.yml for instance
2026-06-10 13:24:24.599468 | controller |
2026-06-10 13:24:24.599481 | controller | TASK [osp.edpm.edpm_container_standalone : Read current state file] ************
2026-06-10 13:24:24.599494 | controller | Wednesday 10 June 2026  13:24:24 +0000 (0:00:00.093)       0:01:01.519 ********
2026-06-10 13:24:25.720330 | controller | ok: [instance]
2026-06-10 13:24:25.720372 | controller |
2026-06-10 13:24:25.720381 | controller | TASK [osp.edpm.edpm_container_standalone : Parse state file data] **************
2026-06-10 13:24:25.720390 | controller | Wednesday 10 June 2026  13:24:25 +0000 (0:00:01.120)       0:01:02.640 ********
2026-06-10 13:24:25.824463 | controller | ok: [instance]
2026-06-10 13:24:25.824497 | controller |
2026-06-10 13:24:25.824804 | controller | TASK [osp.edpm.edpm_container_standalone : Determine service name for state file] ***
2026-06-10 13:24:25.824844 | controller | Wednesday 10 June 2026  13:24:25 +0000 (0:00:00.104)       0:01:02.744 ********
2026-06-10 13:24:25.900553 | controller | ok: [instance]
2026-06-10 13:24:25.900596 | controller |
2026-06-10 13:24:25.900604 | controller | TASK [osp.edpm.edpm_container_standalone : Remove container from service containers list] ***
2026-06-10 13:24:25.900610 | controller | Wednesday 10 June 2026  13:24:25 +0000 (0:00:00.075)       0:01:02.820 ********
2026-06-10 13:24:25.949929 | controller | skipping: [instance]
2026-06-10 13:24:25.950125 | controller |
2026-06-10 13:24:25.950444 | controller | TASK [osp.edpm.edpm_container_standalone : Update service with remaining containers] ***
2026-06-10 13:24:25.950775 | controller | Wednesday 10 June 2026  13:24:25 +0000 (0:00:00.050)       0:01:02.870 ********
2026-06-10 13:24:26.000862 | controller | skipping: [instance]
2026-06-10 13:24:26.001072 | controller |
2026-06-10 13:24:26.001365 | controller | TASK [osp.edpm.edpm_container_standalone : Build filtered services dict (exclude empty service)] ***
2026-06-10 13:24:26.001632 | controller | Wednesday 10 June 2026  13:24:25 +0000 (0:00:00.051)       0:01:02.921 ********
2026-06-10 13:24:26.064071 | controller | skipping: [instance]
2026-06-10 13:24:26.064285 | controller |
2026-06-10 13:24:26.064678 | controller | TASK [osp.edpm.edpm_container_standalone : Update state data without empty service] ***
2026-06-10 13:24:26.064933 | controller | Wednesday 10 June 2026  13:24:26 +0000 (0:00:00.063)       0:01:02.984 ********
2026-06-10 13:24:26.115120 | controller | skipping: [instance]
2026-06-10 13:24:26.115354 | controller |
2026-06-10 13:24:26.115650 | controller | TASK [osp.edpm.edpm_container_standalone : Determine container names from definitions] ***
2026-06-10 13:24:26.115924 | controller | Wednesday 10 June 2026  13:24:26 +0000 (0:00:00.050)       0:01:03.035 ********
2026-06-10 13:24:26.176752 | controller | ok: [instance]
2026-06-10 13:24:26.177062 | controller |
2026-06-10 13:24:26.177494 | controller | TASK [osp.edpm.edpm_container_standalone : Update service in state data] *******
2026-06-10 13:24:26.177918 | controller | Wednesday 10 June 2026  13:24:26 +0000 (0:00:00.061)       0:01:03.097 ********
2026-06-10 13:24:26.251039 | controller | ok: [instance]
2026-06-10 13:24:26.251187 | controller |
2026-06-10 13:24:26.251463 | controller | TASK [osp.edpm.edpm_container_standalone : Write updated state file] ***********
2026-06-10 13:24:26.251687 | controller | Wednesday 10 June 2026  13:24:26 +0000 (0:00:00.074)       0:01:03.171 ********
2026-06-10 13:24:28.221557 | controller | changed: [instance]
2026-06-10 13:24:28.221603 | controller |
2026-06-10 13:24:28.221614 | controller | PLAY RECAP *********************************************************************
2026-06-10 13:24:28.221623 | controller | instance                   : ok=52   changed=32   unreachable=0    failed=0    skipped=13   rescued=0    ignored=0
2026-06-10 13:24:28.223863 | controller |
2026-06-10 13:24:28.223893 | controller | Wednesday 10 June 2026  13:24:28 +0000 (0:00:01.970)       0:01:05.141 ********
2026-06-10 13:24:28.223899 | controller | ===============================================================================
2026-06-10 13:24:28.223903 | controller | osp.edpm.edpm_frr : Download needed container images -------------------- 6.56s
2026-06-10 13:24:28.223907 | controller | osp.edpm.edpm_frr : Create persistent directories ----------------------- 2.80s
2026-06-10 13:24:28.223911 | controller | osp.edpm.edpm_nftables : Push default ruleset snipet -------------------- 2.56s
2026-06-10 13:24:28.223915 | controller | osp.edpm.edpm_nftables : Generate chain jumps --------------------------- 2.20s
2026-06-10 13:24:28.223918 | controller | osp.edpm.edpm_nftables : Generate nft edpm chains ----------------------- 2.18s
2026-06-10 13:24:28.223922 | controller | osp.edpm.edpm_frr : Ensure /run/frr is present upon reboot -------------- 2.06s
2026-06-10 13:24:28.223927 | controller | osp.edpm.edpm_nftables : Generate nft ruleset in static file ------------ 2.04s
2026-06-10 13:24:28.223932 | controller | osp.edpm.edpm_nftables : Push empty ruleset ----------------------------- 2.03s
2026-06-10 13:24:28.223937 | controller | osp.edpm.edpm_nftables : Generate nft flushes --------------------------- 2.02s
2026-06-10 13:24:28.223942 | controller | osp.edpm.edpm_nftables : Generate chain jumps --------------------------- 2.01s
2026-06-10 13:24:28.223947 | controller | osp.edpm.edpm_frr : Configure FRR --------------------------------------- 1.97s
2026-06-10 13:24:28.223952 | controller | osp.edpm.edpm_container_standalone : Write updated state file ----------- 1.97s
2026-06-10 13:24:28.223957 | controller | osp.edpm.edpm_frr : Configure FRR daemons ------------------------------- 1.91s
2026-06-10 13:24:28.223961 | controller | osp.edpm.edpm_container_standalone : Create kolla config files ---------- 1.89s
2026-06-10 13:24:28.223965 | controller | osp.edpm.edpm_nftables : Write user rules snippet ----------------------- 1.75s
2026-06-10 13:24:28.223969 | controller | osp.edpm.edpm_container_standalone : Render Quadlet templates for frr --- 1.75s
2026-06-10 13:24:28.223973 | controller | osp.edpm.edpm_frr : Identify the real interfaces via os-net-config ------ 1.45s
2026-06-10 13:24:28.223977 | controller | osp.edpm.edpm_container_standalone : Reload systemd daemon for quadlet generator --- 1.30s
2026-06-10 13:24:28.223981 | controller | osp.edpm.edpm_nftables : Ensure we load our different nft rulesets on boot --- 1.30s
2026-06-10 13:24:28.223985 | controller | osp.edpm.edpm_nftables : Load empty ruleset ----------------------------- 1.29s
2026-06-10 13:24:28.337813 | controller | INFO     Running default > verify
2026-06-10 13:24:28.338784 | controller | INFO     Running Ansible Verifier
2026-06-10 13:24:28.907256 | controller |
2026-06-10 13:24:28.907712 | controller | PLAY [Verify frr] **************************************************************
2026-06-10 13:24:28.908031 | controller |
2026-06-10 13:24:28.908349 | controller | TASK [Ensure expected directories exist] ***************************************
2026-06-10 13:24:28.908653 | controller | Wednesday 10 June 2026  13:24:28 +0000 (0:00:00.068)       0:00:00.068 ********
2026-06-10 13:24:28.984792 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for instance => (item=/var/lib/openstack/frr)
2026-06-10 13:24:28.985135 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for instance => (item=/etc/tmpfiles.d/)
2026-06-10 13:24:28.985478 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_dir.yaml for instance => (item=/var/lib/openstack/frr/etc/frr)
2026-06-10 13:24:28.985753 | controller |
2026-06-10 13:24:28.986040 | controller | TASK [Check if directory exists /var/lib/openstack/frr] ************************
2026-06-10 13:24:28.986358 | controller | Wednesday 10 June 2026  13:24:28 +0000 (0:00:00.077)       0:00:00.146 ********
2026-06-10 13:24:29.975415 | controller | ok: [instance]
2026-06-10 13:24:29.975450 | controller |
2026-06-10 13:24:29.975550 | controller | TASK [Assert directory exists /var/lib/openstack/frr] **************************
2026-06-10 13:24:29.975562 | controller | Wednesday 10 June 2026  13:24:29 +0000 (0:00:00.990)       0:00:01.136 ********
2026-06-10 13:24:30.020074 | controller | ok: [instance] => changed=false
2026-06-10 13:24:30.020100 | controller |   msg: All assertions passed
2026-06-10 13:24:30.020106 | controller |
2026-06-10 13:24:30.020110 | controller | TASK [Check if directory exists /etc/tmpfiles.d/] ******************************
2026-06-10 13:24:30.020114 | controller | Wednesday 10 June 2026  13:24:30 +0000 (0:00:00.044)       0:00:01.181 ********
2026-06-10 13:24:30.833202 | controller | ok: [instance]
2026-06-10 13:24:30.833240 | controller |
2026-06-10 13:24:30.833251 | controller | TASK [Assert directory exists /etc/tmpfiles.d/] ********************************
2026-06-10 13:24:30.833293 | controller | Wednesday 10 June 2026  13:24:30 +0000 (0:00:00.812)       0:00:01.994 ********
2026-06-10 13:24:30.881451 | controller | ok: [instance] => changed=false
2026-06-10 13:24:30.881493 | controller |   msg: All assertions passed
2026-06-10 13:24:30.881507 | controller |
2026-06-10 13:24:30.881519 | controller | TASK [Check if directory exists /var/lib/openstack/frr/etc/frr] ****************
2026-06-10 13:24:30.881530 | controller | Wednesday 10 June 2026  13:24:30 +0000 (0:00:00.048)       0:00:02.042 ********
2026-06-10 13:24:31.923440 | controller | ok: [instance]
2026-06-10 13:24:31.923467 | controller |
2026-06-10 13:24:31.923472 | controller | TASK [Assert directory exists /var/lib/openstack/frr/etc/frr] ******************
2026-06-10 13:24:31.923476 | controller | Wednesday 10 June 2026  13:24:31 +0000 (0:00:01.042)       0:00:03.084 ********
2026-06-10 13:24:31.967398 | controller | ok: [instance] => changed=false
2026-06-10 13:24:31.967429 | controller |   msg: All assertions passed
2026-06-10 13:24:31.967745 | controller |
2026-06-10 13:24:31.967773 | controller | TASK [Ensure Quadlet .container file exists] ***********************************
2026-06-10 13:24:31.967780 | controller | Wednesday 10 June 2026  13:24:31 +0000 (0:00:00.044)       0:00:03.128 ********
2026-06-10 13:24:32.783678 | controller | ok: [instance]
2026-06-10 13:24:32.783775 | controller |
2026-06-10 13:24:32.783789 | controller | TASK [Ensure staged Quadlet file exists] ***************************************
2026-06-10 13:24:32.783867 | controller | Wednesday 10 June 2026  13:24:32 +0000 (0:00:00.816)       0:00:03.945 ********
2026-06-10 13:24:33.799068 | controller | ok: [instance]
2026-06-10 13:24:33.799117 | controller |
2026-06-10 13:24:33.799135 | controller | TASK [Read Quadlet file content] ***********************************************
2026-06-10 13:24:33.799142 | controller | Wednesday 10 June 2026  13:24:33 +0000 (0:00:01.014)       0:00:04.959 ********
2026-06-10 13:24:35.085798 | controller | ok: [instance]
2026-06-10 13:24:35.085837 | controller |
2026-06-10 13:24:35.085848 | controller | TASK [Verify config_hash is populated in Quadlet file] *************************
2026-06-10 13:24:35.085857 | controller | Wednesday 10 June 2026  13:24:35 +0000 (0:00:01.286)       0:00:06.246 ********
2026-06-10 13:24:35.150513 | controller | ok: [instance] => changed=false
2026-06-10 13:24:35.150554 | controller |   msg: All assertions passed
2026-06-10 13:24:35.150565 | controller |
2026-06-10 13:24:35.151094 | controller | TASK [Check if /etc/tmpfiles.d/run-frr.conf exists] ****************************
2026-06-10 13:24:35.151140 | controller | Wednesday 10 June 2026  13:24:35 +0000 (0:00:00.064)       0:00:06.311 ********
2026-06-10 13:24:36.263512 | controller | ok: [instance]
2026-06-10 13:24:36.263570 | controller |
2026-06-10 13:24:36.263581 | controller | TASK [Assert /etc/tmpfiles.d/run-frr.conf exists] ******************************
2026-06-10 13:24:36.263599 | controller | Wednesday 10 June 2026  13:24:36 +0000 (0:00:01.113)       0:00:07.424 ********
2026-06-10 13:24:36.344399 | controller | ok: [instance] => changed=false
2026-06-10 13:24:36.344458 | controller |   msg: All assertions passed
2026-06-10 13:24:36.344468 | controller |
2026-06-10 13:24:36.344475 | controller | TASK [Check if frr.conf exists] ************************************************
2026-06-10 13:24:36.344482 | controller | Wednesday 10 June 2026  13:24:36 +0000 (0:00:00.080)       0:00:07.504 ********
2026-06-10 13:24:37.487939 | controller | ok: [instance]
2026-06-10 13:24:37.487992 | controller |
2026-06-10 13:24:37.488007 | controller | TASK [Assert frr.conf exists] **************************************************
2026-06-10 13:24:37.488020 | controller | Wednesday 10 June 2026  13:24:37 +0000 (0:00:01.142)       0:00:08.647 ********
2026-06-10 13:24:37.525903 | controller | ok: [instance] => changed=false
2026-06-10 13:24:37.525939 | controller |   msg: All assertions passed
2026-06-10 13:24:37.525946 | controller |
2026-06-10 13:24:37.525952 | controller | TASK [Check if daemons file exists] ********************************************
2026-06-10 13:24:37.525957 | controller | Wednesday 10 June 2026  13:24:37 +0000 (0:00:00.039)       0:00:08.686 ********
2026-06-10 13:24:38.674281 | controller | ok: [instance]
2026-06-10 13:24:38.674335 | controller |
2026-06-10 13:24:38.674343 | controller | TASK [Assert daemons file exists] **********************************************
2026-06-10 13:24:38.674351 | controller | Wednesday 10 June 2026  13:24:38 +0000 (0:00:01.147)       0:00:09.834 ********
2026-06-10 13:24:38.721548 | controller | ok: [instance] => changed=false
2026-06-10 13:24:38.722185 | controller |   msg: All assertions passed
2026-06-10 13:24:38.722225 | controller |
2026-06-10 13:24:38.722236 | controller | TASK [Rule source file exists] *************************************************
2026-06-10 13:24:38.722246 | controller | Wednesday 10 June 2026  13:24:38 +0000 (0:00:00.047)       0:00:09.882 ********
2026-06-10 13:24:39.686879 | controller | ok: [instance]
2026-06-10 13:24:39.686945 | controller |
2026-06-10 13:24:39.686952 | controller | TASK [Assert FRR BGP and BFD rule source file exists] **************************
2026-06-10 13:24:39.686958 | controller | Wednesday 10 June 2026  13:24:39 +0000 (0:00:00.965)       0:00:10.848 ********
2026-06-10 13:24:39.768508 | controller | ok: [instance] => changed=false
2026-06-10 13:24:39.768546 | controller |   msg: All assertions passed
2026-06-10 13:24:39.769185 | controller |
2026-06-10 13:24:39.769222 | controller | TASK [Check if nftables rule exists in /etc/nftables/edpm-rules.nft] ***********
2026-06-10 13:24:39.769233 | controller | Wednesday 10 June 2026  13:24:39 +0000 (0:00:00.081)       0:00:10.929 ********
2026-06-10 13:24:41.618441 | controller | changed: [instance] => (item=121 frr bgp port)
2026-06-10 13:24:41.618487 | controller | changed: [instance] => (item=122 frr bfd ports)
2026-06-10 13:24:41.618497 | controller |
2026-06-10 13:24:41.618505 | controller | TASK [Assert nftables rules exist] *********************************************
2026-06-10 13:24:41.618514 | controller | Wednesday 10 June 2026  13:24:41 +0000 (0:00:01.849)       0:00:12.778 ********
2026-06-10 13:24:41.667429 | controller | ok: [instance] => (item=121 frr bgp port) => changed=false
2026-06-10 13:24:41.667459 | controller |   ansible_loop_var: item
2026-06-10 13:24:41.667465 | controller |   item:
2026-06-10 13:24:41.667471 | controller |     ansible_loop_var: item
2026-06-10 13:24:41.667476 | controller |     changed: true
2026-06-10 13:24:41.667481 | controller |     cmd: grep -q "121 frr bgp port" /etc/nftables/edpm-rules.nft
2026-06-10 13:24:41.667486 | controller |     delta: '0:00:00.003930'
2026-06-10 13:24:41.669353 | controller |     end: '2026-06-10 13:24:40.558010'
2026-06-10 13:24:41.669383 | controller |     failed: false
2026-06-10 13:24:41.669388 | controller |     invocation:
2026-06-10 13:24:41.669392 | controller |       module_args:
2026-06-10 13:24:41.669396 | controller |         _raw_params: grep -q "121 frr bgp port" /etc/nftables/edpm-rules.nft
2026-06-10 13:24:41.669400 | controller |         _uses_shell: true
2026-06-10 13:24:41.669404 | controller |         argv: null
2026-06-10 13:24:41.669408 | controller |         chdir: null
2026-06-10 13:24:41.669411 | controller |         creates: null
2026-06-10 13:24:41.669415 | controller |         executable: null
2026-06-10 13:24:41.669418 | controller |         removes: null
2026-06-10 13:24:41.669422 | controller |         stdin: null
2026-06-10 13:24:41.669426 | controller |         stdin_add_newline: true
2026-06-10 13:24:41.669429 | controller |         strip_empty_ends: true
2026-06-10 13:24:41.669433 | controller |     item: 121 frr bgp port
2026-06-10 13:24:41.669437 | controller |     msg: ''
2026-06-10 13:24:41.669444 | controller |     rc: 0
2026-06-10 13:24:41.669563 | controller |     start: '2026-06-10 13:24:40.554080'
2026-06-10 13:24:41.669701 | controller |     stderr: ''
2026-06-10 13:24:41.669849 | controller |     stderr_lines: []
2026-06-10 13:24:41.669994 | controller |     stdout: ''
2026-06-10 13:24:41.670141 | controller |     stdout_lines: []
2026-06-10 13:24:41.670295 | controller |   msg: All assertions passed
2026-06-10 13:24:41.670454 | controller | ok: [instance] => (item=122 frr bfd ports) => changed=false
2026-06-10 13:24:41.670601 | controller |   ansible_loop_var: item
2026-06-10 13:24:41.670758 | controller |   item:
2026-06-10 13:24:41.670931 | controller |     ansible_loop_var: item
2026-06-10 13:24:41.671096 | controller |     changed: true
2026-06-10 13:24:41.671305 | controller |     cmd: grep -q "122 frr bfd ports" /etc/nftables/edpm-rules.nft
2026-06-10 13:24:41.671486 | controller |     delta: '0:00:00.003124'
2026-06-10 13:24:41.671654 | controller |     end: '2026-06-10 13:24:41.411251'
2026-06-10 13:24:41.671820 | controller |     failed: false
2026-06-10 13:24:41.672027 | controller |     invocation:
2026-06-10 13:24:41.672258 | controller |       module_args:
2026-06-10 13:24:41.672482 | controller |         _raw_params: grep -q "122 frr bfd ports" /etc/nftables/edpm-rules.nft
2026-06-10 13:24:41.672661 | controller |         _uses_shell: true
2026-06-10 13:24:41.672843 | controller |         argv: null
2026-06-10 13:24:41.673012 | controller |         chdir: null
2026-06-10 13:24:41.673210 | controller |         creates: null
2026-06-10 13:24:41.673407 | controller |         executable: null
2026-06-10 13:24:41.673583 | controller |         removes: null
2026-06-10 13:24:41.673746 | controller |         stdin: null
2026-06-10 13:24:41.673923 | controller |         stdin_add_newline: true
2026-06-10 13:24:41.674090 | controller |         strip_empty_ends: true
2026-06-10 13:24:41.674253 | controller |     item: 122 frr bfd ports
2026-06-10 13:24:41.674447 | controller |     msg: ''
2026-06-10 13:24:41.674609 | controller |     rc: 0
2026-06-10 13:24:41.674773 | controller |     start: '2026-06-10 13:24:41.408127'
2026-06-10 13:24:41.674935 | controller |     stderr: ''
2026-06-10 13:24:41.675098 | controller |     stderr_lines: []
2026-06-10 13:24:41.675259 | controller |     stdout: ''
2026-06-10 13:24:41.675478 | controller |     stdout_lines: []
2026-06-10 13:24:41.675643 | controller |   msg: All assertions passed
2026-06-10 13:24:41.675797 | controller |
2026-06-10 13:24:41.675966 | controller | TASK [Check rule content] ******************************************************
2026-06-10 13:24:41.676140 | controller | Wednesday 10 June 2026  13:24:41 +0000 (0:00:00.049)       0:00:12.828 ********
2026-06-10 13:24:44.642468 | controller | changed: [instance] => (item=tcp dport { 179 } ct state new counter accept)
2026-06-10 13:24:44.642508 | controller | changed: [instance] => (item=udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept)
2026-06-10 13:24:44.643349 | controller |
2026-06-10 13:24:44.643378 | controller | TASK [Assert rule content exists] **********************************************
2026-06-10 13:24:44.643383 | controller | Wednesday 10 June 2026  13:24:44 +0000 (0:00:02.974)       0:00:15.803 ********
2026-06-10 13:24:44.688423 | controller | ok: [instance] => (item=tcp dport { 179 } ct state new counter accept) => changed=false
2026-06-10 13:24:44.688478 | controller |   ansible_loop_var: item
2026-06-10 13:24:44.688485 | controller |   item:
2026-06-10 13:24:44.688490 | controller |     ansible_loop_var: item
2026-06-10 13:24:44.688494 | controller |     changed: true
2026-06-10 13:24:44.688570 | controller |     cmd: grep -q "tcp dport { 179 } ct state new counter accept" /etc/nftables/edpm-rules.nft
2026-06-10 13:24:44.688813 | controller |     delta: '0:00:01.005734'
2026-06-10 13:24:44.689061 | controller |     end: '2026-06-10 13:24:43.482655'
2026-06-10 13:24:44.689287 | controller |     failed: false
2026-06-10 13:24:44.689572 | controller |     invocation:
2026-06-10 13:24:44.689796 | controller |       module_args:
2026-06-10 13:24:44.690035 | controller |         _raw_params: grep -q "tcp dport { 179 } ct state new counter accept" /etc/nftables/edpm-rules.nft
2026-06-10 13:24:44.690285 | controller |         _uses_shell: true
2026-06-10 13:24:44.690581 | controller |         argv: null
2026-06-10 13:24:44.690814 | controller |         chdir: null
2026-06-10 13:24:44.691054 | controller |         creates: null
2026-06-10 13:24:44.691283 | controller |         executable: null
2026-06-10 13:24:44.691543 | controller |         removes: null
2026-06-10 13:24:44.691805 | controller |         stdin: null
2026-06-10 13:24:44.692053 | controller |         stdin_add_newline: true
2026-06-10 13:24:44.692285 | controller |         strip_empty_ends: true
2026-06-10 13:24:44.692569 | controller |     item: tcp dport { 179 } ct state new counter accept
2026-06-10 13:24:44.692823 | controller |     msg: ''
2026-06-10 13:24:44.693102 | controller |     rc: 0
2026-06-10 13:24:44.693363 | controller |     start: '2026-06-10 13:24:42.476921'
2026-06-10 13:24:44.693598 | controller |     stderr: ''
2026-06-10 13:24:44.693843 | controller |     stderr_lines: []
2026-06-10 13:24:44.694077 | controller |     stdout: ''
2026-06-10 13:24:44.694347 | controller |     stdout_lines: []
2026-06-10 13:24:44.694590 | controller |   msg: All assertions passed
2026-06-10 13:24:44.694837 | controller | ok: [instance] => (item=udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept) => changed=false
2026-06-10 13:24:44.695061 | controller |   ansible_loop_var: item
2026-06-10 13:24:44.695322 | controller |   item:
2026-06-10 13:24:44.695590 | controller |     ansible_loop_var: item
2026-06-10 13:24:44.695859 | controller |     changed: true
2026-06-10 13:24:44.696105 | controller |     cmd: grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept" /etc/nftables/edpm-rules.nft
2026-06-10 13:24:44.696385 | controller |     delta: '0:00:00.003199'
2026-06-10 13:24:44.696739 | controller |     end: '2026-06-10 13:24:44.402103'
2026-06-10 13:24:44.697020 | controller |     failed: false
2026-06-10 13:24:44.697444 | controller |     invocation:
2026-06-10 13:24:44.697712 | controller |       module_args:
2026-06-10 13:24:44.697993 | controller |         _raw_params: grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept" /etc/nftables/edpm-rules.nft
2026-06-10 13:24:44.698243 | controller |         _uses_shell: true
2026-06-10 13:24:44.698533 | controller |         argv: null
2026-06-10 13:24:44.698776 | controller |         chdir: null
2026-06-10 13:24:44.699012 | controller |         creates: null
2026-06-10 13:24:44.699253 | controller |         executable: null
2026-06-10 13:24:44.699556 | controller |         removes: null
2026-06-10 13:24:44.699818 | controller |         stdin: null
2026-06-10 13:24:44.700093 | controller |         stdin_add_newline: true
2026-06-10 13:24:44.700385 | controller |         strip_empty_ends: true
2026-06-10 13:24:44.700640 | controller |     item: udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter accept
2026-06-10 13:24:44.700886 | controller |     msg: ''
2026-06-10 13:24:44.701118 | controller |     rc: 0
2026-06-10 13:24:44.701624 | controller |     start: '2026-06-10 13:24:44.398904'
2026-06-10 13:24:44.701894 | controller |     stderr: ''
2026-06-10 13:24:44.702195 | controller |     stderr_lines: []
2026-06-10 13:24:44.702485 | controller |     stdout: ''
2026-06-10 13:24:44.702757 | controller |     stdout_lines: []
2026-06-10 13:24:44.703001 | controller |   msg: All assertions passed
2026-06-10 13:24:44.703231 | controller |
2026-06-10 13:24:44.703534 | controller | TASK [Check input chain rules are loaded] **************************************
2026-06-10 13:24:44.703816 | controller | Wednesday 10 June 2026  13:24:44 +0000 (0:00:00.045)       0:00:15.848 ********
2026-06-10 13:24:46.348466 | controller | changed: [instance] => (item=tcp dport 179 ct state new counter)
2026-06-10 13:24:46.348508 | controller | changed: [instance] => (item=udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter)
2026-06-10 13:24:46.348518 | controller |
2026-06-10 13:24:46.348527 | controller | TASK [Assert input chain rules are loaded] *************************************
2026-06-10 13:24:46.348541 | controller | Wednesday 10 June 2026  13:24:46 +0000 (0:00:01.660)       0:00:17.509 ********
2026-06-10 13:24:46.419402 | controller | ok: [instance] => (item=tcp dport 179 ct state new counter) => changed=false
2026-06-10 13:24:46.419434 | controller |   ansible_loop_var: item
2026-06-10 13:24:46.419439 | controller |   item:
2026-06-10 13:24:46.419444 | controller |     ansible_loop_var: item
2026-06-10 13:24:46.419449 | controller |     changed: true
2026-06-10 13:24:46.419453 | controller |     cmd: nft list table inet filter | awk '/chain EDPM_INPUT {/,/}/' | grep -q "tcp dport 179 ct state new counter.*accept"
2026-06-10 13:24:46.419458 | controller |     delta: '0:00:00.008148'
2026-06-10 13:24:46.419462 | controller |     end: '2026-06-10 13:24:45.358333'
2026-06-10 13:24:46.419467 | controller |     failed: false
2026-06-10 13:24:46.421360 | controller |     invocation:
2026-06-10 13:24:46.421393 | controller |       module_args:
2026-06-10 13:24:46.421400 | controller |         _raw_params: nft list table inet filter | awk '/chain EDPM_INPUT {/,/}/' | grep -q "tcp dport 179 ct state new counter.*accept"
2026-06-10 13:24:46.421405 | controller |         _uses_shell: true
2026-06-10 13:24:46.421409 | controller |         argv: null
2026-06-10 13:24:46.421413 | controller |         chdir: null
2026-06-10 13:24:46.421423 | controller |         creates: null
2026-06-10 13:24:46.421428 | controller |         executable: null
2026-06-10 13:24:46.421432 | controller |         removes: null
2026-06-10 13:24:46.421437 | controller |         stdin: null
2026-06-10 13:24:46.421441 | controller |         stdin_add_newline: true
2026-06-10 13:24:46.421446 | controller |         strip_empty_ends: true
2026-06-10 13:24:46.421450 | controller |     item: tcp dport 179 ct state new counter
2026-06-10 13:24:46.421454 | controller |     msg: ''
2026-06-10 13:24:46.421459 | controller |     rc: 0
2026-06-10 13:24:46.421463 | controller |     start: '2026-06-10 13:24:45.350185'
2026-06-10 13:24:46.421467 | controller |     stderr: ''
2026-06-10 13:24:46.421471 | controller |     stderr_lines: []
2026-06-10 13:24:46.421475 | controller |     stdout: ''
2026-06-10 13:24:46.421483 | controller |     stdout_lines: []
2026-06-10 13:24:46.421565 | controller |   msg: All assertions passed
2026-06-10 13:24:46.421704 | controller | ok: [instance] => (item=udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter) => changed=false
2026-06-10 13:24:46.421831 | controller |   ansible_loop_var: item
2026-06-10 13:24:46.421969 | controller |   item:
2026-06-10 13:24:46.422147 | controller |     ansible_loop_var: item
2026-06-10 13:24:46.422313 | controller |     changed: true
2026-06-10 13:24:46.422481 | controller |     cmd: nft list table inet filter | awk '/chain EDPM_INPUT {/,/}/' | grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter.*accept"
2026-06-10 13:24:46.422621 | controller |     delta: '0:00:00.007069'
2026-06-10 13:24:46.422761 | controller |     end: '2026-06-10 13:24:46.183074'
2026-06-10 13:24:46.422900 | controller |     failed: false
2026-06-10 13:24:46.423057 | controller |     invocation:
2026-06-10 13:24:46.423194 | controller |       module_args:
2026-06-10 13:24:46.423373 | controller |         _raw_params: nft list table inet filter | awk '/chain EDPM_INPUT {/,/}/' | grep -q "udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter.*accept"
2026-06-10 13:24:46.423517 | controller |         _uses_shell: true
2026-06-10 13:24:46.423665 | controller |         argv: null
2026-06-10 13:24:46.423797 | controller |         chdir: null
2026-06-10 13:24:46.423953 | controller |         creates: null
2026-06-10 13:24:46.424085 | controller |         executable: null
2026-06-10 13:24:46.424227 | controller |         removes: null
2026-06-10 13:24:46.424383 | controller |         stdin: null
2026-06-10 13:24:46.424524 | controller |         stdin_add_newline: true
2026-06-10 13:24:46.424654 | controller |         strip_empty_ends: true
2026-06-10 13:24:46.424795 | controller |     item: udp dport { 3784, 3785, 4784, 49152, 49153 } ct state new counter
2026-06-10 13:24:46.424930 | controller |     msg: ''
2026-06-10 13:24:46.425066 | controller |     rc: 0
2026-06-10 13:24:46.425225 | controller |     start: '2026-06-10 13:24:46.176005'
2026-06-10 13:24:46.425405 | controller |     stderr: ''
2026-06-10 13:24:46.425549 | controller |     stderr_lines: []
2026-06-10 13:24:46.425687 | controller |     stdout: ''
2026-06-10 13:24:46.425839 | controller |     stdout_lines: []
2026-06-10 13:24:46.425984 | controller |   msg: All assertions passed
2026-06-10 13:24:46.426139 | controller |
2026-06-10 13:24:46.426326 | controller | TASK [Ensure podman container exists and is running] ***************************
2026-06-10 13:24:46.426483 | controller | Wednesday 10 June 2026  13:24:46 +0000 (0:00:00.070)       0:00:17.580 ********
2026-06-10 13:24:46.499737 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_podman.yaml for instance => (item=frr)
2026-06-10 13:24:46.499910 | controller |
2026-06-10 13:24:46.500066 | controller | TASK [Check if podman container exists frr] ************************************
2026-06-10 13:24:46.500218 | controller | Wednesday 10 June 2026  13:24:46 +0000 (0:00:00.080)       0:00:17.660 ********
2026-06-10 13:24:47.504631 | controller | changed: [instance]
2026-06-10 13:24:47.504664 | controller |
2026-06-10 13:24:47.504672 | controller | TASK [Assert podman container exists frr] **************************************
2026-06-10 13:24:47.504679 | controller | Wednesday 10 June 2026  13:24:47 +0000 (0:00:01.004)       0:00:18.665 ********
2026-06-10 13:24:47.567475 | controller | ok: [instance] => changed=false
2026-06-10 13:24:47.568011 | controller |   msg: All assertions passed
2026-06-10 13:24:47.568028 | controller |
2026-06-10 13:24:47.568035 | controller | TASK [Check if podman container is running frr] ********************************
2026-06-10 13:24:47.568042 | controller | Wednesday 10 June 2026  13:24:47 +0000 (0:00:00.063)       0:00:18.728 ********
2026-06-10 13:24:48.670845 | controller | changed: [instance]
2026-06-10 13:24:48.670884 | controller |
2026-06-10 13:24:48.670891 | controller | TASK [Assert podman container is running frr] **********************************
2026-06-10 13:24:48.670897 | controller | Wednesday 10 June 2026  13:24:48 +0000 (0:00:01.103)       0:00:19.832 ********
2026-06-10 13:24:48.752504 | controller | ok: [instance] => changed=false
2026-06-10 13:24:48.752548 | controller |   msg: All assertions passed
2026-06-10 13:24:48.752555 | controller |
2026-06-10 13:24:48.752959 | controller | TASK [Ensure systemd services are defined and functional] **********************
2026-06-10 13:24:48.752999 | controller | Wednesday 10 June 2026  13:24:48 +0000 (0:00:00.081)       0:00:19.913 ********
2026-06-10 13:24:48.808566 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/edpm-ansible/molecule/test-helpers/verify_systemd_unit.yaml for instance => (item={'name': 'edpm_frr.service'})
2026-06-10 13:24:48.808617 | controller |
2026-06-10 13:24:48.808932 | controller | TASK [Query systemd for unit fragment path edpm_frr.service] *******************
2026-06-10 13:24:48.808968 | controller | Wednesday 10 June 2026  13:24:48 +0000 (0:00:00.056)       0:00:19.969 ********
2026-06-10 13:24:49.808540 | controller | ok: [instance]
2026-06-10 13:24:49.808619 | controller |
2026-06-10 13:24:49.808624 | controller | TASK [Assert systemd unit exists edpm_frr.service] *****************************
2026-06-10 13:24:49.808628 | controller | Wednesday 10 June 2026  13:24:49 +0000 (0:00:01.000)       0:00:20.969 ********
2026-06-10 13:24:49.856464 | controller | ok: [instance] => changed=false
2026-06-10 13:24:49.856501 | controller |   msg: All assertions passed
2026-06-10 13:24:49.856508 | controller |
2026-06-10 13:24:49.856514 | controller | TASK [Check if systemd unit is enabled edpm_frr.service] ***********************
2026-06-10 13:24:49.856522 | controller | Wednesday 10 June 2026  13:24:49 +0000 (0:00:00.047)       0:00:21.017 ********
2026-06-10 13:24:50.783061 | controller | ok: [instance]
2026-06-10 13:24:50.783089 | controller |
2026-06-10 13:24:50.783095 | controller | TASK [Assert systemd unit is enabled edpm_frr.service] *************************
2026-06-10 13:24:50.783099 | controller | Wednesday 10 June 2026  13:24:50 +0000 (0:00:00.926)       0:00:21.944 ********
2026-06-10 13:24:50.824415 | controller | ok: [instance] => changed=false
2026-06-10 13:24:50.824446 | controller |   msg: All assertions passed
2026-06-10 13:24:50.824450 | controller |
2026-06-10 13:24:50.824999 | controller | TASK [Check if systemd unit is running edpm_frr.service] ***********************
2026-06-10 13:24:50.825037 | controller | Wednesday 10 June 2026  13:24:50 +0000 (0:00:00.040)       0:00:21.985 ********
2026-06-10 13:24:51.597380 | controller | ok: [instance]
2026-06-10 13:24:51.597422 | controller |
2026-06-10 13:24:51.597428 | controller | TASK [Assert systemd unit is running edpm_frr.service] *************************
2026-06-10 13:24:51.597432 | controller | Wednesday 10 June 2026  13:24:51 +0000 (0:00:00.772)       0:00:22.758 ********
2026-06-10 13:24:51.721805 | controller | ok: [instance] => changed=false
2026-06-10 13:24:51.721846 | controller |   msg: All assertions passed
2026-06-10 13:24:51.721857 | controller |
2026-06-10 13:24:51.721867 | controller | PLAY RECAP *********************************************************************
2026-06-10 13:24:51.721877 | controller | instance                   : ok=39   changed=5    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-06-10 13:24:51.721886 | controller |
2026-06-10 13:24:51.721894 | controller | Wednesday 10 June 2026  13:24:51 +0000 (0:00:00.118)       0:00:22.877 ********
2026-06-10 13:24:51.721903 | controller | ===============================================================================
2026-06-10 13:24:51.721911 | controller | Check rule content ------------------------------------------------------ 2.97s
2026-06-10 13:24:51.721920 | controller | Check if nftables rule exists in /etc/nftables/edpm-rules.nft ----------- 1.85s
2026-06-10 13:24:51.721938 | controller | Check input chain rules are loaded -------------------------------------- 1.66s
2026-06-10 13:24:51.721947 | controller | Read Quadlet file content ----------------------------------------------- 1.29s
2026-06-10 13:24:51.721975 | controller | Check if daemons file exists -------------------------------------------- 1.15s
2026-06-10 13:24:51.721984 | controller | Check if frr.conf exists ------------------------------------------------ 1.14s
2026-06-10 13:24:51.721992 | controller | Check if /etc/tmpfiles.d/run-frr.conf exists ---------------------------- 1.11s
2026-06-10 13:24:51.722005 | controller | Check if podman container is running frr -------------------------------- 1.10s
2026-06-10 13:24:51.722014 | controller | Check if directory exists /var/lib/openstack/frr/etc/frr ---------------- 1.04s
2026-06-10 13:24:51.722022 | controller | Ensure staged Quadlet file exists --------------------------------------- 1.01s
2026-06-10 13:24:51.722030 | controller | Check if podman container exists frr ------------------------------------ 1.00s
2026-06-10 13:24:51.722039 | controller | Query systemd for unit fragment path edpm_frr.service ------------------- 1.00s
2026-06-10 13:24:51.722047 | controller | Check if directory exists /var/lib/openstack/frr ------------------------ 0.99s
2026-06-10 13:24:51.722055 | controller | Rule source file exists ------------------------------------------------- 0.97s
2026-06-10 13:24:51.722064 | controller | Check if systemd unit is enabled edpm_frr.service ----------------------- 0.93s
2026-06-10 13:24:51.722072 | controller | Ensure Quadlet .container file exists ----------------------------------- 0.82s
2026-06-10 13:24:51.722081 | controller | Check if directory exists /etc/tmpfiles.d/ ------------------------------ 0.81s
2026-06-10 13:24:51.722089 | controller | Check if systemd unit is running edpm_frr.service ----------------------- 0.77s
2026-06-10 13:24:51.722101 | controller | Assert systemd unit is running edpm_frr.service ------------------------- 0.12s
2026-06-10 13:24:51.722110 | controller | Assert FRR BGP and BFD rule source file exists -------------------------- 0.08s
2026-06-10 13:24:51.788895 | controller | INFO     Verifier completed successfully.
2026-06-10 13:24:51.811000 | controller | INFO     Running default > destroy
2026-06-10 13:24:52.282357 | controller |
2026-06-10 13:24:52.282725 | controller | PLAY [Destroy] *****************************************************************
2026-06-10 13:24:52.283060 | controller |
2026-06-10 13:24:52.283422 | controller | TASK [Get passwd entries for USER env] *****************************************
2026-06-10 13:24:52.283750 | controller | Wednesday 10 June 2026  13:24:52 +0000 (0:00:00.013)       0:00:00.013 ********
2026-06-10 13:24:52.664463 | controller | ok: [localhost]
2026-06-10 13:24:52.664488 | controller |
2026-06-10 13:24:52.664493 | controller | TASK [Get shell async_dir] *****************************************************
2026-06-10 13:24:52.664497 | controller | Wednesday 10 June 2026  13:24:52 +0000 (0:00:00.382)       0:00:00.395 ********
2026-06-10 13:24:52.736955 | controller | ok: [localhost]
2026-06-10 13:24:52.736984 | controller |
2026-06-10 13:24:52.737036 | controller | TASK [Set async_dir for HOME env] **********************************************
2026-06-10 13:24:52.737043 | controller | Wednesday 10 June 2026  13:24:52 +0000 (0:00:00.072)       0:00:00.468 ********
2026-06-10 13:24:52.800517 | controller | skipping: [localhost]
2026-06-10 13:24:52.800548 | controller |
2026-06-10 13:24:52.800555 | controller | TASK [Destroy molecule instance(s)] ********************************************
2026-06-10 13:24:52.800560 | controller | Wednesday 10 June 2026  13:24:52 +0000 (0:00:00.063)       0:00:00.531 ********
2026-06-10 13:24:53.290185 | controller | changed: [localhost] => (item={'command': '/sbin/init', 'dockerfile': '../../../../molecule/common/Containerfile.j2', 'image': 'ubi9/ubi-init', 'name': 'instance', 'privileged': True, 'registry': {'url': 'registry.access.redhat.com'}, 'ulimits': ['host']})
2026-06-10 13:24:53.290213 | controller |
2026-06-10 13:24:53.290219 | controller | TASK [Wait for instance(s) deletion to complete] *******************************
2026-06-10 13:24:53.290224 | controller | Wednesday 10 June 2026  13:24:53 +0000 (0:00:00.489)       0:00:01.021 ********
2026-06-10 13:24:58.900484 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (300 retries left).
2026-06-10 13:24:58.900538 | controller | changed: [localhost] => (item={'failed': 0, 'started': 1, 'finished': 0, 'ansible_job_id': 'j690283366506.54209', 'results_file': '/home/zuul/.ansible_async/j690283366506.54209', 'changed': True, 'item': {'command': '/sbin/init', 'dockerfile': '../../../../molecule/common/Containerfile.j2', 'image': 'ubi9/ubi-init', 'name': 'instance', 'privileged': True, 'registry': {'url': 'registry.access.redhat.com'}, 'ulimits': ['host']}, 'ansible_loop_var': 'item'})
2026-06-10 13:24:58.900823 | controller |
2026-06-10 13:24:58.900858 | controller | TASK [Delete podman network dedicated to this scenario] ************************
2026-06-10 13:24:58.900874 | controller | Wednesday 10 June 2026  13:24:58 +0000 (0:00:05.608)       0:00:06.630 ********
2026-06-10 13:24:58.992514 | controller | skipping: [localhost] => (item=instance: None specified)
2026-06-10 13:24:58.992554 | controller | skipping: [localhost]
2026-06-10 13:24:58.992565 | controller |
2026-06-10 13:24:58.992573 | controller | PLAY RECAP *********************************************************************
2026-06-10 13:24:58.992583 | controller | localhost                  : ok=4    changed=2    unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2026-06-10 13:24:58.992591 | controller |
2026-06-10 13:24:58.993413 | controller | Wednesday 10 June 2026  13:24:58 +0000 (0:00:00.092)       0:00:06.723 ********
2026-06-10 13:24:58.993428 | controller | ===============================================================================
2026-06-10 13:24:58.993434 | controller | Wait for instance(s) deletion to complete ------------------------------- 5.61s
2026-06-10 13:24:58.993439 | controller | Destroy molecule instance(s) -------------------------------------------- 0.49s
2026-06-10 13:24:58.993444 | controller | Get passwd entries for USER env ----------------------------------------- 0.38s
2026-06-10 13:24:58.993449 | controller | Delete podman network dedicated to this scenario ------------------------ 0.09s
2026-06-10 13:24:58.993454 | controller | Get shell async_dir ----------------------------------------------------- 0.07s
2026-06-10 13:24:58.993459 | controller | Set async_dir for HOME env ---------------------------------------------- 0.06s
2026-06-10 13:24:59.066923 | controller | INFO     Pruning extra files from scenario ephemeral directory
2026-06-10 13:24:59.284490 | controller | INFO     Writing /tmp/report.html report.
2026-06-10 13:24:59.727237 | controller | ok: Runtime: 0:05:19.102383
2026-06-10 13:24:59.748318 | 
2026-06-10 13:24:59.748436 | PLAY RECAP
2026-06-10 13:24:59.748518 | controller | ok: 4 changed: 2 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-10 13:24:59.748561 | 
2026-06-10 13:24:59.931705 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-06-10 13:24:59.933052 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-06-10 13:25:00.531545 | 
2026-06-10 13:25:00.531654 | PLAY [Ensure ci-framework-data base directories exist on all nodes]
2026-06-10 13:25:00.541767 | 
2026-06-10 13:25:00.541835 | TASK [Create ci-framework-data/logs directory if missing]
2026-06-10 13:25:00.948214 | controller | ok
2026-06-10 13:25:00.990752 | 
2026-06-10 13:25:00.990983 | PLAY [Run ci/playbooks/collect-logs.yml]
2026-06-10 13:25:00.998504 | 
2026-06-10 13:25:00.998621 | TASK [Filter out host if needed]
2026-06-10 13:25:01.009145 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2026-06-10 13:25:01.013574 | 
2026-06-10 13:25:01.013648 | TASK [Ensure file is present]
2026-06-10 13:25:01.385305 | controller | ok
2026-06-10 13:25:01.392472 | 
2026-06-10 13:25:01.392544 | TASK [Manage molecule report file]
2026-06-10 13:25:01.925987 | controller | ok: Runtime: 0:00:00.006595
2026-06-10 13:25:01.934434 | 
2026-06-10 13:25:01.934585 | TASK [Check if we get ci-framework-data basedir]
2026-06-10 13:25:02.176684 | controller | ok
2026-06-10 13:25:02.185184 | 
2026-06-10 13:25:02.185306 | TASK [Create ci-framework-data log directory for zuul]
2026-06-10 13:25:02.444894 | controller | changed
2026-06-10 13:25:02.453319 | 
2026-06-10 13:25:02.453463 | TASK [Copy ci-framework interesting files]
2026-06-10 13:25:02.703541 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2026-06-10 13:25:02.996763 | controller | ok: Runtime: 0:00:00.008949
2026-06-10 13:25:03.004172 | 
2026-06-10 13:25:03.004299 | TASK [Get SELinux listing]
2026-06-10 13:25:03.545502 | controller | ok: Runtime: 0:00:00.006574
2026-06-10 13:25:03.553988 | 
2026-06-10 13:25:03.554119 | TASK [Generate log index]
2026-06-10 13:25:04.285978 | controller | changed
2026-06-10 13:25:04.293081 | 
2026-06-10 13:25:04.293178 | TASK [Get some env related data]
2026-06-10 13:25:04.892369 | controller | /home/zuul/.local/bin/ansible
2026-06-10 13:25:05.830147 | controller | ok: Runtime: 0:00:00.998295
2026-06-10 13:25:05.879616 | 
2026-06-10 13:25:05.879832 | TASK [Generate list of logs to collect in home directory]
2026-06-10 13:25:06.269620 | controller | ok: All paths examined
2026-06-10 13:25:06.278516 | 
2026-06-10 13:25:06.278650 | LOOP [Copy logs from home directory]
2026-06-10 13:25:06.671102 | controller | changed:
2026-06-10 13:25:06.671401 | controller | {
2026-06-10 13:25:06.671467 | controller |   "atime": 1781097553.2155743,
2026-06-10 13:25:06.671516 | controller |   "ctime": 1781097574.0759377,
2026-06-10 13:25:06.671553 | controller |   "dev": 64513,
2026-06-10 13:25:06.671597 | controller |   "gid": 1000,
2026-06-10 13:25:06.671639 | controller |   "gr_name": "zuul",
2026-06-10 13:25:06.671682 | controller |   "inode": 55003,
2026-06-10 13:25:06.671728 | controller |   "isblk": false,
2026-06-10 13:25:06.671770 | controller |   "ischr": false,
2026-06-10 13:25:06.671811 | controller |   "isdir": false,
2026-06-10 13:25:06.671879 | controller |   "isfifo": false,
2026-06-10 13:25:06.672036 | controller |   "isgid": false,
2026-06-10 13:25:06.672087 | controller |   "islnk": false,
2026-06-10 13:25:06.672124 | controller |   "isreg": true,
2026-06-10 13:25:06.672157 | controller |   "issock": false,
2026-06-10 13:25:06.672198 | controller |   "isuid": false,
2026-06-10 13:25:06.672232 | controller |   "mode": "0644",
2026-06-10 13:25:06.672266 | controller |   "mtime": 1781097574.0759377,
2026-06-10 13:25:06.672300 | controller |   "nlink": 1,
2026-06-10 13:25:06.672334 | controller |   "path": "/home/zuul/ansible.log",
2026-06-10 13:25:06.672367 | controller |   "pw_name": "zuul",
2026-06-10 13:25:06.672401 | controller |   "rgrp": true,
2026-06-10 13:25:06.672434 | controller |   "roth": true,
2026-06-10 13:25:06.672473 | controller |   "rusr": true,
2026-06-10 13:25:06.672508 | controller |   "size": 6749,
2026-06-10 13:25:06.672541 | controller |   "uid": 1000,
2026-06-10 13:25:06.672575 | controller |   "wgrp": false,
2026-06-10 13:25:06.672607 | controller |   "woth": false,
2026-06-10 13:25:06.672640 | controller |   "wusr": true,
2026-06-10 13:25:06.672672 | controller |   "xgrp": false,
2026-06-10 13:25:06.672705 | controller |   "xoth": false,
2026-06-10 13:25:06.672738 | controller |   "xusr": false
2026-06-10 13:25:06.672771 | controller | }
2026-06-10 13:25:06.692403 | 
2026-06-10 13:25:06.692589 | TASK [Copy crio stats log file]
2026-06-10 13:25:06.720486 | controller | skipping: Conditional result was False
2026-06-10 13:25:06.731964 | 
2026-06-10 13:25:06.732132 | TASK [Get SELinux related data]
2026-06-10 13:25:07.035659 | controller | <no matches>
2026-06-10 13:25:07.274602 | controller | ERROR
2026-06-10 13:25:07.274952 | controller | {
2026-06-10 13:25:07.275022 | controller |   "delta": "0:00:00.010797",
2026-06-10 13:25:07.275065 | controller |   "end": "2026-06-10 13:25:07.036688",
2026-06-10 13:25:07.275103 | controller |   "msg": "non-zero return code",
2026-06-10 13:25:07.275139 | controller |   "rc": 1,
2026-06-10 13:25:07.275174 | controller |   "start": "2026-06-10 13:25:07.025891"
2026-06-10 13:25:07.275208 | controller | }
2026-06-10 13:25:07.275252 | controller | ERROR: Ignoring Errors
2026-06-10 13:25:07.285195 | 
2026-06-10 13:25:07.285470 | TASK [Create system configuration directory]
2026-06-10 13:25:07.565750 | controller | changed
2026-06-10 13:25:07.576024 | 
2026-06-10 13:25:07.576167 | TASK [Get some of the system configurations]
2026-06-10 13:25:08.123430 | controller | ok: Runtime: 0:00:00.014109
2026-06-10 13:25:08.131219 | 
2026-06-10 13:25:08.131343 | TASK [Copy generated documentation if available]
2026-06-10 13:25:08.159434 | controller | skipping: Conditional result was False
2026-06-10 13:25:08.169521 | 
2026-06-10 13:25:08.169676 | TASK [Copy generated AsciiDoc documentation if available]
2026-06-10 13:25:08.196767 | controller | skipping: Conditional result was False
2026-06-10 13:25:08.206818 | 
2026-06-10 13:25:08.206971 | TASK [Compress logs bigger than 2MB]
2026-06-10 13:25:08.752246 | controller | ok: Runtime: 0:00:00.004580
2026-06-10 13:25:08.759896 | 
2026-06-10 13:25:08.760020 | TASK [Copy files from workspace on node]
2026-06-10 13:25:08.784199 | controller | ok
2026-06-10 13:25:08.820291 | 
2026-06-10 13:25:08.820415 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-10 13:25:08.855088 | controller | skipping: Conditional result was False
2026-06-10 13:25:08.860772 | 
2026-06-10 13:25:08.860879 | TASK [fetch-output : Set log path for single node]
2026-06-10 13:25:08.903204 | controller | ok
2026-06-10 13:25:08.911122 | 
2026-06-10 13:25:08.911249 | LOOP [fetch-output : Ensure local output dirs]
2026-06-10 13:25:09.210906 | controller -> localhost | changed: "/var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/logs"
2026-06-10 13:25:09.211384 | controller -> localhost | changed: All items complete
2026-06-10 13:25:09.211442 | 
2026-06-10 13:25:09.491623 | controller -> localhost | changed: "/var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/artifacts"
2026-06-10 13:25:09.747420 | controller -> localhost | changed: "/var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/docs"
2026-06-10 13:25:09.758743 | 
2026-06-10 13:25:09.758871 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-10 13:25:10.500247 | controller | changed:
2026-06-10 13:25:10.500737 | controller | .d..t...... ./
2026-06-10 13:25:10.500812 | controller | >f+++++++++ README.html
2026-06-10 13:25:10.500896 | controller | >f+++++++++ ansible-execution.log
2026-06-10 13:25:10.500949 | controller | >f+++++++++ ansible.log
2026-06-10 13:25:10.500993 | controller | >f+++++++++ dmesg.log
2026-06-10 13:25:10.501031 | controller | >f+++++++++ installed-pkgs.log
2026-06-10 13:25:10.501067 | controller | >f+++++++++ python.log
2026-06-10 13:25:10.501103 | controller | >f+++++++++ registries.conf
2026-06-10 13:25:10.501138 | controller | >f+++++++++ report.html
2026-06-10 13:25:10.501172 | controller | >f+++++++++ selinux-denials.log
2026-06-10 13:25:10.501206 | controller | >f+++++++++ selinux-listing.log
2026-06-10 13:25:10.501240 | controller | cd+++++++++ ci-framework-data/
2026-06-10 13:25:10.501274 | controller | cd+++++++++ ci-framework-data/artifacts/
2026-06-10 13:25:10.501310 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2026-06-10 13:25:10.501347 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2026-06-10 13:25:10.501383 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2026-06-10 13:25:10.501418 | controller | cd+++++++++ ci-framework-data/logs/
2026-06-10 13:25:10.501454 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2026-06-10 13:25:10.501490 | controller | cd+++++++++ registries.conf.d/
2026-06-10 13:25:10.501525 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2026-06-10 13:25:10.501573 | controller | cd+++++++++ system-config/
2026-06-10 13:25:10.501629 | controller | cd+++++++++ system-config/libvirt/
2026-06-10 13:25:10.501679 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2026-06-10 13:25:10.501717 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2026-06-10 13:25:11.046709 | controller | changed: .d..t...... ./
2026-06-10 13:25:11.566150 | controller | changed: .d..t...... ./
2026-06-10 13:25:11.592577 | 
2026-06-10 13:25:11.592695 | TASK [Return artifact to Zuul]
2026-06-10 13:25:11.631639 | controller | ok
2026-06-10 13:25:11.634067 | 
2026-06-10 13:25:11.634129 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2026-06-10 13:25:11.634266 | 
2026-06-10 13:25:11.634324 | PLAY RECAP
2026-06-10 13:25:11.634379 | controller | ok: 19 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2026-06-10 13:25:11.634415 | 
2026-06-10 13:25:11.758695 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-06-10 13:25:11.759890 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-06-10 13:25:12.382924 | 
2026-06-10 13:25:12.383260 | PLAY [all]
2026-06-10 13:25:12.393445 | 
2026-06-10 13:25:12.393515 | TASK [include_role : fetch-output]
2026-06-10 13:25:12.431079 | controller | ok
2026-06-10 13:25:12.445412 | 
2026-06-10 13:25:12.445484 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-10 13:25:12.519946 | controller | skipping: Conditional result was False
2026-06-10 13:25:12.524184 | 
2026-06-10 13:25:12.524252 | TASK [fetch-output : Set log path for single node]
2026-06-10 13:25:12.572381 | controller | ok
2026-06-10 13:25:12.575839 | 
2026-06-10 13:25:12.575923 | LOOP [fetch-output : Ensure local output dirs]
2026-06-10 13:25:13.018260 | controller -> localhost | ok: "/var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/logs"
2026-06-10 13:25:13.287955 | controller -> localhost | ok: "/var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/artifacts"
2026-06-10 13:25:13.566283 | controller -> localhost | ok: "/var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/docs"
2026-06-10 13:25:13.588317 | 
2026-06-10 13:25:13.588503 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-10 13:25:14.331786 | controller | ok
2026-06-10 13:25:14.332189 | controller | ok: All items complete
2026-06-10 13:25:14.332249 | 
2026-06-10 13:25:14.948986 | controller | ok
2026-06-10 13:25:15.509046 | controller | ok
2026-06-10 13:25:15.532903 | 
2026-06-10 13:25:15.533051 | TASK [include_role : fetch-output-openshift]
2026-06-10 13:25:15.558759 | controller | skipping: Conditional result was False
2026-06-10 13:25:15.568005 | 
2026-06-10 13:25:15.568149 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-10 13:25:16.078997 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.015833
2026-06-10 13:25:16.332841 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012439
2026-06-10 13:25:16.347643 | 
2026-06-10 13:25:16.347748 | PLAY [all]
2026-06-10 13:25:16.353624 | 
2026-06-10 13:25:16.353690 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-06-10 13:25:16.866616 | controller | changed
2026-06-10 13:25:16.870939 | 
2026-06-10 13:25:16.870988 | PLAY RECAP
2026-06-10 13:25:16.871053 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-06-10 13:25:16.871078 | 
2026-06-10 13:25:16.995683 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-06-10 13:25:16.998004 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-06-10 13:25:17.630235 | 
2026-06-10 13:25:17.630356 | PLAY [localhost]
2026-06-10 13:25:17.640574 | 
2026-06-10 13:25:17.640658 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-10 13:25:18.083390 | localhost | changed
2026-06-10 13:25:18.092730 | 
2026-06-10 13:25:18.092892 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-10 13:25:18.130369 | localhost | ok
2026-06-10 13:25:18.136094 | 
2026-06-10 13:25:18.136155 | TASK [add-fileserver : Create SSH private key tempfile]
2026-06-10 13:25:18.583351 | localhost | changed
2026-06-10 13:25:18.593738 | 
2026-06-10 13:25:18.593916 | TASK [add-fileserver : Create SSH private key from secret]
2026-06-10 13:25:19.438433 | localhost | changed
2026-06-10 13:25:19.447171 | 
2026-06-10 13:25:19.447358 | TASK [add-fileserver : Add fileserver ssh key]
2026-06-10 13:25:19.981955 | localhost | Identity added: /var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/tmp/ansible.vaaf0ry6 (/var/lib/zuul/builds/25eb16df8eda45028d472ebbf6cc8aa3/work/tmp/ansible.vaaf0ry6)
2026-06-10 13:25:19.982330 | localhost | ok: Runtime: 0:00:00.020523
2026-06-10 13:25:19.989762 | 
2026-06-10 13:25:19.989995 | TASK [add-fileserver : Remove SSH private key from disk]
2026-06-10 13:25:20.327034 | localhost | ok: Runtime: 0:00:00.009130
2026-06-10 13:25:20.336650 | 
2026-06-10 13:25:20.336839 | TASK [add-fileserver : Add fileserver to inventory]
2026-06-10 13:25:20.431706 | localhost | changed
2026-06-10 13:25:20.441220 | 
2026-06-10 13:25:20.441360 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-06-10 13:25:20.929924 | localhost | changed
2026-06-10 13:25:20.940077 | 
2026-06-10 13:25:20.940202 | PLAY [localhost]
2026-06-10 13:25:20.948372 | 
2026-06-10 13:25:20.948498 | TASK [Generate bulk log download script]
2026-06-10 13:25:20.972011 | localhost | ok
2026-06-10 13:25:20.992658 | 
2026-06-10 13:25:20.992832 | TASK [local-log-download : Check API endpoint is defined]
2026-06-10 13:25:21.036361 | localhost | ok: All assertions passed
2026-06-10 13:25:21.043667 | 
2026-06-10 13:25:21.043789 | TASK [local-log-download : Create download script]
2026-06-10 13:25:21.617150 | localhost -> localhost | changed
2026-06-10 13:25:21.671260 | 
2026-06-10 13:25:21.671409 | TASK [Register quick-download link]
2026-06-10 13:25:21.700585 | localhost | ok
2026-06-10 13:25:21.703363 | 
2026-06-10 13:25:21.703438 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com]
2026-06-10 13:25:21.709730 | 
2026-06-10 13:25:21.709821 | TASK [Set zuul-log-path fact]
2026-06-10 13:25:21.727933 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-10 13:25:21.740111 | 
2026-06-10 13:25:21.740283 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-10 13:25:21.777988 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-10 13:25:21.781264 | 
2026-06-10 13:25:21.781349 | TASK [upload-logs : Create log directories]
2026-06-10 13:25:22.682431 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed
2026-06-10 13:25:22.685980 | 
2026-06-10 13:25:22.686112 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-10 13:25:23.032469 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.010012
2026-06-10 13:25:23.038259 | 
2026-06-10 13:25:23.038389 | TASK [upload-logs : Upload logs to log server]
2026-06-10 13:25:25.197813 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | Output suppressed because no_log was given
2026-06-10 13:25:25.201104 | 
2026-06-10 13:25:25.201242 | LOOP [upload-logs : Compress console log and json output]