09:19:42.909:IFCS6:DEBUG:nativeFocus:onfocus fired on: [TextItem ID:isc_TextItem_2 name:COC_FIELD_DESCRIPTION], activeElement: INPUT
09:19:43.081:TMR9:DEBUG:EventHandler:mousing over [ListGrid ID:lookupData]
09:19:43.465:TMR1:DEBUG:EventHandler:mousing out of [ListGrid ID:lookupData]  mousing over [GridBody ID:lookupData_body]
09:19:44.349:TMR9:DEBUG:EventHandler:mousing out of [GridBody ID:lookupData_body]  mousing over [ListGrid ID:lookupData]
09:19:44.377:TMR7:DEBUG:EventHandler:mousing out of [ListGrid ID:lookupData]  
09:19:44.408:TMR2:DEBUG:EventHandler:mousing over [IButton ID:isc_IButton_1]
09:19:44.461:TMR7:DEBUG:EventHandler:mousing out of [IButton ID:isc_IButton_1]  
09:19:44.935:TMR8:DEBUG:EventHandler:mousing over [IButton ID:isc_IButton_1]
09:19:45.650:MDN1:INFO:EventHandler:Target Canvas for event 'mousedown': [IButton ID:isc_IButton_1]
09:19:45.659:MDN1:DEBUG:EventHandler:Bubbling event 'prepareForDragging', target '[IButton ID:isc_IButton_1]' has handler: Canvas.prepareForDragging()
09:19:45.666:MDN1:DEBUG:EventHandler:Event 'prepareForDragging' bubbled to top
09:19:45.673:MDN1:DEBUG:dragDrop:No dragTarget, not dragging
09:19:45.686:MDN1:DEBUG:EventHandler:Event 'mouseDown' bubbled to top
09:19:45.695:MDN1:INFO:nativeFocus:isc_IButton_1:about to call native focus()
    Canvas.setFocus(_1=>true, _2=>undef)
    Canvas.focus(_1=>undef)
    [c]EventHandler._$observed_doHandleMouseDown(_1=>Obj{type:mousedown}, _2=>undef)
    doHandleMouseDownObservation(Obj{type:mousedown}, undef)
    [c]EventHandler.handleMouseDown(_1=>Obj{type:mousedown}, _2=>undef)
    [c]EventHandler.dispatch(_1=>[c]EventHandler.handleMouseDown(), _2=>undef)
    anonymous(event=>undef)
        "if (!isc.Browser.isIE && event == null) return;var returnVal=arguments.callee.$ch.isc.EH.dispatch(arguments.callee.$j2,event);return returnVal;"

09:19:45.712:selectionchange2:INFO:EventHandler:Target Canvas for event 'selectionchange': [DynamicForm ID:isc_DynamicForm_0]
09:19:45.719:selectionchange2:DEBUG:EventHandler:Event 'selectionChange' bubbled to top
09:19:45.725:IBLR3:DEBUG:TextItem:isc_TextItem_2[COC_FIELD_DESCRIPTION]:native change
09:19:45.729:IBLR3:DEBUG:nativeFocus:onblur fired on: [TextItem ID:isc_TextItem_2 name:COC_FIELD_DESCRIPTION], activeElement: DIV
09:19:45.732:FCS4:DEBUG:nativeFocus:onfocus fired on: [IButton ID:isc_IButton_1], activeElement: DIV
09:19:45.745:MUP5:INFO:EventHandler:Target Canvas for event 'mouseup': [IButton ID:isc_IButton_1]
09:19:45.752:MUP5:DEBUG:EventHandler:Event 'mouseUp' bubbled to top
09:19:45.756:MUP5:DEBUG:gridEdit:lookupData:change detection: newValues: {COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test4"}, oldValues: {COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test8"}
09:19:45.760:MUP5:DEBUG:gridEdit:lookupData:At field: COC_FIELD_ID applying validators: [
{type: "isString",
typeCastValidator: true,
_generated: true,
stopIfFalse: true},
{expression: "true",
type: "requiredIf"},
{clientOnly: true,
expression: "^[a-zA-Z _]+$",
stopIfFalse: false,
type: "regexp"},
{type: "isString",
typeCastValidator: true,
_generated: true,
stopIfFalse: true}
] to value:TEST_TYPE
09:19:45.764:MUP5:INFO:gridEdit:lookupData:validateFieldValue, newValue: "TEST_TYPE", passed validation: true, resultingValue: null
09:19:45.770:MUP5:DEBUG:gridEdit:lookupData:At field: COC_FIELD_DESCRIPTION applying validators: [
{type: "isString",
typeCastValidator: true,
_generated: true,
stopIfFalse: true,
defaultErrorMessage: undef},
{expression: "true",
type: "requiredIf"},
{type: "serverCustom",
errorMessage: "$errorInLookUpDesc"},
{type: "isString",
typeCastValidator: true,
_generated: true,
stopIfFalse: true,
defaultErrorMessage: undef}
] to value:test4
09:19:45.774:MUP5:INFO:gridEdit:lookupData:validateFieldValue, newValue: "test4", passed validation: true, resultingValue: null
09:19:45.777:MUP5:INFO:RPCManager:sendQueue called with no current queue, ignoring
09:19:45.789:MUP5:INFO:gridEdit:lookupData:Saving newValues '{COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test4"}'
09:19:45.793:MUP5:DEBUG:DataSource:VCOC_LOOKUP_TABLE_test:Outbound DSRequest: {operationType: "update",
dataSource: "VCOC_LOOKUP_TABLE_test",
data: Obj,
callback: "lookupData.$337(dsResponse, dsRequest)",
requestId: "VCOC_LOOKUP_TABLE_test$6271",
useStrictJSON: null,
fallbackToEval: false,
textMatchStyle: "exact",
operationId: undef,
application: undef,
willHandleError: true,
showPrompt: false,
oldValues: Obj,
internalClientContext: Obj,
componentId: "lookupData",
clientTiming: Obj{name:Client processing},
clientTimingStack: Array[2],
lastClientEventThreadCode: "MUP5",
parentNode: null,
bypassCache: true}
09:19:45.798:MUP5:INFO:DataSource:VCOC_LOOKUP_TABLE_test:Calling convertRelativeDates from sendDSRequest - data is

null
09:19:45.807:MUP5:INFO:AdvancedCriteria:Criteria object:{COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test4"} not explicitly marked as AdvancedCriteria - treating as SimpleCriteria.
09:19:45.810:MUP5:INFO:DataSource:VCOC_LOOKUP_TABLE_test:Called convertRelativeDates from sendDSRequest - data is

{
    "COC_FIELD_ID":"TEST_TYPE", 
    "COC_FIELD_DESCRIPTION":"test4"
}
09:19:45.816:MUP5:INFO:AdvancedCriteria:Criteria object:{COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test4"} not explicitly marked as AdvancedCriteria - treating as SimpleCriteria.
09:19:45.819:MUP5:INFO:AdvancedCriteria:Criteria object:{COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test8"} not explicitly marked as AdvancedCriteria - treating as SimpleCriteria.
09:19:45.822:MUP5:INFO:DataSource:VCOC_LOOKUP_TABLE_test:performDSOperation(update) 1 records
09:19:45.826:MUP5:DEBUG:RPCManager:Using ActiveX XMLHttpRequest via constructor: MSXML2.XMLHTTP
09:19:45.856:MUP5:INFO:RPCManager:sendQueue[1]: 1 RPCRequest(s); transport: xmlHttpRequest; target: http://172.20.164.61:9080/ERP/isomorphic/IDACall?isc_rpc=1&isc_v=v9.1p_2014-12-03&isc_xhr=1
09:19:45.883:MUP5:DEBUG:RPCManager:Using ActiveX XMLHttpRequest via constructor: MSXML2.XMLHTTP
09:19:45.892:MUP5:DEBUG:RPCManager:XMLHttpRequest POST to http://172.20.164.61:9080/ERP/isomorphic/IDACall?isc_rpc=1&isc_v=v9.1p_2014-12-03&isc_xhr=1 contentType: application/x-www-form-urlencoded; charset=UTF-8 with body -->isc_tnum=1&_transaction=<transaction xmlns:xsi="http://www.w3.org/2000/10/XMLSchema-instance" xsi:type="xsd:Object"><transactionNum xsi:type="xsd:long">1</transactionNum><operations xsi:type="xsd:List"><elem xsi:type="xsd:Object"><criteria xsi:type="xsd:Object"><COC_FIELD_ID>TEST_TYPE</COC_FIELD_ID></criteria><values xsi:type="xsd:Object"><COC_FIELD_ID>TEST_TYPE</COC_FIELD_ID><COC_FIELD_DESCRIPTION>test4</COC_FIELD_DESCRIPTION></values><operationConfig xsi:type="xsd:Object"><dataSource>VCOC_LOOKUP_TABLE_test</dataSource><operationType>update</operationType><textMatchStyle>exact</textMatchStyle></operationConfig><componentId>lookupData</componentId><appID>builtinApplication</appID><operation>VCOC_LOOKUP_TABLE_test_update</operation><oldValues xsi:type="xsd:Object"><COC_FIELD_ID>TEST_TYPE</COC_FIELD_ID><COC_FIELD_DESCRIPTION>test8</COC_FIELD_DESCRIPTION></oldValues></elem></operations></transaction>&protocolVersion=1.0<--
09:19:45.897:MUP5:DEBUG:gridEdit:lookupData:change detection: newValues: {COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test4"}, oldValues: {COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test8"}
09:19:45.907:MUP5:DEBUG:gridEdit:lookupData:At field: COC_FIELD_ID applying validators: [
{type: "isString",
typeCastValidator: true,
_generated: true,
stopIfFalse: true,
defaultErrorMessage: undef},
{expression: expression(),
type: "requiredIf",
defaultErrorMessage: undef,
errorMessage: "Field is required"},
{clientOnly: true,
expression: "^[a-zA-Z _]+$",
stopIfFalse: false,
type: "regexp",
defaultErrorMessage: undef},
{type: "isString",
typeCastValidator: true,
_generated: true,
stopIfFalse: true,
defaultErrorMessage: undef}
] to value:TEST_TYPE
09:19:45.913:MUP5:INFO:gridEdit:lookupData:validateFieldValue, newValue: "TEST_TYPE", passed validation: true, resultingValue: null
09:19:45.937:MUP5:DEBUG:gridEdit:lookupData:At field: COC_FIELD_DESCRIPTION applying validators: [
{type: "isString",
typeCastValidator: true,
_generated: true,
stopIfFalse: true,
defaultErrorMessage: undef},
{expression: expression(),
type: "requiredIf",
defaultErrorMessage: undef,
errorMessage: "Field is required"},
{type: "serverCustom",
errorMessage: "$errorInLookUpDesc"},
{type: "isString",
typeCastValidator: true,
_generated: true,
stopIfFalse: true,
defaultErrorMessage: undef}
] to value:test4
09:19:45.942:MUP5:INFO:gridEdit:lookupData:validateFieldValue, newValue: "test4", passed validation: true, resultingValue: null
09:19:45.948:MUP5:DEBUG:DataSource:VCOC_LOOKUP_TABLE_test:Outbound DSRequest: {operationType: "validate",
dataSource: "VCOC_LOOKUP_TABLE_test",
data: Obj,
callback: Canvas.$742(),
requestId: "VCOC_LOOKUP_TABLE_test$6272",
useStrictJSON: null,
fallbackToEval: false,
textMatchStyle: "exact",
showPrompt: false,
prompt: "Validating...",
validationMode: "partial",
internalClientContext: Obj,
willHandleError: true,
clientTiming: Obj{name:Client processing},
clientTimingStack: Array[2],
lastClientEventThreadCode: "MUP5",
parentNode: null,
bypassCache: true}
09:19:45.952:MUP5:INFO:DataSource:VCOC_LOOKUP_TABLE_test:Calling convertRelativeDates from sendDSRequest - data is

null
09:19:45.957:MUP5:INFO:AdvancedCriteria:Criteria object:{COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test8",
_selection_1: true} not explicitly marked as AdvancedCriteria - treating as SimpleCriteria.
09:19:45.960:MUP5:INFO:DataSource:VCOC_LOOKUP_TABLE_test:Called convertRelativeDates from sendDSRequest - data is

{
    "COC_FIELD_ID":"TEST_TYPE", 
    "COC_FIELD_DESCRIPTION":"test8", 
    "_selection_1":true
}
09:19:45.964:MUP5:INFO:AdvancedCriteria:Criteria object:{COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test8",
_selection_1: true} not explicitly marked as AdvancedCriteria - treating as SimpleCriteria.
09:19:45.972:MUP5:INFO:AdvancedCriteria:Criteria object:{COC_FIELD_ID: "TEST_TYPE",
COC_FIELD_DESCRIPTION: "test8",
_selection_1: true} not explicitly marked as AdvancedCriteria - treating as SimpleCriteria.
09:19:45.976:MUP5:INFO:DataSource:VCOC_LOOKUP_TABLE_test:performDSOperation(validate) 1 records, queuing
09:19:45.980:MUP5:DEBUG:RPCManager:Using ActiveX XMLHttpRequest via constructor: MSXML2.XMLHTTP
09:19:45.988:MUP5:DEBUG:RPCManager:Grabbed prompt from first request that defined one: Validating...
09:19:45.998:MUP5:INFO:RPCManager:sendQueue[2]: 1 RPCRequest(s); transport: xmlHttpRequest; target: http://172.20.164.61:9080/ERP/isomorphic/IDACall?isc_rpc=1&isc_v=v9.1p_2014-12-03&isc_xhr=1
09:19:46.028:MUP5:DEBUG:RPCManager:Using ActiveX XMLHttpRequest via constructor: MSXML2.XMLHTTP
09:19:46.033:MUP5:DEBUG:RPCManager:XMLHttpRequest POST to http://172.20.164.61:9080/ERP/isomorphic/IDACall?isc_rpc=1&isc_v=v9.1p_2014-12-03&isc_xhr=1 contentType: application/x-www-form-urlencoded; charset=UTF-8 with body -->isc_tnum=2&_transaction=<transaction xmlns:xsi="http://www.w3.org/2000/10/XMLSchema-instance" xsi:type="xsd:Object"><transactionNum xsi:type="xsd:long">2</transactionNum><operations xsi:type="xsd:List"><elem xsi:type="xsd:Object"><values xsi:type="xsd:Object"><COC_FIELD_ID>TEST_TYPE</COC_FIELD_ID><COC_FIELD_DESCRIPTION>test8</COC_FIELD_DESCRIPTION><_selection_1 xsi:type="xsd:boolean">true</_selection_1></values><operationConfig xsi:type="xsd:Object"><dataSource>VCOC_LOOKUP_TABLE_test</dataSource><operationType>validate</operationType><textMatchStyle>exact</textMatchStyle></operationConfig><validationMode>partial</validationMode><appID>builtinApplication</appID><operation>VCOC_LOOKUP_TABLE_test_validate</operation><oldValues xsi:type="xsd:Object"><COC_FIELD_ID>TEST_TYPE</COC_FIELD_ID><COC_FIELD_DESCRIPTION>test8</COC_FIELD_DESCRIPTION><_selection_1 xsi:type="xsd:boolean">true</_selection_1></oldValues></elem></operations></transaction>&protocolVersion=1.0<--
09:19:46.037:MUP5:INFO:gridEdit:lookupData:saveEdits: no actual change, not saving
09:19:46.043:MUP5:INFO:gridEdit:lookupData:hideInlineEditor for row with no edits - dropping edit values
09:19:46.047:MUP5:DEBUG:GridBody:lookupData_body:delaying adjustOverflow: cell height changed
09:19:46.068:MUP5:INFO:drawing:isc_TextItem_1[COC_FIELD_ID]:Form item cleared from within container widget lookupData_body
    FormItem.cleared()
    ListGrid.$30b(_1=>[TextItem ID:isc_TextItem_1 name:COC_FIELD_ID], _2=>null, _3=>[GridBody ID:lookupData_body])
    ListGrid.refreshCellValue(_1=>68, _2=>1, _3=>true, _4=>undef)
    ListGrid.refreshCell(_1=>68, _2=>1, _3=>true, _4=>undef)
    ListGrid.refreshRow(_1=>68)
    ListGrid.hideInlineEditor(_1=>true, _2=>undef)
    ListGrid.$33x(_1=>"programmatic")
    ListGrid.endEditing()
    [o]IButton.click(Obj, undef)
    StatefulCanvas.handleActivate(_1=>Obj, _2=>undef)
    StatefulCanvas.handleClick(_1=>Obj, _2=>undef)
    [c]EventHandler.bubbleEvent(_1=>[IButton ID:isc_IButton_1], _2=>"click", _3=>undef, _4=>undef)
    [c]EventHandler.handleClick(_1=>[IButton ID:isc_IButton_1], _2=>undef)
    [c]EventHandler.$k5(_1=>Obj{type:mouseup}, _2=>undef)
    [c]EventHandler.handleMouseUp(_1=>Obj{type:mouseup}, _2=>undef)
    [c]EventHandler.dispatch(_1=>[c]EventHandler.handleMouseUp(), _2=>undef)
    anonymous(event=>undef)
        "if (!isc.Browser.isIE && event == null) return;var returnVal=arguments.callee.$ch.isc.EH.dispatch(arguments.callee.$j2,event);return returnVal;"

09:19:46.075:MUP5:INFO:drawing:isc_TextItem_2[COC_FIELD_DESCRIPTION]:Form item cleared from within container widget lookupData_body
    FormItem.cleared()
    ListGrid.$30b(_1=>[TextItem ID:isc_TextItem_2 name:COC_FIELD_DESCRIPTION], _2=>null, _3=>[GridBody ID:lookupData_body])
    ListGrid.refreshCellValue(_1=>68, _2=>2, _3=>true, _4=>undef)
    ListGrid.refreshCell(_1=>68, _2=>2, _3=>true, _4=>undef)
    ListGrid.refreshRow(_1=>68)
    ListGrid.hideInlineEditor(_1=>true, _2=>undef)
    ListGrid.$33x(_1=>"programmatic")
    ListGrid.endEditing()
    [o]IButton.click(Obj, undef)
    StatefulCanvas.handleActivate(_1=>Obj, _2=>undef)
    StatefulCanvas.handleClick(_1=>Obj, _2=>undef)
    [c]EventHandler.bubbleEvent(_1=>[IButton ID:isc_IButton_1], _2=>"click", _3=>undef, _4=>undef)
    [c]EventHandler.handleClick(_1=>[IButton ID:isc_IButton_1], _2=>undef)
    [c]EventHandler.$k5(_1=>Obj{type:mouseup}, _2=>undef)
    [c]EventHandler.handleMouseUp(_1=>Obj{type:mouseup}, _2=>undef)
    [c]EventHandler.dispatch(_1=>[c]EventHandler.handleMouseUp(), _2=>undef)
    anonymous(event=>undef)
        "if (!isc.Browser.isIE && event == null) return;var returnVal=arguments.callee.$ch.isc.EH.dispatch(arguments.callee.$j2,event);return returnVal;"

09:19:46.080:MUP5:DEBUG:EventHandler:Event 'click' bubbled to top
09:19:46.089:click6:INFO:EventHandler:Target Canvas for event 'click': [IButton ID:isc_IButton_1]
09:19:46.118:TMR9:INFO:sizing:lookupData_body:Specified size: 548x246, drawn scroll size: 532x1440, border: 0x0, margin: 0x0, reason: cell height changed
09:19:46.148:TMR9:DEBUG:sizing:lookupData_body:handle sizes: {scrollLeft: 0,
scrollTop: 1194,
scrollWidth: 532,
scrollHeight: 1440,
clientWidth: undef,
clientHeight: undef,
offsetWidth: 532,
offsetHeight: 246,
styleLeft: "25px",
styleTop: "47px",
styleWidth: "532px",
styleHeight: "246px",
styleClip: ""}
09:19:46.218:TMR9:INFO:scrolling:lookupData_body:Drawn size: 532 by 1440, specified: 548 by 246, scrollbar state: v
09:19:46.221:TMR9:DEBUG:Scrollbar:lookupData_body_vscroll:setRect: {left: 557,
top: 47,
width: 16,
height: 246}
09:19:46.234:TMR0:INFO:RPCManager:transaction 2 arrived after 189ms
09:19:46.244:TMR0:DEBUG:RPCManager:Result string for transaction 2: "//isc_RPCResponseStart-->[{affectedRows:0,invalidateCache:false,isDSResponse:true,operationType:"validate",queueStatus:0,status:0,data:null}]//isc_RPCResponseEnd"
09:19:46.257:TMR0:INFO:RPCManager:rpcResponse(custom)[rpc]: result: object[status=0]
09:19:46.261:TMR0:INFO:xmlBinding:VCOC_LOOKUP_TABLE_test:dsResponse is: {operationId: "custom",
clientContext: undef,
internalClientContext: Obj,
context: Obj,
transactionNum: 2,
httpResponseCode: 200,
httpResponseText: "//isc_RPCResponseStart-->[{affectedRows:..."[161],
xmlHttpRequest: Obj,
transport: "xmlHttpRequest",
status: 0,
clientOnly: undef,
httpHeaders: Obj,
isStructured: true,
callbackArgs: null,
results: Obj,
affectedRows: 0,
invalidateCache: false,
isDSResponse: true,
operationType: "validate",
queueStatus: 0,
data: null,
clientTiming: Obj{name:Client processing},
clientTimingStack: Array[2]}
09:19:46.285:TMR1:INFO:RPCManager:transaction 1 arrived after 379ms
09:19:46.289:TMR1:DEBUG:RPCManager:Result string for transaction 1: "//isc_RPCResponseStart-->[{affectedRows:0,errors:[{COC_FIELD_DESCRIPTION:{errorMessage:"This is a restricted value"}}],invalidateCache:false,isDSResponse:true,operationType:"update",queueStatus:-1,status:-4,data:null}]//isc_RPCResponseEnd"
09:19:46.302:TMR1:INFO:RPCManager:rpcResponse(custom)[rpc]: result: object[status=-4]
09:19:46.306:TMR1:INFO:xmlBinding:VCOC_LOOKUP_TABLE_test:dsResponse is: {operationId: "custom",
clientContext: undef,
internalClientContext: Obj,
context: Obj,
transactionNum: 1,
httpResponseCode: 200,
httpResponseText: "//isc_RPCResponseStart-->[{affectedRows:..."[238],
xmlHttpRequest: Obj,
transport: "xmlHttpRequest",
status: -4,
clientOnly: undef,
httpHeaders: Obj,
isStructured: true,
callbackArgs: null,
results: Obj,
affectedRows: 0,
errors: Array[1],
invalidateCache: false,
isDSResponse: true,
operationType: "update",
queueStatus: -1,
data: null,
clientTiming: Obj{name:Client processing},
clientTimingStack: Array[2]}
09:19:46.310:TMR1:INFO:gridEdit:lookupData:error on save, status: -4, errors: [Obj
]
09:19:46.323:TMR2:DEBUG:EventHandler:mousing out of [IButton ID:isc_IButton_1]  
09:19:46.670:KDN9:INFO:EventHandler:keyDown event with Canvas target: [IButton ID:isc_IButton_1], native target: [DIVElement]{ID:isc_H}
09:19:46.681:KDN9:DEBUG:EventHandler:Event 'keyDown' bubbled to top
09:19:46.687:KDN9:INFO:EventHandler:keyPress event with Canvas target: [IButton ID:isc_IButton_1], native target: [DIVElement]{ID:isc_H}
09:19:46.693:KDN9:DEBUG:EventHandler:keyPress not handled natively
09:19:46.699:KDN9:DEBUG:EventHandler:Event 'keyPress' bubbled to top
09:19:46.809:BLR0:DEBUG:nativeFocus:onblur fired on: [IButton ID:isc_IButton_1], activeElement: DIV