[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14934831#comment-14934831
]
Hudson commented on HBASE-14430:
FAILURE: Integrated in HBase-TRUNK #6850 (See
[https://builds.apache.org/job/HBase-TRUNK/6850/])
HBASE-14430 TestHttpServerLifecycle#testStartedServerIsAlive times out (stack:
rev 6ad6273ddaedb7a3a21ef391d4381c19a474e3b3)
*
hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>Assignee: stack
> Fix For: 2.0.0, 1.2.0, 1.3.0
>
> Attachments: 14430.txt
>
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
>
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14934786#comment-14934786
]
Hudson commented on HBASE-14430:
FAILURE: Integrated in HBase-1.2 #206 (See
[https://builds.apache.org/job/HBase-1.2/206/])
HBASE-14430 TestHttpServerLifecycle#testStartedServerIsAlive times out (stack:
rev 527a2106131c04b0282bed15106869e40036a46d)
*
hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>Assignee: stack
> Fix For: 2.0.0, 1.2.0, 1.3.0
>
> Attachments: 14430.txt
>
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14934790#comment-14934790
]
Hudson commented on HBASE-14430:
FAILURE: Integrated in HBase-1.3 #212 (See
[https://builds.apache.org/job/HBase-1.3/212/])
HBASE-14430 TestHttpServerLifecycle#testStartedServerIsAlive times out (stack:
rev 642273bc2a5a415eba6f1592a439a6b2b53a70a9)
*
hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>Assignee: stack
> Fix For: 2.0.0, 1.2.0, 1.3.0
>
> Attachments: 14430.txt
>
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14934882#comment-14934882
]
Hudson commented on HBASE-14430:
FAILURE: Integrated in HBase-1.2-IT #173 (See
[https://builds.apache.org/job/HBase-1.2-IT/173/])
HBASE-14430 TestHttpServerLifecycle#testStartedServerIsAlive times out (stack:
rev 527a2106131c04b0282bed15106869e40036a46d)
*
hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>Assignee: stack
> Fix For: 2.0.0, 1.2.0, 1.3.0
>
> Attachments: 14430.txt
>
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
>
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14934873#comment-14934873
]
Hudson commented on HBASE-14430:
SUCCESS: Integrated in HBase-1.3-IT #189 (See
[https://builds.apache.org/job/HBase-1.3-IT/189/])
HBASE-14430 TestHttpServerLifecycle#testStartedServerIsAlive times out (stack:
rev 642273bc2a5a415eba6f1592a439a6b2b53a70a9)
*
hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>Assignee: stack
> Fix For: 2.0.0, 1.2.0, 1.3.0
>
> Attachments: 14430.txt
>
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
>
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14934608#comment-14934608
]
stack commented on HBASE-14430:
---
I made HBASE-14505 to get these tests reeenabled.
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
> Attachments: 14430.txt
>
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,490 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
>
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14934603#comment-14934603
]
stack commented on HBASE-14430:
---
This test came in when we brought httpserver local.
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,490 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14934602#comment-14934602
]
stack commented on HBASE-14430:
---
Tests run: 6, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 61.573 sec <<<
FAILURE! - in org.apache.hadoop.hbase.http.TestHttpServerLifecycle
testStartedServerIsAlive(org.apache.hadoop.hbase.http.TestHttpServerLifecycle)
Time elapsed: 60.033 sec <<< ERROR!
org.junit.runners.model.TestTimedOutException: test timed out after 6
milliseconds
at
org.mortbay.io.nio.SelectorManager$SelectSet.stop(SelectorManager.java:879)
at org.mortbay.io.nio.SelectorManager.doStop(SelectorManager.java:240)
at
org.mortbay.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:76)
at
org.mortbay.jetty.nio.SelectChannelConnector.close(SelectChannelConnector.java:136)
at org.apache.hadoop.hbase.http.HttpServer.stop(HttpServer.java:1041)
at
org.apache.hadoop.hbase.http.HttpServerFunctionalTest.stop(HttpServerFunctionalTest.java:195)
at
org.apache.hadoop.hbase.http.TestHttpServerLifecycle.testStartedServerIsAlive(TestHttpServerLifecycle.java:73)
https://bugs.eclipse.org/bugs/show_bug.cgi?id=387446 talks of a deadlock in
Jetty in stop (though HW is windows). Goes on in this issue:
https://bugs.eclipse.org/bugs/show_bug.cgi?id=357318 There is talk of a JVM bug
and then workarounds in jetty 7. Am going to disable this. Can reenalbe when
up on jetty 9 or something.
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test]
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14934277#comment-14934277
]
stack commented on HBASE-14430:
---
I just noticed that this test is failing on apache too... its just that it
passes on second run through:
Flaked tests:
org.apache.hadoop.hbase.http.TestHttpServerLifecycle.testStartedServerIsAlive(org.apache.hadoop.hbase.http.TestHttpServerLifecycle)
Run 1:
TestHttpServerLifecycle.testStartedServerIsAlive:73->HttpServerFunctionalTest.stop:195
» TestTimedOut
Run 2: PASS
I don't have this facility turned on on my local rig.
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14904952#comment-14904952
]
stack commented on HBASE-14430:
---
I want to comment out this test. It just keeps failing on rig other than apache:
Tests in error:
TestHttpServerLifecycle.testStoppedServerIsNotAlive:97->HttpServerFunctionalTest.stop:195
» TestTimedOut
Tests in error:
TestHttpServerLifecycle.testStoppedServerIsNotAlive:97->HttpServerFunctionalTest.stop:195
» TestTimedOut
Let me catch it failing on apache jenkins, then I'll undo it.
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,489 INFO
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14904953#comment-14904953
]
stack commented on HBASE-14430:
---
Now I have this:
{code}
diff --git
a/hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
b/hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
index de290e3..2e0748d 100644
---
a/hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
+++
b/hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
@@ -21,6 +21,7 @@ import org.apache.hadoop.hbase.testclassification.MiscTests;
import org.apache.hadoop.hbase.testclassification.SmallTests;
import org.apache.log4j.Logger;
import org.junit.Test;
+import org.junit.Ignore;
import org.junit.experimental.categories.Category;
@Category({MiscTests.class, SmallTests.class})
@@ -63,7 +64,7 @@ public class TestHttpServerLifecycle extends
HttpServerFunctionalTest {
*
* @throws Throwable on failure
*/
- @Test(timeout=6)
+ @Ignore @Test(timeout=6)
public void testStartedServerIsAlive() throws Throwable {
HttpServer server = null;
server = createTestServer();
@@ -89,7 +90,7 @@ public class TestHttpServerLifecycle extends
HttpServerFunctionalTest {
*
* @throws Throwable on failure
*/
- @Test(timeout=6)
+ @Ignore ("Fails on occasion on non-apache rigs") @Test(timeout=6)
public void testStoppedServerIsNotAlive() throws Throwable {
HttpServer server = createAndStartTestServer();
assertAlive(server);
{code}
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14905060#comment-14905060
]
stack commented on HBASE-14430:
---
I need to turn off even more
Tests in error:
TestHttpServerLifecycle.testStoppingTwiceServerIsAllowed:110->HttpServerFunctionalTest.stop:195
» TestTimedOut
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,490 INFO [Time-limited test] http.HttpServer(821): Added
> global
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14803160#comment-14803160
]
stack commented on HBASE-14430:
---
My master builds all passed last night but I had this in place:
{code}
diff --git
a/hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
b/hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
index de290e3..c28d50a 100644
---
a/hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
+++
b/hbase-server/src/test/java/org/apache/hadoop/hbase/http/TestHttpServerLifecycle.java
@@ -21,6 +21,7 @@ import org.apache.hadoop.hbase.testclassification.MiscTests;
import org.apache.hadoop.hbase.testclassification.SmallTests;
import org.apache.log4j.Logger;
import org.junit.Test;
+import org.junit.Ignore;
import org.junit.experimental.categories.Category;
@Category({MiscTests.class, SmallTests.class})
@@ -63,7 +64,7 @@ public class TestHttpServerLifecycle extends
HttpServerFunctionalTest {
*
* @throws Throwable on failure
*/
- @Test(timeout=6)
+ @Ignore @Test(timeout=6)
public void testStartedServerIsAlive() throws Throwable {
HttpServer server = null;
server = createTestServer();
{code}
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test]
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14803299#comment-14803299
]
stack commented on HBASE-14430:
---
Just got this too on my test rig:
TestHttpServerLifecycle.testStoppedServerIsNotAlive:97->HttpServerFunctionalTest.stop:195
» TestTimedOut
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,490 INFO [Time-limited test] http.HttpServer(821): Added
> global filter
[jira] [Commented] (HBASE-14430) TestHttpServerLifecycle#testStartedServerIsAlive times out
[
https://issues.apache.org/jira/browse/HBASE-14430?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=14745487#comment-14745487
]
stack commented on HBASE-14430:
---
This happens a bunch for me on test rig but its history up in apache jenkins is
a long line of successful passes.
> TestHttpServerLifecycle#testStartedServerIsAlive times out
> --
>
> Key: HBASE-14430
> URL: https://issues.apache.org/jira/browse/HBASE-14430
> Project: HBase
> Issue Type: Sub-task
> Components: test
>Reporter: stack
>
> Running on my test rig, I see this test timeout from time to time. It just
> hangs after jetty setup. Port clash?
> {code}
> 2015-09-14 09:08:54,474 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=4,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Availabl
> 2015-09-14 09:08:54,592 INFO [Time-limited test] log.Slf4jLog(67): Logging
> to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2015-09-14 09:08:54,911 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:54,923 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:54,924 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:54,985 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testCreatedServerIsNotAlive Thread=5 (was 4)
> Potentially hanging thread: process reaper
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:226)
>
> java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
>
> java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:359)
> java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:942)
>
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
>
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
>
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> java.lang.Thread.run(Thread.java:745)
> - Thread LEAK? -, OpenFileDescriptor=192 (was 192), MaxFileDescriptor=32768
> (was 32768), SystemLoadAverage=122 (was 122), ProcessCount=507 (was 507),
> AvailableMemoryMB=28014 (was 28054)
> 2015-09-14 09:08:55,013 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5,
> OpenFileDescriptor=192, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, Ava
> 2015-09-14 09:08:55,088 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,089 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,090 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
> (class=org.apache.hadoop.hbase.http.ClickjackingPreventionFilter)
> 2015-09-14 09:08:55,113 INFO [Time-limited test] http.HttpServer(1013):
> Jetty bound to port 60242
> 2015-09-14 09:08:55,113 INFO [Time-limited test] log.Slf4jLog(67):
> jetty-6.1.26
> 2015-09-14 09:08:55,263 INFO [Time-limited test] log.Slf4jLog(67): Started
> SelectChannelConnector@localhost:60242
> 2015-09-14 09:08:55,270 INFO [Time-limited test] log.Slf4jLog(67): Stopped
> SelectChannelConnector@localhost:0
> 2015-09-14 09:08:55,401 INFO [main] hbase.ResourceChecker(172): after:
> http.TestHttpServerLifecycle#testWepAppContextAfterServerStop Thread=5 (was
> 5), OpenFileDescriptor=197 (was 192) - OpenFileDescriptor LEAK? -,
> MaxFileDescriptor=32768
> 2015-09-14 09:08:55,428 INFO [main] hbase.ResourceChecker(148): before:
> http.TestHttpServerLifecycle#testStopUnstartedServer Thread=5,
> OpenFileDescriptor=197, MaxFileDescriptor=32768, SystemLoadAverage=122,
> ProcessCount=507, AvailableMem
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpRequestLog(69):
> Http request log for http.requests.test is not defined
> 2015-09-14 09:08:55,489 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'safety'
> (class=org.apache.hadoop.hbase.http.HttpServer$QuotingInputFilter)
> 2015-09-14 09:08:55,490 INFO [Time-limited test] http.HttpServer(821): Added
> global filter 'clickjackingprevention'
>
