SuccessConsole Output

Skipping 798 KB.. Full Log
726"
16:09:25.373 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Schema Transaction CLOSED with connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@386dd726"
16:09:25.374 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection COMMITTING : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@1c23bf88 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@386dd726, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]"
16:09:25.374 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection CLOSED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@1c23bf88 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@386dd726, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]"
16:09:25.377 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /META-INF/package.jdo
16:09:25.379 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /WEB-INF/package.jdo
16:09:25.380 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /package.jdo
16:09:25.382 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/package.jdo
16:09:25.384 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/package.jdo
16:09:25.385 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/package.jdo
16:09:25.386 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/package.jdo
16:09:25.386 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/persistence/package.jdo
16:09:25.387 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/persistence/Symlink.jdo
16:09:25.387 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" not found
16:09:25.387 [qtp1339273738-38] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.Symlink" has been specified with JDO annotations so using those.
16:09:25.388 [qtp1339273738-38] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.Symlink" : Populating Meta-Data
16:09:25.389 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /META-INF/package.orm
16:09:25.389 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /WEB-INF/package.orm
16:09:25.390 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /package.orm
16:09:25.390 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/package.orm
16:09:25.391 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/package.orm
16:09:25.392 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/package.orm
16:09:25.392 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/package.orm
16:09:25.393 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/persistence/package.orm
16:09:25.393 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/persistence/Symlink.orm
16:09:25.394 [qtp1339273738-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" not found
16:09:25.394 [qtp1339273738-38] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.Symlink" : Initialising Meta-Data
16:09:25.394 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Managing Persistence of Class : co.codewizards.cloudstore.local.persistence.Symlink [Table : "repofile", InheritanceStrategy : superclass-table]
16:09:25.395 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Table "repofile" will manage the persistence of the fields for class co.codewizards.cloudstore.local.persistence.Symlink (inheritance strategy="superclass-table") 
16:09:25.395 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Member co.codewizards.cloudstore.local.persistence.Symlink.target uses superclass-table yet the field is not marked as nullable  nor does it have a default value, so setting the column as nullable
16:09:25.395 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.Symlink.target] -> Column(s) ["repofile"."target"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.StringMapping" (org.datanucleus.store.rdbms.mapping.column.VarCharColumnMapping)
16:09:25.395 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection OPENED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@137ea257 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3d7763f, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" on resource "nontx" with isolation level "serializable" and auto-commit=false
16:09:25.395 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Schema Transaction STARTED with connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3d7763f" with isolation "serializable"
16:09:25.400 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Check of existence of "repofile" returned table type of TABLE
16:09:25.400 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Loading column info for table(s) "repofile" in Catalog "", Schema ""
16:09:25.408 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Column info loaded for Catalog "", Schema "", 1 tables, time = 8 ms
16:09:25.408 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Column info retrieved for table "repofile" : 13 columns found
16:09:25.416 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Validating 6 index(es) for table "repofile"
16:09:25.427 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Validating 1 foreign key(s) for table "repofile"
16:09:25.431 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Validating 2 unique key(s) for table "repofile"
16:09:25.431 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Schema Transaction COMMITTING with connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3d7763f"
16:09:25.431 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Schema - Schema Transaction CLOSED with connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3d7763f"
16:09:25.431 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection COMMITTING : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@137ea257 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3d7763f, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]"
16:09:25.432 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection CLOSED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@137ea257 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3d7763f, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]"
16:09:25.432 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext CLOSED "org.datanucleus.ExecutionContextImpl@678f101e"
16:09:25.433 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext OPENED "org.datanucleus.ExecutionContextImpl@678f101e" for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2974ed23" with txn="org.datanucleus.TransactionImpl@53aea73b"
16:09:25.433 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=1104431548-11, enlisted resources=[]]
16:09:25.433 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e (optimistic=false)
16:09:25.433 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (generic) of "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository"
16:09:25.433 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (generic) = 0 ms
16:09:25.433 [qtp1339273738-38] DEBUG DataNucleus.Query - QueryCompilation:
  [symbols: this type=co.codewizards.cloudstore.local.persistence.LocalRepository]
16:09:25.434 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (datastore) of "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository"
16:09:25.434 [qtp1339273738-38] DEBUG DataNucleus.Query - Compile of JDOQL into SQL - JoinType : navigation(default=(using nullability), filter=(using nullability))
16:09:25.435 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (datastore) = 1 ms
16:09:25.437 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection OPENED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4cfd8d79 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7ab9b543, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" on resource "tx" with isolation level "read-committed" and auto-commit=false
16:09:25.437 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@326190d6, error code TMNOFLAGS and transaction [DataNucleus Transaction, ID=1104431548-11, enlisted resources=[]]
16:09:25.437 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" ...
16:09:25.445 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "56ac44df-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7ab9b543"
16:09:25.445 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."changed","a0"."created","a0"."id","a0"."repositoryid","a0"."revision","a0"."discriminator" FROM "repository" "a0" WHERE "a0"."discriminator" = 'LocalRepository'
16:09:25.446 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.446 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 9 ms
16:09:25.447 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 1 cache
16:09:25.447 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 2 cache
16:09:25.447 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") added to Level 1 cache (loadedFlags="[NNYNNNNNN]")
16:09:25.448 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" (id="1") added to Level 2 cache (fields="[0, 1, 2, 4, 5]", version="")
16:09:25.448 [qtp1339273738-38] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "HOLLOW"->"P_CLEAN"
16:09:25.448 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" (id="1") enlisted in transactional cache
16:09:25.450 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" having fields "publicKey" fetched from table ""repository""
16:09:25.455 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "825444e2-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7ab9b543"
16:09:25.455 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."publickey" FROM "repository" "a0" WHERE "a0"."id" = <1>
16:09:25.456 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.457 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@6bba568c"
16:09:25.457 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" (id="1") is having the following fields in Level 2 cache object updated : [3]
16:09:25.458 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" having fields "privateKey" fetched from table ""repository""
16:09:25.463 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "d4c584e4-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7ab9b543"
16:09:25.463 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."privatekey" FROM "repository" "a0" WHERE "a0"."id" = <1>
16:09:25.464 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.464 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@620d4ed4"
16:09:25.465 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" (id="1") is having the following fields in Level 2 cache object updated : [7]
16:09:25.465 [qtp1339273738-38] INFO co.codewizards.cloudstore.local.LocalRepoManagerImpl - [24573d55]initPersistenceManagerFactory: repositoryId=6488f7e3-73e3-4790-a451-fb10c978504b
16:09:25.465 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e
16:09:25.465 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.466 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.466 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=1104431548-11, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@326190d6]]
16:09:25.466 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection COMMITTING : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4cfd8d79 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7ab9b543, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.466 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection CLOSED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4cfd8d79 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7ab9b543, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.466 [qtp1339273738-38] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "P_CLEAN"->"HOLLOW"
16:09:25.466 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") was evicted from transactional cache
16:09:25.466 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
16:09:25.467 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Disconnecting co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d from StateManager[pc=co.codewizards.cloudstore.local.persistence.LocalRepository@164d983d, lifecycle=HOLLOW]
16:09:25.467 [qtp1339273738-38] DEBUG DataNucleus.Cache - Level 1 Cache cleared
16:09:25.467 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext CLOSED "org.datanucleus.ExecutionContextImpl@678f101e"
16:09:25.467 [qtp1339273738-38] INFO co.codewizards.cloudstore.local.LocalRepoManagerImpl - [24573d55]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2243 ms.
16:09:25.467 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext OPENED "org.datanucleus.ExecutionContextImpl@678f101e" for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2974ed23" with txn="org.datanucleus.TransactionImpl@1cb3a2ef"
16:09:25.467 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=1104431548-12, enlisted resources=[]]
16:09:25.467 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e (optimistic=false)
16:09:25.468 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Single-String with "SELECT WHERE this.changed < :changed"
16:09:25.468 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (generic) of "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed"
16:09:25.469 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (generic) = 1 ms
16:09:25.469 [qtp1339273738-38] DEBUG DataNucleus.Query - QueryCompilation:
  [filter:DyadicExpression{PrimaryExpression{this.changed}  <  ParameterExpression{changed}}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest, changed type=java.util.Date]
