Skip to content

Instantly share code, notes, and snippets.

@avernet
Created January 12, 2011 06:13
Show Gist options
  • Save avernet/775765 to your computer and use it in GitHub Desktop.
Save avernet/775765 to your computer and use it in GitHub Desktop.
While uploading large file
2011-01-11 23:03:36,294 INFO ProcessorService - /xforms-server - Received request
2011-01-11 23:03:36,304 DEBUG XFormsServer - ajax request {body: "
<xxforms:event-request xmlns:xxforms="http://orbeon.org/oxf/xml/xforms">
<xxforms:uuid>E7121315-1231-4234-06D5-9EC5C36BF37E</xxforms:uuid>
<xxforms:sequence>1</xxforms:sequence>
<xxforms:action>
<xxforms:event name="DOMFocusIn" source-control-id="xf-20·1"/>
<xxforms:event name="DOMFocusIn" source-control-id="file-repeat·1"/>
</xxforms:action>
</xxforms:event-request>"}
2011-01-11 23:03:36,307 DEBUG XFormsServer - start handling external events and/or uploaded files
2011-01-11 23:03:36,307 DEBUG XFormsServer - executeExternalEvent - start handling external event {target id: "xf-20·1", event name: "DOMFocusIn"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - start dispatching {name: "xxforms-repeat-focus", id: "xf-20·1"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - start default action handler
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - end default action handler {time (ms): "0"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - end dispatching {time (ms): "0", name: "xxforms-repeat-focus", id: "xf-20·1"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - start dispatching {name: "DOMFocusIn", id: "xf-20·1"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - start default action handler
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - end default action handler {time (ms): "0"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - end dispatching {time (ms): "0", name: "DOMFocusIn", id: "xf-20·1"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - executeExternalEvent - end handling external event {time (ms): "1"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - executeExternalEvent - start handling external event {target id: "file-repeat·1", event name: "DOMFocusIn"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - start dispatching {name: "xxforms-repeat-focus", id: "file-repeat·1"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - start default action handler
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - end default action handler {time (ms): "0"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - end dispatching {time (ms): "0", name: "xxforms-repeat-focus", id: "file-repeat·1"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - start dispatching {name: "DOMFocusIn", id: "file-repeat·1"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - start default action handler
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - end default action handler {time (ms): "0"}
2011-01-11 23:03:36,308 DEBUG XFormsServer - dispatchEvent - end dispatching {time (ms): "0", name: "DOMFocusIn", id: "file-repeat·1"}
2011-01-11 23:03:36,309 DEBUG XFormsServer - executeExternalEvent - end handling external event {time (ms): "1"}
2011-01-11 23:03:36,309 DEBUG XFormsServer - end handling external events and/or uploaded files {time (ms): "5"}
2011-01-11 23:03:36,309 DEBUG XFormsServer - response - start handling regular Ajax response
2011-01-11 23:03:36,309 DEBUG XFormsServer - start computing differences
2011-01-11 23:03:36,309 DEBUG XFormsServer - end computing differences {time (ms): "0"}
2011-01-11 23:03:36,309 DEBUG XFormsServer - response - end handling regular Ajax response {time (ms): "0", ajax response: "
<xxf:event-response xmlns:xxf="http://orbeon.org/oxf/xml/xforms">
<xxf:action>
<xxf:control-values/>
</xxf:action>
</xxf:event-response>"}
2011-01-11 23:03:36,312 INFO ProcessorService - /xforms-server - Timing: 18 - Cache hits for cache.main: 24, fault: 1, adds: 0, expirations: 0, success rate: 96%
2011-01-11 23:03:39,224 INFO ProcessorService - /xforms-server - Received request
2011-01-11 23:03:40,823 INFO ProcessorService - /xforms-server - Received request
2011-01-11 23:03:40,831 DEBUG XFormsServer - ajax request {body: "
<xxforms:event-request xmlns:xxforms="http://orbeon.org/oxf/xml/xforms">
<xxforms:uuid>E7121315-1231-4234-06D5-9EC5C36BF37E</xxforms:uuid>
<xxforms:sequence>2</xxforms:sequence>
<xxforms:action>
<xxforms:event name="xxforms-upload-start" source-control-id="xf-20·1"/>
</xxforms:action>
</xxforms:event-request>"}
2011-01-11 23:03:40,831 DEBUG XFormsServer - start handling external events and/or uploaded files
2011-01-11 23:03:40,831 DEBUG XFormsServer - executeExternalEvent - start handling external event {target id: "xf-20·1", event name: "xxforms-upload-start"}
2011-01-11 23:03:40,832 DEBUG XFormsServer - dispatchEvent - start dispatching {name: "xxforms-repeat-focus", id: "xf-20·1"}
2011-01-11 23:03:40,832 DEBUG XFormsServer - dispatchEvent - start default action handler
2011-01-11 23:03:40,832 DEBUG XFormsServer - dispatchEvent - end default action handler {time (ms): "0"}
2011-01-11 23:03:40,832 DEBUG XFormsServer - dispatchEvent - end dispatching {time (ms): "1", name: "xxforms-repeat-focus", id: "xf-20·1"}
2011-01-11 23:03:40,832 DEBUG XFormsServer - dispatchEvent - start dispatching {name: "xxforms-upload-start", id: "xf-20·1"}
2011-01-11 23:03:40,832 DEBUG XFormsServer - dispatchEvent - start default action handler
2011-01-11 23:03:40,832 DEBUG XFormsServer - dispatchEvent - end default action handler {time (ms): "0"}
2011-01-11 23:03:40,832 DEBUG XFormsServer - dispatchEvent - end dispatching {time (ms): "0", name: "xxforms-upload-start", id: "xf-20·1"}
2011-01-11 23:03:40,832 DEBUG XFormsServer - executeExternalEvent - end handling external event {time (ms): "1"}
2011-01-11 23:03:40,832 DEBUG XFormsServer - end handling external events and/or uploaded files {time (ms): "1"}
2011-01-11 23:03:40,832 DEBUG XFormsServer - response - start handling regular Ajax response
2011-01-11 23:03:40,832 DEBUG XFormsServer - response - end handling regular Ajax response {time (ms): "0", ajax response: "
<xxf:event-response xmlns:xxf="http://orbeon.org/oxf/xml/xforms">
<xxf:action>
<xxf:control-values/>
</xxf:action>
</xxf:event-response>"}
2011-01-11 23:03:40,835 INFO ProcessorService - /xforms-server - Timing: 12 - Cache hits for cache.main: 24, fault: 1, adds: 0, expirations: 0, success rate: 96%
2011-01-11 23:03:42,853 INFO ProcessorService - /xforms-server - Received request
2011-01-11 23:03:42,870 DEBUG XFormsServer - ajax request {body: "
<xxforms:event-request xmlns:xxforms="http://orbeon.org/oxf/xml/xforms">
<xxforms:uuid>E7121315-1231-4234-06D5-9EC5C36BF37E</xxforms:uuid>
<xxforms:sequence>3</xxforms:sequence>
<xxforms:action>
<xxforms:event name="xxforms-upload-progress" source-control-id="xf-20·1"/>
</xxforms:action>
</xxforms:event-request>"}
2011-01-11 23:03:42,874 INFO ProcessorService - /xforms-server - Timing: 21 - Cache hits for cache.main: 24, fault: 1, adds: 0, expirations: 0, success rate: 96%
2011-01-11 23:03:51,049 INFO ProcessorService - /xforms-server - Timing: 11825 - Cache hits for cache.main: 15, fault: 0, adds: 0, expirations: 0, success rate: 100%
2011-01-11 23:03:51,299 INFO ProcessorService - /xforms-server - Received request
2011-01-11 23:03:51,307 DEBUG XFormsServer - ajax request {body: "
<xxforms:event-request xmlns:xxforms="http://orbeon.org/oxf/xml/xforms">
<xxforms:uuid>E7121315-1231-4234-06D5-9EC5C36BF37E</xxforms:uuid>
<xxforms:sequence>4</xxforms:sequence>
<xxforms:action>
<xxforms:event name="xxforms-server-events">X2ztnLbujs+XqidA9K0QDA7tCYzZMUxkjxJtoyE88X5stZACrfP2PPRJ9l6jj/WRL+dgF0Q5Ytno64SqBaLkhhSkVpdkmuMFHxenCZoWvno/Byq6z3XKqtzH9bIFVg8NAuu12bGDv6xyxCvFn4O+arxn+F4YrZtDEXv6pF6qBDOxodD+OZP6TwuRhQ+eAGRkgYEBFFD3KEqWSuumcEFMSKRnOi4HfedT6ureKE1RwUQMmhFGtpz1vc6EfwVXF1kNPQJgswjcYmBZOOLnB94OecCeWemomiif7CwDqrKukOzOH6czCCITcR5dSWe4AYyhMbec2uNZWWs+SWvbCNKYyZNatOn4B2DtRamID5iCIxg3jbhjSWB1lJsOIeYonCs7HVF+P5w0/Q7fvMUjeGtxSCBWGiV5b01KiWP1FAsygXNVIdRQsyc6Q93jJ1cNbU8xdZkHmoNWMIOsTMviUVmiK8x7Ra0Cechy/GkLmr/d+tG/P/kKOKm0xtGAStpR37yQk23AQsKFZvAiFJSxBX1fa4BL6Jgt6O4b5COtpci2T2qF6hmMCExZuMq5j3Bfs5TYFG</xxforms:event>
</xxforms:action>
</xxforms:event-request>"}
2011-01-11 23:03:51,307 ERROR ProcessorService - Exception at line 55, column 65 of oxf:/ops/xforms/xforms-server.xpl (reading processor output: name='response', id='xforms-response')
org.orbeon.oxf.common.OXFException: Got unexpected request sequence number
at org.orbeon.oxf.xforms.processor.XFormsServer.doIt(XFormsServer.java:410)
at org.orbeon.oxf.xforms.processor.XFormsServer.access$000(XFormsServer.java:54)
at org.orbeon.oxf.xforms.processor.XFormsServer$1.readImpl(XFormsServer.java:86)
at org.orbeon.oxf.processor.impl.ProcessorOutputImpl$TopLevelOutputFilter.read(ProcessorOutputImpl.java:263)
at org.orbeon.oxf.processor.impl.ProcessorOutputImpl.read(ProcessorOutputImpl.java:406)
at org.orbeon.oxf.processor.ProcessorImpl.readInputAsSAX(ProcessorImpl.java:257)
at org.orbeon.oxf.processor.pipeline.TeeProcessor.access$200(TeeProcessor.java:32)
at org.orbeon.oxf.processor.pipeline.TeeProcessor$TeeProcessorOutputImpl.readImpl(TeeProcessor.java:89)
at org.orbeon.oxf.processor.impl.ProcessorOutputImpl$TopLevelOutputFilter.read(ProcessorOutputImpl.java:263)
at org.orbeon.oxf.processor.impl.ProcessorOutputImpl.read(ProcessorOutputImpl.java:406)
at org.orbeon.oxf.processor.ProcessorImpl.readInputAsSAX(ProcessorImpl.java:257)
at org.orbeon.oxf.processor.ProcessorImpl.readInputAsTinyTree(ProcessorImpl.java:283)
at org.orbeon.oxf.processor.ProcessorImpl$3.read(ProcessorImpl.java:316)
at org.orbeon.oxf.processor.ProcessorImpl.readCacheInputAsObject(ProcessorImpl.java:391)
at org.orbeon.oxf.processor.ProcessorImpl.readCacheInputAsObject(ProcessorImpl.java:331)
at org.orbeon.oxf.processor.ProcessorImpl.readCacheInputAsTinyTree(ProcessorImpl.java:314)
at org.orbeon.oxf.processor.pipeline.choose.ConcreteChooseProcessor.start(ConcreteChooseProcessor.java:186)
at org.orbeon.oxf.processor.pipeline.PipelineProcessor$5.run(PipelineProcessor.java:661)
at org.orbeon.oxf.processor.pipeline.PipelineProcessor.executeChildren(PipelineProcessor.java:726)
at org.orbeon.oxf.processor.pipeline.PipelineProcessor.start(PipelineProcessor.java:658)
at org.orbeon.oxf.processor.pipeline.choose.ConcreteChooseProcessor.start(ConcreteChooseProcessor.java:248)
at org.orbeon.oxf.processor.pipeline.PipelineProcessor$5.run(PipelineProcessor.java:661)
at org.orbeon.oxf.processor.pipeline.PipelineProcessor.executeChildren(PipelineProcessor.java:726)
at org.orbeon.oxf.processor.pipeline.PipelineProcessor.start(PipelineProcessor.java:658)
at org.orbeon.oxf.pipeline.InitUtils.runProcessor(InitUtils.java:83)
at org.orbeon.oxf.webapp.ProcessorService.service(ProcessorService.java:97)
at org.orbeon.oxf.servlet.OrbeonServletDelegate.service(OrbeonServletDelegate.java:133)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:803)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:210)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:174)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:433)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:151)
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:870)
at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:685)
at java.lang.Thread.run(Thread.java:680)
2011-01-11 23:03:51,308 INFO ProcessorService - /xforms-server - Timing: 9 - Cache hits for cache.main: 20, fault: 1, adds: 0, expirations: 0, success rate: 95%
2011-01-11 23:03:51,308 INFO ProcessorService - /xforms-server - Received request
2011-01-11 23:03:51,323 INFO ProcessorService - /xforms-server - Timing: 15 - Cache hits for cache.main: 8, fault: 0, adds: 0, expirations: 0, success rate: 100%
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment