search

pinpoint-apm / pinpoint

APM, (Application Performance Management) tool for large-scale distributed systems.
https://pinpoint-apm.gitbook.io/
Apache License 2.0
13.42k stars 3.76k forks source link

Agent can't send data to collector #4455

Closed WangHouLing closed 6 years ago

WangHouLing commented 6 years ago

Hi all, I found that if I installed tomcat with pinpoint agent on the same machine as the pinpoint collector, the pinpoint is working. But if I install tomcat with pinpoint agent on the different machine as the pinpoint collector, the pinpoint agent can't send data to pinpoint collector. I don't know if it is caused by network restrictions. I have set firewall to accept 19994(tcp),19995(udp),19996(udp) which configed in pinpoint agent port. What version of pinpoint are you using? pinpoint version: pinpoint 1.6.2 Describe your problem I add these codes in tomcat/bin/catalina.sh:

CATALINA_OPTS="$CATALINA_OPTS -javaagent:/u01/pinpoint/pinpoint-agent-1.6.2/pinpoint-bootstrap-1.6.2.jar"
CATALINA_OPTS="$CATALINA_OPTS -Dpinpoint.applicationName=tomcat-test1"
CATALINA_OPTS="$CATALINA_OPTS -Dpinpoint.agentId=test-tomcat-01"

Then, I start tomcat, but there is nothing in pinpoint web application select menu. What have you done? Steps you have taken to trigger the problem, for example:

  1. Launched '...' with agent: I add pinpoint agent jar in tomcat, then run tomcat/bin/startup.sh to start tomcat.
  2. Tried tracing '...' (see agent log below) 
    
