Skip to content

Instantly share code, notes, and snippets.

@hoila

hoila/orbeon_log_digest.txt

Created January 28, 2019 14:36
Show Gist options
  • Save hoila/3ce468a69dc9e7cafc24f92d09e7f39c to your computer and use it in GitHub Desktop.
Save hoila/3ce468a69dc9e7cafc24f92d09e7f39c to your computer and use it in GitHub Desktop.
Download ZIP
orbeon log with DIGEST authentication
Raw
orbeon_log_digest.txt
2019-01-28 10:54:23,056 INFO ProcessorService - Context listener - Context initialized.
2019-01-28 10:54:23,212 INFO form-runner-auth - initializing
2019-01-28 10:54:23,216 INFO form-runner-auth - configuring: FilterSettings(None)
2019-01-28 10:54:23,231 INFO limiter - initializing
2019-01-28 10:54:23,237 INFO limiter - configuring: FilterSettings(java.util.concurrent.Semaphore@7539039a[Permits = 2],(/fr/.*)|(/xforms-server),(?!/([^/]+)/service/).+\.(gif|css|pdf|json|js|coffee|map|png|jpg|xsd|htc|ico|swf|html|htm|txt))
2019-01-28 10:55:03,158 INFO ProcessorService - Servlet initialized.
2019-01-28 10:55:03,207 INFO lifecycle - event: {"request": "1", "source": "limiter", "message": "start: nofilter", "path": "/home/", "method": "GET"}
2019-01-28 10:55:03,273 INFO ProcessorService - Session listener - Session created.
2019-01-28 10:55:03,313 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:55:03,355 INFO lifecycle - event: {"request": "1", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "start: handle"}
2019-01-28 10:55:03,357 INFO ProcessorService - /home/ - Received request
2019-01-28 10:55:07,201 INFO ProcessorService - /home/ - Timing: 3823
2019-01-28 10:55:07,202 INFO lifecycle - event: {"request": "1", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "end: handle", "time": "3,848 ms"}
2019-01-28 10:55:07,205 INFO lifecycle - event: {"request": "1", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "end: nofilter", "time": "4,030 ms"}
2019-01-28 10:55:07,318 INFO lifecycle - event: {"request": "4", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "start: nofilter", "path": "/fr/style/form-runner-bootstrap-override.css", "method": "GET"}
2019-01-28 10:55:07,328 INFO lifecycle - event: {"request": "3", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "start: nofilter", "path": "/fr/style/bootstrap/css/bootstrap.css", "method": "GET"}
2019-01-28 10:55:07,332 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:55:07,333 INFO lifecycle - event: {"request": "3", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "start: handle"}
2019-01-28 10:55:07,333 INFO ProcessorService - /fr/style/bootstrap/css/bootstrap.css - Received request
2019-01-28 10:55:07,327 INFO lifecycle - event: {"request": "2", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "start: nofilter", "path": "/home/home.css", "method": "GET"}
2019-01-28 10:55:07,352 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:55:07,327 INFO lifecycle - event: {"request": "5", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "start: nofilter", "path": "/config/theme/examples.css", "method": "GET"}
2019-01-28 10:55:07,352 INFO lifecycle - event: {"request": "2", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "start: handle"}
2019-01-28 10:55:07,356 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:55:07,327 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:55:07,356 INFO lifecycle - event: {"request": "5", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "start: handle"}
2019-01-28 10:55:07,356 INFO lifecycle - event: {"request": "4", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "start: handle"}
2019-01-28 10:55:07,356 INFO ProcessorService - /fr/style/form-runner-bootstrap-override.css - Received request
2019-01-28 10:55:07,356 INFO ProcessorService - /home/home.css - Received request
2019-01-28 10:55:07,357 INFO lifecycle - event: {"request": "7", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "start: nofilter", "path": "/apps/fr/style/orbeon-navbar-logo.png", "method": "GET"}
2019-01-28 10:55:07,366 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:55:07,367 INFO lifecycle - event: {"request": "7", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "start: handle"}
2019-01-28 10:55:07,367 INFO ProcessorService - /apps/fr/style/orbeon-navbar-logo.png - Received request
2019-01-28 10:55:07,356 INFO ProcessorService - /config/theme/examples.css - Received request
2019-01-28 10:55:07,357 INFO lifecycle - event: {"request": "6", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "start: nofilter", "path": "/home/images/form-builder-small.jpg", "method": "GET"}
2019-01-28 10:55:07,378 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:55:07,378 INFO lifecycle - event: {"request": "6", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "start: handle"}
2019-01-28 10:55:07,378 INFO ProcessorService - /home/images/form-builder-small.jpg - Received request
2019-01-28 10:55:07,594 INFO ProcessorService - /config/theme/examples.css - Timing: 238
2019-01-28 10:55:07,594 INFO lifecycle - event: {"request": "5", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "end: handle", "time": "238 ms"}
2019-01-28 10:55:07,594 INFO lifecycle - event: {"request": "5", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "end: nofilter", "time": "275 ms"}
2019-01-28 10:55:07,595 INFO ProcessorService - /home/home.css - Timing: 239
2019-01-28 10:55:07,596 INFO lifecycle - event: {"request": "2", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "end: handle", "time": "244 ms"}
2019-01-28 10:55:07,597 INFO lifecycle - event: {"request": "2", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "end: nofilter", "time": "282 ms"}
2019-01-28 10:55:07,612 INFO ProcessorService - /apps/fr/style/orbeon-navbar-logo.png - Timing: 244
2019-01-28 10:55:07,612 INFO lifecycle - event: {"request": "7", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "end: handle", "time": "245 ms"}
2019-01-28 10:55:07,632 INFO lifecycle - event: {"request": "7", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "end: nofilter", "time": "274 ms"}
2019-01-28 10:55:07,651 INFO ProcessorService - /fr/style/form-runner-bootstrap-override.css - Timing: 295
2019-01-28 10:55:07,651 INFO ProcessorService - /home/images/form-builder-small.jpg - Timing: 273
2019-01-28 10:55:07,654 INFO ProcessorService - /fr/style/bootstrap/css/bootstrap.css - Timing: 321
2019-01-28 10:55:07,926 ERROR ProcessorService -
+----------------------------------------------------------------------------------------------------------------------+
|An Error has Occurred |
|----------------------------------------------------------------------------------------------------------------------|
|Broken pipe |
|----------------------------------------------------------------------------------------------------------------------|
|Application Call Stack |
|----------------------------------------------------------------------------------------------------------------------|
|oxf:/config/prologue-servlet.xpl |executing processor | 41|
|······················································································································|
|element=<p:processor name="oxf:page-flow">[...]</p:processor> |
|name ={http://www.orbeon.com/oxf/processors}page-flow |
|----------------------------------------------------------------------------------------------------------------------|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: java.io.IOException |
|----------------------------------------------------------------------------------------------------------------------|
|sun.nio.ch.FileDispatcherImpl |write0 |FileDispatcherImpl.java | |
|sun.nio.ch.SocketDispatcher |write |SocketDispatcher.java | 47|
|sun.nio.ch.IOUtil |writeFromNativeBuffer |IOUtil.java | 115|
|sun.nio.ch.IOUtil |write |IOUtil.java | 80|
|sun.nio.ch.IOUtil |write |IOUtil.java | 50|
|sun.nio.ch.SocketChannelImpl |write |SocketChannelImpl.java | 473|
|org.apache.tomcat.util.net.NioChannel |write |NioChannel.java | 134|
|org.apache.tomcat.util.net.NioBlockingSelector |write |NioBlockingSelector.java | 101|
|org.apache.tomcat.util.net.NioSelectorPool |write |NioSelectorPool.java | 157|
|apache.tomcat.util.net.NioEndpoint$NioSocketWrapper|doWrite |NioEndpoint.java |1306|
|org.apache.tomcat.util.net.SocketWrapperBase |doWrite |SocketWrapperBase.java | 726|
|org.apache.tomcat.util.net.SocketWrapperBase |writeBlocking |SocketWrapperBase.java | 496|
|org.apache.tomcat.util.net.SocketWrapperBase |write |SocketWrapperBase.java | 434|
|coyote.http11.Http11OutputBuffer$SocketOutputBuffer|doWrite |Http11OutputBuffer.java | 623|
|rg.apache.coyote.http11.filters.ChunkedOutputFilter|doWrite |ChunkedOutputFilter.java | 123|
|org.apache.coyote.http11.Http11OutputBuffer |doWrite |Http11OutputBuffer.java | 225|
|org.apache.coyote.Response |doWrite |Response.java | 541|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 351|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.apache.catalina.connector.ClientAbortException |
|----------------------------------------------------------------------------------------------------------------------|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 356|
|org.apache.catalina.connector.OutputBuffer |appendByteArray |OutputBuffer.java | 795|
|org.apache.catalina.connector.OutputBuffer |append |OutputBuffer.java | 724|
|org.apache.catalina.connector.OutputBuffer |writeBytes |OutputBuffer.java | 391|
|org.apache.catalina.connector.OutputBuffer |write |OutputBuffer.java | 369|
|org.apache.catalina.connector.CoyoteOutputStream |write |CoyoteOutputStream.java | 96|
|org.orbeon.oxf.util.NetUtils |copyStream |NetUtils.java | 222|
|org.orbeon.oxf.processor.ResourceServer |serveResource |ResourceServer.java | 128|
|xf.controller.PageFlowControllerProcessor$FileRoute|process |PageFlowControllerProcessor.sc| 543|
|g.orbeon.oxf.controller.PageFlowControllerProcessor|start |PageFlowControllerProcessor.sc| 176|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.ValidationException |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.common.OrbeonLocationException$ |wrapException |OrbeonLocationException.scala | 60|
|org.orbeon.oxf.common.OrbeonLocationException |wrapException |OrbeonLocationException.scala | |
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 619|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start |ConcreteChooseProcessor.java | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|org.orbeon.oxf.pipeline.InitUtils$ |runProcessor |InitUtils.scala | 84|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply$mcV$sp |ProcessorService.scala | 47|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEventAssumingRequest |LifecycleLogger.scala | 118|
|org.orbeon.oxf.webapp.ProcessorService |service |ProcessorService.scala | 42|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp |OrbeonServlet.scala | 78|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.webapp.ServletPortlet$ |withRootException |ServletPortlet.scala | 104|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply$mcV$sp |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.util.DynamicVariable |withValue |DynamicVariable.scala | 42|
|org.orbeon.oxf.webapp.ProcessorService$ |withProcessorService |ProcessorService.scala | 146|
|org.orbeon.oxf.servlet.OrbeonServlet |service |OrbeonServlet.scala | 70|
|javax.servlet.http.HttpServlet |service |HttpServlet.java | 742|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 231|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.tomcat.websocket.server.WsFilter |doFilter |WsFilter.java | 52|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.orbeon.oxf.servlet.FormRunnerAuthFilter |doFilter |FormRunnerAuthFilter.scala | 49|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply$mcV$sp |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 91|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 72|
|scala.Option |foreach |Option.scala | 257|
|org.orbeon.oxf.servlet.LimiterFilter |doFilter |LimiterFilter.scala | 72|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.catalina.core.StandardWrapperValve |invoke |StandardWrapperValve.java | 198|
|org.apache.catalina.core.StandardContextValve |invoke |StandardContextValve.java | 96|
|org.apache.catalina.authenticator.AuthenticatorBase|invoke |AuthenticatorBase.java | 610|
|org.apache.catalina.core.StandardHostValve |invoke |StandardHostValve.java | 140|
|org.apache.catalina.valves.ErrorReportValve |invoke |ErrorReportValve.java | 81|
|org.apache.catalina.valves.AbstractAccessLogValve |invoke |AbstractAccessLogValve.java | 650|
|org.apache.catalina.core.StandardEngineValve |invoke |StandardEngineValve.java | 87|
|org.apache.catalina.connector.CoyoteAdapter |service |CoyoteAdapter.java | 342|
|org.apache.coyote.http11.Http11Processor |service |Http11Processor.java | 800|
|org.apache.coyote.AbstractProcessorLight |process |AbstractProcessorLight.java | 66|
|rg.apache.coyote.AbstractProtocol$ConnectionHandler|process |AbstractProtocol.java | 806|
|.apache.tomcat.util.net.NioEndpoint$SocketProcessor|doRun |NioEndpoint.java |1498|
|org.apache.tomcat.util.net.SocketProcessorBase |run |SocketProcessorBase.java | 49|
|java.util.concurrent.ThreadPoolExecutor |runWorker |ThreadPoolExecutor.java |1135|
|java.util.concurrent.ThreadPoolExecutor$Worker |run |ThreadPoolExecutor.java | 635|
|che.tomcat.util.threads.TaskThread$WrappingRunnable|run |TaskThread.java | 61|
|java.lang.Thread |run |Thread.java | 844|
+----------------------------------------------------------------------------------------------------------------------+
2019-01-28 10:55:07,942 INFO lifecycle - event: {"request": "3", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "end: handle", "time": "610 ms"}
2019-01-28 10:55:07,942 INFO lifecycle - event: {"request": "3", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "end: nofilter", "time": "625 ms"}
2019-01-28 10:55:07,944 ERROR ProcessorService -
+----------------------------------------------------------------------------------------------------------------------+
|An Error has Occurred |
|----------------------------------------------------------------------------------------------------------------------|
|Broken pipe |
|----------------------------------------------------------------------------------------------------------------------|
|Application Call Stack |
|----------------------------------------------------------------------------------------------------------------------|
|oxf:/config/prologue-servlet.xpl |executing processor | 41|
|······················································································································|
|element=<p:processor name="oxf:page-flow">[...]</p:processor> |
|name ={http://www.orbeon.com/oxf/processors}page-flow |
|----------------------------------------------------------------------------------------------------------------------|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: java.io.IOException |
|----------------------------------------------------------------------------------------------------------------------|
|sun.nio.ch.FileDispatcherImpl |write0 |FileDispatcherImpl.java | |
|sun.nio.ch.SocketDispatcher |write |SocketDispatcher.java | 47|
|sun.nio.ch.IOUtil |writeFromNativeBuffer |IOUtil.java | 115|
|sun.nio.ch.IOUtil |write |IOUtil.java | 80|
|sun.nio.ch.IOUtil |write |IOUtil.java | 50|
|sun.nio.ch.SocketChannelImpl |write |SocketChannelImpl.java | 473|
|org.apache.tomcat.util.net.NioChannel |write |NioChannel.java | 134|
|org.apache.tomcat.util.net.NioBlockingSelector |write |NioBlockingSelector.java | 101|
|org.apache.tomcat.util.net.NioSelectorPool |write |NioSelectorPool.java | 157|
|apache.tomcat.util.net.NioEndpoint$NioSocketWrapper|doWrite |NioEndpoint.java |1306|
|org.apache.tomcat.util.net.SocketWrapperBase |doWrite |SocketWrapperBase.java | 726|
|org.apache.tomcat.util.net.SocketWrapperBase |writeBlocking |SocketWrapperBase.java | 496|
|org.apache.tomcat.util.net.SocketWrapperBase |write |SocketWrapperBase.java | 434|
|coyote.http11.Http11OutputBuffer$SocketOutputBuffer|doWrite |Http11OutputBuffer.java | 623|
|rg.apache.coyote.http11.filters.ChunkedOutputFilter|doWrite |ChunkedOutputFilter.java | 123|
|org.apache.coyote.http11.Http11OutputBuffer |doWrite |Http11OutputBuffer.java | 225|
|org.apache.coyote.Response |doWrite |Response.java | 541|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 351|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.apache.catalina.connector.ClientAbortException |
|----------------------------------------------------------------------------------------------------------------------|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 356|
|org.apache.catalina.connector.OutputBuffer |appendByteArray |OutputBuffer.java | 795|
|org.apache.catalina.connector.OutputBuffer |append |OutputBuffer.java | 724|
|org.apache.catalina.connector.OutputBuffer |writeBytes |OutputBuffer.java | 391|
|org.apache.catalina.connector.OutputBuffer |write |OutputBuffer.java | 369|
|org.apache.catalina.connector.CoyoteOutputStream |write |CoyoteOutputStream.java | 96|
|org.orbeon.oxf.util.NetUtils |copyStream |NetUtils.java | 222|
|org.orbeon.oxf.processor.ResourceServer |serveResource |ResourceServer.java | 128|
|xf.controller.PageFlowControllerProcessor$FileRoute|process |PageFlowControllerProcessor.sc| 543|
|g.orbeon.oxf.controller.PageFlowControllerProcessor|start |PageFlowControllerProcessor.sc| 176|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.ValidationException |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.common.OrbeonLocationException$ |wrapException |OrbeonLocationException.scala | 60|
|org.orbeon.oxf.common.OrbeonLocationException |wrapException |OrbeonLocationException.scala | |
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 619|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start |ConcreteChooseProcessor.java | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|org.orbeon.oxf.pipeline.InitUtils$ |runProcessor |InitUtils.scala | 84|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply$mcV$sp |ProcessorService.scala | 47|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEventAssumingRequest |LifecycleLogger.scala | 118|
|org.orbeon.oxf.webapp.ProcessorService |service |ProcessorService.scala | 42|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp |OrbeonServlet.scala | 78|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.webapp.ServletPortlet$ |withRootException |ServletPortlet.scala | 104|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply$mcV$sp |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.util.DynamicVariable |withValue |DynamicVariable.scala | 42|
|org.orbeon.oxf.webapp.ProcessorService$ |withProcessorService |ProcessorService.scala | 146|
|org.orbeon.oxf.servlet.OrbeonServlet |service |OrbeonServlet.scala | 70|
|javax.servlet.http.HttpServlet |service |HttpServlet.java | 742|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 231|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.tomcat.websocket.server.WsFilter |doFilter |WsFilter.java | 52|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.orbeon.oxf.servlet.FormRunnerAuthFilter |doFilter |FormRunnerAuthFilter.scala | 49|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply$mcV$sp |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 91|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 72|
|scala.Option |foreach |Option.scala | 257|
|org.orbeon.oxf.servlet.LimiterFilter |doFilter |LimiterFilter.scala | 72|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.catalina.core.StandardWrapperValve |invoke |StandardWrapperValve.java | 198|
|org.apache.catalina.core.StandardContextValve |invoke |StandardContextValve.java | 96|
|org.apache.catalina.authenticator.AuthenticatorBase|invoke |AuthenticatorBase.java | 610|
|org.apache.catalina.core.StandardHostValve |invoke |StandardHostValve.java | 140|
|org.apache.catalina.valves.ErrorReportValve |invoke |ErrorReportValve.java | 81|
|org.apache.catalina.valves.AbstractAccessLogValve |invoke |AbstractAccessLogValve.java | 650|
|org.apache.catalina.core.StandardEngineValve |invoke |StandardEngineValve.java | 87|
|org.apache.catalina.connector.CoyoteAdapter |service |CoyoteAdapter.java | 342|
|org.apache.coyote.http11.Http11Processor |service |Http11Processor.java | 800|
|org.apache.coyote.AbstractProcessorLight |process |AbstractProcessorLight.java | 66|
|rg.apache.coyote.AbstractProtocol$ConnectionHandler|process |AbstractProtocol.java | 806|
|.apache.tomcat.util.net.NioEndpoint$SocketProcessor|doRun |NioEndpoint.java |1498|
|org.apache.tomcat.util.net.SocketProcessorBase |run |SocketProcessorBase.java | 49|
|java.util.concurrent.ThreadPoolExecutor |runWorker |ThreadPoolExecutor.java |1135|
|java.util.concurrent.ThreadPoolExecutor$Worker |run |ThreadPoolExecutor.java | 635|
|che.tomcat.util.threads.TaskThread$WrappingRunnable|run |TaskThread.java | 61|
|java.lang.Thread |run |Thread.java | 844|
+----------------------------------------------------------------------------------------------------------------------+
2019-01-28 10:55:07,950 INFO lifecycle - event: {"request": "4", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "end: handle", "time": "594 ms"}
2019-01-28 10:55:07,951 INFO lifecycle - event: {"request": "4", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "end: nofilter", "time": "632 ms"}
2019-01-28 10:55:07,947 ERROR ProcessorService -
+----------------------------------------------------------------------------------------------------------------------+
|An Error has Occurred |
|----------------------------------------------------------------------------------------------------------------------|
|Broken pipe |
|----------------------------------------------------------------------------------------------------------------------|
|Application Call Stack |
|----------------------------------------------------------------------------------------------------------------------|
|oxf:/config/prologue-servlet.xpl |executing processor | 41|
|······················································································································|
|element=<p:processor name="oxf:page-flow">[...]</p:processor> |
|name ={http://www.orbeon.com/oxf/processors}page-flow |
|----------------------------------------------------------------------------------------------------------------------|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: java.io.IOException |
|----------------------------------------------------------------------------------------------------------------------|
|sun.nio.ch.FileDispatcherImpl |write0 |FileDispatcherImpl.java | |
|sun.nio.ch.SocketDispatcher |write |SocketDispatcher.java | 47|
|sun.nio.ch.IOUtil |writeFromNativeBuffer |IOUtil.java | 115|
|sun.nio.ch.IOUtil |write |IOUtil.java | 80|
|sun.nio.ch.IOUtil |write |IOUtil.java | 50|
|sun.nio.ch.SocketChannelImpl |write |SocketChannelImpl.java | 473|
|org.apache.tomcat.util.net.NioChannel |write |NioChannel.java | 134|
|org.apache.tomcat.util.net.NioBlockingSelector |write |NioBlockingSelector.java | 101|
|org.apache.tomcat.util.net.NioSelectorPool |write |NioSelectorPool.java | 157|
|apache.tomcat.util.net.NioEndpoint$NioSocketWrapper|doWrite |NioEndpoint.java |1306|
|org.apache.tomcat.util.net.SocketWrapperBase |doWrite |SocketWrapperBase.java | 726|
|org.apache.tomcat.util.net.SocketWrapperBase |writeBlocking |SocketWrapperBase.java | 496|
|org.apache.tomcat.util.net.SocketWrapperBase |write |SocketWrapperBase.java | 434|
|coyote.http11.Http11OutputBuffer$SocketOutputBuffer|doWrite |Http11OutputBuffer.java | 623|
|g.apache.coyote.http11.filters.IdentityOutputFilter|doWrite |IdentityOutputFilter.java | 116|
|org.apache.coyote.http11.Http11OutputBuffer |doWrite |Http11OutputBuffer.java | 225|
|org.apache.coyote.Response |doWrite |Response.java | 541|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 351|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.apache.catalina.connector.ClientAbortException |
|----------------------------------------------------------------------------------------------------------------------|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 356|
|org.apache.catalina.connector.OutputBuffer |appendByteArray |OutputBuffer.java | 795|
|org.apache.catalina.connector.OutputBuffer |append |OutputBuffer.java | 724|
|org.apache.catalina.connector.OutputBuffer |writeBytes |OutputBuffer.java | 391|
|org.apache.catalina.connector.OutputBuffer |write |OutputBuffer.java | 369|
|org.apache.catalina.connector.CoyoteOutputStream |write |CoyoteOutputStream.java | 96|
|org.orbeon.oxf.util.NetUtils |copyStream |NetUtils.java | 222|
|org.orbeon.oxf.processor.ResourceServer |serveResource |ResourceServer.java | 128|
|xf.controller.PageFlowControllerProcessor$FileRoute|process |PageFlowControllerProcessor.sc| 543|
|g.orbeon.oxf.controller.PageFlowControllerProcessor|start |PageFlowControllerProcessor.sc| 176|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.ValidationException |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.common.OrbeonLocationException$ |wrapException |OrbeonLocationException.scala | 60|
|org.orbeon.oxf.common.OrbeonLocationException |wrapException |OrbeonLocationException.scala | |
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 619|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start |ConcreteChooseProcessor.java | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|org.orbeon.oxf.pipeline.InitUtils$ |runProcessor |InitUtils.scala | 84|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply$mcV$sp |ProcessorService.scala | 47|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEventAssumingRequest |LifecycleLogger.scala | 118|
|org.orbeon.oxf.webapp.ProcessorService |service |ProcessorService.scala | 42|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp |OrbeonServlet.scala | 78|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.webapp.ServletPortlet$ |withRootException |ServletPortlet.scala | 104|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply$mcV$sp |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.util.DynamicVariable |withValue |DynamicVariable.scala | 42|
|org.orbeon.oxf.webapp.ProcessorService$ |withProcessorService |ProcessorService.scala | 146|
|org.orbeon.oxf.servlet.OrbeonServlet |service |OrbeonServlet.scala | 70|
|javax.servlet.http.HttpServlet |service |HttpServlet.java | 742|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 231|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.tomcat.websocket.server.WsFilter |doFilter |WsFilter.java | 52|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.orbeon.oxf.servlet.FormRunnerAuthFilter |doFilter |FormRunnerAuthFilter.scala | 49|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply$mcV$sp |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 91|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 72|
|scala.Option |foreach |Option.scala | 257|
|org.orbeon.oxf.servlet.LimiterFilter |doFilter |LimiterFilter.scala | 72|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.catalina.core.StandardWrapperValve |invoke |StandardWrapperValve.java | 198|
|org.apache.catalina.core.StandardContextValve |invoke |StandardContextValve.java | 96|
|org.apache.catalina.authenticator.AuthenticatorBase|invoke |AuthenticatorBase.java | 493|
|org.apache.catalina.core.StandardHostValve |invoke |StandardHostValve.java | 140|
|org.apache.catalina.valves.ErrorReportValve |invoke |ErrorReportValve.java | 81|
|org.apache.catalina.valves.AbstractAccessLogValve |invoke |AbstractAccessLogValve.java | 650|
|org.apache.catalina.core.StandardEngineValve |invoke |StandardEngineValve.java | 87|
|org.apache.catalina.connector.CoyoteAdapter |service |CoyoteAdapter.java | 342|
|org.apache.coyote.http11.Http11Processor |service |Http11Processor.java | 800|
|org.apache.coyote.AbstractProcessorLight |process |AbstractProcessorLight.java | 66|
|rg.apache.coyote.AbstractProtocol$ConnectionHandler|process |AbstractProtocol.java | 806|
|.apache.tomcat.util.net.NioEndpoint$SocketProcessor|doRun |NioEndpoint.java |1498|
|org.apache.tomcat.util.net.SocketProcessorBase |run |SocketProcessorBase.java | 49|
|java.util.concurrent.ThreadPoolExecutor |runWorker |ThreadPoolExecutor.java |1135|
|java.util.concurrent.ThreadPoolExecutor$Worker |run |ThreadPoolExecutor.java | 635|
|che.tomcat.util.threads.TaskThread$WrappingRunnable|run |TaskThread.java | 61|
|java.lang.Thread |run |Thread.java | 844|
+----------------------------------------------------------------------------------------------------------------------+
2019-01-28 10:55:07,954 INFO lifecycle - event: {"request": "6", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "service", "message": "end: handle", "time": "575 ms"}
2019-01-28 10:55:07,954 INFO lifecycle - event: {"request": "6", "session": "472FEA86E324FA31C0C53BF6B2520225", "source": "limiter", "message": "end: nofilter", "time": "620 ms"}
2019-01-28 10:55:24,397 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 10:55:24,873 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 10:55:24,874 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 10:55:24,874 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 10:55:24,874 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 10:55:24,874 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 10:55:24,875 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 10:55:24,875 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 10:55:24,875 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 10:56:03,412 INFO lifecycle - event: {"request": "8", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "start: filter", "path": "/fr/orbeon/bookshelf/summary", "method": "GET"}
2019-01-28 10:56:03,414 INFO lifecycle - event: {"request": "8", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "start: chain", "path": "/fr/orbeon/bookshelf/summary", "method": "GET", "wait": "1"}
2019-01-28 10:56:03,593 INFO lifecycle - event: {"request": "8", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle"}
2019-01-28 10:56:03,594 INFO ProcessorService - /fr/orbeon/bookshelf/summary - Received request
2019-01-28 10:56:10,412 WARN Version - Feature is not enabled in this version of the product: cached XForms instance
2019-01-28 10:56:11,930 WARN XFormsServer - unknown id {id: "fb-form-instance"}
2019-01-28 10:56:12,128 WARN Version - Feature is not enabled in this version of the product: xpath-analysis
2019-01-28 10:56:12,607 INFO lifecycle - event: {"request": "8", "session": "C789AD31894728530BDF81F53CA91925", "source": "xforms", "message": "new form session", "uuid": "c279bf8516d193e349dc20b28e0b6d779b798ca3"}
2019-01-28 10:56:13,258 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 10:56:14,291 INFO lifecycle - event: {"request": "9", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle", "path": "/fr/service/i18n/fr-resources/orbeon/bookshelf", "method": "GET"}
2019-01-28 10:56:14,292 INFO ProcessorService - /fr/service/i18n/fr-resources/orbeon/bookshelf - Received request
2019-01-28 10:56:15,289 INFO ProcessorService - /fr/service/i18n/fr-resources/orbeon/bookshelf - Timing: 997
2019-01-28 10:56:15,290 INFO lifecycle - event: {"request": "9", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "1,007 ms"}
2019-01-28 10:56:15,740 INFO lifecycle - event: {"request": "10", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/form/orbeon/bookshelf", "method": "GET"}
2019-01-28 10:56:15,741 INFO ProcessorService - /fr/service/persistence/form/orbeon/bookshelf - Received request
2019-01-28 10:56:15,913 INFO lifecycle - event: {"request": "11", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle", "path": "/fr/service/exist/form/orbeon/bookshelf", "method": "GET"}
2019-01-28 10:56:15,918 INFO ProcessorService - /fr/service/exist/form/orbeon/bookshelf - Received request
2019-01-28 10:56:17,529 INFO EXistServlet - EXistServlet: exist.home=/opt/tomcat-8.5.37_orbeon_digest/webapps/orbeon/WEB-INF/
2019-01-28 10:56:17,530 INFO EXistServlet - reading configuration from /opt/tomcat-8.5.37_orbeon_digest/webapps/orbeon/WEB-INF/exist-conf.xml
2019-01-28 10:56:17,543 INFO Configuration - Reading configuration from file /opt/tomcat-8.5.37_orbeon_digest/webapps/orbeon/WEB-INF/exist-conf.xml
2019-01-28 10:56:18,141 WARN XQueryContext - Configuration problem: failed to load class for module http://exist-db.org/xquery/xqdoc; class: org.exist.xqdoc.xquery.XQDocModule; message: org.exist.xqdoc.xquery.XQDocModule
2019-01-28 10:56:18,141 INFO EXistServlet - configuring eXist instance
2019-01-28 10:56:18,261 INFO SimpleThreadPool - Job execution threads will use class loader of thread: http-nio-8080-exec-8
2019-01-28 10:56:18,302 INFO SchedulerSignalerImpl - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2019-01-28 10:56:18,302 INFO QuartzScheduler - Quartz Scheduler v.1.6.6 created.
2019-01-28 10:56:18,306 INFO RAMJobStore - RAMJobStore initialized.
2019-01-28 10:56:18,306 INFO StdSchedulerFactory - Quartz scheduler 'exist_QuartzScheduler' initialized from an externally provided properties instance.
2019-01-28 10:56:18,309 INFO StdSchedulerFactory - Quartz scheduler version: 1.6.6
2019-01-28 10:56:18,329 INFO DefaultCacheManager - Cache settings: 20,480k; totalPages: 5,120; maxCacheSize: 4,608
2019-01-28 10:56:18,392 INFO XQueryPool - QueryPool: size = 128; maxStackSize = 5; timeout = 120,000; timeoutCheckInterval = 30,000
2019-01-28 10:56:18,583 INFO IndexManager - Registered index org.exist.indexing.ngram.NGramIndex as ngram-index
2019-01-28 10:56:18,795 INFO IndexManager - Registered index org.exist.indexing.lucene.LuceneIndex as lucene-index
2019-01-28 10:56:18,800 INFO IndexManager - Registered index org.exist.fulltext.FTIndex as ft-legacy-index
2019-01-28 10:56:19,239 INFO QuartzScheduler - Scheduler exist_QuartzScheduler_$_NON_CLUSTERED started.
2019-01-28 10:56:19,246 INFO EXistServlet - registering XMLDB driver
2019-01-28 10:56:19,264 INFO EXistServlet - Using default user guest for all unauthorized requests.
2019-01-28 10:56:19,297 WARN XmlLibraryChecker - Looking for a valid Parser...
Checking for Xerces, found version Xerces-J 2.11.0 needed version Xerces-J 2.9.0
Warning: Failed find a valid Parser!
Please add an appropriate Parser to the class-path, e.g. in the 'endorsed' folder of the servlet container or in the 'endorsed' folder of the JRE.
2019-01-28 10:56:19,302 INFO XmlLibraryChecker - Looking for a valid Transformer...
Checking for Saxon, found version 9.1.0.8
OK!
2019-01-28 10:56:19,307 INFO XmlLibraryChecker - Looking for a valid Resolver...
Checking for Resolver, found version XmlResolver 1.2
OK!
2019-01-28 10:56:19,311 INFO XmlLibraryChecker - Using parser org.orbeon.oxf.xml.xerces.XercesSAXParser
2019-01-28 10:56:19,339 INFO XmlLibraryChecker - Using transformer com.sun.org.apache.xalan.internal.xsltc.trax.TransformerImpl
2019-01-28 10:56:19,351 INFO lifecycle - event: {"request": "12", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr", "method": "POST"}
2019-01-28 10:56:19,351 INFO ProcessorService - Session listener - Session created.
2019-01-28 10:56:19,358 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:56:19,360 WARN Descriptor - Giving up unable to read descriptor file from /opt/tomcat-8.5.37_orbeon_digest/webapps/orbeon/WEB-INF/descriptor.xml
2019-01-28 10:56:19,361 WARN Descriptor - Giving up unable to read descriptor.xml file from classloader in package org.exist.http
2019-01-28 10:56:20,284 INFO lifecycle - event: {"request": "12", "session": "7878A946CC748B76F658ED1321F457D4", "source": "limiter", "message": "end: nofilter", "time": "933 ms"}
2019-01-28 10:56:20,650 INFO ProcessorService - /fr/service/exist/form/orbeon/bookshelf - Timing: 4732
2019-01-28 10:56:20,652 INFO lifecycle - event: {"request": "11", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "4,737 ms"}
2019-01-28 10:56:20,706 INFO ProcessorService - /fr/service/persistence/form/orbeon/bookshelf - Timing: 4966
2019-01-28 10:56:20,707 INFO lifecycle - event: {"request": "10", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "4,967 ms"}
2019-01-28 10:56:20,854 INFO lifecycle - event: {"request": "13", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/crud/orbeon/bookshelf/form/form.xhtml", "method": "GET"}
2019-01-28 10:56:20,858 INFO ProcessorService - /fr/service/persistence/crud/orbeon/bookshelf/form/form.xhtml - Received request
2019-01-28 10:56:20,901 INFO lifecycle - event: {"request": "14", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle", "path": "/fr/service/exist/crud/orbeon/bookshelf/form/form.xhtml", "method": "GET"}
2019-01-28 10:56:20,901 INFO ProcessorService - /fr/service/exist/crud/orbeon/bookshelf/form/form.xhtml - Received request
2019-01-28 10:56:21,291 INFO lifecycle - event: {"request": "15", "session": "7878A946CC748B76F658ED1321F457D4", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr/orbeon/bookshelf/form/form.xhtml", "method": "GET"}
2019-01-28 10:56:21,291 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:56:21,424 INFO lifecycle - event: {"request": "15", "session": "7878A946CC748B76F658ED1321F457D4", "source": "limiter", "message": "end: nofilter", "time": "133 ms"}
2019-01-28 10:56:21,426 INFO ProcessorService - /fr/service/exist/crud/orbeon/bookshelf/form/form.xhtml - Timing: 525
2019-01-28 10:56:21,427 INFO lifecycle - event: {"request": "14", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "525 ms"}
2019-01-28 10:56:21,464 INFO ProcessorService - /fr/service/persistence/crud/orbeon/bookshelf/form/form.xhtml - Timing: 608
2019-01-28 10:56:21,465 INFO lifecycle - event: {"request": "13", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "612 ms"}
2019-01-28 10:56:21,816 INFO lifecycle - event: {"request": "16", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/search/orbeon/bookshelf", "method": "POST"}
2019-01-28 10:56:21,817 INFO ProcessorService - /fr/service/persistence/search/orbeon/bookshelf - Received request
2019-01-28 10:56:21,967 INFO lifecycle - event: {"request": "17", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle", "path": "/fr/service/exist/search/orbeon/bookshelf", "method": "POST"}
2019-01-28 10:56:21,967 INFO ProcessorService - /fr/service/exist/search/orbeon/bookshelf - Received request
2019-01-28 10:56:22,498 INFO lifecycle - event: {"request": "18", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/form/orbeon/bookshelf", "method": "GET"}
2019-01-28 10:56:22,498 INFO ProcessorService - /fr/service/persistence/form/orbeon/bookshelf - Received request
2019-01-28 10:56:22,534 INFO lifecycle - event: {"request": "19", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle", "path": "/fr/service/exist/form/orbeon/bookshelf", "method": "GET"}
2019-01-28 10:56:22,534 INFO ProcessorService - /fr/service/exist/form/orbeon/bookshelf - Received request
2019-01-28 10:56:22,674 INFO lifecycle - event: {"request": "20", "session": "7878A946CC748B76F658ED1321F457D4", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr", "method": "POST"}
2019-01-28 10:56:22,675 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:56:22,741 INFO lifecycle - event: {"request": "20", "session": "7878A946CC748B76F658ED1321F457D4", "source": "limiter", "message": "end: nofilter", "time": "68 ms"}
2019-01-28 10:56:22,833 INFO ProcessorService - /fr/service/exist/form/orbeon/bookshelf - Timing: 298
2019-01-28 10:56:22,834 INFO lifecycle - event: {"request": "19", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "303 ms"}
2019-01-28 10:56:22,848 INFO ProcessorService - /fr/service/persistence/form/orbeon/bookshelf - Timing: 350
2019-01-28 10:56:22,849 INFO lifecycle - event: {"request": "18", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "351 ms"}
2019-01-28 10:56:22,910 INFO lifecycle - event: {"request": "21", "session": "7878A946CC748B76F658ED1321F457D4", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr/orbeon/bookshelf/data/", "method": "POST"}
2019-01-28 10:56:22,910 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:56:23,436 INFO lifecycle - event: {"request": "21", "session": "7878A946CC748B76F658ED1321F457D4", "source": "limiter", "message": "end: nofilter", "time": "526 ms"}
2019-01-28 10:56:23,493 INFO ProcessorService - /fr/service/exist/search/orbeon/bookshelf - Timing: 1526
2019-01-28 10:56:23,494 INFO lifecycle - event: {"request": "17", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "1,527 ms"}
2019-01-28 10:56:23,497 INFO ProcessorService - /fr/service/persistence/search/orbeon/bookshelf - Timing: 1679
2019-01-28 10:56:23,498 INFO lifecycle - event: {"request": "16", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "1,681 ms"}
2019-01-28 10:56:23,558 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 10:56:25,542 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-metadata"}
2019-01-28 10:56:25,557 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 10:56:25,990 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 10:56:27,970 INFO lifecycle - event: {"request": "8", "session": "C789AD31894728530BDF81F53CA91925", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "1", "document cache max size": "50"}
2019-01-28 10:56:28,629 INFO lifecycle - event: {"request": "22", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "start: nofilter", "path": "/xforms-server/form/dynamic/c279bf8516d193e349dc20b28e0b6d779b798ca3.js", "method": "GET"}
2019-01-28 10:56:28,630 INFO lifecycle - event: {"request": "22", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle"}
2019-01-28 10:56:28,630 INFO ProcessorService - /xforms-server/form/dynamic/c279bf8516d193e349dc20b28e0b6d779b798ca3.js - Received request
2019-01-28 10:56:28,769 INFO ProcessorService - /fr/orbeon/bookshelf/summary - Timing: 25175
2019-01-28 10:56:28,769 INFO lifecycle - event: {"request": "8", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "25,176 ms"}
2019-01-28 10:56:28,770 INFO lifecycle - event: {"request": "8", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "end: chain", "time": "25,355 ms"}
2019-01-28 10:56:28,785 INFO lifecycle - event: {"request": "8", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "end: filter", "time": "25,359 ms"}
2019-01-28 10:56:28,787 INFO lifecycle - event: {"request": "22", "session": "C789AD31894728530BDF81F53CA91925", "source": "xforms", "message": "before document lock", "uuid": "c279bf8516d193e349dc20b28e0b6d779b798ca3"}
2019-01-28 10:56:28,796 INFO lifecycle - event: {"request": "22", "session": "C789AD31894728530BDF81F53CA91925", "source": "xforms", "message": "got document lock", "path": "/xforms-server/form/dynamic/c279bf8516d193e349dc20b28e0b6d779b798ca3.js", "method": "GET", "uuid": "c279bf8516d193e349dc20b28e0b6d779b798ca3", "wait": "0"}
2019-01-28 10:56:28,811 INFO lifecycle - event: {"request": "22", "session": "C789AD31894728530BDF81F53CA91925", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "1", "document cache max size": "50"}
2019-01-28 10:56:28,832 INFO ProcessorService - /xforms-server/form/dynamic/c279bf8516d193e349dc20b28e0b6d779b798ca3.js - Timing: 202
2019-01-28 10:56:28,832 INFO lifecycle - event: {"request": "22", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "203 ms"}
2019-01-28 10:56:28,832 INFO lifecycle - event: {"request": "22", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "end: nofilter", "time": "204 ms"}
2019-01-28 10:56:28,840 INFO lifecycle - event: {"request": "23", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "start: nofilter", "path": "/apps/fr/style/images/pixelmixer/info_64.png", "method": "GET"}
2019-01-28 10:56:28,841 INFO lifecycle - event: {"request": "23", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle"}
2019-01-28 10:56:28,841 INFO ProcessorService - /apps/fr/style/images/pixelmixer/info_64.png - Received request
2019-01-28 10:56:28,865 INFO lifecycle - event: {"request": "24", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "start: nofilter", "path": "/ops/images/xforms/warning_64.png", "method": "GET"}
2019-01-28 10:56:28,876 INFO lifecycle - event: {"request": "24", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle"}
2019-01-28 10:56:28,876 INFO ProcessorService - /ops/images/xforms/warning_64.png - Received request
2019-01-28 10:56:28,867 INFO lifecycle - event: {"request": "25", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "start: nofilter", "path": "/apps/fr/style/images/pixelmixer/bubble_64.png", "method": "GET"}
2019-01-28 10:56:28,889 INFO ProcessorService - /apps/fr/style/images/pixelmixer/info_64.png - Timing: 35
2019-01-28 10:56:28,890 INFO lifecycle - event: {"request": "23", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "48 ms"}
2019-01-28 10:56:28,890 INFO lifecycle - event: {"request": "23", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "end: nofilter", "time": "50 ms"}
2019-01-28 10:56:28,890 INFO lifecycle - event: {"request": "25", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle"}
2019-01-28 10:56:28,890 INFO ProcessorService - /apps/fr/style/images/pixelmixer/bubble_64.png - Received request
2019-01-28 10:56:28,902 INFO ProcessorService - /ops/images/xforms/warning_64.png - Timing: 26
2019-01-28 10:56:28,910 INFO ProcessorService - /apps/fr/style/images/pixelmixer/bubble_64.png - Timing: 20
2019-01-28 10:56:28,911 INFO lifecycle - event: {"request": "25", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "20 ms"}
2019-01-28 10:56:28,911 INFO lifecycle - event: {"request": "25", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "end: nofilter", "time": "44 ms"}
2019-01-28 10:56:28,912 INFO lifecycle - event: {"request": "24", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "28 ms"}
2019-01-28 10:56:28,912 INFO lifecycle - event: {"request": "24", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "end: nofilter", "time": "47 ms"}
2019-01-28 10:56:29,229 INFO lifecycle - event: {"request": "26", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "start: nofilter", "path": "/ops/yui/assets/skins/sam/sprite.png", "method": "GET"}
2019-01-28 10:56:29,230 INFO lifecycle - event: {"request": "26", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle"}
2019-01-28 10:56:29,230 INFO ProcessorService - /ops/yui/assets/skins/sam/sprite.png - Received request
2019-01-28 10:56:29,233 INFO ProcessorService - /ops/yui/assets/skins/sam/sprite.png - Timing: 3
2019-01-28 10:56:29,244 INFO lifecycle - event: {"request": "26", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "4 ms"}
2019-01-28 10:56:29,245 INFO lifecycle - event: {"request": "26", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "end: nofilter", "time": "17 ms"}
2019-01-28 10:56:29,255 INFO lifecycle - event: {"request": "27", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "start: nofilter", "path": "/apps/fr/style/font-awesome/fonts/fontawesome-webfont.woff2", "method": "GET"}
2019-01-28 10:56:29,256 INFO lifecycle - event: {"request": "27", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "start: handle"}
2019-01-28 10:56:29,256 INFO ProcessorService - /apps/fr/style/font-awesome/fonts/fontawesome-webfont.woff2 - Received request
2019-01-28 10:56:29,269 INFO ProcessorService - /apps/fr/style/font-awesome/fonts/fontawesome-webfont.woff2 - Timing: 13
2019-01-28 10:56:29,279 ERROR ProcessorService -
+----------------------------------------------------------------------------------------------------------------------+
|An Error has Occurred |
|----------------------------------------------------------------------------------------------------------------------|
|Broken pipe |
|----------------------------------------------------------------------------------------------------------------------|
|Application Call Stack |
|----------------------------------------------------------------------------------------------------------------------|
|oxf:/config/prologue-servlet.xpl |executing processor | 41|
|······················································································································|
|element=<p:processor name="oxf:page-flow">[...]</p:processor> |
|name ={http://www.orbeon.com/oxf/processors}page-flow |
|----------------------------------------------------------------------------------------------------------------------|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: java.io.IOException |
|----------------------------------------------------------------------------------------------------------------------|
|sun.nio.ch.FileDispatcherImpl |write0 |FileDispatcherImpl.java | |
|sun.nio.ch.SocketDispatcher |write |SocketDispatcher.java | 47|
|sun.nio.ch.IOUtil |writeFromNativeBuffer |IOUtil.java | 115|
|sun.nio.ch.IOUtil |write |IOUtil.java | 80|
|sun.nio.ch.IOUtil |write |IOUtil.java | 50|
|sun.nio.ch.SocketChannelImpl |write |SocketChannelImpl.java | 473|
|org.apache.tomcat.util.net.NioChannel |write |NioChannel.java | 134|
|org.apache.tomcat.util.net.NioBlockingSelector |write |NioBlockingSelector.java | 101|
|org.apache.tomcat.util.net.NioSelectorPool |write |NioSelectorPool.java | 157|
|apache.tomcat.util.net.NioEndpoint$NioSocketWrapper|doWrite |NioEndpoint.java |1306|
|org.apache.tomcat.util.net.SocketWrapperBase |doWrite |SocketWrapperBase.java | 726|
|org.apache.tomcat.util.net.SocketWrapperBase |writeBlocking |SocketWrapperBase.java | 496|
|org.apache.tomcat.util.net.SocketWrapperBase |write |SocketWrapperBase.java | 434|
|coyote.http11.Http11OutputBuffer$SocketOutputBuffer|doWrite |Http11OutputBuffer.java | 623|
|rg.apache.coyote.http11.filters.ChunkedOutputFilter|doWrite |ChunkedOutputFilter.java | 123|
|org.apache.coyote.http11.Http11OutputBuffer |doWrite |Http11OutputBuffer.java | 225|
|org.apache.coyote.Response |doWrite |Response.java | 541|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 351|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.apache.catalina.connector.ClientAbortException |
|----------------------------------------------------------------------------------------------------------------------|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 356|
|org.apache.catalina.connector.OutputBuffer |flushByteBuffer |OutputBuffer.java | 825|
|org.apache.catalina.connector.OutputBuffer |append |OutputBuffer.java | 730|
|org.apache.catalina.connector.OutputBuffer |writeBytes |OutputBuffer.java | 391|
|org.apache.catalina.connector.OutputBuffer |write |OutputBuffer.java | 369|
|org.apache.catalina.connector.CoyoteOutputStream |write |CoyoteOutputStream.java | 96|
|org.orbeon.oxf.util.NetUtils |copyStream |NetUtils.java | 222|
|org.orbeon.oxf.processor.ResourceServer |serveResource |ResourceServer.java | 128|
|xf.controller.PageFlowControllerProcessor$FileRoute|process |PageFlowControllerProcessor.sc| 543|
|g.orbeon.oxf.controller.PageFlowControllerProcessor|start |PageFlowControllerProcessor.sc| 176|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.ValidationException |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.common.OrbeonLocationException$ |wrapException |OrbeonLocationException.scala | 60|
|org.orbeon.oxf.common.OrbeonLocationException |wrapException |OrbeonLocationException.scala | |
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 619|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start |ConcreteChooseProcessor.java | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|org.orbeon.oxf.pipeline.InitUtils$ |runProcessor |InitUtils.scala | 84|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply$mcV$sp |ProcessorService.scala | 47|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEventAssumingRequest |LifecycleLogger.scala | 118|
|org.orbeon.oxf.webapp.ProcessorService |service |ProcessorService.scala | 42|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp |OrbeonServlet.scala | 78|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.webapp.ServletPortlet$ |withRootException |ServletPortlet.scala | 104|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply$mcV$sp |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.util.DynamicVariable |withValue |DynamicVariable.scala | 42|
|org.orbeon.oxf.webapp.ProcessorService$ |withProcessorService |ProcessorService.scala | 146|
|org.orbeon.oxf.servlet.OrbeonServlet |service |OrbeonServlet.scala | 70|
|javax.servlet.http.HttpServlet |service |HttpServlet.java | 742|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 231|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.tomcat.websocket.server.WsFilter |doFilter |WsFilter.java | 52|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.orbeon.oxf.servlet.FormRunnerAuthFilter |doFilter |FormRunnerAuthFilter.scala | 49|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply$mcV$sp |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 91|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 72|
|scala.Option |foreach |Option.scala | 257|
|org.orbeon.oxf.servlet.LimiterFilter |doFilter |LimiterFilter.scala | 72|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.catalina.core.StandardWrapperValve |invoke |StandardWrapperValve.java | 198|
|org.apache.catalina.core.StandardContextValve |invoke |StandardContextValve.java | 96|
|org.apache.catalina.authenticator.AuthenticatorBase|invoke |AuthenticatorBase.java | 493|
|org.apache.catalina.core.StandardHostValve |invoke |StandardHostValve.java | 140|
|org.apache.catalina.valves.ErrorReportValve |invoke |ErrorReportValve.java | 81|
|org.apache.catalina.valves.AbstractAccessLogValve |invoke |AbstractAccessLogValve.java | 650|
|org.apache.catalina.core.StandardEngineValve |invoke |StandardEngineValve.java | 87|
|org.apache.catalina.connector.CoyoteAdapter |service |CoyoteAdapter.java | 342|
|org.apache.coyote.http11.Http11Processor |service |Http11Processor.java | 800|
|org.apache.coyote.AbstractProcessorLight |process |AbstractProcessorLight.java | 66|
|rg.apache.coyote.AbstractProtocol$ConnectionHandler|process |AbstractProtocol.java | 806|
|.apache.tomcat.util.net.NioEndpoint$SocketProcessor|doRun |NioEndpoint.java |1498|
|org.apache.tomcat.util.net.SocketProcessorBase |run |SocketProcessorBase.java | 49|
|java.util.concurrent.ThreadPoolExecutor |runWorker |ThreadPoolExecutor.java |1135|
|java.util.concurrent.ThreadPoolExecutor$Worker |run |ThreadPoolExecutor.java | 635|
|che.tomcat.util.threads.TaskThread$WrappingRunnable|run |TaskThread.java | 61|
|java.lang.Thread |run |Thread.java | 844|
+----------------------------------------------------------------------------------------------------------------------+
2019-01-28 10:56:29,282 INFO lifecycle - event: {"request": "27", "session": "C789AD31894728530BDF81F53CA91925", "source": "service", "message": "end: handle", "time": "25 ms"}
2019-01-28 10:56:29,282 INFO lifecycle - event: {"request": "27", "session": "C789AD31894728530BDF81F53CA91925", "source": "limiter", "message": "end: nofilter", "time": "27 ms"}
2019-01-28 10:57:00,217 INFO lifecycle - event: {"request": "28", "source": "limiter", "message": "start: nofilter", "path": "/home/", "method": "GET"}
2019-01-28 10:57:00,217 INFO ProcessorService - Session listener - Session created.
2019-01-28 10:57:00,376 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:57:00,379 INFO lifecycle - event: {"request": "28", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "start: handle"}
2019-01-28 10:57:00,379 INFO ProcessorService - /home/ - Received request
2019-01-28 10:57:00,558 INFO ProcessorService - /home/ - Timing: 179
2019-01-28 10:57:00,558 INFO lifecycle - event: {"request": "28", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "end: handle", "time": "181 ms"}
2019-01-28 10:57:00,559 INFO lifecycle - event: {"request": "28", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "limiter", "message": "end: nofilter", "time": "342 ms"}
2019-01-28 10:57:00,756 INFO lifecycle - event: {"request": "29", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "limiter", "message": "start: nofilter", "path": "/fr/style/form-runner-bootstrap-override.css", "method": "GET"}
2019-01-28 10:57:00,757 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:57:00,757 INFO lifecycle - event: {"request": "29", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "start: handle"}
2019-01-28 10:57:00,758 INFO ProcessorService - /fr/style/form-runner-bootstrap-override.css - Received request
2019-01-28 10:57:00,772 INFO lifecycle - event: {"request": "30", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "limiter", "message": "start: nofilter", "path": "/home/images/form-bookshelf-small.jpg", "method": "GET"}
2019-01-28 10:57:00,772 INFO lifecycle - event: {"request": "31", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "limiter", "message": "start: nofilter", "path": "/home/images/fr-home-small.jpg", "method": "GET"}
2019-01-28 10:57:00,772 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:57:00,772 INFO lifecycle - event: {"request": "30", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "start: handle"}
2019-01-28 10:57:00,773 INFO ProcessorService - /home/images/form-bookshelf-small.jpg - Received request
2019-01-28 10:57:00,774 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:57:00,782 INFO lifecycle - event: {"request": "32", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "limiter", "message": "start: nofilter", "path": "/home/images/form-w9-small.jpg", "method": "GET"}
2019-01-28 10:57:00,782 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 10:57:00,784 INFO lifecycle - event: {"request": "32", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "start: handle"}
2019-01-28 10:57:00,784 INFO ProcessorService - /home/images/form-w9-small.jpg - Received request
2019-01-28 10:57:00,782 INFO lifecycle - event: {"request": "31", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "start: handle"}
2019-01-28 10:57:00,787 INFO ProcessorService - /home/images/fr-home-small.jpg - Received request
2019-01-28 10:57:00,803 INFO ProcessorService - /home/images/form-w9-small.jpg - Timing: 19
2019-01-28 10:57:00,803 INFO ProcessorService - /home/images/fr-home-small.jpg - Timing: 16
2019-01-28 10:57:00,836 INFO ProcessorService - /home/images/form-bookshelf-small.jpg - Timing: 63
2019-01-28 10:57:00,871 ERROR ProcessorService -
+----------------------------------------------------------------------------------------------------------------------+
|An Error has Occurred |
|----------------------------------------------------------------------------------------------------------------------|
|Broken pipe |
|----------------------------------------------------------------------------------------------------------------------|
|Application Call Stack |
|----------------------------------------------------------------------------------------------------------------------|
|oxf:/config/prologue-servlet.xpl |executing processor | 41|
|······················································································································|
|element=<p:processor name="oxf:page-flow">[...]</p:processor> |
|name ={http://www.orbeon.com/oxf/processors}page-flow |
|----------------------------------------------------------------------------------------------------------------------|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: java.io.IOException |
|----------------------------------------------------------------------------------------------------------------------|
|sun.nio.ch.FileDispatcherImpl |write0 |FileDispatcherImpl.java | |
|sun.nio.ch.SocketDispatcher |write |SocketDispatcher.java | 47|
|sun.nio.ch.IOUtil |writeFromNativeBuffer |IOUtil.java | 115|
|sun.nio.ch.IOUtil |write |IOUtil.java | 80|
|sun.nio.ch.IOUtil |write |IOUtil.java | 50|
|sun.nio.ch.SocketChannelImpl |write |SocketChannelImpl.java | 473|
|org.apache.tomcat.util.net.NioChannel |write |NioChannel.java | 134|
|org.apache.tomcat.util.net.NioBlockingSelector |write |NioBlockingSelector.java | 101|
|org.apache.tomcat.util.net.NioSelectorPool |write |NioSelectorPool.java | 157|
|apache.tomcat.util.net.NioEndpoint$NioSocketWrapper|doWrite |NioEndpoint.java |1306|
|org.apache.tomcat.util.net.SocketWrapperBase |doWrite |SocketWrapperBase.java | 726|
|org.apache.tomcat.util.net.SocketWrapperBase |writeBlocking |SocketWrapperBase.java | 496|
|org.apache.tomcat.util.net.SocketWrapperBase |write |SocketWrapperBase.java | 434|
|coyote.http11.Http11OutputBuffer$SocketOutputBuffer|doWrite |Http11OutputBuffer.java | 623|
|g.apache.coyote.http11.filters.IdentityOutputFilter|doWrite |IdentityOutputFilter.java | 116|
|org.apache.coyote.http11.Http11OutputBuffer |doWrite |Http11OutputBuffer.java | 225|
|org.apache.coyote.Response |doWrite |Response.java | 541|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 351|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.apache.catalina.connector.ClientAbortException |
|----------------------------------------------------------------------------------------------------------------------|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 356|
|org.apache.catalina.connector.OutputBuffer |appendByteArray |OutputBuffer.java | 795|
|org.apache.catalina.connector.OutputBuffer |append |OutputBuffer.java | 724|
|org.apache.catalina.connector.OutputBuffer |writeBytes |OutputBuffer.java | 391|
|org.apache.catalina.connector.OutputBuffer |write |OutputBuffer.java | 369|
|org.apache.catalina.connector.CoyoteOutputStream |write |CoyoteOutputStream.java | 96|
|org.orbeon.oxf.util.NetUtils |copyStream |NetUtils.java | 222|
|org.orbeon.oxf.processor.ResourceServer |serveResource |ResourceServer.java | 128|
|xf.controller.PageFlowControllerProcessor$FileRoute|process |PageFlowControllerProcessor.sc| 543|
|g.orbeon.oxf.controller.PageFlowControllerProcessor|start |PageFlowControllerProcessor.sc| 176|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.ValidationException |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.common.OrbeonLocationException$ |wrapException |OrbeonLocationException.scala | 60|
|org.orbeon.oxf.common.OrbeonLocationException |wrapException |OrbeonLocationException.scala | |
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 619|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start |ConcreteChooseProcessor.java | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|org.orbeon.oxf.pipeline.InitUtils$ |runProcessor |InitUtils.scala | 84|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply$mcV$sp |ProcessorService.scala | 47|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEventAssumingRequest |LifecycleLogger.scala | 118|
|org.orbeon.oxf.webapp.ProcessorService |service |ProcessorService.scala | 42|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp |OrbeonServlet.scala | 78|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.webapp.ServletPortlet$ |withRootException |ServletPortlet.scala | 104|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply$mcV$sp |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.util.DynamicVariable |withValue |DynamicVariable.scala | 42|
|org.orbeon.oxf.webapp.ProcessorService$ |withProcessorService |ProcessorService.scala | 146|
|org.orbeon.oxf.servlet.OrbeonServlet |service |OrbeonServlet.scala | 70|
|javax.servlet.http.HttpServlet |service |HttpServlet.java | 742|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 231|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.tomcat.websocket.server.WsFilter |doFilter |WsFilter.java | 52|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.orbeon.oxf.servlet.FormRunnerAuthFilter |doFilter |FormRunnerAuthFilter.scala | 49|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply$mcV$sp |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 91|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 72|
|scala.Option |foreach |Option.scala | 257|
|org.orbeon.oxf.servlet.LimiterFilter |doFilter |LimiterFilter.scala | 72|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.catalina.core.StandardWrapperValve |invoke |StandardWrapperValve.java | 198|
|org.apache.catalina.core.StandardContextValve |invoke |StandardContextValve.java | 96|
|org.apache.catalina.authenticator.AuthenticatorBase|invoke |AuthenticatorBase.java | 493|
|org.apache.catalina.core.StandardHostValve |invoke |StandardHostValve.java | 140|
|org.apache.catalina.valves.ErrorReportValve |invoke |ErrorReportValve.java | 81|
|org.apache.catalina.valves.AbstractAccessLogValve |invoke |AbstractAccessLogValve.java | 650|
|org.apache.catalina.core.StandardEngineValve |invoke |StandardEngineValve.java | 87|
|org.apache.catalina.connector.CoyoteAdapter |service |CoyoteAdapter.java | 342|
|org.apache.coyote.http11.Http11Processor |service |Http11Processor.java | 800|
|org.apache.coyote.AbstractProcessorLight |process |AbstractProcessorLight.java | 66|
|rg.apache.coyote.AbstractProtocol$ConnectionHandler|process |AbstractProtocol.java | 806|
|.apache.tomcat.util.net.NioEndpoint$SocketProcessor|doRun |NioEndpoint.java |1498|
|org.apache.tomcat.util.net.SocketProcessorBase |run |SocketProcessorBase.java | 49|
|java.util.concurrent.ThreadPoolExecutor |runWorker |ThreadPoolExecutor.java |1135|
|java.util.concurrent.ThreadPoolExecutor$Worker |run |ThreadPoolExecutor.java | 635|
|che.tomcat.util.threads.TaskThread$WrappingRunnable|run |TaskThread.java | 61|
|java.lang.Thread |run |Thread.java | 844|
+----------------------------------------------------------------------------------------------------------------------+
2019-01-28 10:57:00,872 INFO lifecycle - event: {"request": "31", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "end: handle", "time": "98 ms"}
2019-01-28 10:57:00,872 INFO lifecycle - event: {"request": "31", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "limiter", "message": "end: nofilter", "time": "100 ms"}
2019-01-28 10:57:00,877 INFO ProcessorService - /fr/style/form-runner-bootstrap-override.css - Timing: 118
2019-01-28 10:57:00,890 ERROR ProcessorService -
+----------------------------------------------------------------------------------------------------------------------+
|An Error has Occurred |
|----------------------------------------------------------------------------------------------------------------------|
|Broken pipe |
|----------------------------------------------------------------------------------------------------------------------|
|Application Call Stack |
|----------------------------------------------------------------------------------------------------------------------|
|oxf:/config/prologue-servlet.xpl |executing processor | 41|
|······················································································································|
|element=<p:processor name="oxf:page-flow">[...]</p:processor> |
|name ={http://www.orbeon.com/oxf/processors}page-flow |
|----------------------------------------------------------------------------------------------------------------------|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: java.io.IOException |
|----------------------------------------------------------------------------------------------------------------------|
|sun.nio.ch.FileDispatcherImpl |write0 |FileDispatcherImpl.java | |
|sun.nio.ch.SocketDispatcher |write |SocketDispatcher.java | 47|
|sun.nio.ch.IOUtil |writeFromNativeBuffer |IOUtil.java | 115|
|sun.nio.ch.IOUtil |write |IOUtil.java | 80|
|sun.nio.ch.IOUtil |write |IOUtil.java | 50|
|sun.nio.ch.SocketChannelImpl |write |SocketChannelImpl.java | 473|
|org.apache.tomcat.util.net.NioChannel |write |NioChannel.java | 134|
|org.apache.tomcat.util.net.NioBlockingSelector |write |NioBlockingSelector.java | 101|
|org.apache.tomcat.util.net.NioSelectorPool |write |NioSelectorPool.java | 157|
|apache.tomcat.util.net.NioEndpoint$NioSocketWrapper|doWrite |NioEndpoint.java |1306|
|org.apache.tomcat.util.net.SocketWrapperBase |doWrite |SocketWrapperBase.java | 726|
|org.apache.tomcat.util.net.SocketWrapperBase |writeBlocking |SocketWrapperBase.java | 496|
|org.apache.tomcat.util.net.SocketWrapperBase |write |SocketWrapperBase.java | 434|
|coyote.http11.Http11OutputBuffer$SocketOutputBuffer|doWrite |Http11OutputBuffer.java | 623|
|g.apache.coyote.http11.filters.IdentityOutputFilter|doWrite |IdentityOutputFilter.java | 116|
|org.apache.coyote.http11.Http11OutputBuffer |doWrite |Http11OutputBuffer.java | 225|
|org.apache.coyote.Response |doWrite |Response.java | 541|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 351|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.apache.catalina.connector.ClientAbortException |
|----------------------------------------------------------------------------------------------------------------------|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 356|
|org.apache.catalina.connector.OutputBuffer |appendByteArray |OutputBuffer.java | 795|
|org.apache.catalina.connector.OutputBuffer |append |OutputBuffer.java | 724|
|org.apache.catalina.connector.OutputBuffer |writeBytes |OutputBuffer.java | 391|
|org.apache.catalina.connector.OutputBuffer |write |OutputBuffer.java | 369|
|org.apache.catalina.connector.CoyoteOutputStream |write |CoyoteOutputStream.java | 96|
|org.orbeon.oxf.util.NetUtils |copyStream |NetUtils.java | 222|
|org.orbeon.oxf.processor.ResourceServer |serveResource |ResourceServer.java | 128|
|xf.controller.PageFlowControllerProcessor$FileRoute|process |PageFlowControllerProcessor.sc| 543|
|g.orbeon.oxf.controller.PageFlowControllerProcessor|start |PageFlowControllerProcessor.sc| 176|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.ValidationException |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.common.OrbeonLocationException$ |wrapException |OrbeonLocationException.scala | 60|
|org.orbeon.oxf.common.OrbeonLocationException |wrapException |OrbeonLocationException.scala | |
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 619|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start |ConcreteChooseProcessor.java | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|org.orbeon.oxf.pipeline.InitUtils$ |runProcessor |InitUtils.scala | 84|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply$mcV$sp |ProcessorService.scala | 47|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEventAssumingRequest |LifecycleLogger.scala | 118|
|org.orbeon.oxf.webapp.ProcessorService |service |ProcessorService.scala | 42|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp |OrbeonServlet.scala | 78|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.webapp.ServletPortlet$ |withRootException |ServletPortlet.scala | 104|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply$mcV$sp |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.util.DynamicVariable |withValue |DynamicVariable.scala | 42|
|org.orbeon.oxf.webapp.ProcessorService$ |withProcessorService |ProcessorService.scala | 146|
|org.orbeon.oxf.servlet.OrbeonServlet |service |OrbeonServlet.scala | 70|
|javax.servlet.http.HttpServlet |service |HttpServlet.java | 742|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 231|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.tomcat.websocket.server.WsFilter |doFilter |WsFilter.java | 52|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.orbeon.oxf.servlet.FormRunnerAuthFilter |doFilter |FormRunnerAuthFilter.scala | 49|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply$mcV$sp |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 91|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 72|
|scala.Option |foreach |Option.scala | 257|
|org.orbeon.oxf.servlet.LimiterFilter |doFilter |LimiterFilter.scala | 72|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.catalina.core.StandardWrapperValve |invoke |StandardWrapperValve.java | 198|
|org.apache.catalina.core.StandardContextValve |invoke |StandardContextValve.java | 96|
|org.apache.catalina.authenticator.AuthenticatorBase|invoke |AuthenticatorBase.java | 493|
|org.apache.catalina.core.StandardHostValve |invoke |StandardHostValve.java | 140|
|org.apache.catalina.valves.ErrorReportValve |invoke |ErrorReportValve.java | 81|
|org.apache.catalina.valves.AbstractAccessLogValve |invoke |AbstractAccessLogValve.java | 650|
|org.apache.catalina.core.StandardEngineValve |invoke |StandardEngineValve.java | 87|
|org.apache.catalina.connector.CoyoteAdapter |service |CoyoteAdapter.java | 342|
|org.apache.coyote.http11.Http11Processor |service |Http11Processor.java | 800|
|org.apache.coyote.AbstractProcessorLight |process |AbstractProcessorLight.java | 66|
|rg.apache.coyote.AbstractProtocol$ConnectionHandler|process |AbstractProtocol.java | 806|
|.apache.tomcat.util.net.NioEndpoint$SocketProcessor|doRun |NioEndpoint.java |1498|
|org.apache.tomcat.util.net.SocketProcessorBase |run |SocketProcessorBase.java | 49|
|java.util.concurrent.ThreadPoolExecutor |runWorker |ThreadPoolExecutor.java |1135|
|java.util.concurrent.ThreadPoolExecutor$Worker |run |ThreadPoolExecutor.java | 635|
|che.tomcat.util.threads.TaskThread$WrappingRunnable|run |TaskThread.java | 61|
|java.lang.Thread |run |Thread.java | 844|
+----------------------------------------------------------------------------------------------------------------------+
2019-01-28 10:57:00,891 INFO lifecycle - event: {"request": "30", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "end: handle", "time": "118 ms"}
2019-01-28 10:57:00,891 INFO lifecycle - event: {"request": "30", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "limiter", "message": "end: nofilter", "time": "119 ms"}
2019-01-28 10:57:00,897 ERROR ProcessorService -
+----------------------------------------------------------------------------------------------------------------------+
|An Error has Occurred |
|----------------------------------------------------------------------------------------------------------------------|
|Broken pipe |
|----------------------------------------------------------------------------------------------------------------------|
|Application Call Stack |
|----------------------------------------------------------------------------------------------------------------------|
|oxf:/config/prologue-servlet.xpl |executing processor | 41|
|······················································································································|
|element=<p:processor name="oxf:page-flow">[...]</p:processor> |
|name ={http://www.orbeon.com/oxf/processors}page-flow |
|----------------------------------------------------------------------------------------------------------------------|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: java.io.IOException |
|----------------------------------------------------------------------------------------------------------------------|
|sun.nio.ch.FileDispatcherImpl |write0 |FileDispatcherImpl.java | |
|sun.nio.ch.SocketDispatcher |write |SocketDispatcher.java | 47|
|sun.nio.ch.IOUtil |writeFromNativeBuffer |IOUtil.java | 115|
|sun.nio.ch.IOUtil |write |IOUtil.java | 80|
|sun.nio.ch.IOUtil |write |IOUtil.java | 50|
|sun.nio.ch.SocketChannelImpl |write |SocketChannelImpl.java | 473|
|org.apache.tomcat.util.net.NioChannel |write |NioChannel.java | 134|
|org.apache.tomcat.util.net.NioBlockingSelector |write |NioBlockingSelector.java | 101|
|org.apache.tomcat.util.net.NioSelectorPool |write |NioSelectorPool.java | 157|
|apache.tomcat.util.net.NioEndpoint$NioSocketWrapper|doWrite |NioEndpoint.java |1306|
|org.apache.tomcat.util.net.SocketWrapperBase |doWrite |SocketWrapperBase.java | 726|
|org.apache.tomcat.util.net.SocketWrapperBase |writeBlocking |SocketWrapperBase.java | 496|
|org.apache.tomcat.util.net.SocketWrapperBase |write |SocketWrapperBase.java | 434|
|coyote.http11.Http11OutputBuffer$SocketOutputBuffer|doWrite |Http11OutputBuffer.java | 623|
|g.apache.coyote.http11.filters.IdentityOutputFilter|doWrite |IdentityOutputFilter.java | 116|
|org.apache.coyote.http11.Http11OutputBuffer |doWrite |Http11OutputBuffer.java | 225|
|org.apache.coyote.Response |doWrite |Response.java | 541|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 351|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.apache.catalina.connector.ClientAbortException |
|----------------------------------------------------------------------------------------------------------------------|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 356|
|org.apache.catalina.connector.OutputBuffer |appendByteArray |OutputBuffer.java | 795|
|org.apache.catalina.connector.OutputBuffer |append |OutputBuffer.java | 724|
|org.apache.catalina.connector.OutputBuffer |writeBytes |OutputBuffer.java | 391|
|org.apache.catalina.connector.OutputBuffer |write |OutputBuffer.java | 369|
|org.apache.catalina.connector.CoyoteOutputStream |write |CoyoteOutputStream.java | 96|
|org.orbeon.oxf.util.NetUtils |copyStream |NetUtils.java | 222|
|org.orbeon.oxf.processor.ResourceServer |serveResource |ResourceServer.java | 128|
|xf.controller.PageFlowControllerProcessor$FileRoute|process |PageFlowControllerProcessor.sc| 543|
|g.orbeon.oxf.controller.PageFlowControllerProcessor|start |PageFlowControllerProcessor.sc| 176|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.ValidationException |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.common.OrbeonLocationException$ |wrapException |OrbeonLocationException.scala | 60|
|org.orbeon.oxf.common.OrbeonLocationException |wrapException |OrbeonLocationException.scala | |
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 619|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start |ConcreteChooseProcessor.java | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|org.orbeon.oxf.pipeline.InitUtils$ |runProcessor |InitUtils.scala | 84|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply$mcV$sp |ProcessorService.scala | 47|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEventAssumingRequest |LifecycleLogger.scala | 118|
|org.orbeon.oxf.webapp.ProcessorService |service |ProcessorService.scala | 42|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp |OrbeonServlet.scala | 78|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.webapp.ServletPortlet$ |withRootException |ServletPortlet.scala | 104|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply$mcV$sp |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.util.DynamicVariable |withValue |DynamicVariable.scala | 42|
|org.orbeon.oxf.webapp.ProcessorService$ |withProcessorService |ProcessorService.scala | 146|
|org.orbeon.oxf.servlet.OrbeonServlet |service |OrbeonServlet.scala | 70|
|javax.servlet.http.HttpServlet |service |HttpServlet.java | 742|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 231|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.tomcat.websocket.server.WsFilter |doFilter |WsFilter.java | 52|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.orbeon.oxf.servlet.FormRunnerAuthFilter |doFilter |FormRunnerAuthFilter.scala | 49|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply$mcV$sp |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 91|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 72|
|scala.Option |foreach |Option.scala | 257|
|org.orbeon.oxf.servlet.LimiterFilter |doFilter |LimiterFilter.scala | 72|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.catalina.core.StandardWrapperValve |invoke |StandardWrapperValve.java | 198|
|org.apache.catalina.core.StandardContextValve |invoke |StandardContextValve.java | 96|
|org.apache.catalina.authenticator.AuthenticatorBase|invoke |AuthenticatorBase.java | 493|
|org.apache.catalina.core.StandardHostValve |invoke |StandardHostValve.java | 140|
|org.apache.catalina.valves.ErrorReportValve |invoke |ErrorReportValve.java | 81|
|org.apache.catalina.valves.AbstractAccessLogValve |invoke |AbstractAccessLogValve.java | 650|
|org.apache.catalina.core.StandardEngineValve |invoke |StandardEngineValve.java | 87|
|org.apache.catalina.connector.CoyoteAdapter |service |CoyoteAdapter.java | 342|
|org.apache.coyote.http11.Http11Processor |service |Http11Processor.java | 800|
|org.apache.coyote.AbstractProcessorLight |process |AbstractProcessorLight.java | 66|
|rg.apache.coyote.AbstractProtocol$ConnectionHandler|process |AbstractProtocol.java | 806|
|.apache.tomcat.util.net.NioEndpoint$SocketProcessor|doRun |NioEndpoint.java |1498|
|org.apache.tomcat.util.net.SocketProcessorBase |run |SocketProcessorBase.java | 49|
|java.util.concurrent.ThreadPoolExecutor |runWorker |ThreadPoolExecutor.java |1135|
|java.util.concurrent.ThreadPoolExecutor$Worker |run |ThreadPoolExecutor.java | 635|
|che.tomcat.util.threads.TaskThread$WrappingRunnable|run |TaskThread.java | 61|
|java.lang.Thread |run |Thread.java | 844|
+----------------------------------------------------------------------------------------------------------------------+
2019-01-28 10:57:00,898 INFO lifecycle - event: {"request": "32", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "end: handle", "time": "115 ms"}
2019-01-28 10:57:00,899 INFO lifecycle - event: {"request": "32", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "limiter", "message": "end: nofilter", "time": "117 ms"}
2019-01-28 10:57:00,906 ERROR ProcessorService -
+----------------------------------------------------------------------------------------------------------------------+
|An Error has Occurred |
|----------------------------------------------------------------------------------------------------------------------|
|Broken pipe |
|----------------------------------------------------------------------------------------------------------------------|
|Application Call Stack |
|----------------------------------------------------------------------------------------------------------------------|
|oxf:/config/prologue-servlet.xpl |executing processor | 41|
|······················································································································|
|element=<p:processor name="oxf:page-flow">[...]</p:processor> |
|name ={http://www.orbeon.com/oxf/processors}page-flow |
|----------------------------------------------------------------------------------------------------------------------|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: java.io.IOException |
|----------------------------------------------------------------------------------------------------------------------|
|sun.nio.ch.FileDispatcherImpl |write0 |FileDispatcherImpl.java | |
|sun.nio.ch.SocketDispatcher |write |SocketDispatcher.java | 47|
|sun.nio.ch.IOUtil |writeFromNativeBuffer |IOUtil.java | 115|
|sun.nio.ch.IOUtil |write |IOUtil.java | 80|
|sun.nio.ch.IOUtil |write |IOUtil.java | 50|
|sun.nio.ch.SocketChannelImpl |write |SocketChannelImpl.java | 473|
|org.apache.tomcat.util.net.NioChannel |write |NioChannel.java | 134|
|org.apache.tomcat.util.net.NioBlockingSelector |write |NioBlockingSelector.java | 101|
|org.apache.tomcat.util.net.NioSelectorPool |write |NioSelectorPool.java | 157|
|apache.tomcat.util.net.NioEndpoint$NioSocketWrapper|doWrite |NioEndpoint.java |1306|
|org.apache.tomcat.util.net.SocketWrapperBase |doWrite |SocketWrapperBase.java | 726|
|org.apache.tomcat.util.net.SocketWrapperBase |writeBlocking |SocketWrapperBase.java | 496|
|org.apache.tomcat.util.net.SocketWrapperBase |write |SocketWrapperBase.java | 434|
|coyote.http11.Http11OutputBuffer$SocketOutputBuffer|doWrite |Http11OutputBuffer.java | 623|
|rg.apache.coyote.http11.filters.ChunkedOutputFilter|doWrite |ChunkedOutputFilter.java | 123|
|org.apache.coyote.http11.Http11OutputBuffer |doWrite |Http11OutputBuffer.java | 225|
|org.apache.coyote.Response |doWrite |Response.java | 541|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 351|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.apache.catalina.connector.ClientAbortException |
|----------------------------------------------------------------------------------------------------------------------|
|org.apache.catalina.connector.OutputBuffer |realWriteBytes |OutputBuffer.java | 356|
|org.apache.catalina.connector.OutputBuffer |appendByteArray |OutputBuffer.java | 795|
|org.apache.catalina.connector.OutputBuffer |append |OutputBuffer.java | 724|
|org.apache.catalina.connector.OutputBuffer |writeBytes |OutputBuffer.java | 391|
|org.apache.catalina.connector.OutputBuffer |write |OutputBuffer.java | 369|
|org.apache.catalina.connector.CoyoteOutputStream |write |CoyoteOutputStream.java | 96|
|org.orbeon.oxf.util.NetUtils |copyStream |NetUtils.java | 222|
|org.orbeon.oxf.processor.ResourceServer |serveResource |ResourceServer.java | 128|
|xf.controller.PageFlowControllerProcessor$FileRoute|process |PageFlowControllerProcessor.sc| 543|
|g.orbeon.oxf.controller.PageFlowControllerProcessor|start |PageFlowControllerProcessor.sc| 176|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.ValidationException |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.common.OrbeonLocationException$ |wrapException |OrbeonLocationException.scala | 60|
|org.orbeon.oxf.common.OrbeonLocationException |wrapException |OrbeonLocationException.scala | |
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 619|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start |ConcreteChooseProcessor.java | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run |PipelineProcessor.java | 617|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren |PipelineProcessor.java | 679|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start |PipelineProcessor.java | 614|
|org.orbeon.oxf.pipeline.InitUtils$ |runProcessor |InitUtils.scala | 84|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply$mcV$sp |ProcessorService.scala | 47|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply |ProcessorService.scala | 42|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEventAssumingRequest |LifecycleLogger.scala | 118|
|org.orbeon.oxf.webapp.ProcessorService |service |ProcessorService.scala | 42|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp |OrbeonServlet.scala | 78|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.webapp.ServletPortlet$ |withRootException |ServletPortlet.scala | 104|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply$mcV$sp |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply |OrbeonServlet.scala | 71|
|org.orbeon.oxf.util.DynamicVariable |withValue |DynamicVariable.scala | 42|
|org.orbeon.oxf.webapp.ProcessorService$ |withProcessorService |ProcessorService.scala | 146|
|org.orbeon.oxf.servlet.OrbeonServlet |service |OrbeonServlet.scala | 70|
|javax.servlet.http.HttpServlet |service |HttpServlet.java | 742|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 231|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.tomcat.websocket.server.WsFilter |doFilter |WsFilter.java | 52|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.orbeon.oxf.servlet.FormRunnerAuthFilter |doFilter |FormRunnerAuthFilter.scala | 49|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply$mcV$sp |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$2|apply |LimiterFilter.scala | 92|
|org.orbeon.oxf.logging.LifecycleLogger$ |withEvent |LifecycleLogger.scala | 125|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 91|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply |LimiterFilter.scala | 72|
|scala.Option |foreach |Option.scala | 257|
|org.orbeon.oxf.servlet.LimiterFilter |doFilter |LimiterFilter.scala | 72|
|org.apache.catalina.core.ApplicationFilterChain |internalDoFilter |ApplicationFilterChain.java | 193|
|org.apache.catalina.core.ApplicationFilterChain |doFilter |ApplicationFilterChain.java | 166|
|org.apache.catalina.core.StandardWrapperValve |invoke |StandardWrapperValve.java | 198|
|org.apache.catalina.core.StandardContextValve |invoke |StandardContextValve.java | 96|
|org.apache.catalina.authenticator.AuthenticatorBase|invoke |AuthenticatorBase.java | 610|
|org.apache.catalina.core.StandardHostValve |invoke |StandardHostValve.java | 140|
|org.apache.catalina.valves.ErrorReportValve |invoke |ErrorReportValve.java | 81|
|org.apache.catalina.valves.AbstractAccessLogValve |invoke |AbstractAccessLogValve.java | 650|
|org.apache.catalina.core.StandardEngineValve |invoke |StandardEngineValve.java | 87|
|org.apache.catalina.connector.CoyoteAdapter |service |CoyoteAdapter.java | 342|
|org.apache.coyote.http11.Http11Processor |service |Http11Processor.java | 800|
|org.apache.coyote.AbstractProcessorLight |process |AbstractProcessorLight.java | 66|
|rg.apache.coyote.AbstractProtocol$ConnectionHandler|process |AbstractProtocol.java | 806|
|.apache.tomcat.util.net.NioEndpoint$SocketProcessor|doRun |NioEndpoint.java |1498|
|org.apache.tomcat.util.net.SocketProcessorBase |run |SocketProcessorBase.java | 49|
|java.util.concurrent.ThreadPoolExecutor |runWorker |ThreadPoolExecutor.java |1135|
|java.util.concurrent.ThreadPoolExecutor$Worker |run |ThreadPoolExecutor.java | 635|
|che.tomcat.util.threads.TaskThread$WrappingRunnable|run |TaskThread.java | 61|
|java.lang.Thread |run |Thread.java | 844|
+----------------------------------------------------------------------------------------------------------------------+
2019-01-28 10:57:00,917 INFO lifecycle - event: {"request": "29", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "service", "message": "end: handle", "time": "160 ms"}
2019-01-28 10:57:00,918 INFO lifecycle - event: {"request": "29", "session": "F982DA8DECF920665D11A93F46C23F13", "source": "limiter", "message": "end: nofilter", "time": "162 ms"}
2019-01-28 10:59:58,060 INFO lifecycle - event: {"request": "33", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: filter", "path": "/fr/orbeon/bookshelf/summary", "method": "GET"}
2019-01-28 10:59:58,069 INFO lifecycle - event: {"request": "33", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: chain", "path": "/fr/orbeon/bookshelf/summary", "method": "GET", "wait": "1"}
2019-01-28 10:59:58,284 INFO lifecycle - event: {"request": "33", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle"}
2019-01-28 10:59:58,284 INFO ProcessorService - /fr/orbeon/bookshelf/summary - Received request
2019-01-28 10:59:59,601 INFO lifecycle - event: {"request": "33", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "xforms", "message": "new form session", "uuid": "c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14"}
2019-01-28 10:59:59,661 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 10:59:59,842 INFO lifecycle - event: {"request": "34", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/form/orbeon/bookshelf", "method": "GET"}
2019-01-28 10:59:59,842 INFO ProcessorService - /fr/service/persistence/form/orbeon/bookshelf - Received request
2019-01-28 10:59:59,945 INFO lifecycle - event: {"request": "35", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle", "path": "/fr/service/exist/form/orbeon/bookshelf", "method": "GET"}
2019-01-28 10:59:59,945 INFO ProcessorService - /fr/service/exist/form/orbeon/bookshelf - Received request
2019-01-28 11:00:00,040 INFO lifecycle - event: {"request": "36", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr", "method": "POST"}
2019-01-28 11:00:00,040 INFO ProcessorService - Session listener - Session created.
2019-01-28 11:00:00,041 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 11:00:00,090 INFO lifecycle - event: {"request": "36", "session": "2FFC5E981C08E9200E14597BEF094AB6", "source": "limiter", "message": "end: nofilter", "time": "49 ms"}
2019-01-28 11:00:00,137 INFO ProcessorService - /fr/service/exist/form/orbeon/bookshelf - Timing: 190
2019-01-28 11:00:00,142 INFO lifecycle - event: {"request": "35", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "197 ms"}
2019-01-28 11:00:00,163 INFO ProcessorService - /fr/service/persistence/form/orbeon/bookshelf - Timing: 321
2019-01-28 11:00:00,166 INFO lifecycle - event: {"request": "34", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "321 ms"}
2019-01-28 11:00:00,228 INFO lifecycle - event: {"request": "37", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/crud/orbeon/bookshelf/form/form.xhtml", "method": "GET"}
2019-01-28 11:00:00,228 INFO ProcessorService - /fr/service/persistence/crud/orbeon/bookshelf/form/form.xhtml - Received request
2019-01-28 11:00:00,320 INFO lifecycle - event: {"request": "38", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle", "path": "/fr/service/exist/crud/orbeon/bookshelf/form/form.xhtml", "method": "GET"}
2019-01-28 11:00:00,320 INFO ProcessorService - /fr/service/exist/crud/orbeon/bookshelf/form/form.xhtml - Received request
2019-01-28 11:00:00,509 INFO lifecycle - event: {"request": "39", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr/orbeon/bookshelf/form/form.xhtml", "method": "GET"}
2019-01-28 11:00:00,510 INFO ProcessorService - Session listener - Session created.
2019-01-28 11:00:00,510 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 11:00:00,685 INFO lifecycle - event: {"request": "39", "session": "4EA90086C80B0942E459146026B2D218", "source": "limiter", "message": "end: nofilter", "time": "176 ms"}
2019-01-28 11:00:00,685 INFO ProcessorService - /fr/service/exist/crud/orbeon/bookshelf/form/form.xhtml - Timing: 365
2019-01-28 11:00:00,685 INFO lifecycle - event: {"request": "38", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "366 ms"}
2019-01-28 11:00:00,690 INFO ProcessorService - /fr/service/persistence/crud/orbeon/bookshelf/form/form.xhtml - Timing: 462
2019-01-28 11:00:00,690 INFO lifecycle - event: {"request": "37", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "462 ms"}
2019-01-28 11:00:00,912 INFO lifecycle - event: {"request": "40", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/search/orbeon/bookshelf", "method": "POST"}
2019-01-28 11:00:00,913 INFO ProcessorService - /fr/service/persistence/search/orbeon/bookshelf - Received request
2019-01-28 11:00:00,959 INFO lifecycle - event: {"request": "41", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle", "path": "/fr/service/exist/search/orbeon/bookshelf", "method": "POST"}
2019-01-28 11:00:00,959 INFO ProcessorService - /fr/service/exist/search/orbeon/bookshelf - Received request
2019-01-28 11:00:01,092 INFO lifecycle - event: {"request": "42", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/form/orbeon/bookshelf", "method": "GET"}
2019-01-28 11:00:01,093 INFO ProcessorService - /fr/service/persistence/form/orbeon/bookshelf - Received request
2019-01-28 11:00:01,110 INFO lifecycle - event: {"request": "43", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle", "path": "/fr/service/exist/form/orbeon/bookshelf", "method": "GET"}
2019-01-28 11:00:01,110 INFO ProcessorService - /fr/service/exist/form/orbeon/bookshelf - Received request
2019-01-28 11:00:01,218 INFO lifecycle - event: {"request": "44", "session": "4EA90086C80B0942E459146026B2D218", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr", "method": "POST"}
2019-01-28 11:00:01,219 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 11:00:01,230 INFO lifecycle - event: {"request": "44", "session": "4EA90086C80B0942E459146026B2D218", "source": "limiter", "message": "end: nofilter", "time": "12 ms"}
2019-01-28 11:00:01,331 INFO ProcessorService - /fr/service/exist/form/orbeon/bookshelf - Timing: 221
2019-01-28 11:00:01,332 INFO lifecycle - event: {"request": "43", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "222 ms"}
2019-01-28 11:00:01,348 INFO ProcessorService - /fr/service/persistence/form/orbeon/bookshelf - Timing: 255
2019-01-28 11:00:01,349 INFO lifecycle - event: {"request": "42", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "256 ms"}
2019-01-28 11:00:01,421 INFO lifecycle - event: {"request": "45", "session": "4EA90086C80B0942E459146026B2D218", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr/orbeon/bookshelf/data/", "method": "POST"}
2019-01-28 11:00:01,422 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 11:00:01,942 INFO lifecycle - event: {"request": "45", "session": "4EA90086C80B0942E459146026B2D218", "source": "limiter", "message": "end: nofilter", "time": "521 ms"}
2019-01-28 11:00:02,002 INFO ProcessorService - /fr/service/exist/search/orbeon/bookshelf - Timing: 1043
2019-01-28 11:00:02,010 INFO lifecycle - event: {"request": "41", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "1,050 ms"}
2019-01-28 11:00:02,019 INFO ProcessorService - /fr/service/persistence/search/orbeon/bookshelf - Timing: 1107
2019-01-28 11:00:02,025 INFO lifecycle - event: {"request": "40", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "1,107 ms"}
2019-01-28 11:00:02,118 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:00:02,824 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-metadata"}
2019-01-28 11:00:02,883 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:00:03,175 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:00:04,284 INFO lifecycle - event: {"request": "33", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "2", "document cache max size": "50"}
2019-01-28 11:00:04,515 INFO ProcessorService - /fr/orbeon/bookshelf/summary - Timing: 6231
2019-01-28 11:00:04,516 INFO lifecycle - event: {"request": "33", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "6,231 ms"}
2019-01-28 11:00:04,518 INFO lifecycle - event: {"request": "33", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: chain", "time": "6,447 ms"}
2019-01-28 11:00:04,527 INFO lifecycle - event: {"request": "33", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: filter", "time": "6,465 ms"}
2019-01-28 11:00:04,635 INFO lifecycle - event: {"request": "46", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: nofilter", "path": "/xforms-server/form/dynamic/c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14.js", "method": "GET"}
2019-01-28 11:00:04,637 INFO lifecycle - event: {"request": "46", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle"}
2019-01-28 11:00:04,637 INFO ProcessorService - /xforms-server/form/dynamic/c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14.js - Received request
2019-01-28 11:00:04,655 INFO lifecycle - event: {"request": "46", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "xforms", "message": "before document lock", "uuid": "c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14"}
2019-01-28 11:00:04,655 INFO lifecycle - event: {"request": "46", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "xforms", "message": "got document lock", "path": "/xforms-server/form/dynamic/c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14.js", "method": "GET", "uuid": "c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14", "wait": "0"}
2019-01-28 11:00:04,658 INFO lifecycle - event: {"request": "46", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "2", "document cache max size": "50"}
2019-01-28 11:00:04,659 INFO ProcessorService - /xforms-server/form/dynamic/c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14.js - Timing: 22
2019-01-28 11:00:04,659 INFO lifecycle - event: {"request": "46", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "23 ms"}
2019-01-28 11:00:04,669 INFO lifecycle - event: {"request": "46", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: nofilter", "time": "25 ms"}
2019-01-28 11:00:04,691 INFO lifecycle - event: {"request": "47", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: nofilter", "path": "/ops/images/xforms/section-closed.png", "method": "GET"}
2019-01-28 11:00:04,692 INFO lifecycle - event: {"request": "47", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle"}
2019-01-28 11:00:04,692 INFO ProcessorService - /ops/images/xforms/section-closed.png - Received request
2019-01-28 11:00:04,695 INFO lifecycle - event: {"request": "48", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: nofilter", "path": "/ops/images/xforms/section-opened.png", "method": "GET"}
2019-01-28 11:00:04,696 INFO lifecycle - event: {"request": "48", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle"}
2019-01-28 11:00:04,696 INFO ProcessorService - /ops/images/xforms/section-opened.png - Received request
2019-01-28 11:00:04,749 INFO ProcessorService - /ops/images/xforms/section-opened.png - Timing: 53
2019-01-28 11:00:04,749 INFO lifecycle - event: {"request": "48", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "53 ms"}
2019-01-28 11:00:04,749 INFO ProcessorService - /ops/images/xforms/section-closed.png - Timing: 57
2019-01-28 11:00:04,760 INFO lifecycle - event: {"request": "48", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: nofilter", "time": "54 ms"}
2019-01-28 11:00:04,767 INFO lifecycle - event: {"request": "47", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "57 ms"}
2019-01-28 11:00:04,768 INFO lifecycle - event: {"request": "47", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: nofilter", "time": "76 ms"}
2019-01-28 11:00:04,793 INFO lifecycle - event: {"request": "50", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: nofilter", "path": "/ops/images/xforms/warning_64.png", "method": "GET"}
2019-01-28 11:00:04,793 INFO lifecycle - event: {"request": "49", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: nofilter", "path": "/apps/fr/style/images/pixelmixer/info_64.png", "method": "GET"}
2019-01-28 11:00:04,794 INFO lifecycle - event: {"request": "50", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle"}
2019-01-28 11:00:04,794 INFO lifecycle - event: {"request": "49", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle"}
2019-01-28 11:00:04,794 INFO ProcessorService - /ops/images/xforms/warning_64.png - Received request
2019-01-28 11:00:04,794 INFO ProcessorService - /apps/fr/style/images/pixelmixer/info_64.png - Received request
2019-01-28 11:00:04,814 INFO ProcessorService - /ops/images/xforms/warning_64.png - Timing: 20
2019-01-28 11:00:04,814 INFO lifecycle - event: {"request": "50", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "20 ms"}
2019-01-28 11:00:04,814 INFO lifecycle - event: {"request": "50", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: nofilter", "time": "21 ms"}
2019-01-28 11:00:04,819 INFO ProcessorService - /apps/fr/style/images/pixelmixer/info_64.png - Timing: 25
2019-01-28 11:00:04,820 INFO lifecycle - event: {"request": "49", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "25 ms"}
2019-01-28 11:00:04,820 INFO lifecycle - event: {"request": "49", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: nofilter", "time": "27 ms"}
2019-01-28 11:00:05,139 INFO lifecycle - event: {"request": "51", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: nofilter", "path": "/ops/yui/assets/skins/sam/sprite.png", "method": "GET"}
2019-01-28 11:00:05,140 INFO lifecycle - event: {"request": "51", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle"}
2019-01-28 11:00:05,140 INFO ProcessorService - /ops/yui/assets/skins/sam/sprite.png - Received request
2019-01-28 11:00:05,281 INFO ProcessorService - /ops/yui/assets/skins/sam/sprite.png - Timing: 141
2019-01-28 11:00:05,281 INFO lifecycle - event: {"request": "51", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "141 ms"}
2019-01-28 11:00:05,282 INFO lifecycle - event: {"request": "51", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: nofilter", "time": "142 ms"}
2019-01-28 11:01:52,694 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: filter", "path": "/xforms-server", "method": "POST"}
2019-01-28 11:01:52,695 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "start: chain", "path": "/xforms-server", "method": "POST", "wait": "0"}
2019-01-28 11:01:52,696 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "start: handle"}
2019-01-28 11:01:52,696 INFO ProcessorService - /xforms-server - Received request
2019-01-28 11:01:52,983 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "xforms", "message": "ajax with update events", "uuid": "c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14"}
2019-01-28 11:01:52,993 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "xforms", "message": "before document lock", "uuid": "c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14"}
2019-01-28 11:01:52,994 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "xforms", "message": "got document lock", "path": "/xforms-server", "method": "POST", "uuid": "c63c456bd57a2f3f77ddc9ffd4afd1a2551c2e14", "wait": "0"}
2019-01-28 11:01:53,912 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "2", "document cache max size": "50"}
2019-01-28 11:01:53,912 INFO ProcessorService - /xforms-server - Timing: 1216
2019-01-28 11:01:53,913 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "service", "message": "end: handle", "time": "1,218 ms"}
2019-01-28 11:01:53,913 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: chain", "time": "1,219 ms"}
2019-01-28 11:01:53,913 INFO lifecycle - event: {"request": "52", "session": "FDDBFDEA7445C9B844C05580F42BC476", "source": "limiter", "message": "end: filter", "time": "1,219 ms"}
2019-01-28 11:03:29,326 INFO lifecycle - event: {"request": "53", "session": "F86F91CF11B12A32CBC6D30CFE1C4B1E", "source": "limiter", "message": "start: filter", "path": "/fr/logout", "method": "GET"}
2019-01-28 11:03:29,327 INFO lifecycle - event: {"request": "53", "session": "F86F91CF11B12A32CBC6D30CFE1C4B1E", "source": "limiter", "message": "start: chain", "path": "/fr/logout", "method": "GET", "wait": "0"}
2019-01-28 11:03:29,328 INFO lifecycle - event: {"request": "53", "session": "F86F91CF11B12A32CBC6D30CFE1C4B1E", "source": "service", "message": "start: handle"}
2019-01-28 11:03:29,328 INFO ProcessorService - /fr/logout - Received request
2019-01-28 11:03:29,491 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 11:03:29,550 INFO ProcessorService - /fr/logout - Timing: 222
2019-01-28 11:03:29,551 INFO lifecycle - event: {"request": "53", "session": "F86F91CF11B12A32CBC6D30CFE1C4B1E", "source": "service", "message": "end: handle", "time": "223 ms"}
2019-01-28 11:03:29,551 INFO lifecycle - event: {"request": "53", "source": "limiter", "message": "end: chain", "time": "224 ms"}
2019-01-28 11:03:29,551 INFO lifecycle - event: {"request": "53", "source": "limiter", "message": "end: filter", "time": "225 ms"}
2019-01-28 11:03:29,582 INFO lifecycle - event: {"request": "54", "source": "limiter", "message": "start: filter", "path": "/fr/logout-done", "method": "GET"}
2019-01-28 11:03:29,583 INFO lifecycle - event: {"request": "54", "source": "limiter", "message": "start: chain", "path": "/fr/logout-done", "method": "GET", "wait": "1"}
2019-01-28 11:03:29,583 INFO ProcessorService - Session listener - Session created.
2019-01-28 11:03:29,585 INFO lifecycle - event: {"request": "54", "session": "AE9FF96A9235ED43DF6DCAE7B5B56C86", "source": "service", "message": "start: handle"}
2019-01-28 11:03:29,585 INFO ProcessorService - /fr/logout-done - Received request
2019-01-28 11:03:30,073 WARN XFormsServer - unknown id {id: "fr-form-instance"}
2019-01-28 11:03:30,073 WARN XFormsServer - unknown id {id: "fb-form-instance"}
2019-01-28 11:03:30,077 WARN XFormsServer - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xf:action observer="fr-form-instance fb-form-instance" event="xforms-insert xforms-delete xxforms-replace xxforms-value-changed" id="xf-198">[...]</xf:action>"}
2019-01-28 11:03:30,077 WARN XFormsServer - unknown id {id: "fr-view-component"}
2019-01-28 11:03:30,077 WARN XFormsServer - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xf:action observer="fr-view-component" event="fr-toc-shown" if="event('separate-toc')" id="xf-249">[...]</xf:action>"}
2019-01-28 11:03:30,078 WARN XFormsServer - unknown id {id: "fr-view-component"}
2019-01-28 11:03:30,078 WARN XFormsServer - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xf:action observer="fr-view-component" event="fr-section-shown" id="xf-251">[...]</xf:action>"}
2019-01-28 11:03:30,079 WARN XFormsServer - unknown id {id: "fr-view-component"}
2019-01-28 11:03:30,079 WARN XFormsServer - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xf:action ev:event="xxforms-upload-error" ev:observer="fr-view-component" ev:defaultAction="cancel" xxf:phantom="true" id="xf-420">[...]</xf:action>"}
2019-01-28 11:03:30,079 WARN XFormsServer - unknown id {id: "fr-view-component"}
2019-01-28 11:03:30,079 WARN XFormsServer - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xf:action ev:event="xxforms-upload-done" ev:observer="fr-view-component" ev:defaultAction="cancel" xxf:phantom="true" type="xpath" id="xf-422">[...]</xf:action>"}
2019-01-28 11:03:30,118 INFO lifecycle - event: {"request": "54", "session": "AE9FF96A9235ED43DF6DCAE7B5B56C86", "source": "xforms", "message": "new form session", "uuid": "7ab2aa26b11f994372829fe5094e111ce6b0bfa0"}
2019-01-28 11:03:30,156 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:03:30,178 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:30,178 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:30,201 WARN XFormsServer - instance() - instance not found {instance id: "fr-form-instance"}
2019-01-28 11:03:30,211 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:30,218 INFO lifecycle - event: {"request": "55", "session": "AE9FF96A9235ED43DF6DCAE7B5B56C86", "source": "service", "message": "start: handle", "path": "/fr/service/i18n/fr-resources/*/*", "method": "GET"}
2019-01-28 11:03:30,218 INFO ProcessorService - /fr/service/i18n/fr-resources/*/* - Received request
2019-01-28 11:03:30,513 INFO ProcessorService - /fr/service/i18n/fr-resources/*/* - Timing: 295
2019-01-28 11:03:30,515 INFO lifecycle - event: {"request": "55", "session": "AE9FF96A9235ED43DF6DCAE7B5B56C86", "source": "service", "message": "end: handle", "time": "296 ms"}
2019-01-28 11:03:30,555 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:30,557 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:30,568 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:30,572 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:30,577 WARN XFormsServer - instance() - instance not found {instance id: "fr-form-instance"}
2019-01-28 11:03:30,796 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-metadata"}
2019-01-28 11:03:30,811 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:03:30,889 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:03:31,086 INFO lifecycle - event: {"request": "54", "session": "AE9FF96A9235ED43DF6DCAE7B5B56C86", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "2", "document cache max size": "50"}
2019-01-28 11:03:31,178 INFO ProcessorService - /fr/logout-done - Timing: 1593
2019-01-28 11:03:31,179 INFO lifecycle - event: {"request": "54", "session": "AE9FF96A9235ED43DF6DCAE7B5B56C86", "source": "service", "message": "end: handle", "time": "1,595 ms"}
2019-01-28 11:03:31,179 INFO lifecycle - event: {"request": "54", "session": "AE9FF96A9235ED43DF6DCAE7B5B56C86", "source": "limiter", "message": "end: chain", "time": "1,596 ms"}
2019-01-28 11:03:31,180 INFO lifecycle - event: {"request": "54", "session": "AE9FF96A9235ED43DF6DCAE7B5B56C86", "source": "limiter", "message": "end: filter", "time": "1,597 ms"}
2019-01-28 11:03:31,218 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "start: filter", "path": "/fr/", "method": "GET"}
2019-01-28 11:03:31,218 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "start: chain", "path": "/fr/", "method": "GET", "wait": "0"}
2019-01-28 11:03:31,219 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "start: handle"}
2019-01-28 11:03:31,219 INFO ProcessorService - /fr/ - Received request
2019-01-28 11:03:32,572 WARN XFormsServer - unknown id {id: "fb-form-instance"}
2019-01-28 11:03:32,573 WARN XFormsServer - unknown id {id: "fr-view-component"}
2019-01-28 11:03:32,574 WARN XFormsServer - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xf:action observer="fr-view-component" event="fr-toc-shown" if="event('separate-toc')" id="xf-253">[...]</xf:action>"}
2019-01-28 11:03:32,574 WARN XFormsServer - unknown id {id: "fr-view-component"}
2019-01-28 11:03:32,574 WARN XFormsServer - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xf:action observer="fr-view-component" event="fr-section-shown" id="xf-255">[...]</xf:action>"}
2019-01-28 11:03:32,580 WARN XFormsServer - unknown id {id: "fr-view-component"}
2019-01-28 11:03:32,580 WARN XFormsServer - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xf:action ev:event="xxforms-upload-error" ev:observer="fr-view-component" ev:defaultAction="cancel" xxf:phantom="true" id="xf-769">[...]</xf:action>"}
2019-01-28 11:03:32,580 WARN XFormsServer - unknown id {id: "fr-view-component"}
2019-01-28 11:03:32,580 WARN XFormsServer - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xf:action ev:event="xxforms-upload-done" ev:observer="fr-view-component" ev:defaultAction="cancel" xxf:phantom="true" type="xpath" id="xf-771">[...]</xf:action>"}
2019-01-28 11:03:32,692 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "xforms", "message": "new form session", "uuid": "2fd2dca2ca8360762d6c8489d136d2d5c1ae548a"}
2019-01-28 11:03:32,746 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:03:32,764 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:32,769 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:32,845 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:32,852 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:32,855 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:32,867 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:32,870 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:03:33,128 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-metadata"}
2019-01-28 11:03:33,145 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:03:33,226 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:03:33,350 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "fr", "message": "start: process", "uuid": "2fd2dca2ca8360762d6c8489d136d2d5c1ae548a", "scope": "oxf.fr.home.process", "name": "load-local"}
2019-01-28 11:03:33,873 INFO lifecycle - event: {"request": "57", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/form", "method": "GET"}
2019-01-28 11:03:33,873 INFO ProcessorService - /fr/service/persistence/form - Received request
2019-01-28 11:03:33,908 INFO lifecycle - event: {"request": "58", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "start: handle", "path": "/fr/service/resource/form", "method": "GET"}
2019-01-28 11:03:33,909 INFO ProcessorService - /fr/service/resource/form - Received request
2019-01-28 11:03:33,995 INFO ProcessorService - /fr/service/resource/form - Timing: 87
2019-01-28 11:03:33,995 INFO lifecycle - event: {"request": "58", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "end: handle", "time": "87 ms"}
2019-01-28 11:03:34,002 INFO lifecycle - event: {"request": "59", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "start: handle", "path": "/fr/service/exist/form", "method": "GET"}
2019-01-28 11:03:34,002 INFO ProcessorService - /fr/service/exist/form - Received request
2019-01-28 11:03:34,085 INFO lifecycle - event: {"request": "60", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr", "method": "POST"}
2019-01-28 11:03:34,086 INFO ProcessorService - Session listener - Session created.
2019-01-28 11:03:34,086 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 11:03:34,237 INFO lifecycle - event: {"request": "60", "session": "6ABA0A7FE28B71F292EC1DF49247C1CA", "source": "limiter", "message": "end: nofilter", "time": "152 ms"}
2019-01-28 11:03:34,274 INFO ProcessorService - /fr/service/exist/form - Timing: 272
2019-01-28 11:03:34,276 INFO lifecycle - event: {"request": "59", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "end: handle", "time": "273 ms"}
2019-01-28 11:03:34,301 INFO ProcessorService - /fr/service/persistence/form - Timing: 428
2019-01-28 11:03:34,301 INFO lifecycle - event: {"request": "57", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "end: handle", "time": "429 ms"}
2019-01-28 11:03:34,427 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "fr", "message": "end: process", "time": "1,076 ms"}
2019-01-28 11:03:35,002 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "3", "document cache max size": "50"}
2019-01-28 11:03:35,356 INFO ProcessorService - /fr/ - Timing: 4137
2019-01-28 11:03:35,357 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "end: handle", "time": "4,137 ms"}
2019-01-28 11:03:35,357 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "end: chain", "time": "4,139 ms"}
2019-01-28 11:03:35,358 INFO lifecycle - event: {"request": "56", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "end: filter", "time": "4,139 ms"}
2019-01-28 11:03:35,424 INFO lifecycle - event: {"request": "61", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "start: nofilter", "path": "/xforms-server/form/dynamic/2fd2dca2ca8360762d6c8489d136d2d5c1ae548a.js", "method": "GET"}
2019-01-28 11:03:35,425 INFO lifecycle - event: {"request": "61", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "start: handle"}
2019-01-28 11:03:35,426 INFO ProcessorService - /xforms-server/form/dynamic/2fd2dca2ca8360762d6c8489d136d2d5c1ae548a.js - Received request
2019-01-28 11:03:35,432 INFO lifecycle - event: {"request": "62", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "start: nofilter", "path": "/xforms-server/orbeon-f2134a6df0ba6b5143b044040092e70b1e1bfa20.css", "method": "GET"}
2019-01-28 11:03:35,433 INFO lifecycle - event: {"request": "62", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "start: handle"}
2019-01-28 11:03:35,433 INFO ProcessorService - /xforms-server/orbeon-f2134a6df0ba6b5143b044040092e70b1e1bfa20.css - Received request
2019-01-28 11:03:35,435 INFO lifecycle - event: {"request": "63", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "start: nofilter", "path": "/xforms-server/form/static/4934e967a26e45d710685df60929d81f9259d528.js", "method": "GET"}
2019-01-28 11:03:35,436 INFO lifecycle - event: {"request": "63", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "start: handle"}
2019-01-28 11:03:35,436 INFO ProcessorService - /xforms-server/form/static/4934e967a26e45d710685df60929d81f9259d528.js - Received request
2019-01-28 11:03:35,565 INFO lifecycle - event: {"request": "64", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "start: nofilter", "path": "/xforms-server/orbeon-0b061cc5e595537168f1ee4e1e257234917e9092.js", "method": "GET"}
2019-01-28 11:03:35,566 INFO lifecycle - event: {"request": "64", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "start: handle"}
2019-01-28 11:03:35,566 INFO ProcessorService - /xforms-server/orbeon-0b061cc5e595537168f1ee4e1e257234917e9092.js - Received request
2019-01-28 11:03:35,598 INFO lifecycle - event: {"request": "61", "session": "E97164DB832D24D67ACC619E3870B595", "source": "xforms", "message": "before document lock", "uuid": "2fd2dca2ca8360762d6c8489d136d2d5c1ae548a"}
2019-01-28 11:03:35,598 INFO lifecycle - event: {"request": "61", "session": "E97164DB832D24D67ACC619E3870B595", "source": "xforms", "message": "got document lock", "path": "/xforms-server/form/dynamic/2fd2dca2ca8360762d6c8489d136d2d5c1ae548a.js", "method": "GET", "uuid": "2fd2dca2ca8360762d6c8489d136d2d5c1ae548a", "wait": "0"}
2019-01-28 11:03:35,618 INFO lifecycle - event: {"request": "61", "session": "E97164DB832D24D67ACC619E3870B595", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "3", "document cache max size": "50"}
2019-01-28 11:03:35,651 INFO ProcessorService - /xforms-server/form/dynamic/2fd2dca2ca8360762d6c8489d136d2d5c1ae548a.js - Timing: 226
2019-01-28 11:03:35,652 INFO lifecycle - event: {"request": "61", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "end: handle", "time": "227 ms"}
2019-01-28 11:03:35,652 INFO lifecycle - event: {"request": "61", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "end: nofilter", "time": "229 ms"}
2019-01-28 11:03:35,653 INFO ProcessorService - /xforms-server/form/static/4934e967a26e45d710685df60929d81f9259d528.js - Timing: 217
2019-01-28 11:03:35,653 INFO lifecycle - event: {"request": "63", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "end: handle", "time": "217 ms"}
2019-01-28 11:03:35,662 INFO lifecycle - event: {"request": "63", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "end: nofilter", "time": "219 ms"}
2019-01-28 11:03:35,734 INFO ProcessorService - /xforms-server/orbeon-0b061cc5e595537168f1ee4e1e257234917e9092.js - Timing: 168
2019-01-28 11:03:35,735 INFO lifecycle - event: {"request": "64", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "end: handle", "time": "168 ms"}
2019-01-28 11:03:35,735 INFO lifecycle - event: {"request": "64", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "end: nofilter", "time": "174 ms"}
2019-01-28 11:03:36,109 INFO ProcessorService - /xforms-server/orbeon-f2134a6df0ba6b5143b044040092e70b1e1bfa20.css - Timing: 676
2019-01-28 11:03:36,110 INFO lifecycle - event: {"request": "62", "session": "E97164DB832D24D67ACC619E3870B595", "source": "service", "message": "end: handle", "time": "676 ms"}
2019-01-28 11:03:36,110 INFO lifecycle - event: {"request": "62", "session": "E97164DB832D24D67ACC619E3870B595", "source": "limiter", "message": "end: nofilter", "time": "678 ms"}
2019-01-28 11:06:45,254 INFO lifecycle - event: {"request": "65", "session": "8AF9AFEB4F7E32EB3946A5C20DF8B76D", "source": "limiter", "message": "start: filter", "path": "/fr/logout", "method": "GET"}
2019-01-28 11:06:45,255 INFO lifecycle - event: {"request": "65", "session": "8AF9AFEB4F7E32EB3946A5C20DF8B76D", "source": "limiter", "message": "start: chain", "path": "/fr/logout", "method": "GET", "wait": "0"}
2019-01-28 11:06:45,256 INFO lifecycle - event: {"request": "65", "session": "8AF9AFEB4F7E32EB3946A5C20DF8B76D", "source": "service", "message": "start: handle"}
2019-01-28 11:06:45,256 INFO ProcessorService - /fr/logout - Received request
2019-01-28 11:06:45,431 INFO ProcessorService - Session listener - Session destroyed.
2019-01-28 11:06:45,448 INFO ProcessorService - /fr/logout - Timing: 192
2019-01-28 11:06:45,449 INFO lifecycle - event: {"request": "65", "session": "8AF9AFEB4F7E32EB3946A5C20DF8B76D", "source": "service", "message": "end: handle", "time": "194 ms"}
2019-01-28 11:06:45,449 INFO lifecycle - event: {"request": "65", "source": "limiter", "message": "end: chain", "time": "194 ms"}
2019-01-28 11:06:45,449 INFO lifecycle - event: {"request": "65", "source": "limiter", "message": "end: filter", "time": "195 ms"}
2019-01-28 11:06:45,470 INFO lifecycle - event: {"request": "66", "source": "limiter", "message": "start: filter", "path": "/fr/logout-done", "method": "GET"}
2019-01-28 11:06:45,471 INFO lifecycle - event: {"request": "66", "source": "limiter", "message": "start: chain", "path": "/fr/logout-done", "method": "GET", "wait": "0"}
2019-01-28 11:06:45,471 INFO ProcessorService - Session listener - Session created.
2019-01-28 11:06:45,476 INFO lifecycle - event: {"request": "66", "session": "044C0BB693A5D6F1184BAF6DEF1BACCC", "source": "service", "message": "start: handle"}
2019-01-28 11:06:45,476 INFO ProcessorService - /fr/logout-done - Received request
2019-01-28 11:06:45,879 INFO lifecycle - event: {"request": "66", "session": "044C0BB693A5D6F1184BAF6DEF1BACCC", "source": "xforms", "message": "new form session", "uuid": "9998b387b9499277713a4d2b58ef7612ef8fdb75"}
2019-01-28 11:06:45,925 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:06:45,942 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:45,943 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:45,963 WARN XFormsServer - instance() - instance not found {instance id: "fr-form-instance"}
2019-01-28 11:06:45,971 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:45,977 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:45,979 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:45,984 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:45,987 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:45,991 WARN XFormsServer - instance() - instance not found {instance id: "fr-form-instance"}
2019-01-28 11:06:46,067 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-metadata"}
2019-01-28 11:06:46,083 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:06:46,152 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:06:46,305 INFO lifecycle - event: {"request": "66", "session": "044C0BB693A5D6F1184BAF6DEF1BACCC", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "2", "document cache max size": "50"}
2019-01-28 11:06:46,360 INFO ProcessorService - /fr/logout-done - Timing: 884
2019-01-28 11:06:46,360 INFO lifecycle - event: {"request": "66", "session": "044C0BB693A5D6F1184BAF6DEF1BACCC", "source": "service", "message": "end: handle", "time": "884 ms"}
2019-01-28 11:06:46,364 INFO lifecycle - event: {"request": "66", "session": "044C0BB693A5D6F1184BAF6DEF1BACCC", "source": "limiter", "message": "end: chain", "time": "892 ms"}
2019-01-28 11:06:46,368 INFO lifecycle - event: {"request": "66", "session": "044C0BB693A5D6F1184BAF6DEF1BACCC", "source": "limiter", "message": "end: filter", "time": "894 ms"}
2019-01-28 11:06:46,389 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "limiter", "message": "start: filter", "path": "/fr/", "method": "GET"}
2019-01-28 11:06:46,389 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "limiter", "message": "start: chain", "path": "/fr/", "method": "GET", "wait": "0"}
2019-01-28 11:06:46,389 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "start: handle"}
2019-01-28 11:06:46,390 INFO ProcessorService - /fr/ - Received request
2019-01-28 11:06:46,721 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "xforms", "message": "new form session", "uuid": "44efdb6ef9ce9784aa77ec528e7cd660f37f33d3"}
2019-01-28 11:06:46,763 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:06:46,781 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:46,783 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:46,840 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:46,844 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:46,846 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:46,849 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:46,850 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-resources"}
2019-01-28 11:06:47,000 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-metadata"}
2019-01-28 11:06:47,029 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:06:47,216 WARN XFormsServer - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2019-01-28 11:06:47,277 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "fr", "message": "start: process", "uuid": "44efdb6ef9ce9784aa77ec528e7cd660f37f33d3", "scope": "oxf.fr.home.process", "name": "load-local"}
2019-01-28 11:06:47,299 INFO lifecycle - event: {"request": "68", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "start: handle", "path": "/fr/service/persistence/form", "method": "GET"}
2019-01-28 11:06:47,299 INFO ProcessorService - /fr/service/persistence/form - Received request
2019-01-28 11:06:47,316 INFO lifecycle - event: {"request": "69", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "start: handle", "path": "/fr/service/resource/form", "method": "GET"}
2019-01-28 11:06:47,316 INFO ProcessorService - /fr/service/resource/form - Received request
2019-01-28 11:06:47,332 INFO ProcessorService - /fr/service/resource/form - Timing: 16
2019-01-28 11:06:47,333 INFO lifecycle - event: {"request": "69", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "end: handle", "time": "16 ms"}
2019-01-28 11:06:47,339 INFO lifecycle - event: {"request": "70", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "start: handle", "path": "/fr/service/exist/form", "method": "GET"}
2019-01-28 11:06:47,340 INFO ProcessorService - /fr/service/exist/form - Received request
2019-01-28 11:06:47,391 INFO lifecycle - event: {"request": "71", "source": "limiter", "message": "start: nofilter", "path": "/exist/rest/db/orbeon/fr", "method": "POST"}
2019-01-28 11:06:47,391 INFO ProcessorService - Session listener - Session created.
2019-01-28 11:06:47,392 WARN auth - not setting credentials headers because credentials are not found
2019-01-28 11:06:47,447 INFO lifecycle - event: {"request": "71", "session": "CDC939C65D21B6869C8852B07CF83B57", "source": "limiter", "message": "end: nofilter", "time": "55 ms"}
2019-01-28 11:06:47,478 INFO ProcessorService - /fr/service/exist/form - Timing: 139
2019-01-28 11:06:47,479 INFO lifecycle - event: {"request": "70", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "end: handle", "time": "139 ms"}
2019-01-28 11:06:47,492 INFO ProcessorService - /fr/service/persistence/form - Timing: 193
2019-01-28 11:06:47,492 INFO lifecycle - event: {"request": "68", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "end: handle", "time": "193 ms"}
2019-01-28 11:06:47,513 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "fr", "message": "end: process", "time": "236 ms"}
2019-01-28 11:06:47,721 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "3", "document cache max size": "50"}
2019-01-28 11:06:47,802 INFO ProcessorService - /fr/ - Timing: 1412
2019-01-28 11:06:47,804 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "end: handle", "time": "1,413 ms"}
2019-01-28 11:06:47,805 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "limiter", "message": "end: chain", "time": "1,415 ms"}
2019-01-28 11:06:47,805 INFO lifecycle - event: {"request": "67", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "limiter", "message": "end: filter", "time": "1,417 ms"}
2019-01-28 11:06:47,952 INFO lifecycle - event: {"request": "72", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "limiter", "message": "start: nofilter", "path": "/xforms-server/form/dynamic/44efdb6ef9ce9784aa77ec528e7cd660f37f33d3.js", "method": "GET"}
2019-01-28 11:06:47,953 INFO lifecycle - event: {"request": "72", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "start: handle"}
2019-01-28 11:06:47,953 INFO ProcessorService - /xforms-server/form/dynamic/44efdb6ef9ce9784aa77ec528e7cd660f37f33d3.js - Received request
2019-01-28 11:06:47,965 INFO lifecycle - event: {"request": "72", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "xforms", "message": "before document lock", "uuid": "44efdb6ef9ce9784aa77ec528e7cd660f37f33d3"}
2019-01-28 11:06:47,966 INFO lifecycle - event: {"request": "72", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "xforms", "message": "got document lock", "path": "/xforms-server/form/dynamic/44efdb6ef9ce9784aa77ec528e7cd660f37f33d3.js", "method": "GET", "uuid": "44efdb6ef9ce9784aa77ec528e7cd660f37f33d3", "wait": "0"}
2019-01-28 11:06:47,967 INFO lifecycle - event: {"request": "72", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "xforms", "message": "after cacheOrStore", "document cache current size": "3", "document cache max size": "50"}
2019-01-28 11:06:47,979 INFO ProcessorService - /xforms-server/form/dynamic/44efdb6ef9ce9784aa77ec528e7cd660f37f33d3.js - Timing: 26
2019-01-28 11:06:47,979 INFO lifecycle - event: {"request": "72", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "service", "message": "end: handle", "time": "26 ms"}
2019-01-28 11:06:47,979 INFO lifecycle - event: {"request": "72", "session": "07398278BE145DBF2078FDA3235C51C8", "source": "limiter", "message": "end: nofilter", "time": "28 ms"}
2019-01-28 11:07:46,658 INFO ProcessorService - Servlet destroyed.
2019-01-28 11:07:46,662 INFO QuartzScheduler - Scheduler exist_QuartzScheduler_$_NON_CLUSTERED shutting down.
2019-01-28 11:07:46,662 INFO QuartzScheduler - Scheduler exist_QuartzScheduler_$_NON_CLUSTERED paused.
2019-01-28 11:07:46,664 INFO QuartzScheduler - Scheduler exist_QuartzScheduler_$_NON_CLUSTERED shutdown complete.
2019-01-28 11:07:46,674 INFO FileLock - Deleting lock file: /opt/tomcat-8.5.37_orbeon_digest/webapps/orbeon/WEB-INF/exist-data/journal.lck
2019-01-28 11:07:46,684 INFO FileLock - Deleting lock file: /opt/tomcat-8.5.37_orbeon_digest/webapps/orbeon/WEB-INF/exist-data/dbx_dir.lck
2019-01-28 11:07:46,684 INFO form-runner-auth - destroying
2019-01-28 11:07:46,691 INFO limiter - destroying
2019-01-28 11:07:46,779 INFO ProcessorService - Context listener - Context destroyed.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment