AnsweredAssumed Answered

Webview unusual behavior

Question asked by GusNetsol on Jun 4, 2015
Latest reply on Aug 3, 2015 by Hallett_German

Hi Folks!

 

I need your help to repair a bug/error on WebView. We ve implemented APM 9.6.1 + CEM in a distributed environment. MOM , DB and 5 Collectors installed in Windows 2008R2 and 2 MTPs.

This last 2 weeks I´m seeing an unusual error when someone logs in WebView UI. Webview service is working BAU and I dont have any errors at startup. This is the startup log:

 

STATUS | wrapper  | 2015/05/29 15:36:05 | Launching a JVM...

INFO   | jvm 1    | 2015/05/29 15:36:05 | WrapperManager: Initializing...

INFO   | jvm 1    | 2015/05/29 15:36:08 | 5/29/15 03:36:08.228 PM ART [INFO] [WebServer] Starting Web Application Server

INFO   | jvm 1    | 2015/05/29 15:36:08 | 5/29/15 03:36:08.551 PM ART [INFO] [org.mortbay.log] Logging to org.slf4j.impl.WilyLoggerAdapter(org.mortbay.log) via org.mortbay.log.Slf4jLog

INFO   | jvm 1    | 2015/05/29 15:36:08 | 5/29/15 03:36:08.557 PM ART [INFO] [WebView] Fully-qualified domain name is XXXXXXXXXXXXX

INFO   | jvm 1    | 2015/05/29 15:36:08 | 5/29/15 03:36:08.558 PM ART [INFO] [WebView] domain is XXXXXXXXXXX

INFO   | jvm 1    | 2015/05/29 15:36:08 | 5/29/15 03:36:08.589 PM ART [INFO] [WebView] Realm Security Services established

INFO   | jvm 1    | 2015/05/29 15:36:08 | 5/29/15 03:36:08.602 PM ART [INFO] [org.mortbay.log] jetty-6.1.25

INFO   | jvm 1    | 2015/05/29 15:36:08 | 5/29/15 03:36:08.627 PM ART [INFO] [org.mortbay.log] Started SocketConnector@0.0.0.0:8080

INFO   | jvm 1    | 2015/05/29 15:36:09 | 5/29/15 03:36:09.168 PM ART [INFO] [WebServer] Adding application /

INFO   | jvm 1    | 2015/05/29 15:36:10 | may 29, 2015 3:36:10 PM org.apache.myfaces.config.FacesConfigurator feedStandardConfig

INFO   | jvm 1    | 2015/05/29 15:36:10 | INFO: Reading standard config org/apache/myfaces/resource/standard-faces-config.xml

INFO   | jvm 1    | 2015/05/29 15:36:10 | may 29, 2015 3:36:10 PM org.apache.myfaces.config.FacesConfigurator feedClassloaderConfigurations

INFO   | jvm 1    | 2015/05/29 15:36:10 | INFO: Reading config bundleresource://10:1/META-INF/faces-config.xml

INFO   | jvm 1    | 2015/05/29 15:36:10 | may 29, 2015 3:36:10 PM org.apache.myfaces.config.FacesConfigurator feedClassloaderConfigurations

INFO   | jvm 1    | 2015/05/29 15:36:10 | INFO: Reading config bundleresource://10/META-INF/faces-config.xml

INFO   | jvm 1    | 2015/05/29 15:36:10 | may 29, 2015 3:36:10 PM org.apache.myfaces.config.FacesConfigurator feedWebAppConfig

INFO   | jvm 1    | 2015/05/29 15:36:10 | INFO: Reading config /WEB-INF/faces-config.xml

INFO   | jvm 1    | 2015/05/29 15:36:10 | may 29, 2015 3:36:10 PM org.apache.myfaces.shared_impl.util.LocaleUtils toLocale

INFO   | jvm 1    | 2015/05/29 15:36:10 | WARNING: Locale name in faces-config.xml null or empty, setting locale to default locale : en_US

INFO   | jvm 1    | 2015/05/29 15:36:11 | may 29, 2015 3:36:11 PM org.apache.myfaces.webapp.StartupServletContextListener initFaces

INFO   | jvm 1    | 2015/05/29 15:36:11 | INFO: ServletContext 'D:\CA APM 9.6.1.0\product\webview\configuration\org.eclipse.osgi\bundles\10\1\.cp\WebContent' initialized.

INFO   | jvm 1    | 2015/05/29 15:36:11 | may 29, 2015 3:36:11 PM org.apache.myfaces.webapp.StartupServletContextListener handleSerialFactory

