09:50:06.451:INFO:Log:initialized
09:50:06.699:WARN:Log:New Class ID: 'DataView' collides with ID of existing object with value 'function DataView() {
    [native code]
}'.  Existing object will be replaced.
This conflict would be avoided by disabling ISC Simple Names mode.  See documentation for further information.
09:50:06.733:WARN:Log:ClassFactory.addGlobalID: ID:'CountryManyToOneSimple_inheritsFrom' for object '[DataSource ID:CountryManyToOneSimple_inheritsFrom]' collides with ID of existing object '[DataSource ID:CountryManyToOneSimple_inheritsFrom]'. The global reference to this object will be replaced
09:50:06.733:WARN:Log:ClassFactory.addGlobalID: ID:'CityManyToOneSimple_inheritsFrom' for object '[DataSource ID:CityManyToOneSimple_inheritsFrom]' collides with ID of existing object '[DataSource ID:CityManyToOneSimple_inheritsFrom]'. The global reference to this object will be replaced
09:50:06.891:INFO:Log:isc.Page is loaded
09:50:10.326:INFO:ResultSet:isc_ListGrid_0:Creating new isc.ResultSet for operation 'countryOneToManyJPA_fetch' with filterValues: {
}
09:50:10.332:INFO:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):setCriteria: filter criteria changed, invalidating cache
09:50:10.332:INFO:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):Invalidating cache
09:50:10.337:DEBUG:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):getRange(0,53), cache check: 1,51 firstMissingRow: 1 lastMissingRow: 51
09:50:10.337:DEBUG:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):getRange: no scrolling direction detected
09:50:10.337:INFO:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):getRange(0, 53) will fetch from 0 to 53
09:50:10.337:INFO:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):fetching rows 0,53 from server
09:50:10.362:WARN:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):ResultSet server fetch with server criteria: {
}
    [a]MathFunction.getStackTrace(_1=>undef, _2=>undef, _3=>undef, _4=>undef, _5=>undef)
    ResultSet.fetchRemoteData(_1=>Obj, _2=>0, _3=>53)
    ResultSet.$39w()
    ResultSet.getRangePaged(_1=>0, _2=>53, _3=>undef, _4=>undef)
    ResultSet.$39u(_1=>0, _2=>53, _3=>undef, _4=>undef)
    ResultSet.getRange(_1=>0, _2=>53, _3=>undef, _4=>undef)
    ListGrid.requestVisibleRows()
    Canvas.filterWithCriteria(_1=>Obj, _2=>Obj{ID:countryOneToManyJPA_fetch}, _3=>Obj)
    Canvas.$wo(_1=>"fetch", _2=>undef, _3=>null, _4=>Obj)
    [a]MathFunction.invokeSuper(_1=>null, _2=>"$wo", _3=>undef, _4=>undef, _5=>undef, _6=>undef, _7=>undef, _8=>undef, _9=>undef, _10=>undef)
    [a]MathFunction.Super(_1=>"$wo", _2=>Array[4], _3=>[object Arguments])
    ListGrid.$wo(_1=>"fetch", _2=>undef, _3=>null, _4=>Obj, _5=>undef)
    Canvas.fetchData(_1=>undef, _2=>null, _3=>Obj)
    Canvas.doInitialFetch()
    Canvas.draw(_1=>undef, undef, undef, undef, undef, undef, undef, undef)
    ** recursed on [a]MathFunction.invokeSuper

