yahoo-eng-team team mailing list archive

Thread
Date
[Bug 1393409] [NEW] In class CiscoCsrIPsecVpnAgentApi used unknown method from L3RouterPlugin

To: yahoo-eng-team@xxxxxxxxxxxxxxxxxxx
From: aalekov <aalekov@xxxxxxxxx>
Date: Mon, 17 Nov 2014 13:16:34 -0000
Reply-to: Bug 1393409 <1393409@xxxxxxxxxxxxxxxxxx>
Sender: bounces@xxxxxxxxxxxxx
Public bug reported:

During testing of VPNaaS feature I'm found problem with incorrect calls
from one class to another.  Class CiscoCsrIPsecVpnAgentApi try to call
unknown method "get_host_for_router" from class "L3RouterPlugin".

Tempest test is
tempest.api.network.test_vpnaas_extensions.VPNaaSTestJSON.test_create_update_delete_vpn_service[gate,smoke].

 Tempest log:
2014-11-16 20:03:45,861 7747 DEBUG    [tempest.common.rest_client] Request (VPNaaSTestJSON:test_create_update_delete_vpn_service): 201 POST http://192.168.0.84:9696/v2.0/vpn/vpnservices 0.066s
    Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}
        Body: {"vpnservice": {"subnet_id": "20da093a-3c97-4757-859c-537a4206d967", "router_id": "0e383b58-33c3-4d55-b72a-ae19e76b2f6f", "name": "vpn-service-1842998599", "admin_state_up": true}}
    Response - Headers: {'status': '201', 'content-length': '322', 'connection': 'close', 'date': 'Sun, 16 Nov 2014 20:03:45 GMT', 'content-type': 'application/json; charset=UTF-8', 'x-openstack-request-id': 'req-a747adae-5586-4f52-b876-3d072ec28ce9'}
        Body: {"vpnservice": {"router_id": "0e383b58-33c3-4d55-b72a-ae19e76b2f6f", "status": "PENDING_CREATE", "name": "vpn-service-1842998599", "admin_state_up": true, "subnet_id": "20da093a-3c97-4757-859c-537a4206d967", "tenant_id": "d6e97fa90ddc4ebab91ab57019826728", "id": "a521e5b9-3edf-4236-a0b0-3df3f9dce602", "description": ""}}
2014-11-16 20:03:45,873 7747 DEBUG    [tempest.common.rest_client] Request (VPNaaSTestJSON:test_create_update_delete_vpn_service): 200 GET http://192.168.0.84:9696/v2.0/vpn/vpnservices 0.011s
    Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}
        Body: None
    Response - Headers: {'status': '200', 'content-length': '632', 'content-location': 'http://192.168.0.84:9696/v2.0/vpn/vpnservices', 'connection': 'close', 'date': 'Sun, 16 Nov 2014 20:03:45 GMT', 'content-type': 'application/json; charset=UTF-8', 'x-openstack-request-id': 'req-a1fb0f92-3ab0-4c19-9de1-c17b603afd41'}
        Body: {"vpnservices": [{"router_id": "0e383b58-33c3-4d55-b72a-ae19e76b2f6f", "status": "PENDING_CREATE", "name": "vpnservice--691534310", "admin_state_up": true, "subnet_id": "20da093a-3c97-4757-859c-537a4206d967", "tenant_id": "d6e97fa90ddc4ebab91ab57019826728", "id": "5a1e5e70-069b-462a-bc13-6c4b0945228f", "description": ""}, {"router_id": "0e383b58-33c3-4d55-b72a-ae19e76b2f6f", "status": "PENDING_CREATE", "name": "vpn-service-1842998599", "admin_state_up": true, "subnet_id": "20da093a-3c97-4757-859c-537a4206d967", "tenant_id": "d6e97fa90ddc4ebab91ab57019826728", "id": "a521e5b9-3edf-4236-a0b0-3df3f9dce602", "description": ""}]}
2014-11-16 20:03:45,916 7747 DEBUG    [tempest.common.rest_client] Request (VPNaaSTestJSON:_run_cleanups): 500 DELETE http://192.168.0.84:9696/v2.0/vpn/vpnservices/a521e5b9-3edf-4236-a0b0-3df3f9dce602 0.038s
    Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}
        Body: None
    Response - Headers: {'status': '500', 'content-length': '150', 'connection': 'close', 'date': 'Sun, 16 Nov 2014 20:03:45 GMT', 'content-type': 'application/json; charset=UTF-8', 'x-openstack-request-id': 'req-1ab34864-f9bf-45ec-a870-439f88b4b974'}
        Body: {"NeutronError": {"message": "Request Failed: internal server error while processing your request.", "type": "HTTPInternalServerError", "detail": ""}}
}}}

