See <http://hudson.zones.apache.org/hudson/job/ESME/210/>
------------------------------------------ [...truncated 441 lines...] INFO - Service request (POST) /api2/user/followees took 1 Milliseconds INFO - Service request (GET) /api2/user/followers took 7 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (GET) /api2/user/followers took 1 Milliseconds INFO - Service request (GET) /api2/user/tracks took 10 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (GET) /api2/user/tracks took 1 Milliseconds INFO - Service request (POST) /api2/user/tracks took 10 Milliseconds INFO - Service request (POST) /api2/session took 5 Milliseconds INFO - Service request (POST) /api2/user/tracks took 1 Milliseconds INFO - Service request (POST) /api2/user/tracks took 4 Milliseconds INFO - Service request (DELETE) /api2/user/tracks/2 took 23 Milliseconds INFO - Service request (POST) /api2/session took 6 Milliseconds INFO - Service request (DELETE) /api2/user/tracks/1 took 2 Milliseconds INFO - Service request (GET) /api2/user/actions took 14 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (GET) /api2/user/actions took 1 Milliseconds INFO - Modified query: Array(Cmp(,=,Full(url:VJJETO4L4GFNZZ2Z),Empty,Empty), OrderBy(-1,Descending), MaxRows(1)) INFO - Request /api2/user/actions took 59 query INFO - Service request (POST) /api2/user/actions took 61 Milliseconds INFO - Service request (POST) /api2/session took 10 Milliseconds INFO - Service request (POST) /api2/user/actions took 1 Milliseconds INFO - Modified query: Array(Cmp(,=,Full(url:VJJETO4L4GFNZZ2Z),Empty,Empty), OrderBy(-1,Descending), MaxRows(1)) INFO - Service request (POST) /api2/user/actions took 14 Milliseconds INFO - Request /api2/user/actions/2 took 116 query INFO - Service request (DELETE) /api2/user/actions/2 took 117 Milliseconds INFO - Service request (POST) /api2/session took 5 Milliseconds INFO - Service request (DELETE) /api2/user/actions/1 took 1 Milliseconds INFO - Service request (POST) /api2/user/messages took 2 Milliseconds WARN - Cookie rejected: "$Version=0; _icl_current_language=en; $Path=/; $Domain=.blog.com". Illegal domain attribute ".blog.com". Domain of origin: "blog.com" WARN - Cookie rejected: "$Version=0; _icl_current_language=en; $Path=/; $Domain=.blog.com". Illegal domain attribute ".blog.com". Domain of origin: "blog.com" INFO - Service request (POST) /api2/user/messages took 2 Milliseconds INFO - Modified query: Array(Cmp(NULL,=,Full(9),Empty,Empty)) INFO - Modified query: Array(Cmp(NULL,=,Full(9),Empty,Empty), OrderBy(-1,Ascending)) INFO - Service request (GET) /api2/conversations/9 took 18 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (GET) /api2/conversations/1 took 1 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Modified query: Array(Cmp(NULL,=,Full(10000),Empty,Empty), OrderBy(-1,Ascending)) INFO - Service request (GET) /api2/conversations/10000 took 9 Milliseconds INFO - Service request (GET) /api2/pools took 14 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (GET) /api2/pools took 1 Milliseconds INFO - Service request (POST) /api2/pools took 6 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (POST) /api2/pools took 1 Milliseconds INFO - Service request (POST) /api2/pools took 8 Milliseconds INFO - Service request (POST) /api2/pools/3/users took 27 Milliseconds INFO - Service request (POST) /api2/session took 5 Milliseconds INFO - Service request (POST) /api2/pools/1/users took 2 Milliseconds INFO - Service request (POST) /api2/pools took 7 Milliseconds INFO - Service request (GET) /api2/pools/4/messages took 8 Milliseconds INFO - Service request (POST) /api2/user/messages took 3 Milliseconds INFO - Service request (GET) /api2/pools/4/messages took 6 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (GET) /api2/pools/1/messages took 3 Milliseconds INFO - Service request (POST) /api2/session took 5 Milliseconds INFO - Service request (GET) /api2/pools/1/messages took 2 Milliseconds INFO - Service request (GET) /api2/pools/1/messages took 3 Milliseconds INFO - Service request (POST) /api2/pools took 6 Milliseconds INFO - Service request (POST) /api2/user/messages took 3 Milliseconds INFO - Modified query: Array(InRaw(-1,17,IHaveValidatedThisSQL(dpp,Aug 25, 2008))) INFO - Request /api2/pools/5/messages took 199 query INFO - Service request (GET) /api2/pools/5/messages took 200 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (POST) /api2/pools took 6 Milliseconds INFO - Service request (POST) /api2/user/messages took 2 Milliseconds INFO - Service request (POST) /api2/user/messages took 5 Milliseconds INFO - Service request (POST) /api2/user/messages took 3 Milliseconds INFO - Service request (POST) /api2/user/messages took 3 Milliseconds INFO - Modified query: Array(InRaw(-1,20,19,IHaveValidatedThisSQL(dpp,Aug 25, 2008))) INFO - Service request (GET) /api2/pools/6/messages took 37 Milliseconds INFO - Service request (GET) /api2/pools/6/messages took 7 Milliseconds INFO - Service request (POST) /api2/session took 5 Milliseconds INFO - Service request (GET) /api2/pools/1/messages took 3 Milliseconds INFO - Service request (POST) /api2/pools took 3 Milliseconds INFO - Service request (GET) /api2/pool/6/messages took 16 Milliseconds INFO - Service request (POST) /api2/user/messages took 3 Milliseconds INFO - Service request (GET) /api2/pools/6/messages took 23 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (POST) /api2/pools took 5 Milliseconds INFO - Service request (GET) /api2/pools/7/messages took 1 Milliseconds INFO - Service request (POST) /api2/user/messages took 3 Milliseconds INFO - Service request (GET) /api2/pools/7/messages took 2 Milliseconds INFO - Service request (POST) /api2/session took 5 Milliseconds INFO - Service request (GET) /api2/pools/1/messages took 3 Milliseconds INFO - Service request (POST) /api2/session took 4 Milliseconds INFO - Service request (GET) /api2/pools/1/messages took 2 Milliseconds INFO - Request /api2/pools/1/messages took 2010 query INFO - Service request (GET) /api2/pools/1/messages took 2011 Milliseconds Tests run: 64, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 27.114 sec Running org.apache.esme.actor.PopStatsActorSpecsAsTest Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.056 sec Running org.apache.esme.api.ApiSpecsAsTest INFO - Request Outside HTTP Request (e.g., on Actor) took 287 query INFO - Service request (POST) /api/login took 14 Milliseconds INFO - Service request (GET) /api/status took 3 Milliseconds INFO - Service request (GET) /api/status took 1 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 262 query INFO - Service request (POST) /api/login took 3 Milliseconds INFO - Service request (POST) /api/login took 2 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 297 query INFO - Service request (GET) /api/status took 1 Milliseconds INFO - Service request (POST) /api/login took 132 Milliseconds INFO - Service request (GET) /api/logout took 3 Milliseconds INFO - Service request (GET) /api/status took 1 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 329 query INFO - Service request (POST) /api/login took 6 Milliseconds INFO - Service request (GET) /api/status took 2 Milliseconds INFO - Service request (GET) /api/logout took 2 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 359 query INFO - Service request (GET) /api/logout took 2 Milliseconds INFO - Service request (POST) /api/login took 5 Milliseconds INFO - Service request (GET) /api/logout took 2 Milliseconds INFO - Service request (GET) /api/logout took 1 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 509 query INFO - Service request (POST) /api/login took 6 Milliseconds INFO - Service request (GET) /api/status took 3 Milliseconds INFO - Service request (POST) /api/send_msg took 6 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 210 query INFO - Service request (POST) /api/send_msg took 1 Milliseconds INFO - Service request (POST) /api/login took 5 Milliseconds INFO - Service request (POST) /api/send_msg took 3 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 210 query INFO - Service request (POST) /api/login took 5 Milliseconds INFO - Service request (POST) /api/add_action took 11 Milliseconds INFO - Service request (POST) /api/add_action took 5 Milliseconds INFO - Service request (POST) /api/add_action took 4 Milliseconds INFO - Service request (POST) /api/add_action took 5 Milliseconds INFO - Service request (POST) /api/add_action took 5 Milliseconds INFO - Service request (POST) /api/add_action took 4 Milliseconds INFO - Service request (POST) /api/add_action took 4 Milliseconds INFO - Service request (POST) /api/add_action took 5 Milliseconds INFO - Service request (POST) /api/add_action took 4 Milliseconds INFO - Service request (POST) /api/add_action took 5 Milliseconds INFO - Service request (POST) /api/add_action took 5 Milliseconds INFO - Service request (POST) /api/add_action took 10 Milliseconds INFO - Modified query: Array(Cmp(,=,Full(url:RETYLBO4D4TUWAH4),Empty,Empty), OrderBy(-1,Descending), MaxRows(1)) INFO - Service request (POST) /api/add_action took 9 Milliseconds INFO - Modified query: Array(Cmp(,=,Full(url:VJJETO4L4GFNZZ2Z),Empty,Empty), OrderBy(-1,Descending), MaxRows(1)) INFO - Service request (POST) /api/add_action took 10 Milliseconds INFO - Modified query: Array(Cmp(,=,Full(url:VJJETO4L4GFNZZ2Z),Empty,Empty), OrderBy(-1,Descending), MaxRows(1)) INFO - Service request (POST) /api/add_action took 15 Milliseconds INFO - Modified query: Array(Cmp(,=,Full(url:VJJETO4L4GFNZZ2Z),Empty,Empty), OrderBy(-1,Descending), MaxRows(1)) INFO - Service request (POST) /api/add_action took 12 Milliseconds INFO - Service request (POST) /api/add_pool/ttt took 7 Milliseconds INFO - Modified query: Array(Cmp(,=,Full(url:VJJETO4L4GFNZZ2Z),Empty,Empty), OrderBy(-1,Descending), MaxRows(1)) INFO - Service request (POST) /api/add_action took 10 Milliseconds INFO - Modified query: Array(Cmp(,=,Full(url:VJJETO4L4GFNZZ2Z),Empty,Empty), OrderBy(-1,Descending), MaxRows(1)) INFO - Service request (POST) /api/add_action took 9 Milliseconds WARN - Cookie rejected: "$Version=0; _icl_current_language=en; $Path=/; $Domain=.blog.com". Illegal domain attribute ".blog.com". Domain of origin: "blog.com" INFO - Request Outside HTTP Request (e.g., on Actor) took 424 query INFO - Service request (POST) /api/add_action took 1 Milliseconds INFO - Service request (POST) /api/login took 4 Milliseconds INFO - Service request (POST) /api/add_action took 2 Milliseconds INFO - Service request (POST) /api/add_action took 2 Milliseconds INFO - Service request (POST) /api/add_action took 2 Milliseconds INFO - Service request (POST) /api/add_action took 3 Milliseconds INFO - Service request (POST) /api/add_action took 3 Milliseconds INFO - Service request (POST) /api/add_action took 3 Milliseconds INFO - Service request (POST) /api/add_action took 3 Milliseconds INFO - Service request (POST) /api/add_action took 3 Milliseconds INFO - Service request (POST) /api/add_action took 5 Milliseconds INFO - Service request (POST) /api/add_action took 2 Milliseconds INFO - Service request (POST) /api/add_action took 3 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 324 query INFO - Service request (POST) /api/send_msg took 5 Milliseconds <esme_api success="true"><xml:group></xml:group></esme_api> INFO - Request Outside HTTP Request (e.g., on Actor) took 400 query INFO - Service request (POST) /api/login took 6 Milliseconds INFO - Service request (POST) /api/add_pool/ttt87 took 5 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 238 query INFO - Service request (POST) /api/add_pool/ttt8787 took 2 Milliseconds INFO - Service request (POST) /api/login took 8 Milliseconds INFO - Service request (POST) /api/add_pool took 1 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 576 query INFO - Service request (POST) /api/send_msg took 1 Milliseconds INFO - Request Outside HTTP Request (e.g., on Actor) took 292 query INFO - Service request (POST) /api/send_msg took 2 Milliseconds <esme_api msg="message parameter is missing" success="false"><xml:group></xml:group></esme_api> Tests run: 14, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.707 sec Results : Tests run: 102, Failures: 0, Errors: 0, Skipped: 0 [HUDSON] Recording test results [INFO] [war:war] [INFO] Packaging webapp [INFO] Assembling webapp[esme-server] in [<http://hudson.zones.apache.org/hudson/job/ESME/ws/server/target/esme-server-apache-esme-1.0-RC1-incubating]> [INFO] Processing war project [INFO] Webapp assembled in[6304 msecs] [INFO] Building war: <http://hudson.zones.apache.org/hudson/job/ESME/ws/server/target/esme-server-apache-esme-1.0-RC1-incubating.war> [INFO] [install:install] [INFO] Installing <http://hudson.zones.apache.org/hudson/job/ESME/ws/server/target/esme-server-apache-esme-1.0-RC1-incubating.war> to /export/home/hudson/.m2/repository/org/apache/esme/esme-server/apache-esme-1.0-RC1-incubating/esme-server-apache-esme-1.0-RC1-incubating.war [HUDSON] Archiving <http://hudson.zones.apache.org/hudson/job/ESME/ws/server/pom.xml> to /export/home/hudson/hudson/jobs/ESME/modules/org.apache.esme$esme-server/builds/2010-05-02_12-11-31/archive/org.apache.esme/esme-server/apache-esme-1.0-RC1-incubating/pom.xml [HUDSON] Archiving <http://hudson.zones.apache.org/hudson/job/ESME/ws/server/target/esme-server-apache-esme-1.0-RC1-incubating.war> to /export/home/hudson/hudson/jobs/ESME/modules/org.apache.esme$esme-server/builds/2010-05-02_12-11-31/archive/org.apache.esme/esme-server/apache-esme-1.0-RC1-incubating/esme-server-apache-esme-1.0-RC1-incubating.war Build timed out. Aborting channel stopped [INFO] ------------------------------------------------------------------------ [ERROR] FATAL ERROR [INFO] ------------------------------------------------------------------------ [INFO] null channel is already closed [INFO] ------------------------------------------------------------------------ [INFO] Trace java.lang.reflect.UndeclaredThrowableException at $Proxy2.isArchivingDisabled(Unknown Source) at hudson.maven.MavenBuildProxy$Filter.isArchivingDisabled(MavenBuildProxy.java:210) at hudson.maven.reporters.MavenArtifact.archive(MavenArtifact.java:192) at hudson.maven.reporters.MavenArtifactArchiver.postBuild(MavenArtifactArchiver.java:109) at hudson.maven.MavenModuleSetBuild$Builder.postModule(MavenModuleSetBuild.java:721) at hudson.maven.MavenBuilder$Adapter.fireLeaveModule(MavenBuilder.java:304) at hudson.maven.MavenBuilder$Adapter.postBuild(MavenBuilder.java:262) at org.apache.maven.lifecycle.LifecycleExecutorInterceptor.execute(LifecycleExecutorInterceptor.java:68) at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:336) at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:129) at org.apache.maven.cli.MavenCli.main(MavenCli.java:287) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at org.codehaus.classworlds.Launcher.launchEnhanced(Launcher.java:315) at org.codehaus.classworlds.Launcher.launch(Launcher.java:255) at hudson.maven.agent.Main.launch(Main.java:165) at hudson.maven.MavenBuilder.call(MavenBuilder.java:159) at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:688) at hudson.maven.MavenModuleSetBuild$Builder.call(MavenModuleSetBuild.java:632) at hudson.remoting.UserRequest.perform(UserRequest.java:114) at hudson.remoting.UserRequest.perform(UserRequest.java:48) at hudson.remoting.Request$2.run(Request.java:270) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441) at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303) at java.util.concurrent.FutureTask.run(FutureTask.java:138) at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907) at java.lang.Thread.run(Thread.java:619) Caused by: hudson.remoting.ChannelClosedException: channel is already closed at hudson.remoting.Channel.send(Channel.java:412) at hudson.remoting.Request.call(Request.java:105) at hudson.remoting.Channel.call(Channel.java:551) at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:158) ... 30 more [INFO] ------------------------------------------------------------------------ [INFO] Total time: 44 minutes 6 seconds [INFO] Finished at: Sun May 02 12:56:53 GMT+00:00 2010 [INFO] Final Memory: 34M/218M [INFO] ------------------------------------------------------------------------
