apm.log

gistfile1.txt

2018-11-29 14:48:27.657 [apm-server-healthcheck] DEBUG co.elastic.apm.report.ApmServerHealthChecker - Starting healthcheck to http://localhost:8200/
2018-11-29 14:48:27.713 [main] INFO co.elastic.apm.configuration.StartupInfo - Starting Elastic APM 1.1.0 as apm-poc on Java 1.8.0_191 (Oracle Corporation) Linux 4.15.0-39-generic
2018-11-29 14:48:27.714 [main] DEBUG co.elastic.apm.configuration.StartupInfo - service_name: 'apm-poc' (source: Java System Properties)
2018-11-29 14:48:27.714 [main] DEBUG co.elastic.apm.configuration.StartupInfo - application_packages: 'org.jboss.as.quickstarts.helloworld' (source: Java System Properties)
2018-11-29 14:48:27.714 [main] DEBUG co.elastic.apm.configuration.StartupInfo - log_level: 'DEBUG' (source: Java System Properties)
2018-11-29 14:48:27.714 [main] DEBUG co.elastic.apm.configuration.StartupInfo - log_file: '/home/mao/work/wfly-apm-poc/poc-wildfly-9.0.2.Final/standalone/log/apm.log' (source: Java System Properties)
2018-11-29 14:48:27.714 [main] DEBUG co.elastic.apm.configuration.StartupInfo - enable_log_correlation: 'true' (source: Java System Properties)
2018-11-29 14:48:27.751 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.ElasticApmApiInstrumentation$StartTransactionInstrumentation
2018-11-29 14:48:27.758 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.ElasticApmApiInstrumentation$CurrentTransactionInstrumentation
2018-11-29 14:48:27.758 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.ElasticApmApiInstrumentation$CurrentSpanInstrumentation
2018-11-29 14:48:27.759 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.ElasticApmApiInstrumentation$CaptureExceptionInstrumentation
2018-11-29 14:48:27.759 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.TransactionInstrumentation$SetUserInstrumentation
2018-11-29 14:48:27.759 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.TransactionInstrumentation$EnsureParentIdInstrumentation
2018-11-29 14:48:27.760 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.TransactionInstrumentation$SetResultInstrumentation
2018-11-29 14:48:27.760 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$SetNameInstrumentation
2018-11-29 14:48:27.760 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$SetTypeInstrumentation
2018-11-29 14:48:27.760 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$DoCreateSpanInstrumentation
2018-11-29 14:48:27.761 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$EndInstrumentation
2018-11-29 14:48:27.761 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$CaptureExceptionInstrumentation
2018-11-29 14:48:27.761 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$GetIdInstrumentation
2018-11-29 14:48:27.762 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$GetTraceIdInstrumentation
2018-11-29 14:48:27.762 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$AddTagInstrumentation
2018-11-29 14:48:27.762 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$ActivateInstrumentation
2018-11-29 14:48:27.763 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.SpanInstrumentation$IsSampledInstrumentation
2018-11-29 14:48:27.763 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.CaptureExceptionInstrumentation
2018-11-29 14:48:27.763 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.ApiScopeInstrumentation
2018-11-29 14:48:27.763 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.CaptureTransactionInstrumentation
2018-11-29 14:48:27.764 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.plugin.api.CaptureSpanInstrumentation
2018-11-29 14:48:27.764 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.jaxrs.JaxRsTransactionNameInstrumentation
2018-11-29 14:48:27.764 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.jdbc.ConnectionInstrumentation
2018-11-29 14:48:27.765 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.jdbc.StatementInstrumentation
2018-11-29 14:48:27.765 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.jdbc.PreparedStatementInstrumentation
2018-11-29 14:48:27.766 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.es.restclient.v5_6.ElasticsearchRestClientInstrumentation
2018-11-29 14:48:27.766 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.es.restclient.v6_4.ElasticsearchRestClientInstrumentation
2018-11-29 14:48:27.766 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ApmSpanInstrumentation$FinishInstrumentation
2018-11-29 14:48:27.766 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ApmSpanInstrumentation$LogInstrumentation
2018-11-29 14:48:27.767 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ApmSpanInstrumentation$TagInstrumentation
2018-11-29 14:48:27.767 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ApmSpanInstrumentation$SetOperationName
2018-11-29 14:48:27.767 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ApmSpanInstrumentation$GetTraceContextInstrumentation
2018-11-29 14:48:27.768 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ApmSpanBuilderInstrumentation$CreateSpanInstrumentation
2018-11-29 14:48:27.768 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ScopeManagerInstrumentation$ActivateInstrumentation
2018-11-29 14:48:27.768 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ScopeManagerInstrumentation$CurrentSpanInstrumentation
2018-11-29 14:48:27.768 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ScopeManagerInstrumentation$CurrentTraceContextInstrumentation
2018-11-29 14:48:27.769 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.ApmScopeInstrumentation
2018-11-29 14:48:27.769 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.opentracing.impl.SpanContextInstrumentation
2018-11-29 14:48:27.769 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.servlet.ServletInstrumentation
2018-11-29 14:48:27.771 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.servlet.FilterChainInstrumentation
2018-11-29 14:48:27.771 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.servlet.AsyncInstrumentation
2018-11-29 14:48:27.771 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.resttemplate.SpringRestTemplateInstrumentation
2018-11-29 14:48:27.772 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applying advice co.elastic.apm.spring.webmvc.SpringTransactionNameInstrumentation
2018-11-29 14:48:27.772 [main] DEBUG co.elastic.apm.bci.ElasticApmAgent - Applied 43 advices
2018-11-29 14:48:27.810 [apm-server-healthcheck] WARN co.elastic.apm.report.ApmServerHealthChecker - Elastic APM server is not available (Connection refused (Connection refused))
2018-11-29 14:48:31.183 [ServerService Thread Pool -- 39] DEBUG co.elastic.apm.bci.ElasticApmAgent - Type match for advice ServletInstrumentation: (not(isInterface()) and hasSuperType(erasure(name(equals(javax.servlet.http.HttpServlet))))) matches class org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher
2018-11-29 14:48:31.406 [ServerService Thread Pool -- 39] DEBUG co.elastic.apm.bci.ElasticApmAgent - Method match for advice ServletInstrumentation: ((name(equals(service)) and hasParameter(hasTypes(with(0 matches erasure(name(equals(javax.servlet.http.HttpServletRequest))))))) and hasParameter(hasTypes(with(1 matches erasure(name(equals(javax.servlet.http.HttpServletResponse))))))) matches protected void org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(javax.servlet.http.HttpServletRequest,javax.servlet.http.HttpServletResponse) throws javax.servlet.ServletException,java.io.IOException
2018-11-29 14:48:31.579 [ServerService Thread Pool -- 39] DEBUG co.elastic.apm.bci.ElasticApmAgent - Type match for advice ServletInstrumentation: (not(isInterface()) and hasSuperType(erasure(name(equals(javax.servlet.http.HttpServlet))))) matches class javax.servlet.http.HttpServlet
2018-11-29 14:48:31.611 [ServerService Thread Pool -- 55] DEBUG co.elastic.apm.bci.ElasticApmAgent - Type match for advice ServletInstrumentation: (not(isInterface()) and hasSuperType(erasure(name(equals(javax.servlet.http.HttpServlet))))) matches class org.apache.jasper.servlet.JspServlet
2018-11-29 14:48:31.637 [ServerService Thread Pool -- 39] DEBUG co.elastic.apm.bci.ElasticApmAgent - Method match for advice ServletInstrumentation: ((name(equals(service)) and hasParameter(hasTypes(with(0 matches erasure(name(equals(javax.servlet.http.HttpServletRequest))))))) and hasParameter(hasTypes(with(1 matches erasure(name(equals(javax.servlet.http.HttpServletResponse))))))) matches protected void javax.servlet.http.HttpServlet.service(javax.servlet.http.HttpServletRequest,javax.servlet.http.HttpServletResponse) throws javax.servlet.ServletException,java.io.IOException
2018-11-29 14:48:31.669 [ServerService Thread Pool -- 55] DEBUG co.elastic.apm.bci.ElasticApmAgent - Method match for advice ServletInstrumentation: ((name(equals(service)) and hasParameter(hasTypes(with(0 matches erasure(name(equals(javax.servlet.http.HttpServletRequest))))))) and hasParameter(hasTypes(with(1 matches erasure(name(equals(javax.servlet.http.HttpServletResponse))))))) matches public void org.apache.jasper.servlet.JspServlet.service(javax.servlet.http.HttpServletRequest,javax.servlet.http.HttpServletResponse) throws javax.servlet.ServletException,java.io.IOException
2018-11-29 14:48:35.089 [MSC service thread 1-5] DEBUG co.elastic.apm.bci.ElasticApmAgent - Type match for advice ServletInstrumentation: (not(isInterface()) and hasSuperType(erasure(name(equals(javax.servlet.http.HttpServlet))))) matches class io.undertow.servlet.handlers.DefaultServlet
2018-11-29 14:48:37.021 [default I/O-1] DEBUG co.elastic.apm.bci.ElasticApmAgent - Type match for advice AsyncInstrumentation: (not(isInterface()) and hasSuperType(erasure(name(equals(javax.servlet.http.HttpServletRequest))))) matches class io.undertow.servlet.spec.HttpServletRequestImpl
2018-11-29 14:48:37.061 [default I/O-1] DEBUG co.elastic.apm.bci.ElasticApmAgent - Method match for advice AsyncInstrumentation: (((isPublic() and name(equals(startAsync))) and returns(erasure(name(equals(javax.servlet.AsyncContext))))) and (hasParameter(ofSize(0)) or (hasParameter(hasTypes(with(0 matches erasure(name(equals(javax.servlet.ServletRequest)))))) and hasParameter(hasTypes(with(1 matches erasure(name(equals(javax.servlet.ServletResponse))))))))) matches public javax.servlet.AsyncContext io.undertow.servlet.spec.HttpServletRequestImpl.startAsync() throws java.lang.IllegalStateException
2018-11-29 14:48:37.064 [default I/O-1] DEBUG co.elastic.apm.bci.ElasticApmAgent - Method match for advice AsyncInstrumentation: (((isPublic() and name(equals(startAsync))) and returns(erasure(name(equals(javax.servlet.AsyncContext))))) and (hasParameter(ofSize(0)) or (hasParameter(hasTypes(with(0 matches erasure(name(equals(javax.servlet.ServletRequest)))))) and hasParameter(hasTypes(with(1 matches erasure(name(equals(javax.servlet.ServletResponse))))))))) matches public javax.servlet.AsyncContext io.undertow.servlet.spec.HttpServletRequestImpl.startAsync(javax.servlet.ServletRequest,javax.servlet.ServletResponse) throws java.lang.IllegalStateException
2018-11-29 14:48:37.125 [default task-1] DEBUG co.elastic.apm.impl.ElasticApmTracer - startTransaction '' 00-d6504aab39894cfdb11f4fde8628b6cd-b84f1242cab0d974-01 {
2018-11-29 14:48:37.125 [default task-1] DEBUG co.elastic.apm.impl.ElasticApmTracer - Activating '' 00-d6504aab39894cfdb11f4fde8628b6cd-b84f1242cab0d974-01 on thread 151
2018-11-29 14:48:37.148 [default task-1] DEBUG co.elastic.apm.impl.ElasticApmTracer - Deactivating 'DefaultServlet#doGet' 00-d6504aab39894cfdb11f4fde8628b6cd-b84f1242cab0d974-01 on thread 151
2018-11-29 14:48:37.150 [default task-1] DEBUG co.elastic.apm.impl.ElasticApmTracer - } endTransaction 'DefaultServlet#doGet' 00-d6504aab39894cfdb11f4fde8628b6cd-b84f1242cab0d974-01
2018-11-29 14:48:37.151 [apm-reporter] DEBUG co.elastic.apm.report.IntakeV2ReportingEventHandler - Receiving TRANSACTION event (sequence 0)
2018-11-29 14:48:37.151 [apm-reporter] DEBUG co.elastic.apm.report.IntakeV2ReportingEventHandler - Starting new request to http://localhost:8200/intake/v2/events
2018-11-29 14:48:37.152 [apm-reporter] INFO co.elastic.apm.report.IntakeV2ReportingEventHandler - Backing off for 0 seconds (±10%)
2018-11-29 14:48:37.412 [default task-3] DEBUG co.elastic.apm.impl.ElasticApmTracer - startTransaction '' 00-2c023c2b38679603bdea04dda41d47b6-bf0d68ca6227d39d-01 {
2018-11-29 14:48:37.412 [default task-3] DEBUG co.elastic.apm.impl.ElasticApmTracer - Activating '' 00-2c023c2b38679603bdea04dda41d47b6-bf0d68ca6227d39d-01 on thread 153
2018-11-29 14:48:37.421 [default task-3] DEBUG co.elastic.apm.impl.ElasticApmTracer - Deactivating 'DefaultServlet#doGet' 00-2c023c2b38679603bdea04dda41d47b6-bf0d68ca6227d39d-01 on thread 153
2018-11-29 14:48:37.421 [default task-3] DEBUG co.elastic.apm.impl.ElasticApmTracer - } endTransaction 'DefaultServlet#doGet' 00-2c023c2b38679603bdea04dda41d47b6-bf0d68ca6227d39d-01
2018-11-29 14:48:37.421 [apm-reporter] DEBUG co.elastic.apm.report.IntakeV2ReportingEventHandler - Receiving TRANSACTION event (sequence 1)
2018-11-29 14:48:37.422 [apm-reporter] DEBUG co.elastic.apm.report.IntakeV2ReportingEventHandler - Starting new request to http://localhost:8200/intake/v2/events
2018-11-29 14:48:37.422 [apm-reporter] INFO co.elastic.apm.report.IntakeV2ReportingEventHandler - Backing off for 1 seconds (±10%)
2018-11-29 14:48:37.597 [default task-4] DEBUG co.elastic.apm.impl.ElasticApmTracer - startTransaction '' 00-7d59ac6e744925ce54d10bce98b2248b-6708c293187b9829-01 {
2018-11-29 14:48:37.598 [default task-4] DEBUG co.elastic.apm.impl.ElasticApmTracer - Activating '' 00-7d59ac6e744925ce54d10bce98b2248b-6708c293187b9829-01 on thread 154
2018-11-29 14:48:37.609 [apm-reporter] DEBUG co.elastic.apm.report.IntakeV2ReportingEventHandler - Receiving ERROR event (sequence 2)
2018-11-29 14:48:37.609 [default task-4] DEBUG co.elastic.apm.impl.ElasticApmTracer - Deactivating 'HelloWorldServlet#doGet' 00-7d59ac6e744925ce54d10bce98b2248b-6708c293187b9829-01 on thread 154
2018-11-29 14:48:37.611 [default task-4] DEBUG co.elastic.apm.impl.ElasticApmTracer - } endTransaction 'HelloWorldServlet#doGet' 00-7d59ac6e744925ce54d10bce98b2248b-6708c293187b9829-01
2018-11-29 14:48:37.611 [apm-reporter] DEBUG co.elastic.apm.report.IntakeV2ReportingEventHandler - Receiving TRANSACTION event (sequence 3)