REST: molExport webservice goes into corrupt state

2014-01-20: Edited title to better explain the main issue

We are running Marvin4JS with Chemaxon REST webservices for structure conversion (6.1.3).

At some point, the molExport service fails to convert a structure for a reason or another and then goes into a state where all further requests to molExport fail with an IllegalStateException. At this point, the webservices need to be restarted.

See below for an example log from chemaxon.log.

Thank you,

David

13:48:10.772 [TP-Processor8] INFO  c.j.ws2base.mapping.FieldMapperImpl -
            sum: 394.8 ms
             molExport 394.6 ms 1 OK

13:48:10.782 [TP-Processor8] ERROR c.j.ws2base.util.RestExceptionMapper - java.lang.IllegalStateException: Cannot create record reader for BASE64 encoded
java.lang.Exception: java.lang.IllegalStateException: Cannot create record reader for BASE64 encoded
    at chemaxon.jchem.ws2common.dto.BatchResult.tryGetResult(BatchResult.java:49) ~[webservices-interface-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.webservice2.services.UtilServiceImpl.calculateField(UtilServiceImpl.java:358) ~[UtilServiceImpl.class:na]
    at chemaxon.jchem.webservice2.services.UtilServiceImpl.calculate(UtilServiceImpl.java:316) ~[UtilServiceImpl.class:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_26]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_26]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_26]
    at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
    at com.sun.jersey.spi.container.JavaMethodInvokerFactory$1.invoke(JavaMethodInvokerFactory.java:60) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.model.method.dispatch.AbstractResourceMethodDispatchProvider$ResponseOutInvoker._dispatch(AbstractResourceMethodDispatchProvider.java:205) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.model.method.dispatch.ResourceJavaMethodDispatcher.dispatch(ResourceJavaMethodDispatcher.java:75) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.HttpMethodRule.accept(HttpMethodRule.java:302) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.RightHandPathRule.accept(RightHandPathRule.java:147) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.ResourceClassRule.accept(ResourceClassRule.java:108) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.RightHandPathRule.accept(RightHandPathRule.java:147) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.RootResourceClassesRule.accept(RootResourceClassesRule.java:84) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.application.WebApplicationImpl._handleRequest(WebApplicationImpl.java:1511) [jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.application.WebApplicationImpl._handleRequest(WebApplicationImpl.java:1442) [jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.application.WebApplicationImpl.handleRequest(WebApplicationImpl.java:1391) [jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.application.WebApplicationImpl.handleRequest(WebApplicationImpl.java:1381) [jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.spi.container.servlet.WebComponent.service(WebComponent.java:416) [jersey-servlet-1.17.1.jar:1.17.1]
    at com.sun.jersey.spi.container.servlet.ServletContainer.service(ServletContainer.java:538) [jersey-servlet-1.17.1.jar:1.17.1]
    at com.sun.jersey.spi.container.servlet.ServletContainer.service(ServletContainer.java:716) [jersey-servlet-1.17.1.jar:1.17.1]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) [servlet-api-2.5.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.24.jar:na]
    at chemaxon.jchem.webservice2.util.license.LicensingFilter.doFilter(LicensingFilter.java:43) [LicensingFilter.class:na]
    at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.24.jar:na]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:139) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:54) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.24.jar:na]
    at chemaxon.jchem.webservice2.util.ResponseCachingFilter.doFilter(ResponseCachingFilter.java:25) [ResponseCachingFilter.class:na]
    at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127) [catalina-6.0.24.jar:na]
    at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109) [catalina-6.0.24.jar:na]
    at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298) [catalina-6.0.24.jar:na]
    at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:190) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:291) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:769) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:698) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.jk.common.ChannelSocket$SocketConnection.runIt(ChannelSocket.java:891) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:690) [tomcat-coyote-6.0.24.jar:na]
    at java.lang.Thread.run(Thread.java:662) [na:1.6.0_26]
