05 EAS常见业务性能问题FAQ

EAS常见业务性能问题FAQ

综上所述，EAS客户端中，用户操作体现为一个鼠标或键盘事件。如果下一个鼠标或键盘事件被dispatch了，就证明上一个用户操作的等待已经结束了。使用自定义的RPCLogEventQueue代替系统默认EventQueue，在每次鼠标释放或键盘释放事件dispatch时通知RPCLogCounter，就可以把一个Action内的多次用户操作分隔开来。

在币别序时簿中，点击“修改”按钮，显示币别编辑界面；点击“保存”按钮，显示“保存成功”消息框；最后，点击“退出”按钮，回到序时簿界面。Rpc log如下。

com.kingdee.eas.basedata.assistant.client.CurrencyEditUI.initUIObject() current thread: AWT-EventQueue-1 stack level: 2

==============rpcInvoke start==============

com.kingdee.eas.base.license.ILicenseController.requestLicense(com.kingdee.eas.base.license.LicenseUserInfo, java.lang.String) int

time: 0 ms request: 419 B response: 85 B invoke_id: -972189611 end_time: 10:49:44

com.kingdee.bos.framework.IDynamicObject.getCollection(com.kingdee.bos.util.BOSObjectType, java.lang.String) com.kingdee.bos.dao.IObjectCollection

time: 172 ms request: 170 B response: 585 B invoke_id: -972189610 end_time: 10:49:44 com.kingdee.eas.framework.ICoreBase.getValue(com.kingdee.bos.dao.IObjectPK, com.kingdee.bos.metadata.entity.SelectorItemCollection) com.kingdee.eas.framework.CoreBaseInfo

time: 16 ms request: 1625 B response: 3275 B invoke_id: -972189609 end_time: 10:49:44

5 / 20

EAS常见业务性能问题FAQ

com.kingdee.eas.base.netctrl.IMutexServiceControl.releaseObjIDForUpdate(java.lang.String) void

time: 0 ms request: 35 B response: 9 B invoke_id: -972189608 end_time: 10:49:44

com.kingdee.eas.base.netctrl.IMutexServiceControl.requestObjIDForUpdate(java.lang.String, java.lang.String, java.lang.String) boolean

time: 0 ms request: 82 B response: 51 B invoke_id: -972189607 end_time: 10:49:44 ==============rpcInvoke end==============

RPC Number: 5 SubAction Number: 0 Cached RPC Number: 0 rpc time: 188 ms request: 2331 B response: 4005 B action time: 266 ms

com.kingdee.eas.basedata.assistant.client.CurrencyEditUI.actionSubmit_actionPerformed current thread: AWT-EventQueue-1 stack level: 2

==============rpcInvoke start==============

com.kingdee.eas.framework.ICoreBase.submit(com.kingdee.eas.framework.CoreBaseInfo) com.kingdee.bos.dao.IObjectPK

time: 875 ms request: 3117 B response: 462 B invoke_id: -972189602 end_time: 10:49:48 com.kingdee.eas.framework.ICoreBase.getValue(com.kingdee.bos.dao.IObjectPK, com.kingdee.bos.metadata.entity.SelectorItemCollection) com.kingdee.eas.framework.CoreBaseInfo

time: 16 ms request: 1625 B response: 3275 B invoke_id: -972189601 end_time: 10:49:48 ##########input.MOUSE_RELEASED（弹出保存成功消息对话框后，点击确定。）

time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 10:49:49

com.kingdee.eas.base.netctrl.IMutexServiceControl.releaseObjIDForUpdate(java.lang.String) void

time: 0 ms request: 63 B response: 9 B invoke_id: -972189600 end_time: 10:49:49

com.kingdee.eas.base.netctrl.IMutexServiceControl.requestObjIDForUpdate(java.lang.String, java.lang.String, java.lang.String) boolean

time: 15 ms request: 82 B response: 51 B invoke_id: -972189599 end_time: 10:49:49 ==============rpcInvoke end==============

RPC Number: 4 SubAction Number: 0 Cached RPC Number: 0 rpc time: 906 ms request: 4887 B response: 3797 B action time: 2078 ms

com.kingdee.eas.basedata.assistant.client.CurrencyListUI.actionEdit_actionPerformed current thread: AWT-EventQueue-1 stack level: 1

==============rpcInvoke start==============

com.kingdee.eas.basedata.framework.ICUIDGetterFacade.getCUID(java.lang.String) java.lang.String

time: 15 ms request: 63 B response: 55 B invoke_id: -972189613 end_time: 10:49:44 com.kingdee.eas.framework.ICoreBase.exists(com.kingdee.bos.dao.IObjectPK) boolean

