search

pinpoint-apm / pinpoint-docker

Official Dockerized components of the Pinpoint
http://pinpoint-apm.github.io/pinpoint/
Apache License 2.0
451 stars 227 forks source link

When using metrics, the pinpoint-collector log level shows DEBUG logs #180

Open Heejong-Oh opened 8 months ago

Heejong-Oh commented 8 months ago

When starting using docker-compose-metric.yml in pinpoint 2.5.x, the container log file size becomes too large as the pinpoint-collector docker log displays DEBUG level logs. I confirmed that "COLLECTOR_LOGGING_LEVEL_ROOT=INFO" in the .env file, but there are a lot of DEBUG logs as shown below.

If I do not use metrics and start by specifying only docker-compose.yml, it is visible at the INFO level.

{"log":"10-26 22:29:54.054 [           main] INFO  i.g.n.LogIdServerListenerDelegator      : 16 -- ServerListener serverListener:io.grpc.internal.ServerImpl$ServerListenerImpl@27b337bb\n","stream":"stdout","time":"2023-10-26T22:29:54.480125531Z"}
{"log":"10-26 22:29:54.054 [           main] INFO  c.n.p.c.g.c.GrpcSslReceiverConfiguration: 50 -- enable:false\n","stream":"stdout","time":"2023-10-26T22:29:54.557044102Z"}
{"log":"10-26 22:29:54.054 [           main] INFO  c.n.p.c.g.c.GrpcSslReceiverConfiguration: 51 -- bindAddress:BindAddress{0.0.0.0:9442}\n","stream":"stdout","time":"2023-10-26T22:29:54.559119687Z"}
{"log":"10-26 22:29:54.054 [           main] INFO  c.n.p.c.g.c.GrpcSslReceiverConfiguration: 52 -- grpcSslConfiguration:GrpcSslConfiguration{enable=false, providerType='null', keyResource='null', keyCertChainResource='null'}\n","stream":"stdout","time":"2023-10-26T22:29:54.559143215Z"}
{"log":"10-26 22:29:54.054 [           main] WARN  c.n.p.c.r.g.GrpcReceiver                : 86 -- grpcStatSslReceiver is false\n","stream":"stdout","time":"2023-10-26T22:29:54.559149307Z"}
{"log":"10-26 22:29:54.054 [           main] INFO  c.t.c.AgentBaseDataReceiverConfiguration: 61 -- AgentBaseDataReceiverConfiguration{bindIp='0.0.0.0', bindPort=9994, workerThreadSize=8, workerQueueSize=1024, workerMonitorEnable=true}\n","stream":"stdout","time":"2023-10-26T22:29:54.562322646Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.t.c.AgentBaseDataReceiverConfiguration: 41 -- String bindIp @Value(\"${collector.receiver.base.ip:0.0.0.0}\") = 0.0.0.0\n","stream":"stdout","time":"2023-10-26T22:29:54.562344409Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.t.c.AgentBaseDataReceiverConfiguration: 41 -- int bindPort @Value(\"${collector.receiver.base.port:9994}\") = 9994\n","stream":"stdout","time":"2023-10-26T22:29:54.562349368Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.t.c.AgentBaseDataReceiverConfiguration: 41 -- int workerThreadSize @Value(\"${collector.receiver.base.worker.threadSize:128}\") = 8\n","stream":"stdout","time":"2023-10-26T22:29:54.562352929Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.t.c.AgentBaseDataReceiverConfiguration: 41 -- int workerQueueSize @Value(\"${collector.receiver.base.worker.queueSize:5120}\") = 1024\n","stream":"stdout","time":"2023-10-26T22:29:54.562356403Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.t.c.AgentBaseDataReceiverConfiguration: 41 -- boolean workerMonitorEnable @Value(\"${collector.receiver.base.worker.monitor:false}\") = true\n","stream":"stdout","time":"2023-10-26T22:29:54.562359701Z"}
{"log":"10-26 22:29:54.054 [           main] INFO  c.n.p.c.t.c.StatReceiverConfiguration   : 80 -- StatReceiverConfiguration{isTcpEnable=false, tcpBindIp='0.0.0.0', tcpBindPort=9995, isUdpEnable=true, udpBindIp='0.0.0.0', udpBindPort=9995, udpReceiveBufferSize=4194304, socketCount=-1, reusePort=false, workerThreadSize=8, workerQueueSize=64, workerMonitorEnable=true}\n","stream":"stdout","time":"2023-10-26T22:29:54.57105942Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.n.p.c.t.c.StatReceiverConfiguration   : 41 -- boolean isTcpEnable @Value(\"${collector.receiver.stat.tcp:false}\") = false\n","stream":"stdout","time":"2023-10-26T22:29:54.600057479Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.n.p.c.t.c.StatReceiverConfiguration   : 41 -- String tcpBindIp @Value(\"${collector.receiver.stat.tcp.ip:0.0.0.0}\") = 0.0.0.0\n","stream":"stdout","time":"2023-10-26T22:29:54.600106267Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.n.p.c.t.c.StatReceiverConfiguration   : 41 -- int tcpBindPort @Value(\"${collector.receiver.stat.tcp.port:-1}\") = 9995\n","stream":"stdout","time":"2023-10-26T22:29:54.600112791Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.n.p.c.t.c.StatReceiverConfiguration   : 41 -- boolean isUdpEnable @Value(\"${collector.receiver.stat.udp:true}\") = true\n","stream":"stdout","time":"2023-10-26T22:29:54.600116459Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.n.p.c.t.c.StatReceiverConfiguration   : 41 -- String udpBindIp @Value(\"${collector.receiver.stat.udp.ip:0.0.0.0}\") = 0.0.0.0\n","stream":"stdout","time":"2023-10-26T22:29:54.600119465Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.n.p.c.t.c.StatReceiverConfiguration   : 41 -- int udpBindPort @Value(\"${collector.receiver.stat.udp.port:9995}\") = 9995\n","stream":"stdout","time":"2023-10-26T22:29:54.60012256Z"}
{"log":"10-26 22:29:54.054 [           main] DEBUG c.n.p.c.t.c.StatReceiverConfiguration   : 41 -- int udpReceiveBufferSize @Value(\"${collector.receiver.stat.udp.receiveBufferSize:4194304}\") = 4194304\n","stream":"stdout","time":"2023-10-26T22:29:54.600126088Z"}
{"log":"10-26 18:03:11.011 [el-Worker(20-6)] DEBUG i.g.n.NettyServerHandler                :214 -- [id: 0x44026432, L:/172.24.0.30:9993 - R:/10.150.8.34:55950] INBOUND DATA: streamId=3 padding=0 endStream=false length=168 bytes=00000000a30aa0010801120b10fcf3ded8b63118839e301966d0c2ceaa977d5621ffffffffffffffff28e8869ee9b631300c380440f2074a490a222f6b657977...\n","stream":"stdout","time":"2023-10-26T18:03:11.015477082Z"}
{"log":"10-26 18:03:11.011 [Span-Worker-111] DEBUG .n.p.c.d.h.HbaseApplicationTraceIndexDao: 88 -- insert ApplicationTraceIndex: SpanBo{version=1, agentId='API_ShopAPI-3', agentName='null', applicationId='ShopAPI', agentStartTime=1698305667186, transactionId=TransactionId{agentId='VA_API2_19012', agentStartTime=1698301251598, transactionSequence=491474}, spanId=1254475573072083780, parentSpanId=999229462036288620, parentApplicationId='ShopAdmin', parentApplicationServiceType=1210, startTime=1698343385331, elapsed=5, rpc='/v1.0/shopify/vendor/settings', serviceType=1010, endPoint='api.Shop.net:17301', apiId=3053, annotationBoList=[AnnotationBo{key=46, value=200, isAuthorized=true}], flag=0, errCode=0, spanEventBoList=[{version=0, sequence=0, startElapsed=0, endElapsed=5, serviceType=1011, destinationId=null, endPoint=null, apiId=3052, annotationBoList=[], depth=1, nextSpanId=-1, hasException=false, exceptionClass=null, nextAsyncId=0}, {version=0, sequence=1, startElapsed=0, endElapsed=5, serviceType=5051, destinationId=null, endPoint=null, apiId=5, annotationBoList=[], depth=2, nextSpanId=-1, hasException=false, exceptionClass=null, nextAsyncId=0}, {version=0, sequence=2, startElapsed=0, endElapsed=1, serviceType=6052, destinationId=null, endPoint=null, apiId=2871, annotationBoList=[], depth=3, nextSpanId=-1, hasException=false, exceptionClass=null, nextAsyncId=0}, {version=0, sequence=3, startElapsed=0, endElapsed=1, serviceType=2251, destinationId=Shop_V2, endPoint=10.150.24.216, apiId=3414, annotationBoList=[AnnotationBo{key=20, value=IntStringStringValue{intValue=1024, stringValue1='1', stringValue2='null'}, isAuthorized=true}], depth=4, nextSpanId=0, hasException=false, exceptionClass=null, nextAsyncId=0}, {version=0, sequence=4, startElapsed=1, endElapsed=0, serviceType=2250, destinationId=Shop_V2, endPoint=10.150.24.216, apiId=3064, annotationBoList=[AnnotationBo{key=-1, value=false, isAuthorized=true}], depth=3, nextSpanId=0, hasException=false, exceptionClass=null, nextAsyncId=0}, {version=0, sequence=5, startElapsed=1, endElapsed=2, serviceType=5071, destinationId=null, endPoint=null, apiId=666, annotationBoList=[], depth=3, nextSpanId=-1, hasException=false, exceptionClass=null, nextAsyncId=0}, {version=0, sequence=6, startElapsed=2, endElapsed=1, serviceType=2251, destinationId=Shop_V2, endPoint=10.150.24.216, apiId=3414, annotationBoList=[AnnotationBo{key=20, value=IntStringStringValue{intValue=1225, stringValue1='0', stringValue2='1735'}, isAuthorized=true}], depth=4, nextSpanId=0, hasException=false, exceptionClass=null, nextAsyncId=0}, {version=0, sequence=7, startElapsed=3, endElapsed=0, serviceType=2250, destinationId=Shop_V2, endPoint=10.150.24.216, apiId=3065, annotationBoList=[], depth=3, nextSpanId=0, hasException=false, exceptionClass=null, nextAsyncId=0}, {version=0, sequence=8, startElapsed=3, endElapsed=1, serviceType=2250, destinationId=Shop_V2, endPoint=10.150.24.216, apiId=3064, annotationBoList=[AnnotationBo{key=-1, value=true, isAuthorized=true}], depth=3, nextSpanId=0, hasException=false, exceptionClass=null, nextAsyncId=0}, {version=0, sequence=9, startElapsed=4, endElapsed=0, serviceType=2251, destinationId=Shop_V2, endPoint=10.150.24.216, apiId=3414, annotationBoList=[AnnotationBo{key=20, value=IntStringStringValue{intValue=1024, stringValue1='1', stringValue2='null'}, isAuthorized=true}], depth=3, nextSpanId=0, hasException=false, exceptionClass=null, nextAsyncId=0}], spanChunkBoList=null, collectorAcceptTime=1698343391011, hasException=false, exceptionClass='null', applicationServiceType=1210, acceptorHost='api.Shop.net', remoteAddr='10.150.8.46', loggingTransactionInfo=0}\n","stream":"stdout","time":"2023-10-26T18:03:11.015488552Z"}
{"log":"10-26 18:03:11.011 [el-Worker(20-6)] DEBUG i.g.n.NettyServerHandler                :214 -- [id: 0x44026432, L:/172.24.0.30:9993 - R:/10.150.8.34:55950] INBOUND DATA: streamId=3 padding=0 endStream=false length=965 bytes=00000003c012bd070801120b10fcf3ded8b63118849e3019a8fc9ac3893a397522147777772e66617368696f6e676f2e6e65743a38302a320801100228908001...\n","stream":"stdout","time":"2023-10-26T18:03:11.015503262Z"}
{"log":"10-26 18:03:11.011 [cSpan-Worker-58] DEBUG c.n.p.c.d.h.HbaseMapStatisticsCallerDao : 76 -- [Caller] ShopAdmin (SPRING_BOOT) VA_API2_19011 -\u003e REDIS (REDIS)[10.150.24.24:6379]\n","stream":"stdout","time":"2023-10-26T18:03:11.015515617Z"}
{"log":"10-26 18:03:11.011 [el-Worker(20-6)] DEBUG i.g.n.NettyServerHandler                :214 -- [id: 0x44026432, L:/172.24.0.30:9993 - R:/10.150.8.34:55950] INBOUND DATA: streamId=3 padding=0 endStream=false length=1002 bytes=00000003e512e2070801120b10fcf3ded8b63118c99d3019bb9daa8350e0482322147777772e66617368696f6e676f2e6e65743a38302a0a08d802100528c85e...\n","stream":"stdout","time":"2023-10-26T18:03:11.015520442Z"}
{"log":"10-26 18:03:11.011 [Span-Worker-128] DEBUG c.n.p.c.d.h.HbaseMapStatisticsCallerDao : 76 -- [Caller] ShopAPI (SPRING_BOOT) API_ShopAPI-3 -\u003e Shop_V2 (MSSQLSERVER)[10.150.24.216]\n","stream":"stdout","time":"2023-10-26T18:03:11.015527561Z"}
{"log":"10-26 18:03:11.011 [el-Worker(20-6)] DEBUG i.g.n.NettyServerHandler                :214 -- [id: 0x44026432, L:/172.24.0.30:9993 - R:/10.150.8.34:55950] INBOUND DATA: streamId=3 padding=0 endStream=false length=952 bytes=00000003b312b0070801120b10fcf3ded8b63118859e301976e2554af0a8672622147777772e66617368696f6e676f2e6e65743a38302a320801100228908001...\n","stream":"stdout","time":"2023-10-26T18:03:11.015531462Z"}
{"log":"10-26 18:03:11.011 [cSpan-Worker-58] DEBUG c.n.p.c.d.h.HbaseMapStatisticsCalleeDao : 78 -- [Callee] REDIS (REDIS) \u003c- ShopAdmin (SPRING_BOOT)[10.150.8.151:80]\n","stream":"stdout","time":"2023-10-26T18:03:11.015535614Z"}
{"log":"10-26 18:03:11.011 [Span-Worker-128] DEBUG c.n.p.c.d.h.HbaseMapStatisticsCalleeDao : 78 -- [Callee] Shop_V2 (MSSQLSERVER) \u003c- ShopAPI (SPRING_BOOT)[api.Shop.net:17301]\n","stream":"stdout","time":"2023-10-26T18:03:11.015539769Z"}
{"log":"10-26 18:03:11.011 [el-Worker(20-6)] DEBUG i.g.n.NettyServerHandler                :214 -- [id: 0x44026432, L:/172.24.0.30:9993 - R:/10.150.8.34:55950] INBOUND DATA: streamId=3 padding=0 endStream=false length=1057 bytes=000000041c1299080801120b10fcf3ded8b63118819e30197e621b9ae5a0fb0622147777772e66617368696f6e676f2e6e65743a38302a0c081510042015289e...\n","stream":"stdout","time":"2023-10-26T18:03:11.015545001Z"}
{"log":"10-26 18:03:11.011 [cSpan-Worker-58] DEBUG c.n.p.c.d.h.HbaseMapStatisticsCallerDao : 76 -- [Caller] ShopAdmin (SPRING_BOOT) VA_API2_19011 -\u003e REDIS (REDIS)[10.150.24.24:6379]\n","stream":"stdout","time":"2023-10-26T18:03:11.015559699Z"}
{"log":"10-26 18:03:11.011 [Span-Worker-128] DEBUG c.n.p.c.d.h.HbaseMapStatisticsCallerDao : 76 -- [Caller] ShopAPI (SPRING_BOOT) API_ShopAPI-3 -\u003e Shop_V2 (MSSQLSERVER)[10.150.24.216]\n","stream":"stdout","time":"2023-10-26T18:03:11.015571357Z"}