Uploaded image for project: 'Virtual Infrastructure Deployment'
  1. Virtual Infrastructure Deployment
  2. VID-37

1.1: NPE AAI get service-design-and-creation/services in getUserInfo() in VID portal - aai1.model-loader 8443 not up

XMLWordPrintable

    • Icon: Task Task
    • Resolution: Done
    • Icon: High High
    • Beijing Release
    • None
    • None
    • None

       issue: logged in to 1.1 on rackspace with 20170804 build - select VID and search for existing services

      get 500 error in what looks like a connectivity issue

      2017-08-07 15:02:26,625|714af5cc-db50-4df5-9fdb-f6a6ea62e8a5||http-apr-8080-exec-1||/aai_get_services|292b461a-2954-4b63-a3f9-f916c7ad3bc0|WARN|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalapp.controller.core.MenuListController|| getUserInfo failed
java.lang.NullPointerException: null
at org.openecomp.portalapp.controller.core.MenuListController.getUserInfo(MenuListController.java:189) ~[epsdk-app-common-1.3.0-20170805.112830-26.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_141]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_141]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_141]
at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_141]
at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:221) [spring-web-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:137) [spring-web-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:111) [spring-webmvc-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:806) [spring-webmvc-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:729) [spring-webmvc-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:85) [spring-webmvc-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:959) [spring-webmvc-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:893) [spring-webmvc-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:970) [spring-webmvc-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:861) [spring-webmvc-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:622) [servlet-api.jar:na]
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:846) [spring-webmvc-4.2.0.RELEASE.jar:4.2.0.RELEASE]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:729) [servlet-api.jar:na]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:292) [catalina.jar:8.0.45]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:207) [catalina.jar:8.0.45]
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52) [tomcat-websocket.jar:8.0.45]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:240) [catalina.jar:8.0.45]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:207) [catalina.jar:8.0.45]
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:212) [catalina.jar:8.0.45]
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:94) [catalina.jar:8.0.45]
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:504) [catalina.jar:8.0.45]
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:141) [catalina.jar:8.0.45]
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:79) [catalina.jar:8.0.45]
at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:620) [catalina.jar:8.0.45]
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:88) [catalina.jar:8.0.45]
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:502) [catalina.jar:8.0.45]
at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1132) [tomcat-coyote.jar:8.0.45]
at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:684) [tomcat-coyote.jar:8.0.45]
at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.doRun(AprEndpoint.java:2521) [tomcat-coyote.jar:8.0.45]
at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.run(AprEndpoint.java:2510) [tomcat-coyote.jar:8.0.45]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_141]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_141]
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) [tomcat-util.jar:8.0.45]
at java.lang.Thread.run(Thread.java:748) [na:1.8.0_141]
2017-08-07 15:02:26,738|9e3b7efc-88b9-4979-8a91-53de9efd5d2e||http-apr-8080-exec-6||/aai_get_services|292b461a-2954-4b63-a3f9-f916c7ad3bc0|INFO|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.vid.controller.AaiController|| 15:02:26:0738<== .getSubscriberListjavax.ws.rs.ProcessingException: java.net.ConnectException: Connection refused (Connection refused)
2017-08-07 15:02:26,739|fb2deb87-1529-4780-851a-2a0987f34784||http-apr-8080-exec-3||/aai_get_full_subscribers|292b461a-2954-4b63-a3f9-f916c7ad3bc0|INFO|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.vid.controller.AaiController|| 15:02:26:0739<== .getSubscriberListjavax.ws.rs.ProcessingException: java.net.ConnectException: Connection refused (Connection refused)
root@eaaef1539662:/usr/local/tomcat/logs# cat /opt/app/vid/logs/vid/error.log

      The docker states are

      root@vm1-vid:~# docker ps -a
CONTAINER ID        IMAGE                                                    COMMAND                  CREATED             STATUS              PORTS                    NAMES
eaaef1539662        nexus3.onap.org:10001/openecomp/vid:1.1-STAGING-latest   "/tmp/vid/localize.sh"   47 hours ago        Up 47 hours         0.0.0.0:8080->8080/tcp   vid-server
7904f2fb73d7        mariadb:10                                               "docker-entrypoint..."   47 hours ago        Up 47 hours         3306/tcp                 vid-mariadb


root@vm1-aai-inst1:~# docker ps -a
CONTAINER ID        IMAGE                                           COMMAND                  CREATED             STATUS              PORTS                                                NAMES
55b31fb01a9f        nexus3.onap.org:10001/openecomp/aai-resources   "/bin/sh -c ./dock..."   47 hours ago        Up 47 hours         0.0.0.0:8447->8447/tcp                               testconfig_aai-resources.api.simpledemo.openecomp.org_1
8d4f6b7800c6        nexus3.onap.org:10001/openecomp/sparky-be       "/bin/sh -c /opt/a..."   47 hours ago        Up 47 hours         8000/tcp, 0.0.0.0:9517->9517/tcp                     testconfig_sparky-be_1
e3960749f594        attos/dmaap                                     "/bin/sh -c ./star..."   47 hours ago        Up 47 hours         0.0.0.0:3904-3905->3904-3905/tcp                     dockerfiles_dmaap_1
10d37c00542d        wurstmeister/zookeeper                          "/bin/sh -c '/usr/..."   47 hours ago        Up 47 hours         22/tcp, 2888/tcp, 3888/tcp, 0.0.0.0:2181->2181/tcp   dockerfiles_zookeeper_1
f654bd1cf0c6        dockerfiles_kafka                               "start-kafka.sh"         47 hours ago        Up 47 hours         0.0.0.0:9092->9092/tcp                               dockerfiles_kafka_1

      debug logs

      .core.service.DataAccessServiceImpl|| Filtering org.openecomp.portalsdk.core.domain.App by:  where id = 1
