You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@jmeter.apache.org by bu...@apache.org on 2013/02/05 20:59:26 UTC

[Bug 54530] New: errors in summariser logs (time gets out of sync)

https://issues.apache.org/bugzilla/show_bug.cgi?id=54530

            Bug ID: 54530
           Summary: errors in summariser logs (time gets out of sync)
           Product: JMeter
           Version: 2.7
          Hardware: PC
                OS: Linux
            Status: NEW
          Severity: normal
          Priority: P2
         Component: Main
          Assignee: issues@jmeter.apache.org
          Reporter: awspyker@gmail.com
    Classification: Unclassified

Java: IBM 1.6.0
java full version "JRE 1.6.0 IBM Linux build pxi3260sr10fp1-20120321_01 (SR10
FP1)"

I see mistakes in the jmeter headless log file coming from the summariser.  I
know the workload keeps running and responding, but see the following in the
log files:

2013/02/05 13:29:30 INFO  - jmeter.reporters.Summariser: summary + 43251 in 
30.2s = 1433.5/s Avg:    38 Min:     1 Max:   322 Err:     1 (0.00%) 
2013/02/05 13:29:30 INFO  - jmeter.reporters.Summariser: summary = 178688 in
126.3s = 1414.3/s Avg:    34 Min:     1 Max:   511 Err:     5 (0.00%) 
2013/02/05 13:30:00 INFO  - jmeter.reporters.Summariser: summary + 44306 in 
30.1s = 1473.3/s Avg:    38 Min:     1 Max:   401 Err:     1 (0.00%) 
2013/02/05 13:30:00 INFO  - jmeter.reporters.Summariser: summary = 222994 in
156.3s = 1426.3/s Avg:    35 Min:     1 Max:   511 Err:     6 (0.00%) 
2013/02/05 13:30:30 INFO  - jmeter.reporters.Summariser: summary + 44607 in
1360092630.0s =    0.0/s Avg:    38 Min:     0 Max:   324 Err:     1 (0.00%) 
2013/02/05 13:30:30 INFO  - jmeter.reporters.Summariser: summary = 267601 in
1360092630.0s =    0.0/s Avg:    36 Min:     0 Max:   511 Err:     7 (0.00%) 
2013/02/05 13:31:00 INFO  - jmeter.reporters.Summariser: summary + 44734 in 
30.1s = 1488.2/s Avg:    38 Min:     2 Max:   514 Err:     4 (0.01%) 
2013/02/05 13:31:00 INFO  - jmeter.reporters.Summariser: summary = 312335 in
1360092660.0s =    0.0/s Avg:    36 Min:     0 Max:   514 Err:    11 (0.00%) 
2013/02/05 13:31:30 INFO  - jmeter.reporters.Summariser: summary + 44671 in
1360092690.0s =    0.0/s Avg:    38 Min:     0 Max:   322 Err:     1 (0.00%) 
2013/02/05 13:31:30 INFO  - jmeter.reporters.Summariser: summary = 357006 in
1360092690.0s =    0.0/s Avg:    36 Min:     0 Max:   514 Err:    12 (0.00%) 
2013/02/05 13:32:00 INFO  - jmeter.reporters.Summariser: summary + 45516 in 
30.0s = 1514.9/s Avg:    37 Min:     1 Max:   321 Err:     1 (0.00%) 
2013/02/05 13:32:00 INFO  - jmeter.reporters.Summariser: summary = 402522 in
1360092720.0s =    0.0/s Avg:    36 Min:     0 Max:   514 Err:    13 (0.00%) 
2013/02/05 13:32:30 INFO  - jmeter.reporters.Summariser: summary + 42467 in 
30.1s = 1410.5/s Avg:    40 Min:     1 Max:   354 Err:     0 (0.00%) 

You can see by the timestamps that it should continue into 156.3s to around
186.3, but instead jumps to 1360092630.0s.

Also + lines at the same time start to report 0.0/s (instead of the expected ~
1400/s) at the same time.  You can see
that recovers back at 13:32.

Is there some debugging I could due to figure this out.

I do note this has only happened thus far on 2 VCPU cloud instances.  I haven't
seen it happen if JMeter is running on a 1 VCPU
cloud instance.  Therefore wondering if it's a threading issue?

-- 
You are receiving this mail because:
You are the assignee for the bug.

[Bug 54530] errors in summariser logs (time gets out of sync)

Posted by bu...@apache.org.
https://issues.apache.org/bugzilla/show_bug.cgi?id=54530

Philippe Mouawad <p....@ubik-ingenierie.com> changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
             Status|NEEDINFO                    |RESOLVED
         Resolution|---                         |WORKSFORME

--- Comment #4 from Philippe Mouawad <p....@ubik-ingenierie.com> ---
Thanks for feedback.
Regarding:
- "Error in NonGUIDriver java.lang.NullPointerException which I didn't get in
2.7"

did you find the issue ? is it a script or configuration error ? if not feel
free to open a bug.

I close this issue as WORKSFORME as of 2.9. Feel free to reopen if you
reproduce.

Regards
Philippe

-- 
You are receiving this mail because:
You are the assignee for the bug.

[Bug 54530] errors in summariser logs (time gets out of sync)

Posted by bu...@apache.org.
https://issues.apache.org/bugzilla/show_bug.cgi?id=54530

--- Comment #3 from Andrew Spyker <aw...@gmail.com> ---
After going to a system where the NonGUIDriver issue wasn't occurring, I can't
seem to reproduce the summariser problem with 2.9.  Unfortunately the issue
doesn't occur all the time, so I can't be certain that 2.9 fixed the problem.

With 2.9, I did about 10 runs over two days and never saw the issue with 2.9
(this was about 100 samples).

With 2.7 (and no other changes), the first day errors occurred once or twice
ever 20 samples and on the second day it occurred once for 60 or so samples.

At this point, I think 2.9 has fixed this, but as I said, I can't be certain.
We'll move our project up to 2.9 and let you know if it re-occurs.

-- 
You are receiving this mail because:
You are the assignee for the bug.

[Bug 54530] errors in summariser logs (time gets out of sync)

Posted by bu...@apache.org.
https://issues.apache.org/bugzilla/show_bug.cgi?id=54530

--- Comment #2 from Andrew Spyker <aw...@gmail.com> ---
I was in the process of trying out 2.9, but got Error in NonGUIDriver
java.lang.NullPointerException which I didn't get in 2.7.  I've been trying to
rework the script to see if I can avoid the new error to get back to verifying
the 2.9 fix for the initial problem.  Will get back to this soon.  Thanks for
checking up on the progress.

-- 
You are receiving this mail because:
You are the assignee for the bug.

[Bug 54530] errors in summariser logs (time gets out of sync)

Posted by bu...@apache.org.
https://issues.apache.org/bugzilla/show_bug.cgi?id=54530

Philippe Mouawad <p....@ubik-ingenierie.com> changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
             Status|NEW                         |NEEDINFO
                 CC|                            |p.mouawad@ubik-ingenierie.c
                   |                            |om

--- Comment #1 from Philippe Mouawad <p....@ubik-ingenierie.com> ---
Can you try with last 2.9 version ?
There have been fixes on a shared DecimalFormat variable which may explain your
issue and on computation of interval

-- 
You are receiving this mail because:
You are the assignee for the bug.