Invalid session ID when generating offline symbol table

Issue #673 resolved
Jarno Goossens created an issue

When I'm generating the offline symbol table I'm always getting an error: "INVALID_SESSION_ID: This session is not valid for use with the API"

Executing code, tests, SOQL, deploying and so on does work.

This is a part of the log:

2017-08-07 10:50:04,988 [ 195352]   INFO - y.ReflectionServiceFactoryBean - Creating Service {urn:partner.soap.sforce.com}PartnerService from class com.sforce.soap.partner.PartnerApi
2017-08-07 10:50:06,980 [ 197344]   INFO - cloud.client.ForceComApiClient - Login successful for connection 'Jarno'.
2017-08-07 10:50:06,980 [ 197344]   INFO - y.ReflectionServiceFactoryBean - Creating Service {urn:partner.soap.sforce.com}PartnerService from class com.sforce.soap.partner.PartnerApi
2017-08-07 10:50:07,157 [ 197521]   INFO - cloud.client.ForceComApiClient - JAXB initialization for com.sforce.soap.partner.SessionHeader took 108ms.
2017-08-07 10:50:07,245 [ 197609]   INFO - cloud.client.ForceComApiClient - JAXB initialization for com.sforce.soap.partner.CallOptions took 88ms.
2017-08-07 10:50:07,247 [ 197611]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading installed package namespaces with 1 steps.
2017-08-07 10:50:07,257 [ 197621]   INFO - y.ReflectionServiceFactoryBean - Creating Service {http://soap.sforce.com/2006/04/metadata}MetadataService from class com.sforce.soap.metadata.MetadataApi
2017-08-07 10:50:09,969 [ 200333]   INFO - cloud.client.ForceComApiClient - JAXB initialization for com.sforce.soap.metadata.SessionHeader took 222ms.
2017-08-07 10:50:10,182 [ 200546]   INFO - cloud.client.ForceComApiClient - JAXB initialization for com.sforce.soap.metadata.CallOptions took 213ms.
2017-08-07 10:50:10,511 [ 200875]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading installed package namespaces in 3264 ms.
2017-08-07 10:50:10,511 [ 200875]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Initializing local symbols with 1 steps.
2017-08-07 10:50:10,663 [ 201027]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Initializing local symbols in 152 ms.
2017-08-07 10:50:10,663 [ 201027]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading system classes with 1 steps.
2017-08-07 10:50:17,016 [ 207380]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading system classes in 6353 ms.
2017-08-07 10:50:17,027 [ 207391]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading system classes with 1 steps.
2017-08-07 10:50:17,086 [ 207450]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading system classes in 59 ms.
2017-08-07 10:50:17,088 [ 207452]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading system classes with 1007 steps.
2017-08-07 10:50:17,151 [ 207515]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__Database.getAsyncLocator.result; using Object.
2017-08-07 10:50:17,151 [ 207515]   INFO - loud.symtab.SystemDeclarations - Ignoring type adjustment for parameter System__Database.update.allOrNothing; adjusted type Boolean is already correct.
2017-08-07 10:50:17,151 [ 207515]   INFO - loud.symtab.SystemDeclarations - Ignoring type adjustment for parameter System__Database.update.allOrNothing; adjusted type Boolean is already correct.
2017-08-07 10:50:17,160 [ 207524]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.beginInvoke.stub; using Object.
2017-08-07 10:50:17,160 [ 207524]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.beginInvoke.request; using Object.
2017-08-07 10:50:17,160 [ 207524]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.beginInvoke.continuation; using Object.
2017-08-07 10:50:17,160 [ 207524]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.endInvoke.future; using Object.
2017-08-07 10:50:17,160 [ 207524]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.invoke.stub; using Object.
2017-08-07 10:50:17,160 [ 207524]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.invoke.request; using Object.
2017-08-07 10:50:17,165 [ 207529]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading system classes in 77 ms.
2017-08-07 10:50:17,170 [ 207534]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading custom classes with 1 steps.
2017-08-07 10:50:17,190 [ 207554]   INFO - y.ReflectionServiceFactoryBean - Creating Service {urn:tooling.soap.sforce.com}ToolingService from class com.sforce.soap.tooling.ToolingApi
2017-08-07 10:50:27,680 [ 218044]   INFO - cloud.client.ForceComApiClient - JAXB initialization for com.sforce.soap.tooling.SessionHeader took 814ms.
2017-08-07 10:50:28,844 [ 219208]   INFO - cloud.client.ForceComApiClient - JAXB initialization for com.sforce.soap.tooling.CallOptions took 1s 164ms.
2017-08-07 10:50:37,668 [ 228032]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading custom classes in 20498 ms.
2017-08-07 10:50:37,670 [ 228034]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading SObject types with 1 steps.
2017-08-07 10:50:38,085 [ 228449]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading SObject types in 415 ms.
2017-08-07 10:50:38,627 [ 228991]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading SObject types with 7 steps.
2017-08-07 10:50:46,204 [ 236568]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading SObject types in 7577 ms.
2017-08-07 10:50:46,212 [ 236576]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading SObject docs with 331 steps.
2017-08-07 10:50:52,798 [ 243162]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading SObject docs in 6586 ms.
2017-08-07 10:50:52,798 [ 243162]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading SObject types with 606 steps.
2017-08-07 10:50:52,923 [ 243287]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading SObject types in 125 ms.
2017-08-07 10:50:52,925 [ 243289]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading class overlays with 8 steps.
2017-08-07 10:50:52,925 [ 243289]   INFO - loud.symtab.OfflineSymbolTable - Querying class summary information
2017-08-07 10:50:53,251 [ 243615]   INFO - loud.symtab.OfflineSymbolTable - Querying class identifiers for Class
2017-08-07 10:50:53,255 [ 243619]   INFO - y.ReflectionServiceFactoryBean - Creating Service {http://soap.sforce.com/2006/08/apex}ApexService from class com.sforce.soap.apex.ApexApi
2017-08-07 10:50:53,337 [ 243701]   INFO - cloud.client.ForceComApiClient - JAXB initialization for com.sforce.soap.apex.SessionHeader took 5ms.
2017-08-07 10:50:53,342 [ 243706]   INFO - cloud.client.ForceComApiClient - JAXB initialization for com.sforce.soap.apex.CallOptions took 5ms.
2017-08-07 10:50:53,586 [ 243950]   WARN - cloud.client.ForceComApiClient - Logout via partner API failed.
javax.xml.ws.soap.SOAPFaultException: INVALID_SESSION_ID: This session is not valid for use with the API
    at org.apache.cxf.jaxws.JaxWsClientProxy.invoke(JaxWsClientProxy.java:161)
    at com.sun.proxy.$Proxy181.logout(Unknown Source)
    at com.illuminatedcloud.client.ForceComApiClient.logout(SourceFile:745)
    at com.illuminatedcloud.client.ForceComApiClient.runWithClient(SourceFile:238)
    at com.illuminatedcloud.client.PartnerQueryResultProcessor.process(SourceFile:38)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$21$2.process(SourceFile:2628)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$21$2.process(SourceFile:2594)
    at com.illuminatedcloud.util.SerialBatchProcessorExecutor.execute(SourceFile:47)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$21.compute(SourceFile:2593)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$21.compute(SourceFile:2543)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$4.compute(SourceFile:654)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.runActivity(SourceFile:622)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.runActivity(SourceFile:649)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.loadApexClassIdentifiers(SourceFile:2542)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.loadClassOverlays(SourceFile:2536)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.applyClassOverlays(SourceFile:2530)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.generateOfflineSymbolTable(SourceFile:794)
    at com.illuminatedcloud.intellij.settings.project.OfflineSymbolTableGenerator$3.run(SourceFile:203)
    at com.intellij.openapi.progress.impl.CoreProgressManager$TaskRunnable.run(CoreProgressManager.java:718)
    at com.intellij.openapi.progress.impl.CoreProgressManager.lambda$runProcess$1(CoreProgressManager.java:170)
    at com.intellij.openapi.progress.impl.CoreProgressManager.registerIndicatorAndRun(CoreProgressManager.java:548)
    at com.intellij.openapi.progress.impl.CoreProgressManager.executeProcessUnderProgress(CoreProgressManager.java:493)
    at com.intellij.openapi.progress.impl.ProgressManagerImpl.executeProcessUnderProgress(ProgressManagerImpl.java:94)
    at com.intellij.openapi.progress.impl.CoreProgressManager.runProcess(CoreProgressManager.java:157)
    at com.intellij.openapi.progress.impl.ProgressManagerImpl$2.run(ProgressManagerImpl.java:165)
    at com.intellij.openapi.application.impl.ApplicationImpl$2.run(ApplicationImpl.java:343)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
Caused by: org.apache.cxf.binding.soap.SoapFault: INVALID_SESSION_ID: This session is not valid for use with the API
    at org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.unmarshalFault(Soap11FaultInInterceptor.java:86)
    at org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:52)
    at org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:41)
    at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
    at org.apache.cxf.interceptor.AbstractFaultChainInitiatorObserver.onMessage(AbstractFaultChainInitiatorObserver.java:112)
    at org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:69)
    at org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:34)
    at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
    at org.apache.cxf.endpoint.ClientImpl.onMessage(ClientImpl.java:798)
    at org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponseInternal(HTTPConduit.java:1670)
    at org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponse(HTTPConduit.java:1551)
    at org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.close(HTTPConduit.java:1348)
    at org.apache.cxf.transport.AbstractConduit.close(AbstractConduit.java:56)
    at org.apache.cxf.transport.http.HTTPConduit.close(HTTPConduit.java:651)
    at org.apache.cxf.interceptor.MessageSenderInterceptor$MessageSenderEndingInterceptor.handleMessage(MessageSenderInterceptor.java:62)
    at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
    at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:514)
    at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:423)
    at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:324)
    at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:277)
    at org.apache.cxf.frontend.ClientProxy.invokeSync(ClientProxy.java:96)
    at org.apache.cxf.jaxws.JaxWsClientProxy.invoke(JaxWsClientProxy.java:139)
    ... 30 more