2017-08-07 15:02:26,714|35ab82ce-5413-432d-8edd-da6b6de01a7b||http-apr-8080-exec-3||/aai_get_services|292b461a-2954-4b63-a3f9-f916c7ad3bc0|INFO|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalsdk.core.interceptor.ResourceInterceptor|| handled session updates for synchronization
2017-08-07 15:02:26,715|||http-apr-8080-exec-6||||INFO|||||org.openecomp.portalsdk.core.interceptor.ResourceInterceptor|| handled session updates for synchronization
2017-08-07 15:02:26,717|||http-apr-8080-exec-6|||292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalsdk.core.web.support.UserUtils|| getRequestId: result is 9e3b7efc-88b9-4979-8a91-53de9efd5d2e
2017-08-07 15:02:26,718|35ab82ce-5413-432d-8edd-da6b6de01a7b||http-apr-8080-exec-3||/aai_get_services|292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalsdk.core.web.support.UserUtils|| getRequestId: result is fb2deb87-1529-4780-851a-2a0987f34784
2017-08-07 15:02:26,720|7e27f5d4-9527-4df1-bae2-cace16377249||http-apr-8080-exec-9||/single_signon.htm|292b461a-2954-4b63-a3f9-f916c7ad3bc0|INFO|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalsdk.core.interceptor.ResourceInterceptor|| Url - get_topMenuInfo
2017-08-07 15:02:26,720|7e27f5d4-9527-4df1-bae2-cace16377249||http-apr-8080-exec-9||/single_signon.htm|292b461a-2954-4b63-a3f9-f916c7ad3bc0|INFO|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalsdk.core.interceptor.ResourceInterceptor|| lastIndexOf - get_topMenuInfo
2017-08-07 15:02:26,722|7e27f5d4-9527-4df1-bae2-cace16377249||http-apr-8080-exec-9||/single_signon.htm|292b461a-2954-4b63-a3f9-f916c7ad3bc0|INFO|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalsdk.core.interceptor.ResourceInterceptor|| successfully authorized rest call
2017-08-07 15:02:26,723|7e27f5d4-9527-4df1-bae2-cace16377249||http-apr-8080-exec-9||/single_signon.htm|292b461a-2954-4b63-a3f9-f916c7ad3bc0|INFO|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalsdk.core.service.DataAccessServiceImpl|| Getting org.openecomp.portalsdk.core.domain.app records...
2017-08-07 15:02:26,723|7e27f5d4-9527-4df1-bae2-cace16377249||http-apr-8080-exec-9||/single_signon.htm|292b461a-2954-4b63-a3f9-f916c7ad3bc0|INFO|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalsdk.core.service.DataAccessServiceImpl|| Filtering org.openecomp.portalsdk.core.domain.App by:  where id = 1
2017-08-07 15:02:26,725|7e27f5d4-9527-4df1-bae2-cace16377249||http-apr-8080-exec-9||/single_signon.htm|292b461a-2954-4b63-a3f9-f916c7ad3bc0|INFO|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalsdk.core.interceptor.ResourceInterceptor|| handled session updates for synchronization
2017-08-07 15:02:26,726|7e27f5d4-9527-4df1-bae2-cace16377249||http-apr-8080-exec-9||/single_signon.htm|292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalapp.controller.core.MenuListController|| getLeftMenuJSP begins
2017-08-07 15:02:26,728|7e27f5d4-9527-4df1-bae2-cace16377249||http-apr-8080-exec-9||/single_signon.htm|292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.portalapp.controller.core.MenuListController|| getLeftMenuJSP ends
2017-08-07 15:02:26,731|fb2deb87-1529-4780-851a-2a0987f34784||http-apr-8080-exec-3||/aai_get_full_subscribers|292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.vid.controller.AaiController|| 15:02:26:0731<== getSubscriberList start
2017-08-07 15:02:26,732|fb2deb87-1529-4780-851a-2a0987f34784||http-apr-8080-exec-3||/aai_get_full_subscribers|292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.aai.util.AAIRestInterface|| 15:02:26:0732<== RestGet start
2017-08-07 15:02:26,735|9e3b7efc-88b9-4979-8a91-53de9efd5d2e||http-apr-8080-exec-6||/aai_get_services|292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.vid.controller.AaiController|| 15:02:26:0735<== getSubscriberList start
2017-08-07 15:02:26,735|9e3b7efc-88b9-4979-8a91-53de9efd5d2e||http-apr-8080-exec-6||/aai_get_services|292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.aai.util.AAIRestInterface|| 15:02:26:0735<== RestGet start
2017-08-07 15:02:26,738|9e3b7efc-88b9-4979-8a91-53de9efd5d2e||http-apr-8080-exec-6||/aai_get_services|292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.vid.controller.AaiController|| 15:02:26:0738<== .getSubscriberListjavax.ws.rs.ProcessingException: java.net.ConnectException: Connection refused (Connection refused)
2017-08-07 15:02:26,739|fb2deb87-1529-4780-851a-2a0987f34784||http-apr-8080-exec-3||/aai_get_full_subscribers|292b461a-2954-4b63-a3f9-f916c7ad3bc0|DEBUG|INFORMATIONAL|172.17.0.3|eaaef1539662||org.openecomp.vid.controller.AaiController|| 15:02:26:0739<== .getSubscriberListjavax.ws.rs.ProcessingException: java.net.ConnectException: Connection refused (Connection refused)

            os0695 os0695
            michaelobrien michaelobrien
            Votes:
            0 Vote for this issue
            Watchers:
            1 Start watching this issue

              Created:
              Updated:
              Resolved: