log traces 'IPv6 subnet is configured for automatic address'

[Gary Kotton]

2015-11-13 07:19:53.080 ERROR oslo_messaging.rpc.dispatcher [req-c1a7e5c5-bdac-4ce9-8099-18965908e11b None None] Exception during message handling: Invalid input for operation: IPv6 address 2003::f816:3eff:fef9:ebe0 can not be directly assigned to a port on subnet 14b253af-925c-45e9-9523-76a649ee37c4 since the subnet is configured for automatic addresses.
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher Traceback (most recent call last):
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 142, in _dispatch_and_reply
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher executor_callback))
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 186, in _dispatch
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher executor_callback)
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 129, in _do_dispatch
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher result = func(ctxt, **new_args)
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_db/api.py", line 147, in wrapper
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher ectxt.value = e.inner_exc
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_utils/excutils.py", line 197, in __exit__
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher six.reraise(self.type_, self.value, self.tb)
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/usr/local/lib/python2.7/dist-packages/oslo_db/api.py", line 137, in wrapper
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher return f(*args, **kwargs)
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/opt/stack/new/neutron/neutron/api/rpc/handlers/dhcp_rpc.py", line 226, in update_dhcp_port
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher return self._port_action(plugin, context, port, 'update_port')
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/opt/stack/new/neutron/neutron/api/rpc/handlers/dhcp_rpc.py", line 88, in _port_action
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher return plugin.update_port(context, port['id'], port)
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/opt/stack/new/neutron/neutron/plugins/ml2/plugin.py", line 1154, in update_port
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher port)
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/opt/stack/new/neutron/neutron/db/db_base_plugin_v2.py", line 1221, in update_port
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher new_port, new_mac)
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/opt/stack/new/neutron/neutron/db/ipam_non_pluggable_backend.py", line 221, in update_port_with_ips
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher original['mac_address'], db_port['device_owner'])
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/opt/stack/new/neutron/neutron/db/ipam_non_pluggable_backend.py", line 322, in _update_ips_for_port
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher changes.add, device_owner)
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher File "/opt/stack/new/neutron/neutron/db/ipam_non_pluggable_backend.py", line 264, in _test_fixed_ips_for_port
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher raise n_exc.InvalidInput(error_message=msg)
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher InvalidInput: Invalid input for operation: IPv6 address 2003::f816:3eff:fef9:ebe0 can not be directly assigned to a port on subnet 14b253af-925c-45e9-9523-76a649ee37c4 since the subnet is configured for automatic addresses.
2015-11-13 07:19:53.080 27535 ERROR oslo_messaging.rpc.dispatcher
2015-11-13 07:19:53.083 ERROR oslo_messaging._drivers.common [req-c1a7e5c5-bdac-4ce9-8099-18965908e11b None None] Returning exception Invalid input for operation: IPv6 address 2003::f816:3eff:fef9:ebe0 can not be directly assigned to a port on subnet 14b253af-925c-45e9-9523-76a649ee37c4 since the subnet is configured for automatic addresses. to caller
2015-11-13 07:19:53.083 ERROR oslo_messaging._drivers.common [req-c1a7e5c5-bdac-4ce9-8099-18965908e11b None None] ['Traceback (most recent call last):\n', ' File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 142, in _dispatch_and_reply\n executor_callback))\n', ' File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 186, in _dispatch\n executor_callback)\n', ' File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 129, in _do_dispatch\n result = func(ctxt, **new_args)\n', ' File "/usr/local/lib/python2.7/dist-packages/oslo_db/api.py", line 147, in wrapper\n ectxt.value = e.inner_exc\n', ' File "/usr/local/lib/python2.7/dist-packages/oslo_utils/excutils.py", line 197, in __exit__\n six.reraise(self.type_, self.value, self.tb)\n', ' File "/usr/local/lib/python2.7/dist-packages/oslo_db/api.py", line 137, in wrapper\n return f(*args, **kwargs)\n', ' File "/opt/stack/new/neutron/neutron/api/rpc/handlers/dhcp_rpc.py", line 226, in update_dhcp_port\n return self._port_action(plugin, context, port, \'update_port\')\n', ' File "/opt/stack/new/neutron/neutron/api/rpc/handlers/dhcp_rpc.py", line 88, in _port_action\n return plugin.update_port(context, port[\'id\'], port)\n', ' File "/opt/stack/new/neutron/neutron/plugins/ml2/plugin.py", line 1154, in update_port\n port)\n', ' File "/opt/stack/new/neutron/neutron/db/db_base_plugin_v2.py", line 1221, in update_port\n new_port, new_mac)\n', ' File "/opt/stack/new/neutron/neutron/db/ipam_non_pluggable_backend.py", line 221, in update_port_with_ips\n original[\'mac_address\'], db_port[\'device_owner\'])\n', ' File "/opt/stack/new/neutron/neutron/db/ipam_non_pluggable_backend.py", line 322, in _update_ips_for_port\n changes.add, device_owner)\n', ' File "/opt/stack/new/neutron/neutron/db/ipam_non_pluggable_backend.py", line 264, in _test_fixed_ips_for_port\n raise n_exc.InvalidInput(error_message=msg)\n', 'InvalidInput: Invalid input for operation: IPv6 address 2003::f816:3eff:fef9:ebe0 can not be directly assigned to a port on subnet 14b253af-925c-45e9-9523-76a649ee37c4 since the subnet is configured for automatic addresses.\n']

[Miguel Angel Ajo (mangelajo)]

Seems to happen on stable/kilo and stable/liberty too, and not indicative of test failure:

http://logstash.openstack.org/#dashboard/file/logstash.json?query=message:%5C%22Exception%20during%20message%20handling:%20Invalid%20input%20for%20operation:%20IPv6%20address%5C%22

[Armando Migliaccio (armando-migliaccio)]

Can't seem to find an occurrence of this failure with a gate failure. Afaik this is log noise. It'd be nice to clean that up though.

[Sean M. Collins (scollins)]

putting this in the low-hanging fruit tag, if there is someone brave enough to tackle this :)

[Armando Migliaccio (armando-migliaccio)]

This bug is > 180 days without activity. We are unsetting assignee and milestone and setting status to Incomplete in order to allow its expiry in 60 days.

If the bug is still valid, then update the bug status.

[Brian Haley (brian-haley)]

All occurrences of this trace I could find were only in the stable/mitaka logs, so either it got fixed or isn't getting triggered any more. Fine with letting it autoclose.

[Launchpad Janitor (janitor)]

[Expired for neutron because there has been no activity for 60 days.]