2025-10-08 12:49:41.208443 | Job console starting... 2025-10-08 12:49:41.452475 | Updating repositories 2025-10-08 12:49:42.203259 | Preparing job workspace 2025-10-08 12:49:49.421606 | Running Ansible setup... 2025-10-08 12:49:52.587318 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-08 12:49:53.129124 | 2025-10-08 12:49:53.129228 | PLAY [localhost] 2025-10-08 12:49:53.138665 | 2025-10-08 12:49:53.138747 | TASK [Gathering Facts] 2025-10-08 12:49:53.976854 | localhost | ok 2025-10-08 12:49:53.991385 | 2025-10-08 12:49:53.991497 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-08 12:49:54.330381 | localhost -> localhost | changed 2025-10-08 12:49:54.336292 | 2025-10-08 12:49:54.336388 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-08 12:49:55.071129 | localhost -> localhost | changed 2025-10-08 12:49:55.079675 | 2025-10-08 12:49:55.079755 | TASK [Setup log path fact] 2025-10-08 12:49:55.098127 | localhost | ok 2025-10-08 12:49:55.110004 | 2025-10-08 12:49:55.110087 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-08 12:49:55.127151 | localhost | ok 2025-10-08 12:49:55.135127 | 2025-10-08 12:49:55.135196 | TASK [emit-job-header : Print job information] 2025-10-08 12:49:55.164041 | # Job Information 2025-10-08 12:49:55.164170 | Ansible Version: 2.15.12 2025-10-08 12:49:55.164200 | Job: cifmw-molecule-cifmw_snr_nhc 2025-10-08 12:49:55.164225 | Pipeline: github-check 2025-10-08 12:49:55.164246 | Executor: ibm-bm4-ze.softwarefactory-project.io 2025-10-08 12:49:55.164266 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3362 2025-10-08 12:49:55.164285 | Log URL (when completed): https://logserver.rdoproject.org/b45/rdoproject.org/b45ae928658a45c58ed9229164a87ab4/ 2025-10-08 12:49:55.164305 | Event ID: 809f8c00-a43f-11f0-9dc5-9cf6e8dba5cd 2025-10-08 12:49:55.167780 | 2025-10-08 12:49:55.167847 | LOOP [emit-job-header : Print node information] 2025-10-08 12:49:55.264450 | localhost | ok: 2025-10-08 12:49:55.264617 | localhost | # Node Information 2025-10-08 12:49:55.264649 | localhost | Inventory Hostname: controller 2025-10-08 12:49:55.264678 | localhost | Hostname: np0005476343 2025-10-08 12:49:55.264700 | localhost | Username: zuul 2025-10-08 12:49:55.264723 | localhost | Distro: CentOS 9 2025-10-08 12:49:55.264743 | localhost | Provider: ibm-bm4-nodepool 2025-10-08 12:49:55.264763 | localhost | Region: regionOne 2025-10-08 12:49:55.264782 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2025-10-08 12:49:55.264801 | localhost | Product Name: OpenStack Compute 2025-10-08 12:49:55.264820 | localhost | Interface IP: 192.168.26.138 2025-10-08 12:49:55.292692 | 2025-10-08 12:49:55.292763 | PLAY [all] 2025-10-08 12:49:55.299410 | 2025-10-08 12:49:55.299547 | TASK [Gather network facts] 2025-10-08 12:49:55.674132 | controller | ok 2025-10-08 12:49:55.690073 | 2025-10-08 12:49:55.690192 | TASK [include_role : start-zuul-console] 2025-10-08 12:49:55.708438 | controller | ok 2025-10-08 12:49:55.722073 | 2025-10-08 12:49:55.722187 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-08 12:49:56.044765 | controller | ok 2025-10-08 12:49:56.053380 | 2025-10-08 12:49:56.053468 | TASK [include_role : add-build-sshkey] 2025-10-08 12:49:56.071618 | controller | ok 2025-10-08 12:49:56.084955 | 2025-10-08 12:49:56.085035 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-08 12:49:56.290673 | controller -> localhost | ok 2025-10-08 12:49:56.296243 | 2025-10-08 12:49:56.296323 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-08 12:49:56.314383 | controller | ok 2025-10-08 12:49:56.328164 | controller | included: /var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-08 12:49:56.333873 | 2025-10-08 12:49:56.333968 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-08 12:49:56.965925 | controller -> localhost | Generating public/private rsa key pair. 2025-10-08 12:49:56.966124 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/b45ae928658a45c58ed9229164a87ab4_id_rsa. 2025-10-08 12:49:56.966160 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/b45ae928658a45c58ed9229164a87ab4_id_rsa.pub. 2025-10-08 12:49:56.966184 | controller -> localhost | The key fingerprint is: 2025-10-08 12:49:56.966205 | controller -> localhost | SHA256:umBTdgFg4X3WU5IQ6ngTq7/QPPPF48NXX54cyO9DvFg zuul-build-sshkey 2025-10-08 12:49:56.966227 | controller -> localhost | The key's randomart image is: 2025-10-08 12:49:56.966246 | controller -> localhost | +---[RSA 3072]----+ 2025-10-08 12:49:56.966265 | controller -> localhost | | +o. oo... | 2025-10-08 12:49:56.966285 | controller -> localhost | | o . o ..o | 2025-10-08 12:49:56.966304 | controller -> localhost | | . + + o | 2025-10-08 12:49:56.966322 | controller -> localhost | | o = . . | 2025-10-08 12:49:56.966339 | controller -> localhost | | . B S . o | 2025-10-08 12:49:56.966355 | controller -> localhost | | B + . o.E.| 2025-10-08 12:49:56.966371 | controller -> localhost | | * * .+ .*o=| 2025-10-08 12:49:56.966387 | controller -> localhost | | . = = oo... *o| 2025-10-08 12:49:56.966404 | controller -> localhost | | +.. .o ...| 2025-10-08 12:49:56.966421 | controller -> localhost | +----[SHA256]-----+ 2025-10-08 12:49:56.966461 | controller -> localhost | ok: Runtime: 0:00:00.249634 2025-10-08 12:49:56.971938 | 2025-10-08 12:49:56.972017 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-08 12:49:57.000482 | controller | ok 2025-10-08 12:49:57.009853 | controller | included: /var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-08 12:49:57.017519 | 2025-10-08 12:49:57.017595 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-08 12:49:57.041628 | controller | skipping: Conditional result was False 2025-10-08 12:49:57.047142 | 2025-10-08 12:49:57.047228 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-08 12:49:57.453040 | controller | changed 2025-10-08 12:49:57.460004 | 2025-10-08 12:49:57.460145 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-08 12:49:57.659761 | controller | ok 2025-10-08 12:49:57.665752 | 2025-10-08 12:49:57.665859 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-08 12:49:58.317938 | controller | changed 2025-10-08 12:49:58.324347 | 2025-10-08 12:49:58.324483 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-08 12:49:58.955081 | controller | changed 2025-10-08 12:49:58.961356 | 2025-10-08 12:49:58.961448 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-08 12:49:58.985362 | controller | skipping: Conditional result was False 2025-10-08 12:49:58.990902 | 2025-10-08 12:49:58.991002 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-08 12:49:59.329159 | controller -> localhost | changed 2025-10-08 12:49:59.346246 | 2025-10-08 12:49:59.346341 | TASK [add-build-sshkey : Add back temp key] 2025-10-08 12:49:59.636189 | controller -> localhost | Identity added: /var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/b45ae928658a45c58ed9229164a87ab4_id_rsa (zuul-build-sshkey) 2025-10-08 12:49:59.636429 | controller -> localhost | ok: Runtime: 0:00:00.011697 2025-10-08 12:49:59.641937 | 2025-10-08 12:49:59.642025 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-08 12:49:59.979485 | controller | ok 2025-10-08 12:49:59.985503 | 2025-10-08 12:49:59.985609 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-08 12:50:00.010434 | controller | skipping: Conditional result was False 2025-10-08 12:50:00.020786 | 2025-10-08 12:50:00.020879 | TASK [include_role : validate-host] 2025-10-08 12:50:00.040202 | controller | ok 2025-10-08 12:50:00.062774 | 2025-10-08 12:50:00.062868 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-08 12:50:00.094159 | controller | ok 2025-10-08 12:50:00.099253 | 2025-10-08 12:50:00.099352 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-08 12:50:00.326982 | controller -> localhost | ok 2025-10-08 12:50:00.332820 | 2025-10-08 12:50:00.332893 | TASK [validate-host : Collect information about the host] 2025-10-08 12:50:01.001697 | controller | ok 2025-10-08 12:50:01.016484 | 2025-10-08 12:50:01.016662 | TASK [validate-host : Sanitize hostname] 2025-10-08 12:50:01.141478 | controller | ok 2025-10-08 12:50:01.147818 | 2025-10-08 12:50:01.147897 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-08 12:50:01.594071 | controller -> localhost | changed 2025-10-08 12:50:01.606326 | 2025-10-08 12:50:01.606413 | TASK [validate-host : Collect information about zuul worker] 2025-10-08 12:50:02.009738 | controller | ok 2025-10-08 12:50:02.014404 | 2025-10-08 12:50:02.014476 | TASK [validate-host : Write out all zuul information for each host] 2025-10-08 12:50:02.415976 | controller -> localhost | changed 2025-10-08 12:50:02.425966 | 2025-10-08 12:50:02.426056 | TASK [include_role : prepare-workspace-openshift] 2025-10-08 12:50:02.440340 | controller | skipping: Conditional result was False 2025-10-08 12:50:02.445928 | 2025-10-08 12:50:02.446017 | TASK [include_role : remove-zuul-sshkey] 2025-10-08 12:50:02.459656 | controller | skipping: Conditional result was False 2025-10-08 12:50:02.466664 | 2025-10-08 12:50:02.466746 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-08 12:50:02.714702 | controller | ok: "logs" 2025-10-08 12:50:02.714955 | controller | ok: All items complete 2025-10-08 12:50:02.714991 | 2025-10-08 12:50:02.901782 | controller | ok: "artifacts" 2025-10-08 12:50:03.076435 | controller | ok: "docs" 2025-10-08 12:50:03.090641 | 2025-10-08 12:50:03.090749 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-08 12:50:03.299276 | controller | changed: "logs" 2025-10-08 12:50:03.482037 | controller | changed: "artifacts" 2025-10-08 12:50:03.666614 | controller | changed: "docs" 2025-10-08 12:50:03.721097 | 2025-10-08 12:50:03.721182 | PLAY RECAP 2025-10-08 12:50:03.721230 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-08 12:50:03.721260 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-08 12:50:03.721280 | 2025-10-08 12:50:03.857440 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-08 12:50:03.858287 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-08 12:50:04.475167 | 2025-10-08 12:50:04.475288 | PLAY [all] 2025-10-08 12:50:04.494936 | 2025-10-08 12:50:04.495053 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-08 12:50:04.544060 | controller | ok 2025-10-08 12:50:04.549103 | 2025-10-08 12:50:04.549206 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-08 12:50:04.913356 | controller | changed 2025-10-08 12:50:04.919409 | 2025-10-08 12:50:04.919495 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-08 12:50:05.769740 | controller | changed 2025-10-08 12:50:05.781556 | 2025-10-08 12:50:05.781665 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-08 12:50:06.189312 | controller | changed: 2025-10-08 12:50:06.189481 | controller | { 2025-10-08 12:50:06.189511 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-08 12:50:06.189544 | controller | } 2025-10-08 12:50:06.411045 | controller | changed: 2025-10-08 12:50:06.411161 | controller | { 2025-10-08 12:50:06.411193 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-08 12:50:06.411217 | controller | } 2025-10-08 12:50:06.623095 | controller | changed: 2025-10-08 12:50:06.623192 | controller | { 2025-10-08 12:50:06.623222 | 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-08 12:50:06.623245 | controller | } 2025-10-08 12:50:06.851790 | controller | changed: 2025-10-08 12:50:06.851880 | controller | { 2025-10-08 12:50:06.851958 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-08 12:50:06.851989 | controller | } 2025-10-08 12:50:07.071272 | controller | changed: 2025-10-08 12:50:07.071405 | controller | { 2025-10-08 12:50:07.071433 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-08 12:50:07.071455 | controller | } 2025-10-08 12:50:07.294367 | controller | changed: 2025-10-08 12:50:07.294468 | controller | { 2025-10-08 12:50:07.294500 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-08 12:50:07.294523 | controller | } 2025-10-08 12:50:07.510158 | controller | changed: 2025-10-08 12:50:07.510313 | controller | { 2025-10-08 12:50:07.510350 | 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-08 12:50:07.510375 | controller | } 2025-10-08 12:50:07.738180 | controller | changed: 2025-10-08 12:50:07.738262 | controller | { 2025-10-08 12:50:07.738291 | 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-08 12:50:07.738315 | controller | } 2025-10-08 12:50:07.963830 | controller | changed: 2025-10-08 12:50:07.964031 | controller | { 2025-10-08 12:50:07.964065 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-08 12:50:07.964088 | controller | } 2025-10-08 12:50:08.184050 | controller | changed: 2025-10-08 12:50:08.184148 | controller | { 2025-10-08 12:50:08.184175 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-08 12:50:08.184197 | controller | } 2025-10-08 12:50:08.414649 | controller | changed: 2025-10-08 12:50:08.414738 | controller | { 2025-10-08 12:50:08.414767 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-08 12:50:08.414789 | controller | } 2025-10-08 12:50:08.629638 | controller | changed: 2025-10-08 12:50:08.629735 | controller | { 2025-10-08 12:50:08.629763 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-08 12:50:08.629785 | controller | } 2025-10-08 12:50:08.846653 | controller | changed: 2025-10-08 12:50:08.846742 | controller | { 2025-10-08 12:50:08.846771 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-08 12:50:08.846792 | controller | } 2025-10-08 12:50:09.061502 | controller | changed: 2025-10-08 12:50:09.061657 | controller | { 2025-10-08 12:50:09.061691 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-08 12:50:09.061716 | controller | } 2025-10-08 12:50:09.277986 | controller | changed: 2025-10-08 12:50:09.278075 | controller | { 2025-10-08 12:50:09.278103 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-08 12:50:09.278124 | controller | } 2025-10-08 12:50:09.489517 | controller | changed: 2025-10-08 12:50:09.489616 | controller | { 2025-10-08 12:50:09.489644 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-08 12:50:09.489665 | controller | } 2025-10-08 12:50:09.701161 | controller | changed: 2025-10-08 12:50:09.701354 | controller | { 2025-10-08 12:50:09.701393 | 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-08 12:50:09.701420 | controller | } 2025-10-08 12:50:09.916653 | controller | changed: 2025-10-08 12:50:09.916751 | controller | { 2025-10-08 12:50:09.916781 | 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-08 12:50:09.916810 | controller | } 2025-10-08 12:50:10.136861 | controller | changed: 2025-10-08 12:50:10.137212 | controller | { 2025-10-08 12:50:10.137245 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-08 12:50:10.137267 | controller | } 2025-10-08 12:50:10.350609 | controller | changed: 2025-10-08 12:50:10.350710 | controller | { 2025-10-08 12:50:10.350741 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-08 12:50:10.350766 | controller | } 2025-10-08 12:50:10.597178 | controller | changed: 2025-10-08 12:50:10.597266 | controller | { 2025-10-08 12:50:10.597295 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-08 12:50:10.597316 | controller | } 2025-10-08 12:50:10.810032 | controller | changed: 2025-10-08 12:50:10.810731 | controller | { 2025-10-08 12:50:10.810769 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-08 12:50:10.810793 | controller | } 2025-10-08 12:50:11.031374 | controller | changed: 2025-10-08 12:50:11.031458 | controller | { 2025-10-08 12:50:11.031494 | 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-08 12:50:11.031515 | controller | } 2025-10-08 12:50:11.255293 | controller | changed: 2025-10-08 12:50:11.255400 | controller | { 2025-10-08 12:50:11.255429 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-08 12:50:11.255533 | controller | } 2025-10-08 12:50:11.474643 | controller | changed: 2025-10-08 12:50:11.474735 | controller | { 2025-10-08 12:50:11.474763 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-08 12:50:11.474784 | controller | } 2025-10-08 12:50:11.698537 | controller | changed: 2025-10-08 12:50:11.698758 | controller | { 2025-10-08 12:50:11.698794 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-08 12:50:11.698817 | controller | } 2025-10-08 12:50:11.725087 | 2025-10-08 12:50:11.725177 | TASK [Set timezone to UTC] 2025-10-08 12:50:12.166034 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-10-08 12:50:12.175771 | 2025-10-08 12:50:12.175876 | TASK [Create nodepool directory] 2025-10-08 12:50:12.398221 | controller | changed 2025-10-08 12:50:12.404142 | 2025-10-08 12:50:12.404224 | TASK [Create nodepool sub_nodes file] 2025-10-08 12:50:12.969684 | controller | changed 2025-10-08 12:50:12.975097 | 2025-10-08 12:50:12.975193 | TASK [Create nodepool sub_nodes_private file] 2025-10-08 12:50:13.540303 | controller | changed 2025-10-08 12:50:13.554547 | 2025-10-08 12:50:13.554644 | LOOP [Populate nodepool sub_nodes file] 2025-10-08 12:50:13.583490 | 2025-10-08 12:50:13.583624 | LOOP [Populate nodepool sub_nodes_private file] 2025-10-08 12:50:13.612342 | 2025-10-08 12:50:13.612476 | TASK [Create nodepool primary file] 2025-10-08 12:50:13.635831 | controller | skipping: Conditional result was False 2025-10-08 12:50:13.641312 | 2025-10-08 12:50:13.641400 | TASK [Create nodepool node_private for this node] 2025-10-08 12:50:14.239059 | controller | changed 2025-10-08 12:50:14.254325 | 2025-10-08 12:50:14.254799 | LOOP [Copy ssh keys to nodepool directory] 2025-10-08 12:50:14.624735 | controller | ok: Item: id_rsa Runtime: 0:00:00.006409 2025-10-08 12:50:14.624980 | 2025-10-08 12:50:14.798241 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004921 2025-10-08 12:50:14.805967 | 2025-10-08 12:50:14.806070 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-10-08 12:50:15.378086 | controller | changed 2025-10-08 12:50:15.383121 | 2025-10-08 12:50:15.383195 | TASK [Validate sudoers config after edits] 2025-10-08 12:50:15.633323 | controller | /etc/sudoers: parsed OK 2025-10-08 12:50:15.633394 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-10-08 12:50:15.633405 | controller | /etc/sudoers.d/zuul: parsed OK 2025-10-08 12:50:15.633411 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-08 12:50:15.918280 | controller | ok: Runtime: 0:00:00.004760 2025-10-08 12:50:15.923661 | 2025-10-08 12:50:15.923730 | TASK [Show the environment passed in to job shell scripts] 2025-10-08 12:50:16.136231 | controller | SHELL=/bin/bash 2025-10-08 12:50:16.136284 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-10-08 12:50:16.136295 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-10-08 12:50:16.136301 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/62/3362/41f2edaa0ac45cd85919f70775e84cf472326a6e 2025-10-08 12:50:16.136307 | controller | PWD=/home/zuul 2025-10-08 12:50:16.136312 | controller | ZUUL_PIPELINE=github-check 2025-10-08 12:50:16.136317 | controller | LOGNAME=zuul 2025-10-08 12:50:16.136323 | controller | XDG_SESSION_TYPE=tty 2025-10-08 12:50:16.136328 | controller | _=/usr/bin/env 2025-10-08 12:50:16.136383 | controller | MOTD_SHOWN=pam 2025-10-08 12:50:16.136393 | controller | HOME=/home/zuul 2025-10-08 12:50:16.136399 | controller | LANG=en_US.UTF-8 2025-10-08 12:50:16.136404 | controller | SSH_CONNECTION=192.168.26.12 48544 192.168.26.138 22 2025-10-08 12:50:16.136409 | 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-08 12:50:16.136418 | controller | ZUUL_CHANGE_IDS=3362,41f2edaa0ac45cd85919f70775e84cf472326a6e 2025-10-08 12:50:16.136423 | controller | WORKSPACE=/home/zuul/workspace 2025-10-08 12:50:16.136429 | controller | XDG_SESSION_CLASS=user 2025-10-08 12:50:16.136434 | controller | SELINUX_ROLE_REQUESTED= 2025-10-08 12:50:16.136439 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-08 12:50:16.136445 | controller | USER=zuul 2025-10-08 12:50:16.136450 | controller | ZUUL_VOTING=True 2025-10-08 12:50:16.136455 | controller | BUILD_TIMEOUT=1800000 2025-10-08 12:50:16.136460 | controller | SELINUX_USE_CURRENT_RANGE= 2025-10-08 12:50:16.136465 | controller | SHLVL=1 2025-10-08 12:50:16.136471 | controller | ZUUL_PATCHSET=41f2edaa0ac45cd85919f70775e84cf472326a6e 2025-10-08 12:50:16.136476 | controller | XDG_SESSION_ID=1 2025-10-08 12:50:16.136481 | controller | ZUUL_BRANCH=main 2025-10-08 12:50:16.136486 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-10-08 12:50:16.136491 | controller | SSH_CLIENT=192.168.26.12 48544 22 2025-10-08 12:50:16.136497 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-10-08 12:50:16.136502 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-10-08 12:50:16.136507 | controller | which_declare=declare -f 2025-10-08 12:50:16.136513 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-08 12:50:16.136518 | controller | SELINUX_LEVEL_REQUESTED= 2025-10-08 12:50:16.136524 | controller | ZUUL_CHANGE=3362 2025-10-08 12:50:16.136529 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-08 12:50:16.136534 | controller | ZUUL_UUID=b45ae928658a45c58ed9229164a87ab4 2025-10-08 12:50:16.136539 | controller | BASH_FUNC_which%%=() { ( alias; 2025-10-08 12:50:16.136546 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-08 12:50:16.136552 | controller | } 2025-10-08 12:50:16.448980 | controller | ok: Runtime: 0:00:00.005904 2025-10-08 12:50:16.454581 | 2025-10-08 12:50:16.454670 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-10-08 12:50:16.471836 | controller | skipping: Conditional result was False 2025-10-08 12:50:16.478259 | 2025-10-08 12:50:16.478337 | TASK [Symlink /home/zuul-worker/workspace] 2025-10-08 12:50:17.006062 | controller | skipping: Conditional result was False 2025-10-08 12:50:17.012541 | 2025-10-08 12:50:17.012634 | TASK [Ensure legacy workspace directory] 2025-10-08 12:50:17.227202 | controller | changed 2025-10-08 12:50:17.247160 | 2025-10-08 12:50:17.247238 | PLAY RECAP 2025-10-08 12:50:17.247286 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-08 12:50:17.247309 | 2025-10-08 12:50:17.348348 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-08 12:50:17.349134 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-08 12:50:17.885647 | 2025-10-08 12:50:17.885811 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-08 12:50:17.905967 | 2025-10-08 12:50:17.906048 | TASK [Create zuul-output directory] 2025-10-08 12:50:18.242265 | controller | changed 2025-10-08 12:50:18.249039 | 2025-10-08 12:50:18.249147 | TASK [Slurp Zuul inventory test] 2025-10-08 12:50:18.557735 | controller -> localhost | ok 2025-10-08 12:50:18.565183 | 2025-10-08 12:50:18.565292 | TASK [Save zuul inventory] 2025-10-08 12:50:19.444182 | controller | changed 2025-10-08 12:50:19.449817 | 2025-10-08 12:50:19.449893 | TASK [Save zuul vars without the change_message] 2025-10-08 12:50:20.116526 | controller | changed 2025-10-08 12:50:20.155401 | 2025-10-08 12:50:20.155490 | PLAY RECAP 2025-10-08 12:50:20.155539 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-08 12:50:20.155564 | 2025-10-08 12:50:20.241381 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-08 12:50:20.242273 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-10-08 12:50:21.018999 | 2025-10-08 12:50:21.019121 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2025-10-08 12:50:21.050278 | 2025-10-08 12:50:21.050398 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2025-10-08 12:50:21.069629 | controller | ok 2025-10-08 12:50:21.087244 | 2025-10-08 12:50:21.087352 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-08 12:50:21.111396 | controller | skipping: Conditional result was False 2025-10-08 12:50:21.117463 | 2025-10-08 12:50:21.117554 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-08 12:50:21.477107 | controller | ok 2025-10-08 12:50:21.482804 | 2025-10-08 12:50:21.482897 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-08 12:50:22.168096 | controller | ok 2025-10-08 12:50:22.181001 | 2025-10-08 12:50:22.181088 | TASK [Prepare workspace] 2025-10-08 12:50:22.199069 | controller | ok 2025-10-08 12:50:22.224276 | 2025-10-08 12:50:22.224382 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-08 12:50:22.554526 | controller | ok 2025-10-08 12:50:22.562264 | 2025-10-08 12:50:22.562388 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-08 12:50:24.892104 | controller | Output suppressed because no_log was given 2025-10-08 12:50:24.902285 | 2025-10-08 12:50:24.902392 | LOOP [Create zuul-output directory] 2025-10-08 12:50:25.103771 | controller | changed: "/home/zuul/ci-framework-data/logs" 2025-10-08 12:50:25.280650 | controller | ok: "/home/zuul/zuul-output/logs" 2025-10-08 12:50:25.296116 | 2025-10-08 12:50:25.296211 | TASK [Install required packages] 2025-10-08 12:51:17.101446 | controller | changed 2025-10-08 12:51:17.107272 | 2025-10-08 12:51:17.107362 | TASK [Install venv] 2025-10-08 12:52:17.371600 | controller | changed 2025-10-08 12:52:17.437392 | 2025-10-08 12:52:17.437498 | PLAY RECAP 2025-10-08 12:52:17.437551 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-10-08 12:52:17.437578 | 2025-10-08 12:52:17.576995 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-10-08 12:52:17.577855 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-10-08 12:52:18.359231 | 2025-10-08 12:52:18.359343 | PLAY [Run ci/playbooks/molecule-test.yml] 2025-10-08 12:52:18.393352 | 2025-10-08 12:52:18.393485 | TASK [Gather required facts] 2025-10-08 12:52:18.984539 | controller | ok 2025-10-08 12:52:18.994377 | 2025-10-08 12:52:18.994473 | TASK [Load environment var if instructed to] 2025-10-08 12:52:19.024550 | controller | skipping: Conditional result was False 2025-10-08 12:52:19.031185 | 2025-10-08 12:52:19.031273 | TASK [Run molecule] 2025-10-08 12:52:20.027779 | controller | INFO Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml 2025-10-08 12:52:20.099539 | controller | WARNING Driver podman does not provide a schema. 2025-10-08 12:52:20.102178 | controller | INFO Performing prerun with role_name_check=0... 2025-10-08 12:52:36.897769 | 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-08 12:52:36.898209 | 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-08 12:52:36.898677 | 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-08 12:52:36.899148 | 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-08 12:52:36.899609 | controller | WARNING Another version of 'cifmw.general' 1.0.0+c1adc95e was found installed in /home/zuul/.cache/ansible-compat/8256b2/collections/ansible_collections, only the first one will be used, 1.0.0+c1adc95e (/home/zuul/.ansible/collections/ansible_collections). 2025-10-08 12:52:36.900080 | 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-08 12:52:36.900525 | 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-08 12:52:36.900986 | 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-08 12:52:36.901442 | 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-08 12:52:36.901897 | 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-08 12:52:36.902380 | 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-08 12:52:36.902850 | 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-08 12:52:36.903304 | 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-08 12:52:36.903764 | 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-08 12:52:36.904218 | 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-08 12:52:36.915448 | controller | INFO Running default > dependency 2025-10-08 12:52:36.916360 | controller | WARNING Skipping, missing the requirements file. 2025-10-08 12:52:36.917080 | controller | WARNING Skipping, missing the requirements file. 2025-10-08 12:52:36.926373 | controller | INFO Running default > create 2025-10-08 12:52:37.157059 | controller | INFO Sanity checks: 'podman' 2025-10-08 12:52:38.059910 | controller | 2025-10-08 12:52:38.059968 | controller | PLAY [Create] ****************************************************************** 2025-10-08 12:52:38.060004 | controller | 2025-10-08 12:52:38.060148 | controller | TASK [Get podman executable path] ********************************************** 2025-10-08 12:52:38.060247 | controller | Wednesday 08 October 2025 12:52:38 +0000 (0:00:00.014) 0:00:00.014 ***** 2025-10-08 12:52:38.354762 | controller | ok: [localhost] 2025-10-08 12:52:38.354813 | controller | 2025-10-08 12:52:38.354923 | controller | TASK [Register podman executable path] ***************************************** 2025-10-08 12:52:38.355024 | controller | Wednesday 08 October 2025 12:52:38 +0000 (0:00:00.295) 0:00:00.309 ***** 2025-10-08 12:52:38.394621 | controller | ok: [localhost] 2025-10-08 12:52:38.394708 | controller | 2025-10-08 12:52:38.394853 | controller | TASK [Get passwd entries for USER env] ***************************************** 2025-10-08 12:52:38.394977 | controller | Wednesday 08 October 2025 12:52:38 +0000 (0:00:00.039) 0:00:00.349 ***** 2025-10-08 12:52:38.684158 | controller | ok: [localhost] 2025-10-08 12:52:38.684213 | controller | 2025-10-08 12:52:38.684285 | controller | TASK [Get shell async_dir] ***************************************************** 2025-10-08 12:52:38.684387 | controller | Wednesday 08 October 2025 12:52:38 +0000 (0:00:00.289) 0:00:00.639 ***** 2025-10-08 12:52:38.725288 | controller | ok: [localhost] 2025-10-08 12:52:38.725404 | controller | 2025-10-08 12:52:38.725536 | controller | TASK [Set async_dir for HOME env] ********************************************** 2025-10-08 12:52:38.725665 | controller | Wednesday 08 October 2025 12:52:38 +0000 (0:00:00.041) 0:00:00.680 ***** 2025-10-08 12:52:38.757683 | controller | skipping: [localhost] 2025-10-08 12:52:38.757772 | controller | 2025-10-08 12:52:38.757888 | controller | TASK [Log into a container registry] ******************************************* 2025-10-08 12:52:38.757992 | controller | Wednesday 08 October 2025 12:52:38 +0000 (0:00:00.032) 0:00:00.712 ***** 2025-10-08 12:52:38.804223 | controller | skipping: [localhost] => (item="instance registry username: None specified") 2025-10-08 12:52:38.804285 | controller | skipping: [localhost] 2025-10-08 12:52:38.804387 | controller | 2025-10-08 12:52:38.804492 | controller | TASK [Check presence of custom Dockerfiles] ************************************ 2025-10-08 12:52:38.805170 | controller | Wednesday 08 October 2025 12:52:38 +0000 (0:00:00.046) 0:00:00.759 ***** 2025-10-08 12:52:39.097511 | controller | ok: [localhost] => (item=Dockerfile: None specified) 2025-10-08 12:52:39.097584 | controller | 2025-10-08 12:52:39.097697 | controller | TASK [Create Dockerfiles from image names] ************************************* 2025-10-08 12:52:39.097828 | controller | Wednesday 08 October 2025 12:52:39 +0000 (0:00:00.293) 0:00:01.052 ***** 2025-10-08 12:52:39.138610 | controller | skipping: [localhost] => (item="Dockerfile: None specified; Image: registry.access.redhat.com/ubi9/ubi:latest") 2025-10-08 12:52:39.138711 | controller | skipping: [localhost] 2025-10-08 12:52:39.138841 | controller | 2025-10-08 12:52:39.138944 | controller | TASK [Discover local Podman images] ******************************************** 2025-10-08 12:52:39.139084 | controller | Wednesday 08 October 2025 12:52:39 +0000 (0:00:00.041) 0:00:01.093 ***** 2025-10-08 12:52:39.963762 | controller | ok: [localhost] => (item=instance) 2025-10-08 12:52:39.963890 | controller | 2025-10-08 12:52:39.964030 | controller | TASK [Build an Ansible compatible image] *************************************** 2025-10-08 12:52:39.964201 | controller | Wednesday 08 October 2025 12:52:39 +0000 (0:00:00.825) 0:00:01.918 ***** 2025-10-08 12:52:40.005150 | controller | skipping: [localhost] => (item=registry.access.redhat.com/ubi9/ubi:latest) 2025-10-08 12:52:40.005280 | controller | skipping: [localhost] 2025-10-08 12:52:40.005401 | controller | 2025-10-08 12:52:40.005508 | controller | TASK [Determine the CMD directives] ******************************************** 2025-10-08 12:52:40.005616 | controller | Wednesday 08 October 2025 12:52:40 +0000 (0:00:00.041) 0:00:01.960 ***** 2025-10-08 12:52:40.054950 | controller | ok: [localhost] => (item="instance command: sleep infinity") 2025-10-08 12:52:40.055095 | controller | 2025-10-08 12:52:40.055234 | controller | TASK [Remove possible pre-existing containers] ********************************* 2025-10-08 12:52:40.055362 | controller | Wednesday 08 October 2025 12:52:40 +0000 (0:00:00.049) 0:00:02.009 ***** 2025-10-08 12:52:40.292244 | controller | changed: [localhost] 2025-10-08 12:52:40.292354 | controller | 2025-10-08 12:52:40.292464 | controller | TASK [Discover local podman networks] ****************************************** 2025-10-08 12:52:40.292568 | controller | Wednesday 08 October 2025 12:52:40 +0000 (0:00:00.237) 0:00:02.247 ***** 2025-10-08 12:52:40.336608 | controller | skipping: [localhost] => (item=instance: None specified) 2025-10-08 12:52:40.336702 | controller | skipping: [localhost] 2025-10-08 12:52:40.336823 | controller | 2025-10-08 12:52:40.336927 | controller | TASK [Create podman network dedicated to this scenario] ************************ 2025-10-08 12:52:40.337026 | controller | Wednesday 08 October 2025 12:52:40 +0000 (0:00:00.044) 0:00:02.291 ***** 2025-10-08 12:52:40.373551 | controller | skipping: [localhost] 2025-10-08 12:52:40.373658 | controller | 2025-10-08 12:52:40.373814 | controller | TASK [Create molecule instance(s)] ********************************************* 2025-10-08 12:52:40.373941 | controller | Wednesday 08 October 2025 12:52:40 +0000 (0:00:00.036) 0:00:02.328 ***** 2025-10-08 12:52:40.699487 | controller | changed: [localhost] => (item=instance) 2025-10-08 12:52:40.699540 | controller | 2025-10-08 12:52:40.699643 | controller | TASK [Wait for instance(s) creation to complete] ******************************* 2025-10-08 12:52:40.699762 | controller | Wednesday 08 October 2025 12:52:40 +0000 (0:00:00.323) 0:00:02.652 ***** 2025-10-08 12:52:46.167899 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) creation to complete (300 retries left). 2025-10-08 12:52:46.167983 | controller | changed: [localhost] => (item=instance) 2025-10-08 12:52:46.170246 | controller | 2025-10-08 12:52:46.229941 | controller | PLAY RECAP ********************************************************************* 2025-10-08 12:52:46.229973 | controller | localhost : ok=10 changed=3 unreachable=0 failed=0 skipped=6 rescued=0 ignored=0 2025-10-08 12:52:46.229981 | controller | 2025-10-08 12:52:46.229987 | controller | Wednesday 08 October 2025 12:52:46 +0000 (0:00:05.470) 0:00:08.122 ***** 2025-10-08 12:52:46.229992 | controller | =============================================================================== 2025-10-08 12:52:46.229998 | controller | Wait for instance(s) creation to complete ------------------------------- 5.47s 2025-10-08 12:52:46.230003 | controller | Discover local Podman images -------------------------------------------- 0.83s 2025-10-08 12:52:46.230008 | controller | Create molecule instance(s) --------------------------------------------- 0.32s 2025-10-08 12:52:46.230013 | controller | Get podman executable path ---------------------------------------------- 0.30s 2025-10-08 12:52:46.230018 | controller | Check presence of custom Dockerfiles ------------------------------------ 0.29s 2025-10-08 12:52:46.230023 | controller | Get passwd entries for USER env ----------------------------------------- 0.29s 2025-10-08 12:52:46.230032 | controller | Remove possible pre-existing containers --------------------------------- 0.24s 2025-10-08 12:52:46.230088 | controller | Determine the CMD directives -------------------------------------------- 0.05s 2025-10-08 12:52:46.230096 | controller | Log into a container registry ------------------------------------------- 0.05s 2025-10-08 12:52:46.230101 | controller | Discover local podman networks ------------------------------------------ 0.04s 2025-10-08 12:52:46.230107 | controller | Build an Ansible compatible image --------------------------------------- 0.04s 2025-10-08 12:52:46.230112 | controller | Get shell async_dir ----------------------------------------------------- 0.04s 2025-10-08 12:52:46.230117 | controller | Create Dockerfiles from image names ------------------------------------- 0.04s 2025-10-08 12:52:46.230128 | controller | Register podman executable path ----------------------------------------- 0.04s 2025-10-08 12:52:46.230133 | controller | Create podman network dedicated to this scenario ------------------------ 0.04s 2025-10-08 12:52:46.230139 | controller | Set async_dir for HOME env ---------------------------------------------- 0.03s 2025-10-08 12:52:46.230149 | controller | INFO Running default > prepare 2025-10-08 12:52:46.641460 | controller | 2025-10-08 12:52:47.632704 | controller | PLAY [Prepare] ***************************************************************** 2025-10-08 12:52:47.632734 | controller | 2025-10-08 12:52:47.632741 | controller | TASK [Gathering Facts] ********************************************************* 2025-10-08 12:52:47.632747 | controller | Wednesday 08 October 2025 12:52:46 +0000 (0:00:00.010) 0:00:00.010 ***** 2025-10-08 12:52:47.632757 | controller | ok: [instance] 2025-10-08 12:52:54.522715 | controller | 2025-10-08 12:52:54.522757 | controller | TASK [Install Python pip and dependencies using dnf] *************************** 2025-10-08 12:52:54.522766 | controller | Wednesday 08 October 2025 12:52:47 +0000 (0:00:00.991) 0:00:01.002 ***** 2025-10-08 12:52:54.522776 | controller | changed: [instance] 2025-10-08 12:52:59.856179 | controller | 2025-10-08 12:52:59.856210 | controller | TASK [Install Python dependencies] ********************************************* 2025-10-08 12:52:59.856218 | controller | Wednesday 08 October 2025 12:52:54 +0000 (0:00:06.890) 0:00:07.892 ***** 2025-10-08 12:52:59.856228 | controller | changed: [instance] 2025-10-08 12:53:01.375876 | controller | 2025-10-08 12:53:01.375908 | controller | TASK [Create mock kubeconfig file] ********************************************* 2025-10-08 12:53:01.375916 | controller | Wednesday 08 October 2025 12:52:59 +0000 (0:00:05.333) 0:00:13.225 ***** 2025-10-08 12:53:01.375926 | controller | changed: [instance] 2025-10-08 12:53:02.731109 | controller | 2025-10-08 12:53:02.731147 | controller | TASK [Create mock kubeadmin password file] ************************************* 2025-10-08 12:53:02.731156 | controller | Wednesday 08 October 2025 12:53:01 +0000 (0:00:01.519) 0:00:14.745 ***** 2025-10-08 12:53:02.731166 | controller | changed: [instance] 2025-10-08 12:53:02.731183 | controller | 2025-10-08 12:53:02.731189 | controller | PLAY RECAP ********************************************************************* 2025-10-08 12:53:02.731195 | controller | instance : ok=5 changed=4 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2025-10-08 12:53:02.731200 | controller | 2025-10-08 12:53:02.731206 | controller | Wednesday 08 October 2025 12:53:02 +0000 (0:00:01.355) 0:00:16.100 ***** 2025-10-08 12:53:02.731211 | controller | =============================================================================== 2025-10-08 12:53:02.731218 | controller | Install Python pip and dependencies using dnf --------------------------- 6.89s 2025-10-08 12:53:02.731268 | controller | Install Python dependencies --------------------------------------------- 5.33s 2025-10-08 12:53:02.731371 | controller | Create mock kubeconfig file --------------------------------------------- 1.52s 2025-10-08 12:53:02.731474 | controller | Create mock kubeadmin password file ------------------------------------- 1.36s 2025-10-08 12:53:02.731581 | controller | Gathering Facts --------------------------------------------------------- 0.99s 2025-10-08 12:53:02.791730 | controller | INFO Running default > converge 2025-10-08 12:53:03.250532 | controller | 2025-10-08 12:53:03.251849 | controller | PLAY [Converge] **************************************************************** 2025-10-08 12:53:03.252326 | controller | 2025-10-08 12:53:03.252349 | controller | TASK [Test that required variables are defined] ******************************** 2025-10-08 12:53:03.276832 | controller | Wednesday 08 October 2025 12:53:03 +0000 (0:00:00.023) 0:00:00.023 ***** 2025-10-08 12:53:03.276863 | controller | ok: [instance] => changed=false 2025-10-08 12:53:03.300156 | controller | msg: Required variables are defined 2025-10-08 12:53:03.300192 | controller | 2025-10-08 12:53:03.300201 | controller | TASK [Display test information] ************************************************ 2025-10-08 12:53:03.300207 | controller | Wednesday 08 October 2025 12:53:03 +0000 (0:00:00.028) 0:00:00.051 ***** 2025-10-08 12:53:03.300217 | controller | ok: [instance] => 2025-10-08 12:53:03.300236 | controller | msg: 'Testing role cifmw_snr_nhc with kubeconfig: /tmp/kubeconfig and namespace: workload-availability' 2025-10-08 12:53:03.300269 | controller | 2025-10-08 12:53:03.300512 | controller | TASK [Test that Python kubernetes library is available] ************************ 2025-10-08 12:53:04.473688 | controller | Wednesday 08 October 2025 12:53:03 +0000 (0:00:00.023) 0:00:00.074 ***** 2025-10-08 12:53:04.473728 | controller | ok: [instance] 2025-10-08 12:53:04.473786 | controller | 2025-10-08 12:53:04.473988 | controller | TASK [Display kubernetes library test result] ********************************** 2025-10-08 12:53:04.495160 | controller | Wednesday 08 October 2025 12:53:04 +0000 (0:00:01.173) 0:00:01.248 ***** 2025-10-08 12:53:04.495189 | controller | ok: [instance] => 2025-10-08 12:53:05.319360 | controller | msg: Library available 2025-10-08 12:53:05.319391 | controller | 2025-10-08 12:53:05.319398 | controller | TASK [Test that mock kubeconfig exists] **************************************** 2025-10-08 12:53:05.319405 | controller | Wednesday 08 October 2025 12:53:04 +0000 (0:00:00.021) 0:00:01.269 ***** 2025-10-08 12:53:05.319415 | controller | ok: [instance] 2025-10-08 12:53:05.343289 | controller | 2025-10-08 12:53:05.343319 | controller | TASK [Assert kubeconfig exists] ************************************************ 2025-10-08 12:53:05.343327 | controller | Wednesday 08 October 2025 12:53:05 +0000 (0:00:00.823) 0:00:02.093 ***** 2025-10-08 12:53:05.343337 | controller | ok: [instance] => changed=false 2025-10-08 12:53:06.785980 | controller | msg: Kubeconfig file exists 2025-10-08 12:53:06.786013 | controller | 2025-10-08 12:53:06.786021 | controller | TASK [Test kubernetes.core.k8s module availability] **************************** 2025-10-08 12:53:06.786027 | controller | Wednesday 08 October 2025 12:53:05 +0000 (0:00:00.024) 0:00:02.117 ***** 2025-10-08 12:53:06.786052 | controller | ok: [instance] 2025-10-08 12:53:06.810075 | controller | 2025-10-08 12:53:06.810105 | controller | TASK [Display k8s connection test result] ************************************** 2025-10-08 12:53:06.810113 | controller | Wednesday 08 October 2025 12:53:06 +0000 (0:00:01.442) 0:00:03.560 ***** 2025-10-08 12:53:06.810123 | controller | ok: [instance] => 2025-10-08 12:53:06.877244 | controller | msg: 'K8s connection test result: False' 2025-10-08 12:53:06.877284 | controller | 2025-10-08 12:53:06.877292 | controller | TASK [Include the cifmw_snr_nhc role] ****************************************** 2025-10-08 12:53:06.877298 | controller | Wednesday 08 October 2025 12:53:06 +0000 (0:00:00.023) 0:00:03.584 ***** 2025-10-08 12:53:06.877309 | controller | 2025-10-08 12:53:06.904106 | controller | TASK [cifmw_snr_nhc : Check if NodeHealthCheck exists and is active] *********** 2025-10-08 12:53:06.904132 | controller | Wednesday 08 October 2025 12:53:06 +0000 (0:00:00.067) 0:00:03.651 ***** 2025-10-08 12:53:06.904142 | controller | skipping: [instance] 2025-10-08 12:53:06.930861 | controller | 2025-10-08 12:53:06.930899 | controller | TASK [cifmw_snr_nhc : Check for active SelfNodeRemediations] ******************* 2025-10-08 12:53:06.930909 | controller | Wednesday 08 October 2025 12:53:06 +0000 (0:00:00.026) 0:00:03.678 ***** 2025-10-08 12:53:06.930921 | controller | skipping: [instance] 2025-10-08 12:53:06.960169 | controller | 2025-10-08 12:53:06.960200 | controller | TASK [cifmw_snr_nhc : Display active remediations info] ************************ 2025-10-08 12:53:06.960209 | controller | Wednesday 08 October 2025 12:53:06 +0000 (0:00:00.026) 0:00:03.705 ***** 2025-10-08 12:53:06.960221 | controller | skipping: [instance] 2025-10-08 12:53:06.960385 | controller | 2025-10-08 12:53:06.960535 | controller | TASK [cifmw_snr_nhc : Disable NodeHealthCheck to stop active remediations] ***** 2025-10-08 12:53:06.960690 | controller | Wednesday 08 October 2025 12:53:06 +0000 (0:00:00.029) 0:00:03.735 ***** 2025-10-08 12:53:06.988150 | controller | skipping: [instance] 2025-10-08 12:53:06.988227 | controller | 2025-10-08 12:53:06.988254 | controller | TASK [cifmw_snr_nhc : Wait for active remediations to stop] ******************** 2025-10-08 12:53:06.988266 | controller | Wednesday 08 October 2025 12:53:06 +0000 (0:00:00.027) 0:00:03.762 ***** 2025-10-08 12:53:07.015404 | controller | skipping: [instance] 2025-10-08 12:53:07.041702 | controller | 2025-10-08 12:53:07.041724 | controller | TASK [cifmw_snr_nhc : Delete existing NodeHealthCheck resources] *************** 2025-10-08 12:53:07.041731 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.027) 0:00:03.789 ***** 2025-10-08 12:53:07.041740 | controller | skipping: [instance] 2025-10-08 12:53:07.067988 | controller | 2025-10-08 12:53:07.068008 | controller | TASK [cifmw_snr_nhc : Check for blocking remediations when deletion fails] ***** 2025-10-08 12:53:07.068029 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.026) 0:00:03.816 ***** 2025-10-08 12:53:07.068055 | controller | skipping: [instance] 2025-10-08 12:53:07.094116 | controller | 2025-10-08 12:53:07.094149 | controller | TASK [cifmw_snr_nhc : Display blocking remediation details] ******************** 2025-10-08 12:53:07.094156 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.026) 0:00:03.842 ***** 2025-10-08 12:53:07.094167 | controller | skipping: [instance] 2025-10-08 12:53:07.094316 | controller | 2025-10-08 12:53:07.094325 | controller | TASK [cifmw_snr_nhc : Display warning if NodeHealthCheck deletion failed due to active remediation] *** 2025-10-08 12:53:07.094334 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.026) 0:00:03.868 ***** 2025-10-08 12:53:07.120683 | controller | skipping: [instance] 2025-10-08 12:53:07.146104 | controller | 2025-10-08 12:53:07.146129 | controller | TASK [cifmw_snr_nhc : Skip NodeHealthCheck deletion retry if webhook blocks it] *** 2025-10-08 12:53:07.146136 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.026) 0:00:03.895 ***** 2025-10-08 12:53:07.146146 | controller | skipping: [instance] 2025-10-08 12:53:07.146169 | controller | 2025-10-08 12:53:07.146364 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationConfig exists] *************** 2025-10-08 12:53:07.172002 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.025) 0:00:03.921 ***** 2025-10-08 12:53:07.172028 | controller | skipping: [instance] 2025-10-08 12:53:07.197809 | controller | 2025-10-08 12:53:07.197834 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationConfig resources] ***** 2025-10-08 12:53:07.197841 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.025) 0:00:03.946 ***** 2025-10-08 12:53:07.197850 | controller | skipping: [instance] 2025-10-08 12:53:07.223652 | controller | 2025-10-08 12:53:07.223674 | controller | TASK [cifmw_snr_nhc : Check if SelfNodeRemediationTemplate exists] ************* 2025-10-08 12:53:07.223681 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.025) 0:00:03.972 ***** 2025-10-08 12:53:07.223690 | controller | skipping: [instance] 2025-10-08 12:53:07.249121 | controller | 2025-10-08 12:53:07.249161 | controller | TASK [cifmw_snr_nhc : Delete existing SelfNodeRemediationTemplate resources] *** 2025-10-08 12:53:07.249170 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.025) 0:00:03.998 ***** 2025-10-08 12:53:07.249183 | controller | skipping: [instance] 2025-10-08 12:53:07.249218 | controller | 2025-10-08 12:53:07.249228 | controller | TASK [cifmw_snr_nhc : Check if Subscriptions exist] **************************** 2025-10-08 12:53:07.249244 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.025) 0:00:04.024 ***** 2025-10-08 12:53:07.274758 | controller | skipping: [instance] 2025-10-08 12:53:07.307151 | controller | 2025-10-08 12:53:07.307185 | controller | TASK [cifmw_snr_nhc : Delete existing Subscriptions] *************************** 2025-10-08 12:53:07.307194 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.025) 0:00:04.049 ***** 2025-10-08 12:53:07.307213 | controller | skipping: [instance] => (item=self-node-remediation-operator) 2025-10-08 12:53:07.307239 | controller | skipping: [instance] => (item=node-health-check-operator) 2025-10-08 12:53:07.307249 | controller | skipping: [instance] 2025-10-08 12:53:07.307519 | controller | 2025-10-08 12:53:07.332826 | controller | TASK [cifmw_snr_nhc : Check if OperatorGroup exists] *************************** 2025-10-08 12:53:07.332849 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.032) 0:00:04.082 ***** 2025-10-08 12:53:07.332860 | controller | skipping: [instance] 2025-10-08 12:53:07.358923 | controller | 2025-10-08 12:53:07.358952 | controller | TASK [cifmw_snr_nhc : Delete existing OperatorGroup] *************************** 2025-10-08 12:53:07.358959 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.025) 0:00:04.107 ***** 2025-10-08 12:53:07.358969 | controller | skipping: [instance] 2025-10-08 12:53:07.384947 | controller | 2025-10-08 12:53:07.384973 | controller | TASK [cifmw_snr_nhc : Delete the entire workload-availability namespace] ******* 2025-10-08 12:53:07.384981 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.025) 0:00:04.133 ***** 2025-10-08 12:53:07.384990 | controller | skipping: [instance] 2025-10-08 12:53:07.411515 | controller | 2025-10-08 12:53:07.411544 | controller | TASK [cifmw_snr_nhc : Wait for namespace deletion to complete] ***************** 2025-10-08 12:53:07.411560 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.026) 0:00:04.159 ***** 2025-10-08 12:53:07.411570 | controller | skipping: [instance] 2025-10-08 12:53:08.681442 | controller | 2025-10-08 12:53:08.681473 | controller | TASK [cifmw_snr_nhc : Create the workload-availability namespace] ************** 2025-10-08 12:53:08.681481 | controller | Wednesday 08 October 2025 12:53:07 +0000 (0:00:00.026) 0:00:04.186 ***** 2025-10-08 12:53:08.681492 | 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(': Failed to establish a new connection: [Errno -2] Name or service not known')) 2025-10-08 12:53:08.683127 | controller | fatal: [instance]: FAILED! => changed=false 2025-10-08 12:53:08.683176 | controller | module_stderr: |- 2025-10-08 12:53:08.683187 | controller | Traceback (most recent call last): 2025-10-08 12:53:08.686087 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 169, in _new_conn 2025-10-08 12:53:08.686117 | controller | conn = connection.create_connection( 2025-10-08 12:53:08.686125 | controller | File "/usr/lib/python3.9/site-packages/urllib3/util/connection.py", line 73, in create_connection 2025-10-08 12:53:08.686131 | controller | for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM): 2025-10-08 12:53:08.686136 | controller | File "/usr/lib64/python3.9/socket.py", line 966, in getaddrinfo 2025-10-08 12:53:08.686142 | controller | for res in _socket.getaddrinfo(host, port, family, type, proto, flags): 2025-10-08 12:53:08.686148 | controller | socket.gaierror: [Errno -2] Name or service not known 2025-10-08 12:53:08.686153 | controller | 2025-10-08 12:53:08.686159 | controller | During handling of the above exception, another exception occurred: 2025-10-08 12:53:08.686164 | controller | 2025-10-08 12:53:08.686169 | controller | Traceback (most recent call last): 2025-10-08 12:53:08.686175 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 700, in urlopen 2025-10-08 12:53:08.686180 | controller | httplib_response = self._make_request( 2025-10-08 12:53:08.686186 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 383, in _make_request 2025-10-08 12:53:08.686191 | controller | self._validate_conn(conn) 2025-10-08 12:53:08.686197 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 1015, in _validate_conn 2025-10-08 12:53:08.686202 | controller | conn.connect() 2025-10-08 12:53:08.686214 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 353, in connect 2025-10-08 12:53:08.686220 | controller | conn = self._new_conn() 2025-10-08 12:53:08.686225 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connection.py", line 181, in _new_conn 2025-10-08 12:53:08.686230 | controller | raise NewConnectionError( 2025-10-08 12:53:08.686236 | controller | urllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known 2025-10-08 12:53:08.686242 | controller | 2025-10-08 12:53:08.686247 | controller | During handling of the above exception, another exception occurred: 2025-10-08 12:53:08.686253 | controller | 2025-10-08 12:53:08.686258 | controller | Traceback (most recent call last): 2025-10-08 12:53:08.686264 | controller | File "/tmp/ansible-tmp-1759927987.4233851-28174-115438690122013/AnsiballZ_k8s.py", line 107, in 2025-10-08 12:53:08.686269 | controller | _ansiballz_main() 2025-10-08 12:53:08.686275 | controller | File "/tmp/ansible-tmp-1759927987.4233851-28174-115438690122013/AnsiballZ_k8s.py", line 99, in _ansiballz_main 2025-10-08 12:53:08.686282 | controller | invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS) 2025-10-08 12:53:08.686387 | controller | File "/tmp/ansible-tmp-1759927987.4233851-28174-115438690122013/AnsiballZ_k8s.py", line 47, in invoke_module 2025-10-08 12:53:08.686398 | 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-08 12:53:08.686510 | controller | File "/usr/lib64/python3.9/runpy.py", line 225, in run_module 2025-10-08 12:53:08.686647 | controller | return _run_module_code(code, init_globals, run_name, mod_spec) 2025-10-08 12:53:08.686766 | controller | File "/usr/lib64/python3.9/runpy.py", line 97, in _run_module_code 2025-10-08 12:53:08.686874 | controller | _run_code(code, mod_globals, init_globals, 2025-10-08 12:53:08.686987 | controller | File "/usr/lib64/python3.9/runpy.py", line 87, in _run_code 2025-10-08 12:53:08.687230 | controller | exec(code, run_globals) 2025-10-08 12:53:08.687356 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_ceprjub3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in 2025-10-08 12:53:08.687478 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_ceprjub3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 503, in main 2025-10-08 12:53:08.687611 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_ceprjub3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", line 88, in run_module 2025-10-08 12:53:08.687744 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_ceprjub3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, in get_api_client 2025-10-08 12:53:08.687872 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_ceprjub3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 246, in wrapper 2025-10-08 12:53:08.687991 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_ceprjub3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 259, in create_api_client 2025-10-08 12:53:08.688129 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 84, in __init__ 2025-10-08 12:53:08.688255 | controller | self.__discoverer = discoverer(self, cache_file) 2025-10-08 12:53:08.688376 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_ceprjub3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 190, in __init__ 2025-10-08 12:53:08.688493 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_ceprjub3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 45, in __init__ 2025-10-08 12:53:08.688627 | controller | File "/tmp/ansible_kubernetes.core.k8s_payload_ceprjub3/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 92, in __init_cache 2025-10-08 12:53:08.688745 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/discovery.py", line 146, in _load_server_info 2025-10-08 12:53:08.688863 | controller | 'kubernetes': self.client.request('get', '/version', serializer=just_json) 2025-10-08 12:53:08.688982 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 55, in inner 2025-10-08 12:53:08.689119 | controller | resp = func(self, *args, **kwargs) 2025-10-08 12:53:08.689249 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/dynamic/client.py", line 277, in request 2025-10-08 12:53:08.689363 | controller | api_response = self.client.call_api( 2025-10-08 12:53:08.689477 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 348, in call_api 2025-10-08 12:53:08.689598 | controller | return self.__call_api(resource_path, method, 2025-10-08 12:53:08.689724 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 180, in __call_api 2025-10-08 12:53:08.689836 | controller | response_data = self.request( 2025-10-08 12:53:08.689952 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/api_client.py", line 373, in request 2025-10-08 12:53:08.690090 | controller | return self.rest_client.GET(url, 2025-10-08 12:53:08.690220 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 244, in GET 2025-10-08 12:53:08.690333 | controller | return self.request("GET", url, 2025-10-08 12:53:08.690448 | controller | File "/usr/local/lib/python3.9/site-packages/kubernetes/client/rest.py", line 217, in request 2025-10-08 12:53:08.690560 | controller | r = self.pool_manager.request(method, url, 2025-10-08 12:53:08.690687 | controller | File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 74, in request 2025-10-08 12:53:08.690798 | controller | return self.request_encode_url( 2025-10-08 12:53:08.690920 | controller | File "/usr/lib/python3.9/site-packages/urllib3/request.py", line 96, in request_encode_url 2025-10-08 12:53:08.691046 | controller | return self.urlopen(method, url, **extra_kw) 2025-10-08 12:53:08.691174 | controller | File "/usr/lib/python3.9/site-packages/urllib3/poolmanager.py", line 376, in urlopen 2025-10-08 12:53:08.691293 | controller | response = conn.urlopen(method, u.request_uri, **kw) 2025-10-08 12:53:08.691408 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen 2025-10-08 12:53:08.691521 | controller | return self.urlopen( 2025-10-08 12:53:08.691653 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen 2025-10-08 12:53:08.691766 | controller | return self.urlopen( 2025-10-08 12:53:08.691880 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 784, in urlopen 2025-10-08 12:53:08.691998 | controller | return self.urlopen( 2025-10-08 12:53:08.692133 | controller | File "/usr/lib/python3.9/site-packages/urllib3/connectionpool.py", line 756, in urlopen 2025-10-08 12:53:08.692255 | controller | retries = retries.increment( 2025-10-08 12:53:08.692370 | controller | File "/usr/lib/python3.9/site-packages/urllib3/util/retry.py", line 576, in increment 2025-10-08 12:53:08.692482 | controller | raise MaxRetryError(_pool, url, error or ResponseError(cause)) 2025-10-08 12:53:08.692632 | controller | urllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host='api.test.example.com', port=6443): Max retries exceeded with url: /version (Caused by NewConnectionError(': Failed to establish a new connection: [Errno -2] Name or service not known')) 2025-10-08 12:53:08.692749 | controller | module_stdout: '' 2025-10-08 12:53:08.692861 | controller | msg: |- 2025-10-08 12:53:08.692972 | controller | MODULE FAILURE 2025-10-08 12:53:08.693112 | controller | See stdout/stderr for the exact error 2025-10-08 12:53:08.693233 | controller | rc: 1 2025-10-08 12:53:08.693394 | controller | 2025-10-08 12:53:08.693511 | controller | TASK [Capture role execution error] ******************************************** 2025-10-08 12:53:08.693652 | controller | Wednesday 08 October 2025 12:53:08 +0000 (0:00:01.278) 0:00:05.464 ***** 2025-10-08 12:53:08.713303 | controller | ok: [instance] 2025-10-08 12:53:08.713401 | controller | 2025-10-08 12:53:08.713524 | controller | TASK [Display role execution error details] ************************************ 2025-10-08 12:53:08.713666 | controller | Wednesday 08 October 2025 12:53:08 +0000 (0:00:00.023) 0:00:05.488 ***** 2025-10-08 12:53:08.736701 | controller | ok: [instance] => 2025-10-08 12:53:08.736824 | controller | msg: |- 2025-10-08 12:53:08.736949 | controller | Role execution failed with error: 2025-10-08 12:53:08.737148 | 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': 'fa163e46-f0e7-7fbc-7fb9-000000000166', 'finalized': True, 'squashed': False}, 'poll': 15, 'register': 'namespace_result', 'retries': 3, 'until': [], 'loop_with': None, 'uuid': 'fa163e46-f0e7-7fbc-7fb9-00000000008f', 'finalized': True, 'squashed': True} 2025-10-08 12:53:08.737271 | controller | 2025-10-08 12:53:08.737402 | controller | TASK [Analyze specific error patterns] ***************************************** 2025-10-08 12:53:08.737512 | controller | Wednesday 08 October 2025 12:53:08 +0000 (0:00:00.023) 0:00:05.511 ***** 2025-10-08 12:53:08.774870 | controller | ok: [instance] => 2025-10-08 12:53:08.774972 | controller | msg: |- 2025-10-08 12:53:08.775112 | controller | Error analysis: 2025-10-08 12:53:08.775234 | controller | - Connection error: False 2025-10-08 12:53:08.775351 | controller | - Authentication error: False 2025-10-08 12:53:08.775459 | controller | - API error: False 2025-10-08 12:53:08.775570 | controller | - Timeout error: False 2025-10-08 12:53:08.775704 | controller | 2025-10-08 12:53:08.775817 | controller | TASK [Continue with test evaluation] ******************************************* 2025-10-08 12:53:08.775930 | controller | Wednesday 08 October 2025 12:53:08 +0000 (0:00:00.038) 0:00:05.549 ***** 2025-10-08 12:53:08.798288 | controller | ok: [instance] => 2025-10-08 12:53:08.798396 | controller | msg: Role failed as expected in test environment - this is normal 2025-10-08 12:53:08.798505 | controller | 2025-10-08 12:53:08.798643 | controller | TASK [Verify namespace exists] ************************************************* 2025-10-08 12:53:08.798761 | controller | Wednesday 08 October 2025 12:53:08 +0000 (0:00:00.023) 0:00:05.573 ***** 2025-10-08 12:53:10.083769 | controller | ok: [instance] 2025-10-08 12:53:10.083938 | controller | 2025-10-08 12:53:10.083963 | controller | TASK [Display namespace verification result] *********************************** 2025-10-08 12:53:10.100840 | controller | Wednesday 08 October 2025 12:53:10 +0000 (0:00:01.285) 0:00:06.858 ***** 2025-10-08 12:53:10.100880 | controller | ok: [instance] => 2025-10-08 12:53:10.100889 | 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-08 12:53:10.100897 | 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: : 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-1759927988.812647-28352-131859188119954/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927988.812647-28352-131859188119954/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927988.812647-28352-131859188119954/AnsiballZ_k8s.py", 2025-10-08 12:53:10.100914 | 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_uhjvccec/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_uhjvccec/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_uhjvccec/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-10-08 12:53:10.100927 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_uhjvccec/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_uhjvccec/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_uhjvccec/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_uhjvccec/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_uhjvccec/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:10.100933 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_uhjvccec/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-08 12:53:10.100939 | 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-08 12:53:10.100951 | 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(\'': 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-08 12:53:10.100959 | 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-08 12:53:10.100986 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : 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-1759927988.812647-28352-131859188119954/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927988.812647-28352-131859188119954/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927988.812647-28352-131859188119954/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-08 12:53:10.100998 | 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_uhjvccec/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_uhjvccec/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_uhjvccec/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_uhjvccec/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-10-08 12:53:10.101478 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_uhjvccec/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_uhjvccec/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_uhjvccec/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_uhjvccec/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_uhjvccec/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:10.106147 | 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-08 12:53:10.106190 | 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-08 12:53:10.106198 | 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(\'': 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-08 12:53:10.106217 | controller | 2025-10-08 12:53:11.295676 | controller | TASK [Test namespace creation idempotency] ************************************* 2025-10-08 12:53:11.295707 | controller | Wednesday 08 October 2025 12:53:10 +0000 (0:00:00.022) 0:00:06.881 ***** 2025-10-08 12:53:11.295719 | controller | ok: [instance] 2025-10-08 12:53:11.320514 | controller | 2025-10-08 12:53:11.320535 | controller | TASK [Assert expected behavior for namespace creation] ************************* 2025-10-08 12:53:11.320542 | controller | Wednesday 08 October 2025 12:53:11 +0000 (0:00:01.189) 0:00:08.070 ***** 2025-10-08 12:53:11.320552 | controller | ok: [instance] => changed=false 2025-10-08 12:53:12.511590 | controller | msg: Namespace creation task behaves consistently 2025-10-08 12:53:12.511622 | controller | 2025-10-08 12:53:12.511629 | controller | TASK [Verify OperatorGroup exists] ********************************************* 2025-10-08 12:53:12.511635 | controller | Wednesday 08 October 2025 12:53:11 +0000 (0:00:00.025) 0:00:08.095 ***** 2025-10-08 12:53:12.511645 | controller | ok: [instance] 2025-10-08 12:53:12.528641 | controller | 2025-10-08 12:53:12.528674 | controller | TASK [Display OperatorGroup verification result] ******************************* 2025-10-08 12:53:12.528682 | controller | Wednesday 08 October 2025 12:53:12 +0000 (0:00:01.190) 0:00:09.285 ***** 2025-10-08 12:53:12.528692 | controller | ok: [instance] => 2025-10-08 12:53:12.528699 | 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-08 12:53:12.528706 | 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: : 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-1759927991.3339155-28691-68428482701332/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927991.3339155-28691-68428482701332/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927991.3339155-28691-68428482701332/AnsiballZ_k8s.py", 2025-10-08 12:53:12.528717 | 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_8t1kzib8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_8t1kzib8/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_8t1kzib8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-10-08 12:53:12.528730 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_8t1kzib8/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_8t1kzib8/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_8t1kzib8/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_8t1kzib8/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_8t1kzib8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:12.528739 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_8t1kzib8/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-08 12:53:12.528745 | 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-08 12:53:12.528753 | 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(\'': 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-08 12:53:12.528762 | 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-08 12:53:12.528788 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : 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-1759927991.3339155-28691-68428482701332/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927991.3339155-28691-68428482701332/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927991.3339155-28691-68428482701332/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-08 12:53:12.528797 | 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_8t1kzib8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_8t1kzib8/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_8t1kzib8/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_8t1kzib8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-10-08 12:53:12.528828 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_8t1kzib8/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_8t1kzib8/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_8t1kzib8/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_8t1kzib8/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_8t1kzib8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:12.529078 | 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-08 12:53:12.529111 | 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-08 12:53:12.529247 | 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(\'': 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-08 12:53:12.533828 | controller | 2025-10-08 12:53:13.634156 | controller | TASK [Test OperatorGroup creation idempotency] ********************************* 2025-10-08 12:53:13.634189 | controller | Wednesday 08 October 2025 12:53:12 +0000 (0:00:00.022) 0:00:09.308 ***** 2025-10-08 12:53:13.634200 | controller | ok: [instance] 2025-10-08 12:53:13.660032 | controller | 2025-10-08 12:53:13.660078 | controller | TASK [Assert expected behavior for OperatorGroup creation] ********************* 2025-10-08 12:53:13.660086 | controller | Wednesday 08 October 2025 12:53:13 +0000 (0:00:01.099) 0:00:10.408 ***** 2025-10-08 12:53:13.660096 | controller | ok: [instance] => changed=false 2025-10-08 12:53:14.813836 | controller | msg: OperatorGroup creation task behaves consistently 2025-10-08 12:53:14.813868 | controller | 2025-10-08 12:53:14.813875 | controller | TASK [Verify SNR Subscription exists] ****************************************** 2025-10-08 12:53:14.813881 | controller | Wednesday 08 October 2025 12:53:13 +0000 (0:00:00.025) 0:00:10.434 ***** 2025-10-08 12:53:14.813891 | controller | ok: [instance] 2025-10-08 12:53:14.831131 | controller | 2025-10-08 12:53:14.831167 | controller | TASK [Display SNR Subscription verification result] **************************** 2025-10-08 12:53:14.831175 | controller | Wednesday 08 October 2025 12:53:14 +0000 (0:00:01.153) 0:00:11.588 ***** 2025-10-08 12:53:14.831187 | controller | ok: [instance] => 2025-10-08 12:53:14.831220 | 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-08 12:53:14.831229 | 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: : 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-1759927993.6713436-29029-184679382756676/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927993.6713436-29029-184679382756676/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927993.6713436-29029-184679382756676/AnsiballZ_k8s.py", 2025-10-08 12:53:14.831235 | 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_o1_x9euc/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_o1_x9euc/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_o1_x9euc/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-10-08 12:53:14.831247 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_o1_x9euc/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_o1_x9euc/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_o1_x9euc/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_o1_x9euc/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_o1_x9euc/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:14.832147 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_o1_x9euc/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-08 12:53:14.832180 | 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-08 12:53:14.832189 | 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(\'': 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-08 12:53:14.832198 | 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-08 12:53:14.832210 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : 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-1759927993.6713436-29029-184679382756676/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927993.6713436-29029-184679382756676/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927993.6713436-29029-184679382756676/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-08 12:53:14.832229 | 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_o1_x9euc/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_o1_x9euc/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_o1_x9euc/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_o1_x9euc/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-10-08 12:53:14.832237 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_o1_x9euc/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_o1_x9euc/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_o1_x9euc/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_o1_x9euc/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_o1_x9euc/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:14.832268 | 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-08 12:53:14.832520 | 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-08 12:53:14.837301 | 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(\'': 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-08 12:53:14.837322 | controller | 2025-10-08 12:53:15.988761 | controller | TASK [Test SNR Subscription creation idempotency] ****************************** 2025-10-08 12:53:15.988792 | controller | Wednesday 08 October 2025 12:53:14 +0000 (0:00:00.023) 0:00:11.612 ***** 2025-10-08 12:53:15.988804 | controller | ok: [instance] 2025-10-08 12:53:16.009797 | controller | 2025-10-08 12:53:16.009820 | controller | TASK [Assert expected behavior for SNR Subscription creation] ****************** 2025-10-08 12:53:16.009827 | controller | Wednesday 08 October 2025 12:53:15 +0000 (0:00:01.151) 0:00:12.763 ***** 2025-10-08 12:53:16.009836 | controller | ok: [instance] => changed=false 2025-10-08 12:53:17.149511 | controller | msg: SNR Subscription creation task behaves consistently 2025-10-08 12:53:17.149543 | controller | 2025-10-08 12:53:17.149551 | controller | TASK [Verify SNR deployment status] ******************************************** 2025-10-08 12:53:17.149557 | controller | Wednesday 08 October 2025 12:53:16 +0000 (0:00:00.021) 0:00:12.784 ***** 2025-10-08 12:53:17.149567 | controller | ok: [instance] 2025-10-08 12:53:17.150114 | controller | 2025-10-08 12:53:17.150137 | controller | TASK [Display SNR deployment verification result] ****************************** 2025-10-08 12:53:17.150160 | controller | Wednesday 08 October 2025 12:53:17 +0000 (0:00:01.138) 0:00:13.923 ***** 2025-10-08 12:53:17.164192 | controller | ok: [instance] => 2025-10-08 12:53:17.164241 | 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-08 12:53:17.164252 | 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: : 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-1759927996.0209994-29370-79628470547175/AnsiballZ_k8s_info.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927996.0209994-29370-79628470547175/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927996.0209994-29370-79628470547175/AnsiballZ_k8s_info.py", 2025-10-08 12:53:17.164266 | 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_yghsprx8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in \n File "/tmp/ansible_kubernetes.core.k8s_info_payload_yghsprx8/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_yghsprx8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", 2025-10-08 12:53:17.165096 | controller | line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_yghsprx8/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_yghsprx8/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_yghsprx8/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_yghsprx8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 2025-10-08 12:53:17.165110 | controller | 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_yghsprx8/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-08 12:53:17.165120 | 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-08 12:53:17.165126 | 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(\'': 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-08 12:53:17.165137 | 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-08 12:53:17.165739 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : 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-1759927996.0209994-29370-79628470547175/AnsiballZ_k8s_info.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927996.0209994-29370-79628470547175/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927996.0209994-29370-79628470547175/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-08 12:53:17.165761 | 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_yghsprx8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in \n File "/tmp/ansible_kubernetes.core.k8s_info_payload_yghsprx8/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_yghsprx8/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_yghsprx8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", 2025-10-08 12:53:17.165768 | controller | line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_yghsprx8/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_yghsprx8/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_yghsprx8/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_yghsprx8/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 2025-10-08 12:53:17.165776 | 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-08 12:53:17.165790 | 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-08 12:53:17.170788 | 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(\'': 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-08 12:53:17.170809 | controller | 2025-10-08 12:53:17.189292 | controller | TASK [Test deployment verification behavior] *********************************** 2025-10-08 12:53:17.189317 | controller | Wednesday 08 October 2025 12:53:17 +0000 (0:00:00.022) 0:00:13.945 ***** 2025-10-08 12:53:17.189327 | controller | ok: [instance] => 2025-10-08 12:53:17.189517 | controller | msg: Testing deployment verification logic - expected to fail in mock environment 2025-10-08 12:53:17.189666 | controller | 2025-10-08 12:53:17.189823 | controller | TASK [Assert SNR deployment verification behaves as expected] ****************** 2025-10-08 12:53:17.189972 | controller | Wednesday 08 October 2025 12:53:17 +0000 (0:00:00.018) 0:00:13.964 ***** 2025-10-08 12:53:17.209860 | controller | ok: [instance] => changed=false 2025-10-08 12:53:17.210089 | controller | msg: SNR deployment verification logic behaves as expected 2025-10-08 12:53:17.210273 | controller | 2025-10-08 12:53:17.210454 | controller | TASK [Verify NHC Subscription exists] ****************************************** 2025-10-08 12:53:17.210653 | controller | Wednesday 08 October 2025 12:53:17 +0000 (0:00:00.020) 0:00:13.984 ***** 2025-10-08 12:53:18.393390 | controller | ok: [instance] 2025-10-08 12:53:18.411710 | controller | 2025-10-08 12:53:18.411740 | controller | TASK [Display NHC Subscription verification result] **************************** 2025-10-08 12:53:18.411748 | controller | Wednesday 08 October 2025 12:53:18 +0000 (0:00:01.182) 0:00:15.167 ***** 2025-10-08 12:53:18.411759 | controller | ok: [instance] => 2025-10-08 12:53:18.411766 | 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-08 12:53:18.411774 | 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: : 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-1759927997.2217753-29545-78332732007381/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927997.2217753-29545-78332732007381/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927997.2217753-29545-78332732007381/AnsiballZ_k8s.py", 2025-10-08 12:53:18.411780 | 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_ncje7gin/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_ncje7gin/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_ncje7gin/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-10-08 12:53:18.411790 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_ncje7gin/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_ncje7gin/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_ncje7gin/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_ncje7gin/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_ncje7gin/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:18.411824 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_ncje7gin/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-08 12:53:18.412084 | 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-08 12:53:18.413065 | 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(\'': 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-08 12:53:18.413107 | 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-08 12:53:18.413124 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : 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-1759927997.2217753-29545-78332732007381/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927997.2217753-29545-78332732007381/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927997.2217753-29545-78332732007381/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-08 12:53:18.413130 | 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_ncje7gin/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_ncje7gin/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_ncje7gin/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_ncje7gin/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-10-08 12:53:18.413139 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_ncje7gin/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_ncje7gin/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_ncje7gin/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_ncje7gin/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_ncje7gin/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:18.417416 | 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-08 12:53:18.417441 | 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-08 12:53:18.417449 | 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(\'': 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-08 12:53:18.417459 | controller | 2025-10-08 12:53:19.537773 | controller | TASK [Test NHC Subscription creation idempotency] ****************************** 2025-10-08 12:53:19.537805 | controller | Wednesday 08 October 2025 12:53:18 +0000 (0:00:00.024) 0:00:15.192 ***** 2025-10-08 12:53:19.537817 | controller | ok: [instance] 2025-10-08 12:53:19.561736 | controller | 2025-10-08 12:53:19.561767 | controller | TASK [Assert expected behavior for NHC Subscription creation] ****************** 2025-10-08 12:53:19.561774 | controller | Wednesday 08 October 2025 12:53:19 +0000 (0:00:01.119) 0:00:16.312 ***** 2025-10-08 12:53:19.561784 | controller | ok: [instance] => changed=false 2025-10-08 12:53:20.673835 | controller | msg: NHC Subscription creation task behaves consistently 2025-10-08 12:53:20.673864 | controller | 2025-10-08 12:53:20.673872 | controller | TASK [Verify CSV status] ******************************************************* 2025-10-08 12:53:20.673878 | controller | Wednesday 08 October 2025 12:53:19 +0000 (0:00:00.024) 0:00:16.336 ***** 2025-10-08 12:53:20.673888 | controller | ok: [instance] 2025-10-08 12:53:20.690107 | controller | 2025-10-08 12:53:20.690133 | controller | TASK [Display CSV verification result] ***************************************** 2025-10-08 12:53:20.690146 | controller | Wednesday 08 October 2025 12:53:20 +0000 (0:00:01.112) 0:00:17.448 ***** 2025-10-08 12:53:20.690160 | controller | ok: [instance] => 2025-10-08 12:53:20.691141 | 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-08 12:53:20.691175 | 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: : 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-1759927999.5749166-29884-179640606476297/AnsiballZ_k8s_info.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927999.5749166-29884-179640606476297/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927999.5749166-29884-179640606476297/AnsiballZ_k8s_info.py", 2025-10-08 12:53:20.691188 | 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_y4jtt4k9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in \n File "/tmp/ansible_kubernetes.core.k8s_info_payload_y4jtt4k9/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_y4jtt4k9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", 2025-10-08 12:53:20.691199 | controller | line 352, in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_y4jtt4k9/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_y4jtt4k9/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_y4jtt4k9/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_y4jtt4k9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 2025-10-08 12:53:20.691208 | controller | 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_y4jtt4k9/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-08 12:53:20.691218 | 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-08 12:53:20.691241 | 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(\'': 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-08 12:53:20.691250 | 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-08 12:53:20.691259 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : 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-1759927999.5749166-29884-179640606476297/AnsiballZ_k8s_info.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759927999.5749166-29884-179640606476297/AnsiballZ_k8s_info.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759927999.5749166-29884-179640606476297/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-08 12:53:20.691266 | 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_y4jtt4k9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s_info.py", line 229, in \n File "/tmp/ansible_kubernetes.core.k8s_info_payload_y4jtt4k9/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_y4jtt4k9/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_y4jtt4k9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", 2025-10-08 12:53:20.691291 | controller | line 246, in wrapper\n File "/tmp/ansible_kubernetes.core.k8s_info_payload_y4jtt4k9/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_y4jtt4k9/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_y4jtt4k9/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_y4jtt4k9/ansible_kubernetes.core.k8s_info_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", line 2025-10-08 12:53:20.691670 | 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-08 12:53:20.696419 | 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-08 12:53:20.696437 | 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(\'': 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-08 12:53:20.696447 | controller | 2025-10-08 12:53:20.716160 | controller | TASK [Test CSV verification behavior] ****************************************** 2025-10-08 12:53:20.716183 | controller | Wednesday 08 October 2025 12:53:20 +0000 (0:00:00.022) 0:00:17.471 ***** 2025-10-08 12:53:20.716194 | controller | ok: [instance] => 2025-10-08 12:53:20.716349 | controller | msg: Testing CSV verification logic - expected to fail in mock environment 2025-10-08 12:53:20.716509 | controller | 2025-10-08 12:53:20.716651 | controller | TASK [Assert CSV verification behaves as expected] ***************************** 2025-10-08 12:53:20.716788 | controller | Wednesday 08 October 2025 12:53:20 +0000 (0:00:00.019) 0:00:17.491 ***** 2025-10-08 12:53:20.738802 | controller | ok: [instance] => changed=false 2025-10-08 12:53:20.738987 | controller | msg: CSV verification logic behaves as expected 2025-10-08 12:53:20.739175 | controller | 2025-10-08 12:53:20.739342 | controller | TASK [Verify NHC CR exists] **************************************************** 2025-10-08 12:53:20.739500 | controller | Wednesday 08 October 2025 12:53:20 +0000 (0:00:00.022) 0:00:17.513 ***** 2025-10-08 12:53:21.886908 | controller | ok: [instance] 2025-10-08 12:53:21.886978 | controller | 2025-10-08 12:53:21.887246 | controller | TASK [Display NHC CR verification result] ************************************** 2025-10-08 12:53:21.904126 | controller | Wednesday 08 October 2025 12:53:21 +0000 (0:00:01.147) 0:00:18.661 ***** 2025-10-08 12:53:21.904163 | controller | ok: [instance] => 2025-10-08 12:53:21.905095 | 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-08 12:53:21.905121 | 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: : 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-1759928000.7525964-30061-198764017810576/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759928000.7525964-30061-198764017810576/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759928000.7525964-30061-198764017810576/AnsiballZ_k8s.py", 2025-10-08 12:53:21.905132 | 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_zu64ro_8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_zu64ro_8/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_zu64ro_8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/runner.py", 2025-10-08 12:53:21.905138 | controller | line 88, in run_module\n File "/tmp/ansible_kubernetes.core.k8s_payload_zu64ro_8/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_zu64ro_8/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_zu64ro_8/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_zu64ro_8/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_zu64ro_8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:21.905146 | controller | line 45, in __init__\n File "/tmp/ansible_kubernetes.core.k8s_payload_zu64ro_8/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-08 12:53:21.905155 | 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-08 12:53:21.905178 | 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(\'': 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-08 12:53:21.905188 | 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-08 12:53:21.905195 | controller | NewConnectionError(\nurllib3.exceptions.NewConnectionError: : 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-1759928000.7525964-30061-198764017810576/AnsiballZ_k8s.py", line 107, in \n _ansiballz_main()\n File "/tmp/ansible-tmp-1759928000.7525964-30061-198764017810576/AnsiballZ_k8s.py", line 99, in _ansiballz_main\n invoke_module(zipped_mod, temp_path, ANSIBALLZ_PARAMS)\n File "/tmp/ansible-tmp-1759928000.7525964-30061-198764017810576/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-08 12:53:21.905203 | 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_zu64ro_8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/modules/k8s.py", line 509, in \n File "/tmp/ansible_kubernetes.core.k8s_payload_zu64ro_8/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_zu64ro_8/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_zu64ro_8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/k8s/client.py", line 352, 2025-10-08 12:53:21.905654 | controller | in get_api_client\n File "/tmp/ansible_kubernetes.core.k8s_payload_zu64ro_8/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_zu64ro_8/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_zu64ro_8/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_zu64ro_8/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_zu64ro_8/ansible_kubernetes.core.k8s_payload.zip/ansible_collections/kubernetes/core/plugins/module_utils/client/discovery.py", 2025-10-08 12:53:21.910503 | 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-08 12:53:21.910525 | 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-08 12:53:21.910534 | 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(\'': 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-08 12:53:21.910543 | controller | 2025-10-08 12:53:22.944650 | controller | TASK [Test NHC CR creation idempotency] **************************************** 2025-10-08 12:53:22.944710 | controller | Wednesday 08 October 2025 12:53:21 +0000 (0:00:00.023) 0:00:18.685 ***** 2025-10-08 12:53:22.944724 | controller | ok: [instance] 2025-10-08 12:53:22.967258 | controller | 2025-10-08 12:53:22.967286 | controller | TASK [Assert expected behavior for NHC CR creation] **************************** 2025-10-08 12:53:22.967294 | controller | Wednesday 08 October 2025 12:53:22 +0000 (0:00:01.033) 0:00:19.719 ***** 2025-10-08 12:53:22.967304 | controller | ok: [instance] => changed=false 2025-10-08 12:53:22.998133 | controller | msg: NHC CR creation task behaves consistently 2025-10-08 12:53:22.998163 | controller | 2025-10-08 12:53:22.998171 | controller | TASK [Verify role structure and logic] ***************************************** 2025-10-08 12:53:22.998178 | controller | Wednesday 08 October 2025 12:53:22 +0000 (0:00:00.022) 0:00:19.741 ***** 2025-10-08 12:53:22.998188 | controller | ok: [instance] => 2025-10-08 12:53:22.998212 | controller | msg: Role execution and verification completed - errors are expected in test environment without real K8s cluster 2025-10-08 12:53:22.999085 | controller | 2025-10-08 12:53:23.000787 | controller | PLAY RECAP ********************************************************************* 2025-10-08 12:53:23.000816 | controller | instance : ok=41 changed=0 unreachable=0 failed=0 skipped=20 rescued=1 ignored=0 2025-10-08 12:53:23.000823 | controller | 2025-10-08 12:53:23.000829 | controller | Wednesday 08 October 2025 12:53:22 +0000 (0:00:00.031) 0:00:19.772 ***** 2025-10-08 12:53:23.000835 | controller | =============================================================================== 2025-10-08 12:53:23.000840 | controller | Test kubernetes.core.k8s module availability ---------------------------- 1.44s 2025-10-08 12:53:23.000846 | controller | Verify namespace exists ------------------------------------------------- 1.29s 2025-10-08 12:53:23.000856 | controller | cifmw_snr_nhc : Create the workload-availability namespace -------------- 1.28s 2025-10-08 12:53:23.058343 | controller | Verify OperatorGroup exists --------------------------------------------- 1.19s 2025-10-08 12:53:23.058379 | controller | Test namespace creation idempotency ------------------------------------- 1.19s 2025-10-08 12:53:23.058387 | controller | Verify NHC Subscription exists ------------------------------------------ 1.18s 2025-10-08 12:53:23.058392 | controller | Test that Python kubernetes library is available ------------------------ 1.17s 2025-10-08 12:53:23.058398 | controller | Verify SNR Subscription exists ------------------------------------------ 1.15s 2025-10-08 12:53:23.058403 | controller | Test SNR Subscription creation idempotency ------------------------------ 1.15s 2025-10-08 12:53:23.058408 | controller | Verify NHC CR exists ---------------------------------------------------- 1.15s 2025-10-08 12:53:23.058413 | controller | Verify SNR deployment status -------------------------------------------- 1.14s 2025-10-08 12:53:23.058419 | controller | Test NHC Subscription creation idempotency ------------------------------ 1.12s 2025-10-08 12:53:23.058424 | controller | Verify CSV status ------------------------------------------------------- 1.11s 2025-10-08 12:53:23.058433 | controller | Test OperatorGroup creation idempotency --------------------------------- 1.10s 2025-10-08 12:53:23.058458 | controller | Test NHC CR creation idempotency ---------------------------------------- 1.03s 2025-10-08 12:53:23.058463 | controller | Test that mock kubeconfig exists ---------------------------------------- 0.82s 2025-10-08 12:53:23.058468 | controller | Include the cifmw_snr_nhc role ------------------------------------------ 0.07s 2025-10-08 12:53:23.058474 | controller | Analyze specific error patterns ----------------------------------------- 0.04s 2025-10-08 12:53:23.058479 | controller | cifmw_snr_nhc : Delete existing Subscriptions --------------------------- 0.03s 2025-10-08 12:53:23.058484 | controller | Verify role structure and logic ----------------------------------------- 0.03s 2025-10-08 12:53:23.058495 | controller | INFO Running default > verify 2025-10-08 12:53:23.058878 | controller | INFO Running Ansible Verifier 2025-10-08 12:53:23.497446 | controller | 2025-10-08 12:53:23.497659 | controller | PLAY [Verify] ****************************************************************** 2025-10-08 12:53:23.497804 | controller | 2025-10-08 12:53:23.497951 | controller | TASK [Check if Python kubernetes library is installed] ************************* 2025-10-08 12:53:23.498117 | controller | Wednesday 08 October 2025 12:53:23 +0000 (0:00:00.021) 0:00:00.021 ***** 2025-10-08 12:53:24.759919 | controller | ok: [instance] 2025-10-08 12:53:24.759980 | controller | 2025-10-08 12:53:24.759991 | controller | TASK [Display kubernetes library version] ************************************** 2025-10-08 12:53:24.781848 | controller | Wednesday 08 October 2025 12:53:24 +0000 (0:00:01.262) 0:00:01.283 ***** 2025-10-08 12:53:24.781878 | controller | ok: [instance] => 2025-10-08 12:53:25.709869 | controller | msg: 'kubernetes library version: 34.1.0' 2025-10-08 12:53:25.709901 | controller | 2025-10-08 12:53:25.709909 | controller | TASK [Verify kubeconfig mock file exists] ************************************** 2025-10-08 12:53:25.709915 | controller | Wednesday 08 October 2025 12:53:24 +0000 (0:00:00.021) 0:00:01.305 ***** 2025-10-08 12:53:25.709925 | controller | ok: [instance] 2025-10-08 12:53:25.730844 | controller | 2025-10-08 12:53:25.730866 | controller | TASK [Assert kubeconfig mock file exists] ************************************** 2025-10-08 12:53:25.730874 | controller | Wednesday 08 October 2025 12:53:25 +0000 (0:00:00.928) 0:00:02.233 ***** 2025-10-08 12:53:25.730883 | controller | ok: [instance] => changed=false 2025-10-08 12:53:26.377662 | controller | msg: Mock kubeconfig file exists 2025-10-08 12:53:26.377696 | controller | 2025-10-08 12:53:26.377704 | controller | TASK [Verify kubeadmin password mock file exists] ****************************** 2025-10-08 12:53:26.377710 | controller | Wednesday 08 October 2025 12:53:25 +0000 (0:00:00.021) 0:00:02.255 ***** 2025-10-08 12:53:26.377720 | controller | ok: [instance] 2025-10-08 12:53:26.399821 | controller | 2025-10-08 12:53:26.399865 | controller | TASK [Assert kubeadmin password mock file exists] ****************************** 2025-10-08 12:53:26.399874 | controller | Wednesday 08 October 2025 12:53:26 +0000 (0:00:00.646) 0:00:02.901 ***** 2025-10-08 12:53:26.399884 | controller | ok: [instance] => changed=false 2025-10-08 12:53:27.130828 | controller | msg: Mock kubeadmin password file exists 2025-10-08 12:53:27.130864 | controller | 2025-10-08 12:53:27.130872 | controller | TASK [Test Python yaml library] ************************************************ 2025-10-08 12:53:27.130879 | controller | Wednesday 08 October 2025 12:53:26 +0000 (0:00:00.022) 0:00:02.923 ***** 2025-10-08 12:53:27.130889 | controller | ok: [instance] 2025-10-08 12:53:27.130933 | controller | 2025-10-08 12:53:27.131138 | controller | TASK [Display yaml test result] ************************************************ 2025-10-08 12:53:27.166393 | controller | Wednesday 08 October 2025 12:53:27 +0000 (0:00:00.731) 0:00:03.655 ***** 2025-10-08 12:53:27.166430 | controller | ok: [instance] => 2025-10-08 12:53:27.208794 | controller | msg: yaml library works 2025-10-08 12:53:27.208821 | controller | 2025-10-08 12:53:27.208829 | controller | PLAY RECAP ********************************************************************* 2025-10-08 12:53:27.208835 | controller | instance : ok=8 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2025-10-08 12:53:27.208841 | controller | 2025-10-08 12:53:27.208846 | controller | Wednesday 08 October 2025 12:53:27 +0000 (0:00:00.034) 0:00:03.689 ***** 2025-10-08 12:53:27.208852 | controller | =============================================================================== 2025-10-08 12:53:27.208857 | controller | Check if Python kubernetes library is installed ------------------------- 1.26s 2025-10-08 12:53:27.208862 | controller | Verify kubeconfig mock file exists -------------------------------------- 0.93s 2025-10-08 12:53:27.208868 | controller | Test Python yaml library ------------------------------------------------ 0.73s 2025-10-08 12:53:27.208873 | controller | Verify kubeadmin password mock file exists ------------------------------ 0.65s 2025-10-08 12:53:27.208884 | controller | Display yaml test result ------------------------------------------------ 0.03s 2025-10-08 12:53:27.208889 | controller | Assert kubeadmin password mock file exists ------------------------------ 0.02s 2025-10-08 12:53:27.208894 | controller | Display kubernetes library version -------------------------------------- 0.02s 2025-10-08 12:53:27.208900 | controller | Assert kubeconfig mock file exists -------------------------------------- 0.02s 2025-10-08 12:53:27.208910 | controller | INFO Verifier completed successfully. 2025-10-08 12:53:27.218758 | controller | INFO Running default > destroy 2025-10-08 12:53:27.640931 | controller | 2025-10-08 12:53:27.949483 | controller | PLAY [Destroy] ***************************************************************** 2025-10-08 12:53:27.949514 | controller | 2025-10-08 12:53:27.949522 | controller | TASK [Get passwd entries for USER env] ***************************************** 2025-10-08 12:53:27.949528 | controller | Wednesday 08 October 2025 12:53:27 +0000 (0:00:00.014) 0:00:00.014 ***** 2025-10-08 12:53:27.949538 | controller | ok: [localhost] 2025-10-08 12:53:27.992137 | controller | 2025-10-08 12:53:27.992167 | controller | TASK [Get shell async_dir] ***************************************************** 2025-10-08 12:53:27.992176 | controller | Wednesday 08 October 2025 12:53:27 +0000 (0:00:00.308) 0:00:00.323 ***** 2025-10-08 12:53:27.992185 | controller | ok: [localhost] 2025-10-08 12:53:28.025711 | controller | 2025-10-08 12:53:28.025734 | controller | TASK [Set async_dir for HOME env] ********************************************** 2025-10-08 12:53:28.025742 | controller | Wednesday 08 October 2025 12:53:27 +0000 (0:00:00.042) 0:00:00.366 ***** 2025-10-08 12:53:28.025752 | controller | skipping: [localhost] 2025-10-08 12:53:28.422135 | controller | 2025-10-08 12:53:28.422177 | controller | TASK [Destroy molecule instance(s)] ******************************************** 2025-10-08 12:53:28.422186 | controller | Wednesday 08 October 2025 12:53:28 +0000 (0:00:00.033) 0:00:00.399 ***** 2025-10-08 12:53:28.422204 | 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-08 12:53:28.422354 | controller | 2025-10-08 12:53:28.422365 | controller | TASK [Wait for instance(s) deletion to complete] ******************************* 2025-10-08 12:53:28.422374 | controller | Wednesday 08 October 2025 12:53:28 +0000 (0:00:00.395) 0:00:00.795 ***** 2025-10-08 12:53:39.074140 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (300 retries left). 2025-10-08 12:53:39.074227 | controller | FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (299 retries left). 2025-10-08 12:53:39.074245 | controller | changed: [localhost] => (item={'failed': 0, 'started': 1, 'finished': 0, 'ansible_job_id': 'j692634049576.31130', 'results_file': '/home/zuul/.ansible_async/j692634049576.31130', '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-08 12:53:39.074253 | controller | 2025-10-08 12:53:39.074259 | controller | TASK [Delete podman network dedicated to this scenario] ************************ 2025-10-08 12:53:39.074268 | controller | Wednesday 08 October 2025 12:53:39 +0000 (0:00:10.652) 0:00:11.447 ***** 2025-10-08 12:53:39.124128 | controller | skipping: [localhost] => (item=instance: None specified) 2025-10-08 12:53:39.125099 | controller | skipping: [localhost] 2025-10-08 12:53:39.125637 | controller | 2025-10-08 12:53:39.125668 | controller | PLAY RECAP ********************************************************************* 2025-10-08 12:53:39.125677 | controller | localhost : ok=4 changed=2 unreachable=0 failed=0 skipped=2 rescued=0 ignored=0 2025-10-08 12:53:39.125683 | controller | 2025-10-08 12:53:39.125689 | controller | Wednesday 08 October 2025 12:53:39 +0000 (0:00:00.050) 0:00:11.498 ***** 2025-10-08 12:53:39.125694 | controller | =============================================================================== 2025-10-08 12:53:39.125701 | controller | Wait for instance(s) deletion to complete ------------------------------ 10.65s 2025-10-08 12:53:39.125711 | controller | Destroy molecule instance(s) -------------------------------------------- 0.40s 2025-10-08 12:53:39.172070 | controller | Get passwd entries for USER env ----------------------------------------- 0.31s 2025-10-08 12:53:39.172102 | controller | Delete podman network dedicated to this scenario ------------------------ 0.05s 2025-10-08 12:53:39.172110 | controller | Get shell async_dir ----------------------------------------------------- 0.04s 2025-10-08 12:53:39.172115 | controller | Set async_dir for HOME env ---------------------------------------------- 0.03s 2025-10-08 12:53:39.172126 | controller | INFO Pruning extra files from scenario ephemeral directory 2025-10-08 12:53:39.174163 | controller | INFO Writing /tmp/report.html report. 2025-10-08 12:53:39.665242 | controller | changed 2025-10-08 12:53:39.721584 | 2025-10-08 12:53:39.721680 | PLAY RECAP 2025-10-08 12:53:39.721724 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-10-08 12:53:39.721749 | 2025-10-08 12:53:39.907152 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-10-08 12:53:39.908038 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-08 12:53:40.564860 | 2025-10-08 12:53:40.565001 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-10-08 12:53:40.585611 | 2025-10-08 12:53:40.585705 | TASK [Filter out host if needed] 2025-10-08 12:53:40.594645 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-08 12:53:40.599157 | 2025-10-08 12:53:40.599226 | TASK [Ensure file is present] 2025-10-08 12:53:40.944203 | controller | ok 2025-10-08 12:53:40.959565 | 2025-10-08 12:53:40.959666 | TASK [Manage molecule report file] 2025-10-08 12:53:41.508065 | controller | changed 2025-10-08 12:53:41.514111 | 2025-10-08 12:53:41.514201 | TASK [Check if we get ci-framework-data basedir] 2025-10-08 12:53:41.697507 | controller | ok 2025-10-08 12:53:41.703392 | 2025-10-08 12:53:41.703479 | TASK [Create ci-framework-data log directory for zuul] 2025-10-08 12:53:42.027096 | controller | changed 2025-10-08 12:53:42.033394 | 2025-10-08 12:53:42.033480 | TASK [Copy ci-framework interesting files] 2025-10-08 12:53:42.228358 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-10-08 12:53:42.560997 | controller | changed 2025-10-08 12:53:42.573382 | 2025-10-08 12:53:42.573516 | TASK [Get SELinux listing] 2025-10-08 12:53:43.115692 | controller | changed 2025-10-08 12:53:43.122753 | 2025-10-08 12:53:43.122849 | TASK [Generate log index] 2025-10-08 12:53:43.793622 | controller | changed 2025-10-08 12:53:43.798787 | 2025-10-08 12:53:43.798862 | TASK [Get some env related data] 2025-10-08 12:53:44.345936 | controller | /home/zuul/.local/bin/ansible 2025-10-08 12:53:45.351397 | controller | changed 2025-10-08 12:53:45.357494 | 2025-10-08 12:53:45.357578 | TASK [Generate list of logs to collect in home directory] 2025-10-08 12:53:45.670593 | controller | ok: All paths examined 2025-10-08 12:53:45.676313 | 2025-10-08 12:53:45.676408 | LOOP [Copy logs from home directory] 2025-10-08 12:53:45.996382 | controller | changed: 2025-10-08 12:53:45.996493 | controller | { 2025-10-08 12:53:45.996520 | controller | "atime": 1759927921.0284169, 2025-10-08 12:53:45.996540 | controller | "ctime": 1759927936.9261687, 2025-10-08 12:53:45.996559 | controller | "dev": 64513, 2025-10-08 12:53:45.996576 | controller | "gid": 1000, 2025-10-08 12:53:45.996592 | controller | "gr_name": "zuul", 2025-10-08 12:53:45.996609 | controller | "inode": 4460563, 2025-10-08 12:53:45.996631 | controller | "isblk": false, 2025-10-08 12:53:45.996648 | controller | "ischr": false, 2025-10-08 12:53:45.996664 | controller | "isdir": false, 2025-10-08 12:53:45.996679 | controller | "isfifo": false, 2025-10-08 12:53:45.996694 | controller | "isgid": false, 2025-10-08 12:53:45.996709 | controller | "islnk": false, 2025-10-08 12:53:45.996724 | controller | "isreg": true, 2025-10-08 12:53:45.996739 | controller | "issock": false, 2025-10-08 12:53:45.996755 | controller | "isuid": false, 2025-10-08 12:53:45.996770 | controller | "mode": "0644", 2025-10-08 12:53:45.996785 | controller | "mtime": 1759927936.9261687, 2025-10-08 12:53:45.996801 | controller | "nlink": 1, 2025-10-08 12:53:45.996818 | controller | "path": "/home/zuul/ansible.log", 2025-10-08 12:53:45.996836 | controller | "pw_name": "zuul", 2025-10-08 12:53:45.996853 | controller | "rgrp": true, 2025-10-08 12:53:45.996869 | controller | "roth": true, 2025-10-08 12:53:45.996884 | controller | "rusr": true, 2025-10-08 12:53:45.996899 | controller | "size": 6749, 2025-10-08 12:53:45.996937 | controller | "uid": 1000, 2025-10-08 12:53:45.996956 | controller | "wgrp": false, 2025-10-08 12:53:45.996982 | controller | "woth": false, 2025-10-08 12:53:45.997001 | controller | "wusr": true, 2025-10-08 12:53:45.997018 | controller | "xgrp": false, 2025-10-08 12:53:45.997034 | controller | "xoth": false, 2025-10-08 12:53:45.997049 | controller | "xusr": false 2025-10-08 12:53:45.997064 | controller | } 2025-10-08 12:53:46.010745 | 2025-10-08 12:53:46.010858 | TASK [Copy crio stats log file] 2025-10-08 12:53:46.034670 | controller | skipping: Conditional result was False 2025-10-08 12:53:46.041788 | 2025-10-08 12:53:46.041901 | TASK [Get SELinux related data] 2025-10-08 12:53:46.255643 | controller | 2025-10-08 12:53:46.570506 | controller | ERROR 2025-10-08 12:53:46.570718 | controller | { 2025-10-08 12:53:46.570752 | controller | "delta": "0:00:00.009314", 2025-10-08 12:53:46.570775 | controller | "end": "2025-10-08 12:53:46.256269", 2025-10-08 12:53:46.570794 | controller | "msg": "non-zero return code", 2025-10-08 12:53:46.570811 | controller | "rc": 1, 2025-10-08 12:53:46.570828 | controller | "start": "2025-10-08 12:53:46.246955" 2025-10-08 12:53:46.570845 | controller | } 2025-10-08 12:53:46.570868 | controller | ERROR: Ignoring Errors 2025-10-08 12:53:46.576216 | 2025-10-08 12:53:46.576281 | TASK [Create system configuration directory] 2025-10-08 12:53:46.767286 | controller | changed 2025-10-08 12:53:46.772803 | 2025-10-08 12:53:46.772925 | TASK [Get some of the system configurations] 2025-10-08 12:53:47.309008 | controller | changed 2025-10-08 12:53:47.316176 | 2025-10-08 12:53:47.316302 | TASK [Copy generated documentation if available] 2025-10-08 12:53:47.340159 | controller | skipping: Conditional result was False 2025-10-08 12:53:47.347532 | 2025-10-08 12:53:47.347638 | TASK [Copy generated AsciiDoc documentation if available] 2025-10-08 12:53:47.371757 | controller | skipping: Conditional result was False 2025-10-08 12:53:47.379174 | 2025-10-08 12:53:47.379281 | TASK [Compress logs bigger than 2MB] 2025-10-08 12:53:47.919420 | controller | changed 2025-10-08 12:53:47.925199 | 2025-10-08 12:53:47.925267 | TASK [Copy files from workspace on node] 2025-10-08 12:53:47.945415 | controller | ok 2025-10-08 12:53:47.971808 | 2025-10-08 12:53:47.971948 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-08 12:53:47.998850 | controller | skipping: Conditional result was False 2025-10-08 12:53:48.005023 | 2025-10-08 12:53:48.005207 | TASK [fetch-output : Set log path for single node] 2025-10-08 12:53:48.037221 | controller | ok 2025-10-08 12:53:48.042551 | 2025-10-08 12:53:48.042628 | LOOP [fetch-output : Ensure local output dirs] 2025-10-08 12:53:48.270306 | controller -> localhost | ok: "/var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/logs" 2025-10-08 12:53:48.270592 | controller -> localhost | changed: All items complete 2025-10-08 12:53:48.270640 | 2025-10-08 12:53:48.472454 | controller -> localhost | changed: "/var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/artifacts" 2025-10-08 12:53:48.676747 | controller -> localhost | changed: "/var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/docs" 2025-10-08 12:53:48.687557 | 2025-10-08 12:53:48.687648 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-08 12:53:49.290934 | controller | changed: 2025-10-08 12:53:49.291169 | controller | .d..t...... ./ 2025-10-08 12:53:49.291231 | controller | >f+++++++++ README.html 2025-10-08 12:53:49.291256 | controller | >f+++++++++ ansible-execution.log 2025-10-08 12:53:49.291308 | controller | >f+++++++++ ansible.log 2025-10-08 12:53:49.291332 | controller | >f+++++++++ dmesg.log 2025-10-08 12:53:49.291377 | controller | >f+++++++++ installed-pkgs.log 2025-10-08 12:53:49.291402 | controller | >f+++++++++ python.log 2025-10-08 12:53:49.291445 | controller | >f+++++++++ registries.conf 2025-10-08 12:53:49.291472 | controller | >f+++++++++ report.html 2025-10-08 12:53:49.291494 | controller | >f+++++++++ selinux-denials.log 2025-10-08 12:53:49.291536 | controller | >f+++++++++ selinux-listing.log 2025-10-08 12:53:49.291558 | controller | cd+++++++++ ci-framework-data/ 2025-10-08 12:53:49.291576 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-10-08 12:53:49.291617 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-10-08 12:53:49.291638 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-10-08 12:53:49.291656 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-10-08 12:53:49.291697 | controller | cd+++++++++ ci-framework-data/logs/ 2025-10-08 12:53:49.291717 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log 2025-10-08 12:53:49.291735 | controller | cd+++++++++ registries.conf.d/ 2025-10-08 12:53:49.291775 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-10-08 12:53:49.291796 | controller | cd+++++++++ system-config/ 2025-10-08 12:53:49.291815 | controller | cd+++++++++ system-config/libvirt/ 2025-10-08 12:53:49.291853 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-10-08 12:53:49.291875 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-10-08 12:53:49.692255 | controller | changed: .d..t...... ./ 2025-10-08 12:53:50.088922 | controller | changed: .d..t...... ./ 2025-10-08 12:53:50.111945 | 2025-10-08 12:53:50.112059 | TASK [Return artifact to Zuul] 2025-10-08 12:53:50.140887 | controller | ok 2025-10-08 12:53:50.159702 | 2025-10-08 12:53:50.159768 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-10-08 12:53:50.159866 | 2025-10-08 12:53:50.159894 | PLAY RECAP 2025-10-08 12:53:50.159958 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1 2025-10-08 12:53:50.159996 | 2025-10-08 12:53:50.240499 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-08 12:53:50.241328 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-08 12:53:50.789501 | 2025-10-08 12:53:50.789614 | PLAY [all] 2025-10-08 12:53:50.809000 | 2025-10-08 12:53:50.809110 | TASK [include_role : fetch-output] 2025-10-08 12:53:50.840320 | controller | ok 2025-10-08 12:53:50.857295 | 2025-10-08 12:53:50.857419 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-08 12:53:50.911994 | controller | skipping: Conditional result was False 2025-10-08 12:53:50.917759 | 2025-10-08 12:53:50.917844 | TASK [fetch-output : Set log path for single node] 2025-10-08 12:53:50.946764 | controller | ok 2025-10-08 12:53:50.954295 | 2025-10-08 12:53:50.954399 | LOOP [fetch-output : Ensure local output dirs] 2025-10-08 12:53:51.357796 | controller -> localhost | ok: "/var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/logs" 2025-10-08 12:53:51.582621 | controller -> localhost | ok: "/var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/artifacts" 2025-10-08 12:53:51.799613 | controller -> localhost | ok: "/var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/docs" 2025-10-08 12:53:51.813751 | 2025-10-08 12:53:51.814102 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-08 12:53:52.397463 | controller | ok 2025-10-08 12:53:52.397673 | controller | ok: All items complete 2025-10-08 12:53:52.397710 | 2025-10-08 12:53:52.841655 | controller | ok 2025-10-08 12:53:53.249180 | controller | ok 2025-10-08 12:53:53.272181 | 2025-10-08 12:53:53.272345 | TASK [include_role : fetch-output-openshift] 2025-10-08 12:53:53.287519 | controller | skipping: Conditional result was False 2025-10-08 12:53:53.294667 | 2025-10-08 12:53:53.294943 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-08 12:53:53.672456 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008966 2025-10-08 12:53:53.892229 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007960 2025-10-08 12:53:53.923990 | 2025-10-08 12:53:53.924068 | PLAY [all] 2025-10-08 12:53:53.938643 | 2025-10-08 12:53:53.938723 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-08 12:53:54.355056 | controller | changed 2025-10-08 12:53:54.379209 | 2025-10-08 12:53:54.379285 | PLAY RECAP 2025-10-08 12:53:54.379330 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-08 12:53:54.379353 | 2025-10-08 12:53:54.455694 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-08 12:53:54.456493 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-08 12:53:55.058796 | 2025-10-08 12:53:55.058898 | PLAY [localhost] 2025-10-08 12:53:55.077089 | 2025-10-08 12:53:55.077169 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-08 12:53:55.411487 | localhost | changed 2025-10-08 12:53:55.416077 | 2025-10-08 12:53:55.416171 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-08 12:53:55.445590 | localhost | ok 2025-10-08 12:53:55.454791 | 2025-10-08 12:53:55.454896 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-08 12:53:55.800092 | localhost | changed 2025-10-08 12:53:55.806547 | 2025-10-08 12:53:55.806666 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-08 12:53:56.407619 | localhost | changed 2025-10-08 12:53:56.415830 | 2025-10-08 12:53:56.415934 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-08 12:53:56.817139 | localhost | Identity added: /var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/tmp/ansible.290qvaai (/var/lib/zuul/builds/b45ae928658a45c58ed9229164a87ab4/work/tmp/ansible.290qvaai) 2025-10-08 12:53:56.817350 | localhost | ok: Runtime: 0:00:00.007743 2025-10-08 12:53:56.824119 | 2025-10-08 12:53:56.824196 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-08 12:53:57.110594 | localhost | ok: Runtime: 0:00:00.004746 2025-10-08 12:53:57.116840 | 2025-10-08 12:53:57.116960 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-08 12:53:57.167671 | localhost | changed 2025-10-08 12:53:57.172010 | 2025-10-08 12:53:57.172107 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-08 12:53:57.546521 | localhost | changed 2025-10-08 12:53:57.569241 | 2025-10-08 12:53:57.569343 | PLAY [localhost] 2025-10-08 12:53:57.583127 | 2025-10-08 12:53:57.583205 | TASK [Generate bulk log download script] 2025-10-08 12:53:57.600692 | localhost | ok 2025-10-08 12:53:57.613773 | 2025-10-08 12:53:57.613856 | TASK [local-log-download : Check API endpoint is defined] 2025-10-08 12:53:57.642679 | localhost | ok: All assertions passed 2025-10-08 12:53:57.647368 | 2025-10-08 12:53:57.647445 | TASK [local-log-download : Create download script] 2025-10-08 12:53:58.016065 | localhost -> localhost | changed 2025-10-08 12:53:58.024484 | 2025-10-08 12:53:58.024570 | TASK [Register quick-download link] 2025-10-08 12:53:58.042028 | localhost | ok 2025-10-08 12:53:58.085322 | 2025-10-08 12:53:58.085415 | PLAY [logserver.rdoproject.org] 2025-10-08 12:53:58.095261 | 2025-10-08 12:53:58.095330 | TASK [Set zuul-log-path fact] 2025-10-08 12:53:58.111366 | logserver.rdoproject.org | ok 2025-10-08 12:53:58.121307 | 2025-10-08 12:53:58.121393 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-08 12:53:58.147381 | logserver.rdoproject.org | ok 2025-10-08 12:53:58.153668 | 2025-10-08 12:53:58.153754 | TASK [upload-logs : Create log directories] 2025-10-08 12:53:59.808629 | logserver.rdoproject.org | changed 2025-10-08 12:53:59.812180 | 2025-10-08 12:53:59.812267 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-08 12:54:00.092097 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.006104 2025-10-08 12:54:00.098064 | 2025-10-08 12:54:00.098158 | TASK [upload-logs : Upload logs to log server] 2025-10-08 12:54:01.767599 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-08 12:54:01.770829 | 2025-10-08 12:54:01.770901 | LOOP [upload-logs : Compress console log and json output] 2025-10-08 12:54:01.811132 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-08 12:54:01.819823 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-08 12:54:01.829062 | 2025-10-08 12:54:01.829142 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-08 12:54:01.873964 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-08 12:54:01.874221 | 2025-10-08 12:54:01.878863 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-08 12:54:01.886788 | 2025-10-08 12:54:01.886859 | LOOP [upload-logs : Upload console log and json output]