2018-08-06 10:01:13 [DEBUG](o.j.n.c.s.n.SelectorUtil           :32 ) Using select timeout of 500
2018-08-06 10:01:13 [DEBUG](o.j.n.c.s.n.SelectorUtil           :32 ) Epoll-bug workaround enabled = false
2018-08-06 10:01:13 [INFO ](c.n.p.r.s.PinpointServerAcceptor   :158) bind() /127.0.0.1:65535
2018-08-06 10:01:13 [DEBUG](c.n.p.r.s.PinpointServerAcceptor   :249) sendPing
2018-08-06 10:01:13 [DEBUG](c.n.p.r.s.PinpointServerAcceptor   :282) newPingTimeout
2018-08-06 10:01:13 [DEBUG](.p.r.c.DefaultPinpointClientFactory:199) createBootStrap boss:1, worker:1
2018-08-06 10:01:13 [DEBUG](.p.r.c.DefaultPinpointClientHandler:144) DefaultPinpointClientHandler@2781e022 channelOpen() started. channel:[id: 0x4b5fd6a6]
2018-08-06 10:01:13 [INFO ](.p.r.c.DefaultPinpointClientHandler:156) DefaultPinpointClientHandler@2781e022 channelConnected() started. channel:[id: 0x4b5fd6a6, /127.0.0.1:33680 => /127.0.0.1:65535]
2018-08-06 10:01:13 [INFO ](c.n.p.r.s.PinpointServerAcceptor   :342) channelConnected channel:[id: 0x93c139aa, /127.0.0.1:33680 => /127.0.0.1:65535]
2018-08-06 10:01:13 [DEBUG](.n.p.r.c.PinpointClientHandlerState:118) DefaultPinpointClientHandler@2781e022 stateTo() started. to:CONNECTED
2018-08-06 10:01:13 [INFO ](.n.p.r.c.PinpointClientHandlerState:125) DefaultPinpointClientHandler@2781e022 stateTo() completed. Socket state change success(updateWanted:CONNECTED ,before:NONE ,current:CONNECTED).
2018-08-06 10:01:14 [DEBUG](.n.p.r.c.PinpointClientHandlerState:118) DefaultPinpointClientHandler@2781e022 stateTo() started. to:RUN_WITHOUT_HANDSHAKE
2018-08-06 10:01:14 [INFO ](.n.p.r.c.PinpointClientHandlerState:125) DefaultPinpointClientHandler@2781e022 stateTo() completed. Socket state change success(updateWanted:RUN_WITHOUT_HANDSHAKE ,before:CONNECTED ,current:RUN_WITHOUT_HANDSHAKE).
2018-08-06 10:01:14 [INFO ](c.n.p.r.c.PinpointClientHandshaker :82 ) PinpointClientHandshaker@6be9bf34 handshakeStart() started. channel:[id: 0x4b5fd6a6, /127.0.0.1:33680 => /127.0.0.1:65535]
2018-08-06 10:01:14 [INFO ](c.n.p.r.s.DefaultPinpointServer    :118) DefaultPinpointServer@7434e9a5 start() started. channel:[id: 0x93c139aa, /127.0.0.1:33680 => /127.0.0.1:65535].
2018-08-06 10:01:14 [DEBUG](.n.p.r.s.DefaultPinpointServerState:110) DefaultPinpointServer@7434e9a5 stateTo() started. to:CONNECTED
2018-08-06 10:01:14 [INFO ](h.DoNothingChannelStateEventHandler:36 ) DoNothingChannelStateEventHandler eventPerformed(). pinpointServer:DefaultPinpointServer@7434e9a5(remote:/127.0.0.1:33680, state:CONNECTED), code:CONNECTED
2018-08-06 10:01:14 [INFO ](.n.p.r.s.DefaultPinpointServerState:117) DefaultPinpointServer@7434e9a5 stateTo() completed. Socket state change success(updateWanted:CONNECTED ,before:NONE ,current:CONNECTED).
2018-08-06 10:01:14 [DEBUG](.n.p.r.s.DefaultPinpointServerState:110) DefaultPinpointServer@7434e9a5 stateTo() started. to:RUN_WITHOUT_HANDSHAKE
2018-08-06 10:01:14 [INFO ](h.DoNothingChannelStateEventHandler:36 ) DoNothingChannelStateEventHandler eventPerformed(). pinpointServer:DefaultPinpointServer@7434e9a5(remote:/127.0.0.1:33680, state:RUN_WITHOUT_HANDSHAKE), code:RUN_WITHOUT_HANDSHAKE
2018-08-06 10:01:14 [INFO ](.n.p.r.s.DefaultPinpointServerState:117) DefaultPinpointServer@7434e9a5 stateTo() completed. Socket state change success(updateWanted:RUN_WITHOUT_HANDSHAKE ,before:CONNECTED ,current:RUN_WITHOUT_HANDSHAKE).
2018-08-06 10:01:14 [INFO ](c.n.p.r.s.DefaultPinpointServer    :123) DefaultPinpointServer@7434e9a5 start() completed.
2018-08-06 10:01:14 [INFO ](c.n.p.r.c.PinpointClientHandshaker :131) PinpointClientHandshaker@6be9bf34 do handshake(1/2147483647). channel:[id: 0x4b5fd6a6, /127.0.0.1:33680 => /127.0.0.1:65535].
2018-08-06 10:01:14 [DEBUG](c.n.p.r.c.PinpointClientHandshaker :55 ) HandShakePacket write success. channel:[id: 0x4b5fd6a6, /127.0.0.1:33680 => /127.0.0.1:65535]
2018-08-06 10:01:14 [DEBUG](c.n.p.r.c.PinpointClientHandshaker :144) PinpointClientHandshaker@6be9bf34 reserveHandshake() started.
2018-08-06 10:01:14 [INFO ](c.n.p.r.c.PinpointClientHandshaker :114) PinpointClientHandshaker@6be9bf34 handshakeStart() completed. channel:[id: 0x4b5fd6a6, /127.0.0.1:33680 => /127.0.0.1:65535], data:{socketId=1}
2018-08-06 10:01:14 [INFO ](.p.r.c.DefaultPinpointClientHandler:184) DefaultPinpointClientHandler@2781e022 channelConnected() completed.
2018-08-06 10:01:14 [INFO ](c.n.p.r.s.DefaultPinpointServer    :353) DefaultPinpointServer@7434e9a5 handleHandshake() started. Packet:ControlHandshakePacket{requestId=0, payloadLength=17}
2018-08-06 10:01:14 [INFO ](n.p.r.s.SimpleServerMessageListener:54 ) handleHandshake properties:{socketId=1}
2018-08-06 10:01:14 [DEBUG](.n.p.r.s.DefaultPinpointServerState:110) DefaultPinpointServer@7434e9a5 stateTo() started. to:RUN_SIMPLEX
2018-08-06 10:01:14 [INFO ](h.DoNothingChannelStateEventHandler:36 ) DoNothingChannelStateEventHandler eventPerformed(). pinpointServer:DefaultPinpointServer@7434e9a5(remote:/127.0.0.1:33680, state:RUN_SIMPLEX), code:RUN_SIMPLEX
2018-08-06 10:01:14 [INFO ](.n.p.r.s.DefaultPinpointServerState:117) DefaultPinpointServer@7434e9a5 stateTo() completed. Socket state change success(updateWanted:RUN_SIMPLEX ,before:RUN_WITHOUT_HANDSHAKE ,current:RUN_SIMPLEX).
2018-08-06 10:01:14 [INFO ](c.n.p.r.s.DefaultPinpointServer    :368) DefaultPinpointServer@7434e9a5 handleHandshake(). ResponseCode:SIMPLEX_COMMUNICATION
2018-08-06 10:01:14 [DEBUG](.p.r.c.DefaultPinpointClientHandler:490) DefaultPinpointClientHandler@2781e022 close() started.
2018-08-06 10:01:14 [DEBUG](.n.p.r.c.PinpointClientHandlerState:118) DefaultPinpointClientHandler@2781e022 stateTo() started. to:BEING_CLOSE_BY_CLIENT
2018-08-06 10:01:14 [INFO ](.n.p.r.c.PinpointClientHandlerState:125) DefaultPinpointClientHandler@2781e022 stateTo() completed. Socket state change success(updateWanted:BEING_CLOSE_BY_CLIENT ,before:RUN_WITHOUT_HANDSHAKE ,current:BEING_CLOSE_BY_CLIENT).
2018-08-06 10:01:14 [DEBUG](.p.r.c.DefaultPinpointClientHandler:547) DefaultPinpointClientHandler@2781e022 sendClosedPacket() started.
2018-08-06 10:01:14 [INFO ](c.n.p.r.s.DefaultPinpointServer    :373) DefaultPinpointServer@7434e9a5 handleHandshake() completed.
2018-08-06 10:01:14 [INFO ](c.n.p.r.c.PinpointClientHandshaker :149) PinpointClientHandshaker@6be9bf34 handshakeComplete() started. responsePacket:ControlHandshakeResponsePacket{requestId=0, payloadLength=27}
2018-08-06 10:01:14 [INFO ](n.p.r.s.SimpleServerMessageListener:45 ) handleSend packet:SendPacket{payloadLength=0}, remote:/127.0.0.1:33680
2018-08-06 10:01:14 [INFO ](c.n.p.r.c.PinpointClientHandshaker :167) PinpointClientHandshaker@6be9bf34 handshakeComplete() completed. handshake-response:{code=0, subCode=1}.
2018-08-06 10:01:14 [INFO ](.p.r.c.DefaultPinpointClientHandler:428) DefaultPinpointClientHandler@2781e022 handleHandshakePacket() started. message:ControlHandshakeResponsePacket{requestId=0, payloadLength=27}
2018-08-06 10:01:14 [DEBUG](.n.p.r.c.PinpointClientHandlerState:118) DefaultPinpointClientHandler@2781e022 stateTo() started. to:RUN_SIMPLEX
2018-08-06 10:01:14 [INFO ](.n.p.r.c.PinpointClientHandlerState:125) DefaultPinpointClientHandler@2781e022 stateTo() completed. Socket state change fail(updateWanted:RUN_SIMPLEX ,before:RUN_WITHOUT_HANDSHAKE ,current:BEING_CLOSE_BY_CLIENT).
2018-08-06 10:01:14 [INFO ](.p.r.c.DefaultPinpointClientHandler:445) [id: 0x4b5fd6a6, /127.0.0.1:33680 => /127.0.0.1:65535] handleHandshakePacket() completed. code:SIMPLEX_COMMUNICATION
2018-08-06 10:01:14 [DEBUG](.p.r.c.DefaultPinpointClientHandler:55 ) sendClosedPacket() write success. channel:[id: 0x4b5fd6a6, /127.0.0.1:33680 => /127.0.0.1:65535]
2018-08-06 10:01:14 [INFO ](c.n.p.r.s.DefaultPinpointServer    :407) DefaultPinpointServer@7434e9a5 handleClosePacket() started.
2018-08-06 10:01:14 [DEBUG](.n.p.r.s.DefaultPinpointServerState:110) DefaultPinpointServer@7434e9a5 stateTo() started. to:BEING_CLOSE_BY_CLIENT
2018-08-06 10:01:14 [INFO ](h.DoNothingChannelStateEventHandler:36 ) DoNothingChannelStateEventHandler eventPerformed(). pinpointServer:DefaultPinpointServer@7434e9a5(remote:/127.0.0.1:33680, state:BEING_CLOSE_BY_CLIENT), code:BEING_CLOSE_BY_CLIENT
2018-08-06 10:01:14 [INFO ](.n.p.r.s.DefaultPinpointServerState:117) DefaultPinpointServer@7434e9a5 stateTo() completed. Socket state change success(updateWanted:BEING_CLOSE_BY_CLIENT ,before:RUN_SIMPLEX ,current:BEING_CLOSE_BY_CLIENT).
2018-08-06 10:01:14 [INFO ](.p.r.c.DefaultPinpointClientHandler:556) DefaultPinpointClientHandler@2781e022 channelClosed() started.
2018-08-06 10:01:14 [DEBUG](.p.r.c.DefaultPinpointClientHandler:55 ) close() event success. channel:[id: 0x4b5fd6a6, /127.0.0.1:33680 :> /127.0.0.1:65535]
2018-08-06 10:01:14 [DEBUG](.n.p.r.c.PinpointClientHandlerState:118) DefaultPinpointClientHandler@2781e022 stateTo() started. to:CLOSED_BY_CLIENT
2018-08-06 10:01:14 [INFO ](.n.p.r.c.PinpointClientHandlerState:125) DefaultPinpointClientHandler@2781e022 stateTo() completed. Socket state change success(updateWanted:CLOSED_BY_CLIENT ,before:BEING_CLOSE_BY_CLIENT ,current:CLOSED_BY_CLIENT).
2018-08-06 10:01:14 [INFO ](c.n.p.r.s.DefaultPinpointServer    :413) DefaultPinpointServer@7434e9a5 handleClosePacket() completed.
2018-08-06 10:01:14 [DEBUG](.p.r.c.DefaultPinpointClientHandler:519) DefaultPinpointClientHandler@2781e022 closeResources() started.
2018-08-06 10:01:14 [DEBUG](.n.p.r.s.DefaultPinpointServerState:110) DefaultPinpointServer@7434e9a5 stateTo() started. to:CLOSED_BY_CLIENT
2018-08-06 10:01:14 [INFO ](h.DoNothingChannelStateEventHandler:36 ) DoNothingChannelStateEventHandler eventPerformed(). pinpointServer:DefaultPinpointServer@7434e9a5(remote:/127.0.0.1:33680, state:CLOSED_BY_CLIENT), code:CLOSED_BY_CLIENT
2018-08-06 10:01:14 [INFO ](c.n.p.r.c.PinpointClientHandshaker :238) PinpointClientHandshaker@6be9bf34 handshakeAbort() started.
2018-08-06 10:01:14 [INFO ](.n.p.r.s.DefaultPinpointServerState:117) DefaultPinpointServer@7434e9a5 stateTo() completed. Socket state change success(updateWanted:CLOSED_BY_CLIENT ,before:BEING_CLOSE_BY_CLIENT ,current:CLOSED_BY_CLIENT).
2018-08-06 10:01:14 [INFO ](c.n.p.r.c.PinpointClientHandshaker :242) PinpointClientHandshaker@6be9bf34 unexpected state
2018-08-06 10:01:14 [DEBUG](c.n.p.r.c.RequestManager           :164) close()
2018-08-06 10:01:14 [INFO ](c.n.p.p.DefaultAgent               :102) AgentOption:DefaultAgentOption{instrumentation=sun.instrument.InstrumentationImpl@548ad73b, agentId='test-tomcat-01', applicationName='tomcat-test1', profilerConfig=DefaultProfilerConfig{properties={profiler.jdbc.mysql=true, profiler.statdatasender.chunk.size=16384, profiler.ning.asynchttpclient.param.sampling.rate=1, profiler.jdbc.postgresql.commit=true, profiler.jdbc.dbcp.connectionclose=true, profiler.logback.logging.transactioninfo=false, profiler.google.httpclient.async=true, profiler.collector.stat.ip=${profiler.collector.ip}, profiler.vertx.handlers=, profiler.thrift.service.args=true, profiler.vertx.http.server.excludeurl=, profiler.jboss.tracerequestparam=true, profiler.jetty.enable=true, profiler.jdbc.jtds.rollback=true, profiler.json.jsonlib=true, profiler.json.jackson=true, profiler.ning.asynchttpclient.entity.sampling.rate=1, profiler.jdbc.mariadb.setautocommit=true, profiler.vertx.http.server.enable=false, profiler.jdbc.postgresql.rollback=true, profiler.orm.mybatis=true, profiler.dubbo.bootstrap.main=com.alibaba.dubbo.container.Main, profiler.collector.tcp.ip=${profiler.collector.ip}, profiler.pinpoint.activethread=true, profiler.cassandra=true, profiler.vertx.bootstrap.main=io.vertx.core.Starter, profiler.vertx.http.client.enable=false, profiler.jdbc.tracesqlbindvalue=true, profiler.redis.io=true, profiler.jdbc.cubrid.commit=true, profiler.spandatasender.write.queue.size=5120, profiler.instrument.engine=ASM, profiler.jdbc.mysql.setautocommit=true, profiler.apache.httpclient4.entity.sampling.rate=1, profiler.enable=true, profiler.redis=true, profiler.thrift.client=true, profiler.activemq.client.destination.exclude=, profiler.thrift.client.async=true, profiler.tomcat.hidepinpointheader=true, profiler.jboss.enable=true, profiler.apache.httpclient3.io=true, profiler.memcached=true, profiler.type.detect.order=, profiler.jdbc.mariadb.rollback=true, profiler.apache.httpclient3.entity.dumptype=ALWAYS, profiler.resin.enable=true, profiler.springboot.bootstrap.main=org.springframework.boot.loader.JarLauncher, org.springframework.boot.loader.WarLauncher, org.springframework.boot.loader.PropertiesLauncher, profiler.dubbo.enable=true, profiler.jdbc.jtds.commit=true, profiler.jdbc.postgresql=true, profiler.resin.bootstrap.main=, profiler.redis.pipeline=, profiler.jdbc.hikaricp.connectionclose=true, profiler.spring.beans.1.name.pattern=, profiler.jdbc.cubrid.setautocommit=true, profiler.jdbc.cubrid=true, profiler.apache.httpclient3.entity.sampling.rate=1, profiler.ning.asynchttpclient.param=true, profiler.log4j.logging.transactioninfo=false, profiler.arcus=true, profiler.okhttp.param=true, profiler.tomcat.enable=true, profiler.spandatasender.chunk.size=16384, profiler.resin.tracecookies=true, profiler.arcus.keytrace=true, profiler.vertx.enable=false, profiler.thrift.processor.async=true, bytecode.dump.verify=false, profiler.vertx.http.client.entity.statuscode=true, profiler.collector.ip=XXX.XX.XX.X, profiler.pinpoint.datasource=true, profiler.jdbc.oracle.commit=true, profiler.spring.beans.1.annotation=org.springframework.stereotype.Controller,org.springframework.stereotype.Service,org.springframework.stereotype.Repository, profiler.okhttp.cookie=false, profiler.thrift.service.result=true, profiler.thrift.processor=true, bytecode.dump.bytecode=false, profiler.jdbc.mysql.rollback=true, profiler.jdbc.mariadb=true, profiler.jdbc.oracle=true, profiler.tomcat.excludeurl=/aa/test.html, /bb/exclude.html, profiler.apache.httpclient4.io=true, profiler.apache.httpclient3.entity=true, profiler.apache.httpclient3.cookie.dumptype=ALWAYS, profiler.tomcat.conditional.transform=false, profiler.entrypoint=, profiler.jetty.bootstrap.main=org.eclipse.jetty.start.Main, profiler.apache.httpclient3.cookie=true, profiler.jdbc.maxsqlbindvaluesize=1024, profiler.jdk.http.param=true, profiler.spring.beans=true, profiler.jvm.vendor.name=Oracle, profiler.tomcat.bootstrap.main=org.apache.catalina.startup.Bootstrap, profiler.jdbc.hikaricp=true, profiler.resin.tracerequestparam=true, profiler.jdbc.postgresql.setautocommit=true, bytecode.dump.classlist=, profiler.ning.asynchttpclient=true, profiler.tcpdatasender.command.activethread.threaddump.enable=true, profiler.apache.httpclient4.entity.dumptype=ALWAYS, profiler.vertx.http.client.cookie.dumptype=ALWAYS, profiler.ning.asynchttpclient.entity.dumptype=ALWAYS, profiler.activemq.client.consumer.enable=true, profiler.tomcat.tracerequestparam=true, profiler.statdatasender.socket.type=OIO, profiler.spring.beans.1.base-packages=, profiler.jboss.conditional.transform=true, profiler.resin.cookie.sampling.rate=10, profiler.ning.asynchttpclient.entity=true, profiler.include=, profiler.activemq.client.producer.enable=true, profiler.vertx.http.client.cookie.sampling.rate=1, profiler.ning.asynchttpclient.param.dumptype=ALWAYS, profiler.sampling.rate=1, profiler.io.buffering.enable=true, profiler.spring.beans.mark.error=false, profiler.jvm.collect.detailed.metrics=true, profiler.ning.asynchttpclient.cookie.sampling.rate=1, profiler.ning.asynchttpclient.cookie=true, profiler.jdbc.oracle.rollback=true, profiler.memcached.keytrace=true, profiler.springboot.enable=true, profiler.interceptor.exception.propagate=false, profiler.callstack.max.depth=64, profiler.apache.httpclient4.cookie.dumptype=ALWAYS, profiler.ning.asynchttpclient.entity.dumpsize=1024, profiler.ning.asynchttpclient.cookie.dumptype=ALWAYS, profiler.jetty.excludeurl=, profiler.okhttp.cookie.dumptype=EXCEPTION, profiler.spandatasender.socket.sendbuffersize=655360, profiler.collector.stat.port=19995, profiler.apache.httpclient4.entity.statuscode=true, profiler.collector.span.ip=${profiler.collector.ip}, profiler.vertx.http.client.param=true, bytecode.dump.asm=false, profiler.jboss.bootstrap.main=org.jboss.modules.Main, profiler.tcpdatasender.command.activethread.count.enable=true, profiler.hystrix=true, profiler.ning.asynchttpclient.param.dumpsize=1024, profiler.orm.ibatis=true, profiler.apache.httpclient4.cookie.sampling.rate=1, profiler.jboss.hidepinpointheader=true, profiler.jdbc=true, profiler.tcpdatasender.command.activethread.enable=true, profiler.apache.httpclient3.param=true, profiler.collector.tcp.port=19994, profiler.plugin.disable=, profiler.apache.httpclient4.entity=true, profiler.apache.httpclient4.param=true, profiler.ning.asynchttpclient.cookie.dumpsize=1024, profiler.jdbc.dbcp2.connectionclose=true, profiler.jboss.excludeurl=, profiler.tcpdatasender.command.accept.enable=true, profiler.apache.httpclient4.cookie=true, profiler.jdbc.jtds.setautocommit=true, bytecode.dump.enable=false, profiler.resin.cookie.dumptype=ALWAYS, profiler.okhttp.async=true, profiler.agentInfo.send.retry.interval=300000, profiler.io.buffering.buffersize=20, profiler.jdbc.cubrid.rollback=true, profiler.jdbc.oracle.setautocommit=true, profiler.tcpdatasender.command.activethread.threadlightdump.enable=true, profiler.jdbc.mariadb.commit=true, profiler.apache.httpclient3.cookie.sampling.rate=1, profiler.statdatasender.write.queue.size=5120, profiler.activemq.client.destination.separator=, profiler.interceptorregistry.size=8192, profiler.spring.beans.1.class.pattern=, profiler.jdbc.mysql.commit=true, profiler.spring.beans.1.scope=component-scan, profiler.collector.span.port=19996, profiler.jdbc.dbcp2=true, profiler.jdbc.dbcp=true, profiler.resin.excludeurl=, profiler.vertx.http.server.tracerequestparam=true, profiler.jdbc.sqlcachesize=1024, profiler.okhttp.cookie.sampling.rate=10, profiler.sampling.enable=true, profiler.spandatasender.socket.type=OIO, profiler.vertx.http.client.cookie=true, profiler.activemq.client.enable=true, profiler.applicationservertype=SPRING_BOOT, profiler.jdbc.jtds=true, profiler.jvm.collect.interval=1000, profiler.json.gson=true}, interceptorRegistrySize=8192, propertyPlaceholderHelper=com.navercorp.pinpoint.bootstrap.util.spring.PropertyPlaceholderHelper@4c762604, profileEnable=true, collectorSpanServerIp=XXX.XX.XX.X, collectorSpanServerPort=19996, collectorStatServerIp=XXX.XX.XX.X, collectorStatServerPort=19995, collectorTcpServerIp=XXX.XX.XX.X, collectorTcpServerPort=19994, spanDataSenderWriteQueueSize=5120, spanDataSenderSocketSendBufferSize=655360, spanDataSenderSocketTimeout=3000, spanDataSenderChunkSize=16384, spanDataSenderSocketType=OIO, statDataSenderWriteQueueSize=5120, statDataSenderSocketSendBufferSize=1048576, statDataSenderSocketTimeout=3000, statDataSenderChunkSize=16384, statDataSenderSocketType=OIO, tcpDataSenderCommandAcceptEnable=true, tcpDataSenderCommandActiveThreadEnable=true, tcpDataSenderCommandActiveThreadCountEnable=true, tcpDataSenderCommandActiveThreadDumpEnable=true, tcpDataSenderCommandActiveThreadLightDumpEnable=true, traceAgentActiveThread=true, traceAgentDataSource=true, dataSourceTraceLimitSize=20, callStackMaxDepth=64, jdbcSqlCacheSize=1024, traceSqlBindValue=true, maxSqlBindValueSize=1024, samplingEnable=true, samplingRate=1, ioBufferingEnable=true, ioBufferingBufferSize=20, profileJvmCollectInterval=1000, profilableClassFilter=com.navercorp.pinpoint.bootstrap.config.SkipFilter@2641e737, DEFAULT_AGENT_INFO_SEND_RETRY_INTERVAL=300000, agentInfoSendRetryInterval=300000, applicationServerType=SPRING_BOOT, applicationTypeDetectOrder=[], disabledPlugins=[]}, pluginJars=[file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-httpclient4-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-httpclient4-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-user-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-user-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-ning-asynchttpclient-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-ning-asynchttpclient-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-commons-dbcp-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-commons-dbcp-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-log4j-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-log4j-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-ibatis-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-ibatis-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-resin-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-resin-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-dubbo-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-dubbo-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-okhttp-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-okhttp-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-gson-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-gson-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-commons-dbcp2-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-commons-dbcp2-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-json-lib-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-json-lib-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-jackson-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-jackson-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-jboss-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-jboss-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-cxf-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-spring-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-spring-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-jtds-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-jtds-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-mysql-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-mysql-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-tomcat-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-tomcat-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-mybatis-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-mybatis-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-cubrid-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-cubrid-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-thrift-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-thrift-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-hikaricp-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-hikaricp-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-hystrix-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-hystrix-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-arcus-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-arcus-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-jetty-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-jetty-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-logback-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-logback-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-mariadb-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-mariadb-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-spring-boot-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-spring-boot-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-jdk-http-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-jdk-http-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-redis-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-redis-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-cassandra-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-cassandra-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-activemq-client-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-activemq-client-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-httpclient3-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-httpclient3-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-postgresql-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-postgresql-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-oracle-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-oracle-jdbc-driver-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-vertx-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-vertx-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/._pinpoint-google-httpclient-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-google-httpclient-plugin-1.6.2.jar, file:/u01/pinpoint/pinpoint-agent-1.6.2/plugin/pinpoint-cxf-plugin-1.6.2.jar], bootstrapJarPaths=[/u01/pinpoint/pinpoint-agent-1.6.2/boot/pinpoint-commons-1.6.2.jar, /u01/pinpoint/pinpoint-agent-1.6.2/boot/pinpoint-bootstrap-core-1.6.2.jar, /u01/pinpoint/pinpoint-agent-1.6.2/boot/pinpoint-bootstrap-core-optional-1.6.2.jar, /u01/pinpoint/pinpoint-agent-1.6.2/boot/pinpoint-annotations-1.6.2.jar], serviceTypeRegistryService=com.navercorp.pinpoint.common.service.DefaultServiceTypeRegistryService@727803de, annotationKeyRegistryService=com.navercorp.pinpoint.common.service.DefaultAnnotationKeyRegistryService@704921a5}
2018-08-06 10:01:14 [INFO ](c.n.p.p.l.Slf4jLoggerBinder        :347) PLoggerFactory.initialize() bind:com.navercorp.pinpoint.profiler.logging.Slf4jLoggerBinder cl:com.navercorp.pinpoint.bootstrap.classloader.ParallelCapablePinpointURLClassLoader@5c0369c4
2018-08-06 10:01:14 [INFO ](.r.DefaultInterceptorRegistryBinder:50 ) bind:DefaultRegistry-0
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.runtime.name=OpenJDK Runtime Environment
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.protocol.handler.pkgs=org.apache.catalina.webresources
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties sun.boot.library.path=/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/amd64
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.vm.version=25.102-b14
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.vm.vendor=Oracle Corporation
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.vendor.url=http://java.oracle.com/
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties path.separator=:
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.vm.name=OpenJDK 64-Bit Server VM
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties file.encoding.pkg=sun.io
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.util.logging.config.file=/home/mtnsadmin/apache-tomcat-8.5.14/conf/logging.properties
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties user.country=US
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties sun.java.launcher=SUN_STANDARD
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties sun.os.patch.level=unknown
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.vm.specification.name=Java Virtual Machine Specification
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties user.dir=/home/mtnsadmin/apache-tomcat-8.5.14/bin
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.runtime.version=1.8.0_102-b14
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.awt.graphicsenv=sun.awt.X11GraphicsEnvironment
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.endorsed.dirs=/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/endorsed
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties os.arch=amd64
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties java.io.tmpdir=/home/mtnsadmin/apache-tomcat-8.5.14/temp
2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper     :37 ) SystemProperties line.separator=