INFO   | jvm 1    | 2015/05/29 15:36:11 | INFO: Serialization provider : class org.apache.myfaces.shared_impl.util.serial.DefaultSerialFactory

INFO   | jvm 1    | 2015/05/29 15:36:11 | 5/29/15 03:36:11.523 PM ART [INFO] [WebView.HealthMonitor] EM/MOM status is available

INFO   | jvm 1    | 2015/05/29 15:36:11 | 5/29/15 03:36:11.588 PM ART [INFO] [WebView] Introscope WebView Release 9.6.1.0 (Build 961036)

INFO   | jvm 1    | 2015/05/29 15:36:11 | 5/29/15 03:36:11.588 PM ART [INFO] [WebView] Using Java VM version "Java HotSpot(TM) 64-Bit Server VM 1.7.0_21" from Oracle Corporation

INFO   | jvm 1    | 2015/05/29 15:36:11 | 5/29/15 03:36:11.589 PM ART [INFO] [WebView] Using Introscope installation at: D:\CA APM 9.6.1.0\.

INFO   | jvm 1    | 2015/05/29 15:36:11 | 5/29/15 03:36:11.589 PM ART [INFO] [WebView] CA Wily Introscope(R) Version 9.6.1.0

INFO   | jvm 1    | 2015/05/29 15:36:11 | 5/29/15 03:36:11.589 PM ART [INFO] [WebView] Copyright (c) 2015 CA. All Rights Reserved.

INFO   | jvm 1    | 2015/05/29 15:36:11 | 5/29/15 03:36:11.590 PM ART [INFO] [WebView] Introscope(R) is a registered trademark of CA.

INFO   | jvm 1    | 2015/05/29 15:36:11 | 5/29/15 03:36:11.590 PM ART [INFO] [WebView] Starting Introscope WebView...

INFO   | jvm 1    | 2015/05/29 15:36:11 | 5/29/15 03:36:11.763 PM ART [INFO] [WebView] Introscope WebView started.

INFO   | jvm 1    | 2015/05/29 15:36:13 | 5/29/15 03:36:12.983 PM ART [INFO] [WebView.Login] Successfully logged in user "WilyWebView"

INFO   | jvm 1    | 2015/05/29 15:36:13 | 5/29/15 03:36:13.366 PM ART [INFO] [WebServer] Adding application /castylesr2

INFO   | jvm 1    | 2015/05/29 15:36:13 | 5/29/15 03:36:13.372 PM ART [INFO] [org.mortbay.log] Extract /D:/CA APM 9.6.1.0/product/webview/configuration/org.eclipse.osgi/bundles/12/1/.cp/castylesr2.1.war to work\Jetty_0_0_0_0_8080_castylesr2.1.war__castylesr2__.4fpexc\webapp

INFO   | jvm 1    | 2015/05/29 15:36:13 | 5/29/15 03:36:13.491 PM ART [INFO] [WebServer] Adding application /castylesr5.1.2

INFO   | jvm 1    | 2015/05/29 15:36:13 | 5/29/15 03:36:13.500 PM ART [INFO] [org.mortbay.log] Extract /D:/CA APM 9.6.1.0/product/webview/configuration/org.eclipse.osgi/bundles/13/1/.cp/castylesr5.1.2.war to work\Jetty_0_0_0_0_8080_castylesr5.1.2.war__castylesr5.1.2__cj905b\webapp

INFO   | jvm 1    | 2015/05/29 15:36:13 | 5/29/15 03:36:13.789 PM ART [INFO] [WebServer] Web Application Server started

INFO   | jvm 1    | 2015/05/29 15:36:51 | 5/29/15 03:36:51 PM ART [INFO] [/] No state saving method defined, assuming default server state saving

INFO   | jvm 1    | 2015/05/29 15:36:51 | may 29, 2015 3:36:51 PM org.apache.myfaces.shared_tomahawk.config.MyfacesConfig getBooleanInitParameter

INFO   | jvm 1    | 2015/05/29 15:36:51 | INFO: No context init parameter 'org.apache.myfaces.PRETTY_HTML' found, using default value true

INFO   | jvm 1    | 2015/05/29 15:36:51 | may 29, 2015 3:36:51 PM org.apache.myfaces.shared_tomahawk.config.MyfacesConfig getBooleanInitParameter

INFO   | jvm 1    | 2015/05/29 15:36:51 | INFO: No context init parameter 'org.apache.myfaces.ALLOW_JAVASCRIPT' found, using default value true

INFO   | jvm 1    | 2015/05/29 15:36:51 | may 29, 2015 3:36:51 PM org.apache.myfaces.shared_tomahawk.config.MyfacesConfig getBooleanInitParameter

INFO   | jvm 1    | 2015/05/29 15:36:51 | INFO: No context init parameter 'org.apache.myfaces.READONLY_AS_DISABLED_FOR_SELECTS' found, using default value true

INFO   | jvm 1    | 2015/05/29 15:36:51 | may 29, 2015 3:36:51 PM org.apache.myfaces.shared_tomahawk.config.MyfacesConfig getBooleanInitParameter

INFO   | jvm 1    | 2015/05/29 15:36:51 | INFO: No context init parameter 'org.apache.myfaces.DETECT_JAVASCRIPT' found, using default value false

INFO   | jvm 1    | 2015/05/29 15:36:51 | may 29, 2015 3:36:51 PM org.apache.myfaces.shared_tomahawk.config.MyfacesConfig getBooleanInitParameter

INFO   | jvm 1    | 2015/05/29 15:36:51 | INFO: No context init parameter 'org.apache.myfaces.AUTO_SCROLL' found, using default value false

INFO   | jvm 1    | 2015/05/29 15:36:51 | may 29, 2015 3:36:51 PM org.apache.myfaces.shared_tomahawk.config.MyfacesConfig getStringInitParameter

INFO   | jvm 1    | 2015/05/29 15:36:51 | INFO: No context init parameter 'org.apache.myfaces.ADD_RESOURCE_CLASS' found, using default value org.apache.myfaces.renderkit.html.util.DefaultAddResource

INFO   | jvm 1    | 2015/05/29 15:36:51 | may 29, 2015 3:36:51 PM org.apache.myfaces.shared_tomahawk.config.MyfacesConfig getStringInitParameter

INFO   | jvm 1    | 2015/05/29 15:36:51 | INFO: No context init parameter 'org.apache.myfaces.RESOURCE_VIRTUAL_PATH' found, using default value /faces/myFacesExtensionResource

INFO   | jvm 1    | 2015/05/29 15:36:51 | may 29, 2015 3:36:51 PM org.apache.myfaces.shared_tomahawk.config.MyfacesConfig getBooleanInitParameter

INFO   | jvm 1    | 2015/05/29 15:36:51 | INFO: No context init parameter 'org.apache.myfaces.CHECK_EXTENSIONS_FILTER' found, using default value true

INFO   | jvm 1    | 2015/05/29 15:36:51 | may 29, 2015 3:36:51 PM org.apache.myfaces.shared_tomahawk.config.MyfacesConfig getCurrentInstance

INFO   | jvm 1    | 2015/05/29 15:36:51 | INFO: Starting up Tomahawk on the MyFaces-JSF-Implementation

 

 

So, when a user (local or ldap, is the same) successfully logs into Webview, the first page that Webview shows is HOME. But in my case, HOME page is not beeing showed , It takes too much time to process the request and most of the times it hungs. This is the log after the first login action:

 