16:09:25.469 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (datastore) of "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed"
16:09:25.470 [qtp1339273738-38] DEBUG DataNucleus.Query - Compile of JDOQL into SQL - JoinType : navigation(default=(using nullability), filter=(using nullability))
16:09:25.471 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (datastore) = 2 ms
16:09:25.471 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection OPENED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@5bc72bf6 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@5ae24ebb, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" on resource "tx" with isolation level "read-committed" and auto-commit=false
16:09:25.471 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@225f9c96, error code TMNOFLAGS and transaction [DataNucleus Transaction, ID=1104431548-12, enlisted resources=[]]
16:09:25.471 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed" ...
16:09:25.479 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "e737c4e6-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@5ae24ebb"
16:09:25.479 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT 'co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest' AS "dn_type","a0"."changed","a0"."created","a0"."id","a0"."localpathprefix","a0"."repositoryid" FROM "remoterepositoryrequest" "a0" WHERE "a0"."changed" < <2020-04-30 16:09:25.468>
16:09:25.480 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.480 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 9 ms
16:09:25.480 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e
16:09:25.480 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.481 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.481 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=1104431548-12, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@225f9c96]]
16:09:25.481 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection COMMITTING : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@5bc72bf6 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@5ae24ebb, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.481 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection CLOSED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@5bc72bf6 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@5ae24ebb, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.481 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
16:09:25.481 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext CLOSED "org.datanucleus.ExecutionContextImpl@678f101e"
16:09:25.482 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [1decffad]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
16:09:25.482 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [1decffad]tryAcquire: returning true. lockCounter=1
16:09:25.482 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [1decffad]tryAcquire: returning true. lockCounter=2
16:09:25.482 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
16:09:25.483 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [1decffad]release: NOT releasing underlying FileLock. lockCounter=1
16:09:25.483 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [1decffad]release: releasing underlying FileLock. lockCounter=0
16:09:25.483 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext OPENED "org.datanucleus.ExecutionContextImpl@678f101e" for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2974ed23" with txn="org.datanucleus.TransactionImpl@7efd30ed"
16:09:25.483 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=1104431548-13, enlisted resources=[]]
16:09:25.484 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e (optimistic=false)
16:09:25.484 [qtp1339273738-38] DEBUG DataNucleus.Query - Query "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository FetchPlan [default]" of language "JDOQL" has been run before so reusing existing generic compilation
16:09:25.484 [qtp1339273738-38] DEBUG DataNucleus.Query - Query "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository FetchPlan [default]" of language "JDOQL" for datastore "rdbms-derby" has been run before so reusing existing datastore compilation
16:09:25.485 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection OPENED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4a0cdf7e [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7be3f1de, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" on resource "tx" with isolation level "read-committed" and auto-commit=false
16:09:25.485 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@16cd6d8d, error code TMNOFLAGS and transaction [DataNucleus Transaction, ID=1104431548-13, enlisted resources=[]]
16:09:25.485 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" ...
16:09:25.486 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "56ac44df-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7be3f1de"
16:09:25.486 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."changed","a0"."created","a0"."id","a0"."repositoryid","a0"."revision","a0"."discriminator" FROM "repository" "a0" WHERE "a0"."discriminator" = 'LocalRepository'
16:09:25.486 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 0 ms
16:09:25.486 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 1 ms
16:09:25.487 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 1 cache
16:09:25.487 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") added to Level 1 cache (loadedFlags="[NNYNNNNNN]")
16:09:25.487 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "changed" replaced by a SCO wrapper
16:09:25.487 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "created" replaced by a SCO wrapper
16:09:25.487 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd" (id="1") enlisted in transactional cache
16:09:25.488 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object with id="co.codewizards.cloudstore.local.persistence.LocalRepository:1" taken from Level 2 cache (fields="[0, 1, 2, 3, 4, 5, 7]", version="") - represented as "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd"
16:09:25.489 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd" field "aliases" is replaced by a SCO wrapper of type "org.datanucleus.store.types.wrappers.backed.Set" [cache-values=true, lazy-loading=true, allow-nulls=false]
16:09:25.489 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd" (id="1") is having the following fields in Level 2 cache object updated : [6]
16:09:25.489 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd" field "aliases" loading contents to SCO wrapper from the datastore
16:09:25.498 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "02e504e9-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7be3f1de"
16:09:25.498 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."element" FROM "localrepository_aliases" "a0" WHERE "a0"."id_oid" = <1>
16:09:25.499 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.499 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@3a61313d"
16:09:25.499 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [5546a4d5]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
16:09:25.500 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [5546a4d5]tryAcquire: returning true. lockCounter=1
16:09:25.500 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
16:09:25.501 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [5546a4d5]release: releasing underlying FileLock. lockCounter=0
16:09:25.501 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.local.LocalRepoManagerImpl - syncWithLocalRepoRegistry: Alias 'k9o9wdif-w4jm1' of repository '6488f7e3-73e3-4790-a451-fb10c978504b' already in-sync.
16:09:25.501 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [70823643]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
16:09:25.501 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [70823643]tryAcquire: returning true. lockCounter=1
16:09:25.502 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [70823643]tryAcquire: returning true. lockCounter=2
16:09:25.502 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
16:09:25.503 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [70823643]release: NOT releasing underlying FileLock. lockCounter=1
16:09:25.503 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [70823643]release: releasing underlying FileLock. lockCounter=0
16:09:25.503 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.503 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.503 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.local.AutoTrackLifecycleListener - onCommit: Deferred operations took 0 ms for 0 entities.
16:09:25.504 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.504 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.504 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e
16:09:25.504 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.504 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.505 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=1104431548-13, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@16cd6d8d]]
16:09:25.505 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection COMMITTING : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4a0cdf7e [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7be3f1de, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.505 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection CLOSED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4a0cdf7e [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@7be3f1de, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.505 [qtp1339273738-38] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "P_CLEAN"->"HOLLOW"
16:09:25.506 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") was evicted from transactional cache
16:09:25.506 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committed in 2 ms
16:09:25.506 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Disconnecting co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd from StateManager[pc=co.codewizards.cloudstore.local.persistence.LocalRepository@5a3aa0bd, lifecycle=HOLLOW]
16:09:25.506 [qtp1339273738-38] DEBUG DataNucleus.Cache - Level 1 Cache cleared
16:09:25.506 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext CLOSED "org.datanucleus.ExecutionContextImpl@678f101e"
16:09:25.506 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext OPENED "org.datanucleus.ExecutionContextImpl@678f101e" for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2974ed23" with txn="org.datanucleus.TransactionImpl@755ffcb7"
16:09:25.507 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=1104431548-14, enlisted resources=[]]
16:09:25.507 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e (optimistic=false)
16:09:25.507 [qtp1339273738-38] DEBUG DataNucleus.Query - Query "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository FetchPlan [default]" of language "JDOQL" has been run before so reusing existing generic compilation
16:09:25.508 [qtp1339273738-38] DEBUG DataNucleus.Query - Query "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository FetchPlan [default]" of language "JDOQL" for datastore "rdbms-derby" has been run before so reusing existing datastore compilation
16:09:25.508 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection OPENED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@14d03d47 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3982901f, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" on resource "tx" with isolation level "read-committed" and auto-commit=false
16:09:25.508 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@3b56ea3e, error code TMNOFLAGS and transaction [DataNucleus Transaction, ID=1104431548-14, enlisted resources=[]]
16:09:25.508 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" ...
16:09:25.509 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "56ac44df-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3982901f"
16:09:25.509 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."changed","a0"."created","a0"."id","a0"."repositoryid","a0"."revision","a0"."discriminator" FROM "repository" "a0" WHERE "a0"."discriminator" = 'LocalRepository'
16:09:25.510 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.510 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 2 ms
16:09:25.510 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 1 cache
16:09:25.511 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") added to Level 1 cache (loadedFlags="[NNYNNNNNN]")
16:09:25.511 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "changed" replaced by a SCO wrapper
16:09:25.511 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "created" replaced by a SCO wrapper
16:09:25.511 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db" (id="1") enlisted in transactional cache
16:09:25.511 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object with id="co.codewizards.cloudstore.local.persistence.LocalRepository:1" taken from Level 2 cache (fields="[0, 1, 2, 3, 4, 5, 7]", version="") - represented as "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db"
16:09:25.512 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db" field "aliases" is replaced by a SCO wrapper of type "org.datanucleus.store.types.wrappers.backed.Set" [cache-values=true, lazy-loading=true, allow-nulls=false]
16:09:25.512 [qtp1339273738-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db" (id="1") is having the following fields in Level 2 cache object updated : [6]
16:09:25.518 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "9e9484ec-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3982901f"
16:09:25.518 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT COUNT(*) FROM "localrepository_aliases" THIS WHERE THIS."id_oid"=<1>
16:09:25.519 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.519 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@35d6798c"
16:09:25.519 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db" field "aliases" loading contents to SCO wrapper from the datastore
16:09:25.520 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "02e504e9-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3982901f"
16:09:25.520 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."element" FROM "localrepository_aliases" "a0" WHERE "a0"."id_oid" = <1>
16:09:25.520 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 0 ms
16:09:25.521 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@67d38e22"
16:09:25.521 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.521 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.521 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.local.AutoTrackLifecycleListener - onCommit: Deferred operations took 0 ms for 0 entities.
16:09:25.521 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.522 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.522 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e
16:09:25.522 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.522 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.522 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=1104431548-14, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@3b56ea3e]]
16:09:25.522 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection COMMITTING : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@14d03d47 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3982901f, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.522 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection CLOSED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@14d03d47 [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@3982901f, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.523 [qtp1339273738-38] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "P_CLEAN"->"HOLLOW"
16:09:25.523 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") was evicted from transactional cache
16:09:25.523 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
16:09:25.523 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Disconnecting co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db from StateManager[pc=co.codewizards.cloudstore.local.persistence.LocalRepository@5c31f7db, lifecycle=HOLLOW]
16:09:25.523 [qtp1339273738-38] DEBUG DataNucleus.Cache - Level 1 Cache cleared
16:09:25.523 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext CLOSED "org.datanucleus.ExecutionContextImpl@678f101e"
16:09:25.523 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.local.LocalRepoManagerImpl - [24573d55]open: closing=false closeAbortable=true
16:09:25.524 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext OPENED "org.datanucleus.ExecutionContextImpl@678f101e" for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2974ed23" with txn="org.datanucleus.TransactionImpl@70a53d76"
16:09:25.524 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=1104431548-15, enlisted resources=[]]
16:09:25.524 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e (optimistic=false)
16:09:25.524 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [5b2dce5b]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
16:09:25.524 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [5b2dce5b]tryAcquire: returning true. lockCounter=1
16:09:25.524 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [5b2dce5b]tryAcquire: returning true. lockCounter=2
16:09:25.526 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
16:09:25.526 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [5b2dce5b]release: NOT releasing underlying FileLock. lockCounter=1
16:09:25.526 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [5b2dce5b]release: releasing underlying FileLock. lockCounter=0
16:09:25.527 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (generic) of "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository"
16:09:25.527 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (generic) = 0 ms
16:09:25.527 [qtp1339273738-38] DEBUG DataNucleus.Query - QueryCompilation:
  [symbols: this type=co.codewizards.cloudstore.local.persistence.RemoteRepository]