2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.vm.specification.vendor=Oracle Corporation 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.util.logging.manager=org.apache.juli.ClassLoaderLogManager 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties os.name=Linux 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties sun.jnu.encoding=UTF-8 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.library.path=/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties sun.nio.ch.bugLevel= 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.specification.name=Java Platform API Specification 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.class.version=52.0 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties sun.management.compiler=HotSpot 64-Bit Tiered Compilers 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties os.version=3.10.0-693.11.6.el7.x86_64 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties user.home=/root 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties user.timezone=Asia/Shanghai 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.awt.printerjob=sun.print.PSPrinterJob 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.specification.version=1.8 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties file.encoding=UTF-8 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties catalina.home=/home/mtnsadmin/apache-tomcat-8.5.14 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties user.name=root 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.class.path=/home/mtnsadmin/apache-tomcat-8.5.14/bin/bootstrap.jar:/home/mtnsadmin/apache-tomcat-8.5.14/bin/tomcat-juli.jar:/u01/pinpoint/pinpoint-agent-1.6.2/pinpoint-bootstrap-1.6.2.jar 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties pinpoint.agentId=test-tomcat-01 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.vm.specification.version=1.8 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties sun.arch.data.model=64 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.home=/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties sun.java.command=org.apache.catalina.startup.Bootstrap start 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.specification.vendor=Oracle Corporation 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties user.language=en 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties awt.toolkit=sun.awt.X11.XToolkit 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.vm.info=mixed mode 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.version=1.8.0_102 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties pinpoint.log=/u01/pinpoint/pinpoint-agent-1.6.2/log 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.ext.dirs=/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/ext:/usr/java/packages/lib/ext 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties pinpoint.applicationName=tomcat-test1 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties sun.boot.class.path=/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/resources.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/rt.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/sunrsasign.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/jsse.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/jce.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/charsets.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/lib/jfr.jar:/usr/lib/jvm/java-1.8.0-openjdk-1.8.0.102-4.b14.el7.x86_64/jre/classes 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.vendor=Oracle Corporation 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties catalina.base=/home/mtnsadmin/apache-tomcat-8.5.14 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties jdk.tls.ephemeralDHKeySize=2048 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties file.separator=/ 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties java.vendor.url.bug=http://bugreport.sun.com/bugreport/ 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties sun.cpu.endian=little 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties sun.io.unicode.encoding=UnicodeLittle 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties sun.cpu.isalist= 2018-08-06 10:01:14 [INFO ](c.n.p.p.u.SystemPropertyDumper :37 ) SystemProperties pinpoint.version=1.6.2 2018-08-06 10:01:14 [INFO ](c.n.p.p.DefaultAgent :140) dumpConfig DefaultProfilerConfig{properties={profiler.jdbc.mysql=true, profiler.statdatasender.chunk.size=16384, profiler.ning.asynchttpclient.param.sampling.rate=1, profiler.jdbc.postgresql.commit=true, profiler.jdbc.dbcp.connectionclose=true, profiler.logback.logging.transactioninfo=false, profiler.google.httpclient.async=true, profiler.collector.stat.ip=${profiler.collector.ip}, profiler.vertx.handlers=, profiler.thrift.service.args=true, profiler.vertx.http.server.excludeurl=, profiler.jboss.tracerequestparam=true, profiler.jetty.enable=true, profiler.jdbc.jtds.rollback=true, profiler.json.jsonlib=true, profiler.json.jackson=true, profiler.ning.asynchttpclient.entity.sampling.rate=1, profiler.jdbc.mariadb.setautocommit=true, profiler.vertx.http.server.enable=false, profiler.jdbc.postgresql.rollback=true, profiler.orm.mybatis=true, profiler.dubbo.bootstrap.main=com.alibaba.dubbo.container.Main, profiler.collector.tcp.ip=${profiler.collector.ip}, profiler.pinpoint.activethread=true, profiler.cassandra=true, profiler.vertx.bootstrap.main=io.vertx.core.Starter, profiler.vertx.http.client.enable=false, profiler.jdbc.tracesqlbindvalue=true, profiler.redis.io=true, profiler.jdbc.cubrid.commit=true, profiler.spandatasender.write.queue.size=5120, profiler.instrument.engine=ASM, profiler.jdbc.mysql.setautocommit=true, profiler.apache.httpclient4.entity.sampling.rate=1, profiler.enable=true, profiler.redis=true, profiler.thrift.client=true, profiler.activemq.client.destination.exclude=, profiler.thrift.client.async=true, profiler.tomcat.hidepinpointheader=true, profiler.jboss.enable=true, profiler.apache.httpclient3.io=true, profiler.memcached=true, profiler.type.detect.order=, profiler.jdbc.mariadb.rollback=true, profiler.apache.httpclient3.entity.dumptype=ALWAYS, profiler.resin.enable=true, profiler.springboot.bootstrap.main=org.springframework.boot.loader.JarLauncher, org.springframework.boot.loader.WarLauncher, org.springframework.boot.loader.PropertiesLauncher, profiler.dubbo.enable=true, profiler.jdbc.jtds.commit=true, profiler.jdbc.postgresql=true, profiler.resin.bootstrap.main=, profiler.redis.pipeline=, profiler.jdbc.hikaricp.connectionclose=true, profiler.spring.beans.1.name.pattern=, profiler.jdbc.cubrid.setautocommit=true, profiler.jdbc.cubrid=true, profiler.apache.httpclient3.entity.sampling.rate=1, profiler.ning.asynchttpclient.param=true, profiler.log4j.logging.transactioninfo=false, profiler.arcus=true, profiler.okhttp.param=true, profiler.tomcat.enable=true, profiler.spandatasender.chunk.size=16384, profiler.resin.tracecookies=true, profiler.arcus.keytrace=true, profiler.vertx.enable=false, profiler.thrift.processor.async=true, bytecode.dump.verify=false, profiler.vertx.http.client.entity.statuscode=true, profiler.collector.ip=XXX.XX.XX.X, profiler.pinpoint.datasource=true, profiler.jdbc.oracle.commit=true, profiler.spring.beans.1.annotation=org.springframework.stereotype.Controller,org.springframework.stereotype.Service,org.springframework.stereotype.Repository, profiler.okhttp.cookie=false, profiler.thrift.service.result=true, profiler.thrift.processor=true, bytecode.dump.bytecode=false, profiler.jdbc.mysql.rollback=true, profiler.jdbc.mariadb=true, profiler.jdbc.oracle=true, profiler.tomcat.excludeurl=/aa/test.html, /bb/exclude.html, profiler.apache.httpclient4.io=true, profiler.apache.httpclient3.entity=true, profiler.apache.httpclient3.cookie.dumptype=ALWAYS, profiler.tomcat.conditional.transform=false, profiler.entrypoint=, profiler.jetty.bootstrap.main=org.eclipse.jetty.start.Main, profiler.apache.httpclient3.cookie=true, profiler.jdbc.maxsqlbindvaluesize=1024, profiler.jdk.http.param=true, profiler.spring.beans=true, profiler.jvm.vendor.name=Oracle, profiler.tomcat.bootstrap.main=org.apache.catalina.startup.Bootstrap, profiler.jdbc.hikaricp=true, profiler.resin.tracerequestparam=true, profiler.jdbc.postgresql.setautocommit=true, bytecode.dump.classlist=, profiler.ning.asynchttpclient=true, profiler.tcpdatasender.command.activethread.threaddump.enable=true, profiler.apache.httpclient4.entity.dumptype=ALWAYS, profiler.vertx.http.client.cookie.dumptype=ALWAYS, profiler.ning.asynchttpclient.entity.dumptype=ALWAYS, profiler.activemq.client.consumer.enable=true, profiler.tomcat.tracerequestparam=true, profiler.statdatasender.socket.type=OIO, profiler.spring.beans.1.base-packages=, profiler.jboss.conditional.transform=true, profiler.resin.cookie.sampling.rate=10, profiler.ning.asynchttpclient.entity=true, profiler.include=, profiler.activemq.client.producer.enable=true, profiler.vertx.http.client.cookie.sampling.rate=1, profiler.ning.asynchttpclient.param.dumptype=ALWAYS, profiler.sampling.rate=1, profiler.io.buffering.enable=true, profiler.spring.beans.mark.error=false, profiler.jvm.collect.detailed.metrics=true, profiler.ning.asynchttpclient.cookie.sampling.rate=1, profiler.ning.asynchttpclient.cookie=true, profiler.jdbc.oracle.rollback=true, profiler.memcached.keytrace=true, profiler.springboot.enable=true, profiler.interceptor.exception.propagate=false, profiler.callstack.max.depth=64, profiler.apache.httpclient4.cookie.dumptype=ALWAYS, profiler.ning.asynchttpclient.entity.dumpsize=1024, profiler.ning.asynchttpclient.cookie.dumptype=ALWAYS, profiler.jetty.excludeurl=, profiler.okhttp.cookie.dumptype=EXCEPTION, profiler.spandatasender.socket.sendbuffersize=655360, profiler.collector.stat.port=19995, profiler.apache.httpclient4.entity.statuscode=true, profiler.collector.span.ip=${profiler.collector.ip}, profiler.vertx.http.client.param=true, bytecode.dump.asm=false, profiler.jboss.bootstrap.main=org.jboss.modules.Main, profiler.tcpdatasender.command.activethread.count.enable=true, profiler.hystrix=true, profiler.ning.asynchttpclient.param.dumpsize=1024, profiler.orm.ibatis=true, profiler.apache.httpclient4.cookie.sampling.rate=1, profiler.jboss.hidepinpointheader=true, profiler.jdbc=true, profiler.tcpdatasender.command.activethread.enable=true, profiler.apache.httpclient3.param=true, profiler.collector.tcp.port=19994, profiler.plugin.disable=, profiler.apache.httpclient4.entity=true, profiler.apache.httpclient4.param=true, profiler.ning.asynchttpclient.cookie.dumpsize=1024, profiler.jdbc.dbcp2.connectionclose=true, profiler.jboss.excludeurl=, profiler.tcpdatasender.command.accept.enable=true, profiler.apache.httpclient4.cookie=true, profiler.jdbc.jtds.setautocommit=true, bytecode.dump.enable=false, profiler.resin.cookie.dumptype=ALWAYS, profiler.okhttp.async=true, profiler.agentInfo.send.retry.interval=300000, profiler.io.buffering.buffersize=20, profiler.jdbc.cubrid.rollback=true, profiler.jdbc.oracle.setautocommit=true, profiler.tcpdatasender.command.activethread.threadlightdump.enable=true, profiler.jdbc.mariadb.commit=true, profiler.apache.httpclient3.cookie.sampling.rate=1, profiler.statdatasender.write.queue.size=5120, profiler.activemq.client.destination.separator=, profiler.interceptorregistry.size=8192, profiler.spring.beans.1.class.pattern=, profiler.jdbc.mysql.commit=true, profiler.spring.beans.1.scope=component-scan, profiler.collector.span.port=19996, profiler.jdbc.dbcp2=true, profiler.jdbc.dbcp=true, profiler.resin.excludeurl=, profiler.vertx.http.server.tracerequestparam=true, profiler.jdbc.sqlcachesize=1024, profiler.okhttp.cookie.sampling.rate=10, profiler.sampling.enable=true, profiler.spandatasender.socket.type=OIO, profiler.vertx.http.client.cookie=true, profiler.activemq.client.enable=true, profiler.applicationservertype=SPRING_BOOT, profiler.jdbc.jtds=true, profiler.jvm.collect.interval=1000, profiler.json.gson=true}, interceptorRegistrySize=8192, propertyPlaceholderHelper=com.navercorp.pinpoint.bootstrap.util.spring.PropertyPlaceholderHelper@4c762604, profileEnable=true, collectorSpanServerIp=XXX.XX.XX.X, collectorSpanServerPort=19996, collectorStatServerIp=XXX.XX.XX.X, collectorStatServerPort=19995, collectorTcpServerIp=XXX.XX.XX.X, collectorTcpServerPort=19994, spanDataSenderWriteQueueSize=5120, spanDataSenderSocketSendBufferSize=655360, spanDataSenderSocketTimeout=3000, spanDataSenderChunkSize=16384, spanDataSenderSocketType=OIO, statDataSenderWriteQueueSize=5120, statDataSenderSocketSendBufferSize=1048576, statDataSenderSocketTimeout=3000, statDataSenderChunkSize=16384, statDataSenderSocketType=OIO, tcpDataSenderCommandAcceptEnable=true, tcpDataSenderCommandActiveThreadEnable=true, tcpDataSenderCommandActiveThreadCountEnable=true, tcpDataSenderCommandActiveThreadDumpEnable=true, tcpDataSenderCommandActiveThreadLightDumpEnable=true, traceAgentActiveThread=true, traceAgentDataSource=true, dataSourceTraceLimitSize=20, callStackMaxDepth=64, jdbcSqlCacheSize=1024, traceSqlBindValue=true, maxSqlBindValueSize=1024, samplingEnable=true, samplingRate=1, ioBufferingEnable=true, ioBufferingBufferSize=20, profileJvmCollectInterval=1000, profilableClassFilter=com.navercorp.pinpoint.bootstrap.config.SkipFilter@2641e737, DEFAULT_AGENT_INFO_SEND_RETRY_INTERVAL=300000, agentInfoSendRetryInterval=300000, applicationServerType=SPRING_BOOT, applicationTypeDetectOrder=[], disabledPlugins=[]} 2018-08-06 10:01:14 [DEBUG](c.n.p.p.DefaultAgent :148) Agent status is changed. INITIALIZING 2018-08-06 10:01:14 INFO DefaultAgent classLoader:com.navercorp.pinpoint.bootstrap.classloader.ParallelCapablePinpointURLClassLoader@5c0369c4 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO ASM InstrumentEngine. 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 [INFO ](c.n.p.p.s.UdpDataSender :77 ) UdpDataSender initialized. host=XXX.XX.XX.X, port=19996 2018-08-06 10:01:15 [INFO ](c.n.p.p.s.AsyncQueueingExecutor :78 ) Pinpoint-UdpSpanDataExecutor(18-0) started. 2018-08-06 10:01:15 [INFO ](c.n.p.p.s.UdpDataSender :77 ) UdpDataSender initialized. host=XXX.XX.XX.X, port=19995 2018-08-06 10:01:15 [INFO ](c.n.p.p.s.UdpDataSender :102) DatagramSocket.setSendBufferSize() error. 1048576!=655360 2018-08-06 10:01:15 [INFO ](c.n.p.p.s.AsyncQueueingExecutor :78 ) Pinpoint-UdpStatDataExecutor(19-0) started. 2018-08-06 10:01:15 INFO loaded : HotSpot's Parallel (Old) gc garbage collector metrics 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO loaded : HotSpot's Parallel (Old) gc memory metrics 2018-08-06 10:01:15 INFO loaded : CpuLoadMetric for Oracle Java 1.7+ 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 DEBUG createBootStrap boss:1, worker:1 2018-08-06 10:01:15 INFO default ApplicationServerType=SPRING_BOOT 2018-08-06 10:01:15 INFO load plugin 2018-08-06 10:01:15 INFO load plugin


