See <https://builds.apache.org/job/HTrace-Master/128/changes>
Changes:
[cmccabe] HTRACE-237. Optimize htraced span receiver (cmccabe)
------------------------------------------
[...truncated 40713 lines...]
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@896759592-170-selector-ClientSelectorManager@12d4d8c/7" prio=5
tid=170 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@1934516108-160-selector-ClientSelectorManager@1d878a3b/7" prio=5
tid=160 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@635285010-22-selector-ClientSelectorManager@5f52408b/0" prio=5
tid=22 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@896759592-164-selector-ClientSelectorManager@12d4d8c/1" prio=5
tid=164 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"Reference Handler" daemon prio=10 tid=2 in Object.wait()
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:503)
at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:133)
"HttpClient@1934516108-156-selector-ClientSelectorManager@1d878a3b/3" prio=5
tid=156 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@1601730096-175-selector-ClientSelectorManager@79109fdd/2" prio=5
tid=175 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@1290173470-85-selector-ClientSelectorManager@785c9e4e/1" prio=5
tid=85 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@1934516108-188" prio=5 tid=188 timed_waiting
java.lang.Thread.State: TIMED_WAITING
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:389)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:522)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$700(QueuedThreadPool.java:47)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:581)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@1934519451-37-selector-ClientSelectorManager@14a61465/5" prio=5
tid=37 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@1601730096-174-selector-ClientSelectorManager@79109fdd/1" prio=5
tid=174 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@896759592-186" prio=5 tid=186 timed_waiting
java.lang.Thread.State: TIMED_WAITING
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2082)
at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:389)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:522)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$700(QueuedThreadPool.java:47)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:581)
at java.lang.Thread.run(Thread.java:745)
"HttpClient@1290173470-91-selector-ClientSelectorManager@785c9e4e/7" prio=5
tid=91 runnable
java.lang.Thread.State: RUNNABLE
at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
at sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
at sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:79)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:87)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:98)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:102)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546)
at java.lang.Thread.run(Thread.java:745)
at org.apache.htrace.util.TestUtil.waitFor(TestUtil.java:95)
at
org.apache.htrace.impl.TestHTracedReceiver.waitForSpans(TestHTracedReceiver.java:90)
at
org.apache.htrace.impl.TestHTracedReceiver.waitForSpans(TestHTracedReceiver.java:79)
at
org.apache.htrace.impl.TestHTracedReceiver.testRestRetryAfterFlushError(TestHTracedReceiver.java:566)
testFullBufferCausesRestThreadTrigger(org.apache.htrace.impl.TestHTracedReceiver)
Time elapsed: 60.005 sec <<< ERROR!
java.lang.Exception: test timed out after 60000 milliseconds
at java.lang.Thread.sleep(Native Method)
at
org.apache.htrace.impl.HTracedSpanReceiver.receiveSpan(HTracedSpanReceiver.java:160)
at
org.apache.htrace.impl.TestHTracedReceiver.testFullBufferCausesRestThreadTrigger(TestHTracedReceiver.java:339)
Running org.apache.htrace.impl.TestPackedBuffer
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec - in
org.apache.htrace.impl.TestPackedBuffer
Running org.apache.htrace.impl.TestHTracedReceiverConf
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec - in
org.apache.htrace.impl.TestHTracedReceiverConf
Results :
Tests in error:
TestHTracedReceiver.testFullBufferCausesRestThreadTrigger:339 ? test timed
ou...
TestHTracedReceiver.testMultipleRestFlushes:508->waitForSpans:90 ? test
timed...
TestHTracedReceiver.testRestRetryAfterFlushError:566->waitForSpans:79->waitForSpans:90
? Timeout
TestHTracedReceiver.testSendSpansViaRest:205->waitForSpans:79->waitForSpans:90
? Timeout
TestHTracedReceiver.testSendSpansViaRestAndClose:234->waitForSpans:79->waitForSpans:90
? Timeout
Tests run: 19, Failures: 0, Errors: 5, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Apache HTrace ..................................... SUCCESS [1:56.350s]
[INFO] htrace-c .......................................... SUCCESS [8.350s]
[INFO] htrace-core4 ...................................... SUCCESS [35.825s]
[INFO] htrace-webapp ..................................... SUCCESS [6.148s]
[INFO] htrace-zipkin ..................................... SUCCESS [30.101s]
[INFO] htrace-hbase ...................................... SUCCESS [47.198s]
[INFO] htrace-flume ...................................... SUCCESS [26.506s]
[INFO] htrace-htraced .................................... FAILURE [6:06.431s]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 10:37.344s
[INFO] Finished at: Mon Oct 12 20:50:53 UTC 2015
[INFO] Final Memory: 68M/1193M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal
org.apache.maven.plugins:maven-surefire-plugin:2.18.1:test (default-test) on
project htrace-htraced: There are test failures.
[ERROR]
[ERROR] Please refer to /htrace/htrace-htraced/target/surefire-reports for the
individual test results.
[ERROR] -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e
switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please
read the following articles:
[ERROR] [Help 1]
http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :htrace-htraced
Build step 'Execute shell' marked build as failure
[FINDBUGS] Skipping publisher since build result is FAILURE
Performing Post build task...
Match found for :.* : True
Logical operation result is TRUE
Running script :
[HTrace-Master] $ /bin/bash -xe /tmp/hudson8431287185758914973.sh
POST BUILD TASK : SUCCESS
END OF POST BUILD TASK : 0
Archiving artifacts
Recording test results
Updating HTRACE-237