16:09:25.527 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (datastore) of "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository"
16:09:25.528 [qtp1339273738-38] DEBUG DataNucleus.Query - Compile of JDOQL into SQL - JoinType : navigation(default=(using nullability), filter=(using nullability))
16:09:25.529 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (datastore) = 2 ms
16:09:25.530 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection OPENED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@54145cb [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@579ff788, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" on resource "tx" with isolation level "read-committed" and auto-commit=false
16:09:25.530 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@5e9a5461, error code TMNOFLAGS and transaction [DataNucleus Transaction, ID=1104431548-15, enlisted resources=[]]
16:09:25.530 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository" ...
16:09:25.538 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "6a4644ef-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@579ff788"
16:09:25.538 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."changed","a0"."created","a0"."id","a0"."repositoryid","a0"."revision","a0"."localpathprefix","a0"."localrevision","a0"."remoteroot","a0"."remoterootsha1","a0"."discriminator" FROM "repository" "a0" WHERE "a0"."discriminator" = 'RemoteRepository'
16:09:25.539 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.539 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 9 ms
16:09:25.539 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (generic) of "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest"
16:09:25.540 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (generic) = 1 ms
16:09:25.540 [qtp1339273738-38] DEBUG DataNucleus.Query - QueryCompilation:
  [symbols: this type=co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest]
16:09:25.540 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (datastore) of "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest"
16:09:25.541 [qtp1339273738-38] DEBUG DataNucleus.Query - Compile of JDOQL into SQL - JoinType : navigation(default=(using nullability), filter=(using nullability))
16:09:25.541 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (datastore) = 1 ms
16:09:25.542 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest" ...
16:09:25.547 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "8cbe04f1-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@579ff788"
16:09:25.547 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT 'co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest' AS "dn_type","a0"."changed","a0"."created","a0"."id","a0"."localpathprefix","a0"."repositoryid" FROM "remoterepositoryrequest" "a0"
16:09:25.548 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.548 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 6 ms
16:09:25.549 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (generic) of "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile"
16:09:25.550 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (generic) = 1 ms
16:09:25.550 [qtp1339273738-38] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.NormalFile]
16:09:25.550 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (datastore) of "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile"
16:09:25.551 [qtp1339273738-38] DEBUG DataNucleus.Query - Compile of JDOQL into SQL - JoinType : navigation(default=(using nullability), filter=(using nullability))
16:09:25.552 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (datastore) = 2 ms
16:09:25.552 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile" ...
16:09:25.563 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "af36c4f3-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@579ff788"
16:09:25.563 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "repofile" "a0" WHERE "a0"."discriminator" = 'NormalFile'
16:09:25.564 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.564 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 12 ms
16:09:25.565 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (generic) of "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory"
16:09:25.566 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (generic) = 1 ms
16:09:25.566 [qtp1339273738-38] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.Directory]
16:09:25.566 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (datastore) of "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory"
16:09:25.567 [qtp1339273738-38] DEBUG DataNucleus.Query - Compile of JDOQL into SQL - JoinType : navigation(default=(using nullability), filter=(using nullability))
16:09:25.567 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (datastore) = 1 ms
16:09:25.568 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory" ...
16:09:25.577 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "51b084f5-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@579ff788"
16:09:25.577 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "repofile" "a0" WHERE "a0"."discriminator" = 'Directory'
16:09:25.577 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 0 ms
16:09:25.578 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 10 ms
16:09:25.578 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (generic) of "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification"
16:09:25.579 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (generic) = 1 ms
16:09:25.579 [qtp1339273738-38] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.CopyModification]
16:09:25.579 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (datastore) of "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification"
16:09:25.580 [qtp1339273738-38] DEBUG DataNucleus.Query - Compile of JDOQL into SQL - JoinType : navigation(default=(using nullability), filter=(using nullability))
16:09:25.581 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (datastore) = 2 ms
16:09:25.581 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification" ...
16:09:25.594 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "f42b44f7-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@579ff788"
16:09:25.594 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "copymodification" "a0" INNER JOIN "modification" "a1" ON "a0"."id" = "a1"."id" WHERE "a1"."discriminator" = 'CopyModification'
16:09:25.595 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 1 ms
16:09:25.595 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 14 ms
16:09:25.595 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (generic) of "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification"
16:09:25.596 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (generic) = 1 ms
16:09:25.596 [qtp1339273738-38] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.DeleteModification]
16:09:25.596 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile (datastore) of "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification"
16:09:25.597 [qtp1339273738-38] DEBUG DataNucleus.Query - Compile of JDOQL into SQL - JoinType : navigation(default=(using nullability), filter=(using nullability))
16:09:25.598 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time (datastore) = 2 ms
16:09:25.598 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification" ...
16:09:25.609 [qtp1339273738-38] DEBUG DataNucleus.Datastore - Using PreparedStatement "16a704f9-0171-d091-be18-000007fe7318" for connection "org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@579ff788"
16:09:25.610 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "deletemodification" "a0" INNER JOIN "modification" "a1" ON "a0"."id" = "a1"."id" WHERE "a1"."discriminator" = 'DeleteModification'
16:09:25.610 [qtp1339273738-38] DEBUG DataNucleus.Datastore.Retrieve - SQL Execution Time = 0 ms
16:09:25.611 [qtp1339273738-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 13 ms
16:09:25.611 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.611 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.611 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.local.AutoTrackLifecycleListener - onCommit: Deferred operations took 0 ms for 0 entities.
16:09:25.611 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.611 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.611 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@678f101e
16:09:25.612 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() START : using ordered flush - 0 enlisted objects
16:09:25.612 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() END
16:09:25.612 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=1104431548-15, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@5e9a5461]]
16:09:25.612 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection COMMITTING : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@54145cb [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@579ff788, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.612 [qtp1339273738-38] DEBUG DataNucleus.Connection - ManagedConnection CLOSED : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@54145cb [conn=org.datanucleus.store.rdbms.datasource.dbcp2.PoolingDataSource$PoolGuardConnectionWrapper@579ff788, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]"
16:09:25.612 [qtp1339273738-38] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
16:09:25.613 [qtp1339273738-38] DEBUG DataNucleus.Persistence - ExecutionContext CLOSED "org.datanucleus.ExecutionContextImpl@678f101e"
16:09:25.613 [qtp1339273738-38] INFO co.codewizards.cloudstore.local.LocalRepoManagerImpl - [24573d55]getCloseDeferredMillis: closeDeferredMillis=0
16:09:25.613 [qtp1339273738-38] INFO co.codewizards.cloudstore.local.LocalRepoManagerImpl - [24573d55]close: Closing real LocalRepoManager immediately.
16:09:25.613 [qtp1339273738-38] INFO co.codewizards.cloudstore.local.LocalRepoManagerImpl - [24573d55]_close: Shutting down real LocalRepoManager.
16:09:25.613 [qtp1339273738-38] DEBUG DataNucleus.Connection - Closing ConnectionPool "tx"
16:09:25.614 [qtp1339273738-38] DEBUG DataNucleus.Connection - Closing ConnectionPool "nontx"
16:09:25.616 [qtp1339273738-38] DEBUG DataNucleus.Persistence - Unmanaging Persistence of all classes
16:09:25.616 [qtp1339273738-38] DEBUG DataNucleus.MetaData - Deregistering listener for metadata initialisation
16:09:25.616 [qtp1339273738-38] DEBUG DataNucleus.Cache - Level 2 Cache cleared
16:09:25.616 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.local.db.DatabaseAdapterFactoryRegistry - getDatabaseAdapterFactoryOrFail: returning existing DatabaseAdapterFactory instance.
16:09:25.618 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.jdbc.hostName' is not set (config is queried next).
16:09:25.618 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.jdbc.userName' is not set (config is queried next).
16:09:25.618 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.jdbc.password' is not set (config is queried next).
16:09:25.618 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.jdbc.dbNamePrefix' is not set (config is queried next).
16:09:25.619 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.jdbc.dbNameSuffix' is not set (config is queried next).
16:09:25.619 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.jdbc.sysdbName' is not set (config is queried next).
16:09:26.034 [qtp1339273738-38] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [1333a685]release: releasing underlying FileLock. lockCounter=0
16:09:26.045 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpChannel - sendResponse info=null content=HeapByteBuffer@161dc194[p=0,l=773,c=8192,r=773]={<<<<?xml version="1....nfoResponseDto>>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00} complete=true committing=true callback=Blocker@784ee67a{null}
16:09:26.046 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpChannel - COMMIT for /RepoInfo on HttpChannelOverHttp@281c3a81{r=1,c=true,c=false/false,a=DISPATCHED,uri=//127.0.0.1:45280/RepoInfo,age=2888}
200 OK HTTP/1.1
Content-Length: 773
Content-Type: application/xml


16:09:26.046 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$SendCallback@3526a1b[PROCESSING][i=HTTP/1.1{s=200,h=2,cl=773},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@1620300b] generate: NEED_HEADER (null,[p=0,l=773,c=8192,r=773],true)@START
16:09:26.046 [qtp1339273738-38] DEBUG org.eclipse.jetty.http.HttpGenerator - generateHeaders HTTP/1.1{s=200,h=2,cl=773} last=true content=HeapByteBuffer@161dc194[p=0,l=773,c=8192,r=773]={<<<<?xml version="1....nfoResponseDto>>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
16:09:26.046 [qtp1339273738-38] DEBUG org.eclipse.jetty.http.HttpGenerator - Content-Length: 773
Content-Type: application/xml


16:09:26.046 [qtp1339273738-38] DEBUG org.eclipse.jetty.http.HttpGenerator - CONTENT_LENGTH
16:09:26.046 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$SendCallback@3526a1b[PROCESSING][i=HTTP/1.1{s=200,h=2,cl=773},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@1620300b] generate: FLUSH ([p=0,l=104,c=8192,r=104],[p=0,l=773,c=8192,r=773],true)@COMPLETING
16:09:26.047 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.WriteFlusher - write: WriteFlusher@6e49523a{IDLE}->null [HeapByteBuffer@40d7e3ab[p=0,l=104,c=8192,r=104]={<<<HTTP/1.1 200 OK\r\n....v20190418)\r\n\r\n>>>ZadVVSVXpCTEVSU0p...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@161dc194[p=0,l=773,c=8192,r=773]={<<<<?xml version="1....nfoResponseDto>>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}]
16:09:26.047 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@6e49523a{WRITING}->null:IDLE-->WRITING
16:09:26.047 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 877 SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=-,flush=W,to=2894/30000}{io=0/0,kio=0,kro=1}->HttpConnection@692130ba[p=HttpParser{s=END,244 of 244},g=HttpGenerator@11036724{s=COMPLETING}]=>HttpChannelOverHttp@281c3a81{r=1,c=true,c=false/false,a=DISPATCHED,uri=//127.0.0.1:45280/RepoInfo,age=2890}
16:09:26.047 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.WriteFlusher - Flushed=true written=877 remaining=0 WriteFlusher@6e49523a{WRITING}->null
16:09:26.048 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@6e49523a{IDLE}->null:WRITING-->IDLE
16:09:26.048 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$SendCallback@3526a1b[PROCESSING][i=HTTP/1.1{s=200,h=2,cl=773},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@1620300b] generate: DONE ([p=104,l=104,c=8192,r=0],[p=773,l=773,c=8192,r=0],true)@END
16:09:26.048 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.session - FinalSession=null, old_session_handler=null, this=org.eclipse.jetty.server.session.SessionHandler1840987517==dftMaxIdleSec=-1, calling complete=true
16:09:26.048 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.session - Complete called with session null
16:09:26.049 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.Server - handled=true async=false committed=true on HttpChannelOverHttp@281c3a81{r=1,c=true,c=false/true,a=DISPATCHED,uri=//127.0.0.1:45280/RepoInfo,age=2892}
16:09:26.049 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpChannelState - unhandle HttpChannelState@2c23ab5a{s=DISPATCHED a=NOT_ASYNC i=true r=READY w=false}
16:09:26.049 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@281c3a81{r=1,c=true,c=false/true,a=COMPLETING,uri=//127.0.0.1:45280/RepoInfo,age=2892} action COMPLETE
16:09:26.049 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpChannelState - onComplete HttpChannelState@2c23ab5a{s=COMPLETING a=NOT_ASYNC i=false r=READY w=false}
16:09:26.049 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpChannel - COMPLETE for /RepoInfo written=773
16:09:26.050 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpChannelState - recycle HttpChannelState@2c23ab5a{s=COMPLETED a=NOT_ASYNC i=false r=READY w=false}
16:09:26.050 [qtp1339273738-38] DEBUG org.eclipse.jetty.http.HttpParser - reset HttpParser{s=END,244 of 244}
16:09:26.050 [qtp1339273738-38] DEBUG org.eclipse.jetty.http.HttpParser - END --> START
16:09:26.050 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} handle exit, result COMPLETE
16:09:26.050 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.ChannelEndPoint - filled 0 HeapByteBuffer@40d7e3ab[p=0,l=0,c=8192,r=0]={<<<>>>HTTP/1.1 200 OK\r\n...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
16:09:26.050 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.ChannelEndPoint - filled 0 HeapByteBuffer@40d7e3ab[p=0,l=0,c=8192,r=0]={<<<>>>HTTP/1.1 200 OK\r\n...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
16:09:26.051 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpConnection - HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=-,flush=-,to=3/30000}{io=0/0,kio=0,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} filled 0 HeapByteBuffer@40d7e3ab[p=0,l=0,c=8192,r=0]={<<<>>>HTTP/1.1 200 OK\r\n...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
16:09:26.051 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpConnection - HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=-,flush=-,to=4/30000}{io=0/0,kio=0,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} parse HeapByteBuffer@40d7e3ab[p=0,l=0,c=8192,r=0]={<<<>>>HTTP/1.1 200 OK\r\n...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00} {}
16:09:26.051 [qtp1339273738-38] DEBUG org.eclipse.jetty.http.HttpParser - parseNext s=START HeapByteBuffer@40d7e3ab[p=0,l=0,c=8192,r=0]={<<<>>>HTTP/1.1 200 OK\r\n...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
16:09:26.051 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpConnection - HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=-,flush=-,to=4/30000}{io=0/0,kio=0,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} parsed false HttpParser{s=START,0 of -1}
16:09:26.052 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpConnection - releaseRequestBuffer HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=-,flush=-,to=5/30000}{io=0/0,kio=0,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
16:09:26.052 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.AbstractConnection - fillInterested HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=-,flush=-,to=5/30000}{io=0/0,kio=0,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
16:09:26.053 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.FillInterest - interested FillInterest@58829fb7{AC.ReadCB@692130ba{HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=FI,flush=-,to=1/30000}{io=0/0,kio=0,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}}}
16:09:26.054 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.ChannelEndPoint - changeInterests p=false 0->1 for SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=FI,flush=-,to=1/30000}{io=0/1,kio=0,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
16:09:26.054 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ChannelEndPoint$1@694a9686 on ManagedSelector@73da303e{STARTED} id=1 keys=1 selected=0 updates=0
16:09:26.054 [qtp1339273738-38] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@73da303e{STARTED} id=1 keys=1 selected=0 updates=1
16:09:26.054 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 woken with none selected
16:09:26.054 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 woken up from select, 0/0/1 selected
16:09:26.054 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 processing 0 keys, 1 updates
16:09:26.054 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
16:09:26.054 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ChannelEndPoint$1@694a9686
16:09:26.054 [qtp1339273738-38] DEBUG org.eclipse.jetty.server.HttpConnection - HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=FI,flush=-,to=2/30000}{io=0/1,kio=0,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} onFillable exit HttpChannelState@2c23ab5a{s=IDLE a=NOT_ASYNC i=true r=IDLE w=false} null
16:09:26.055 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ChannelEndPoint - Key interests updated 0 -> 1 on SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=FI,flush=-,to=2/30000}{io=1/1,kio=1,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
16:09:26.055 [qtp1339273738-38] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran CEP:SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=FI,flush=-,to=3/30000}{io=1/1,kio=1,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}:runFillable:BLOCKING
16:09:26.055 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
16:09:26.055 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 waiting with 1 keys
16:09:26.065 [main] DEBUG co.codewizards.cloudstore.ls.rest.client.LocalServerRestClient - execute: invocation took 3021 ms
Local repository:
  repository.repositoryId = 6488f7e3-73e3-4790-a451-fb10c978504b
  repository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/repo/k9o9wdif-w4jm1
  repository.aliases = co.codewizards.cloudstore.ls.core.dto.RepoInfoResponseDto@5454be
  repository.publicKeySha1 = 7E:D8:B1:C4:96:87:37:70:D1:EA:B7:27:9D:2B:3D:19:7E:C1:FA:11

Remote repositories connected: {NONE}

Remote repositories requesting connection: {NONE}

Statistics:
  * Count(NormalFile): 0
  * Count(Directory): 1
  * Count(CopyModification): 0
  * Count(DeleteModification): 0

16:09:26.066 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping Server@295d54d6{STARTED}[9.4.17.v20190418]
16:09:26.066 [main] DEBUG org.eclipse.jetty.server.Server - doStop Server@295d54d6{STOPPING}[9.4.17.v20190418]
16:09:26.066 [qtp1339273738-35] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran qtp1339273738-35-acceptor-0@2f166d61-ServerConnector@158e6fc2{HTTP/1.1,[http/1.1]}{127.0.0.1:45280}
16:09:26.066 [main] DEBUG org.eclipse.jetty.server.handler.AbstractHandlerContainer - Graceful shutdown Server@295d54d6{STOPPING}[9.4.17.v20190418] by 
16:09:26.066 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping ServerConnector@158e6fc2{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
16:09:26.066 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping SelectorManager@ServerConnector@158e6fc2{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
16:09:26.067 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping ManagedSelector@5d0e703a{STARTED} id=2 keys=0 selected=0 updates=0
16:09:26.067 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseConnections@2dd08ff1 on ManagedSelector@5d0e703a{STOPPING} id=2 keys=0 selected=0 updates=0
16:09:26.067 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@5d0e703a{STOPPING} id=2 keys=0 selected=0 updates=1
16:09:26.067 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5124dbcd woken with none selected
16:09:26.067 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5124dbcd woken up from select, 0/0/0 selected
16:09:26.067 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5124dbcd processing 0 keys, 1 updates
16:09:26.068 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
16:09:26.068 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$CloseConnections@2dd08ff1
16:09:26.068 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Closing 0 connections on ManagedSelector@5d0e703a{STOPPING} id=2 keys=0 selected=0 updates=0
16:09:26.068 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
16:09:26.068 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$StopSelector@37dec463 on ManagedSelector@5d0e703a{STOPPING} id=2 keys=0 selected=0 updates=0
16:09:26.068 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5124dbcd waiting with 0 keys
16:09:26.068 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@5d0e703a{STOPPING} id=2 keys=0 selected=0 updates=1
16:09:26.069 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5124dbcd woken with none selected
16:09:26.069 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5124dbcd woken up from select, 0/0/0 selected
16:09:26.069 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5124dbcd processing 0 keys, 1 updates
16:09:26.069 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
16:09:26.069 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$StopSelector@37dec463
16:09:26.069 [qtp1339273738-34] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
16:09:26.069 [qtp1339273738-34] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector$$Lambda$231/0x0000000800320840@3a751535
16:09:26.070 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping EatWhatYouKill@24068086/SelectorProducer@32513dea/IDLE/p=false/QueuedThreadPool[qtp1339273738]@4fd3b20a{STARTED,8<=8<=500,i=5,q=0}[ReservedThreadExecutor@45c408a4{s=1/6,p=0}][pc=0,pic=0,pec=0,epc=0]@2020-05-01T16:09:26.069898+02:00
16:09:26.070 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED EatWhatYouKill@24068086/SelectorProducer@32513dea/IDLE/p=false/QueuedThreadPool[qtp1339273738]@4fd3b20a{STARTED,8<=8<=500,i=5,q=0}[ReservedThreadExecutor@45c408a4{s=1/6,p=0}][pc=0,pic=0,pec=0,epc=0]@2020-05-01T16:09:26.070459+02:00
16:09:26.070 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED ManagedSelector@5d0e703a{STOPPED} id=2 keys=-1 selected=-1 updates=0
16:09:26.070 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping ManagedSelector@73da303e{STARTED} id=1 keys=1 selected=0 updates=0
16:09:26.071 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseConnections@3bf26810 on ManagedSelector@73da303e{STOPPING} id=1 keys=1 selected=0 updates=0
16:09:26.071 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@73da303e{STOPPING} id=1 keys=1 selected=0 updates=1
16:09:26.071 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 woken with none selected
16:09:26.071 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 woken up from select, 0/0/1 selected
16:09:26.071 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 processing 0 keys, 1 updates
16:09:26.071 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
16:09:26.071 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$CloseConnections@3bf26810
16:09:26.071 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Closing 1 connections on ManagedSelector@73da303e{STOPPING} id=1 keys=1 selected=0 updates=0
16:09:26.072 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.AbstractEndPoint - close SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=FI,flush=-,to=19/30000}{io=1/1,kio=1,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
16:09:26.072 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.AbstractEndPoint - close(null) SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,OPEN,fill=FI,flush=-,to=20/30000}{io=1/1,kio=1,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
16:09:26.074 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ChannelEndPoint - doClose SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,CLOSED,fill=FI,flush=-,to=20/30000}{io=1/1,kio=1,kro=1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
16:09:26.074 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@6e49523a{IDLE}->null
java.nio.channels.ClosedChannelException: null
	at org.eclipse.jetty.io.WriteFlusher.onClose(WriteFlusher.java:492)
	at org.eclipse.jetty.io.AbstractEndPoint.onClose(AbstractEndPoint.java:353)
	at org.eclipse.jetty.io.ChannelEndPoint.onClose(ChannelEndPoint.java:215)
	at org.eclipse.jetty.io.AbstractEndPoint.doOnClose(AbstractEndPoint.java:225)
	at org.eclipse.jetty.io.AbstractEndPoint.close(AbstractEndPoint.java:192)
	at org.eclipse.jetty.io.AbstractEndPoint.close(AbstractEndPoint.java:175)
	at org.eclipse.jetty.io.AbstractConnection.close(AbstractConnection.java:248)
	at org.eclipse.jetty.io.ManagedSelector.closeNoExceptions(ManagedSelector.java:252)
	at org.eclipse.jetty.io.ManagedSelector.access$1400(ManagedSelector.java:61)
	at org.eclipse.jetty.io.ManagedSelector$CloseConnections.update(ManagedSelector.java:866)
	at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.processUpdates(ManagedSelector.java:426)
	at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:397)
	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:357)
	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:181)
	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:132)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:786)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:743)
	at java.base/java.lang.Thread.run(Thread.java:834)
16:09:26.075 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.FillInterest - onClose FillInterest@58829fb7{AC.ReadCB@692130ba{HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,CLOSED,fill=FI,flush=-,to=23/30000}{io=1/1,kio=-1,kro=-1}->HttpConnection@692130ba[p=HttpParser{s=START,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}}}
16:09:26.076 [qtp1339273738-33] DEBUG org.eclipse.jetty.http.HttpParser - close HttpParser{s=START,0 of -1}
16:09:26.076 [qtp1339273738-33] DEBUG org.eclipse.jetty.http.HttpParser - START --> CLOSE
16:09:26.076 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.AbstractConnection - HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,CLOSED,fill=-,flush=-,to=24/30000}{io=1/1,kio=-1,kro=-1}->HttpConnection@692130ba[p=HttpParser{s=CLOSE,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} onFillInterestedFailed {}
16:09:26.076 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup ManagedSelector@73da303e{STOPPING} id=1 keys=1 selected=0 updates=0
16:09:26.076 [qtp1339273738-33] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - queue org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@34bcd111
16:09:26.077 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
16:09:26.077 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 waiting with 1 keys
16:09:26.077 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$StopSelector@19213a74 on ManagedSelector@73da303e{STOPPING} id=1 keys=1 selected=0 updates=0
16:09:26.077 [qtp1339273738-39] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - run org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@34bcd111
16:09:26.077 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@73da303e{STOPPING} id=1 keys=0 selected=0 updates=1
16:09:26.078 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 woken with none selected
16:09:26.078 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 woken up from select, 0/0/0 selected
16:09:26.078 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7b463a32 processing 0 keys, 1 updates
16:09:26.078 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
16:09:26.078 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$StopSelector@19213a74
16:09:26.078 [qtp1339273738-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
16:09:26.078 [qtp1339273738-33] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector$$Lambda$231/0x0000000800320840@546083d6
16:09:26.079 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping EatWhatYouKill@1c815814/SelectorProducer@14af73e1/IDLE/p=false/QueuedThreadPool[qtp1339273738]@4fd3b20a{STARTED,8<=8<=500,i=5,q=0}[ReservedThreadExecutor@45c408a4{s=1/6,p=0}][pc=0,pic=0,pec=1,epc=0]@2020-05-01T16:09:26.078767+02:00
16:09:26.079 [qtp1339273738-39] DEBUG org.eclipse.jetty.io.ManagedSelector - Destroyed SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,CLOSED,fill=-,flush=-,to=26/30000}{io=1/1,kio=-1,kro=-1}->HttpConnection@692130ba[p=HttpParser{s=CLOSE,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
16:09:26.079 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED EatWhatYouKill@1c815814/SelectorProducer@14af73e1/IDLE/p=false/QueuedThreadPool[qtp1339273738]@4fd3b20a{STARTED,8<=8<=500,i=5,q=0}[ReservedThreadExecutor@45c408a4{s=1/6,p=0}][pc=0,pic=0,pec=1,epc=0]@2020-05-01T16:09:26.07925+02:00
16:09:26.079 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED ManagedSelector@73da303e{STOPPED} id=1 keys=-1 selected=-1 updates=0
16:09:26.079 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping ManagedSelector@53a09566{STARTED} id=0 keys=0 selected=0 updates=0
16:09:26.079 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseConnections@30a791a6 on ManagedSelector@53a09566{STOPPING} id=0 keys=0 selected=0 updates=0
16:09:26.079 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@53a09566{STOPPING} id=0 keys=0 selected=0 updates=1
16:09:26.080 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5b626288 woken with none selected
16:09:26.080 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5b626288 woken up from select, 0/0/0 selected
16:09:26.080 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5b626288 processing 0 keys, 1 updates
16:09:26.080 [qtp1339273738-39] DEBUG org.eclipse.jetty.io.AbstractConnection - onClose HttpConnection@692130ba::SocketChannelEndPoint@26dbc02a{/127.0.0.1:38308<->/127.0.0.1:45280,CLOSED,fill=-,flush=-,to=27/30000}{io=1/1,kio=-1,kro=-1}->HttpConnection@692130ba[p=HttpParser{s=CLOSE,0 of -1},g=HttpGenerator@11036724{s=START}]=>HttpChannelOverHttp@281c3a81{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
16:09:26.080 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
16:09:26.080 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$CloseConnections@30a791a6
16:09:26.081 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Closing 0 connections on ManagedSelector@53a09566{STOPPING} id=0 keys=0 selected=0 updates=0
16:09:26.081 [qtp1339273738-39] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@34bcd111
16:09:26.081 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
16:09:26.081 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5b626288 waiting with 0 keys
16:09:26.081 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$StopSelector@719bb60d on ManagedSelector@53a09566{STOPPING} id=0 keys=0 selected=0 updates=0
16:09:26.082 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@53a09566{STOPPING} id=0 keys=0 selected=0 updates=1
16:09:26.082 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5b626288 woken with none selected
16:09:26.082 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5b626288 woken up from select, 0/0/0 selected
16:09:26.082 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@5b626288 processing 0 keys, 1 updates
16:09:26.082 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
16:09:26.082 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$StopSelector@719bb60d
16:09:26.082 [qtp1339273738-32] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
16:09:26.082 [qtp1339273738-32] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector$$Lambda$231/0x0000000800320840@7f77e065
16:09:26.083 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping EatWhatYouKill@2295566b/SelectorProducer@174e1b99/IDLE/p=false/QueuedThreadPool[qtp1339273738]@4fd3b20a{STARTED,8<=8<=500,i=7,q=0}[ReservedThreadExecutor@45c408a4{s=1/6,p=0}][pc=0,pic=0,pec=0,epc=0]@2020-05-01T16:09:26.083282+02:00
16:09:26.083 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED EatWhatYouKill@2295566b/SelectorProducer@174e1b99/IDLE/p=false/QueuedThreadPool[qtp1339273738]@4fd3b20a{STARTED,8<=8<=500,i=7,q=0}[ReservedThreadExecutor@45c408a4{s=1/6,p=0}][pc=0,pic=0,pec=0,epc=0]@2020-05-01T16:09:26.083628+02:00
16:09:26.083 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED ManagedSelector@53a09566{STOPPED} id=0 keys=-1 selected=-1 updates=0
16:09:26.084 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED SelectorManager@ServerConnector@158e6fc2{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
16:09:26.084 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping HttpConnectionFactory@4a7db5a[HTTP/1.1]
16:09:26.084 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED HttpConnectionFactory@4a7db5a[HTTP/1.1]
16:09:26.084 [main] INFO org.eclipse.jetty.server.AbstractConnector - Stopped ServerConnector@158e6fc2{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
16:09:26.084 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED ServerConnector@158e6fc2{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
16:09:26.084 [main] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping Server@295d54d6{STOPPING}[9.4.17.v20190418]
16:09:26.084 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping DefaultSessionIdManager@21c99abf{STARTED}[worker=node0]
16:09:26.085 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping HouseKeeper@6d6f6ca9{STARTED}[interval=660000, ownscheduler=false]
16:09:26.085 [main] INFO org.eclipse.jetty.server.session - node0 Stopped scavenging
16:09:26.085 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED HouseKeeper@6d6f6ca9{STOPPED}[interval=660000, ownscheduler=false]
16:09:26.085 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED DefaultSessionIdManager@21c99abf{STOPPED}[worker=node0]
16:09:26.085 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping ErrorHandler@26495639{STARTED}
16:09:26.085 [main] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping ErrorHandler@26495639{STOPPING}
16:09:26.085 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED ErrorHandler@26495639{STOPPED}
16:09:26.086 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping o.e.j.s.ServletContextHandler@b2da3a5{/,null,SHUTDOWN}
16:09:26.086 [main] DEBUG org.eclipse.jetty.server.handler.AbstractHandlerContainer - Graceful shutdown o.e.j.s.ServletContextHandler@b2da3a5{/,null,SHUTDOWN} by 
16:09:26.086 [main] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping o.e.j.s.ServletContextHandler@b2da3a5{/,null,UNAVAILABLE}
16:09:26.086 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.session.SessionHandler1840987517==dftMaxIdleSec=-1
16:09:26.086 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.session.DefaultSessionCache@6f4adaab[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
16:09:26.086 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.session.NullSessionDataStore@69de72ec[passivating=false,graceSec=3600]
16:09:26.087 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.session.NullSessionDataStore@69de72ec[passivating=false,graceSec=3600]
16:09:26.087 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.session.DefaultSessionCache@6f4adaab[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
16:09:26.087 [main] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.session.SessionHandler1840987517==dftMaxIdleSec=-1
16:09:26.087 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping ServletHandler@7a3a49e5{STARTED}
16:09:26.087 [main] DEBUG org.eclipse.jetty.server.handler.AbstractHandler - stopping ServletHandler@7a3a49e5{STOPPING}
16:09:26.087 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-4e1a3d5a@aec852f2==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
16:09:26.088 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-4e1a3d5a@aec852f2==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
16:09:26.088 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping org.glassfish.jersey.servlet.ServletContainer-16f4a3c0@94bc9c20==org.glassfish.jersey.servlet.ServletContainer,jsp=null,order=-1,inst=true,async=true
16:09:26.103 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.glassfish.jersey.servlet.ServletContainer-16f4a3c0@94bc9c20==org.glassfish.jersey.servlet.ServletContainer,jsp=null,order=-1,inst=true,async=true
16:09:26.104 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED ServletHandler@7a3a49e5{STOPPED}
16:09:26.104 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.session.SessionHandler1840987517==dftMaxIdleSec=-1
16:09:26.104 [main] INFO org.eclipse.jetty.server.handler.ContextHandler - Stopped o.e.j.s.ServletContextHandler@b2da3a5{/,null,UNAVAILABLE}
16:09:26.104 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED o.e.j.s.ServletContextHandler@b2da3a5{/,null,UNAVAILABLE}
16:09:26.104 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping ScheduledExecutorScheduler@398f0516{STARTED}
16:09:26.105 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED ScheduledExecutorScheduler@398f0516{STOPPED}
16:09:26.105 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping QueuedThreadPool[qtp1339273738]@4fd3b20a{STARTED,8<=8<=500,i=7,q=0}[ReservedThreadExecutor@45c408a4{s=1/6,p=0}]
16:09:26.106 [main] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - Stopping QueuedThreadPool[qtp1339273738]@4fd3b20a{STOPPING,8<=8<=500,i=7,q=0}[ReservedThreadExecutor@45c408a4{s=1/6,p=0}]
16:09:26.106 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - stopping ReservedThreadExecutor@45c408a4{s=1/6,p=0}
16:09:26.106 [main] DEBUG org.eclipse.jetty.util.thread.ReservedThreadExecutor - ReservedThreadExecutor@45c408a4{s=0/6,p=0}@71be5142 offer STOP!
16:09:26.106 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED ReservedThreadExecutor@45c408a4{s=0/6,p=0}
16:09:26.107 [main] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - Waiting for Thread[qtp1339273738-36,5,main] for 14999
16:09:26.107 [qtp1339273738-36] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.107 [qtp1339273738-37] DEBUG org.eclipse.jetty.util.thread.ReservedThreadExecutor - ReservedThreadExecutor@45c408a4{s=0/6,p=0}@71be5142 task=STOP!
16:09:26.107 [qtp1339273738-36] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.107 [qtp1339273738-38] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.107 [qtp1339273738-35] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.107 [qtp1339273738-38] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.107 [qtp1339273738-37] DEBUG org.eclipse.jetty.util.thread.ReservedThreadExecutor - ReservedThreadExecutor@45c408a4{s=0/6,p=0}@71be5142 Exited
16:09:26.107 [qtp1339273738-34] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.107 [qtp1339273738-34] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.108 [qtp1339273738-37] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran ReservedThreadExecutor@45c408a4{s=0/6,p=0}@71be5142
16:09:26.108 [qtp1339273738-33] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.108 [qtp1339273738-33] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.108 [qtp1339273738-39] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.107 [qtp1339273738-35] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.108 [qtp1339273738-39] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.109 [main] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - Waiting for Thread[qtp1339273738-33,5,] for 14998
16:09:26.109 [main] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - Waiting for Thread[qtp1339273738-32,5,main] for 14997
16:09:26.109 [qtp1339273738-32] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.109 [qtp1339273738-32] DEBUG org.eclipse.jetty.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$321/0x000000080094cc40@137ddd88
16:09:26.110 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED QueuedThreadPool[qtp1339273738]@4fd3b20a{STOPPED,8<=0<=500,i=0,q=0}[org.eclipse.jetty.util.thread.TryExecutor$$Lambda$67/0x00000008001e4840@5bf8fa12]
16:09:26.110 [main] DEBUG org.eclipse.jetty.util.component.AbstractLifeCycle - STOPPED Server@295d54d6{STOPPED}[9.4.17.v20190418]
16:09:26.110 [main] INFO co.codewizards.cloudstore.ls.server.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/.cloudstore/localServerRunning.deleteToStop
16:09:26.110 [main] DEBUG co.codewizards.cloudstore.core.io.LockFileImpl - [4e951fb1]release: releasing underlying FileLock. lockCounter=0
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 28.385 sec

Results :

Tests run: 1, Failures: 0, Errors: 0, Skipped: 0

[JENKINS] Recording test results
[INFO] 
[INFO] --- maven-jar-plugin:2.4:jar (default-jar) @ co.codewizards.cloudstore.client ---
[INFO] Building jar: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT.jar
[INFO] 
[INFO] --- maven-dependency-plugin:2.8:copy-dependencies (copy-dependencies) @ co.codewizards.cloudstore.client ---
[INFO] Copying jaxb-api-2.4.0-b180830.0359.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jaxb-api-2.4.0-b180830.0359.jar
[INFO] Copying co.codewizards.cloudstore.rest.shared-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.rest.shared-1.0.1-SNAPSHOT.jar
[INFO] Copying hk2-utils-2.5.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/hk2-utils-2.5.0.jar
[INFO] Copying javax.mail-1.6.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/javax.mail-1.6.0.jar
[INFO] Copying jakarta.inject-2.6.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jakarta.inject-2.6.1.jar
[INFO] Copying co.codewizards.cloudstore.ls.rest.server-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.rest.server-1.0.1-SNAPSHOT.jar
[INFO] Copying jetty-util-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-util-9.4.17.v20190418.jar
[INFO] Copying jetty-servlet-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-servlet-9.4.17.v20190418.jar
[INFO] Copying co.codewizards.cloudstore.local-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.local-1.0.1-SNAPSHOT.jar
[INFO] Copying hk2-locator-2.5.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/hk2-locator-2.5.0.jar
[INFO] Copying aopalliance-repackaged-2.5.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/aopalliance-repackaged-2.5.0.jar
[INFO] Copying FastInfoset-1.2.15.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/FastInfoset-1.2.15.jar
[INFO] Copying jersey-client-2.29.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jersey-client-2.29.1.jar
[INFO] Copying co.codewizards.cloudstore.ls.core-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.core-1.0.1-SNAPSHOT.jar
[INFO] Copying jcl-over-slf4j-2.0.0-alpha1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jcl-over-slf4j-2.0.0-alpha1.jar
[INFO] Copying jetty-continuation-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-continuation-9.4.17.v20190418.jar
[INFO] Copying datanucleus-core-5.2.2.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/datanucleus-core-5.2.2.jar
[INFO] Copying bcprov-jdk15on-161b03.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/bcprov-jdk15on-161b03.jar
[INFO] Copying javassist-3.22.0-CR2.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/javassist-3.22.0-CR2.jar
[INFO] Copying log4j-over-slf4j-2.0.0-alpha1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/log4j-over-slf4j-2.0.0-alpha1.jar
[INFO] Copying jakarta.annotation-api-1.3.5.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jakarta.annotation-api-1.3.5.jar
[INFO] Copying jakarta.ws.rs-api-2.1.6.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jakarta.ws.rs-api-2.1.6.jar
[INFO] Copying osgi-resource-locator-1.0.3.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/osgi-resource-locator-1.0.3.jar
[INFO] Copying jetty-http-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-http-9.4.17.v20190418.jar
[INFO] Copying slf4j-api-2.0.0-alpha1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/slf4j-api-2.0.0-alpha1.jar
[INFO] Copying datanucleus-rdbms-5.2.2.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/datanucleus-rdbms-5.2.2.jar
[INFO] Copying jetty-security-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-security-9.4.17.v20190418.jar
[INFO] Copying co.codewizards.cloudstore.core.oio.nio-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.core.oio.nio-1.0.1-SNAPSHOT.jar
[INFO] Copying jersey-container-servlet-core-2.29.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jersey-container-servlet-core-2.29.1.jar
[INFO] Copying args4j-2.0.16.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/args4j-2.0.16.jar
[INFO] Copying jaxb-runtime-2.4.0-b180830.0438.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jaxb-runtime-2.4.0-b180830.0438.jar
[INFO] Copying javax.activation-api-1.2.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/javax.activation-api-1.2.0.jar
[INFO] Copying co.codewizards.cloudstore.core-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.core-1.0.1-SNAPSHOT.jar
[INFO] Copying co.codewizards.cloudstore.rest.client-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.rest.client-1.0.1-SNAPSHOT.jar
[INFO] Copying stax-ex-1.8.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/stax-ex-1.8.jar
[INFO] Copying co.codewizards.cloudstore.ls.rest.client-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.rest.client-1.0.1-SNAPSHOT.jar
[INFO] Copying jersey-media-jaxb-2.29.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jersey-media-jaxb-2.29.1.jar
[INFO] Copying istack-commons-runtime-3.0.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/istack-commons-runtime-3.0.7.jar
[INFO] Copying derby-10.13.1.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/derby-10.13.1.1.jar
[INFO] Copying postgresql-42.2.12.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/postgresql-42.2.12.jar
[INFO] Copying jul-to-slf4j-2.0.0-alpha1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jul-to-slf4j-2.0.0-alpha1.jar
[INFO] Copying jersey-server-2.29.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jersey-server-2.29.1.jar
[INFO] Copying jersey-hk2-2.28.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jersey-hk2-2.28.jar
[INFO] Copying commons-compress-1.18.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/commons-compress-1.18.jar
[INFO] Copying jetty-servlets-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-servlets-9.4.17.v20190418.jar
[INFO] Copying jetty-server-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-server-9.4.17.v20190418.jar
[INFO] Copying jersey-container-servlet-2.29.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jersey-container-servlet-2.29.1.jar
[INFO] Copying co.codewizards.cloudstore.ls.server-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.server-1.0.1-SNAPSHOT.jar
[INFO] Copying jersey-common-2.29.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jersey-common-2.29.1.jar
[INFO] Copying txw2-2.4.0-b180830.0438.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/txw2-2.4.0-b180830.0438.jar
[INFO] Copying hk2-api-2.5.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/hk2-api-2.5.0.jar
[INFO] Copying javax.jdo-3.2.0-m13.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/javax.jdo-3.2.0-m13.jar
[INFO] Copying co.codewizards.cloudstore.updater-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.updater-1.0.1-SNAPSHOT.jar
[INFO] Copying jakarta.validation-api-2.0.2.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jakarta.validation-api-2.0.2.jar
[INFO] Copying jetty-xml-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-xml-9.4.17.v20190418.jar
[INFO] Copying co.codewizards.cloudstore.ls.server.cproc-1.0.1-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.server.cproc-1.0.1-SNAPSHOT.jar
[INFO] Copying logback-classic-1.3.0-alpha4.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/logback-classic-1.3.0-alpha4.jar
[INFO] Copying datanucleus-api-jdo-5.2.3.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/datanucleus-api-jdo-5.2.3.jar
[INFO] Copying jetty-io-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-io-9.4.17.v20190418.jar
[INFO] Copying logback-core-1.3.0-alpha4.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/logback-core-1.3.0-alpha4.jar
[INFO] Copying jetty-webapp-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/jetty-webapp-9.4.17.v20190418.jar
[INFO] Copying bcpg-jdk15on-161b03.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/dependency/bcpg-jdk15on-161b03.jar
[INFO] 
[INFO] --- maven-assembly-plugin:2.2-beta-5:single (make-assembly) @ co.codewizards.cloudstore.client ---
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.1/maven-common-artifact-filters-1.1.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.1/maven-common-artifact-filters-1.1.pom (2.8 kB at 115 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-plugin-testing-harness/1.1/maven-plugin-testing-harness-1.1.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-plugin-testing-harness/1.1/maven-plugin-testing-harness-1.1.pom (6.3 kB at 226 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/7/maven-shared-components-7.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/7/maven-shared-components-7.pom (2.6 kB at 79 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.0/maven-project-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.0/maven-project-2.0.pom (1.6 kB at 68 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven/2.0/maven-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven/2.0/maven-2.0.pom (8.8 kB at 351 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.0/maven-profile-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.0/maven-profile-2.0.pom (1.4 kB at 57 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.0/maven-model-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.0/maven-model-2.0.pom (2.4 kB at 96 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0/maven-artifact-manager-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0/maven-artifact-manager-2.0.pom (1.3 kB at 47 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0/maven-repository-metadata-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0/maven-repository-metadata-2.0.pom (1.2 kB at 38 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0/maven-artifact-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0/maven-artifact-2.0.pom (723 B at 30 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-core/2.0/maven-core-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-core/2.0/maven-core-2.0.pom (5.6 kB at 233 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-settings/2.0/maven-settings-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-settings/2.0/maven-settings-2.0.pom (1.4 kB at 60 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-parameter-documenter/2.0/maven-plugin-parameter-documenter-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-parameter-documenter/2.0/maven-plugin-parameter-documenter-2.0.pom (1.5 kB at 57 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting-api/2.0/maven-reporting-api-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting-api/2.0/maven-reporting-api-2.0.pom (1.1 kB at 35 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting/2.0/maven-reporting-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting/2.0/maven-reporting-2.0.pom (504 B at 21 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/doxia/doxia-sink-api/1.0-alpha-4/doxia-sink-api-1.0-alpha-4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/doxia/doxia-sink-api/1.0-alpha-4/doxia-sink-api-1.0-alpha-4.pom (1.1 kB at 46 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-error-diagnostics/2.0/maven-error-diagnostics-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-error-diagnostics/2.0/maven-error-diagnostics-2.0.pom (812 B at 31 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-registry/2.0/maven-plugin-registry-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-registry/2.0/maven-plugin-registry-2.0.pom (1.3 kB at 48 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-api/2.0/maven-plugin-api-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-api/2.0/maven-plugin-api-2.0.pom (601 B at 21 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-descriptor/2.0/maven-plugin-descriptor-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-descriptor/2.0/maven-plugin-descriptor-2.0.pom (1.5 kB at 54 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-monitor/2.0/maven-monitor-2.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-monitor/2.0/maven-monitor-2.0.pom (400 B at 15 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/1.0-alpha-7/plexus-archiver-1.0-alpha-7.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/1.0-alpha-7/plexus-archiver-1.0-alpha-7.pom (1.0 kB at 42 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-components/1.1.6/plexus-components-1.1.6.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-components/1.1.6/plexus-components-1.1.6.pom (1.9 kB at 86 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/1.2/plexus-utils-1.2.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/1.2/plexus-utils-1.2.pom (767 B at 38 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus/1.0.5/plexus-1.0.5.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus/1.0.5/plexus-1.0.5.pom (5.9 kB at 212 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-interpolation/1.7/plexus-interpolation-1.7.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-interpolation/1.7/plexus-interpolation-1.7.pom (2.9 kB at 104 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/1.0-alpha-12/plexus-archiver-1.0-alpha-12.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/1.0-alpha-12/plexus-archiver-1.0-alpha-12.pom (1.6 kB at 72 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/1.0-alpha-4/plexus-io-1.0-alpha-4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/1.0-alpha-4/plexus-io-1.0-alpha-4.pom (1.2 kB at 48 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.1/file-management-1.1.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.1/file-management-1.1.pom (2.7 kB at 89 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/4/maven-shared-components-4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/4/maven-shared-components-4.pom (2.2 kB at 79 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-parent/4/maven-parent-4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-parent/4/maven-parent-4.pom (10.0 kB at 333 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-io/1.0/maven-shared-io-1.0.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-io/1.0/maven-shared-io-1.0.pom (3.0 kB at 108 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-filtering/1.0-beta-2/maven-filtering-1.0-beta-2.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-filtering/1.0-beta-2/maven-filtering-1.0-beta-2.pom (4.0 kB at 161 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-interpolation/1.6/plexus-interpolation-1.6.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-interpolation/1.6/plexus-interpolation-1.6.pom (2.9 kB at 116 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-active-collections/1.0-beta-2/plexus-active-collections-1.0-beta-2.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-active-collections/1.0-beta-2/plexus-active-collections-1.0-beta-2.pom (2.8 kB at 107 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-container-default/1.0-alpha-22/plexus-container-default-1.0-alpha-22.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-container-default/1.0-alpha-22/plexus-container-default-1.0-alpha-22.pom (3.0 kB at 115 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-containers/1.0-alpha-22/plexus-containers-1.0-alpha-22.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-containers/1.0-alpha-22/plexus-containers-1.0-alpha-22.pom (1.9 kB at 73 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-api/2.0.4/maven-plugin-api-2.0.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-api/2.0.4/maven-plugin-api-2.0.4.pom (643 B at 25 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven/2.0.4/maven-2.0.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven/2.0.4/maven-2.0.4.pom (12 kB at 393 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.0.4/maven-project-2.0.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.0.4/maven-project-2.0.4.pom (1.8 kB at 80 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-settings/2.0.4/maven-settings-2.0.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-settings/2.0.4/maven-settings-2.0.4.pom (1.6 kB at 74 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.0.4/maven-model-2.0.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.0.4/maven-model-2.0.4.pom (2.7 kB at 108 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.0.4/maven-profile-2.0.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.0.4/maven-profile-2.0.4.pom (1.6 kB at 77 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0.4/maven-artifact-manager-2.0.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0.4/maven-artifact-manager-2.0.4.pom (1.4 kB at 50 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0.4/maven-repository-metadata-2.0.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0.4/maven-repository-metadata-2.0.4.pom (1.5 kB at 53 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0.4/maven-artifact-2.0.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0.4/maven-artifact-2.0.4.pom (765 B at 35 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-archiver/2.4/maven-archiver-2.4.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-archiver/2.4/maven-archiver-2.4.pom (3.4 kB at 137 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/1.0-alpha-11/plexus-archiver-1.0-alpha-11.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/1.0-alpha-11/plexus-archiver-1.0-alpha-11.pom (1.8 kB at 69 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-container-default/1.0-alpha-15/plexus-container-default-1.0-alpha-15.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-container-default/1.0-alpha-15/plexus-container-default-1.0-alpha-15.pom (1.7 kB at 68 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-containers/1.0-alpha-15/plexus-containers-1.0-alpha-15.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-containers/1.0-alpha-15/plexus-containers-1.0-alpha-15.pom (1.9 kB at 61 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-component-api/1.0-alpha-15/plexus-component-api-1.0-alpha-15.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-component-api/1.0-alpha-15/plexus-component-api-1.0-alpha-15.pom (948 B at 38 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-classworlds/1.2-alpha-6/plexus-classworlds-1.2-alpha-6.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-classworlds/1.2-alpha-6/plexus-classworlds-1.2-alpha-6.pom (2.4 kB at 79 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/1.0-alpha-3/plexus-io-1.0-alpha-3.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/1.0-alpha-3/plexus-io-1.0-alpha-3.pom (1.4 kB at 56 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-component-api/1.0-alpha-16/plexus-component-api-1.0-alpha-16.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-component-api/1.0-alpha-16/plexus-component-api-1.0-alpha-16.pom (2.2 kB at 85 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-containers/1.0-alpha-16/plexus-containers-1.0-alpha-16.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-containers/1.0-alpha-16/plexus-containers-1.0-alpha-16.pom (1.9 kB at 61 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/1.4.9/plexus-utils-1.4.9.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/1.4.9/plexus-utils-1.4.9.pom (2.3 kB at 96 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/2.0.1/plexus-utils-2.0.1.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/2.0.1/plexus-utils-2.0.1.pom (3.3 kB at 134 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-repository-builder/1.0-alpha-2/maven-repository-builder-1.0-alpha-2.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-repository-builder/1.0-alpha-2/maven-repository-builder-1.0-alpha-2.pom (3.2 kB at 120 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.0-alpha-1/maven-common-artifact-filters-1.0-alpha-1.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.0-alpha-1/maven-common-artifact-filters-1.0-alpha-1.pom (1.8 kB at 86 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/6/maven-shared-components-6.pom
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/6/maven-shared-components-6.pom (3.1 kB at 115 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.1/maven-common-artifact-filters-1.1.jar
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-plugin-testing-harness/1.1/maven-plugin-testing-harness-1.1.jar
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-interpolation/1.7/plexus-interpolation-1.7.jar
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/1.0-alpha-12/plexus-archiver-1.0-alpha-12.jar
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.1/file-management-1.1.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.1/maven-common-artifact-filters-1.1.jar (30 kB at 790 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0.2/maven-artifact-manager-2.0.2.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-plugin-testing-harness/1.1/maven-plugin-testing-harness-1.1.jar (32 kB at 833 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0.2/maven-repository-metadata-2.0.2.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-interpolation/1.7/plexus-interpolation-1.7.jar (51 kB at 1.3 MB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-filtering/1.0-beta-2/maven-filtering-1.0-beta-2.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.1/file-management-1.1.jar (31 kB at 663 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-active-collections/1.0-beta-2/plexus-active-collections-1.0-beta-2.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/1.0-alpha-12/plexus-archiver-1.0-alpha-12.jar (177 kB at 2.9 MB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/1.0-alpha-4/plexus-io-1.0-alpha-4.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0.2/maven-repository-metadata-2.0.2.jar (20 kB at 352 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-api/2.0.4/maven-plugin-api-2.0.4.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0.2/maven-artifact-manager-2.0.2.jar (49 kB at 833 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.0.4/maven-project-2.0.4.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-filtering/1.0-beta-2/maven-filtering-1.0-beta-2.jar (33 kB at 527 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.0.4/maven-profile-2.0.4.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-active-collections/1.0-beta-2/plexus-active-collections-1.0-beta-2.jar (21 kB at 260 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-archiver/2.4/maven-archiver-2.4.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/1.0-alpha-4/plexus-io-1.0-alpha-4.jar (48 kB at 576 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/2.0.1/plexus-utils-2.0.1.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-api/2.0.4/maven-plugin-api-2.0.4.jar (8.3 kB at 95 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0.4/maven-artifact-2.0.4.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.0.4/maven-project-2.0.4.jar (109 kB at 1.1 MB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.0.4/maven-model-2.0.4.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.0.4/maven-profile-2.0.4.jar (30 kB at 285 kB/s)
[INFO] Downloading from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-repository-builder/1.0-alpha-2/maven-repository-builder-1.0-alpha-2.jar
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-archiver/2.4/maven-archiver-2.4.jar (20 kB at 180 kB/s)
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/2.0.1/plexus-utils-2.0.1.jar (222 kB at 1.6 MB/s)
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0.4/maven-artifact-2.0.4.jar (80 kB at 565 kB/s)
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-repository-builder/1.0-alpha-2/maven-repository-builder-1.0-alpha-2.jar (23 kB at 161 kB/s)
[INFO] Downloaded from central: https://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.0.4/maven-model-2.0.4.jar (80 kB at 528 kB/s)
[INFO] Reading assembly descriptor: src/assembly/bin.xml
[INFO] Building tar : /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT-bin.tar.gz
[INFO] Building zip: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT-bin.zip
[INFO] 
[INFO] --- maven-source-plugin:3.2.1:jar-no-fork (attach-sources) @ co.codewizards.cloudstore.client ---
[INFO] Building jar: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT-sources.jar
[INFO] 
[INFO] --- maven-install-plugin:2.4:install (default-install) @ co.codewizards.cloudstore.client ---
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT.jar
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/pom.xml to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT.pom
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT-bin.tar.gz to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT-bin.tar.gz
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT-bin.zip to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT-bin.zip
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT-sources.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-SNAPSHOT-sources.jar
[INFO] 
[INFO] --- maven-deploy-plugin:2.7:deploy (default-deploy) @ co.codewizards.cloudstore.client ---
[INFO] Downloading from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml
[INFO] Downloaded from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml (1.4 kB at 144 kB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4.jar
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4.jar (45 kB at 15 MB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4.pom
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4.pom (3.8 kB at 1.9 MB/s)
[INFO] Downloading from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml
[INFO] Downloaded from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml (358 B at 19 kB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml (1.4 kB at 481 kB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml (358 B at 358 kB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4-bin.tar.gz
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4-bin.tar.gz (24 MB at 57 MB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml (1.4 kB at 722 kB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4-bin.zip
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4-bin.zip (24 MB at 51 MB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml (1.4 kB at 722 kB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4-sources.jar
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/co.codewizards.cloudstore.client-1.0.1-20200501.140935-4-sources.jar (29 kB at 14 MB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/1.0.1-SNAPSHOT/maven-metadata.xml (1.4 kB at 722 kB/s)
[INFO] 
[INFO] --- maven-site-plugin:3.3:site (default-site) @ co.codewizards.cloudstore.client ---
[INFO] Relativizing decoration links with respect to project URL: http://cloudstore.codewizards.co/co.codewizards.cloudstore.client
[INFO] Rendering site with org.apache.maven.skins:maven-default-skin:jar:1.0 skin.
[INFO] Relativizing decoration links with respect to project URL: http://cloudstore.codewizards.co/co.codewizards.cloudstore.client/de
[INFO] Rendering site with org.apache.maven.skins:maven-default-skin:jar:1.0 skin.
[JENKINS] Archiving site from /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/site to /home/tomcat/.jenkins/jobs/co.codewizards.cloudstore_java_11/site/co.codewizards.cloudstore.client
[INFO] 
[INFO] >>> maven-javadoc-plugin:3.1.1:javadoc (javadoc-generate-unfiltered) > generate-sources @ co.codewizards.cloudstore.client >>>
[WARNING] Failed to getClass for org.apache.maven.plugins.javadoc.JavadocReport
[JENKINS] Archiving  javadoc
[INFO] 
[INFO] <<< maven-javadoc-plugin:3.1.1:javadoc (javadoc-generate-unfiltered) < generate-sources @ co.codewizards.cloudstore.client <<<
[INFO] 
[INFO] 
[INFO] --- maven-javadoc-plugin:3.1.1:javadoc (javadoc-generate-unfiltered) @ co.codewizards.cloudstore.client ---
[INFO] Skipping javadoc generation
[JENKINS] Archiving  javadoc
[INFO] 
[INFO] --- maven-resources-plugin:2.6:copy-resources (javadoc-filter) @ co.codewizards.cloudstore.client ---
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/javadoc.unfiltered
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/javadoc.unfiltered
[INFO] 
[INFO] --- maven-resources-plugin:2.6:copy-resources (javadoc-copy-to-site) @ co.codewizards.cloudstore.client ---
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/apidocs
[INFO] 
[INFO] --- maven-site-plugin:3.3:deploy (default-deploy) @ co.codewizards.cloudstore.client ---
file:/tmp/cloudstore-junk/ - Session: Opened  
[INFO] Pushing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.client/target/site
[INFO]    >>> to file:/tmp/cloudstore-junk/co.codewizards.cloudstore.client
[INFO]    >>> to file:/tmp/cloudstore-junk/de/co.codewizards.cloudstore.client
file:/tmp/cloudstore-junk/ - Session: Disconnecting  
file:/tmp/cloudstore-junk/ - Session: Disconnected