Skip to content

Console Output

Skipping 847 KB.. Full Log
core.service.CoreService: successfully logged in user 'johndoe'
2022-07-08T14:48:59,759 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-08T14:48:59,765 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2022-07-08T14:48:59,765 INFO  [main] org.appng.core.service.CoreService: 'null' logged out
2022-07-08T14:48:59,767 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@1ebd47fd, testMethod = testLoginGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:48:59,768 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@366046d9, testMethod = testLoginPrincipal@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:48:59,781 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1276209530 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:48:59,789 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#13817911 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:48:59,795 INFO  [main] org.appng.core.service.CoreService: user subject-2 found
2022-07-08T14:48:59,797 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-2
2022-07-08T14:48:59,798 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'subject-2'
2022-07-08T14:48:59,798 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-08T14:48:59,798 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2022-07-08T14:48:59,798 INFO  [main] org.appng.core.service.CoreService: 'null' logged out
2022-07-08T14:48:59,800 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@366046d9, testMethod = testLoginPrincipal@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:48:59,801 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@7c94f226, testMethod = testLoginPrincipalWithGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:48:59,811 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1391046882 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:48:59,817 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1749995848 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:48:59,822 INFO  [main] org.appng.core.service.CoreService: Subject authentication failed. Trying to authenticate based on LDAP group membership.
2022-07-08T14:48:59,824 INFO  [main] org.appng.core.service.CoreService: user 'null' belongs to group 'subject-1'
2022-07-08T14:48:59,826 INFO  [main] org.appng.core.service.CoreService: User 'null' successfully authenticated.
2022-07-08T14:48:59,826 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'null'
2022-07-08T14:48:59,826 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-08T14:48:59,826 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged out
2022-07-08T14:48:59,827 INFO  [main] org.appng.core.service.CoreService: 'null' logged out
2022-07-08T14:48:59,828 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@7c94f226, testMethod = testLoginPrincipalWithGroup@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:48:59,829 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5aba547f, testMethod = testLoginSubjectIsExpired@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:48:59,840 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1146989891 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:48:59,845 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#295166379 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:48:59,848 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:00,647 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform User subject-3 has been locked because the expiry date has exceeded (Fri Jul 08 14:48:59 CEST 2022).
2022-07-08T14:49:00,649 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:00,652 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:00,653 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5aba547f, testMethod = testLoginSubjectIsExpired@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:00,654 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@62d32920, testMethod = testLoginSubjectIsInactive@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:00,665 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1428797374 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:00,670 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1567733147 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:00,672 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:01,493 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null WARN appNG platform User subject-3 has been locked due to inactivity (last login was at Fri Apr 08 14:49:00 CEST 2022).
2022-07-08T14:49:01,496 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:01,499 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:01,499 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@62d32920, testMethod = testLoginSubjectIsInactive@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:01,501 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2830d83d, testMethod = testLoginSubjectIsLocked@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:01,516 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#876396184 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:01,526 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1073161843 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:01,530 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:02,356 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Rejected login for locked user subject-3.
2022-07-08T14:49:02,361 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:02,361 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2830d83d, testMethod = testLoginSubjectIsLocked@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:02,362 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@28264aea, testMethod = testMigratePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:02,376 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#195932060 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:02,383 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#422985225 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:02,384 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Subject deve
2022-07-08T14:49:03,227 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Subject deve
2022-07-08T14:49:03,227 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@28264aea, testMethod = testMigratePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:03,229 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@406008f1, testMethod = testProvideApplication@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:03,244 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#304025597 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,251 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#649784625 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,252 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Repository testrepo
2022-07-08T14:49:03,254 INFO  [main] org.appng.core.service.CoreService: retrieving 'demo-application-1.5.2' from repository file:/var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/zip
2022-07-08T14:49:03,273 INFO  [main] org.appng.core.service.CoreService: deploying application demo-application-1.5.2
2022-07-08T14:49:03,275 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application demo-application
2022-07-08T14:49:03,277 INFO  [main] org.appng.core.service.CoreService: creating new permission 'debug' for application 'demo-application'
2022-07-08T14:49:03,278 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission debug
2022-07-08T14:49:03,279 INFO  [main] org.appng.core.service.CoreService: creating new permission 'output-format.html' for application 'demo-application'
2022-07-08T14:49:03,279 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-format.html
2022-07-08T14:49:03,279 INFO  [main] org.appng.core.service.CoreService: creating new permission 'output-type.webgui' for application 'demo-application'
2022-07-08T14:49:03,280 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-type.webgui
2022-07-08T14:49:03,281 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Administrator
2022-07-08T14:49:03,285 INFO  [main] org.appng.core.service.CoreService: added permission 'output-format.html' to role 'Administrator'
2022-07-08T14:49:03,286 INFO  [main] org.appng.core.service.CoreService: added permission 'output-type.webgui' to role 'Administrator'
2022-07-08T14:49:03,287 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-08T14:49:03,287 INFO  [main] org.appng.core.service.CoreService: creating new role 'Administrator' for application 'demo-application'
2022-07-08T14:49:03,288 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Debugger
2022-07-08T14:49:03,289 INFO  [main] org.appng.core.service.CoreService: added permission 'debug' to role 'Debugger'
2022-07-08T14:49:03,289 INFO  [main] org.appng.core.service.CoreService: creating new role 'Debugger' for application 'demo-application'
2022-07-08T14:49:03,292 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.foo
2022-07-08T14:49:03,292 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.clobValue
2022-07-08T14:49:03,295 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Administrator
2022-07-08T14:49:03,296 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Debugger
2022-07-08T14:49:03,301 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,301 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,301 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,301 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,301 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,302 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,302 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,302 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,302 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,302 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-1.5.2'
2022-07-08T14:49:03,302 INFO  [main] org.appng.core.service.CoreService: extracting filebased application demo-application - 1.5.2 to target/ROOT/applications/demo-application
2022-07-08T14:49:03,317 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-format.html'
2022-07-08T14:49:03,318 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-type.webgui'
2022-07-08T14:49:03,318 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-08T14:49:03,320 INFO  [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'debug'
2022-07-08T14:49:03,325 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Application demo-application
2022-07-08T14:49:03,326 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@406008f1, testMethod = testProvideApplication@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:03,328 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2f9e8f1b, testMethod = testProvideApplicationUpdate@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:03,341 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#649245294 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,347 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1778565378 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,365 INFO  [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/ROOT/WEB-INF/cache/platform/site-1/demo-application
2022-07-08T14:49:03,365 INFO  [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/ROOT/WEB-INF/cache/application/site-1/demo-application
2022-07-08T14:49:03,367 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Assigned application demo-application to site site-1
2022-07-08T14:49:03,368 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.application.demo-application.foo
2022-07-08T14:49:03,369 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.application.demo-application.clobValue
2022-07-08T14:49:03,369 INFO  [main] org.appng.core.service.CoreService: retrieving 'demo-application-1.5.3' from repository file:/var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/zip
2022-07-08T14:49:03,377 INFO  [main] org.appng.core.service.CoreService: updating application demo-application-1.5.3
2022-07-08T14:49:03,382 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,382 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,382 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,383 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,383 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,383 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,383 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,383 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,383 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,384 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-1.5.3'
2022-07-08T14:49:03,384 INFO  [main] org.appng.core.service.CoreService: extracting filebased application demo-application - 1.5.3 to target/ROOT/applications/demo-application
2022-07-08T14:49:03,387 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Application demo-application
2022-07-08T14:49:03,390 INFO  [main] org.appng.core.service.CoreService: creating new permission 'testPermission' for application 'demo-application'
2022-07-08T14:49:03,390 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission testPermission
2022-07-08T14:49:03,393 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-format.html'
2022-07-08T14:49:03,394 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-type.webgui'
2022-07-08T14:49:03,394 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-08T14:49:03,396 INFO  [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'debug'
2022-07-08T14:49:03,397 INFO  [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Debugger'
2022-07-08T14:49:03,399 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Debugger
2022-07-08T14:49:03,400 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Tester
2022-07-08T14:49:03,401 INFO  [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Tester'
2022-07-08T14:49:03,401 INFO  [main] org.appng.core.service.CoreService: creating new role 'Tester' for application 'demo-application'
2022-07-08T14:49:03,402 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.bar
2022-07-08T14:49:03,403 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.application.demo-application.bar
2022-07-08T14:49:03,405 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.application.demo-application.clobValue
2022-07-08T14:49:03,406 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.application.demo-application.foo
2022-07-08T14:49:03,407 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.site.site-1.application.demo-application.foo
2022-07-08T14:49:03,407 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Tester
2022-07-08T14:49:03,408 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.application.demo-application.bar
2022-07-08T14:49:03,408 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Property platform.site.site-1.application.demo-application.bar
2022-07-08T14:49:03,410 INFO  [main] org.appng.core.service.CoreService: loading properties for application 'demo-application' of site 'site-1'
2022-07-08T14:49:03,411 INFO  [main] org.appng.core.service.CoreService: loading properties for application demo-application
2022-07-08T14:49:03,414 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Repository testrepo
2022-07-08T14:49:03,414 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2f9e8f1b, testMethod = testProvideApplicationUpdate@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:03,416 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@54625d9e, testMethod = testProvideApplicationUpdateDelete@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:03,431 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#2139178524 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,438 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#622378500 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,443 INFO  [main] org.appng.core.service.CoreService: unlinking application demo-application from site site-1, status of database-connection is NO_DB_SUPPORTED
2022-07-08T14:49:03,444 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Removed application demo-application from site site-1
2022-07-08T14:49:03,445 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.demo-application.bar
2022-07-08T14:49:03,445 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.demo-application.clobValue
2022-07-08T14:49:03,446 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.demo-application.foo
2022-07-08T14:49:03,453 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Role Administrator
2022-07-08T14:49:03,455 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Role Tester
2022-07-08T14:49:03,463 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Role Debugger
2022-07-08T14:49:03,463 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission debug
2022-07-08T14:49:03,464 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission output-type.webgui
2022-07-08T14:49:03,464 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission output-format.html
2022-07-08T14:49:03,465 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Permission testPermission
2022-07-08T14:49:03,465 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.application.demo-application.bar
2022-07-08T14:49:03,466 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.application.demo-application.clobValue
2022-07-08T14:49:03,466 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.application.demo-application.foo
2022-07-08T14:49:03,466 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Application demo-application
2022-07-08T14:49:03,468 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@54625d9e, testMethod = testProvideApplicationUpdateDelete@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:03,470 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@28578a8, testMethod = testProvideApplicationWithAdminRole@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:03,483 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#741592969 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,490 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#49039743 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,491 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Repository testrepo
2022-07-08T14:49:03,492 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Group Administrators
2022-07-08T14:49:03,493 INFO  [main] org.appng.core.service.CoreService: retrieving 'demo-application-1.5.4' from repository file:/var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/zip
2022-07-08T14:49:03,507 INFO  [main] org.appng.core.service.CoreService: deploying application demo-application-1.5.4
2022-07-08T14:49:03,508 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application demo-application
2022-07-08T14:49:03,510 INFO  [main] org.appng.core.service.CoreService: creating new permission 'debug' for application 'demo-application'
2022-07-08T14:49:03,510 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission debug
2022-07-08T14:49:03,511 INFO  [main] org.appng.core.service.CoreService: creating new permission 'output-format.html' for application 'demo-application'
2022-07-08T14:49:03,511 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-format.html
2022-07-08T14:49:03,512 INFO  [main] org.appng.core.service.CoreService: creating new permission 'output-type.webgui' for application 'demo-application'
2022-07-08T14:49:03,512 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission output-type.webgui
2022-07-08T14:49:03,513 INFO  [main] org.appng.core.service.CoreService: creating new permission 'testPermission' for application 'demo-application'
2022-07-08T14:49:03,513 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission testPermission
2022-07-08T14:49:03,514 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Administrator
2022-07-08T14:49:03,516 INFO  [main] org.appng.core.service.CoreService: added permission 'output-format.html' to role 'Administrator'
2022-07-08T14:49:03,517 INFO  [main] org.appng.core.service.CoreService: added permission 'output-type.webgui' to role 'Administrator'
2022-07-08T14:49:03,518 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-08T14:49:03,518 INFO  [main] org.appng.core.service.CoreService: creating new role 'Administrator' for application 'demo-application'
2022-07-08T14:49:03,519 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Debugger
2022-07-08T14:49:03,521 INFO  [main] org.appng.core.service.CoreService: added permission 'debug' to role 'Debugger'
2022-07-08T14:49:03,522 INFO  [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Debugger'
2022-07-08T14:49:03,522 INFO  [main] org.appng.core.service.CoreService: creating new role 'Debugger' for application 'demo-application'
2022-07-08T14:49:03,522 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role Tester
2022-07-08T14:49:03,524 INFO  [main] org.appng.core.service.CoreService: added permission 'testPermission' to role 'Tester'
2022-07-08T14:49:03,524 INFO  [main] org.appng.core.service.CoreService: creating new role 'Tester' for application 'demo-application'
2022-07-08T14:49:03,527 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.foo
2022-07-08T14:49:03,528 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.bar
2022-07-08T14:49:03,528 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.application.demo-application.clobValue
2022-07-08T14:49:03,532 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Group Administrators
2022-07-08T14:49:03,533 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Administrator
2022-07-08T14:49:03,534 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Debugger
2022-07-08T14:49:03,534 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role Tester
2022-07-08T14:49:03,539 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,539 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,539 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,540 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,540 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,540 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,540 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,541 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,541 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,541 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-1.5.4'
2022-07-08T14:49:03,541 INFO  [main] org.appng.core.service.CoreService: extracting filebased application demo-application - 1.5.4 to target/ROOT/applications/demo-application
2022-07-08T14:49:03,550 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-format.html'
2022-07-08T14:49:03,550 INFO  [main] org.appng.core.service.CoreService: role 'Administrator' already has permission 'output-type.webgui'
2022-07-08T14:49:03,551 WARN  [main] org.appng.core.service.CoreService: the role 'Administrator' references permisson 'logViewer' which does not exist!
2022-07-08T14:49:03,553 INFO  [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'debug'
2022-07-08T14:49:03,554 INFO  [main] org.appng.core.service.CoreService: role 'Debugger' already has permission 'testPermission'
2022-07-08T14:49:03,556 INFO  [main] org.appng.core.service.CoreService: role 'Tester' already has permission 'testPermission'
2022-07-08T14:49:03,559 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@28578a8, testMethod = testProvideApplicationWithAdminRole@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:03,561 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@40f44ff3, testMethod = testReloadRepository@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:03,573 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1900851706 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,579 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1690006071 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,582 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@40f44ff3, testMethod = testReloadRepository@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:03,584 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@47c86b27, testMethod = testResetPassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:03,596 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#690287861 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:03,601 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#818240877 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,456 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:04,457 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@47c86b27, testMethod = testResetPassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:04,458 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2738b906, testMethod = testRestoreSubject@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:04,471 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#740331110 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,477 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#363026347 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,482 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@2738b906, testMethod = testRestoreSubject@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:04,483 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@1dd00e34, testMethod = testSaveProperties@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:04,496 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#253392568 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,502 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#386380441 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,503 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property foobaz.a
2022-07-08T14:49:04,503 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property foobaz.b
2022-07-08T14:49:04,505 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@1dd00e34, testMethod = testSaveProperties@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:04,507 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5283ed0a, testMethod = testSaveProperty@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:04,519 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1020211816 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,525 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1646395396 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,526 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property prop1
2022-07-08T14:49:04,527 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5283ed0a, testMethod = testSaveProperty@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:04,530 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@6b7cbb60, testMethod = testUnlinkApplicationFromSiteIntegerString@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:04,541 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#615760628 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,547 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#748932417 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,550 INFO  [main] org.appng.core.service.CoreService: unlinking application manager from site site-1, status of database-connection is NO_DB_SUPPORTED
2022-07-08T14:49:04,550 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Removed application manager from site site-1
2022-07-08T14:49:04,551 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.manager.foo
2022-07-08T14:49:04,552 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null DELETE appNG platform Property platform.site.site-1.application.manager.foobar
2022-07-08T14:49:04,553 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@6b7cbb60, testMethod = testUnlinkApplicationFromSiteIntegerString@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:04,554 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@14021397, testMethod = testUpdatePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:04,565 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#378451613 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:04,572 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1926282183 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:05,405 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:05,406 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@14021397, testMethod = testUpdatePassword@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:05,408 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5e533e66, testMethod = testUpdatePasswordFail@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@736f2875]; rollback [false]
2022-07-08T14:49:05,420 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#1872915229 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:05,426 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#271354879 for site example with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:05,429 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@a3c48d4 testClass = CoreServiceTest, testInstance = org.appng.core.service.CoreServiceTest@5e533e66, testMethod = testUpdatePasswordFail@CoreServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@63fa8787 testClass = CoreServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:05,431 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-08T14:49:05,431 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[WARNING] Tests run: 85, Failures: 0, Errors: 0, Skipped: 20, Time elapsed: 14.428 s - in org.appng.core.service.CoreServiceTest
[INFO] Running org.appng.core.service.LdapServiceTest
2022-07-08T14:49:05,459 INFO  [main] org.appng.core.service.LdapService: Found 2 member(s) for group 'cn=logingroup,ou=groups,l=egypt'
2022-07-08T14:49:05,463 INFO  [main] org.appng.core.service.LdapService: Unknown keyword 'bogus' in site property 'testLoginUserSucces.ldapPrincipalScheme'. Falling back to plain username 'aziz' as principal.
2022-07-08T14:49:05,467 INFO  [main] org.appng.core.service.LdapService: LDAP operation failed on host 'ldaps://testLoginUserFailure:129' with principal 'aziz' (javax.naming.NamingException: Sorry kiddo. You got the gift, but it looks like you're waiting for something.)
2022-07-08T14:49:05,468 INFO  [main] org.appng.core.service.LdapService: LDAP operation failed on host 'ldaps://testLoginUserFailure:139' with principal 'aziz' (javax.naming.NamingException: Ah ah ah, you didn't say the magic word!)
2022-07-08T14:49:05,469 INFO  [main] org.appng.core.service.LdapService: User 'aziz' (uid=aziz,ou=users,l=egypt) is member of 'cn=logingroup,ou=groups,l=egypt'
2022-07-08T14:49:05,470 INFO  [main] org.appng.core.service.LdapService: User 'aZiZ' (uid=aziz,ou=users,l=egypt) is member of 'cn=logingroup,ou=groups,l=egypt'
2022-07-08T14:49:05,472 INFO  [main] org.appng.core.service.LdapService: User 'aZiZ' (uid=aziz,ou=users,l=egypt) is member of 'cn=logingroup,ou=groups,l=egypt'
[INFO] Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 s - in org.appng.core.service.LdapServiceTest
[INFO] Running org.appng.core.service.InitializerServiceTest
2022-07-08T14:49:05,477 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.event.ApplicationEventsTestExecutionListener, 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]
2022-07-08T14:49:05,477 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@53e349a4, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@26c4259d, org.springframework.test.context.event.ApplicationEventsTestExecutionListener@13cb6913, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@2d989cc9, org.springframework.test.context.support.DirtiesContextTestExecutionListener@64ff4eb7, org.springframework.test.context.transaction.TransactionalTestExecutionListener@63906778, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@2bdb09e8, org.springframework.test.context.event.EventPublishingTestExecutionListener@42cca68e]
2022-07-08T14:49:05,538 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-08T14:49:05,561 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 22 ms. Found 15 JPA repository interfaces.
2022-07-08T14:49:05,562 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-08T14:49:05,583 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 20 ms. Found 15 JPA repository interfaces.
2022-07-08T14:49:05,597 INFO  [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2022-07-08T14:49:05,637 WARN  [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2022-07-08T14:49:05,637 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2022-07-08T14:49:05,638 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {password=****, user=sa}
2022-07-08T14:49:05,638 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2022-07-08T14:49:05,638 INFO  [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2022-07-08T14:49:05,638 INFO  [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.hibernate.dialect.HSQLDialect
2022-07-08T14:49:05,643 INFO  [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2022-07-08T14:49:05,859 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@74732aab] 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.
2022-07-08T14:49:05,864 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@71869cd7] 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.
2022-07-08T14:49:05,881 INFO  [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-07-08T14:49:05,882 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-08T14:49:05,883 INFO  [main] org.appng.core.domain.PlatformEventListener: Using application context appNG platform context, started on Fri Jul 08 14:49:05 CEST 2022
2022-07-08T14:49:06,256 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@b930aa3 testClass = InitializerServiceTest, testInstance = org.appng.core.service.InitializerServiceTest@41b243be, testMethod = testInitPlatform@InitializerServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@5c0709f7 testClass = InitializerServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.InitializerServiceTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@88b888e]; rollback [false]
2022-07-08T14:49:06,258 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#465604469 for site manager with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:06,259 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Subject subject-3
2022-07-08T14:49:06,261 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Site site-1
2022-07-08T14:49:06,262 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Resource application.xml of application application1
2022-07-08T14:49:06,263 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Application application1
2022-07-08T14:49:06,264 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Role dummy
2022-07-08T14:49:06,264 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Permission permission-1
2022-07-08T14:49:06,265 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Group group-1
2022-07-08T14:49:06,279 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingEnabled
2022-07-08T14:49:06,280 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.filebasedDeployment
2022-07-08T14:49:06,280 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.jspFileType
2022-07-08T14:49:06,280 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryTrustStorePassword
2022-07-08T14:49:06,281 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.platformRootPath
2022-07-08T14:49:06,281 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.manageDatabases
2022-07-08T14:49:06,281 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.inactiveLockPeriod
2022-07-08T14:49:06,282 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.appngData
2022-07-08T14:49:06,282 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cachePlatformFolder
2022-07-08T14:49:06,282 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.monitoringPath
2022-07-08T14:49:06,282 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryCert
2022-07-08T14:49:06,283 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.defaultTemplate
2022-07-08T14:49:06,283 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.devMode
2022-07-08T14:49:06,283 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.logfile
2022-07-08T14:49:06,284 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.xssAllowedTags
2022-07-08T14:49:06,284 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailDisabled
2022-07-08T14:49:06,284 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.passwordPolicyRegEx
2022-07-08T14:49:06,284 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.formatOutput
2022-07-08T14:49:06,285 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheConfig
2022-07-08T14:49:06,285 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sharedSecret
2022-07-08T14:49:06,285 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryPath
2022-07-08T14:49:06,286 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryVerifySignature
2022-07-08T14:49:06,286 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositorySignature
2022-07-08T14:49:06,286 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sessionFilter
2022-07-08T14:49:06,286 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheApplicationFolder
2022-07-08T14:49:06,287 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.writeDebugFiles
2022-07-08T14:49:06,287 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryDefaultDigest
2022-07-08T14:49:06,287 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.monitorPerformance
2022-07-08T14:49:06,288 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mdcEnabled
2022-07-08T14:49:06,288 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.vHostMode
2022-07-08T14:49:06,288 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.templateFolder
2022-07-08T14:49:06,288 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.maxLoginAttempts
2022-07-08T14:49:06,289 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.passwordPolicyErrorMessageKey
2022-07-08T14:49:06,289 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.locale
2022-07-08T14:49:06,289 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sessionTimeout
2022-07-08T14:49:06,290 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cleanTempFolderOnStartup
2022-07-08T14:49:06,290 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.encoding
2022-07-08T14:49:06,290 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.maxUploadSize
2022-07-08T14:49:06,290 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.templatePrefix
2022-07-08T14:49:06,291 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryTrustStore
2022-07-08T14:49:06,291 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.imageMagickPath
2022-07-08T14:49:06,291 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.databasePrefix
2022-07-08T14:49:06,292 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheFolder
2022-07-08T14:49:06,292 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingGroupAddress
2022-07-08T14:49:06,292 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.xssProtect
2022-07-08T14:49:06,292 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailHost
2022-07-08T14:49:06,293 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.timeZone
2022-07-08T14:49:06,293 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheImageFolder
2022-07-08T14:49:06,293 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingReceiver
2022-07-08T14:49:06,293 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingGroupPort
2022-07-08T14:49:06,294 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.csrfFilterEnabled
2022-07-08T14:49:06,294 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailPort
2022-07-08T14:49:06,294 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.uploadDir
2022-07-08T14:49:06,295 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.applicationDir
2022-07-08T14:49:06,295 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.databaseValidationPeriod
2022-07-08T14:49:06,295 INFO  [main] org.appng.core.service.InitializerService: Caching uses HazelcastInstance{name='test', node=[10.102.4.103]:5702}
2022-07-08T14:49:06,296 INFO  [main] org.appng.api.messaging.Messaging: messaging is disabled
2022-07-08T14:49:06,296 INFO  [main] org.appng.core.service.InitializerService: applications are located at /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/applications or in the database
2022-07-08T14:49:06,311 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject subject-3
2022-07-08T14:49:06,312 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Resource application.xml of application application1
2022-07-08T14:49:06,313 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Role dummy
2022-07-08T14:49:06,319 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapPrincipalScheme
2022-07-08T14:49:06,319 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheTimeouts
2022-07-08T14:49:06,319 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapStartTls
2022-07-08T14:49:06,320 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapIdAttribute
2022-07-08T14:49:06,320 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.errorPages
2022-07-08T14:49:06,320 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.host
2022-07-08T14:49:06,321 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.defaultPage
2022-07-08T14:49:06,321 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.csrfProtectedPaths
2022-07-08T14:49:06,321 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLogoutActionName
2022-07-08T14:49:06,322 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapDisabled
2022-07-08T14:49:06,322 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.serviceOutputFormat
2022-07-08T14:49:06,322 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.tagPrefix
2022-07-08T14:49:06,322 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.name
2022-07-08T14:49:06,323 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.csrfProtectionEnabled
2022-07-08T14:49:06,323 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapUser
2022-07-08T14:49:06,323 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.timeZone
2022-07-08T14:49:06,324 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLogoutRef
2022-07-08T14:49:06,324 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.encoding
2022-07-08T14:49:06,324 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authApplication
2022-07-08T14:49:06,325 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheEnabled
2022-07-08T14:49:06,325 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLoginPage
2022-07-08T14:49:06,325 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.searchChunkSize
2022-07-08T14:49:06,325 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.template
2022-07-08T14:49:06,326 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheTimeoutsAntStyle
2022-07-08T14:49:06,326 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapUserBaseDn
2022-07-08T14:49:06,326 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.serviceOutputType
2022-07-08T14:49:06,327 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.sessionTrackingEnabled
2022-07-08T14:49:06,327 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.supportedLanguages
2022-07-08T14:49:06,327 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.mailPort
2022-07-08T14:49:06,327 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.errorPage
2022-07-08T14:49:06,328 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.service-path
2022-07-08T14:49:06,328 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexFileSystemQueueSize
2022-07-08T14:49:06,328 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.siteRootDir
2022-07-08T14:49:06,329 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheTimeToLive
2022-07-08T14:49:06,329 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexConfig
2022-07-08T14:49:06,329 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapHost
2022-07-08T14:49:06,330 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.searchMaxHits
2022-07-08T14:49:06,330 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.mailHost
2022-07-08T14:49:06,330 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheClearOnShutdown
2022-07-08T14:49:06,330 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexTimeout
2022-07-08T14:49:06,331 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.jdbcLogPerformance
2022-07-08T14:49:06,331 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.DatasourceConfigurer
2022-07-08T14:49:06,331 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.jdbcMaxLifetime
2022-07-08T14:49:06,331 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheExceptions
2022-07-08T14:49:06,332 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapDomain
2022-07-08T14:49:06,332 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.csrfProtectedMethods
2022-07-08T14:49:06,332 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.defaultApplication
2022-07-08T14:49:06,333 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.jdbcValidationTimeout
2022-07-08T14:49:06,333 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.documentDir
2022-07-08T14:49:06,333 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.allowSkipRender
2022-07-08T14:49:06,333 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.defaultPageSize
2022-07-08T14:49:06,334 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.cacheStatistics
2022-07-08T14:49:06,334 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLogoutPage
2022-07-08T14:49:06,334 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapPassword
2022-07-08T14:49:06,334 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexFileTypes
2022-07-08T14:49:06,335 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.assetsDir
2022-07-08T14:49:06,335 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLoginRef
2022-07-08T14:49:06,335 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.locale
2022-07-08T14:49:06,336 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.ldapGroupBaseDn
2022-07-08T14:49:06,336 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexDir
2022-07-08T14:49:06,336 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.wwwDir
2022-07-08T14:49:06,336 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.enforcePrimaryDomain
2022-07-08T14:49:06,337 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.supportReloadFile
2022-07-08T14:49:06,337 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.indexQueueSize
2022-07-08T14:49:06,337 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.appendTabId
2022-07-08T14:49:06,337 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.mailDisabled
2022-07-08T14:49:06,338 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.authLogoutActionValue
2022-07-08T14:49:06,338 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.manager-path
2022-07-08T14:49:06,338 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.xssExceptions
2022-07-08T14:49:06,339 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.rewriteConfig
2022-07-08T14:49:06,339 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.site.site-1.jdbcConnectionTimeout
2022-07-08T14:49:06,341 INFO  [main] org.appng.core.service.InitializerService: ==========================================================================================
2022-07-08T14:49:06,344 INFO  [main] org.appng.core.service.InitializerService: loading site site-1 (host-1)
2022-07-08T14:49:06,344 INFO  [main] org.appng.core.service.InitializerService: loading applications for site site-1
2022-07-08T14:49:06,345 INFO  [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/WEB-INF/cache/platform/site-1
2022-07-08T14:49:06,346 INFO  [main] org.appng.core.model.CacheProvider: cleaning /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/WEB-INF/cache/application/site-1
2022-07-08T14:49:06,365 INFO  [main] org.appng.core.service.TemplateService: copying template from /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/template/appng to /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/test-classes/repository/site-1/www/template
2022-07-08T14:49:06,366 INFO  [main] org.appng.core.service.CacheService: No cache found, can not remove elements starting with /template
2022-07-08T14:49:06,367 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#221921197 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:06,367 INFO  [main] org.appng.core.service.InitializerService: SiteClassLoader#221921197 for site site-1 with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156
2022-07-08T14:49:06,368 INFO  [main] org.appng.core.service.InitializerService: started site thread [appng-indexthread-site-1] with runnable of type org.appng.search.indexer.DocumentIndexer
2022-07-08T14:49:06,374 INFO  [main] org.appng.core.service.InitializerService: loading site site-1 completed in 32ms
2022-07-08T14:49:06,374 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform Loaded site site-1
2022-07-08T14:49:06,374 INFO  [main] org.appng.core.service.InitializerService: ==========================================================================================
2022-07-08T14:49:11,395 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@b930aa3 testClass = InitializerServiceTest, testInstance = org.appng.core.service.InitializerServiceTest@41b243be, testMethod = testInitPlatform@InitializerServiceTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@5c0709f7 testClass = InitializerServiceTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.InitializerServiceTest]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:11,398 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-08T14:49:11,398 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[WARNING] Tests run: 2, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 5.924 s - in org.appng.core.service.InitializerServiceTest
[INFO] Running org.appng.core.service.SubjectMustChangePasswordTest
2022-07-08T14:49:11,404 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.event.ApplicationEventsTestExecutionListener, 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]
2022-07-08T14:49:11,404 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@21feafaf, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@3893e5a0, org.springframework.test.context.event.ApplicationEventsTestExecutionListener@9f9ed03, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@170a3fcb, org.springframework.test.context.support.DirtiesContextTestExecutionListener@43dd7952, org.springframework.test.context.transaction.TransactionalTestExecutionListener@64443a6c, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@22134212, org.springframework.test.context.event.EventPublishingTestExecutionListener@6421d5fc]
2022-07-08T14:49:11,469 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-08T14:49:11,499 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 29 ms. Found 15 JPA repository interfaces.
2022-07-08T14:49:11,501 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-08T14:49:11,525 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 23 ms. Found 15 JPA repository interfaces.
2022-07-08T14:49:11,538 INFO  [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2022-07-08T14:49:11,576 WARN  [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2022-07-08T14:49:11,576 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2022-07-08T14:49:11,577 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {password=****, user=sa}
2022-07-08T14:49:11,577 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2022-07-08T14:49:11,577 INFO  [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2022-07-08T14:49:11,578 INFO  [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.hibernate.dialect.HSQLDialect
2022-07-08T14:49:11,583 INFO  [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2022-07-08T14:49:11,780 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@7c66b053] 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.
2022-07-08T14:49:11,784 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@7e1a38d9] 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.
2022-07-08T14:49:11,800 INFO  [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-07-08T14:49:11,801 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-08T14:49:11,813 INFO  [main] org.appng.core.domain.PlatformEventListener: Using application context appNG platform context, started on Fri Jul 08 14:49:11 CEST 2022
2022-07-08T14:49:12,322 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Began transaction (1) for test context [DefaultTestContext@6b852205 testClass = SubjectMustChangePasswordTest, testInstance = org.appng.core.service.SubjectMustChangePasswordTest@3db34acc, testMethod = testMustChangePassword@SubjectMustChangePasswordTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@349b22da testClass = SubjectMustChangePasswordTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@1e40b8a8]; rollback [false]
2022-07-08T14:49:12,345 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.passwordMaxValidity
2022-07-08T14:49:12,345 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingEnabled
2022-07-08T14:49:12,346 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.filebasedDeployment
2022-07-08T14:49:12,346 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.jspFileType
2022-07-08T14:49:12,347 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryTrustStorePassword
2022-07-08T14:49:12,347 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.platformRootPath
2022-07-08T14:49:12,347 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.manageDatabases
2022-07-08T14:49:12,348 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.inactiveLockPeriod
2022-07-08T14:49:12,348 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.appngData
2022-07-08T14:49:12,348 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cachePlatformFolder
2022-07-08T14:49:12,349 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.monitoringPath
2022-07-08T14:49:12,349 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryCert
2022-07-08T14:49:12,349 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.defaultTemplate
2022-07-08T14:49:12,349 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.devMode
2022-07-08T14:49:12,350 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.logfile
2022-07-08T14:49:12,350 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.xssAllowedTags
2022-07-08T14:49:12,350 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailDisabled
2022-07-08T14:49:12,351 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.passwordPolicyRegEx
2022-07-08T14:49:12,351 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.formatOutput
2022-07-08T14:49:12,351 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheConfig
2022-07-08T14:49:12,352 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sharedSecret
2022-07-08T14:49:12,352 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryPath
2022-07-08T14:49:12,352 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryVerifySignature
2022-07-08T14:49:12,352 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositorySignature
2022-07-08T14:49:12,353 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sessionFilter
2022-07-08T14:49:12,353 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheApplicationFolder
2022-07-08T14:49:12,353 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.writeDebugFiles
2022-07-08T14:49:12,353 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryDefaultDigest
2022-07-08T14:49:12,354 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.monitorPerformance
2022-07-08T14:49:12,354 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mdcEnabled
2022-07-08T14:49:12,354 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.vHostMode
2022-07-08T14:49:12,354 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.templateFolder
2022-07-08T14:49:12,355 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.maxLoginAttempts
2022-07-08T14:49:12,355 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.passwordPolicyErrorMessageKey
2022-07-08T14:49:12,355 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.locale
2022-07-08T14:49:12,356 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.sessionTimeout
2022-07-08T14:49:12,356 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cleanTempFolderOnStartup
2022-07-08T14:49:12,357 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.encoding
2022-07-08T14:49:12,357 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.maxUploadSize
2022-07-08T14:49:12,357 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.templatePrefix
2022-07-08T14:49:12,357 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.repositoryTrustStore
2022-07-08T14:49:12,358 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.imageMagickPath
2022-07-08T14:49:12,358 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.databasePrefix
2022-07-08T14:49:12,358 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheFolder
2022-07-08T14:49:12,358 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingGroupAddress
2022-07-08T14:49:12,359 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.xssProtect
2022-07-08T14:49:12,359 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailHost
2022-07-08T14:49:12,359 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.timeZone
2022-07-08T14:49:12,359 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.cacheImageFolder
2022-07-08T14:49:12,360 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingReceiver
2022-07-08T14:49:12,360 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.messagingGroupPort
2022-07-08T14:49:12,361 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.forceChangePassword
2022-07-08T14:49:12,361 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.csrfFilterEnabled
2022-07-08T14:49:12,361 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.mailPort
2022-07-08T14:49:12,362 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.uploadDir
2022-07-08T14:49:12,362 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.applicationDir
2022-07-08T14:49:12,362 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Property platform.databaseValidationPeriod
2022-07-08T14:49:12,366 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Subject shady
2022-07-08T14:49:12,383 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-08T14:49:12,384 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'shady'
2022-07-08T14:49:12,384 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-08T14:49:12,386 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-08T14:49:12,389 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-08T14:49:12,389 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'shady'
2022-07-08T14:49:12,389 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-08T14:49:12,391 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-08T14:49:12,393 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform User shady must change password (has not been changed since more than 3 days).
2022-07-08T14:49:12,394 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform Subject shady
2022-07-08T14:49:12,394 INFO  [main] org.appng.core.service.CoreService: successfully logged in user 'shady'
2022-07-08T14:49:12,394 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null INFO appNG platform logged in
2022-07-08T14:49:12,396 INFO  [main] org.springframework.test.context.transaction.TransactionContext: Committed transaction for test: [DefaultTestContext@6b852205 testClass = SubjectMustChangePasswordTest, testInstance = org.appng.core.service.SubjectMustChangePasswordTest@3db34acc, testMethod = testMustChangePassword@SubjectMustChangePasswordTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@349b22da testClass = SubjectMustChangePasswordTest, locations = '{}', classes = '{class org.appng.core.service.PlatformTestConfig}', contextInitializerClasses = '[class org.appng.core.service.TestInitializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{}', contextCustomizers = set[[empty]], contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]], attributes = map['org.springframework.test.context.event.ApplicationEventsTestExecutionListener.recordApplicationEvents' -> false]]
2022-07-08T14:49:12,397 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-08T14:49:12,398 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.995 s - in org.appng.core.service.SubjectMustChangePasswordTest
[INFO] Running org.appng.core.service.HsqlStarterTest
2022-07-08T14:49:12,401 INFO  [Time-limited test] org.appng.core.service.HsqlStarter: starting HSQL Server 2.5.0 at /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/appNG/WEB-INF/database/appng on port 9001
2022-07-08T14:49:12,414 INFO  [HSQLDB Server @7947bbf5] hsqldb.db.HSQLDB81DDDB66DC.ENGINE: Checkpoint start
2022-07-08T14:49:12,414 INFO  [HSQLDB Server @7947bbf5] hsqldb.db.HSQLDB81DDDB66DC.ENGINE: checkpointClose start
2022-07-08T14:49:12,532 INFO  [HSQLDB Server @7947bbf5] hsqldb.db.HSQLDB81DDDB66DC.ENGINE: checkpointClose synched
2022-07-08T14:49:12,538 INFO  [HSQLDB Server @7947bbf5] hsqldb.db.HSQLDB81DDDB66DC.ENGINE: checkpointClose script done
2022-07-08T14:49:12,550 INFO  [HSQLDB Server @7947bbf5] hsqldb.db.HSQLDB81DDDB66DC.ENGINE: checkpointClose end
2022-07-08T14:49:12,550 INFO  [HSQLDB Server @7947bbf5] hsqldb.db.HSQLDB81DDDB66DC.ENGINE: Checkpoint end - txts: 1
2022-07-08T14:49:12,706 INFO  [Time-limited test] org.appng.core.service.HsqlStarter: shutting down HSQL Server 2.5.0 at /var/lib/jenkins/workspace/appNG_2.0.x/appng-core/target/appNG/WEB-INF/database/appng on port 9001
2022-07-08T14:49:13,132 INFO  [HSQLDB Connection @56f8a38d] hsqldb.db.HSQLDB81DDDB66DC.ENGINE: Database closed
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.936 s - in org.appng.core.service.HsqlStarterTest
[INFO] Running org.appng.core.service.SiteClassLoaderBuilderTest
2022-07-08T14:49:13,340 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#451843630 for site localhost with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 s - in org.appng.core.service.SiteClassLoaderBuilderTest
[INFO] Running org.appng.core.service.ApplicationArchiveProcessorTest
2022-07-08T14:49:13,348 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'application.xml' for application 'demo-application-null'
2022-07-08T14:49:13,349 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'beans.xml' for application 'demo-application-null'
2022-07-08T14:49:13,349 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'datasources.xml' for application 'demo-application-null'
2022-07-08T14:49:13,349 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'events.xml' for application 'demo-application-null'
2022-07-08T14:49:13,349 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'master.xml' for application 'demo-application-null'
2022-07-08T14:49:13,350 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'page.xml' for application 'demo-application-null'
2022-07-08T14:49:13,350 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'plugin.xml' for application 'demo-application-null'
2022-07-08T14:49:13,350 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'messages-demo.properties' for application 'demo-application-null'
2022-07-08T14:49:13,350 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mssql/V1.0_script.sql' for application 'demo-application-null'
2022-07-08T14:49:13,350 INFO  [main] org.appng.core.service.ApplicationArchiveProcessor: adding application-resource 'mysql/V1.0_script.sql' for application 'demo-application-null'
application.xml
beans.xml
datasources.xml
events.xml
master.xml
page.xml
plugin.xml
messages-demo.properties
mssql/V1.0_script.sql
mysql/V1.0_script.sql
[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 s - in org.appng.core.service.ApplicationArchiveProcessorTest
[INFO] Running org.appng.core.service.TemplateServiceTest
2022-07-08T14:49:13,355 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.event.ApplicationEventsTestExecutionListener, 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]
2022-07-08T14:49:13,357 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@7b273e0f, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@64bb7b24, org.springframework.test.context.event.ApplicationEventsTestExecutionListener@6d2f1f4e, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@2978039d, org.springframework.test.context.support.DirtiesContextTestExecutionListener@6bed87fb, org.springframework.test.context.transaction.TransactionalTestExecutionListener@5430a3f9, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@4170135e, org.springframework.test.context.event.EventPublishingTestExecutionListener@287d8406]
2022-07-08T14:49:13,417 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-08T14:49:13,440 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 22 ms. Found 15 JPA repository interfaces.
2022-07-08T14:49:13,441 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-08T14:49:13,461 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 20 ms. Found 15 JPA repository interfaces.
2022-07-08T14:49:13,473 INFO  [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2022-07-08T14:49:13,509 WARN  [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2022-07-08T14:49:13,510 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2022-07-08T14:49:13,510 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {password=****, user=sa}
2022-07-08T14:49:13,510 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2022-07-08T14:49:13,510 INFO  [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2022-07-08T14:49:13,511 INFO  [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.hibernate.dialect.HSQLDialect
2022-07-08T14:49:13,516 INFO  [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2022-07-08T14:49:13,693 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@680ec419] 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.
2022-07-08T14:49:13,697 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@b6bcc20] 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.
2022-07-08T14:49:13,713 INFO  [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-07-08T14:49:13,713 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-08T14:49:13,714 INFO  [main] org.appng.core.domain.PlatformEventListener: Using application context appNG platform context, started on Fri Jul 08 14:49:13 CEST 2022
2022-07-08T14:49:14,098 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#269372296 for site manager with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:14,112 INFO  [main] org.appng.core.service.TemplateService: added resource assets/favicon.ico
2022-07-08T14:49:14,112 INFO  [main] org.appng.core.service.TemplateService: added resource conf/platform.xml
2022-07-08T14:49:14,112 INFO  [main] org.appng.core.service.TemplateService: added resource resources/dummy.txt
2022-07-08T14:49:14,113 INFO  [main] org.appng.core.service.TemplateService: added resource template.xml
2022-07-08T14:49:14,113 INFO  [main] org.appng.core.service.TemplateService: added resource xsl/platform.xsl
2022-07-08T14:49:14,114 INFO  [main] org.appng.core.service.TemplateService: added resource xsl/utils.xsl
2022-07-08T14:49:14,135 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#879680059 for site manager with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:14,162 INFO  [main] org.appng.api.support.SiteClassLoader: SiteClassLoader#21481493 for site manager with parent jdk.internal.loader.ClassLoaders$AppClassLoader#661672156 created
2022-07-08T14:49:14,177 INFO  [main] org.appng.core.service.TemplateService: added resource assets/favicon.ico
2022-07-08T14:49:14,177 INFO  [main] org.appng.core.service.TemplateService: added resource conf/platform.xml
2022-07-08T14:49:14,177 INFO  [main] org.appng.core.service.TemplateService: added resource resources/dummy.txt
2022-07-08T14:49:14,179 INFO  [main] org.appng.core.service.TemplateService: added resource template.xml
2022-07-08T14:49:14,179 INFO  [main] org.appng.core.service.TemplateService: added resource xsl/platform.xsl
2022-07-08T14:49:14,179 INFO  [main] org.appng.core.service.TemplateService: added resource xsl/utils.xsl
2022-07-08T14:49:14,183 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform Template appng-template
2022-07-08T14:49:14,198 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-08T14:49:14,198 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.844 s - in org.appng.core.service.TemplateServiceTest
[INFO] Running org.appng.core.service.DatabaseServiceTest
2022-07-08T14:49:14,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.event.ApplicationEventsTestExecutionListener, 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]
2022-07-08T14:49:14,204 INFO  [main] org.springframework.test.context.support.DefaultTestContextBootstrapper: Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@49a72fd2, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@420bbf24, org.springframework.test.context.event.ApplicationEventsTestExecutionListener@1085480d, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@4ca2dabc, org.springframework.test.context.support.DirtiesContextTestExecutionListener@3c8ba545, org.springframework.test.context.transaction.TransactionalTestExecutionListener@23e6cf6f, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@19193e3e, org.springframework.test.context.event.EventPublishingTestExecutionListener@43b4609b]
2022-07-08T14:49:14,261 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-08T14:49:14,284 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 22 ms. Found 15 JPA repository interfaces.
2022-07-08T14:49:14,286 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2022-07-08T14:49:14,305 INFO  [main] org.springframework.data.repository.config.RepositoryConfigurationDelegate: Finished Spring Data repository scanning in 19 ms. Found 15 JPA repository interfaces.
2022-07-08T14:49:14,320 INFO  [main] org.hibernate.jpa.internal.util.LogHelper: HHH000204: Processing PersistenceUnitInfo [name: hsql-testdb]
2022-07-08T14:49:14,356 WARN  [main] org.hibernate.orm.connections.pooling: HHH10001002: Using Hibernate built-in connection pool (not for production use!)
2022-07-08T14:49:14,356 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001005: using driver [org.hsqldb.jdbc.JDBCDriver] at URL [jdbc:hsqldb:mem:hsql-testdb]
2022-07-08T14:49:14,356 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001001: Connection properties: {password=****, user=sa}
2022-07-08T14:49:14,356 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001003: Autocommit mode: false
2022-07-08T14:49:14,356 INFO  [main] org.hibernate.engine.jdbc.connections.internal.DriverManagerConnectionProviderImpl: HHH000115: Hibernate connection pool size: 20 (min=1)
2022-07-08T14:49:14,357 INFO  [main] org.hibernate.dialect.Dialect : HHH000400: Using dialect: org.appng.persistence.hibernate.dialect.HSQLDialect
2022-07-08T14:49:14,361 INFO  [main] org.hibernate.envers.boot.internal.EnversServiceImpl: Envers integration enabled? : true
2022-07-08T14:49:14,526 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@7b2eb590] 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.
2022-07-08T14:49:14,529 INFO  [main] org.hibernate.orm.connections.access: HHH10001501: Connection obtained from JdbcConnectionAccess [org.hibernate.engine.jdbc.env.internal.JdbcEnvironmentInitiator$ConnectionProviderJdbcConnectionAccess@6c18157] 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.
2022-07-08T14:49:14,544 INFO  [main] org.hibernate.engine.transaction.jta.platform.internal.JtaPlatformInitiator: HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-07-08T14:49:14,544 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Initialized JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-08T14:49:14,545 INFO  [main] org.appng.core.domain.PlatformEventListener: Using application context appNG platform context, started on Fri Jul 08 14:49:14 CEST 2022
2022-07-08T14:49:14,878 INFO  [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver org.hsqldb.jdbc.JDBCDriver
2022-07-08T14:49:14,889 INFO  [main] org.appng.core.service.MigrationService: connected to jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5.0)
2022-07-08T14:49:14,891 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: Flyway Community Edition 8.5.13 by Redgate
2022-07-08T14:49:14,891 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: See what's new here: https://flywaydb.org/documentation/learnmore/releaseNotes#8.5.13
2022-07-08T14:49:14,891 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: 
2022-07-08T14:49:14,894 INFO  [main] org.flywaydb.core.internal.database.base.BaseDatabaseType: Database: jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5)
2022-07-08T14:49:14,906 INFO  [main] org.appng.core.service.MigrationService: connected to jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5.0)
2022-07-08T14:49:14,907 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: Flyway Community Edition 8.5.13 by Redgate
2022-07-08T14:49:14,907 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: See what's new here: https://flywaydb.org/documentation/learnmore/releaseNotes#8.5.13
2022-07-08T14:49:14,907 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: 
2022-07-08T14:49:14,910 INFO  [main] org.flywaydb.core.internal.database.base.BaseDatabaseType: Database: jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5)
2022-07-08T14:49:14,920 INFO  [main] org.flywaydb.core.internal.command.DbValidate: Successfully validated 16 migrations (execution time 00:00.008s)
2022-07-08T14:49:14,922 INFO  [main] org.flywaydb.core.internal.schemahistory.JdbcTableSchemaHistory: Creating Schema History table "PUBLIC"."schema_version" ...
2022-07-08T14:49:14,928 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Current version of schema "PUBLIC": << Empty Schema >>
2022-07-08T14:49:14,963 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.0 - appNG initial setup"
2022-07-08T14:49:15,002 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.1 - Quartz initial setup"
2022-07-08T14:49:15,015 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.2 - add template"
2022-07-08T14:49:15,022 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.2.1 - add repository strict"
2022-07-08T14:49:15,030 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.2.2 - add repository digest"
2022-07-08T14:49:15,037 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.2.3 - set resource bytes not null"
2022-07-08T14:49:15,048 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.3.0 - add type to template"
2022-07-08T14:49:15,055 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.3.1 - add global admin role"
2022-07-08T14:49:15,062 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "1.3.2 - add repository accepted certs"
2022-07-08T14:49:15,069 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "2.0.0 - add platform event"
2022-07-08T14:49:15,076 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.0.0 - add job execution record"
2022-07-08T14:49:15,083 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.1.0 - change caching properties"
2022-07-08T14:49:15,083 WARN  [main] org.flywaydb.core.internal.sqlscript.DefaultSqlScriptExecutor: DB: no data (SQL State: 02000 - Error Code: -1100)
2022-07-08T14:49:15,084 WARN  [main] org.flywaydb.core.internal.sqlscript.DefaultSqlScriptExecutor: DB: no data (SQL State: 02000 - Error Code: -1100)
2022-07-08T14:49:15,089 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.1.1 - add site reload count"
2022-07-08T14:49:15,096 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.1.2 - add property type"
2022-07-08T14:49:15,105 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.2 - add subject columns"
2022-07-08T14:49:15,108 WARN  [main] org.flywaydb.core.internal.sqlscript.DefaultSqlScriptExecutor: DB: no data (SQL State: 02000 - Error Code: -1100)
2022-07-08T14:49:15,113 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Migrating schema "PUBLIC" to version "4.2.1 - change subject name length"
2022-07-08T14:49:15,117 INFO  [main] org.flywaydb.core.internal.command.DbMigrate: Successfully applied 16 migrations to schema "PUBLIC", now at version v4.2.1 (execution time 00:00.190s)
2022-07-08T14:49:15,119 INFO  [main] org.appng.core.service.MigrationService: connected to jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5.0)
2022-07-08T14:49:15,120 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: Flyway Community Edition 8.5.13 by Redgate
2022-07-08T14:49:15,120 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: See what's new here: https://flywaydb.org/documentation/learnmore/releaseNotes#8.5.13
2022-07-08T14:49:15,120 INFO  [main] org.flywaydb.core.internal.license.VersionPrinter: 
2022-07-08T14:49:15,123 INFO  [main] org.flywaydb.core.internal.database.base.BaseDatabaseType: Database: jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5)
2022-07-08T14:49:15,137 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform DatabaseConnection appNG Root Database
2022-07-08T14:49:15,144 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform DatabaseConnection appNG HSQL
2022-07-08T14:49:15,151 INFO  [main] org.appng.core.service.DatabaseService: HSQL jdbc:hsqldb:mem:testInitDatabase (HSQL Database Engine 2.5.0) is active.
2022-07-08T14:49:15,153 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null UPDATE appNG platform DatabaseConnection appNG HSQL
2022-07-08T14:49:15,154 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform DatabaseConnection appNG MYSQL
2022-07-08T14:49:15,155 INFO  [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver com.mysql.cj.jdbc.Driver
2022-07-08T14:49:15,538 WARN  [main] org.appng.core.domain.DatabaseConnection: error while connecting to jdbc:mysql://localhost:3306/appNG MYSQL (org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection; nested exception is java.sql.SQLException: Access denied for user 'user'@'127.0.0.1' (using password: NO))
2022-07-08T14:49:15,538 INFO  [main] org.appng.core.service.DatabaseService: MYSQL jdbc:mysql://localhost:3306/appNG MYSQL is not working and will be deactivated.
2022-07-08T14:49:15,541 INFO  [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver com.microsoft.sqlserver.jdbc.SQLServerDriver
2022-07-08T14:49:15,544 INFO  [main] org.appng.core.domain.PlatformEventListener: Created entry null CREATE appNG platform DatabaseConnection appNG POSTGRESQL
2022-07-08T14:49:15,544 INFO  [main] org.appng.core.domain.DatabaseConnection: Registered JDBC driver org.postgresql.Driver
2022-07-08T14:49:15,579 WARN  [main] org.appng.core.domain.DatabaseConnection: error while connecting to jdbc:postgresql://localhost:5432/appNG POSTGRESQL (org.springframework.jdbc.CannotGetJdbcConnectionException: Failed to obtain JDBC Connection; nested exception is org.postgresql.util.PSQLException: Connection refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.)
2022-07-08T14:49:15,579 INFO  [main] org.appng.core.service.DatabaseService: POSTGRESQL jdbc:postgresql://localhost:5432/appNG POSTGRESQL is not working and will be deactivated.
2022-07-08T14:49:15,585 INFO  [main] org.springframework.orm.jpa.LocalEntityManagerFactoryBean: Closing JPA EntityManagerFactory for persistence unit 'hsql-testdb'
2022-07-08T14:49:15,586 INFO  [main] org.hibernate.orm.connections.pooling: HHH10001008: Cleaning up connection pool [jdbc:hsqldb:mem:hsql-testdb]
[WARNING] Tests run: 11, Failures: 0, Errors: 0, Skipped: 9, Time elapsed: 1.385 s - in org.appng.core.service.DatabaseServiceTest
[INFO] Running org.appng.core.service.PropertySupportTest
[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 s - in org.appng.core.service.PropertySupportTest
[INFO] 
[INFO] Results:
[INFO] 
[ERROR] Errors: 
[ERROR]   JarInfoBuilderTest.test:32 NullPointer
[INFO] 
[ERROR] Tests run: 352, Failures: 0, Errors: 1, Skipped: 30
[INFO] 
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary for appNG Parent 2.0.0-SNAPSHOT:
[INFO] 
[INFO] appNG Parent ....................................... SUCCESS [  2.276 s]
[INFO] appNG Tools ........................................ SUCCESS [ 16.384 s]
[INFO] appNG Mail ......................................... SUCCESS [  4.067 s]
[INFO] appNG Forms ........................................ SUCCESS [  5.482 s]
[INFO] appng Formtags ..................................... SUCCESS [  5.380 s]
[INFO] appNG XML-API ...................................... SUCCESS [ 11.052 s]
[INFO] appNG public API ................................... SUCCESS [ 24.205 s]
[INFO] appNG testsupport .................................. SUCCESS [  8.740 s]
[INFO] appNG REST API ..................................... SUCCESS [ 15.483 s]
[INFO] appNG Persistence-Tools ............................ SUCCESS [ 19.992 s]
[INFO] appNG Search ....................................... SUCCESS [ 21.210 s]
[INFO] appNG Core Library ................................. FAILURE [01:31 min]
[INFO] appNG Command Line Interface ....................... SKIPPED
[INFO] appNG Tag Library .................................. SKIPPED
[INFO] appNGizer JAXB API ................................. SKIPPED
[INFO] appNGizer .......................................... 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] 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] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time:  03:46 min
[INFO] Finished at: 2022-07-08T14:49:16+02:00
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:3.0.0-M5:test (default-test) on project appng-core: There are test failures.
[ERROR] 
[ERROR] Please refer to /var/lib/jenkins/workspace/appNG_2.0.x/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 <args> -rf :appng-core