2017-08-07 10:50:53,588 [ 243952]   INFO - y.ReflectionServiceFactoryBean - Creating Service {urn:partner.soap.sforce.com}PartnerService from class com.sforce.soap.partner.PartnerApi
2017-08-07 10:50:54,032 [ 244396]   INFO - cloud.client.ForceComApiClient - Login successful for connection 'Jarno'.
2017-08-07 10:50:54,033 [ 244397]   INFO - y.ReflectionServiceFactoryBean - Creating Service {urn:partner.soap.sforce.com}PartnerService from class com.sforce.soap.partner.PartnerApi
2017-08-07 10:50:54,069 [ 244433]   INFO - y.ReflectionServiceFactoryBean - Creating Service {http://soap.sforce.com/2006/04/metadata}MetadataService from class com.sforce.soap.metadata.MetadataApi
2017-08-07 10:50:54,090 [ 244454]   INFO - y.ReflectionServiceFactoryBean - Creating Service {http://soap.sforce.com/2006/08/apex}ApexService from class com.sforce.soap.apex.ApexApi
2017-08-07 10:50:54,098 [ 244462]   INFO - y.ReflectionServiceFactoryBean - Creating Service {urn:tooling.soap.sforce.com}ToolingService from class com.sforce.soap.tooling.ToolingApi
2017-08-07 10:50:54,289 [ 244653]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading class overlays in 1364 ms.
2017-08-07 10:50:54,290 [ 244654]   WARN - .IlluminatedCloudExceptionUtil - INVALID_SESSION_ID: This session is not valid for use with the API
javax.xml.ws.soap.SOAPFaultException: INVALID_SESSION_ID: This session is not valid for use with the API
    at org.apache.cxf.jaxws.JaxWsClientProxy.invoke(JaxWsClientProxy.java:161)
    at com.sun.proxy.$Proxy181.query(Unknown Source)
    at com.illuminatedcloud.client.PartnerQueryResultProcessor$1.compute(SourceFile:43)
    at com.illuminatedcloud.client.PartnerQueryResultProcessor$1.compute(SourceFile:39)
    at com.illuminatedcloud.client.ForceComApiClient.runWithClient(SourceFile:246)
    at com.illuminatedcloud.client.PartnerQueryResultProcessor.process(SourceFile:38)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$21$2.process(SourceFile:2628)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$21$2.process(SourceFile:2594)
    at com.illuminatedcloud.util.SerialBatchProcessorExecutor.execute(SourceFile:47)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$21.compute(SourceFile:2593)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$21.compute(SourceFile:2543)
    at com.illuminatedcloud.symtab.OfflineSymbolTable$4.compute(SourceFile:654)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.runActivity(SourceFile:622)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.runActivity(SourceFile:649)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.loadApexClassIdentifiers(SourceFile:2542)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.loadClassOverlays(SourceFile:2536)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.applyClassOverlays(SourceFile:2530)
    at com.illuminatedcloud.symtab.OfflineSymbolTable.generateOfflineSymbolTable(SourceFile:794)
    at com.illuminatedcloud.intellij.settings.project.OfflineSymbolTableGenerator$3.run(SourceFile:203)
    at com.intellij.openapi.progress.impl.CoreProgressManager$TaskRunnable.run(CoreProgressManager.java:718)
    at com.intellij.openapi.progress.impl.CoreProgressManager.lambda$runProcess$1(CoreProgressManager.java:170)
    at com.intellij.openapi.progress.impl.CoreProgressManager.registerIndicatorAndRun(CoreProgressManager.java:548)
    at com.intellij.openapi.progress.impl.CoreProgressManager.executeProcessUnderProgress(CoreProgressManager.java:493)
    at com.intellij.openapi.progress.impl.ProgressManagerImpl.executeProcessUnderProgress(ProgressManagerImpl.java:94)
    at com.intellij.openapi.progress.impl.CoreProgressManager.runProcess(CoreProgressManager.java:157)
    at com.intellij.openapi.progress.impl.ProgressManagerImpl$2.run(ProgressManagerImpl.java:165)
    at com.intellij.openapi.application.impl.ApplicationImpl$2.run(ApplicationImpl.java:343)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    at java.lang.Thread.run(Thread.java:745)
Caused by: org.apache.cxf.binding.soap.SoapFault: INVALID_SESSION_ID: This session is not valid for use with the API
    at org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.unmarshalFault(Soap11FaultInInterceptor.java:86)
    at org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:52)
    at org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:41)
    at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
    at org.apache.cxf.interceptor.AbstractFaultChainInitiatorObserver.onMessage(AbstractFaultChainInitiatorObserver.java:112)
    at org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:69)
    at org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:34)
    at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
    at org.apache.cxf.endpoint.ClientImpl.onMessage(ClientImpl.java:798)
    at org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponseInternal(HTTPConduit.java:1670)
    at org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponse(HTTPConduit.java:1551)
    at org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.close(HTTPConduit.java:1348)
    at org.apache.cxf.transport.AbstractConduit.close(AbstractConduit.java:56)
    at org.apache.cxf.transport.http.HTTPConduit.close(HTTPConduit.java:651)
    at org.apache.cxf.interceptor.MessageSenderInterceptor$MessageSenderEndingInterceptor.handleMessage(MessageSenderInterceptor.java:62)
    at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
    at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:514)
    at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:423)
    at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:324)
    at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:277)
    at org.apache.cxf.frontend.ClientProxy.invokeSync(ClientProxy.java:96)
    at org.apache.cxf.jaxws.JaxWsClientProxy.invoke(JaxWsClientProxy.java:139)
    ... 31 more
