See <http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/752/display/redirect?page=changes> Changes: [Arnaud Thimel] Mise à jour de la base de test pour supprimer les codeSpea et ------------------------------------------ [...truncated 1,50 MB...] 2017-12-23 02:58:41,402 WARN Thread[C3P0PooledConnectionPoolManager[identityToken->1hge14e9szrn4e55bawmu|7e9067bb]-HelperThread-#2,5,main] -- caught unexpected Exception while executing posted task. - com.mchange.v2.async.ThreadPoolAsynchronousRunner:223 [C3P0PooledConnectionPoolManager[identityToken->1hge14e9szrn4e55bawmu|7e9067bb]-HelperThread-#2] java.lang.IllegalStateException: Timer already cancelled. at java.util.Timer.sched(Timer.java:397) at java.util.Timer.schedule(Timer.java:193) at com.mchange.v2.resourcepool.BasicResourcePool$ScatteredAcquireTask.run(BasicResourcePool.java:1965) at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:696) 2017-12-23 02:58:41,404 INFO trying to stop postgresql - ru.yandex.qatools.embed.postgresql.PostgresProcess:147 [main] 2017-12-23 02:58:41,422 INFO start AbstractPostgresConfig{storage=Storage{dbDir=<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/postgresql-embed-ba01900a-6ff4-4707-b779-0f22d35d3eff/db-content-ffd1b6ec-c613-48b1-aa21-fea62721c236,> dbName='test', isTmpDir=true}, network=Net{host='127.0.0.1', port=59314}, timeout=Timeout{startupTimeout=15000}, credentials=Credentials{username='sispea_contributeur', password='sa'}, args=[stop], additionalInitDbParams=[]} - de.flapdoodle.embed.process.runtime.Executable:102 [main] 2017-12-23 02:58:42,439 INFO execSuccess: false [kill, 38938] - de.flapdoodle.embed.process.runtime.ProcessControl:231 [main] 2017-12-23 02:58:42,517 INFO Refreshing org.springframework.context.support.GenericApplicationContext@5ddf6ec7: startup date [Sat Dec 23 02:58:42 CET 2017]; root of context hierarchy - org.springframework.context.support.GenericApplicationContext:589 [main] 2017-12-23 02:58:42,564 INFO Loading configuration file (classpath) : <http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/test-classes/sispea-service-test.conf> - org.nuiton.config.ApplicationConfig:2184 [main] 2017-12-23 02:58:42,876 INFO Initializing c3p0 pool... com.mchange.v2.c3p0.ComboPooledDataSource [ acquireIncrement -> 3, acquireRetryAttempts -> 10, acquireRetryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 0, connectionCustomizerClassName -> null, connectionTesterClassName -> com.mchange.v2.c3p0.impl.DefaultConnectionTester, contextClassLoaderSource -> caller, dataSourceName -> 1hge14e9szrn4e55bawmu|3c0b939e, debugUnreturnedConnectionStackTraces -> false, description -> null, driverClass -> org.h2.Driver, extensions -> {}, factoryClassLocation -> null, forceIgnoreUnresolvedTransactions -> false, forceSynchronousCheckins -> false, forceUseNamedDriverClass -> false, identityToken -> 1hge14e9szrn4e55bawmu|3c0b939e, idleConnectionTestPeriod -> 1800, initialPoolSize -> 3, jdbcUrl -> jdbc:h2:<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/test-CommuneTest-testCreateCommune-1513994322566,> maxAdministrativeTaskTime -> 0, maxConnectionAge -> 1800, maxIdleTime -> 600, maxIdleTimeExcessConnections -> 0, maxPoolSize -> 30, maxStatements -> 0, maxStatementsPerConnection -> 0, minPoolSize -> 3, numHelperThreads -> 3, preferredTestQuery -> SELECT 1, privilegeSpawnedThreads -> false, properties -> {user=******, password=******}, propertyCycle -> 0, statementCacheNumDeferredCloseThreads -> 0, testConnectionOnCheckin -> true, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, userOverrides -> {}, usesTraditionalReflectiveProxies -> false ] - com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource:212 [main] 2017-12-23 02:58:42,879 INFO HHH000400: Using dialect: org.hibernate.dialect.H2Dialect - org.hibernate.dialect.Dialect:157 [main] 2017-12-23 02:58:43,293 INFO Using DataSource [com.mchange.v2.c3p0.ComboPooledDataSource[ identityToken -> 1hge14e9szrn4e55bawmu|3c0b939e, dataSourceName -> 1hge14e9szrn4e55bawmu|3c0b939e ]] of Hibernate SessionFactory for HibernateTransactionManager - fr.onema.sispea.serviceng.SispeaHibernateTransactionManager:378 [main] 2017-12-23 02:58:43,726 INFO No TaskScheduler/ScheduledExecutorService bean found for scheduled processing - org.springframework.scheduling.annotation.ScheduledAnnotationBeanPostProcessor:273 [main] 2017-12-23 02:58:43,729 INFO Began transaction (1) for test context [DefaultTestContext@7bdfbf8 testClass = CommuneTest, testInstance = fr.onema.sispea.service.CommuneTest@5c98d548, testMethod = testCreateCommune@CommuneTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@1a040bce testClass = CommuneTest, locations = '{classpath:sispea-service-test-context.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [fr.onema.sispea.serviceng.SispeaHibernateTransactionManager@1f2685cc]; rollback [true] - org.springframework.test.context.transaction.TransactionContext:105 [main] 2017-12-23 02:58:43,729 INFO HHH000397: Using ASTQueryTranslatorFactory - org.hibernate.hql.internal.QueryTranslatorFactoryInitiator:47 [main] 2017-12-23 02:58:43,732 INFO Starting inserts from: /static/01-static.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:43,783 INFO End of static inserts : 89 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:43,785 INFO Starting inserts from: /static/02-address.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:44,858 INFO 10000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:45,790 INFO 20000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:46,275 INFO End of static inserts : 27739 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:46,434 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:46,450 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:46,452 INFO Starting inserts from: /static/03-organism.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:48,046 INFO 10000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:48,835 INFO 20000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:49,686 INFO 30000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:50,470 INFO 40000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:51,384 INFO 50000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:52,200 INFO 60000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:53,035 INFO 70000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:54,027 INFO 80000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:55,371 INFO 90000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:56,002 INFO 100000 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:166 [main] 2017-12-23 02:58:56,192 INFO End of static inserts : 102493 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,545 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,546 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,552 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,553 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,553 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,554 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,556 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,557 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,557 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,557 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,558 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,559 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,559 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,560 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,561 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,563 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,563 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,565 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,566 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,567 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,568 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,568 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,569 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,570 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,570 INFO Starting inserts from: /static/99-sequences.sql - fr.onema.sispea.service.SispeaFixtures:150 [main] 2017-12-23 02:58:57,572 INFO End of static inserts : 6 row(w) inserted - fr.onema.sispea.service.SispeaFixtures:176 [main] 2017-12-23 02:58:57,603 INFO Rolled back transaction for test context [DefaultTestContext@7bdfbf8 testClass = CommuneTest, testInstance = fr.onema.sispea.service.CommuneTest@5c98d548, testMethod = testCreateCommune@CommuneTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@1a040bce testClass = CommuneTest, locations = '{classpath:sispea-service-test-context.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]. - org.springframework.test.context.transaction.TransactionContext:137 [main] 2017-12-23 02:58:57,604 INFO Closing org.springframework.context.support.GenericApplicationContext@5ddf6ec7: startup date [Sat Dec 23 02:58:42 CET 2017]; root of context hierarchy - org.springframework.context.support.GenericApplicationContext:989 [main] 2017-12-23 02:58:58,780 INFO Refreshing org.springframework.context.support.GenericApplicationContext@a1dc661: startup date [Sat Dec 23 02:58:58 CET 2017]; root of context hierarchy - org.springframework.context.support.GenericApplicationContext:589 [main] 2017-12-23 02:58:58,818 INFO Loading configuration file (classpath) : <http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/test-classes/sispea-service-test.conf> - org.nuiton.config.ApplicationConfig:2184 [main] 2017-12-23 02:58:58,821 WARN Starting embedded postgres (cache: <http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/1513991230299-0)> - fr.onema.sispea.SispeaConfiguration:141 [main] 2017-12-23 02:58:59,393 INFO start AbstractPostgresConfig{storage=Storage{dbDir=<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/postgresql-embed-ba01900a-6ff4-4707-b779-0f22d35d3eff/db-content-341919d2-9d85-4648-88fa-4ba1666ef9f7,> dbName='test', isTmpDir=true}, network=Net{host='127.0.0.1', port=40010}, timeout=Timeout{startupTimeout=15000}, credentials=Credentials{username='sispea_contributeur', password='sa'}, args=[], additionalInitDbParams=[-E, UTF-8, --locale=C, --lc-collate=C, --lc-ctype=C]} - de.flapdoodle.embed.process.runtime.Executable:102 [main] 2017-12-23 02:58:59,903 INFO start AbstractPostgresConfig{storage=Storage{dbDir=<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/postgresql-embed-ba01900a-6ff4-4707-b779-0f22d35d3eff/db-content-341919d2-9d85-4648-88fa-4ba1666ef9f7,> dbName='test', isTmpDir=true}, network=Net{host='127.0.0.1', port=40010}, timeout=Timeout{startupTimeout=15000}, credentials=Credentials{username='sispea_contributeur', password='sa'}, args=[test], additionalInitDbParams=[]} - de.flapdoodle.embed.process.runtime.Executable:102 [main] 2017-12-23 02:59:00,118 WARN Could not create database first time (0 of 3 trials) - ru.yandex.qatools.embed.postgresql.PostgresProcess:278 [main] 2017-12-23 02:59:00,289 INFO start AbstractPostgresConfig{storage=Storage{dbDir=<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/postgresql-embed-ba01900a-6ff4-4707-b779-0f22d35d3eff/db-content-341919d2-9d85-4648-88fa-4ba1666ef9f7,> dbName='test', isTmpDir=true}, network=Net{host='127.0.0.1', port=40010}, timeout=Timeout{startupTimeout=15000}, credentials=Credentials{username='sispea_contributeur', password='sa'}, args=[test], additionalInitDbParams=[]} - de.flapdoodle.embed.process.runtime.Executable:102 [main] 2017-12-23 02:59:02,289 INFO start AbstractPostgresConfig{storage=Storage{dbDir=<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/postgresql-embed-ba01900a-6ff4-4707-b779-0f22d35d3eff/db-content-341919d2-9d85-4648-88fa-4ba1666ef9f7,> dbName='test', isTmpDir=true}, network=Net{host='127.0.0.1', port=40010}, timeout=Timeout{startupTimeout=15000}, credentials=Credentials{username='sispea_contributeur', password='sa'}, args=[], additionalInitDbParams=[-E, UTF-8, --locale=C, --lc-collate=C, --lc-ctype=C]} - de.flapdoodle.embed.process.runtime.Executable:102 [main] 2017-12-23 02:59:02,308 INFO start AbstractPostgresConfig{storage=Storage{dbDir=<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/postgresql-embed-ba01900a-6ff4-4707-b779-0f22d35d3eff/db-content-341919d2-9d85-4648-88fa-4ba1666ef9f7,> dbName='test', isTmpDir=true}, network=Net{host='127.0.0.1', port=40010}, timeout=Timeout{startupTimeout=15000}, credentials=Credentials{username='sispea_contributeur', password='sa'}, args=[-U, sispea_contributeur, -d, test, -h, 127.0.0.1, -p, 40010, <http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/test-classes/pg/20171017_sispea-3.2_019-for-tests_sans-donnees-annuelles.dump],> additionalInitDbParams=[]} - de.flapdoodle.embed.process.runtime.Executable:102 [main] 2017-12-23 02:59:05,210 INFO Initializing c3p0 pool... com.mchange.v2.c3p0.ComboPooledDataSource [ acquireIncrement -> 3, acquireRetryAttempts -> 10, acquireRetryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 0, connectionCustomizerClassName -> null, connectionTesterClassName -> com.mchange.v2.c3p0.impl.DefaultConnectionTester, contextClassLoaderSource -> caller, dataSourceName -> 1hge14e9szrn4e55bawmu|fffcde1, debugUnreturnedConnectionStackTraces -> false, description -> null, driverClass -> org.postgresql.Driver, extensions -> {}, factoryClassLocation -> null, forceIgnoreUnresolvedTransactions -> false, forceSynchronousCheckins -> false, forceUseNamedDriverClass -> false, identityToken -> 1hge14e9szrn4e55bawmu|fffcde1, idleConnectionTestPeriod -> 1800, initialPoolSize -> 3, jdbcUrl -> jdbc:postgresql://127.0.0.1:40010/test?user=sispea_contributeur&password=sa, maxAdministrativeTaskTime -> 0, maxConnectionAge -> 1800, maxIdleTime -> 600, maxIdleTimeExcessConnections -> 0, maxPoolSize -> 30, maxStatements -> 0, maxStatementsPerConnection -> 0, minPoolSize -> 3, numHelperThreads -> 3, preferredTestQuery -> SELECT 1, privilegeSpawnedThreads -> false, properties -> {user=******, password=******}, propertyCycle -> 0, statementCacheNumDeferredCloseThreads -> 0, testConnectionOnCheckin -> true, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, userOverrides -> {}, usesTraditionalReflectiveProxies -> false ] - com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource:212 [main] 2017-12-23 02:59:05,217 INFO HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL9Dialect - org.hibernate.dialect.Dialect:157 [main] 2017-12-23 02:59:05,270 INFO HHH000424: Disabling contextual LOB creation as createClob() method threw error : java.lang.reflect.InvocationTargetException - org.hibernate.engine.jdbc.env.internal.LobCreatorBuilderImpl:124 [main] 2017-12-23 02:59:05,270 INFO HHH000270: Type registration [java.util.UUID] overrides previous : org.hibernate.type.UUIDBinaryType@6e9f8160 - org.hibernate.type.BasicTypeRegistry:148 [main] 2017-12-23 02:59:05,606 INFO Using DataSource [com.mchange.v2.c3p0.ComboPooledDataSource[ identityToken -> 1hge14e9szrn4e55bawmu|fffcde1, dataSourceName -> 1hge14e9szrn4e55bawmu|fffcde1 ]] of Hibernate SessionFactory for HibernateTransactionManager - fr.onema.sispea.serviceng.SispeaHibernateTransactionManager:378 [main] 2017-12-23 02:59:06,036 INFO No TaskScheduler/ScheduledExecutorService bean found for scheduled processing - org.springframework.scheduling.annotation.ScheduledAnnotationBeanPostProcessor:273 [main] 2017-12-23 02:59:06,039 INFO Began transaction (1) for test context [DefaultTestContext@7bdfbf8 testClass = CommuneTest, testInstance = fr.onema.sispea.service.CommuneTest@5bd4a058, testMethod = testFindCommune@CommuneTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@1a040bce testClass = CommuneTest, locations = '{classpath:sispea-service-test-context.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [fr.onema.sispea.serviceng.SispeaHibernateTransactionManager@11459b2]; rollback [true] - org.springframework.test.context.transaction.TransactionContext:105 [main] 2017-12-23 02:59:06,045 DEBUG Updating user with login "admin" - fr.onema.sispea.service.user.LegacyUserService:147 [main] 2017-12-23 02:59:06,046 INFO HHH000397: Using ASTQueryTranslatorFactory - org.hibernate.hql.internal.QueryTranslatorFactoryInitiator:47 [main] 2017-12-23 02:59:06,061 INFO Rolled back transaction for test context [DefaultTestContext@7bdfbf8 testClass = CommuneTest, testInstance = fr.onema.sispea.service.CommuneTest@5bd4a058, testMethod = testFindCommune@CommuneTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@1a040bce testClass = CommuneTest, locations = '{classpath:sispea-service-test-context.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]. - org.springframework.test.context.transaction.TransactionContext:137 [main] 2017-12-23 02:59:06,061 INFO Closing org.springframework.context.support.GenericApplicationContext@a1dc661: startup date [Sat Dec 23 02:58:58 CET 2017]; root of context hierarchy - org.springframework.context.support.GenericApplicationContext:989 [main] 2017-12-23 02:59:06,073 INFO trying to stop postgresql - ru.yandex.qatools.embed.postgresql.PostgresProcess:147 [main] 2017-12-23 02:59:06,096 INFO start AbstractPostgresConfig{storage=Storage{dbDir=<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/postgresql-embed-ba01900a-6ff4-4707-b779-0f22d35d3eff/db-content-341919d2-9d85-4648-88fa-4ba1666ef9f7,> dbName='test', isTmpDir=true}, network=Net{host='127.0.0.1', port=40010}, timeout=Timeout{startupTimeout=15000}, credentials=Credentials{username='sispea_contributeur', password='sa'}, args=[stop], additionalInitDbParams=[]} - de.flapdoodle.embed.process.runtime.Executable:102 [main] 2017-12-23 02:59:08,113 INFO execSuccess: false [kill, 39296] - de.flapdoodle.embed.process.runtime.ProcessControl:231 [main] Tests run: 3, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 51.468 sec <<< FAILURE! - in fr.onema.sispea.service.CommuneTest testCountCommunes(fr.onema.sispea.service.CommuneTest) Time elapsed: 10.031 sec <<< ERROR! org.springframework.transaction.CannotCreateTransactionException: Could not open Hibernate Session for transaction; nested exception is org.hibernate.exception.GenericJDBCException: Unable to acquire JDBC Connection Caused by: org.hibernate.exception.GenericJDBCException: Unable to acquire JDBC Connection Caused by: java.sql.SQLException: Connections could not be acquired from the underlying database! Caused by: com.mchange.v2.resourcepool.CannotAcquireResourceException: A ResourcePool could not acquire a resource from its primary factory or source. Caused by: org.postgresql.util.PSQLException: FATAL: database "test" does not exist Running fr.onema.sispea.service.SispeaServiceContextTest 2017-12-23 02:59:08,167 INFO Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [org.springframework.test.context.web.ServletTestExecutionListener, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener, org.springframework.test.context.support.DependencyInjectionTestExecutionListener, org.springframework.test.context.support.DirtiesContextTestExecutionListener, org.springframework.test.context.transaction.TransactionalTestExecutionListener, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener] - org.springframework.test.context.support.DefaultTestContextBootstrapper:257 [main] 2017-12-23 02:59:08,167 INFO Could not instantiate TestExecutionListener [org.springframework.test.context.web.ServletTestExecutionListener]. Specify custom listener classes or make the default listener classes (and their required dependencies) available. Offending class: [javax/servlet/ServletContext] - org.springframework.test.context.support.DefaultTestContextBootstrapper:206 [main] 2017-12-23 02:59:08,167 INFO Using TestExecutionListeners: [org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@7067711e, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@29488049, org.springframework.test.context.support.DirtiesContextTestExecutionListener@141aff8e, org.springframework.test.context.transaction.TransactionalTestExecutionListener@1bd1ca92, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@50f5b777] - org.springframework.test.context.support.DefaultTestContextBootstrapper:184 [main] 2017-12-23 02:59:08,224 INFO Refreshing org.springframework.context.support.GenericApplicationContext@3d523fe8: startup date [Sat Dec 23 02:59:08 CET 2017]; root of context hierarchy - org.springframework.context.support.GenericApplicationContext:589 [main] 2017-12-23 02:59:08,304 INFO Loading configuration file (classpath) : <http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/test-classes/sispea-service-test.conf> - org.nuiton.config.ApplicationConfig:2184 [main] 2017-12-23 02:59:08,641 INFO Initializing c3p0 pool... com.mchange.v2.c3p0.ComboPooledDataSource [ acquireIncrement -> 3, acquireRetryAttempts -> 10, acquireRetryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 0, connectionCustomizerClassName -> null, connectionTesterClassName -> com.mchange.v2.c3p0.impl.DefaultConnectionTester, contextClassLoaderSource -> caller, dataSourceName -> 1hge14e9szrn4e55bawmu|6b790314, debugUnreturnedConnectionStackTraces -> false, description -> null, driverClass -> org.h2.Driver, extensions -> {}, factoryClassLocation -> null, forceIgnoreUnresolvedTransactions -> false, forceSynchronousCheckins -> false, forceUseNamedDriverClass -> false, identityToken -> 1hge14e9szrn4e55bawmu|6b790314, idleConnectionTestPeriod -> 1800, initialPoolSize -> 3, jdbcUrl -> jdbc:h2:<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/test-SispeaServiceContextTest-testContextLoaded-1513994348310,> maxAdministrativeTaskTime -> 0, maxConnectionAge -> 1800, maxIdleTime -> 600, maxIdleTimeExcessConnections -> 0, maxPoolSize -> 30, maxStatements -> 0, maxStatementsPerConnection -> 0, minPoolSize -> 3, numHelperThreads -> 3, preferredTestQuery -> SELECT 1, privilegeSpawnedThreads -> false, properties -> {user=******, password=******}, propertyCycle -> 0, statementCacheNumDeferredCloseThreads -> 0, testConnectionOnCheckin -> true, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, userOverrides -> {}, usesTraditionalReflectiveProxies -> false ] - com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource:212 [main] 2017-12-23 02:59:08,644 INFO HHH000400: Using dialect: org.hibernate.dialect.H2Dialect - org.hibernate.dialect.Dialect:157 [main] 2017-12-23 02:59:09,110 INFO Using DataSource [com.mchange.v2.c3p0.ComboPooledDataSource[ identityToken -> 1hge14e9szrn4e55bawmu|6b790314, dataSourceName -> 1hge14e9szrn4e55bawmu|6b790314 ]] of Hibernate SessionFactory for HibernateTransactionManager - fr.onema.sispea.serviceng.SispeaHibernateTransactionManager:378 [main] 2017-12-23 02:59:09,551 INFO No TaskScheduler/ScheduledExecutorService bean found for scheduled processing - org.springframework.scheduling.annotation.ScheduledAnnotationBeanPostProcessor:273 [main] 2017-12-23 02:59:09,553 INFO Began transaction (1) for test context [DefaultTestContext@af7e265 testClass = SispeaServiceContextTest, testInstance = fr.onema.sispea.service.SispeaServiceContextTest@81ae283, testMethod = testContextLoaded@SispeaServiceContextTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@507444df testClass = SispeaServiceContextTest, locations = '{classpath:sispea-service-test-context.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [fr.onema.sispea.serviceng.SispeaHibernateTransactionManager@1a017874]; rollback [true] - org.springframework.test.context.transaction.TransactionContext:105 [main] 2017-12-23 02:59:09,554 INFO HHH000397: Using ASTQueryTranslatorFactory - org.hibernate.hql.internal.QueryTranslatorFactoryInitiator:47 [main] 2017-12-23 02:59:09,555 INFO Rolled back transaction for test context [DefaultTestContext@af7e265 testClass = SispeaServiceContextTest, testInstance = fr.onema.sispea.service.SispeaServiceContextTest@81ae283, testMethod = testContextLoaded@SispeaServiceContextTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@507444df testClass = SispeaServiceContextTest, locations = '{classpath:sispea-service-test-context.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]. - org.springframework.test.context.transaction.TransactionContext:137 [main] 2017-12-23 02:59:09,555 INFO Closing org.springframework.context.support.GenericApplicationContext@3d523fe8: startup date [Sat Dec 23 02:59:08 CET 2017]; root of context hierarchy - org.springframework.context.support.GenericApplicationContext:989 [main] 2017-12-23 02:59:09,581 INFO Refreshing org.springframework.context.support.GenericApplicationContext@70d82f2e: startup date [Sat Dec 23 02:59:09 CET 2017]; root of context hierarchy - org.springframework.context.support.GenericApplicationContext:589 [main] 2017-12-23 02:59:09,617 INFO Loading configuration file (classpath) : <http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/test-classes/sispea-service-test.conf> - org.nuiton.config.ApplicationConfig:2184 [main] 2017-12-23 02:59:09,886 INFO Initializing c3p0 pool... com.mchange.v2.c3p0.ComboPooledDataSource [ acquireIncrement -> 3, acquireRetryAttempts -> 10, acquireRetryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 0, connectionCustomizerClassName -> null, connectionTesterClassName -> com.mchange.v2.c3p0.impl.DefaultConnectionTester, contextClassLoaderSource -> caller, dataSourceName -> 1hge14e9szrn4e55bawmu|297ef77b, debugUnreturnedConnectionStackTraces -> false, description -> null, driverClass -> org.h2.Driver, extensions -> {}, factoryClassLocation -> null, forceIgnoreUnresolvedTransactions -> false, forceSynchronousCheckins -> false, forceUseNamedDriverClass -> false, identityToken -> 1hge14e9szrn4e55bawmu|297ef77b, idleConnectionTestPeriod -> 1800, initialPoolSize -> 3, jdbcUrl -> jdbc:h2:<http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-workdir/test-SispeaServiceContextTest-testCreateExercise-1513994349619,> maxAdministrativeTaskTime -> 0, maxConnectionAge -> 1800, maxIdleTime -> 600, maxIdleTimeExcessConnections -> 0, maxPoolSize -> 30, maxStatements -> 0, maxStatementsPerConnection -> 0, minPoolSize -> 3, numHelperThreads -> 3, preferredTestQuery -> SELECT 1, privilegeSpawnedThreads -> false, properties -> {user=******, password=******}, propertyCycle -> 0, statementCacheNumDeferredCloseThreads -> 0, testConnectionOnCheckin -> true, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, userOverrides -> {}, usesTraditionalReflectiveProxies -> false ] - com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource:212 [main] 2017-12-23 02:59:09,889 INFO HHH000400: Using dialect: org.hibernate.dialect.H2Dialect - org.hibernate.dialect.Dialect:157 [main] 2017-12-23 02:59:10,272 INFO Using DataSource [com.mchange.v2.c3p0.ComboPooledDataSource[ identityToken -> 1hge14e9szrn4e55bawmu|297ef77b, dataSourceName -> 1hge14e9szrn4e55bawmu|297ef77b ]] of Hibernate SessionFactory for HibernateTransactionManager - fr.onema.sispea.serviceng.SispeaHibernateTransactionManager:378 [main] 2017-12-23 02:59:10,733 INFO No TaskScheduler/ScheduledExecutorService bean found for scheduled processing - org.springframework.scheduling.annotation.ScheduledAnnotationBeanPostProcessor:273 [main] 2017-12-23 02:59:10,735 INFO Began transaction (1) for test context [DefaultTestContext@af7e265 testClass = SispeaServiceContextTest, testInstance = fr.onema.sispea.service.SispeaServiceContextTest@373d401c, testMethod = testCreateExercise@SispeaServiceContextTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@507444df testClass = SispeaServiceContextTest, locations = '{classpath:sispea-service-test-context.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [fr.onema.sispea.serviceng.SispeaHibernateTransactionManager@680c90e1]; rollback [true] - org.springframework.test.context.transaction.TransactionContext:105 [main] 2017-12-23 02:59:10,736 INFO HHH000397: Using ASTQueryTranslatorFactory - org.hibernate.hql.internal.QueryTranslatorFactoryInitiator:47 [main] 2017-12-23 02:59:10,739 INFO Rolled back transaction for test context [DefaultTestContext@af7e265 testClass = SispeaServiceContextTest, testInstance = fr.onema.sispea.service.SispeaServiceContextTest@373d401c, testMethod = testCreateExercise@SispeaServiceContextTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@507444df testClass = SispeaServiceContextTest, locations = '{classpath:sispea-service-test-context.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]. - org.springframework.test.context.transaction.TransactionContext:137 [main] 2017-12-23 02:59:10,739 INFO Closing org.springframework.context.support.GenericApplicationContext@70d82f2e: startup date [Sat Dec 23 02:59:09 CET 2017]; root of context hierarchy - org.springframework.context.support.GenericApplicationContext:989 [main] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.342 sec - in fr.onema.sispea.service.SispeaServiceContextTest Results : Tests in error: IpTest.testGetIpFromCode » CannotCreateTransaction Could not open Hibernate Se... CommuneTest.testCountCommunes » CannotCreateTransaction Could not open Hiberna... Tests run: 123, Failures: 0, Errors: 2, Skipped: 17 [ERROR] There are test failures. Please refer to <http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/surefire-reports> for the individual test results. [JENKINS] Recording test results [INFO] [INFO] --- maven-jar-plugin:3.0.2:jar (default-jar) @ sispea-service --- [INFO] Building jar: <http://ci.codelutin.com/jenkins/job/sispea-demo-latest/fr.onema$sispea-service/ws/target/sispea-service-3.2-rc-5-revd92dfc0.jar> [INFO] [INFO] >>> maven-source-plugin:3.0.1:jar (attach-sources) > generate-sources @ sispea-service >>> [INFO] [INFO] --- helper-maven-plugin:2.3.2:check-auto-container (check-central-safe) @ sispea-service --- [INFO] Will use repository http://repo1.maven.org/maven2/ [INFO] Will use repository https://nexus.nuiton.org/nexus/content/repositories/central-releases [INFO] 96 dependencies to check. [INFO] 96 artifact(s) resolved by repository http://repo1.maven.org/maven2/ in 183838ns [INFO] All dependencies are safe. [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (enforce-project-files) @ sispea-service --- [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (enforce-platform) @ sispea-service --- [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (enforce-projectId) @ sispea-service --- [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (enforce-ciViewId) @ sispea-service --- [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (enforce-javaVersion) @ sispea-service --- [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (enforce-signatureArtifactId) @ sispea-service --- [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (enforce-signatureVersion) @ sispea-service --- [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (enforce-java-versions) @ sispea-service --- [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (ensure-no-container-api) @ sispea-service --- [INFO] [INFO] --- maven-enforcer-plugin:1.4.1:enforce (enforce-bytecode-version) @ sispea-service --- [INFO] [INFO] --- helper-maven-plugin:2.3.2:share-server-secret (get-redmine-login) @ sispea-service --- [INFO] Skipping goal (runOnce flag is on and goal was already executed). [WARNING] Failed to getClass for org.apache.maven.plugins.source.SourceJarMojo [INFO] [INFO] <<< maven-source-plugin:3.0.1:jar (attach-sources) < generate-sources @ sispea-service <<< [INFO] [INFO] --- maven-source-plugin:3.0.1:jar (attach-sources) @ sispea-service --- [INFO] Skipping source per configuration. [INFO] [INFO] --- maven-javadoc-plugin:2.10.4:jar (attach-javadocs) @ sispea-service --- [INFO] Skipping javadoc generation [INFO] [INFO] --- maven-site-plugin:3.4:attach-descriptor (attach-descriptor) @ sispea-service --- [INFO] [INFO] --- helper-maven-plugin:2.3.2:share-server-secret (get-pgp-passphrase) @ sispea-service --- [INFO] Exporting server [gpg-signer] username in ${gpg.keyname} [INFO] Exporting server [gpg-signer] password in ${gpg.passphrase} [INFO] [INFO] --- helper-maven-plugin:2.3.2:collect-files (collect-build-artifacts) @ sispea-service --- [INFO] Loaded /var/local/forge/data/codelutin.com/jenkins/workspace/sispea-demo-latest/target/collect-artifacts.txt [INFO] Copying sispea-service-3.2-rc-5-revd92dfc0.jar to /var/local/forge/data/codelutin.com/jenkins/workspace/sispea-demo-latest/target/collect/fr.onema--sispea-service/sispea-service-3.2-rc-5-revd92dfc0.jar [INFO] Copying THIRD-PARTY.properties to /var/local/forge/data/codelutin.com/jenkins/workspace/sispea-demo-latest/target/collect/fr.onema--sispea-service/THIRD-PARTY.properties [INFO] [INFO] --- helper-maven-plugin:2.3.2:collect-files (collect-build-attachements) @ sispea-service --- [WARNING] Skipping goal (No file to collect). [INFO] [INFO] --- helper-maven-plugin:2.3.2:collect-files (collect-deploy-files) @ sispea-service --- [WARNING] Skipping goal (No file to collect). [INFO] [INFO] --- maven-gpg-plugin:1.6:sign (sign-artifacts) @ sispea-service --- [INFO] [INFO] --- maven-dependency-plugin:2.10:analyze-only (analyze) @ sispea-service --- [INFO] Used declared dependencies found: [INFO] fr.onema:sispea-util:jar:3.2-rc-5-revd92dfc0:compile [INFO] fr.onema:sispea-persist:jar:3.2-rc-5-revd92dfc0:compile [INFO] org.nuiton:nuiton-utils:jar:3.0:compile [INFO] org.nuiton:nuiton-csv:jar:3.0-rc-6:compile [INFO] net.sf.opencsv:opencsv:jar:2.3:compile [INFO] com.tutego:jrtf:jar:0.7:compile [INFO] org.hibernate:hibernate-core:jar:5.2.12.Final:compile [INFO] xml-apis:xml-apis:jar:2.0.2:compile [INFO] org.reflections:reflections:jar:0.9.11:compile [INFO] org.immutables:value:jar:2.5.6:compile [INFO] com.google.code.findbugs:annotations:jar:3.0.1u2:compile [INFO] com.google.errorprone:error_prone_annotations:jar:2.1.3:compile [INFO] javax.mail:mail:jar:1.4.7:compile [INFO] javax.activation:activation:jar:1.1.1:compile [INFO] org.apache.velocity:velocity:jar:1.7:compile [INFO] org.apache.velocity:velocity-tools:jar:2.0:compile [INFO] org.springframework:spring-beans:jar:5.0.2.RELEASE:compile [INFO] org.springframework.ldap:spring-ldap-core:jar:2.3.2.RELEASE:compile [INFO] org.springframework:spring-context-support:jar:5.0.2.RELEASE:compile [INFO] org.springframework:spring-context:jar:5.0.2.RELEASE:compile [INFO] org.springframework:spring-tx:jar:5.0.2.RELEASE:compile [INFO] org.springframework:spring-orm:jar:5.0.2.RELEASE:compile [INFO] org.apache.commons:commons-lang3:jar:3.7:compile [INFO] org.apache.commons:commons-text:jar:1.2:compile [INFO] org.apache.commons:commons-collections4:jar:4.1:compile [INFO] commons-digester:commons-digester:jar:2.1:compile [INFO] com.google.guava:guava:jar:23.5-jre:compile [INFO] com.google.code.gson:gson:jar:2.8.2:compile [INFO] jdom:jdom:jar:1.0:compile [INFO] org.nfunk:jep:jar:2.4.0:compile [INFO] jfree:jfreechart:jar:1.0.7:compile [INFO] junit:junit:jar:4.12:test [INFO] ru.yandex.qatools.embed:postgresql-embedded:jar:2.6:test [INFO] de.flapdoodle.embed:de.flapdoodle.embed.process:jar:2.0.1:test [INFO] log4j:log4j:jar:1.2.17:compile [INFO] org.springframework:spring-test:jar:5.0.2.RELEASE:test [INFO] org.mockito:mockito-core:jar:2.13.0:test [INFO] commons-io:commons-io:jar:2.6:compile [INFO] org.apache.poi:poi:jar:3.16:compile [INFO] org.apache.poi:poi-ooxml:jar:3.16:compile [WARNING] Used undeclared dependencies found: [WARNING] org.springframework:spring-jcl:jar:5.0.2.RELEASE:compile [WARNING] org.springframework:spring-core:jar:5.0.2.RELEASE:compile [WARNING] Unused declared dependencies found: [WARNING] commons-logging:commons-logging:jar:1.2:compile [JENKINS] Archiving disabled