2025-10-13 07:00:14.511478 | Job console starting...
2025-10-13 07:00:14.993010 | Updating repositories
2025-10-13 07:00:15.819772 | Preparing job workspace
2025-10-13 07:00:31.852092 | Running Ansible setup...
2025-10-13 07:00:38.642600 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-13 07:00:40.294214 | 
2025-10-13 07:00:40.294305 | PLAY [localhost]
2025-10-13 07:00:40.313019 | 
2025-10-13 07:00:40.313095 | TASK [Gathering Facts]
2025-10-13 07:00:43.162968 | localhost | ok
2025-10-13 07:00:43.219515 | 
2025-10-13 07:00:43.219665 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-13 07:00:44.576314 | localhost -> localhost | changed
2025-10-13 07:00:44.582221 | 
2025-10-13 07:00:44.582292 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-13 07:00:47.239414 | localhost -> localhost | changed
2025-10-13 07:00:47.257677 | 
2025-10-13 07:00:47.257757 | TASK [Setup log path fact]
2025-10-13 07:00:47.317978 | localhost | ok
2025-10-13 07:00:47.399992 | 
2025-10-13 07:00:47.403988 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-13 07:00:47.504036 | localhost | ok
2025-10-13 07:00:47.521293 | 
2025-10-13 07:00:47.521378 | TASK [emit-job-header : Print job information]
2025-10-13 07:00:47.603240 | # Job Information
2025-10-13 07:00:47.603562 | Ansible Version: 2.15.12
2025-10-13 07:00:47.603596 | Job: cifmw-molecule-cifmw_snr_nhc
2025-10-13 07:00:47.603621 | Pipeline: github-check
2025-10-13 07:00:47.603643 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-10-13 07:00:47.603663 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3237
2025-10-13 07:00:47.603683 | Log URL (when completed): https://logserver.rdoproject.org/c60/rdoproject.org/c60da158f9824245b4d222fc08901eda/
2025-10-13 07:00:47.603702 | Event ID: 07b5c7c0-a802-11f0-8dbe-38d1533757a8
2025-10-13 07:00:47.610376 | 
2025-10-13 07:00:47.610443 | LOOP [emit-job-header : Print node information]
2025-10-13 07:00:47.957726 | localhost | ok:
2025-10-13 07:00:47.957870 | localhost | # Node Information
2025-10-13 07:00:47.957900 | localhost | Inventory Hostname: controller
2025-10-13 07:00:47.957947 | localhost | Hostname: np0005482754
2025-10-13 07:00:47.957971 | localhost | Username: zuul
2025-10-13 07:00:47.957992 | localhost | Distro: CentOS 9
2025-10-13 07:00:47.958010 | localhost | Provider: ibm-bm4-nodepool
2025-10-13 07:00:47.958050 | localhost | Region: regionOne
2025-10-13 07:00:47.958075 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-10-13 07:00:47.958093 | localhost | Product Name: OpenStack Compute
2025-10-13 07:00:47.958109 | localhost | Interface IP: 192.168.26.229
2025-10-13 07:00:48.005511 | 
2025-10-13 07:00:48.005614 | PLAY [all]
2025-10-13 07:00:48.022862 | 
2025-10-13 07:00:48.022965 | TASK [Gather network facts]
2025-10-13 07:00:48.506901 | controller | ok
2025-10-13 07:00:48.567538 | 
2025-10-13 07:00:48.567652 | TASK [include_role : start-zuul-console]
2025-10-13 07:00:48.676015 | controller | ok
2025-10-13 07:00:48.721395 | 
2025-10-13 07:00:48.721492 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-13 07:00:49.555345 | controller | ok
2025-10-13 07:00:49.574638 | 
2025-10-13 07:00:49.574747 | TASK [include_role : add-build-sshkey]
2025-10-13 07:00:49.658203 | controller | ok
2025-10-13 07:00:49.680901 | 
2025-10-13 07:00:49.680989 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-13 07:00:50.443024 | controller -> localhost | ok
2025-10-13 07:00:50.448314 | 
2025-10-13 07:00:50.448386 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-13 07:00:50.486354 | controller | ok
2025-10-13 07:00:50.521799 | controller | included: /var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-13 07:00:50.553785 | 
2025-10-13 07:00:50.553903 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-13 07:00:51.982556 | controller -> localhost | Generating public/private rsa key pair.
2025-10-13 07:00:51.982731 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/c60da158f9824245b4d222fc08901eda_id_rsa.
2025-10-13 07:00:51.982765 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/c60da158f9824245b4d222fc08901eda_id_rsa.pub.
2025-10-13 07:00:51.982791 | controller -> localhost | The key fingerprint is:
2025-10-13 07:00:51.982812 | controller -> localhost | SHA256:JFk4ccfkfCoWLBwjJwKdvuixYR4yjb4rXAacPcJy0g0 zuul-build-sshkey
2025-10-13 07:00:51.982833 | controller -> localhost | The key's randomart image is:
2025-10-13 07:00:51.982852 | controller -> localhost | +---[RSA 3072]----+
2025-10-13 07:00:51.982870 | controller -> localhost | |.o..o =oooo      |
2025-10-13 07:00:51.982890 | controller -> localhost | |  E. =oB +.      |
2025-10-13 07:00:51.982927 | controller -> localhost | |oooo  =.+ o .    |
2025-10-13 07:00:51.982955 | controller -> localhost | |o*+o.  + . o     |
2025-10-13 07:00:51.982976 | controller -> localhost | |.*o..   S .      |
2025-10-13 07:00:51.982996 | controller -> localhost | |==oo   . .       |
2025-10-13 07:00:51.983015 | controller -> localhost | |B.B              |
2025-10-13 07:00:51.983035 | controller -> localhost | |.*               |
2025-10-13 07:00:51.983054 | controller -> localhost | |.oo              |
2025-10-13 07:00:51.983071 | controller -> localhost | +----[SHA256]-----+
2025-10-13 07:00:51.983114 | controller -> localhost | ok: Runtime: 0:00:00.167820
2025-10-13 07:00:51.988581 | 
2025-10-13 07:00:51.988647 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-13 07:00:52.070094 | controller | ok
2025-10-13 07:00:52.094632 | controller | included: /var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-13 07:00:52.129828 | 
2025-10-13 07:00:52.129948 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-13 07:00:52.202574 | controller | skipping: Conditional result was False
2025-10-13 07:00:52.207495 | 
2025-10-13 07:00:52.207571 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-13 07:00:53.020765 | controller | changed
2025-10-13 07:00:53.033321 | 
2025-10-13 07:00:53.033400 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-13 07:00:53.344100 | controller | ok
2025-10-13 07:00:53.357324 | 
2025-10-13 07:00:53.357400 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-13 07:00:54.314029 | controller | changed
2025-10-13 07:00:54.318948 | 
2025-10-13 07:00:54.319013 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-13 07:00:55.393442 | controller | changed
2025-10-13 07:00:55.398581 | 
2025-10-13 07:00:55.398647 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-13 07:00:55.421896 | controller | skipping: Conditional result was False
2025-10-13 07:00:55.430035 | 
2025-10-13 07:00:55.430101 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-13 07:00:56.761146 | controller -> localhost | changed
2025-10-13 07:00:56.777449 | 
2025-10-13 07:00:56.777521 | TASK [add-build-sshkey : Add back temp key]
2025-10-13 07:00:58.016278 | controller -> localhost | Identity added: /var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/c60da158f9824245b4d222fc08901eda_id_rsa (zuul-build-sshkey)
2025-10-13 07:00:58.016450 | controller -> localhost | ok: Runtime: 0:00:00.043943
2025-10-13 07:00:58.021997 | 
2025-10-13 07:00:58.022074 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-13 07:00:58.612301 | controller | ok
2025-10-13 07:00:58.620738 | 
2025-10-13 07:00:58.620811 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-13 07:00:58.746887 | controller | skipping: Conditional result was False
2025-10-13 07:00:58.756267 | 
2025-10-13 07:00:58.756348 | TASK [include_role : validate-host]
2025-10-13 07:00:58.835492 | controller | ok
2025-10-13 07:00:58.896927 | 
2025-10-13 07:00:58.897040 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-13 07:00:58.935554 | controller | ok
2025-10-13 07:00:58.950831 | 
2025-10-13 07:00:58.954902 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-13 07:00:59.851976 | controller -> localhost | ok
2025-10-13 07:00:59.857764 | 
2025-10-13 07:00:59.857830 | TASK [validate-host : Collect information about the host]
2025-10-13 07:01:00.601152 | controller | ok
2025-10-13 07:01:00.647725 | 
2025-10-13 07:01:00.647815 | TASK [validate-host : Sanitize hostname]
2025-10-13 07:01:00.913022 | controller | ok
2025-10-13 07:01:00.948085 | 
2025-10-13 07:01:00.948180 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-13 07:01:02.993100 | controller -> localhost | changed
2025-10-13 07:01:02.999027 | 
2025-10-13 07:01:02.999090 | TASK [validate-host : Collect information about zuul worker]
2025-10-13 07:01:03.744261 | controller | ok
2025-10-13 07:01:03.749135 | 
2025-10-13 07:01:03.749206 | TASK [validate-host : Write out all zuul information for each host]
2025-10-13 07:01:06.126737 | controller -> localhost | changed
2025-10-13 07:01:06.137446 | 
2025-10-13 07:01:06.137517 | TASK [include_role : prepare-workspace-openshift]
2025-10-13 07:01:06.205427 | controller | skipping: Conditional result was False
2025-10-13 07:01:06.210810 | 
2025-10-13 07:01:06.210874 | TASK [include_role : remove-zuul-sshkey]
2025-10-13 07:01:06.265133 | controller | skipping: Conditional result was False
2025-10-13 07:01:06.270781 | 
2025-10-13 07:01:06.270850 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-13 07:01:06.598294 | controller | ok: "logs"
2025-10-13 07:01:06.598526 | controller | ok: All items complete
2025-10-13 07:01:06.598560 | 
2025-10-13 07:01:06.786448 | controller | ok: "artifacts"
2025-10-13 07:01:06.969403 | controller | ok: "docs"
2025-10-13 07:01:06.986513 | 
2025-10-13 07:01:06.986618 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-13 07:01:07.299629 | controller | changed: "logs"
2025-10-13 07:01:07.482272 | controller | changed: "artifacts"
2025-10-13 07:01:07.686073 | controller | changed: "docs"
2025-10-13 07:01:07.759742 | 
2025-10-13 07:01:07.759823 | PLAY RECAP
2025-10-13 07:01:07.760140 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-13 07:01:07.760195 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-13 07:01:07.760221 | 
2025-10-13 07:01:08.304769 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-13 07:01:08.305561 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-13 07:01:11.441870 | 
2025-10-13 07:01:11.441995 | PLAY [all]
2025-10-13 07:01:11.464263 | 
2025-10-13 07:01:11.464341 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-13 07:01:11.513164 | controller | ok
2025-10-13 07:01:11.518737 | 
2025-10-13 07:01:11.518834 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-13 07:01:12.599778 | controller | changed
2025-10-13 07:01:12.609199 | 
2025-10-13 07:01:12.609272 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-13 07:01:14.447151 | controller | changed
2025-10-13 07:01:14.463178 | 
2025-10-13 07:01:14.463253 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-13 07:01:15.508847 | controller | changed:
2025-10-13 07:01:15.509038 | controller | {
2025-10-13 07:01:15.509070 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-13 07:01:15.509102 | controller | }
2025-10-13 07:01:15.727579 | controller | changed:
2025-10-13 07:01:15.727750 | controller | {
2025-10-13 07:01:15.727787 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-13 07:01:15.727812 | controller | }
2025-10-13 07:01:15.983192 | controller | changed:
2025-10-13 07:01:15.983276 | controller | {
2025-10-13 07:01:15.983304 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-10-13 07:01:15.983326 | controller | }
2025-10-13 07:01:16.241615 | controller | changed:
2025-10-13 07:01:16.241700 | controller | {
2025-10-13 07:01:16.241728 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-13 07:01:16.241750 | controller | }
2025-10-13 07:01:16.482357 | controller | changed:
2025-10-13 07:01:16.482437 | controller | {
2025-10-13 07:01:16.482464 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-13 07:01:16.482486 | controller | }
2025-10-13 07:01:16.700804 | controller | changed:
2025-10-13 07:01:16.700881 | controller | {
2025-10-13 07:01:16.700936 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-13 07:01:16.700968 | controller | }
2025-10-13 07:01:16.928339 | controller | changed:
2025-10-13 07:01:16.928422 | controller | {
2025-10-13 07:01:16.928449 | 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"
2025-10-13 07:01:16.928473 | controller | }
2025-10-13 07:01:17.292686 | controller | changed:
2025-10-13 07:01:17.292766 | controller | {
2025-10-13 07:01:17.292795 | 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"
2025-10-13 07:01:17.292818 | controller | }
2025-10-13 07:01:17.420979 | controller | changed:
2025-10-13 07:01:17.421066 | controller | {
2025-10-13 07:01:17.421094 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-13 07:01:17.421116 | controller | }
2025-10-13 07:01:17.660172 | controller | changed:
2025-10-13 07:01:17.660247 | controller | {
2025-10-13 07:01:17.660276 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-13 07:01:17.660298 | controller | }
2025-10-13 07:01:17.918021 | controller | changed:
2025-10-13 07:01:17.918095 | controller | {
2025-10-13 07:01:17.918123 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-13 07:01:17.918146 | controller | }
2025-10-13 07:01:18.166662 | controller | changed:
2025-10-13 07:01:18.166756 | controller | {
2025-10-13 07:01:18.166788 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-13 07:01:18.166811 | controller | }
2025-10-13 07:01:18.418094 | controller | changed:
2025-10-13 07:01:18.418247 | controller | {
2025-10-13 07:01:18.418282 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-13 07:01:18.418305 | controller | }
2025-10-13 07:01:18.668351 | controller | changed:
2025-10-13 07:01:18.668442 | controller | {
2025-10-13 07:01:18.668469 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-13 07:01:18.668491 | controller | }
2025-10-13 07:01:18.914797 | controller | changed:
2025-10-13 07:01:18.914870 | controller | {
2025-10-13 07:01:18.914898 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-13 07:01:18.914943 | controller | }
2025-10-13 07:01:19.190735 | controller | changed:
2025-10-13 07:01:19.190808 | controller | {
2025-10-13 07:01:19.190836 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-13 07:01:19.190857 | controller | }
2025-10-13 07:01:19.414831 | controller | changed:
2025-10-13 07:01:19.414943 | controller | {
2025-10-13 07:01:19.414989 | 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"
2025-10-13 07:01:19.415015 | controller | }
2025-10-13 07:01:19.634729 | controller | changed:
2025-10-13 07:01:19.634806 | controller | {
2025-10-13 07:01:19.634834 | 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"
2025-10-13 07:01:19.634863 | controller | }
2025-10-13 07:01:19.869201 | controller | changed:
2025-10-13 07:01:19.869289 | controller | {
2025-10-13 07:01:19.869316 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-13 07:01:19.869337 | controller | }
2025-10-13 07:01:20.124995 | controller | changed:
2025-10-13 07:01:20.125096 | controller | {
2025-10-13 07:01:20.125125 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-13 07:01:20.125147 | controller | }
2025-10-13 07:01:20.397381 | controller | changed:
2025-10-13 07:01:20.397460 | controller | {
2025-10-13 07:01:20.397489 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-13 07:01:20.397510 | controller | }
2025-10-13 07:01:20.646961 | controller | changed:
2025-10-13 07:01:20.647048 | controller | {
2025-10-13 07:01:20.647075 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-13 07:01:20.647096 | controller | }
2025-10-13 07:01:20.881165 | controller | changed:
2025-10-13 07:01:20.881338 | controller | {
2025-10-13 07:01:20.881371 | 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"
2025-10-13 07:01:20.881395 | controller | }
2025-10-13 07:01:21.121329 | controller | changed:
2025-10-13 07:01:21.121406 | controller | {
2025-10-13 07:01:21.121434 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-13 07:01:21.121455 | controller | }
2025-10-13 07:01:21.376167 | controller | changed:
2025-10-13 07:01:21.376252 | controller | {
2025-10-13 07:01:21.376280 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-13 07:01:21.376302 | controller | }
2025-10-13 07:01:21.626875 | controller | changed:
2025-10-13 07:01:21.626970 | controller | {
2025-10-13 07:01:21.626999 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-13 07:01:21.627022 | controller | }
2025-10-13 07:01:21.676315 | 
2025-10-13 07:01:21.676402 | TASK [Set timezone to UTC]
2025-10-13 07:01:22.618371 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-13 07:01:22.633543 | 
2025-10-13 07:01:22.633643 | TASK [Create nodepool directory]
2025-10-13 07:01:22.913844 | controller | changed
2025-10-13 07:01:22.927481 | 
2025-10-13 07:01:22.927556 | TASK [Create nodepool sub_nodes file]
2025-10-13 07:01:23.694361 | controller | changed
2025-10-13 07:01:23.701492 | 
2025-10-13 07:01:23.701575 | TASK [Create nodepool sub_nodes_private file]
2025-10-13 07:01:24.416769 | controller | changed
2025-10-13 07:01:24.430938 | 
2025-10-13 07:01:24.431006 | LOOP [Populate nodepool sub_nodes file]
2025-10-13 07:01:24.550431 | 
2025-10-13 07:01:24.550662 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-13 07:01:24.664759 | 
2025-10-13 07:01:24.664904 | TASK [Create nodepool primary file]
2025-10-13 07:01:24.739503 | controller | skipping: Conditional result was False
2025-10-13 07:01:24.745156 | 
2025-10-13 07:01:24.745241 | TASK [Create nodepool node_private for this node]
2025-10-13 07:01:25.570343 | controller | changed
2025-10-13 07:01:25.583649 | 
2025-10-13 07:01:25.583725 | LOOP [Copy ssh keys to nodepool directory]
2025-10-13 07:01:26.455153 | controller | ok: Item: id_rsa Runtime: 0:00:00.004677
2025-10-13 07:01:26.455324 | 
2025-10-13 07:01:26.653598 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004427
2025-10-13 07:01:26.668449 | 
2025-10-13 07:01:26.668572 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-13 07:01:27.390490 | controller | changed
2025-10-13 07:01:27.397349 | 
2025-10-13 07:01:27.399377 | TASK [Validate sudoers config after edits]
2025-10-13 07:01:27.805968 | controller | /etc/sudoers: parsed OK
2025-10-13 07:01:27.806039 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-13 07:01:27.806050 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-13 07:01:27.806058 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-13 07:01:28.016844 | controller | ok: Runtime: 0:00:00.005475
2025-10-13 07:01:28.031980 | 
2025-10-13 07:01:28.032062 | TASK [Show the environment passed in to job shell scripts]
2025-10-13 07:01:28.518934 | controller | SHELL=/bin/bash
2025-10-13 07:01:28.518994 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-13 07:01:28.519004 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-13 07:01:28.519062 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/37/3237/b7deffb48ede63961bc321fbc461da66a70c6d19
2025-10-13 07:01:28.519083 | controller | PWD=/home/zuul
2025-10-13 07:01:28.519090 | controller | ZUUL_PIPELINE=github-check
2025-10-13 07:01:28.519095 | controller | LOGNAME=zuul
2025-10-13 07:01:28.519101 | controller | XDG_SESSION_TYPE=tty
2025-10-13 07:01:28.519107 | controller | _=/usr/bin/env
2025-10-13 07:01:28.519112 | controller | MOTD_SHOWN=pam
2025-10-13 07:01:28.519117 | controller | HOME=/home/zuul
2025-10-13 07:01:28.519122 | controller | LANG=en_US.UTF-8
2025-10-13 07:01:28.519128 | controller | SSH_CONNECTION=192.168.26.12 36426 192.168.26.229 22
2025-10-13 07:01:28.519134 | 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
2025-10-13 07:01:28.519143 | controller | ZUUL_CHANGE_IDS=3237,b7deffb48ede63961bc321fbc461da66a70c6d19
2025-10-13 07:01:28.519149 | controller | WORKSPACE=/home/zuul/workspace
2025-10-13 07:01:28.519154 | controller | XDG_SESSION_CLASS=user
2025-10-13 07:01:28.519160 | controller | SELINUX_ROLE_REQUESTED=
2025-10-13 07:01:28.519165 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-13 07:01:28.519171 | controller | USER=zuul
2025-10-13 07:01:28.519177 | controller | ZUUL_VOTING=True
2025-10-13 07:01:28.519182 | controller | BUILD_TIMEOUT=1800000
2025-10-13 07:01:28.519187 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-13 07:01:28.519192 | controller | SHLVL=1
2025-10-13 07:01:28.519198 | controller | ZUUL_PATCHSET=b7deffb48ede63961bc321fbc461da66a70c6d19
2025-10-13 07:01:28.519203 | controller | XDG_SESSION_ID=1
2025-10-13 07:01:28.519209 | controller | ZUUL_BRANCH=main
2025-10-13 07:01:28.519214 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-13 07:01:28.519220 | controller | SSH_CLIENT=192.168.26.12 36426 22
2025-10-13 07:01:28.519225 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-13 07:01:28.519231 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-13 07:01:28.519236 | controller | which_declare=declare -f
2025-10-13 07:01:28.519243 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-13 07:01:28.519249 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-13 07:01:28.519255 | controller | ZUUL_CHANGE=3237
2025-10-13 07:01:28.519260 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-13 07:01:28.519265 | controller | ZUUL_UUID=c60da158f9824245b4d222fc08901eda
2025-10-13 07:01:28.519271 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-13 07:01:28.519276 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-13 07:01:28.519282 | controller | }
2025-10-13 07:01:28.672511 | controller | ok: Runtime: 0:00:00.006633
2025-10-13 07:01:28.679592 | 
2025-10-13 07:01:28.679666 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-13 07:01:28.734637 | controller | skipping: Conditional result was False
2025-10-13 07:01:28.741239 | 
2025-10-13 07:01:28.741315 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-13 07:01:29.393969 | controller | skipping: Conditional result was False
2025-10-13 07:01:29.400010 | 
2025-10-13 07:01:29.400101 | TASK [Ensure legacy workspace directory]
2025-10-13 07:01:29.694188 | controller | changed
2025-10-13 07:01:29.779059 | 
2025-10-13 07:01:29.779142 | PLAY RECAP
2025-10-13 07:01:29.779191 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-13 07:01:29.779214 | 
2025-10-13 07:01:30.189118 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-13 07:01:30.189864 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-13 07:01:32.783254 | 
2025-10-13 07:01:32.783359 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-10-13 07:01:32.875643 | 
2025-10-13 07:01:32.875747 | TASK [Create zuul-output directory]
2025-10-13 07:01:33.841269 | controller | changed
2025-10-13 07:01:33.857991 | 
2025-10-13 07:01:33.858114 | TASK [Slurp Zuul inventory test]
2025-10-13 07:01:35.310044 | controller -> localhost | ok
2025-10-13 07:01:35.316857 | 
2025-10-13 07:01:35.316960 | TASK [Save zuul inventory]
2025-10-13 07:01:37.023349 | controller | changed
2025-10-13 07:01:37.033878 | 
2025-10-13 07:01:37.033982 | TASK [Save zuul vars without the change_message]
2025-10-13 07:01:38.079993 | controller | changed
2025-10-13 07:01:38.198088 | 
2025-10-13 07:01:38.198162 | PLAY RECAP
2025-10-13 07:01:38.198207 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-13 07:01:38.198231 | 
2025-10-13 07:01:38.842866 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-13 07:01:38.843606 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-13 07:01:40.748425 | 
2025-10-13 07:01:40.748531 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-10-13 07:01:40.830611 | 
2025-10-13 07:01:40.830745 | TASK [Read group_vars]
2025-10-13 07:01:40.882196 | controller | ok
2025-10-13 07:01:40.973116 | 
2025-10-13 07:01:40.973249 | TASK [cifmw_helpers : Check directory is available]
2025-10-13 07:01:41.618734 | controller | ok
2025-10-13 07:01:41.633101 | 
2025-10-13 07:01:41.633197 | TASK [cifmw_helpers : Print var]
2025-10-13 07:01:41.725322 | controller | ok: provide_var is /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars
2025-10-13 07:01:41.744298 | 
2025-10-13 07:01:41.744392 | TASK [cifmw_helpers : List dir in ansible user home]
2025-10-13 07:01:42.684904 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory
2025-10-13 07:01:42.686533 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory
2025-10-13 07:01:42.688366 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied
2025-10-13 07:01:42.689370 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory
2025-10-13 07:01:42.944894 | controller | ERROR
2025-10-13 07:01:42.945082 | controller | {
2025-10-13 07:01:42.945131 | controller |   "delta": "0:00:00.010146",
2025-10-13 07:01:42.945164 | controller |   "end": "2025-10-13 07:01:42.689754",
2025-10-13 07:01:42.945186 | controller |   "msg": "non-zero return code",
2025-10-13 07:01:42.945210 | controller |   "rc": 2,
2025-10-13 07:01:42.945232 | controller |   "start": "2025-10-13 07:01:42.679608"
2025-10-13 07:01:42.945250 | controller | }
2025-10-13 07:01:42.945277 | controller | ERROR: Ignoring Errors
2025-10-13 07:01:42.951268 | 
2025-10-13 07:01:42.951334 | TASK [cifmw_helpers : List available files]
2025-10-13 07:01:43.536214 | controller | skipping: Conditional result was False
2025-10-13 07:01:43.542038 | 
2025-10-13 07:01:43.542107 | LOOP [cifmw_helpers : Read vars]
2025-10-13 07:01:43.603879 | 
2025-10-13 07:01:43.604114 | LOOP [cifmw_helpers : Call task to parse all files as fact]
2025-10-13 07:01:43.837840 | 
2025-10-13 07:01:43.837992 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-10-13 07:01:43.887380 | controller | ok
2025-10-13 07:01:43.955136 | 
2025-10-13 07:01:43.955232 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-13 07:01:44.049399 | controller | skipping: Conditional result was False
2025-10-13 07:01:44.055753 | 
2025-10-13 07:01:44.055829 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-13 07:01:44.658604 | controller | ok
2025-10-13 07:01:44.667598 | 
2025-10-13 07:01:44.667725 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-13 07:01:45.326116 | controller | ok
2025-10-13 07:01:45.349484 | 
2025-10-13 07:01:45.349554 | TASK [Prepare workspace]
2025-10-13 07:01:45.408520 | controller | ok
2025-10-13 07:01:45.510389 | 
2025-10-13 07:01:45.510481 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-13 07:01:46.138792 | controller | ok
2025-10-13 07:01:46.144704 | 
2025-10-13 07:01:46.144770 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-13 07:01:56.364523 | controller | Output suppressed because no_log was given
2025-10-13 07:01:56.390815 | 
2025-10-13 07:01:56.391618 | LOOP [Create zuul-output directory]
2025-10-13 07:01:56.686398 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-10-13 07:01:56.686614 | 
2025-10-13 07:01:56.882901 | controller | ok: "/home/zuul/zuul-output/logs"
2025-10-13 07:01:56.896212 | 
2025-10-13 07:01:56.896304 | TASK [Install required packages]
2025-10-13 07:02:48.548173 | controller | changed
2025-10-13 07:02:48.553608 | 
2025-10-13 07:02:48.553686 | TASK [Install venv]
2025-10-13 07:03:51.832102 | controller | changed
2025-10-13 07:03:51.859120 | 
2025-10-13 07:03:51.859195 | PLAY RECAP
2025-10-13 07:03:51.859240 | controller | ok: 10 changed: 5 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-13 07:03:51.859265 | 
2025-10-13 07:03:51.943040 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-13 07:03:51.943841 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-13 07:03:52.492316 | 
2025-10-13 07:03:52.492422 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-10-13 07:03:52.514151 | 
2025-10-13 07:03:52.514233 | TASK [Gather required facts]
2025-10-13 07:03:53.010596 | controller | ok
2025-10-13 07:03:53.016337 | 
2025-10-13 07:03:53.016416 | TASK [Load environment var if instructed to]
2025-10-13 07:03:53.040703 | controller | skipping: Conditional result was False
2025-10-13 07:03:53.046086 | 
2025-10-13 07:03:53.046154 | TASK [Ensure group_vars dir exists]
2025-10-13 07:03:53.358891 | controller | ok
2025-10-13 07:03:53.365100 | 
2025-10-13 07:03:53.365179 | TASK [Run molecule]
2025-10-13 07:03:54.327360 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-10-13 07:03:54.400859 | controller | WARNING  Driver podman does not provide a schema.
2025-10-13 07:03:54.403705 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-13 07:04:14.043436 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.044020 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.044527 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.045040 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.045546 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+b7deffb4 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.0.0+b7deffb4 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.046068 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.046550 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.047064 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.047538 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.048054 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.048528 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.049046 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.049521 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.050039 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.050533 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 07:04:14.061653 | controller | INFO     Running default > dependency
2025-10-13 07:04:14.062651 | controller | WARNING  Skipping, missing the requirements file.
2025-10-13 07:04:14.063421 | controller | WARNING  Skipping, missing the requirements file.
2025-10-13 07:04:14.072507 | controller | INFO     Running default > create
2025-10-13 07:04:14.301791 | controller | INFO     Sanity checks: 'podman'
2025-10-13 07:04:15.201012 | controller |
2025-10-13 07:04:15.201217 | controller | PLAY [Create] ******************************************************************
2025-10-13 07:04:15.201357 | controller |
2025-10-13 07:04:15.201500 | controller | TASK [Get podman executable path] **********************************************
2025-10-13 07:04:15.201729 | controller | Monday 13 October 2025  07:04:15 +0000 (0:00:00.014)       0:00:00.014 ********
2025-10-13 07:04:15.498086 | controller | ok: [localhost]
2025-10-13 07:04:15.538680 | controller |
2025-10-13 07:04:15.538715 | controller | TASK [Register podman executable path] *****************************************
2025-10-13 07:04:15.538725 | controller | Monday 13 October 2025  07:04:15 +0000 (0:00:00.298)       0:00:00.313 ********
2025-10-13 07:04:15.538743 | controller | ok: [localhost]
2025-10-13 07:04:15.538764 | controller |
2025-10-13 07:04:15.538780 | controller | TASK [Get passwd entries for USER env] *****************************************
2025-10-13 07:04:15.538801 | controller | Monday 13 October 2025  07:04:15 +0000 (0:00:00.040)       0:00:00.354 ********
2025-10-13 07:04:15.824870 | controller | ok: [localhost]
2025-10-13 07:04:15.824952 | controller |
2025-10-13 07:04:15.825063 | controller | TASK [Get shell async_dir] *****************************************************
2025-10-13 07:04:15.825169 | controller | Monday 13 October 2025  07:04:15 +0000 (0:00:00.286)       0:00:00.640 ********
2025-10-13 07:04:15.866761 | controller | ok: [localhost]
2025-10-13 07:04:15.866871 | controller |
2025-10-13 07:04:15.866996 | controller | TASK [Set async_dir for HOME env] **********************************************
2025-10-13 07:04:15.867120 | controller | Monday 13 October 2025  07:04:15 +0000 (0:00:00.042)       0:00:00.682 ********
2025-10-13 07:04:15.901385 | controller | skipping: [localhost]
2025-10-13 07:04:15.901497 | controller |
2025-10-13 07:04:15.901655 | controller | TASK [Log into a container registry] *******************************************
2025-10-13 07:04:15.901759 | controller | Monday 13 October 2025  07:04:15 +0000 (0:00:00.034)       0:00:00.717 ********
2025-10-13 07:04:15.944846 | controller | skipping: [localhost] => (item="instance registry username: None specified")
2025-10-13 07:04:15.944941 | controller | skipping: [localhost]
2025-10-13 07:04:15.945038 | controller |
2025-10-13 07:04:15.945144 | controller | TASK [Check presence of custom Dockerfiles] ************************************
2025-10-13 07:04:15.945255 | controller | Monday 13 October 2025  07:04:15 +0000 (0:00:00.043)       0:00:00.760 ********
2025-10-13 07:04:16.233276 | controller | ok: [localhost] => (item=Dockerfile: None specified)
2025-10-13 07:04:16.233358 | controller |
2025-10-13 07:04:16.233474 | controller | TASK [Create Dockerfiles from image names] *************************************
2025-10-13 07:04:16.233604 | controller | Monday 13 October 2025  07:04:16 +0000 (0:00:00.288)       0:00:01.048 ********
2025-10-13 07:04:16.274652 | controller | skipping: [localhost] => (item="Dockerfile: None specified; Image: registry.access.redhat.com/ubi9/ubi:latest")
2025-10-13 07:04:16.274734 | controller | skipping: [localhost]
2025-10-13 07:04:16.274837 | controller |
2025-10-13 07:04:16.274945 | controller | TASK [Discover local Podman images] ********************************************
2025-10-13 07:04:16.275052 | controller | Monday 13 October 2025  07:04:16 +0000 (0:00:00.041)       0:00:01.090 ********
2025-10-13 07:04:17.129427 | controller | ok: [localhost] => (item=instance)
2025-10-13 07:04:17.129498 | controller |
2025-10-13 07:04:17.129656 | controller | TASK [Build an Ansible compatible image] ***************************************
2025-10-13 07:04:17.129756 | controller | Monday 13 October 2025  07:04:17 +0000 (0:00:00.854)       0:00:01.944 ********
2025-10-13 07:04:17.168990 | controller | skipping: [localhost] => (item=registry.access.redhat.com/ubi9/ubi:latest)
2025-10-13 07:04:17.169085 | controller | skipping: [localhost]
2025-10-13 07:04:17.169184 | controller |
2025-10-13 07:04:17.169289 | controller | TASK [Determine the CMD directives] ********************************************
2025-10-13 07:04:17.169397 | controller | Monday 13 October 2025  07:04:17 +0000 (0:00:00.039)       0:00:01.984 ********
2025-10-13 07:04:17.217497 | controller | ok: [localhost] => (item="instance command: sleep infinity")
2025-10-13 07:04:17.217600 | controller |
2025-10-13 07:04:17.217718 | controller | TASK [Remove possible pre-existing containers] *********************************
2025-10-13 07:04:17.217824 | controller | Monday 13 October 2025  07:04:17 +0000 (0:00:00.048)       0:00:02.033 ********
2025-10-13 07:04:17.444379 | controller | changed: [localhost]
2025-10-13 07:04:17.444458 | controller |
2025-10-13 07:04:17.444608 | controller | TASK [Discover local podman networks] ******************************************
2025-10-13 07:04:17.444706 | controller | Monday 13 October 2025  07:04:17 +0000 (0:00:00.226)       0:00:02.259 ********
2025-10-13 07:04:17.486581 | controller | skipping: [localhost] => (item=instance: None specified)
2025-10-13 07:04:17.486680 | controller | skipping: [localhost]
2025-10-13 07:04:17.486776 | controller |
2025-10-13 07:04:17.486880 | controller | TASK [Create podman network dedicated to this scenario] ************************
2025-10-13 07:04:17.486982 | controller | Monday 13 October 2025  07:04:17 +0000 (0:00:00.042)       0:00:02.302 ********
2025-10-13 07:04:17.521093 | controller | skipping: [localhost]
2025-10-13 07:04:17.521198 | controller |
2025-10-13 07:04:17.521326 | controller | TASK [Create molecule instance(s)] *********************************************
2025-10-13 07:04:17.521451 | controller | Monday 13 October 2025  07:04:17 +0000 (0:00:00.034)       0:00:02.336 ********
2025-10-13 07:04:17.834937 | controller | changed: [localhost] => (item=instance)
2025-10-13 07:04:17.835012 | controller |
2025-10-13 07:04:17.835129 | controller | TASK [Wait for instance(s) creation to complete] *******************************
2025-10-13 07:04:17.835231 | controller | Monday 13 October 2025  07:04:17 +0000 (0:00:00.313)       0:00:02.650 ********
2025-10-13 07:04:23.304662 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) creation to complete (300 retries left).
2025-10-13 07:04:23.304723 | controller | changed: [localhost] => (item=instance)
2025-10-13 07:04:23.304828 | controller |
2025-10-13 07:04:23.304928 | controller | PLAY RECAP *********************************************************************
2025-10-13 07:04:23.305042 | controller | localhost                  : ok=10   changed=3    unreachable=0    failed=0    skipped=6    rescued=0    ignored=0
2025-10-13 07:04:23.305133 | controller |
2025-10-13 07:04:23.305236 | controller | Monday 13 October 2025  07:04:23 +0000 (0:00:05.469)       0:00:08.120 ********
2025-10-13 07:04:23.305331 | controller | ===============================================================================
2025-10-13 07:04:23.305430 | controller | Wait for instance(s) creation to complete ------------------------------- 5.47s
2025-10-13 07:04:23.305529 | controller | Discover local Podman images -------------------------------------------- 0.85s
2025-10-13 07:04:23.305678 | controller | Create molecule instance(s) --------------------------------------------- 0.31s
2025-10-13 07:04:23.305768 | controller | Get podman executable path ---------------------------------------------- 0.30s
2025-10-13 07:04:23.305870 | controller | Check presence of custom Dockerfiles ------------------------------------ 0.29s
2025-10-13 07:04:23.305963 | controller | Get passwd entries for USER env ----------------------------------------- 0.29s
2025-10-13 07:04:23.306062 | controller | Remove possible pre-existing containers --------------------------------- 0.23s
2025-10-13 07:04:23.306150 | controller | Determine the CMD directives -------------------------------------------- 0.05s
2025-10-13 07:04:23.306243 | controller | Log into a container registry ------------------------------------------- 0.04s
2025-10-13 07:04:23.306338 | controller | Discover local podman networks ------------------------------------------ 0.04s
2025-10-13 07:04:23.306429 | controller | Get shell async_dir ----------------------------------------------------- 0.04s
2025-10-13 07:04:23.306524 | controller | Create Dockerfiles from image names ------------------------------------- 0.04s
2025-10-13 07:04:23.306674 | controller | Register podman executable path ----------------------------------------- 0.04s
2025-10-13 07:04:23.306774 | controller | Build an Ansible compatible image --------------------------------------- 0.04s
2025-10-13 07:04:23.306880 | controller | Set async_dir for HOME env ---------------------------------------------- 0.03s
2025-10-13 07:04:23.306977 | controller | Create podman network dedicated to this scenario ------------------------ 0.03s
2025-10-13 07:04:23.362945 | controller | INFO     Running default > prepare
2025-10-13 07:04:23.771456 | controller |
2025-10-13 07:04:23.771525 | controller | PLAY [Prepare] *****************************************************************
2025-10-13 07:04:23.771677 | controller |
2025-10-13 07:04:23.771785 | controller | TASK [Gathering Facts] *********************************************************
2025-10-13 07:04:23.771893 | controller | Monday 13 October 2025  07:04:23 +0000 (0:00:00.010)       0:00:00.010 ********
2025-10-13 07:04:24.954760 | controller | ok: [instance]
2025-10-13 07:04:24.954820 | controller |
2025-10-13 07:04:24.955072 | controller | TASK [Install Python pip and dependencies using dnf] ***************************
2025-10-13 07:04:31.953390 | controller | Monday 13 October 2025  07:04:24 +0000 (0:00:01.183)       0:00:01.194 ********
2025-10-13 07:04:31.953427 | controller | changed: [instance]
2025-10-13 07:04:31.954609 | controller |
2025-10-13 07:04:37.105793 | controller | TASK [Install Python dependencies] *********************************************
2025-10-13 07:04:37.105868 | controller | Monday 13 October 2025  07:04:31 +0000 (0:00:06.997)       0:00:08.191 ********
2025-10-13 07:04:37.105882 | controller | changed: [instance]
2025-10-13 07:04:37.106081 | controller |
2025-10-13 07:04:38.674375 | controller | TASK [Create mock kubeconfig file] *********************************************
2025-10-13 07:04:38.674406 | controller | Monday 13 October 2025  07:04:37 +0000 (0:00:05.153)       0:00:13.344 ********
2025-10-13 07:04:38.674418 | controller | changed: [instance]
2025-10-13 07:04:40.022062 | controller |
2025-10-13 07:04:40.022094 | controller | TASK [Create mock kubeadmin password file] *************************************
2025-10-13 07:04:40.022102 | controller | Monday 13 October 2025  07:04:38 +0000 (0:00:01.568)       0:00:14.913 ********
2025-10-13 07:04:40.022112 | controller | changed: [instance]
2025-10-13 07:04:40.076905 | controller |
2025-10-13 07:04:40.076940 | controller | PLAY RECAP *********************************************************************
2025-10-13 07:04:40.076949 | controller | instance                   : ok=5    changed=4    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2025-10-13 07:04:40.076955 | controller |
2025-10-13 07:04:40.076961 | controller | Monday 13 October 2025  07:04:40 +0000 (0:00:01.347)       0:00:16.260 ********
2025-10-13 07:04:40.076967 | controller | ===============================================================================
2025-10-13 07:04:40.076972 | controller | Install Python pip and dependencies using dnf --------------------------- 7.00s
2025-10-13 07:04:40.076977 | controller | Install Python dependencies --------------------------------------------- 5.15s
2025-10-13 07:04:40.076983 | controller | Create mock kubeconfig file --------------------------------------------- 1.57s
2025-10-13 07:04:40.076988 | controller | Create mock kubeadmin password file ------------------------------------- 1.35s
2025-10-13 07:04:40.076994 | controller | Gathering Facts --------------------------------------------------------- 1.18s
2025-10-13 07:04:40.077004 | controller | INFO     Running default > converge
2025-10-13 07:04:40.525903 | controller |
2025-10-13 07:04:40.526153 | controller | PLAY [Converge] ****************************************************************
2025-10-13 07:04:40.526319 | controller |
2025-10-13 07:04:40.526466 | controller | TASK [Test that required variables are defined] ********************************
2025-10-13 07:04:40.526639 | controller | Monday 13 October 2025  07:04:40 +0000 (0:00:00.022)       0:00:00.022 ********
2025-10-13 07:04:40.551668 | controller | ok: [instance] => changed=false
2025-10-13 07:04:40.551956 | controller |   msg: Required variables are defined
2025-10-13 07:04:40.551978 | controller |
2025-10-13 07:04:40.572481 | controller | TASK [Display test information] ************************************************
2025-10-13 07:04:40.572502 | controller | Monday 13 October 2025  07:04:40 +0000 (0:00:00.026)       0:00:00.048 ********
2025-10-13 07:04:40.572512 | controller | ok: [instance] =>
2025-10-13 07:04:41.778842 | controller |   msg: 'Testing role cifmw_snr_nhc with kubeconfig: /tmp/kubeconfig and namespace: workload-availability'
2025-10-13 07:04:41.778886 | controller |
2025-10-13 07:04:41.778895 | controller | TASK [Test that Python kubernetes library is available] ************************
2025-10-13 07:04:41.778921 | controller | Monday 13 October 2025  07:04:40 +0000 (0:00:00.020)       0:00:00.069 ********
2025-10-13 07:04:41.778933 | controller | ok: [instance]
2025-10-13 07:04:41.778950 | controller |
2025-10-13 07:04:41.778958 | controller | TASK [Display kubernetes library test result] **********************************
2025-10-13 07:04:41.779087 | controller | Monday 13 October 2025  07:04:41 +0000 (0:00:01.206)       0:00:01.275 ********
2025-10-13 07:04:41.800659 | controller | ok: [instance] =>
2025-10-13 07:04:41.800711 | controller |   msg: Library available
2025-10-13 07:04:41.800722 | controller |
2025-10-13 07:04:41.800987 | controller | TASK [Test that mock kubeconfig exists] ****************************************
2025-10-13 07:04:42.497155 | controller | Monday 13 October 2025  07:04:41 +0000 (0:00:00.021)       0:00:01.297 ********
2025-10-13 07:04:42.497188 | controller | ok: [instance]
2025-10-13 07:04:42.523278 | controller |
2025-10-13 07:04:42.523303 | controller | TASK [Assert kubeconfig exists] ************************************************
2025-10-13 07:04:42.523311 | controller | Monday 13 October 2025  07:04:42 +0000 (0:00:00.696)       0:00:01.993 ********
2025-10-13 07:04:42.523322 | controller | ok: [instance] => changed=false
2025-10-13 07:04:44.009459 | controller |   msg: Kubeconfig file exists
2025-10-13 07:04:44.009489 | controller |
2025-10-13 07:04:44.009498 | controller | TASK [Test kubernetes.core.k8s module availability] ****************************
2025-10-13 07:04:44.009504 | controller | Monday 13 October 2025  07:04:42 +0000 (0:00:00.026)       0:00:02.019 ********
2025-10-13 07:04:44.009514 | controller | ok: [instance]
2025-10-13 07:04:44.031638 | controller |
2025-10-13 07:04:44.031670 | controller | TASK [Display k8s connection test result] **************************************
2025-10-13 07:04:44.031679 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:01.486)       0:00:03.506 ********
2025-10-13 07:04:44.031689 | controller | ok: [instance] =>
2025-10-13 07:04:44.031712 | controller |   msg: 'K8s connection test result: False'
2025-10-13 07:04:44.031719 | controller |
2025-10-13 07:04:44.031727 | controller | TASK [Include the cifmw_snr_nhc role] ******************************************
2025-10-13 07:04:44.031827 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.022)       0:00:03.528 ********
2025-10-13 07:04:44.083693 | controller |
2025-10-13 07:04:44.083723 | controller | TASK [cifmw_snr_nhc : Check if NodeHealthCheck exists and is active] ***********
2025-10-13 07:04:44.083735 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.052)       0:00:03.580 ********
2025-10-13 07:04:44.110468 | controller | skipping: [instance]
2025-10-13 07:04:44.137542 | controller |
2025-10-13 07:04:44.137609 | controller | TASK [cifmw_snr_nhc : Check for active SelfNodeRemediations] *******************
2025-10-13 07:04:44.137618 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.026)       0:00:03.607 ********
2025-10-13 07:04:44.137629 | controller | skipping: [instance]
2025-10-13 07:04:44.163031 | controller |
2025-10-13 07:04:44.163050 | controller | TASK [cifmw_snr_nhc : Display active remediations info] ************************
2025-10-13 07:04:44.163057 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.026)       0:00:03.634 ********
2025-10-13 07:04:44.163066 | controller | skipping: [instance]
2025-10-13 07:04:44.204379 | controller |
2025-10-13 07:04:44.204412 | controller | TASK [cifmw_snr_nhc : Disable NodeHealthCheck to stop active remediations] *****
2025-10-13 07:04:44.204420 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.025)       0:00:03.659 ********
2025-10-13 07:04:44.204430 | controller | skipping: [instance]
2025-10-13 07:04:44.204637 | controller |
2025-10-13 07:04:44.204804 | controller | TASK [cifmw_snr_nhc : Wait for active remediations to stop] ********************
2025-10-13 07:04:44.204954 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.041)       0:00:03.701 ********
2025-10-13 07:04:44.230986 | controller | skipping: [instance]
2025-10-13 07:04:44.231387 | controller |
2025-10-13 07:04:44.231549 | controller | TASK [cifmw_snr_nhc : Delete existing NodeHealthCheck resources] ***************
2025-10-13 07:04:44.231747 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.026)       0:00:03.728 ********
2025-10-13 07:04:44.257000 | controller | skipping: [instance]
2025-10-13 07:04:44.257186 | controller |
2025-10-13 07:04:44.257351 | controller | TASK [cifmw_snr_nhc : Check for blocking remediations when deletion fails] *****
2025-10-13 07:04:44.257508 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.026)       0:00:03.754 ********
2025-10-13 07:04:44.283128 | controller | skipping: [instance]
2025-10-13 07:04:44.283293 | controller |
2025-10-13 07:04:44.283449 | controller | TASK [cifmw_snr_nhc : Display blocking remediation details] ********************
2025-10-13 07:04:44.283631 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.026)       0:00:03.780 ********
2025-10-13 07:04:44.309304 | controller | skipping: [instance]
2025-10-13 07:04:44.335370 | controller |
2025-10-13 07:04:44.335402 | controller | TASK [cifmw_snr_nhc : Display warning if NodeHealthCheck deletion failed due to active remediation] ***
2025-10-13 07:04:44.335411 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.025)       0:00:03.806 ********
2025-10-13 07:04:44.335421 | controller | skipping: [instance]
2025-10-13 07:04:44.362343 | controller |
2025-10-13 07:04:44.362375 | controller | TASK [cifmw_snr_nhc : Skip NodeHealthCheck deletion retry if webhook blocks it] ***
2025-10-13 07:04:44.362384 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.025)       0:00:03.832 ********
2025-10-13 07:04:44.362400 | controller | skipping: [instance]
2025-10-13 07:04:44.392645 | controller |
2025-10-13 07:04:44.392677 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationConfig exists] ***************
2025-10-13 07:04:44.392685 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.026)       0:00:03.859 ********
2025-10-13 07:04:44.392694 | controller | skipping: [instance]
2025-10-13 07:04:44.393044 | controller |
2025-10-13 07:04:44.420710 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationConfig resources] *****
2025-10-13 07:04:44.420730 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.030)       0:00:03.889 ********
2025-10-13 07:04:44.420740 | controller | skipping: [instance]
2025-10-13 07:04:44.448406 | controller |
2025-10-13 07:04:44.448427 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationTemplate exists] *************
2025-10-13 07:04:44.448435 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.027)       0:00:03.917 ********
2025-10-13 07:04:44.448444 | controller | skipping: [instance]
2025-10-13 07:04:44.448623 | controller |
2025-10-13 07:04:44.448783 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationTemplate resources] ***
2025-10-13 07:04:44.448928 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.028)       0:00:03.945 ********
2025-10-13 07:04:44.476234 | controller | skipping: [instance]
2025-10-13 07:04:44.476425 | controller |
2025-10-13 07:04:44.476649 | controller | TASK [cifmw_snr_nhc : Check if Subscriptions exist] ****************************
2025-10-13 07:04:44.476813 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.027)       0:00:03.973 ********
2025-10-13 07:04:44.503718 | controller | skipping: [instance]
2025-10-13 07:04:44.503888 | controller |
2025-10-13 07:04:44.504039 | controller | TASK [cifmw_snr_nhc : Delete existing Subscriptions] ***************************
2025-10-13 07:04:44.504183 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.027)       0:00:04.000 ********
2025-10-13 07:04:44.535633 | controller | skipping: [instance] => (item=self-node-remediation-operator)
2025-10-13 07:04:44.535667 | controller | skipping: [instance] => (item=node-health-check-operator)
2025-10-13 07:04:44.535676 | controller | skipping: [instance]
2025-10-13 07:04:44.535682 | controller |
2025-10-13 07:04:44.535689 | controller | TASK [cifmw_snr_nhc : Check if OperatorGroup exists] ***************************
2025-10-13 07:04:44.535785 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.031)       0:00:04.032 ********
2025-10-13 07:04:44.565709 | controller | skipping: [instance]
2025-10-13 07:04:44.591649 | controller |
2025-10-13 07:04:44.591681 | controller | TASK [cifmw_snr_nhc : Delete existing OperatorGroup] ***************************
2025-10-13 07:04:44.591689 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.029)       0:00:04.062 ********
2025-10-13 07:04:44.591699 | controller | skipping: [instance]
2025-10-13 07:04:44.591798 | controller |
2025-10-13 07:04:44.591821 | controller | TASK [cifmw_snr_nhc : Delete the entire workload-availability namespace] *******
2025-10-13 07:04:44.591834 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.026)       0:00:04.088 ********
2025-10-13 07:04:44.618287 | controller | skipping: [instance]
2025-10-13 07:04:44.645073 | controller |
2025-10-13 07:04:44.645094 | controller | TASK [cifmw_snr_nhc : Wait for namespace deletion to complete] *****************
2025-10-13 07:04:44.645109 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.026)       0:00:04.115 ********
2025-10-13 07:04:44.645118 | controller | skipping: [instance]
2025-10-13 07:04:45.846349 | controller |
2025-10-13 07:04:45.846382 | controller | TASK [cifmw_snr_nhc : Create the workload-availability namespace] **************
2025-10-13 07:04:45.846391 | controller | Monday 13 October 2025  07:04:44 +0000 (0:00:00.026)       0:00:04.141 ********
2025-10-13 07:04:45.846401 | controller | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: urllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host='api.test.example.com', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7f9748f8e0d0>: Failed to establish a new connection: [Errno -2] Name or service not known'))
2025-10-13 07:04:45.848654 | controller | fatal: [instance]: FAILED! => changed=false
2025-10-13 07:04:45.849760 | controller |   module_stderr: |-
2025-10-13 07:04:45.849776 | controller |     Traceback (most recent call last):
2025-10-13 07:04:45.849784 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn
2025-10-13 07:04:45.849790 | controller |         conn = connection.create_connection(
2025-10-13 07:04:45.849795 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection
2025-10-13 07:04:45.849801 | controller |         for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):
2025-10-13 07:04:45.849807 | controller |       File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo
2025-10-13 07:04:45.849813 | controller |         for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
2025-10-13 07:04:45.849818 | controller |     socket.gaierror: [Errno -2] Name or service not known
2025-10-13 07:04:45.849824 | controller |
2025-10-13 07:04:45.849833 | controller |     During handling of the above exception, another exception occurred:
2025-10-13 07:04:45.850623 | controller |
2025-10-13 07:04:45.850642 | controller |     Traceback (most recent call last):
2025-10-13 07:04:45.850650 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen
2025-10-13 07:04:45.850656 | controller |         httplib_response = self._make_request(
2025-10-13 07:04:45.850662 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request
2025-10-13 07:04:45.850667 | controller |         self._validate_conn(conn)
2025-10-13 07:04:45.850673 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn
2025-10-13 07:04:45.850678 | controller |         conn.connect()
2025-10-13 07:04:45.850690 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect
2025-10-13 07:04:45.850699 | controller |         conn = self._new_conn()
2025-10-13 07:04:45.850769 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn
2025-10-13 07:04:45.850778 | controller |         raise NewConnectionError(
2025-10-13 07:04:45.850785 | controller |     urllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f9748f8e0d0>: Failed to establish a new connection: [Errno -2] Name or service not known
2025-10-13 07:04:45.850791 | controller |
2025-10-13 07:04:45.850796 | controller |     During handling of the above exception, another exception occurred:
2025-10-13 07:04:45.850801 | controller |
2025-10-13 07:04:45.850807 | controller |     Traceback (most recent call last):
2025-10-13 07:04:45.850813 | controller |       File "/tmp/ansible-tmp-1760339084.6580315-28260-218281955061259/AnsiballZ_k8s.py", line 107, in <module>
2025-10-13 07:04:45.850821 | controller |         _ansiballz_main()
2025-10-13 07:04:45.850895 | controller |       File "/tmp/ansible-tmp-1760339084.6580315-28260-218281955061259/AnsiballZ_k8s.py", line 99, in _ansiballz_main
2025-10-13 07:04:45.851010 | controller |         invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)
2025-10-13 07:04:45.851238 | controller |       File "/tmp/ansible-tmp-1760339084.6580315-28260-218281955061259/AnsiballZ_k8s.py", line 47, in invoke_module
2025-10-13 07:04:45.851376 | controller |         runpy.run_module(mod_name='ansible_collections.kubernetes.core.plugins.modules.k8s', init_globals=dict(_module_fqn='ansible_collections.kubernetes.core.plugins.modules.k8s', _modlib_path=modlib_path),
2025-10-13 07:04:45.851485 | controller |       File "/usr/lib64/python3.9/runpy.py", line 225, in run_module
2025-10-13 07:04:45.851634 | controller |         return _run_module_code(code, init_globals, run_name, mod_spec)
2025-10-13 07:04:45.851758 | controller |       File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code
2025-10-13 07:04:45.851870 | controller |         _run_code(code, mod_globals, init_globals,
2025-10-13 07:04:45.851982 | controller |       File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code
2025-10-13 07:04:45.852092 | controller |         exec(code, run_globals)
2025-10-13 07:04:45.852210 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_kf2i30gy/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>
2025-10-13 07:04:45.852324 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_kf2i30gy/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main
2025-10-13 07:04:45.852441 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_kf2i30gy/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module
2025-10-13 07:04:45.852579 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_kf2i30gy/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client
2025-10-13 07:04:45.852733 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_kf2i30gy/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper
2025-10-13 07:04:45.852851 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_kf2i30gy/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client
2025-10-13 07:04:45.852965 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__
2025-10-13 07:04:45.853075 | controller |         self.__discoverer = discoverer(self, cache_file)
2025-10-13 07:04:45.853191 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_kf2i30gy/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__
2025-10-13 07:04:45.853306 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_kf2i30gy/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__
2025-10-13 07:04:45.853432 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_kf2i30gy/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache
2025-10-13 07:04:45.853549 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info
2025-10-13 07:04:45.853715 | controller |         'kubernetes': self.client.request('get', '/version', serializer=just_json)
2025-10-13 07:04:45.853840 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner
2025-10-13 07:04:45.853950 | controller |         resp = func(self, *args, **kwargs)
2025-10-13 07:04:45.854064 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request
2025-10-13 07:04:45.854174 | controller |         api_response = self.client.call_api(
2025-10-13 07:04:45.854286 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api
2025-10-13 07:04:45.854395 | controller |         return self.__call_api(resource_path, method,
2025-10-13 07:04:45.854508 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api
2025-10-13 07:04:45.854649 | controller |         response_data = self.request(
2025-10-13 07:04:45.854772 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request
2025-10-13 07:04:45.854883 | controller |         return self.rest_client.GET(url,
2025-10-13 07:04:45.854999 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET
2025-10-13 07:04:45.855111 | controller |         return self.request("GET", url,
2025-10-13 07:04:45.855223 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request
2025-10-13 07:04:45.855339 | controller |         r = self.pool_manager.request(method, url,
2025-10-13 07:04:45.855453 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request
2025-10-13 07:04:45.855570 | controller |         return self.request_encode_url(
2025-10-13 07:04:45.855713 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url
2025-10-13 07:04:45.855829 | controller |         return self.urlopen(method, url, **extra_kw)
2025-10-13 07:04:45.855945 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen
2025-10-13 07:04:45.856055 | controller |         response = conn.urlopen(method, u.request_uri, **kw)
2025-10-13 07:04:45.856169 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen
2025-10-13 07:04:45.856285 | controller |         return self.urlopen(
2025-10-13 07:04:45.856399 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen
2025-10-13 07:04:45.856508 | controller |         return self.urlopen(
2025-10-13 07:04:45.856664 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen
2025-10-13 07:04:45.856781 | controller |         return self.urlopen(
2025-10-13 07:04:45.856894 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen
2025-10-13 07:04:45.857005 | controller |         retries = retries.increment(
2025-10-13 07:04:45.857121 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment
2025-10-13 07:04:45.857231 | controller |         raise MaxRetryError(_pool, url, error or ResponseError(cause))
2025-10-13 07:04:45.857364 | controller |     urllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host='api.test.example.com', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7f9748f8e0d0>: Failed to establish a new connection: [Errno -2] Name or service not known'))
2025-10-13 07:04:45.857478 | controller |   module_stdout: ''
2025-10-13 07:04:45.857618 | controller |   msg: |-
2025-10-13 07:04:45.857740 | controller |     MODULE FAILURE
2025-10-13 07:04:45.857851 | controller |     See stdout/stderr for the exact error
2025-10-13 07:04:45.857959 | controller |   rc: 1
2025-10-13 07:04:45.858131 | controller |
2025-10-13 07:04:45.858248 | controller | TASK [Capture role execution error] ********************************************
2025-10-13 07:04:45.858368 | controller | Monday 13 October 2025  07:04:45 +0000 (0:00:01.209)       0:00:05.350 ********
2025-10-13 07:04:45.876115 | controller | ok: [instance]
2025-10-13 07:04:45.876280 | controller |
2025-10-13 07:04:45.876423 | controller | TASK [Display role execution error details] ************************************
2025-10-13 07:04:45.876620 | controller | Monday 13 October 2025  07:04:45 +0000 (0:00:00.022)       0:00:05.373 ********
2025-10-13 07:04:45.900600 | controller | ok: [instance] =>
2025-10-13 07:04:45.900767 | controller |   msg: |-
2025-10-13 07:04:45.900922 | controller |     Role execution failed with error:
2025-10-13 07:04:45.901118 | controller |     {'delegate_to': None, 'delegate_facts': None, 'notify': None, 'collections': [], 'tags': [], 'when': [], 'name': 'Create the workload-availability namespace', 'connection': 'ssh', 'port': None, 'remote_user': None, 'vars': {}, 'module_defaults': [], 'environment': [{}], 'no_log': False, 'run_once': None, 'ignore_errors': None, 'ignore_unreachable': None, 'check_mode': False, 'diff': False, 'any_errors_fatal': False, 'throttle': 0, 'timeout': 0, 'debugger': None, 'become': False, 'become_method': 'sudo', 'become_user': None, 'become_flags': None, 'become_exe': None, 'args': {'kubeconfig': '/tmp/kubeconfig', 'state': 'present', 'resource_definition': {'apiVersion': 'v1', 'kind': 'Namespace', 'metadata': {'name': 'workload-availability'}}}, 'action': 'kubernetes.core.k8s', 'async_val': 0, 'async': 0, 'changed_when': [], 'delay': 5, 'failed_when': [], 'loop': None, 'loop_control': {'loop_var': 'item', 'index_var': None, 'label': None, 'pause': 0.0, 'extended': None, 'extended_allitems': True, 'uuid': 'fa163ee9-2cfb-9788-6602-000000000166', 'finalized': True, 'squashed': False}, 'poll': 15, 'register': 'namespace_result', 'retries': 3, 'until': [], 'loop_with': None, 'uuid': 'fa163ee9-2cfb-9788-6602-00000000008f', 'finalized': True, 'squashed': True}
2025-10-13 07:04:45.901260 | controller |
2025-10-13 07:04:45.901404 | controller | TASK [Analyze specific error patterns] *****************************************
2025-10-13 07:04:45.901523 | controller | Monday 13 October 2025  07:04:45 +0000 (0:00:00.024)       0:00:05.397 ********
2025-10-13 07:04:45.939492 | controller | ok: [instance] =>
2025-10-13 07:04:45.939651 | controller |   msg: |-
2025-10-13 07:04:45.939770 | controller |     Error analysis:
2025-10-13 07:04:45.939892 | controller |     - Connection error: False
2025-10-13 07:04:45.940010 | controller |     - Authentication error: False
2025-10-13 07:04:45.940128 | controller |     - API error: False
2025-10-13 07:04:45.940238 | controller |     - Timeout error: False
2025-10-13 07:04:45.940350 | controller |
2025-10-13 07:04:45.940468 | controller | TASK [Continue with test evaluation] *******************************************
2025-10-13 07:04:45.940613 | controller | Monday 13 October 2025  07:04:45 +0000 (0:00:00.038)       0:00:05.436 ********
2025-10-13 07:04:45.961801 | controller | ok: [instance] =>
2025-10-13 07:04:45.961922 | controller |   msg: Role failed as expected in test environment - this is normal
2025-10-13 07:04:45.962032 | controller |
2025-10-13 07:04:45.962151 | controller | TASK [Verify namespace exists] *************************************************
2025-10-13 07:04:45.962269 | controller | Monday 13 October 2025  07:04:45 +0000 (0:00:00.022)       0:00:05.458 ********
2025-10-13 07:04:47.209952 | controller | ok: [instance]
2025-10-13 07:04:47.227632 | controller |
2025-10-13 07:04:47.227652 | controller | TASK [Display namespace verification result] ***********************************
2025-10-13 07:04:47.227660 | controller | Monday 13 October 2025  07:04:47 +0000 (0:00:01.247)       0:00:06.706 ********
2025-10-13 07:04:47.227669 | controller | ok: [instance] =>
2025-10-13 07:04:47.227676 | controller |   msg: 'Namespace verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 07:04:47.227683 | controller |     "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fabb4f1df40>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339085.9773765-28437-212362945849032/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339085.9773765-28437-212362945849032/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339085.9773765-28437-212362945849032/AnsiballZ_k8s.py",
2025-10-13 07:04:47.227698 | controller |     line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 07:04:47.227711 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:47.228699 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 07:04:47.228746 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:47.228765 | controller |     line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7fabb4f1df40>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 07:04:47.228772 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 07:04:47.228778 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fabb4f1df40>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339085.9773765-28437-212362945849032/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339085.9773765-28437-212362945849032/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339085.9773765-28437-212362945849032/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 07:04:47.228790 | controller |     _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 07:04:47.228799 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_zfhbgzx3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:47.228804 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 07:04:47.228815 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:47.232975 | controller |     line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7fabb4f1df40>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 07:04:47.233004 | controller |
2025-10-13 07:04:48.496192 | controller | TASK [Test namespace creation idempotency] *************************************
2025-10-13 07:04:48.496222 | controller | Monday 13 October 2025  07:04:47 +0000 (0:00:00.023)       0:00:06.730 ********
2025-10-13 07:04:48.496234 | controller | ok: [instance]
2025-10-13 07:04:48.519240 | controller |
2025-10-13 07:04:48.519260 | controller | TASK [Assert expected behavior for namespace creation] *************************
2025-10-13 07:04:48.519268 | controller | Monday 13 October 2025  07:04:48 +0000 (0:00:01.262)       0:00:07.992 ********
2025-10-13 07:04:48.519277 | controller | ok: [instance] => changed=false
2025-10-13 07:04:49.889831 | controller |   msg: Namespace creation task behaves consistently
2025-10-13 07:04:49.889863 | controller |
2025-10-13 07:04:49.889870 | controller | TASK [Verify OperatorGroup exists] *********************************************
2025-10-13 07:04:49.889877 | controller | Monday 13 October 2025  07:04:48 +0000 (0:00:00.023)       0:00:08.016 ********
2025-10-13 07:04:49.889886 | controller | ok: [instance]
2025-10-13 07:04:49.906696 | controller |
2025-10-13 07:04:49.906727 | controller | TASK [Display OperatorGroup verification result] *******************************
2025-10-13 07:04:49.906735 | controller | Monday 13 October 2025  07:04:49 +0000 (0:00:01.370)       0:00:09.386 ********
2025-10-13 07:04:49.906745 | controller | ok: [instance] =>
2025-10-13 07:04:49.907625 | controller |   msg: 'OperatorGroup verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 07:04:49.907648 | controller |     "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7feadd9f8c40>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339088.5319378-28778-152492223417183/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339088.5319378-28778-152492223417183/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339088.5319378-28778-152492223417183/AnsiballZ_k8s.py",
2025-10-13 07:04:49.907656 | controller |     line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 07:04:49.907674 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:49.907763 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 07:04:49.907793 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:49.907805 | controller |     line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7feadd9f8c40>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 07:04:49.907821 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 07:04:49.907874 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7feadd9f8c40>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339088.5319378-28778-152492223417183/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339088.5319378-28778-152492223417183/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339088.5319378-28778-152492223417183/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 07:04:49.907997 | controller |     _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 07:04:49.908127 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_ya9fb2b0/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:49.908240 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 07:04:49.908372 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:49.908484 | controller |     line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7feadd9f8c40>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 07:04:49.913122 | controller |
2025-10-13 07:04:50.995220 | controller | TASK [Test OperatorGroup creation idempotency] *********************************
2025-10-13 07:04:50.995277 | controller | Monday 13 October 2025  07:04:49 +0000 (0:00:00.023)       0:00:09.410 ********
2025-10-13 07:04:50.995290 | controller | ok: [instance]
2025-10-13 07:04:51.017898 | controller |
2025-10-13 07:04:51.017923 | controller | TASK [Assert expected behavior for OperatorGroup creation] *********************
2025-10-13 07:04:51.017931 | controller | Monday 13 October 2025  07:04:50 +0000 (0:00:01.081)       0:00:10.491 ********
2025-10-13 07:04:51.017940 | controller | ok: [instance] => changed=false
2025-10-13 07:04:52.105126 | controller |   msg: OperatorGroup creation task behaves consistently
2025-10-13 07:04:52.105160 | controller |
2025-10-13 07:04:52.105168 | controller | TASK [Verify SNR Subscription exists] ******************************************
2025-10-13 07:04:52.105174 | controller | Monday 13 October 2025  07:04:51 +0000 (0:00:00.022)       0:00:10.514 ********
2025-10-13 07:04:52.105184 | controller | ok: [instance]
2025-10-13 07:04:52.121618 | controller |
2025-10-13 07:04:52.121636 | controller | TASK [Display SNR Subscription verification result] ****************************
2025-10-13 07:04:52.121643 | controller | Monday 13 October 2025  07:04:52 +0000 (0:00:01.087)       0:00:11.601 ********
2025-10-13 07:04:52.121653 | controller | ok: [instance] =>
2025-10-13 07:04:52.122188 | controller |   msg: 'SNR Subscription verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 07:04:52.122221 | controller |     "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fbbd7fb13d0>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339091.0304477-29119-154767376192937/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339091.0304477-29119-154767376192937/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339091.0304477-29119-154767376192937/AnsiballZ_k8s.py",
2025-10-13 07:04:52.122229 | controller |     line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 07:04:52.122244 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:52.122256 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 07:04:52.122262 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:52.122271 | controller |     line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7fbbd7fb13d0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 07:04:52.122304 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 07:04:52.123067 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fbbd7fb13d0>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339091.0304477-29119-154767376192937/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339091.0304477-29119-154767376192937/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339091.0304477-29119-154767376192937/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 07:04:52.123087 | controller |     _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 07:04:52.123095 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_xtj31zd5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:52.123114 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 07:04:52.127377 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:52.127394 | controller |     line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7fbbd7fb13d0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 07:04:52.127405 | controller |
2025-10-13 07:04:53.232098 | controller | TASK [Test SNR Subscription creation idempotency] ******************************
2025-10-13 07:04:53.232129 | controller | Monday 13 October 2025  07:04:52 +0000 (0:00:00.022)       0:00:11.624 ********
2025-10-13 07:04:53.232141 | controller | ok: [instance]
2025-10-13 07:04:53.232196 | controller |
2025-10-13 07:04:53.232308 | controller | TASK [Assert expected behavior for SNR Subscription creation] ******************
2025-10-13 07:04:53.232400 | controller | Monday 13 October 2025  07:04:53 +0000 (0:00:01.104)       0:00:12.728 ********
2025-10-13 07:04:53.257851 | controller | ok: [instance] => changed=false
2025-10-13 07:04:54.469889 | controller |   msg: SNR Subscription creation task behaves consistently
2025-10-13 07:04:54.469922 | controller |
2025-10-13 07:04:54.469930 | controller | TASK [Verify SNR deployment status] ********************************************
2025-10-13 07:04:54.469936 | controller | Monday 13 October 2025  07:04:53 +0000 (0:00:00.025)       0:00:12.754 ********
2025-10-13 07:04:54.469945 | controller | ok: [instance]
2025-10-13 07:04:54.488654 | controller |
2025-10-13 07:04:54.488685 | controller | TASK [Display SNR deployment verification result] ******************************
2025-10-13 07:04:54.488693 | controller | Monday 13 October 2025  07:04:54 +0000 (0:00:01.212)       0:00:13.966 ********
2025-10-13 07:04:54.488703 | controller | ok: [instance] =>
2025-10-13 07:04:54.488710 | controller |   msg: 'SNR deployment verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 07:04:54.488722 | controller |     "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fdeedcee820>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339093.2707043-29461-281472454259456/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339093.2707043-29461-281472454259456/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339093.2707043-29461-281472454259456/AnsiballZ_k8s_info.py",
2025-10-13 07:04:54.488728 | controller |     line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 221, in main\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-13 07:04:54.488740 | controller |     line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-13 07:04:54.489710 | controller |     45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 07:04:54.489728 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:54.489736 | controller |     line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7fdeedcee820>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 07:04:54.489751 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 07:04:54.489757 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fdeedcee820>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339093.2707043-29461-281472454259456/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339093.2707043-29461-281472454259456/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339093.2707043-29461-281472454259456/AnsiballZ_k8s_info.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py",
2025-10-13 07:04:54.489763 | controller |     line 225, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 221, in main\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-13 07:04:54.489771 | controller |     line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_xen__7je/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-13 07:04:54.495805 | controller |     92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 07:04:54.495824 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:54.495831 | controller |     line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7fdeedcee820>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 07:04:54.495840 | controller |
2025-10-13 07:04:54.515674 | controller | TASK [Test deployment verification behavior] ***********************************
2025-10-13 07:04:54.515708 | controller | Monday 13 October 2025  07:04:54 +0000 (0:00:00.026)       0:00:13.992 ********
2025-10-13 07:04:54.515720 | controller | ok: [instance] =>
2025-10-13 07:04:54.537096 | controller |   msg: Testing deployment verification logic - expected to fail in mock environment
2025-10-13 07:04:54.537122 | controller |
2025-10-13 07:04:54.537130 | controller | TASK [Assert SNR deployment verification behaves as expected] ******************
2025-10-13 07:04:54.537137 | controller | Monday 13 October 2025  07:04:54 +0000 (0:00:00.019)       0:00:14.012 ********
2025-10-13 07:04:54.537146 | controller | ok: [instance] => changed=false
2025-10-13 07:04:55.654691 | controller |   msg: SNR deployment verification logic behaves as expected
2025-10-13 07:04:55.654728 | controller |
2025-10-13 07:04:55.654740 | controller | TASK [Verify NHC Subscription exists] ******************************************
2025-10-13 07:04:55.654747 | controller | Monday 13 October 2025  07:04:54 +0000 (0:00:00.021)       0:00:14.033 ********
2025-10-13 07:04:55.654756 | controller | ok: [instance]
2025-10-13 07:04:55.671900 | controller |
2025-10-13 07:04:55.671934 | controller | TASK [Display NHC Subscription verification result] ****************************
2025-10-13 07:04:55.671943 | controller | Monday 13 October 2025  07:04:55 +0000 (0:00:01.117)       0:00:15.151 ********
2025-10-13 07:04:55.671953 | controller | ok: [instance] =>
2025-10-13 07:04:55.671974 | controller |   msg: 'NHC Subscription verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 07:04:55.673610 | controller |     "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f7144f1b130>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339094.5493815-29633-196906914675897/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339094.5493815-29633-196906914675897/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339094.5493815-29633-196906914675897/AnsiballZ_k8s.py",
2025-10-13 07:04:55.673637 | controller |     line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 07:04:55.673646 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:55.673663 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 07:04:55.673670 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:55.673675 | controller |     line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7f7144f1b130>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 07:04:55.673683 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 07:04:55.673695 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f7144f1b130>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339094.5493815-29633-196906914675897/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339094.5493815-29633-196906914675897/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339094.5493815-29633-196906914675897/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 07:04:55.673701 | controller |     _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 07:04:55.673708 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload__2dg9360/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:55.673716 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 07:04:55.673725 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:55.679011 | controller |     line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7f7144f1b130>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 07:04:55.679030 | controller |
2025-10-13 07:04:56.790291 | controller | TASK [Test NHC Subscription creation idempotency] ******************************
2025-10-13 07:04:56.790322 | controller | Monday 13 October 2025  07:04:55 +0000 (0:00:00.024)       0:00:15.175 ********
2025-10-13 07:04:56.790334 | controller | ok: [instance]
2025-10-13 07:04:56.815311 | controller |
2025-10-13 07:04:56.815338 | controller | TASK [Assert expected behavior for NHC Subscription creation] ******************
2025-10-13 07:04:56.815346 | controller | Monday 13 October 2025  07:04:56 +0000 (0:00:01.110)       0:00:16.286 ********
2025-10-13 07:04:56.815356 | controller | ok: [instance] => changed=false
2025-10-13 07:04:57.981737 | controller |   msg: NHC Subscription creation task behaves consistently
2025-10-13 07:04:57.981769 | controller |
2025-10-13 07:04:57.981776 | controller | TASK [Verify CSV status] *******************************************************
2025-10-13 07:04:57.981783 | controller | Monday 13 October 2025  07:04:56 +0000 (0:00:00.024)       0:00:16.311 ********
2025-10-13 07:04:57.981793 | controller | ok: [instance]
2025-10-13 07:04:57.998368 | controller |
2025-10-13 07:04:57.998397 | controller | TASK [Display CSV verification result] *****************************************
2025-10-13 07:04:57.998412 | controller | Monday 13 October 2025  07:04:57 +0000 (0:00:01.166)       0:00:17.478 ********
2025-10-13 07:04:57.998423 | controller | ok: [instance] =>
2025-10-13 07:04:57.998430 | controller |   msg: 'CSV verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 07:04:57.998437 | controller |     "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f07accd5be0>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339096.8287148-29969-123556419916802/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339096.8287148-29969-123556419916802/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339096.8287148-29969-123556419916802/AnsiballZ_k8s_info.py",
2025-10-13 07:04:57.998443 | controller |     line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 221, in main\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-13 07:04:57.998455 | controller |     line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-13 07:04:57.998482 | controller |     45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 07:04:57.998489 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:57.998498 | controller |     line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7f07accd5be0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 07:04:57.998506 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 07:04:57.998528 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f07accd5be0>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339096.8287148-29969-123556419916802/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339096.8287148-29969-123556419916802/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339096.8287148-29969-123556419916802/AnsiballZ_k8s_info.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py",
2025-10-13 07:04:57.999183 | controller |     line 225, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 221, in main\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-13 07:04:57.999206 | controller |     line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_x2o_99p_/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-13 07:04:57.999214 | controller |     92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 07:04:57.999228 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:58.003726 | controller |     line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7f07accd5be0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 07:04:58.003746 | controller |
2025-10-13 07:04:58.023613 | controller | TASK [Test CSV verification behavior] ******************************************
2025-10-13 07:04:58.023635 | controller | Monday 13 October 2025  07:04:58 +0000 (0:00:00.022)       0:00:17.500 ********
2025-10-13 07:04:58.023646 | controller | ok: [instance] =>
2025-10-13 07:04:58.023804 | controller |   msg: Testing CSV verification logic - expected to fail in mock environment
2025-10-13 07:04:58.023943 | controller |
2025-10-13 07:04:58.024086 | controller | TASK [Assert CSV verification behaves as expected] *****************************
2025-10-13 07:04:58.024233 | controller | Monday 13 October 2025  07:04:58 +0000 (0:00:00.020)       0:00:17.520 ********
2025-10-13 07:04:58.045884 | controller | ok: [instance] => changed=false
2025-10-13 07:04:58.046076 | controller |   msg: CSV verification logic behaves as expected
2025-10-13 07:04:58.046241 | controller |
2025-10-13 07:04:58.046409 | controller | TASK [Verify NHC CR exists] ****************************************************
2025-10-13 07:04:58.046549 | controller | Monday 13 October 2025  07:04:58 +0000 (0:00:00.022)       0:00:17.542 ********
2025-10-13 07:04:59.105144 | controller | ok: [instance]
2025-10-13 07:04:59.121986 | controller |
2025-10-13 07:04:59.122015 | controller | TASK [Display NHC CR verification result] **************************************
2025-10-13 07:04:59.122023 | controller | Monday 13 October 2025  07:04:59 +0000 (0:00:01.058)       0:00:18.601 ********
2025-10-13 07:04:59.122033 | controller | ok: [instance] =>
2025-10-13 07:04:59.122045 | controller |   msg: 'NHC CR verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 07:04:59.122059 | controller |     "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fa851d945b0>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339098.0584452-30143-178114852901993/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339098.0584452-30143-178114852901993/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339098.0584452-30143-178114852901993/AnsiballZ_k8s.py",
2025-10-13 07:04:59.122067 | controller |     line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 07:04:59.122079 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:59.122088 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 07:04:59.122094 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:59.122100 | controller |     line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7fa851d945b0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 07:04:59.122111 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 07:04:59.122119 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fa851d945b0>: Failed to establish a new connection: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/tmp/ansible-tmp-1760339098.0584452-30143-178114852901993/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760339098.0584452-30143-178114852901993/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760339098.0584452-30143-178114852901993/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 07:04:59.122124 | controller |     _run_module_code(code, init_globals, run_name, mod_spec)\n  File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code\n    exec(code, run_globals)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 07:04:59.122130 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__\n    self.__discoverer = discoverer(self, cache_file)\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_px9a69a2/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 07:04:59.122143 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 07:04:59.126162 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 07:04:59.126179 | controller |     line 756, in urlopen\n    retries = retries.increment(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment\n    raise MaxRetryError(_pool, url, error or ResponseError(cause))\nurllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host=\''api.test.example.com\'', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(\''<urllib3.connection.HTTPSConnection object at 0x7fa851d945b0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 07:04:59.126190 | controller |
2025-10-13 07:05:00.135205 | controller | TASK [Test NHC CR creation idempotency] ****************************************
2025-10-13 07:05:00.135236 | controller | Monday 13 October 2025  07:04:59 +0000 (0:00:00.021)       0:00:18.623 ********
2025-10-13 07:05:00.135248 | controller | ok: [instance]
2025-10-13 07:05:00.156274 | controller |
2025-10-13 07:05:00.156302 | controller | TASK [Assert expected behavior for NHC CR creation] ****************************
2025-10-13 07:05:00.156310 | controller | Monday 13 October 2025  07:05:00 +0000 (0:00:01.008)       0:00:19.631 ********
2025-10-13 07:05:00.156320 | controller | ok: [instance] => changed=false
2025-10-13 07:05:00.188342 | controller |   msg: NHC CR creation task behaves consistently
2025-10-13 07:05:00.188365 | controller |
2025-10-13 07:05:00.188373 | controller | TASK [Verify role structure and logic] *****************************************
2025-10-13 07:05:00.188379 | controller | Monday 13 October 2025  07:05:00 +0000 (0:00:00.021)       0:00:19.652 ********
2025-10-13 07:05:00.188388 | controller | ok: [instance] =>
2025-10-13 07:05:00.244879 | controller |   msg: Role execution and verification completed - errors are expected in test environment without real K8s cluster
2025-10-13 07:05:00.244910 | controller |
2025-10-13 07:05:00.244919 | controller | PLAY RECAP *********************************************************************
2025-10-13 07:05:00.244925 | controller | instance                   : ok=41   changed=0    unreachable=0    failed=0    skipped=20   rescued=1    ignored=0
2025-10-13 07:05:00.244931 | controller |
2025-10-13 07:05:00.244936 | controller | Monday 13 October 2025  07:05:00 +0000 (0:00:00.029)       0:00:19.682 ********
2025-10-13 07:05:00.244942 | controller | ===============================================================================
2025-10-13 07:05:00.244947 | controller | Test kubernetes.core.k8s module availability ---------------------------- 1.49s
2025-10-13 07:05:00.244953 | controller | Verify OperatorGroup exists --------------------------------------------- 1.37s
2025-10-13 07:05:00.244958 | controller | Test namespace creation idempotency ------------------------------------- 1.26s
2025-10-13 07:05:00.244967 | controller | Verify namespace exists ------------------------------------------------- 1.25s
2025-10-13 07:05:00.244972 | controller | Verify SNR deployment status -------------------------------------------- 1.21s
2025-10-13 07:05:00.244978 | controller | cifmw_snr_nhc : Create the workload-availability namespace -------------- 1.21s
2025-10-13 07:05:00.244983 | controller | Test that Python kubernetes library is available ------------------------ 1.21s
2025-10-13 07:05:00.244988 | controller | Verify CSV status ------------------------------------------------------- 1.17s
2025-10-13 07:05:00.244994 | controller | Verify NHC Subscription exists ------------------------------------------ 1.12s
2025-10-13 07:05:00.244999 | controller | Test NHC Subscription creation idempotency ------------------------------ 1.11s
2025-10-13 07:05:00.245005 | controller | Test SNR Subscription creation idempotency ------------------------------ 1.10s
2025-10-13 07:05:00.245010 | controller | Verify SNR Subscription exists ------------------------------------------ 1.09s
2025-10-13 07:05:00.245016 | controller | Test OperatorGroup creation idempotency --------------------------------- 1.08s
2025-10-13 07:05:00.245021 | controller | Verify NHC CR exists ---------------------------------------------------- 1.06s
2025-10-13 07:05:00.245027 | controller | Test NHC CR creation idempotency ---------------------------------------- 1.01s
2025-10-13 07:05:00.245032 | controller | Test that mock kubeconfig exists ---------------------------------------- 0.70s
2025-10-13 07:05:00.245037 | controller | Include the cifmw_snr_nhc role ------------------------------------------ 0.05s
2025-10-13 07:05:00.245043 | controller | cifmw_snr_nhc : Disable NodeHealthCheck to stop active remediations ----- 0.04s
2025-10-13 07:05:00.245048 | controller | Analyze specific error patterns ----------------------------------------- 0.04s
2025-10-13 07:05:00.245053 | controller | cifmw_snr_nhc : Delete existing Subscriptions --------------------------- 0.03s
2025-10-13 07:05:00.245063 | controller | INFO     Running default > verify
2025-10-13 07:05:00.245435 | controller | INFO     Running Ansible Verifier
2025-10-13 07:05:00.664749 | controller |
2025-10-13 07:05:01.844572 | controller | PLAY [Verify] ******************************************************************
2025-10-13 07:05:01.844614 | controller |
2025-10-13 07:05:01.844623 | controller | TASK [Check if Python kubernetes library is installed] *************************
2025-10-13 07:05:01.844629 | controller | Monday 13 October 2025  07:05:00 +0000 (0:00:00.020)       0:00:00.020 ********
2025-10-13 07:05:01.844639 | controller | ok: [instance]
2025-10-13 07:05:01.864367 | controller |
2025-10-13 07:05:01.864390 | controller | TASK [Display kubernetes library version] **************************************
2025-10-13 07:05:01.864397 | controller | Monday 13 October 2025  07:05:01 +0000 (0:00:01.180)       0:00:01.200 ********
2025-10-13 07:05:01.864407 | controller | ok: [instance] =>
2025-10-13 07:05:02.560947 | controller |   msg: 'kubernetes library version: 34.1.0'
2025-10-13 07:05:02.560976 | controller |
2025-10-13 07:05:02.560985 | controller | TASK [Verify kubeconfig mock file exists] **************************************
2025-10-13 07:05:02.560991 | controller | Monday 13 October 2025  07:05:01 +0000 (0:00:00.019)       0:00:01.220 ********
2025-10-13 07:05:02.561001 | controller | ok: [instance]
2025-10-13 07:05:02.582411 | controller |
2025-10-13 07:05:02.582439 | controller | TASK [Assert kubeconfig mock file exists] **************************************
2025-10-13 07:05:02.582447 | controller | Monday 13 October 2025  07:05:02 +0000 (0:00:00.696)       0:00:01.917 ********
2025-10-13 07:05:02.582458 | controller | ok: [instance] => changed=false
2025-10-13 07:05:03.142020 | controller |   msg: Mock kubeconfig file exists
2025-10-13 07:05:03.142052 | controller |
2025-10-13 07:05:03.142061 | controller | TASK [Verify kubeadmin password mock file exists] ******************************
2025-10-13 07:05:03.142068 | controller | Monday 13 October 2025  07:05:02 +0000 (0:00:00.021)       0:00:01.938 ********
2025-10-13 07:05:03.142078 | controller | ok: [instance]
2025-10-13 07:05:03.162895 | controller |
2025-10-13 07:05:03.162937 | controller | TASK [Assert kubeadmin password mock file exists] ******************************
2025-10-13 07:05:03.162948 | controller | Monday 13 October 2025  07:05:03 +0000 (0:00:00.559)       0:00:02.498 ********
2025-10-13 07:05:03.162960 | controller | ok: [instance] => changed=false
2025-10-13 07:05:03.850137 | controller |   msg: Mock kubeadmin password file exists
2025-10-13 07:05:03.850172 | controller |
2025-10-13 07:05:03.850181 | controller | TASK [Test Python yaml library] ************************************************
2025-10-13 07:05:03.850187 | controller | Monday 13 October 2025  07:05:03 +0000 (0:00:00.020)       0:00:02.519 ********
2025-10-13 07:05:03.850197 | controller | ok: [instance]
2025-10-13 07:05:03.884589 | controller |
2025-10-13 07:05:03.884630 | controller | TASK [Display yaml test result] ************************************************
2025-10-13 07:05:03.884639 | controller | Monday 13 October 2025  07:05:03 +0000 (0:00:00.687)       0:00:03.206 ********
2025-10-13 07:05:03.884650 | controller | ok: [instance] =>
2025-10-13 07:05:03.931237 | controller |   msg: yaml library works
2025-10-13 07:05:03.931264 | controller |
2025-10-13 07:05:03.931273 | controller | PLAY RECAP *********************************************************************
2025-10-13 07:05:03.931279 | controller | instance                   : ok=8    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2025-10-13 07:05:03.931285 | controller |
2025-10-13 07:05:03.931290 | controller | Monday 13 October 2025  07:05:03 +0000 (0:00:00.033)       0:00:03.239 ********
2025-10-13 07:05:03.931296 | controller | ===============================================================================
2025-10-13 07:05:03.931301 | controller | Check if Python kubernetes library is installed ------------------------- 1.18s
2025-10-13 07:05:03.931307 | controller | Verify kubeconfig mock file exists -------------------------------------- 0.70s
2025-10-13 07:05:03.931312 | controller | Test Python yaml library ------------------------------------------------ 0.69s
2025-10-13 07:05:03.931317 | controller | Verify kubeadmin password mock file exists ------------------------------ 0.56s
2025-10-13 07:05:03.931329 | controller | Display yaml test result ------------------------------------------------ 0.03s
2025-10-13 07:05:03.931334 | controller | Assert kubeconfig mock file exists -------------------------------------- 0.02s
2025-10-13 07:05:03.931340 | controller | Assert kubeadmin password mock file exists ------------------------------ 0.02s
2025-10-13 07:05:03.931345 | controller | Display kubernetes library version -------------------------------------- 0.02s
2025-10-13 07:05:03.931355 | controller | INFO     Verifier completed successfully.
2025-10-13 07:05:03.941730 | controller | INFO     Running default > destroy
2025-10-13 07:05:04.361077 | controller |
2025-10-13 07:05:04.361335 | controller | PLAY [Destroy] *****************************************************************
2025-10-13 07:05:04.361490 | controller |
2025-10-13 07:05:04.361683 | controller | TASK [Get passwd entries for USER env] *****************************************
2025-10-13 07:05:04.361836 | controller | Monday 13 October 2025  07:05:04 +0000 (0:00:00.014)       0:00:00.014 ********
2025-10-13 07:05:04.643535 | controller | ok: [localhost]
2025-10-13 07:05:04.684585 | controller |
2025-10-13 07:05:04.684624 | controller | TASK [Get shell async_dir] *****************************************************
2025-10-13 07:05:04.684633 | controller | Monday 13 October 2025  07:05:04 +0000 (0:00:00.282)       0:00:00.296 ********
2025-10-13 07:05:04.684642 | controller | ok: [localhost]
2025-10-13 07:05:04.717635 | controller |
2025-10-13 07:05:04.717663 | controller | TASK [Set async_dir for HOME env] **********************************************
2025-10-13 07:05:04.717672 | controller | Monday 13 October 2025  07:05:04 +0000 (0:00:00.041)       0:00:00.338 ********
2025-10-13 07:05:04.717684 | controller | skipping: [localhost]
2025-10-13 07:05:05.090832 | controller |
2025-10-13 07:05:05.090863 | controller | TASK [Destroy molecule instance(s)] ********************************************
2025-10-13 07:05:05.090871 | controller | Monday 13 October 2025  07:05:04 +0000 (0:00:00.032)       0:00:00.370 ********
2025-10-13 07:05:05.090882 | controller | changed: [localhost] => (item={'capabilities': ['SYS_ADMIN'], 'command': 'sleep infinity', 'groups': ['molecule', 'rhol_crc_molecule'], 'image': 'registry.access.redhat.com/ubi9/ubi:latest', 'name': 'instance', 'pre_build_image': True, 'privileged': True, 'tmpfs': ['/run', '/tmp'], 'volumes': ['/sys/fs/cgroup:/sys/fs/cgroup:ro']})
2025-10-13 07:05:15.710638 | controller |
2025-10-13 07:05:15.710672 | controller | TASK [Wait for instance(s) deletion to complete] *******************************
2025-10-13 07:05:15.710680 | controller | Monday 13 October 2025  07:05:05 +0000 (0:00:00.373)       0:00:00.744 ********
2025-10-13 07:05:15.710694 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (300 retries left).
2025-10-13 07:05:15.757706 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (299 retries left).
2025-10-13 07:05:15.757740 | controller | changed: [localhost] => (item={'failed': 0, 'started': 1, 'finished': 0, 'ansible_job_id': 'j856379204662.31204', 'results_file': '/home/zuul/.ansible_async/j856379204662.31204', 'changed': True, 'item': {'capabilities': ['SYS_ADMIN'], 'command': 'sleep infinity', 'groups': ['molecule', 'rhol_crc_molecule'], 'image': 'registry.access.redhat.com/ubi9/ubi:latest', 'name': 'instance', 'pre_build_image': True, 'privileged': True, 'tmpfs': ['/run', '/tmp'], 'volumes': ['/sys/fs/cgroup:/sys/fs/cgroup:ro']}, 'ansible_loop_var': 'item'})
2025-10-13 07:05:15.757749 | controller |
2025-10-13 07:05:15.757755 | controller | TASK [Delete podman network dedicated to this scenario] ************************
2025-10-13 07:05:15.757761 | controller | Monday 13 October 2025  07:05:15 +0000 (0:00:10.619)       0:00:11.363 ********
2025-10-13 07:05:15.757771 | controller | skipping: [localhost] => (item=instance: None specified)
2025-10-13 07:05:15.757795 | controller | skipping: [localhost]
2025-10-13 07:05:15.757802 | controller |
2025-10-13 07:05:15.757808 | controller | PLAY RECAP *********************************************************************
2025-10-13 07:05:15.757815 | controller | localhost                  : ok=4    changed=2    unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-10-13 07:05:15.758600 | controller |
2025-10-13 07:05:15.758712 | controller | Monday 13 October 2025  07:05:15 +0000 (0:00:00.047)       0:00:11.411 ********
2025-10-13 07:05:15.758731 | controller | ===============================================================================
2025-10-13 07:05:15.758738 | controller | Wait for instance(s) deletion to complete ------------------------------ 10.62s
2025-10-13 07:05:15.758743 | controller | Destroy molecule instance(s) -------------------------------------------- 0.37s
2025-10-13 07:05:15.758749 | controller | Get passwd entries for USER env ----------------------------------------- 0.28s
2025-10-13 07:05:15.758754 | controller | Delete podman network dedicated to this scenario ------------------------ 0.05s
2025-10-13 07:05:15.758760 | controller | Get shell async_dir ----------------------------------------------------- 0.04s
2025-10-13 07:05:15.758769 | controller | Set async_dir for HOME env ---------------------------------------------- 0.03s
2025-10-13 07:05:15.800055 | controller | INFO     Pruning extra files from scenario ephemeral directory
2025-10-13 07:05:15.801933 | controller | INFO     Writing /tmp/report.html report.
2025-10-13 07:05:15.980760 | controller | changed
2025-10-13 07:05:16.007375 | 
2025-10-13 07:05:16.007453 | PLAY RECAP
2025-10-13 07:05:16.007497 | controller | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-13 07:05:16.007519 | 
2025-10-13 07:05:16.074739 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-13 07:05:16.075559 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-13 07:05:16.610432 | 
2025-10-13 07:05:16.610527 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-13 07:05:16.630279 | 
2025-10-13 07:05:16.630351 | TASK [Filter out host if needed]
2025-10-13 07:05:16.639693 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-13 07:05:16.644127 | 
2025-10-13 07:05:16.644194 | TASK [Ensure file is present]
2025-10-13 07:05:16.955935 | controller | ok
2025-10-13 07:05:16.962582 | 
2025-10-13 07:05:16.962649 | TASK [Manage molecule report file]
2025-10-13 07:05:17.487224 | controller | changed
2025-10-13 07:05:17.493185 | 
2025-10-13 07:05:17.493254 | TASK [Check if we get ci-framework-data basedir]
2025-10-13 07:05:17.687193 | controller | ok
2025-10-13 07:05:17.695497 | 
2025-10-13 07:05:17.695567 | TASK [Create ci-framework-data log directory for zuul]
2025-10-13 07:05:18.032294 | controller | changed
2025-10-13 07:05:18.047281 | 
2025-10-13 07:05:18.047373 | TASK [Copy ci-framework interesting files]
2025-10-13 07:05:18.278682 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-10-13 07:05:18.610724 | controller | changed
2025-10-13 07:05:18.620516 | 
2025-10-13 07:05:18.620616 | TASK [Get SELinux listing]
2025-10-13 07:05:19.151956 | controller | changed
2025-10-13 07:05:19.158120 | 
2025-10-13 07:05:19.158190 | TASK [Generate log index]
2025-10-13 07:05:19.785059 | controller | changed
2025-10-13 07:05:19.789903 | 
2025-10-13 07:05:19.789987 | TASK [Get some env related data]
2025-10-13 07:05:20.319004 | controller | /home/zuul/.local/bin/ansible
2025-10-13 07:05:21.316680 | controller | changed
2025-10-13 07:05:21.321949 | 
2025-10-13 07:05:21.322048 | TASK [Generate list of logs to collect in home directory]
2025-10-13 07:05:21.613474 | controller | ok: All paths examined
2025-10-13 07:05:21.618542 | 
2025-10-13 07:05:21.618622 | LOOP [Copy logs from home directory]
2025-10-13 07:05:21.928616 | controller | changed:
2025-10-13 07:05:21.928720 | controller | {
2025-10-13 07:05:21.928747 | controller |   "atime": 1760339013.864715,
2025-10-13 07:05:21.928766 | controller |   "ctime": 1760339031.4117868,
2025-10-13 07:05:21.928782 | controller |   "dev": 64513,
2025-10-13 07:05:21.928879 | controller |   "gid": 1000,
2025-10-13 07:05:21.928905 | controller |   "gr_name": "zuul",
2025-10-13 07:05:21.928945 | controller |   "inode": 4481741,
2025-10-13 07:05:21.928964 | controller |   "isblk": false,
2025-10-13 07:05:21.929123 | controller |   "ischr": false,
2025-10-13 07:05:21.929159 | controller |   "isdir": false,
2025-10-13 07:05:21.929181 | controller |   "isfifo": false,
2025-10-13 07:05:21.929220 | controller |   "isgid": false,
2025-10-13 07:05:21.929238 | controller |   "islnk": false,
2025-10-13 07:05:21.929254 | controller |   "isreg": true,
2025-10-13 07:05:21.929269 | controller |   "issock": false,
2025-10-13 07:05:21.929284 | controller |   "isuid": false,
2025-10-13 07:05:21.929298 | controller |   "mode": "0644",
2025-10-13 07:05:21.929313 | controller |   "mtime": 1760339031.4117868,
2025-10-13 07:05:21.929327 | controller |   "nlink": 1,
2025-10-13 07:05:21.929341 | controller |   "path": "/home/zuul/ansible.log",
2025-10-13 07:05:21.929356 | controller |   "pw_name": "zuul",
2025-10-13 07:05:21.929371 | controller |   "rgrp": true,
2025-10-13 07:05:21.929385 | controller |   "roth": true,
2025-10-13 07:05:21.929399 | controller |   "rusr": true,
2025-10-13 07:05:21.929414 | controller |   "size": 6749,
2025-10-13 07:05:21.929428 | controller |   "uid": 1000,
2025-10-13 07:05:21.929442 | controller |   "wgrp": false,
2025-10-13 07:05:21.929454 | controller |   "woth": false,
2025-10-13 07:05:21.929470 | controller |   "wusr": true,
2025-10-13 07:05:21.929483 | controller |   "xgrp": false,
2025-10-13 07:05:21.929497 | controller |   "xoth": false,
2025-10-13 07:05:21.929510 | controller |   "xusr": false
2025-10-13 07:05:21.929523 | controller | }
2025-10-13 07:05:21.946525 | 
2025-10-13 07:05:21.946633 | TASK [Copy crio stats log file]
2025-10-13 07:05:21.960554 | controller | skipping: Conditional result was False
2025-10-13 07:05:21.967618 | 
2025-10-13 07:05:21.967709 | TASK [Get SELinux related data]
2025-10-13 07:05:22.180392 | controller | <no matches>
2025-10-13 07:05:22.493438 | controller | ERROR
2025-10-13 07:05:22.493602 | controller | {
2025-10-13 07:05:22.493635 | controller |   "delta": "0:00:00.008613",
2025-10-13 07:05:22.493658 | controller |   "end": "2025-10-13 07:05:22.181310",
2025-10-13 07:05:22.493677 | controller |   "msg": "non-zero return code",
2025-10-13 07:05:22.493695 | controller |   "rc": 1,
2025-10-13 07:05:22.493713 | controller |   "start": "2025-10-13 07:05:22.172697"
2025-10-13 07:05:22.493730 | controller | }
2025-10-13 07:05:22.493754 | controller | ERROR: Ignoring Errors
2025-10-13 07:05:22.500190 | 
2025-10-13 07:05:22.500262 | TASK [Create system configuration directory]
2025-10-13 07:05:22.685703 | controller | changed
2025-10-13 07:05:22.691720 | 
2025-10-13 07:05:22.691794 | TASK [Get some of the system configurations]
2025-10-13 07:05:23.219838 | controller | changed
2025-10-13 07:05:23.229962 | 
2025-10-13 07:05:23.230110 | TASK [Copy generated documentation if available]
2025-10-13 07:05:23.254129 | controller | skipping: Conditional result was False
2025-10-13 07:05:23.260734 | 
2025-10-13 07:05:23.260808 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-13 07:05:23.274197 | controller | skipping: Conditional result was False
2025-10-13 07:05:23.281740 | 
2025-10-13 07:05:23.281804 | TASK [Compress logs bigger than 2MB]
2025-10-13 07:05:23.815062 | controller | changed
2025-10-13 07:05:23.820480 | 
2025-10-13 07:05:23.820551 | TASK [Copy files from workspace on node]
2025-10-13 07:05:23.838667 | controller | ok
2025-10-13 07:05:23.862300 | 
2025-10-13 07:05:23.862404 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-13 07:05:23.875843 | controller | skipping: Conditional result was False
2025-10-13 07:05:23.882270 | 
2025-10-13 07:05:23.882352 | TASK [fetch-output : Set log path for single node]
2025-10-13 07:05:23.913603 | controller | ok
2025-10-13 07:05:23.919693 | 
2025-10-13 07:05:23.919769 | LOOP [fetch-output : Ensure local output dirs]
2025-10-13 07:05:24.124690 | controller -> localhost | ok: "/var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/logs"
2025-10-13 07:05:24.124932 | controller -> localhost | changed: All items complete
2025-10-13 07:05:24.124974 | 
2025-10-13 07:05:24.320905 | controller -> localhost | changed: "/var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/artifacts"
2025-10-13 07:05:24.513317 | controller -> localhost | changed: "/var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/docs"
2025-10-13 07:05:24.529305 | 
2025-10-13 07:05:24.530228 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-13 07:05:25.098357 | controller | changed:
2025-10-13 07:05:25.099487 | controller | .d..t...... ./
2025-10-13 07:05:25.099547 | controller | >f+++++++++ README.html
2025-10-13 07:05:25.099575 | controller | >f+++++++++ ansible-execution.log
2025-10-13 07:05:25.099601 | controller | >f+++++++++ ansible.log
2025-10-13 07:05:25.099623 | controller | >f+++++++++ dmesg.log
2025-10-13 07:05:25.099643 | controller | >f+++++++++ installed-pkgs.log
2025-10-13 07:05:25.099664 | controller | >f+++++++++ python.log
2025-10-13 07:05:25.099684 | controller | >f+++++++++ registries.conf
2025-10-13 07:05:25.099702 | controller | >f+++++++++ report.html
2025-10-13 07:05:25.099722 | controller | >f+++++++++ selinux-denials.log
2025-10-13 07:05:25.099741 | controller | >f+++++++++ selinux-listing.log
2025-10-13 07:05:25.099758 | controller | cd+++++++++ ci-framework-data/
2025-10-13 07:05:25.099776 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-10-13 07:05:25.099794 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-10-13 07:05:25.099812 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-10-13 07:05:25.099829 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-10-13 07:05:25.099850 | controller | cd+++++++++ ci-framework-data/logs/
2025-10-13 07:05:25.099869 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-10-13 07:05:25.099886 | controller | cd+++++++++ registries.conf.d/
2025-10-13 07:05:25.099904 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-13 07:05:25.099955 | controller | cd+++++++++ system-config/
2025-10-13 07:05:25.099976 | controller | cd+++++++++ system-config/libvirt/
2025-10-13 07:05:25.099994 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-10-13 07:05:25.100012 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-10-13 07:05:25.609938 | controller | changed: .d..t...... ./
2025-10-13 07:05:26.052533 | controller | changed: .d..t...... ./
2025-10-13 07:05:26.066693 | 
2025-10-13 07:05:26.066799 | TASK [Return artifact to Zuul]
2025-10-13 07:05:26.095265 | controller | ok
2025-10-13 07:05:26.117202 | 
2025-10-13 07:05:26.117285 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-13 07:05:26.117381 | 
2025-10-13 07:05:26.117407 | PLAY RECAP
2025-10-13 07:05:26.117447 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-13 07:05:26.117468 | 
2025-10-13 07:05:26.205657 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-13 07:05:26.206479 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-13 07:05:26.811289 | 
2025-10-13 07:05:26.811421 | PLAY [all]
2025-10-13 07:05:26.829928 | 
2025-10-13 07:05:26.830004 | TASK [include_role : fetch-output]
2025-10-13 07:05:26.859162 | controller | ok
2025-10-13 07:05:26.875868 | 
2025-10-13 07:05:26.875979 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-13 07:05:26.930256 | controller | skipping: Conditional result was False
2025-10-13 07:05:26.936183 | 
2025-10-13 07:05:26.936255 | TASK [fetch-output : Set log path for single node]
2025-10-13 07:05:26.974685 | controller | ok
2025-10-13 07:05:26.985107 | 
2025-10-13 07:05:26.985222 | LOOP [fetch-output : Ensure local output dirs]
2025-10-13 07:05:27.363405 | controller -> localhost | ok: "/var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/logs"
2025-10-13 07:05:27.554832 | controller -> localhost | ok: "/var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/artifacts"
2025-10-13 07:05:27.758698 | controller -> localhost | ok: "/var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/docs"
2025-10-13 07:05:27.773021 | 
2025-10-13 07:05:27.773130 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-13 07:05:28.315602 | controller | ok
2025-10-13 07:05:28.315793 | controller | ok: All items complete
2025-10-13 07:05:28.315824 | 
2025-10-13 07:05:28.691902 | controller | ok
2025-10-13 07:05:29.088623 | controller | ok
2025-10-13 07:05:29.100546 | 
2025-10-13 07:05:29.100636 | TASK [include_role : fetch-output-openshift]
2025-10-13 07:05:29.128217 | controller | skipping: Conditional result was False
2025-10-13 07:05:29.136063 | 
2025-10-13 07:05:29.136163 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-13 07:05:29.559742 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006568
2025-10-13 07:05:29.808333 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.017929
2025-10-13 07:05:29.855188 | 
2025-10-13 07:05:29.855267 | PLAY [all]
2025-10-13 07:05:29.877251 | 
2025-10-13 07:05:29.877322 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-13 07:05:30.294769 | controller | changed
2025-10-13 07:05:30.322653 | 
2025-10-13 07:05:30.322722 | PLAY RECAP
2025-10-13 07:05:30.322768 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-13 07:05:30.322792 | 
2025-10-13 07:05:30.398585 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-13 07:05:30.399359 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-13 07:05:31.062454 | 
2025-10-13 07:05:31.062556 | PLAY [localhost]
2025-10-13 07:05:31.079489 | 
2025-10-13 07:05:31.079563 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-13 07:05:31.475401 | localhost | changed
2025-10-13 07:05:31.480142 | 
2025-10-13 07:05:31.480222 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-13 07:05:31.509454 | localhost | ok
2025-10-13 07:05:31.519356 | 
2025-10-13 07:05:31.519438 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-13 07:05:31.864390 | localhost | changed
2025-10-13 07:05:31.870870 | 
2025-10-13 07:05:31.870971 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-13 07:05:32.588758 | localhost | changed
2025-10-13 07:05:32.595430 | 
2025-10-13 07:05:32.595507 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-13 07:05:33.059202 | localhost | Identity added: /var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/tmp/ansible.wyrl2mx0 (/var/lib/zuul/builds/c60da158f9824245b4d222fc08901eda/work/tmp/ansible.wyrl2mx0)
2025-10-13 07:05:33.059394 | localhost | ok: Runtime: 0:00:00.011842
2025-10-13 07:05:33.064492 | 
2025-10-13 07:05:33.064573 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-13 07:05:33.513340 | localhost | ok: Runtime: 0:00:00.011227
2025-10-13 07:05:33.518863 | 
2025-10-13 07:05:33.518971 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-13 07:05:33.570606 | localhost | changed
2025-10-13 07:05:33.577023 | 
2025-10-13 07:05:33.577102 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-13 07:05:33.960543 | localhost | changed
2025-10-13 07:05:33.989165 | 
2025-10-13 07:05:33.989234 | PLAY [localhost]
2025-10-13 07:05:34.010108 | 
2025-10-13 07:05:34.010178 | TASK [Generate bulk log download script]
2025-10-13 07:05:34.041954 | localhost | ok
2025-10-13 07:05:34.054739 | 
2025-10-13 07:05:34.054837 | TASK [local-log-download : Check API endpoint is defined]
2025-10-13 07:05:34.092801 | localhost | ok: All assertions passed
2025-10-13 07:05:34.097468 | 
2025-10-13 07:05:34.097542 | TASK [local-log-download : Create download script]
2025-10-13 07:05:34.513410 | localhost -> localhost | changed
2025-10-13 07:05:34.522460 | 
2025-10-13 07:05:34.522525 | TASK [Register quick-download link]
2025-10-13 07:05:34.556362 | localhost | ok
2025-10-13 07:05:34.619160 | 
2025-10-13 07:05:34.619250 | PLAY [logserver.rdoproject.org]
2025-10-13 07:05:34.630520 | 
2025-10-13 07:05:34.630583 | TASK [Set zuul-log-path fact]
2025-10-13 07:05:34.647258 | logserver.rdoproject.org | ok
2025-10-13 07:05:34.656899 | 
2025-10-13 07:05:34.656984 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-13 07:05:34.683749 | logserver.rdoproject.org | ok
2025-10-13 07:05:34.689842 | 
2025-10-13 07:05:34.689934 | TASK [upload-logs : Create log directories]
2025-10-13 07:05:36.321635 | logserver.rdoproject.org | changed
2025-10-13 07:05:36.325097 | 
2025-10-13 07:05:36.325167 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-13 07:05:36.654347 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005939
2025-10-13 07:05:36.659849 | 
2025-10-13 07:05:36.659957 | TASK [upload-logs : Upload logs to log server]
2025-10-13 07:05:38.274090 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-13 07:05:38.278083 | 
2025-10-13 07:05:38.278153 | LOOP [upload-logs : Compress console log and json output]
2025-10-13 07:05:38.384339 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 07:05:38.404634 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 07:05:38.413721 | 
2025-10-13 07:05:38.413843 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-13 07:05:38.454471 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 07:05:38.454701 | 
2025-10-13 07:05:38.457737 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 07:05:38.463258 | 
2025-10-13 07:05:38.463383 | LOOP [upload-logs : Upload console log and json output]