You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@hbase.apache.org by Gaojinchao <ga...@huawei.com> on 2011/05/06 04:47:01 UTC

A question about unit test

A test case was timeout. 

Who has the experience for this. 
Thanks

   <message priority="info"><![CDATA[[exec] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.101 sec]]></message>
                <message priority="info"><![CDATA[[exec] Running org.apache.hadoop.hbase.TestInfoServers]]></message>
                <message priority="info"><![CDATA[[exec] killed.]]></message>
                <message priority="info"><![CDATA[[exec] [INFO] ------------------------------------------------------------------------]]></message>
                <message priority="info"><![CDATA[[exec] [INFO] BUILD FAILURE]]></message>
                <message priority="info"><![CDATA[[exec] [INFO] ------------------------------------------------------------------------]]></message>
                <message priority="info"><![CDATA[[exec] [INFO] Total time: 1:15:10.277s]]></message>
                <message priority="info"><![CDATA[[exec] [INFO] Finished at: Fri May 06 04:52:47 GMT+08:00 2011]]></message>
                <message priority="info"><![CDATA[[exec] [INFO] Final Memory: 53M/949M]]></message>
                <message priority="info"><![CDATA[[exec] [INFO] ------------------------------------------------------------------------]]></message>
                <message priority="info"><![CDATA[[exec] [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.4.3:test (default-test) on project hbase: Error while executing forked tests.; nested exception is org.apache.maven.surefire.booter.shade.org.codehaus.plexus.util.cli.CommandLineException: Error while executing external command, process killed. Process timeout out after 900 seconds -> [Help 1]]]></message>
                <message priority="info"><![CDATA[[exec] [ERROR]]]></message>
                <message priority="info"><![CDATA[[exec] [ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.]]></message>
                <message priority="info"><![CDATA[[exec] [ERROR] Re-run Maven using the -X switch to enable full debug logging.]]></message>
                <message priority="info"><![CDATA[[exec] [ERROR]]]></message>
                <message priority="info"><![CDATA[[exec] [ERROR] For more information about the errors and possible solutions, please read the following articles:]]></message>
                <message priority="info"><![CDATA[[exec] [ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoExecutionException]]></message>
                <message priority="info"><![CDATA[[echo] llt success.]]></message>
                <message priority="info"><![CDATA[llt.report:]]></message>

The log is half 

2011-05-06 04:38:15,466 DEBUG [main-EventThread] zookeeper.ZKUtil(1107): master:56634-0x12fc1e1c2fa0000 Retrieved 54 byte(s) of data from znode /hbase/unassigned/1028785192 and set watcher; region=.META.,,1, server=linux1.site,48768,1304627889113, state=RS_ZK_REGION_OPENING
2011-05-06 04:38:15,466 DEBUG [main-EventThread] master.AssignmentManager(371): Handling transition=RS_ZK_REGION_OPENING, server=linux1.site,48768,13046278891  // The log is half

Re: A question about unit test

Posted by Gaojinchao <ga...@huawei.com>.
Unlucky. It can't reproduce. It happened last night.

It seems some threads for freeze or locking. 



-----邮件原件-----
发件人: Ted Yu [mailto:yuzhihong@gmail.com] 
发送时间: 2011年5月6日 10:59
收件人: user@hbase.apache.org
抄送: Chenjian
主题: Re: A question about unit test

Can you enable -X switch ?
Also, 1 minute into running the test, you can use jstack to see what the
main thread is doing.

On Thu, May 5, 2011 at 7:47 PM, Gaojinchao <ga...@huawei.com> wrote:

> A test case was timeout.
>
> Who has the experience for this.
> Thanks
>
>   <message priority="info"><![CDATA[[exec] Tests run: 3, Failures: 0,
> Errors: 0, Skipped: 0, Time elapsed: 0.101 sec]]></message>
>                <message priority="info"><![CDATA[[exec] Running
> org.apache.hadoop.hbase.TestInfoServers]]></message>
>                <message priority="info"><![CDATA[[exec]
> killed.]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO]
> ------------------------------------------------------------------------]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO] BUILD
> FAILURE]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO]
> ------------------------------------------------------------------------]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO] Total time:
> 1:15:10.277s]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO] Finished at:
> Fri May 06 04:52:47 GMT+08:00 2011]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO] Final
> Memory: 53M/949M]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO]
> ------------------------------------------------------------------------]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] Failed to
> execute goal org.apache.maven.plugins:maven-surefire-plugin:2.4.3:test
> (default-test) on project hbase: Error while executing forked tests.; nested
> exception is
> org.apache.maven.surefire.booter.shade.org.codehaus.plexus.util.cli.CommandLineException:
> Error while executing external command, process killed. Process timeout out
> after 900 seconds -> [Help 1]]]></message>
>                <message priority="info"><![CDATA[[exec]
> [ERROR]]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] To see the
> full stack trace of the errors, re-run Maven with the -e
> switch.]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] Re-run
> Maven using the -X switch to enable full debug logging.]]></message>
>                <message priority="info"><![CDATA[[exec]
> [ERROR]]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] For more
> information about the errors and possible solutions, please read the
> following articles:]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] [Help 1]
> http://cwiki.apache.org/confluence/display/MAVEN/MojoExecutionException]
> ]></message>
>                <message priority="info"><![CDATA[[echo] llt
> success.]]></message>
>                <message priority="info"><![CDATA[llt.report:]]></message>
>
> The log is half
>
> 2011-05-06 04:38:15,466 DEBUG [main-EventThread] zookeeper.ZKUtil(1107):
> master:56634-0x12fc1e1c2fa0000 Retrieved 54 byte(s) of data from znode
> /hbase/unassigned/1028785192 and set watcher; region=.META.,,1,
> server=linux1.site,48768,1304627889113, state=RS_ZK_REGION_OPENING
> 2011-05-06 04:38:15,466 DEBUG [main-EventThread]
> master.AssignmentManager(371): Handling transition=RS_ZK_REGION_OPENING,
> server=linux1.site,48768,13046278891  // The log is half
>

