起步软件技术论坛
搜索
 找回密码
 注册

QQ登录

只需一步,快速开始

查看: 8612|回复: 20

[处理中3] 奇怪的日志异常,希望探讨一下有哪些可能的原因引起!

[复制链接]

22

主题

117

帖子

433

积分

中级会员

Rank: 3Rank: 3

积分
433
QQ
发表于 2018-4-27 10:21:12 | 显示全部楼层 |阅读模式
我这里服务器有时会出现cpu率占用过高的问题(具体现象是突然cpu占用率特别低,然后过了1秒后突然涨到70%以上)。如果出现后就会有下面两种类似日志,能帮忙分析原因或者是什么方向的问题引起的。直到cpu占用率下来才会停止报错。此问题困扰了我几个月时间了,希望给些思路找到问题所在。此问题出现会导致服务器卡顿,客户无法正常访问。
奇怪一:
各种action执行都会报0023错误,0023代表的是什么含义?
2018-04-27 08:58:24 [catalina-exec-325] [com.justep.business.server.BusinessServer] ERROR: excute stream action, params:{"accept":"application/json","action":"queryCUX_HR_TASK_TO_OA_V1Action","actionFlag":"__action_0__","activity":"mainActivity","contentType":"json","executeContext":"","executor":"","parameters":{"columns":"APPLY_DATETIME,APPLY_DEPT,APPLY_DEPTNAME,APPLY_PERSON,APPLY_PERSONNAME,AUDIT_DATETIME,AUDIT_DEPT,AUDIT_DEPTNAME,AUDIT_PERSON,AUDIT_PERSONNAME,CUX_HR_TASK_TO_OA_V1,TASK_ID,TASK_STATUS,TASK_TITLE,version","filter":"(CUX_HR_TASK_TO_OA_V1.AUDIT_PERSON = '0000032062' and CUX_HR_TASK_TO_OA_V1.TASK_STATUS = '未处理')","limit":20,"offset":0,"orderBy":"APPLY_DATETIME DESC","variables":{}},"process":"/jingbo/hrTask/process/hrPortal/hrPortalProcess","translateParameter":{"cellnameByRelation":false,"dataType":"row-list","includeState":true,"rowsConfig":{"concept":"CUX_HR_TASK_TO_OA_V1","sequence":"APPLY_DATETIME,APPLY_DEPT,APPLY_DEPTNAME,APPLY_PERSON,APPLY_PERSONNAME,AUDIT_DATETIME,AUDIT_DEPT,AUDIT_DEPTNAME,AUDIT_PERSON,AUDIT_PERSONNAME,CUX_HR_TASK_TO_OA_V1,TASK_ID,TASK_STATUS,TASK_TITLE,version"},"transformIdcolumn":true,"useNamespace":true}}
com.justep.exception.BusinessException: 编码: JUSTEP153034; 提示: 非法的错误编号"0023"
    at com.justep.exception.BusinessException.create(Unknown Source)
    at com.justep.util.Utils.check(Unknown Source)
    at com.justep.exception.Message.getMessageByNumber(Unknown Source)
    at com.justep.util.Utils.throwSystemException(Unknown Source)
    at com.justep.system.action.Engine.invokeActions(Native Method)
    at com.justep.system.action.Engine.invokeActions(Unknown Source)
    at com.justep.business.server.BusinessServer.doAction(Unknown Source)
    at com.justep.business.server.BusinessServer.doExcute(Unknown Source)
    at com.juste
2018-04-27 08:58:24 [catalina-exec-215] [com.justep.business.server.BusinessServer] ERROR: excute stream action, params:{"accept":"application/json","action":"queryJb_navigate_viewAction","actionFlag":"__action_0__","activity":"mainActivity","contentType":"json","executeContext":"","executor":"","parameters":{"columns":"is_my_system,is_single_login,jb_navigate_view,length,prefix,single_url,system_content,system_developer,system_id,system_maintainor,system_name,system_order,system_url,system_user,usercard,version","filter":"(usercard = '0000033438')","limit":-1,"offset":0,"orderBy":"system_order ASC","variables":{}},"process":"/jingbo/navigation/process/navigateView/navigateViewProcess","translateParameter":{"cellnameByRelation":false,"dataType":"row-list","includeState":true,"rowsConfig":{"concept":"jb_navigate_view","sequence":"is_my_system,is_single_login,jb_navigate_view,length,prefix,single_url,system_content,system_developer,system_id,system_maintainor,system_name,system_order,system_url,system_user,usercard,version"},"transformIdcolumn":true,"useNamespace":true}}
com.justep.exception.BusinessException: 编码: JUSTEP153034; 提示: 非法的错误编号"0023"
    at com.justep.exception.BusinessException.create(Unknown Source)
    at com.justep.util.Utils.check(Unknown Source)
    at com.justep.exception.Message.getMessageByNumber(Unknown Source)
    at com.justep.util.Utils.throwSystemException(Unknown Source)
    at com.justep.system.action.Engine.invokeActions(Native Method)
等等




奇怪二:
用的ntlogin登录,但是会报用户名密码错误。
Caused by: com.justep.exception.BusinessException: Invalid name or password!
    at com.justep.util.Utils.check(Unknown Source)
    at com.justep.system.opm.OrgUtils.login(Native Method)
    at com.justep.system.opm.OrgUtils.login1(Unknown Source)
    at OPMProcedure.login(OPMProcedure.java:145)
    at OPMProcedure.ntLogin(OPMProcedure.java:125)
    ... 28 more
相关代码是:
Action action = new Action();
                action.setProcess("/SA/OPM/system/systemProcess");
                action.setActivity("mainActivity");
                action.setName("ntLoginAction");
                action.setParameter("name", username);
                action.setParameter("loginDate", new java.sql.Date(System.currentTimeMillis()));
                action.setParameter("ip", "127.0.0.1");
                action.setParameter("options", new HashMap<String, Object>());
                action.setParameter("lang", language);
                try {
                        ActionResult ar = ActionEngine.invokeActions(bussinessServer + "/login3", null, action.asXML().getBytes("UTF-8"),
                                        null, ActionUtils.XML_CONTENT_TYPE, ActionUtils.XML_CONTENT_TYPE,
                                        null, language, "post", null);
                        if (ar.isSuccess()){
//                                System.out.println("bsessionid===="+ar.getBSessionID());
                                return ar.getBSessionID();
                               
                        }else{
                                throw new RuntimeException(ar.getMessage());
                        }
                } catch (Exception e) {
                        e.printStackTrace();
                        throw new RuntimeException(e.getMessage()+"", e);
                }
以上日志前后我都仔细检查了,没有什么异常。



22

主题

117

帖子

433

积分

中级会员

Rank: 3Rank: 3

积分
433
QQ
 楼主| 发表于 2018-4-27 10:28:13 | 显示全部楼层
本帖最后由 tiger_lixy 于 2018-4-27 10:30 编辑

A8FE23A6F16BDCB3C9895FE587497A37.jpg CBAE330CA51DC474CFB851748E8784E5.jpg
请看监控图,本来在使用高峰期,突然停滞一样,然后又恢复并且cpu占用率猛增。第一楼是这个时间报的异常。
回复 支持 反对

使用道具 举报

91

主题

13万

帖子

3万

积分

管理员

Rank: 9Rank: 9Rank: 9

积分
35915
发表于 2018-4-27 10:37:17 | 显示全部楼层
1.在服务器上安装http分析工具,看cpu占用高的时候执行的什么请求
2.用的ntLogin登录的,下面为什么有调用了login3
login.png
远程的联系方法QQ1392416607,添加好友时,需在备注里注明其论坛名字及ID,公司等信息
发远程时同时也发一下帖子地址,方便了解要解决的问题  WeX5教程  WeX5下载