2017-08-07 10:51:13,771 [ 264135]   INFO - il.indexing.FileBasedIndexImpl - Rebuild requested for index CaseInsensitiveFilenameIndex
java.lang.Throwable: java.lang.Throwable: Rebuilding CaseInsensitiveFilenameIndex
    at com.intellij.util.indexing.FileBasedIndexImpl.scheduleRebuild(FileBasedIndexImpl.java:1128)
    at com.illuminatedcloud.intellij.index.IlluminatedCloudIndexUtil.rebuildIndices(SourceFile:412)
    at com.illuminatedcloud.intellij.index.IlluminatedCloudIndexUtil.rebuildIndices(SourceFile:315)
    at com.illuminatedcloud.intellij.index.IlluminatedCloudIndexUtil$2.run(SourceFile:473)
    at com.intellij.openapi.application.TransactionGuardImpl$2.run(TransactionGuardImpl.java:314)
    at com.intellij.openapi.application.impl.LaterInvocator$FlushQueue.runNextEvent(LaterInvocator.java:416)
    at com.intellij.openapi.application.impl.LaterInvocator$FlushQueue.run(LaterInvocator.java:399)
    at java.awt.event.InvocationEvent.dispatch(InvocationEvent.java:311)
    at java.awt.EventQueue.dispatchEventImpl(EventQueue.java:762)
    at java.awt.EventQueue.access$500(EventQueue.java:98)
    at java.awt.EventQueue$3.run(EventQueue.java:715)
    at java.awt.EventQueue$3.run(EventQueue.java:709)
    at java.security.AccessController.doPrivileged(Native Method)
    at java.security.ProtectionDomain$JavaSecurityAccessImpl.doIntersectionPrivilege(ProtectionDomain.java:80)
    at java.awt.EventQueue.dispatchEvent(EventQueue.java:732)
    at com.intellij.ide.IdeEventQueue.defaultDispatchEvent(IdeEventQueue.java:821)
    at com.intellij.ide.IdeEventQueue._dispatchEvent(IdeEventQueue.java:649)
    at com.intellij.ide.IdeEventQueue.dispatchEvent(IdeEventQueue.java:365)
    at java.awt.EventDispatchThread.pumpOneEventForFilters(EventDispatchThread.java:201)
    at java.awt.EventDispatchThread.pumpEventsForFilter(EventDispatchThread.java:116)
    at java.awt.EventDispatchThread.pumpEventsForHierarchy(EventDispatchThread.java:105)
    at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:101)
    at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:93)
    at java.awt.EventDispatchThread.run(EventDispatchThread.java:82)