Re: A question about unit test

Posted by Ted Yu <yu...@gmail.com>.
Can you enable -X switch ?
Also, 1 minute into running the test, you can use jstack to see what the
main thread is doing.

On Thu, May 5, 2011 at 7:47 PM, Gaojinchao <ga...@huawei.com> wrote:

> A test case was timeout.
>
> Who has the experience for this.
> Thanks
>
>   <message priority="info"><![CDATA[[exec] Tests run: 3, Failures: 0,
> Errors: 0, Skipped: 0, Time elapsed: 0.101 sec]]></message>
>                <message priority="info"><![CDATA[[exec] Running
> org.apache.hadoop.hbase.TestInfoServers]]></message>
>                <message priority="info"><![CDATA[[exec]
> killed.]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO]
> ------------------------------------------------------------------------]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO] BUILD
> FAILURE]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO]
> ------------------------------------------------------------------------]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO] Total time:
> 1:15:10.277s]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO] Finished at:
> Fri May 06 04:52:47 GMT+08:00 2011]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO] Final
> Memory: 53M/949M]]></message>
>                <message priority="info"><![CDATA[[exec] [INFO]
> ------------------------------------------------------------------------]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] Failed to
> execute goal org.apache.maven.plugins:maven-surefire-plugin:2.4.3:test
> (default-test) on project hbase: Error while executing forked tests.; nested
> exception is
> org.apache.maven.surefire.booter.shade.org.codehaus.plexus.util.cli.CommandLineException:
> Error while executing external command, process killed. Process timeout out
> after 900 seconds -> [Help 1]]]></message>
>                <message priority="info"><![CDATA[[exec]
> [ERROR]]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] To see the
> full stack trace of the errors, re-run Maven with the -e
> switch.]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] Re-run
> Maven using the -X switch to enable full debug logging.]]></message>
>                <message priority="info"><![CDATA[[exec]
> [ERROR]]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] For more
> information about the errors and possible solutions, please read the
> following articles:]]></message>
>                <message priority="info"><![CDATA[[exec] [ERROR] [Help 1]
> http://cwiki.apache.org/confluence/display/MAVEN/MojoExecutionException]
> ]></message>
>                <message priority="info"><![CDATA[[echo] llt
> success.]]></message>
>                <message priority="info"><![CDATA[llt.report:]]></message>
>
> The log is half
>
> 2011-05-06 04:38:15,466 DEBUG [main-EventThread] zookeeper.ZKUtil(1107):
> master:56634-0x12fc1e1c2fa0000 Retrieved 54 byte(s) of data from znode
> /hbase/unassigned/1028785192 and set watcher; region=.META.,,1,
> server=linux1.site,48768,1304627889113, state=RS_ZK_REGION_OPENING
> 2011-05-06 04:38:15,466 DEBUG [main-EventThread]
> master.AssignmentManager(371): Handling transition=RS_ZK_REGION_OPENING,
> server=linux1.site,48768,13046278891  // The log is half
>