09:50:10.496:INFO:ResultSet:isc_PickListMenu_0:Creating new isc.ResultSet for operation 'cityOneToManyJPA_fetch' with filterValues: {
}
09:50:10.498:INFO:ResultSet:isc_ResultSet_1 (created by: isc_PickListMenu_0):setCriteria: filter criteria changed, invalidating cache
09:50:10.498:INFO:ResultSet:isc_ResultSet_1 (created by: isc_PickListMenu_0):Invalidating cache
09:50:10.535:WARN:ResultSet:isc_ResultSet_1 (created by: isc_PickListMenu_0):ResultSet server fetch with server criteria: {
}
    [a]MathFunction.getStackTrace(_1=>undef, _2=>undef, _3=>undef, _4=>undef, _5=>undef)
    ResultSet.fetchRemoteData(_1=>Obj, _2=>undef, _3=>undef)
    ResultSet.getRange(_1=>0, _2=>undef, _3=>undef, _4=>undef)
    ListGrid.requestVisibleRows()
    Canvas.filterWithCriteria(_1=>Obj, _2=>Obj{ID:cityOneToManyJPA_fetch}, _3=>Obj)
    Canvas.$wo(_1=>"filter", _2=>Obj, _3=>Obj, _4=>Obj)
    [a]MathFunction.invokeSuper(_1=>null, _2=>"$wo", _3=>undef, _4=>undef, _5=>undef, _6=>undef, _7=>undef, _8=>undef, _9=>undef, _10=>undef)
    [a]MathFunction.Super(_1=>"$wo", _2=>Array[4], _3=>[object Arguments])
    ListGrid.$wo(_1=>"filter", _2=>Obj, _3=>Obj, _4=>Obj, _5=>undef)
    Canvas.filterData(_1=>Obj, _2=>Obj, _3=>Obj)
    PickList.filterDataBoundPickList(_1=>Obj, _2=>true)
    PickList.$19p(_1=>false, _2=>Obj, _3=>null, _4=>true)
    PickList.filterPickList(_1=>false, _2=>false, _3=>Obj, _4=>true)
    PickList.setUpPickList(_1=>false, _2=>false, _3=>Obj, _4=>true)
    PickList.makePickList(_1=>false, _2=>Obj, _3=>false, _4=>true)
    SelectItem.makePickList(_1=>false, Obj, false, true)
    PickList.fetchData(_1=>null, _2=>Obj, _3=>true)
    SelectItem.drawn(_1=>undef, _2=>undef, _3=>undef, _4=>undef)
    ListGrid.$30b(_1=>null, _2=>null, _3=>[GridBody ID:isc_ListGrid_0filterEditor_body])
    GridBody.draw(_1=>undef, _2=>undef, _3=>undef, _4=>undef)
    Layout.layoutChildren(_1=>"initial draw", _2=>undef, _3=>undef)
    ListGrid.layoutChildren(_1=>"initial draw", _2=>undef, _3=>undef)
    ** recursed on [a]MathFunction.invokeSuper

