Forum Discussion

Testranger's avatar
Testranger
Contributor
13 years ago

maven log4j level

Hi All,

I'm running the soapui pro maven plugin but can't set the level of logging. It always logs DEBUG. Was hoping somebody could help? Removing the dependency from the pom altogether hides the issue but I don't want to go down that path.

MAVEN LOG
[INFO] [soapui-pro:test {execution: test-id}]
soapUI Pro 4.0.0 Maven2 TestCase Runner
12:39:01,979 INFO [DefaultSoapUICore] initialized soapui-settings from [C:\Documents and Settings\lti\soapui-settings.xml]
12:39:02,277 INFO [HttpClientSupport$Helper] Initializing KeyStore
12:39:02.339 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.useragent = Jakarta Commons-HttpClient/3.1
12:39:02.339 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.protocol.version = HTTP/1.1
12:39:02.339 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.connection-manager.class = class org.apache.commons.httpclient.SimpleHttpConnectionManager
12:39:02.339 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.protocol.cookie-policy = default
12:39:02.339 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.protocol.element-charset = US-ASCII
12:39:02.339 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.protocol.content-charset = ISO-8859-1
12:39:02.355 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.method.retry-handler = org.apache.commons.httpclient.DefaultHttpMethodRetryHandler@633e10
12:39:02.355 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.dateparser.patterns = [EEE, dd MMM yyyy HH:mm:ss zzz, EEEE, dd-MMM-yy HH:mm:ss zzz, EEE MMM d HH:mm:ss yyyy, EEE, dd-MMM-yyyy HH:mm:ss z, EEE, dd-MMM-yyyy HH-mm-ss z, EEE, dd MMM yy HH:mm:ss z, EEE dd-MMM-yyyy HH:mm:ss z, EEE dd MMM yyyy HH:mm:ss z, EEE dd-MMM-yyyy HH-mm-ss z, EEE dd-MMM-yy HH:mm:ss z, EEE dd MMM yy HH:mm:ss z, EEE,dd-MMM-yy HH:mm:ss z, EEE,dd-MMM-yyyy HH:mm:ss z, EEE, dd-MM-yyyy HH:mm:ss z]
12:39:02.355 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.connection-manager.max-per-host = {HostConfiguration[]=500}
12:39:02.355 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.connection-manager.max-total = 2000
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - Java version: 1.6.0_21
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - Java vendor: Sun Microsystems Inc.
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - Java class path: C:\Documents and Settings\lti\.hudson\plugins\maven-plugin\WEB-INF\lib\maven-agent-1.2.jar;C:\apache-maven-2.2.1\boot\classworlds-1.1.jar
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - Operating system name: Windows XP
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - Operating system architecture: x86
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - Operating system version: 5.1
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - SUN 1.6: SUN (DSA key/parameter generation; DSA signing; SHA-1, MD5 digests; SecureRandom; X.509 certificates; JKS keystore; PKIX CertPathValidator; PKIX CertPathBuilder; LDAP, Collection CertStores, JavaPolicy Policy; JavaLoginConfig Configuration)
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - SunRsaSign 1.5: Sun RSA signature provider
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - SunJSSE 1.6: Sun JSSE provider(PKCS12, SunX509 key/trust factories, SSLv3, TLSv1)
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - SunJCE 1.6: SunJCE Provider (implements RSA, DES, Triple DES, AES, Blowfish, ARCFOUR, RC2, PBE, Diffie-Hellman, HMAC)
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - SunJGSS 1.0: Sun (Kerberos v5, SPNEGO)
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - SunSASL 1.5: Sun SASL provider(implements client mechanisms for: DIGEST-MD5, GSSAPI, EXTERNAL, PLAIN, CRAM-MD5; server mechanisms for: DIGEST-MD5, GSSAPI, CRAM-MD5)
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - XMLDSig 1.0: XMLDSig (DOM XMLSignatureFactory; DOM KeyInfoFactory)
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - SunPCSC 1.6: Sun PC/SC provider
12:39:02.355 [pool-1-thread-1] DEBUG o.a.commons.httpclient.HttpClient - SunMSCAPI 1.6: Sun's Microsoft Crypto API provider
12:39:02,511 INFO [SoapUIProGroovyScriptEngineFactory] Setting Script Library to [C:\Program Files\SmartBear\soapUI-Pro-4.5.1\bin\scripts]
12:39:03,184 INFO [WsdlProject] Loaded project from [file:/C:/Development/BusinessService/test/LSVM-Ranking-Func-01/src/test/resources/LSVM-Ranking-Func-01-soapui-project.xml]
12:39:03,638 INFO [SoapUIProGroovyScriptEngineFactory] Setting Script Library to [C:\Program Files\SmartBear\soapUI-Pro-4.5.1\bin\scripts]
12:39:04,280 INFO [SoapUIProTestCaseRunner] Running soapUI tests in project [LSVM-Ranking-Func-01]
12:39:04,280 INFO [SoapUIProTestCaseRunner] Running Project [LSVM-Ranking-Func-01], runType = SEQUENTIAL
12:39:04,389 INFO [SoapUIProTestCaseRunner] Running soapUI testcase [sendRequest]
12:39:04,389 INFO [SoapUIProTestCaseRunner] running step [Initialise-Vars]
12:39:07,347 INFO [SoapUIProTestCaseRunner] running step [generateIntegratorAuthToken(BSG)]
12:39:07.410 [Thread-6] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.protocol.version = HTTP/1.1
12:39:07.410 [Thread-6] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.socket.timeout = 720000
12:39:07.425 [Thread-6] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter soapui.sslConfig = null
12:39:07.425 [Thread-6] DEBUG o.a.c.httpclient.HttpConnection - Open connection to 172.16.16.31:8080

