2015-03-05 19:34:59,690 INFO  lifecycle  - event: {"request": "4492", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "limiter", "message": "start: filter", "path": "/xforms-server", "method": "POST"}
2015-03-05 19:34:59,690 INFO  lifecycle  - event: {"request": "4492", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "limiter", "message": "start: chain", "path": "/xforms-server", "method": "POST", "wait": "0"}
2015-03-05 19:34:59,690 INFO  lifecycle  - event: {"request": "4492", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "service", "message": "start: handle"}
2015-03-05 19:34:59,690 INFO  ProcessorService  - /xforms-server - Received request
2015-03-05 19:34:59,721 INFO  lifecycle  - event: {"request": "4492", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "xforms", "message": "ajax with update events", "uuid": "ebfe073c083885493c56d7590e3864399d2df9bf"}
2015-03-05 19:34:59,721 INFO  lifecycle  - event: {"request": "4492", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "xforms", "message": "before document lock", "uuid": "ebfe073c083885493c56d7590e3864399d2df9bf"}
2015-03-05 19:34:59,721 INFO  lifecycle  - event: {"request": "4492", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "xforms", "message": "got document lock", "path": "/xforms-server", "method": "POST", "uuid": "ebfe073c083885493c56d7590e3864399d2df9bf", "wait": "0"}
2015-03-05 19:34:59,970 WARN  XFormsServer  - xxf:instance() - instance not found {instance id: "fr-form-attachments"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-1732">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-1732">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-1768">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-1768">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-1804">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-1804">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-1867">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-1867">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2038">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2038">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2074">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2074">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2235">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2235">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2273">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2273">[...]</xxf:script>"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,813 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2335">[...]</xxf:script>"}
2015-03-05 19:35:00,828 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2335">[...]</xxf:script>"}
2015-03-05 19:35:00,828 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,828 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2371">[...]</xxf:script>"}
2015-03-05 19:35:00,828 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2371">[...]</xxf:script>"}
2015-03-05 19:35:00,828 WARN  XFormsServer  - unknown id {id: "fr-number"}
2015-03-05 19:35:00,828 WARN  XFormsServer  - observer attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2463">[...]</xxf:script>"}
2015-03-05 19:35:00,828 WARN  XFormsServer  - target attribute present but does not refer to at least one valid id, ignoring event handler {element: "<xxf:script ev:target="#observer" ev:observer="fr-number" ev:event="DOMFocusOut" id="xf-2463">[...]</xxf:script>"}
2015-03-05 19:35:01,156 ERROR XFormsServer  - 
+----------------------------------------------------------------------------------------------------------------------+
|An Error has Occurred                                                                                                 |
|----------------------------------------------------------------------------------------------------------------------|
|Duplicate id found for static id: camps-and-buildings_camps_total-merchantable-timber-bind                            |
|----------------------------------------------------------------------------------------------------------------------|
|Application Call Stack                                                                                                |
|----------------------------------------------------------------------------------------------------------------------|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.OXFException                                                                         |
|----------------------------------------------------------------------------------------------------------------------|
|rg.orbeon.oxf.xforms.xbl.XBLBindings$ScopeExtractor|indexElementWithScope         |XBLBindings.scala             | 474|
|org.orbeon.oxf.xforms.analysis.XFormsExtractor     |startElement                  |XFormsExtractor.java          | 371|
|org.dom4j.io.SAXWriter                             |startElement                  |SAXWriter.java                | 810|
|org.orbeon.oxf.xml.dom4j.LocationSAXWriter         |startElement                  |LocationSAXWriter.java        |  79|
|org.dom4j.io.SAXWriter                             |write                         |SAXWriter.java                | 732|
|org.dom4j.io.SAXWriter                             |writeContent                  |SAXWriter.java                | 619|
|org.dom4j.io.SAXWriter                             |write                         |SAXWriter.java                | 733|
|org.dom4j.io.SAXWriter                             |writeContent                  |SAXWriter.java                | 619|
|org.dom4j.io.SAXWriter                             |write                         |SAXWriter.java                | 733|
|org.dom4j.io.SAXWriter                             |writeContent                  |SAXWriter.java                | 619|
|org.dom4j.io.SAXWriter                             |write                         |SAXWriter.java                | 733|
|org.dom4j.io.SAXWriter                             |writeContent                  |SAXWriter.java                | 619|
|org.dom4j.io.SAXWriter                             |write                         |SAXWriter.java                | 733|
|org.dom4j.io.SAXWriter                             |writeContent                  |SAXWriter.java                | 619|
|org.dom4j.io.SAXWriter                             |write                         |SAXWriter.java                | 202|
|org.dom4j.io.SAXWriter                             |write                         |SAXWriter.java                | 164|
|org.orbeon.oxf.xml.dom4j.LocationSAXWriter         |write                         |LocationSAXWriter.java        |  74|
|org.orbeon.oxf.xml.TransformerUtils                |writeDom4j                    |TransformerUtils.java         | 550|
|.xforms.xbl.XBLBindings$$anonfun$annotateSubtree1$3|apply                         |XBLBindings.scala             | 274|
|.xforms.xbl.XBLBindings$$anonfun$annotateSubtree1$3|apply                         |XBLBindings.scala             | 269|
|org.orbeon.oxf.util.Logging$class                  |withDebug                     |Logging.scala                 |  50|
|org.orbeon.oxf.xforms.xbl.XBLBindings              |withDebug                     |XBLBindings.scala             |  46|
|org.orbeon.oxf.xforms.xbl.XBLBindings              |annotateSubtree1              |XBLBindings.scala             | 269|
|g.orbeon.oxf.xforms.analysis.model.ModelBinds$class|org$orbeon$oxf$xforms$analysis|Model.scala                   | 239|
|ModelBinds$$anonfun$rebuildBinds$1$$anonfun$apply$1|apply                         |Model.scala                   | 257|
|ModelBinds$$anonfun$rebuildBinds$1$$anonfun$apply$1|apply                         |Model.scala                   | 257|
|scala.collection.TraversableLike$$anonfun$map$1    |apply                         |TraversableLike.scala         | 244|
|scala.collection.TraversableLike$$anonfun$map$1    |apply                         |TraversableLike.scala         | 244|
|scala.collection.Iterator$class                    |foreach                       |Iterator.scala                | 727|
|scala.collection.AbstractIterator                  |foreach                       |Iterator.scala                |1157|
|scala.collection.IterableLike$class                |foreach                       |IterableLike.scala            |  72|
|scala.collection.AbstractIterable                  |foreach                       |Iterable.scala                |  54|
|scala.collection.TraversableLike$class             |map                           |TraversableLike.scala         | 244|
|scala.collection.AbstractTraversable               |map                           |Traversable.scala             | 105|
|s.analysis.model.ModelBinds$$anonfun$rebuildBinds$1|apply                         |Model.scala                   | 257|
|s.analysis.model.ModelBinds$$anonfun$rebuildBinds$1|apply                         |Model.scala                   | 257|
|n.oxf.xforms.analysis.model.ModelBinds$LazyConstant|result$lzycompute             |Model.scala                   | 211|
|n.oxf.xforms.analysis.model.ModelBinds$LazyConstant|result                        |Model.scala                   | 211|
|n.oxf.xforms.analysis.model.ModelBinds$LazyConstant|apply                         |Model.scala                   | 212|
|g.orbeon.oxf.xforms.analysis.model.ModelBinds$class|topLevelBinds                 |Model.scala                   | 278|
|org.orbeon.oxf.xforms.analysis.model.Model         |topLevelBinds                 |Model.scala                   |  35|
|.oxf.xforms.XFormsModelBindsBase$$anonfun$rebuild$1|apply$mcV$sp                  |XFormsModelBindsBase.scala    | 106|
|.oxf.xforms.XFormsModelBindsBase$$anonfun$rebuild$1|apply                         |XFormsModelBindsBase.scala    |  76|
|.oxf.xforms.XFormsModelBindsBase$$anonfun$rebuild$1|apply                         |XFormsModelBindsBase.scala    |  76|
|org.orbeon.oxf.util.Logging$class                  |withDebug                     |Logging.scala                 |  50|
|org.orbeon.oxf.xforms.XFormsModelBindsBase         |withDebug                     |XFormsModelBindsBase.scala    |  34|
|org.orbeon.oxf.xforms.XFormsModelBindsBase         |rebuild                       |XFormsModelBindsBase.scala    |  76|
|org.orbeon.oxf.xforms.XFormsModelBase              |doRebuild                     |XFormsModelBase.scala         |  73|
|org.orbeon.oxf.xforms.XFormsModel                  |performDefaultAction          |XFormsModel.java              | 396|
|.oxf.xforms.event.Dispatch$$anonfun$dispatchEvent$1|apply$mcV$sp                  |Dispatch.scala                | 137|
|.oxf.xforms.event.Dispatch$$anonfun$dispatchEvent$1|apply                         |Dispatch.scala                |  73|
|.oxf.xforms.event.Dispatch$$anonfun$dispatchEvent$1|apply                         |Dispatch.scala                |  73|
|org.orbeon.oxf.xforms.event.Dispatch$              |withEvent$1                   |Dispatch.scala                |  38|
|org.orbeon.oxf.xforms.event.Dispatch$              |dispatchEvent                 |Dispatch.scala                |  72|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.ValidationException                                                                  |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.common.OrbeonLocationException$     |wrapException                 |OrbeonLocationException.scala |  60|
|org.orbeon.oxf.xforms.event.Dispatch$              |dispatchEvent                 |Dispatch.scala                | 146|
|org.orbeon.oxf.xforms.event.Dispatch               |dispatchEvent                 |Dispatch.scala                |    |
|org.orbeon.oxf.xforms.XFormsModel                  |rebuildRecalculateRevalidateIf|XFormsModel.java              | 721|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|scala.collection.Iterator$class                    |foreach                       |Iterator.scala                | 727|
|scala.collection.AbstractIterator                  |foreach                       |Iterator.scala                |1157|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |rebuildRecalculateRevalidateIf|XBLContainer.scala            | 273|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |rebuildRecalculateRevalidateIf|XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |synchronizeAndRefresh         |XBLContainer.scala            | 260|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |synchronizeAndRefresh         |XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |endOutermostActionHandler     |XBLContainer.scala            | 234|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |endOutermostActionHandler     |XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.XFormsModel                  |rebuildRecalculateRevalidateIf|XFormsModel.java              | 727|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|scala.collection.Iterator$class                    |foreach                       |Iterator.scala                | 727|
|scala.collection.AbstractIterator                  |foreach                       |Iterator.scala                |1157|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |rebuildRecalculateRevalidateIf|XBLContainer.scala            | 273|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |rebuildRecalculateRevalidateIf|XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |synchronizeAndRefresh         |XBLContainer.scala            | 260|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |synchronizeAndRefresh         |XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |endOutermostActionHandler     |XBLContainer.scala            | 234|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |endOutermostActionHandler     |XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.XFormsModel                  |rebuildRecalculateRevalidateIf|XFormsModel.java              | 722|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|scala.collection.Iterator$class                    |foreach                       |Iterator.scala                | 727|
|scala.collection.AbstractIterator                  |foreach                       |Iterator.scala                |1157|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |rebuildRecalculateRevalidateIf|XBLContainer.scala            | 273|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |rebuildRecalculateRevalidateIf|XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |synchronizeAndRefresh         |XBLContainer.scala            | 260|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |synchronizeAndRefresh         |XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |endOutermostActionHandler     |XBLContainer.scala            | 234|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |endOutermostActionHandler     |XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.XFormsModel                  |rebuildRecalculateRevalidateIf|XFormsModel.java              | 727|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|scala.collection.Iterator$class                    |foreach                       |Iterator.scala                | 727|
|---8<--------8<--------8<--------8<--------8<--------8<--------8<--------8<--------8<--------8<--------8<--------8<---|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|scala.collection.Iterator$class                    |foreach                       |Iterator.scala                | 727|
|scala.collection.AbstractIterator                  |foreach                       |Iterator.scala                |1157|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |rebuildRecalculateRevalidateIf|XBLContainer.scala            | 273|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |rebuildRecalculateRevalidateIf|XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |synchronizeAndRefresh         |XBLContainer.scala            | 260|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |synchronizeAndRefresh         |XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |endOutermostActionHandler     |XBLContainer.scala            | 234|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |endOutermostActionHandler     |XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.XFormsModel                  |rebuildRecalculateRevalidateIf|XFormsModel.java              | 727|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|ort$$anonfun$rebuildRecalculateRevalidateIfNeeded$1|apply                         |XBLContainer.scala            | 273|
|scala.collection.Iterator$class                    |foreach                       |Iterator.scala                | 727|
|scala.collection.AbstractIterator                  |foreach                       |Iterator.scala                |1157|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |rebuildRecalculateRevalidateIf|XBLContainer.scala            | 273|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |rebuildRecalculateRevalidateIf|XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |synchronizeAndRefresh         |XBLContainer.scala            | 260|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |synchronizeAndRefresh         |XBLContainer.scala            |  49|
|org.orbeon.oxf.xforms.xbl.RefreshSupport$class     |endOutermostActionHandler     |XBLContainer.scala            | 234|
|org.orbeon.oxf.xforms.xbl.XBLContainer             |endOutermostActionHandler     |XBLContainer.scala            |  49|
|f.xforms.event.ClientEvents$$anonfun$processEvent$1|apply$mcV$sp                  |ClientEvents.scala            | 574|
|f.xforms.event.ClientEvents$$anonfun$processEvent$1|apply                         |ClientEvents.scala            | 536|
|f.xforms.event.ClientEvents$$anonfun$processEvent$1|apply                         |ClientEvents.scala            | 536|
|org.orbeon.oxf.util.Logging$class                  |withDebug                     |Logging.scala                 |  50|
|org.orbeon.oxf.xforms.event.ClientEvents$          |withDebug                     |ClientEvents.scala            |  37|
|org.orbeon.oxf.xforms.event.ClientEvents$          |processEvent                  |ClientEvents.scala            | 536|
|.xforms.event.ClientEvents$$anonfun$processEvents$1|apply                         |ClientEvents.scala            | 143|
|.xforms.event.ClientEvents$$anonfun$processEvents$1|apply                         |ClientEvents.scala            | 142|
|scala.collection.immutable.List                    |foreach                       |List.scala                    | 318|
|org.orbeon.oxf.xforms.event.ClientEvents$          |processEvents                 |ClientEvents.scala            | 142|
|org.orbeon.oxf.xforms.event.ClientEvents           |processEvents                 |ClientEvents.scala            |    |
|org.orbeon.oxf.xforms.processor.XFormsServer$2     |run                           |XFormsServer.java             | 260|
|ion.XFormsAPI$$anonfun$withContainingDocumentJava$1|apply$mcV$sp                  |XFormsAPI.scala               |  55|
|ion.XFormsAPI$$anonfun$withContainingDocumentJava$1|apply                         |XFormsAPI.scala               |  55|
|ion.XFormsAPI$$anonfun$withContainingDocumentJava$1|apply                         |XFormsAPI.scala               |  55|
|org.orbeon.oxf.util.DynamicVariable                |withValue                     |DynamicVariable.scala         |  42|
|org.orbeon.oxf.xforms.action.XFormsAPI$            |withContainingDocument        |XFormsAPI.scala               |  60|
|org.orbeon.oxf.xforms.action.XFormsAPI$            |withContainingDocumentJava    |XFormsAPI.scala               |  54|
|org.orbeon.oxf.xforms.action.XFormsAPI             |withContainingDocumentJava    |XFormsAPI.scala               |    |
|org.orbeon.oxf.xforms.processor.XFormsServer       |doIt                          |XFormsServer.java             | 243|
|----------------------------------------------------------------------------------------------------------------------|
|Exception: org.orbeon.oxf.common.OXFException                                                                         |
|----------------------------------------------------------------------------------------------------------------------|
|org.orbeon.oxf.xforms.processor.XFormsServer       |doIt                          |XFormsServer.java             | 375|
|org.orbeon.oxf.xforms.processor.XFormsServer       |access$000                    |XFormsServer.java             |  63|
|org.orbeon.oxf.xforms.processor.XFormsServer$1     |readImpl                      |XFormsServer.java             |  90|
|essor.impl.ProcessorOutputImpl$TopLevelOutputFilter|read                          |ProcessorOutputImpl.java      | 257|
|eteRuntimeOutputFilter$ForwarderRuntimeOutputOutput|read                          |ProcessorOutputImpl.java      | 218|
|org.orbeon.oxf.processor.ProcessorImpl             |readInputAsSAX                |ProcessorImpl.java            | 262|
|n.oxf.processor.validation.MSVValidationProcessor$3|readImpl                      |MSVValidationProcessor.java   | 221|
|essor.impl.ProcessorOutputImpl$TopLevelOutputFilter|read                          |ProcessorOutputImpl.java      | 257|
|org.orbeon.oxf.processor.impl.ProcessorOutputImpl  |read                          |ProcessorOutputImpl.java      | 394|
|mpl.ProcessorOutputImpl$ConcreteRuntimeOutputFilter|read                          |ProcessorOutputImpl.java      | 241|
|org.orbeon.oxf.processor.impl.ProcessorOutputImpl  |read                          |ProcessorOutputImpl.java      | 394|
|org.orbeon.oxf.processor.ProcessorImpl             |readInputAsSAX                |ProcessorImpl.java            | 262|
|rg.orbeon.oxf.processor.converter.TextConverterBase|readInput                     |TextConverterBase.java        | 113|
|rg.orbeon.oxf.processor.converter.TextConverterBase|access$000                    |TextConverterBase.java        |  39|
|.orbeon.oxf.processor.converter.TextConverterBase$1|readImpl                      |TextConverterBase.java        |  91|
|essor.impl.ProcessorOutputImpl$TopLevelOutputFilter|read                          |ProcessorOutputImpl.java      | 257|
|org.orbeon.oxf.processor.impl.ProcessorOutputImpl  |read                          |ProcessorOutputImpl.java      | 394|
|org.orbeon.oxf.processor.ProcessorImpl             |readInputAsSAX                |ProcessorImpl.java            | 262|
|org.orbeon.oxf.processor.serializer.HttpSerializer |readInput                     |HttpSerializer.java           |  42|
|.orbeon.oxf.processor.serializer.HttpSerializerBase|start                         |HttpSerializerBase.java       | 205|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run                           |PipelineProcessor.java        | 618|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren               |PipelineProcessor.java        | 680|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start                         |PipelineProcessor.java        | 615|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start                         |ConcreteChooseProcessor.java  | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run                           |PipelineProcessor.java        | 618|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren               |PipelineProcessor.java        | 680|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start                         |PipelineProcessor.java        | 615|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run                           |PipelineProcessor.java        | 618|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren               |PipelineProcessor.java        | 680|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start                         |PipelineProcessor.java        | 615|
|f.processor.pipeline.choose.ConcreteChooseProcessor|start                         |ConcreteChooseProcessor.java  | 231|
|g.orbeon.oxf.processor.pipeline.PipelineProcessor$4|run                           |PipelineProcessor.java        | 618|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|executeChildren               |PipelineProcessor.java        | 680|
|org.orbeon.oxf.processor.pipeline.PipelineProcessor|start                         |PipelineProcessor.java        | 615|
|org.orbeon.oxf.pipeline.InitUtils$                 |runProcessor                  |InitUtils.scala               |  82|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply$mcV$sp                  |ProcessorService.scala        |  45|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply                         |ProcessorService.scala        |  40|
|beon.oxf.webapp.ProcessorService$$anonfun$service$1|apply                         |ProcessorService.scala        |  40|
|org.orbeon.oxf.logging.LifecycleLogger$            |withEvent                     |LifecycleLogger.scala         | 124|
|org.orbeon.oxf.logging.LifecycleLogger$            |withEventAssumingRequest      |LifecycleLogger.scala         | 117|
|org.orbeon.oxf.webapp.ProcessorService             |service                       |ProcessorService.scala        |  40|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp                  |OrbeonServlet.scala           |  79|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply                         |OrbeonServlet.scala           |  72|
|nServlet$$anonfun$service$1$$anonfun$apply$mcV$sp$1|apply                         |OrbeonServlet.scala           |  72|
|org.orbeon.oxf.util.ScalaUtils$                    |withRootException             |ScalaUtils.scala              |  83|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply$mcV$sp                  |OrbeonServlet.scala           |  72|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply                         |OrbeonServlet.scala           |  72|
|orbeon.oxf.servlet.OrbeonServlet$$anonfun$service$1|apply                         |OrbeonServlet.scala           |  72|
|org.orbeon.oxf.util.DynamicVariable                |withValue                     |DynamicVariable.scala         |  42|
|org.orbeon.oxf.servlet.OrbeonServlet               |service                       |OrbeonServlet.scala           |  71|
|javax.servlet.http.HttpServlet                     |service                       |HttpServlet.java              | 727|
|org.apache.catalina.core.ApplicationFilterChain    |internalDoFilter              |ApplicationFilterChain.java   | 303|
|org.apache.catalina.core.ApplicationFilterChain    |doFilter                      |ApplicationFilterChain.java   | 208|
|org.apache.tomcat.websocket.server.WsFilter        |doFilter                      |WsFilter.java                 |  52|
|org.apache.catalina.core.ApplicationFilterChain    |internalDoFilter              |ApplicationFilterChain.java   | 241|
|org.apache.catalina.core.ApplicationFilterChain    |doFilter                      |ApplicationFilterChain.java   | 208|
|doFilter$1$$anonfun$apply$1$$anonfun$apply$mcV$sp$1|apply$mcV$sp                  |LimiterFilter.scala           |  85|
|doFilter$1$$anonfun$apply$1$$anonfun$apply$mcV$sp$1|apply                         |LimiterFilter.scala           |  85|
|doFilter$1$$anonfun$apply$1$$anonfun$apply$mcV$sp$1|apply                         |LimiterFilter.scala           |  85|
|org.orbeon.oxf.logging.LifecycleLogger$            |withEvent                     |LifecycleLogger.scala         | 124|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$1|apply$mcV$sp                  |LimiterFilter.scala           |  84|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$1|apply                         |LimiterFilter.scala           |  78|
|.LimiterFilter$$anonfun$doFilter$1$$anonfun$apply$1|apply                         |LimiterFilter.scala           |  78|
|org.orbeon.oxf.logging.LifecycleLogger$            |withEvent                     |LifecycleLogger.scala         | 124|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply                         |LimiterFilter.scala           |  78|
|rbeon.oxf.servlet.LimiterFilter$$anonfun$doFilter$1|apply                         |LimiterFilter.scala           |  72|
|scala.Option                                       |foreach                       |Option.scala                  | 236|
|org.orbeon.oxf.servlet.LimiterFilter               |doFilter                      |LimiterFilter.scala           |  72|
|org.apache.catalina.core.ApplicationFilterChain    |internalDoFilter              |ApplicationFilterChain.java   | 241|
|org.apache.catalina.core.ApplicationFilterChain    |doFilter                      |ApplicationFilterChain.java   | 208|
|org.apache.catalina.core.StandardWrapperValve      |invoke                        |StandardWrapperValve.java     | 220|
|org.apache.catalina.core.StandardContextValve      |invoke                        |StandardContextValve.java     | 122|
|org.apache.catalina.authenticator.AuthenticatorBase|invoke                        |AuthenticatorBase.java        | 503|
|org.apache.catalina.core.StandardHostValve         |invoke                        |StandardHostValve.java        | 170|
|org.apache.catalina.valves.ErrorReportValve        |invoke                        |ErrorReportValve.java         | 103|
|org.apache.catalina.valves.AccessLogValve          |invoke                        |AccessLogValve.java           | 950|
|org.apache.catalina.core.StandardEngineValve       |invoke                        |StandardEngineValve.java      | 116|
|org.apache.catalina.connector.CoyoteAdapter        |service                       |CoyoteAdapter.java            | 421|
|org.apache.coyote.http11.AbstractHttp11Processor   |process                       |AbstractHttp11Processor.java  |1070|
|e.coyote.AbstractProtocol$AbstractConnectionHandler|process                       |AbstractProtocol.java         | 611|
|.apache.tomcat.util.net.JIoEndpoint$SocketProcessor|run                           |JIoEndpoint.java              | 314|
|java.util.concurrent.ThreadPoolExecutor            |runWorker                     |ThreadPoolExecutor.java       |1145|
|java.util.concurrent.ThreadPoolExecutor$Worker     |run                           |ThreadPoolExecutor.java       | 615|
|che.tomcat.util.threads.TaskThread$WrappingRunnable|run                           |TaskThread.java               |  61|
|java.lang.Thread                                   |run                           |Thread.java                   | 744|
+----------------------------------------------------------------------------------------------------------------------+
2015-03-05 19:35:01,156 INFO  ProcessorService  - /xforms-server - Timing: 1466
2015-03-05 19:35:01,156 INFO  lifecycle  - event: {"request": "4492", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "service", "message": "end: handle", "time": "1,466 ms"}
2015-03-05 19:35:01,156 INFO  lifecycle  - event: {"request": "4492", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "limiter", "message": "end: chain", "time": "1,466 ms"}
2015-03-05 19:35:01,156 INFO  lifecycle  - event: {"request": "4492", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "limiter", "message": "end: filter", "time": "1,466 ms"}
2015-03-05 19:35:01,328 INFO  lifecycle  - event: {"request": "4493", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "limiter", "message": "start: filter", "path": "/xforms-server", "method": "POST"}
2015-03-05 19:35:01,328 INFO  lifecycle  - event: {"request": "4493", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "limiter", "message": "start: chain", "path": "/xforms-server", "method": "POST", "wait": "0"}
2015-03-05 19:35:01,328 INFO  lifecycle  - event: {"request": "4493", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "service", "message": "start: handle"}
2015-03-05 19:35:01,328 INFO  ProcessorService  - /xforms-server - Received request
2015-03-05 19:35:01,343 INFO  lifecycle  - event: {"request": "4493", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "xforms", "message": "ajax with update events", "uuid": "ebfe073c083885493c56d7590e3864399d2df9bf"}
2015-03-05 19:35:01,343 INFO  lifecycle  - event: {"request": "4493", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "xforms", "message": "before document lock", "uuid": "ebfe073c083885493c56d7590e3864399d2df9bf"}
2015-03-05 19:35:01,343 INFO  lifecycle  - event: {"request": "4493", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "xforms", "message": "Unknown form document requested."}
2015-03-05 19:35:01,343 INFO  XFormsServer  - Unknown form document requested.
2015-03-05 19:35:01,343 INFO  ProcessorService  - /xforms-server - Timing: 15
2015-03-05 19:35:01,343 INFO  lifecycle  - event: {"request": "4493", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "service", "message": "end: handle", "time": "15 ms"}
2015-03-05 19:35:01,343 INFO  lifecycle  - event: {"request": "4493", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "limiter", "message": "end: chain", "time": "15 ms"}
2015-03-05 19:35:01,343 INFO  lifecycle  - event: {"request": "4493", "session": "CFEDFF3D3529576648DB247C22F4A2E2", "source": "limiter", "message": "end: filter", "time": "15 ms"}