09:50:10.553:DEBUG:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):getRange(0, 7) satisfied from cache
09:50:10.630:INFO:ResultSet:isc_PickListMenu_1:Creating new isc.ResultSet for operation 'cityOneToManyJPA_fetch' with filterValues: {
}
09:50:10.632:INFO:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):setCriteria: filter criteria changed, invalidating cache
09:50:10.632:INFO:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):Invalidating cache
09:50:10.635:DEBUG:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):getRange(0,1), cache check: 0,37 firstMissingRow: 0 lastMissingRow: 37
09:50:10.635:DEBUG:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):getRange: guessing forward scrolling
09:50:10.635:INFO:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):getRange(0, 1) will fetch from 0 to 75
09:50:10.635:INFO:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):fetching rows 0,75 from server
09:50:10.650:WARN:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):ResultSet server fetch with server criteria: {
}
    [a]MathFunction.getStackTrace(_1=>undef, _2=>undef, _3=>undef, _4=>undef, _5=>undef)
    ResultSet.fetchRemoteData(_1=>Obj, _2=>0, _3=>75)
    ResultSet.$39w()
    ResultSet.getRangePaged(_1=>0, _2=>1, _3=>undef, _4=>undef)
    ResultSet.$39u(_1=>0, _2=>1, _3=>undef, _4=>undef)
    ResultSet.getRange(_1=>0, _2=>undef, _3=>undef, _4=>undef)
    ListGrid.requestVisibleRows()
    Canvas.filterWithCriteria(_1=>Obj, _2=>Obj{ID:cityOneToManyJPA_fetch}, _3=>Obj)
    Canvas.$wo(_1=>"filter", _2=>Obj, _3=>Obj, _4=>Obj)
    [a]MathFunction.invokeSuper(_1=>null, _2=>"$wo", _3=>undef, _4=>undef, _5=>undef, _6=>undef, _7=>undef, _8=>undef, _9=>undef, _10=>undef)
    [a]MathFunction.Super(_1=>"$wo", _2=>Array[4], _3=>[object Arguments])
    ListGrid.$wo(_1=>"filter", _2=>Obj, _3=>Obj, _4=>Obj, _5=>undef)
    Canvas.filterData(_1=>Obj, _2=>Obj, _3=>Obj)
    PickList.filterDataBoundPickList(_1=>Obj, _2=>true)
    PickList.$19p(_1=>false, _2=>Obj, _3=>null, _4=>true)
    PickList.filterPickList(_1=>false, _2=>false, _3=>Obj, _4=>true)
    PickList.setUpPickList(_1=>false, _2=>false, _3=>Obj, _4=>true)
    PickList.makePickList(_1=>false, _2=>Obj, _3=>false, _4=>true)
    SelectItem.makePickList(_1=>false, Obj, false, true)
    PickList.fetchData(_1=>null, _2=>Obj, _3=>true)
    SelectItem.drawn(_1=>undef, _2=>undef, _3=>undef, _4=>undef)
    DynamicForm.$102()
    DynamicForm.draw(_1=>undef, _2=>undef, _3=>undef, _4=>undef)
    Layout.layoutChildren(_1=>"initial draw", _2=>undef, _3=>undef)
    Layout.drawChildren()
    Canvas.draw(_1=>undef)
    ** recursed on Layout.layoutChildren

09:50:10.962:XRP3:INFO:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):Received 6 records from server
09:50:10.962:XRP3:DEBUG:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):full length set to: 6
09:50:10.963:XRP3:DEBUG:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):integrating 6 rows into cache at position 0
09:50:10.963:XRP3:INFO:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):cached 6 rows, from 0 to 6 (6 total rows, 6 cached)
09:50:10.963:XRP3:INFO:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):Cache for entire DataSource complete
09:50:10.963:XRP3:DEBUG:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):getRange(0, 1) satisfied from cache
09:50:10.968:XRP3:DEBUG:ResultSet:isc_ResultSet_2 (created by: isc_PickListMenu_1):getRange(0, 6) satisfied from cache
09:50:10.992:XRP6:INFO:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):Received 4 records from server
09:50:10.992:XRP6:DEBUG:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):full length set to: 4
09:50:10.992:XRP6:DEBUG:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):integrating 4 rows into cache at position 0
09:50:10.993:XRP6:INFO:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):cached 4 rows, from 0 to 4 (4 total rows, 4 cached)
09:50:10.993:XRP6:INFO:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):Cache for entire DataSource complete
09:50:10.994:XRP6:INFO:ResultSet:isc_ResultSet_1 (created by: isc_PickListMenu_0):Received 6 records from server
09:50:11.000:XRP6:INFO:ResultSet:isc_ResultSet_3 (created by: undefined):creating auto-operation for operationType: fetch
09:50:11.002:XRP6:INFO:ResultSet:isc_ResultSet_3 (created by: undefined):setCriteria: filter criteria changed, invalidating cache
09:50:11.002:XRP6:INFO:ResultSet:isc_ResultSet_3 (created by: undefined):Invalidating cache
09:50:11.003:XRP6:DEBUG:ResultSet:isc_ResultSet_3 (created by: undefined):integrating 6 rows into cache at position 0
09:50:11.003:XRP6:DEBUG:ResultSet:isc_ResultSet_3 (created by: undefined):full length set to: 6
09:50:11.115:TMR6:DEBUG:ResultSet:isc_ResultSet_0 (created by: isc_ListGrid_0):getRange(0, 4) satisfied from cache


### before problematic filtering
10:01:01.124:IFCS9:INFO:ResultSet:isc_ResultSet_1 (created by: isc_PickListMenu_0):setCriteria: filter criteria unchanged