Hi Isomorphic,
I got a server exception for a exportClientData request. It *seems* that the exceptions lead to further Java RAM related exceptions in the progress.
Please see these server logs (using v10.0p_2015-04-10):
1st request (null pointer exception in com.isomorphic class):
2nd request (null pointer exception in com.isomorphic class):
I put both request logs in WinMerge - they are the same besides the timestamp. I don't know what happened here. For some seconds, other requests are processed normally, but then the logs are full of "java.lang.Exception: java.lang.OutOfMemoryError: PermGen space".
The two requests I have shown are the first ones in today's logs (after 17 hours) resulting in a Java exceptions - operations were normal before.
1st out of memory request:
2nd out of memory request:
3rd out of memory request:
and so on.
I restarted Tomcat after noticing, which stopped the exceptions for me. Also, I'm running many instances of the application under different Tomcat server.xml <Host>-tags. It seems, the other hosts were not affected by the error.
I can provide full logs via email, if needed. I don't have any linux memory listings from before the exception but can provide all needed current RAM usage and configurations parameters.
Does this (java.lang.NullPointerException at com.isomorphic.rpc.ExcelDataExport.writeExportObject(ExcelDataExport.java:1313)) look like a possible bug?
Best regards
Blama
I got a server exception for a exportClientData request. It *seems* that the exceptions lead to further Java RAM related exceptions in the progress.
Please see these server logs (using v10.0p_2015-04-10):
1st request (null pointer exception in com.isomorphic class):
Code:
=== 2015-04-24 17:39:01,245 [c-39] INFO RequestContext - URL: '/test/lms/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0': Moz (Gecko) with Accept-Encoding header
=== 2015-04-24 17:39:01,245 [c-39] DEBUG LMSIDACall - Header Name:Value pair: host:REMOVED
=== 2015-04-24 17:39:01,245 [c-39] DEBUG LMSIDACall - Header Name:Value pair: user-agent:Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0
=== 2015-04-24 17:39:01,245 [c-39] DEBUG LMSIDACall - Header Name:Value pair: accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2015-04-24 17:39:01,245 [c-39] DEBUG LMSIDACall - Header Name:Value pair: Accept-Language:de,en-US;q=0.7,en;q=0.3
=== 2015-04-24 17:39:01,246 [c-39] DEBUG LMSIDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2015-04-24 17:39:01,246 [c-39] DEBUG LMSIDACall - Header Name:Value pair: referer:REMOVED
=== 2015-04-24 17:39:01,246 [c-39] DEBUG LMSIDACall - Header Name:Value pair: cookie:JSESSIONID=REMOVED; isc_cState=ready; GLog=REMOVED
=== 2015-04-24 17:39:01,246 [c-39] DEBUG LMSIDACall - Header Name:Value pair: connection:keep-alive
=== 2015-04-24 17:39:01,246 [c-39] DEBUG LMSIDACall - Header Name:Value pair: content-type:application/x-www-form-urlencoded
=== 2015-04-24 17:39:01,246 [c-39] DEBUG LMSIDACall - Header Name:Value pair: content-length:12274
=== 2015-04-24 17:39:01,246 [c-39] DEBUG LMSIDACall - session exists: REMOVED
=== 2015-04-24 17:39:01,246 [c-39] DEBUG LMSIDACall - remote user: csuperuser
=== 2015-04-24 17:39:01,249 [c-39] DEBUG RPCManager - Processing 1 requests.
=== 2015-04-24 17:39:01,249 [c-39] DEBUG RPCManager - Request #1 (RPCRequest) data: {
appID:"isc_builtin",
className:"builtin",
methodName:"downloadClientExport",
arguments:[
[
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"08.04.2015",
PICKED_DATE$style:{
rawValue:new Date(1428504613000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"Hopsassa Gmbh (Günther Hopsassa)",
CAMPAIGN_ID:"Hannover Messe 2015",
CAMPAIGN_ID$style:{
rawValue:59
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Event",
LEADTYPE_ID$style:{
rawValue:22
},
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"21.01.2015",
PICKED_DATE$style:{
rawValue:new Date(1421830376000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"Test gmbh (Test)",
CAMPAIGN_ID:"Kündiger-Reaktivierung",
CAMPAIGN_ID$style:{
rawValue:50
},
LEADTEMPERATURE_ID:"Marketing qualified Lead",
LEADTEMPERATURE_ID$style:{
rawValue:19
},
LEADTYPE_ID:" ",
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"Top-Software Reseller UG (MS)",
STATUS_RESELLER_ID$style:{
rawValue:26
},
STATUS_USER_ID:"S. Resch",
STATUS_USER_ID$style:{
rawValue:1098
},
PICKED_DATE:"26.03.2015",
PICKED_DATE$style:{
rawValue:new Date(1427368899000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"tmp Gmbh (Müller)",
CAMPAIGN_ID:"Cebit Stand 2014",
CAMPAIGN_ID$style:{
rawValue:51
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Trial DL",
LEADTYPE_ID$style:{
rawValue:25
},
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Angebot",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"30.03.2015",
PICKED_DATE$style:{
rawValue:new Date(1427724435000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:"30.04.2015",
STATUS_STATUSDATE$style:{
rawValue:new Date(1430344800000),
dateFormatter:null
},
CUST_NAME_CONTACTPERSFULLNAME:"tmp gmbh (Heiko Wedemeyer)",
CAMPAIGN_ID:"Cebit Stand 2014",
CAMPAIGN_ID$style:{
rawValue:51
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Event",
LEADTYPE_ID$style:{
rawValue:22
},
STATUS_POTREV_COMPANY:"2.000 €",
STATUS_POTREV_COMPANY$style:{
rawValue:2000
},
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
}
],
"ooxml",
"picked_leads.xlsx",
"download",
{
exportAs:"ooxml",
exportDisplay:"download",
exportFilename:"picked_leads.xlsx",
exportPath:null,
exportToClient:null,
exportToFilesystem:null,
exportDelimiter:null,
exportFields:[
"leadAction",
"STATUS_RESELLER_ID",
"STATUS_USER_ID",
"PICKED_DATE",
"STATUS_STATUSDATE",
"CUST_NAME_CONTACTPERSFULLNAME",
"CAMPAIGN_ID",
"LEADTEMPERATURE_ID",
"LEADTYPE_ID",
"STATUS_POTREV_COMPANY",
"STATUS_POTREV_PROJECT",
"CREATED_BY",
"CREATED_BY_LEGALENTITYNAME"
],
exportHeader:null,
exportHeaderless:null,
exportFooter:null,
exportTitleSeparatorChar:null,
exportDefaultBGColor:null,
exportAlternateRowBGColor:null,
exportRowBGColors:{
},
exportColumnBGColors:{
},
exportRawValues:false,
exportCurrencySymbol:"€",
lineBreakStyle:null,
exportOtherFields:{
leadAction:"Aktionen",
STATUS_RESELLER_ID:"Gepickt von Firma",
STATUS_USER_ID:"Gepickt von Benutzer",
PICKED_DATE:"Gepickt am",
STATUS_STATUSDATE:"Statusdatum",
CUST_NAME_CONTACTPERSFULLNAME:"Ansprechpartner",
CAMPAIGN_ID:"Kampagne",
LEADTEMPERATURE_ID:"Leadtemperatur",
LEADTYPE_ID:"Leadtyp",
STATUS_POTREV_COMPANY:"Anteil Kunde (netto)",
STATUS_POTREV_PROJECT:"Umfang Gesamtprojekt (netto)",
CREATED_BY:"Erst. v. (User)",
CREATED_BY_LEGALENTITYNAME:"Erst. v. (Firma)"
},
exportWrapHeaderTitles:null
}
],
is_ISC_RPC_DMI:true
}
=== 2015-04-24 17:39:01,250 [c-39] INFO LMSIDACall - Performing 1 operation(s)
=== 2015-04-24 17:39:01,258 [c-39] DEBUG RPCDMI - appConfig: isc.Application.create({
rpcBindings:[
{
ID:"builtin",
className:"com.isomorphic.rpc.BuiltinRPC",
visibleMethods:[
{
name:"downloadWSDL"
},
{
name:"downloadClientContent"
},
{
name:"downloadClientExport"
},
{
name:"xmlToJS"
},
{
name:"uploadProgressCheck"
},
{
name:"saveFile"
},
{
name:"appendToFile"
},
{
name:"loadFile"
},
{
name:"deleteFile"
},
{
name:"loadSharedXML"
},
{
name:"saveSharedXML"
},
{
name:"getAvailableScriptEngines"
},
{
name:"devConsoleEvalServerScript"
},
{
name:"evalJava"
},
{
name:"getLogNames"
},
{
name:"getLogEntries"
},
{
name:"clearLogEntries"
},
{
name:"getLogThresholds"
},
{
name:"setLogThreshold"
},
{
name:"setTemporaryLogThreshold"
},
{
name:"revertTemporaryLogThresholds"
},
{
name:"getPdfObject"
},
{
name:"exportImage"
},
{
name:"areServerTimingsTracked"
},
{
name:"trackServerTimings"
}
]
},
{
ID:"builtin_tools",
className:"com.isomorphic.tools.BuiltinRPC",
visibleMethods:[
{
name:"getDataSourceFromTable"
},
{
name:"getDataSourceJSONFromTable"
},
{
name:"getDataSourceFromHibernateMapping"
},
{
name:"getDataSourceJSONFromHibernateMapping"
},
{
name:"getTables"
},
{
name:"getFieldsFromTable"
},
{
name:"getBeanFields"
},
{
name:"getHibernateBeans"
},
{
name:"getDatabaseProductNameAndVersion"
},
{
name:"getDatabaseTableTypes"
},
{
name:"setAttributes"
},
{
name:"clearAttributes"
},
{
name:"getAttributes"
},
{
name:"getAttribute"
},
{
name:"getDataSourceConfigFromJavaClass"
},
{
args:"cName",
language:"groovy",
name:"getJavaSource",
script:"\n if (!com.isomorphic.auth.DevModeAuthFilter.devModeAuthorized(request)) throw new Exception(\"Not Authorized\"); \n //import org.apache.bcel.Repository;\n\n try {\n return org.apache.bcel.Repository.lookupClass(cName).toString();\n } catch (Throwable e) {\n return \"Unable to reverse engineer class \"+cName+\": \"+e.getMessage();\n }\n "
},
{
name:"loadDataSource"
},
{
name:"dsFromXML"
},
{
name:"dsConfigFromXML"
},
{
name:"getDefinedDataSources"
}
]
},
{
ID:"builtin_adminconsole",
className:"com.isomorphic.tools.AdminConsole",
visibleMethods:[
{
name:"getDefinedDatabases"
},
{
name:"testDB"
},
{
name:"saveDBConfig"
},
{
name:"setDefaultDB"
},
{
name:"importDataSources"
},
{
name:"discoverJNDIDatabases"
}
]
}
]
})
=== 2015-04-24 17:39:01,261 [c-39] INFO BuiltinRPC - Export data passed to server:
[
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"08.04.2015",
PICKED_DATE$style:{
rawValue:new Date(1428504613000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"Hopsassa Gmbh (Günther Hopsassa)",
CAMPAIGN_ID:"Hannover Messe 2015",
CAMPAIGN_ID$style:{
rawValue:59
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Event",
LEADTYPE_ID$style:{
rawValue:22
},
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"21.01.2015",
PICKED_DATE$style:{
rawValue:new Date(1421830376000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"Test gmbh (Test)",
CAMPAIGN_ID:"Kündiger-Reaktivierung",
CAMPAIGN_ID$style:{
rawValue:50
},
LEADTEMPERATURE_ID:"Marketing qualified Lead",
LEADTEMPERATURE_ID$style:{
rawValue:19
},
LEADTYPE_ID:" ",
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"Top-Software Reseller UG (MS)",
STATUS_RESELLER_ID$style:{
rawValue:26
},
STATUS_USER_ID:"S. Resch",
STATUS_USER_ID$style:{
rawValue:1098
},
PICKED_DATE:"26.03.2015",
PICKED_DATE$style:{
rawValue:new Date(1427368899000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"tmp Gmbh (Müller)",
CAMPAIGN_ID:"Cebit Stand 2014",
CAMPAIGN_ID$style:{
rawValue:51
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Trial DL",
LEADTYPE_ID$style:{
rawValue:25
},
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Angebot",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"30.03.2015",
PICKED_DATE$style:{
rawValue:new Date(1427724435000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:"30.04.2015",
STATUS_STATUSDATE$style:{
rawValue:new Date(1430344800000),
dateFormatter:null
},
CUST_NAME_CONTACTPERSFULLNAME:"tmp gmbh (Heiko Wedemeyer)",
CAMPAIGN_ID:"Cebit Stand 2014",
CAMPAIGN_ID$style:{
rawValue:51
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Event",
LEADTYPE_ID$style:{
rawValue:22
},
STATUS_POTREV_COMPANY:"2.000 €",
STATUS_POTREV_COMPANY$style:{
rawValue:2000
},
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
}
]
=== 2015-04-24 17:39:01,263 [c-39] INFO ProxyHttpServletResponse - content-disposition set to: attachment; fileName=picked_leads.xlsx - unwrapping response output stream (CompressionFilter)
=== 2015-04-24 17:39:01,263 [c-39] DEBUG ConfigParser - Matched var name: webRoot
=== 2015-04-24 17:39:01,264 [c-39] DEBUG ConfigParser - value after substitution: /usr/share/apache-tomcat-7.0.53/lms_test/test
=== 2015-04-24 17:39:01,264 [c-39] INFO BuiltinRPC - Generating and streaming ooxml file...
=== 2015-04-24 17:39:02,952 [c-39] WARN BuiltinRPC - Exception during export - continuing anyway to avoid sending the client to a blank screen
java.lang.NullPointerException
at com.isomorphic.rpc.ExcelDataExport.writeExportObject(ExcelDataExport.java:1313)
at com.isomorphic.rpc.DataExport.exportResultSet(DataExport.java:640)
at com.isomorphic.rpc.DataExport.exportResultSet(DataExport.java:460)
at com.isomorphic.rpc.BuiltinRPC.downloadClientExport(BuiltinRPC.java:850)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.isomorphic.base.Reflection.adaptArgsAndInvoke(Reflection.java:975)
at com.isomorphic.base.Reflection.adaptArgsAndInvoke(Reflection.java:805)
at com.isomorphic.rpc.RPCDMI.execute(RPCDMI.java:309)
at com.isomorphic.rpc.RPCDMI.execute(RPCDMI.java:66)
at com.isomorphic.rpc.RPCRequest.execute(RPCRequest.java:231)
at com.isomorphic.servlet.IDACall.handleRPCRequest(IDACall.java:328)
at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:182)
at com.lmscompany.lms.server.LMSIDACall.processRequest(LMSIDACall.java:40)
at com.isomorphic.servlet.IDACall._processRequest(IDACall.java:117)
at com.isomorphic.servlet.IDACall.doPost(IDACall.java:76)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:646)
at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:156)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at com.isomorphic.servlet.CompressionFilter._doFilter(CompressionFilter.java:260)
at com.isomorphic.servlet.BaseFilter.doFilter(BaseFilter.java:83)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:610)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:98)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:950)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
at org.apache.coyote.ajp.AjpProcessor.process(AjpProcessor.java:193)
at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:607)
at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:313)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
=== 2015-04-24 17:39:02,953 [c-39] DEBUG RPCDMI - rpc returned data
Code:
=== 2015-04-24 17:39:03,616 [c-56] INFO RequestContext - URL: '/test/lms/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0': Moz (Gecko) with Accept-Encoding header
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: host:REMOVED
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: user-agent:Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: Accept-Language:de,en-US;q=0.7,en;q=0.3
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: referer:REMOVED
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: cookie:JSESSIONID=REMOVED; isc_cState=ready; GLog=REMOVED
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: connection:keep-alive
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: content-type:application/x-www-form-urlencoded
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - Header Name:Value pair: content-length:12274
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - session exists: REMOVED
=== 2015-04-24 17:39:03,616 [c-56] DEBUG LMSIDACall - remote user: csuperuser
=== 2015-04-24 17:39:03,620 [c-56] DEBUG RPCManager - Processing 1 requests.
=== 2015-04-24 17:39:03,620 [c-56] DEBUG RPCManager - Request #1 (RPCRequest) data: {
appID:"isc_builtin",
className:"builtin",
methodName:"downloadClientExport",
arguments:[
[
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"08.04.2015",
PICKED_DATE$style:{
rawValue:new Date(1428504613000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"Hopsassa Gmbh (Günther Hopsassa)",
CAMPAIGN_ID:"Hannover Messe 2015",
CAMPAIGN_ID$style:{
rawValue:59
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Event",
LEADTYPE_ID$style:{
rawValue:22
},
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"21.01.2015",
PICKED_DATE$style:{
rawValue:new Date(1421830376000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"Test gmbh (Test)",
CAMPAIGN_ID:"Kündiger-Reaktivierung",
CAMPAIGN_ID$style:{
rawValue:50
},
LEADTEMPERATURE_ID:"Marketing qualified Lead",
LEADTEMPERATURE_ID$style:{
rawValue:19
},
LEADTYPE_ID:" ",
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"Top-Software Reseller UG (MS)",
STATUS_RESELLER_ID$style:{
rawValue:26
},
STATUS_USER_ID:"S. Resch",
STATUS_USER_ID$style:{
rawValue:1098
},
PICKED_DATE:"26.03.2015",
PICKED_DATE$style:{
rawValue:new Date(1427368899000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"tmp Gmbh (Müller)",
CAMPAIGN_ID:"Cebit Stand 2014",
CAMPAIGN_ID$style:{
rawValue:51
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Trial DL",
LEADTYPE_ID$style:{
rawValue:25
},
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Angebot",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"30.03.2015",
PICKED_DATE$style:{
rawValue:new Date(1427724435000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:"30.04.2015",
STATUS_STATUSDATE$style:{
rawValue:new Date(1430344800000),
dateFormatter:null
},
CUST_NAME_CONTACTPERSFULLNAME:"tmp gmbh (Heiko Wedemeyer)",
CAMPAIGN_ID:"Cebit Stand 2014",
CAMPAIGN_ID$style:{
rawValue:51
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Event",
LEADTYPE_ID$style:{
rawValue:22
},
STATUS_POTREV_COMPANY:"2.000 €",
STATUS_POTREV_COMPANY$style:{
rawValue:2000
},
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
}
],
"ooxml",
"picked_leads.xlsx",
"download",
{
exportAs:"ooxml",
exportDisplay:"download",
exportFilename:"picked_leads.xlsx",
exportPath:null,
exportToClient:null,
exportToFilesystem:null,
exportDelimiter:null,
exportFields:[
"leadAction",
"STATUS_RESELLER_ID",
"STATUS_USER_ID",
"PICKED_DATE",
"STATUS_STATUSDATE",
"CUST_NAME_CONTACTPERSFULLNAME",
"CAMPAIGN_ID",
"LEADTEMPERATURE_ID",
"LEADTYPE_ID",
"STATUS_POTREV_COMPANY",
"STATUS_POTREV_PROJECT",
"CREATED_BY",
"CREATED_BY_LEGALENTITYNAME"
],
exportHeader:null,
exportHeaderless:null,
exportFooter:null,
exportTitleSeparatorChar:null,
exportDefaultBGColor:null,
exportAlternateRowBGColor:null,
exportRowBGColors:{
},
exportColumnBGColors:{
},
exportRawValues:false,
exportCurrencySymbol:"€",
lineBreakStyle:null,
exportOtherFields:{
leadAction:"Aktionen",
STATUS_RESELLER_ID:"Gepickt von Firma",
STATUS_USER_ID:"Gepickt von Benutzer",
PICKED_DATE:"Gepickt am",
STATUS_STATUSDATE:"Statusdatum",
CUST_NAME_CONTACTPERSFULLNAME:"Ansprechpartner",
CAMPAIGN_ID:"Kampagne",
LEADTEMPERATURE_ID:"Leadtemperatur",
LEADTYPE_ID:"Leadtyp",
STATUS_POTREV_COMPANY:"Anteil Kunde (netto)",
STATUS_POTREV_PROJECT:"Umfang Gesamtprojekt (netto)",
CREATED_BY:"Erst. v. (User)",
CREATED_BY_LEGALENTITYNAME:"Erst. v. (Firma)"
},
exportWrapHeaderTitles:null
}
],
is_ISC_RPC_DMI:true
}
=== 2015-04-24 17:39:03,620 [c-56] INFO LMSIDACall - Performing 1 operation(s)
=== 2015-04-24 17:39:03,621 [c-56] DEBUG RPCDMI - appConfig: isc.Application.create({
rpcBindings:[
{
ID:"builtin",
className:"com.isomorphic.rpc.BuiltinRPC",
visibleMethods:[
{
name:"downloadWSDL"
},
{
name:"downloadClientContent"
},
{
name:"downloadClientExport"
},
{
name:"xmlToJS"
},
{
name:"uploadProgressCheck"
},
{
name:"saveFile"
},
{
name:"appendToFile"
},
{
name:"loadFile"
},
{
name:"deleteFile"
},
{
name:"loadSharedXML"
},
{
name:"saveSharedXML"
},
{
name:"getAvailableScriptEngines"
},
{
name:"devConsoleEvalServerScript"
},
{
name:"evalJava"
},
{
name:"getLogNames"
},
{
name:"getLogEntries"
},
{
name:"clearLogEntries"
},
{
name:"getLogThresholds"
},
{
name:"setLogThreshold"
},
{
name:"setTemporaryLogThreshold"
},
{
name:"revertTemporaryLogThresholds"
},
{
name:"getPdfObject"
},
{
name:"exportImage"
},
{
name:"areServerTimingsTracked"
},
{
name:"trackServerTimings"
}
]
},
{
ID:"builtin_tools",
className:"com.isomorphic.tools.BuiltinRPC",
visibleMethods:[
{
name:"getDataSourceFromTable"
},
{
name:"getDataSourceJSONFromTable"
},
{
name:"getDataSourceFromHibernateMapping"
},
{
name:"getDataSourceJSONFromHibernateMapping"
},
{
name:"getTables"
},
{
name:"getFieldsFromTable"
},
{
name:"getBeanFields"
},
{
name:"getHibernateBeans"
},
{
name:"getDatabaseProductNameAndVersion"
},
{
name:"getDatabaseTableTypes"
},
{
name:"setAttributes"
},
{
name:"clearAttributes"
},
{
name:"getAttributes"
},
{
name:"getAttribute"
},
{
name:"getDataSourceConfigFromJavaClass"
},
{
args:"cName",
language:"groovy",
name:"getJavaSource",
script:"\n if (!com.isomorphic.auth.DevModeAuthFilter.devModeAuthorized(request)) throw new Exception(\"Not Authorized\"); \n //import org.apache.bcel.Repository;\n\n try {\n return org.apache.bcel.Repository.lookupClass(cName).toString();\n } catch (Throwable e) {\n return \"Unable to reverse engineer class \"+cName+\": \"+e.getMessage();\n }\n "
},
{
name:"loadDataSource"
},
{
name:"dsFromXML"
},
{
name:"dsConfigFromXML"
},
{
name:"getDefinedDataSources"
}
]
},
{
ID:"builtin_adminconsole",
className:"com.isomorphic.tools.AdminConsole",
visibleMethods:[
{
name:"getDefinedDatabases"
},
{
name:"testDB"
},
{
name:"saveDBConfig"
},
{
name:"setDefaultDB"
},
{
name:"importDataSources"
},
{
name:"discoverJNDIDatabases"
}
]
}
]
})
=== 2015-04-24 17:39:03,622 [c-56] INFO BuiltinRPC - Export data passed to server:
[
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"08.04.2015",
PICKED_DATE$style:{
rawValue:new Date(1428504613000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"Hopsassa Gmbh (Günther Hopsassa)",
CAMPAIGN_ID:"Hannover Messe 2015",
CAMPAIGN_ID$style:{
rawValue:59
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Event",
LEADTYPE_ID$style:{
rawValue:22
},
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"21.01.2015",
PICKED_DATE$style:{
rawValue:new Date(1421830376000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"Test gmbh (Test)",
CAMPAIGN_ID:"Kündiger-Reaktivierung",
CAMPAIGN_ID$style:{
rawValue:50
},
LEADTEMPERATURE_ID:"Marketing qualified Lead",
LEADTEMPERATURE_ID$style:{
rawValue:19
},
LEADTYPE_ID:" ",
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Gepickt",
leadAction:" ",
STATUS_RESELLER_ID:"Top-Software Reseller UG (MS)",
STATUS_RESELLER_ID$style:{
rawValue:26
},
STATUS_USER_ID:"S. Resch",
STATUS_USER_ID$style:{
rawValue:1098
},
PICKED_DATE:"26.03.2015",
PICKED_DATE$style:{
rawValue:new Date(1427368899000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:" ",
CUST_NAME_CONTACTPERSFULLNAME:"tmp Gmbh (Müller)",
CAMPAIGN_ID:"Cebit Stand 2014",
CAMPAIGN_ID$style:{
rawValue:51
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Trial DL",
LEADTYPE_ID$style:{
rawValue:25
},
STATUS_POTREV_COMPANY:" ",
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
},
{
STATUS_SHORTNAME:"Angebot",
leadAction:" ",
STATUS_RESELLER_ID:"ABC-Softwarehaus GmbH (B)",
STATUS_RESELLER_ID$style:{
rawValue:31
},
STATUS_USER_ID:"M. Unmüssig",
STATUS_USER_ID$style:{
rawValue:1094
},
PICKED_DATE:"30.03.2015",
PICKED_DATE$style:{
rawValue:new Date(1427724435000),
dateFormatter:"toEuropeanShortDate"
},
STATUS_STATUSDATE:"30.04.2015",
STATUS_STATUSDATE$style:{
rawValue:new Date(1430344800000),
dateFormatter:null
},
CUST_NAME_CONTACTPERSFULLNAME:"tmp gmbh (Heiko Wedemeyer)",
CAMPAIGN_ID:"Cebit Stand 2014",
CAMPAIGN_ID$style:{
rawValue:51
},
LEADTEMPERATURE_ID:"Hot Lead",
LEADTEMPERATURE_ID$style:{
rawValue:17
},
LEADTYPE_ID:"Event",
LEADTYPE_ID$style:{
rawValue:22
},
STATUS_POTREV_COMPANY:"2.000 €",
STATUS_POTREV_COMPANY$style:{
rawValue:2000
},
STATUS_POTREV_PROJECT:" ",
CREATED_BY:"K. Kowalski",
CREATED_BY$style:{
rawValue:1083
},
CREATED_BY_LEGALENTITYNAME:"OURCOMPANY TESTACCOUNT"
}
]
=== 2015-04-24 17:39:03,622 [c-56] INFO ProxyHttpServletResponse - content-disposition set to: attachment; fileName=picked_leads.xlsx - unwrapping response output stream (CompressionFilter)
=== 2015-04-24 17:39:03,622 [c-56] INFO BuiltinRPC - Generating and streaming ooxml file...
=== 2015-04-24 17:39:03,623 [c-56] WARN BuiltinRPC - Exception during export - continuing anyway to avoid sending the client to a blank screen
java.lang.NullPointerException
at com.isomorphic.rpc.ExcelDataExport.writeExportObject(ExcelDataExport.java:1313)
at com.isomorphic.rpc.DataExport.exportResultSet(DataExport.java:640)
at com.isomorphic.rpc.DataExport.exportResultSet(DataExport.java:460)
at com.isomorphic.rpc.BuiltinRPC.downloadClientExport(BuiltinRPC.java:850)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.isomorphic.base.Reflection.adaptArgsAndInvoke(Reflection.java:975)
at com.isomorphic.base.Reflection.adaptArgsAndInvoke(Reflection.java:805)
at com.isomorphic.rpc.RPCDMI.execute(RPCDMI.java:309)
at com.isomorphic.rpc.RPCDMI.execute(RPCDMI.java:66)
at com.isomorphic.rpc.RPCRequest.execute(RPCRequest.java:231)
at com.isomorphic.servlet.IDACall.handleRPCRequest(IDACall.java:328)
at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:182)
at com.lmscompany.lms.server.LMSIDACall.processRequest(LMSIDACall.java:40)
at com.isomorphic.servlet.IDACall._processRequest(IDACall.java:117)
at com.isomorphic.servlet.IDACall.doPost(IDACall.java:76)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:646)
at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:156)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at com.isomorphic.servlet.CompressionFilter._doFilter(CompressionFilter.java:260)
at com.isomorphic.servlet.BaseFilter.doFilter(BaseFilter.java:83)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:610)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:98)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:950)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
at org.apache.coyote.ajp.AjpProcessor.process(AjpProcessor.java:193)
at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:607)
at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:313)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
=== 2015-04-24 17:39:03,624 [c-56] DEBUG RPCDMI - rpc returned data
The two requests I have shown are the first ones in today's logs (after 17 hours) resulting in a Java exceptions - operations were normal before.
1st out of memory request:
Code:
=== 2015-04-24 17:40:08,380 [c-31] INFO RequestContext - URL: '/test/lms/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0': Moz (Gecko) with Accept-Encoding header
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: host:REMOVED
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: user-agent:Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: Accept-Language:de,en-US;q=0.7,en;q=0.3
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: content-type:application/x-www-form-urlencoded; charset=UTF-8
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: referer:REMOVED
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: content-length:1059
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: cookie:JSESSIONID=REMOVED; isc_cState=ready; GLog=REMOVED
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: connection:keep-alive
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: pragma:no-cache
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - session exists: REMOVED
=== 2015-04-24 17:40:08,380 [c-31] DEBUG LMSIDACall - remote user: csuperuser
=== 2015-04-24 17:40:08,381 [c-31] DEBUG RPCManager - Processing 1 requests.
=== 2015-04-24 17:40:08,381 [c-31] DEBUG RPCManager - Request #1 (DSRequest) payload: {
criteria:{
ID:51
},
operationConfig:{
dataSource:"T_CAMPAIGN",
repo:null,
operationType:"fetch",
textMatchStyle:"exact"
},
componentId:"isc_AddEditLeadMasterdata_2_0",
appID:"builtinApplication",
operation:"fetchOwnAndOtherLECampaigns",
oldValues:{
ID:51
}
}
=== 2015-04-24 17:40:08,381 [c-31] INFO LMSIDACall - Performing 1 operation(s)
=== 2015-04-24 17:40:08,805 [c-31] WARN DataSourceDMI - Failed to create serverObject using operation level config. Will try to use DataSource level config instead. Actual error: PermGen space
=== 2015-04-24 17:40:09,180 [c-31] WARN RequestContext - dsRequest.execute() failed:
java.lang.Exception: java.lang.OutOfMemoryError: PermGen space
at com.isomorphic.datasource.DataSourceDMI.execute(DataSourceDMI.java:246)
at com.isomorphic.datasource.DataSourceDMI.execute(DataSourceDMI.java:64)
at com.isomorphic.datasource.DSRequest.execute(DSRequest.java:2544)
at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:220)
at com.lmscompany.lms.server.LMSIDACall.handleDSRequest(LMSIDACall.java:75)
at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:185)
at com.lmscompany.lms.server.LMSIDACall.processRequest(LMSIDACall.java:40)
at com.isomorphic.servlet.IDACall._processRequest(IDACall.java:117)
at com.isomorphic.servlet.IDACall.doPost(IDACall.java:76)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:646)
at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:156)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at com.isomorphic.servlet.CompressionFilter._doFilter(CompressionFilter.java:260)
at com.isomorphic.servlet.BaseFilter.doFilter(BaseFilter.java:83)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:610)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:98)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:950)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
at org.apache.coyote.ajp.AjpProcessor.process(AjpProcessor.java:193)
at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:607)
at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:313)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
Caused by: java.lang.OutOfMemoryError: PermGen space
at java.lang.ClassLoader.defineClass1(Native Method)
at java.lang.ClassLoader.defineClass(ClassLoader.java:800)
at java.security.SecureClassLoader.defineClass(SecureClassLoader.java:142)
at org.apache.catalina.loader.WebappClassLoader.findClassInternal(WebappClassLoader.java:2957)
at org.apache.catalina.loader.WebappClassLoader.findClass(WebappClassLoader.java:1210)
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1690)
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1571)
at java.lang.Class.forName0(Native Method)
at java.lang.Class.forName(Class.java:270)
at com.isomorphic.base.Reflection.classForName(Reflection.java:139)
at com.isomorphic.rpc.ServerObject.<init>(ServerObject.java:157)
at com.isomorphic.rpc.ServerObject.<init>(ServerObject.java:70)
at com.isomorphic.datasource.DataSourceDMI.execute(DataSourceDMI.java:236)
at com.isomorphic.datasource.DataSourceDMI.execute(DataSourceDMI.java:64)
at com.isomorphic.datasource.DSRequest.execute(DSRequest.java:2544)
at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:220)
at com.lmscompany.lms.server.LMSIDACall.handleDSRequest(LMSIDACall.java:75)
at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:185)
at com.lmscompany.lms.server.LMSIDACall.processRequest(LMSIDACall.java:40)
at com.isomorphic.servlet.IDACall._processRequest(IDACall.java:117)
at com.isomorphic.servlet.IDACall.doPost(IDACall.java:76)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:646)
at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:156)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at com.isomorphic.servlet.CompressionFilter._doFilter(CompressionFilter.java:260)
at com.isomorphic.servlet.BaseFilter.doFilter(BaseFilter.java:83)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
Code:
=== 2015-04-24 17:40:08,381 [c-50] INFO RequestContext - URL: '/test/lms/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0': Moz (Gecko) with Accept-Encoding header
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: host:REMOVED
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: user-agent:Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: Accept-Language:de,en-US;q=0.7,en;q=0.3
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: content-type:application/x-www-form-urlencoded; charset=UTF-8
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: referer:REMOVED
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: content-length:1282
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: cookie:JSESSIONID=REMOVED; isc_cState=ready; GLog=REMOVED
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: connection:keep-alive
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: pragma:no-cache
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - session exists: REMOVED
=== 2015-04-24 17:40:08,381 [c-50] DEBUG LMSIDACall - remote user: csuperuser
=== 2015-04-24 17:40:09,181 [c-50] DEBUG RPCManager - Processing 1 requests.
=== 2015-04-24 17:40:09,181 [c-50] DEBUG RPCManager - Request #1 (DSRequest) payload: {
criteria:{
operator:"equals",
fieldName:"LEAD_ID",
value:85,
_constructor:"AdvancedCriteria"
},
operationConfig:{
dataSource:"V_LEAD_RESELLER_MATCH_ALL_RD",
repo:null,
operationType:"fetch",
textMatchStyle:"exact"
},
appID:"builtinApplication",
operation:"countPossibleResellers",
oldValues:{
operator:"equals",
fieldName:"LEAD_ID",
value:85,
_constructor:"AdvancedCriteria"
}
}
=== 2015-04-24 17:40:09,181 [c-50] INFO LMSIDACall - Performing 1 operation(s)
=== 2015-04-24 17:40:09,688 [c-50] WARN RequestContext - dsRequest.execute() failed:
java.lang.OutOfMemoryError: PermGen space
at java.lang.ClassLoader.defineClass1(Native Method)
at java.lang.ClassLoader.defineClass(ClassLoader.java:800)
at java.security.SecureClassLoader.defineClass(SecureClassLoader.java:142)
at org.apache.catalina.loader.WebappClassLoader.findClassInternal(WebappClassLoader.java:2957)
at org.apache.catalina.loader.WebappClassLoader.findClass(WebappClassLoader.java:1210)
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1690)
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1571)
at com.isomorphic.datasource.DSRequest.convertMapOfStringToMapOfSummaryFunctionType(DSRequest.java:642)
at com.isomorphic.datasource.DSRequest.buildSummaryFields(DSRequest.java:1648)
at com.isomorphic.datasource.DSRequest.buildFieldData(DSRequest.java:3053)
at com.isomorphic.datasource.DSRequest.execute(DSRequest.java:2392)
at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:220)
at com.lmscompany.lms.server.LMSIDACall.handleDSRequest(LMSIDACall.java:75)
at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:185)
at com.lmscompany.lms.server.LMSIDACall.processRequest(LMSIDACall.java:40)
at com.isomorphic.servlet.IDACall._processRequest(IDACall.java:117)
at com.isomorphic.servlet.IDACall.doPost(IDACall.java:76)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:646)
at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:156)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at com.isomorphic.servlet.CompressionFilter._doFilter(CompressionFilter.java:260)
at com.isomorphic.servlet.BaseFilter.doFilter(BaseFilter.java:83)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:610)
Code:
=== 2015-04-24 17:40:19,249 [c-54] INFO RequestContext - URL: '/test/lms/sc/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0': Moz (Gecko) with Accept-Encoding header
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: host:REMOVED
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: user-agent:Mozilla/5.0 (Windows NT 6.3; WOW64; rv:37.0) Gecko/20100101 Firefox/37.0
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: accept:text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: Accept-Language:de,en-US;q=0.7,en;q=0.3
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: Accept-Encoding:gzip, deflate
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: content-type:application/x-www-form-urlencoded; charset=UTF-8
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: referer:REMOVED
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: content-length:1566
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: cookie:JSESSIONID=REMOVED; isc_cState=ready; GLog=REMOVED
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: connection:keep-alive
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: pragma:no-cache
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - Header Name:Value pair: Cache-Control:no-cache
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - session exists: REMOVED
=== 2015-04-24 17:40:19,249 [c-54] DEBUG LMSIDACall - remote user: csuperuser
=== 2015-04-24 17:40:19,251 [c-54] DEBUG RPCManager - Processing 1 requests.
=== 2015-04-24 17:40:19,251 [c-54] DEBUG RPCManager - Request #1 (DSRequest) payload: {
criteria:{
operator:"equals",
fieldName:"LEAD_ID",
value:85,
_constructor:"AdvancedCriteria"
},
operationConfig:{
dataSource:"V_LEAD_STATUS_HISTORY",
repo:null,
operationType:"fetch",
textMatchStyle:"exact"
},
startRow:0,
endRow:75,
sortBy:[
"-CHANGENUMBER"
],
componentId:"isc_ShowLeadHistoryStatus_1_0",
appID:"builtinApplication",
operation:"V_LEAD_STATUS_HISTORY_fetch",
oldValues:{
operator:"equals",
fieldName:"LEAD_ID",
value:85,
_constructor:"AdvancedCriteria"
}
}
=== 2015-04-24 17:40:19,251 [c-54] INFO LMSIDACall - Performing 1 operation(s)
=== 2015-04-24 17:40:19,770 [c-54] WARN DataSourceDMI - Failed to create serverObject using operation level config. Will try to use DataSource level config instead. Actual error: PermGen space
=== 2015-04-24 17:40:20,161 [c-54] WARN RequestContext - dsRequest.execute() failed:
java.lang.Exception: java.lang.OutOfMemoryError: PermGen space
at com.isomorphic.datasource.DataSourceDMI.execute(DataSourceDMI.java:246)
at com.isomorphic.datasource.DataSourceDMI.execute(DataSourceDMI.java:64)
at com.isomorphic.datasource.DSRequest.execute(DSRequest.java:2544)
at com.isomorphic.servlet.IDACall.handleDSRequest(IDACall.java:220)
at com.lmscompany.lms.server.LMSIDACall.handleDSRequest(LMSIDACall.java:75)
at com.isomorphic.servlet.IDACall.processRPCTransaction(IDACall.java:185)
at com.lmscompany.lms.server.LMSIDACall.processRequest(LMSIDACall.java:40)
at com.isomorphic.servlet.IDACall._processRequest(IDACall.java:117)
at com.isomorphic.servlet.IDACall.doPost(IDACall.java:76)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:646)
at com.isomorphic.servlet.BaseServlet.service(BaseServlet.java:156)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at com.isomorphic.servlet.CompressionFilter._doFilter(CompressionFilter.java:260)
at com.isomorphic.servlet.BaseFilter.doFilter(BaseFilter.java:83)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:610)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:98)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:950)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
at org.apache.coyote.ajp.AjpProcessor.process(AjpProcessor.java:193)
at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:607)
at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:313)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
Caused by: java.lang.OutOfMemoryError: PermGen space
=== 2015-04-24 17:40:20,289 [c-54] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8
=== 2015-04-24 17:40:20,289 [c-54] DEBUG RPCManager - non-DMI response, dropExtraFields: false
=== 2015-04-24 17:40:20,290 [c-54] INFO Compression - /test/lms/sc/IDACall: 177 -> 158 bytes
I restarted Tomcat after noticing, which stopped the exceptions for me. Also, I'm running many instances of the application under different Tomcat server.xml <Host>-tags. It seems, the other hosts were not affected by the error.
I can provide full logs via email, if needed. I don't have any linux memory listings from before the exception but can provide all needed current RAM usage and configurations parameters.
Does this (java.lang.NullPointerException at com.isomorphic.rpc.ExcelDataExport.writeExportObject(ExcelDataExport.java:1313)) look like a possible bug?
Best regards
Blama
Comment