[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.74 s - in org.appng.core.repository.RoleRepositoryTest
[INFO] Running org.appng.core.repository.PermissionRepositoryTest
2019-12-19 10:58:38,491 INFO [main] org.springframework.test.context.support.AbstractContextLoader: Could not detect default resource locations for test class [org.appng.core.repository.PermissionRepositoryTest]: no resource found for suffixes {-context.xml}.
2019-12-19 10:58:38,491 INFO [main] org.springframework.test.context.support.AnnotationConfigContextLoaderUtils: Could not detect default configuration classes for test class [org.appng.core.repository.PermissionRepositoryTest]: PermissionRepositoryTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
2019-12-19 10:58:38,491 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:38,492 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@215867af, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@17d5e438, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@3bddb025, org.springframework.test.context.support.DirtiesContextTestExecutionListener@3b0ebc6, org.springframework.test.context.transaction.TransactionalTestExecutionListener@61378100, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@59fb5d3a, org.springframework.test.context.event.EventPublishingTestExecutionListener@ff192b8]
2019-12-19 10:58:38,580 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:38,614 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 34ms. Found 15 repository interfaces.
2019-12-19 10:58:38,622 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:38,664 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 42ms. Found 15 repository interfaces.
2019-12-19 10:58:38,702 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:38,780 WARN [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2019-12-19 10:58:38,780 INFO [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2019-12-19 10:58:38,780 INFO [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {user=sa, password=****}
2019-12-19 10:58:38,781 INFO [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2019-12-19 10:58:38,781 INFO [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2019-12-19 10:58:38,781 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:38,786 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:38,983 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@5a3f4166] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:38,986 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@7dd1fd41] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:39,004 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:39,004 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:39,033 INFO [main] org.appng.core.domain.PlatformEventListener: Using application context org.springframework.context.support.GenericApplicationContext@b1ba65b, started on Thu Dec 19 10:58:38 CET 2019
2019-12-19 10:58:39,393 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4bbd3f6c testClass = PermissionRepositoryTest, testInstance = org.appng.core.repository.PermissionRepositoryTest@32f0fd44, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@5c8292df testClass = PermissionRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.PermissionRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@29ff3af]; rollback [true]
2019-12-19 10:58:39,394 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application name
2019-12-19 10:58:39,396 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission name
2019-12-19 10:58:39,405 INFO [main] org.springframework.test.context.transaction.TransactionContext: Rolled back transaction for test: [DefaultTestContext@4bbd3f6c testClass = PermissionRepositoryTest, testInstance = org.appng.core.repository.PermissionRepositoryTest@32f0fd44, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@5c8292df testClass = PermissionRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.PermissionRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]
2019-12-19 10:58:39,406 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:39,406 INFO [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.919 s - in org.appng.core.repository.PermissionRepositoryTest
[INFO] Running org.appng.core.repository.RepositoryCacheTest
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.022 s - in org.appng.core.repository.RepositoryCacheTest
[INFO] Running org.appng.core.repository.PropertyRepositoryTest
2019-12-19 10:58:39,438 INFO [main] org.springframework.test.context.support.AbstractContextLoader: Could not detect default resource locations for test class [org.appng.core.repository.PropertyRepositoryTest]: no resource found for suffixes {-context.xml}.
2019-12-19 10:58:39,438 INFO [main] org.springframework.test.context.support.AnnotationConfigContextLoaderUtils: Could not detect default configuration classes for test class [org.appng.core.repository.PropertyRepositoryTest]: PropertyRepositoryTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
2019-12-19 10:58:39,438 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:39,438 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@5ed3696c, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@3b78be1d, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@11eb6744, org.springframework.test.context.support.DirtiesContextTestExecutionListener@1600e2c0, org.springframework.test.context.transaction.TransactionalTestExecutionListener@535d6165, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@2d2bb545, org.springframework.test.context.event.EventPublishingTestExecutionListener@673036e3]
2019-12-19 10:58:39,531 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:39,559 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 27ms. Found 15 repository interfaces.
2019-12-19 10:58:39,560 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:39,587 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 26ms. Found 15 repository interfaces.
2019-12-19 10:58:39,608 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:39,633 WARN [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2019-12-19 10:58:39,633 INFO [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2019-12-19 10:58:39,633 INFO [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {user=sa, password=****}
2019-12-19 10:58:39,633 INFO [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2019-12-19 10:58:39,633 INFO [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2019-12-19 10:58:39,634 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:39,646 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:39,829 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@63ef0ce] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:39,832 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@5620bd60] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:39,850 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:39,850 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:39,880 INFO [main] org.appng.core.domain.PlatformEventListener: Using application context org.springframework.context.support.GenericApplicationContext@76b7ce27, started on Thu Dec 19 10:58:39 CET 2019
2019-12-19 10:58:40,180 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@679f1314 testClass = PropertyRepositoryTest, testInstance = org.appng.core.repository.PropertyRepositoryTest@472bc0b7, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@290df0bf testClass = PropertyRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.PropertyRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@4f3cd6f1]; rollback [true]
2019-12-19 10:58:40,181 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property foo.bar
2019-12-19 10:58:40,187 INFO [main] org.springframework.test.context.transaction.TransactionContext: Rolled back transaction for test: [DefaultTestContext@679f1314 testClass = PropertyRepositoryTest, testInstance = org.appng.core.repository.PropertyRepositoryTest@472bc0b7, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@290df0bf testClass = PropertyRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.PropertyRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]
2019-12-19 10:58:40,195 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:40,195 INFO [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.761 s - in org.appng.core.repository.PropertyRepositoryTest
[INFO] Running org.appng.core.repository.ResourceRepositoryTest
2019-12-19 10:58:40,203 INFO [main] org.springframework.test.context.support.AbstractContextLoader: Could not detect default resource locations for test class [org.appng.core.repository.ResourceRepositoryTest]: no resource found for suffixes {-context.xml}.
2019-12-19 10:58:40,203 INFO [main] org.springframework.test.context.support.AnnotationConfigContextLoaderUtils: Could not detect default configuration classes for test class [org.appng.core.repository.ResourceRepositoryTest]: ResourceRepositoryTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
2019-12-19 10:58:40,203 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:40,203 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@11c9bf6e, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@4fd0d9ba, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@380f5cac, org.springframework.test.context.support.DirtiesContextTestExecutionListener@5933305, org.springframework.test.context.transaction.TransactionalTestExecutionListener@59fdce16, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@1029d19a, org.springframework.test.context.event.EventPublishingTestExecutionListener@5281150f]
2019-12-19 10:58:40,286 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:40,317 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 30ms. Found 15 repository interfaces.
2019-12-19 10:58:40,318 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:40,340 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 22ms. Found 15 repository interfaces.
2019-12-19 10:58:40,358 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:40,378 WARN [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2019-12-19 10:58:40,378 INFO [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2019-12-19 10:58:40,378 INFO [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {user=sa, password=****}
2019-12-19 10:58:40,378 INFO [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2019-12-19 10:58:40,378 INFO [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2019-12-19 10:58:40,379 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:40,382 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:40,572 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@582957b1] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:40,574 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@1309cca9] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:40,589 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:40,589 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:40,613 INFO [main] org.appng.core.domain.PlatformEventListener: Using application context org.springframework.context.support.GenericApplicationContext@4e161f41, started on Thu Dec 19 10:58:40 CET 2019
2019-12-19 10:58:40,873 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@132f32a9 testClass = ResourceRepositoryTest, testInstance = org.appng.core.repository.ResourceRepositoryTest@29727534, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@2135337a testClass = ResourceRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.ResourceRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@6ea2549c]; rollback [true]
2019-12-19 10:58:40,874 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application name
2019-12-19 10:58:40,875 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Resource name of application name
2019-12-19 10:58:40,878 INFO [main] org.springframework.test.context.transaction.TransactionContext: Rolled back transaction for test: [DefaultTestContext@132f32a9 testClass = ResourceRepositoryTest, testInstance = org.appng.core.repository.ResourceRepositoryTest@29727534, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@2135337a testClass = ResourceRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.ResourceRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]
2019-12-19 10:58:40,879 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:40,879 INFO [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.679 s - in org.appng.core.repository.ResourceRepositoryTest
[INFO] Running org.appng.core.repository.RepositoryTest
2019-12-19 10:58:40,884 INFO [main] org.springframework.test.context.support.AbstractContextLoader: Could not detect default resource locations for test class [org.appng.core.repository.RepositoryTest]: no resource found for suffixes {-context.xml}.
2019-12-19 10:58:40,884 INFO [main] org.springframework.test.context.support.AnnotationConfigContextLoaderUtils: Could not detect default configuration classes for test class [org.appng.core.repository.RepositoryTest]: RepositoryTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
2019-12-19 10:58:40,884 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:40,884 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@1d15a08b, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@4e1cf13c, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@3b577a6a, org.springframework.test.context.support.DirtiesContextTestExecutionListener@544ec29e, org.springframework.test.context.transaction.TransactionalTestExecutionListener@64ef3164, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@4d53b9d4, org.springframework.test.context.event.EventPublishingTestExecutionListener@4d571e3e]
2019-12-19 10:58:40,972 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:41,000 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 28ms. Found 15 repository interfaces.
2019-12-19 10:58:41,001 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:41,026 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 25ms. Found 15 repository interfaces.
2019-12-19 10:58:41,047 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:41,070 WARN [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2019-12-19 10:58:41,070 INFO [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2019-12-19 10:58:41,070 INFO [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {user=sa, password=****}
2019-12-19 10:58:41,070 INFO [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2019-12-19 10:58:41,070 INFO [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2019-12-19 10:58:41,071 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:41,076 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:41,267 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@557e98b7] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:41,269 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@1b7999b7] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:41,287 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:41,287 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:41,316 INFO [main] org.appng.core.domain.PlatformEventListener: Using application context org.springframework.context.support.GenericApplicationContext@6faf6f38, started on Thu Dec 19 10:58:40 CET 2019
2019-12-19 10:58:41,617 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@5b919201 testClass = RepositoryTest, testInstance = org.appng.core.repository.RepositoryTest@5cc54c2b, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@4a74038e testClass = RepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.RepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@4a377a8e]; rollback [true]
2019-12-19 10:58:41,618 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application name
2019-12-19 10:58:41,622 INFO [main] org.springframework.test.context.transaction.TransactionContext: Rolled back transaction for test: [DefaultTestContext@5b919201 testClass = RepositoryTest, testInstance = org.appng.core.repository.RepositoryTest@5cc54c2b, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@4a74038e testClass = RepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.RepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]
2019-12-19 10:58:41,623 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:41,623 INFO [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.741 s - in org.appng.core.repository.RepositoryTest
[INFO] Running org.appng.core.repository.GroupRepositoryTest
2019-12-19 10:58:41,625 INFO [main] org.springframework.test.context.support.AbstractContextLoader: Could not detect default resource locations for test class [org.appng.core.repository.GroupRepositoryTest]: no resource found for suffixes {-context.xml}.
2019-12-19 10:58:41,625 INFO [main] org.springframework.test.context.support.AnnotationConfigContextLoaderUtils: Could not detect default configuration classes for test class [org.appng.core.repository.GroupRepositoryTest]: GroupRepositoryTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
2019-12-19 10:58:41,625 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:41,625 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@67301e27, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@2755a766, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@a8f1f0, org.springframework.test.context.support.DirtiesContextTestExecutionListener@74e9c76f, org.springframework.test.context.transaction.TransactionalTestExecutionListener@134f3ef3, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@192bd56b, org.springframework.test.context.event.EventPublishingTestExecutionListener@5e4b90cf]
2019-12-19 10:58:41,704 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:41,729 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 24ms. Found 15 repository interfaces.
2019-12-19 10:58:41,730 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:41,753 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 22ms. Found 15 repository interfaces.
2019-12-19 10:58:41,771 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:41,791 WARN [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2019-12-19 10:58:41,791 INFO [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2019-12-19 10:58:41,792 INFO [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {user=sa, password=****}
2019-12-19 10:58:41,792 INFO [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2019-12-19 10:58:41,792 INFO [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2019-12-19 10:58:41,792 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:41,796 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:41,938 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@282e7ecd] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:41,940 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@40b759ed] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:41,954 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:41,954 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:41,981 INFO [main] org.appng.core.domain.PlatformEventListener: Using application context org.springframework.context.support.GenericApplicationContext@6423e6d6, started on Thu Dec 19 10:58:41 CET 2019
2019-12-19 10:58:42,408 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4fcd440f testClass = GroupRepositoryTest, testInstance = org.appng.core.repository.GroupRepositoryTest@7fd0e8ca, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@768d49d5 testClass = GroupRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.GroupRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@7a8dc096]; rollback [true]
2019-12-19 10:58:42,409 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application name
2019-12-19 10:58:42,411 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role name
2019-12-19 10:58:42,411 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Group name
2019-12-19 10:58:42,417 INFO [main] org.springframework.test.context.transaction.TransactionContext: Rolled back transaction for test: [DefaultTestContext@4fcd440f testClass = GroupRepositoryTest, testInstance = org.appng.core.repository.GroupRepositoryTest@7fd0e8ca, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@768d49d5 testClass = GroupRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.GroupRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]
2019-12-19 10:58:42,418 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:42,418 INFO [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.792 s - in org.appng.core.repository.GroupRepositoryTest
[INFO] Running org.appng.core.repository.JobExecutionRecordRepositoryTest
2019-12-19 10:58:42,420 INFO [main] org.springframework.test.context.support.AbstractContextLoader: Could not detect default resource locations for test class [org.appng.core.repository.JobExecutionRecordRepositoryTest]: no resource found for suffixes {-context.xml}.
2019-12-19 10:58:42,420 INFO [main] org.springframework.test.context.support.AnnotationConfigContextLoaderUtils: Could not detect default configuration classes for test class [org.appng.core.repository.JobExecutionRecordRepositoryTest]: JobExecutionRecordRepositoryTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
2019-12-19 10:58:42,420 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:42,421 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@4a3ad0f8, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@6d64aa05, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@6655decb, org.springframework.test.context.support.DirtiesContextTestExecutionListener@5342b1e9, org.springframework.test.context.transaction.TransactionalTestExecutionListener@4fe30669, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@71fa912, org.springframework.test.context.event.EventPublishingTestExecutionListener@4f748cbc]
2019-12-19 10:58:42,506 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:42,533 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 26ms. Found 15 repository interfaces.
2019-12-19 10:58:42,534 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:42,559 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 24ms. Found 15 repository interfaces.
2019-12-19 10:58:42,578 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:42,601 WARN [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2019-12-19 10:58:42,601 INFO [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2019-12-19 10:58:42,601 INFO [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {user=sa, password=****}
2019-12-19 10:58:42,601 INFO [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2019-12-19 10:58:42,602 INFO [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2019-12-19 10:58:42,602 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:42,606 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:43,038 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@751ea31d] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:43,041 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@4ebea736] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:43,057 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:43,057 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:43,093 INFO [main] org.appng.core.domain.PlatformEventListener: Using application context org.springframework.context.support.GenericApplicationContext@97fa142, started on Thu Dec 19 10:58:42 CET 2019
2019-12-19 10:58:43,413 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@4b1d4faf testClass = JobExecutionRecordRepositoryTest, testInstance = org.appng.core.repository.JobExecutionRecordRepositoryTest@7cd48c6b, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@42206830 testClass = JobExecutionRecordRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.JobExecutionRecordRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@4ff2de2]; rollback [true]
2019-12-19 10:58:43,420 INFO [main] org.springframework.test.context.transaction.TransactionContext: Rolled back transaction for test: [DefaultTestContext@4b1d4faf testClass = JobExecutionRecordRepositoryTest, testInstance = org.appng.core.repository.JobExecutionRecordRepositoryTest@7cd48c6b, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@42206830 testClass = JobExecutionRecordRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.JobExecutionRecordRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]
2019-12-19 10:58:43,421 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:43,421 INFO [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.001 s - in org.appng.core.repository.JobExecutionRecordRepositoryTest
[INFO] Running org.appng.core.repository.SubjectRepositoryTest
2019-12-19 10:58:43,425 INFO [main] org.springframework.test.context.support.AbstractContextLoader: Could not detect default resource locations for test class [org.appng.core.repository.SubjectRepositoryTest]: no resource found for suffixes {-context.xml}.
2019-12-19 10:58:43,425 INFO [main] org.springframework.test.context.support.AnnotationConfigContextLoaderUtils: Could not detect default configuration classes for test class [org.appng.core.repository.SubjectRepositoryTest]: SubjectRepositoryTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
2019-12-19 10:58:43,425 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:43,426 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@ebbab4b, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@6becf62, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@5bdc7fa1, org.springframework.test.context.support.DirtiesContextTestExecutionListener@44cc5ecf, org.springframework.test.context.transaction.TransactionalTestExecutionListener@177e44ee, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@674b5cbc, org.springframework.test.context.event.EventPublishingTestExecutionListener@5fd21683]
2019-12-19 10:58:43,516 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:43,543 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 27ms. Found 15 repository interfaces.
2019-12-19 10:58:43,544 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:43,571 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 26ms. Found 15 repository interfaces.
2019-12-19 10:58:43,596 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:43,620 WARN [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2019-12-19 10:58:43,620 INFO [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2019-12-19 10:58:43,620 INFO [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {user=sa, password=****}
2019-12-19 10:58:43,620 INFO [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2019-12-19 10:58:43,620 INFO [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2019-12-19 10:58:43,620 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:43,624 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:43,780 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@13bd2f20] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:43,783 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@6a8f232] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:43,799 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:43,799 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:43,825 INFO [main] org.appng.core.domain.PlatformEventListener: Using application context org.springframework.context.support.GenericApplicationContext@79ce0190, started on Thu Dec 19 10:58:43 CET 2019
2019-12-19 10:58:44,100 INFO [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@16f4777d testClass = SubjectRepositoryTest, testInstance = org.appng.core.repository.SubjectRepositoryTest@7abbf13, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7fd48a39 testClass = SubjectRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.SubjectRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@36fe7b03]; rollback [true]
2019-12-19 10:58:44,101 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Group name
2019-12-19 10:58:44,102 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Site name
2019-12-19 10:58:44,103 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application name
2019-12-19 10:58:44,105 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role name
2019-12-19 10:58:44,105 INFO [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Subject name
2019-12-19 10:58:44,112 INFO [main] org.springframework.test.context.transaction.TransactionContext: Rolled back transaction for test: [DefaultTestContext@16f4777d testClass = SubjectRepositoryTest, testInstance = org.appng.core.repository.SubjectRepositoryTest@7abbf13, testMethod = test@AbstractRepositoryTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@7fd48a39 testClass = SubjectRepositoryTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.repository.SubjectRepositoryTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map[[empty]]]
2019-12-19 10:58:44,113 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:44,113 INFO [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.688 s - in org.appng.core.repository.SubjectRepositoryTest
[INFO] Running org.appng.core.model.PlatformTransformerTest
2019-12-19 10:58:44,119 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:44,119 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@77368ce, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@21c92c7e, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@419cc39c, org.springframework.test.context.support.DirtiesContextTestExecutionListener@5d729736, org.springframework.test.context.transaction.TransactionalTestExecutionListener@415ba14e, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@2919cfc7, org.springframework.test.context.event.EventPublishingTestExecutionListener@ebe695b]
2019-12-19 10:58:44,195 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:44,218 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 23ms. Found 15 repository interfaces.
2019-12-19 10:58:44,219 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:44,241 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 21ms. Found 15 repository interfaces.
2019-12-19 10:58:44,257 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:44,276 WARN [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2019-12-19 10:58:44,276 INFO [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2019-12-19 10:58:44,276 INFO [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {user=sa, password=****}
2019-12-19 10:58:44,276 INFO [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2019-12-19 10:58:44,276 INFO [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2019-12-19 10:58:44,277 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:44,279 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:44,448 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@75f0074f] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:44,450 INFO [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@49a248bc] for (non-JTA) DDL execution was not in auto-commit mode; the Connection 'local transaction' will be committed and the Connection will be set into auto-commit mode.
2019-12-19 10:58:44,464 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:44,464 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:44,486 INFO [main] org.appng.core.domain.PlatformEventListener: Using application context org.springframework.context.support.GenericApplicationContext@473c849d, started on Thu Dec 19 10:58:44 CET 2019
2019-12-19 10:58:46,262 ERROR [main] org.appng.core.model.PlatformTransformer: An empty sequence is not allowed as the value of variable $foo
; SystemID: ; Line#: 6; Column#: 10
net.sf.saxon.trans.XPathException: An empty sequence is not allowed as the value of variable $foo
at net.sf.saxon.expr.Expression.typeError(Expression.java:1464)
at net.sf.saxon.expr.CardinalityChecker.evaluateItem(CardinalityChecker.java:280)
at net.sf.saxon.expr.AtomicSequenceConverter.evaluateItem(AtomicSequenceConverter.java:354)
at net.sf.saxon.expr.AtomicSequenceConverter.evaluateItem(AtomicSequenceConverter.java:28)
at net.sf.saxon.expr.Expression.evaluateAsString(Expression.java:911)
at net.sf.saxon.expr.instruct.SimpleNodeConstructor.processLeavingTail(SimpleNodeConstructor.java:218)
at net.sf.saxon.expr.instruct.ValueOf.processLeavingTail(ValueOf.java:290)
at net.sf.saxon.expr.instruct.TemplateRule.applyLeavingTail(TemplateRule.java:352)
at net.sf.saxon.trans.Mode.applyTemplates(Mode.java:532)
at net.sf.saxon.trans.XsltController.applyTemplates(XsltController.java:747)
at net.sf.saxon.s9api.AbstractXsltTransformer.applyTemplatesToSource(AbstractXsltTransformer.java:347)
at net.sf.saxon.s9api.XsltTransformer.transform(XsltTransformer.java:349)
at net.sf.saxon.jaxp.TransformerImpl.transform(TransformerImpl.java:71)
at org.appng.core.model.PlatformTransformer.transform(PlatformTransformer.java:320)
at org.appng.core.model.PlatformTransformer.transform(PlatformTransformer.java:197)
at org.appng.core.model.PlatformTransformerTest.runErrornousTest(PlatformTransformerTest.java:153)
at org.appng.core.model.PlatformTransformerTest.testRuntimeError(PlatformTransformerTest.java:132)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.springframework.test.context.junit4.statements.RunBeforeTestExecutionCallbacks.evaluate(RunBeforeTestExecutionCallbacks.java:74)
at org.springframework.test.context.junit4.statements.RunAfterTestExecutionCallbacks.evaluate(RunAfterTestExecutionCallbacks.java:84)
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75)
at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86)
at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:251)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:97)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61)
at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:190)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
2019-12-19 10:58:46,264 INFO [main] org.appng.core.model.PlatformTransformer: writing debug files to target/debug
2019-12-19 10:58:46,264 INFO [main] org.appng.core.model.PlatformTransformer: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/template.xsl
2019-12-19 10:58:46,264 INFO [main] org.appng.core.model.PlatformTransformer: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/platform.xml
2019-12-19 10:58:46,265 INFO [main] org.appng.core.model.PlatformTransformer: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/stacktrace.txt
2019-12-19 10:58:46,321 ERROR [main] org.appng.core.model.PlatformTransformer: Unknown XSLT element: <tmplate>
; SystemID: ; Line#: 5; Column#: 25
net.sf.saxon.trans.XPathException: Unknown XSLT element: <tmplate>
at net.sf.saxon.style.StyleNodeFactory.makeElementNode(StyleNodeFactory.java:255)
at net.sf.saxon.tree.linked.LinkedTreeBuilder.startContent(LinkedTreeBuilder.java:254)
at net.sf.saxon.style.UseWhenFilter.startContent(UseWhenFilter.java:533)
at net.sf.saxon.event.StartTagBuffer.startContent(StartTagBuffer.java:258)
at net.sf.saxon.event.ProxyReceiver.startContent(ProxyReceiver.java:177)
at net.sf.saxon.event.ProxyReceiver.startContent(ProxyReceiver.java:177)
at net.sf.saxon.event.ProxyReceiver.startContent(ProxyReceiver.java:177)
at net.sf.saxon.event.ReceivingContentHandler.startElement(ReceivingContentHandler.java:446)
at com.sun.org.apache.xerces.internal.parsers.AbstractSAXParser.startElement(AbstractSAXParser.java:509)
at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.scanStartElement(XMLNSDocumentScannerImpl.java:374)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl$FragmentContentDriver.next(XMLDocumentFragmentScannerImpl.java:2784)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(XMLDocumentScannerImpl.java:602)
at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.next(XMLNSDocumentScannerImpl.java:112)
at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(XMLDocumentFragmentScannerImpl.java:505)
at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:841)
at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:770)
at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:141)
at com.sun.org.apache.xerces.internal.parsers.AbstractSAXParser.parse(AbstractSAXParser.java:1213)
at com.sun.org.apache.xerces.internal.jaxp.SAXParserImpl$JAXPSAXParser.parse(SAXParserImpl.java:643)
at net.sf.saxon.event.Sender.sendSAXSource(Sender.java:435)
at net.sf.saxon.event.Sender.send(Sender.java:167)
at net.sf.saxon.style.StylesheetModule.sendStylesheetSource(StylesheetModule.java:274)
at net.sf.saxon.style.StylesheetModule.loadStylesheet(StylesheetModule.java:199)
at net.sf.saxon.style.Compilation.compileSingletonPackage(Compilation.java:107)
at net.sf.saxon.s9api.XsltCompiler.compile(XsltCompiler.java:785)
at net.sf.saxon.jaxp.SaxonTransformerFactory.newTemplates(SaxonTransformerFactory.java:149)
at org.appng.core.model.PlatformTransformer.transform(PlatformTransformer.java:181)
at org.appng.core.model.PlatformTransformerTest.runErrornousTest(PlatformTransformerTest.java:153)
at org.appng.core.model.PlatformTransformerTest.testCompileError(PlatformTransformerTest.java:127)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.springframework.test.context.junit4.statements.RunBeforeTestExecutionCallbacks.evaluate(RunBeforeTestExecutionCallbacks.java:74)
at org.springframework.test.context.junit4.statements.RunAfterTestExecutionCallbacks.evaluate(RunAfterTestExecutionCallbacks.java:84)
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75)
at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86)
at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:251)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:97)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61)
at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:190)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
2019-12-19 10:58:46,322 INFO [main] org.appng.core.model.PlatformTransformer: writing debug files to target/debug
2019-12-19 10:58:46,322 INFO [main] org.appng.core.model.PlatformTransformer: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/template.xsl
2019-12-19 10:58:46,322 INFO [main] org.appng.core.model.PlatformTransformer: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/platform.xml
2019-12-19 10:58:46,323 INFO [main] org.appng.core.model.PlatformTransformer: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/stacktrace.txt
2019-12-19 10:58:46,342 INFO [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:46,342 INFO [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.225 s - in org.appng.core.model.PlatformTransformerTest
[INFO] Running org.appng.core.model.RepositoryUtilsTest
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in org.appng.core.model.RepositoryUtilsTest
[INFO] Running org.appng.core.model.CacheProviderTest
2019-12-19 10:58:46,350 INFO [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/WEB-INF/cache/platform/appNG
2019-12-19 10:58:46,350 INFO [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/WEB-INF/cache/application/appNG
2019-12-19 10:58:46,353 INFO [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/WEB-INF/cache/platform/appNG/foobar
2019-12-19 10:58:46,354 INFO [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/WEB-INF/cache/application/appNG/foobar
[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 s - in org.appng.core.model.CacheProviderTest
[INFO] Running org.appng.core.model.JarInfoBuilderTest
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in org.appng.core.model.JarInfoBuilderTest
[INFO] Running org.appng.core.model.ApplicationProviderTest
2019-12-19 10:58:46,364 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:46,365 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@27be6a15, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@65433a3a, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@4c9dddda, org.springframework.test.context.support.DirtiesContextTestExecutionListener@279f970c, org.springframework.test.context.transaction.TransactionalTestExecutionListener@73a5af28, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@fcbd98c, org.springframework.test.context.event.EventPublishingTestExecutionListener@2d1ab6a2]
2019-12-19 10:58:46,573 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:46,580 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 6ms. Found 0 repository interfaces.
2019-12-19 10:58:46,661 WARN [main] org.springframework.orm.jpa.persistenceunit.DefaultPersistenceUnitManager: Found explicit default persistence unit with name 'hsql-testdb' in persistence.xml - overriding local default persistence unit settings ('packagesToScan'/'mappingResources')
2019-12-19 10:58:46,664 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:46,706 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:46,711 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:46,987 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:46,987 INFO [main] org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:47,121 WARN [main] org.appng.api.support.RequestFactoryBean: invalid value for platform property 'uploadDir', folder 'null/target/uploads' does not exist!
2019-12-19 10:58:47,237 WARN [main] org.springframework.context.support.ResourceBundleMessageSource: ResourceBundle [messages-demo] not found for MessageSource: Can't find bundle for base name messages-demo, locale en
2019-12-19 10:58:47,238 WARN [main] org.springframework.context.support.ResourceBundleMessageSource: ResourceBundle [testmessages] not found for MessageSource: Can't find bundle for base name testmessages, locale en
2019-12-19 10:58:47,409 ERROR [main] org.appng.core.model.ApplicationProvider: [localhost:demo-application] error while building structure for page 'entity'
org.appng.api.ProcessingException: error performing action 'update' of event 'events', ID: 1161485443
at org.appng.api.support.CallableAction.execute(CallableAction.java:445)
at org.appng.api.support.CallableAction.perform(CallableAction.java:325)
at org.appng.core.model.ActionElement.perform(ActionElement.java:72)
at org.appng.core.model.ApplicationProvider.getActionSectionElement(ApplicationProvider.java:531)
at org.appng.core.model.ApplicationProvider.access$000(ApplicationProvider.java:125)
at org.appng.core.model.ApplicationProvider$2.perform(ApplicationProvider.java:422)
at org.appng.core.model.ApplicationProvider.doMonitored(ApplicationProvider.java:466)
at org.appng.core.model.ApplicationProvider.addElements(ApplicationProvider.java:430)
at org.appng.core.model.ApplicationProvider.buildStructure(ApplicationProvider.java:349)
at org.appng.core.model.ApplicationProvider.process(ApplicationProvider.java:278)
at org.appng.core.model.ApplicationProviderTest.runTest(ApplicationProviderTest.java:282)
at org.appng.core.model.ApplicationProviderTest.testUpdateException(ApplicationProviderTest.java:183)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.springframework.test.context.junit4.statements.RunBeforeTestExecutionCallbacks.evaluate(RunBeforeTestExecutionCallbacks.java:74)
at org.springframework.test.context.junit4.statements.RunAfterTestExecutionCallbacks.evaluate(RunAfterTestExecutionCallbacks.java:84)
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75)
at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86)
at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:251)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:97)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61)
at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:190)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
Caused by: org.appng.api.ApplicationException: adfsf
at org.appng.testapplication.TestEntities.perform(TestEntities.java:71)
at org.appng.testapplication.TestEntities.perform(TestEntities.java:35)
at org.appng.api.support.CallableAction.execute(CallableAction.java:427)
... 45 more
2019-12-19 10:58:47,567 ERROR [main] org.appng.core.model.ApplicationProvider: [localhost:demo-application] error while building structure for page 'entity'
org.appng.api.ProcessingException: error retrieving datasource 'entity', ID: 1018206003
at org.appng.api.support.CallableDataSource.perform(CallableDataSource.java:238)
at org.appng.api.support.CallableAction.retrieveData(CallableAction.java:231)
at org.appng.api.support.CallableAction.perform(CallableAction.java:323)
at org.appng.core.model.ActionElement.perform(ActionElement.java:72)
at org.appng.core.model.ApplicationProvider.getActionSectionElement(ApplicationProvider.java:531)
at org.appng.core.model.ApplicationProvider.access$000(ApplicationProvider.java:125)
at org.appng.core.model.ApplicationProvider$2.perform(ApplicationProvider.java:422)
at org.appng.core.model.ApplicationProvider.doMonitored(ApplicationProvider.java:466)
at org.appng.core.model.ApplicationProvider.addElements(ApplicationProvider.java:430)
at org.appng.core.model.ApplicationProvider.buildStructure(ApplicationProvider.java:349)
at org.appng.core.model.ApplicationProvider.process(ApplicationProvider.java:278)
at org.appng.core.model.ApplicationProviderTest.runTest(ApplicationProviderTest.java:282)
at org.appng.core.model.ApplicationProviderTest.testUpdateExceptionDataSource(ApplicationProviderTest.java:173)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.springframework.test.context.junit4.statements.RunBeforeTestExecutionCallbacks.evaluate(RunBeforeTestExecutionCallbacks.java:74)
at org.springframework.test.context.junit4.statements.RunAfterTestExecutionCallbacks.evaluate(RunAfterTestExecutionCallbacks.java:84)
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75)
at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86)
at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:251)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:97)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61)
at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:190)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
Caused by: org.appng.api.ApplicationException: adfsf
at org.appng.testapplication.TestEntities.getData(TestEntities.java:45)
at org.appng.api.support.CallableDataSource.perform(CallableDataSource.java:199)
... 46 more
2019-12-19 10:58:47,752 INFO [main] org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
[INFO] Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.388 s - in org.appng.core.model.ApplicationProviderTest
[INFO] Running org.appng.core.model.ThymeleafProcessorTest
2019-12-19 10:58:47,871 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:47,844_main/platform.xml
2019-12-19 10:58:48,623 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:47,844_main/template/hello.html
2019-12-19 10:58:48,625 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:47,844_main/template/platform.html
2019-12-19 10:58:48,626 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:47,844_main/template/hello-custom.html
2019-12-19 10:58:49,842 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:47,844_main/index.html
2019-12-19 10:58:50,102 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:50,084_main/platform.xml
2019-12-19 10:58:50,123 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:50,084_main/template/hello.html
2019-12-19 10:58:50,124 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:50,084_main/template/platform.html
2019-12-19 10:58:50,124 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:50,084_main/template/hello-custom.html
2019-12-19 10:58:50,133 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:50,084_main/index.html
2019-12-19 10:58:50,155 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:50,150_main/platform.xml
2019-12-19 10:58:50,165 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:50,150_main/template/hello.html
2019-12-19 10:58:50,166 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:50,150_main/template/platform.html
2019-12-19 10:58:50,166 INFO [main] org.appng.core.model.ThymeleafProcessor: writing debug file /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/debug/2019-12-19-10:58:50,150_main/template/hello-custom.html
[INFO] Tests run: 24, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.41 s - in org.appng.core.model.ThymeleafProcessorTest
[INFO] Running org.appng.core.model.OutputFormatAndTypeTest
[INFO] Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 s - in org.appng.core.model.OutputFormatAndTypeTest
[INFO] Running org.appng.core.model.PageParameterProcessorTest
2019-12-19 10:58:50,319 INFO [main] org.appng.core.model.PageParameterProcessor: retrieved new value for url-param 'hash' from session: 'hashFromSession'
[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.163 s - in org.appng.core.model.PageParameterProcessorTest
[INFO] Running org.appng.core.PathInfoTest
[INFO] Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007 s - in org.appng.core.PathInfoTest
[INFO] Running org.appng.core.application.PermissionProcessorTest
2019-12-19 10:58:50,379 INFO [main] org.appng.api.support.DefaultPermissionProcessor: subject 'null' does not belong to any group, thus has no permissions
2019-12-19 10:58:50,379 INFO [main] org.appng.api.support.DefaultPermissionProcessor: subject 'null' does not belong to any group, thus has no permissions
2019-12-19 10:58:50,379 INFO [main] org.appng.api.support.DefaultPermissionProcessor: subject 'null' does not belong to any group, thus has no permissions
2019-12-19 10:58:50,379 INFO [main] org.appng.api.support.DefaultPermissionProcessor: subject 'null' does not belong to any group, thus has no permissions
2019-12-19 10:58:50,379 INFO [main] org.appng.api.support.DefaultPermissionProcessor: subject 'null' does not belong to any group, thus has no permissions
2019-12-19 10:58:50,379 INFO [main] org.appng.api.support.DefaultPermissionProcessor: subject 'null' does not belong to any group, thus has no permissions
[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.012 s - in org.appng.core.application.PermissionProcessorTest
[INFO] Running org.appng.core.controller.rest.RestActionTest
2019-12-19 10:58:51,027 ERROR [main] org.appng.core.controller.rest.RestOperation$RestErrorHandler: error in REST service
java.io.IOException: BOOOM!
at org.appng.core.controller.rest.RestOperationTest.testHandleException(RestOperationTest.java:98)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
[INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.644 s - in org.appng.core.controller.rest.RestActionTest
[INFO] Running org.appng.core.controller.rest.RestDataSourceTest
2019-12-19 10:58:51,175 ERROR [main] org.appng.core.controller.rest.RestOperation$RestErrorHandler: error in REST service
java.io.IOException: BOOOM!
at org.appng.core.controller.rest.RestOperationTest.testHandleException(RestOperationTest.java:98)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.142 s - in org.appng.core.controller.rest.RestDataSourceTest
[INFO] Running org.appng.core.controller.rest.RestOperationTest
2019-12-19 10:58:51,177 ERROR [main] org.appng.core.controller.rest.RestOperation$RestErrorHandler: error in REST service
java.io.IOException: BOOOM!
at org.appng.core.controller.rest.RestOperationTest.testHandleException(RestOperationTest.java:98)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in org.appng.core.controller.rest.RestOperationTest
[INFO] Running org.appng.core.controller.PlatformConfigTest
2019-12-19 10:58:51,180 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:51,181 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@71d53591, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@70ed82cd, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@6e955295, org.springframework.test.context.support.DirtiesContextTestExecutionListener@3a72e19f, org.springframework.test.context.transaction.TransactionalTestExecutionListener@625322fd, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@7eb43f90, org.springframework.test.context.event.EventPublishingTestExecutionListener@3af1cb29]
2019-12-19 10:58:51,290 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:51,321 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 31ms. Found 15 repository interfaces.
2019-12-19 10:58:51,323 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:51,353 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 29ms. Found 15 repository interfaces.
2019-12-19 10:58:51,383 INFO [main] org.appng.core.repository.config.HikariCPConfigurer: connection jdbc:hsqldb:mem://appng uses datasource org.hsqldb.jdbc.JDBCDataSource
2019-12-19 10:58:51,422 INFO [main] com.zaxxer.hikari.HikariDataSource: appNG ROOT connection - Starting...
2019-12-19 10:58:51,804 INFO [main] com.zaxxer.hikari.pool.PoolBase: appNG ROOT connection - Driver does not support get/set network timeout for connections. (feature not supported)
2019-12-19 10:58:51,812 INFO [main] com.zaxxer.hikari.HikariDataSource: appNG ROOT connection - Start completed.
2019-12-19 10:58:51,825 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: appNG]
2019-12-19 10:58:51,861 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:51,879 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:52,048 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:52,048 INFO [main] org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'appNG'
2019-12-19 10:58:52,084 INFO [main] org.appng.core.domain.PlatformEventListener: Using application context org.springframework.context.support.GenericApplicationContext@1722abf1, started on Thu Dec 19 10:58:51 CET 2019
2019-12-19 10:58:52,404 INFO [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver org.hsqldb.jdbc.JDBCDriver
2019-12-19 10:58:52,405 INFO [main] org.appng.core.service.MigrationService: connected to jdbc:hsqldb:mem://appng (HSQL Database Engine 2.5.0)
2019-12-19 10:58:52,406 INFO [main] org.flywaydb.core.internal.database.DatabaseFactory: Database: jdbc:hsqldb:mem://appng (HSQL Database Engine 2.5)
2019-12-19 10:58:52,406 WARN [main] org.flywaydb.core.internal.database.base.Database: Flyway upgrade recommended: HSQLDB 2.5 is newer than this version of Flyway and support has not been tested.
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.234 s - in org.appng.core.controller.PlatformConfigTest
[INFO] Running org.appng.core.controller.messaging.MessagingTest
2019-12-19 10:58:52,437 INFO [main] org.appng.core.controller.messaging.MulticastReceiver: about to execute org.appng.core.controller.messaging.MessagingTest$TestEvent - Origin: appng.node2 - Site: localhost
2019-12-19 10:58:52,439 INFO [main] org.appng.core.controller.messaging.MulticastReceiver: about to execute org.appng.core.controller.messaging.MessagingTest$TestEvent - Origin: appng.node1 - Site: localhost
2019-12-19 10:58:52,439 INFO [main] org.appng.core.controller.messaging.MulticastReceiver: about to execute org.appng.core.controller.messaging.MessagingTest$TestEvent - Origin: appng.node2 - Site: localhost
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.02 s - in org.appng.core.controller.messaging.MessagingTest
[INFO] Running org.appng.core.controller.RequestUtilTest
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 s - in org.appng.core.controller.RequestUtilTest
[INFO] Running org.appng.core.controller.ApplicationContextTest
2019-12-19 10:58:52,449 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: 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.event.EventPublishingTestExecutionListener]
2019-12-19 10:58:52,449 INFO [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@5c30fbc5, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@68f6e2c3, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@547985d7, org.springframework.test.context.support.DirtiesContextTestExecutionListener@3e750a08, org.springframework.test.context.transaction.TransactionalTestExecutionListener@654030d0, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@3a7f3641, org.springframework.test.context.event.EventPublishingTestExecutionListener@22305be4]
2019-12-19 10:58:52,500 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data repositories in DEFAULT mode.
2019-12-19 10:58:52,509 INFO [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 8ms. Found 0 repository interfaces.
2019-12-19 10:58:52,524 WARN [main] org.springframework.orm.jpa.persistenceunit.DefaultPersistenceUnitManager: Found explicit default persistence unit with name 'hsql-testdb' in persistence.xml - overriding local default persistence unit settings ('packagesToScan'/'mappingResources')
2019-12-19 10:58:52,525 INFO [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2019-12-19 10:58:52,552 INFO [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.dialect.HSQLDialect
2019-12-19 10:58:52,556 INFO [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2019-12-19 10:58:52,671 INFO [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2019-12-19 10:58:52,672 INFO [main] org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2019-12-19 10:58:52,707 WARN [main] org.appng.api.support.RequestFactoryBean: invalid value for platform property 'uploadDir', folder 'null/target/uploads' does not exist!
2019-12-19 10:58:52,718 INFO [main] org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.267 s - in org.appng.core.controller.ApplicationContextTest
[INFO] Running org.appng.core.controller.RedirectTest
2019-12-19 10:58:52,723 INFO [main] org.appng.core.Redirect : Redirecting request to /targeturl (301)
2019-12-19 10:58:52,724 INFO [main] org.appng.core.Redirect : Redirecting request to targeturl (302)
2019-12-19 10:58:52,724 INFO [main] org.appng.core.Redirect : Redirecting request to http://www.example.com (301)
[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 s - in org.appng.core.controller.RedirectTest
[INFO] Running org.appng.core.controller.PlatformStartupTest
2019-12-19 10:58:52,749 INFO [main] org.appng.core.controller.Log4jConfigurer: Initialized log4j from classpath:log4j.properties
2019-12-19 10:58:52,750 INFO [main] org.appng.core.controller.PlatformStartup:
2019-12-19 10:58:52,750 INFO [main] org.appng.core.controller.PlatformStartup: Launching appNG, the Next Generation Application Platform ...
2019-12-19 10:58:52,750 INFO [main] org.appng.core.controller.PlatformStartup:
2019-12-19 10:58:52,752 INFO [main] org.appng.core.controller.PlatformStartup: - - ---- ----------------------------------------- -------- - -
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: ____ _______ _____ .---,,--,-^²²^-,.
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: .,--^^²´´ `^^²´´ `²^-.-²´´ ``²---´ dSb. db ,dS$P² <
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: ,-´_.dSS$§§§§$Sb. .dS$§§§§§$Sb. : .dS$§§§§$SSb. : $§4b.$$ l$´ ss ;
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: ,/ .dS$SP²^^^²4$§§$ $§§$P²^^^²4S$$b.`4$$P²^^^²4S§$b. 4$`4b$P `4S$SP |
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: ! .$§SP° $§§$ $§§$´ `4S§$.`4$´ `4S§$. .-----^²------´
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: ; [$§$l $§§$ $§§$ l$§$] l$ l$§$] !
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: l.`S$Sb. $§§$ $§§$ ,dS$S´ d$ ,dS$S´ ;
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: \ `4S$Sbsaaasd$§§$ $§§$ssaaasdS$SP´,d$$ssaaasdS$SP´ l
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: \_ ``4SS$§§§§§§§$ $§§§§§§§$SSP´´ $§§§§§§§$SSP´´_.^
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: `----,_,.____,. $$$$ ___.___,^ $$$$ ___.,--^
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: _ _ ______ ____ ! $§§$ ! ____ _ ! $$$$ | ________ _______ ____ _ _
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: | $$$$ ; l $$$$ ;
2019-12-19 10:58:52,753 INFO [main] org.appng.core.controller.PlatformStartup: `--,.-^´ `--,.-^´
2019-12-19 10:58:52,755 INFO [main] org.appng.core.service.HsqlStarter: starting HSQL Server 2.5.0 at /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/WEB-INF/database/appng on port 9050
2019-12-19 10:58:52,770 INFO [HSQLDB Server @141b0618] hsqldb.db.HSQLDB6F1D98865F.ENGINE: Checkpoint start
2019-12-19 10:58:52,770 INFO [HSQLDB Server @141b0618] hsqldb.db.HSQLDB6F1D98865F.ENGINE: checkpointClose start
2019-12-19 10:58:52,776 INFO [HSQLDB Server @141b0618] hsqldb.db.HSQLDB6F1D98865F.ENGINE: checkpointClose synched
2019-12-19 10:58:52,784 INFO [HSQLDB Server @141b0618] hsqldb.db.HSQLDB6F1D98865F.ENGINE: checkpointClose script done
2019-12-19 10:58:52,798 INFO [HSQLDB Server @141b0618] hsqldb.db.HSQLDB6F1D98865F.ENGINE: checkpointClose end
2019-12-19 10:58:52,800 INFO [HSQLDB Server @141b0618] hsqldb.db.HSQLDB6F1D98865F.ENGINE: Checkpoint end - txts: 1
2019-12-19 10:58:52,856 INFO [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver org.hsqldb.jdbc.JDBCDriver
2019-12-19 10:58:52,962 INFO [main] org.appng.core.service.MigrationService: connected to jdbc:hsqldb:hsql://localhost:9050/appng (HSQL Database Engine 2.5.0)
2019-12-19 10:58:53,067 INFO [main] org.flywaydb.core.internal.database.DatabaseFactory: Database: jdbc:hsqldb:hsql://localhost:9050/appng (HSQL Database Engine 2.5)
2019-12-19 10:58:53,068 WARN [main] org.flywaydb.core.internal.database.base.Database: Flyway upgrade recommended: HSQLDB 2.5 is newer than this version of Flyway and support has not been tested.
2019-12-19 10:58:53,195 INFO [main] org.appng.core.service.MigrationService: connected to jdbc:hsqldb:hsql://localhost:9050/appng (HSQL Database Engine 2.5.0)
2019-12-19 10:58:53,299 INFO [main] org.flywaydb.core.internal.database.DatabaseFactory: Database: jdbc:hsqldb:hsql://localhost:9050/appng (HSQL Database Engine 2.5)
2019-12-19 10:58:53,301 WARN [main] org.flywaydb.core.internal.database.base.Database: Flyway upgrade recommended: HSQLDB 2.5 is newer than this version of Flyway and support has not been tested.
2019-12-19 10:58:53,321 INFO [main] org.flywaydb.core.internal.command.DbValidate: Successfully validated 14 migrations (execution time 00:00.013s)
2019-12-19 10:58:53,330 INFO [main] org.flywaydb.core.internal.schemahistory.JdbcTableSchemaHistory: Creating Schema History table: "PUBLIC"."schema_version"
2019-12-19 10:58:53,339 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Current version of schema "PUBLIC": << Empty Schema >>
2019-12-19 10:58:53,340 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.0 - appNG initial setup
2019-12-19 10:58:53,359 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.1 - Quartz initial setup
2019-12-19 10:58:53,371 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.2 - add template
2019-12-19 10:58:53,378 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.2.1 - add repository strict
2019-12-19 10:58:53,385 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.2.2 - add repository digest
2019-12-19 10:58:53,392 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.2.3 - set resource bytes not null
2019-12-19 10:58:53,398 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.3.0 - add type to template
2019-12-19 10:58:53,404 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.3.1 - add global admin role
2019-12-19 10:58:53,413 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 1.3.2 - add repository accepted certs
2019-12-19 10:58:53,422 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 2.0.0 - add platform event
2019-12-19 10:58:53,428 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 4.0.0 - add job execution record
2019-12-19 10:58:53,434 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 4.1.0 - change caching properties
2019-12-19 10:58:53,435 WARN [main] org.flywaydb.core.internal.sqlscript.DefaultSqlScriptExecutor: DB: no data (SQL State: 02000 - Error Code: -1100)
2019-12-19 10:58:53,436 WARN [main] org.flywaydb.core.internal.sqlscript.DefaultSqlScriptExecutor: DB: no data (SQL State: 02000 - Error Code: -1100)
2019-12-19 10:58:53,439 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 4.1.1 - add site reload count
2019-12-19 10:58:53,444 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version 4.1.2 - add property type
2019-12-19 10:58:53,450 INFO [main] org.flywaydb.core.internal.command.DbMigrate: Successfully applied 14 migrations to schema "PUBLIC" (execution time 00:00.120s)
2019-12-19 10:58:53,450 INFO [main] org.appng.core.controller.PlatformStartup: Platform connection: HSQL jdbc:hsqldb:hsql://localhost:9050/appng
2019-12-19 10:58:53,451 INFO [main] org.appng.core.controller.PlatformStartup: appNG null started in 701 ms.
2019-12-19 10:58:53,451 INFO [main] org.appng.core.controller.PlatformStartup: ====================================================================================================
2019-12-19 10:58:58,454 INFO [main] org.appng.core.service.HazelcastConfigurer: Shutting down instance appNG
2019-12-19 10:58:58,455 INFO [main] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is SHUTTING_DOWN
2019-12-19 10:58:58,457 INFO [main] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is SHUTTING_DOWN
2019-12-19 10:58:58,472 INFO [hz.appNG.cached.thread-1] com.hazelcast.internal.partition.impl.MigrationManager: [10.102.4.100]:5701 [dev] [3.12.5] Shutdown request of Member [10.102.4.100]:5701 - d5215a62-22cf-47cd-813b-937655a4eeb9 this is handled
2019-12-19 10:58:58,493 INFO [main] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] Shutting down connection manager...
2019-12-19 10:58:58,499 INFO [main] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] Shutting down node engine...
2019-12-19 10:58:58,519 INFO [main] com.hazelcast.instance.NodeExtension: [10.102.4.100]:5701 [dev] [3.12.5] Destroying node NodeExtension.
2019-12-19 10:58:58,519 INFO [main] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] Hazelcast Shutdown is completed in 51 ms.
2019-12-19 10:58:58,520 INFO [main] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is SHUTDOWN
2019-12-19 10:58:58,521 INFO [main] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] Node is already shutting down... Waiting for shutdown process to complete...
2019-12-19 10:58:58,521 INFO [main] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is SHUTDOWN
2019-12-19 10:58:58,521 INFO [main] org.appng.core.controller.PlatformStartup: appNG stopped.
2019-12-19 10:58:58,521 INFO [main] org.appng.core.controller.PlatformStartup: ====================================================================================================
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.793 s - in org.appng.core.controller.PlatformStartupTest
[INFO] Running org.appng.core.controller.handler.GuiHandlerTest
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 s - in org.appng.core.controller.handler.GuiHandlerTest
[INFO] Running org.appng.core.controller.handler.ServiceRequestHandlerTest
2019-12-19 10:58:59,156 WARN [main] org.appng.core.controller.handler.ServiceRequestHandler: No such application 'bar?jin=fizz' for site 'localhost' returning 404 (path: /services/localhost/bar?jin=fizz)
2019-12-19 10:58:59,188 ERROR [main] org.appng.core.controller.handler.ServiceRequestHandler: no webservice 'foobar' for application 'appng-demoapplication' in site 'localhost'
2019-12-19 10:58:59,194 WARN [main] org.appng.core.controller.handler.RestService: no @RestController found for /services/site1/appng-demoapplication/rest/notfound
2019-12-19 10:59:00,195 INFO [main] org.appng.api.RequestUtil : site 'localhost [STARTING] (#132909799)' is currently being started, waited 1000ms
2019-12-19 10:59:00,196 WARN [main] org.appng.core.controller.handler.ServiceRequestHandler: Site 'localhost' is in state STARTING, returning 503 (path: /services/localhost/foobar)
2019-12-19 10:59:00,249 WARN [main] org.appng.core.controller.handler.ServiceRequestHandler: No such site: 'foo', returning 404 (path: /services/foo/bar?jin=fizz)
[INFO] Tests run: 18, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.719 s - in org.appng.core.controller.handler.ServiceRequestHandlerTest
[INFO] Running org.appng.core.controller.RepositoryWatcherTest
Dec 19, 2019 10:59:00 AM com.hazelcast.config.AbstractConfigLocator
INFO: Loading 'hazelcast.xml' from the classpath.
2019-12-19 10:59:00,303 INFO [Time-limited test] com.hazelcast.instance.AddressPicker: [LOCAL] [dev] [3.12.5] Prefer IPv4 stack is true, prefer IPv6 addresses is false
2019-12-19 10:59:00,303 INFO [Time-limited test] com.hazelcast.instance.AddressPicker: [LOCAL] [dev] [3.12.5] Picked [10.102.4.100]:5701, using socket ServerSocket[addr=/0:0:0:0:0:0:0:0,localport=5701], bind any local is true
2019-12-19 10:59:00,304 INFO [Time-limited test] com.hazelcast.system : [10.102.4.100]:5701 [dev] [3.12.5] Hazelcast 3.12.5 (20191210 - 294ff46) starting at [10.102.4.100]:5701
2019-12-19 10:59:00,305 INFO [Time-limited test] com.hazelcast.system : [10.102.4.100]:5701 [dev] [3.12.5] Copyright (c) 2008-2019, Hazelcast, Inc. All Rights Reserved.
2019-12-19 10:59:00,314 INFO [Time-limited test] com.hazelcast.spi.impl.operationservice.impl.BackpressureRegulator: [10.102.4.100]:5701 [dev] [3.12.5] Backpressure is disabled
2019-12-19 10:59:00,329 INFO [Time-limited test] com.hazelcast.spi.impl.operationexecutor.impl.OperationExecutorImpl: [10.102.4.100]:5701 [dev] [3.12.5] Starting 4 partition threads and 3 generic threads (1 dedicated for priority tasks)
2019-12-19 10:59:00,335 INFO [Time-limited test] com.hazelcast.internal.diagnostics.Diagnostics: [10.102.4.100]:5701 [dev] [3.12.5] Diagnostics disabled. To enable add -Dhazelcast.diagnostics.enabled=true to the JVM arguments.
2019-12-19 10:59:00,336 INFO [Time-limited test] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is STARTING
2019-12-19 10:59:00,344 WARN [Time-limited test] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] No join method is enabled! Starting standalone.
2019-12-19 10:59:00,345 INFO [Time-limited test] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is STARTED
2019-12-19 10:59:00,345 INFO [Time-limited test] org.appng.core.service.HazelcastConfigurer: Created default instance appNG
2019-12-19 10:59:00,350 INFO [Time-limited test] com.hazelcast.internal.partition.impl.PartitionStateManager: [10.102.4.100]:5701 [dev] [3.12.5] Initializing cluster partition table arrangement...
2019-12-19 10:59:00,393 INFO [Time-limited test] com.hazelcast.cache.impl.CacheService: [10.102.4.100]:5701 [dev] [3.12.5] Added cache config: CacheConfig{name='pageCache-localhost', managerPrefix='/hz/', inMemoryFormat=BINARY, backupCount=1, hotRestart=HotRestartConfig{enabled=false, fsync=false}, wanReplicationRef=null}
2019-12-19 10:59:00,429 INFO [Time-limited test] org.appng.core.service.CacheService: Created cache 'pageCache-localhost' with TTL of 1800 seconds (statistics: true).
2019-12-19 10:59:00,625 INFO [Time-limited test] org.appng.core.controller.RepositoryWatcher: /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/test-classes/conf/urlrewrite.xml has been read, 9 forward rules have been processed
2019-12-19 10:59:00,626 INFO [Time-limited test] org.appng.core.controller.RepositoryWatcher: watching /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/test-classes/conf
2019-12-19 10:59:00,626 INFO [Time-limited test] org.appng.core.controller.RepositoryWatcher: watching /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/test-classes/repository/manager/www/de
2019-12-19 10:59:00,631 INFO [repositoryWatcher] org.appng.core.controller.RepositoryWatcher: start watching...
2019-12-19 10:59:00,670 INFO [repositoryWatcher] org.appng.core.service.CacheService: removed 1 cache elements for /de/fehler (cache size: 4)
2019-12-19 10:59:00,691 INFO [repositoryWatcher] org.appng.core.service.CacheService: removed 1 cache elements for /de/error (cache size: 3)
2019-12-19 10:59:00,711 INFO [repositoryWatcher] org.appng.core.service.CacheService: removed 1 cache elements for /de/fault (cache size: 2)
2019-12-19 10:59:00,735 INFO [repositoryWatcher] org.appng.core.service.CacheService: removed 1 cache elements for /de/test (cache size: 1)
2019-12-19 10:59:00,745 INFO [repositoryWatcher] org.appng.core.controller.RepositoryWatcher: /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/test-classes/conf/urlrewrite.xml has been read, 9 forward rules have been processed
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.548 s - in org.appng.core.controller.RepositoryWatcherTest
[INFO] Running org.appng.core.controller.SessionListenerTest
2019-12-19 10:59:00,812 INFO [main] org.appng.core.controller.SessionListener: Session created: ZUS383883OTOTOLSKKL (created: 2019-12-19 10:59:00)
2019-12-19 10:59:00,814 INFO [main] org.appng.core.controller.SessionListener: Session created: ERTERTZGFHFGHGFH234 (created: 2019-12-19 10:59:00)
2019-12-19 10:59:00,815 INFO [main] org.appng.core.controller.SessionListener: Session destroyed: ZUS383883OTOTOLSKKL (created: 2019-12-19 10:59:00, accessed: 2019-12-19 10:59:00, requests: 1, domain: http://localhost:8080, user-agent: null)
2019-12-19 10:59:00,816 INFO [main] org.appng.core.controller.SessionListener: Session created: ZUS383883OTOTOLSKKL (created: 2019-12-19 10:59:00)
[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.013 s - in org.appng.core.controller.SessionListenerTest
[INFO] Running org.appng.core.controller.ControllerTest
2019-12-19 10:59:00,854 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,856 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#657518504 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,912 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,913 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#912721896 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,916 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,917 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#837348912 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,917 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,918 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1151482077 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,924 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,924 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#183716640 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,926 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,926 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#654076766 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,927 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,928 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2012144124 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,929 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,931 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#51572553 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,932 INFO [main] org.appng.core.Redirect : Redirecting request to /de/index (301)
2019-12-19 10:59:00,932 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,933 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#121769284 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,939 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,940 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#804579670 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,954 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,955 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#645161328 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,957 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,958 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1431767656 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,959 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,959 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#863785348 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,960 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,961 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#472073684 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,961 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,962 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#833369355 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,964 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,965 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#105824284 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,966 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,967 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#443392953 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,968 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,969 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1789052156 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,970 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,971 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#106823652 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,971 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,972 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#254067274 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,973 INFO [main] org.appng.core.Redirect : Redirecting request /de to /de/index (301)
2019-12-19 10:59:00,973 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,974 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#34341692 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,975 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,975 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#842917742 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,978 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,979 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1357671596 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,982 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,982 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1579915983 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,991 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,992 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#715704825 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,993 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,993 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1189299112 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,994 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,995 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1390879543 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,995 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,996 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2077432082 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:00,997 INFO [main] org.appng.core.controller.Controller: Controller created
2019-12-19 10:59:00,998 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#575076179 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
[INFO] Tests run: 29, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.176 s - in org.appng.core.controller.ControllerTest
[INFO] Running org.appng.core.controller.filter.JspExtensionFilterTest
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.252 s - in org.appng.core.controller.filter.JspExtensionFilterTest
[INFO] Running org.appng.core.controller.filter.RedirectFilterTest
2019-12-19 10:59:01,299 INFO [main] org.springframework.mock.web.MockServletContext: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: conf reload check set to 5000s
2019-12-19 10:59:01,302 INFO [main] org.springframework.mock.web.MockServletContext: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter ERROR: unable to find urlrewrite conf file at /WEB-INF/urlrewrite.xml
2019-12-19 10:59:01,306 INFO [main] org.springframework.mock.web.MockServletContext: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: conf reload check set to 5000s
2019-12-19 10:59:01,312 INFO [main] org.springframework.mock.web.MockServletContext: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
2019-12-19 10:59:01,319 INFO [main] org.springframework.mock.web.MockServletContext: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.068 s - in org.appng.core.controller.filter.RedirectFilterTest
[INFO] Running org.appng.core.controller.filter.PageCacheFilterTest
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.075 s - in org.appng.core.controller.filter.PageCacheFilterTest
[INFO] Running org.appng.core.controller.PlatformProcessorTest
2019-12-19 10:59:01,407 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1756370424 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:01,417 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#278007742 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:01,443 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#562794315 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
2019-12-19 10:59:01,448 ERROR [main] org.appng.core.model.PlatformProcessor: error while processing
java.io.FileNotFoundException: /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/xsl/platform.xsl (No such file or directory)
at java.io.FileInputStream.open0(Native Method)
at java.io.FileInputStream.open(FileInputStream.java:195)
at java.io.FileInputStream.<init>(FileInputStream.java:138)
at org.appng.core.model.PlatformTransformer.transform(PlatformTransformer.java:128)
at org.appng.core.model.PlatformProcessor.processWithTemplate(PlatformProcessor.java:106)
at org.appng.core.controller.PlatformProcessorTest.testTransformError(PlatformProcessorTest.java:143)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273)
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238)
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159)
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
2019-12-19 10:59:01,466 INFO [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1727926662 for site manager with parent sun.misc.Launcher$AppClassLoader#1252169911 created
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.083 s - in org.appng.core.controller.PlatformProcessorTest
2019-12-19 10:59:01,503 INFO [hz.ShutdownThread] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] Running shutdown hook... Current state: ACTIVE
2019-12-19 10:59:01,505 INFO [SpringContextShutdownHook] org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'appNG'
2019-12-19 10:59:01,506 INFO [hz.ShutdownThread] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is SHUTTING_DOWN
2019-12-19 10:59:01,507 INFO [SpringContextShutdownHook] com.zaxxer.hikari.HikariDataSource: appNG ROOT connection - Shutdown initiated...
2019-12-19 10:59:01,512 INFO [hz.ShutdownThread] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is SHUTTING_DOWN
2019-12-19 10:59:01,518 INFO [hz.appNG.cached.thread-4] com.hazelcast.internal.partition.impl.MigrationManager: [10.102.4.100]:5701 [dev] [3.12.5] Shutdown request of Member [10.102.4.100]:5701 - 2b85e101-8267-4deb-950b-326d93985682 this is handled
2019-12-19 10:59:01,530 INFO [SpringContextShutdownHook] com.zaxxer.hikari.HikariDataSource: appNG ROOT connection - Shutdown completed.
2019-12-19 10:59:01,579 INFO [hz.ShutdownThread] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] Shutting down connection manager...
2019-12-19 10:59:01,584 INFO [hz.ShutdownThread] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] Shutting down node engine...
2019-12-19 10:59:01,587 INFO [hz.ShutdownThread] com.hazelcast.cache.impl.CacheService: [10.102.4.100]:5701 [dev] [3.12.5] Removed cache config: CacheConfig{name='pageCache-localhost', managerPrefix='/hz/', inMemoryFormat=BINARY, backupCount=1, hotRestart=HotRestartConfig{enabled=false, fsync=false}, wanReplicationRef=null}
2019-12-19 10:59:01,602 INFO [hz.ShutdownThread] com.hazelcast.instance.NodeExtension: [10.102.4.100]:5701 [dev] [3.12.5] Destroying node NodeExtension.
2019-12-19 10:59:01,603 INFO [hz.ShutdownThread] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] Hazelcast Shutdown is completed in 90 ms.
2019-12-19 10:59:01,603 INFO [hz.ShutdownThread] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is SHUTDOWN
2019-12-19 10:59:01,603 INFO [hz.ShutdownThread] com.hazelcast.instance.Node : [10.102.4.100]:5701 [dev] [3.12.5] Node is already shutting down... Waiting for shutdown process to complete...
2019-12-19 10:59:01,603 INFO [hz.ShutdownThread] com.hazelcast.core.LifecycleService: [10.102.4.100]:5701 [dev] [3.12.5] [10.102.4.100]:5701 is SHUTDOWN
[INFO]
[INFO] Results:
[INFO]
[ERROR] Failures:
[ERROR] CoreServiceTest.testDeleteSiteWithEnvironment:427 expected null, but was:<STARTED>
[INFO]
[ERROR] Tests run: 321, Failures: 1, Errors: 0, Skipped: 26
[INFO]
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] appNG Parent ....................................... SUCCESS [ 8.377 s]
[INFO] appNG Tools ........................................ SUCCESS [ 28.616 s]
[INFO] appNG Mail ......................................... SUCCESS [ 6.116 s]
[INFO] appNG Forms ........................................ SUCCESS [ 8.543 s]
[INFO] appng Formtags ..................................... SUCCESS [ 3.714 s]
[INFO] appNG XML-API ...................................... SUCCESS [ 11.426 s]
[INFO] appNG public API ................................... SUCCESS [ 17.537 s]
[INFO] appNG testsupport .................................. SUCCESS [ 7.488 s]
[INFO] appNG REST API ..................................... SUCCESS [ 7.994 s]
[INFO] appNG Persistence-Tools ............................ SUCCESS [ 17.388 s]
[INFO] appNG Search ....................................... SUCCESS [ 26.414 s]
[INFO] appNG Core Library ................................. FAILURE [01:09 min]
[INFO] appNG Command Line Interface ....................... SKIPPED
[INFO] appNG Tag Library .................................. SKIPPED
[INFO] appNG Application .................................. SKIPPED
[INFO] appNG application BOM .............................. SKIPPED
[INFO] appNG Documentation ................................ SKIPPED
[INFO] appNG Template Assembly Descriptors ................ SKIPPED
[INFO] appNG Template Parent .............................. SKIPPED
[INFO] appng-application-assembly ......................... SKIPPED
[INFO] appNG application parent ........................... SKIPPED
[INFO] Archetype - appng-archetype-application ............ SKIPPED
[INFO] appNGizer JAXB API ................................. SKIPPED
[INFO] appNGizer .......................................... SKIPPED
[INFO] appNG appNGizer Maven Plugin ....................... SKIPPED
[INFO] appNG camunda ...................................... SKIPPED
[INFO] appNG Application, including Camunda BPM process engine libraries SKIPPED
[INFO] appNG Maven Plugin ................................. SKIPPED
[INFO] upNGizr ............................................ SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 03:33 min
[INFO] Finished at: 2019-12-19T10:59:02+01:00
[INFO] Final Memory: 107M/1483M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:3.0.0-M3:test (default-test) on project appng-core: There are test failures.
[ERROR]
[ERROR] Please refer to /var/lib/jenkins/workspace/appNG_CI_feature_APPNG-2295/appng-core/target/surefire-reports for the individual test results.
[ERROR] Please refer to dump files (if any exist) [date].dump, [date]-jvmRun[N].dump and [date].dumpstream.
[ERROR] -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
[ERROR]
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR] mvn <goals> -rf :appng-core
[Pipeline] }
[Pipeline] // stage
[Pipeline] stage
[Pipeline] { (Results)
[Pipeline] junit
Recording test results
[Pipeline] }
[Pipeline] // stage
[Pipeline] stage
[Pipeline] { (notifyFinish)
[Pipeline] emailext
Not sending mail to unregistered user noreply@github.com because your SCM claimed this was associated with a user ID ‘noreply' which your security realm does not recognize; you may need changes in your SCM plugin
An attempt to send an e-mail to empty list of recipients, ignored.
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // node
[Pipeline] End of Pipeline
Finished: FAILURE
![[Jenkins]](/jenkins/static/0ac95dd5/images/svgs/logo.svg){kind=logo}