Caused by: java.lang.Throwable: Rebuilding CaseInsensitiveFilenameIndex
    ... 23 more
2017-08-07 10:51:13,776 [ 264140]   INFO - il.indexing.FileBasedIndexImpl - scheduleIndexRebuild, reason: checkRebuild
2017-08-07 10:51:14,278 [ 264642]   INFO - .diagnostic.PerformanceWatcher - Pushing properties took 8ms; general responsiveness: ok; EDT responsiveness: ok
2017-08-07 10:51:14,559 [ 264923]   INFO - .diagnostic.PerformanceWatcher - Indexable file iteration took 259ms; general responsiveness: ok; EDT responsiveness: ok
2017-08-07 10:51:14,563 [ 264927]   INFO - indexing.UnindexedFilesUpdater - Unindexed files update started: 9180 files to update
2017-08-07 10:51:25,946 [ 276310]   INFO - .diagnostic.PerformanceWatcher - Unindexed files update took 11383ms; general responsiveness: ok; EDT responsiveness: ok
2017-08-07 11:27:59,828 [2470192]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading installed package namespaces with 1 steps.
2017-08-07 11:28:00,130 [2470494]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading installed package namespaces in 302 ms.
2017-08-07 11:28:00,130 [2470494]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Initializing local symbols with 1 steps.
2017-08-07 11:28:00,202 [2470566]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Initializing local symbols in 72 ms.
2017-08-07 11:28:00,202 [2470566]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading system classes with 1 steps.
2017-08-07 11:28:06,495 [2476859]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading system classes in 6293 ms. 
2017-08-07 11:28:06,496 [2476860]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading system classes with 1 steps.
2017-08-07 11:28:06,523 [2476887]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading system classes in 27 ms.
2017-08-07 11:28:06,523 [2476887]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading system classes with 1007 steps.
2017-08-07 11:28:06,579 [2476943]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__Database.getAsyncLocator.result; using Object.
2017-08-07 11:28:06,579 [2476943]   INFO - loud.symtab.SystemDeclarations - Ignoring type adjustment for parameter System__Database.update.allOrNothing; adjusted type Boolean is already correct.
2017-08-07 11:28:06,579 [2476943]   INFO - loud.symtab.SystemDeclarations - Ignoring type adjustment for parameter System__Database.update.allOrNothing; adjusted type Boolean is already correct.
2017-08-07 11:28:06,585 [2476949]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.beginInvoke.stub; using Object.
2017-08-07 11:28:06,585 [2476949]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.beginInvoke.request; using Object.
2017-08-07 11:28:06,585 [2476949]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.beginInvoke.continuation; using Object.
2017-08-07 11:28:06,585 [2476949]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.endInvoke.future; using Object.
2017-08-07 11:28:06,585 [2476949]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.invoke.stub; using Object.
2017-08-07 11:28:06,585 [2476949]   WARN - loud.symtab.SystemDeclarations - Failed to find an adjustment for APEX_OBJECT typed parameter System__WebServiceCallout.invoke.request; using Object.
2017-08-07 11:28:06,589 [2476953]   INFO - ct.OfflineSymbolTableGenerator - Completed activity Loading system classes in 66 ms.
2017-08-07 11:28:06,590 [2476954]   INFO - ct.OfflineSymbolTableGenerator - Starting activity Loading custom classes with 1 steps.