I've tried the following in groovy too, with no luck:
java.util.logging.Logger.getLogger("org.apache.http.wire").setLevel(java.util.logging.Level.FINEST);
java.util.logging.Logger.getLogger("org.apache.http.headers").setLevel(java.util.logging.Level.FINEST);
System.setProperty("org.apache.commons.logging.Log", "org.apache.commons.logging.impl.SimpleLog");
System.setProperty("org.apache.commons.logging.simplelog.showdatetime", "true");
System.setProperty("org.apache.commons.logging.simplelog.log.httpclient.wire", "ERROR");
System.setProperty("org.apache.commons.logging.simplelog.log.org.apache.http", "ERROR");
System.setProperty("org.apache.commons.logging.simplelog.log.org.apache.http.headers", "ERROR");

LOG4J.PROPERTIES file:
log4j.rootLogger=INFO
log4j.logger.httpclient.wire.header=INFO
log4j.logger.httpclient.wire.content=INFO



Thanks,
testranger

6 Replies

  • Testranger's avatar
    Testranger
    Contributor
    13 years ago
    Running "mvn test" from the command prompt or via jenkins gives the same result.
  • Testranger's avatar
    Testranger
    Contributor
    13 years ago
    Hi redfish4ktc,

    I've tried everything. It just won't disable.

    <?xml version="1.0" encoding="UTF-8"?>
    <!--
    ~ Copyright 2012 Thomas Bouffard (redfish4ktc)
    ~
    ~ Licensed under the Apache License, Version 2.0 (the "License");
    ~ you may not use this file except in compliance with the License.
    ~ You may obtain a copy of the License at
    ~
    ~ http://www.apache.org/licenses/LICENSE-2.0
    ~
    ~ Unless required by applicable law or agreed to in writing,
    ~ software distributed under the License is distributed on an
    ~ "AS IS" BASIS, WITHOUT WARRANTIES OR CONDITIONS OF ANY
    ~ KIND, either express or implied. See the License for the
    ~ specific language governing permissions and limitations
    ~ under the License.
    -->


    <!DOCTYPE log4j:configuration SYSTEM "log4j.dtd">
    <log4j:configuration xmlns:log4j="http://jakarta.apache.org/log4j/" debug="false">

    <!-- =================== -->
    <!-- Appenders -->
    <!-- =================== -->

    <appender name="CONSOLE" class="org.apache.log4j.ConsoleAppender">
    <errorHandler class="org.apache.log4j.helpers.OnlyOnceErrorHandler"/>
    <param name="Target" value="System.out"/>
    <param name="Threshold" value="OFF"/>
    <layout class="org.apache.log4j.PatternLayout">
    <!-- The default pattern: Date Priority [Category] Message\n -->
    <param name="ConversionPattern" value="%d{ABSOLUTE} %-5p [%c{1}] %m%n"/>
    </layout>
    </appender>

    <appender name="FILE" class="org.apache.log4j.RollingFileAppender">
    <errorHandler class="org.apache.log4j.helpers.OnlyOnceErrorHandler"/>
    <param name="File" value="target/custom/custom_soapui.log"/>
    <param name="Threshold" value="OFF"/>
    <param name="Append" value="false"/>
    <param name="MaxFileSize" value="5000KB"/>
    <param name="MaxBackupIndex" value="50"/>
    <layout class="org.apache.log4j.PatternLayout">
    <param name="ConversionPattern" value="%d %-5p [%c{1}] %m%n"/>
    </layout>
    </appender>

    <!-- =============== -->
    <!-- Loggers -->
    <!-- =============== -->

    <logger name="com.eviware.soapui">
    <level value="OFF" />
    </logger>

    <logger name="org.apache.log4j.logger.httpclient">
    <level value="OFF" />
    </logger>


    <logger name="org.apache.commons">
    <level value="OFF" />
    </logger>

    <logger name="o.a.c.h">
    <level value="OFF" />
    </logger>

    <logger name="org.apache.commons.httpclient">
    <level value="OFF" />
    </logger>


    <logger name="org.apache.commons.httpclient.HttpClient">
    <level value="OFF" />
    </logger>



    <logger name="org.apache.http.wire">
    <level value="OFF" />
    </logger>

    <logger name="org.apache.http.headers">
    <level value="OFF" />
    </logger>


    <logger name="httpclient.wire.header">
    <level value="OFF" />
    </logger>

    <logger name="httpclient.wire.content">
    <level value="OFF" />
    </logger>

    <logger name="org.apache.log4j.logger.httpclient.wire.header">
    <level value="OFF" />
    </logger>

    <logger name="org.apache.log4j.logger.httpclient.wire.content">
    <level value="OFF" />
    </logger>


    <root>
    <appender-ref ref="CONSOLE"/>
    <appender-ref ref="FILE"/>
    </root>

    </log4j:configuration>
  • Testranger's avatar
    Testranger
    Contributor
    13 years ago
    Good point, I've updated the version.

    tions [HttpRoute[{tls}->http://172.16.16.31:8080->https://uat.rpdata.com]][null

    9:19:21.093 [Thread-8] DEBUG o.a.h.i.conn.tsccm.ConnPoolByRoute - Available cap
    city: 2 out of 2 [HttpRoute[{tls}->http://172.16.16.31:8080->https://uat.rpdata
    com]][null]
    9:19:21.093 [Thread-8] DEBUG o.a.h.i.conn.tsccm.ConnPoolByRoute - Creating new
    onnection [HttpRoute[{tls}->http://172.16.16.31:8080->https://uat.rpdata.com]]
    9:19:21.109 [Thread-8] DEBUG c.e.s.i.w.s.h.SoapUIMultiThreadedHttpConnectionMan
    ger$SoapUIDefaultClientConnection - Connection shut down
    9:19:21.109 [Thread-8] DEBUG o.a.h.i.conn.tsccm.ConnPoolByRoute - Releasing con
    ection [HttpRoute[{tls}->http://172.16.16.31:8080->https://uat.rpdata.com]][nul
    ]
    9:19:21.109 [Thread-8] DEBUG o.a.h.i.conn.tsccm.ConnPoolByRoute - Notifying no-
    ne, there are no waiting threads
    ava.lang.ClassCastException: org.apache.http.message.BasicHttpRequest cannot be
    cast to org.apache.http.impl.client.RequestWrapper
    at com.eviware.soapui.impl.wsdl.support.http.HttpClientSupport$SoapUIHtt
    RequestExecutor.preProcess(HttpClientSupport.java:93)
    at org.apache.http.impl.client.DefaultRequestDirector.createTunnelToTarg
    t(DefaultRequestDirector.java:830)
    at org.apache.http.impl.client.DefaultRequestDirector.establishRoute(Def
    ultRequestDirector.java:739)
    at org.apache.http.impl.client.DefaultRequestDirector.tryConnect(Default
    equestDirector.java:565)
    at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultReq


    However, I still get the DEBUG messages and also, it seems v 4.5.1 has that class ClassCastException again. I resolves that by updating to version 4.5.1-SNAPSHOT, but I can't seem to specify SNAPSHOT in the pom.xml. Seems unrecognised. Should there be a 4.5.1-SNAPSHOT plugin?

    Regards,
    testranger
  • Testranger's avatar
    Testranger
    Contributor
    13 years ago
    Tried the following in the groovy script of my first step and still no luck:

    Logger.getLogger( "org.apache" ).setLevel( Level.OFF );
    Logger.getLogger( "org.apache.http.wire" ).setLevel( Level.OFF );
    Logger.getLogger( "org.apache.http.headers" ).setLevel( Level.OFF );
    Logger.getLogger( "org.apache.httpclient.wire.header" ).setLevel( Level.OFF );
    Logger.getLogger( "org.apache.httpclient.wire.content" ).setLevel( Level.OFF );
    Logger.getLogger( "org.apache.httpclient" ).setLevel( Level.OFF );
    Logger.getLogger( "org.apache.commons.httpclient" ).setLevel( Level.OFF );
    Logger.getLogger( "org.apache.commons.httpclient.HttpClient" ).setLevel( Level.OFF );
  • Testranger's avatar
    Testranger
    Contributor
    13 years ago
    Tried the blank soapui-settings.xml with no success.

    pom.xml:

    <project xmlns="http://maven.apache.org/POM/4.0.0" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
    xsi:schemaLocation="http://maven.apache.org/POM/4.0.0 http://maven.apache.org/xsd/maven-4.0.0.xsd">

    <modelVersion>4.0.0</modelVersion>
    <packaging>jar</packaging>

    <groupId>LSVM</groupId>
    <artifactId>LSVM-Ranking-Func-01</artifactId>
    <version>1.0.0</version>
    <name>LSVM-Ranking-Func-01 maven plugin</name> <!-- optional -->

    <pluginRepositories>
    <pluginRepository>
    <id>eviwarePluginRepository</id>
    <url>http://www.soapui.org/repository/maven2/</url>
    </pluginRepository>
    </pluginRepositories>

    <build>

    <testResources>
    <testResource>
    <filtering>true</filtering>
    <directory>src/test/resources</directory>
    </testResource>
    </testResources>

    <plugins>
    <plugin>
    <groupId>eviware</groupId>
    <artifactId>maven-soapui-pro-plugin</artifactId>
    <version>4.0.0</version>

    <configuration>
    <junitReport>true</junitReport>
    <exportAll>false</exportAll> <!-- Controls if all test requests should be exported (default only exports errors), (true/false) -->

    <testFailIgnore>true</testFailIgnore>
    <printReport>true</printReport>
    <projectFile>${project.basedir}\src\test\resources\LSVM-Ranking-Func-01-soapui-project.xml</projectFile>
    <!-- if any project properties -->
    <projectProperties>
    <projectProperty>evr-host=http://localhost</projectProperty>
    </projectProperties>
    <!--
    <outputFolder>C:\junitReport\target\surefire-reports\LSVM-Ranking-Func-01</outputFolder>
    -->
    <outputFolder>${project.build.directory}/surefire-reports</outputFolder>
    </configuration>

    <dependencies>

    <dependency>
    <groupId>log4j</groupId>
    <artifactId>log4j</artifactId>
    <version>1.2.14</version>
    </dependency>

    <dependency>
    <groupId>jgoodies</groupId>
    <artifactId>looks</artifactId>
    <version>2.2.0</version>
    </dependency>

    <dependency>
    <groupId>fife</groupId>
    <artifactId>rsyntaxtextarea</artifactId>
    <version>1.3.4</version>
    </dependency>

    <dependency>
    <groupId>joda-time</groupId>
    <artifactId>joda-time</artifactId>
    <version>2.0</version>
    </dependency>

    <dependency>
    <groupId>com.fasterxml.jackson.core</groupId>
    <artifactId>jackson-databind</artifactId>
    <version>2.0.4</version>
    </dependency>
    <dependency>
    <groupId>com.fasterxml.jackson.jaxrs</groupId>
    <artifactId>jackson-jaxrs-json-provider</artifactId>
    <version>2.0.4</version>
    </dependency>
    <dependency>
    <groupId>com.fasterxml.jackson.datatype</groupId>
    <artifactId>jackson-datatype-joda</artifactId>
    <version>2.0.4</version>
    </dependency>

    <dependency>
    <groupId>com.tekdata.common</groupId>
    <artifactId>jaxb-ext</artifactId>
    <version>0.0.4-RELEASE</version>
    </dependency>

    <dependency>
    <groupId>com.tekdata.businessservicescommon.bsgproxy</groupId>
    <artifactId>bsg-proxy</artifactId>
    <version>1.3.4-SNAPSHOT</version>
    </dependency>

    <dependency>
    <groupId>com.tekdata.common</groupId>
    <artifactId>jackson-ext</artifactId>
    <version>0.0.10-SNAPSHOT</version>
    </dependency>

    </dependencies>

    <executions>
    <execution>
    <id>test-id</id>
    <phase>test</phase>
    <goals>
    <goal>test</goal>
    </goals>
    </execution>
    </executions>
    </plugin>
    </plugins>
    </build>

    <reporting>
    <plugins>
    <plugin>
    <groupId>org.apache.maven.plugins</groupId>
    <artifactId>maven-surefire-report-plugin</artifactId>
    <configuration>
    <outputDirectory>target\site\soapui</outputDirectory>
    <reportsDirectories>
    <reportsDirectories>target\soapui</reportsDirectories>
    </reportsDirectories>
    </configuration>
    </plugin>
    </plugins>
    </reporting>

    </project>
  • redfish4ktc2's avatar
    redfish4ktc2
    Super Contributor
    13 years ago
    Hi did you solve your issue?

    As I previously replied (my account has been deleted :-( ), it seems there are 2 different kind of logs as the patterns are different

    soapui logs
    12:39:01,979 INFO [DefaultSoapUICore] initialized soapui-settings from [C:\Documents and Settings\lti\soapui-settings.xml]
    12:39:02,277 INFO [HttpClientSupport$Helper] Initializing KeyStore

    httpclient logs
    12:39:02.339 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.useragent = Jakarta Commons-HttpClient/3.1
    12:39:02.339 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.protocol.version = HTTP/1.1
    12:39:02.339 [pool-1-thread-1] DEBUG o.a.c.h.params.DefaultHttpParams - Set parameter http.connection-manager.class = class org.apache.commons.httpclient.SimpleHttpConnectionManager

    httpclient source code: https://svn.apache.org/viewvc/httpcompo ... LIENT_3_1/ shows that it uses commons-logging

    As I can not reproduce your issue, could you confirm there is not log4j.properties/xml in the 2 snapshots jar you added as dependency of the plugin (or any logging configuration files)? or does this 2 snapshot have dependencies that could be logging libraries or contains log configuration files?
    maybe they can mess the logging