time: 16 ms request: 486 B response: 51 B invoke_id: -972189612 end_time: 10:49:44 ----------com.kingdee.eas.basedata.assistant.client.CurrencyEditUI.initUIObject() time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 10:49:44

com.kingdee.eas.framework.config.IUserCustomConfig.getValue(com.kingdee.bos.dao.IObjectPK) com.kingdee.eas.framework.config.UserCustomConfigInfo

time: 31 ms request: 551 B response: 2566 B invoke_id: -972189606 end_time: 10:49:44 ##########input.MOUSE_RELEASED（点击保存按钮，此前的rpc调用为点击序时簿上修改按钮，然后币别编辑界面初始化过程中发生的，此后即为币别的修改保存。）

time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 10:49:47

----------com.kingdee.eas.basedata.assistant.client.CurrencyEditUI.actionSubmit_actionPerformed

time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 10:49:49

6 / 20

EAS常见业务性能问题FAQ

##########input.MOUSE_RELEASED（点击退出按钮，退出币别编辑界面。）

time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 10:49:51

com.kingdee.eas.base.license.ILicenseController.releaseLicense(java.lang.String, java.lang.String) void

time: 0 ms request: 115 B response: 9 B invoke_id: -972189596 end_time: 10:49:51

com.kingdee.eas.base.netctrl.IMutexServiceControl.releaseObjIDForUpdate(java.lang.String) void

time: 0 ms request: 63 B response: 9 B invoke_id: -972189595 end_time: 10:49:51