Comments (9)

  1. Scott Wells repo owner

    Hi, Jarno. My apologies for the issue. Does this happen consistently? Also, are you using the SFDX pre-release build by chance and if so, is this against a scratch org?

  2. Jarno Goossens reporter

    Hi @RoseSilverSoftware, Sorry I missed your response. It is happening all the time, we are unable to generate offline symbol tables for a couple of months now. It is happening on a regular production organisation and all sandboxes connected to it. It is still working on developer instances.

  3. Scott Wells repo owner

    Oh, I'm sorry to hear that. Then we absolutely need to do something about it! Do you mind trying to generate the OST with a few classes enabled for debug logging so I can get a really verbose log of what's happening? If that's okay, please add the following under Help>Debug Log Settings:

    #com.illuminatedcloud.symtab.OfflineSymbolTable
    #com.illuminatedcloud.client.ForceComApiClient
    

    then generate the OST. Assuming it fails the same way, please zip up all log file under Help>Show Log in Finder/Explorer/Files and email them to be at support@illuminatedcloud.com. I don't need any of the sub-folders from that directory, just the idea.log* files. If I can't figure out what's going on from that, we may need to do a screenshare so we can get to the bottom of this for you. One way or the other we'll get it fixed, though!

  4. Scott Wells repo owner

    I did, Jarno. I apologize but the past two weeks have been insane for me as I've been working against a deadline. I wrapped that up yesterday, though, and will take a look at your logs and follow up with thoughts later today. Sorry for the long delay on the follow-up.

  5. Scott Wells repo owner

    Jarno, I'd sent an email response earlier this week but am not sure if you received it. The main part of it is:

    I can see exactly what you describe in the log, so I'm going to need a more detailed log. Do you mind adding the following to Help>Debug Log Settings:

    #com.illuminatedcloud.client.ForceComApiClient!trace
    

    then clear your existing logs (Help>Show Log in Explorer/Finder/Files and remove all idea.log* files), restart the IDE (required to pick up the log change above), and reproduce issue. Finally zip up all idea.log* files from the log directory and send them to me. That's going to show the actual SOAP messages being sent back and forth so I can see exactly which session IDs are being used when this occurs.

  6. Scott Wells repo owner

    Issue tracker grooming. If this is still an issue, please feel free to reopen, ideally with a concrete reproduction scenario.

  7. Log in to comment