Caused by: java.lang.IllegalStateException: Cannot create record reader for BASE64 encoded
    at chemaxon.jchem.ws2common.util.ExceptionHandler.asIllegalState(ExceptionHandler.java:22) ~[webservices-interface-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.model.dto.ChMolecule.lazyUpdateMoleculeAndFormat(ChMolecule.java:196) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.model.dto.ChMolecule.getMolecule(ChMolecule.java:109) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.model.dto.ChMolecule.exportToFormat(ChMolecule.java:423) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.calculators.JsonMolExporterCalculator.getMolexporterResult(JsonMolExporterCalculator.java:58) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.calculators.JsonMolExporterCalculator$1.process(JsonMolExporterCalculator.java:46) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.calculators.JsonMolExporterCalculator$1.process(JsonMolExporterCalculator.java:42) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor$1.process(ParallelProcessor.java:49) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor$1.process(ParallelProcessor.java:42) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor$2.call(ParallelProcessor.java:147) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor$2.call(ParallelProcessor.java:144) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303) ~[na:1.6.0_26]
    at java.util.concurrent.FutureTask.run(FutureTask.java:138) ~[na:1.6.0_26]
    at com.google.common.util.concurrent.MoreExecutors$SameThreadExecutorService.execute(MoreExecutors.java:262) ~[guava-13.0.jar:na]
    at com.google.common.util.concurrent.AbstractListeningExecutorService.submit(AbstractListeningExecutorService.java:55) ~[guava-13.0.jar:na]
    at com.google.common.util.concurrent.ForwardingListeningExecutorService.submit(ForwardingListeningExecutorService.java:40) ~[guava-13.0.jar:na]
    at chemaxon.jchem.ws2base.util.ParallelProcessor.submitTasks(ParallelProcessor.java:144) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor.process(ParallelProcessor.java:128) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.FieldMapperImpl$2.call(FieldMapperImpl.java:255) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.FieldMapperImpl$2.call(FieldMapperImpl.java:237) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303) ~[na:1.6.0_26]
    at java.util.concurrent.FutureTask.run(FutureTask.java:138) ~[na:1.6.0_26]
    at com.google.common.util.concurrent.MoreExecutors$SameThreadExecutorService.execute(MoreExecutors.java:262) ~[guava-13.0.jar:na]
    at com.google.common.util.concurrent.AbstractListeningExecutorService.submit(AbstractListeningExecutorService.java:55) ~[guava-13.0.jar:na]
    at com.google.common.util.concurrent.ForwardingListeningExecutorService.submit(ForwardingListeningExecutorService.java:40) ~[guava-13.0.jar:na]
    at chemaxon.jchem.ws2base.util.concurrent.PriorityTaskExecutor.submit(PriorityTaskExecutor.java:128) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.FieldMapperImpl.calculateFields(FieldMapperImpl.java:189) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.FieldMapperImpl.calculateFields(FieldMapperImpl.java:112) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.webservice2.services.UtilServiceImpl.calculateField(UtilServiceImpl.java:349) ~[UtilServiceImpl.class:na]
    ... 70 common frames omitted
Caused by: chemaxon.formats.MolFormatException: Cannot create record reader for BASE64 encoded
    at chemaxon.formats.MFileFormat.createRecordReader(MFileFormat.java:1015) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MFileFormatUtil.createRecordReader(MFileFormatUtil.java:840) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MFileFormatUtil.createRecordReader(MFileFormatUtil.java:799) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.marvin.io.MRecordImporter.<init>(MRecordImporter.java:274) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MolImporter.init(MolImporter.java:517) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MolImporter.<init>(MolImporter.java:187) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MolImporter.importMol(MolImporter.java:1229) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MolImporter.importMol(MolImporter.java:1425) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.jchem.ws2base.model.dto.ChMolecule.lazyUpdateMoleculeAndFormat(ChMolecule.java:184) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    ... 97 common frames omitted
Caused by: chemaxon.formats.MolFormatException: Cannot read molecule file.
    at chemaxon.formats.MolInputStream.init(MolInputStream.java:146) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MolInputStream.<init>(MolInputStream.java:115) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MolInputStream.<init>(MolInputStream.java:72) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.marvin.io.formats.AbstractMRecordReader.<init>(AbstractMRecordReader.java:58) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.marvin.io.formats.base64.Base64RecordReader.<init>(Base64RecordReader.java:45) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[na:1.6.0_26]
    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39) ~[na:1.6.0_26]
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27) ~[na:1.6.0_26]
    at java.lang.reflect.Constructor.newInstance(Constructor.java:513) ~[na:1.6.0_26]
    at chemaxon.formats.MFileFormat.createRecordReader(MFileFormat.java:994) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    ... 105 common frames omitted
Caused by: chemaxon.formats.MolFormatException: Cannot recognize format (?)
Unrecognized file contents:
qнz)�
    at chemaxon.formats.recognizer.RecognitionSubsystem.getFormat(RecognitionSubsystem.java:219) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MolInputStream.initTextFormat(MolInputStream.java:315) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    at chemaxon.formats.MolInputStream.init(MolInputStream.java:135) ~[jchem-6.1.3.jar:6.1.3 2013-10-30]
    ... 114 common frames omitted
