2025-10-03 12:56:31.066814 | Job console starting...
2025-10-03 12:56:31.307683 | Updating repositories
2025-10-03 12:56:32.321397 | Preparing job workspace
2025-10-03 12:56:51.987542 | Running Ansible setup...
2025-10-03 12:57:00.559251 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-03 12:57:02.941828 | 
2025-10-03 12:57:02.941992 | PLAY [localhost]
2025-10-03 12:57:02.998427 | 
2025-10-03 12:57:02.998541 | TASK [Gathering Facts]
2025-10-03 12:57:06.926649 | localhost | ok
2025-10-03 12:57:06.999457 | 
2025-10-03 12:57:06.999603 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-03 12:57:08.703558 | localhost -> localhost | changed
2025-10-03 12:57:08.710829 | 
2025-10-03 12:57:08.710936 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-03 12:57:12.601460 | localhost -> localhost | changed
2025-10-03 12:57:12.612781 | 
2025-10-03 12:57:12.612906 | TASK [Setup log path fact]
2025-10-03 12:57:12.727965 | localhost | ok
2025-10-03 12:57:12.789041 | 
2025-10-03 12:57:12.789172 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-03 12:57:12.924450 | localhost | ok
2025-10-03 12:57:12.944641 | 
2025-10-03 12:57:12.944750 | TASK [emit-job-header : Print job information]
2025-10-03 12:57:13.128213 | # Job Information
2025-10-03 12:57:13.128519 | Ansible Version: 2.15.12
2025-10-03 12:57:13.128551 | Job: cifmw-molecule-cifmw_snr_nhc
2025-10-03 12:57:13.128575 | Pipeline: github-check
2025-10-03 12:57:13.128596 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-10-03 12:57:13.128615 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3366
2025-10-03 12:57:13.128635 | Log URL (when completed): https://logserver.rdoproject.org/620/rdoproject.org/6206bd2b107848b3bfc19e2e9fd0536c/
2025-10-03 12:57:13.128657 | Event ID: 2f17a3d0-a058-11f0-9c81-07e47aea193a
2025-10-03 12:57:13.136613 | 
2025-10-03 12:57:13.136685 | LOOP [emit-job-header : Print node information]
2025-10-03 12:57:13.642477 | localhost | ok:
2025-10-03 12:57:13.642739 | localhost | # Node Information
2025-10-03 12:57:13.642777 | localhost | Inventory Hostname: controller
2025-10-03 12:57:13.642809 | localhost | Hostname: np0005469125
2025-10-03 12:57:13.642834 | localhost | Username: zuul
2025-10-03 12:57:13.642857 | localhost | Distro: CentOS 9
2025-10-03 12:57:13.642879 | localhost | Provider: ibm-bm4-nodepool
2025-10-03 12:57:13.642899 | localhost | Region: regionOne
2025-10-03 12:57:13.642998 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-10-03 12:57:13.643026 | localhost | Product Name: OpenStack Compute
2025-10-03 12:57:13.643047 | localhost | Interface IP: 192.168.26.213
2025-10-03 12:57:13.728168 | 
2025-10-03 12:57:13.728280 | PLAY [all]
2025-10-03 12:57:13.757218 | 
2025-10-03 12:57:13.757309 | TASK [Gather network facts]
2025-10-03 12:57:14.217629 | controller | ok
2025-10-03 12:57:14.281308 | 
2025-10-03 12:57:14.281440 | TASK [include_role : start-zuul-console]
2025-10-03 12:57:14.346500 | controller | ok
2025-10-03 12:57:14.390341 | 
2025-10-03 12:57:14.390459 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-03 12:57:15.353800 | controller | ok
2025-10-03 12:57:15.387665 | 
2025-10-03 12:57:15.387759 | TASK [include_role : add-build-sshkey]
2025-10-03 12:57:15.452964 | controller | ok
2025-10-03 12:57:15.516811 | 
2025-10-03 12:57:15.516952 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-03 12:57:16.887278 | controller -> localhost | ok
2025-10-03 12:57:16.900644 | 
2025-10-03 12:57:16.900736 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-03 12:57:17.008408 | controller | ok
2025-10-03 12:57:17.082399 | controller | included: /var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-03 12:57:17.116781 | 
2025-10-03 12:57:17.116881 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-03 12:57:19.927184 | controller -> localhost | Generating public/private rsa key pair.
2025-10-03 12:57:19.927452 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/6206bd2b107848b3bfc19e2e9fd0536c_id_rsa.
2025-10-03 12:57:19.927489 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/6206bd2b107848b3bfc19e2e9fd0536c_id_rsa.pub.
2025-10-03 12:57:19.927515 | controller -> localhost | The key fingerprint is:
2025-10-03 12:57:19.927538 | controller -> localhost | SHA256:kl144DmlXa2POx9icZl8NFPe5s2bqDD+hvCHDeLCzKs zuul-build-sshkey
2025-10-03 12:57:19.927558 | controller -> localhost | The key's randomart image is:
2025-10-03 12:57:19.927579 | controller -> localhost | +---[RSA 3072]----+
2025-10-03 12:57:19.927599 | controller -> localhost | |        . . ..  .|
2025-10-03 12:57:19.927619 | controller -> localhost | |       . B .  ..o|
2025-10-03 12:57:19.927638 | controller -> localhost | |        * +  . o=|
2025-10-03 12:57:19.927659 | controller -> localhost | |       o +  .. B+|
2025-10-03 12:57:19.927679 | controller -> localhost | |      o S   .o= =|
2025-10-03 12:57:19.927697 | controller -> localhost | |       + .  .oo.o|
2025-10-03 12:57:19.927718 | controller -> localhost | |    + . +o= oo.o |
2025-10-03 12:57:19.927738 | controller -> localhost | |     = ..+o=+. . |
2025-10-03 12:57:19.927758 | controller -> localhost | |   E..o  .+o o.  |
2025-10-03 12:57:19.927778 | controller -> localhost | +----[SHA256]-----+
2025-10-03 12:57:19.927832 | controller -> localhost | ok: Runtime: 0:00:00.580188
2025-10-03 12:57:19.933902 | 
2025-10-03 12:57:19.934006 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-03 12:57:20.072215 | controller | ok
2025-10-03 12:57:20.149608 | controller | included: /var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-03 12:57:20.665218 | 
2025-10-03 12:57:20.665345 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-03 12:57:20.775019 | controller | skipping: Conditional result was False
2025-10-03 12:57:20.781339 | 
2025-10-03 12:57:20.781419 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-03 12:57:21.541877 | controller | changed
2025-10-03 12:57:21.556014 | 
2025-10-03 12:57:21.556141 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-03 12:57:21.940877 | controller | ok
2025-10-03 12:57:21.959138 | 
2025-10-03 12:57:21.959366 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-03 12:57:22.799010 | controller | changed
2025-10-03 12:57:22.814363 | 
2025-10-03 12:57:22.814454 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-03 12:57:23.768618 | controller | changed
2025-10-03 12:57:23.776538 | 
2025-10-03 12:57:23.776630 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-03 12:57:23.912265 | controller | skipping: Conditional result was False
2025-10-03 12:57:23.918387 | 
2025-10-03 12:57:23.918464 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-03 12:57:25.097426 | controller -> localhost | changed
2025-10-03 12:57:25.112674 | 
2025-10-03 12:57:25.112751 | TASK [add-build-sshkey : Add back temp key]
2025-10-03 12:57:26.392508 | controller -> localhost | Identity added: /var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/6206bd2b107848b3bfc19e2e9fd0536c_id_rsa (zuul-build-sshkey)
2025-10-03 12:57:26.392705 | controller -> localhost | ok: Runtime: 0:00:00.060757
2025-10-03 12:57:26.400540 | 
2025-10-03 12:57:26.400612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-03 12:57:27.237167 | controller | ok
2025-10-03 12:57:27.263037 | 
2025-10-03 12:57:27.263135 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-03 12:57:27.382461 | controller | skipping: Conditional result was False
2025-10-03 12:57:27.395796 | 
2025-10-03 12:57:27.395889 | TASK [include_role : validate-host]
2025-10-03 12:57:27.516690 | controller | ok
2025-10-03 12:57:27.641542 | 
2025-10-03 12:57:27.641705 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-03 12:57:27.751190 | controller | ok
2025-10-03 12:57:27.756169 | 
2025-10-03 12:57:27.756235 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-03 12:57:29.329473 | controller -> localhost | ok
2025-10-03 12:57:29.372479 | 
2025-10-03 12:57:29.372595 | TASK [validate-host : Collect information about the host]
2025-10-03 12:57:30.086993 | controller | ok
2025-10-03 12:57:30.122629 | 
2025-10-03 12:57:30.122728 | TASK [validate-host : Sanitize hostname]
2025-10-03 12:57:30.396492 | controller | ok
2025-10-03 12:57:30.409653 | 
2025-10-03 12:57:30.409737 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-03 12:57:32.860130 | controller -> localhost | changed
2025-10-03 12:57:32.865878 | 
2025-10-03 12:57:32.866025 | TASK [validate-host : Collect information about zuul worker]
2025-10-03 12:57:34.234295 | controller | ok
2025-10-03 12:57:34.256185 | 
2025-10-03 12:57:34.256305 | TASK [validate-host : Write out all zuul information for each host]
2025-10-03 12:57:36.519473 | controller -> localhost | changed
2025-10-03 12:57:36.572549 | 
2025-10-03 12:57:36.572657 | TASK [include_role : prepare-workspace-openshift]
2025-10-03 12:57:36.641289 | controller | skipping: Conditional result was False
2025-10-03 12:57:36.647977 | 
2025-10-03 12:57:36.648077 | TASK [include_role : remove-zuul-sshkey]
2025-10-03 12:57:36.749828 | controller | skipping: Conditional result was False
2025-10-03 12:57:36.756713 | 
2025-10-03 12:57:36.756807 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-03 12:57:37.100267 | controller | ok: "logs"
2025-10-03 12:57:37.100504 | controller | ok: All items complete
2025-10-03 12:57:37.100533 | 
2025-10-03 12:57:37.262773 | controller | ok: "artifacts"
2025-10-03 12:57:37.466799 | controller | ok: "docs"
2025-10-03 12:57:37.495745 | 
2025-10-03 12:57:37.495868 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-03 12:57:37.864293 | controller | changed: "logs"
2025-10-03 12:57:38.026903 | controller | changed: "artifacts"
2025-10-03 12:57:38.246691 | controller | changed: "docs"
2025-10-03 12:57:38.303194 | 
2025-10-03 12:57:38.303283 | PLAY RECAP
2025-10-03 12:57:38.303341 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-03 12:57:38.303370 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-03 12:57:38.303390 | 
2025-10-03 12:57:38.788332 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-03 12:57:38.789122 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-03 12:57:41.072719 | 
2025-10-03 12:57:41.072840 | PLAY [all]
2025-10-03 12:57:41.130199 | 
2025-10-03 12:57:41.130324 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-03 12:57:41.253268 | controller | ok
2025-10-03 12:57:41.268985 | 
2025-10-03 12:57:41.269076 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-03 12:57:42.130249 | controller | changed
2025-10-03 12:57:42.136410 | 
2025-10-03 12:57:42.136485 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-03 12:57:43.872113 | controller | changed
2025-10-03 12:57:43.905584 | 
2025-10-03 12:57:43.905692 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-03 12:57:44.678158 | controller | changed:
2025-10-03 12:57:44.678373 | controller | {
2025-10-03 12:57:44.678411 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-03 12:57:44.678441 | controller | }
2025-10-03 12:57:44.902985 | controller | changed:
2025-10-03 12:57:44.903072 | controller | {
2025-10-03 12:57:44.903100 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-03 12:57:44.903122 | controller | }
2025-10-03 12:57:45.117297 | controller | changed:
2025-10-03 12:57:45.117381 | controller | {
2025-10-03 12:57:45.117408 | 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-03 12:57:45.117428 | controller | }
2025-10-03 12:57:45.334124 | controller | changed:
2025-10-03 12:57:45.334233 | controller | {
2025-10-03 12:57:45.334302 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-03 12:57:45.334328 | controller | }
2025-10-03 12:57:45.551339 | controller | changed:
2025-10-03 12:57:45.551423 | controller | {
2025-10-03 12:57:45.551450 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-03 12:57:45.551471 | controller | }
2025-10-03 12:57:45.801518 | controller | changed:
2025-10-03 12:57:45.801608 | controller | {
2025-10-03 12:57:45.801638 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-03 12:57:45.801661 | controller | }
2025-10-03 12:57:46.034979 | controller | changed:
2025-10-03 12:57:46.035058 | controller | {
2025-10-03 12:57:46.035086 | 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-03 12:57:46.035109 | controller | }
2025-10-03 12:57:46.255723 | controller | changed:
2025-10-03 12:57:46.255798 | controller | {
2025-10-03 12:57:46.255828 | 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-03 12:57:46.255850 | controller | }
2025-10-03 12:57:46.554880 | controller | changed:
2025-10-03 12:57:46.556038 | controller | {
2025-10-03 12:57:46.556073 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-03 12:57:46.556098 | controller | }
2025-10-03 12:57:46.722232 | controller | changed:
2025-10-03 12:57:46.722314 | controller | {
2025-10-03 12:57:46.722342 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-03 12:57:46.722365 | controller | }
2025-10-03 12:57:46.952883 | controller | changed:
2025-10-03 12:57:46.953007 | controller | {
2025-10-03 12:57:46.953034 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-03 12:57:46.953055 | controller | }
2025-10-03 12:57:47.185995 | controller | changed:
2025-10-03 12:57:47.186104 | controller | {
2025-10-03 12:57:47.186131 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-03 12:57:47.186152 | controller | }
2025-10-03 12:57:47.430800 | controller | changed:
2025-10-03 12:57:47.433955 | controller | {
2025-10-03 12:57:47.434007 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-03 12:57:47.434035 | controller | }
2025-10-03 12:57:47.679245 | controller | changed:
2025-10-03 12:57:47.679327 | controller | {
2025-10-03 12:57:47.679355 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-03 12:57:47.679376 | controller | }
2025-10-03 12:57:47.898078 | controller | changed:
2025-10-03 12:57:47.898159 | controller | {
2025-10-03 12:57:47.898188 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-03 12:57:47.898211 | controller | }
2025-10-03 12:57:48.131876 | controller | changed:
2025-10-03 12:57:48.132040 | controller | {
2025-10-03 12:57:48.132069 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-03 12:57:48.132091 | controller | }
2025-10-03 12:57:48.364834 | controller | changed:
2025-10-03 12:57:48.364970 | controller | {
2025-10-03 12:57:48.365002 | 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-03 12:57:48.365027 | controller | }
2025-10-03 12:57:48.596847 | controller | changed:
2025-10-03 12:57:48.596982 | controller | {
2025-10-03 12:57:48.597013 | 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-03 12:57:48.597042 | controller | }
2025-10-03 12:57:48.836484 | controller | changed:
2025-10-03 12:57:48.836577 | controller | {
2025-10-03 12:57:48.836698 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-03 12:57:48.836726 | controller | }
2025-10-03 12:57:49.061823 | controller | changed:
2025-10-03 12:57:49.061902 | controller | {
2025-10-03 12:57:49.061960 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-03 12:57:49.061984 | controller | }
2025-10-03 12:57:49.304476 | controller | changed:
2025-10-03 12:57:49.304572 | controller | {
2025-10-03 12:57:49.304600 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-03 12:57:49.304622 | controller | }
2025-10-03 12:57:49.526540 | controller | changed:
2025-10-03 12:57:49.526641 | controller | {
2025-10-03 12:57:49.526668 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-03 12:57:49.526689 | controller | }
2025-10-03 12:57:49.749584 | controller | changed:
2025-10-03 12:57:49.749688 | controller | {
2025-10-03 12:57:49.749719 | 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-03 12:57:49.749742 | controller | }
2025-10-03 12:57:49.990370 | controller | changed:
2025-10-03 12:57:49.990486 | controller | {
2025-10-03 12:57:49.990513 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-03 12:57:49.990535 | controller | }
2025-10-03 12:57:50.216086 | controller | changed:
2025-10-03 12:57:50.216185 | controller | {
2025-10-03 12:57:50.216216 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-03 12:57:50.216239 | controller | }
2025-10-03 12:57:50.456676 | controller | changed:
2025-10-03 12:57:50.457031 | controller | {
2025-10-03 12:57:50.457182 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-03 12:57:50.457213 | controller | }
2025-10-03 12:57:50.507465 | 
2025-10-03 12:57:50.507574 | TASK [Set timezone to UTC]
2025-10-03 12:57:51.387240 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-03 12:57:51.399774 | 
2025-10-03 12:57:51.399841 | TASK [Create nodepool directory]
2025-10-03 12:57:51.678183 | controller | changed
2025-10-03 12:57:51.698184 | 
2025-10-03 12:57:51.698265 | TASK [Create nodepool sub_nodes file]
2025-10-03 12:57:52.406424 | controller | changed
2025-10-03 12:57:52.412053 | 
2025-10-03 12:57:52.412127 | TASK [Create nodepool sub_nodes_private file]
2025-10-03 12:57:53.096591 | controller | changed
2025-10-03 12:57:53.106407 | 
2025-10-03 12:57:53.110480 | LOOP [Populate nodepool sub_nodes file]
2025-10-03 12:57:53.226950 | 
2025-10-03 12:57:53.227112 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-03 12:57:53.320347 | 
2025-10-03 12:57:53.320502 | TASK [Create nodepool primary file]
2025-10-03 12:57:53.451194 | controller | skipping: Conditional result was False
2025-10-03 12:57:53.457163 | 
2025-10-03 12:57:53.457243 | TASK [Create nodepool node_private for this node]
2025-10-03 12:57:54.254882 | controller | changed
2025-10-03 12:57:54.270018 | 
2025-10-03 12:57:54.270206 | LOOP [Copy ssh keys to nodepool directory]
2025-10-03 12:57:55.313497 | controller | ok: Item: id_rsa Runtime: 0:00:00.006158
2025-10-03 12:57:55.313674 | 
2025-10-03 12:57:55.500192 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.005775
2025-10-03 12:57:55.515683 | 
2025-10-03 12:57:55.515773 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-03 12:57:56.320584 | controller | changed
2025-10-03 12:57:56.325981 | 
2025-10-03 12:57:56.326045 | TASK [Validate sudoers config after edits]
2025-10-03 12:57:56.772632 | controller | /etc/sudoers: parsed OK
2025-10-03 12:57:56.772718 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-03 12:57:56.772730 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-03 12:57:56.772736 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-03 12:57:56.930012 | controller | ok: Runtime: 0:00:00.005352
2025-10-03 12:57:56.935451 | 
2025-10-03 12:57:56.935514 | TASK [Show the environment passed in to job shell scripts]
2025-10-03 12:57:57.347005 | controller | SHELL=/bin/bash
2025-10-03 12:57:57.347042 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-03 12:57:57.347052 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-03 12:57:57.347058 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/66/3366/b240c2cfd05c40bb7a65ea687abcd0518a943f72
2025-10-03 12:57:57.347063 | controller | PWD=/home/zuul
2025-10-03 12:57:57.347069 | controller | ZUUL_PIPELINE=github-check
2025-10-03 12:57:57.347074 | controller | LOGNAME=zuul
2025-10-03 12:57:57.347080 | controller | XDG_SESSION_TYPE=tty
2025-10-03 12:57:57.347117 | controller | _=/usr/bin/env
2025-10-03 12:57:57.347126 | controller | MOTD_SHOWN=pam
2025-10-03 12:57:57.347131 | controller | HOME=/home/zuul
2025-10-03 12:57:57.347137 | controller | LANG=en_US.UTF-8
2025-10-03 12:57:57.347143 | controller | SSH_CONNECTION=192.168.26.12 60658 192.168.26.213 22
2025-10-03 12:57:57.347149 | 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-03 12:57:57.347157 | controller | ZUUL_CHANGE_IDS=3366,b240c2cfd05c40bb7a65ea687abcd0518a943f72
2025-10-03 12:57:57.347162 | controller | WORKSPACE=/home/zuul/workspace
2025-10-03 12:57:57.347167 | controller | XDG_SESSION_CLASS=user
2025-10-03 12:57:57.347173 | controller | SELINUX_ROLE_REQUESTED=
2025-10-03 12:57:57.347178 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-03 12:57:57.347183 | controller | USER=zuul
2025-10-03 12:57:57.347188 | controller | ZUUL_VOTING=True
2025-10-03 12:57:57.347193 | controller | BUILD_TIMEOUT=1800000
2025-10-03 12:57:57.347198 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-03 12:57:57.347204 | controller | SHLVL=1
2025-10-03 12:57:57.347209 | controller | ZUUL_PATCHSET=b240c2cfd05c40bb7a65ea687abcd0518a943f72
2025-10-03 12:57:57.347214 | controller | XDG_SESSION_ID=1
2025-10-03 12:57:57.347219 | controller | ZUUL_BRANCH=main
2025-10-03 12:57:57.347224 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-03 12:57:57.347230 | controller | SSH_CLIENT=192.168.26.12 60658 22
2025-10-03 12:57:57.347235 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-03 12:57:57.347240 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-03 12:57:57.347245 | controller | which_declare=declare -f
2025-10-03 12:57:57.347251 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-03 12:57:57.347256 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-03 12:57:57.347261 | controller | ZUUL_CHANGE=3366
2025-10-03 12:57:57.347266 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-03 12:57:57.347271 | controller | ZUUL_UUID=6206bd2b107848b3bfc19e2e9fd0536c
2025-10-03 12:57:57.347277 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-03 12:57:57.347282 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-03 12:57:57.347287 | controller | }
2025-10-03 12:57:57.535493 | controller | ok: Runtime: 0:00:00.005240
2025-10-03 12:57:57.541247 | 
2025-10-03 12:57:57.541312 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-03 12:57:57.596053 | controller | skipping: Conditional result was False
2025-10-03 12:57:57.602653 | 
2025-10-03 12:57:57.602746 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-03 12:57:58.259222 | controller | skipping: Conditional result was False
2025-10-03 12:57:58.264889 | 
2025-10-03 12:57:58.264990 | TASK [Ensure legacy workspace directory]
2025-10-03 12:57:58.530977 | controller | changed
2025-10-03 12:57:58.602492 | 
2025-10-03 12:57:58.602610 | PLAY RECAP
2025-10-03 12:57:58.602659 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-03 12:57:58.603195 | 
2025-10-03 12:57:58.967736 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-03 12:57:58.968576 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-03 12:58:01.186791 | 
2025-10-03 12:58:01.186903 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-10-03 12:58:01.319802 | 
2025-10-03 12:58:01.319959 | TASK [Create zuul-output directory]
2025-10-03 12:58:02.275423 | controller | changed
2025-10-03 12:58:02.280751 | 
2025-10-03 12:58:02.280831 | TASK [Slurp Zuul inventory test]
2025-10-03 12:58:03.065452 | controller -> localhost | ok
2025-10-03 12:58:03.083396 | 
2025-10-03 12:58:03.083492 | TASK [Save zuul inventory]
2025-10-03 12:58:04.794302 | controller | changed
2025-10-03 12:58:04.801808 | 
2025-10-03 12:58:04.801898 | TASK [Save zuul vars without the change_message]
2025-10-03 12:58:05.843682 | controller | changed
2025-10-03 12:58:05.904083 | 
2025-10-03 12:58:05.904164 | PLAY RECAP
2025-10-03 12:58:05.904210 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-03 12:58:05.904234 | 
2025-10-03 12:58:06.096109 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-03 12:58:06.096883 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-03 12:58:07.107944 | 
2025-10-03 12:58:07.108071 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-10-03 12:58:07.168014 | 
2025-10-03 12:58:07.168185 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-10-03 12:58:07.200273 | controller | ok
2025-10-03 12:58:07.247674 | 
2025-10-03 12:58:07.247800 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-03 12:58:07.341258 | controller | skipping: Conditional result was False
2025-10-03 12:58:07.355089 | 
2025-10-03 12:58:07.355174 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-03 12:58:07.751086 | controller | ok
2025-10-03 12:58:07.764754 | 
2025-10-03 12:58:07.764844 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-03 12:58:08.630959 | controller | ok
2025-10-03 12:58:08.647073 | 
2025-10-03 12:58:08.647163 | TASK [Prepare workspace]
2025-10-03 12:58:08.667139 | controller | ok
2025-10-03 12:58:08.685502 | 
2025-10-03 12:58:08.685585 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-03 12:58:09.085711 | controller | ok
2025-10-03 12:58:09.108568 | 
2025-10-03 12:58:09.108864 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-03 12:58:11.924137 | controller | Output suppressed because no_log was given
2025-10-03 12:58:11.934519 | 
2025-10-03 12:58:11.934597 | LOOP [Create zuul-output directory]
2025-10-03 12:58:12.133890 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-10-03 12:58:12.291404 | controller | ok: "/home/zuul/zuul-output/logs"
2025-10-03 12:58:12.307365 | 
2025-10-03 12:58:12.307481 | TASK [Install required packages]
2025-10-03 12:59:04.202597 | controller | changed
2025-10-03 12:59:04.207856 | 
2025-10-03 12:59:04.207971 | TASK [Install venv]
2025-10-03 13:00:08.642970 | controller | changed
2025-10-03 13:00:08.671400 | 
2025-10-03 13:00:08.671483 | PLAY RECAP
2025-10-03 13:00:08.671529 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-03 13:00:08.671553 | 
2025-10-03 13:00:08.756233 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-03 13:00:08.757117 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-03 13:00:09.383835 | 
2025-10-03 13:00:09.384030 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-10-03 13:00:09.407069 | 
2025-10-03 13:00:09.407157 | TASK [Gather required facts]
2025-10-03 13:00:09.969753 | controller | ok
2025-10-03 13:00:09.981643 | 
2025-10-03 13:00:09.981732 | TASK [Load environment var if instructed to]
2025-10-03 13:00:10.027754 | controller | skipping: Conditional result was False
2025-10-03 13:00:10.033542 | 
2025-10-03 13:00:10.033656 | TASK [Check if group_vars dir exists]
2025-10-03 13:00:10.372262 | controller | ok
2025-10-03 13:00:10.382604 | 
2025-10-03 13:00:10.382773 | TASK [Create group_vars dir if does not exist]
2025-10-03 13:00:10.396543 | controller | skipping: Conditional result was False
2025-10-03 13:00:10.403059 | 
2025-10-03 13:00:10.403143 | TASK [Run molecule]
2025-10-03 13:00:11.392210 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-10-03 13:00:11.464847 | controller | WARNING  Driver podman does not provide a schema.
2025-10-03 13:00:11.467862 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-03 13:00:29.748797 | 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-03 13:00:29.749207 | 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-03 13:00:29.749698 | 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-03 13:00:29.750143 | 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-03 13:00:29.750633 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+5cbab3ac was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.0.0+5cbab3ac (/home/zuul/.ansible/collections/ansible_collections).
2025-10-03 13:00:29.751070 | 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-03 13:00:29.751529 | 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-03 13:00:29.751970 | 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-03 13:00:29.752410 | 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-03 13:00:29.752858 | 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-03 13:00:29.753278 | 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-03 13:00:29.753755 | 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-03 13:00:29.754179 | 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-03 13:00:29.754648 | 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-03 13:00:29.755087 | 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-03 13:00:29.766023 | controller | INFO     Running default > dependency
2025-10-03 13:00:29.767101 | controller | WARNING  Skipping, missing the requirements file.
2025-10-03 13:00:29.767872 | controller | WARNING  Skipping, missing the requirements file.
2025-10-03 13:00:29.776875 | controller | INFO     Running default > create
2025-10-03 13:00:30.007821 | controller | INFO     Sanity checks: 'podman'
2025-10-03 13:00:30.906576 | controller |
2025-10-03 13:00:30.906666 | controller | PLAY [Create] ******************************************************************
2025-10-03 13:00:30.906760 | controller |
2025-10-03 13:00:30.906863 | controller | TASK [Get podman executable path] **********************************************
2025-10-03 13:00:30.906962 | controller | Friday 03 October 2025  13:00:30 +0000 (0:00:00.014)       0:00:00.014 ********
2025-10-03 13:00:31.208976 | controller | ok: [localhost]
2025-10-03 13:00:31.209041 | controller |
2025-10-03 13:00:31.209144 | controller | TASK [Register podman executable path] *****************************************
2025-10-03 13:00:31.209245 | controller | Friday 03 October 2025  13:00:31 +0000 (0:00:00.302)       0:00:00.317 ********
2025-10-03 13:00:31.250363 | controller | ok: [localhost]
2025-10-03 13:00:31.250486 | controller |
2025-10-03 13:00:31.250610 | controller | TASK [Get passwd entries for USER env] *****************************************
2025-10-03 13:00:31.250718 | controller | Friday 03 October 2025  13:00:31 +0000 (0:00:00.041)       0:00:00.358 ********
2025-10-03 13:00:31.540868 | controller | ok: [localhost]
2025-10-03 13:00:31.540941 | controller |
2025-10-03 13:00:31.541047 | controller | TASK [Get shell async_dir] *****************************************************
2025-10-03 13:00:31.541155 | controller | Friday 03 October 2025  13:00:31 +0000 (0:00:00.290)       0:00:00.649 ********
2025-10-03 13:00:31.584517 | controller | ok: [localhost]
2025-10-03 13:00:31.584599 | controller |
2025-10-03 13:00:31.584726 | controller | TASK [Set async_dir for HOME env] **********************************************
2025-10-03 13:00:31.584855 | controller | Friday 03 October 2025  13:00:31 +0000 (0:00:00.043)       0:00:00.692 ********
2025-10-03 13:00:31.620388 | controller | skipping: [localhost]
2025-10-03 13:00:31.620509 | controller |
2025-10-03 13:00:31.620637 | controller | TASK [Log into a container registry] *******************************************
2025-10-03 13:00:31.620764 | controller | Friday 03 October 2025  13:00:31 +0000 (0:00:00.035)       0:00:00.728 ********
2025-10-03 13:00:31.667530 | controller | skipping: [localhost] => (item="instance registry username: None specified")
2025-10-03 13:00:31.667618 | controller | skipping: [localhost]
2025-10-03 13:00:31.667735 | controller |
2025-10-03 13:00:31.667863 | controller | TASK [Check presence of custom Dockerfiles] ************************************
2025-10-03 13:00:31.667988 | controller | Friday 03 October 2025  13:00:31 +0000 (0:00:00.047)       0:00:00.775 ********
2025-10-03 13:00:31.964604 | controller | ok: [localhost] => (item=Dockerfile: None specified)
2025-10-03 13:00:31.964672 | controller |
2025-10-03 13:00:31.964788 | controller | TASK [Create Dockerfiles from image names] *************************************
2025-10-03 13:00:31.964915 | controller | Friday 03 October 2025  13:00:31 +0000 (0:00:00.296)       0:00:01.072 ********
2025-10-03 13:00:32.007625 | controller | skipping: [localhost] => (item="Dockerfile: None specified; Image: registry.access.redhat.com/ubi9/ubi:latest")
2025-10-03 13:00:32.007756 | controller | skipping: [localhost]
2025-10-03 13:00:32.007869 | controller |
2025-10-03 13:00:32.007977 | controller | TASK [Discover local Podman images] ********************************************
2025-10-03 13:00:32.008083 | controller | Friday 03 October 2025  13:00:32 +0000 (0:00:00.043)       0:00:01.115 ********
2025-10-03 13:00:32.883703 | controller | ok: [localhost] => (item=instance)
2025-10-03 13:00:32.883763 | controller |
2025-10-03 13:00:32.883887 | controller | TASK [Build an Ansible compatible image] ***************************************
2025-10-03 13:00:32.883995 | controller | Friday 03 October 2025  13:00:32 +0000 (0:00:00.876)       0:00:01.991 ********
2025-10-03 13:00:32.924943 | controller | skipping: [localhost] => (item=registry.access.redhat.com/ubi9/ubi:latest)
2025-10-03 13:00:32.925064 | controller | skipping: [localhost]
2025-10-03 13:00:32.925179 | controller |
2025-10-03 13:00:32.925306 | controller | TASK [Determine the CMD directives] ********************************************
2025-10-03 13:00:32.925492 | controller | Friday 03 October 2025  13:00:32 +0000 (0:00:00.041)       0:00:02.033 ********
2025-10-03 13:00:32.976114 | controller | ok: [localhost] => (item="instance command: sleep infinity")
2025-10-03 13:00:32.976178 | controller |
2025-10-03 13:00:32.976287 | controller | TASK [Remove possible pre-existing containers] *********************************
2025-10-03 13:00:32.976431 | controller | Friday 03 October 2025  13:00:32 +0000 (0:00:00.051)       0:00:02.084 ********
2025-10-03 13:00:33.226789 | controller | changed: [localhost]
2025-10-03 13:00:33.226889 | controller |
2025-10-03 13:00:33.227004 | controller | TASK [Discover local podman networks] ******************************************
2025-10-03 13:00:33.227112 | controller | Friday 03 October 2025  13:00:33 +0000 (0:00:00.250)       0:00:02.334 ********
2025-10-03 13:00:33.272472 | controller | skipping: [localhost] => (item=instance: None specified)
2025-10-03 13:00:33.272614 | controller | skipping: [localhost]
2025-10-03 13:00:33.272740 | controller |
2025-10-03 13:00:33.272884 | controller | TASK [Create podman network dedicated to this scenario] ************************
2025-10-03 13:00:33.273014 | controller | Friday 03 October 2025  13:00:33 +0000 (0:00:00.045)       0:00:02.380 ********
2025-10-03 13:00:33.309227 | controller | skipping: [localhost]
2025-10-03 13:00:33.309306 | controller |
2025-10-03 13:00:33.309438 | controller | TASK [Create molecule instance(s)] *********************************************
2025-10-03 13:00:33.309554 | controller | Friday 03 October 2025  13:00:33 +0000 (0:00:00.036)       0:00:02.417 ********
2025-10-03 13:00:33.646728 | controller | changed: [localhost] => (item=instance)
2025-10-03 13:00:33.646801 | controller |
2025-10-03 13:00:33.646910 | controller | TASK [Wait for instance(s) creation to complete] *******************************
2025-10-03 13:00:33.647018 | controller | Friday 03 October 2025  13:00:33 +0000 (0:00:00.335)       0:00:02.753 ********
2025-10-03 13:00:39.125872 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) creation to complete (300 retries left).
2025-10-03 13:00:39.125922 | controller | changed: [localhost] => (item=instance)
2025-10-03 13:00:39.126429 | controller |
2025-10-03 13:00:39.126484 | controller | PLAY RECAP *********************************************************************
2025-10-03 13:00:39.126495 | controller | localhost                  : ok=10   changed=3    unreachable=0    failed=0    skipped=6    rescued=0    ignored=0
2025-10-03 13:00:39.126503 | controller |
2025-10-03 13:00:39.126526 | controller | Friday 03 October 2025  13:00:39 +0000 (0:00:05.480)       0:00:08.234 ********
2025-10-03 13:00:39.126551 | controller | ===============================================================================
2025-10-03 13:00:39.128250 | controller | Wait for instance(s) creation to complete ------------------------------- 5.48s
2025-10-03 13:00:39.203111 | controller | Discover local Podman images -------------------------------------------- 0.88s
2025-10-03 13:00:39.203153 | controller | Create molecule instance(s) --------------------------------------------- 0.34s
2025-10-03 13:00:39.203161 | controller | Get podman executable path ---------------------------------------------- 0.30s
2025-10-03 13:00:39.203167 | controller | Check presence of custom Dockerfiles ------------------------------------ 0.30s
2025-10-03 13:00:39.203172 | controller | Get passwd entries for USER env ----------------------------------------- 0.29s
2025-10-03 13:00:39.203181 | controller | Remove possible pre-existing containers --------------------------------- 0.25s
2025-10-03 13:00:39.203187 | controller | Determine the CMD directives -------------------------------------------- 0.05s
2025-10-03 13:00:39.203192 | controller | Log into a container registry ------------------------------------------- 0.05s
2025-10-03 13:00:39.203198 | controller | Discover local podman networks ------------------------------------------ 0.05s
2025-10-03 13:00:39.203203 | controller | Get shell async_dir ----------------------------------------------------- 0.04s
2025-10-03 13:00:39.203208 | controller | Create Dockerfiles from image names ------------------------------------- 0.04s
2025-10-03 13:00:39.203213 | controller | Register podman executable path ----------------------------------------- 0.04s
2025-10-03 13:00:39.203225 | controller | Build an Ansible compatible image --------------------------------------- 0.04s
2025-10-03 13:00:39.203230 | controller | Create podman network dedicated to this scenario ------------------------ 0.04s
2025-10-03 13:00:39.203236 | controller | Set async_dir for HOME env ---------------------------------------------- 0.04s
2025-10-03 13:00:39.203249 | controller | INFO     Running default > prepare
2025-10-03 13:00:39.617020 | controller |
2025-10-03 13:00:39.617113 | controller | PLAY [Prepare] *****************************************************************
2025-10-03 13:00:39.617209 | controller |
2025-10-03 13:00:39.617310 | controller | TASK [Gathering Facts] *********************************************************
2025-10-03 13:00:39.617447 | controller | Friday 03 October 2025  13:00:39 +0000 (0:00:00.010)       0:00:00.010 ********
2025-10-03 13:00:40.793804 | controller | ok: [instance]
2025-10-03 13:00:40.793863 | controller |
2025-10-03 13:00:40.794117 | controller | TASK [Install Python pip and dependencies using dnf] ***************************
2025-10-03 13:00:47.025448 | controller | Friday 03 October 2025  13:00:40 +0000 (0:00:01.177)       0:00:01.187 ********
2025-10-03 13:00:47.025484 | controller | changed: [instance]
2025-10-03 13:00:52.193200 | controller |
2025-10-03 13:00:52.193232 | controller | TASK [Install Python dependencies] *********************************************
2025-10-03 13:00:52.193241 | controller | Friday 03 October 2025  13:00:47 +0000 (0:00:06.231)       0:00:07.419 ********
2025-10-03 13:00:52.193251 | controller | changed: [instance]
2025-10-03 13:00:53.673951 | controller |
2025-10-03 13:00:53.673981 | controller | TASK [Create mock kubeconfig file] *********************************************
2025-10-03 13:00:53.673989 | controller | Friday 03 October 2025  13:00:52 +0000 (0:00:05.167)       0:00:12.586 ********
2025-10-03 13:00:53.673999 | controller | changed: [instance]
2025-10-03 13:00:54.966409 | controller |
2025-10-03 13:00:54.966438 | controller | TASK [Create mock kubeadmin password file] *************************************
2025-10-03 13:00:54.966447 | controller | Friday 03 October 2025  13:00:53 +0000 (0:00:01.480)       0:00:14.067 ********
2025-10-03 13:00:54.966457 | controller | changed: [instance]
2025-10-03 13:00:54.966480 | controller |
2025-10-03 13:00:54.966487 | controller | PLAY RECAP *********************************************************************
2025-10-03 13:00:54.966493 | controller | instance                   : ok=5    changed=4    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2025-10-03 13:00:54.966498 | controller |
2025-10-03 13:00:54.966504 | controller | Friday 03 October 2025  13:00:54 +0000 (0:00:01.292)       0:00:15.360 ********
2025-10-03 13:00:54.966511 | controller | ===============================================================================
2025-10-03 13:00:54.966558 | controller | Install Python pip and dependencies using dnf --------------------------- 6.23s
2025-10-03 13:00:54.966666 | controller | Install Python dependencies --------------------------------------------- 5.17s
2025-10-03 13:00:54.966766 | controller | Create mock kubeconfig file --------------------------------------------- 1.48s
2025-10-03 13:00:54.966871 | controller | Create mock kubeadmin password file ------------------------------------- 1.29s
2025-10-03 13:00:54.966965 | controller | Gathering Facts --------------------------------------------------------- 1.18s
2025-10-03 13:00:55.020135 | controller | INFO     Running default > converge
2025-10-03 13:00:55.464784 | controller |
2025-10-03 13:00:55.464913 | controller | PLAY [Converge] ****************************************************************
2025-10-03 13:00:55.465033 | controller |
2025-10-03 13:00:55.465143 | controller | TASK [Test that required variables are defined] ********************************
2025-10-03 13:00:55.465266 | controller | Friday 03 October 2025  13:00:55 +0000 (0:00:00.022)       0:00:00.022 ********
2025-10-03 13:00:55.489046 | controller | ok: [instance] => changed=false
2025-10-03 13:00:55.507958 | controller |   msg: Required variables are defined
2025-10-03 13:00:55.507977 | controller |
2025-10-03 13:00:55.507985 | controller | TASK [Display test information] ************************************************
2025-10-03 13:00:55.507991 | controller | Friday 03 October 2025  13:00:55 +0000 (0:00:00.024)       0:00:00.046 ********
2025-10-03 13:00:55.508001 | controller | ok: [instance] =>
2025-10-03 13:00:56.639404 | controller |   msg: 'Testing role cifmw_snr_nhc with kubeconfig: /tmp/kubeconfig and namespace: workload-availability'
2025-10-03 13:00:56.639446 | controller |
2025-10-03 13:00:56.639454 | controller | TASK [Test that Python kubernetes library is available] ************************
2025-10-03 13:00:56.639460 | controller | Friday 03 October 2025  13:00:55 +0000 (0:00:00.018)       0:00:00.065 ********
2025-10-03 13:00:56.639470 | controller | ok: [instance]
2025-10-03 13:00:56.662434 | controller |
2025-10-03 13:00:56.662460 | controller | TASK [Display kubernetes library test result] **********************************
2025-10-03 13:00:56.662468 | controller | Friday 03 October 2025  13:00:56 +0000 (0:00:01.130)       0:00:01.196 ********
2025-10-03 13:00:56.662478 | controller | ok: [instance] =>
2025-10-03 13:00:56.662756 | controller |   msg: Library available
2025-10-03 13:00:56.662776 | controller |
2025-10-03 13:00:57.522167 | controller | TASK [Test that mock kubeconfig exists] ****************************************
2025-10-03 13:00:57.522197 | controller | Friday 03 October 2025  13:00:56 +0000 (0:00:00.023)       0:00:01.220 ********
2025-10-03 13:00:57.522209 | controller | ok: [instance]
2025-10-03 13:00:57.548030 | controller |
2025-10-03 13:00:57.548059 | controller | TASK [Assert kubeconfig exists] ************************************************
2025-10-03 13:00:57.548068 | controller | Friday 03 October 2025  13:00:57 +0000 (0:00:00.859)       0:00:02.079 ********
2025-10-03 13:00:57.548077 | controller | ok: [instance] => changed=false
2025-10-03 13:00:59.137166 | controller |   msg: Kubeconfig file exists
2025-10-03 13:00:59.137198 | controller |
2025-10-03 13:00:59.137210 | controller | TASK [Test kubernetes.core.k8s module availability] ****************************
2025-10-03 13:00:59.137216 | controller | Friday 03 October 2025  13:00:57 +0000 (0:00:00.025)       0:00:02.105 ********
2025-10-03 13:00:59.137226 | controller | ok: [instance]
2025-10-03 13:00:59.157074 | controller |
2025-10-03 13:00:59.157094 | controller | TASK [Display k8s connection test result] **************************************
2025-10-03 13:00:59.157103 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:01.589)       0:00:03.694 ********
2025-10-03 13:00:59.157113 | controller | ok: [instance] =>
2025-10-03 13:00:59.222163 | controller |   msg: 'K8s connection test result: False'
2025-10-03 13:00:59.222182 | controller |
2025-10-03 13:00:59.222189 | controller | TASK [Include the cifmw_snr_nhc role] ******************************************
2025-10-03 13:00:59.222195 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.019)       0:00:03.714 ********
2025-10-03 13:00:59.222203 | controller |
2025-10-03 13:00:59.248756 | controller | TASK [cifmw_snr_nhc : Check if NodeHealthCheck exists and is active] ***********
2025-10-03 13:00:59.248774 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.065)       0:00:03.780 ********
2025-10-03 13:00:59.248784 | controller | skipping: [instance]
2025-10-03 13:00:59.273448 | controller |
2025-10-03 13:00:59.273471 | controller | TASK [cifmw_snr_nhc : Check for active SelfNodeRemediations] *******************
2025-10-03 13:00:59.273480 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.026)       0:00:03.806 ********
2025-10-03 13:00:59.273491 | controller | skipping: [instance]
2025-10-03 13:00:59.297791 | controller |
2025-10-03 13:00:59.297810 | controller | TASK [cifmw_snr_nhc : Display active remediations info] ************************
2025-10-03 13:00:59.297818 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.024)       0:00:03.831 ********
2025-10-03 13:00:59.297826 | controller | skipping: [instance]
2025-10-03 13:00:59.297970 | controller |
2025-10-03 13:00:59.298114 | controller | TASK [cifmw_snr_nhc : Disable NodeHealthCheck to stop active remediations] *****
2025-10-03 13:00:59.298253 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.024)       0:00:03.855 ********
2025-10-03 13:00:59.322978 | controller | skipping: [instance]
2025-10-03 13:00:59.323129 | controller |
2025-10-03 13:00:59.323277 | controller | TASK [cifmw_snr_nhc : Wait for active remediations to stop] ********************
2025-10-03 13:00:59.323459 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.025)       0:00:03.881 ********
2025-10-03 13:00:59.347668 | controller | skipping: [instance]
2025-10-03 13:00:59.347863 | controller |
2025-10-03 13:00:59.348221 | controller | TASK [cifmw_snr_nhc : Delete existing NodeHealthCheck resources] ***************
2025-10-03 13:00:59.348401 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.024)       0:00:03.905 ********
2025-10-03 13:00:59.372472 | controller | skipping: [instance]
2025-10-03 13:00:59.372623 | controller |
2025-10-03 13:00:59.372783 | controller | TASK [cifmw_snr_nhc : Check for blocking remediations when deletion fails] *****
2025-10-03 13:00:59.372934 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.024)       0:00:03.930 ********
2025-10-03 13:00:59.397583 | controller | skipping: [instance]
2025-10-03 13:00:59.397804 | controller |
2025-10-03 13:00:59.397968 | controller | TASK [cifmw_snr_nhc : Display blocking remediation details] ********************
2025-10-03 13:00:59.398107 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.025)       0:00:03.955 ********
2025-10-03 13:00:59.424577 | controller | skipping: [instance]
2025-10-03 13:00:59.424783 | controller |
2025-10-03 13:00:59.424970 | controller | TASK [cifmw_snr_nhc : Display warning if NodeHealthCheck deletion failed due to active remediation] ***
2025-10-03 13:00:59.425110 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.026)       0:00:03.982 ********
2025-10-03 13:00:59.449529 | controller | skipping: [instance]
2025-10-03 13:00:59.449734 | controller |
2025-10-03 13:00:59.449917 | controller | TASK [cifmw_snr_nhc : Skip NodeHealthCheck deletion retry if webhook blocks it] ***
2025-10-03 13:00:59.450074 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.024)       0:00:04.007 ********
2025-10-03 13:00:59.474374 | controller | skipping: [instance]
2025-10-03 13:00:59.474566 | controller |
2025-10-03 13:00:59.474770 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationConfig exists] ***************
2025-10-03 13:00:59.474957 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.024)       0:00:04.032 ********
2025-10-03 13:00:59.499192 | controller | skipping: [instance]
2025-10-03 13:00:59.499422 | controller |
2025-10-03 13:00:59.499611 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationConfig resources] *****
2025-10-03 13:00:59.499806 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.024)       0:00:04.057 ********
2025-10-03 13:00:59.523831 | controller | skipping: [instance]
2025-10-03 13:00:59.524017 | controller |
2025-10-03 13:00:59.524185 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationTemplate exists] *************
2025-10-03 13:00:59.524352 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.024)       0:00:04.081 ********
2025-10-03 13:00:59.549045 | controller | skipping: [instance]
2025-10-03 13:00:59.549218 | controller |
2025-10-03 13:00:59.549388 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationTemplate resources] ***
2025-10-03 13:00:59.549531 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.025)       0:00:04.107 ********
2025-10-03 13:00:59.574888 | controller | skipping: [instance]
2025-10-03 13:00:59.575058 | controller |
2025-10-03 13:00:59.575230 | controller | TASK [cifmw_snr_nhc : Check if Subscriptions exist] ****************************
2025-10-03 13:00:59.575399 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.025)       0:00:04.133 ********
2025-10-03 13:00:59.602718 | controller | skipping: [instance]
2025-10-03 13:00:59.602870 | controller |
2025-10-03 13:00:59.603010 | controller | TASK [cifmw_snr_nhc : Delete existing Subscriptions] ***************************
2025-10-03 13:00:59.603146 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.027)       0:00:04.160 ********
2025-10-03 13:00:59.632715 | controller | skipping: [instance] => (item=self-node-remediation-operator)
2025-10-03 13:00:59.632890 | controller | skipping: [instance] => (item=node-health-check-operator)
2025-10-03 13:00:59.633030 | controller | skipping: [instance]
2025-10-03 13:00:59.633161 | controller |
2025-10-03 13:00:59.633296 | controller | TASK [cifmw_snr_nhc : Check if OperatorGroup exists] ***************************
2025-10-03 13:00:59.633454 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.030)       0:00:04.190 ********
2025-10-03 13:00:59.658553 | controller | skipping: [instance]
2025-10-03 13:00:59.683450 | controller |
2025-10-03 13:00:59.683486 | controller | TASK [cifmw_snr_nhc : Delete existing OperatorGroup] ***************************
2025-10-03 13:00:59.683496 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.025)       0:00:04.216 ********
2025-10-03 13:00:59.683508 | controller | skipping: [instance]
2025-10-03 13:00:59.683545 | controller |
2025-10-03 13:00:59.683567 | controller | TASK [cifmw_snr_nhc : Delete the entire workload-availability namespace] *******
2025-10-03 13:00:59.683693 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.025)       0:00:04.241 ********
2025-10-03 13:00:59.710083 | controller | skipping: [instance]
2025-10-03 13:00:59.735819 | controller |
2025-10-03 13:00:59.735842 | controller | TASK [cifmw_snr_nhc : Wait for namespace deletion to complete] *****************
2025-10-03 13:00:59.735858 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.026)       0:00:04.267 ********
2025-10-03 13:00:59.735867 | controller | skipping: [instance]
2025-10-03 13:01:01.057430 | controller |
2025-10-03 13:01:01.057462 | controller | TASK [cifmw_snr_nhc : Create the workload-availability namespace] **************
2025-10-03 13:01:01.057470 | controller | Friday 03 October 2025  13:00:59 +0000 (0:00:00.025)       0:00:04.293 ********
2025-10-03 13:01:01.057481 | 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 0x7fc5631e1d00>: Failed to establish a new connection: [Errno -2] Name or service not known'))
2025-10-03 13:01:01.057505 | controller | fatal: [instance]: FAILED! => changed=false
2025-10-03 13:01:01.057512 | controller |   module_stderr: |-
2025-10-03 13:01:01.057517 | controller |     Traceback (most recent call last):
2025-10-03 13:01:01.057523 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn
2025-10-03 13:01:01.057528 | controller |         conn = connection.create_connection(
2025-10-03 13:01:01.057534 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection
2025-10-03 13:01:01.057539 | controller |         for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):
2025-10-03 13:01:01.057544 | controller |       File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo
2025-10-03 13:01:01.057551 | controller |         for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
2025-10-03 13:01:01.058356 | controller |     socket.gaierror: [Errno -2] Name or service not known
2025-10-03 13:01:01.059398 | controller |
2025-10-03 13:01:01.059430 | controller |     During handling of the above exception, another exception occurred:
2025-10-03 13:01:01.059439 | controller |
2025-10-03 13:01:01.059445 | controller |     Traceback (most recent call last):
2025-10-03 13:01:01.059451 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen
2025-10-03 13:01:01.059457 | controller |         httplib_response = self._make_request(
2025-10-03 13:01:01.059462 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request
2025-10-03 13:01:01.059468 | controller |         self._validate_conn(conn)
2025-10-03 13:01:01.059483 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn
2025-10-03 13:01:01.059600 | controller |         conn.connect()
2025-10-03 13:01:01.059609 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect
2025-10-03 13:01:01.059615 | controller |         conn = self._new_conn()
2025-10-03 13:01:01.059620 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn
2025-10-03 13:01:01.059626 | controller |         raise NewConnectionError(
2025-10-03 13:01:01.059631 | controller |     urllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fc5631e1d00>: Failed to establish a new connection: [Errno -2] Name or service not known
2025-10-03 13:01:01.059637 | controller |
2025-10-03 13:01:01.059643 | controller |     During handling of the above exception, another exception occurred:
2025-10-03 13:01:01.059648 | controller |
2025-10-03 13:01:01.059653 | controller |     Traceback (most recent call last):
2025-10-03 13:01:01.059661 | controller |       File "/tmp/ansible-tmp-1759496459.7492268-28216-74097250321425/AnsiballZ_k8s.py", line 107, in <module>
2025-10-03 13:01:01.059737 | controller |         _ansiballz_main()
2025-10-03 13:01:01.059864 | controller |       File "/tmp/ansible-tmp-1759496459.7492268-28216-74097250321425/AnsiballZ_k8s.py", line 99, in _ansiballz_main
2025-10-03 13:01:01.059980 | controller |         invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)
2025-10-03 13:01:01.060105 | controller |       File "/tmp/ansible-tmp-1759496459.7492268-28216-74097250321425/AnsiballZ_k8s.py", line 47, in invoke_module
2025-10-03 13:01:01.060222 | 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-03 13:01:01.060373 | controller |       File "/usr/lib64/python3.9/runpy.py", line 225, in run_module
2025-10-03 13:01:01.060504 | controller |         return _run_module_code(code, init_globals, run_name, mod_spec)
2025-10-03 13:01:01.060619 | controller |       File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code
2025-10-03 13:01:01.060747 | controller |         _run_code(code, mod_globals, init_globals,
2025-10-03 13:01:01.060863 | controller |       File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code
2025-10-03 13:01:01.060976 | controller |         exec(code, run_globals)
2025-10-03 13:01:01.061097 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_g6s_sozt/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>
2025-10-03 13:01:01.061215 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_g6s_sozt/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main
2025-10-03 13:01:01.061360 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_g6s_sozt/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module
2025-10-03 13:01:01.061499 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_g6s_sozt/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client
2025-10-03 13:01:01.061618 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_g6s_sozt/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper
2025-10-03 13:01:01.061761 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_g6s_sozt/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client
2025-10-03 13:01:01.061881 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__
2025-10-03 13:01:01.061998 | controller |         self.__discoverer = discoverer(self, cache_file)
2025-10-03 13:01:01.062122 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_g6s_sozt/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__
2025-10-03 13:01:01.062238 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_g6s_sozt/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__
2025-10-03 13:01:01.062373 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_g6s_sozt/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache
2025-10-03 13:01:01.062497 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info
2025-10-03 13:01:01.062613 | controller |         'kubernetes': self.client.request('get', '/version', serializer=just_json)
2025-10-03 13:01:01.062751 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner
2025-10-03 13:01:01.062866 | controller |         resp = func(self, *args, **kwargs)
2025-10-03 13:01:01.062982 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request
2025-10-03 13:01:01.063091 | controller |         api_response = self.client.call_api(
2025-10-03 13:01:01.063207 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api
2025-10-03 13:01:01.063338 | controller |         return self.__call_api(resource_path, method,
2025-10-03 13:01:01.063466 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api
2025-10-03 13:01:01.063582 | controller |         response_data = self.request(
2025-10-03 13:01:01.063711 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request
2025-10-03 13:01:01.063827 | controller |         return self.rest_client.GET(url,
2025-10-03 13:01:01.063946 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET
2025-10-03 13:01:01.064056 | controller |         return self.request("GET", url,
2025-10-03 13:01:01.064170 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request
2025-10-03 13:01:01.064282 | controller |         r = self.pool_manager.request(method, url,
2025-10-03 13:01:01.064433 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request
2025-10-03 13:01:01.064557 | controller |         return self.request_encode_url(
2025-10-03 13:01:01.064676 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url
2025-10-03 13:01:01.064802 | controller |         return self.urlopen(method, url, **extra_kw)
2025-10-03 13:01:01.064917 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen
2025-10-03 13:01:01.065030 | controller |         response = conn.urlopen(method, u.request_uri, **kw)
2025-10-03 13:01:01.065143 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen
2025-10-03 13:01:01.065255 | controller |         return self.urlopen(
2025-10-03 13:01:01.065393 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen
2025-10-03 13:01:01.065512 | controller |         return self.urlopen(
2025-10-03 13:01:01.065635 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen
2025-10-03 13:01:01.065765 | controller |         return self.urlopen(
2025-10-03 13:01:01.065880 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen
2025-10-03 13:01:01.065992 | controller |         retries = retries.increment(
2025-10-03 13:01:01.066107 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment
2025-10-03 13:01:01.066218 | controller |         raise MaxRetryError(_pool, url, error or ResponseError(cause))
2025-10-03 13:01:01.066368 | 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 0x7fc5631e1d00>: Failed to establish a new connection: [Errno -2] Name or service not known'))
2025-10-03 13:01:01.066495 | controller |   module_stdout: ''
2025-10-03 13:01:01.066607 | controller |   msg: |-
2025-10-03 13:01:01.066742 | controller |     MODULE FAILURE
2025-10-03 13:01:01.066856 | controller |     See stdout/stderr for the exact error
2025-10-03 13:01:01.066967 | controller |   rc: 1
2025-10-03 13:01:01.067129 | controller |
2025-10-03 13:01:01.067247 | controller | TASK [Capture role execution error] ********************************************
2025-10-03 13:01:01.067393 | controller | Friday 03 October 2025  13:01:01 +0000 (0:00:01.327)       0:00:05.620 ********
2025-10-03 13:01:01.086108 | controller | ok: [instance]
2025-10-03 13:01:01.086253 | controller |
2025-10-03 13:01:01.086428 | controller | TASK [Display role execution error details] ************************************
2025-10-03 13:01:01.086572 | controller | Friday 03 October 2025  13:01:01 +0000 (0:00:00.023)       0:00:05.644 ********
2025-10-03 13:01:01.107630 | controller | ok: [instance] =>
2025-10-03 13:01:01.107807 | controller |   msg: |-
2025-10-03 13:01:01.107927 | controller |     Role execution failed with error:
2025-10-03 13:01:01.108100 | 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': 'fa163e4b-89eb-6fa8-4e04-000000000166', 'finalized': True, 'squashed': False}, 'poll': 15, 'register': 'namespace_result', 'retries': 3, 'until': [], 'loop_with': None, 'uuid': 'fa163e4b-89eb-6fa8-4e04-00000000008f', 'finalized': True, 'squashed': True}
2025-10-03 13:01:01.108211 | controller |
2025-10-03 13:01:01.108328 | controller | TASK [Analyze specific error patterns] *****************************************
2025-10-03 13:01:01.108472 | controller | Friday 03 October 2025  13:01:01 +0000 (0:00:00.021)       0:00:05.665 ********
2025-10-03 13:01:01.142308 | controller | ok: [instance] =>
2025-10-03 13:01:01.142456 | controller |   msg: |-
2025-10-03 13:01:01.142584 | controller |     Error analysis:
2025-10-03 13:01:01.142715 | controller |     - Connection error: False
2025-10-03 13:01:01.142849 | controller |     - Authentication error: False
2025-10-03 13:01:01.142954 | controller |     - API error: False
2025-10-03 13:01:01.143065 | controller |     - Timeout error: False
2025-10-03 13:01:01.143172 | controller |
2025-10-03 13:01:01.143292 | controller | TASK [Continue with test evaluation] *******************************************
2025-10-03 13:01:01.143421 | controller | Friday 03 October 2025  13:01:01 +0000 (0:00:00.034)       0:00:05.700 ********
2025-10-03 13:01:01.161705 | controller | ok: [instance] =>
2025-10-03 13:01:01.161867 | controller |   msg: Role failed as expected in test environment - this is normal
2025-10-03 13:01:01.162010 | controller |
2025-10-03 13:01:01.162156 | controller | TASK [Verify namespace exists] *************************************************
2025-10-03 13:01:01.162298 | controller | Friday 03 October 2025  13:01:01 +0000 (0:00:00.019)       0:00:05.719 ********
2025-10-03 13:01:02.511131 | controller | ok: [instance]
2025-10-03 13:01:02.527277 | controller |
2025-10-03 13:01:02.527308 | controller | TASK [Display namespace verification result] ***********************************
2025-10-03 13:01:02.527339 | controller | Friday 03 October 2025  13:01:02 +0000 (0:00:01.349)       0:00:07.068 ********
2025-10-03 13:01:02.527351 | controller | ok: [instance] =>
2025-10-03 13:01:02.527358 | 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-03 13:01:02.527365 | 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 0x7f528fe35b50>: 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-1759496461.1741142-28394-252877809815630/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496461.1741142-28394-252877809815630/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496461.1741142-28394-252877809815630/AnsiballZ_k8s.py",
2025-10-03 13:01:02.527380 | 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_iqxadihd/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_iqxadihd/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_iqxadihd/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-03 13:01:02.527392 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_iqxadihd/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_iqxadihd/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_iqxadihd/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_iqxadihd/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_iqxadihd/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:02.527419 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_iqxadihd/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-03 13:01:02.527427 | 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-03 13:01:02.527438 | 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 0x7f528fe35b50>: 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-03 13:01:02.527447 | 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-03 13:01:02.528185 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f528fe35b50>: 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-1759496461.1741142-28394-252877809815630/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496461.1741142-28394-252877809815630/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496461.1741142-28394-252877809815630/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-03 13:01:02.528205 | 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_iqxadihd/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_iqxadihd/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_iqxadihd/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_iqxadihd/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-03 13:01:02.528216 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_iqxadihd/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_iqxadihd/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_iqxadihd/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_iqxadihd/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_iqxadihd/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:02.528226 | 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-03 13:01:02.532352 | 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-03 13:01:02.532372 | 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 0x7f528fe35b50>: 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-03 13:01:02.532390 | controller |
2025-10-03 13:01:02.532573 | controller | TASK [Test namespace creation idempotency] *************************************
2025-10-03 13:01:02.532760 | controller | Friday 03 October 2025  13:01:02 +0000 (0:00:00.021)       0:00:07.090 ********
2025-10-03 13:01:03.791579 | controller | ok: [instance]
2025-10-03 13:01:03.812402 | controller |
2025-10-03 13:01:03.812434 | controller | TASK [Assert expected behavior for namespace creation] *************************
2025-10-03 13:01:03.812445 | controller | Friday 03 October 2025  13:01:03 +0000 (0:00:01.258)       0:00:08.349 ********
2025-10-03 13:01:03.812456 | controller | ok: [instance] => changed=false
2025-10-03 13:01:03.812483 | controller |   msg: Namespace creation task behaves consistently
2025-10-03 13:01:03.812491 | controller |
2025-10-03 13:01:03.812500 | controller | TASK [Verify OperatorGroup exists] *********************************************
2025-10-03 13:01:03.812552 | controller | Friday 03 October 2025  13:01:03 +0000 (0:00:00.021)       0:00:08.370 ********
2025-10-03 13:01:05.111295 | controller | ok: [instance]
2025-10-03 13:01:05.125754 | controller |
2025-10-03 13:01:05.125780 | controller | TASK [Display OperatorGroup verification result] *******************************
2025-10-03 13:01:05.125788 | controller | Friday 03 October 2025  13:01:05 +0000 (0:00:01.298)       0:00:09.668 ********
2025-10-03 13:01:05.125798 | controller | ok: [instance] =>
2025-10-03 13:01:05.125824 | 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-03 13:01:05.127397 | 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 0x7fbbafbeba90>: 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-1759496463.825537-28752-110310434590632/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496463.825537-28752-110310434590632/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496463.825537-28752-110310434590632/AnsiballZ_k8s.py",
2025-10-03 13:01:05.127421 | 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_osjclthl/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_osjclthl/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_osjclthl/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-03 13:01:05.127433 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_osjclthl/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_osjclthl/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_osjclthl/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_osjclthl/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_osjclthl/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:05.127443 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_osjclthl/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-03 13:01:05.127451 | 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-03 13:01:05.127460 | 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 0x7fbbafbeba90>: 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-03 13:01:05.127465 | 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-03 13:01:05.127476 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fbbafbeba90>: 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-1759496463.825537-28752-110310434590632/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496463.825537-28752-110310434590632/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496463.825537-28752-110310434590632/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-03 13:01:05.127482 | 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_osjclthl/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_osjclthl/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_osjclthl/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_osjclthl/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-03 13:01:05.127492 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_osjclthl/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_osjclthl/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_osjclthl/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_osjclthl/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_osjclthl/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:05.127499 | 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-03 13:01:05.127507 | 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-03 13:01:05.131382 | 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 0x7fbbafbeba90>: 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-03 13:01:05.131413 | controller |
2025-10-03 13:01:05.131476 | controller | TASK [Test OperatorGroup creation idempotency] *********************************
2025-10-03 13:01:05.131621 | controller | Friday 03 October 2025  13:01:05 +0000 (0:00:00.020)       0:00:09.689 ********
2025-10-03 13:01:06.147131 | controller | ok: [instance]
2025-10-03 13:01:06.170624 | controller |
2025-10-03 13:01:06.170653 | controller | TASK [Assert expected behavior for OperatorGroup creation] *********************
2025-10-03 13:01:06.170661 | controller | Friday 03 October 2025  13:01:06 +0000 (0:00:01.015)       0:00:10.704 ********
2025-10-03 13:01:06.170671 | controller | ok: [instance] => changed=false
2025-10-03 13:01:07.361391 | controller |   msg: OperatorGroup creation task behaves consistently
2025-10-03 13:01:07.361422 | controller |
2025-10-03 13:01:07.361430 | controller | TASK [Verify SNR Subscription exists] ******************************************
2025-10-03 13:01:07.361436 | controller | Friday 03 October 2025  13:01:06 +0000 (0:00:00.023)       0:00:10.728 ********
2025-10-03 13:01:07.361446 | controller | ok: [instance]
2025-10-03 13:01:07.361778 | controller |
2025-10-03 13:01:07.379403 | controller | TASK [Display SNR Subscription verification result] ****************************
2025-10-03 13:01:07.379432 | controller | Friday 03 October 2025  13:01:07 +0000 (0:00:01.191)       0:00:11.919 ********
2025-10-03 13:01:07.379444 | controller | ok: [instance] =>
2025-10-03 13:01:07.379451 | 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-03 13:01:07.379458 | 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 0x7f8d9ced2e80>: 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-1759496466.185124-29090-50489909522694/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496466.185124-29090-50489909522694/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496466.185124-29090-50489909522694/AnsiballZ_k8s.py",
2025-10-03 13:01:07.379464 | 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_8gc40zyj/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_8gc40zyj/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_8gc40zyj/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-03 13:01:07.379485 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_8gc40zyj/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_8gc40zyj/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_8gc40zyj/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_8gc40zyj/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_8gc40zyj/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:07.379494 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_8gc40zyj/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-03 13:01:07.379500 | 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-03 13:01:07.379505 | 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 0x7f8d9ced2e80>: 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-03 13:01:07.379518 | 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-03 13:01:07.380079 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f8d9ced2e80>: 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-1759496466.185124-29090-50489909522694/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496466.185124-29090-50489909522694/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496466.185124-29090-50489909522694/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-03 13:01:07.380094 | 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_8gc40zyj/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_8gc40zyj/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_8gc40zyj/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_8gc40zyj/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-03 13:01:07.380105 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_8gc40zyj/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_8gc40zyj/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_8gc40zyj/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_8gc40zyj/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_8gc40zyj/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:07.385361 | 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-03 13:01:07.385399 | 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-03 13:01:07.385408 | 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 0x7f8d9ced2e80>: 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-03 13:01:07.385420 | controller |
2025-10-03 13:01:08.584375 | controller | TASK [Test SNR Subscription creation idempotency] ******************************
2025-10-03 13:01:08.584406 | controller | Friday 03 October 2025  13:01:07 +0000 (0:00:00.024)       0:00:11.943 ********
2025-10-03 13:01:08.584418 | controller | ok: [instance]
2025-10-03 13:01:08.604403 | controller |
2025-10-03 13:01:08.604439 | controller | TASK [Assert expected behavior for SNR Subscription creation] ******************
2025-10-03 13:01:08.604448 | controller | Friday 03 October 2025  13:01:08 +0000 (0:00:01.198)       0:00:13.141 ********
2025-10-03 13:01:08.604458 | controller | ok: [instance] => changed=false
2025-10-03 13:01:08.604478 | controller |   msg: SNR Subscription creation task behaves consistently
2025-10-03 13:01:08.604533 | controller |
2025-10-03 13:01:08.604641 | controller | TASK [Verify SNR deployment status] ********************************************
2025-10-03 13:01:08.604755 | controller | Friday 03 October 2025  13:01:08 +0000 (0:00:00.020)       0:00:13.162 ********
2025-10-03 13:01:09.888893 | controller | ok: [instance]
2025-10-03 13:01:09.888954 | controller |
2025-10-03 13:01:09.889068 | controller | TASK [Display SNR deployment verification result] ******************************
2025-10-03 13:01:09.889178 | controller | Friday 03 October 2025  13:01:09 +0000 (0:00:01.284)       0:00:14.446 ********
2025-10-03 13:01:09.904796 | controller | ok: [instance] =>
2025-10-03 13:01:09.904920 | 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-03 13:01:09.905059 | 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 0x7fd2e752f4c0>: 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-1759496468.615583-29430-123696293568770/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496468.615583-29430-123696293568770/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496468.615583-29430-123696293568770/AnsiballZ_k8s_info.py",
2025-10-03 13:01:09.905183 | 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_a4kujom9/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_a4kujom9/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_a4kujom9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-03 13:01:09.905309 | controller |     line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_a4kujom9/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_a4kujom9/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_a4kujom9/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_a4kujom9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-03 13:01:09.905457 | controller |     45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_a4kujom9/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-03 13:01:09.905581 | 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-03 13:01:09.905713 | 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 0x7fd2e752f4c0>: 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-03 13:01:09.905854 | 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-03 13:01:09.905984 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fd2e752f4c0>: 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-1759496468.615583-29430-123696293568770/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496468.615583-29430-123696293568770/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496468.615583-29430-123696293568770/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-03 13:01:09.906106 | 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_a4kujom9/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_a4kujom9/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_a4kujom9/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_a4kujom9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-03 13:01:09.906219 | controller |     line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_a4kujom9/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_a4kujom9/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_a4kujom9/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_a4kujom9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-03 13:01:09.906360 | 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-03 13:01:09.906483 | 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-03 13:01:09.906606 | 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 0x7fd2e752f4c0>: 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-03 13:01:09.911585 | controller |
2025-10-03 13:01:09.911686 | controller | TASK [Test deployment verification behavior] ***********************************
2025-10-03 13:01:09.911792 | controller | Friday 03 October 2025  13:01:09 +0000 (0:00:00.022)       0:00:14.469 ********
2025-10-03 13:01:09.930612 | controller | ok: [instance] =>
2025-10-03 13:01:09.930720 | controller |   msg: Testing deployment verification logic - expected to fail in mock environment
2025-10-03 13:01:09.930851 | controller |
2025-10-03 13:01:09.930972 | controller | TASK [Assert SNR deployment verification behaves as expected] ******************
2025-10-03 13:01:09.931069 | controller | Friday 03 October 2025  13:01:09 +0000 (0:00:00.018)       0:00:14.488 ********
2025-10-03 13:01:09.951826 | controller | ok: [instance] => changed=false
2025-10-03 13:01:09.951900 | controller |   msg: SNR deployment verification logic behaves as expected
2025-10-03 13:01:09.951997 | controller |
2025-10-03 13:01:09.952090 | controller | TASK [Verify NHC Subscription exists] ******************************************
2025-10-03 13:01:09.952194 | controller | Friday 03 October 2025  13:01:09 +0000 (0:00:00.021)       0:00:14.509 ********
2025-10-03 13:01:11.055541 | controller | ok: [instance]
2025-10-03 13:01:11.072407 | controller |
2025-10-03 13:01:11.072436 | controller | TASK [Display NHC Subscription verification result] ****************************
2025-10-03 13:01:11.072445 | controller | Friday 03 October 2025  13:01:11 +0000 (0:00:01.103)       0:00:15.613 ********
2025-10-03 13:01:11.072456 | controller | ok: [instance] =>
2025-10-03 13:01:11.072463 | 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-03 13:01:11.072470 | 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 0x7fa921579ca0>: 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-1759496469.964246-29607-267263311916425/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496469.964246-29607-267263311916425/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496469.964246-29607-267263311916425/AnsiballZ_k8s.py",
2025-10-03 13:01:11.072476 | 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_4rrrcr06/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_4rrrcr06/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_4rrrcr06/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-03 13:01:11.072485 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_4rrrcr06/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_4rrrcr06/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_4rrrcr06/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_4rrrcr06/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_4rrrcr06/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:11.072494 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_4rrrcr06/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-03 13:01:11.072504 | 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-03 13:01:11.072510 | 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 0x7fa921579ca0>: 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-03 13:01:11.072518 | 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-03 13:01:11.072544 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fa921579ca0>: 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-1759496469.964246-29607-267263311916425/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496469.964246-29607-267263311916425/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496469.964246-29607-267263311916425/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-03 13:01:11.072553 | 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_4rrrcr06/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_4rrrcr06/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_4rrrcr06/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_4rrrcr06/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-03 13:01:11.072559 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_4rrrcr06/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_4rrrcr06/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_4rrrcr06/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_4rrrcr06/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_4rrrcr06/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:11.072569 | 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-03 13:01:11.072757 | 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-03 13:01:11.078049 | 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 0x7fa921579ca0>: 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-03 13:01:11.078072 | controller |
2025-10-03 13:01:12.217659 | controller | TASK [Test NHC Subscription creation idempotency] ******************************
2025-10-03 13:01:12.217693 | controller | Friday 03 October 2025  13:01:11 +0000 (0:00:00.022)       0:00:15.635 ********
2025-10-03 13:01:12.217706 | controller | ok: [instance]
2025-10-03 13:01:12.218029 | controller |
2025-10-03 13:01:12.240412 | controller | TASK [Assert expected behavior for NHC Subscription creation] ******************
2025-10-03 13:01:12.240444 | controller | Friday 03 October 2025  13:01:12 +0000 (0:00:01.139)       0:00:16.775 ********
2025-10-03 13:01:12.240456 | controller | ok: [instance] => changed=false
2025-10-03 13:01:12.240757 | controller |   msg: NHC Subscription creation task behaves consistently
2025-10-03 13:01:12.240804 | controller |
2025-10-03 13:01:13.416324 | controller | TASK [Verify CSV status] *******************************************************
2025-10-03 13:01:13.416356 | controller | Friday 03 October 2025  13:01:12 +0000 (0:00:00.022)       0:00:16.798 ********
2025-10-03 13:01:13.416368 | controller | ok: [instance]
2025-10-03 13:01:13.431701 | controller |
2025-10-03 13:01:13.431731 | controller | TASK [Display CSV verification result] *****************************************
2025-10-03 13:01:13.431739 | controller | Friday 03 October 2025  13:01:13 +0000 (0:00:01.175)       0:00:17.973 ********
2025-10-03 13:01:13.431752 | controller | ok: [instance] =>
2025-10-03 13:01:13.431765 | 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-03 13:01:13.431772 | 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 0x7f381ae6d670>: 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-1759496472.2532492-29947-210429158303676/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496472.2532492-29947-210429158303676/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496472.2532492-29947-210429158303676/AnsiballZ_k8s_info.py",
2025-10-03 13:01:13.431781 | 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_vrj0e4hl/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_vrj0e4hl/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_vrj0e4hl/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-03 13:01:13.431802 | controller |     line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_vrj0e4hl/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_vrj0e4hl/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_vrj0e4hl/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_vrj0e4hl/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-03 13:01:13.431824 | controller |     45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_vrj0e4hl/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-03 13:01:13.432395 | 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-03 13:01:13.432950 | 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 0x7f381ae6d670>: 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-03 13:01:13.432967 | 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-03 13:01:13.432978 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f381ae6d670>: 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-1759496472.2532492-29947-210429158303676/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496472.2532492-29947-210429158303676/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496472.2532492-29947-210429158303676/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-03 13:01:13.432990 | 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_vrj0e4hl/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_vrj0e4hl/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_vrj0e4hl/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_vrj0e4hl/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-03 13:01:13.432996 | controller |     line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_vrj0e4hl/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_vrj0e4hl/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_vrj0e4hl/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_vrj0e4hl/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-03 13:01:13.433002 | 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-03 13:01:13.433017 | 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-03 13:01:13.436986 | 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 0x7f381ae6d670>: 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-03 13:01:13.437004 | controller |
2025-10-03 13:01:13.437152 | controller | TASK [Test CSV verification behavior] ******************************************
2025-10-03 13:01:13.437291 | controller | Friday 03 October 2025  13:01:13 +0000 (0:00:00.021)       0:00:17.995 ********
2025-10-03 13:01:13.455281 | controller | ok: [instance] =>
2025-10-03 13:01:13.455522 | controller |   msg: Testing CSV verification logic - expected to fail in mock environment
2025-10-03 13:01:13.455688 | controller |
2025-10-03 13:01:13.455849 | controller | TASK [Assert CSV verification behaves as expected] *****************************
2025-10-03 13:01:13.455990 | controller | Friday 03 October 2025  13:01:13 +0000 (0:00:00.018)       0:00:18.013 ********
2025-10-03 13:01:13.475959 | controller | ok: [instance] => changed=false
2025-10-03 13:01:13.476121 | controller |   msg: CSV verification logic behaves as expected
2025-10-03 13:01:13.476254 | controller |
2025-10-03 13:01:13.476421 | controller | TASK [Verify NHC CR exists] ****************************************************
2025-10-03 13:01:13.476564 | controller | Friday 03 October 2025  13:01:13 +0000 (0:00:00.020)       0:00:18.034 ********
2025-10-03 13:01:14.685017 | controller | ok: [instance]
2025-10-03 13:01:14.700331 | controller |
2025-10-03 13:01:14.700360 | controller | TASK [Display NHC CR verification result] **************************************
2025-10-03 13:01:14.700368 | controller | Friday 03 October 2025  13:01:14 +0000 (0:00:01.208)       0:00:19.242 ********
2025-10-03 13:01:14.700378 | controller | ok: [instance] =>
2025-10-03 13:01:14.700385 | 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-03 13:01:14.700400 | 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 0x7f941bce5c40>: 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-1759496473.487895-30120-222870919085481/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496473.487895-30120-222870919085481/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496473.487895-30120-222870919085481/AnsiballZ_k8s.py",
2025-10-03 13:01:14.700407 | 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_swlanmdm/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_swlanmdm/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_swlanmdm/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-03 13:01:14.700419 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_swlanmdm/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_swlanmdm/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_swlanmdm/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_swlanmdm/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_swlanmdm/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:14.700447 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_swlanmdm/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-03 13:01:14.700456 | 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-03 13:01:14.701363 | 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 0x7f941bce5c40>: 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-03 13:01:14.701376 | 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-03 13:01:14.701387 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f941bce5c40>: 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-1759496473.487895-30120-222870919085481/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1759496473.487895-30120-222870919085481/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1759496473.487895-30120-222870919085481/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-03 13:01:14.701393 | 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_swlanmdm/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_swlanmdm/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_swlanmdm/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_swlanmdm/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-03 13:01:14.701401 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_swlanmdm/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_swlanmdm/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_swlanmdm/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_swlanmdm/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_swlanmdm/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-03 13:01:14.706011 | 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-03 13:01:14.706034 | 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-03 13:01:14.706042 | 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 0x7f941bce5c40>: 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-03 13:01:14.706052 | controller |
2025-10-03 13:01:15.851233 | controller | TASK [Test NHC CR creation idempotency] ****************************************
2025-10-03 13:01:15.851262 | controller | Friday 03 October 2025  13:01:14 +0000 (0:00:00.021)       0:00:19.264 ********
2025-10-03 13:01:15.851274 | controller | ok: [instance]
2025-10-03 13:01:15.871393 | controller |
2025-10-03 13:01:15.871421 | controller | TASK [Assert expected behavior for NHC CR creation] ****************************
2025-10-03 13:01:15.871430 | controller | Friday 03 October 2025  13:01:15 +0000 (0:00:01.144)       0:00:20.408 ********
2025-10-03 13:01:15.871442 | controller | ok: [instance] => changed=false
2025-10-03 13:01:15.871469 | controller |   msg: NHC CR creation task behaves consistently
2025-10-03 13:01:15.871477 | controller |
2025-10-03 13:01:15.871485 | controller | TASK [Verify role structure and logic] *****************************************
2025-10-03 13:01:15.871551 | controller | Friday 03 October 2025  13:01:15 +0000 (0:00:00.020)       0:00:20.429 ********
2025-10-03 13:01:15.901377 | controller | ok: [instance] =>
2025-10-03 13:01:15.902364 | controller |   msg: Role execution and verification completed - errors are expected in test environment without real K8s cluster
2025-10-03 13:01:15.904145 | controller |
2025-10-03 13:01:15.904162 | controller | PLAY RECAP *********************************************************************
2025-10-03 13:01:15.904169 | controller | instance                   : ok=41   changed=0    unreachable=0    failed=0    skipped=20   rescued=1    ignored=0
2025-10-03 13:01:15.904175 | controller |
2025-10-03 13:01:15.904180 | controller | Friday 03 October 2025  13:01:15 +0000 (0:00:00.029)       0:00:20.459 ********
2025-10-03 13:01:15.904186 | controller | ===============================================================================
2025-10-03 13:01:15.904191 | controller | Test kubernetes.core.k8s module availability ---------------------------- 1.59s
2025-10-03 13:01:15.904199 | controller | Verify namespace exists ------------------------------------------------- 1.35s
2025-10-03 13:01:15.955909 | controller | cifmw_snr_nhc : Create the workload-availability namespace -------------- 1.33s
2025-10-03 13:01:15.955939 | controller | Verify OperatorGroup exists --------------------------------------------- 1.30s
2025-10-03 13:01:15.955951 | controller | Verify SNR deployment status -------------------------------------------- 1.28s
2025-10-03 13:01:15.955958 | controller | Test namespace creation idempotency ------------------------------------- 1.26s
2025-10-03 13:01:15.955963 | controller | Verify NHC CR exists ---------------------------------------------------- 1.21s
2025-10-03 13:01:15.955968 | controller | Test SNR Subscription creation idempotency ------------------------------ 1.20s
2025-10-03 13:01:15.955973 | controller | Verify SNR Subscription exists ------------------------------------------ 1.19s
2025-10-03 13:01:15.955979 | controller | Verify CSV status ------------------------------------------------------- 1.18s
2025-10-03 13:01:15.955984 | controller | Test NHC CR creation idempotency ---------------------------------------- 1.14s
2025-10-03 13:01:15.955989 | controller | Test NHC Subscription creation idempotency ------------------------------ 1.14s
2025-10-03 13:01:15.955994 | controller | Test that Python kubernetes library is available ------------------------ 1.13s
2025-10-03 13:01:15.955999 | controller | Verify NHC Subscription exists ------------------------------------------ 1.10s
2025-10-03 13:01:15.956005 | controller | Test OperatorGroup creation idempotency --------------------------------- 1.02s
2025-10-03 13:01:15.956010 | controller | Test that mock kubeconfig exists ---------------------------------------- 0.86s
2025-10-03 13:01:15.956015 | controller | Include the cifmw_snr_nhc role ------------------------------------------ 0.07s
2025-10-03 13:01:15.956020 | controller | Analyze specific error patterns ----------------------------------------- 0.03s
2025-10-03 13:01:15.956026 | controller | cifmw_snr_nhc : Delete existing Subscriptions --------------------------- 0.03s
2025-10-03 13:01:15.956031 | controller | Verify role structure and logic ----------------------------------------- 0.03s
2025-10-03 13:01:15.956045 | controller | INFO     Running default > verify
2025-10-03 13:01:15.956463 | controller | INFO     Running Ansible Verifier
2025-10-03 13:01:16.374395 | controller |
2025-10-03 13:01:16.374601 | controller | PLAY [Verify] ******************************************************************
2025-10-03 13:01:16.374738 | controller |
2025-10-03 13:01:16.374900 | controller | TASK [Check if Python kubernetes library is installed] *************************
2025-10-03 13:01:16.375039 | controller | Friday 03 October 2025  13:01:16 +0000 (0:00:00.020)       0:00:00.020 ********
2025-10-03 13:01:17.583383 | controller | ok: [instance]
2025-10-03 13:01:17.583435 | controller |
2025-10-03 13:01:17.583444 | controller | TASK [Display kubernetes library version] **************************************
2025-10-03 13:01:17.583452 | controller | Friday 03 October 2025  13:01:17 +0000 (0:00:01.208)       0:00:01.229 ********
2025-10-03 13:01:17.604307 | controller | ok: [instance] =>
2025-10-03 13:01:18.337786 | controller |   msg: 'kubernetes library version: 34.1.0'
2025-10-03 13:01:18.337821 | controller |
2025-10-03 13:01:18.337843 | controller | TASK [Verify kubeconfig mock file exists] **************************************
2025-10-03 13:01:18.337851 | controller | Friday 03 October 2025  13:01:17 +0000 (0:00:00.020)       0:00:01.250 ********
2025-10-03 13:01:18.337862 | controller | ok: [instance]
2025-10-03 13:01:18.359189 | controller |
2025-10-03 13:01:18.359211 | controller | TASK [Assert kubeconfig mock file exists] **************************************
2025-10-03 13:01:18.359219 | controller | Friday 03 October 2025  13:01:18 +0000 (0:00:00.733)       0:00:01.984 ********
2025-10-03 13:01:18.359229 | controller | ok: [instance] => changed=false
2025-10-03 13:01:18.986452 | controller |   msg: Mock kubeconfig file exists
2025-10-03 13:01:18.986484 | controller |
2025-10-03 13:01:18.986492 | controller | TASK [Verify kubeadmin password mock file exists] ******************************
2025-10-03 13:01:18.986498 | controller | Friday 03 October 2025  13:01:18 +0000 (0:00:00.021)       0:00:02.005 ********
2025-10-03 13:01:18.986508 | controller | ok: [instance]
2025-10-03 13:01:19.009728 | controller |
2025-10-03 13:01:19.009773 | controller | TASK [Assert kubeadmin password mock file exists] ******************************
2025-10-03 13:01:19.009782 | controller | Friday 03 October 2025  13:01:18 +0000 (0:00:00.626)       0:00:02.632 ********
2025-10-03 13:01:19.009792 | controller | ok: [instance] => changed=false
2025-10-03 13:01:19.766809 | controller |   msg: Mock kubeadmin password file exists
2025-10-03 13:01:19.766852 | controller |
2025-10-03 13:01:19.766866 | controller | TASK [Test Python yaml library] ************************************************
2025-10-03 13:01:19.766873 | controller | Friday 03 October 2025  13:01:19 +0000 (0:00:00.023)       0:00:02.656 ********
2025-10-03 13:01:19.766883 | controller | ok: [instance]
2025-10-03 13:01:19.767150 | controller |
2025-10-03 13:01:19.800547 | controller | TASK [Display yaml test result] ************************************************
2025-10-03 13:01:19.800576 | controller | Friday 03 October 2025  13:01:19 +0000 (0:00:00.756)       0:00:03.413 ********
2025-10-03 13:01:19.800588 | controller | ok: [instance] =>
2025-10-03 13:01:19.843962 | controller |   msg: yaml library works
2025-10-03 13:01:19.843991 | controller |
2025-10-03 13:01:19.843999 | controller | PLAY RECAP *********************************************************************
2025-10-03 13:01:19.844006 | controller | instance                   : ok=8    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2025-10-03 13:01:19.844011 | controller |
2025-10-03 13:01:19.844017 | controller | Friday 03 October 2025  13:01:19 +0000 (0:00:00.033)       0:00:03.446 ********
2025-10-03 13:01:19.844022 | controller | ===============================================================================
2025-10-03 13:01:19.844027 | controller | Check if Python kubernetes library is installed ------------------------- 1.21s
2025-10-03 13:01:19.844033 | controller | Test Python yaml library ------------------------------------------------ 0.76s
2025-10-03 13:01:19.844038 | controller | Verify kubeconfig mock file exists -------------------------------------- 0.73s
2025-10-03 13:01:19.844043 | controller | Verify kubeadmin password mock file exists ------------------------------ 0.63s
2025-10-03 13:01:19.844053 | controller | Display yaml test result ------------------------------------------------ 0.03s
2025-10-03 13:01:19.844059 | controller | Assert kubeadmin password mock file exists ------------------------------ 0.02s
2025-10-03 13:01:19.844064 | controller | Assert kubeconfig mock file exists -------------------------------------- 0.02s
2025-10-03 13:01:19.844070 | controller | Display kubernetes library version -------------------------------------- 0.02s
2025-10-03 13:01:19.844079 | controller | INFO     Verifier completed successfully.
2025-10-03 13:01:19.854414 | controller | INFO     Running default > destroy
2025-10-03 13:01:20.279530 | controller |
2025-10-03 13:01:20.279744 | controller | PLAY [Destroy] *****************************************************************
2025-10-03 13:01:20.279896 | controller |
2025-10-03 13:01:20.280038 | controller | TASK [Get passwd entries for USER env] *****************************************
2025-10-03 13:01:20.280177 | controller | Friday 03 October 2025  13:01:20 +0000 (0:00:00.014)       0:00:00.014 ********
2025-10-03 13:01:20.574413 | controller | ok: [localhost]
2025-10-03 13:01:20.616005 | controller |
2025-10-03 13:01:20.616038 | controller | TASK [Get shell async_dir] *****************************************************
2025-10-03 13:01:20.616046 | controller | Friday 03 October 2025  13:01:20 +0000 (0:00:00.294)       0:00:00.309 ********
2025-10-03 13:01:20.616057 | controller | ok: [localhost]
2025-10-03 13:01:20.649942 | controller |
2025-10-03 13:01:20.649979 | controller | TASK [Set async_dir for HOME env] **********************************************
2025-10-03 13:01:20.649987 | controller | Friday 03 October 2025  13:01:20 +0000 (0:00:00.041)       0:00:00.351 ********
2025-10-03 13:01:20.649996 | controller | skipping: [localhost]
2025-10-03 13:01:21.053233 | controller |
2025-10-03 13:01:21.053264 | controller | TASK [Destroy molecule instance(s)] ********************************************
2025-10-03 13:01:21.053272 | controller | Friday 03 October 2025  13:01:20 +0000 (0:00:00.033)       0:00:00.384 ********
2025-10-03 13:01:21.053286 | 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-03 13:01:31.673417 | controller |
2025-10-03 13:01:31.673447 | controller | TASK [Wait for instance(s) deletion to complete] *******************************
2025-10-03 13:01:31.673456 | controller | Friday 03 October 2025  13:01:21 +0000 (0:00:00.399)       0:00:00.784 ********
2025-10-03 13:01:31.673466 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (300 retries left).
2025-10-03 13:01:31.673497 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (299 retries left).
2025-10-03 13:01:31.673504 | controller | changed: [localhost] => (item={'failed': 0, 'started': 1, 'finished': 0, 'ansible_job_id': 'j498378614372.31182', 'results_file': '/home/zuul/.ansible_async/j498378614372.31182', '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-03 13:01:31.673511 | controller |
2025-10-03 13:01:31.673518 | controller | TASK [Delete podman network dedicated to this scenario] ************************
2025-10-03 13:01:31.673594 | controller | Friday 03 October 2025  13:01:31 +0000 (0:00:10.621)       0:00:11.405 ********
2025-10-03 13:01:31.722408 | controller | skipping: [localhost] => (item=instance: None specified)
2025-10-03 13:01:31.723709 | controller | skipping: [localhost]
2025-10-03 13:01:31.774008 | controller |
2025-10-03 13:01:31.774030 | controller | PLAY RECAP *********************************************************************
2025-10-03 13:01:31.774039 | controller | localhost                  : ok=4    changed=2    unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-10-03 13:01:31.774045 | controller |
2025-10-03 13:01:31.774050 | controller | Friday 03 October 2025  13:01:31 +0000 (0:00:00.052)       0:00:11.458 ********
2025-10-03 13:01:31.774055 | controller | ===============================================================================
2025-10-03 13:01:31.774061 | controller | Wait for instance(s) deletion to complete ------------------------------ 10.62s
2025-10-03 13:01:31.774066 | controller | Destroy molecule instance(s) -------------------------------------------- 0.40s
2025-10-03 13:01:31.774071 | controller | Get passwd entries for USER env ----------------------------------------- 0.30s
2025-10-03 13:01:31.774076 | controller | Delete podman network dedicated to this scenario ------------------------ 0.05s
2025-10-03 13:01:31.774081 | controller | Get shell async_dir ----------------------------------------------------- 0.04s
2025-10-03 13:01:31.774087 | controller | Set async_dir for HOME env ---------------------------------------------- 0.03s
2025-10-03 13:01:31.774095 | controller | INFO     Pruning extra files from scenario ephemeral directory
2025-10-03 13:01:31.775893 | controller | INFO     Writing /tmp/report.html report.
2025-10-03 13:01:32.019637 | controller | changed
2025-10-03 13:01:32.043597 | 
2025-10-03 13:01:32.043665 | PLAY RECAP
2025-10-03 13:01:32.043705 | controller | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-03 13:01:32.043728 | 
2025-10-03 13:01:32.113226 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-03 13:01:32.114052 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-03 13:01:32.757313 | 
2025-10-03 13:01:32.757436 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-03 13:01:32.780367 | 
2025-10-03 13:01:32.780593 | TASK [Filter out host if needed]
2025-10-03 13:01:32.789758 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-03 13:01:32.795854 | 
2025-10-03 13:01:32.795948 | TASK [Ensure file is present]
2025-10-03 13:01:33.141335 | controller | ok
2025-10-03 13:01:33.150619 | 
2025-10-03 13:01:33.150719 | TASK [Manage molecule report file]
2025-10-03 13:01:33.706715 | controller | changed
2025-10-03 13:01:33.712268 | 
2025-10-03 13:01:33.712335 | TASK [Check if we get ci-framework-data basedir]
2025-10-03 13:01:33.943848 | controller | ok
2025-10-03 13:01:33.949738 | 
2025-10-03 13:01:33.949809 | TASK [Create ci-framework-data log directory for zuul]
2025-10-03 13:01:34.304995 | controller | changed
2025-10-03 13:01:34.310555 | 
2025-10-03 13:01:34.310623 | TASK [Copy ci-framework interesting files]
2025-10-03 13:01:34.507738 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-10-03 13:01:34.838559 | controller | changed
2025-10-03 13:01:34.843992 | 
2025-10-03 13:01:34.844062 | TASK [Get SELinux listing]
2025-10-03 13:01:35.374337 | controller | changed
2025-10-03 13:01:35.380265 | 
2025-10-03 13:01:35.380354 | TASK [Generate log index]
2025-10-03 13:01:36.023023 | controller | changed
2025-10-03 13:01:36.028570 | 
2025-10-03 13:01:36.028649 | TASK [Get some env related data]
2025-10-03 13:01:36.645228 | controller | /home/zuul/.local/bin/ansible
2025-10-03 13:01:37.594329 | controller | changed
2025-10-03 13:01:37.599804 | 
2025-10-03 13:01:37.599898 | TASK [Generate list of logs to collect in home directory]
2025-10-03 13:01:38.137893 | controller | ok: All paths examined
2025-10-03 13:01:38.152881 | 
2025-10-03 13:01:38.152993 | LOOP [Copy logs from home directory]
2025-10-03 13:01:38.575050 | controller | changed:
2025-10-03 13:01:38.575172 | controller | {
2025-10-03 13:01:38.575201 | controller |   "atime": 1759496389.874247,
2025-10-03 13:01:38.575229 | controller |   "ctime": 1759496408.2275012,
2025-10-03 13:01:38.575250 | controller |   "dev": 64513,
2025-10-03 13:01:38.575269 | controller |   "gid": 1000,
2025-10-03 13:01:38.575287 | controller |   "gr_name": "zuul",
2025-10-03 13:01:38.575305 | controller |   "inode": 4448225,
2025-10-03 13:01:38.575321 | controller |   "isblk": false,
2025-10-03 13:01:38.575340 | controller |   "ischr": false,
2025-10-03 13:01:38.575357 | controller |   "isdir": false,
2025-10-03 13:01:38.575373 | controller |   "isfifo": false,
2025-10-03 13:01:38.575389 | controller |   "isgid": false,
2025-10-03 13:01:38.575404 | controller |   "islnk": false,
2025-10-03 13:01:38.575420 | controller |   "isreg": true,
2025-10-03 13:01:38.575436 | controller |   "issock": false,
2025-10-03 13:01:38.575451 | controller |   "isuid": false,
2025-10-03 13:01:38.575466 | controller |   "mode": "0644",
2025-10-03 13:01:38.575481 | controller |   "mtime": 1759496408.2275012,
2025-10-03 13:01:38.575496 | controller |   "nlink": 1,
2025-10-03 13:01:38.575511 | controller |   "path": "/home/zuul/ansible.log",
2025-10-03 13:01:38.575528 | controller |   "pw_name": "zuul",
2025-10-03 13:01:38.575544 | controller |   "rgrp": true,
2025-10-03 13:01:38.575560 | controller |   "roth": true,
2025-10-03 13:01:38.575576 | controller |   "rusr": true,
2025-10-03 13:01:38.575591 | controller |   "size": 6749,
2025-10-03 13:01:38.575607 | controller |   "uid": 1000,
2025-10-03 13:01:38.575623 | controller |   "wgrp": false,
2025-10-03 13:01:38.575640 | controller |   "woth": false,
2025-10-03 13:01:38.575658 | controller |   "wusr": true,
2025-10-03 13:01:38.575675 | controller |   "xgrp": false,
2025-10-03 13:01:38.575691 | controller |   "xoth": false,
2025-10-03 13:01:38.575707 | controller |   "xusr": false
2025-10-03 13:01:38.575722 | controller | }
2025-10-03 13:01:38.583211 | 
2025-10-03 13:01:38.583319 | TASK [Copy crio stats log file]
2025-10-03 13:01:38.607555 | controller | skipping: Conditional result was False
2025-10-03 13:01:38.614022 | 
2025-10-03 13:01:38.614105 | TASK [Get SELinux related data]
2025-10-03 13:01:38.851642 | controller | <no matches>
2025-10-03 13:01:39.157604 | controller | ERROR
2025-10-03 13:01:39.157774 | controller | {
2025-10-03 13:01:39.157808 | controller |   "delta": "0:00:00.008136",
2025-10-03 13:01:39.157832 | controller |   "end": "2025-10-03 13:01:38.852211",
2025-10-03 13:01:39.157851 | controller |   "msg": "non-zero return code",
2025-10-03 13:01:39.157879 | controller |   "rc": 1,
2025-10-03 13:01:39.157897 | controller |   "start": "2025-10-03 13:01:38.844075"
2025-10-03 13:01:39.157968 | controller | }
2025-10-03 13:01:39.158002 | controller | ERROR: Ignoring Errors
2025-10-03 13:01:39.165067 | 
2025-10-03 13:01:39.165135 | TASK [Create system configuration directory]
2025-10-03 13:01:39.385993 | controller | changed
2025-10-03 13:01:39.399274 | 
2025-10-03 13:01:39.399361 | TASK [Get some of the system configurations]
2025-10-03 13:01:39.944539 | controller | changed
2025-10-03 13:01:39.949869 | 
2025-10-03 13:01:39.949967 | TASK [Copy generated documentation if available]
2025-10-03 13:01:39.973386 | controller | skipping: Conditional result was False
2025-10-03 13:01:39.979076 | 
2025-10-03 13:01:39.979143 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-03 13:01:40.033392 | controller | skipping: Conditional result was False
2025-10-03 13:01:40.038682 | 
2025-10-03 13:01:40.038750 | TASK [Compress logs bigger than 2MB]
2025-10-03 13:01:40.589537 | controller | changed
2025-10-03 13:01:40.595762 | 
2025-10-03 13:01:40.595835 | TASK [Copy files from workspace on node]
2025-10-03 13:01:40.624856 | controller | ok
2025-10-03 13:01:40.666727 | 
2025-10-03 13:01:40.666811 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-03 13:01:40.700457 | controller | skipping: Conditional result was False
2025-10-03 13:01:40.707241 | 
2025-10-03 13:01:40.707311 | TASK [fetch-output : Set log path for single node]
2025-10-03 13:01:40.734772 | controller | ok
2025-10-03 13:01:40.740471 | 
2025-10-03 13:01:40.740539 | LOOP [fetch-output : Ensure local output dirs]
2025-10-03 13:01:41.020950 | controller -> localhost | ok: "/var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/logs"
2025-10-03 13:01:41.021171 | controller -> localhost | changed: All items complete
2025-10-03 13:01:41.021203 | 
2025-10-03 13:01:41.239117 | controller -> localhost | changed: "/var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/artifacts"
2025-10-03 13:01:41.470798 | controller -> localhost | changed: "/var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/docs"
2025-10-03 13:01:41.487179 | 
2025-10-03 13:01:41.487537 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-03 13:01:42.136577 | controller | changed:
2025-10-03 13:01:42.136830 | controller | .d..t...... ./
2025-10-03 13:01:42.136866 | controller | >f+++++++++ README.html
2025-10-03 13:01:42.136891 | controller | >f+++++++++ ansible-execution.log
2025-10-03 13:01:42.136946 | controller | >f+++++++++ ansible.log
2025-10-03 13:01:42.136972 | controller | >f+++++++++ dmesg.log
2025-10-03 13:01:42.136992 | controller | >f+++++++++ installed-pkgs.log
2025-10-03 13:01:42.137010 | controller | >f+++++++++ python.log
2025-10-03 13:01:42.137030 | controller | >f+++++++++ registries.conf
2025-10-03 13:01:42.137048 | controller | >f+++++++++ report.html
2025-10-03 13:01:42.137068 | controller | >f+++++++++ selinux-denials.log
2025-10-03 13:01:42.137085 | controller | >f+++++++++ selinux-listing.log
2025-10-03 13:01:42.137102 | controller | cd+++++++++ ci-framework-data/
2025-10-03 13:01:42.137119 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-10-03 13:01:42.137135 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-10-03 13:01:42.137151 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-10-03 13:01:42.137167 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-10-03 13:01:42.137183 | controller | cd+++++++++ ci-framework-data/logs/
2025-10-03 13:01:42.137200 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-10-03 13:01:42.137216 | controller | cd+++++++++ registries.conf.d/
2025-10-03 13:01:42.137232 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-03 13:01:42.137247 | controller | cd+++++++++ system-config/
2025-10-03 13:01:42.137262 | controller | cd+++++++++ system-config/libvirt/
2025-10-03 13:01:42.137279 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-10-03 13:01:42.137295 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-10-03 13:01:42.831644 | controller | changed: .d..t...... ./
2025-10-03 13:01:43.494559 | controller | changed: .d..t...... ./
2025-10-03 13:01:43.518461 | 
2025-10-03 13:01:43.518553 | TASK [Return artifact to Zuul]
2025-10-03 13:01:43.590725 | controller | ok
2025-10-03 13:01:43.610892 | 
2025-10-03 13:01:43.611028 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-03 13:01:43.611129 | 
2025-10-03 13:01:43.611159 | PLAY RECAP
2025-10-03 13:01:43.611196 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-03 13:01:43.611218 | 
2025-10-03 13:01:43.757644 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-03 13:01:43.758579 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-03 13:01:44.716736 | 
2025-10-03 13:01:44.716881 | PLAY [all]
2025-10-03 13:01:44.751216 | 
2025-10-03 13:01:44.751352 | TASK [include_role : fetch-output]
2025-10-03 13:01:44.783900 | controller | ok
2025-10-03 13:01:44.804870 | 
2025-10-03 13:01:44.805027 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-03 13:01:44.859830 | controller | skipping: Conditional result was False
2025-10-03 13:01:44.870601 | 
2025-10-03 13:01:44.870702 | TASK [fetch-output : Set log path for single node]
2025-10-03 13:01:44.960207 | controller | ok
2025-10-03 13:01:44.965636 | 
2025-10-03 13:01:44.965736 | LOOP [fetch-output : Ensure local output dirs]
2025-10-03 13:01:45.657978 | controller -> localhost | ok: "/var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/logs"
2025-10-03 13:01:46.154739 | controller -> localhost | ok: "/var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/artifacts"
2025-10-03 13:01:46.517655 | controller -> localhost | ok: "/var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/docs"
2025-10-03 13:01:46.533052 | 
2025-10-03 13:01:46.533162 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-03 13:01:47.720124 | controller | ok
2025-10-03 13:01:47.720312 | controller | ok: All items complete
2025-10-03 13:01:47.720343 | 
2025-10-03 13:01:48.440013 | controller | ok
2025-10-03 13:01:49.242640 | controller | ok
2025-10-03 13:01:49.266276 | 
2025-10-03 13:01:49.266375 | TASK [include_role : fetch-output-openshift]
2025-10-03 13:01:49.311762 | controller | skipping: Conditional result was False
2025-10-03 13:01:49.318015 | 
2025-10-03 13:01:49.318092 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-03 13:01:50.227708 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.051219
2025-10-03 13:01:50.986873 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.065014
2025-10-03 13:01:51.070163 | 
2025-10-03 13:01:51.070289 | PLAY [all]
2025-10-03 13:01:51.127176 | 
2025-10-03 13:01:51.127281 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-03 13:01:52.089504 | controller | changed
2025-10-03 13:01:52.158709 | 
2025-10-03 13:01:52.158802 | PLAY RECAP
2025-10-03 13:01:52.158847 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-03 13:01:52.158871 | 
2025-10-03 13:01:52.391331 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-03 13:01:52.392577 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-03 13:01:53.868890 | 
2025-10-03 13:01:53.869043 | PLAY [localhost]
2025-10-03 13:01:53.919090 | 
2025-10-03 13:01:53.919223 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-03 13:01:54.363855 | localhost | changed
2025-10-03 13:01:54.369801 | 
2025-10-03 13:01:54.369888 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-03 13:01:54.412669 | localhost | ok
2025-10-03 13:01:54.426536 | 
2025-10-03 13:01:54.426629 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-03 13:01:54.895634 | localhost | changed
2025-10-03 13:01:54.902150 | 
2025-10-03 13:01:54.902225 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-03 13:01:55.935747 | localhost | changed
2025-10-03 13:01:55.943389 | 
2025-10-03 13:01:55.943456 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-03 13:01:56.493214 | localhost | Identity added: /var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/tmp/ansible.akv14tiv (/var/lib/zuul/builds/6206bd2b107848b3bfc19e2e9fd0536c/work/tmp/ansible.akv14tiv)
2025-10-03 13:01:56.493383 | localhost | ok: Runtime: 0:00:00.011380
2025-10-03 13:01:56.497567 | 
2025-10-03 13:01:56.497636 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-03 13:01:56.898429 | localhost | ok: Runtime: 0:00:00.018525
2025-10-03 13:01:56.903256 | 
2025-10-03 13:01:56.903338 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-03 13:01:57.004005 | localhost | changed
2025-10-03 13:01:57.008545 | 
2025-10-03 13:01:57.008612 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-03 13:01:57.728021 | localhost | changed
2025-10-03 13:01:57.770951 | 
2025-10-03 13:01:57.771033 | PLAY [localhost]
2025-10-03 13:01:57.794881 | 
2025-10-03 13:01:57.794990 | TASK [Generate bulk log download script]
2025-10-03 13:01:57.856177 | localhost | ok
2025-10-03 13:01:57.882993 | 
2025-10-03 13:01:57.883099 | TASK [local-log-download : Check API endpoint is defined]
2025-10-03 13:01:57.959685 | localhost | ok: All assertions passed
2025-10-03 13:01:57.965248 | 
2025-10-03 13:01:57.965320 | TASK [local-log-download : Create download script]
2025-10-03 13:01:58.896310 | localhost -> localhost | changed
2025-10-03 13:01:58.904604 | 
2025-10-03 13:01:58.904686 | TASK [Register quick-download link]
2025-10-03 13:01:58.956504 | localhost | ok
2025-10-03 13:01:58.989598 | 
2025-10-03 13:01:58.989672 | PLAY [logserver.rdoproject.org]
2025-10-03 13:01:59.022137 | 
2025-10-03 13:01:59.022211 | TASK [Set zuul-log-path fact]
2025-10-03 13:01:59.061632 | logserver.rdoproject.org | ok
2025-10-03 13:01:59.074254 | 
2025-10-03 13:01:59.074486 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-03 13:01:59.141669 | logserver.rdoproject.org | ok
2025-10-03 13:01:59.148131 | 
2025-10-03 13:01:59.148199 | TASK [upload-logs : Create log directories]
2025-10-03 13:02:01.084597 | logserver.rdoproject.org | changed
2025-10-03 13:02:01.087968 | 
2025-10-03 13:02:01.088035 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-03 13:02:01.756162 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.024785
2025-10-03 13:02:01.760870 | 
2025-10-03 13:02:01.760965 | TASK [upload-logs : Upload logs to log server]
2025-10-03 13:02:03.943465 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-03 13:02:03.946614 | 
2025-10-03 13:02:03.946681 | LOOP [upload-logs : Compress console log and json output]
2025-10-03 13:02:04.063819 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-03 13:02:04.077892 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-03 13:02:04.089477 | 
2025-10-03 13:02:04.089576 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-03 13:02:04.182186 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-03 13:02:04.182464 | 
2025-10-03 13:02:04.185283 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-03 13:02:04.198058 | 
2025-10-03 13:02:04.198161 | LOOP [upload-logs : Upload console log and json output]