2025-10-13 13:07:49.661369 | Job console starting...
2025-10-13 13:07:49.957733 | Updating repositories
2025-10-13 13:07:50.821288 | Preparing job workspace
2025-10-13 13:08:03.850623 | Running Ansible setup...
2025-10-13 13:08:09.731423 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-13 13:08:11.126110 | 
2025-10-13 13:08:11.126228 | PLAY [localhost]
2025-10-13 13:08:11.140856 | 
2025-10-13 13:08:11.140947 | TASK [Gathering Facts]
2025-10-13 13:08:12.721139 | localhost | ok
2025-10-13 13:08:12.756034 | 
2025-10-13 13:08:12.756147 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-13 13:08:13.753771 | localhost -> localhost | changed
2025-10-13 13:08:13.759139 | 
2025-10-13 13:08:13.759222 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-13 13:08:16.073130 | localhost -> localhost | changed
2025-10-13 13:08:16.082201 | 
2025-10-13 13:08:16.082285 | TASK [Setup log path fact]
2025-10-13 13:08:16.135381 | localhost | ok
2025-10-13 13:08:16.159326 | 
2025-10-13 13:08:16.159421 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-13 13:08:16.235815 | localhost | ok
2025-10-13 13:08:16.251458 | 
2025-10-13 13:08:16.251550 | TASK [emit-job-header : Print job information]
2025-10-13 13:08:16.360720 | # Job Information
2025-10-13 13:08:16.360866 | Ansible Version: 2.15.12
2025-10-13 13:08:16.360898 | Job: cifmw-molecule-cifmw_snr_nhc
2025-10-13 13:08:16.360945 | Pipeline: github-check
2025-10-13 13:08:16.360970 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-10-13 13:08:16.360990 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3402
2025-10-13 13:08:16.361011 | Log URL (when completed): https://logserver.rdoproject.org/9a7/rdoproject.org/9a72e896a43b4c138c7dc4bf0bd9e61f/
2025-10-13 13:08:16.361033 | Event ID: 713e3280-a835-11f0-8df6-28652843c3d7
2025-10-13 13:08:16.365766 | 
2025-10-13 13:08:16.365836 | LOOP [emit-job-header : Print node information]
2025-10-13 13:08:16.603570 | localhost | ok:
2025-10-13 13:08:16.603774 | localhost | # Node Information
2025-10-13 13:08:16.603807 | localhost | Inventory Hostname: controller
2025-10-13 13:08:16.603837 | localhost | Hostname: np0005484644
2025-10-13 13:08:16.603861 | localhost | Username: zuul
2025-10-13 13:08:16.603883 | localhost | Distro: CentOS 9
2025-10-13 13:08:16.603903 | localhost | Provider: ibm-bm4-nodepool
2025-10-13 13:08:16.603948 | localhost | Region: regionOne
2025-10-13 13:08:16.603971 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-10-13 13:08:16.603991 | localhost | Product Name: OpenStack Compute
2025-10-13 13:08:16.604010 | localhost | Interface IP: 192.168.26.81
2025-10-13 13:08:16.665623 | 
2025-10-13 13:08:16.665702 | PLAY [all]
2025-10-13 13:08:16.691053 | 
2025-10-13 13:08:16.691123 | TASK [Gather network facts]
2025-10-13 13:08:17.103749 | controller | ok
2025-10-13 13:08:17.161856 | 
2025-10-13 13:08:17.161952 | TASK [include_role : start-zuul-console]
2025-10-13 13:08:17.223200 | controller | ok
2025-10-13 13:08:17.251391 | 
2025-10-13 13:08:17.251463 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-13 13:08:17.900532 | controller | ok
2025-10-13 13:08:17.913743 | 
2025-10-13 13:08:17.913825 | TASK [include_role : add-build-sshkey]
2025-10-13 13:08:18.013859 | controller | ok
2025-10-13 13:08:18.037591 | 
2025-10-13 13:08:18.037686 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-13 13:08:18.647020 | controller -> localhost | ok
2025-10-13 13:08:18.652548 | 
2025-10-13 13:08:18.652611 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-13 13:08:18.723560 | controller | ok
2025-10-13 13:08:18.771572 | controller | included: /var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-13 13:08:18.789037 | 
2025-10-13 13:08:18.789112 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-13 13:08:21.022522 | controller -> localhost | Generating public/private rsa key pair.
2025-10-13 13:08:21.022712 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/9a72e896a43b4c138c7dc4bf0bd9e61f_id_rsa.
2025-10-13 13:08:21.022749 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/9a72e896a43b4c138c7dc4bf0bd9e61f_id_rsa.pub.
2025-10-13 13:08:21.022775 | controller -> localhost | The key fingerprint is:
2025-10-13 13:08:21.022796 | controller -> localhost | SHA256:sIz4zR4J93Wk9kUUQcOoet3ERt5l9BYec2yZMFQPbOg zuul-build-sshkey
2025-10-13 13:08:21.022817 | controller -> localhost | The key's randomart image is:
2025-10-13 13:08:21.022838 | controller -> localhost | +---[RSA 3072]----+
2025-10-13 13:08:21.022858 | controller -> localhost | |            .XXX=|
2025-10-13 13:08:21.022878 | controller -> localhost | |            o.B=%|
2025-10-13 13:08:21.022897 | controller -> localhost | |      .    o.=.==|
2025-10-13 13:08:21.022945 | controller -> localhost | |   . o o  .oE.=..|
2025-10-13 13:08:21.022970 | controller -> localhost | |  . o + S.+..+.  |
2025-10-13 13:08:21.022991 | controller -> localhost | |   . = o.o.o...  |
2025-10-13 13:08:21.023010 | controller -> localhost | |    . = ..  .    |
2025-10-13 13:08:21.023031 | controller -> localhost | |     . .         |
2025-10-13 13:08:21.023049 | controller -> localhost | |      .          |
2025-10-13 13:08:21.023067 | controller -> localhost | +----[SHA256]-----+
2025-10-13 13:08:21.023112 | controller -> localhost | ok: Runtime: 0:00:00.714539
2025-10-13 13:08:21.032412 | 
2025-10-13 13:08:21.032478 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-13 13:08:21.088208 | controller | ok
2025-10-13 13:08:21.124083 | controller | included: /var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-13 13:08:21.162579 | 
2025-10-13 13:08:21.162676 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-13 13:08:21.239172 | controller | skipping: Conditional result was False
2025-10-13 13:08:21.244685 | 
2025-10-13 13:08:21.244767 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-13 13:08:22.147872 | controller | changed
2025-10-13 13:08:22.155782 | 
2025-10-13 13:08:22.155860 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-13 13:08:22.396934 | controller | ok
2025-10-13 13:08:22.403544 | 
2025-10-13 13:08:22.403626 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-13 13:08:23.227599 | controller | changed
2025-10-13 13:08:23.239453 | 
2025-10-13 13:08:23.239530 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-13 13:08:24.093565 | controller | changed
2025-10-13 13:08:24.098581 | 
2025-10-13 13:08:24.098661 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-13 13:08:24.164072 | controller | skipping: Conditional result was False
2025-10-13 13:08:24.169677 | 
2025-10-13 13:08:24.169753 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-13 13:08:25.443268 | controller -> localhost | changed
2025-10-13 13:08:25.453851 | 
2025-10-13 13:08:25.453955 | TASK [add-build-sshkey : Add back temp key]
2025-10-13 13:08:26.270325 | controller -> localhost | Identity added: /var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/9a72e896a43b4c138c7dc4bf0bd9e61f_id_rsa (zuul-build-sshkey)
2025-10-13 13:08:26.270513 | controller -> localhost | ok: Runtime: 0:00:00.029279
2025-10-13 13:08:26.276622 | 
2025-10-13 13:08:26.276688 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-13 13:08:26.873326 | controller | ok
2025-10-13 13:08:26.882131 | 
2025-10-13 13:08:26.882216 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-13 13:08:26.999296 | controller | skipping: Conditional result was False
2025-10-13 13:08:27.025791 | 
2025-10-13 13:08:27.025874 | TASK [include_role : validate-host]
2025-10-13 13:08:27.106880 | controller | ok
2025-10-13 13:08:27.209159 | 
2025-10-13 13:08:27.209256 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-13 13:08:27.298029 | controller | ok
2025-10-13 13:08:27.307042 | 
2025-10-13 13:08:27.307128 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-13 13:08:28.145604 | controller -> localhost | ok
2025-10-13 13:08:28.151688 | 
2025-10-13 13:08:28.151760 | TASK [validate-host : Collect information about the host]
2025-10-13 13:08:28.884072 | controller | ok
2025-10-13 13:08:28.921187 | 
2025-10-13 13:08:28.921284 | TASK [validate-host : Sanitize hostname]
2025-10-13 13:08:29.096395 | controller | ok
2025-10-13 13:08:29.102876 | 
2025-10-13 13:08:29.102984 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-13 13:08:30.717094 | controller -> localhost | changed
2025-10-13 13:08:30.726232 | 
2025-10-13 13:08:30.726325 | TASK [validate-host : Collect information about zuul worker]
2025-10-13 13:08:31.296446 | controller | ok
2025-10-13 13:08:31.308738 | 
2025-10-13 13:08:31.313939 | TASK [validate-host : Write out all zuul information for each host]
2025-10-13 13:08:32.571193 | controller -> localhost | changed
2025-10-13 13:08:32.582740 | 
2025-10-13 13:08:32.582827 | TASK [include_role : prepare-workspace-openshift]
2025-10-13 13:08:32.631242 | controller | skipping: Conditional result was False
2025-10-13 13:08:32.638537 | 
2025-10-13 13:08:32.638624 | TASK [include_role : remove-zuul-sshkey]
2025-10-13 13:08:32.693244 | controller | skipping: Conditional result was False
2025-10-13 13:08:32.700028 | 
2025-10-13 13:08:32.700114 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-13 13:08:32.987393 | controller | ok: "logs"
2025-10-13 13:08:32.987750 | controller | ok: All items complete
2025-10-13 13:08:32.987789 | 
2025-10-13 13:08:33.175884 | controller | ok: "artifacts"
2025-10-13 13:08:33.385818 | controller | ok: "docs"
2025-10-13 13:08:33.399957 | 
2025-10-13 13:08:33.400047 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-13 13:08:33.633307 | controller | changed: "logs"
2025-10-13 13:08:33.805390 | controller | changed: "artifacts"
2025-10-13 13:08:33.998587 | controller | changed: "docs"
2025-10-13 13:08:34.044327 | 
2025-10-13 13:08:34.044406 | PLAY RECAP
2025-10-13 13:08:34.044452 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-13 13:08:34.044482 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-13 13:08:34.044505 | 
2025-10-13 13:08:34.323731 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-13 13:08:34.325000 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-13 13:08:36.491660 | 
2025-10-13 13:08:36.491761 | PLAY [all]
2025-10-13 13:08:36.534172 | 
2025-10-13 13:08:36.534336 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-13 13:08:36.682783 | controller | ok
2025-10-13 13:08:36.687961 | 
2025-10-13 13:08:36.688057 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-13 13:08:37.423450 | controller | changed
2025-10-13 13:08:37.437334 | 
2025-10-13 13:08:37.437433 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-13 13:08:39.073562 | controller | changed
2025-10-13 13:08:39.105381 | 
2025-10-13 13:08:39.105486 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-13 13:08:39.938801 | controller | changed:
2025-10-13 13:08:39.938999 | controller | {
2025-10-13 13:08:39.939035 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-13 13:08:39.939065 | controller | }
2025-10-13 13:08:40.147546 | controller | changed:
2025-10-13 13:08:40.147631 | controller | {
2025-10-13 13:08:40.147662 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-13 13:08:40.147686 | controller | }
2025-10-13 13:08:40.382154 | controller | changed:
2025-10-13 13:08:40.382239 | controller | {
2025-10-13 13:08:40.382269 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-10-13 13:08:40.382291 | controller | }
2025-10-13 13:08:40.596872 | controller | changed:
2025-10-13 13:08:40.596970 | controller | {
2025-10-13 13:08:40.597000 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-13 13:08:40.597022 | controller | }
2025-10-13 13:08:40.837342 | controller | changed:
2025-10-13 13:08:40.837463 | controller | {
2025-10-13 13:08:40.837495 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-13 13:08:40.837519 | controller | }
2025-10-13 13:08:41.064422 | controller | changed:
2025-10-13 13:08:41.064501 | controller | {
2025-10-13 13:08:41.064530 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-13 13:08:41.064557 | controller | }
2025-10-13 13:08:41.289197 | controller | changed:
2025-10-13 13:08:41.289279 | controller | {
2025-10-13 13:08:41.289309 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen"
2025-10-13 13:08:41.289343 | controller | }
2025-10-13 13:08:41.501361 | controller | changed:
2025-10-13 13:08:41.501441 | controller | {
2025-10-13 13:08:41.501471 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora"
2025-10-13 13:08:41.501494 | controller | }
2025-10-13 13:08:41.827327 | controller | changed:
2025-10-13 13:08:41.827428 | controller | {
2025-10-13 13:08:41.827462 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-13 13:08:41.827485 | controller | }
2025-10-13 13:08:41.969955 | controller | changed:
2025-10-13 13:08:41.970029 | controller | {
2025-10-13 13:08:41.970058 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-13 13:08:41.970080 | controller | }
2025-10-13 13:08:42.193512 | controller | changed:
2025-10-13 13:08:42.193630 | controller | {
2025-10-13 13:08:42.193663 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-13 13:08:42.193685 | controller | }
2025-10-13 13:08:42.429291 | controller | changed:
2025-10-13 13:08:42.429383 | controller | {
2025-10-13 13:08:42.429413 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-13 13:08:42.429436 | controller | }
2025-10-13 13:08:42.657119 | controller | changed:
2025-10-13 13:08:42.657256 | controller | {
2025-10-13 13:08:42.657289 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-13 13:08:42.657312 | controller | }
2025-10-13 13:08:42.904756 | controller | changed:
2025-10-13 13:08:42.904897 | controller | {
2025-10-13 13:08:42.904951 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-13 13:08:42.904976 | controller | }
2025-10-13 13:08:43.136271 | controller | changed:
2025-10-13 13:08:43.136366 | controller | {
2025-10-13 13:08:43.136396 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-13 13:08:43.136418 | controller | }
2025-10-13 13:08:43.378876 | controller | changed:
2025-10-13 13:08:43.379009 | controller | {
2025-10-13 13:08:43.379038 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-13 13:08:43.379059 | controller | }
2025-10-13 13:08:43.618280 | controller | changed:
2025-10-13 13:08:43.618690 | controller | {
2025-10-13 13:08:43.618752 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com"
2025-10-13 13:08:43.618999 | controller | }
2025-10-13 13:08:43.856335 | controller | changed:
2025-10-13 13:08:43.856418 | controller | {
2025-10-13 13:08:43.856446 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb"
2025-10-13 13:08:43.856477 | controller | }
2025-10-13 13:08:44.106325 | controller | changed:
2025-10-13 13:08:44.106453 | controller | {
2025-10-13 13:08:44.106487 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-13 13:08:44.106511 | controller | }
2025-10-13 13:08:44.351160 | controller | changed:
2025-10-13 13:08:44.351252 | controller | {
2025-10-13 13:08:44.351283 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-13 13:08:44.351305 | controller | }
2025-10-13 13:08:44.589992 | controller | changed:
2025-10-13 13:08:44.590083 | controller | {
2025-10-13 13:08:44.590117 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-13 13:08:44.590144 | controller | }
2025-10-13 13:08:44.828136 | controller | changed:
2025-10-13 13:08:44.828214 | controller | {
2025-10-13 13:08:44.828241 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-13 13:08:44.828263 | controller | }
2025-10-13 13:08:45.064013 | controller | changed:
2025-10-13 13:08:45.066005 | controller | {
2025-10-13 13:08:45.066050 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com"
2025-10-13 13:08:45.066076 | controller | }
2025-10-13 13:08:45.298698 | controller | changed:
2025-10-13 13:08:45.301019 | controller | {
2025-10-13 13:08:45.301080 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-13 13:08:45.301109 | controller | }
2025-10-13 13:08:45.511866 | controller | changed:
2025-10-13 13:08:45.511978 | controller | {
2025-10-13 13:08:45.512008 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-13 13:08:45.512031 | controller | }
2025-10-13 13:08:45.742245 | controller | changed:
2025-10-13 13:08:45.742346 | controller | {
2025-10-13 13:08:45.742376 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-13 13:08:45.742398 | controller | }
2025-10-13 13:08:45.785943 | 
2025-10-13 13:08:45.786049 | TASK [Set timezone to UTC]
2025-10-13 13:08:47.015540 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-13 13:08:47.026160 | 
2025-10-13 13:08:47.026277 | TASK [Create nodepool directory]
2025-10-13 13:08:47.296087 | controller | changed
2025-10-13 13:08:47.307535 | 
2025-10-13 13:08:47.307628 | TASK [Create nodepool sub_nodes file]
2025-10-13 13:08:48.025799 | controller | changed
2025-10-13 13:08:48.033015 | 
2025-10-13 13:08:48.033107 | TASK [Create nodepool sub_nodes_private file]
2025-10-13 13:08:48.755536 | controller | changed
2025-10-13 13:08:48.767052 | 
2025-10-13 13:08:48.767122 | LOOP [Populate nodepool sub_nodes file]
2025-10-13 13:08:48.851065 | 
2025-10-13 13:08:48.851294 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-13 13:08:48.992759 | 
2025-10-13 13:08:48.992925 | TASK [Create nodepool primary file]
2025-10-13 13:08:49.092231 | controller | skipping: Conditional result was False
2025-10-13 13:08:49.097790 | 
2025-10-13 13:08:49.097868 | TASK [Create nodepool node_private for this node]
2025-10-13 13:08:49.887854 | controller | changed
2025-10-13 13:08:49.909727 | 
2025-10-13 13:08:49.909822 | LOOP [Copy ssh keys to nodepool directory]
2025-10-13 13:08:50.977362 | controller | ok: Item: id_rsa Runtime: 0:00:00.005620
2025-10-13 13:08:50.977521 | 
2025-10-13 13:08:51.174522 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004585
2025-10-13 13:08:51.186529 | 
2025-10-13 13:08:51.186636 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-13 13:08:52.092892 | controller | changed
2025-10-13 13:08:52.098212 | 
2025-10-13 13:08:52.098288 | TASK [Validate sudoers config after edits]
2025-10-13 13:08:52.579519 | controller | /etc/sudoers: parsed OK
2025-10-13 13:08:52.579584 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-13 13:08:52.579593 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-13 13:08:52.579600 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-13 13:08:52.712622 | controller | ok: Runtime: 0:00:00.006283
2025-10-13 13:08:52.718648 | 
2025-10-13 13:08:52.718716 | TASK [Show the environment passed in to job shell scripts]
2025-10-13 13:08:52.977446 | controller | SHELL=/bin/bash
2025-10-13 13:08:52.977503 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-13 13:08:52.977514 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-13 13:08:52.977519 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/02/3402/d06510c33c77f91e7f781656796544e000bd377e
2025-10-13 13:08:52.977525 | controller | PWD=/home/zuul
2025-10-13 13:08:52.977531 | controller | ZUUL_PIPELINE=github-check
2025-10-13 13:08:52.977536 | controller | LOGNAME=zuul
2025-10-13 13:08:52.977541 | controller | XDG_SESSION_TYPE=tty
2025-10-13 13:08:52.977546 | controller | _=/usr/bin/env
2025-10-13 13:08:52.977552 | controller | MOTD_SHOWN=pam
2025-10-13 13:08:52.977557 | controller | HOME=/home/zuul
2025-10-13 13:08:52.977594 | controller | LANG=en_US.UTF-8
2025-10-13 13:08:52.977601 | controller | SSH_CONNECTION=192.168.26.12 57126 192.168.26.81 22
2025-10-13 13:08:52.977607 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET
2025-10-13 13:08:52.977615 | controller | ZUUL_CHANGE_IDS=3402,d06510c33c77f91e7f781656796544e000bd377e
2025-10-13 13:08:52.977620 | controller | WORKSPACE=/home/zuul/workspace
2025-10-13 13:08:52.977626 | controller | XDG_SESSION_CLASS=user
2025-10-13 13:08:52.977631 | controller | SELINUX_ROLE_REQUESTED=
2025-10-13 13:08:52.977636 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-13 13:08:52.977641 | controller | USER=zuul
2025-10-13 13:08:52.977647 | controller | ZUUL_VOTING=True
2025-10-13 13:08:52.977652 | controller | BUILD_TIMEOUT=1800000
2025-10-13 13:08:52.977657 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-13 13:08:52.977662 | controller | SHLVL=1
2025-10-13 13:08:52.977667 | controller | ZUUL_PATCHSET=d06510c33c77f91e7f781656796544e000bd377e
2025-10-13 13:08:52.977673 | controller | XDG_SESSION_ID=1
2025-10-13 13:08:52.977678 | controller | ZUUL_BRANCH=main
2025-10-13 13:08:52.977683 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-13 13:08:52.977688 | controller | SSH_CLIENT=192.168.26.12 57126 22
2025-10-13 13:08:52.977695 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-13 13:08:52.977700 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-13 13:08:52.977705 | controller | which_declare=declare -f
2025-10-13 13:08:52.977711 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-13 13:08:52.977716 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-13 13:08:52.977721 | controller | ZUUL_CHANGE=3402
2025-10-13 13:08:52.977726 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-13 13:08:52.977731 | controller | ZUUL_UUID=9a72e896a43b4c138c7dc4bf0bd9e61f
2025-10-13 13:08:52.977737 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-13 13:08:52.977742 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-13 13:08:52.977747 | controller | }
2025-10-13 13:08:53.287131 | controller | ok: Runtime: 0:00:00.005654
2025-10-13 13:08:53.320041 | 
2025-10-13 13:08:53.320156 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-13 13:08:53.376701 | controller | skipping: Conditional result was False
2025-10-13 13:08:53.382585 | 
2025-10-13 13:08:53.382669 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-13 13:08:54.246039 | controller | skipping: Conditional result was False
2025-10-13 13:08:54.252253 | 
2025-10-13 13:08:54.252346 | TASK [Ensure legacy workspace directory]
2025-10-13 13:08:54.581567 | controller | changed
2025-10-13 13:08:54.676600 | 
2025-10-13 13:08:54.676723 | PLAY RECAP
2025-10-13 13:08:54.676778 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-13 13:08:54.676803 | 
2025-10-13 13:08:55.240936 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-13 13:08:55.241719 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-13 13:08:57.614461 | 
2025-10-13 13:08:57.614591 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-10-13 13:08:57.732579 | 
2025-10-13 13:08:57.732713 | TASK [Create zuul-output directory]
2025-10-13 13:08:58.790888 | controller | changed
2025-10-13 13:08:58.805723 | 
2025-10-13 13:08:58.805830 | TASK [Slurp Zuul inventory test]
2025-10-13 13:09:00.322429 | controller -> localhost | ok
2025-10-13 13:09:00.331268 | 
2025-10-13 13:09:00.331403 | TASK [Save zuul inventory]
2025-10-13 13:09:02.090044 | controller | changed
2025-10-13 13:09:02.095153 | 
2025-10-13 13:09:02.103010 | TASK [Save zuul vars without the change_message]
2025-10-13 13:09:03.241302 | controller | changed
2025-10-13 13:09:03.318165 | 
2025-10-13 13:09:03.318254 | PLAY RECAP
2025-10-13 13:09:03.318299 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-13 13:09:03.318337 | 
2025-10-13 13:09:03.714424 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-13 13:09:03.715182 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-13 13:09:06.772162 | 
2025-10-13 13:09:06.772286 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-10-13 13:09:06.882859 | 
2025-10-13 13:09:06.883014 | TASK [Read group_vars]
2025-10-13 13:09:06.938033 | controller | ok
2025-10-13 13:09:07.042550 | 
2025-10-13 13:09:07.042689 | TASK [cifmw_helpers : Check directory is available /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars]
2025-10-13 13:09:07.547782 | controller | ok
2025-10-13 13:09:07.569087 | 
2025-10-13 13:09:07.569178 | TASK [cifmw_helpers : List available files]
2025-10-13 13:09:08.288215 | controller | skipping: Conditional result was False
2025-10-13 13:09:08.294560 | 
2025-10-13 13:09:08.294648 | LOOP [cifmw_helpers : Read vars]
2025-10-13 13:09:08.395189 | 
2025-10-13 13:09:08.395354 | LOOP [cifmw_helpers : Call task to parse all files as fact]
2025-10-13 13:09:08.466838 | 
2025-10-13 13:09:08.467009 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-10-13 13:09:08.536992 | controller | ok
2025-10-13 13:09:08.628274 | 
2025-10-13 13:09:08.628403 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-13 13:09:08.733104 | controller | skipping: Conditional result was False
2025-10-13 13:09:08.739142 | 
2025-10-13 13:09:08.739234 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-13 13:09:09.536519 | controller | ok
2025-10-13 13:09:09.556228 | 
2025-10-13 13:09:09.556320 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-13 13:09:10.218406 | controller | ok
2025-10-13 13:09:10.248431 | 
2025-10-13 13:09:10.248531 | TASK [Prepare workspace]
2025-10-13 13:09:10.333494 | controller | ok
2025-10-13 13:09:10.403258 | 
2025-10-13 13:09:10.403372 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-13 13:09:11.031248 | controller | ok
2025-10-13 13:09:11.049971 | 
2025-10-13 13:09:11.050082 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-13 13:09:17.701132 | controller | Output suppressed because no_log was given
2025-10-13 13:09:17.721139 | 
2025-10-13 13:09:17.721252 | LOOP [Create zuul-output directory]
2025-10-13 13:09:18.021763 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-10-13 13:09:18.022058 | 
2025-10-13 13:09:18.204770 | controller | ok: "/home/zuul/zuul-output/logs"
2025-10-13 13:09:18.213425 | 
2025-10-13 13:09:18.213512 | TASK [Install required packages]
2025-10-13 13:10:13.663861 | controller | changed
2025-10-13 13:10:13.669413 | 
2025-10-13 13:10:13.669491 | TASK [Install venv]
2025-10-13 13:11:21.732176 | controller | changed
2025-10-13 13:11:21.757802 | 
2025-10-13 13:11:21.757870 | PLAY RECAP
2025-10-13 13:11:21.757945 | controller | ok: 8 changed: 4 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0
2025-10-13 13:11:21.757975 | 
2025-10-13 13:11:21.842919 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-13 13:11:21.843870 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-13 13:11:22.391323 | 
2025-10-13 13:11:22.391438 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-10-13 13:11:22.411434 | 
2025-10-13 13:11:22.411510 | TASK [Gather required facts]
2025-10-13 13:11:22.902625 | controller | ok
2025-10-13 13:11:22.907956 | 
2025-10-13 13:11:22.908032 | TASK [Load environment var if instructed to]
2025-10-13 13:11:22.931850 | controller | skipping: Conditional result was False
2025-10-13 13:11:22.936926 | 
2025-10-13 13:11:22.936991 | TASK [Ensure group_vars dir exists]
2025-10-13 13:11:23.259857 | controller | ok
2025-10-13 13:11:23.266007 | 
2025-10-13 13:11:23.266086 | TASK [Run molecule]
2025-10-13 13:11:24.210031 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-10-13 13:11:24.280147 | controller | WARNING  Driver podman does not provide a schema.
2025-10-13 13:11:24.282819 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-13 13:11:42.471235 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.471676 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.472144 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.472598 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.473076 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+5ba44b0c was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.0.0+5ba44b0c (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.473528 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.473989 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.474419 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.474875 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.475303 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.475779 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.476217 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.476657 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.477093 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.477535 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-13 13:11:42.488203 | controller | INFO     Running default > dependency
2025-10-13 13:11:42.489087 | controller | WARNING  Skipping, missing the requirements file.
2025-10-13 13:11:42.489817 | controller | WARNING  Skipping, missing the requirements file.
2025-10-13 13:11:42.498806 | controller | INFO     Running default > create
2025-10-13 13:11:42.726062 | controller | INFO     Sanity checks: 'podman'
2025-10-13 13:11:43.625409 | controller |
2025-10-13 13:11:43.625517 | controller | PLAY [Create] ******************************************************************
2025-10-13 13:11:43.625613 | controller |
2025-10-13 13:11:43.625712 | controller | TASK [Get podman executable path] **********************************************
2025-10-13 13:11:43.625828 | controller | Monday 13 October 2025  13:11:43 +0000 (0:00:00.014)       0:00:00.014 ********
2025-10-13 13:11:43.915764 | controller | ok: [localhost]
2025-10-13 13:11:43.915840 | controller |
2025-10-13 13:11:43.915948 | controller | TASK [Register podman executable path] *****************************************
2025-10-13 13:11:43.916074 | controller | Monday 13 October 2025  13:11:43 +0000 (0:00:00.290)       0:00:00.305 ********
2025-10-13 13:11:43.954853 | controller | ok: [localhost]
2025-10-13 13:11:43.954915 | controller |
2025-10-13 13:11:43.955030 | controller | TASK [Get passwd entries for USER env] *****************************************
2025-10-13 13:11:43.955132 | controller | Monday 13 October 2025  13:11:43 +0000 (0:00:00.039)       0:00:00.344 ********
2025-10-13 13:11:44.239978 | controller | ok: [localhost]
2025-10-13 13:11:44.240024 | controller |
2025-10-13 13:11:44.240128 | controller | TASK [Get shell async_dir] *****************************************************
2025-10-13 13:11:44.240230 | controller | Monday 13 October 2025  13:11:44 +0000 (0:00:00.285)       0:00:00.629 ********
2025-10-13 13:11:44.280755 | controller | ok: [localhost]
2025-10-13 13:11:44.280811 | controller |
2025-10-13 13:11:44.280921 | controller | TASK [Set async_dir for HOME env] **********************************************
2025-10-13 13:11:44.281018 | controller | Monday 13 October 2025  13:11:44 +0000 (0:00:00.040)       0:00:00.670 ********
2025-10-13 13:11:44.313351 | controller | skipping: [localhost]
2025-10-13 13:11:44.313421 | controller |
2025-10-13 13:11:44.313552 | controller | TASK [Log into a container registry] *******************************************
2025-10-13 13:11:44.313706 | controller | Monday 13 October 2025  13:11:44 +0000 (0:00:00.032)       0:00:00.702 ********
2025-10-13 13:11:44.355448 | controller | skipping: [localhost] => (item="instance registry username: None specified")
2025-10-13 13:11:44.355515 | controller | skipping: [localhost]
2025-10-13 13:11:44.355667 | controller |
2025-10-13 13:11:44.355719 | controller | TASK [Check presence of custom Dockerfiles] ************************************
2025-10-13 13:11:44.355893 | controller | Monday 13 October 2025  13:11:44 +0000 (0:00:00.042)       0:00:00.745 ********
2025-10-13 13:11:44.649409 | controller | ok: [localhost] => (item=Dockerfile: None specified)
2025-10-13 13:11:44.649493 | controller |
2025-10-13 13:11:44.649606 | controller | TASK [Create Dockerfiles from image names] *************************************
2025-10-13 13:11:44.649705 | controller | Monday 13 October 2025  13:11:44 +0000 (0:00:00.293)       0:00:01.038 ********
2025-10-13 13:11:44.689823 | controller | skipping: [localhost] => (item="Dockerfile: None specified; Image: registry.access.redhat.com/ubi9/ubi:latest")
2025-10-13 13:11:44.689917 | controller | skipping: [localhost]
2025-10-13 13:11:44.690013 | controller |
2025-10-13 13:11:44.690118 | controller | TASK [Discover local Podman images] ********************************************
2025-10-13 13:11:44.690220 | controller | Monday 13 October 2025  13:11:44 +0000 (0:00:00.040)       0:00:01.079 ********
2025-10-13 13:11:45.570405 | controller | ok: [localhost] => (item=instance)
2025-10-13 13:11:45.570503 | controller |
2025-10-13 13:11:45.570615 | controller | TASK [Build an Ansible compatible image] ***************************************
2025-10-13 13:11:45.570731 | controller | Monday 13 October 2025  13:11:45 +0000 (0:00:00.880)       0:00:01.959 ********
2025-10-13 13:11:45.611015 | controller | skipping: [localhost] => (item=registry.access.redhat.com/ubi9/ubi:latest)
2025-10-13 13:11:45.611113 | controller | skipping: [localhost]
2025-10-13 13:11:45.611213 | controller |
2025-10-13 13:11:45.611321 | controller | TASK [Determine the CMD directives] ********************************************
2025-10-13 13:11:45.611430 | controller | Monday 13 October 2025  13:11:45 +0000 (0:00:00.040)       0:00:02.000 ********
2025-10-13 13:11:45.658851 | controller | ok: [localhost] => (item="instance command: sleep infinity")
2025-10-13 13:11:45.658926 | controller |
2025-10-13 13:11:45.659033 | controller | TASK [Remove possible pre-existing containers] *********************************
2025-10-13 13:11:45.659137 | controller | Monday 13 October 2025  13:11:45 +0000 (0:00:00.047)       0:00:02.048 ********
2025-10-13 13:11:45.890658 | controller | changed: [localhost]
2025-10-13 13:11:45.890775 | controller |
2025-10-13 13:11:45.890877 | controller | TASK [Discover local podman networks] ******************************************
2025-10-13 13:11:45.890980 | controller | Monday 13 October 2025  13:11:45 +0000 (0:00:00.231)       0:00:02.280 ********
2025-10-13 13:11:45.934502 | controller | skipping: [localhost] => (item=instance: None specified)
2025-10-13 13:11:45.934611 | controller | skipping: [localhost]
2025-10-13 13:11:45.934739 | controller |
2025-10-13 13:11:45.934873 | controller | TASK [Create podman network dedicated to this scenario] ************************
2025-10-13 13:11:45.934992 | controller | Monday 13 October 2025  13:11:45 +0000 (0:00:00.043)       0:00:02.323 ********
2025-10-13 13:11:45.969235 | controller | skipping: [localhost]
2025-10-13 13:11:45.969321 | controller |
2025-10-13 13:11:45.969426 | controller | TASK [Create molecule instance(s)] *********************************************
2025-10-13 13:11:45.969557 | controller | Monday 13 October 2025  13:11:45 +0000 (0:00:00.034)       0:00:02.358 ********
2025-10-13 13:11:46.289763 | controller | changed: [localhost] => (item=instance)
2025-10-13 13:11:46.289850 | controller |
2025-10-13 13:11:46.289968 | controller | TASK [Wait for instance(s) creation to complete] *******************************
2025-10-13 13:11:46.290075 | controller | Monday 13 October 2025  13:11:46 +0000 (0:00:00.320)       0:00:02.679 ********
2025-10-13 13:11:51.749198 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) creation to complete (300 retries left).
2025-10-13 13:11:51.749269 | controller | changed: [localhost] => (item=instance)
2025-10-13 13:11:51.749380 | controller |
2025-10-13 13:11:51.749498 | controller | PLAY RECAP *********************************************************************
2025-10-13 13:11:51.749616 | controller | localhost                  : ok=10   changed=3    unreachable=0    failed=0    skipped=6    rescued=0    ignored=0
2025-10-13 13:11:51.749725 | controller |
2025-10-13 13:11:51.749823 | controller | Monday 13 October 2025  13:11:51 +0000 (0:00:05.459)       0:00:08.138 ********
2025-10-13 13:11:51.749925 | controller | ===============================================================================
2025-10-13 13:11:51.750027 | controller | Wait for instance(s) creation to complete ------------------------------- 5.46s
2025-10-13 13:11:51.750126 | controller | Discover local Podman images -------------------------------------------- 0.88s
2025-10-13 13:11:51.750250 | controller | Create molecule instance(s) --------------------------------------------- 0.32s
2025-10-13 13:11:51.750340 | controller | Check presence of custom Dockerfiles ------------------------------------ 0.29s
2025-10-13 13:11:51.750442 | controller | Get podman executable path ---------------------------------------------- 0.29s
2025-10-13 13:11:51.750567 | controller | Get passwd entries for USER env ----------------------------------------- 0.29s
2025-10-13 13:11:51.750666 | controller | Remove possible pre-existing containers --------------------------------- 0.23s
2025-10-13 13:11:51.750777 | controller | Determine the CMD directives -------------------------------------------- 0.05s
2025-10-13 13:11:51.750877 | controller | Discover local podman networks ------------------------------------------ 0.04s
2025-10-13 13:11:51.750975 | controller | Log into a container registry ------------------------------------------- 0.04s
2025-10-13 13:11:51.751072 | controller | Get shell async_dir ----------------------------------------------------- 0.04s
2025-10-13 13:11:51.751170 | controller | Build an Ansible compatible image --------------------------------------- 0.04s
2025-10-13 13:11:51.751266 | controller | Create Dockerfiles from image names ------------------------------------- 0.04s
2025-10-13 13:11:51.751364 | controller | Register podman executable path ----------------------------------------- 0.04s
2025-10-13 13:11:51.751459 | controller | Create podman network dedicated to this scenario ------------------------ 0.03s
2025-10-13 13:11:51.751587 | controller | Set async_dir for HOME env ---------------------------------------------- 0.03s
2025-10-13 13:11:51.806095 | controller | INFO     Running default > prepare
2025-10-13 13:11:52.223210 | controller |
2025-10-13 13:11:52.223289 | controller | PLAY [Prepare] *****************************************************************
2025-10-13 13:11:52.223385 | controller |
2025-10-13 13:11:52.223530 | controller | TASK [Gathering Facts] *********************************************************
2025-10-13 13:11:52.223613 | controller | Monday 13 October 2025  13:11:52 +0000 (0:00:00.011)       0:00:00.011 ********
2025-10-13 13:11:53.264659 | controller | ok: [instance]
2025-10-13 13:11:53.265034 | controller |
2025-10-13 13:11:59.809995 | controller | TASK [Install Python pip and dependencies using dnf] ***************************
2025-10-13 13:11:59.810025 | controller | Monday 13 October 2025  13:11:53 +0000 (0:00:01.041)       0:00:01.052 ********
2025-10-13 13:11:59.810037 | controller | changed: [instance]
2025-10-13 13:11:59.810120 | controller |
2025-10-13 13:11:59.810139 | controller | TASK [Install Python dependencies] *********************************************
2025-10-13 13:12:05.092296 | controller | Monday 13 October 2025  13:11:59 +0000 (0:00:06.545)       0:00:07.598 ********
2025-10-13 13:12:05.092335 | controller | changed: [instance]
2025-10-13 13:12:06.754645 | controller |
2025-10-13 13:12:06.754679 | controller | TASK [Create mock kubeconfig file] *********************************************
2025-10-13 13:12:06.754694 | controller | Monday 13 October 2025  13:12:05 +0000 (0:00:05.282)       0:00:12.880 ********
2025-10-13 13:12:06.754706 | controller | changed: [instance]
2025-10-13 13:12:08.167706 | controller |
2025-10-13 13:12:08.167742 | controller | TASK [Create mock kubeadmin password file] *************************************
2025-10-13 13:12:08.167751 | controller | Monday 13 October 2025  13:12:06 +0000 (0:00:01.662)       0:00:14.542 ********
2025-10-13 13:12:08.167761 | controller | changed: [instance]
2025-10-13 13:12:08.226656 | controller |
2025-10-13 13:12:08.226692 | controller | PLAY RECAP *********************************************************************
2025-10-13 13:12:08.226701 | controller | instance                   : ok=5    changed=4    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2025-10-13 13:12:08.226707 | controller |
2025-10-13 13:12:08.226713 | controller | Monday 13 October 2025  13:12:08 +0000 (0:00:01.412)       0:00:15.955 ********
2025-10-13 13:12:08.226718 | controller | ===============================================================================
2025-10-13 13:12:08.226724 | controller | Install Python pip and dependencies using dnf --------------------------- 6.55s
2025-10-13 13:12:08.226729 | controller | Install Python dependencies --------------------------------------------- 5.28s
2025-10-13 13:12:08.226734 | controller | Create mock kubeconfig file --------------------------------------------- 1.66s
2025-10-13 13:12:08.226740 | controller | Create mock kubeadmin password file ------------------------------------- 1.41s
2025-10-13 13:12:08.226745 | controller | Gathering Facts --------------------------------------------------------- 1.04s
2025-10-13 13:12:08.226756 | controller | INFO     Running default > converge
2025-10-13 13:12:08.678875 | controller |
2025-10-13 13:12:08.679070 | controller | PLAY [Converge] ****************************************************************
2025-10-13 13:12:08.679212 | controller |
2025-10-13 13:12:08.679356 | controller | TASK [Test that required variables are defined] ********************************
2025-10-13 13:12:08.679530 | controller | Monday 13 October 2025  13:12:08 +0000 (0:00:00.022)       0:00:00.022 ********
2025-10-13 13:12:08.706502 | controller | ok: [instance] => changed=false
2025-10-13 13:12:08.727408 | controller |   msg: Required variables are defined
2025-10-13 13:12:08.727432 | controller |
2025-10-13 13:12:08.727440 | controller | TASK [Display test information] ************************************************
2025-10-13 13:12:08.727446 | controller | Monday 13 October 2025  13:12:08 +0000 (0:00:00.027)       0:00:00.049 ********
2025-10-13 13:12:08.727455 | controller | ok: [instance] =>
2025-10-13 13:12:09.947372 | controller |   msg: 'Testing role cifmw_snr_nhc with kubeconfig: /tmp/kubeconfig and namespace: workload-availability'
2025-10-13 13:12:09.947409 | controller |
2025-10-13 13:12:09.947418 | controller | TASK [Test that Python kubernetes library is available] ************************
2025-10-13 13:12:09.947424 | controller | Monday 13 October 2025  13:12:08 +0000 (0:00:00.021)       0:00:00.070 ********
2025-10-13 13:12:09.947434 | controller | ok: [instance]
2025-10-13 13:12:09.968305 | controller |
2025-10-13 13:12:09.968328 | controller | TASK [Display kubernetes library test result] **********************************
2025-10-13 13:12:09.968336 | controller | Monday 13 October 2025  13:12:09 +0000 (0:00:01.219)       0:00:01.290 ********
2025-10-13 13:12:09.968345 | controller | ok: [instance] =>
2025-10-13 13:12:10.708262 | controller |   msg: Library available
2025-10-13 13:12:10.708294 | controller |
2025-10-13 13:12:10.708302 | controller | TASK [Test that mock kubeconfig exists] ****************************************
2025-10-13 13:12:10.708308 | controller | Monday 13 October 2025  13:12:09 +0000 (0:00:00.021)       0:00:01.311 ********
2025-10-13 13:12:10.708337 | controller | ok: [instance]
2025-10-13 13:12:10.708364 | controller |
2025-10-13 13:12:10.708529 | controller | TASK [Assert kubeconfig exists] ************************************************
2025-10-13 13:12:10.708637 | controller | Monday 13 October 2025  13:12:10 +0000 (0:00:00.739)       0:00:02.051 ********
2025-10-13 13:12:10.734572 | controller | ok: [instance] => changed=false
2025-10-13 13:12:10.734634 | controller |   msg: Kubeconfig file exists
2025-10-13 13:12:10.734649 | controller |
2025-10-13 13:12:10.734815 | controller | TASK [Test kubernetes.core.k8s module availability] ****************************
2025-10-13 13:12:12.297917 | controller | Monday 13 October 2025  13:12:10 +0000 (0:00:00.026)       0:00:02.078 ********
2025-10-13 13:12:12.297951 | controller | ok: [instance]
2025-10-13 13:12:12.320043 | controller |
2025-10-13 13:12:12.320070 | controller | TASK [Display k8s connection test result] **************************************
2025-10-13 13:12:12.320077 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:01.563)       0:00:03.641 ********
2025-10-13 13:12:12.320087 | controller | ok: [instance] =>
2025-10-13 13:12:12.386112 | controller |   msg: 'K8s connection test result: False'
2025-10-13 13:12:12.386141 | controller |
2025-10-13 13:12:12.386149 | controller | TASK [Include the cifmw_snr_nhc role] ******************************************
2025-10-13 13:12:12.386156 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.022)       0:00:03.663 ********
2025-10-13 13:12:12.386165 | controller |
2025-10-13 13:12:12.413386 | controller | TASK [cifmw_snr_nhc : Check if NodeHealthCheck exists and is active] ***********
2025-10-13 13:12:12.413414 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.066)       0:00:03.729 ********
2025-10-13 13:12:12.413425 | controller | skipping: [instance]
2025-10-13 13:12:12.440549 | controller |
2025-10-13 13:12:12.440581 | controller | TASK [cifmw_snr_nhc : Check for active SelfNodeRemediations] *******************
2025-10-13 13:12:12.440589 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.027)       0:00:03.756 ********
2025-10-13 13:12:12.440600 | controller | skipping: [instance]
2025-10-13 13:12:12.440633 | controller |
2025-10-13 13:12:12.440642 | controller | TASK [cifmw_snr_nhc : Display active remediations info] ************************
2025-10-13 13:12:12.440727 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.027)       0:00:03.784 ********
2025-10-13 13:12:12.467241 | controller | skipping: [instance]
2025-10-13 13:12:12.494214 | controller |
2025-10-13 13:12:12.494237 | controller | TASK [cifmw_snr_nhc : Disable NodeHealthCheck to stop active remediations] *****
2025-10-13 13:12:12.494245 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.026)       0:00:03.810 ********
2025-10-13 13:12:12.494255 | controller | skipping: [instance]
2025-10-13 13:12:12.521557 | controller |
2025-10-13 13:12:12.521591 | controller | TASK [cifmw_snr_nhc : Wait for active remediations to stop] ********************
2025-10-13 13:12:12.521601 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.026)       0:00:03.837 ********
2025-10-13 13:12:12.521613 | controller | skipping: [instance]
2025-10-13 13:12:12.522189 | controller |
2025-10-13 13:12:12.522222 | controller | TASK [cifmw_snr_nhc : Delete existing NodeHealthCheck resources] ***************
2025-10-13 13:12:12.546835 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.027)       0:00:03.865 ********
2025-10-13 13:12:12.546865 | controller | skipping: [instance]
2025-10-13 13:12:12.547005 | controller |
2025-10-13 13:12:12.547154 | controller | TASK [cifmw_snr_nhc : Check for blocking remediations when deletion fails] *****
2025-10-13 13:12:12.547311 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.025)       0:00:03.890 ********
2025-10-13 13:12:12.572432 | controller | skipping: [instance]
2025-10-13 13:12:12.572660 | controller |
2025-10-13 13:12:12.572837 | controller | TASK [cifmw_snr_nhc : Display blocking remediation details] ********************
2025-10-13 13:12:12.573002 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.025)       0:00:03.916 ********
2025-10-13 13:12:12.600851 | controller | skipping: [instance]
2025-10-13 13:12:12.601029 | controller |
2025-10-13 13:12:12.601196 | controller | TASK [cifmw_snr_nhc : Display warning if NodeHealthCheck deletion failed due to active remediation] ***
2025-10-13 13:12:12.601344 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.028)       0:00:03.944 ********
2025-10-13 13:12:12.625962 | controller | skipping: [instance]
2025-10-13 13:12:12.626182 | controller |
2025-10-13 13:12:12.626377 | controller | TASK [cifmw_snr_nhc : Skip NodeHealthCheck deletion retry if webhook blocks it] ***
2025-10-13 13:12:12.626558 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.025)       0:00:03.969 ********
2025-10-13 13:12:12.651589 | controller | skipping: [instance]
2025-10-13 13:12:12.651771 | controller |
2025-10-13 13:12:12.651916 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationConfig exists] ***************
2025-10-13 13:12:12.652058 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.025)       0:00:03.995 ********
2025-10-13 13:12:12.678248 | controller | skipping: [instance]
2025-10-13 13:12:12.678394 | controller |
2025-10-13 13:12:12.678572 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationConfig resources] *****
2025-10-13 13:12:12.678736 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.026)       0:00:04.022 ********
2025-10-13 13:12:12.705111 | controller | skipping: [instance]
2025-10-13 13:12:12.705283 | controller |
2025-10-13 13:12:12.705432 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationTemplate exists] *************
2025-10-13 13:12:12.705604 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.026)       0:00:04.048 ********
2025-10-13 13:12:12.731311 | controller | skipping: [instance]
2025-10-13 13:12:12.731653 | controller |
2025-10-13 13:12:12.731872 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationTemplate resources] ***
2025-10-13 13:12:12.732034 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.026)       0:00:04.075 ********
2025-10-13 13:12:12.757737 | controller | skipping: [instance]
2025-10-13 13:12:12.757909 | controller |
2025-10-13 13:12:12.758060 | controller | TASK [cifmw_snr_nhc : Check if Subscriptions exist] ****************************
2025-10-13 13:12:12.758202 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.026)       0:00:04.101 ********
2025-10-13 13:12:12.787160 | controller | skipping: [instance]
2025-10-13 13:12:12.787317 | controller |
2025-10-13 13:12:12.787482 | controller | TASK [cifmw_snr_nhc : Delete existing Subscriptions] ***************************
2025-10-13 13:12:12.787651 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.029)       0:00:04.131 ********
2025-10-13 13:12:12.818163 | controller | skipping: [instance] => (item=self-node-remediation-operator)
2025-10-13 13:12:12.818325 | controller | skipping: [instance] => (item=node-health-check-operator)
2025-10-13 13:12:12.818496 | controller | skipping: [instance]
2025-10-13 13:12:12.818657 | controller |
2025-10-13 13:12:12.818800 | controller | TASK [cifmw_snr_nhc : Check if OperatorGroup exists] ***************************
2025-10-13 13:12:12.818936 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.031)       0:00:04.162 ********
2025-10-13 13:12:12.853958 | controller | skipping: [instance]
2025-10-13 13:12:12.881824 | controller |
2025-10-13 13:12:12.881842 | controller | TASK [cifmw_snr_nhc : Delete existing OperatorGroup] ***************************
2025-10-13 13:12:12.881850 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.035)       0:00:04.197 ********
2025-10-13 13:12:12.881859 | controller | skipping: [instance]
2025-10-13 13:12:12.910069 | controller |
2025-10-13 13:12:12.910103 | controller | TASK [cifmw_snr_nhc : Delete the entire workload-availability namespace] *******
2025-10-13 13:12:12.910111 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.028)       0:00:04.225 ********
2025-10-13 13:12:12.910120 | controller | skipping: [instance]
2025-10-13 13:12:12.936594 | controller |
2025-10-13 13:12:12.936638 | controller | TASK [cifmw_snr_nhc : Wait for namespace deletion to complete] *****************
2025-10-13 13:12:12.936656 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.027)       0:00:04.253 ********
2025-10-13 13:12:12.936668 | controller | skipping: [instance]
2025-10-13 13:12:14.289062 | controller |
2025-10-13 13:12:14.289091 | controller | TASK [cifmw_snr_nhc : Create the workload-availability namespace] **************
2025-10-13 13:12:14.289099 | controller | Monday 13 October 2025  13:12:12 +0000 (0:00:00.026)       0:00:04.280 ********
2025-10-13 13:12:14.289109 | 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 0x7ff6a720f5e0>: Failed to establish a new connection: [Errno -2] Name or service not known'))
2025-10-13 13:12:14.290562 | controller | fatal: [instance]: FAILED! => changed=false
2025-10-13 13:12:14.293504 | controller |   module_stderr: |-
2025-10-13 13:12:14.293519 | controller |     Traceback (most recent call last):
2025-10-13 13:12:14.293528 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn
2025-10-13 13:12:14.293623 | controller |         conn = connection.create_connection(
2025-10-13 13:12:14.293633 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection
2025-10-13 13:12:14.293639 | controller |         for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):
2025-10-13 13:12:14.293645 | controller |       File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo
2025-10-13 13:12:14.293650 | controller |         for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
2025-10-13 13:12:14.293656 | controller |     socket.gaierror: [Errno -2] Name or service not known
2025-10-13 13:12:14.293661 | controller |
2025-10-13 13:12:14.293667 | controller |     During handling of the above exception, another exception occurred:
2025-10-13 13:12:14.293673 | controller |
2025-10-13 13:12:14.293678 | controller |     Traceback (most recent call last):
2025-10-13 13:12:14.293683 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen
2025-10-13 13:12:14.293688 | controller |         httplib_response = self._make_request(
2025-10-13 13:12:14.293694 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request
2025-10-13 13:12:14.293699 | controller |         self._validate_conn(conn)
2025-10-13 13:12:14.293705 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn
2025-10-13 13:12:14.293710 | controller |         conn.connect()
2025-10-13 13:12:14.293721 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect
2025-10-13 13:12:14.293727 | controller |         conn = self._new_conn()
2025-10-13 13:12:14.293732 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn
2025-10-13 13:12:14.293738 | controller |         raise NewConnectionError(
2025-10-13 13:12:14.293743 | controller |     urllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7ff6a720f5e0>: Failed to establish a new connection: [Errno -2] Name or service not known
2025-10-13 13:12:14.293749 | controller |
2025-10-13 13:12:14.293754 | controller |     During handling of the above exception, another exception occurred:
2025-10-13 13:12:14.293759 | controller |
2025-10-13 13:12:14.293765 | controller |     Traceback (most recent call last):
2025-10-13 13:12:14.293770 | controller |       File "/tmp/ansible-tmp-1760361132.9492443-28238-253021580486729/AnsiballZ_k8s.py", line 107, in <module>
2025-10-13 13:12:14.293776 | controller |         _ansiballz_main()
2025-10-13 13:12:14.293781 | controller |       File "/tmp/ansible-tmp-1760361132.9492443-28238-253021580486729/AnsiballZ_k8s.py", line 99, in _ansiballz_main
2025-10-13 13:12:14.293786 | controller |         invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)
2025-10-13 13:12:14.293792 | controller |       File "/tmp/ansible-tmp-1760361132.9492443-28238-253021580486729/AnsiballZ_k8s.py", line 47, in invoke_module
2025-10-13 13:12:14.293801 | controller |         runpy.run_module(mod_name='ansible_collections.kubernetes.core.plugins.modules.k8s', init_globals=dict(_module_fqn='ansible_collections.kubernetes.core.plugins.modules.k8s', _modlib_path=modlib_path),
2025-10-13 13:12:14.293876 | controller |       File "/usr/lib64/python3.9/runpy.py", line 225, in run_module
2025-10-13 13:12:14.293887 | controller |         return _run_module_code(code, init_globals, run_name, mod_spec)
2025-10-13 13:12:14.293984 | controller |       File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code
2025-10-13 13:12:14.294098 | controller |         _run_code(code, mod_globals, init_globals,
2025-10-13 13:12:14.294203 | controller |       File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code
2025-10-13 13:12:14.294312 | controller |         exec(code, run_globals)
2025-10-13 13:12:14.294431 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_zoyy4xzf/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in <module>
2025-10-13 13:12:14.294577 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_zoyy4xzf/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main
2025-10-13 13:12:14.294721 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_zoyy4xzf/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module
2025-10-13 13:12:14.294844 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_zoyy4xzf/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client
2025-10-13 13:12:14.294968 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_zoyy4xzf/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper
2025-10-13 13:12:14.295089 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_zoyy4xzf/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client
2025-10-13 13:12:14.295203 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__
2025-10-13 13:12:14.295311 | controller |         self.__discoverer = discoverer(self, cache_file)
2025-10-13 13:12:14.295426 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_zoyy4xzf/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__
2025-10-13 13:12:14.295562 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_zoyy4xzf/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__
2025-10-13 13:12:14.295703 | controller |       File "/tmp/ansible_kubernetes.core.k8s_payload_zoyy4xzf/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache
2025-10-13 13:12:14.295824 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info
2025-10-13 13:12:14.295948 | controller |         'kubernetes': self.client.request('get', '/version', serializer=just_json)
2025-10-13 13:12:14.296065 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner
2025-10-13 13:12:14.296174 | controller |         resp = func(self, *args, **kwargs)
2025-10-13 13:12:14.296287 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request
2025-10-13 13:12:14.296394 | controller |         api_response = self.client.call_api(
2025-10-13 13:12:14.296527 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api
2025-10-13 13:12:14.296664 | controller |         return self.__call_api(resource_path, method,
2025-10-13 13:12:14.296779 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api
2025-10-13 13:12:14.296888 | controller |         response_data = self.request(
2025-10-13 13:12:14.297001 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request
2025-10-13 13:12:14.297110 | controller |         return self.rest_client.GET(url,
2025-10-13 13:12:14.297223 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET
2025-10-13 13:12:14.297330 | controller |         return self.request("GET", url,
2025-10-13 13:12:14.297443 | controller |       File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request
2025-10-13 13:12:14.297585 | controller |         r = self.pool_manager.request(method, url,
2025-10-13 13:12:14.297726 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request
2025-10-13 13:12:14.297839 | controller |         return self.request_encode_url(
2025-10-13 13:12:14.297958 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url
2025-10-13 13:12:14.298069 | controller |         return self.urlopen(method, url, **extra_kw)
2025-10-13 13:12:14.298181 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen
2025-10-13 13:12:14.298290 | controller |         response = conn.urlopen(method, u.request_uri, **kw)
2025-10-13 13:12:14.298401 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen
2025-10-13 13:12:14.298635 | controller |         return self.urlopen(
2025-10-13 13:12:14.299038 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen
2025-10-13 13:12:14.299159 | controller |         return self.urlopen(
2025-10-13 13:12:14.299275 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen
2025-10-13 13:12:14.299385 | controller |         return self.urlopen(
2025-10-13 13:12:14.299513 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen
2025-10-13 13:12:14.299654 | controller |         retries = retries.increment(
2025-10-13 13:12:14.299755 | controller |       File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment
2025-10-13 13:12:14.299867 | controller |         raise MaxRetryError(_pool, url, error or ResponseError(cause))
2025-10-13 13:12:14.300001 | 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 0x7ff6a720f5e0>: Failed to establish a new connection: [Errno -2] Name or service not known'))
2025-10-13 13:12:14.300115 | controller |   module_stdout: ''
2025-10-13 13:12:14.300223 | controller |   msg: |-
2025-10-13 13:12:14.300330 | controller |     MODULE FAILURE
2025-10-13 13:12:14.300437 | controller |     See stdout/stderr for the exact error
2025-10-13 13:12:14.300562 | controller |   rc: 1
2025-10-13 13:12:14.300759 | controller |
2025-10-13 13:12:14.300867 | controller | TASK [Capture role execution error] ********************************************
2025-10-13 13:12:14.300982 | controller | Monday 13 October 2025  13:12:14 +0000 (0:00:01.360)       0:00:05.640 ********
2025-10-13 13:12:14.319242 | controller | ok: [instance]
2025-10-13 13:12:14.342227 | controller |
2025-10-13 13:12:14.342264 | controller | TASK [Display role execution error details] ************************************
2025-10-13 13:12:14.342274 | controller | Monday 13 October 2025  13:12:14 +0000 (0:00:00.022)       0:00:05.662 ********
2025-10-13 13:12:14.342287 | controller | ok: [instance] =>
2025-10-13 13:12:14.378578 | controller |   msg: |-
2025-10-13 13:12:14.378630 | controller |     Role execution failed with error:
2025-10-13 13:12:14.378641 | 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': 'fa163e50-75a6-49c4-7154-000000000166', 'finalized': True, 'squashed': False}, 'poll': 15, 'register': 'namespace_result', 'retries': 3, 'until': [], 'loop_with': None, 'uuid': 'fa163e50-75a6-49c4-7154-00000000008f', 'finalized': True, 'squashed': True}
2025-10-13 13:12:14.378663 | controller |
2025-10-13 13:12:14.378670 | controller | TASK [Analyze specific error patterns] *****************************************
2025-10-13 13:12:14.378678 | controller | Monday 13 October 2025  13:12:14 +0000 (0:00:00.022)       0:00:05.685 ********
2025-10-13 13:12:14.378689 | controller | ok: [instance] =>
2025-10-13 13:12:14.378718 | controller |   msg: |-
2025-10-13 13:12:14.378726 | controller |     Error analysis:
2025-10-13 13:12:14.378735 | controller |     - Connection error: False
2025-10-13 13:12:14.379195 | controller |     - Authentication error: False
2025-10-13 13:12:14.379226 | controller |     - API error: False
2025-10-13 13:12:14.398567 | controller |     - Timeout error: False
2025-10-13 13:12:14.398602 | controller |
2025-10-13 13:12:14.398629 | controller | TASK [Continue with test evaluation] *******************************************
2025-10-13 13:12:14.398638 | controller | Monday 13 October 2025  13:12:14 +0000 (0:00:00.036)       0:00:05.722 ********
2025-10-13 13:12:14.398650 | controller | ok: [instance] =>
2025-10-13 13:12:14.398678 | controller |   msg: Role failed as expected in test environment - this is normal
2025-10-13 13:12:14.398688 | controller |
2025-10-13 13:12:14.398879 | controller | TASK [Verify namespace exists] *************************************************
2025-10-13 13:12:15.716488 | controller | Monday 13 October 2025  13:12:14 +0000 (0:00:00.020)       0:00:05.742 ********
2025-10-13 13:12:15.716527 | controller | ok: [instance]
2025-10-13 13:12:15.735616 | controller |
2025-10-13 13:12:15.735649 | controller | TASK [Display namespace verification result] ***********************************
2025-10-13 13:12:15.735657 | controller | Monday 13 October 2025  13:12:15 +0000 (0:00:01.317)       0:00:07.059 ********
2025-10-13 13:12:15.735668 | controller | ok: [instance] =>
2025-10-13 13:12:15.735675 | controller |   msg: 'Namespace verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 13:12:15.735681 | 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 0x7f70b09167f0>: 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-1760361134.411233-28416-67048247209822/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361134.411233-28416-67048247209822/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361134.411233-28416-67048247209822/AnsiballZ_k8s.py",
2025-10-13 13:12:15.735697 | 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_j1t68zji/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_j1t68zji/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_j1t68zji/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 13:12:15.735710 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_j1t68zji/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_j1t68zji/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_j1t68zji/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_j1t68zji/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_j1t68zji/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:15.735716 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_j1t68zji/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 13:12:15.735721 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:15.735732 | 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 0x7f70b09167f0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 13:12:15.735741 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 13:12:15.735765 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f70b09167f0>: 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-1760361134.411233-28416-67048247209822/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361134.411233-28416-67048247209822/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361134.411233-28416-67048247209822/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 13:12:15.735775 | 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_j1t68zji/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_j1t68zji/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_j1t68zji/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_j1t68zji/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 13:12:15.735784 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_j1t68zji/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_j1t68zji/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_j1t68zji/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_j1t68zji/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_j1t68zji/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:15.735792 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 13:12:15.735817 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:15.735979 | 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 0x7f70b09167f0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 13:12:15.740768 | controller |
2025-10-13 13:12:16.997381 | controller | TASK [Test namespace creation idempotency] *************************************
2025-10-13 13:12:16.997413 | controller | Monday 13 October 2025  13:12:15 +0000 (0:00:00.024)       0:00:07.084 ********
2025-10-13 13:12:16.997425 | controller | ok: [instance]
2025-10-13 13:12:17.020383 | controller |
2025-10-13 13:12:17.020413 | controller | TASK [Assert expected behavior for namespace creation] *************************
2025-10-13 13:12:17.020421 | controller | Monday 13 October 2025  13:12:16 +0000 (0:00:01.256)       0:00:08.340 ********
2025-10-13 13:12:17.020431 | controller | ok: [instance] => changed=false
2025-10-13 13:12:18.339623 | controller |   msg: Namespace creation task behaves consistently
2025-10-13 13:12:18.339652 | controller |
2025-10-13 13:12:18.339659 | controller | TASK [Verify OperatorGroup exists] *********************************************
2025-10-13 13:12:18.339666 | controller | Monday 13 October 2025  13:12:17 +0000 (0:00:00.023)       0:00:08.363 ********
2025-10-13 13:12:18.339675 | controller | ok: [instance]
2025-10-13 13:12:18.354586 | controller |
2025-10-13 13:12:18.354620 | controller | TASK [Display OperatorGroup verification result] *******************************
2025-10-13 13:12:18.354628 | controller | Monday 13 October 2025  13:12:18 +0000 (0:00:01.319)       0:00:09.683 ********
2025-10-13 13:12:18.354638 | controller | ok: [instance] =>
2025-10-13 13:12:18.354662 | controller |   msg: 'OperatorGroup verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 13:12:18.355574 | 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 0x7f3c3df40400>: 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-1760361137.032746-28758-44618526131059/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361137.032746-28758-44618526131059/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361137.032746-28758-44618526131059/AnsiballZ_k8s.py",
2025-10-13 13:12:18.355625 | 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__44jz06a/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__44jz06a/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__44jz06a/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 13:12:18.355637 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload__44jz06a/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__44jz06a/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__44jz06a/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__44jz06a/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__44jz06a/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:18.355647 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload__44jz06a/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 13:12:18.355675 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:18.355685 | 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 0x7f3c3df40400>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 13:12:18.355691 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 13:12:18.355699 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f3c3df40400>: 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-1760361137.032746-28758-44618526131059/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361137.032746-28758-44618526131059/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361137.032746-28758-44618526131059/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 13:12:18.356287 | 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__44jz06a/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__44jz06a/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__44jz06a/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__44jz06a/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 13:12:18.356311 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload__44jz06a/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__44jz06a/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__44jz06a/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__44jz06a/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__44jz06a/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:18.356319 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 13:12:18.356328 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:18.360252 | 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 0x7f3c3df40400>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 13:12:18.360275 | controller |
2025-10-13 13:12:19.561117 | controller | TASK [Test OperatorGroup creation idempotency] *********************************
2025-10-13 13:12:19.561147 | controller | Monday 13 October 2025  13:12:18 +0000 (0:00:00.021)       0:00:09.704 ********
2025-10-13 13:12:19.561159 | controller | ok: [instance]
2025-10-13 13:12:19.561411 | controller |
2025-10-13 13:12:19.584499 | controller | TASK [Assert expected behavior for OperatorGroup creation] *********************
2025-10-13 13:12:19.584519 | controller | Monday 13 October 2025  13:12:19 +0000 (0:00:01.200)       0:00:10.904 ********
2025-10-13 13:12:19.584529 | controller | ok: [instance] => changed=false
2025-10-13 13:12:20.741586 | controller |   msg: OperatorGroup creation task behaves consistently
2025-10-13 13:12:20.741631 | controller |
2025-10-13 13:12:20.741639 | controller | TASK [Verify SNR Subscription exists] ******************************************
2025-10-13 13:12:20.741645 | controller | Monday 13 October 2025  13:12:19 +0000 (0:00:00.023)       0:00:10.928 ********
2025-10-13 13:12:20.741655 | controller | ok: [instance]
2025-10-13 13:12:20.761712 | controller |
2025-10-13 13:12:20.761740 | controller | TASK [Display SNR Subscription verification result] ****************************
2025-10-13 13:12:20.761748 | controller | Monday 13 October 2025  13:12:20 +0000 (0:00:01.157)       0:00:12.085 ********
2025-10-13 13:12:20.761759 | controller | ok: [instance] =>
2025-10-13 13:12:20.761766 | controller |   msg: 'SNR Subscription verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 13:12:20.761773 | 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 0x7f7d901ef040>: 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-1760361139.597257-29102-199575572304718/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361139.597257-29102-199575572304718/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361139.597257-29102-199575572304718/AnsiballZ_k8s.py",
2025-10-13 13:12:20.761779 | 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_gmurczj5/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_gmurczj5/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_gmurczj5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 13:12:20.761791 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_gmurczj5/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_gmurczj5/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_gmurczj5/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_gmurczj5/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_gmurczj5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:20.761797 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_gmurczj5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 13:12:20.761808 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:20.761813 | 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 0x7f7d901ef040>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 13:12:20.761827 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 13:12:20.761835 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f7d901ef040>: 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-1760361139.597257-29102-199575572304718/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361139.597257-29102-199575572304718/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361139.597257-29102-199575572304718/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 13:12:20.761841 | 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_gmurczj5/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_gmurczj5/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_gmurczj5/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_gmurczj5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 13:12:20.761846 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_gmurczj5/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_gmurczj5/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_gmurczj5/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_gmurczj5/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_gmurczj5/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:20.761859 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 13:12:20.767580 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:20.767633 | 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 0x7f7d901ef040>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 13:12:20.767649 | controller |
2025-10-13 13:12:20.767726 | controller | TASK [Test SNR Subscription creation idempotency] ******************************
2025-10-13 13:12:20.767752 | controller | Monday 13 October 2025  13:12:20 +0000 (0:00:00.026)       0:00:12.111 ********
2025-10-13 13:12:21.872540 | controller | ok: [instance]
2025-10-13 13:12:21.872723 | controller |
2025-10-13 13:12:21.872741 | controller | TASK [Assert expected behavior for SNR Subscription creation] ******************
2025-10-13 13:12:21.872750 | controller | Monday 13 October 2025  13:12:21 +0000 (0:00:01.104)       0:00:13.216 ********
2025-10-13 13:12:21.894542 | controller | ok: [instance] => changed=false
2025-10-13 13:12:21.894593 | controller |   msg: SNR Subscription creation task behaves consistently
2025-10-13 13:12:21.894986 | controller |
2025-10-13 13:12:23.205166 | controller | TASK [Verify SNR deployment status] ********************************************
2025-10-13 13:12:23.205196 | controller | Monday 13 October 2025  13:12:21 +0000 (0:00:00.022)       0:00:13.238 ********
2025-10-13 13:12:23.205207 | controller | ok: [instance]
2025-10-13 13:12:23.222606 | controller |
2025-10-13 13:12:23.222640 | controller | TASK [Display SNR deployment verification result] ******************************
2025-10-13 13:12:23.222649 | controller | Monday 13 October 2025  13:12:23 +0000 (0:00:01.310)       0:00:14.548 ********
2025-10-13 13:12:23.222660 | controller | ok: [instance] =>
2025-10-13 13:12:23.222687 | controller |   msg: 'SNR deployment verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 13:12:23.222695 | 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 0x7fcfcdf93a90>: 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-1760361141.9065273-29447-41026018933457/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361141.9065273-29447-41026018933457/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361141.9065273-29447-41026018933457/AnsiballZ_k8s_info.py",
2025-10-13 13:12:23.222707 | 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_5qz0w_kb/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_5qz0w_kb/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_5qz0w_kb/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-13 13:12:23.222717 | controller |     line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_5qz0w_kb/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_5qz0w_kb/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_5qz0w_kb/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_5qz0w_kb/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-13 13:12:23.222741 | controller |     45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_5qz0w_kb/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 13:12:23.223516 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:23.223533 | 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 0x7fcfcdf93a90>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 13:12:23.223542 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 13:12:23.223548 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7fcfcdf93a90>: 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-1760361141.9065273-29447-41026018933457/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361141.9065273-29447-41026018933457/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361141.9065273-29447-41026018933457/AnsiballZ_k8s_info.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s_info\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py",
2025-10-13 13:12:23.223558 | 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_5qz0w_kb/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_5qz0w_kb/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_5qz0w_kb/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_5qz0w_kb/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-13 13:12:23.223583 | controller |     line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_5qz0w_kb/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_5qz0w_kb/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_5qz0w_kb/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_5qz0w_kb/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-13 13:12:23.223987 | controller |     92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 13:12:23.228407 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:23.228434 | 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 0x7fcfcdf93a90>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 13:12:23.228446 | controller |
2025-10-13 13:12:23.248166 | controller | TASK [Test deployment verification behavior] ***********************************
2025-10-13 13:12:23.248191 | controller | Monday 13 October 2025  13:12:23 +0000 (0:00:00.023)       0:00:14.572 ********
2025-10-13 13:12:23.248204 | controller | ok: [instance] =>
2025-10-13 13:12:23.270514 | controller |   msg: Testing deployment verification logic - expected to fail in mock environment
2025-10-13 13:12:23.270531 | controller |
2025-10-13 13:12:23.270538 | controller | TASK [Assert SNR deployment verification behaves as expected] ******************
2025-10-13 13:12:23.270544 | controller | Monday 13 October 2025  13:12:23 +0000 (0:00:00.019)       0:00:14.591 ********
2025-10-13 13:12:23.270553 | controller | ok: [instance] => changed=false
2025-10-13 13:12:23.270728 | controller |   msg: SNR deployment verification logic behaves as expected
2025-10-13 13:12:23.270873 | controller |
2025-10-13 13:12:23.271018 | controller | TASK [Verify NHC Subscription exists] ******************************************
2025-10-13 13:12:23.271163 | controller | Monday 13 October 2025  13:12:23 +0000 (0:00:00.022)       0:00:14.614 ********
2025-10-13 13:12:24.494553 | controller | ok: [instance]
2025-10-13 13:12:24.494875 | controller |
2025-10-13 13:12:24.494890 | controller | TASK [Display NHC Subscription verification result] ****************************
2025-10-13 13:12:24.510512 | controller | Monday 13 October 2025  13:12:24 +0000 (0:00:01.223)       0:00:15.838 ********
2025-10-13 13:12:24.510536 | controller | ok: [instance] =>
2025-10-13 13:12:24.511679 | controller |   msg: 'NHC Subscription verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 13:12:24.511711 | 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 0x7f6b3e523550>: 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-1760361143.2838197-29624-35178027971131/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361143.2838197-29624-35178027971131/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361143.2838197-29624-35178027971131/AnsiballZ_k8s.py",
2025-10-13 13:12:24.511719 | 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_yq9qieh6/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_yq9qieh6/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_yq9qieh6/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 13:12:24.511728 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_yq9qieh6/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_yq9qieh6/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_yq9qieh6/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_yq9qieh6/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_yq9qieh6/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:24.511737 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_yq9qieh6/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 13:12:24.511743 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:24.511755 | 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 0x7f6b3e523550>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 13:12:24.511763 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 13:12:24.511790 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f6b3e523550>: 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-1760361143.2838197-29624-35178027971131/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361143.2838197-29624-35178027971131/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361143.2838197-29624-35178027971131/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 13:12:24.512336 | 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_yq9qieh6/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_yq9qieh6/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_yq9qieh6/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_yq9qieh6/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 13:12:24.512360 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_yq9qieh6/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_yq9qieh6/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_yq9qieh6/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_yq9qieh6/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_yq9qieh6/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:24.512370 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 13:12:24.512379 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:24.517388 | 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 0x7f6b3e523550>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 13:12:24.517410 | controller |
2025-10-13 13:12:25.620287 | controller | TASK [Test NHC Subscription creation idempotency] ******************************
2025-10-13 13:12:25.620319 | controller | Monday 13 October 2025  13:12:24 +0000 (0:00:00.023)       0:00:15.861 ********
2025-10-13 13:12:25.620330 | controller | ok: [instance]
2025-10-13 13:12:25.644158 | controller |
2025-10-13 13:12:25.644187 | controller | TASK [Assert expected behavior for NHC Subscription creation] ******************
2025-10-13 13:12:25.644195 | controller | Monday 13 October 2025  13:12:25 +0000 (0:00:01.102)       0:00:16.963 ********
2025-10-13 13:12:25.644205 | controller | ok: [instance] => changed=false
2025-10-13 13:12:26.786626 | controller |   msg: NHC Subscription creation task behaves consistently
2025-10-13 13:12:26.786658 | controller |
2025-10-13 13:12:26.786665 | controller | TASK [Verify CSV status] *******************************************************
2025-10-13 13:12:26.786672 | controller | Monday 13 October 2025  13:12:25 +0000 (0:00:00.024)       0:00:16.987 ********
2025-10-13 13:12:26.786681 | controller | ok: [instance]
2025-10-13 13:12:26.805030 | controller |
2025-10-13 13:12:26.805055 | controller | TASK [Display CSV verification result] *****************************************
2025-10-13 13:12:26.805067 | controller | Monday 13 October 2025  13:12:26 +0000 (0:00:01.142)       0:00:18.130 ********
2025-10-13 13:12:26.805083 | controller | ok: [instance] =>
2025-10-13 13:12:26.805091 | controller |   msg: 'CSV verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 13:12:26.805098 | 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 0x7f3669d757c0>: 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-1760361145.657044-29963-55073924671663/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361145.657044-29963-55073924671663/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361145.657044-29963-55073924671663/AnsiballZ_k8s_info.py",
2025-10-13 13:12:26.805103 | 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_likxksa8/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_likxksa8/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_likxksa8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-13 13:12:26.805116 | controller |     line 352, in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_likxksa8/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_likxksa8/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_likxksa8/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_likxksa8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-13 13:12:26.805125 | controller |     45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_likxksa8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 13:12:26.805130 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:26.805136 | 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 0x7f3669d757c0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 13:12:26.805146 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 13:12:26.805154 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f3669d757c0>: 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-1760361145.657044-29963-55073924671663/AnsiballZ_k8s_info.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361145.657044-29963-55073924671663/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361145.657044-29963-55073924671663/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", line
2025-10-13 13:12:26.805159 | controller |     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_likxksa8/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_likxksa8/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_likxksa8/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_likxksa8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py",
2025-10-13 13:12:26.805167 | controller |     line 246, in wrapper\n  File "/tmp/ansible_kubernetes.core.k8s_info_payload_likxksa8/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_likxksa8/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_likxksa8/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_likxksa8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line
2025-10-13 13:12:26.805175 | controller |     92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 13:12:26.809945 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:26.809967 | 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 0x7f3669d757c0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 13:12:26.809977 | controller |
2025-10-13 13:12:26.829285 | controller | TASK [Test CSV verification behavior] ******************************************
2025-10-13 13:12:26.829302 | controller | Monday 13 October 2025  13:12:26 +0000 (0:00:00.023)       0:00:18.153 ********
2025-10-13 13:12:26.829312 | controller | ok: [instance] =>
2025-10-13 13:12:26.851176 | controller |   msg: Testing CSV verification logic - expected to fail in mock environment
2025-10-13 13:12:26.851196 | controller |
2025-10-13 13:12:26.851204 | controller | TASK [Assert CSV verification behaves as expected] *****************************
2025-10-13 13:12:26.851209 | controller | Monday 13 October 2025  13:12:26 +0000 (0:00:00.019)       0:00:18.172 ********
2025-10-13 13:12:26.851218 | controller | ok: [instance] => changed=false
2025-10-13 13:12:27.935141 | controller |   msg: CSV verification logic behaves as expected
2025-10-13 13:12:27.935173 | controller |
2025-10-13 13:12:27.935181 | controller | TASK [Verify NHC CR exists] ****************************************************
2025-10-13 13:12:27.935187 | controller | Monday 13 October 2025  13:12:26 +0000 (0:00:00.021)       0:00:18.194 ********
2025-10-13 13:12:27.935197 | controller | ok: [instance]
2025-10-13 13:12:27.953571 | controller |
2025-10-13 13:12:27.953612 | controller | TASK [Display NHC CR verification result] **************************************
2025-10-13 13:12:27.953620 | controller | Monday 13 October 2025  13:12:27 +0000 (0:00:01.083)       0:00:19.278 ********
2025-10-13 13:12:27.953630 | controller | ok: [instance] =>
2025-10-13 13:12:27.954569 | controller |   msg: 'NHC CR verification result: {''failed'': False, ''module_stdout'': '''', ''module_stderr'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File
2025-10-13 13:12:27.954633 | 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 0x7f62255eccd0>: 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-1760361146.8635101-30138-229341118808595/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361146.8635101-30138-229341118808595/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361146.8635101-30138-229341118808595/AnsiballZ_k8s.py",
2025-10-13 13:12:27.954644 | 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_m59wvtkq/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_m59wvtkq/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_m59wvtkq/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py",
2025-10-13 13:12:27.954657 | controller |     line 88, in run_module\n  File "/tmp/ansible_kubernetes.core.k8s_payload_m59wvtkq/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_m59wvtkq/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_m59wvtkq/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_m59wvtkq/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_m59wvtkq/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:27.954667 | controller |     line 45, in __init__\n  File "/tmp/ansible_kubernetes.core.k8s_payload_m59wvtkq/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File
2025-10-13 13:12:27.954673 | controller |     "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:27.954685 | 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 0x7f62255eccd0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''exception'': ''Traceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn\n    conn = connection.create_connection(\n  File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py",
2025-10-13 13:12:27.954716 | controller |     line 73, in create_connection\n    for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):\n  File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo\n    for res in _socket.getaddrinfo(host, port, family, type, proto, flags):\nsocket.gaierror: [Errno -2] Name or service not known\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen\n    httplib_response = self._make_request(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request\n    self._validate_conn(conn)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn\n    conn.connect()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect\n    conn = self._new_conn()\n  File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn\n    raise
2025-10-13 13:12:27.954726 | controller |     NewConnectionError(\nurllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f62255eccd0>: 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-1760361146.8635101-30138-229341118808595/AnsiballZ_k8s.py", line 107, in <module>\n    _ansiballz_main()\n  File "/tmp/ansible-tmp-1760361146.8635101-30138-229341118808595/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n    invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n  File "/tmp/ansible-tmp-1760361146.8635101-30138-229341118808595/AnsiballZ_k8s.py", line 47, in invoke_module\n    runpy.run_module(mod_name=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', init_globals=dict(_module_fqn=\''ansible_collections.kubernetes.core.plugins.modules.k8s\'', _modlib_path=modlib_path),\n  File "/usr/lib64/python3.9/runpy.py", line 225, in run_module\n    return
2025-10-13 13:12:27.954732 | 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_m59wvtkq/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_m59wvtkq/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_m59wvtkq/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_m59wvtkq/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352,
2025-10-13 13:12:27.954742 | controller |     in get_api_client\n  File "/tmp/ansible_kubernetes.core.k8s_payload_m59wvtkq/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_m59wvtkq/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_m59wvtkq/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_m59wvtkq/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_m59wvtkq/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py",
2025-10-13 13:12:27.955065 | controller |     line 92, in __init_cache\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info\n    \''kubernetes\'': self.client.request(\''get\'', \''/version\'', serializer=just_json)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner\n    resp = func(self, *args, **kwargs)\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request\n    api_response = self.client.call_api(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api\n    return self.__call_api(resource_path, method,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api\n    response_data = self.request(\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request\n    return self.rest_client.GET(url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py",
2025-10-13 13:12:27.960322 | controller |     line 244, in GET\n    return self.request("GET", url,\n  File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request\n    r = self.pool_manager.request(method, url,\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request\n    return self.request_encode_url(\n  File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url\n    return self.urlopen(method, url, **extra_kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen\n    response = conn.urlopen(method, u.request_uri, **kw)\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen\n    return self.urlopen(\n  File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py",
2025-10-13 13:12:27.960344 | 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 0x7f62255eccd0>: Failed to establish a new connection: [Errno -2] Name or service not known\''))\n'', ''msg'': ''MODULE FAILURE\nSee stdout/stderr for the exact error'', ''rc'': 1, ''changed'': False, ''failed_when_result'': False}'
2025-10-13 13:12:27.960355 | controller |
2025-10-13 13:12:29.170741 | controller | TASK [Test NHC CR creation idempotency] ****************************************
2025-10-13 13:12:29.170777 | controller | Monday 13 October 2025  13:12:27 +0000 (0:00:00.025)       0:00:19.304 ********
2025-10-13 13:12:29.170789 | controller | ok: [instance]
2025-10-13 13:12:29.200133 | controller |
2025-10-13 13:12:29.200168 | controller | TASK [Assert expected behavior for NHC CR creation] ****************************
2025-10-13 13:12:29.200176 | controller | Monday 13 October 2025  13:12:29 +0000 (0:00:01.209)       0:00:20.513 ********
2025-10-13 13:12:29.200186 | controller | ok: [instance] => changed=false
2025-10-13 13:12:29.241233 | controller |   msg: NHC CR creation task behaves consistently
2025-10-13 13:12:29.241268 | controller |
2025-10-13 13:12:29.241276 | controller | TASK [Verify role structure and logic] *****************************************
2025-10-13 13:12:29.241282 | controller | Monday 13 October 2025  13:12:29 +0000 (0:00:00.029)       0:00:20.543 ********
2025-10-13 13:12:29.241292 | controller | ok: [instance] =>
2025-10-13 13:12:29.324009 | controller |   msg: Role execution and verification completed - errors are expected in test environment without real K8s cluster
2025-10-13 13:12:29.324042 | controller |
2025-10-13 13:12:29.324051 | controller | PLAY RECAP *********************************************************************
2025-10-13 13:12:29.324057 | controller | instance                   : ok=41   changed=0    unreachable=0    failed=0    skipped=20   rescued=1    ignored=0
2025-10-13 13:12:29.324062 | controller |
2025-10-13 13:12:29.324068 | controller | Monday 13 October 2025  13:12:29 +0000 (0:00:00.038)       0:00:20.581 ********
2025-10-13 13:12:29.324073 | controller | ===============================================================================
2025-10-13 13:12:29.324078 | controller | Test kubernetes.core.k8s module availability ---------------------------- 1.56s
2025-10-13 13:12:29.324084 | controller | cifmw_snr_nhc : Create the workload-availability namespace -------------- 1.36s
2025-10-13 13:12:29.324089 | controller | Verify OperatorGroup exists --------------------------------------------- 1.32s
2025-10-13 13:12:29.324094 | controller | Verify namespace exists ------------------------------------------------- 1.32s
2025-10-13 13:12:29.324103 | controller | Verify SNR deployment status -------------------------------------------- 1.31s
2025-10-13 13:12:29.324108 | controller | Test namespace creation idempotency ------------------------------------- 1.26s
2025-10-13 13:12:29.324113 | controller | Verify NHC Subscription exists ------------------------------------------ 1.22s
2025-10-13 13:12:29.324119 | controller | Test that Python kubernetes library is available ------------------------ 1.22s
2025-10-13 13:12:29.324124 | controller | Test NHC CR creation idempotency ---------------------------------------- 1.21s
2025-10-13 13:12:29.324129 | controller | Test OperatorGroup creation idempotency --------------------------------- 1.20s
2025-10-13 13:12:29.324134 | controller | Verify SNR Subscription exists ------------------------------------------ 1.16s
2025-10-13 13:12:29.324139 | controller | Verify CSV status ------------------------------------------------------- 1.14s
2025-10-13 13:12:29.324144 | controller | Test SNR Subscription creation idempotency ------------------------------ 1.10s
2025-10-13 13:12:29.324154 | controller | Test NHC Subscription creation idempotency ------------------------------ 1.10s
2025-10-13 13:12:29.324160 | controller | Verify NHC CR exists ---------------------------------------------------- 1.08s
2025-10-13 13:12:29.324165 | controller | Test that mock kubeconfig exists ---------------------------------------- 0.74s
2025-10-13 13:12:29.324170 | controller | Include the cifmw_snr_nhc role ------------------------------------------ 0.07s
2025-10-13 13:12:29.324176 | controller | Verify role structure and logic ----------------------------------------- 0.04s
2025-10-13 13:12:29.324181 | controller | Analyze specific error patterns ----------------------------------------- 0.04s
2025-10-13 13:12:29.324186 | controller | cifmw_snr_nhc : Check if OperatorGroup exists --------------------------- 0.04s
2025-10-13 13:12:29.324196 | controller | INFO     Running default > verify
2025-10-13 13:12:29.324607 | controller | INFO     Running Ansible Verifier
2025-10-13 13:12:29.753653 | controller |
2025-10-13 13:12:30.866048 | controller | PLAY [Verify] ******************************************************************
2025-10-13 13:12:30.866078 | controller |
2025-10-13 13:12:30.866086 | controller | TASK [Check if Python kubernetes library is installed] *************************
2025-10-13 13:12:30.866092 | controller | Monday 13 October 2025  13:12:29 +0000 (0:00:00.020)       0:00:00.020 ********
2025-10-13 13:12:30.866102 | controller | ok: [instance]
2025-10-13 13:12:30.889763 | controller |
2025-10-13 13:12:30.889791 | controller | TASK [Display kubernetes library version] **************************************
2025-10-13 13:12:30.889799 | controller | Monday 13 October 2025  13:12:30 +0000 (0:00:01.113)       0:00:01.134 ********
2025-10-13 13:12:30.889809 | controller | ok: [instance] =>
2025-10-13 13:12:31.615113 | controller |   msg: 'kubernetes library version: 34.1.0'
2025-10-13 13:12:31.615145 | controller |
2025-10-13 13:12:31.615153 | controller | TASK [Verify kubeconfig mock file exists] **************************************
2025-10-13 13:12:31.615159 | controller | Monday 13 October 2025  13:12:30 +0000 (0:00:00.023)       0:00:01.158 ********
2025-10-13 13:12:31.615169 | controller | ok: [instance]
2025-10-13 13:12:31.636547 | controller |
2025-10-13 13:12:31.636586 | controller | TASK [Assert kubeconfig mock file exists] **************************************
2025-10-13 13:12:31.636595 | controller | Monday 13 October 2025  13:12:31 +0000 (0:00:00.725)       0:00:01.883 ********
2025-10-13 13:12:31.636605 | controller | ok: [instance] => changed=false
2025-10-13 13:12:32.233615 | controller |   msg: Mock kubeconfig file exists
2025-10-13 13:12:32.233647 | controller |
2025-10-13 13:12:32.233655 | controller | TASK [Verify kubeadmin password mock file exists] ******************************
2025-10-13 13:12:32.233661 | controller | Monday 13 October 2025  13:12:31 +0000 (0:00:00.021)       0:00:01.904 ********
2025-10-13 13:12:32.233671 | controller | ok: [instance]
2025-10-13 13:12:32.257047 | controller |
2025-10-13 13:12:32.257087 | controller | TASK [Assert kubeadmin password mock file exists] ******************************
2025-10-13 13:12:32.257096 | controller | Monday 13 October 2025  13:12:32 +0000 (0:00:00.596)       0:00:02.501 ********
2025-10-13 13:12:32.257106 | controller | ok: [instance] => changed=false
2025-10-13 13:12:32.999072 | controller |   msg: Mock kubeadmin password file exists
2025-10-13 13:12:32.999103 | controller |
2025-10-13 13:12:32.999117 | controller | TASK [Test Python yaml library] ************************************************
2025-10-13 13:12:32.999123 | controller | Monday 13 October 2025  13:12:32 +0000 (0:00:00.023)       0:00:02.525 ********
2025-10-13 13:12:32.999133 | controller | ok: [instance]
2025-10-13 13:12:33.034092 | controller |
2025-10-13 13:12:33.034121 | controller | TASK [Display yaml test result] ************************************************
2025-10-13 13:12:33.034129 | controller | Monday 13 October 2025  13:12:32 +0000 (0:00:00.742)       0:00:03.267 ********
2025-10-13 13:12:33.034139 | controller | ok: [instance] =>
2025-10-13 13:12:33.083692 | controller |   msg: yaml library works
2025-10-13 13:12:33.083717 | controller |
2025-10-13 13:12:33.083725 | controller | PLAY RECAP *********************************************************************
2025-10-13 13:12:33.083731 | controller | instance                   : ok=8    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2025-10-13 13:12:33.083736 | controller |
2025-10-13 13:12:33.083742 | controller | Monday 13 October 2025  13:12:33 +0000 (0:00:00.034)       0:00:03.301 ********
2025-10-13 13:12:33.083747 | controller | ===============================================================================
2025-10-13 13:12:33.083752 | controller | Check if Python kubernetes library is installed ------------------------- 1.11s
2025-10-13 13:12:33.083758 | controller | Test Python yaml library ------------------------------------------------ 0.74s
2025-10-13 13:12:33.083763 | controller | Verify kubeconfig mock file exists -------------------------------------- 0.73s
2025-10-13 13:12:33.083768 | controller | Verify kubeadmin password mock file exists ------------------------------ 0.60s
2025-10-13 13:12:33.083779 | controller | Display yaml test result ------------------------------------------------ 0.03s
2025-10-13 13:12:33.083784 | controller | Display kubernetes library version -------------------------------------- 0.02s
2025-10-13 13:12:33.083790 | controller | Assert kubeadmin password mock file exists ------------------------------ 0.02s
2025-10-13 13:12:33.083795 | controller | Assert kubeconfig mock file exists -------------------------------------- 0.02s
2025-10-13 13:12:33.083805 | controller | INFO     Verifier completed successfully.
2025-10-13 13:12:33.094012 | controller | INFO     Running default > destroy
2025-10-13 13:12:33.513632 | controller |
2025-10-13 13:12:33.513876 | controller | PLAY [Destroy] *****************************************************************
2025-10-13 13:12:33.514022 | controller |
2025-10-13 13:12:33.514167 | controller | TASK [Get passwd entries for USER env] *****************************************
2025-10-13 13:12:33.514306 | controller | Monday 13 October 2025  13:12:33 +0000 (0:00:00.014)       0:00:00.014 ********
2025-10-13 13:12:33.797137 | controller | ok: [localhost]
2025-10-13 13:12:33.839566 | controller |
2025-10-13 13:12:33.839629 | controller | TASK [Get shell async_dir] *****************************************************
2025-10-13 13:12:33.839637 | controller | Monday 13 October 2025  13:12:33 +0000 (0:00:00.283)       0:00:00.298 ********
2025-10-13 13:12:33.839648 | controller | ok: [localhost]
2025-10-13 13:12:33.873806 | controller |
2025-10-13 13:12:33.873839 | controller | TASK [Set async_dir for HOME env] **********************************************
2025-10-13 13:12:33.873847 | controller | Monday 13 October 2025  13:12:33 +0000 (0:00:00.042)       0:00:00.340 ********
2025-10-13 13:12:33.873857 | controller | skipping: [localhost]
2025-10-13 13:12:34.262157 | controller |
2025-10-13 13:12:34.262188 | controller | TASK [Destroy molecule instance(s)] ********************************************
2025-10-13 13:12:34.262196 | controller | Monday 13 October 2025  13:12:33 +0000 (0:00:00.034)       0:00:00.374 ********
2025-10-13 13:12:34.262207 | controller | changed: [localhost] => (item={'capabilities': ['SYS_ADMIN'], 'command': 'sleep infinity', 'groups': ['molecule', 'rhol_crc_molecule'], 'image': 'registry.access.redhat.com/ubi9/ubi:latest', 'name': 'instance', 'pre_build_image': True, 'privileged': True, 'tmpfs': ['/run', '/tmp'], 'volumes': ['/sys/fs/cgroup:/sys/fs/cgroup:ro']})
2025-10-13 13:12:44.881185 | controller |
2025-10-13 13:12:44.881219 | controller | TASK [Wait for instance(s) deletion to complete] *******************************
2025-10-13 13:12:44.881227 | controller | Monday 13 October 2025  13:12:34 +0000 (0:00:00.386)       0:00:00.761 ********
2025-10-13 13:12:44.881237 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (300 retries left).
2025-10-13 13:12:44.934867 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (299 retries left).
2025-10-13 13:12:44.934901 | controller | changed: [localhost] => (item={'failed': 0, 'started': 1, 'finished': 0, 'ansible_job_id': 'j107798040736.31212', 'results_file': '/home/zuul/.ansible_async/j107798040736.31212', 'changed': True, 'item': {'capabilities': ['SYS_ADMIN'], 'command': 'sleep infinity', 'groups': ['molecule', 'rhol_crc_molecule'], 'image': 'registry.access.redhat.com/ubi9/ubi:latest', 'name': 'instance', 'pre_build_image': True, 'privileged': True, 'tmpfs': ['/run', '/tmp'], 'volumes': ['/sys/fs/cgroup:/sys/fs/cgroup:ro']}, 'ansible_loop_var': 'item'})
2025-10-13 13:12:44.934910 | controller |
2025-10-13 13:12:44.934916 | controller | TASK [Delete podman network dedicated to this scenario] ************************
2025-10-13 13:12:44.934922 | controller | Monday 13 October 2025  13:12:44 +0000 (0:00:10.620)       0:00:11.381 ********
2025-10-13 13:12:44.934932 | controller | skipping: [localhost] => (item=instance: None specified)
2025-10-13 13:12:44.984435 | controller | skipping: [localhost]
2025-10-13 13:12:44.984486 | controller |
2025-10-13 13:12:44.984497 | controller | PLAY RECAP *********************************************************************
2025-10-13 13:12:44.984504 | controller | localhost                  : ok=4    changed=2    unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-10-13 13:12:44.984509 | controller |
2025-10-13 13:12:44.984515 | controller | Monday 13 October 2025  13:12:44 +0000 (0:00:00.053)       0:00:11.435 ********
2025-10-13 13:12:44.984520 | controller | ===============================================================================
2025-10-13 13:12:44.984526 | controller | Wait for instance(s) deletion to complete ------------------------------ 10.62s
2025-10-13 13:12:44.984531 | controller | Destroy molecule instance(s) -------------------------------------------- 0.39s
2025-10-13 13:12:44.984536 | controller | Get passwd entries for USER env ----------------------------------------- 0.28s
2025-10-13 13:12:44.984542 | controller | Delete podman network dedicated to this scenario ------------------------ 0.05s
2025-10-13 13:12:44.984561 | controller | Get shell async_dir ----------------------------------------------------- 0.04s
2025-10-13 13:12:44.984566 | controller | Set async_dir for HOME env ---------------------------------------------- 0.03s
2025-10-13 13:12:44.984577 | controller | INFO     Pruning extra files from scenario ephemeral directory
2025-10-13 13:12:44.986407 | controller | INFO     Writing /tmp/report.html report.
2025-10-13 13:12:45.381709 | controller | changed
2025-10-13 13:12:45.408495 | 
2025-10-13 13:12:45.408581 | PLAY RECAP
2025-10-13 13:12:45.408625 | controller | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-13 13:12:45.408655 | 
2025-10-13 13:12:45.505938 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-13 13:12:45.506721 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-13 13:12:46.156395 | 
2025-10-13 13:12:46.156491 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-13 13:12:46.187121 | 
2025-10-13 13:12:46.187215 | TASK [Filter out host if needed]
2025-10-13 13:12:46.196547 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-13 13:12:46.201281 | 
2025-10-13 13:12:46.201350 | TASK [Ensure file is present]
2025-10-13 13:12:46.566009 | controller | ok
2025-10-13 13:12:46.573173 | 
2025-10-13 13:12:46.573251 | TASK [Manage molecule report file]
2025-10-13 13:12:47.099546 | controller | changed
2025-10-13 13:12:47.105094 | 
2025-10-13 13:12:47.105175 | TASK [Check if we get ci-framework-data basedir]
2025-10-13 13:12:47.295985 | controller | ok
2025-10-13 13:12:47.301422 | 
2025-10-13 13:12:47.301509 | TASK [Create ci-framework-data log directory for zuul]
2025-10-13 13:12:47.664467 | controller | changed
2025-10-13 13:12:47.670904 | 
2025-10-13 13:12:47.671051 | TASK [Copy ci-framework interesting files]
2025-10-13 13:12:47.917721 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-10-13 13:12:48.208012 | controller | changed
2025-10-13 13:12:48.213273 | 
2025-10-13 13:12:48.213341 | TASK [Get SELinux listing]
2025-10-13 13:12:48.743448 | controller | changed
2025-10-13 13:12:48.749005 | 
2025-10-13 13:12:48.749076 | TASK [Generate log index]
2025-10-13 13:12:49.411160 | controller | changed
2025-10-13 13:12:49.416204 | 
2025-10-13 13:12:49.416286 | TASK [Get some env related data]
2025-10-13 13:12:49.952872 | controller | /home/zuul/.local/bin/ansible
2025-10-13 13:12:50.943939 | controller | changed
2025-10-13 13:12:50.950392 | 
2025-10-13 13:12:50.950477 | TASK [Generate list of logs to collect in home directory]
2025-10-13 13:12:51.270484 | controller | ok: All paths examined
2025-10-13 13:12:51.275998 | 
2025-10-13 13:12:51.276083 | LOOP [Copy logs from home directory]
2025-10-13 13:12:51.622967 | controller | changed:
2025-10-13 13:12:51.623079 | controller | {
2025-10-13 13:12:51.623107 | controller |   "atime": 1760361062.3563762,
2025-10-13 13:12:51.623127 | controller |   "ctime": 1760361081.3034363,
2025-10-13 13:12:51.623145 | controller |   "dev": 64513,
2025-10-13 13:12:51.623163 | controller |   "gid": 1000,
2025-10-13 13:12:51.623179 | controller |   "gr_name": "zuul",
2025-10-13 13:12:51.623196 | controller |   "inode": 4485537,
2025-10-13 13:12:51.623212 | controller |   "isblk": false,
2025-10-13 13:12:51.623226 | controller |   "ischr": false,
2025-10-13 13:12:51.623240 | controller |   "isdir": false,
2025-10-13 13:12:51.623254 | controller |   "isfifo": false,
2025-10-13 13:12:51.623268 | controller |   "isgid": false,
2025-10-13 13:12:51.623282 | controller |   "islnk": false,
2025-10-13 13:12:51.623295 | controller |   "isreg": true,
2025-10-13 13:12:51.623308 | controller |   "issock": false,
2025-10-13 13:12:51.623321 | controller |   "isuid": false,
2025-10-13 13:12:51.623334 | controller |   "mode": "0644",
2025-10-13 13:12:51.623346 | controller |   "mtime": 1760361081.3034363,
2025-10-13 13:12:51.623361 | controller |   "nlink": 1,
2025-10-13 13:12:51.623389 | controller |   "path": "/home/zuul/ansible.log",
2025-10-13 13:12:51.623407 | controller |   "pw_name": "zuul",
2025-10-13 13:12:51.623422 | controller |   "rgrp": true,
2025-10-13 13:12:51.623436 | controller |   "roth": true,
2025-10-13 13:12:51.623450 | controller |   "rusr": true,
2025-10-13 13:12:51.623567 | controller |   "size": 6749,
2025-10-13 13:12:51.623594 | controller |   "uid": 1000,
2025-10-13 13:12:51.623613 | controller |   "wgrp": false,
2025-10-13 13:12:51.623629 | controller |   "woth": false,
2025-10-13 13:12:51.623646 | controller |   "wusr": true,
2025-10-13 13:12:51.623661 | controller |   "xgrp": false,
2025-10-13 13:12:51.623675 | controller |   "xoth": false,
2025-10-13 13:12:51.623688 | controller |   "xusr": false
2025-10-13 13:12:51.623701 | controller | }
2025-10-13 13:12:51.637067 | 
2025-10-13 13:12:51.637152 | TASK [Copy crio stats log file]
2025-10-13 13:12:51.660590 | controller | skipping: Conditional result was False
2025-10-13 13:12:51.666644 | 
2025-10-13 13:12:51.666719 | TASK [Get SELinux related data]
2025-10-13 13:12:51.912680 | controller | <no matches>
2025-10-13 13:12:52.221567 | controller | ERROR
2025-10-13 13:12:52.221687 | controller | {
2025-10-13 13:12:52.221722 | controller |   "delta": "0:00:00.009381",
2025-10-13 13:12:52.221744 | controller |   "end": "2025-10-13 13:12:51.913743",
2025-10-13 13:12:52.221763 | controller |   "msg": "non-zero return code",
2025-10-13 13:12:52.221781 | controller |   "rc": 1,
2025-10-13 13:12:52.221797 | controller |   "start": "2025-10-13 13:12:51.904362"
2025-10-13 13:12:52.221813 | controller | }
2025-10-13 13:12:52.221837 | controller | ERROR: Ignoring Errors
2025-10-13 13:12:52.227827 | 
2025-10-13 13:12:52.227898 | TASK [Create system configuration directory]
2025-10-13 13:12:52.425596 | controller | changed
2025-10-13 13:12:52.433847 | 
2025-10-13 13:12:52.433970 | TASK [Get some of the system configurations]
2025-10-13 13:12:52.971953 | controller | changed
2025-10-13 13:12:52.977244 | 
2025-10-13 13:12:52.977309 | TASK [Copy generated documentation if available]
2025-10-13 13:12:53.001118 | controller | skipping: Conditional result was False
2025-10-13 13:12:53.006454 | 
2025-10-13 13:12:53.006520 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-13 13:12:53.019847 | controller | skipping: Conditional result was False
2025-10-13 13:12:53.025403 | 
2025-10-13 13:12:53.025466 | TASK [Compress logs bigger than 2MB]
2025-10-13 13:12:53.552833 | controller | changed
2025-10-13 13:12:53.558394 | 
2025-10-13 13:12:53.558471 | TASK [Copy files from workspace on node]
2025-10-13 13:12:53.576593 | controller | ok
2025-10-13 13:12:53.600356 | 
2025-10-13 13:12:53.600449 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-13 13:12:53.614255 | controller | skipping: Conditional result was False
2025-10-13 13:12:53.623123 | 
2025-10-13 13:12:53.623204 | TASK [fetch-output : Set log path for single node]
2025-10-13 13:12:53.659020 | controller | ok
2025-10-13 13:12:53.666108 | 
2025-10-13 13:12:53.666199 | LOOP [fetch-output : Ensure local output dirs]
2025-10-13 13:12:54.008581 | controller -> localhost | ok: "/var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/logs"
2025-10-13 13:12:54.008812 | controller -> localhost | changed: All items complete
2025-10-13 13:12:54.008846 | 
2025-10-13 13:12:54.453167 | controller -> localhost | changed: "/var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/artifacts"
2025-10-13 13:12:54.737070 | controller -> localhost | changed: "/var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/docs"
2025-10-13 13:12:54.749485 | 
2025-10-13 13:12:54.749614 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-13 13:12:55.354640 | controller | changed:
2025-10-13 13:12:55.354817 | controller | .d..t...... ./
2025-10-13 13:12:55.354848 | controller | >f+++++++++ README.html
2025-10-13 13:12:55.354872 | controller | >f+++++++++ ansible-execution.log
2025-10-13 13:12:55.354893 | controller | >f+++++++++ ansible.log
2025-10-13 13:12:55.354948 | controller | >f+++++++++ dmesg.log
2025-10-13 13:12:55.354973 | controller | >f+++++++++ installed-pkgs.log
2025-10-13 13:12:55.354996 | controller | >f+++++++++ python.log
2025-10-13 13:12:55.355016 | controller | >f+++++++++ registries.conf
2025-10-13 13:12:55.355035 | controller | >f+++++++++ report.html
2025-10-13 13:12:55.355055 | controller | >f+++++++++ selinux-denials.log
2025-10-13 13:12:55.355072 | controller | >f+++++++++ selinux-listing.log
2025-10-13 13:12:55.355089 | controller | cd+++++++++ ci-framework-data/
2025-10-13 13:12:55.355106 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-10-13 13:12:55.355122 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-10-13 13:12:55.355139 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-10-13 13:12:55.355155 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-10-13 13:12:55.355171 | controller | cd+++++++++ ci-framework-data/logs/
2025-10-13 13:12:55.355187 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-10-13 13:12:55.355202 | controller | cd+++++++++ registries.conf.d/
2025-10-13 13:12:55.355217 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-13 13:12:55.355233 | controller | cd+++++++++ system-config/
2025-10-13 13:12:55.355250 | controller | cd+++++++++ system-config/libvirt/
2025-10-13 13:12:55.355266 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-10-13 13:12:55.355282 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-10-13 13:12:55.823277 | controller | changed: .d..t...... ./
2025-10-13 13:12:56.420962 | controller | changed: .d..t...... ./
2025-10-13 13:12:56.448711 | 
2025-10-13 13:12:56.448822 | TASK [Return artifact to Zuul]
2025-10-13 13:12:56.502437 | controller | ok
2025-10-13 13:12:56.525028 | 
2025-10-13 13:12:56.525093 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-13 13:12:56.525195 | 
2025-10-13 13:12:56.525239 | PLAY RECAP
2025-10-13 13:12:56.525280 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-13 13:12:56.525318 | 
2025-10-13 13:12:56.629541 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-13 13:12:56.630289 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-13 13:12:57.288192 | 
2025-10-13 13:12:57.288295 | PLAY [all]
2025-10-13 13:12:57.309002 | 
2025-10-13 13:12:57.309097 | TASK [include_role : fetch-output]
2025-10-13 13:12:57.344745 | controller | ok
2025-10-13 13:12:57.362461 | 
2025-10-13 13:12:57.362575 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-13 13:12:57.417459 | controller | skipping: Conditional result was False
2025-10-13 13:12:57.423235 | 
2025-10-13 13:12:57.423330 | TASK [fetch-output : Set log path for single node]
2025-10-13 13:12:57.452428 | controller | ok
2025-10-13 13:12:57.458172 | 
2025-10-13 13:12:57.458277 | LOOP [fetch-output : Ensure local output dirs]
2025-10-13 13:12:57.844749 | controller -> localhost | ok: "/var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/logs"
2025-10-13 13:12:58.100760 | controller -> localhost | ok: "/var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/artifacts"
2025-10-13 13:12:58.345940 | controller -> localhost | ok: "/var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/docs"
2025-10-13 13:12:58.362761 | 
2025-10-13 13:12:58.362872 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-13 13:12:58.998966 | controller | ok
2025-10-13 13:12:58.999185 | controller | ok: All items complete
2025-10-13 13:12:58.999224 | 
2025-10-13 13:12:59.534668 | controller | ok
2025-10-13 13:13:00.304187 | controller | ok
2025-10-13 13:13:00.319064 | 
2025-10-13 13:13:00.319165 | TASK [include_role : fetch-output-openshift]
2025-10-13 13:13:00.359619 | controller | skipping: Conditional result was False
2025-10-13 13:13:00.366155 | 
2025-10-13 13:13:00.366244 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-13 13:13:00.934846 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013082
2025-10-13 13:13:01.322996 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.051430
2025-10-13 13:13:01.393095 | 
2025-10-13 13:13:01.393227 | PLAY [all]
2025-10-13 13:13:01.431403 | 
2025-10-13 13:13:01.431506 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-13 13:13:01.969984 | controller | changed
2025-10-13 13:13:02.018021 | 
2025-10-13 13:13:02.018098 | PLAY RECAP
2025-10-13 13:13:02.018144 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-13 13:13:02.018168 | 
2025-10-13 13:13:02.216246 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-13 13:13:02.218396 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-13 13:13:03.510007 | 
2025-10-13 13:13:03.510136 | PLAY [localhost]
2025-10-13 13:13:03.531710 | 
2025-10-13 13:13:03.531823 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-13 13:13:04.061299 | localhost | changed
2025-10-13 13:13:04.065826 | 
2025-10-13 13:13:04.065928 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-13 13:13:04.094780 | localhost | ok
2025-10-13 13:13:04.103718 | 
2025-10-13 13:13:04.103807 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-13 13:13:04.705539 | localhost | changed
2025-10-13 13:13:04.711023 | 
2025-10-13 13:13:04.711124 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-13 13:13:06.119397 | localhost | changed
2025-10-13 13:13:06.125050 | 
2025-10-13 13:13:06.125125 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-13 13:13:06.746812 | localhost | Identity added: /var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/tmp/ansible.3ed0pcb_ (/var/lib/zuul/builds/9a72e896a43b4c138c7dc4bf0bd9e61f/work/tmp/ansible.3ed0pcb_)
2025-10-13 13:13:06.747010 | localhost | ok: Runtime: 0:00:00.016470
2025-10-13 13:13:06.751284 | 
2025-10-13 13:13:06.751355 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-13 13:13:07.437364 | localhost | ok: Runtime: 0:00:00.038494
2025-10-13 13:13:07.442324 | 
2025-10-13 13:13:07.442428 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-13 13:13:07.568996 | localhost | changed
2025-10-13 13:13:07.573713 | 
2025-10-13 13:13:07.573798 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-13 13:13:08.478187 | localhost | changed
2025-10-13 13:13:08.530419 | 
2025-10-13 13:13:08.530499 | PLAY [localhost]
2025-10-13 13:13:08.552673 | 
2025-10-13 13:13:08.552741 | TASK [Generate bulk log download script]
2025-10-13 13:13:08.605881 | localhost | ok
2025-10-13 13:13:08.633148 | 
2025-10-13 13:13:08.633241 | TASK [local-log-download : Check API endpoint is defined]
2025-10-13 13:13:08.864807 | localhost | ok: All assertions passed
2025-10-13 13:13:08.868955 | 
2025-10-13 13:13:08.869021 | TASK [local-log-download : Create download script]
2025-10-13 13:13:10.146257 | localhost -> localhost | changed
2025-10-13 13:13:10.156734 | 
2025-10-13 13:13:10.156824 | TASK [Register quick-download link]
2025-10-13 13:13:10.210607 | localhost | ok
2025-10-13 13:13:10.241717 | 
2025-10-13 13:13:10.241795 | PLAY [logserver.rdoproject.org]
2025-10-13 13:13:10.264614 | 
2025-10-13 13:13:10.264687 | TASK [Set zuul-log-path fact]
2025-10-13 13:13:10.293970 | logserver.rdoproject.org | ok
2025-10-13 13:13:10.303576 | 
2025-10-13 13:13:10.303647 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-13 13:13:10.330929 | logserver.rdoproject.org | ok
2025-10-13 13:13:10.337565 | 
2025-10-13 13:13:10.337630 | TASK [upload-logs : Create log directories]
2025-10-13 13:13:12.144371 | logserver.rdoproject.org | changed
2025-10-13 13:13:12.148002 | 
2025-10-13 13:13:12.148076 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-13 13:13:12.729266 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.031087
2025-10-13 13:13:12.734204 | 
2025-10-13 13:13:12.734291 | TASK [upload-logs : Upload logs to log server]
2025-10-13 13:13:14.728088 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-13 13:13:14.731747 | 
2025-10-13 13:13:14.731813 | LOOP [upload-logs : Compress console log and json output]
2025-10-13 13:13:14.881837 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 13:13:14.889898 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 13:13:14.900707 | 
2025-10-13 13:13:14.900817 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-13 13:13:14.989845 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 13:13:14.990113 | 
2025-10-13 13:13:15.006224 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-13 13:13:15.014345 | 
2025-10-13 13:13:15.014460 | LOOP [upload-logs : Upload console log and json output]