Forum Discussion

Thomas_Bonds's avatar
Thomas_Bonds
Occasional Contributor
13 years ago

better control of message logging for loadtestrunner.sh

When I run loadtestrunner.sh from the command line, I see output like this:


2011-08-22 20:07:48,890 INFO [DefaultSoapUICore] initialized soapui-settings fr
om [/root/soapui-settings.xml]
2011-08-22 20:07:48,950 INFO [DefaultSoapUICore] Adding listeners from [/opt/ev
iware/soapUI-Pro-3.6.1/bin/listeners/demo-listeners.xml]
2011-08-22 20:07:48,956 WARN [SoapUIProGroovyScriptEngineFactory] Missing scrip
ts folder [/usr/bobj/bin/scripts]
2011-08-22 20:07:49,001 INFO [WsdlProject] Loaded project from [file:/usr/bobj/
SOAPUIprojects/PXSMS900_SOAP-soapui-project.xml]
2011-08-22 20:07:49,023 WARN [SoapUIProGroovyScriptEngineFactory] Missing scrip
ts folder [/usr/bobj/bin/scripts]
2011-08-22 20:07:49,100 INFO [SoapUIProLoadTestRunner] Skipping testcase [Start
StopSmsNotification--tts01], filter is [sendSms]
2011-08-22 20:07:49,130 INFO [SoapUIProLoadTestRunner] Running LoadTest [PXSMS
SOAP Client Load Test]
2011-08-22 20:07:49,131 INFO [SoapUIProLoadTestRunner] Overriding limit [400000
] with specified [60]
2011-08-22 20:07:49,132 INFO [SoapUIProLoadTestRunner] Overriding threadCount [
4] with specified [1]
2011-08-22 20:07:49,186 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 3.5E-4, 1
2011-08-22 20:07:50,187 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.017033333, 1
2011-08-22 20:07:52,191 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.050433334, 1
2011-08-22 20:07:53,193 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.06713333, 1
2011-08-22 20:07:54,195 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.08383334, 1
2011-08-22 20:07:55,197 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.10053334, 1
2011-08-22 20:07:56,199 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.117233336, 1
2011-08-22 20:07:57,201 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.13393334, 1
2011-08-22 20:07:58,203 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.15063334, 1
2011-08-22 20:07:59,205 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.16733333, 1
2011-08-22 20:08:00,207 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.18403333, 1
2011-08-22 20:08:01,209 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.20073333, 1
......

INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Client Load Test] finished with status FINISHED
2011-08-22 20:08:49,306 INFO [SoapUIProLoadTestRunner] Exporting log and statis
tics for LoadTest [PXSMS SOAP Client Load Test]
2011-08-22 20:08:49,308 INFO [SoapUIProLoadTestRunner] Exported 3 log items to
[/opt/SOAPUILogs/2011.08.22/PXSMS-SOAP/1/PXSMS_SOAP_Client_Load_Test-log.txt]
2011-08-22 20:08:49,313 INFO [SoapUIProLoadTestRunner] Exported 1 error results
2011-08-22 20:08:49,314 INFO [SoapUIProLoadTestRunner] Exported 4 statistics to
[/opt/SOAPUILogs/2011.08.22/PXSMS-SOAP/1/PXSMS_SOAP_Client_Load_Test-statistics
.txt]
2011-08-22 20:08:49,332 INFO [SoapUIProLoadTestRunner] Skipping testcase [Start
StopSmsNotification--ihwin01], filter is [sendSms]
2011-08-22 20:08:49,332 INFO [SoapUIProLoadTestRunner] soapUI suite [Performanc
eMTTestSuite] finished in 60232ms


The items that show the current test progress, like this:

2011-08-22 20:07:55,197 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.10053334, 1
2011-08-22 20:07:56,199 INFO [SoapUIProLoadTestRunner] LoadTest [PXSMS SOAP Cli
ent Load Test] progress: 0.117233336, 1


aren't very useful.

I really would like two things.

a) better control of logging in general. Right now everything gets logged, but many java applications
provide operators with the facility to output messages of only a certain priority or higher. All of these
progress notes are priority INFO, and perhaps I just want to log SEVERE priority messages.

b) If we implement the above, then we should have lower priority for the progress notes. If we can't
have the facility to control logging based on certain priority, then it would be good to be able to suppress
them altogether.

2 Replies

Sort By
  • SmartBear_Suppo's avatar
    SmartBear_Suppo
    SmartBear Alumni (Retired)
    13 years ago
    Hello!

    SoapUI (that includes loadtestrunner.sh/bat) will obey the logging instructions given in soapui-log4j.xml.

    In your case, try replacing this:
       <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="[color=#FF0000]DEBUG[/color]"/>
          <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>


    with this:

       <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="[color=#FF0000]WARN[/color]"/>
          <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>


    Hope it helps

    Henrik
    SmartBear Sweden