如按照该方法解决,请及时跟帖,便于版主结贴
回复 支持 反对

使用道具 举报

22

主题

117

帖子

433

积分

中级会员

Rank: 3Rank: 3

积分
433
QQ
 楼主| 发表于 2018-4-27 11:05:37 | 显示全部楼层
jishuang 发表于 2018-4-27 10:37
1.在服务器上安装http分析工具,看cpu占用高的时候执行的什么请求
2.用的ntLogin登录的,下面为什么有调用 ...

第二个问题完整日志:2018-04-27 08:56:50 action:<?xml version="1.0" encoding="UTF-8"?>
<action process="/SA/OPM/system/systemProcess" activity="mainActivity" name="ntLoginAction" execute-context="" content-type="application/xml"><parameters><parameter name="ip"><xbiz:simple xmlns:xbiz="http://www.justep.com/xbiz#" type="http://www.w3.org/2001/XMLSchema#String">127.0.0.1</xbiz:simple></parameter><parameter name="name"><xbiz:simple xmlns:xbiz="http://www.justep.com/xbiz#" type="http://www.w3.org/2001/XMLSchema#String">40029</xbiz:simple></parameter><parameter name="options"><xbiz:map xmlns:xbiz="http://www.justep.com/xbiz#"></xbiz:map></parameter><parameter name="loginDate"><xbiz:simple xmlns:xbiz="http://www.justep.com/xbiz#" type="http://www.w3.org/2001/XMLSchema#Date">2018-04-27</xbiz:simple></parameter><parameter name="lang"><xbiz:simple xmlns:xbiz="http://www.justep.com/xbiz#" type="http://www.w3.org/2001/XMLSchema#String">zh-cn</xbiz:simple></parameter></parameters></action>
java.lang.reflect.InvocationTargetException
        at sun.reflect.GeneratedMethodAccessor474.invoke(Unknown Source)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        at com.justep.system.action.Engine.invokeActions(Native Method)
        at com.justep.system.action.Engine.invokeActions(Unknown Source)
        at com.justep.business.server.BusinessServer.doAction(Unknown Source)
        at com.justep.business.server.BusinessServer.doExcute(Unknown Source)
        at com.justep.business.server.BusinessServer.excute(Unknown Source)
        at com.justep.business.server.BusinessServerServlet.execService(Unknown Source)
        at com.justep.business.server.BusinessServerServlet.service(Unknown Source)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at com.justep.x.bs.BusinessServerServlet.service(Unknown Source)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
        at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
        at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
        at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
        at com.googlecode.psiprobe.Tomcat60AgentValve.invoke(Tomcat60AgentValve.java:40)
        at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103)
        at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
        at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:293)
        at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:861)
        at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:606)
        at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:396)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
Caused by: com.justep.exception.BusinessException: Invalid name or password!
        at com.justep.util.Utils.check(Unknown Source)
        at com.justep.system.opm.OrgUtils.login(Native Method)
        at com.justep.system.opm.OrgUtils.login1(Unknown Source)
        at OPMProcedure.login(OPMProcedure.java:145)
        at OPMProcedure.ntLogin(OPMProcedure.java:125)
        ... 28 more
java.lang.RuntimeException: Invalid name or password!
        at Login_weixin.ssoLogin(Login_weixin.java:191)
        at Login_weixin.execute(Login_weixin.java:52)
        at com.justep.ui.JavaServer.runJava(Unknown Source)
        at com.justep.ui.JavaServer.doJ(Unknown Source)
        at com.justep.ui.JavaServer.service(Native Method)
        at com.justep.ui.servlet.MainServlet.service(Unknown Source)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
        at com.justep.portal.filter.RedirectFilter.doFilter(Unknown Source)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
        at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
        at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
        at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
        at com.googlecode.psiprobe.Tomcat60AgentValve.invoke(Tomcat60AgentValve.java:40)
        at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103)
        at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
        at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:293)
        at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:861)
        at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:606)
        at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:396)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
