After i have applied the patch i get still the exceptions from vpn-agent.log: 2016-08-01 09:41:26.377 53157 DEBUG oslo_concurrency.lockutils [-] Lock "_check_child_processes" acquired by "neutron.agent.linux.external_process._check_child_processes" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270 2016-08-01 09:41:26.380 53157 DEBUG oslo_concurrency.lockutils [-] Lock "_check_child_processes" released by "neutron.agent.linux.external_process._check_child_processes" :: held 0.003s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282 2016-08-01 09:41:26.429 53157 DEBUG oslo_concurrency.lockutils [-] Lock "_check_child_processes" acquired by "neutron.agent.linux.external_process._check_child_processes" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270 2016-08-01 09:41:26.429 53157 DEBUG oslo_concurrency.lockutils [-] Lock "_check_child_processes" released by "neutron.agent.linux.external_process._check_child_processes" :: held 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282 2016-08-01 09:41:26.523 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] CALL msg_id: 743c08e13d104d73b6c122fbbb1becae exchange 'neutron' topic 'q-reports-plugin' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:454 2016-08-01 09:41:26.538 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: 743c08e13d104d73b6c122fbbb1becae __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:302 2016-08-01 09:41:48.585 53157 DEBUG oslo_service.periodic_task [req-c87d0ab2-94d9-4fcb-967a-9640ed3c1f59 - - - - -] Running periodic task VPNAgent.periodic_sync_routers_task run_periodic_tasks /usr/lib/python2.7/site-packages/oslo_service/periodic_task.py:215 2016-08-01 09:41:56.519 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] CALL msg_id: f7123d03a9744005b710b144545de115 exchange 'neutron' topic 'q-reports-plugin' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:454 2016-08-01 09:41:56.533 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: f7123d03a9744005b710b144545de115 __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:302 2016-08-01 09:42:07.823 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] received message msg_id: None reply to None __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:201 2016-08-01 09:42:07.825 53157 DEBUG neutron.agent.l3.agent [req-8bf4976f-a606-42a7-b60d-7baebe276155 4afea4ec82774aa3bfc4dab741c29934 352cd4ef40c04b058ba40316140c5a29 - - -] Got routers updated notification :[u'a9806b97-0850-4f40-8c73-c1fac666d21b'] routers_updated /usr/lib/python2.7/site-packages/neutron/agent/l3/agent.py:392 2016-08-01 09:42:07.825 53157 DEBUG neutron.agent.l3.agent [-] Starting router update for a9806b97-0850-4f40-8c73-c1fac666d21b, action None, priority 0 _process_router_update /usr/lib/python2.7/site-packages/neutron/agent/l3/agent.py:467 2016-08-01 09:42:07.826 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] CALL msg_id: 882a5673e9a84c33be219d327487a427 exchange 'neutron' topic 'q-l3-plugin' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:454 2016-08-01 09:42:08.837 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: 882a5673e9a84c33be219d327487a427 __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:302 2016-08-01 09:42:08.839 53157 DEBUG neutron.callbacks.manager [-] Notify callbacks for router, before_create _notify_loop /usr/lib/python2.7/site-packages/neutron/callbacks/manager.py:138 2016-08-01 09:42:08.839 53157 DEBUG neutron.callbacks.manager [-] Calling callback neutron.agent.linux.pd.add_router _notify_loop /usr/lib/python2.7/site-packages/neutron/callbacks/manager.py:145 2016-08-01 09:42:08.839 53157 DEBUG oslo_concurrency.lockutils [-] Lock "l3-agent-pd" acquired by "neutron.agent.linux.pd.add_router" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270 2016-08-01 09:42:08.839 53157 DEBUG oslo_concurrency.lockutils [-] Lock "l3-agent-pd" released by "neutron.agent.linux.pd.add_router" :: held 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282 2016-08-01 09:42:08.840 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', '-o', 'netns', 'list'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.845 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.846 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'sysctl', '-w', 'net.ipv4.ip_forward=1'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.857 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.858 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'sysctl', '-w', 'net.ipv6.conf.all.forwarding=1'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.868 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.870 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip', '-o', 'link', 'show', 'ha-f7750b12-a0'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.879 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.880 53157 INFO neutron.agent.linux.interface [-] Device ha-f7750b12-a0 already exists 2016-08-01 09:42:08.880 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip', '-o', 'link', 'show', 'ha-f7750b12-a0'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.890 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.890 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip', 'addr', 'show', 'ha-f7750b12-a0', 'permanent'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.900 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.900 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip', 'addr', 'show', 'ha-f7750b12-a0'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.910 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.910 53157 INFO neutron.agent.l3.ha [-] Router a9806b97-0850-4f40-8c73-c1fac666d21b transitioned to backup 2016-08-01 09:42:08.911 53157 DEBUG neutron.agent.l3.ha [-] Closing metadata proxy for router a9806b97-0850-4f40-8c73-c1fac666d21b _update_metadata_proxy /usr/lib/python2.7/site-packages/neutron/agent/l3/ha.py:154 2016-08-01 09:42:08.911 53157 DEBUG neutron.agent.linux.utils [-] Unable to access /var/lib/neutron/external/pids/a9806b97-0850-4f40-8c73-c1fac666d21b.pid get_value_from_file /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:225 2016-08-01 09:42:08.911 53157 DEBUG neutron.agent.linux.utils [-] Unable to access /var/lib/neutron/external/pids/a9806b97-0850-4f40-8c73-c1fac666d21b.pid get_value_from_file /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:225 2016-08-01 09:42:08.911 53157 DEBUG neutron.agent.linux.external_process [-] No process started for a9806b97-0850-4f40-8c73-c1fac666d21b disable /usr/lib/python2.7/site-packages/neutron/agent/linux/external_process.py:118 2016-08-01 09:42:08.912 53157 DEBUG neutron.agent.l3.router_info [-] Terminating radvd daemon in router device: a9806b97-0850-4f40-8c73-c1fac666d21b disable_radvd /usr/lib/python2.7/site-packages/neutron/agent/l3/router_info.py:446 2016-08-01 09:42:08.912 53157 DEBUG neutron.agent.linux.utils [-] Unable to access /var/lib/neutron/external/pids/a9806b97-0850-4f40-8c73-c1fac666d21b.pid.radvd get_value_from_file /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:225 2016-08-01 09:42:08.912 53157 DEBUG neutron.agent.linux.utils [-] Unable to access /var/lib/neutron/external/pids/a9806b97-0850-4f40-8c73-c1fac666d21b.pid.radvd get_value_from_file /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:225 2016-08-01 09:42:08.912 53157 DEBUG neutron.agent.linux.external_process [-] No process started for a9806b97-0850-4f40-8c73-c1fac666d21b disable /usr/lib/python2.7/site-packages/neutron/agent/linux/external_process.py:118 2016-08-01 09:42:08.913 53157 DEBUG neutron.agent.linux.ra [-] radvd disabled for router a9806b97-0850-4f40-8c73-c1fac666d21b disable /usr/lib/python2.7/site-packages/neutron/agent/linux/ra.py:190 2016-08-01 09:42:08.913 53157 DEBUG neutron_fwaas.services.firewall.agents.l3reference.firewall_l3_agent [-] Process router add, router_id: 'a9806b97-0850-4f40-8c73-c1fac666d21b' _process_router_add /usr/lib/python2.7/site-packages/neutron_fwaas/services/firewall/agents/l3reference/firewall_l3_agent.py:168 2016-08-01 09:42:08.914 53157 DEBUG neutron.agent.linux.utils [-] Running command: ['ip', 'netns', 'list'] create_process /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:84 2016-08-01 09:42:08.918 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.919 53157 DEBUG neutron_fwaas.services.firewall.agents.l3reference.firewall_l3_agent [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Retrieve Firewall with rules from Plugin get_firewalls_for_tenant /usr/lib/python2.7/site-packages/neutron_fwaas/services/firewall/agents/l3reference/firewall_l3_agent.py:39 2016-08-01 09:42:08.920 53157 DEBUG oslo_messaging._drivers.amqpdriver [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] CALL msg_id: d4bebeee21a04d19aba418e696526f49 exchange 'neutron' topic 'q-firewall-plugin' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:454 2016-08-01 09:42:08.931 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: d4bebeee21a04d19aba418e696526f49 __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:302 2016-08-01 09:42:08.932 53157 DEBUG neutron.agent.l3.router_info [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] process router updates process /usr/lib/python2.7/site-packages/neutron/agent/l3/router_info.py:960 2016-08-01 09:42:08.932 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip', '-o', 'link', 'show', 'qr-6ae2e68c-e0'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.945 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command: ['ip', '-o', 'link', 'show', 'br-int'] create_process /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:84 2016-08-01 09:42:08.950 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.952 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ovs-vsctl', '--timeout=10', '--oneline', '--format=json', '--', '--if-exists', 'del-port', 'qr-6ae2e68c-e0'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.960 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.960 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ovs-vsctl', '--timeout=10', '--oneline', '--format=json', '--', 'add-port', 'br-int', 'qr-6ae2e68c-e0', '--', 'set', 'Interface', 'qr-6ae2e68c-e0', 'type=internal', 'external_ids:iface-id=6ae2e68c-e0d2-4724-8491-d123ec6d498f', 'external_ids:iface-status=active', 'external_ids:attached-mac=fa:16:3e:92:f5:3d'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.975 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.976 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ovs-vsctl', '--timeout=10', '--oneline', '--format=json', '--', '--columns=ofport', 'list', 'Interface', 'qr-6ae2e68c-e0'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.981 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.982 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'link', 'set', 'qr-6ae2e68c-e0', 'address', 'fa:16:3e:92:f5:3d'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.984 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.985 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'link', 'set', 'qr-6ae2e68c-e0', 'mtu', '1458'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.987 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.988 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', '-o', 'netns', 'list'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:08.990 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:08.991 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'link', 'set', 'qr-6ae2e68c-e0', 'netns', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.000 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.000 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip', 'link', 'set', 'qr-6ae2e68c-e0', 'up'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.010 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.011 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip', '-o', 'link', 'show', 'qr-6ae2e68c-e0'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.020 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.021 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip', '-6', 'addr', 'flush', 'qr-6ae2e68c-e0'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.031 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.031 53157 DEBUG neutron.agent.l3.router_info [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] appending port {u'allowed_address_pairs': [], u'extra_dhcp_opts': [], u'updated_at': u'2016-08-01T07:42:07', u'device_owner': u'network:router_interface', u'port_security_enabled': False, u'binding:profile': {}, u'binding:vnic_type': u'normal', u'fixed_ips': [{u'subnet_id': u'f30be168-0864-4b05-8ce0-b55a9cb72c5a', u'prefixlen': 24, u'ip_address': u'192.168.0.1'}], u'id': u'6ae2e68c-e0d2-4724-8491-d123ec6d498f', u'security_groups': [], u'binding:vif_details': {}, u'address_scopes': {u'4': None, u'6': None}, u'binding:vif_type': u'unbound', u'mac_address': u'fa:16:3e:92:f5:3d', u'status': u'DOWN', u'subnets': [{u'dns_nameservers': [], u'ipv6_ra_mode': None, u'gateway_ip': u'192.168.0.1', u'cidr': u'192.168.0.0/24', u'id': u'f30be168-0864-4b05-8ce0-b55a9cb72c5a', u'subnetpool_id': None}], u'binding:host_id': u'', u'description': u'', u'device_id': u'a9806b97-0850-4f40-8c73-c1fac666d21b', u'name': u'', u'admin_state_up': True, u'network_id': u'8eea9a1b-d5d3-4e8b-a2e8-aeaccf5085dc', u'dns_name': None, u'created_at': u'2016-08-01T07:42:07', u'mtu': 1458, u'tenant_id': u'352cd4ef40c04b058ba40316140c5a29', u'extra_subnets': []} to internal_ports cache _process_internal_ports /usr/lib/python2.7/site-packages/neutron/agent/l3/router_info.py:479 2016-08-01 09:42:09.032 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'find', '/sys/class/net', '-maxdepth', '1', '-type', 'l', '-printf', '%f '] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.042 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.042 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Lock "l3-agent-pd" acquired by "neutron.agent.linux.pd.sync_router" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270 2016-08-01 09:42:09.043 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Lock "l3-agent-pd" released by "neutron.agent.linux.pd.sync_router" :: held 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282 2016-08-01 09:42:09.043 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'find', '/sys/class/net', '-maxdepth', '1', '-type', 'l', '-printf', '%f '] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.053 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.053 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Acquired semaphore "iptables-qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:212 2016-08-01 09:42:09.054 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'iptables-save'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.065 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.068 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'iptables-restore', '-n'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.081 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.081 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip6tables-save'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.092 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.094 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip6tables-restore', '-n'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.106 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.107 53157 DEBUG neutron.agent.linux.iptables_manager [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] IPTablesManager.apply completed with success. 100 iptables commands were issued _apply_synchronized /usr/lib/python2.7/site-packages/neutron/agent/linux/iptables_manager.py:561 2016-08-01 09:42:09.107 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Releasing semaphore "iptables-qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:225 2016-08-01 09:42:09.108 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Acquired semaphore "iptables-qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:212 2016-08-01 09:42:09.108 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'iptables-save'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.119 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.122 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'iptables-restore', '-n'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.134 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.135 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip6tables-save'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.145 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.147 53157 DEBUG neutron.agent.linux.iptables_manager [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] IPTablesManager.apply completed with success. 10 iptables commands were issued _apply_synchronized /usr/lib/python2.7/site-packages/neutron/agent/linux/iptables_manager.py:561 2016-08-01 09:42:09.147 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Releasing semaphore "iptables-qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:225 2016-08-01 09:42:09.149 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['kill', '-HUP', '58067'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.151 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.152 53157 DEBUG neutron.agent.linux.keepalived [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Keepalived spawned with config /var/lib/neutron/ha_confs/a9806b97-0850-4f40-8c73-c1fac666d21b/keepalived.conf spawn /usr/lib/python2.7/site-packages/neutron/agent/linux/keepalived.py:407 2016-08-01 09:42:09.152 53157 DEBUG neutron.callbacks.manager [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Notify callbacks for router, after_create _notify_loop /usr/lib/python2.7/site-packages/neutron/callbacks/manager.py:138 2016-08-01 09:42:09.152 53157 DEBUG neutron.callbacks.manager [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Calling callback neutron_vpnaas.services.vpn.vpn_service.router_added_actions _notify_loop /usr/lib/python2.7/site-packages/neutron/callbacks/manager.py:145 2016-08-01 09:42:09.153 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Lock "vpn-agent" acquired by "neutron_vpnaas.services.vpn.device_drivers.ipsec.sync" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270 2016-08-01 09:42:09.153 53157 DEBUG oslo_messaging._drivers.amqpdriver [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] CALL msg_id: 753e3075fde8429780699929921a66d7 exchange 'neutron' topic 'ipsec_driver' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:454 2016-08-01 09:42:09.174 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: 753e3075fde8429780699929921a66d7 __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:302 2016-08-01 09:42:09.175 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Lock "vpn-agent" released by "neutron_vpnaas.services.vpn.device_drivers.ipsec.sync" :: held 0.022s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282 2016-08-01 09:42:09.175 53157 DEBUG neutron.callbacks.manager [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Calling callback neutron.agent.metadata.driver.after_router_added _notify_loop /usr/lib/python2.7/site-packages/neutron/callbacks/manager.py:145 2016-08-01 09:42:09.176 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Acquired semaphore "iptables-qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:212 2016-08-01 09:42:09.176 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'iptables-save'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.187 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.190 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'iptables-restore', '-n'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.204 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.204 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip6tables-save'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:09.214 53157 DEBUG neutron.agent.linux.utils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:09.216 53157 DEBUG neutron.agent.linux.iptables_manager [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] IPTablesManager.apply completed with success. 16 iptables commands were issued _apply_synchronized /usr/lib/python2.7/site-packages/neutron/agent/linux/iptables_manager.py:561 2016-08-01 09:42:09.217 53157 DEBUG oslo_concurrency.lockutils [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Releasing semaphore "iptables-qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:225 2016-08-01 09:42:09.217 53157 DEBUG neutron.agent.l3.agent [req-b353d6e1-cdb0-4de1-99cf-214e9ca3c4be - 352cd4ef40c04b058ba40316140c5a29 - - -] Finished a router update for a9806b97-0850-4f40-8c73-c1fac666d21b _process_router_update /usr/lib/python2.7/site-packages/neutron/agent/l3/agent.py:515 2016-08-01 09:42:24.917 53157 DEBUG neutron.agent.l3.ha [-] Updating server with HA routers states {u'a9806b97-0850-4f40-8c73-c1fac666d21b': 'standby'} notify_server /usr/lib/python2.7/site-packages/neutron/agent/l3/ha.py:173 2016-08-01 09:42:24.918 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] CALL msg_id: d0e954e31e8b4a62ba00443c24176bc3 exchange 'neutron' topic 'q-l3-plugin' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:454 2016-08-01 09:42:24.954 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: d0e954e31e8b4a62ba00443c24176bc3 __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:302 2016-08-01 09:42:26.377 53157 DEBUG oslo_concurrency.lockutils [-] Lock "_check_child_processes" acquired by "neutron.agent.linux.external_process._check_child_processes" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270 2016-08-01 09:42:26.380 53157 DEBUG oslo_concurrency.lockutils [-] Lock "_check_child_processes" released by "neutron.agent.linux.external_process._check_child_processes" :: held 0.002s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282 2016-08-01 09:42:26.429 53157 DEBUG oslo_concurrency.lockutils [-] Lock "_check_child_processes" acquired by "neutron.agent.linux.external_process._check_child_processes" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270 2016-08-01 09:42:26.429 53157 DEBUG oslo_concurrency.lockutils [-] Lock "_check_child_processes" released by "neutron.agent.linux.external_process._check_child_processes" :: held 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282 2016-08-01 09:42:26.514 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] CALL msg_id: a25a4a63cdde4dbfb2f392df8458f4f5 exchange 'neutron' topic 'q-reports-plugin' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:454 2016-08-01 09:42:26.525 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: a25a4a63cdde4dbfb2f392df8458f4f5 __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:302 2016-08-01 09:42:28.585 53157 DEBUG oslo_service.periodic_task [req-c87d0ab2-94d9-4fcb-967a-9640ed3c1f59 - - - - -] Running periodic task VPNAgent.periodic_sync_routers_task run_periodic_tasks /usr/lib/python2.7/site-packages/oslo_service/periodic_task.py:215 2016-08-01 09:42:51.543 53157 DEBUG oslo_messaging._drivers.amqpdriver [-] received message msg_id: None reply to None __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:201 2016-08-01 09:42:51.544 53157 DEBUG neutron.agent.l3.agent [req-fd8723c4-4734-4d27-b6d6-a6d71c9d9a7d 4afea4ec82774aa3bfc4dab741c29934 352cd4ef40c04b058ba40316140c5a29 - - -] Got router deleted notification for a9806b97-0850-4f40-8c73-c1fac666d21b router_deleted /usr/lib/python2.7/site-packages/neutron/agent/l3/agent.py:384 2016-08-01 09:42:51.545 53157 DEBUG neutron.agent.l3.agent [-] Starting router update for a9806b97-0850-4f40-8c73-c1fac666d21b, action 1, priority 0 _process_router_update /usr/lib/python2.7/site-packages/neutron/agent/l3/agent.py:467 2016-08-01 09:42:51.545 53157 DEBUG neutron.callbacks.manager [-] Notify callbacks for router, before_delete _notify_loop /usr/lib/python2.7/site-packages/neutron/callbacks/manager.py:138 2016-08-01 09:42:51.545 53157 DEBUG neutron.callbacks.manager [-] Calling callback neutron.agent.metadata.driver.before_router_removed _notify_loop /usr/lib/python2.7/site-packages/neutron/callbacks/manager.py:145 2016-08-01 09:42:51.546 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['kill', '-9', '58376'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:51.551 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:51.551 53157 DEBUG neutron.agent.l3.router_info [-] process router delete process_delete /usr/lib/python2.7/site-packages/neutron/agent/l3/router_info.py:946 2016-08-01 09:42:51.552 53157 DEBUG neutron.agent.l3.router_info [-] removing internal network: port(6ae2e68c-e0d2-4724-8491-d123ec6d498f) interface(qr-6ae2e68c-e0) internal_network_removed /usr/lib/python2.7/site-packages/neutron/agent/l3/router_info.py:406 2016-08-01 09:42:51.552 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'ip', '-o', 'link', 'show', 'qr-6ae2e68c-e0'] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:51.599 53157 DEBUG neutron.agent.l3.router_info [-] removing port {u'allowed_address_pairs': [], u'extra_dhcp_opts': [], u'updated_at': u'2016-08-01T07:42:07', u'device_owner': u'network:router_interface', u'port_security_enabled': False, u'binding:profile': {}, u'binding:vnic_type': u'normal', u'fixed_ips': [{u'subnet_id': u'f30be168-0864-4b05-8ce0-b55a9cb72c5a', u'prefixlen': 24, u'ip_address': u'192.168.0.1'}], u'id': u'6ae2e68c-e0d2-4724-8491-d123ec6d498f', u'security_groups': [], u'binding:vif_details': {}, u'address_scopes': {u'4': None, u'6': None}, u'binding:vif_type': u'unbound', u'mac_address': u'fa:16:3e:92:f5:3d', u'status': u'DOWN', u'subnets': [{u'dns_nameservers': [], u'ipv6_ra_mode': None, u'gateway_ip': u'192.168.0.1', u'cidr': u'192.168.0.0/24', u'id': u'f30be168-0864-4b05-8ce0-b55a9cb72c5a', u'subnetpool_id': None}], u'binding:host_id': u'', u'description': u'', u'device_id': u'a9806b97-0850-4f40-8c73-c1fac666d21b', u'name': u'', u'admin_state_up': True, u'network_id': u'8eea9a1b-d5d3-4e8b-a2e8-aeaccf5085dc', u'dns_name': None, u'created_at': u'2016-08-01T07:42:07', u'mtu': 1458, u'tenant_id': u'352cd4ef40c04b058ba40316140c5a29', u'extra_subnets': []} from internal_ports cache _process_internal_ports /usr/lib/python2.7/site-packages/neutron/agent/l3/router_info.py:491 2016-08-01 09:42:51.600 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'find', '/sys/class/net', '-maxdepth', '1', '-type', 'l', '-printf', '%f '] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:51.613 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:51.613 53157 DEBUG oslo_concurrency.lockutils [-] Lock "l3-agent-pd" acquired by "neutron.agent.linux.pd.sync_router" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270 2016-08-01 09:42:51.613 53157 DEBUG oslo_concurrency.lockutils [-] Lock "l3-agent-pd" released by "neutron.agent.linux.pd.sync_router" :: held 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282 2016-08-01 09:42:51.614 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'find', '/sys/class/net', '-maxdepth', '1', '-type', 'l', '-printf', '%f '] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:51.625 53157 DEBUG neutron.agent.linux.utils [-] Exit code: 0 execute /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:142 2016-08-01 09:42:51.626 53157 DEBUG neutron.agent.l3.router_info [-] Terminating radvd daemon in router device: a9806b97-0850-4f40-8c73-c1fac666d21b disable_radvd /usr/lib/python2.7/site-packages/neutron/agent/l3/router_info.py:446 2016-08-01 09:42:51.626 53157 DEBUG neutron.agent.linux.utils [-] Unable to access /var/lib/neutron/external/pids/a9806b97-0850-4f40-8c73-c1fac666d21b.pid.radvd get_value_from_file /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:225 2016-08-01 09:42:51.627 53157 DEBUG neutron.agent.linux.utils [-] Unable to access /var/lib/neutron/external/pids/a9806b97-0850-4f40-8c73-c1fac666d21b.pid.radvd get_value_from_file /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:225 2016-08-01 09:42:51.627 53157 DEBUG neutron.agent.linux.external_process [-] No process started for a9806b97-0850-4f40-8c73-c1fac666d21b disable /usr/lib/python2.7/site-packages/neutron/agent/linux/external_process.py:118 2016-08-01 09:42:51.627 53157 DEBUG neutron.agent.linux.ra [-] radvd disabled for router a9806b97-0850-4f40-8c73-c1fac666d21b disable /usr/lib/python2.7/site-packages/neutron/agent/linux/ra.py:190 2016-08-01 09:42:51.627 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'find', '/sys/class/net', '-maxdepth', '1', '-type', 'l', '-printf', '%f '] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:51.632 53157 ERROR neutron.agent.linux.utils [-] Exit code: 1; Stdin: ; Stdout: ; Stderr: Cannot open network namespace "qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b": No such file or directory 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent [-] Error while deleting router a9806b97-0850-4f40-8c73-c1fac666d21b 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent Traceback (most recent call last): 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent File "/usr/lib/python2.7/site-packages/neutron/agent/l3/agent.py", line 359, in _safe_router_removed 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent self._router_removed(router_id) 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent File "/usr/lib/python2.7/site-packages/neutron/agent/l3/agent.py", line 377, in _router_removed 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent ri.delete(self) 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent File "/usr/lib/python2.7/site-packages/neutron/agent/l3/ha_router.py", line 380, in delete 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent super(HaRouter, self).delete(agent) 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent File "/usr/lib/python2.7/site-packages/neutron/agent/l3/router_info.py", line 349, in delete 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent self.router_namespace.delete() 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent File "/usr/lib/python2.7/site-packages/neutron/agent/l3/namespaces.py", line 100, in delete 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent for d in ns_ip.get_devices(exclude_loopback=True): 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent File "/usr/lib/python2.7/site-packages/neutron/agent/linux/ip_lib.py", line 130, in get_devices 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent log_fail_as_error=self.log_fail_as_error 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent File "/usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py", line 140, in execute 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent raise RuntimeError(msg) 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent RuntimeError: Exit code: 1; Stdin: ; Stdout: ; Stderr: Cannot open network namespace "qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b": No such file or directory 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent 2016-08-01 09:42:51.633 53157 ERROR neutron.agent.l3.agent 2016-08-01 09:42:51.635 53157 DEBUG neutron.agent.l3.agent [-] Finished a router update for a9806b97-0850-4f40-8c73-c1fac666d21b _process_router_update /usr/lib/python2.7/site-packages/neutron/agent/l3/agent.py:497 2016-08-01 09:42:51.635 53157 DEBUG neutron.agent.l3.agent [-] Starting router update for a9806b97-0850-4f40-8c73-c1fac666d21b, action 1, priority 1 _process_router_update /usr/lib/python2.7/site-packages/neutron/agent/l3/agent.py:467 2016-08-01 09:42:51.635 53157 DEBUG neutron.callbacks.manager [-] Notify callbacks for router, before_delete _notify_loop /usr/lib/python2.7/site-packages/neutron/callbacks/manager.py:138 2016-08-01 09:42:51.635 53157 DEBUG neutron.callbacks.manager [-] Calling callback neutron.agent.metadata.driver.before_router_removed _notify_loop /usr/lib/python2.7/site-packages/neutron/callbacks/manager.py:145 2016-08-01 09:42:51.636 53157 DEBUG neutron.agent.linux.utils [-] Unable to access /var/lib/neutron/external/pids/a9806b97-0850-4f40-8c73-c1fac666d21b.pid get_value_from_file /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:225 2016-08-01 09:42:51.636 53157 DEBUG neutron.agent.linux.utils [-] Unable to access /var/lib/neutron/external/pids/a9806b97-0850-4f40-8c73-c1fac666d21b.pid get_value_from_file /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:225 2016-08-01 09:42:51.636 53157 DEBUG neutron.agent.linux.external_process [-] No process started for a9806b97-0850-4f40-8c73-c1fac666d21b disable /usr/lib/python2.7/site-packages/neutron/agent/linux/external_process.py:118 2016-08-01 09:42:51.636 53157 DEBUG neutron.agent.l3.router_info [-] process router delete process_delete /usr/lib/python2.7/site-packages/neutron/agent/l3/router_info.py:946 2016-08-01 09:42:51.637 53157 DEBUG neutron.agent.linux.utils [-] Running command (rootwrap daemon): ['ip', 'netns', 'exec', 'qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b', 'find', '/sys/class/net', '-maxdepth', '1', '-type', 'l', '-printf', '%f '] execute_rootwrap_daemon /usr/lib/python2.7/site-packages/neutron/agent/linux/utils.py:100 2016-08-01 09:42:51.641 53157 ERROR neutron.agent.linux.utils [-] Exit code: 1; Stdin: ; Stdout: ; Stderr: Cannot open network namespace "qrouter-a9806b97-0850-4f40-8c73-c1fac666d21b": No such file or directory