2026-01-29 15:28:33,560 - INFO - Reading existing Domain with UUID 5762e81a-fedf-4255-81ca-e05b2ea83674
2026-01-29 15:28:33,574 - INFO - Using existing domain ['admin_domain'](5762e81a-fedf-4255-81ca-e05b2ea83674)
2026-01-29 15:28:33,789 - INFO - Project ctest-TestPorts-58240869 not found, creating it
2026-01-29 15:28:34,330 - INFO - Created Project:ctest-TestPorts-58240869, ID : 2192e931-9e2e-48b1-b3c2-dcdc4325f981
2026-01-29 15:28:36,249 - INFO - ================================================================================
2026-01-29 15:28:36,249 - INFO - STARTING TEST : test_ports_bindings
2026-01-29 15:28:36,249 - INFO - TEST DESCRIPTION :
Verify that we are able to create a port with custom port bindings
Steps:
1) Create Port with Port bindings profile set to {'foo': 'bar'}
2) Retrieve and verify the same is set
2026-01-29 15:28:36,645 - DEBUG - Nothing to compare xmpp stats {'10.0.0.61': {'10.0.0.61': '0'}} with
2026-01-29 15:28:36,645 - INFO - Initial checks done. Running the testcase now
2026-01-29 15:28:36,645 - INFO -
2026-01-29 15:28:37,400 - DEBUG - Response for create_network : {'network': {'id': '2f5625fc-6e89-4ae1-8b44-6992a2167225', 'name': 'ctest-vn-93449131', 'tenant_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'project_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['admin_domain', 'ctest-TestPorts-58240869', 'ctest-vn-93449131'], 'port_security_enabled': True, 'description': '', 'created_at': None, 'updated_at': None}}
2026-01-29 15:28:37,625 - DEBUG - Response for create_subnet : {'subnet': {'id': '3e434b9c-bdef-4044-8344-025646c2400c', 'name': '', 'tenant_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'network_id': '2f5625fc-6e89-4ae1-8b44-6992a2167225', 'ip_version': 4, 'cidr': '76.10.227.64/26', 'allocation_pools': [{'start': '76.10.227.66', 'end': '76.10.227.126'}], 'gateway_ip': '76.10.227.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'created_at': '2026-01-29T15:28:37.529670', 'updated_at': '2026-01-29T15:28:37.529670', 'dns_server_address': '76.10.227.66', 'tags': [], 'project_id': '2192e9319e2e48b1b3c2dcdc4325f981'}}
2026-01-29 15:28:37,694 - INFO - Created VN ctest-vn-93449131
2026-01-29 15:28:37,748 - DEBUG - VN ctest-vn-93449131 UUID is 2f5625fc-6e89-4ae1-8b44-6992a2167225
2026-01-29 15:28:37,954 - DEBUG - Read virtual machine interface {'fq_name': ['admin_domain', 'ctest-TestPorts-58240869', 'ctest-vmi-44114325']}
2026-01-29 15:28:38,265 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-44114325', 'id': 'b5ebbe98-ef21-4510-979e-7508298278c6', 'tenant_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'network_id': '2f5625fc-6e89-4ae1-8b44-6992a2167225', 'mac_address': '02:b5:eb:be:98:ef', 'binding:profile': {'foo': 'bar'}, 'binding:vnic_type': 'normal', 'binding:vif_details': {'port_filter': True}, 'binding:vif_type': 'unbound', 'binding:host_id': None, 'allowed_address_pairs': [], 'fixed_ips': [{'ip_address': '76.10.227.67', 'subnet_id': '3e434b9c-bdef-4044-8344-025646c2400c'}], 'security_groups': ['b0bcac46-361f-48a5-8d6f-c36c544a3134'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'created_at': '2026-01-29T15:28:38.064146', 'updated_at': '2026-01-29T15:28:38.129256', 'project_id': '2192e9319e2e48b1b3c2dcdc4325f981'}}
2026-01-29 15:28:38,265 - DEBUG - Created port b5ebbe98-ef21-4510-979e-7508298278c6
2026-01-29 15:28:38,372 - DEBUG - Requesting: https://10.0.0.61:8082/virtual-machine-interface/b5ebbe98-ef21-4510-979e-7508298278c6
2026-01-29 15:28:38,717 - DEBUG - Requesting: https://10.0.0.61:8082/virtual-machine-interface/b5ebbe98-ef21-4510-979e-7508298278c6
2026-01-29 15:28:38,801 - INFO - VMI b5ebbe98-ef21-4510-979e-7508298278c6 verification in API Server passed
2026-01-29 15:28:38,966 - DEBUG - Response for delete_port : ()
2026-01-29 15:28:38,967 - INFO - Deleted port b5ebbe98-ef21-4510-979e-7508298278c6
2026-01-29 15:28:38,967 - INFO - Deleting VN ctest-vn-93449131
2026-01-29 15:28:39,145 - DEBUG - Response for deleting network ()
2026-01-29 15:28:39,534 - DEBUG - No XMPP flaps were noticed during the test
2026-01-29 15:28:39,534 - INFO - END TEST : test_ports_bindings : PASSED[0:00:03]
2026-01-29 15:28:39,534 - INFO - --------------------------------------------------------------------------------
2026-01-29 15:28:39,540 - INFO - ================================================================================
2026-01-29 15:28:39,540 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2026-01-29 15:28:39,540 - INFO - TEST DESCRIPTION : Create ports with specific Subnet and IP
Create two ports in a VN with 2 subnets and specific IPs
Attach to two VMs
Ping between them should pass
2026-01-29 15:28:39,925 - DEBUG - Nothing to compare xmpp stats {'10.0.0.61': {'10.0.0.61': '0'}} with
2026-01-29 15:28:39,925 - INFO - Initial checks done. Running the testcase now
2026-01-29 15:28:39,925 - INFO -
2026-01-29 15:28:40,228 - DEBUG - Response for create_network : {'network': {'id': '4b10501b-84f4-4d9c-8632-7503c4d036b5', 'name': 'ctest-vn1-63129368', 'tenant_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'project_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['admin_domain', 'ctest-TestPorts-58240869', 'ctest-vn1-63129368'], 'port_security_enabled': True, 'description': '', 'created_at': None, 'updated_at': None}}
2026-01-29 15:28:40,453 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fa1f2f6a-75ee-4a5a-bcee-594ab615fd7a', 'name': '', 'tenant_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'network_id': '4b10501b-84f4-4d9c-8632-7503c4d036b5', 'ip_version': 4, 'cidr': '24.201.216.64/26', 'allocation_pools': [{'start': '24.201.216.66', 'end': '24.201.216.126'}], 'gateway_ip': '24.201.216.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'created_at': '2026-01-29T15:28:40.340060', 'updated_at': '2026-01-29T15:28:40.340060', 'dns_server_address': '24.201.216.66', 'tags': [], 'project_id': '2192e9319e2e48b1b3c2dcdc4325f981'}}
2026-01-29 15:28:40,650 - DEBUG - Response for create_subnet : {'subnet': {'id': '0d2f8d23-ccbe-4456-9d1d-3efb244a1d1b', 'name': '', 'tenant_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'network_id': '4b10501b-84f4-4d9c-8632-7503c4d036b5', 'ip_version': 4, 'cidr': '96.193.16.192/26', 'allocation_pools': [{'start': '96.193.16.194', 'end': '96.193.16.254'}], 'gateway_ip': '96.193.16.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'created_at': '2026-01-29T15:28:40.549571', 'updated_at': '2026-01-29T15:28:40.549571', 'dns_server_address': '96.193.16.194', 'tags': [], 'project_id': '2192e9319e2e48b1b3c2dcdc4325f981'}}
2026-01-29 15:28:40,718 - INFO - Created VN ctest-vn1-63129368
2026-01-29 15:28:40,772 - DEBUG - VN ctest-vn1-63129368 UUID is 4b10501b-84f4-4d9c-8632-7503c4d036b5
2026-01-29 15:28:41,302 - DEBUG - Response for create_port : {'port': {'name': 'f3c909a2-5a3f-4b03-b1da-98a6c6105b3a', 'id': 'f3c909a2-5a3f-4b03-b1da-98a6c6105b3a', 'tenant_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'network_id': '4b10501b-84f4-4d9c-8632-7503c4d036b5', 'mac_address': '02:f3:c9:09:a2:5a', 'binding:vnic_type': 'normal', 'binding:vif_details': {'port_filter': True}, 'binding:vif_type': 'unbound', 'binding:host_id': None, 'allowed_address_pairs': [], 'fixed_ips': [{'ip_address': '24.201.216.69', 'subnet_id': 'fa1f2f6a-75ee-4a5a-bcee-594ab615fd7a'}], 'security_groups': ['b0bcac46-361f-48a5-8d6f-c36c544a3134'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'created_at': '2026-01-29T15:28:41.122721', 'updated_at': '2026-01-29T15:28:41.190245', 'project_id': '2192e9319e2e48b1b3c2dcdc4325f981'}}
2026-01-29 15:28:41,561 - DEBUG - Response for create_port : {'port': {'name': '0dbd9044-9301-4dbf-808f-69a161d4ff89', 'id': '0dbd9044-9301-4dbf-808f-69a161d4ff89', 'tenant_id': '2192e9319e2e48b1b3c2dcdc4325f981', 'network_id': '4b10501b-84f4-4d9c-8632-7503c4d036b5', 'mac_address': '02:0d:bd:90:44:93', 'binding:vnic_type': 'normal', 'binding:vif_details': {'port_filter': True}, 'binding:vif_type': 'unbound', 'binding:host_id': None, 'allowed_address_pairs': [], 'fixed_ips': [{'ip_address': '96.193.16.197', 'subnet_id': '0d2f8d23-ccbe-4456-9d1d-3efb244a1d1b'}], 'security_groups': ['b0bcac46-361f-48a5-8d6f-c36c544a3134'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'created_at': '2026-01-29T15:28:41.377671', 'updated_at': '2026-01-29T15:28:41.440443', 'project_id': '2192e9319e2e48b1b3c2dcdc4325f981'}}
2026-01-29 15:28:41,679 - DEBUG - Services list from nova: [, , ]
2026-01-29 15:28:42,486 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-juju-os-655-1), Zone: (nova:cn-jenkins-deploy-platform-juju-os-655-1)
2026-01-29 15:28:43,452 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-juju-os-655-1), Zone: (nova:cn-jenkins-deploy-platform-juju-os-655-1)
2026-01-29 15:28:43,452 - INFO - Waiting for VM ctest-vn1-vm1-45362736 to be up..
2026-01-29 15:28:43,562 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-01-29 15:28:48,713 - DEBUG - VM is in ACTIVE state now
2026-01-29 15:28:48,714 - INFO - VM name : ctest-vn1-vm1-45362736
2026-01-29 15:28:48,857 - DEBUG - VM ctest-vn1-vm1-45362736 ID is e79db300-edaf-474a-9b24-593f625da03d
2026-01-29 15:28:48,894 - DEBUG - VM ctest-vn1-vm1-45362736 launched on Node cn-jenkins-deploy-platform-juju-os-655-1
2026-01-29 15:28:49,036 - DEBUG - Requesting: https://10.0.0.61:8082/virtual-machine/e79db300-edaf-474a-9b24-593f625da03d
2026-01-29 15:28:49,089 - DEBUG - Requesting: https://10.0.0.61:8082/virtual-machine-interface/f3c909a2-5a3f-4b03-b1da-98a6c6105b3a
2026-01-29 15:28:52,560 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms')
2026-01-29 15:28:52,560 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-45362736 failed!
2026-01-29 15:28:52,616 - DEBUG - Gateway for vn admin_domain:ctest-TestPorts-58240869:ctest-vn1-63129368 is 24.201.216.65 and allocation pool is NOT set
2026-01-29 15:28:52,616 - DEBUG - Gateway for vn admin_domain:ctest-TestPorts-58240869:ctest-vn1-63129368 is 96.193.16.193 and allocation pool is NOT set
2026-01-29 15:28:56,718 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.56 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1016ms\r\nrtt min/avg/max/mdev = 3.563/3.563/3.563/0.000 ms')
2026-01-29 15:28:56,719 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-45362736 passed
2026-01-29 15:28:56,868 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-29 15:28:56,868 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-45362736, IP 24.201.216.69, Port 22
2026-01-29 15:28:57,079 - DEBUG - VM ctest-vn1-vm1-45362736 is ready for SSH connections
2026-01-29 15:28:57,079 - INFO - Waiting for VM ctest-vn1-vm2-24842274 to be up..
2026-01-29 15:28:57,229 - DEBUG - VM is in ACTIVE state now
2026-01-29 15:28:57,229 - INFO - VM name : ctest-vn1-vm2-24842274
2026-01-29 15:28:57,373 - DEBUG - VM ctest-vn1-vm2-24842274 ID is 65e6f31c-6b8a-4994-aa86-f76ac5fe68a3
2026-01-29 15:28:57,373 - DEBUG - VM ctest-vn1-vm2-24842274 launched on Node cn-jenkins-deploy-platform-juju-os-655-1
2026-01-29 15:28:57,514 - DEBUG - Requesting: https://10.0.0.61:8082/virtual-machine/65e6f31c-6b8a-4994-aa86-f76ac5fe68a3
2026-01-29 15:28:57,569 - DEBUG - Requesting: https://10.0.0.61:8082/virtual-machine-interface/0dbd9044-9301-4dbf-808f-69a161d4ff89
2026-01-29 15:28:59,026 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=2.92 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.373 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 0.373/1.647/2.921/1.274 ms')
2026-01-29 15:28:59,026 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-24842274 passed
2026-01-29 15:28:59,180 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-29 15:28:59,180 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-24842274, IP 96.193.16.197, Port 22
2026-01-29 15:28:59,402 - DEBUG - VM ctest-vn1-vm2-24842274 is ready for SSH connections
2026-01-29 15:28:59,402 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-29 15:28:59,402 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-29 15:28:59,402 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-29 15:28:59,402 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 24.201.216.69, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.61, gateway password: c0ntrail123
2026-01-29 15:28:59,402 - DEBUG - ping -s 56 -c 3 -W 1 24.201.216.69
2026-01-29 15:29:02,113 - DEBUG - PING 24.201.216.69 (24.201.216.69): 56 data bytes
64 bytes from 24.201.216.69: seq=0 ttl=63 time=3.430 ms
64 bytes from 24.201.216.69: seq=1 ttl=63 time=1.031 ms
64 bytes from 24.201.216.69: seq=2 ttl=63 time=1.053 ms
--- 24.201.216.69 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.031/1.838/3.430 ms
2026-01-29 15:29:02,113 - INFO - Ping to IP 24.201.216.69 from VM ctest-vn1-vm2-24842274 passed
2026-01-29 15:29:02,113 - INFO - Detaching port 0dbd9044-9301-4dbf-808f-69a161d4ff89 from VM ctest-vn1-vm2-24842274
2026-01-29 15:29:02,307 - INFO - Deleting VM ctest-vn1-vm2-24842274
2026-01-29 15:29:02,467 - INFO - Detaching port f3c909a2-5a3f-4b03-b1da-98a6c6105b3a from VM ctest-vn1-vm1-45362736
2026-01-29 15:29:02,657 - INFO - Deleting VM ctest-vn1-vm1-45362736
2026-01-29 15:29:03,076 - DEBUG - Response for delete_port : ()
2026-01-29 15:29:03,344 - DEBUG - Response for delete_port : ()
2026-01-29 15:29:03,344 - INFO - Deleting VN ctest-vn1-63129368
2026-01-29 15:29:03,603 - DEBUG - Response for deleting network ()
2026-01-29 15:29:03,981 - DEBUG - No XMPP flaps were noticed during the test
2026-01-29 15:29:03,981 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:24]
2026-01-29 15:29:03,981 - INFO - --------------------------------------------------------------------------------
2026-01-29 15:29:04,708 - INFO - Deleted project: ctest-TestPorts-58240869, ID : 2192e931-9e2e-48b1-b3c2-dcdc4325f981