回复 支持 反对

使用道具 举报

22

主题

117

帖子

433

积分

中级会员

Rank: 3Rank: 3

积分
433
QQ
 楼主| 发表于 2018-4-27 11:09:08 | 显示全部楼层
jishuang 发表于 2018-4-27 10:37
1.在服务器上安装http分析工具,看cpu占用高的时候执行的什么请求
2.用的ntLogin登录的,下面为什么有调用 ...

第一个我会安装的。
1、需要解释下0023的含义是什么。
2、为什么监控工具的图形这么奇怪。cpu会先占用率很低(低到几乎没有),然后突然高。
业务代码能做到让其他线程做等待吗?
回复 支持 反对

使用道具 举报

22

主题

117

帖子

433

积分

中级会员

Rank: 3Rank: 3

积分
433
QQ
 楼主| 发表于 2018-4-27 11:20:10 | 显示全部楼层
本帖最后由 tiger_lixy 于 2018-4-27 11:21 编辑

刚刚另一台服务器也出现了,首次出现的日志如下:
2018-04-27 10:37:01 [catalina-exec-1311] [com.justep.business.server.BusinessServer] ERROR: excute stream action, params:{process=/SA/OPM/system/systemProcess, activity=mainActivity, action=getSysCode, parameters={}}
com.justep.exception.LicenseException: 编码: JUSTEP153012; 提示: 当前用户不在在线用户列表中!
        at com.justep.exception.LicenseException.create(Unknown Source)
        at com.justep.util.Utils.throwSystemException(Unknown Source)
        at com.justep.system.action.Engine.invokeActions(Native Method)
        at com.justep.system.action.Engine.invokeActions(Unknown Source)
        at com.justep.business.server.BusinessServer.doAction(Unknown Source)
        at com.justep.business.server.BusinessServer.doExcute(Unknown Source)
        at com.justep.business.server.BusinessServer.excute(Unknown Source)
        at com.justep.business.server.BusinessServer.excuteGETAction(Unknown Source)
        at com.justep.business.server.BusinessServerServlet.execService(Unknown Source)
        at com.justep.business.server.BusinessServerServlet.service(Unknown Source)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at com.justep.x.bs.BusinessServerServlet.service(Unknown Source)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
        at org.apache.catalina.core.Applica

2018-04-27 10:40:43 [catalina-exec-1382] [com.justep.business.server.BusinessServer] ERROR: excute stream action, params:null
com.justep.exception.BusinessException: 编码: JUSTEP150017; 提示: 构造Action出错, Action内容不允许为空
        at com.justep.exception.BusinessException.create(Unknown Source)
        at com.justep.business.server.BusinessServer.getActions(Unknown Source)
        at com.justep.business.server.BusinessServer.parserInput(Unknown Source)
        at com.justep.business.server.BusinessServer.excute(Unknown Source)
        at com.justep.business.server.BusinessServer.excute(Unknown Source)
        at com.justep.business.server.BusinessServerServlet.execService(Unknown Source)
        at com.justep.business.server.BusinessServerServlet.service(Unknown Source)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at com.justep.x.bs.BusinessServerServlet.service(Unknown Source)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
        at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
        at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
        at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
        at com.googlecode.psiprobe.Tomcat60AgentValve.invoke(Tomcat60AgentValve.java:40)
        at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103)
        at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
        at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:293)
        at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:861)
        at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:606)
        at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:396)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