3. Collector outputs trace log (see collector log below)
I cant't find these codes like `[DEBUG](c.n.p.c.h.AgentStatHandlerV2       :104) Received TAgentStatBatch=TAgentStatBatch(agentId:test-tomcat-01` in collector log

**Additional context**
By the way, I find it always `load plugin` in agent log, why it happened?
RoySRose commented 6 years ago

Hello, @WangHouLing

Please take a look at network configuration checker, this may help you check if the configuration is correct.

It must be the problem with the network or the firewall since there is no problem when you installed tomcat with Pinpoint agent on the same machine as the pinpoint collector.

I can see that you have posted 'Pinpoint agent config' file. You don't expect me to take a look at it and figure out what has changed, right?

If you don't want to load all the plugins you can disable them in the config file. But it will not affect the performance anyway.

WangHouLing commented 6 years ago

@RoySRose Thank you for your reply! I only changed these items in pinpoint agent config:

profiler.collector.ip=XXX.XX.XX.X
profiler.collector.span.port=19996
profiler.collector.stat.port=19995
profiler.collector.tcp.port=19994

# Manually override jvm vendor name (Oracle, IBM, OpenJDK, etc)
# You probably won't ever need to set this value.
profiler.jvm.vendor.name=Oracle

###########################################################
# application type                                        # 
###########################################################
#profiler.applicationservertype=TOMCAT
profiler.applicationservertype=SPRING_BOOT
#profiler.applicationservertype=BLOC
#profiler.spandatasender.socket.sendbuffersize=1048576
profiler.spandatasender.socket.sendbuffersize=655360
#profiler.statdatasender.socket.sendbuffersize=1048576
profiler.spandatasender.socket.sendbuffersize=655360

I run sh networktest.sh, this is detail:

2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.pinpoint.datasource.tracelimitsize=20
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.callstack.max.depth=64
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.jdbc.sqlcachesize=1024
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.jdbc.tracesqlbindvalue=true
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.sampling.enable=true
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.sampling.rate=1
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.io.buffering.enable=true
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.io.buffering.buffersize=20
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.jvm.collect.interval=1000
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.jvm.vendor.name=Oracle
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.jvm.collect.detailed.metrics=true
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.agentInfo.send.retry.interval=300000
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.applicationservertype=SPRING_BOOT
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.include=
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) profiler.interceptor.exception.propagate=false
2018-08-06 13:39:08 [INFO ](com.navercorp.pinpoint.bootstrap.config.DefaultProfilerConfig) configuration loaded successfully.
UDP-STAT:// XXX.XX.XX.X
    => XXX.XX.XX.X:19995 [SUCCESS]

UDP-SPAN:// XXX.XX.XX.X
    => XXX.XX.XX.X:19996 [SUCCESS]

TCP:// XXX.XX.XX.X
    => XXX.XX.XX.X:19994 [SUCCESS]

It displays network is normal. So is there any other reason that may cause the data not to be sent?

Thanks!

RoySRose commented 6 years ago

@WangHouLing