13:48:10.787 [TP-Processor8] DEBUG c.j.w.util.RestServiceFilter - 457.4 ms - https://qa.collaborativedrug.com/webservices2/rest-v0/util/calculate/molExport />13:48:50.284 [taskScheduler-1] INFO  c.j.w.util.license.LicenseState - molImport() stats: sum: 578.4ms, count: 5, avg: 115.68ms
13:49:12.811 [TP-Processor8] INFO  c.j.w.util.RestServiceFilter - 67.169.71.105 remaining quota: 100 (164.3 μs)
13:49:12.818 [TP-Processor8] INFO  c.j.ws2base.mapping.FieldMapperImpl -
            sum: 568.1 μs
             molExport 330.0 μs 1 OK

13:49:12.821 [TP-Processor8] ERROR c.j.ws2base.util.RestExceptionMapper - java.lang.IllegalStateException
java.lang.Exception: java.lang.IllegalStateException
    at chemaxon.jchem.ws2common.dto.BatchResult.tryGetResult(BatchResult.java:49) ~[webservices-interface-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.webservice2.services.UtilServiceImpl.calculateField(UtilServiceImpl.java:358) ~[UtilServiceImpl.class:na]
    at chemaxon.jchem.webservice2.services.UtilServiceImpl.calculate(UtilServiceImpl.java:316) ~[UtilServiceImpl.class:na]
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.6.0_26]
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) ~[na:1.6.0_26]
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) ~[na:1.6.0_26]
    at java.lang.reflect.Method.invoke(Method.java:597) ~[na:1.6.0_26]
    at com.sun.jersey.spi.container.JavaMethodInvokerFactory$1.invoke(JavaMethodInvokerFactory.java:60) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.model.method.dispatch.AbstractResourceMethodDispatchProvider$ResponseOutInvoker._dispatch(AbstractResourceMethodDispatchProvider.java:205) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.model.method.dispatch.ResourceJavaMethodDispatcher.dispatch(ResourceJavaMethodDispatcher.java:75) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.HttpMethodRule.accept(HttpMethodRule.java:302) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.RightHandPathRule.accept(RightHandPathRule.java:147) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.ResourceClassRule.accept(ResourceClassRule.java:108) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.RightHandPathRule.accept(RightHandPathRule.java:147) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.uri.rules.RootResourceClassesRule.accept(RootResourceClassesRule.java:84) ~[jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.application.WebApplicationImpl._handleRequest(WebApplicationImpl.java:1511) [jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.application.WebApplicationImpl._handleRequest(WebApplicationImpl.java:1442) [jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.application.WebApplicationImpl.handleRequest(WebApplicationImpl.java:1391) [jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.server.impl.application.WebApplicationImpl.handleRequest(WebApplicationImpl.java:1381) [jersey-server-1.17.1.jar:1.17.1]
    at com.sun.jersey.spi.container.servlet.WebComponent.service(WebComponent.java:416) [jersey-servlet-1.17.1.jar:1.17.1]
    at com.sun.jersey.spi.container.servlet.ServletContainer.service(ServletContainer.java:538) [jersey-servlet-1.17.1.jar:1.17.1]
    at com.sun.jersey.spi.container.servlet.ServletContainer.service(ServletContainer.java:716) [jersey-servlet-1.17.1.jar:1.17.1]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) [servlet-api-2.5.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.24.jar:na]
    at chemaxon.jchem.webservice2.util.license.LicensingFilter.doFilter(LicensingFilter.java:43) [LicensingFilter.class:na]
    at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.24.jar:na]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:139) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:54) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160) [spring-security-web-3.1.4.RELEASE.jar:3.1.4.RELEASE]
    at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.24.jar:na]
    at chemaxon.jchem.webservice2.util.ResponseCachingFilter.doFilter(ResponseCachingFilter.java:25) [ResponseCachingFilter.class:na]
    at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259) [spring-web-3.2.3.RELEASE.jar:3.2.3.RELEASE]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127) [catalina-6.0.24.jar:na]
    at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102) [catalina-6.0.24.jar:na]
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109) [catalina-6.0.24.jar:na]
    at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298) [catalina-6.0.24.jar:na]
    at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:190) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:291) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:769) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:698) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.jk.common.ChannelSocket$SocketConnection.runIt(ChannelSocket.java:891) [tomcat-coyote-6.0.24.jar:na]
    at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:690) [tomcat-coyote-6.0.24.jar:na]
    at java.lang.Thread.run(Thread.java:662) [na:1.6.0_26]
