You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@sling.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2013/03/18 18:41:14 UTC

Build failed in Jenkins: sling-trunk-1.6 #1597

See <https://builds.apache.org/job/sling-trunk-1.6/1597/changes>

Changes:

[bdelacretaz] SLING-2792 - typo in javadoc link, thanks Lukas Eder for your contribution!

------------------------------------------
[...truncated 9705 lines...]
749640 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
749641 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue2 - Stopped job queue queue2
749641 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue16 - Stopped job queue queue16
749641 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue11 - Stopped job queue queue11
749641 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue3 - Stopped job queue queue3
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue4 - Stopped job queue queue4
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue19 - Stopped job queue queue19
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue18 - Stopped job queue queue18
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue1 - Stopped job queue queue1
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue12 - Stopped job queue queue12
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue9 - Stopped job queue queue9
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue7 - Stopped job queue queue7
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue13 - Stopped job queue queue13
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue14 - Stopped job queue queue14
749643 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue8 - Stopped job queue queue8
749644 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue0 - Stopped job queue queue0
749644 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue5 - Stopped job queue queue5
749644 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue15 - Stopped job queue queue15
749644 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue10 - Stopped job queue queue10
749644 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue6 - Stopped job queue queue6
749644 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.queue17 - Stopped job queue queue17
749644 [main] INFO org.apache.sling.event.impl.jobs.ExtendedJobManager - Apache Sling Job Event Handler stopped on instance 4711
754507 [Apache Sling Job Writer] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
754508 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
754508 [main] INFO org.apache.sling.event.impl.jobs.ExtendedJobManager - Apache Sling Job Event Handler started on instance 4711
755507 [Apache Sling Job Background Loader] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
755644 [Apache Sling Job Background Loader] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
758255 [Apache Sling Job Queue <main queue>] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - Starting job queue <main queue>
829135 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-439912146) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:07 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_356] stored at anon/4711/2013/3/18/17/37/sling.test2_356. Requeueing job.
829139 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-439912769) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:08 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_358] stored at anon/4711/2013/3/18/17/37/sling.test2_358. Requeueing job.
829151 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-440103547) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:08 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_362] stored at anon/4711/2013/3/18/17/37/sling.test2_362. Requeueing job.
829158 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-439911730) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:07 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_350] stored at anon/4711/2013/3/18/17/37/sling.test2_350. Requeueing job.
829161 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-440103640) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:08 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_360] stored at anon/4711/2013/3/18/17/37/sling.test2_360. Requeueing job.
829174 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-439911726) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:07 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_352] stored at anon/4711/2013/3/18/17/37/sling.test2_352. Requeueing job.
829180 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-439913924) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:07 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_348] stored at anon/4711/2013/3/18/17/37/sling.test2_348. Requeueing job.
829192 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-440102434) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:09 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_366] stored at anon/4711/2013/3/18/17/37/sling.test2_366. Requeueing job.
829195 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-439912162) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:07 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_354] stored at anon/4711/2013/3/18/17/37/sling.test2_354. Requeueing job.
829218 [pool-2-thread-1] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - No acknowledge received for job org.osgi.service.event.Event(-440102791) [topic=sling/test2, properties=event.topics=sling/test2,event.application=4711,slingevent:created=java.util.GregorianCalendar(Mon Mar 18 17:37:09 UTC 2013),event.job.retrycount=0,event.job.topic=sling/test2,slingevent:eventId=anon/4711/2013/3/18/17/37/sling.test2_364] stored at anon/4711/2013/3/18/17/37/sling.test2_364. Requeueing job.
831721 [Apache Sling Job Writer] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
831721 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
831721 [main] INFO org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.<main queue> - Stopped job queue <main queue>
831721 [main] INFO org.apache.sling.event.impl.jobs.ExtendedJobManager - Apache Sling Job Event Handler stopped on instance 4711
831779 [Apache Sling Job Writer] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
831780 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
831780 [main] INFO org.apache.sling.event.impl.jobs.ExtendedJobManager - Apache Sling Job Event Handler started on instance 4711
832779 [Apache Sling Job Background Loader] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
832788 [Apache Sling Job Background Loader] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
833781 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
833781 [Apache Sling Job Writer] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
833781 [main] INFO org.apache.sling.event.impl.jobs.ExtendedJobManager - Apache Sling Job Event Handler stopped on instance 4711
833782 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
833783 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
833783 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - Shutting down repository...
833790 [main] INFO org.apache.jackrabbit.core.query.lucene.SearchIndex - Index closed: <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/repository/index>
833790 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - shutting down workspace 'default'...
833790 [main] INFO org.apache.jackrabbit.core.observation.ObservationDispatcher - Notification of EventListeners stopped.
833797 [main] INFO org.apache.jackrabbit.core.query.lucene.SearchIndex - Index closed: <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/workspaces/default/index>
833928 [main] INFO org.apache.jackrabbit.core.util.db.DerbyConnectionHelper - Database '<https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/workspaces/default/db'> shutdown.
833928 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - workspace 'default' has been shutdown
833937 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - shutting down workspace 'security'...
833937 [main] INFO org.apache.jackrabbit.core.observation.ObservationDispatcher - Notification of EventListeners stopped.
833942 [main] INFO org.apache.jackrabbit.core.query.lucene.SearchIndex - Index closed: <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/workspaces/security/index>
834021 [main] INFO org.apache.jackrabbit.core.util.db.DerbyConnectionHelper - Database '<https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/workspaces/security/db'> shutdown.
834021 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - workspace 'security' has been shutdown
834132 [main] INFO org.apache.jackrabbit.core.util.db.DerbyConnectionHelper - Database '<https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/version/db'> shutdown.
834141 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - Repository has been shutdown
834141 [main] INFO org.apache.jackrabbit.core.TransientRepository - Transient repository shut down
Tests run: 14, Failures: 4, Errors: 0, Skipped: 0, Time elapsed: 660.452 sec <<< FAILURE!
testCancelJob(org.apache.sling.event.impl.jobs.JobEventHandlerTest)  Time elapsed: 14.613 sec  <<< FAILURE!
java.lang.AssertionError
	at org.junit.Assert.fail(Assert.java:92)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertTrue(Assert.java:54)
	at org.apache.sling.event.impl.jobs.JobEventHandlerTest.testCancelJob(JobEventHandlerTest.java:224)
	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.junit.internal.runners.TestMethod.invoke(TestMethod.java:66)
	at org.jmock.integration.junit4.JMock$1.invoke(JMock.java:37)
	at org.junit.internal.runners.MethodRoadie.runTestMethod(MethodRoadie.java:105)
	at org.junit.internal.runners.MethodRoadie$2.run(MethodRoadie.java:86)
	at org.junit.internal.runners.MethodRoadie.runBeforesThenTestThenAfters(MethodRoadie.java:94)
	at org.junit.internal.runners.MethodRoadie.runTest(MethodRoadie.java:84)
	at org.junit.internal.runners.MethodRoadie.run(MethodRoadie.java:49)
	at org.junit.internal.runners.JUnit4ClassRunner.invokeTestMethod(JUnit4ClassRunner.java:98)
	at org.junit.internal.runners.JUnit4ClassRunner.runMethods(JUnit4ClassRunner.java:61)
	at org.junit.internal.runners.JUnit4ClassRunner$1.run(JUnit4ClassRunner.java:54)
	at org.junit.internal.runners.ClassRoadie.runUnprotected(ClassRoadie.java:34)
	at org.junit.internal.runners.ClassRoadie.runProtected(ClassRoadie.java:44)
	at org.junit.internal.runners.JUnit4ClassRunner.run(JUnit4ClassRunner.java:52)
	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112)
	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.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:115)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)

