java – 将Logback跟踪日志发送到Azure应用程序洞察 – 错误:发送失败,请求错误

我在Azure中有一个Java Web应用程序,它使用Logback进行跟踪日志记录.我正在尝试将跟踪日志记录链接到Azure中的Application Insights,并且我已按照Azure documentation中的所有说明进行操作.

这是Maven pom.xml的相关部分:

    <dependency>
        <groupId>com.microsoft.azure</groupId>
        <artifactId>applicationinsights-web</artifactId>
        <version>[1.0,)</version>
    </dependency>
    <dependency>
        <groupId>com.microsoft.azure</groupId>
        <artifactId>applicationinsights-core</artifactId>
        <version>[1.0,)</version>
    </dependency>
    <dependency>
        <groupId>com.microsoft.azure</groupId>
        <artifactId>applicationinsights-logging-logback</artifactId>
        <version>[1.0,)</version>
    </dependency>
  </dependencies>

  <repositories>
    <repository>
      <id>central</id>
      <name>Central</name>
      <url>http://repo1.maven.org/maven2</url>
    </repository>
  </repositories>

我的ApplicationInsights.xml:

<?xml version="1.0" encoding="utf-8" standalone="no"?>
<!DOCTYPE xml>
<ApplicationInsights xmlns="http://schemas.microsoft.com/ApplicationInsights/2013/Settings" schemaVersion="2014-05-30">
  <SDKLogger />
  <InstrumentationKey>*my key here*</InstrumentationKey>
  <ContextInitializers>
  </ContextInitializers>
  <TelemetryInitializers>
    <Add type="com.microsoft.applicationinsights.web.extensibility.initializers.WebOperationIdTelemetryInitializer"/>
    <Add type="com.microsoft.applicationinsights.web.extensibility.initializers.WebOperationNameTelemetryInitializer"/>
    <Add type="com.microsoft.applicationinsights.web.extensibility.initializers.WebSessionTelemetryInitializer"/>
    <Add type="com.microsoft.applicationinsights.web.extensibility.initializers.WebUserTelemetryInitializer"/>
    <Add type="com.microsoft.applicationinsights.web.extensibility.initializers.WebUserAgentTelemetryInitializer"/>
  </TelemetryInitializers>
  <TelemetryModules>
    <Add type="com.microsoft.applicationinsights.web.extensibility.modules.WebRequestTrackingTelemetryModule"/>
    <Add type="com.microsoft.applicationinsights.web.extensibility.modules.WebSessionTrackingTelemetryModule"/>
    <Add type="com.microsoft.applicationinsights.web.extensibility.modules.WebUserTrackingTelemetryModule"/>    
  </TelemetryModules>
  <Channel>
    <!-- 
      Setting DeveloperMode to true will enable immediate transmission of the telemetry events, which can be helpful during the development process.
      Make sure to turn this off on production servers due to performance considerations.
    -->
    <DeveloperMode>true</DeveloperMode>
  </Channel>
  <DisableTelemetry>false</DisableTelemetry>
</ApplicationInsights>

我的logback.xml:

<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE xml>

<configuration debug = "true">

    <appender class="ch.qos.logback.core.ConsoleAppender" name="STDOUT">
        <encoder>
            <Pattern>%d{HH:mm:ss.SSS} %-5level - %msg%n</Pattern>
        </encoder>
    </appender>

    <appender name="aiAppender" class="com.microsoft.applicationinsights.logback.ApplicationInsightsAppender">
    </appender>

    <root level="info">
        <appender-ref ref="STDOUT"/>
        <appender-ref ref="aiAppender"/>
    </root>

</configuration>

我的班级测试记录器和应用程序见解集成:

import org.slf4j.Logger;
import org.slf4j.LoggerFactory;

import com.microsoft.applicationinsights.TelemetryClient;
/**
 * Hello world!
 *
 */
public class App 
{
    private final static Logger LOG = LoggerFactory.getLogger("root");
    public static void main( String[] args ) throws InterruptedException
    {
        LOG.info("Logging is working");
        TelemetryClient tc = new TelemetryClient();
        tc.trackTrace("Telemetry is working");
        System.out.println( "Hello World!" );
    }
}

当我运行它时,Logback可以正常使用控制台appender,遥测到应用程序洞察可以正常工作,但跟踪日志不会进入应用程序洞察门户.我收到以下错误:

AI: ERROR 18-10-2017 20:40, 19: Failed to send, Bad request :
{“itemsReceived”:1,”itemsAccepted”:0,”errors”:[{“index”:0,”statusCode”:400,”message”:”SyntaxError:
Unexpected token I”}]}

我已经搜索了这个问题的解决方案,但是我似乎无法解决这个问题.有没有人有任何想法?谢谢!!

更新:

这是完整的堆栈跟踪:

09:13:59,774 |-INFO in ch.qos.logback.classic.LoggerContext[default] – Could NOT find resource [logback.groovy]
09:13:59,774 |-INFO in ch.qos.logback.classic.LoggerContext[default] – Could NOT find resource [logback-test.xml]
09:13:59,774 |-INFO in ch.qos.logback.classic.LoggerContext[default] – Found resource [logback.xml] at [file:/C:/Users/greta/OneDrive/Eclipse%20Water%20Application%20Project%20Files/Test2/target/classes/logback.xml]
09:13:59,888 |-INFO in ch.qos.logback.core.joran.action.AppenderAction – About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
09:13:59,891 |-INFO in ch.qos.logback.core.joran.action.AppenderAction – Naming appender as [STDOUT]
09:13:59,911 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA – Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:13:59,943 |-INFO in ch.qos.logback.core.joran.action.AppenderAction – About to instantiate appender of type [com.microsoft.applicationinsights.logback.ApplicationInsightsAppender]
09:13:59,988 |-INFO in ch.qos.logback.core.joran.action.AppenderAction – Naming appender as [aiAppender]
AI: INFO 20-10-2017 09:14, 1: Configuration file has been successfully found as resource
AI: INFO 20-10-2017 09:14, 1: ‘MaxTelemetryBufferCapacity’: null value is replaced with ‘500’
AI: INFO 20-10-2017 09:14, 1: ‘FlushIntervalInSeconds’: null value is replaced with ‘5’
AI: TRACE 20-10-2017 09:14, 1: Using Http Client version 4.3+
AI: INFO 20-10-2017 09:14, 1: ‘Channel.MaxTransmissionStorageCapacityInMB’: null value is replaced with ’10’
AI: TRACE 20-10-2017 09:14, 1: C:\Users\greta\AppData\Local\Temp\AISDK\native\1.0.10 folder exists
AI: TRACE 20-10-2017 09:14, 1: Java process name is set to ‘javaw’
AI: TRACE 20-10-2017 09:14, 1: Successfully loaded library ‘applicationinsights-core-native-win64.dll’
AI: INFO 20-10-2017 09:14, 1: Configuration file has been successfully found as resource
AI: INFO 20-10-2017 09:14, 1: ‘MaxTelemetryBufferCapacity’: null value is replaced with ‘500’
AI: INFO 20-10-2017 09:14, 1: ‘FlushIntervalInSeconds’: null value is replaced with ‘5’
AI: INFO 20-10-2017 09:14, 1: ‘Channel.MaxTransmissionStorageCapacityInMB’: null value is replaced with ’10’
AI: TRACE 20-10-2017 09:14, 1: C:\Users\greta\AppData\Local\Temp\AISDK\native\1.0.10 folder exists
AI: TRACE 20-10-2017 09:14, 1: Java process name is set to ‘javaw’
AI: TRACE 20-10-2017 09:14, 1: Successfully loaded library ‘applicationinsights-core-native-win64.dll’
AI: TRACE 20-10-2017 09:14, 1: Registering PC ‘DeadLockDetector’
AI: TRACE 20-10-2017 09:14, 1: Registering PC ‘JvmHeapMemoryUsedPerformanceCounter’
AI: TRACE 20-10-2017 09:14, 1: Registering PC ‘JSDK_ProcessMemoryPerformanceCounter’
AI: TRACE 20-10-2017 09:14, 1: Registering PC ‘JSDK_ProcessCpuPerformanceCounter’
AI: TRACE 20-10-2017 09:14, 1: Registering PC ‘JSDK_WindowsPerformanceCounterAsPC’
AI: TRACE 20-10-2017 09:14, 1: Registering PC ‘DeadLockDetector’
AI: TRACE 20-10-2017 09:14, 1: Failed to store performance counter ‘DeadLockDetector’, since there is already one
AI: TRACE 20-10-2017 09:14, 1: Registering PC ‘JvmHeapMemoryUsedPerformanceCounter’
AI: TRACE 20-10-2017 09:14, 1: Failed to store performance counter ‘JvmHeapMemoryUsedPerformanceCounter’, since there is already one
AI: ERROR 20-10-2017 09:14, 1: Failed to create WindowsPerformanceCounterAsPC: ‘Failed to register all built-in Windows performance counters.’
AI: TRACE 20-10-2017 09:14, 1: Registering PC ‘JSDK_ProcessMemoryPerformanceCounter’
AI: TRACE 20-10-2017 09:14, 1: Failed to store performance counter ‘JSDK_ProcessMemoryPerformanceCounter’, since there is already one
AI: TRACE 20-10-2017 09:14, 1: Registering PC ‘JSDK_ProcessCpuPerformanceCounter’
AI: TRACE 20-10-2017 09:14, 1: Failed to store performance counter ‘JSDK_ProcessCpuPerformanceCounter’, since there is already one
09:14:01,943 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction – Setting level of ROOT logger to INFO
09:14:01,943 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction – Attaching appender named [STDOUT] to Logger[ROOT]
09:14:01,944 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction – Attaching appender named [aiAppender] to Logger[ROOT]
09:14:01,944 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction – End of configuration.
09:14:01,945 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6b415f5f – Registering current configuration as safe fallback point
09:13:59,774 |-INFO in ch.qos.logback.classic.LoggerContext[default] – Could NOT find resource [logback.groovy]
09:13:59,774 |-INFO in ch.qos.logback.classic.LoggerContext[default] – Could NOT find resource [logback-test.xml]
09:13:59,774 |-INFO in ch.qos.logback.classic.LoggerContext[default] – Found resource [logback.xml] at [file:/C:/Users/greta/OneDrive/Eclipse%20Water%20Application%20Project%20Files/Test2/target/classes/logback.xml]
09:13:59,888 |-INFO in ch.qos.logback.core.joran.action.AppenderAction – About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
09:13:59,891 |-INFO in ch.qos.logback.core.joran.action.AppenderAction – Naming appender as [STDOUT]
09:13:59,911 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA – Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:13:59,943 |-INFO in ch.qos.logback.core.joran.action.AppenderAction – About to instantiate appender of type [com.microsoft.applicationinsights.logback.ApplicationInsightsAppender]
09:13:59,988 |-INFO in ch.qos.logback.core.joran.action.AppenderAction – Naming appender as [aiAppender]
09:14:01,943 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction – Setting level of ROOT logger to INFO
09:14:01,943 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction – Attaching appender named [STDOUT] to Logger[ROOT]
09:14:01,944 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction – Attaching appender named [aiAppender] to Logger[ROOT]
09:14:01,944 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction – End of configuration.
09:14:01,945 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6b415f5f – Registering current configuration as safe fallback point
09:14:01.948 INFO – Logging is working
AI: TRACE 20-10-2017 09:14, 1: InProcessTelemetryChannel sending telemetry
AI: TRACE 20-10-2017 09:14, 1: InProcessTelemetryChannel sending telemetry
Hello World!
AI: ERROR 20-10-2017 09:14, 19: Failed to send, Bad request : {“itemsReceived”:1,”itemsAccepted”:0,”errors”:[{“index”:0,”statusCode”:400,”message”:”SyntaxError: Unexpected token I”}]}

性能计数器有一些错误.我试着找到一些关于这些错误的信息,但没有太多的运气.也许这是问题的一部分?

解决方法:

我在这里可以看到的一个问题是AI的内部记录器报告了意外的特征.我发现其中一个可能的问题是清理逻辑中存在一些问题,这会阻止项目发送到终点,因此您无法在门户上看到数据.还有一些已知的logback问题已在github上提到:
https://github.com/Microsoft/ApplicationInsights-Java/issues/453
这应该回答你的问题.如果您愿意,可以随时在Github上创建另一个问题.希望下一次公开发布应该解决这个问题.

相关文章

Microsoft云包括了Azure、PowerPlatform、Microsoft365、Git...
《WindowsAzurePlatform系列文章目录》 我们在使用AzureAPI...
微软免费使用一年的Azure虚拟机,默认提供了一个64G的磁盘,...
上篇请访问这里做一个能对标阿里云的前端APM工具(上)样本多...
一年一度的MicrosoftBuild终于来了,带来了非常非常多的新技...