yahoo-eng-team team mailing list archive
-
yahoo-eng-team team
-
Mailing list archive
-
Message #91046
[Bug 1639033] Re: Traces seen in l3 agent with prefix delegation enabled subnet
** Changed in: neutron
Status: In Progress => Won't Fix
--
You received this bug notification because you are a member of Yahoo!
Engineering Team, which is subscribed to neutron.
https://bugs.launchpad.net/bugs/1639033
Title:
Traces seen in l3 agent with prefix delegation enabled subnet
Status in neutron:
Won't Fix
Bug description:
2016-11-03 11:22:41.381 [00;32mDEBUG neutron.agent.linux.utils [[00;36m-[00;32m] [01;35m[00;32mRunning command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-9f1e22fe-eac6-4032-87f2-315f028076c8', 'ip', '-6', 'addr', 'add', '::8/64', 'scope', 'global', 'dev', 'qr-352a870a-7d'][00m [00;33mfrom (pid=28627) execute_rootwrap_daemon /opt/stack/neutron/neutron/agent/linux/utils.py:100[00m
2016-11-03 11:22:41.444 [01;31mERROR neutron.agent.linux.utils [[00;36m-[01;31m] [01;35m[01;31mExit code: 2; Stdin: ; Stdout: ; Stderr: RTNETLINK answers: File exists
[00m
2016-11-03 11:22:41.445 [01;31mERROR neutron.agent.l3.router_info [[00;36m-[01;31m] [01;35m[01;31mExit code: 2; Stdin: ; Stdout: ; Stderr: RTNETLINK answers: File exists
[00m
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00mTraceback (most recent call last):
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/common/utils.py", line 216, in call
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m return func(*args, **kwargs)
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/agent/l3/router_info.py", line 1064, in process
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m self._process_internal_ports(agent.pd)
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/agent/l3/router_info.py", line 555, in _process_internal_ports
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m updated_cidrs)
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/agent/l3/router_info.py", line 394, in _internal_network_updated
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m self.ns_name)
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/interface.py", line 183, in add_ipv6_addr
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m device.addr.add(str(net), scope)
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/ip_lib.py", line 580, in add
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m self._as_root([net.version], tuple(args))
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/ip_lib.py", line 367, in _as_root
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m use_root_namespace=use_root_namespace)
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/ip_lib.py", line 96, in _as_root
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m log_fail_as_error=self.log_fail_as_error)
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/ip_lib.py", line 105, in _execute
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m log_fail_as_error=log_fail_as_error)
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/utils.py", line 139, in execute
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m raise RuntimeError(msg)
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00mRuntimeError: Exit code: 2; Stdin: ; Stdout: ; Stderr: RTNETLINK answers: File exists
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m
[01;31m2016-11-03 11:22:41.445 TRACE neutron.agent.l3.router_info [01;35m[00m
2016-11-03 11:22:41.448 [01;31mERROR neutron.agent.l3.agent [[00;36m-[01;31m] [01;35m[01;31mFailed to process compatible router: 9f1e22fe-eac6-4032-87f2-315f028076c8[00m
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00mTraceback (most recent call last):
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/l3/agent.py", line 508, in _process_router_update
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m self._process_router_if_compatible(router)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/l3/agent.py", line 445, in _process_router_if_compatible
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m self._process_updated_router(router)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/l3/agent.py", line 460, in _process_updated_router
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m ri.process(self)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/common/utils.py", line 219, in call
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m self.logger(e)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/usr/local/lib/python2.7/dist-packages/oslo_utils/excutils.py", line 220, in __exit__
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m self.force_reraise()
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/usr/local/lib/python2.7/dist-packages/oslo_utils/excutils.py", line 196, in force_reraise
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m six.reraise(self.type_, self.value, self.tb)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/common/utils.py", line 216, in call
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m return func(*args, **kwargs)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/l3/router_info.py", line 1064, in process
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m self._process_internal_ports(agent.pd)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/l3/router_info.py", line 555, in _process_internal_ports
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m updated_cidrs)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/l3/router_info.py", line 394, in _internal_network_updated
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m self.ns_name)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/interface.py", line 183, in add_ipv6_addr
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m device.addr.add(str(net), scope)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/ip_lib.py", line 580, in add
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m self._as_root([net.version], tuple(args))
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/ip_lib.py", line 367, in _as_root
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m use_root_namespace=use_root_namespace)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/ip_lib.py", line 96, in _as_root
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m log_fail_as_error=self.log_fail_as_error)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/ip_lib.py", line 105, in _execute
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m log_fail_as_error=log_fail_as_error)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m File "/opt/stack/neutron/neutron/agent/linux/utils.py", line 139, in execute
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m raise RuntimeError(msg)
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00mRuntimeError: Exit code: 2; Stdin: ; Stdout: ; Stderr: RTNETLINK answers: File exists
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m
[01;31m2016-11-03 11:22:41.448 TRACE neutron.agent.l3.agent [01;35m[00m
2016-11-03 11:22:41.450 [00;32mDEBUG neutron.agent.l3.agent [[00;36m-[00;32m] [01;35m[00;32mPayload:
{
"enable_snat": true,
"gw_port": {
"allowed_address_pairs": [],
"extra_dhcp_opts": [],
"updated_at": "2016-11-03T15:22:34Z",
"device_owner": "network:router_gateway",
"revision_number": 8,
"port_security_enabled": false,
"binding:profile": {},
"binding:vnic_type": "normal",
"fixed_ips": [
{
"subnet_id": "e8cbec96-2ea4-43d5-a717-93b03231d393",
"prefixlen": 24,
"ip_address": "172.24.4.5"
},
{
"subnet_id": "68fc0073-619a-43ca-be62-569842366e48",
"prefixlen": 64,
"ip_address": "2001:db8::7"
}
],
"id": "8ffa9d13-f66d-4cfe-b16d-f71c315c53a9",
"security_groups": [],
"binding:vif_details": {
"port_filter": true,
"ovs_hybrid_plug": true
},
"address_scopes": {
"4": null,
"6": null
},
"binding:vif_type": "ovs",
"mac_address": "fa:16:3e:eb:cb:05",
"project_id": "",
"status": "ACTIVE",
"subnets": [
{
"dns_nameservers": [],
"ipv6_ra_mode": null,
"gateway_ip": "2001:db8::2",
"cidr": "2001:db8::/64",
"id": "68fc0073-619a-43ca-be62-569842366e48",
"subnetpool_id": null
},
{
"dns_nameservers": [],
"ipv6_ra_mode": null,
"gateway_ip": "172.24.4.1",
"cidr": "172.24.4.0/24",
"id": "e8cbec96-2ea4-43d5-a717-93b03231d393",
"subnetpool_id": null
}
],
"binding:host_id": "ip6-devstack-43",
"description": "",
"device_id": "9f1e22fe-eac6-4032-87f2-315f028076c8",
"name": "",
"admin_state_up": true,
"network_id": "8da945b9-8ac2-4d1b-840f-094dbd794500",
"tenant_id": "",
"created_at": "2016-11-03T15:22:30Z",
"mtu": 1500,
"extra_subnets": []
},
"updated_at": "2016-11-03T15:22:31Z",
"revision_number": 6,
"id": "9f1e22fe-eac6-4032-87f2-315f028076c8",
"_interfaces": [
{
"allowed_address_pairs": [],
"extra_dhcp_opts": [],
"updated_at": "2016-11-03T15:22:30Z",
"device_owner": "network:router_interface",
"revision_number": 8,
"port_security_enabled": false,
"binding:profile": {},
"binding:vnic_type": "normal",
"fixed_ips": [
{
"subnet_id": "3b227ecc-c0ac-4b9e-bc29-9458e0f35633",
"prefixlen": 64,
"ip_address": "::8"
}
],
"id": "352a870a-7d20-4964-b739-7febbefa8687",
"security_groups": [],
"binding:vif_details": {
"port_filter": true,
"ovs_hybrid_plug": true
},
"address_scopes": {
"4": null,
"6": null
},
"binding:vif_type": "ovs",
"mac_address": "fa:16:3e:3d:7b:0d",
"project_id": "59485ad25c25488cae7711528c3a3914",
"status": "ACTIVE",
"subnets": [
{
"dns_nameservers": [],
"ipv6_ra_mode": "slaac",
"gateway_ip": "2001:420:2c50:2024::1",
"cidr": "2001:420:2c50:2024::/64",
"id": "3b227ecc-c0ac-4b9e-bc29-9458e0f35633",
"subnetpool_id": "prefix_delegation"
}
],
"binding:host_id": "ip6-devstack-43",
"description": "",
"device_id": "9f1e22fe-eac6-4032-87f2-315f028076c8",
"name": "",
"admin_state_up": true,
"network_id": "243184e5-72d4-43eb-9295-b10ae8b44c7a",
"tenant_id": "59485ad25c25488cae7711528c3a3914",
"created_at": "2016-11-03T15:22:26Z",
"mtu": 1500,
"extra_subnets": []
}
],
"availability_zone_hints": [],
"availability_zones": [
"nova"
],
"distributed": false,
"project_id": "59485ad25c25488cae7711528c3a3914",
"status": "ACTIVE",
"ha_vr_id": 0,
"description": "",
"ha": false,
"gw_port_host": "ip6-devstack-43",
"external_gateway_info": {
"network_id": "8da945b9-8ac2-4d1b-840f-094dbd794500",
"enable_snat": true,
"external_fixed_ips": [
{
"subnet_id": "e8cbec96-2ea4-43d5-a717-93b03231d393",
"ip_address": "172.24.4.5"
},
{
"subnet_id": "68fc0073-619a-43ca-be62-569842366e48",
"ip_address": "2001:db8::7"
}
]
},
"name": "ha-router",
"gw_port_id": "8ffa9d13-f66d-4cfe-b16d-f71c315c53a9",
"admin_state_up": true,
"tenant_id": "59485ad25c25488cae7711528c3a3914",
"created_at": "2016-11-03T15:22:22Z",
"flavor_id": null,
"routes": []
}[00m [00;33mfrom (pid=28627) log_verbose_exc /opt/stack/neutron/neutron/agent/l3/agent.py:76[00m
Noticed that in the above payload, "gateway_ip":
"2001:420:2c50:2024::1", but fixed ip doesn't get updated on the
gateway port.
The traceback caused resync, and subsequent router update has the
correct fixed up.
To manage notifications about this bug go to:
https://bugs.launchpad.net/neutron/+bug/1639033/+subscriptions
References