2018-04-27 10:40:46 [catalina-exec-1209] [com.justep.business.server.BusinessServer] ERROR: excute stream action, params:{"accept":"application/json","action":"queryCardTask","actionFlag":"__action_0__","activity":"mainActivity","contentType":"json","executeContext":"","executor":"","parameters":{"cardID":"29893"},"process":"/jingbo/hrTask/process/hrPortal/hrPortalProcess"}
com.justep.exception.BusinessException: 编码: JUSTEP153034; 提示: 非法的错误编号"0023"
        at com.justep.exception.BusinessException.create(Unknown Source)
        at com.justep.util.Utils.check(Unknown Source)
        at com.justep.exception.Message.getMessageByNumber(Unknown Source)
        at com.justep.util.Utils.throwSystemException(Unknown Source)
        at com.justep.system.action.Engine.invokeActions(Native Method)
        at com.justep.system.action.Engine.invokeActions(Unknown Source)
        at com.justep.business.server.BusinessServer.doAction(Unknown Source)
        at com.justep.business.server.BusinessServer.doExcute(Unknown Source)
        at com.justep.business.server.BusinessServer.excute(Unknown Source)
        at com.justep.business.server.BusinessServer.excute(Unknown Source)
        at com.justep.business.server.BusinessServerServlet.execService(Unknown Source)
        at com.justep.business.server.BusinessServerServlet.service(Unknown Source)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at com.justep.x.bs.BusinessServerServlet.service(Unknown
回复 支持 反对

使用道具 举报

91

主题

13万

帖子

3万

积分

管理员

Rank: 9Rank: 9Rank: 9

积分
35915
发表于 2018-4-27 11:42:16 | 显示全部楼层
1.把model同级的logs下的biz的日志发一下
0023看不出什么错误
为什么高,要看具体执行的什么导致的啊
2.是微信报错的http://docs.wex5.com/bex5-deploy-question-list-10047/
远程的联系方法QQ1392416607,添加好友时,需在备注里注明其论坛名字及ID,公司等信息
发远程时同时也发一下帖子地址,方便了解要解决的问题  WeX5教程  WeX5下载



如按照该方法解决,请及时跟帖,便于版主结贴
回复 支持 反对

使用道具 举报

22

主题

117

帖子

433

积分

中级会员

Rank: 3Rank: 3

积分
433
QQ
 楼主| 发表于 2018-4-27 11:53:08 | 显示全部楼层
已经发了,通过别的渠道。日志里面有敏感信息,不方便放论坛上。
回复 支持 反对

使用道具 举报

22

主题

117

帖子

433

积分

中级会员

Rank: 3Rank: 3

积分
433
QQ
 楼主| 发表于 2018-4-27 11:54:26 | 显示全部楼层
jishuang 发表于 2018-4-27 11:42
1.把model同级的logs下的biz的日志发一下
0023看不出什么错误
为什么高,要看具体执行的什么导致的啊

您仔细看下是微信报错???
回复 支持 反对

使用道具 举报

22

主题

117

帖子

433

积分

中级会员

Rank: 3Rank: 3

积分
433
QQ
 楼主| 发表于 2018-4-27 11:56:09 | 显示全部楼层
try {
                        ActionResult ar = ActionEngine.invokeActions(bussinessServer + "/login3", null, action.asXML().getBytes("UTF-8"),
                                        null, ActionUtils.XML_CONTENT_TYPE, ActionUtils.XML_CONTENT_TYPE,
                                        null, language, "post", null);
                        if (ar.isSuccess()){
//                                System.out.println("bsessionid===="+ar.getBSessionID());
                                return ar.getBSessionID();
                               
                        }else{
                                throw new RuntimeException(ar.getMessage());------》》》》》》191行  报错
                        }
回复 支持 反对

使用道具 举报

您需要登录后才可以回帖 登录 | 注册

本版积分规则

小黑屋|手机版|X3技术论坛|Justep Inc.    

GMT+8, 2024-4-25 09:54 , Processed in 0.116278 second(s), 26 queries .

Powered by Discuz! X3.4

© 2001-2013 Comsenz Inc.

快速回复 返回顶部 返回列表