Caused by: java.lang.IllegalStateException: null
    at com.google.common.base.Preconditions.checkState(Preconditions.java:133) ~[guava-13.0.jar:na]
    at com.google.common.base.Stopwatch.start(Stopwatch.java:111) ~[guava-13.0.jar:na]
    at chemaxon.jchem.ws2base.util.GlobalStopWatch.startMeasure(GlobalStopWatch.java:25) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.model.dto.ChMolecule.lazyUpdateMoleculeAndFormat(ChMolecule.java:179) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.model.dto.ChMolecule.getMolecule(ChMolecule.java:109) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.model.dto.ChMolecule.exportToFormat(ChMolecule.java:423) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.calculators.JsonMolExporterCalculator.getMolexporterResult(JsonMolExporterCalculator.java:58) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.calculators.JsonMolExporterCalculator$1.process(JsonMolExporterCalculator.java:46) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.calculators.JsonMolExporterCalculator$1.process(JsonMolExporterCalculator.java:42) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor$1.process(ParallelProcessor.java:49) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor$1.process(ParallelProcessor.java:42) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor$2.call(ParallelProcessor.java:147) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor$2.call(ParallelProcessor.java:144) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303) ~[na:1.6.0_26]
    at java.util.concurrent.FutureTask.run(FutureTask.java:138) ~[na:1.6.0_26]
    at com.google.common.util.concurrent.MoreExecutors$SameThreadExecutorService.execute(MoreExecutors.java:262) ~[guava-13.0.jar:na]
    at com.google.common.util.concurrent.AbstractListeningExecutorService.submit(AbstractListeningExecutorService.java:55) ~[guava-13.0.jar:na]
    at com.google.common.util.concurrent.ForwardingListeningExecutorService.submit(ForwardingListeningExecutorService.java:40) ~[guava-13.0.jar:na]
    at chemaxon.jchem.ws2base.util.ParallelProcessor.submitTasks(ParallelProcessor.java:144) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.util.ParallelProcessor.process(ParallelProcessor.java:128) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.FieldMapperImpl$2.call(FieldMapperImpl.java:255) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.FieldMapperImpl$2.call(FieldMapperImpl.java:237) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303) ~[na:1.6.0_26]
    at java.util.concurrent.FutureTask.run(FutureTask.java:138) ~[na:1.6.0_26]
    at com.google.common.util.concurrent.MoreExecutors$SameThreadExecutorService.execute(MoreExecutors.java:262) ~[guava-13.0.jar:na]
    at com.google.common.util.concurrent.AbstractListeningExecutorService.submit(AbstractListeningExecutorService.java:55) ~[guava-13.0.jar:na]
    at com.google.common.util.concurrent.ForwardingListeningExecutorService.submit(ForwardingListeningExecutorService.java:40) ~[guava-13.0.jar:na]
    at chemaxon.jchem.ws2base.util.concurrent.PriorityTaskExecutor.submit(PriorityTaskExecutor.java:128) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.FieldMapperImpl.calculateFields(FieldMapperImpl.java:189) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.ws2base.mapping.FieldMapperImpl.calculateFields(FieldMapperImpl.java:112) ~[webservices-base-6.1.3-b13.jar:6.1.3-b13]
    at chemaxon.jchem.webservice2.services.UtilServiceImpl.calculateField(UtilServiceImpl.java:349) ~[UtilServiceImpl.class:na]
    ... 70 common frames omitted
13:49:12.822 [TP-Processor8] DEBUG c.j.w.util.RestServiceFilter - 11.18 ms - https://qa.collaborativedrug.com/webservices2/rest-v0/util/calculate/molExport />13:49:19.668 [TP-Processor8] INFO  c.j.w.util.RestServiceFilter - 67.169.71.105 remaining quota: 99 (74.89 μs)
13:49:19.670 [TP-Processor8] INFO  c.j.ws2base.mapping.FieldMapperImpl -
            sum: 552.3 μs
             molExport 313.9 μs 1 OK

13:49:19.673 [TP-Processor8] ERROR c.j.ws2base.util.RestExceptionMapper - java.lang.IllegalStateException

We have been able to consistently reproduce it by starting with the following request to molexport:

{"structure":"\nbenzene","parameters":"mrv"}

This returns

webservices2/rest-v0/util/calculate/molExport

David

I can reproduce the first part of the error, but I don't understand why you start a chemical name with a "\n". This services does an auto format recognition and a chemical name in our interpretation does not start with a new line character in our definition, so it returns an error message.

I was not able to reproduce the IllegalStateException after the call.

Can you observe anything suspicious on thread/memory/CPU load changes, which can be associated with the issue?

We found an issue which can be connected to this problem, but we think it is already corrected in the 6.1.6. Which version do you use?

According to our download log, you have a 6.1.3 version which does not contains this fix. Could you download the latest and verify that it fix your problem.

Hi Gabor,

Thank you for following up.

To answer your first question, yes, the extra "\n" prefix is superfluous and we have implemented code to trim that from user input. At the same time, the goal here was to reproduce the second error and any invalid structure would have worked (I believe something like "caffeïne" for example).

I downloaded 6.1.6 and it indeed does seem to have a fix for the issue. Thank you!

Best,

David