Good! if the network test has all 3 successes.Then there shouldn't be any problem with the network.

In the collector's log. I don't see any transaction traced.

Is there any reason that you're using 1.6.x version? instead of 1.7.x?

You don't have to set the below configuration if you are already using Oracle jvm. It's only necessary if you want to force Pinpoint to think it's Oracle jvm even it's not.

# Manually override jvm vendor name (Oracle, IBM, OpenJDK, etc)
# You probably won't ever need to set this value.
profiler.jvm.vendor.name=Oracle
WangHouLing commented 6 years ago

@RoySRose Did your application successfully traced by Pinpoint when the application and the Pinpoint-collector is installed on the same machine? My application successfully traced by Pinpoint when the application and the Pinpoint-collector is installed on the same machine.

I found these messages in tomcat/logs/catalina.out file:

2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=SPRING_BOOT
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [INFO ](.n.p.p.c.p.s.j.MemoryMetricProvider:67 ) loaded : HotSpot's Parallel (Old) gc memory metrics
2018-08-06 10:01:15 [INFO ](n.p.p.c.p.s.c.CpuLoadMetricProvider:75 ) loaded : CpuLoadMetric for Oracle Java 1.7+
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [DEBUG](.p.r.c.DefaultPinpointClientFactory:199) createBootStrap boss:1, worker:1
2018-08-06 10:01:15 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=SPRING_BOOT
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 10:01:15 [WARN ](com.navercorp.pinpoint.bootstrap.PinpointStarter) pinpoint start failed.
com.navercorp.pinpoint.bootstrap.BootStrapException: execute fail. Error:null
    at com.navercorp.pinpoint.bootstrap.ContextClassLoaderExecuteTemplate.execute(ContextClassLoaderExecuteTemplate.java:52)
    at com.navercorp.pinpoint.bootstrap.AgentClassLoader.boot(AgentClassLoader.java:73)
    at com.navercorp.pinpoint.bootstrap.PinpointStarter.start(PinpointStarter.java:125)
    at com.navercorp.pinpoint.bootstrap.PinpointBootStrap.premain(PinpointBootStrap.java:62)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at sun.instrument.InstrumentationImpl.loadClassAndStartAgent(InstrumentationImpl.java:386)
    at sun.instrument.InstrumentationImpl.loadClassAndCallPremain(InstrumentationImpl.java:401)
Caused by: java.lang.reflect.InvocationTargetException
    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
    at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
    at com.navercorp.pinpoint.bootstrap.AgentClassLoader$2.call(AgentClassLoader.java:78)
    at com.navercorp.pinpoint.bootstrap.ContextClassLoaderExecuteTemplate.execute(ContextClassLoaderExecuteTemplate.java:42)
    ... 9 more
Caused by: com.google.inject.CreationException: Unable to create injector, see the following errors:

1) Error in custom provider, java.lang.RuntimeException: IO error. null
  while locating com.navercorp.pinpoint.profiler.context.provider.PluginContextLoadResultProvider
  at com.navercorp.pinpoint.profiler.context.module.ApplicationContextModule.configure(ApplicationContextModule.java:192)
  while locating com.navercorp.pinpoint.profiler.plugin.PluginContextLoadResult
  while locating com.navercorp.pinpoint.profiler.context.provider.ApplicationServerTypeProvider
  at com.navercorp.pinpoint.profiler.context.module.ApplicationContextModule.bindAgentInformation(ApplicationContextModule.java:252)
  while locating com.navercorp.pinpoint.common.trace.ServiceType annotated with interface com.navercorp.pinpoint.profiler.context.module.ApplicationServerType