INFO   | jvm 1| 2015/05/29 15:36:59 | 5/29/15 03:36:59.354 PM ART [INFO] [WebView] Login event    b010458    6rpm95ygn5lk8286ppsqaqky    180.166.165.163    true
INFO   | jvm 1| 2015/05/29 15:36:59 | 5/29/15 03:36:59.373 PM ART [INFO] [WebView] ABA service available: true
INFO   | jvm 1| 2015/05/29 15:36:59 | 5/29/15 03:36:59.417 PM ART [INFO] [WebView] ABA service available: true
INFO   | jvm 1| 2015/05/29 15:37:00 | 5/29/15 03:37:00.370 PM ART [INFO] [WebView.Login] Successfully logged in user "b010458"
INFO   | jvm 1| 2015/05/29 15:37:11 | 5/29/15 03:37:11.496 PM ART [ERROR] [WebView] Error processing the incoming data Row
INFO   | jvm 1| 2015/05/29 15:37:11 | java.lang.NumberFormatException: For input string: "0,296"
INFO   | jvm 1| 2015/05/29 15:37:11 |     at sun.misc.FloatingDecimal.readJavaFormatString(FloatingDecimal.java:1241)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at java.lang.Double.parseDouble(Double.java:540)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.ca.apm.introscope.workstation.webapp.server.home.HomeModel.getFormatedDoubleValue(HomeModel.java:62)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel.createHomeInfoObject(ApplicationComponentModel.java:753)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel.handleDataSync(ApplicationComponentModel.java:644)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel.access$0(ApplicationComponentModel.java:616)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel$DataMetricReceiver.handleData(ApplicationComponentModel.java:853)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.wily.introscope.spec.server.beans.metricdata.AMetricDataNotification.handleData(AMetricDataNotification.java:37)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.wily.introscope.spec.server.beans.metricdata.AMetricDataNotification.handleData(AMetricDataNotification.java:87)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel$DataMetricReceiver.handleData(ApplicationComponentModel.java:883)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at java.lang.reflect.Method.invoke(Method.java:601)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.wily.isengard.messageprimitives.MethodCallUtilities.callInterface(MethodCallUtilities.java:75)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.wily.isengard.messageprimitives.MethodCallUtilities.callInterface(MethodCallUtilities.java:29)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.wily.isengard.messageprimitives.pipe.AAsyncMessagePipeEndpoint.receiveMessage(AAsyncMessagePipeEndpoint.java:365)
INFO   | jvm 1| 2015/05/29 15:37:11 |     at com.wily.isengard.postoffice.Mailbox.handleMessage(Mailbox.java:252)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.postoffice.PostOffice.deliverInternal(PostOffice.java:505)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.postoffice.PostOffice.access$1(PostOffice.java:451)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.postoffice.PostOffice$DeliveryItem.run(PostOffice.java:790)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:728)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at java.lang.Thread.run(Thread.java:722)
INFO   | jvm 1| 2015/05/29 15:37:12 | 5/29/15 03:37:11.504 PM ART [ERROR] [WebView] Error processing the incoming data Row
INFO   | jvm 1| 2015/05/29 15:37:12 | java.lang.NumberFormatException: For input string: "0,037"
INFO   | jvm 1| 2015/05/29 15:37:12 |     at sun.misc.FloatingDecimal.readJavaFormatString(FloatingDecimal.java:1241)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at java.lang.Double.parseDouble(Double.java:540)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.ca.apm.introscope.workstation.webapp.server.home.HomeModel.getFormatedDoubleValue(HomeModel.java:62)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel.createHomeInfoObject(ApplicationComponentModel.java:753)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel.handleDataSync(ApplicationComponentModel.java:644)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel.access$0(ApplicationComponentModel.java:616)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel$DataMetricReceiver.handleData(ApplicationComponentModel.java:853)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.introscope.spec.server.beans.metricdata.AMetricDataNotification.handleData(AMetricDataNotification.java:37)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.introscope.spec.server.beans.metricdata.AMetricDataNotification.handleData(AMetricDataNotification.java:87)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.ca.apm.introscope.workstation.webapp.server.home.ApplicationComponentModel$DataMetricReceiver.handleData(ApplicationComponentModel.java:883)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at java.lang.reflect.Method.invoke(Method.java:601)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.messageprimitives.MethodCallUtilities.callInterface(MethodCallUtilities.java:75)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.messageprimitives.MethodCallUtilities.callInterface(MethodCallUtilities.java:29)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.messageprimitives.pipe.AAsyncMessagePipeEndpoint.receiveMessage(AAsyncMessagePipeEndpoint.java:365)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.postoffice.Mailbox.handleMessage(Mailbox.java:252)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.postoffice.PostOffice.deliverInternal(PostOffice.java:505)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.postoffice.PostOffice.access$1(PostOffice.java:451)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.isengard.postoffice.PostOffice$DeliveryItem.run(PostOffice.java:790)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at com.wily.EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:728)
INFO   | jvm 1| 2015/05/29 15:37:12 |     at java.lang.Thread.run(Thread.java:722)

 

Issue or bug "Error processing the incoming data Row" will be generated all time, and the process to stop it is to Stop the service.

 

If I log into WebView using another page, like Investigator or Console, I dont get this error log, unless I click on Home TAB. But making this I can see most of the page not getting info for the first two views Business Transactions & Application Components. I think the issue is related with this 2 views and the data that they need to populate. But, after checking HOME page, I need to move fast and change to another page to avoid the big amount of errors on the log. This movement stops erros logs and Webview works as usual.

 

 

Resuming, I need some help to resolve this case. While we are waiting CA Support feedback (for a week till now), maybe someone can tell me how to resolve this problem.

 

I´ve only restart  MOM and WebView several times and nothing happen.

 

Thanks  for your help,

 

Best

 

Gustavo.

Outcomes