testStartJobAndReschedule(org.apache.sling.event.impl.jobs.JobEventHandlerTest)  Time elapsed: 15.33 sec  <<< FAILURE!
java.lang.AssertionError: No event received in the given time.
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.sling.event.impl.jobs.JobEventHandlerTest.testStartJobAndReschedule(JobEventHandlerTest.java:296)
	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.junit.internal.runners.TestMethod.invoke(TestMethod.java:66)
	at org.jmock.integration.junit4.JMock$1.invoke(JMock.java:37)
	at org.junit.internal.runners.MethodRoadie.runTestMethod(MethodRoadie.java:105)
	at org.junit.internal.runners.MethodRoadie$2.run(MethodRoadie.java:86)
	at org.junit.internal.runners.MethodRoadie.runBeforesThenTestThenAfters(MethodRoadie.java:94)
	at org.junit.internal.runners.MethodRoadie.runTest(MethodRoadie.java:84)
	at org.junit.internal.runners.MethodRoadie.run(MethodRoadie.java:49)
	at org.junit.internal.runners.JUnit4ClassRunner.invokeTestMethod(JUnit4ClassRunner.java:98)
	at org.junit.internal.runners.JUnit4ClassRunner.runMethods(JUnit4ClassRunner.java:61)
	at org.junit.internal.runners.JUnit4ClassRunner$1.run(JUnit4ClassRunner.java:54)
	at org.junit.internal.runners.ClassRoadie.runUnprotected(ClassRoadie.java:34)
	at org.junit.internal.runners.ClassRoadie.runProtected(ClassRoadie.java:44)
	at org.junit.internal.runners.JUnit4ClassRunner.run(JUnit4ClassRunner.java:52)
	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112)
	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.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:115)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)