Caused by: java.lang.RuntimeException: IO error. null
    at com.navercorp.pinpoint.profiler.plugin.ProfilerPluginLoader.createJarFile(ProfilerPluginLoader.java:138)
    at com.navercorp.pinpoint.profiler.plugin.ProfilerPluginLoader.load(ProfilerPluginLoader.java:78)
    at com.navercorp.pinpoint.profiler.plugin.DefaultPluginContextLoadResult.load(DefaultPluginContextLoadResult.java:76)
    at com.navercorp.pinpoint.profiler.plugin.DefaultPluginContextLoadResult.<init>(DefaultPluginContextLoadResult.java:66)
    at com.navercorp.pinpoint.profiler.context.provider.PluginContextLoadResultProvider.get(PluginContextLoadResultProvider.java:65)
    at com.navercorp.pinpoint.profiler.context.provider.PluginContextLoadResultProvider.get(PluginContextLoadResultProvider.java:33)
    at com.google.inject.internal.ProviderInternalFactory.provision(ProviderInternalFactory.java:81)
    at com.google.inject.internal.BoundProviderFactory.provision(BoundProviderFactory.java:72)
    at com.google.inject.internal.ProviderInternalFactory.circularGet(ProviderInternalFactory.java:61)
    at com.google.inject.internal.BoundProviderFactory.get(BoundProviderFactory.java:62)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.InjectorImpl$2$1.call(InjectorImpl.java:1019)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.InjectorImpl$2.get(InjectorImpl.java:1015)
    at com.navercorp.pinpoint.profiler.context.provider.ApplicationServerTypeProvider.get(ApplicationServerTypeProvider.java:62)
    at com.navercorp.pinpoint.profiler.context.provider.ApplicationServerTypeProvider.get(ApplicationServerTypeProvider.java:36)
    at com.google.inject.internal.ProviderInternalFactory.provision(ProviderInternalFactory.java:81)
    at com.google.inject.internal.BoundProviderFactory.provision(BoundProviderFactory.java:72)
    at com.google.inject.internal.ProviderInternalFactory.circularGet(ProviderInternalFactory.java:61)
    at com.google.inject.internal.BoundProviderFactory.get(BoundProviderFactory.java:62)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:205)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1085)
    at com.google.inject.internal.InternalInjectorCreator.loadEagerSingletons(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:180)
    at com.google.inject.internal.InternalInjectorCreator.build(InternalInjectorCreator.java:110)
    at com.google.inject.Guice.createInjector(Guice.java:99)
    at com.google.inject.Guice.createInjector(Guice.java:84)
    at com.navercorp.pinpoint.profiler.context.module.DefaultApplicationContext.<init>(DefaultApplicationContext.java:100)
    at com.navercorp.pinpoint.profiler.DefaultAgent.newApplicationContext(DefaultAgent.java:125)
    at com.navercorp.pinpoint.profiler.DefaultAgent.<init>(DefaultAgent.java:118)
    at com.navercorp.pinpoint.profiler.DefaultAgent.<init>(DefaultAgent.java:69)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
    at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
    at com.navercorp.pinpoint.bootstrap.AgentClassLoader$2.call(AgentClassLoader.java:78)
    at com.navercorp.pinpoint.bootstrap.ContextClassLoaderExecuteTemplate.execute(ContextClassLoaderExecuteTemplate.java:42)
    at com.navercorp.pinpoint.bootstrap.AgentClassLoader.boot(AgentClassLoader.java:73)
    at com.navercorp.pinpoint.bootstrap.PinpointStarter.start(PinpointStarter.java:125)
    at com.navercorp.pinpoint.bootstrap.PinpointBootStrap.premain(PinpointBootStrap.java:62)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at sun.instrument.InstrumentationImpl.loadClassAndStartAgent(InstrumentationImpl.java:386)
    at sun.instrument.InstrumentationImpl.loadClassAndCallPremain(InstrumentationImpl.java:401)
Caused by: java.util.zip.ZipException: error in opening zip file
    at java.util.zip.ZipFile.open(Native Method)
    at java.util.zip.ZipFile.<init>(ZipFile.java:219)
    at java.util.zip.ZipFile.<init>(ZipFile.java:149)
    at java.util.jar.JarFile.<init>(JarFile.java:166)
    at java.util.jar.JarFile.<init>(JarFile.java:130)
    at com.navercorp.pinpoint.profiler.plugin.ProfilerPluginLoader.createJarFile(ProfilerPluginLoader.java:134)
    ... 55 more

2) Error in custom provider, java.lang.RuntimeException: IO error. null
  while locating com.navercorp.pinpoint.profiler.context.provider.PluginContextLoadResultProvider
  at com.navercorp.pinpoint.profiler.context.module.ApplicationContextModule.configure(ApplicationContextModule.java:192)
  while locating com.navercorp.pinpoint.profiler.plugin.PluginContextLoadResult
  while locating com.navercorp.pinpoint.profiler.context.provider.ApplicationServerTypeProvider
  at com.navercorp.pinpoint.profiler.context.module.ApplicationContextModule.bindAgentInformation(ApplicationContextModule.java:252)
  while locating com.navercorp.pinpoint.common.trace.ServiceType annotated with @com.navercorp.pinpoint.profiler.context.module.ApplicationServerType()
    for the 4th parameter of com.navercorp.pinpoint.profiler.context.provider.AgentInformationProvider.<init>(AgentInformationProvider.java:46)
  while locating com.navercorp.pinpoint.profiler.context.provider.AgentInformationProvider
  at com.navercorp.pinpoint.profiler.context.module.ApplicationContextModule.configure(ApplicationContextModule.java:197)
  while locating com.navercorp.pinpoint.profiler.AgentInformation
  while locating com.navercorp.pinpoint.profiler.context.provider.PinpointClientFactoryProvider
  at com.navercorp.pinpoint.profiler.context.module.ApplicationContextModule.bindDataTransferComponent(ApplicationContextModule.java:228)
  while locating com.navercorp.pinpoint.rpc.client.PinpointClientFactory
