Monday, 2023-08-28

opendevreviewyatin proposed openstack/devstack master: [neutron] Rely on PATH env set by devstack  https://review.opendev.org/c/openstack/devstack/+/89284805:31
*** elodilles_pto is now known as elodilles06:41
opendevreviewAbhishek Kekane proposed openstack/tempest master: Fix image race condition  https://review.opendev.org/c/openstack/tempest/+/89273106:59
liuc49Does anyone meet the problem. When I run tempest cases, some cases about booting a instance. The server cannot ssh login successfully and it shows time out. And the status of the floatingIP is down. The error log is as following:07:37
liuc49Body: b'{"floatingip": {"id": "5c4e68c1-aad9-498d-8fcf-91bb2031c27e", "tenant_id": "9fc039ef8cb942de9e6a57f484dd4942", "floating_ip_address": "172.24.4.159", "floating_network_id": "3067c886-e311-402f-b4b9-3b24c7456fa5", "router_id": "4ea198ac-facc-4201-b80c-ccd5a5828a43", "port_id": "8b8b5840-a5d3-427c-9278-ead7f54a544f", "fixed_ip_address": "10.0.0.11", "status": "DOWN", "description": "", "port_details":07:37
liuc49{"name": "", "network_id": "e8b6d264-7e08-4da9-bd67-1f1062634b4d", "mac_address": "fa:16:3e:e4:17:54", "admin_state_up": true, "status": "ACTIVE", "device_id": "d9af96ca-56cc-49fd-9bc9-3d99a2e542bf", "device_owner": "compute:nova"}07:37
liuc49, "dns_domain": "", "dns_name": "", "tags": [], "created_at": "2023-08-18T04:09:27Z", "updated_at": "2023-08-18T04:09:38Z", "revision_number": 1, "project_id": "9fc039ef8cb942de9e6a57f484dd4942"}}'07:37
liuc492023-08-18 04:09:38,489 395657 INFO [tempest.lib.common.ssh] Creating ssh connection to '172.24.4.159:22' as 'cirros' with public key authentication07:37
liuc492023-08-18 04:10:38,546 395657 WARNING [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to cirros@172.24.4.159 (timed out). Number attempts: 1. Retry after 2 seconds.07:37
liuc492023-08-18 04:11:41,109 395657 WARNING [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to cirros@172.24.4.159 (timed out). Number attempts: 2. Retry after 3 seconds.07:37
liuc492023-08-18 04:12:44,663 395657 WARNING [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to cirros@172.24.4.159 (timed out). Number attempts: 3. Retry after 4 seconds.07:37
liuc492023-08-18 04:13:49,225 395657 ERROR [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to cirros@172.24.4.159 after 3 attempts. Proxy client: no proxy client07:37
liuc492023-08-18 04:13:49.225 395657 ERROR tempest.lib.common.ssh Traceback (most recent call last):07:37
liuc492023-08-18 04:13:49.225 395657 ERROR tempest.lib.common.ssh File "/opt/stack/tempest/tempest/lib/common/ssh.py", line 136, in _get_ssh_connection07:37
liuc492023-08-18 04:13:49.225 395657 ERROR tempest.lib.common.ssh ssh.connect(self.host, port=self.port, username=self.username,07:37
liuc492023-08-18 04:13:49.225 395657 ERROR tempest.lib.common.ssh File "/opt/stack/.local/lib/python3.10/site-packages/paramiko/client.py", line 386, in connect07:38
liuc492023-08-18 04:13:49.225 395657 ERROR tempest.lib.common.ssh sock.connect(addr)07:38
liuc492023-08-18 04:13:49.225 395657 ERROR tempest.lib.common.ssh TimeoutError: timed out07:38
liuc492023-08-18 04:13:49.225 395657 ERROR tempest.lib.common.ssh07:38
opendevreviewRodolfo Alonso proposed openstack/tempest master: Revert "Mark "test_live_migration_with_trunk" as unstable"  https://review.opendev.org/c/openstack/tempest/+/88877008:16
liuc49I他I他I他08:36
liuc49But it seems that my 172.24.x.x network is unreachable from the outside. The appearance can recurred every time when I run the related tempest cases, for example:  tempest run -r   tempest.scenario.test_stamp_pattern.TestStampPattern.test_stamp_pattern08:40
liuc49{0} tempest.scenario.test_stamp_pattern.TestStampPattern.test_stamp_pattern [266.960423s] ... FAILED08:41
liuc49Captured traceback:08:41
liuc49~~~~~~~~~~~~~~~~~~~08:41
liuc49    Traceback (most recent call last):08:41
liuc49      File "/opt/stack/tempest/tempest/lib/common/ssh.py", line 136, in _get_ssh_connection08:41
liuc49    ssh.connect(self.host, port=self.port, username=self.username,08:41
liuc49      File "/opt/stack/.local/lib/python3.10/site-packages/paramiko/client.py", line 386, in connect08:41
liuc49    sock.connect(addr)08:41
liuc49    TimeoutError: timed out08:41
liuc49    08:41
liuc49During handling of the above exception, another exception occurred:08:41
liuc49    Traceback (most recent call last):08:42
liuc49      File "/opt/stack/tempest/tempest/common/utils/__init__.py", line 70, in wrapper08:42
liuc49    return f(*func_args, **func_kwargs)08:42
liuc49      File "/opt/stack/tempest/tempest/scenario/test_stamp_pattern.py", line 99, in test_stamp_pattern08:42
liuc49    linux_client = self.get_remote_client(08:42
liuc49      File "/opt/stack/tempest/tempest/scenario/manager.py", line 763, in get_remote_client08:42
liuc49    linux_client.validate_authentication()08:42
liuc49      File "/opt/stack/tempest/tempest/lib/common/utils/linux/remote_client.py", line 31, in wrapper08:42
liuc49    return function(self, *args, **kwargs)08:42
liuc49      File "/opt/stack/tempest/tempest/lib/common/utils/linux/remote_client.py", line 123, in validate_authentication08:42
liuc49    self.ssh_client.test_connection_auth()08:42
liuc49      File "/opt/stack/tempest/tempest/lib/common/ssh.py", line 245, in test_connection_auth08:42
liuc49    connection = self._get_ssh_connection()08:42
liuc49      File "/opt/stack/tempest/tempest/lib/common/ssh.py", line 155, in _get_ssh_connection08:42
liuc49    raise exceptions.SSHTimeout(host=self.host,08:42
liuc49    tempest.lib.exceptions.SSHTimeout: Connection to the 172.24.4.213 via SSH timed out.08:42
liuc49User: cirros, Password: None08:42
liuc49Captured pythonlogging:08:42
liuc49~~~~~~~~~~~~~~~~~~~~~~~08:42
liuc49    2023-08-25 10:12:47,613 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 POST http://10.225.110.7/compute/v2.1/os-keypairs 0.226s08:42
liuc492023-08-25 10:12:47,613 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:42
liuc49        Body: {"keypair": {"name": "tempest-TestStampPattern-240132218", "public_key": "ecdsa-sha2-nistp384 AAAAE2VjZHNhLXNoYTItbmlzdHAzODQAAAAIbmlzdHAzODQAAABhBPwOPTmTTC1uDHI2PSQ6J9nFpAuXe2kiC+z4F3AjpyuOsfQGTJJORnfXaFK69wdsCCalO99n0wGYN7EtAagUQ/eqjNor6cQpBtxqQfeatgiC3830UT7o8TwnOSuYVSCJVw=="}}08:42
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:47 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '394', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-6b7ef4d5-b53b-4f2a-9f17-d72e37204d3c', 'x-compute-request-id': 'req-6b7ef4d5-b53b-4f2a-9f17-d72e37204d3c', 08:42
liuc49'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7/compute/v2.1/os-keypairs'}08:42
liuc49        Body: b'{"keypair": {"name": "tempest-TestStampPattern-240132218", "public_key": "ecdsa-sha2-nistp384 AAAAE2VjZHNhLXNoYTItbmlzdHAzODQAAAAIbmlzdHAzODQAAABhBPwOPTmTTC1uDHI2PSQ6J9nFpAuXe2kiC+z4F3AjpyuOsfQGTJJORnfXaFK69wdsCCalO99n0wGYN7EtAagUQ/eqjNor6cQpBtxqQfeatgiC3830UT7o8TwnOSuYVSCJVw==", "fingerprint": "fd:cd:b6:6e:ea:05:80:27:02:28:bc:0e:a3:ed:38:fe", "user_id": "611183d8869348369d99061bc78af7bc"}}'08:43
liuc492023-08-25 10:12:47,830 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 201 POST http://10.225.110.7:9696/networking/v2.0/security-groups 0.216s08:43
liuc492023-08-25 10:12:47,831 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:43
liuc49        Body: {"security_group": {"name": "tempest-secgroup-smoke-734784657", "description": "tempest-secgroup-smoke-734784657 description", "project_id": "8f8595f12b7143988bbf4872ed53bb4d"}}08:43
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '1609', 'x-openstack-request-id': 'req-4fc420ba-dd50-4fac-8d26-966b067d56da', 'date': 'Fri, 25 Aug 2023 10:12:47 GMT', 'connection': 'close', 'status': '201', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/security-groups'}08:43
liuc49        Body: b'{"security_group": {"id": "f380340a-257f-4284-9f50-e802f0d4fd56", "name": "tempest-secgroup-smoke-734784657", "stateful": true, "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "description": "tempest-secgroup-smoke-734784657 description", "shared": false, "security_group_rules": [{"id": "20f7e4a4-ae96-4dc4-ab39-50557d18187e", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", 08:43
liuc49"security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "ethertype": "IPv4", "direction": "egress", "protocol": null, "port_range_min": null, "port_range_max": null, "remote_ip_prefix": null, "remote_address_group_id": null, "normalized_cidr": null, "remote_group_id": null, "standard_attr_id": 360, "description": null, "tags": [], "created_at": "2023-08-25T10:12:47Z", "updated_at": "2023-08-25T10:12:47Z", "revision_number": 0}, {"id": 08:43
liuc49"8c19d986-e6e6-48eb-8fef-b7f16ddc34ee", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "ethertype": "IPv6", "direction": "egress", "protocol": null, "port_range_min": null, "port_range_max": null, "remote_ip_prefix": null, "remote_address_group_id": null, "normalized_cidr": null, "remote_group_id": null, "standard_attr_id": 361, 08:43
liuc49"description": null, "tags": [], "created_at": "2023-08-25T10:12:47Z", "updated_at": "2023-08-25T10:12:47Z", "revision_number": 0}], "tags": [], "created_at": "2023-08-25T10:12:47Z", "updated_at": "2023-08-25T10:12:47Z", "revision_number": 1, "pr08:43
liuc49    oject_id": "8f8595f12b7143988bbf4872ed53bb4d"}}'08:43
liuc492023-08-25 10:12:48,054 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 201 POST http://10.225.110.7:9696/networking/v2.0/security-group-rules 0.222s08:43
liuc492023-08-25 10:12:48,054 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:43
liuc49        Body: {"security_group_rule": {"security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "protocol": "tcp", "port_range_min": 22, "port_range_max": 22, "direction": "ingress"}}08:43
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '565', 'x-openstack-request-id': 'req-5e8cb8cd-2afb-4879-ae70-e2a84347f348', 'date': 'Fri, 25 Aug 2023 10:12:48 GMT', 'connection': 'close', 'status': '201', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/security-group-rules'}08:43
liuc49        Body: b'{"security_group_rule": {"id": "76c50600-6d22-4d6d-ae9c-43e5ad1a98c7", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "ethertype": "IPv4", "direction": "ingress", "protocol": "tcp", "port_range_min": 22, "port_range_max": 22, "remote_ip_prefix": null, "remote_address_group_id": null, "normalized_cidr": null, 08:43
liuc49"remote_group_id": null, "description": "", "created_at": "2023-08-25T10:12:47Z", "updated_at": "2023-08-25T10:12:47Z", "revision_number": 0}}'08:44
liuc492023-08-25 10:12:48,231 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 201 POST http://10.225.110.7:9696/networking/v2.0/security-group-rules 0.176s08:44
liuc492023-08-25 10:12:48,231 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:44
liuc49        Body: {"security_group_rule": {"security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "protocol": "tcp", "port_range_min": 22, "port_range_max": 22, "direction": "egress"}}08:44
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '564', 'x-openstack-request-id': 'req-7bbf924b-5d6d-4f6b-bf55-cec8756cfae2', 'date': 'Fri, 25 Aug 2023 10:12:48 GMT', 'connection': 'close', 'status': '201', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/security-group-rules'}08:44
liuc49        Body: b'{"security_group_rule": {"id": "9335b0eb-5624-4a20-b4f0-2f4fa5301796", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "ethertype": "IPv4", "direction": "egress", "protocol": "tcp", "port_range_min": 22, "port_range_max": 22, "remote_ip_prefix": null, "remote_address_group_id": null, "normalized_cidr": null, 08:44
liuc49"remote_group_id": null, "description": "", "created_at": "2023-08-25T10:12:48Z", "updated_at": "2023-08-25T10:12:48Z", "revision_number": 0}}'08:44
liuc492023-08-25 10:12:48,373 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 201 POST http://10.225.110.7:9696/networking/v2.0/security-group-rules 0.142s08:44
liuc492023-08-25 10:12:48,374 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:44
liuc49        Body: {"security_group_rule": {"security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "protocol": "icmp", "direction": "ingress"}}08:44
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '570', 'x-openstack-request-id': 'req-0527af66-5e8d-48f1-9e04-21ea316e0054', 'date': 'Fri, 25 Aug 2023 10:12:48 GMT', 'connection': 'close', 'status': '201', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/security-group-rules'}08:44
liuc49        Body: b'{"security_group_rule": {"id": "484cd9eb-fe3d-4541-bb65-621b738dd839", "08:44
liuc49    project_id": "8f8595f12b7143988bbf4872ed53bb4d", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "ethertype": "IPv4", "direction": "ingress", "protocol": "icmp", "port_range_min": null, "port_range_max": null, "remote_ip_prefix": null, "remote_address_group_id": null, "normalized_cidr": null, "remote_group_id": null, "description": "", "created_at": "2023-08-25T10:12:48Z", 08:44
liuc49"updated_at": "2023-08-25T10:12:48Z", "revision_number": 0}}'08:44
liuc492023-08-25 10:12:48,518 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 201 POST http://10.225.110.7:9696/networking/v2.0/security-group-rules 0.144s08:44
liuc492023-08-25 10:12:48,518 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:44
liuc49        Body: {"security_group_rule": {"security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "protocol": "icmp", "direction": "egress"}}08:45
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '569', 'x-openstack-request-id': 'req-d9f85f84-57b3-4e2b-8bfa-8310739b5ef6', 'date': 'Fri, 25 Aug 2023 10:12:48 GMT', 'connection': 'close', 'status': '201', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/security-group-rules'}08:45
liuc49        Body: b'{"security_group_rule": {"id": "5dc0ce14-a1eb-4659-8a1c-e7430a0c9849", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "ethertype": "IPv4", "direction": "egress", "protocol": "icmp", "port_range_min": null, "port_range_max": null, "remote_ip_prefix": null, "remote_address_group_id": null, "normalized_cidr": null, 08:45
liuc49"remote_group_id": null, "description": "", "created_at": "2023-08-25T10:12:48Z", "updated_at": "2023-08-25T10:12:48Z", "revision_number": 0}}'08:45
liuc492023-08-25 10:12:48,650 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 201 POST http://10.225.110.7:9696/networking/v2.0/security-group-rules 0.131s08:45
liuc492023-08-25 10:12:48,650 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:45
liuc49        Body: {"security_group_rule": {"security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "protocol": "icmp", "ethertype": "IPv6", "direction": "ingress"}}08:45
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '575', 'x-openstack-request-id': 'req-a3fcc4c9-4bef-4f47-867b-71870dee574b', 'date': 'Fri, 25 Aug 2023 10:12:48 GMT', 'connection': 'close', 'status': '201', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/security-group-rules'}08:45
liuc49        Body: b'{"security_group_rule": {"id": "5cf1cd07-6238-4aa7-8e04-337fb02a8ffd", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "ethertype": "IPv6", "direction": "ingress", "protocol": "ipv6-icmp", "port_range_min": null, "port_range_max": null, "remote_ip_prefix": null, "remote_address_group_id": null, "normalized_cidr": null, 08:45
liuc49"remote_group_id": null, "description": "", "created_at": "2023-08-25T10:12:48Z", "updated_at": "2023-08-25T10:12:48Z", "revision_number": 0}}'08:45
liuc492023-08-25 10:12:48,787 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 201 POST http://10.225.110.7:9696/networking/v2.0/security-group-rules 0.136s08:45
liuc492023-08-25 10:12:48,787 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:45
liuc49        Body: {"security_group_rule": {"security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "protocol": "icmp", "ethertype": "IPv6", "direction": 08:45
liuc49    "egress"}}08:45
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '574', 'x-openstack-request-id': 'req-b06462cf-3f59-4c52-a51f-3be69b39d8d3', 'date': 'Fri, 25 Aug 2023 10:12:48 GMT', 'connection': 'close', 'status': '201', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/security-group-rules'}08:45
liuc49        Body: b'{"security_group_rule": {"id": "64088da1-89b5-48ce-9b68-e2ed0966e515", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "security_group_id": "f380340a-257f-4284-9f50-e802f0d4fd56", "ethertype": "IPv6", "direction": "egress", "protocol": "ipv6-icmp", "port_range_min": null, "port_range_max": null, "remote_ip_prefix": null, "remote_address_group_id": null, "normalized_cidr": null, 08:45
liuc49"remote_group_id": null, "description": "", "created_at": "2023-08-25T10:12:48Z", "updated_at": "2023-08-25T10:12:48Z", "revision_number": 0}}'08:46
liuc492023-08-25 10:12:49,253 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 202 POST http://10.225.110.7/volume/v3/8f8595f12b7143988bbf4872ed53bb4d/volumes 0.466s08:46
liuc492023-08-25 10:12:49,254 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:46
liuc49        Body: {"volume": {"name": "tempest-TestStampPattern-volume-430466372", "snapshot_id": null, "imageRef": null, "volume_type": null, "size": 1}}08:46
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:48 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-type': 'application/json', 'x-compute-request-id': 'req-797e92b2-b142-44b4-916f-65b30f845411', 'content-length': '820', 'openstack-api-version': 'volume 3.0', 'vary': 'OpenStack-API-Version', 'x-openstack-request-id': 'req-797e92b2-b142-44b4-916f-65b30f845411', 'connection': 'close', 'status': '202', 'content-location': 'http://10.225.110.7/v08:46
liuc49olume/v3/8f8595f12b7143988bbf4872ed53bb4d/volumes'}08:46
liuc49        Body: b'{"volume": {"id": "3e780641-532c-4954-96ae-2fc6069320d9", "status": "creating", "size": 1, "availability_zone": "nova", "created_at": "2023-08-25T10:12:48.971356", "updated_at": null, "name": "tempest-TestStampPattern-volume-430466372", "description": null, "volume_type": "powerstorenvme", "snapshot_id": null, "source_volid": null, "metadata": {}, "links": [{"rel": "self", "href": "http://10.225.110.7/volume/v3/8f8595f12b7143988bbf487208:46
liuc49ed53bb4d/volumes/3e780641-532c-4954-96ae-2fc6069320d9"}, {"rel": "bookmark", "href": "http://10.225.110.7/volume/8f8595f12b7143988bbf4872ed53bb4d/volumes/3e780641-532c-4954-96ae-2fc6069320d9"}], "user_id": "611183d8869348369d99061bc78af7bc", "bootable": "false", "encrypted": false, "replication_status": null, "consistencygroup_id": null, "multiattach": false, "attachments": []}}'08:46
liuc492023-08-25 10:12:49,283 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 201 POST http://10.225.110.7/identity/v3/auth/tokens 0.023s08:46
liuc492023-08-25 10:12:49,283 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json'}08:46
liuc49        Body: <omitted>08:46
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:49 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-type': 'application/json', 'content-length': '2821', 'x-subject-token': '<omitted>', 'vary': 'X-Auth-Token', 'x-openstack-request-id': 'req-4fb3aa98-0156-4101-b963-b38a9a0d0755', 'connection': 'close', 'status': '201', 'content-location': 'http://10.225.110.7/identity/v3/auth/tokens'}08:46
liuc49        Body: b'{"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "611183d8869348369d99061bc78af7bc", "name": "tempest-TestStampPattern-2035236386-project-member", "password_expires_at": null}, "audit_ids": ["VGFjd5V7RfyIOaj7gEnsvA"], "expires_at": "2023-08-25T11:12:49.000000Z", "issued_at": "2023-08-25T10:12:49.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": 08:46
liuc49"8f8595f12b7143988bbf4872ed53bb4d", "name": "tempest-TestStampPattern-2035236386"08:46
liuc49    }, "is_domain": false, "roles": [{"id": "12c2f7d5f12a410ab490726fda56f755", "name": "reader"}, {"id": "c7358658dad74826bc2f75932c5c9b81", "name": "member"}], "catalog": [{"endpoints": [{"id": "11d87061e1c6417f9ec1ba84eb185984", "interface": "public", "region_id": "RegionOne", "url": "http://10.225.110.7/image", "region": "RegionOne"}], "id": "21375daec4b54a7bb98bc80be11e7bf5", "type": "image", "name": "glance"}, {"endpoints": [{"id": 08:46
liuc49"ae0a4005b01e4e82a5a13d45f58f5a24", "interface": "public", "region_id": "RegionOne", "url": "http://10.225.110.7/compute/v2.1", "region": "RegionOne"}], "id": "62a30e75d18b41eb8afc3865d8430945", "type": "compute", "name": "nova"}, {"endpoints": [{"id": "4884969ec8494a8cb6a3520884bbd2fa", "interface": "public", "region_id": "RegionOne", "url": "http://10.225.110.7/placement", "region": "RegionOne"}], "id": "79dfc1f38dfb4a48b1dc091c2bad4fa1", "type": 08:46
liuc49"placement", "name": "placement"}, {"endpoints": [{"id": "65794bcc8ab24f0ba0de17715fb9dda9", "interface": "public", "region_id": "RegionOne", "url": "http://10.225.110.7/volume/v3/8f8595f12b7143988bbf4872ed53bb4d", "region": "RegionOne"}], "id": "89642e1afa294da29b1b2fff41b58dfa", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "34d16abbb23b4ab381d2d4153c5bfa10", "interface": "public", "region_id": "RegionOne", "url": 08:47
liuc49"http://10.225.110.7/volume/v3/8f8595f12b7143988bbf4872ed53bb4d", "region": "RegionOne"}], "id": "995911b582204a6aba81fea2bb951188", "type": "block-storage", "name": "cinder"}, {"endpoints": [{"id": "fdf73633a5824afc9d006933b7b1acd8", "interface": "public", "region_id": "RegionOne", "url": "http://10.225.110.7/identity", "region": "RegionOne"}], "id": "c3d4b500b7c7456d904c9eef2c67d7cd", "type": "identity", "name": "keystone"}, {"endpoints": [{"id": 08:47
liuc49"38702ea951d343acbc078ca67f9b9a76", "interface": "public", "region_id": "RegionOne", "url": "http://10.225.110.7:9696/networking", "region": "RegionOne"}], "id": "d342de520c22448c8831e6e9ffd74443", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "a41e95a9d00b4504b87673917fd94efa", "interface": "public", "region_id": "RegionOne", "url": "http://10.225.110.7/compute/v2/8f8595f12b7143988bbf4872ed53bb4d", "region": "RegionOne"}], "id": 08:47
liuc49"d9c6673819f7446db79e149827f3afef", "type": "compute_legacy", "name": "nova_legacy"}]}}'08:47
liuc492023-08-25 10:12:49,284 215379 INFO     [tempest.lib.common.fixed_network] (TestStampPattern:test_stamp_pattern) Found network {'id': 'f8b17969-a062-4311-b141-113d0755a26a', 'name': 'tempest-TestStampPattern-575007048-network', 'tenant_id': '8f8595f12b7143988bbf4872ed53bb4d', 'admin_state_up': True, 'mtu': 1442, 'status': 'ACTIVE', 'subnets': [], 'shared': False, 'project_id': '8f8595f12b7143988bbf4872ed53bb4d', 'port_security_enabled': True, 08:47
liuc49'router:external': False, 'provider:network_type': 'geneve', 'provider:physical_network': None, 'provider:segmentation_id': 45267, 'is_default': False, 'availability_zone_hints': [], 'availability_zones': [], 'ipv4_address_scope': None, 'ipv6_address_scope': None, 'description': '', 'tags': [], 'created_at': '2023-08-25T10:12:36Z', 'updated_at': '2023-08-25T10:12:37Z', 'revision_number': 1} available for tenant08:47
liuc492023-08-25 10:12:50,250 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 202 POST http://10.225.110.7/compute/v2.1/servers 0.965s08:47
liuc492023-08-25 10:12:50,250 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:47
liuc49        Body: {"server": {"name": "tempest-TestStampPattern-server-2071343168", "imageRef": "52641559-2817-49d7-9642-b36377db9d11", "flavorRef": "42", "key_name": "tempest-TestStampPattern-240132218", "security_groups": [{"name": "tempest-secgroup-smoke-734784657"}], "networks": [{"uuid": "f8b17969-a062-4311-b141-113d0755a26a"}]}}08:47
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:49 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '407', 'location': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb3108:47
liuc49    ', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-3ff53bf2-dca0-49f2-bee8-35ee0774c7a6', 'x-compute-request-id': 'req-3ff53bf2-dca0-49f2-bee8-35ee0774c7a6', 'connection': 'close', 'status': '202', 'content-location': 'http://10.225.110.7/compute/v2.1/servers'}08:47
liuc49        Body: b'{"server": {"id": "7c1d25d5-13d9-4b7a-b5f3-c417751edb31", "links": [{"rel": "self", "href": "http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}, {"rel": "bookmark", "href": "http://10.225.110.7/compute/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}], "OS-DCF:diskConfig": "MANUAL", "security_groups": [{"name": "tempest-secgroup-smoke-734784657"}], "adminPass": "74nPqRX477qH"}}'08:47
liuc492023-08-25 10:12:50,407 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 GET http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31 0.155s08:47
liuc492023-08-25 10:12:50,407 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:48
liuc49        Body: None08:48
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:50 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '1244', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-f62f417f-dd01-49d1-a150-91b07b1c9c72', 'x-compute-request-id': 'req-f62f417f-dd01-49d1-a150-91b07b1c9c72', 08:48
liuc49'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}08:48
liuc49        Body: b'{"server": {"id": "7c1d25d5-13d9-4b7a-b5f3-c417751edb31", "name": "tempest-TestStampPattern-server-2071343168", "status": "BUILD", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "user_id": "611183d8869348369d99061bc78af7bc", "metadata": {}, "hostId": "", "image": {"id": "52641559-2817-49d7-9642-b36377db9d11", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/images/52641559-2817-49d7-9642-b36377db9d11"}]}, "flavor": 08:48
liuc49{"id": "42", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/flavors/42"}]}, "created": "2023-08-25T10:12:50Z", "updated": "2023-08-25T10:12:50Z", "addresses": {}, "accessIPv4": "", "accessIPv6": "", "links": [{"rel": "self", "href": "http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}, {"rel": "bookmark", "href": "http://10.225.110.7/compute/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}], 08:48
liuc49"OS-DCF:diskConfig": "MANUAL", "progress": 0, "OS-EXT-AZ:availability_zone": "", "config_drive": "", "key_name": "tempest-TestStampPattern-240132218", "OS-SRV-USG:launched_at": null, "OS-SRV-USG:terminated_at": null, "OS-EXT-STS:task_state": "scheduling", "OS-EXT-STS:vm_state": "building", "OS-EXT-STS:power_state": 0, "os-extended-volumes:volumes_attached": []}}'08:48
liuc492023-08-25 10:12:51,733 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 GET http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31 0.321s08:48
liuc492023-08-25 10:12:51,733 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:48
liuc49        Body: None08:48
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:51 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '1296', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-67694c31-9961-40f8-85f9-760335cf3954', 'x-compute-request-id': 'req-67694c31-9961-40f8-85f9-760335cf3954', 08:48
liuc49'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a08:48
liuc49    -b5f3-c417751edb31'}08:48
liuc49        Body: b'{"server": {"id": "7c1d25d5-13d9-4b7a-b5f3-c417751edb31", "name": "tempest-TestStampPattern-server-2071343168", "status": "BUILD", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "user_id": "611183d8869348369d99061bc78af7bc", "metadata": {}, "hostId": "8235c74c04a0aeae07bc3e044a6bfbc0a58d2abfd1d940daf4d14f77", "image": {"id": "52641559-2817-49d7-9642-b36377db9d11", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/ima08:48
liuc49ges/52641559-2817-49d7-9642-b36377db9d11"}]}, "flavor": {"id": "42", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/flavors/42"}]}, "created": "2023-08-25T10:12:50Z", "updated": "2023-08-25T10:12:51Z", "addresses": {}, "accessIPv4": "", "accessIPv6": "", "links": [{"rel": "self", "href": "http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}, {"rel": "bookmark", "href": "http://10.225.110.7/compute/servers08:48
liuc49/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}], "OS-DCF:diskConfig": "MANUAL", "progress": 0, "OS-EXT-AZ:availability_zone": "nova", "config_drive": "", "key_name": "tempest-TestStampPattern-240132218", "OS-SRV-USG:launched_at": null, "OS-SRV-USG:terminated_at": null, "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "building", "OS-EXT-STS:power_state": 0, "os-extended-volumes:volumes_attached": []}}'08:49
liuc492023-08-25 10:12:51,737 215379 INFO     [tempest.common.waiters] State transition "BUILD/scheduling" ==> "BUILD/None" after 1 second wait08:49
liuc492023-08-25 10:12:53,031 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 GET http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31 0.292s08:49
liuc492023-08-25 10:12:53,032 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:49
liuc49        Body: None08:49
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:52 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '1369', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-740b246f-db62-420b-965d-163a8b0df5d2', 'x-compute-request-id': 'req-740b246f-db62-420b-965d-163a8b0df5d2', 08:49
liuc49'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}08:49
liuc49        Body: b'{"server": {"id": "7c1d25d5-13d9-4b7a-b5f3-c417751edb31", "name": "tempest-TestStampPattern-server-2071343168", "status": "BUILD", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "user_id": "611183d8869348369d99061bc78af7bc", "metadata": {}, "hostId": "8235c74c04a0aeae07bc3e044a6bfbc0a58d2abfd1d940daf4d14f77", "image": {"id": "52641559-2817-49d7-9642-b36377db9d11", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/ima08:49
liuc49ges/52641559-2817-49d7-9642-b36377db9d11"}]}, "flavor": {"id": "42", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/flavors/42"}]}, "created": "2023-08-25T10:12:50Z", "updated": "2023-08-25T10:12:52Z", "addresses": {}, "accessIPv4": "", "accessIPv6": "", "links": [{"rel": "self", "href": "http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}, {"rel": "bookmark", "href": "http://10.225.110.7/compute/servers08:49
liuc49/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}], "OS-DCF:diskConfig": "MANUAL", "progress": 0, "OS-EXT-AZ:availability_zone": "nova", "config_drive": "", "key_name": "tempest-TestStampPattern-240132218", "OS-SRV-USG:launched_at": null, "OS-SRV-USG:terminated_at": null, "security_groups": [{"name": "tempest-secgroup-smoke-734784657"}], "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-EXT-STS:power_state": 0, "os-extended-volumes:vol08:49
liuc49umes_attached": []}}'08:49
liuc492023-08-25 10:12:53,035 215379 INFO     [tempest.common.waiters] State transition "BUILD/None" ==> "BUILD/spawning" after 3 second wait08:49
liuc492023-08-25 10:12:54,316 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPatte08:49
liuc49    rn:test_stamp_pattern): 200 GET http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31 0.280s08:49
liuc492023-08-25 10:12:54,317 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:49
liuc49        Body: None08:49
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:54 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '1369', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-b7a09d88-ff25-43e0-9fb3-4c29547f05a1', 'x-compute-request-id': 'req-b7a09d88-ff25-43e0-9fb3-4c29547f05a1', 08:49
liuc49'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}08:50
liuc49        Body: b'{"server": {"id": "7c1d25d5-13d9-4b7a-b5f3-c417751edb31", "name": "tempest-TestStampPattern-server-2071343168", "status": "BUILD", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "user_id": "611183d8869348369d99061bc78af7bc", "metadata": {}, "hostId": "8235c74c04a0aeae07bc3e044a6bfbc0a58d2abfd1d940daf4d14f77", "image": {"id": "52641559-2817-49d7-9642-b36377db9d11", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/ima08:50
liuc49ges/52641559-2817-49d7-9642-b36377db9d11"}]}, "flavor": {"id": "42", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/flavors/42"}]}, "created": "2023-08-25T10:12:50Z", "updated": "2023-08-25T10:12:52Z", "addresses": {}, "accessIPv4": "", "accessIPv6": "", "links": [{"rel": "self", "href": "http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}, {"rel": "bookmark", "href": "http://10.225.110.7/compute/servers08:50
liuc49/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}], "OS-DCF:diskConfig": "MANUAL", "progress": 0, "OS-EXT-AZ:availability_zone": "nova", "config_drive": "", "key_name": "tempest-TestStampPattern-240132218", "OS-SRV-USG:launched_at": null, "OS-SRV-USG:terminated_at": null, "security_groups": [{"name": "tempest-secgroup-smoke-734784657"}], "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-EXT-STS:power_state": 0, "os-extended-volumes:vol08:50
liuc49umes_attached": []}}'08:50
liuc492023-08-25 10:12:55,455 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 GET http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31 0.134s08:50
liuc492023-08-25 10:12:55,456 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:50
liuc49        Body: None08:50
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:55 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '1369', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-94413ae9-7abd-4f05-8718-d9c655af5728', 'x-compute-request-id': 'req-94413ae9-7abd-4f05-8718-d9c655af5728', 08:50
liuc49'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}08:50
liuc49        Body: b'{"server": {"id": "7c1d25d5-13d9-4b7a-b5f3-c417751edb31", "name": "tempest-TestStampPattern-server-2071343168", "status": "BUILD", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "user_id": "611183d8869348369d99061bc78af7bc", "metadata": {}, "hostId": "8235c74c04a0aeae07bc3e044a6bfbc0a58d2abfd1d940daf4d14f77", "image": {"id": "52641559-2817-49d7-9642-b36377db9d11", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/ima08:50
liuc49ges/52641559-2817-49d7-9642-b36377db9d11"}]}, "flavor": {"id": "42", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/flavors/42"}]}, "created": "2023-08-25T10:12:50Z", "updated": "2023-08-25T10:12:52Z", "addresses": {}, "accessIPv4": "", "accessIPv6": "", "links": [{"rel": "self", "href": "http://10.225.110.7/compute/v2.108:50
liuc49    /servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}, {"rel": "bookmark", "href": "http://10.225.110.7/compute/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}], "OS-DCF:diskConfig": "MANUAL", "progress": 0, "OS-EXT-AZ:availability_zone": "nova", "config_drive": "", "key_name": "tempest-TestStampPattern-240132218", "OS-SRV-USG:launched_at": null, "OS-SRV-USG:terminated_at": null, "security_groups": [{"name": "tempest-secgroup-smoke-734784657"}], 08:50
liuc49"OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-EXT-STS:power_state": 0, "os-extended-volumes:volumes_attached": []}}'08:50
liuc492023-08-25 10:12:56,678 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 GET http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31 0.215s08:51
liuc492023-08-25 10:12:56,679 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:51
liuc49        Body: None08:51
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:56 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '1545', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-bcd59f33-6f31-40f1-99ec-d4f0be44c28d', 'x-compute-request-id': 'req-bcd59f33-6f31-40f1-99ec-d4f0be44c28d', 08:51
liuc49'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}08:51
liuc49        Body: b'{"server": {"id": "7c1d25d5-13d9-4b7a-b5f3-c417751edb31", "name": "tempest-TestStampPattern-server-2071343168", "status": "ACTIVE", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "user_id": "611183d8869348369d99061bc78af7bc", "metadata": {}, "hostId": "8235c74c04a0aeae07bc3e044a6bfbc0a58d2abfd1d940daf4d14f77", "image": {"id": "52641559-2817-49d7-9642-b36377db9d11", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/im08:51
liuc49ages/52641559-2817-49d7-9642-b36377db9d11"}]}, "flavor": {"id": "42", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/flavors/42"}]}, "created": "2023-08-25T10:12:50Z", "updated": "2023-08-25T10:12:56Z", "addresses": {"tempest-TestStampPattern-575007048-network": [{"version": 4, "addr": "10.0.0.11", "OS-EXT-IPS:type": "fixed", "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:9a:a3:c9"}]}, "accessIPv4": "", "accessIPv6": "", "links": [{"rel": 08:51
liuc49"self", "href": "http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}, {"rel": "bookmark", "href": "http://10.225.110.7/compute/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}], "OS-DCF:diskConfig": "MANUAL", "progress": 0, "OS-EXT-AZ:availability_zone": "nova", "config_drive": "", "key_name": "tempest-TestStampPattern-240132218", "OS-SRV-USG:launched_at": "2023-08-25T10:12:56.000000", "OS-SRV-USG:terminated_at": null, 08:51
liuc49"security_groups": [{"name": "tempest-secgroup-smoke-734784657"}], "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-EXT-STS:power_state": 1, "os-extended-volumes:volumes_attached": []}}'08:51
liuc492023-08-25 10:12:56,683 215379 INFO     [tempest.common.waiters] State transition "BUILD/spawning" ==> "ACTIVE/None" after 6 second wait08:51
liuc492023-08-25 10:12:56,815 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 GET http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31 0.132s08:51
liuc492023-08-25 10:12:56,815 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:51
liuc49        Body: None08:51
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:12:56 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '1545', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-85d44c2a-2ff6-4bbf-bd6d-6d19a83f9a3d', 'x-comp08:51
liuc49    ute-request-id': 'req-85d44c2a-2ff6-4bbf-bd6d-6d19a83f9a3d', 'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}08:51
liuc49        Body: b'{"server": {"id": "7c1d25d5-13d9-4b7a-b5f3-c417751edb31", "name": "tempest-TestStampPattern-server-2071343168", "status": "ACTIVE", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "user_id": "611183d8869348369d99061bc78af7bc", "metadata": {}, "hostId": "8235c74c04a0aeae07bc3e044a6bfbc0a58d2abfd1d940daf4d14f77", "image": {"id": "52641559-2817-49d7-9642-b36377db9d11", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/im08:51
liuc49ages/52641559-2817-49d7-9642-b36377db9d11"}]}, "flavor": {"id": "42", "links": [{"rel": "bookmark", "href": "http://10.225.110.7/compute/flavors/42"}]}, "created": "2023-08-25T10:12:50Z", "updated": "2023-08-25T10:12:56Z", "addresses": {"tempest-TestStampPattern-575007048-network": [{"version": 4, "addr": "10.0.0.11", "OS-EXT-IPS:type": "fixed", "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:9a:a3:c9"}]}, "accessIPv4": "", "accessIPv6": "", "links": [{"rel": 08:52
liuc49"self", "href": "http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}, {"rel": "bookmark", "href": "http://10.225.110.7/compute/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31"}], "OS-DCF:diskConfig": "MANUAL", "progress": 0, "OS-EXT-AZ:availability_zone": "nova", "config_drive": "", "key_name": "tempest-TestStampPattern-240132218", "OS-SRV-USG:launched_at": "2023-08-25T10:12:56.000000", "OS-SRV-USG:terminated_at": null, 08:52
liuc49"security_groups": [{"name": "tempest-secgroup-smoke-734784657"}], "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-EXT-STS:power_state": 1, "os-extended-volumes:volumes_attached": []}}'08:52
liuc492023-08-25 10:12:56,880 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 GET http://10.225.110.7:9696/networking/v2.0/ports?device_id=7c1d25d5-13d9-4b7a-b5f3-c417751edb31 0.061s08:52
liuc492023-08-25 10:12:56,880 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:52
liuc49        Body: None08:52
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '909', 'x-openstack-request-id': 'req-6e681062-0b70-4cd0-b3b7-06139ddda813', 'date': 'Fri, 25 Aug 2023 10:12:56 GMT', 'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/ports?device_id=7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}08:52
liuc49        Body: b'{"ports":[{"id":"f9153fd5-01aa-45d7-ae83-f8203a758677","name":"","network_id":"f8b17969-a062-4311-b141-113d0755a26a","tenant_id":"8f8595f12b7143988bbf4872ed53bb4d","mac_address":"fa:16:3e:9a:a3:c9","admin_state_up":true,"status":"ACTIVE","device_id":"7c1d25d5-13d9-4b7a-b5f3-c417751edb31","device_owner":"compute:nova","fixed_ips":[{"subnet_id":"7f8e4a15-efef-42d9-9d1a-66dd96240c3e","ip_address":"10.0.0.11"}],"allowed_address_pairs":[],"08:52
liuc49extra_dhcp_opts":[],"security_groups":["f380340a-257f-4284-9f50-e802f0d4fd56"],"description":"","binding:vnic_type":"normal","binding:profile":{},"binding:host_id":"myhost","binding:vif_type":"ovs","binding:vif_details":{"port_filter":true,"connectivity":"l2","bound_drivers":{"0":"ovn"}},"port_security_enabled":true,"tags":[],"created_at":"2023-08-25T10:12:52Z","updated_at":"2023-08-25T10:12:54Z","revision_number":4,"project_id":"8f8595f12b7143988bbf408:52
liuc49872ed53bb4d"}]}'08:52
liuc492023-08-25 10:12:56,915 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 GET http://10.225.110.7:9696/networking/v2.0/floatingips?floating_network_id=af849ff4-7d4a-45c4-b31e-07739ac98404&port_id=f9153fd5-01aa-45d7-ae83-f8203a758677 0.035s08:52
liuc492023-08-25 10:12:56,916 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:52
liuc49        Body: None08:52
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '19', 'x-openstack-request-id': 'req-108:52
liuc49    dc13b55-5140-4a01-bc4c-52a4c745fe64', 'date': 'Fri, 25 Aug 2023 10:12:56 GMT', 'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/floatingips?floating_network_id=af849ff4-7d4a-45c4-b31e-07739ac98404&port_id=f9153fd5-01aa-45d7-ae83-f8203a758677'}08:52
liuc49        Body: b'{"floatingips": []}'08:53
liuc492023-08-25 10:12:56,946 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 GET http://10.225.110.7:9696/networking/v2.0/ports?device_id=7c1d25d5-13d9-4b7a-b5f3-c417751edb31 0.030s08:53
liuc492023-08-25 10:12:56,946 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:53
liuc49        Body: None08:53
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '909', 'x-openstack-request-id': 'req-cfffd18a-3675-417d-a7f8-dbc264a56f78', 'date': 'Fri, 25 Aug 2023 10:12:56 GMT', 'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/ports?device_id=7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}08:53
liuc49        Body: b'{"ports":[{"id":"f9153fd5-01aa-45d7-ae83-f8203a758677","name":"","network_id":"f8b17969-a062-4311-b141-113d0755a26a","tenant_id":"8f8595f12b7143988bbf4872ed53bb4d","mac_address":"fa:16:3e:9a:a3:c9","admin_state_up":true,"status":"ACTIVE","device_id":"7c1d25d5-13d9-4b7a-b5f3-c417751edb31","device_owner":"compute:nova","fixed_ips":[{"subnet_id":"7f8e4a15-efef-42d9-9d1a-66dd96240c3e","ip_address":"10.0.0.11"}],"allowed_address_pairs":[],"08:53
liuc49extra_dhcp_opts":[],"security_groups":["f380340a-257f-4284-9f50-e802f0d4fd56"],"description":"","binding:vnic_type":"normal","binding:profile":{},"binding:host_id":"myhost","binding:vif_type":"ovs","binding:vif_details":{"port_filter":true,"connectivity":"l2","bound_drivers":{"0":"ovn"}},"port_security_enabled":true,"tags":[],"created_at":"2023-08-25T10:12:52Z","updated_at":"2023-08-25T10:12:54Z","revision_number":4,"project_id":"8f8595f12b7143988bbf408:53
liuc49872ed53bb4d"}]}'08:53
liuc492023-08-25 10:12:58,389 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 201 POST http://10.225.110.7:9696/networking/v2.0/floatingips 1.442s08:53
liuc492023-08-25 10:12:58,390 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:53
liuc49        Body: {"floatingip": {"floating_network_id": "af849ff4-7d4a-45c4-b31e-07739ac98404", "port_id": "f9153fd5-01aa-45d7-ae83-f8203a758677", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "fixed_ip_address": "10.0.0.11"}}08:53
liuc49    Response - Headers: {'content-type': 'application/json', 'content-length': '830', 'x-openstack-request-id': 'req-0f183f38-eda3-4b05-b6e1-8b78b8e85a3b', 'date': 'Fri, 25 Aug 2023 10:12:58 GMT', 'connection': 'close', 'status': '201', 'content-location': 'http://10.225.110.7:9696/networking/v2.0/floatingips'}08:53
liuc49        Body: b'{"floatingip": {"id": "637bc942-cd77-481f-a513-6b943d1951bc", "tenant_id": "8f8595f12b7143988bbf4872ed53bb4d", "floating_ip_address": "172.24.4.213", "floating_network_id": "af849ff4-7d4a-45c4-b31e-07739ac98404", "router_id": "c7fe9f1d-5d5a-4ac6-b694-d7c5f7e54c07", "port_id": "f9153fd5-01aa-45d7-ae83-f8203a758677", "fixed_ip_address": "10.0.0.11", "status": "DOWN", "project_id": "8f8595f12b7143988bbf4872ed53bb4d", "description": "", 08:53
liuc49"port_details": {"name": "", "network_id": "f8b17969-a062-4311-b141-113d0755a26a", "mac_address": "fa:16:3e:9a:a3:c9", "admin_state_up": true, "status": "ACTIVE", "device_id": "7c1d25d5-13d9-4b7a-b5f3-c417751edb31", "device_owner": "compute:nova"}, "dns_domain": "", "dns_name": "", "tags": [], "created_at": "2023-08-25T10:12:57Z", "updated_at": "2023-08-25T10:12:57Z", "revision_number": 0}}'08:53
liuc492023-08-25 10:12:58,392 215379 INFO     [tempest.lib.common.ssh] Creating ssh connection to '172.24.4.213:22' as 'cirros' with public key authentication08:53
liuc492023-08-25 10:13:58,449 215379 WARNING  [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to cirros@17208:54
liuc49    .24.4.213 (timed out). Number attempts: 1. Retry after 2 seconds.08:54
liuc492023-08-25 10:15:01,012 215379 WARNING  [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to cirros@172.24.4.213 (timed out). Number attempts: 2. Retry after 3 seconds.08:54
liuc492023-08-25 10:16:04,575 215379 WARNING  [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to cirros@172.24.4.213 (timed out). Number attempts: 3. Retry after 4 seconds.08:54
liuc492023-08-25 10:17:09,135 215379 ERROR    [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to cirros@172.24.4.213 after 3 attempts. Proxy client: no proxy client08:54
liuc492023-08-25 10:17:09.135 215379 ERROR tempest.lib.common.ssh Traceback (most recent call last):08:54
liuc492023-08-25 10:17:09.135 215379 ERROR tempest.lib.common.ssh   File "/opt/stack/tempest/tempest/lib/common/ssh.py", line 136, in _get_ssh_connection08:54
liuc492023-08-25 10:17:09.135 215379 ERROR tempest.lib.common.ssh     ssh.connect(self.host, port=self.port, username=self.username,08:54
liuc492023-08-25 10:17:09.135 215379 ERROR tempest.lib.common.ssh   File "/opt/stack/.local/lib/python3.10/site-packages/paramiko/client.py", line 386, in connect08:54
liuc492023-08-25 10:17:09.135 215379 ERROR tempest.lib.common.ssh     sock.connect(addr)08:54
liuc492023-08-25 10:17:09.135 215379 ERROR tempest.lib.common.ssh TimeoutError: timed out08:54
liuc492023-08-25 10:17:09.135 215379 ERROR tempest.lib.common.ssh 08:54
liuc492023-08-25 10:17:09,136 215379 DEBUG    [tempest.lib.common.utils.linux.remote_client] Caller: TestStampPattern:test_stamp_pattern. Timeout trying to ssh to server {'id': '7c1d25d5-13d9-4b7a-b5f3-c417751edb31', 'name': 'tempest-TestStampPattern-server-2071343168', 'status': 'ACTIVE', 'tenant_id': '8f8595f12b7143988bbf4872ed53bb4d', 'user_id': '611183d8869348369d99061bc78af7bc', 'metadata': {}, 'hostId': '8235c74c04a0aeae07bc3e044a6bfbc0a58d2abfd1d940d08:54
liuc49af4d14f77', 'image': {'id': '52641559-2817-49d7-9642-b36377db9d11', 'links': [{'rel': 'bookmark', 'href': 'http://10.225.110.7/compute/images/52641559-2817-49d7-9642-b36377db9d11'}]}, 'flavor': {'id': '42', 'links': [{'rel': 'bookmark', 'href': 'http://10.225.110.7/compute/flavors/42'}]}, 'created': '2023-08-25T10:12:50Z', 'updated': '2023-08-25T10:12:56Z', 'addresses': {'tempest-TestStampPattern-575007048-network': [{'version': 4, 'addr': 08:54
liuc49'10.0.0.11', 'OS-EXT-IPS:type': 'fixed', 'OS-EXT-IPS-MAC:mac_addr': 'fa:16:3e:9a:a3:c9'}]}, 'accessIPv4': '', 'accessIPv6': '', 'links': [{'rel': 'self', 'href': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}, {'rel': 'bookmark', 'href': 'http://10.225.110.7/compute/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31'}], 'OS-DCF:diskConfig': 'MANUAL', 'progress': 0, 'OS-EXT-AZ:availability_zone': 'nova', 'config_drive': '', 08:54
liuc49'key_name': 'tempest-TestStampPattern-240132218', 'OS-SRV-USG:launched_at': '2023-08-25T10:12:56.000000', 'OS-SRV-USG:terminated_at': None, 'security_groups': [{'name': 'tempest-secgroup-smoke-734784657'}], 'OS-EXT-STS:task_state': None, 'OS-EXT-STS:vm_state': 'active', 'OS-EXT-STS:power_state': 1, 'os-extended-volumes:volumes_attached': []}08:54
liuc492023-08-25 10:17:09,349 215379 INFO     [tempest.lib.common.rest_client] Request (TestStampPattern:test_stamp_pattern): 200 POST http://10.225.110.7/compute/v2.1/servers/7c1d25d5-13d9-4b7a-b5f3-c417751edb31/action 0.212s08:54
liuc492023-08-25 10:17:09,349 215379 DEBUG    [tempest.lib.common.rest_client] Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}08:55
liuc49        Body: {"os-getConsoleOutput": {}}08:55
liuc49    Response - Headers: {'date': 'Fri, 25 Aug 2023 10:17:09 GMT', 'server': 'Apache/2.4.52 (Ubuntu)', 'content-length': '32517', 'content-type': 'application/json', 'openstack-api-version': 'compute 2.1', 'x-openstack-nova-api-version': '2.1', 'vary': 'OpenStack-API-Version,X-OpenStack-Nova-API-Version', 'x-openstack-request-id': 'req-0dd3c891-be0a-436a-bd19-ed612f541683', 'x-compute-request-id': 'req-0dd3c891-be0a-436a-bd19-ed612f541683', 08:55
liuc49'connection': 'close', 'status': '200', 'content-location': 'http://10.225.110.7/compute/v2.1/servers/7c1d25d5-08:55
liuc49    13d9-4b7a-b5f3-c417751edb31/action'}08:55
liuc49        Body: b'{"output": "[    0.000000] Linux version 5.15.0-71-generic (buildd@lcy02-amd64-044) (gcc (Ubuntu 11.3.0-1ubuntu1~22.04.1) 11.3.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #78-Ubuntu SMP Tue Apr 18 09:00:29 UTC 2023 (Ubuntu 5.15.0-71.78-generic 5.15.92)\\n[    0.000000] Command line: LABEL=cirros-rootfs ro console=tty1 console=ttyS0\\n[    0.000000] KERNEL supported cpus:\\n[    0.000000]   Intel GenuineIntel\\n[    0.000000]   AMD 08:55
liuc49AuthenticAMD\\n[    0.000000]   Hygon HygonGenuine\\n[    0.000000]   Centaur CentaurHauls\\n[    0.000000]   zhaoxin   Shanghai  \\n[    0.000000] x86/fpu: x87 FPU will use FXSAVE\\n[    0.000000] signal: max sigframe size: 1440\\n[    0.000000] BIOS-provided physical RAM map:\\n[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable\\n[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved\\n[    08:55
liuc490.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved\\n[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000007fdcfff] usable\\n[    0.000000] BIOS-e820: [mem 0x0000000007fdd000-0x0000000007ffffff] reserved\\n[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved\\n[    0.000000] NX (Execute Disable) protection: active\\n[    0.000000] SMBIOS 2.8 present.\\n[    0.000000] DMI: OpenStack Foundation 08:55
liuc49OpenStack Nova, BIOS 1.15.0-1 04/01/2014\\n[    0.000000] last_pfn = 0x7fdd max_arch_pfn = 0x400000000\\n[    0.000000] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  \\n[    0.000000] found SMP MP-table at [mem 0x000f5b80-0x000f5b8f]\\n[    0.000000] RAMDISK: [mem 0x07743000-0x07fccfff]\\n[    0.000000] ACPI: Early table checksum verification disabled\\n[    0.000000] ACPI: RSDP 0x00000000000F5990 000014 (v00 BOCHS )\\n[    0.000000] 08:55
liuc49ACPI: RSDT 0x0000000007FE18B3 000034 (v01 BOCHS  BXPC     00000001 BXPC 00000001)\\n[    0.000000] ACPI: FACP 0x0000000007FE1767 000074 (v01 BOCHS  BXPC     00000001 BXPC 00000001)\\n[    0.000000] ACPI: DSDT 0x0000000007FE0040 001727 (v01 BOCHS  BXPC     00000001 BXPC 00000001)\\n[    0.000000] ACPI: FACS 0x0000000007FE0000 000040\\n[    0.000000] ACPI: APIC 0x0000000007FE17DB 000078 (v01 BOCHS  BXPC     00000001 BXPC 00000001)\\n[    0.000000] 08:55
liuc49ACPI: HPET 0x0000000007FE1853 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)\\n[    0.000000] ACPI: WAET 0x0000000007FE188B 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)\\n[    0.000000] ACPI: Reserving FACP table memory at [mem 0x7fe1767-0x7fe17da]\\n[    0.000000] ACPI: Reserving DSDT table memory at [mem 0x7fe0040-0x7fe1766]\\n[    0.000000] ACPI: Reserving FACS table memory at [mem 0x7fe0000-0x7fe003f]\\n[    0.000000] ACPI: Reserving 08:55
liuc49APIC table memory at [mem 0x7fe17db-0x7fe1852]\\n[    0.000000] ACPI: Reserving HPET table memory at [mem 0x7fe1853-0x7fe188a]\\n[    0.000000] ACPI: Reserving WAET table memory at [mem 0x7fe188b-0x7fe18b2]\\n[    0.000000] No NUMA configuration found\\n[    0.000000] Faking a node at [mem 0x0000000000000000-0x0000000007fdcfff]\\n[    0.000000] NODE_DATA(0) allocated [mem 0x07719000-0x07742fff]\\n[    0.000000] Zone ranges:\\n[    0.000000]   DMA     08:55
liuc49 [mem 0x0000000000001000-0x0000000000ffffff]\\n[    0.000000]   DMA32    [mem 0x0000000001000000-0x0000000007fdcfff]\\n[    0.000000]   Normal   empty\\n[    0.000000]   Device   empty\\n[    0.000000] Movable zone start for each node\\n[    0.000000] Early memory node ranges\\n[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]\\n[    0.000000]   node   0: [mem 0x0000000000100000-0x0000000007fdcfff]\\n[    0.000000] Initmem setup 08:55
liuc49node 0 [mem 0x0000000000001000-0x0000000007fdcfff]\\n[    0.000000] On node 0, zone DMA: 1 pages in unavailable ranges\\n[    0.000000] On node 0, zone DMA: 97 pages in unavailable ranges\\n[    0.000000] On node 0, zone DMA32: 35 pages in unavailable ranges\\n[    0.000000] ACPI: PM-Timer IO Port: 0x608\\n[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])\\n[    0.000000] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, G08:55
liuc49    SI 0-23\\n[    0.000000] ACPI: INT_SRC_OVR (bus 0 b08:56
liuc492023-08-25 10:17:09,350 215379 DEBUG    [tempest.lib.common.utils.linux.remote_client] Console log for server 7c1d25d5-13d9-4b7a-b5f3-c417751edb31: [    0.000000] Linux version 5.15.0-71-generic (buildd@lcy02-amd64-044) (gcc (Ubuntu 11.3.0-1ubuntu1~22.04.1) 11.3.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #78-Ubuntu SMP Tue Apr 18 09:00:29 UTC 2023 (Ubuntu 5.15.0-71.78-generic 5.15.92)08:56
liuc49[    0.000000] Command line: LABEL=cirros-rootfs ro console=tty1 console=ttyS008:56
liuc49[    0.000000] KERNEL supported cpus:08:56
liuc49[    0.000000]   Intel GenuineIntel08:56
liuc49[    0.000000]   AMD AuthenticAMD08:56
liuc49[    0.000000]   Hygon HygonGenuine08:56
liuc49[    0.000000]   Centaur CentaurHauls08:56
liuc49[    0.000000]   zhaoxin   Shanghai  08:56
liuc49[    0.000000] x86/fpu: x87 FPU will use FXSAVE08:56
liuc49[    0.000000] signal: max sigframe size: 144008:56
liuc49[    0.000000] BIOS-provided physical RAM map:08:56
liuc49[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable08:56
liuc49[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved08:56
liuc49[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved08:56
liuc49[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000007fdcfff] usable08:56
liuc49[    0.000000] BIOS-e820: [mem 0x0000000007fdd000-0x0000000007ffffff] reserved08:56
liuc49[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved08:56
liuc49[    0.000000] NX (Execute Disable) protection: active08:56
liuc49[    0.000000] SMBIOS 2.8 present.08:56
liuc49[    0.000000] DMI: OpenStack Foundation OpenStack Nova, BIOS 1.15.0-1 04/01/201408:56
liuc49[    0.000000] last_pfn = 0x7fdd max_arch_pfn = 0x40000000008:56
liuc49[    0.000000] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  08:56
liuc49[    0.000000] found SMP MP-table at [mem 0x000f5b80-0x000f5b8f]08:56
liuc49[    0.000000] RAMDISK: [mem 0x07743000-0x07fccfff]08:56
liuc49[    0.000000] ACPI: Early table checksum verification disabled08:57
liuc49[    0.000000] ACPI: RSDP 0x00000000000F5990 000014 (v00 BOCHS )08:57
liuc49[    0.000000] ACPI: RSDT 0x0000000007FE18B3 000034 (v01 BOCHS  BXPC     00000001 BXPC 00000001)08:57
liuc49[    0.000000] ACPI: FACP 0x0000000007FE1767 000074 (v01 BOCHS  BXPC     00000001 BXPC 00000001)08:57
liuc49[    0.000000] ACPI: DSDT 0x0000000007FE0040 001727 (v01 BOCHS  BXPC     00000001 BXPC 00000001)08:57
liuc49[    0.000000] ACPI: FACS 0x0000000007FE0000 00004008:57
liuc49[    0.000000] ACPI: APIC 0x0000000007FE17DB 000078 (v01 BOCHS  BXPC     00000001 BXPC 00000001)08:57
liuc49[    0.000000] ACPI: HPET 0x0000000007FE1853 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)08:57
liuc49[    0.000000] ACPI: WAET 0x0000000007FE188B 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)08:57
liuc49[    0.000000] ACPI: Reserving FACP table memory at [mem 0x7fe1767-0x7fe17da]08:57
liuc49[    0.000000] ACPI: Reserving DSDT table memory at [mem 0x7fe0040-0x7fe1766]08:57
liuc49[    0.000000] ACPI: Reserving FACS table memory at [mem 0x7fe0000-0x7fe003f]08:57
liuc49[    0.000000] ACPI: Reserving APIC table memory at [mem 0x7fe17db-0x7fe1852]08:57
liuc49[    0.000000] ACPI: Reserving HPET table memory at [mem 0x7fe1853-0x7fe188a]08:57
liuc49[    0.000000] ACPI: Reserving WAET table memory at [mem 0x7fe188b-0x7fe18b2]08:57
liuc49[    0.000000] No NUMA configuration found08:57
liuc49[    0.000000] Faking a node at [mem 0x0000000000000000-0x0000000007fdcfff]08:57
liuc49[    0.000000] NODE_DATA(0) allocated [mem 0x07719000-0x07742fff]08:57
liuc49[    0.000000] Zone ranges:08:57
liuc49[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]08:57
liuc49[    0.000000]   DMA32    [mem 0x0000000001000000-0x0000000007fdcfff]08:57
liuc49[    0.000000]   Normal   empty08:57
liuc49[    0.000000]   Device   empty08:57
liuc49[    0.000000] Movable zone start for each node08:57
liuc49[    0.000000] Early memory node ranges08:57
liuc49[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]08:57
liuc49[    0.000000]   node   0: [mem 0x0000000000100000-0x0000000007fdcfff]08:57
liuc49[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000007fdcfff]08:57
liuc49[    0.000000] On node 0, zone DMA: 1 pages in unavailable ranges08:58
liuc49[    0.000000] On node 0, zone DMA: 97 pages in unavailable ranges08:58
liuc49[    0.000000] On node 0, zone DMA32: 35 pages in unavailable ranges08:58
liuc49[    0.000000] ACPI: PM-Timer IO Port: 0x60808:58
liuc49[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])08:58
liuc49[    0.000000] IOAPIC[0]: apic_id 0, version 32, 08:58
liuc49    address 0xfec00000, GSI 0-2308:58
liuc49[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)08:58
liuc49[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)08:58
liuc49[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)08:58
liuc49[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)08:58
liuc49[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)08:58
liuc49[    0.000000] ACPI: Using ACPI (MADT) for SMP configuration information08:58
liuc49[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed0000008:58
liuc49[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs08:58
liuc49[    0.000000] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]08:58
liuc49[    0.000000] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff]08:58
liuc49[    0.000000] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000effff]08:58
liuc49[    0.000000] PM: hibernation: Registered nosave memory: [mem 0x000f0000-0x000fffff]08:58
liuc49[    0.000000] [mem 0x08000000-0xfffbffff] available for PCI devices08:58
liuc49[    0.000000] Booting paravirtualized kernel on bare hardware08:58
liuc49[    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns08:58
liuc49[    0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:108:58
liuc49[    0.000000] percpu: Embedded 60 pages/cpu s208896 r8192 d28672 u209715208:58
liuc49[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 3196508:58
liuc49[    0.000000] Policy zone: DMA3208:58
liuc49[    0.000000] Kernel command line: LABEL=cirros-rootfs ro console=tty1 console=ttyS008:58
liuc49[    0.000000] Unknown kernel command line parameters "LABEL=cirros-rootfs", will be passed to user space.08:59
liuc49[    0.000000] Dentry cache hash table entries: 16384 (order: 5, 131072 bytes, linear)08:59
liuc49[    0.000000] Inode-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)08:59
liuc49[    0.000000] mem auto-init: stack:off, heap alloc:on, heap free:off08:59
liuc49[    0.000000] Memory: 73084K/130540K available (16393K kernel code, 4383K rwdata, 10840K rodata, 3244K init, 6548K bss, 57196K reserved, 0K cma-reserved)08:59
liuc49[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=108:59
liuc49[    0.000000] Kernel/User page tables isolation: enabled08:59
liuc49[    0.000000] ftrace: allocating 50600 entries in 198 pages08:59
liuc49[    0.000000] ftrace: allocated 198 pages with 4 groups08:59
liuc49[    0.000000] rcu: Hierarchical RCU implementation.08:59
liuc49[    0.000000] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=1.08:59
liuc49[    0.000000] Rude variant of Tasks RCU enabled.08:59
liuc49[    0.000000] Tracing variant of Tasks RCU enabled.08:59
liuc49[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.08:59
liuc49[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=108:59
liuc49[    0.000000] NR_IRQS: 524544, nr_irqs: 256, preallocated irqs: 1608:59
opendevreviewJakub Skunda proposed openstack/tempest master: Remove test duplication between tempest and neutron-tempest-plugin QuotasTest  https://review.opendev.org/c/openstack/tempest/+/89267708:59
liuc49[    0.000000] Console: colour VGA+ 80x2508:59
liuc49[    0.000000] printk: console [tty1] enabled08:59
liuc49[    0.000000] printk: console [ttyS0] enabled08:59
liuc49[    0.000000] ACPI: Core revision 2021073008:59
liuc49[    0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns08:59
liuc49[    0.008000] APIC: Switch to symmetric I/O mode setup08:59
liuc49[    0.016000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-108:59
liuc49[    0.048000] tsc: Unable to calibrate against PIT08:59
liuc49[    0.048000] tsc: using HPET reference calibration08:59
liuc49[    0.048000] tsc: Detected 2191.275 MHz processor08:59
liuc49[    0.002086] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x1f9600b58eb, max_idle_ns: 440795309356 ns08:59
liuc49[    0.003261] Calibrating delay loop (skipped), value calculated using timer frequency.. 4382.55 BogoMIPS (lpj=8765100)09:00
liuc49[    0.006915] pid_max: default: 32768 minimum: 30109:00
liuc49[    0.008945] LSM: Security Framework initializing09:00
liuc49[    0.011059] landlock: Up and running.09:00
liuc49[    0.011264] Yama: becoming mindful.09:00
liuc49[    0.015384] AppArmor: AppArmor initialized09:00
liuc49[    0.020286] Mount-cache hash table entries: 512 (order: 0, 4096 bytes, linear)09:00
liuc49[    0.020621] Mountpoint-cache hash table entries: 512 (order: 0, 4096 bytes, linear)09:00
liuc49[    0.057814] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 009:00
liuc49[    0.058131] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 009:00
liuc49[  09:00
liuc49      0.058787] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization09:00
liuc49[    0.059473] Spectre V2 : Mitigation: Retpolines09:00
liuc49[    0.059679] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch09:00
liuc49[    0.059982] Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT09:00
liuc49[    0.060426] Speculative Store Bypass: Vulnerable09:00
liuc49[    0.061124] MDS: Vulnerable: Clear CPU buffers attempted, no microcode09:00
liuc49[    0.061395] MMIO Stale Data: Unknown: No mitigations09:00
liuc49[    0.766916] Freeing SMP alternatives memory: 44K09:00
liuc49[    0.898060] smpboot: CPU0: Intel Core i7 9xx (Nehalem Class Core i7) (family: 0x6, model: 0x1a, stepping: 0x3)09:00
liuc49[    0.908731] Performance Events: unsupported p6 CPU model 26 no PMU driver, software events only.09:00
liuc49[    0.912105] rcu: Hierarchical SRCU implementation.09:00
liuc49[    0.925063] NMI watchdog: Perf NMI watchdog permanently disabled09:00
liuc49[    0.931657] smp: Bringing up secondary CPUs ...09:00
liuc49[    0.931981] smp: Brought up 1 node, 1 CPU09:00
liuc49[    0.932202] smpboot: Max logical packages: 109:00
liuc49[    0.932473] smpboot: Total of 1 processors activated (4382.55 BogoMIPS)09:01
liuc49[    0.956677] devtmpfs: initialized09:01
liuc49[    0.962922] x86/mm: Memory block size: 128MB09:01
liuc49[    0.970502] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns09:01
liuc49[    0.971269] futex hash table entries: 256 (order: 2, 16384 bytes, linear)09:01
liuc49[    0.977319] pinctrl core: initialized pinctrl subsystem09:01
liuc49[    0.989196] PM: RTC time: 10:13:02, date: 2023-08-2509:01
liuc49[    1.003091] NET: Registered PF_NETLINK/PF_ROUTE protocol family09:01
liuc49[    1.009480] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations09:01
liuc49[    1.010467] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations09:01
liuc49[    1.011027] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations09:01
liuc49[    1.011625] audit: initializing netlink subsys (disabled)09:01
liuc49[    1.019396] audit: type=2000 audit(1692958382.060:1): state=initialized audit_enabled=0 res=109:01
liuc49[    1.024250] thermal_sys: Registered thermal governor 'fair_share'09:01
liuc49[    1.024306] thermal_sys: Registered thermal governor 'bang_bang'09:01
liuc49[    1.024544] thermal_sys: Registered thermal governor 'step_wise'09:01
liuc49[    1.024735] thermal_sys: Registered thermal governor 'use09:01
fricklerliuc49: please use paste.opendev.org for multiline pastes. what environment are you testing on, a local devstack deployment?09:05
liuc49yes. I deploy a ubuntu VM.09:09
fricklerliuc49: did you try to create an instance manually and access it via a floating IP?09:21
liuc49no09:47
liuc49The instance show active but cannot ping successfully.09:48
fricklerliuc49: so that needs to be fixed first before attempting to run tempest. did you reboot the ubuntu VM after deploying devstack? that would currently destroy some of the network setup, see https://bugs.launchpad.net/devstack/+bug/2032774 , you could try the step listed under 2. there10:08
opendevreviewMerged openstack/tempest master: tox: Remove basepython  https://review.opendev.org/c/openstack/tempest/+/89037610:16
*** gthiemon1e is now known as gthiemonge12:20
*** JasonF is now known as JaqyF14:54
*** JaqyF is now known as JayF14:54
opendevreviewClark Boylan proposed openstack/tempest master: DNM test devstack+tempest under Ansible 8  https://review.opendev.org/c/openstack/tempest/+/89298115:56
gmannkopecmartin: can you check this, this is needed for sean-k-mooney change in nova https://review.opendev.org/c/openstack/devstack/+/89275317:16
sean-k-mooneyyes to remove the az filter. fyi i did not put a depend on in the nova patch to the backport because i dont knwo what will happen when it across branches like this17:26
opendevreviewMerged openstack/devstack stable/zed: The AZ filter is deprecated and planned for removal this cycle  https://review.opendev.org/c/openstack/devstack/+/89275323:15

Generated by irclog2html.py 2.17.3 by Marius Gedminas - find it at https://mg.pov.lt/irclog2html/!