testLoad(org.apache.sling.event.impl.jobs.JobEventHandlerTest)  Time elapsed: 8.368 sec  <<< FAILURE!
java.lang.AssertionError: No event received in the given time.
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.sling.event.impl.jobs.JobEventHandlerTest.testLoad(JobEventHandlerTest.java:518)
	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.junit.internal.runners.TestMethod.invoke(TestMethod.java:66)
	at org.jmock.integration.junit4.JMock$1.invoke(JMock.java:37)
	at org.junit.internal.runners.MethodRoadie.runTestMethod(MethodRoadie.java:105)
	at org.junit.internal.runners.MethodRoadie$2.run(MethodRoadie.java:86)
	at org.junit.internal.runners.MethodRoadie.runBeforesThenTestThenAfters(MethodRoadie.java:94)
	at org.junit.internal.runners.MethodRoadie.runTest(MethodRoadie.java:84)
	at org.junit.internal.runners.MethodRoadie.run(MethodRoadie.java:49)
	at org.junit.internal.runners.JUnit4ClassRunner.invokeTestMethod(JUnit4ClassRunner.java:98)
	at org.junit.internal.runners.JUnit4ClassRunner.runMethods(JUnit4ClassRunner.java:61)
	at org.junit.internal.runners.JUnit4ClassRunner$1.run(JUnit4ClassRunner.java:54)
	at org.junit.internal.runners.ClassRoadie.runUnprotected(ClassRoadie.java:34)
	at org.junit.internal.runners.ClassRoadie.runProtected(ClassRoadie.java:44)
	at org.junit.internal.runners.JUnit4ClassRunner.run(JUnit4ClassRunner.java:52)
	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112)
	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.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:115)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)

testRunLocal(org.apache.sling.event.impl.jobs.JobEventHandlerTest)  Time elapsed: 20.248 sec  <<< FAILURE!
java.lang.AssertionError: No event received in the given time.
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.sling.event.impl.jobs.JobEventHandlerTest.testRunLocal(JobEventHandlerTest.java:580)
	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.junit.internal.runners.TestMethod.invoke(TestMethod.java:66)
	at org.jmock.integration.junit4.JMock$1.invoke(JMock.java:37)
	at org.junit.internal.runners.MethodRoadie.runTestMethod(MethodRoadie.java:105)
	at org.junit.internal.runners.MethodRoadie$2.run(MethodRoadie.java:86)
	at org.junit.internal.runners.MethodRoadie.runBeforesThenTestThenAfters(MethodRoadie.java:94)
	at org.junit.internal.runners.MethodRoadie.runTest(MethodRoadie.java:84)
	at org.junit.internal.runners.MethodRoadie.run(MethodRoadie.java:49)
	at org.junit.internal.runners.JUnit4ClassRunner.invokeTestMethod(JUnit4ClassRunner.java:98)
	at org.junit.internal.runners.JUnit4ClassRunner.runMethods(JUnit4ClassRunner.java:61)
	at org.junit.internal.runners.JUnit4ClassRunner$1.run(JUnit4ClassRunner.java:54)
	at org.junit.internal.runners.ClassRoadie.runUnprotected(ClassRoadie.java:34)
	at org.junit.internal.runners.ClassRoadie.runProtected(ClassRoadie.java:44)
	at org.junit.internal.runners.JUnit4ClassRunner.run(JUnit4ClassRunner.java:52)
	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112)
	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.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:115)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)