Caused by: java.lang.RuntimeException: IO error. null
    at com.navercorp.pinpoint.profiler.plugin.ProfilerPluginLoader.createJarFile(ProfilerPluginLoader.java:138)
    at com.navercorp.pinpoint.profiler.plugin.ProfilerPluginLoader.load(ProfilerPluginLoader.java:78)
    at com.navercorp.pinpoint.profiler.plugin.DefaultPluginContextLoadResult.load(DefaultPluginContextLoadResult.java:76)
    at com.navercorp.pinpoint.profiler.plugin.DefaultPluginContextLoadResult.<init>(DefaultPluginContextLoadResult.java:66)
    at com.navercorp.pinpoint.profiler.context.provider.PluginContextLoadResultProvider.get(PluginContextLoadResultProvider.java:65)
    at com.navercorp.pinpoint.profiler.context.provider.PluginContextLoadResultProvider.get(PluginContextLoadResultProvider.java:33)
    at com.google.inject.internal.ProviderInternalFactory.provision(ProviderInternalFactory.java:81)
    at com.google.inject.internal.BoundProviderFactory.provision(BoundProviderFactory.java:72)
    at com.google.inject.internal.ProviderInternalFactory.circularGet(ProviderInternalFactory.java:61)
    at com.google.inject.internal.BoundProviderFactory.get(BoundProviderFactory.java:62)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.InjectorImpl$2$1.call(InjectorImpl.java:1019)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.InjectorImpl$2.get(InjectorImpl.java:1015)
    at com.navercorp.pinpoint.profiler.context.provider.ApplicationServerTypeProvider.get(ApplicationServerTypeProvider.java:62)
    at com.navercorp.pinpoint.profiler.context.provider.ApplicationServerTypeProvider.get(ApplicationServerTypeProvider.java:36)
    at com.google.inject.internal.ProviderInternalFactory.provision(ProviderInternalFactory.java:81)
    at com.google.inject.internal.BoundProviderFactory.provision(BoundProviderFactory.java:72)
    at com.google.inject.internal.ProviderInternalFactory.circularGet(ProviderInternalFactory.java:61)
    at com.google.inject.internal.BoundProviderFactory.get(BoundProviderFactory.java:62)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.SingleParameterInjector.inject(SingleParameterInjector.java:38)
    at com.google.inject.internal.SingleParameterInjector.getAll(SingleParameterInjector.java:62)
    at com.google.inject.internal.ConstructorInjector.provision(ConstructorInjector.java:110)
    at com.google.inject.internal.ConstructorInjector.construct(ConstructorInjector.java:90)
    at com.google.inject.internal.ConstructorBindingImpl$Factory.get(ConstructorBindingImpl.java:268)
    at com.google.inject.internal.BoundProviderFactory.get(BoundProviderFactory.java:61)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.InjectorImpl$2$1.call(InjectorImpl.java:1019)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.InjectorImpl$2.get(InjectorImpl.java:1015)
    at com.navercorp.pinpoint.profiler.context.provider.PinpointClientFactoryProvider.get(PinpointClientFactoryProvider.java:60)
    at com.navercorp.pinpoint.profiler.context.provider.PinpointClientFactoryProvider.get(PinpointClientFactoryProvider.java:34)
    at com.google.inject.internal.ProviderInternalFactory.provision(ProviderInternalFactory.java:81)
    at com.google.inject.internal.BoundProviderFactory.provision(BoundProviderFactory.java:72)
    at com.google.inject.internal.ProviderInternalFactory.circularGet(ProviderInternalFactory.java:61)
    at com.google.inject.internal.BoundProviderFactory.get(BoundProviderFactory.java:62)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:205)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1085)
    at com.google.inject.internal.InternalInjectorCreator.loadEagerSingletons(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:180)
    at com.google.inject.internal.InternalInjectorCreator.build(InternalInjectorCreator.java:110)
    at com.google.inject.Guice.createInjector(Guice.java:99)
    at com.google.inject.Guice.createInjector(Guice.java:84)
    at com.navercorp.pinpoint.profiler.context.module.DefaultApplicationContext.<init>(DefaultApplicationContext.java:100)
    at com.navercorp.pinpoint.profiler.DefaultAgent.newApplicationContext(DefaultAgent.java:125)
    at com.navercorp.pinpoint.profiler.DefaultAgent.<init>(DefaultAgent.java:118)
    at com.navercorp.pinpoint.profiler.DefaultAgent.<init>(DefaultAgent.java:69)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
    at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
    at com.navercorp.pinpoint.bootstrap.AgentClassLoader$2.call(AgentClassLoader.java:78)
    at com.navercorp.pinpoint.bootstrap.ContextClassLoaderExecuteTemplate.execute(ContextClassLoaderExecuteTemplate.java:42)
    at com.navercorp.pinpoint.bootstrap.AgentClassLoader.boot(AgentClassLoader.java:73)
    at com.navercorp.pinpoint.bootstrap.PinpointStarter.start(PinpointStarter.java:125)
    at com.navercorp.pinpoint.bootstrap.PinpointBootStrap.premain(PinpointBootStrap.java:62)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at sun.instrument.InstrumentationImpl.loadClassAndStartAgent(InstrumentationImpl.java:386)
    at sun.instrument.InstrumentationImpl.loadClassAndCallPremain(InstrumentationImpl.java:401)
Caused by: java.util.zip.ZipException: error in opening zip file
    at java.util.zip.ZipFile.open(Native Method)
    at java.util.zip.ZipFile.<init>(ZipFile.java:219)
    at java.util.zip.ZipFile.<init>(ZipFile.java:149)
    at java.util.jar.JarFile.<init>(JarFile.java:166)
    at java.util.jar.JarFile.<init>(JarFile.java:130)
    at com.navercorp.pinpoint.profiler.plugin.ProfilerPluginLoader.createJarFile(ProfilerPluginLoader.java:134)
    ... 80 more

3) Error in custom provider, java.lang.RuntimeException: IO error. null
..........
*****************************************************************************
* Pinpoint Agent load failure
*****************************************************************************
06-Aug-2018 11:54:02.819 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version:        Apache Tomcat/8.5.14

I think this may be more important. Can you see useful information from these messages? Please help me. Thank you!

RoySRose commented 6 years ago

@WangHouLing

Well, as you can see in the log. Pinpoint-Agent has not been started correctly. I see java.util.zip.ZipException: error in opening zip file in the log. I think failure of opening zip file is related to your server environment.

take a look #3189 this might help you.

WangHouLing commented 6 years ago

Thank you very much! I may have solved this problem. :)

RoySRose commented 6 years ago

@WangHouLing

Good to hear that you are finding your way to the solution! I'd appreciate if you can share your solution with the community:) Thanks~

WangHouLing commented 6 years ago

@RoySRose Good morning! Maybe I am a bit optimistic. There is a bad news. Yesterday, I changed my pinpoint agent config, only edit these items:

profiler.collector.ip=XXX.XX.XX.X
profiler.collector.span.port=19996
profiler.collector.stat.port=19995
profiler.collector.tcp.port=19994

Then, my tomcat can be monitored by pinpoint successfully. But, my springboot application can't be monitored with the same pinpoint agent config in this morning. I use pinpoint to monitor tomcat just to test my pinpoint agent. In fact, what I really need to monitor is the springboot application. So, the problem has not been solved. I find these logs in pinpoint agent log file:

2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=UNDEFINED
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [DEBUG](.p.r.c.DefaultPinpointClientFactory:199) createBootStrap boss:1, worker:1
2018-08-06 23:12:04 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=UNDEFINED
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [DEBUG](.p.r.c.DefaultPinpointClientFactory:199) createBootStrap boss:1, worker:1
2018-08-06 23:12:04 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=UNDEFINED
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=UNDEFINED
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=UNDEFINED
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [DEBUG](.p.r.c.DefaultPinpointClientFactory:199) createBootStrap boss:1, worker:1
2018-08-06 23:12:04 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=UNDEFINED
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [DEBUG](.p.r.c.DefaultPinpointClientFactory:199) createBootStrap boss:1, worker:1
2018-08-06 23:12:04 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=UNDEFINED
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=UNDEFINED
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](.n.p.p.c.p.s.j.MemoryMetricProvider:67 ) loaded : HotSpot's Parallel (Old) gc memory metrics
2018-08-06 23:12:04 [INFO ](n.p.p.c.p.s.c.CpuLoadMetricProvider:75 ) loaded : CpuLoadMetric for Oracle Java 1.7+
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [DEBUG](.p.r.c.DefaultPinpointClientFactory:199) createBootStrap boss:1, worker:1
2018-08-06 23:12:04 [INFO ](p.c.p.ApplicationServerTypeProvider:60 ) default ApplicationServerType=UNDEFINED
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin
2018-08-06 23:12:04 [INFO ](.p.p.DefaultPluginContextLoadResult:73 ) load plugin

I noticed default ApplicationServerType=UNDEFINED in the log file. Do I need to modify this profiler.applicationservertype=SPRING_BOOT? Please help me, Thank you!

RoySRose commented 6 years ago

@WangHouLing No, you don't have to modify the config to trace spring boot application. I think you should take a look at other logs that have errors. The Pinpoint-Agent log doesn't seem to have any problem.

WangHouLing commented 6 years ago

@RoySRose Thank you for your reply! I think maybe my copy operation caused this error result. As mentioned before, I only edited four items in pinpoint agent config, then my tomcat can be monitored successfully by this new pinpoint agent. Because I want to monitor my springboot application, then I run cp -r new-pinpoint-agent-file/* old-pinpoint-agent-file/ command to overwrite the old pinpoint agent file that couldn't successfully monitor springboot. I also restarted my springboot application. As a result, pinpoint agent worked failed. Then I use tomcat to test this pinpoint agent, pinpoint agent monitored tomcat failed too. I am confused about this result. Then I did a second test, I run these commands:

  1. cd old-pinpoint-agent-file
  2. rm -rf *
  3. cp -r ../new-pinpoint-agent-file/* .

After did that, my tomcat can be monitored successfully by 'old-pinpoint-agent-file/pinpoint-bootstrap-1.6.2.jar'. I run ls -a in old-pinpoint-agent-file/ to find some differences: There are files below the 'old-pinpoint-agent-file/' when testing for the first time. image There are files below the 'old-pinpoint-agent-file/' when testing for the second time. image Why are there ._* hidden files? Is there a possibility that "._pinpoint-bootstrap-1.6.2.jar" causes monitor failed? Thank you!

RoySRose commented 6 years ago

@WangHouLing First of all, I'm happy to hear that you've got your agent to start monitoring. (The second test) On the questions, you've asked.

WangHouLing commented 6 years ago

@RoySRose Follow your advice, I try with delete "._pinpoint-bootstrap-1.6.2.jar" file in the first test condition, but agent already can't work. Now, I have no idea about this. I am waiting for the result after the springboot applications restart with the second test overwrite method. I hope agent can work will. I really appreciate your patience in answering all my questions :)

stale[bot] commented 6 years ago

This issue/proposal has been automatically marked as stale because it hasn't had any recent activity. It will automatically be closed if no further activity occurs for 20days. If you think this should still be open, or the problem still persists, just pop a reply in the comments and one of the maintainers will (try!) to follow up. Thank you for your interest and contribution to the Pinpoint Community.