Traceback (most recent call last):
  File "tempest/api/network/test_vpnaas_extensions.py", line 86, in _delete_vpn_service
    self.client.delete_vpnservice(vpn_service_id)
  File "tempest/services/network/network_client_base.py", line 124, in _delete
    resp, body = self.delete(uri)
  File "tempest/services/network/network_client_base.py", line 83, in delete
    return self.rest_client.delete(uri, headers)
  File "tempest/common/rest_client.py", line 240, in delete
    return self.request('DELETE', url, extra_headers, headers, body)
  File "tempest/common/rest_client.py", line 454, in request
    resp, resp_body)
  File "tempest/common/rest_client.py", line 550, in _error_checker
    raise exceptions.ServerFault(message)
ServerFault: Got server fault
Details: Request Failed: internal server error while processing your request.
Traceback (most recent call last):
_StringException: Empty attachments:
  stderr
  stdout


Neutron log:
2014-11-16 20:03:46.133 [00;32mDEBUG neutron.policy [[01;36mreq-7e22a57a-977a-4a8d-8369-d4df3ecc3fcd [00;36mVPNaaSTestJSON-584604556 d6e97fa90ddc4ebab91ab57019826728[00;32m] [01;35m[00;32mEnforcing rules: ['delete_vpnservice'][00m [00;33mfrom (pid=4825) _build_match_rule /opt/stack/neutron/neutron/policy.py:232[00m
2014-11-16 20:03:46.165 [01;31mERROR neutron.api.v2.resource [[01;36mreq-7e22a57a-977a-4a8d-8369-d4df3ecc3fcd [00;36mVPNaaSTestJSON-584604556 d6e97fa90ddc4ebab91ab57019826728[01;31m] [01;35m[01;31mdelete failed[00m
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00mTraceback (most recent call last):
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/api/v2/resource.py", line 82, in resource
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    result = method(request=request, **args)
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/api/v2/base.py", line 478, in delete
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    obj_deleter(request.context, id, **kwargs)
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/services/vpn/plugin.py", line 107, in delete_vpnservice
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    driver.delete_vpnservice(context, vpnservice)
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/services/vpn/service_drivers/cisco_ipsec.py", line 183, in delete_vpnservice
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    reason='vpn-service-delete')
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/services/vpn/service_drivers/__init__.py", line 111, in vpnservice_updated
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    **kwargs)
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/services/vpn/service_drivers/cisco_ipsec.py", line 101, in _agent_notification
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    host = self.driver.l3_plugin.get_host_for_router(admin_context,
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00mAttributeError: 'L3RouterPlugin' object has no attribute 'get_host_for_router'
[01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m
2014-11-16 20:03:46.168 [00;36mINFO neutron.wsgi [[01;36mreq-7e22a57a-977a-4a8d-8369-d4df3ecc3fcd [00;36mVPNaaSTestJSON-584604556 d6e97fa90ddc4ebab91ab57019826728[00;36m] [01;35m[00;36m192.168.0.84 - - [16/Nov/2014 20:03:46] "DELETE /v2.0/vpn/vpnservices/5a1e5e70-069b-462a-bc13-6c4b0945228f HTTP/1.1" 500 378 0.041538[00m


Devstack local.conf
[[local|localrc]]
MYSQL_PASSWORD=nova
RABBIT_PASSWORD=nova
SERVICE_TOKEN=nova
SERVICE_PASSWORD=nova
ADMIN_PASSWORD=nova
ENABLED_SERVICES=g-api,g-reg,key,n-api,n-crt,n-obj,n-cpu,n-cond,n-sch,n-novnc,n-xvnc,n-cauth,rabbit
enable_service mysql
disable_service n-net
enable_service q-svc
enable_service q-agt
enable_service q-l3
enable_service q-dhcp
enable_service q-meta
enable_service q-lbaas
enable_service neutron
enable_service q-vpn
enable_service tempest
LIBVIRT_TYPE=qemu
NOVA_USE_QUANTUM_API=v2
VOLUME_BACKING_FILE_SIZE=2052M
Q_PLUGIN=ml2
API_RATE_LIMIT=False
VERBOSE=True
DEBUG=True
USE_SCREEN=True
RECLONE=True

** Affects: neutron
     Importance: Undecided
         Status: New


** Tags: cisco

-- 
You received this bug notification because you are a member of Yahoo!
Engineering Team, which is subscribed to neutron.
https://bugs.launchpad.net/bugs/1393409

Title:
  In class CiscoCsrIPsecVpnAgentApi used unknown method from
  L3RouterPlugin

Status in OpenStack Neutron (virtual network service):
  New

Bug description:
  During testing of VPNaaS feature I'm found problem with incorrect
  calls from one class to another.  Class CiscoCsrIPsecVpnAgentApi try
  to call unknown method "get_host_for_router" from class
  "L3RouterPlugin".

  Tempest test is
  tempest.api.network.test_vpnaas_extensions.VPNaaSTestJSON.test_create_update_delete_vpn_service[gate,smoke].

   Tempest log:
  2014-11-16 20:03:45,861 7747 DEBUG    [tempest.common.rest_client] Request (VPNaaSTestJSON:test_create_update_delete_vpn_service): 201 POST http://192.168.0.84:9696/v2.0/vpn/vpnservices 0.066s
      Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}
          Body: {"vpnservice": {"subnet_id": "20da093a-3c97-4757-859c-537a4206d967", "router_id": "0e383b58-33c3-4d55-b72a-ae19e76b2f6f", "name": "vpn-service-1842998599", "admin_state_up": true}}
      Response - Headers: {'status': '201', 'content-length': '322', 'connection': 'close', 'date': 'Sun, 16 Nov 2014 20:03:45 GMT', 'content-type': 'application/json; charset=UTF-8', 'x-openstack-request-id': 'req-a747adae-5586-4f52-b876-3d072ec28ce9'}
          Body: {"vpnservice": {"router_id": "0e383b58-33c3-4d55-b72a-ae19e76b2f6f", "status": "PENDING_CREATE", "name": "vpn-service-1842998599", "admin_state_up": true, "subnet_id": "20da093a-3c97-4757-859c-537a4206d967", "tenant_id": "d6e97fa90ddc4ebab91ab57019826728", "id": "a521e5b9-3edf-4236-a0b0-3df3f9dce602", "description": ""}}
  2014-11-16 20:03:45,873 7747 DEBUG    [tempest.common.rest_client] Request (VPNaaSTestJSON:test_create_update_delete_vpn_service): 200 GET http://192.168.0.84:9696/v2.0/vpn/vpnservices 0.011s
      Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}
          Body: None
      Response - Headers: {'status': '200', 'content-length': '632', 'content-location': 'http://192.168.0.84:9696/v2.0/vpn/vpnservices', 'connection': 'close', 'date': 'Sun, 16 Nov 2014 20:03:45 GMT', 'content-type': 'application/json; charset=UTF-8', 'x-openstack-request-id': 'req-a1fb0f92-3ab0-4c19-9de1-c17b603afd41'}
          Body: {"vpnservices": [{"router_id": "0e383b58-33c3-4d55-b72a-ae19e76b2f6f", "status": "PENDING_CREATE", "name": "vpnservice--691534310", "admin_state_up": true, "subnet_id": "20da093a-3c97-4757-859c-537a4206d967", "tenant_id": "d6e97fa90ddc4ebab91ab57019826728", "id": "5a1e5e70-069b-462a-bc13-6c4b0945228f", "description": ""}, {"router_id": "0e383b58-33c3-4d55-b72a-ae19e76b2f6f", "status": "PENDING_CREATE", "name": "vpn-service-1842998599", "admin_state_up": true, "subnet_id": "20da093a-3c97-4757-859c-537a4206d967", "tenant_id": "d6e97fa90ddc4ebab91ab57019826728", "id": "a521e5b9-3edf-4236-a0b0-3df3f9dce602", "description": ""}]}
  2014-11-16 20:03:45,916 7747 DEBUG    [tempest.common.rest_client] Request (VPNaaSTestJSON:_run_cleanups): 500 DELETE http://192.168.0.84:9696/v2.0/vpn/vpnservices/a521e5b9-3edf-4236-a0b0-3df3f9dce602 0.038s
      Request - Headers: {'Content-Type': 'application/json', 'Accept': 'application/json', 'X-Auth-Token': '<omitted>'}
          Body: None
      Response - Headers: {'status': '500', 'content-length': '150', 'connection': 'close', 'date': 'Sun, 16 Nov 2014 20:03:45 GMT', 'content-type': 'application/json; charset=UTF-8', 'x-openstack-request-id': 'req-1ab34864-f9bf-45ec-a870-439f88b4b974'}
          Body: {"NeutronError": {"message": "Request Failed: internal server error while processing your request.", "type": "HTTPInternalServerError", "detail": ""}}
  }}}

  Traceback (most recent call last):
    File "tempest/api/network/test_vpnaas_extensions.py", line 86, in _delete_vpn_service
      self.client.delete_vpnservice(vpn_service_id)
    File "tempest/services/network/network_client_base.py", line 124, in _delete
      resp, body = self.delete(uri)
    File "tempest/services/network/network_client_base.py", line 83, in delete
      return self.rest_client.delete(uri, headers)
    File "tempest/common/rest_client.py", line 240, in delete
      return self.request('DELETE', url, extra_headers, headers, body)
    File "tempest/common/rest_client.py", line 454, in request
      resp, resp_body)
    File "tempest/common/rest_client.py", line 550, in _error_checker
      raise exceptions.ServerFault(message)
  ServerFault: Got server fault
  Details: Request Failed: internal server error while processing your request.
  Traceback (most recent call last):
  _StringException: Empty attachments:
    stderr
    stdout

  
  Neutron log:
  2014-11-16 20:03:46.133 [00;32mDEBUG neutron.policy [[01;36mreq-7e22a57a-977a-4a8d-8369-d4df3ecc3fcd [00;36mVPNaaSTestJSON-584604556 d6e97fa90ddc4ebab91ab57019826728[00;32m] [01;35m[00;32mEnforcing rules: ['delete_vpnservice'][00m [00;33mfrom (pid=4825) _build_match_rule /opt/stack/neutron/neutron/policy.py:232[00m
  2014-11-16 20:03:46.165 [01;31mERROR neutron.api.v2.resource [[01;36mreq-7e22a57a-977a-4a8d-8369-d4df3ecc3fcd [00;36mVPNaaSTestJSON-584604556 d6e97fa90ddc4ebab91ab57019826728[01;31m] [01;35m[01;31mdelete failed[00m
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00mTraceback (most recent call last):
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/api/v2/resource.py", line 82, in resource
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    result = method(request=request, **args)
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/api/v2/base.py", line 478, in delete
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    obj_deleter(request.context, id, **kwargs)
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/services/vpn/plugin.py", line 107, in delete_vpnservice
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    driver.delete_vpnservice(context, vpnservice)
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/services/vpn/service_drivers/cisco_ipsec.py", line 183, in delete_vpnservice
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    reason='vpn-service-delete')
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/services/vpn/service_drivers/__init__.py", line 111, in vpnservice_updated
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    **kwargs)
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m  File "/opt/stack/neutron/neutron/services/vpn/service_drivers/cisco_ipsec.py", line 101, in _agent_notification
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m    host = self.driver.l3_plugin.get_host_for_router(admin_context,
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00mAttributeError: 'L3RouterPlugin' object has no attribute 'get_host_for_router'
  [01;31m2014-11-16 20:03:46.165 TRACE neutron.api.v2.resource [01;35m[00m
  2014-11-16 20:03:46.168 [00;36mINFO neutron.wsgi [[01;36mreq-7e22a57a-977a-4a8d-8369-d4df3ecc3fcd [00;36mVPNaaSTestJSON-584604556 d6e97fa90ddc4ebab91ab57019826728[00;36m] [01;35m[00;36m192.168.0.84 - - [16/Nov/2014 20:03:46] "DELETE /v2.0/vpn/vpnservices/5a1e5e70-069b-462a-bc13-6c4b0945228f HTTP/1.1" 500 378 0.041538[00m

  
  Devstack local.conf
  [[local|localrc]]
  MYSQL_PASSWORD=nova
  RABBIT_PASSWORD=nova
  SERVICE_TOKEN=nova
  SERVICE_PASSWORD=nova
  ADMIN_PASSWORD=nova
  ENABLED_SERVICES=g-api,g-reg,key,n-api,n-crt,n-obj,n-cpu,n-cond,n-sch,n-novnc,n-xvnc,n-cauth,rabbit
  enable_service mysql
  disable_service n-net
  enable_service q-svc
  enable_service q-agt
  enable_service q-l3
  enable_service q-dhcp
  enable_service q-meta
  enable_service q-lbaas
  enable_service neutron
  enable_service q-vpn
  enable_service tempest
  LIBVIRT_TYPE=qemu
  NOVA_USE_QUANTUM_API=v2
  VOLUME_BACKING_FILE_SIZE=2052M
  Q_PLUGIN=ml2
  API_RATE_LIMIT=False
  VERBOSE=True
  DEBUG=True
  USE_SCREEN=True
  RECLONE=True

To manage notifications about this bug go to:
https://bugs.launchpad.net/neutron/+bug/1393409/+subscriptions
Follow ups

[Bug 1393409] Re: In class CiscoCsrIPsecVpnAgentApi used unknown method from L3RouterPlugin
From: Andrey Alekov, 2014-11-18
[Bug 1393409] [NEW] In class CiscoCsrIPsecVpnAgentApi used unknown method from L3RouterPlugin
From: aalekov, 2014-11-17
References

[Bug 1393409] [NEW] In class CiscoCsrIPsecVpnAgentApi used unknown method from L3RouterPlugin
From: aalekov, 2014-11-17