Running org.apache.sling.event.impl.jobs.RoundRobinQueueTest
836469 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - Starting repository...
836470 [main] INFO org.apache.jackrabbit.core.fs.local.LocalFileSystem - LocalFileSystem initialized at path <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/repository>
836599 [main] INFO org.apache.jackrabbit.core.fs.local.LocalFileSystem - LocalFileSystem initialized at path <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/version>
837011 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - initializing workspace 'default'...
837011 [main] INFO org.apache.jackrabbit.core.fs.local.LocalFileSystem - LocalFileSystem initialized at path <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/workspaces/default>
837869 [main] INFO org.apache.jackrabbit.core.query.lucene.SearchIndex - Index initialized: <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/repository/index> Version: 3
837950 [main] INFO org.apache.jackrabbit.core.query.lucene.SearchIndex - Index initialized: <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/workspaces/default/index> Version: 3
837950 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - workspace 'default' initialized
837951 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - SecurityManager = class org.apache.jackrabbit.core.security.simple.SimpleSecurityManager
837951 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - initializing workspace 'security'...
837951 [main] INFO org.apache.jackrabbit.core.fs.local.LocalFileSystem - LocalFileSystem initialized at path <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/workspaces/security>
841843 [main] INFO org.apache.jackrabbit.core.query.lucene.SearchIndex - Index initialized: <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/bundles/extensions/event/target/repository/workspaces/security/index> Version: 3
841853 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - workspace 'security' initialized
841853 [main] INFO org.apache.jackrabbit.core.security.simple.SimpleSecurityManager - init: using Repository LoginModule configuration for Jackrabbit
841853 [main] INFO org.apache.jackrabbit.core.RepositoryImpl - Repository started (5384ms)
841853 [main] INFO org.apache.jackrabbit.core.TransientRepository - Transient repository initialized
842189 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
842190 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
842328 [Apache Sling Job Writer] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
842329 [main] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
842329 [main] INFO org.apache.sling.event.impl.jobs.ExtendedJobManager - Apache Sling Job Event Handler started on instance 4711
843327 [Apache Sling Job Background Loader] INFO org.apache.jackrabbit.core.TransientRepository - Session opened
843335 [Apache Sling Job Background Loader] INFO org.apache.jackrabbit.core.TransientRepository - Session closed
844377 [Apache Sling Job Queue roundrobintest] INFO org.apache.sling.event.impl.jobs.queues.TopicRoundRobinJobQueue.roundrobintest - Starting job queue roundrobintest
Build timed out (after 150 minutes). Marking the build as failed.

Results :

Sending e-mails to: dev@sling.apache.org
Failed tests:   testCancelJob(org.apache.sling.event.impl.jobs.JobEventHandlerTest)
  testStartJobAndReschedule(org.apache.sling.event.impl.jobs.JobEventHandlerTest): No event received in the given time.
  testLoad(org.apache.sling.event.impl.jobs.JobEventHandlerTest): No event received in the given time.
  testRunLocal(org.apache.sling.event.impl.jobs.JobEventHandlerTest): No event received in the given time.

Tests run: 39, Failures: 4, Errors: 0, Skipped: 0