com.kingdee.bos.dao.query.server.IVirtualModeDataAccess.doAllQueryTask(com.kingdee.util.Uuid, int, int, com.kingdee.bos.metadata.IMetaDataPK, com.kingdee.bos.util.BOSObjectType, com.kingdee.bos.metadata.entity.EntityViewInfo, java.util.Map, java.util.Map,

com.kingdee.bos.dao.query.QueryExecuteOption, [Ljava.lang.String;, boolean) java.util.Map time: 532 ms request: 2184 B response: 4395 B invoke_id: -972189594 end_time: 10:49:51 com.kingdee.eas.basedata.assistant.ICurrency.getCurrencyInfo(com.kingdee.bos.dao.IObjectPK) com.kingdee.eas.basedata.assistant.CurrencyInfo

time: 16 ms request: 486 B response: 3275 B invoke_id: -972189593 end_time: 10:49:51 ==============rpcInvoke end==============

RPC Number: 7 SubAction Number: 2 Cached RPC Number: 0 rpc time: 610 ms request: 3948 B response: 10360 B stack rpc time: 1704 ms stack request: 11166 B stack response: 18162 B stack RPCNumber: 16

action time: 7360 ms max wait RPCNumber: 8

com.kingdee.eas.basedata.assistant.client.CurrencyEditUI.initUIObject() current thread: AWT-EventQueue-1

stack level: 2 action_id: 51dfb278-0117-1000-e000-008bc0a813c6 ==============rpcInvoke start==============

com.kingdee.eas.framework.ICoreBase.getCollection(java.lang.String) com.kingdee.eas.framework.CoreBaseCollection

time: 31 ms request: 115 B response: 110 B invoke_id: -970489720 end_time: 9:38:16 com.kingdee.eas.framework.ICoreBase.getValue(com.kingdee.bos.dao.IObjectPK, com.kingdee.bos.metadata.entity.SelectorItemCollection) com.kingdee.eas.framework.CoreBaseInfo

time: 31 ms request: 341 B response: 957 B invoke_id: -970489719 end_time: 9:38:16

com.kingdee.eas.base.netctrl.IMutexServiceControl.requestObjIDForUpdate(java.lang.String, java.lang.String, java.lang.String) boolean

time: 16 ms request: 117 B response: 13 B invoke_id: -970489718 end_time: 9:38:16 ==============rpcInvoke end==============

RPC Number: 3 SubAction Number: 0 Cached RPC Number: 0 rpc time: 78 ms request: 573 B response: 1080 B action time: 157 ms

com.kingdee.eas.basedata.assistant.client.CurrencyEditUI.actionSubmit_actionPerformed current thread: AWT-EventQueue-1

stack level: 2 action_id: 51dfb278-0117-1000-e000-0092c0a813c6 ==============rpcInvoke start==============

com.kingdee.eas.framework.ICoreBase.submit(com.kingdee.eas.framework.CoreBaseInfo) com.kingdee.bos.dao.IObjectPK

time: 1188 ms request: 980 B response: 1985 B invoke_id: -970489714 end_time: 9:38:19 com.kingdee.eas.framework.ICoreBase.getValue(com.kingdee.bos.dao.IObjectPK, com.kingdee.bos.metadata.entity.SelectorItemCollection) com.kingdee.eas.framework.CoreBaseInfo

time: 31 ms request: 341 B response: 957 B invoke_id: -970489713 end_time: 9:38:19 ##########input.MOUSE_RELEASED（弹出保存成功消息对话框后，点击确定。）

time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 9:38:20

7 / 20

EAS常见业务性能问题FAQ

com.kingdee.eas.base.netctrl.IMutexServiceControl.releaseObjIDForUpdate(java.lang.String) void

time: 0 ms request: 82 B response: 12 B invoke_id: -970489712 end_time: 9:38:20

com.kingdee.eas.base.netctrl.IMutexServiceControl.requestObjIDForUpdate(java.lang.String, java.lang.String, java.lang.String) boolean

time: 0 ms request: 117 B response: 13 B invoke_id: -970489711 end_time: 9:38:20 ==============rpcInvoke end==============

RPC Number: 4 SubAction Number: 0 Cached RPC Number: 0 rpc time: 1219 ms request: 1520 B response: 2967 B action time: 2156 ms

com.kingdee.eas.basedata.assistant.client.CurrencyListUI.actionEdit_actionPerformed current thread: AWT-EventQueue-1

stack level: 1 action_id: 51dfb278-0117-1000-e000-0097c0a813c6 ==============rpcInvoke start============== 9:38:16

com.kingdee.eas.basedata.framework.ICUIDGetterFacade.getCUID(java.lang.String) java.lang.String

time: 47 ms request: 82 B response: 61 B invoke_id: -970489722 end_time: 9:38:16 com.kingdee.eas.framework.ICoreBase.exists(com.kingdee.bos.dao.IObjectPK) boolean time: 15 ms request: 106 B response: 13 B invoke_id: -970489721 end_time: 9:38:16 ----------com.kingdee.eas.basedata.assistant.client.CurrencyEditUI.initUIObject()

time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 9:38:16 subaction_id: 51dfb278-0117-1000-e000-008bc0a813c6

com.kingdee.eas.framework.config.IUserCustomConfig.getValue(com.kingdee.bos.dao.IObjectPK) com.kingdee.eas.framework.config.UserCustomConfigInfo

time: 16 ms request: 187 B response: 12 B invoke_id: -970489716 end_time: 9:38:16

##########input.MOUSE_RELEASED（点击保存按钮，此前的rpc调用为点击序时簿上修改按钮，然后币别编辑界面初始化过程中发生的，此后即为币别的修改保存。）

time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 9:38:18

----------com.kingdee.eas.basedata.assistant.client.CurrencyEditUI.actionSubmit_actionPerformed

time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 9:38:20 subaction_id: 51dfb278-0117-1000-e000-0092c0a813c6

##########input.MOUSE_RELEASED（点击退出按钮，退出币别编辑界面。）

time: 0 ms request: 0 B response: 0 B invoke_id: -1 end_time: 9:38:21

com.kingdee.eas.base.netctrl.IMutexServiceControl.releaseObjIDForUpdate(java.lang.String) void

time: 0 ms request: 82 B response: 12 B invoke_id: -970489708 end_time: 9:38:21

com.kingdee.bos.dao.query.server.IVirtualModeDataAccess.doAllQueryTask(com.kingdee.util.Uuid, int, int, com.kingdee.bos.metadata.IMetaDataPK, com.kingdee.bos.util.BOSObjectType, com.kingdee.bos.metadata.entity.EntityViewInfo, java.util.Map, java.util.Map,

com.kingdee.bos.dao.query.QueryExecuteOption, [Ljava.lang.String;, boolean) java.util.Map time: 1547 ms request: 829 B response: 863 B invoke_id: -970489707 end_time: 9:38:23 com.kingdee.eas.basedata.assistant.ICurrency.getCurrencyInfo(com.kingdee.bos.dao.IObjectPK) com.kingdee.eas.basedata.assistant.CurrencyInfo

time: 16 ms request: 106 B response: 957 B invoke_id: -970489706 end_time: 9:38:23 ==============rpcInvoke end============== 9:38:23

RPC Number: 6 SubAction Number: 2 Cached RPC Number: 0 rpc time: 1641 ms request: 1392 B response: 1918 B

stack rpc time: 2938 ms stack request: 3485 B stack response: 5965 B stack RPCNumber: 13

cpu time: 312 gc count: 3 gc time: 36

action time: 6875 ms UserOperation: 4（对应点击序时簿上修改按钮加其他三次鼠标输出事件）

MaxWaitRPCNumber: 6（对应上文中深蓝色rpc调用） MaxWaitRPCBytes: 4263 B（对应上文中浅蓝色rpc调

8 / 20