channel stopped
[locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released

Build failed in Jenkins: sling-trunk-1.6 #1598

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/sling-trunk-1.6/1598/changes>

Changes:

[mykee] SLING-2698 - resource access security service for resource providers without backing ACLs

------------------------------------------
Started by an SCM change
Building remotely on ubuntu1 in workspace <https://builds.apache.org/job/sling-trunk-1.6/ws/>
Updating http://svn.apache.org/repos/asf/sling/trunk
A         bundles/resourceaccesssecurity
A         bundles/resourceaccesssecurity/src
A         bundles/resourceaccesssecurity/src/main
A         bundles/resourceaccesssecurity/src/main/java
A         bundles/resourceaccesssecurity/src/main/java/org
A         bundles/resourceaccesssecurity/src/main/java/org/apache
A         bundles/resourceaccesssecurity/src/main/java/org/apache/sling
A         bundles/resourceaccesssecurity/src/main/java/org/apache/sling/resourceaccesssecurity
A         bundles/resourceaccesssecurity/src/main/java/org/apache/sling/resourceaccesssecurity/impl
A         bundles/resourceaccesssecurity/src/main/java/org/apache/sling/resourceaccesssecurity/impl/ResourceAccessSecurityImpl.java
A         bundles/resourceaccesssecurity/src/main/java/org/apache/sling/resourceaccesssecurity/impl/ResourceAccessGateTracker.java
A         bundles/resourceaccesssecurity/src/main/java/org/apache/sling/resourceaccesssecurity/impl/ResourceAccessGateHandler.java
A         bundles/resourceaccesssecurity/src/main/java/org/apache/sling/resourceaccesssecurity/impl/AccessGateResourceWrapper.java
A         bundles/resourceaccesssecurity/src/main/java/org/apache/sling/resourceaccesssecurity/ResourceAccessGate.java
A         bundles/resourceaccesssecurity/pom.xml
A         bundles/resourceaccesssecurity/README.txt
D         bundles/api/src/main/java/org/apache/sling/api/resource/ResourceAccessGate.java
D         bundles/api/src/main/java/org/apache/sling/api/resource/AccessGateException.java
A         bundles/api/src/main/java/org/apache/sling/api/resource/ResourceAccessSecurity.java
A         bundles/api/src/main/java/org/apache/sling/api/resource/AccessSecurityException.java
D         bundles/resourceresolver/src/main/java/org/apache/sling/resourceresolver/accessgate
At revision 1457984
[locks-and-latches] Checking to see if we really have the locks
[locks-and-latches] Have all the locks, build can start
Parsing POMs
Modules changed, recalculating dependency graph
[trunk] $ /home/hudson/tools/java/latest1.6/bin/java -Xmx512M -XX:MaxPermSize=256M -enableassertions -cp /home/jenkins/jenkins-slave/maven3-agent.jar:/home/hudson/tools/maven/apache-maven-3.0.4/boot/plexus-classworlds-2.4.jar org.jvnet.hudson.maven3.agent.Maven3Main /home/hudson/tools/maven/apache-maven-3.0.4 /home/jenkins/jenkins-slave/slave.jar /home/jenkins/jenkins-slave/maven3-interceptor.jar 40803
<===[JENKINS REMOTING CAPACITY]===>   channel started
log4j:WARN No appenders could be found for logger (org.apache.commons.beanutils.converters.BooleanConverter).
log4j:WARN Please initialize the log4j system properly.
Executing Maven:  -B -f <https://builds.apache.org/job/sling-trunk-1.6/ws/trunk/pom.xml> -Dmaven.repo.local=/home/jenkins/jenkins-slave/maven-repositories/0 -DobrRepository=false clean install -DHttpTestBase.readyTimeoutSeconds=300 -PwarIntegrationTests
[INFO] Scanning for projects...
[INFO] [locks-and-latches] Releasing all the locks
[locks-and-latches] All the locks released
ERROR: Failed to parse POMs
hudson.remoting.ChannelClosedException: channel is already closed
	at hudson.remoting.Channel.send(Channel.java:494)
	at hudson.remoting.Request.call(Request.java:129)
	at hudson.remoting.Channel.call(Channel.java:672)
	at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:158)
	at sun.proxy.$Proxy39.isAlive(Unknown Source)
	at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:920)
	at hudson.maven.ProcessCache$MavenProcess.call(ProcessCache.java:161)
	at hudson.maven.MavenModuleSetBuild$MavenModuleSetBuildExecution.doRun(MavenModuleSetBuild.java:755)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:592)
	at hudson.model.Run.execute(Run.java:1568)
	at hudson.maven.MavenModuleSetBuild.run(MavenModuleSetBuild.java:477)
	at hudson.model.ResourceController.execute(ResourceController.java:88)
	at hudson.model.Executor.run(Executor.java:236)
Caused by: java.io.IOException
	at hudson.remoting.Channel.close(Channel.java:910)
	at hudson.slaves.ChannelPinger$1.onDead(ChannelPinger.java:110)
	at hudson.remoting.PingThread.ping(PingThread.java:120)
	at hudson.remoting.PingThread.run(PingThread.java:81)
Caused by: java.util.concurrent.TimeoutException: Ping started on 1363644575048 hasn't completed at 1363644815048
	... 2 more
FATAL: channel is already closed
hudson.remoting.ChannelClosedException: channel is already closed
	at hudson.remoting.Channel.send(Channel.java:494)
	at hudson.remoting.Request.call(Request.java:129)
	at hudson.remoting.Channel.call(Channel.java:672)
	at hudson.Launcher$RemoteLauncher.kill(Launcher.java:877)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:615)
	at hudson.model.Run.execute(Run.java:1568)
	at hudson.maven.MavenModuleSetBuild.run(MavenModuleSetBuild.java:477)
	at hudson.model.ResourceController.execute(ResourceController.java:88)
	at hudson.model.Executor.run(Executor.java:236)
Caused by: hudson.remoting.Channel$OrderlyShutdown
	at hudson.remoting.Channel$CloseCommand.execute(Channel.java:850)
	at hudson.remoting.Channel$2.handle(Channel.java:435)
	at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:60)
Caused by: Command close created at
	at hudson.remoting.Command.<init>(Command.java:56)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:844)
	at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:842)
	at hudson.remoting.Channel.close(Channel.java:909)
	at hudson.remoting.Channel.close(Channel.java:892)
	at hudson.remoting.Channel$CloseCommand.execute(Channel.java:849)
	... 2 more