Console Output

true, closeOnRelease=true, closeOnTxnEnd=true]" closed
10:37:45.556 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /META-INF/package.jdo
10:37:45.558 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /WEB-INF/package.jdo
10:37:45.560 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /package.jdo
10:37:45.562 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/package.jdo
10:37:45.563 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co.jdo
10:37:45.565 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/package.jdo
10:37:45.567 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards.jdo
10:37:45.568 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/package.jdo
10:37:45.568 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore.jdo
10:37:45.569 [qtp945683299-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
10:37:45.570 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local.jdo
10:37:45.570 [qtp945683299-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
10:37:45.571 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/persistence.jdo
10:37:45.572 [qtp945683299-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
10:37:45.572 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" not found
10:37:45.572 [qtp945683299-38] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.Symlink" has been specified with JDO annotations so using those.
10:37:45.572 [qtp945683299-38] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.Symlink" : Populating Meta-Data
10:37:45.573 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /META-INF/package.orm
10:37:45.574 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /WEB-INF/package.orm
10:37:45.574 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /package.orm
10:37:45.575 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/package.orm
10:37:45.575 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co.orm
10:37:45.576 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/package.orm
10:37:45.576 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards.orm
10:37:45.577 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/package.orm
10:37:45.578 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore.orm
10:37:45.578 [qtp945683299-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
10:37:45.579 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local.orm
10:37:45.580 [qtp945683299-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
10:37:45.580 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/persistence.orm
10:37:45.581 [qtp945683299-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
10:37:45.581 [qtp945683299-38] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" not found
10:37:45.581 [qtp945683299-38] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.Symlink" : Initialising Meta-Data
10:37:45.582 [qtp945683299-38] DEBUG DataNucleus.Persistence - Managing Persistence of Class : co.codewizards.cloudstore.local.persistence.Symlink [Table : "repofile", InheritanceStrategy : superclass-table]
10:37:45.582 [qtp945683299-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") 
10:37:45.582 [qtp945683299-38] DEBUG DataNucleus.Datastore.Schema - Column ""repofile"."target"" added to internal representation of table.
10:37:45.582 [qtp945683299-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
10:37:45.582 [qtp945683299-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.datastore.VarCharRDBMSMapping)
10:37:45.584 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@2e1ae1b [conn=null, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" opened with isolation level "serializable" and auto-commit=false
10:37:45.584 [qtp945683299-38] DEBUG DataNucleus.Datastore.Schema - Schema Transaction started with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@1d05b593" with isolation "serializable"
10:37:45.589 [qtp945683299-38] DEBUG DataNucleus.Datastore.Schema - Check of existence of "repofile" returned table type of TABLE
10:37:45.596 [qtp945683299-38] DEBUG DataNucleus.Datastore.Schema - Validating 6 index(es) for table "repofile"
10:37:45.608 [qtp945683299-38] DEBUG DataNucleus.Datastore.Schema - Validating 1 foreign key(s) for table "repofile"
10:37:45.611 [qtp945683299-38] DEBUG DataNucleus.Datastore.Schema - Validating 2 unique key(s) for table "repofile"
10:37:45.611 [qtp945683299-38] DEBUG DataNucleus.Datastore.Schema - Schema Transaction committing with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@1d05b593"
10:37:45.611 [qtp945683299-38] DEBUG DataNucleus.Datastore.Schema - Schema Transaction closing with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@1d05b593"
10:37:45.611 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@2e1ae1b [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@1d05b593, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" is being committed.
10:37:45.611 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@2e1ae1b [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@1d05b593, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" closed
10:37:45.612 [qtp945683299-38] DEBUG DataNucleus.Cache - Level 1 Cache cleared
10:37:45.612 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" closed
10:37:45.612 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@51deca43" with txn="org.datanucleus.TransactionImpl@5fceff22"
10:37:45.612 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
10:37:45.612 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473 (optimistic=false)
10:37:45.613 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository"
10:37:45.613 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 0 ms
10:37:45.613 [qtp945683299-38] DEBUG DataNucleus.Query - QueryCompilation:
  [symbols: this type=co.codewizards.cloudstore.local.persistence.LocalRepository]
10:37:45.613 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" for datastore
10:37:45.615 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 1 ms
10:37:45.615 [qtp945683299-38] DEBUG DataNucleus.Query - SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository Query compiled to datastore query "SELECT "a0"."changed","a0"."created","a0"."id","a0"."repositoryid","a0"."revision","a0"."discriminator" FROM "repository" "a0" WHERE "a0"."discriminator" = 'LocalRepository'"
10:37:45.616 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@406ec422 [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
10:37:45.616 [qtp945683299-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@2f7f931e, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
10:37:45.616 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@406ec422 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@16bb9198, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=" with flags "0"
10:37:45.616 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@406ec422 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@16bb9198, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.617 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" ...
10:37:45.624 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@149c6ec0"
10:37:45.624 [qtp945683299-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'
10:37:45.625 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.625 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 9 ms
10:37:45.626 [qtp945683299-38] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 1 cache [cache size = 0]
10:37:45.626 [qtp945683299-38] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 2 cache
10:37:45.626 [qtp945683299-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") added to Level 1 cache (loadedFlags="[NNYNNNNNN]")
10:37:45.627 [qtp945683299-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" (id="1") added to Level 2 cache (fields="[0, 1, 2, 4, 5]", version="")
10:37:45.627 [qtp945683299-38] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "HOLLOW"->"P_CLEAN"
10:37:45.627 [qtp945683299-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" (id="1") enlisted in transactional cache
10:37:45.628 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" having fields "publicKey" fetched from table ""repository""
10:37:45.628 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@406ec422 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@16bb9198, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.636 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@17a9ced1"
10:37:45.636 [qtp945683299-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."publickey" FROM "repository" "a0" WHERE "a0"."id" = <1>
10:37:45.637 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.638 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@4d48d3e3"
10:37:45.638 [qtp945683299-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" (id="1") is having the following fields in Level 2 cache object updated : [3]
10:37:45.640 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" having fields "privateKey" fetched from table ""repository""
10:37:45.640 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@406ec422 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@16bb9198, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.645 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@3135fbb5"
10:37:45.645 [qtp945683299-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."privatekey" FROM "repository" "a0" WHERE "a0"."id" = <1>
10:37:45.645 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
10:37:45.646 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@5a346c3e"
10:37:45.646 [qtp945683299-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" (id="1") is having the following fields in Level 2 cache object updated : [7]
10:37:45.646 [qtp945683299-38] INFO  c.c.c.local.LocalRepoManagerImpl - [44c9e0fb]initPersistenceManagerFactory: repositoryId=0d2ad2d4-c3e8-473c-a63e-3c3610d7f084
10:37:45.646 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473
10:37:45.646 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.646 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.646 [qtp945683299-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@2f7f931e]]
10:37:45.647 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@406ec422 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@16bb9198, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=" with onePhase="true"
10:37:45.647 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@406ec422 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@16bb9198, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
10:37:45.647 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@406ec422 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@16bb9198, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.647 [qtp945683299-38] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "P_CLEAN"->"HOLLOW"
10:37:45.647 [qtp945683299-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") was evicted from transactional cache
10:37:45.647 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
10:37:45.648 [qtp945683299-38] DEBUG DataNucleus.Persistence - Disconnecting co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3 from StateManager[pc=co.codewizards.cloudstore.local.persistence.LocalRepository@5e3376a3, lifecycle=HOLLOW]
10:37:45.648 [qtp945683299-38] DEBUG DataNucleus.Cache - Object with id="co.codewizards.cloudstore.local.persistence.LocalRepository:1" being removed from Level 1 cache [current cache size = 1]
10:37:45.648 [qtp945683299-38] DEBUG DataNucleus.Cache - Level 1 Cache cleared
10:37:45.648 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" closed
10:37:45.648 [qtp945683299-38] INFO  c.c.c.local.LocalRepoManagerImpl - [44c9e0fb]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 10061 ms.
10:37:45.648 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@51deca43" with txn="org.datanucleus.TransactionImpl@3203691c"
10:37:45.648 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
10:37:45.648 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473 (optimistic=false)
10:37:45.648 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Single-String with "SELECT WHERE this.changed < :changed"
10:37:45.649 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed"
10:37:45.650 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 1 ms
10:37:45.650 [qtp945683299-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]
10:37:45.650 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed" for datastore
10:37:45.651 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 1 ms
10:37:45.651 [qtp945683299-38] DEBUG DataNucleus.Query - SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed Query compiled to datastore query "SELECT 'co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest' AS NUCLEUS_TYPE,"a0"."changed","a0"."created","a0"."id","a0"."localpathprefix","a0"."repositoryid" FROM "remoterepositoryrequest" "a0" WHERE "a0"."changed" < ?"
10:37:45.652 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@6e6fb11d [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
10:37:45.652 [qtp945683299-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@478d7e45, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
10:37:45.652 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@6e6fb11d [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@289d8f3b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=" with flags "0"
10:37:45.652 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@6e6fb11d [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@289d8f3b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.652 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed" ...
10:37:45.660 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@14ebcd88"
10:37:45.660 [qtp945683299-38] DEBUG DataNucleus.Datastore.Native - SELECT 'co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest' AS NUCLEUS_TYPE,"a0"."changed","a0"."created","a0"."id","a0"."localpathprefix","a0"."repositoryid" FROM "remoterepositoryrequest" "a0" WHERE "a0"."changed" < <2019-10-05 10:37:45.648>
10:37:45.661 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.661 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 9 ms
10:37:45.662 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473
10:37:45.662 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.662 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.662 [qtp945683299-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@478d7e45]]
10:37:45.662 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@6e6fb11d [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@289d8f3b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=" with onePhase="true"
10:37:45.662 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@6e6fb11d [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@289d8f3b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
10:37:45.662 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@6e6fb11d [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@289d8f3b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.662 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committed in 0 ms
10:37:45.663 [qtp945683299-38] DEBUG DataNucleus.Cache - Level 1 Cache cleared
10:37:45.663 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" closed
10:37:45.663 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [65b25ff2]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
10:37:45.663 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [65b25ff2]tryAcquire: returning true. lockCounter=1
10:37:45.663 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [65b25ff2]tryAcquire: returning true. lockCounter=2
10:37:45.663 [qtp945683299-38] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
10:37:45.664 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [65b25ff2]release: NOT releasing underlying FileLock. lockCounter=1
10:37:45.664 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [65b25ff2]release: releasing underlying FileLock. lockCounter=0
10:37:45.664 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@51deca43" with txn="org.datanucleus.TransactionImpl@22aab07c"
10:37:45.664 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=
, enlisted resources=[]]
10:37:45.664 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473 (optimistic=false)
10:37:45.665 [qtp945683299-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
10:37:45.665 [qtp945683299-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
10:37:45.665 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@723912cf [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
10:37:45.666 [qtp945683299-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@704c373b, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=
, enlisted resources=[]]
10:37:45.666 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@723912cf [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@519630f8, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=
" with flags "0"
10:37:45.666 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@723912cf [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@519630f8, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.666 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" ...
10:37:45.666 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@5580dcc1"
10:37:45.666 [qtp945683299-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'
10:37:45.667 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.667 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 1 ms
10:37:45.667 [qtp945683299-38] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 1 cache [cache size = 0]
10:37:45.667 [qtp945683299-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") added to Level 1 cache (loadedFlags="[NNYNNNNNN]")
10:37:45.668 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "changed" replaced by a SCO wrapper
10:37:45.668 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "created" replaced by a SCO wrapper
10:37:45.668 [qtp945683299-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8" (id="1") enlisted in transactional cache
10:37:45.668 [qtp945683299-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@30560ae8"
10:37:45.669 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8" 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]
10:37:45.669 [qtp945683299-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8" (id="1") is having the following fields in Level 2 cache object updated : [6]
10:37:45.670 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8" field "aliases" loading contents to SCO wrapper from the datastore
10:37:45.670 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@723912cf [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@519630f8, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.680 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@7d58d632"
10:37:45.680 [qtp945683299-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."element" FROM "localrepository_aliases" "a0" WHERE "a0"."id_oid" = <1>
10:37:45.681 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.681 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@257ee63d"
10:37:45.681 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [47233dbb]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
10:37:45.681 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [47233dbb]tryAcquire: returning true. lockCounter=1
10:37:45.682 [qtp945683299-38] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
10:37:45.682 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [47233dbb]release: releasing underlying FileLock. lockCounter=0
10:37:45.682 [qtp945683299-38] DEBUG c.c.c.local.LocalRepoManagerImpl - syncWithLocalRepoRegistry: Alias 'k1eqfbuu-xypi5' of repository '0d2ad2d4-c3e8-473c-a63e-3c3610d7f084' already in-sync.
10:37:45.682 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [16531a30]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
10:37:45.682 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [16531a30]tryAcquire: returning true. lockCounter=1
10:37:45.683 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [16531a30]tryAcquire: returning true. lockCounter=2
10:37:45.683 [qtp945683299-38] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
10:37:45.683 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [16531a30]release: NOT releasing underlying FileLock. lockCounter=1
10:37:45.683 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [16531a30]release: releasing underlying FileLock. lockCounter=0
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.684 [qtp945683299-38] DEBUG c.c.c.l.AutoTrackLifecycleListener - onCommit: Deferred operations took 0 ms for 0 entities.
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=
, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@704c373b]]
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@723912cf [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@519630f8, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=
" with onePhase="true"
10:37:45.684 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@723912cf [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@519630f8, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
10:37:45.685 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@723912cf [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@519630f8, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.685 [qtp945683299-38] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "P_CLEAN"->"HOLLOW"
10:37:45.685 [qtp945683299-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") was evicted from transactional cache
10:37:45.685 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
10:37:45.685 [qtp945683299-38] DEBUG DataNucleus.Persistence - Disconnecting co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8 from StateManager[pc=co.codewizards.cloudstore.local.persistence.LocalRepository@30560ae8, lifecycle=HOLLOW]
10:37:45.686 [qtp945683299-38] DEBUG DataNucleus.Cache - Object with id="co.codewizards.cloudstore.local.persistence.LocalRepository:1" being removed from Level 1 cache [current cache size = 1]
10:37:45.686 [qtp945683299-38] DEBUG DataNucleus.Cache - Level 1 Cache cleared
10:37:45.686 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" closed
10:37:45.686 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@51deca43" with txn="org.datanucleus.TransactionImpl@6a8e1bac"
10:37:45.686 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
10:37:45.686 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473 (optimistic=false)
10:37:45.687 [qtp945683299-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
10:37:45.687 [qtp945683299-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
10:37:45.687 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@219a32f0 [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
10:37:45.687 [qtp945683299-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@559ee032, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
10:37:45.687 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@219a32f0 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@27c03d65, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=" with flags "0"
10:37:45.688 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@219a32f0 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@27c03d65, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.688 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" ...
10:37:45.688 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@7427da6c"
10:37:45.688 [qtp945683299-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'
10:37:45.688 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
10:37:45.689 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 1 ms
10:37:45.689 [qtp945683299-38] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 1 cache [cache size = 0]
10:37:45.689 [qtp945683299-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") added to Level 1 cache (loadedFlags="[NNYNNNNNN]")
10:37:45.689 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "changed" replaced by a SCO wrapper
10:37:45.690 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "created" replaced by a SCO wrapper
10:37:45.690 [qtp945683299-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153" (id="1") enlisted in transactional cache
10:37:45.690 [qtp945683299-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@6d097153"
10:37:45.690 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153" 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]
10:37:45.690 [qtp945683299-38] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153" (id="1") is having the following fields in Level 2 cache object updated : [6]
10:37:45.691 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@219a32f0 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@27c03d65, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.698 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@6bc3d197"
10:37:45.698 [qtp945683299-38] DEBUG DataNucleus.Datastore.Native - SELECT COUNT(*) FROM "localrepository_aliases" THIS WHERE THIS."id_oid"=<1>
10:37:45.699 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.700 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@6602232d"
10:37:45.700 [qtp945683299-38] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153" field "aliases" loading contents to SCO wrapper from the datastore
10:37:45.701 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@219a32f0 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@27c03d65, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.701 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@5262cbe1"
10:37:45.702 [qtp945683299-38] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."element" FROM "localrepository_aliases" "a0" WHERE "a0"."id_oid" = <1>
10:37:45.703 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.703 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@2bbe4a5b"
10:37:45.704 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.704 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.704 [qtp945683299-38] DEBUG c.c.c.l.AutoTrackLifecycleListener - onCommit: Deferred operations took 0 ms for 0 entities.
10:37:45.704 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.705 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.705 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473
10:37:45.705 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.706 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.706 [qtp945683299-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@559ee032]]
10:37:45.706 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@219a32f0 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@27c03d65, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=" with onePhase="true"
10:37:45.706 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@219a32f0 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@27c03d65, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
10:37:45.706 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@219a32f0 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@27c03d65, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.706 [qtp945683299-38] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "P_CLEAN"->"HOLLOW"
10:37:45.706 [qtp945683299-38] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") was evicted from transactional cache
10:37:45.707 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committed in 2 ms
10:37:45.707 [qtp945683299-38] DEBUG DataNucleus.Persistence - Disconnecting co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153 from StateManager[pc=co.codewizards.cloudstore.local.persistence.LocalRepository@6d097153, lifecycle=HOLLOW]
10:37:45.707 [qtp945683299-38] DEBUG DataNucleus.Cache - Object with id="co.codewizards.cloudstore.local.persistence.LocalRepository:1" being removed from Level 1 cache [current cache size = 1]
10:37:45.707 [qtp945683299-38] DEBUG DataNucleus.Cache - Level 1 Cache cleared
10:37:45.707 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" closed
10:37:45.707 [qtp945683299-38] DEBUG c.c.c.local.LocalRepoManagerImpl - [44c9e0fb]open: closing=false closeAbortable=true
10:37:45.708 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@51deca43" with txn="org.datanucleus.TransactionImpl@18abfae2"
10:37:45.708 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
10:37:45.708 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473 (optimistic=false)
10:37:45.708 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [6d78e621]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
10:37:45.708 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [6d78e621]tryAcquire: returning true. lockCounter=1
10:37:45.709 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [6d78e621]tryAcquire: returning true. lockCounter=2
10:37:45.709 [qtp945683299-38] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
10:37:45.709 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [6d78e621]release: NOT releasing underlying FileLock. lockCounter=1
10:37:45.710 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [6d78e621]release: releasing underlying FileLock. lockCounter=0
10:37:45.710 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository"
10:37:45.710 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 0 ms
10:37:45.710 [qtp945683299-38] DEBUG DataNucleus.Query - QueryCompilation:
  [symbols: this type=co.codewizards.cloudstore.local.persistence.RemoteRepository]
10:37:45.710 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository" for datastore
10:37:45.712 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 2 ms
10:37:45.712 [qtp945683299-38] DEBUG DataNucleus.Query - SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository Query compiled to datastore query "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'"
10:37:45.712 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
10:37:45.712 [qtp945683299-38] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@7269fd72, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
10:37:45.713 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=" with flags "0"
10:37:45.713 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.713 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository" ...
10:37:45.718 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@1b4eb4cf"
10:37:45.718 [qtp945683299-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'
10:37:45.719 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.720 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 6 ms
10:37:45.720 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest"
10:37:45.720 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 0 ms
10:37:45.720 [qtp945683299-38] DEBUG DataNucleus.Query - QueryCompilation:
  [symbols: this type=co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest]
10:37:45.720 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest" for datastore
10:37:45.722 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 2 ms
10:37:45.722 [qtp945683299-38] DEBUG DataNucleus.Query - SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest Query compiled to datastore query "SELECT 'co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest' AS NUCLEUS_TYPE,"a0"."changed","a0"."created","a0"."id","a0"."localpathprefix","a0"."repositoryid" FROM "remoterepositoryrequest" "a0""
10:37:45.722 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.722 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest" ...
10:37:45.727 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@774ba517"
10:37:45.727 [qtp945683299-38] DEBUG DataNucleus.Datastore.Native - SELECT 'co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest' AS NUCLEUS_TYPE,"a0"."changed","a0"."created","a0"."id","a0"."localpathprefix","a0"."repositoryid" FROM "remoterepositoryrequest" "a0"
10:37:45.727 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
10:37:45.728 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 6 ms
10:37:45.728 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile"
10:37:45.729 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 1 ms
10:37:45.729 [qtp945683299-38] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.NormalFile]
10:37:45.729 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile" for datastore
10:37:45.731 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 2 ms
10:37:45.731 [qtp945683299-38] DEBUG DataNucleus.Query - SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile Query compiled to datastore query "SELECT COUNT("a0"."id") FROM "repofile" "a0" WHERE "a0"."discriminator" = 'NormalFile'"
10:37:45.731 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.731 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile" ...
10:37:45.739 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@38b38ccb"
10:37:45.739 [qtp945683299-38] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "repofile" "a0" WHERE "a0"."discriminator" = 'NormalFile'
10:37:45.740 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.740 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 9 ms
10:37:45.741 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory"
10:37:45.741 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 0 ms
10:37:45.741 [qtp945683299-38] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.Directory]
10:37:45.741 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory" for datastore
10:37:45.742 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 1 ms
10:37:45.742 [qtp945683299-38] DEBUG DataNucleus.Query - SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory Query compiled to datastore query "SELECT COUNT("a0"."id") FROM "repofile" "a0" WHERE "a0"."discriminator" = 'Directory'"
10:37:45.743 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.743 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory" ...
10:37:45.750 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@1a59de72"
10:37:45.750 [qtp945683299-38] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "repofile" "a0" WHERE "a0"."discriminator" = 'Directory'
10:37:45.751 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.752 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 9 ms
10:37:45.752 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification"
10:37:45.753 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 1 ms
10:37:45.753 [qtp945683299-38] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.CopyModification]
10:37:45.753 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification" for datastore
10:37:45.755 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 1 ms
10:37:45.755 [qtp945683299-38] DEBUG DataNucleus.Query - SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification Query compiled to datastore query "SELECT COUNT("a0"."id") FROM "copymodification" "a0" INNER JOIN "modification" "a1" ON "a0"."id" = "a1"."id" WHERE "a1"."discriminator" = 'CopyModification'"
10:37:45.755 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.755 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification" ...
10:37:45.768 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@2e0c8069"
10:37:45.769 [qtp945683299-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'
10:37:45.770 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
10:37:45.770 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 15 ms
10:37:45.770 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification"
10:37:45.771 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 1 ms
10:37:45.771 [qtp945683299-38] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.DeleteModification]
10:37:45.771 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification" for datastore
10:37:45.773 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 1 ms
10:37:45.773 [qtp945683299-38] DEBUG DataNucleus.Query - SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification Query compiled to datastore query "SELECT COUNT("a0"."id") FROM "deletemodification" "a0" INNER JOIN "modification" "a1" ON "a0"."id" = "a1"."id" WHERE "a1"."discriminator" = 'DeleteModification'"
10:37:45.773 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.773 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification" ...
10:37:45.784 [qtp945683299-38] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@78b9c9b3"
10:37:45.785 [qtp945683299-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'
10:37:45.785 [qtp945683299-38] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
10:37:45.786 [qtp945683299-38] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 13 ms
10:37:45.786 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.786 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.786 [qtp945683299-38] DEBUG c.c.c.l.AutoTrackLifecycleListener - onCommit: Deferred operations took 0 ms for 0 entities.
10:37:45.786 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.786 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.787 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@619e7473
10:37:45.787 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
10:37:45.787 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
10:37:45.787 [qtp945683299-38] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@7269fd72]]
10:37:45.787 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=" with onePhase="true"
10:37:45.787 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
10:37:45.787 [qtp945683299-38] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@580a41bc [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@43f711e4, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@619e7473" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@694b16b1]"
10:37:45.788 [qtp945683299-38] DEBUG DataNucleus.Transaction - Transaction committed in 2 ms
10:37:45.788 [qtp945683299-38] DEBUG DataNucleus.Cache - Level 1 Cache cleared
10:37:45.788 [qtp945683299-38] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@619e7473" closed
10:37:45.788 [qtp945683299-38] INFO  c.c.c.local.LocalRepoManagerImpl - [44c9e0fb]getCloseDeferredMillis: closeDeferredMillis=0
10:37:45.788 [qtp945683299-38] INFO  c.c.c.local.LocalRepoManagerImpl - [44c9e0fb]close: Closing real LocalRepoManager immediately.
10:37:45.788 [qtp945683299-38] INFO  c.c.c.local.LocalRepoManagerImpl - [44c9e0fb]_close: Shutting down real LocalRepoManager.
10:37:46.007 [qtp945683299-38] DEBUG DataNucleus.Connection - Closing Connection Pool tx
10:37:46.010 [qtp945683299-38] DEBUG DataNucleus.Connection - Closing Connection Pool nontx
10:37:46.011 [qtp945683299-38] DEBUG DataNucleus.Persistence - Unmanaging Persistence of all classes
10:37:46.011 [qtp945683299-38] DEBUG DataNucleus.MetaData - Deregistering listener for metadata initialisation
10:37:46.012 [qtp945683299-38] DEBUG DataNucleus.Cache - Level 2 Cache cleared
10:37:48.877 [qtp945683299-38] DEBUG c.c.cloudstore.core.io.LockFileImpl - [2386a8e3]release: releasing underlying FileLock. lockCounter=0
10:37:48.881 [qtp945683299-38] DEBUG org.eclipse.jetty.server.HttpChannel - sendResponse info=null content=HeapByteBuffer@45e2be0d[p=0,l=765,c=8192,r=765]={<<<<?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@356f241e{null}
10:37:48.881 [qtp945683299-38] DEBUG org.eclipse.jetty.server.HttpChannel - COMMIT for /RepoInfo on HttpChannelOverHttp@489783f{r=1,c=true,c=false/false,a=DISPATCHED,uri=//127.0.0.1:38906/RepoInfo,age=13355}
200 OK HTTP/1.1
Content-Length: 765
Content-Type: application/xml


10:37:48.881 [qtp945683299-38] DEBUG o.e.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$SendCallback@1c682cf[PROCESSING][i=HTTP/1.1{s=200,h=2,cl=765},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@55cc54a6] generate: NEED_HEADER (null,[p=0,l=765,c=8192,r=765],true)@START
10:37:48.882 [qtp945683299-38] DEBUG org.eclipse.jetty.http.HttpGenerator - generateHeaders HTTP/1.1{s=200,h=2,cl=765} last=true content=HeapByteBuffer@45e2be0d[p=0,l=765,c=8192,r=765]={<<<<?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}
10:37:48.882 [qtp945683299-38] DEBUG org.eclipse.jetty.http.HttpGenerator - Content-Length: 765
Content-Type: application/xml


10:37:48.882 [qtp945683299-38] DEBUG org.eclipse.jetty.http.HttpGenerator - CONTENT_LENGTH
10:37:48.882 [qtp945683299-38] DEBUG o.e.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$SendCallback@1c682cf[PROCESSING][i=HTTP/1.1{s=200,h=2,cl=765},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@55cc54a6] generate: FLUSH ([p=0,l=104,c=8192,r=104],[p=0,l=765,c=8192,r=765],true)@COMPLETING
10:37:48.882 [qtp945683299-38] DEBUG org.eclipse.jetty.io.WriteFlusher - write: WriteFlusher@58e9ac4{IDLE}->null [HeapByteBuffer@1130f317[p=0,l=104,c=8192,r=104]={<<<HTTP/1.1 200 OK\r\n....v20190418)\r\n\r\n>>>BsZ2NPTnZNN01feGo...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@45e2be0d[p=0,l=765,c=8192,r=765]={<<<<?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}]
10:37:48.882 [qtp945683299-38] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@58e9ac4{WRITING}->null:IDLE-->WRITING
10:37:48.883 [qtp945683299-38] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 869 SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=-,flush=W,to=13360/30000}{io=0/0,kio=0,kro=1}->HttpConnection@45b47204[p=HttpParser{s=END,236 of 236},g=HttpGenerator@3bbcab03{s=COMPLETING}]=>HttpChannelOverHttp@489783f{r=1,c=true,c=false/false,a=DISPATCHED,uri=//127.0.0.1:38906/RepoInfo,age=13357}
10:37:48.883 [qtp945683299-38] DEBUG org.eclipse.jetty.io.WriteFlusher - Flushed=true written=869 remaining=0 WriteFlusher@58e9ac4{WRITING}->null
10:37:48.883 [qtp945683299-38] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@58e9ac4{IDLE}->null:WRITING-->IDLE
10:37:48.883 [qtp945683299-38] DEBUG o.e.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$SendCallback@1c682cf[PROCESSING][i=HTTP/1.1{s=200,h=2,cl=765},cb=org.eclipse.jetty.server.HttpChannel$SendCallback@55cc54a6] generate: DONE ([p=104,l=104,c=8192,r=0],[p=765,l=765,c=8192,r=0],true)@END
10:37:48.891 [qtp945683299-38] DEBUG org.eclipse.jetty.server.session - FinalSession=null, old_session_handler=null, this=org.eclipse.jetty.server.session.SessionHandler2021540695==dftMaxIdleSec=-1, calling complete=true
10:37:48.892 [qtp945683299-38] DEBUG org.eclipse.jetty.server.session - Complete called with session null
10:37:48.892 [qtp945683299-38] DEBUG org.eclipse.jetty.server.Server - handled=true async=false committed=true on HttpChannelOverHttp@489783f{r=1,c=true,c=false/true,a=DISPATCHED,uri=//127.0.0.1:38906/RepoInfo,age=13366}
10:37:48.892 [qtp945683299-38] DEBUG o.e.jetty.server.HttpChannelState - unhandle HttpChannelState@b6ec76{s=DISPATCHED a=NOT_ASYNC i=true r=READY w=false}
10:37:48.892 [qtp945683299-38] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@489783f{r=1,c=true,c=false/true,a=COMPLETING,uri=//127.0.0.1:38906/RepoInfo,age=13366} action COMPLETE
10:37:48.893 [qtp945683299-38] DEBUG o.e.jetty.server.HttpChannelState - onComplete HttpChannelState@b6ec76{s=COMPLETING a=NOT_ASYNC i=false r=READY w=false}
10:37:48.893 [qtp945683299-38] DEBUG org.eclipse.jetty.server.HttpChannel - COMPLETE for /RepoInfo written=765
10:37:48.894 [qtp945683299-38] DEBUG o.e.jetty.server.HttpChannelState - recycle HttpChannelState@b6ec76{s=COMPLETED a=NOT_ASYNC i=false r=READY w=false}
10:37:48.894 [qtp945683299-38] DEBUG org.eclipse.jetty.http.HttpParser - reset HttpParser{s=END,236 of 236}
10:37:48.894 [qtp945683299-38] DEBUG org.eclipse.jetty.http.HttpParser - END --> START
10:37:48.894 [qtp945683299-38] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} handle exit, result COMPLETE
10:37:48.895 [qtp945683299-38] DEBUG org.eclipse.jetty.io.ChannelEndPoint - filled 0 HeapByteBuffer@1130f317[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}
10:37:48.895 [qtp945683299-38] DEBUG org.eclipse.jetty.io.ChannelEndPoint - filled 0 HeapByteBuffer@1130f317[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}
10:37:48.896 [qtp945683299-38] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=-,flush=-,to=12/30000}{io=0/0,kio=0,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} filled 0 HeapByteBuffer@1130f317[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}
10:37:48.896 [qtp945683299-38] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=-,flush=-,to=13/30000}{io=0/0,kio=0,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} parse HeapByteBuffer@1130f317[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} {}
10:37:48.897 [qtp945683299-38] DEBUG org.eclipse.jetty.http.HttpParser - parseNext s=START HeapByteBuffer@1130f317[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}
10:37:48.898 [qtp945683299-38] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=-,flush=-,to=14/30000}{io=0/0,kio=0,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} parsed false HttpParser{s=START,0 of -1}
10:37:48.898 [qtp945683299-38] DEBUG o.e.jetty.server.HttpConnection - releaseRequestBuffer HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=-,flush=-,to=15/30000}{io=0/0,kio=0,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
10:37:48.899 [qtp945683299-38] DEBUG o.e.jetty.io.AbstractConnection - fillInterested HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=-,flush=-,to=16/30000}{io=0/0,kio=0,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
10:37:48.900 [qtp945683299-38] DEBUG org.eclipse.jetty.io.FillInterest - interested FillInterest@743b74cb{AC.ReadCB@45b47204{HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=FI,flush=-,to=0/30000}{io=0/0,kio=0,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}}}
10:37:48.900 [qtp945683299-38] DEBUG org.eclipse.jetty.io.ChannelEndPoint - changeInterests p=false 0->1 for SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=FI,flush=-,to=1/30000}{io=0/1,kio=0,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
10:37:48.901 [qtp945683299-38] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ChannelEndPoint$1@43d9f366 on ManagedSelector@9df564f{STARTED} id=1 keys=1 selected=0 updates=0
10:37:48.901 [qtp945683299-38] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@9df564f{STARTED} id=1 keys=1 selected=0 updates=1
10:37:48.901 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 woken with none selected
10:37:48.902 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 woken up from select, 0/0/1 selected
10:37:48.902 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 processing 0 keys, 1 updates
10:37:48.902 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
10:37:48.902 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ChannelEndPoint$1@43d9f366
10:37:48.903 [main] DEBUG c.c.c.l.r.c.LocalServerRestClient - execute: invocation took 13429 ms
Local repository:
10:37:48.902 [qtp945683299-38] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=FI,flush=-,to=2/30000}{io=0/1,kio=0,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} onFillable exit HttpChannelState@b6ec76{s=IDLE a=NOT_ASYNC i=true r=IDLE w=false} null
  repository.repositoryId = 0d2ad2d4-c3e8-473c-a63e-3c3610d7f084
  repository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/repo/k1eqfbuu-xypi5
  repository.aliases = co.codewizards.cloudstore.ls.core.dto.RepoInfoResponseDto@17216605
10:37:48.903 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ChannelEndPoint - Key interests updated 0 -> 1 on SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=FI,flush=-,to=3/30000}{io=1/1,kio=1,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
10:37:48.903 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
10:37:48.903 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 waiting with 1 keys
10:37:48.903 [qtp945683299-38] DEBUG o.e.j.util.thread.QueuedThreadPool - ran CEP:SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=FI,flush=-,to=4/30000}{io=1/1,kio=1,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}:runFillable:BLOCKING
  repository.publicKeySha1 = C3:AD:C0:FE:3D:17:DA:4E:1E:39:3D:D0:49:39:85:E1:BA:B7:A1:3A

Remote repositories connected: {NONE}

Remote repositories requesting connection: {NONE}

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

10:37:48.904 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping Server@364fd4ae{STARTED}[9.4.17.v20190418]
10:37:48.904 [main] DEBUG org.eclipse.jetty.server.Server - doStop Server@364fd4ae{STOPPING}[9.4.17.v20190418]
10:37:48.904 [main] DEBUG o.e.j.s.h.AbstractHandlerContainer - Graceful shutdown Server@364fd4ae{STOPPING}[9.4.17.v20190418] by 
10:37:48.905 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ServerConnector@d325518{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:37:48.905 [qtp945683299-35] DEBUG o.e.j.util.thread.QueuedThreadPool - ran qtp945683299-35-acceptor-0@622d7e4-ServerConnector@d325518{HTTP/1.1,[http/1.1]}{127.0.0.1:38906}
10:37:48.905 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping SelectorManager@ServerConnector@d325518{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:37:48.905 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ManagedSelector@241fbec{STARTED} id=2 keys=0 selected=0 updates=0
10:37:48.905 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseConnections@10a907ec on ManagedSelector@241fbec{STOPPING} id=2 keys=0 selected=0 updates=0
10:37:48.905 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@241fbec{STOPPING} id=2 keys=0 selected=0 updates=1
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7a3e24c3 woken with none selected
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7a3e24c3 woken up from select, 0/0/0 selected
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7a3e24c3 processing 0 keys, 1 updates
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$CloseConnections@10a907ec
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Closing 0 connections on ManagedSelector@241fbec{STOPPING} id=2 keys=0 selected=0 updates=0
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7a3e24c3 waiting with 0 keys
10:37:48.906 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$StopSelector@59b492ec on ManagedSelector@241fbec{STOPPING} id=2 keys=0 selected=0 updates=0
10:37:48.906 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@241fbec{STOPPING} id=2 keys=0 selected=0 updates=1
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7a3e24c3 woken with none selected
10:37:48.906 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7a3e24c3 woken up from select, 0/0/0 selected
10:37:48.907 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@7a3e24c3 processing 0 keys, 1 updates
10:37:48.907 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
10:37:48.907 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$StopSelector@59b492ec
10:37:48.907 [qtp945683299-34] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
10:37:48.907 [qtp945683299-34] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector$$Lambda$28/727860268@4a70d302
10:37:48.907 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping EatWhatYouKill@1a21f43f/SelectorProducer@7f0a133d/IDLE/p=false/QueuedThreadPool[qtp945683299]@385dfb63{STARTED,8<=8<=500,i=5,q=0}[ReservedThreadExecutor@1d4f5506{s=1/6,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-10-06T10:37:48.907+02:00
10:37:48.908 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED EatWhatYouKill@1a21f43f/SelectorProducer@7f0a133d/IDLE/p=false/QueuedThreadPool[qtp945683299]@385dfb63{STARTED,8<=8<=500,i=5,q=0}[ReservedThreadExecutor@1d4f5506{s=1/6,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-10-06T10:37:48.908+02:00
10:37:48.908 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ManagedSelector@241fbec{STOPPED} id=2 keys=-1 selected=-1 updates=0
10:37:48.908 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ManagedSelector@9df564f{STARTED} id=1 keys=1 selected=0 updates=0
10:37:48.908 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseConnections@55c1ced9 on ManagedSelector@9df564f{STOPPING} id=1 keys=1 selected=0 updates=0
10:37:48.908 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@9df564f{STOPPING} id=1 keys=1 selected=0 updates=1
10:37:48.908 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 woken with none selected
10:37:48.908 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 woken up from select, 0/0/1 selected
10:37:48.909 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 processing 0 keys, 1 updates
10:37:48.909 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
10:37:48.909 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$CloseConnections@55c1ced9
10:37:48.909 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Closing 1 connections on ManagedSelector@9df564f{STOPPING} id=1 keys=1 selected=0 updates=0
10:37:48.909 [qtp945683299-33] DEBUG o.eclipse.jetty.io.AbstractEndPoint - close SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=FI,flush=-,to=10/30000}{io=1/1,kio=1,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
10:37:48.910 [qtp945683299-33] DEBUG o.eclipse.jetty.io.AbstractEndPoint - close(null) SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,OPEN,fill=FI,flush=-,to=10/30000}{io=1/1,kio=1,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
10:37:48.910 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ChannelEndPoint - doClose SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,CLOSED,fill=FI,flush=-,to=11/30000}{io=1/1,kio=1,kro=1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
10:37:48.911 [qtp945683299-33] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@58e9ac4{IDLE}->null
java.nio.channels.ClosedChannelException: null
	at org.eclipse.jetty.io.WriteFlusher.onClose(WriteFlusher.java:492) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.AbstractEndPoint.onClose(AbstractEndPoint.java:353) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.ChannelEndPoint.onClose(ChannelEndPoint.java:215) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.AbstractEndPoint.doOnClose(AbstractEndPoint.java:225) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.AbstractEndPoint.close(AbstractEndPoint.java:192) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.AbstractEndPoint.close(AbstractEndPoint.java:175) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.AbstractConnection.close(AbstractConnection.java:248) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.ManagedSelector.closeNoExceptions(ManagedSelector.java:252) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.ManagedSelector.access$1400(ManagedSelector.java:61) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.ManagedSelector$CloseConnections.update(ManagedSelector.java:866) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.processUpdates(ManagedSelector.java:426) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:397) [jetty-io-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:357) [jetty-util-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:181) [jetty-util-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168) [jetty-util-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:132) [jetty-util-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:786) ~[jetty-util-9.4.17.v20190418.jar:9.4.17.v20190418]
	at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:743) ~[jetty-util-9.4.17.v20190418.jar:9.4.17.v20190418]
	at java.lang.Thread.run(Thread.java:748) ~[na:1.8.0_222]
10:37:48.912 [qtp945683299-33] DEBUG org.eclipse.jetty.io.FillInterest - onClose FillInterest@743b74cb{AC.ReadCB@45b47204{HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,CLOSED,fill=FI,flush=-,to=12/30000}{io=1/1,kio=-1,kro=-1}->HttpConnection@45b47204[p=HttpParser{s=START,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}}}
10:37:48.912 [qtp945683299-33] DEBUG org.eclipse.jetty.http.HttpParser - close HttpParser{s=START,0 of -1}
10:37:48.912 [qtp945683299-33] DEBUG org.eclipse.jetty.http.HttpParser - START --> CLOSE
10:37:48.912 [qtp945683299-33] DEBUG o.e.jetty.io.AbstractConnection - HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,CLOSED,fill=-,flush=-,to=13/30000}{io=1/1,kio=-1,kro=-1}->HttpConnection@45b47204[p=HttpParser{s=CLOSE,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0} onFillInterestedFailed java.nio.channels.ClosedChannelException
10:37:48.912 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup ManagedSelector@9df564f{STOPPING} id=1 keys=1 selected=0 updates=0
10:37:48.912 [qtp945683299-33] DEBUG o.e.j.util.thread.QueuedThreadPool - queue org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@27cde4ff
10:37:48.913 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
10:37:48.913 [qtp945683299-39] DEBUG o.e.j.util.thread.QueuedThreadPool - run org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@27cde4ff
10:37:48.913 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$StopSelector@49cc9b2a on ManagedSelector@9df564f{STOPPING} id=1 keys=1 selected=0 updates=0
10:37:48.913 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@9df564f{STOPPING} id=1 keys=1 selected=0 updates=1
10:37:48.913 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 waiting with 1 keys
10:37:48.914 [qtp945683299-39] DEBUG org.eclipse.jetty.io.ManagedSelector - Destroyed SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,CLOSED,fill=-,flush=-,to=14/30000}{io=1/1,kio=-1,kro=-1}->HttpConnection@45b47204[p=HttpParser{s=CLOSE,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
10:37:48.914 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 woken with none selected
10:37:48.914 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 woken up from select, 0/0/0 selected
10:37:48.914 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@68370db2 processing 0 keys, 1 updates
10:37:48.914 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
10:37:48.914 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$StopSelector@49cc9b2a
10:37:48.914 [qtp945683299-39] DEBUG o.e.jetty.io.AbstractConnection - onClose HttpConnection@45b47204::SocketChannelEndPoint@a4e8706{/127.0.0.1:60452<->/127.0.0.1:38906,CLOSED,fill=-,flush=-,to=15/30000}{io=1/1,kio=-1,kro=-1}->HttpConnection@45b47204[p=HttpParser{s=CLOSE,0 of -1},g=HttpGenerator@3bbcab03{s=START}]=>HttpChannelOverHttp@489783f{r=1,c=false,c=false/false,a=IDLE,uri=null,age=0}
10:37:48.914 [qtp945683299-39] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@27cde4ff
10:37:48.914 [qtp945683299-33] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
10:37:48.914 [qtp945683299-33] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector$$Lambda$28/727860268@4b765e92
10:37:48.915 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping EatWhatYouKill@2f995afc/SelectorProducer@377949f1/IDLE/p=false/QueuedThreadPool[qtp945683299]@385dfb63{STARTED,8<=8<=500,i=6,q=0}[ReservedThreadExecutor@1d4f5506{s=1/6,p=0}][pc=0,pic=0,pec=1,epc=0]@2019-10-06T10:37:48.914+02:00
10:37:48.915 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED EatWhatYouKill@2f995afc/SelectorProducer@377949f1/IDLE/p=false/QueuedThreadPool[qtp945683299]@385dfb63{STARTED,8<=8<=500,i=6,q=0}[ReservedThreadExecutor@1d4f5506{s=1/6,p=0}][pc=0,pic=0,pec=1,epc=0]@2019-10-06T10:37:48.915+02:00
10:37:48.915 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ManagedSelector@9df564f{STOPPED} id=1 keys=-1 selected=-1 updates=0
10:37:48.915 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ManagedSelector@7c5df615{STARTED} id=0 keys=0 selected=0 updates=0
10:37:48.915 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseConnections@11826398 on ManagedSelector@7c5df615{STOPPING} id=0 keys=0 selected=0 updates=0
10:37:48.916 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@7c5df615{STOPPING} id=0 keys=0 selected=0 updates=1
10:37:48.916 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@42a3fbb9 woken with none selected
10:37:48.916 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@42a3fbb9 woken up from select, 0/0/0 selected
10:37:48.916 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@42a3fbb9 processing 0 keys, 1 updates
10:37:48.916 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
10:37:48.916 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$CloseConnections@11826398
10:37:48.916 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Closing 0 connections on ManagedSelector@7c5df615{STOPPING} id=0 keys=0 selected=0 updates=0
10:37:48.916 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
10:37:48.916 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@42a3fbb9 waiting with 0 keys
10:37:48.916 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$StopSelector@6c5ca0b6 on ManagedSelector@7c5df615{STOPPING} id=0 keys=0 selected=0 updates=0
10:37:48.916 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Wakeup on submit ManagedSelector@7c5df615{STOPPING} id=0 keys=0 selected=0 updates=1
10:37:48.917 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@42a3fbb9 woken with none selected
10:37:48.917 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@42a3fbb9 woken up from select, 0/0/0 selected
10:37:48.917 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector sun.nio.ch.EPollSelectorImpl@42a3fbb9 processing 0 keys, 1 updates
10:37:48.917 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - updateable 1
10:37:48.917 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - update org.eclipse.jetty.io.ManagedSelector$StopSelector@6c5ca0b6
10:37:48.917 [qtp945683299-32] DEBUG org.eclipse.jetty.io.ManagedSelector - updates 0
10:37:48.918 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping EatWhatYouKill@5f08fe00/SelectorProducer@a1691c0/PRODUCING/p=false/QueuedThreadPool[qtp945683299]@385dfb63{STARTED,8<=8<=500,i=6,q=0}[ReservedThreadExecutor@1d4f5506{s=1/6,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-10-06T10:37:48.917+02:00
10:37:48.918 [qtp945683299-32] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector$$Lambda$28/727860268@715fa8c5
10:37:48.918 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED EatWhatYouKill@5f08fe00/SelectorProducer@a1691c0/IDLE/p=false/QueuedThreadPool[qtp945683299]@385dfb63{STARTED,8<=8<=500,i=7,q=0}[ReservedThreadExecutor@1d4f5506{s=1/6,p=0}][pc=0,pic=0,pec=0,epc=0]@2019-10-06T10:37:48.918+02:00
10:37:48.918 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ManagedSelector@7c5df615{STOPPED} id=0 keys=-1 selected=-1 updates=0
10:37:48.918 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED SelectorManager@ServerConnector@d325518{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:37:48.918 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping HttpConnectionFactory@12417468[HTTP/1.1]
10:37:48.919 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED HttpConnectionFactory@12417468[HTTP/1.1]
10:37:48.919 [main] INFO  o.e.jetty.server.AbstractConnector - Stopped ServerConnector@d325518{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:37:48.919 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ServerConnector@d325518{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:37:48.919 [main] DEBUG o.e.j.server.handler.AbstractHandler - stopping Server@364fd4ae{STOPPING}[9.4.17.v20190418]
10:37:48.919 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping DefaultSessionIdManager@2a8b33ba{STARTED}[worker=node0]
10:37:48.920 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping HouseKeeper@4e8b357d{STARTED}[interval=600000, ownscheduler=false]
10:37:48.920 [main] INFO  org.eclipse.jetty.server.session - node0 Stopped scavenging
10:37:48.920 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED HouseKeeper@4e8b357d{STOPPED}[interval=600000, ownscheduler=false]
10:37:48.920 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED DefaultSessionIdManager@2a8b33ba{STOPPED}[worker=node0]
10:37:48.920 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ErrorHandler@79b18230{STARTED}
10:37:48.920 [main] DEBUG o.e.j.server.handler.AbstractHandler - stopping ErrorHandler@79b18230{STOPPING}
10:37:48.920 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ErrorHandler@79b18230{STOPPED}
10:37:48.921 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping o.e.j.s.ServletContextHandler@67fb5025{/,null,SHUTDOWN}
10:37:48.921 [main] DEBUG o.e.j.s.h.AbstractHandlerContainer - Graceful shutdown o.e.j.s.ServletContextHandler@67fb5025{/,null,SHUTDOWN} by 
10:37:48.921 [main] DEBUG o.e.j.server.handler.AbstractHandler - stopping o.e.j.s.ServletContextHandler@67fb5025{/,null,UNAVAILABLE}
10:37:48.921 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.session.SessionHandler2021540695==dftMaxIdleSec=-1
10:37:48.922 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.session.DefaultSessionCache@2f79f192[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
10:37:48.922 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.session.NullSessionDataStore@5fdfe8cf[passivating=false,graceSec=3600]
10:37:48.922 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.session.NullSessionDataStore@5fdfe8cf[passivating=false,graceSec=3600]
10:37:48.922 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.session.DefaultSessionCache@2f79f192[evict=-1,removeUnloadable=false,saveOnCreate=false,saveOnInactiveEvict=false]
10:37:48.922 [main] DEBUG o.e.j.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.session.SessionHandler2021540695==dftMaxIdleSec=-1
10:37:48.922 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ServletHandler@392781e{STARTED}
10:37:48.922 [main] DEBUG o.e.j.server.handler.AbstractHandler - stopping ServletHandler@392781e{STOPPING}
10:37:48.923 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-ea7a4c3@bc1d1cea==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
10:37:48.923 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-ea7a4c3@bc1d1cea==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false,async=true
10:37:48.923 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.glassfish.jersey.servlet.ServletContainer-18a096b5@f5b655d4==org.glassfish.jersey.servlet.ServletContainer,jsp=null,order=-1,inst=true,async=true
10:37:48.923 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.glassfish.jersey.servlet.ServletContainer-18a096b5@f5b655d4==org.glassfish.jersey.servlet.ServletContainer,jsp=null,order=-1,inst=true,async=true
10:37:48.924 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ServletHandler@392781e{STOPPED}
10:37:48.924 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.session.SessionHandler2021540695==dftMaxIdleSec=-1
10:37:48.924 [main] INFO  o.e.j.server.handler.ContextHandler - Stopped o.e.j.s.ServletContextHandler@67fb5025{/,null,UNAVAILABLE}
10:37:48.924 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED o.e.j.s.ServletContextHandler@67fb5025{/,null,UNAVAILABLE}
10:37:48.924 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ScheduledExecutorScheduler@245253d8{STARTED}
10:37:48.925 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ScheduledExecutorScheduler@245253d8{STOPPED}
10:37:48.925 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping QueuedThreadPool[qtp945683299]@385dfb63{STARTED,8<=8<=500,i=7,q=0}[ReservedThreadExecutor@1d4f5506{s=1/6,p=0}]
10:37:48.925 [main] DEBUG o.e.j.util.thread.QueuedThreadPool - Stopping QueuedThreadPool[qtp945683299]@385dfb63{STOPPING,8<=8<=500,i=7,q=0}[ReservedThreadExecutor@1d4f5506{s=1/6,p=0}]
10:37:48.925 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ReservedThreadExecutor@1d4f5506{s=1/6,p=0}
10:37:48.926 [main] DEBUG o.e.j.u.t.ReservedThreadExecutor - ReservedThreadExecutor@1d4f5506{s=0/6,p=0}@62cf66c2 offer STOP!
10:37:48.926 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ReservedThreadExecutor@1d4f5506{s=0/6,p=0}
10:37:48.926 [qtp945683299-37] DEBUG o.e.j.u.t.ReservedThreadExecutor - ReservedThreadExecutor@1d4f5506{s=0/6,p=0}@62cf66c2 task=STOP!
10:37:48.926 [main] DEBUG o.e.j.util.thread.QueuedThreadPool - Waiting for Thread[qtp945683299-33,5,main] for 14999
10:37:48.926 [qtp945683299-36] DEBUG o.e.j.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.926 [qtp945683299-36] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.926 [qtp945683299-37] DEBUG o.e.j.u.t.ReservedThreadExecutor - ReservedThreadExecutor@1d4f5506{s=0/6,p=0}@62cf66c2 Exited
10:37:48.926 [qtp945683299-38] DEBUG o.e.j.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.927 [qtp945683299-37] DEBUG o.e.j.util.thread.QueuedThreadPool - ran ReservedThreadExecutor@1d4f5506{s=0/6,p=0}@62cf66c2
10:37:48.927 [qtp945683299-38] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.927 [qtp945683299-35] DEBUG o.e.j.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.927 [qtp945683299-35] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.927 [qtp945683299-34] DEBUG o.e.j.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.927 [qtp945683299-34] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.928 [qtp945683299-39] DEBUG o.e.j.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.928 [qtp945683299-39] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.928 [qtp945683299-33] DEBUG o.e.j.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.928 [qtp945683299-33] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.928 [qtp945683299-32] DEBUG o.e.j.util.thread.QueuedThreadPool - run org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.928 [qtp945683299-32] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.util.thread.QueuedThreadPool$$Lambda$51/1381702512@53159035
10:37:48.928 [main] DEBUG o.e.j.util.thread.QueuedThreadPool - Waiting for Thread[qtp945683299-38,5,] for 14998
10:37:48.928 [main] DEBUG o.e.j.util.thread.QueuedThreadPool - Waiting for Thread[qtp945683299-32,5,] for 14997
10:37:48.930 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED QueuedThreadPool[qtp945683299]@385dfb63{STOPPED,8<=0<=500,i=0,q=0}[org.eclipse.jetty.util.thread.TryExecutor$$Lambda$1/2044903525@4218d6a3]
10:37:48.930 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED Server@364fd4ae{STOPPED}[9.4.17.v20190418]
10:37:48.930 [main] INFO  c.c.cloudstore.ls.server.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/.cloudstore/localServerRunning.deleteToStop
10:37:48.930 [main] DEBUG c.c.cloudstore.core.io.LockFileImpl - [623e0631]release: releasing underlying FileLock. lockCounter=0
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 93.467 sec - in co.codewizards.cloudstore.client.RepairDatabaseSubCommandTest

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/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7.jar
[INFO] 
[INFO] --- maven-dependency-plugin:2.8:copy-dependencies (copy-dependencies) @ co.codewizards.cloudstore.client ---
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/doxia/doxia-sink-api/1.0-alpha-10/doxia-sink-api-1.0-alpha-10.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/doxia/doxia-sink-api/1.0-alpha-10/doxia-sink-api-1.0-alpha-10.pom (2 KB at 82.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/doxia/doxia/1.0-alpha-10/doxia-1.0-alpha-10.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/doxia/doxia/1.0-alpha-10/doxia-1.0-alpha-10.pom (9 KB at 26.9 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting-impl/2.0.5/maven-reporting-impl-2.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting-impl/2.0.5/maven-reporting-impl-2.0.5.pom (5 KB at 147.3 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-doxia-tools/1.0.2/maven-doxia-tools-1.0.2.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-doxia-tools/1.0.2/maven-doxia-tools-1.0.2.pom (6 KB at 301.4 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/2.3/plexus-archiver-2.3.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/2.3/plexus-archiver-2.3.pom (4 KB at 182.8 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-components/1.3/plexus-components-1.3.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-components/1.3/plexus-components-1.3.pom (3 KB at 165.9 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/2.0.6/plexus-io-2.0.6.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/2.0.6/plexus-io-2.0.6.pom (3 KB at 143.9 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-components/1.2/plexus-components-1.2.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-components/1.2/plexus-components-1.2.pom (3 KB at 199.1 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/3.0.9/plexus-utils-3.0.9.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/3.0.9/plexus-utils-3.0.9.pom (4 KB at 204.6 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.2.1/file-management-1.2.1.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.2.1/file-management-1.2.1.pom (4 KB at 210.6 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/10/maven-shared-components-10.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/10/maven-shared-components-10.pom (9 KB at 514.7 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-parent/9/maven-parent-9.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-parent/9/maven-parent-9.pom (33 KB at 1457.6 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-io/1.1/maven-shared-io-1.1.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-io/1.1/maven-shared-io-1.1.pom (4 KB at 247.8 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/8/maven-shared-components-8.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/8/maven-shared-components-8.pom (3 KB at 163.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-parent/7/maven-parent-7.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-parent/7/maven-parent-7.pom (21 KB at 1220.4 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0.2/maven-artifact-2.0.2.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0.2/maven-artifact-2.0.2.pom (765 B at 41.5 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven/2.0.2/maven-2.0.2.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven/2.0.2/maven-2.0.2.pom (13 KB at 756.7 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0.2/maven-artifact-manager-2.0.2.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0.2/maven-artifact-manager-2.0.2.pom (2 KB at 59.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0.2/maven-repository-metadata-2.0.2.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0.2/maven-repository-metadata-2.0.2.pom (2 KB at 53.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/wagon/wagon-provider-api/1.0-alpha-6/wagon-provider-api-1.0-alpha-6.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/wagon/wagon-provider-api/1.0-alpha-6/wagon-provider-api-1.0-alpha-6.pom (588 B at 35.9 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/wagon/wagon/1.0-alpha-6/wagon-1.0-alpha-6.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/wagon/wagon/1.0-alpha-6/wagon-1.0-alpha-6.pom (7 KB at 250.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-dependency-analyzer/1.4/maven-dependency-analyzer-1.4.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-dependency-analyzer/1.4/maven-dependency-analyzer-1.4.pom (6 KB at 228.8 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.0.5/maven-project-2.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.0.5/maven-project-2.0.5.pom (2 KB at 99.9 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven/2.0.5/maven-2.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven/2.0.5/maven-2.0.5.pom (6 KB at 309.5 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-settings/2.0.5/maven-settings-2.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-settings/2.0.5/maven-settings-2.0.5.pom (2 KB at 45.5 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.0.5/maven-model-2.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.0.5/maven-model-2.0.5.pom (3 KB at 68.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.0.5/maven-profile-2.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.0.5/maven-profile-2.0.5.pom (2 KB at 49.0 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0.5/maven-artifact-manager-2.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.0.5/maven-artifact-manager-2.0.5.pom (2 KB at 39.8 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0.5/maven-repository-metadata-2.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.0.5/maven-repository-metadata-2.0.5.pom (2 KB at 69.1 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0.5/maven-artifact-2.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.0.5/maven-artifact-2.0.5.pom (727 B at 30.9 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-dependency-tree/2.1/maven-dependency-tree-2.1.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-dependency-tree/2.1/maven-dependency-tree-2.1.pom (7 KB at 315.8 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.2.0/maven-project-2.2.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-project/2.2.0/maven-project-2.2.0.pom (3 KB at 142.5 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven/2.2.0/maven-2.2.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven/2.2.0/maven-2.2.0.pom (22 KB at 996.8 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-settings/2.2.0/maven-settings-2.2.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-settings/2.2.0/maven-settings-2.2.0.pom (3 KB at 106.4 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.2.0/maven-model-2.2.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-model/2.2.0/maven-model-2.2.0.pom (4 KB at 158.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.2.0/maven-profile-2.2.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-profile/2.2.0/maven-profile-2.2.0.pom (3 KB at 117.8 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.2.0/maven-artifact-manager-2.2.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact-manager/2.2.0/maven-artifact-manager-2.2.0.pom (4 KB at 121.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.2.0/maven-repository-metadata-2.2.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-repository-metadata/2.2.0/maven-repository-metadata-2.2.0.pom (2 KB at 87.0 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.2.0/maven-artifact-2.2.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-artifact/2.2.0/maven-artifact-2.2.0.pom (2 KB at 73.5 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-registry/2.2.0/maven-plugin-registry-2.2.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-plugin-registry/2.2.0/maven-plugin-registry-2.2.0.pom (2 KB at 110.8 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.4/maven-common-artifact-filters-1.4.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.4/maven-common-artifact-filters-1.4.pom (4 KB at 159.6 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/commons-lang/commons-lang/2.6/commons-lang-2.6.pom
Downloaded: http://repo.maven.apache.org/maven2/commons-lang/commons-lang/2.6/commons-lang-2.6.pom (18 KB at 533.9 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/commons/commons-parent/17/commons-parent-17.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/commons/commons-parent/17/commons-parent-17.pom (31 KB at 1127.9 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting-impl/2.0.5/maven-reporting-impl-2.0.5.jar
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-doxia-tools/1.0.2/maven-doxia-tools-1.0.2.jar
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.2.1/file-management-1.2.1.jar
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/2.3/plexus-archiver-2.3.jar
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/3.0.9/plexus-utils-3.0.9.jar
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting-impl/2.0.5/maven-reporting-impl-2.0.5.jar (21 KB at 805.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-io/1.1/maven-shared-io-1.1.jar
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.2.1/file-management-1.2.1.jar (37 KB at 1359.1 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/2.0.6/plexus-io-2.0.6.jar
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-doxia-tools/1.0.2/maven-doxia-tools-1.0.2.jar (41 KB at 1114.5 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-dependency-analyzer/1.4/maven-dependency-analyzer-1.4.jar
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/2.3/plexus-archiver-2.3.jar (183 KB at 3793.7 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-dependency-tree/2.1/maven-dependency-tree-2.1.jar
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-io/1.1/maven-shared-io-1.1.jar (39 KB at 1168.3 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.4/maven-common-artifact-filters-1.4.jar
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-io/2.0.6/plexus-io-2.0.6.jar (57 KB at 1706.6 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/commons-lang/commons-lang/2.6/commons-lang-2.6.jar
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-dependency-analyzer/1.4/maven-dependency-analyzer-1.4.jar (27 KB at 724.0 KB/sec)
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-common-artifact-filters/1.4/maven-common-artifact-filters-1.4.jar (31 KB at 1402.6 KB/sec)
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-dependency-tree/2.1/maven-dependency-tree-2.1.jar (59 KB at 1829.6 KB/sec)
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/3.0.9/plexus-utils-3.0.9.jar (227 KB at 2762.2 KB/sec)
Downloaded: http://repo.maven.apache.org/maven2/commons-lang/commons-lang/2.6/commons-lang-2.6.jar (278 KB at 5905.5 KB/sec)
[INFO] Copying jaxb-core-2.3.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jaxb-core-2.3.0.jar
[INFO] Copying jetty-util-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/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/co.codewizards.cloudstore.client/target/dependency/jetty-servlet-9.4.17.v20190418.jar
[INFO] Copying co.codewizards.cloudstore.ls.rest.client-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.rest.client-0.10.7.jar
[INFO] Copying jersey-container-servlet-core-2.5.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jersey-container-servlet-core-2.5.1.jar
[INFO] Copying transaction-api-1.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/transaction-api-1.1.jar
[INFO] Copying jetty-continuation-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-continuation-9.4.17.v20190418.jar
[INFO] Copying bcprov-jdk15on-161b03.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/bcprov-jdk15on-161b03.jar
[INFO] Copying co.codewizards.cloudstore.ls.server-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.server-0.10.7.jar
[INFO] Copying cglib-2.2.0-b21.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/cglib-2.2.0-b21.jar
[INFO] Copying jdo-api-3.1-rc1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jdo-api-3.1-rc1.jar
[INFO] Copying jaxb-api-2.3.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jaxb-api-2.3.0.jar
[INFO] Copying jetty-http-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-http-9.4.17.v20190418.jar
[INFO] Copying jersey-server-2.5.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jersey-server-2.5.1.jar
[INFO] Copying jetty-security-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-security-9.4.17.v20190418.jar
[INFO] Copying args4j-2.0.16.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/args4j-2.0.16.jar
[INFO] Copying jersey-container-servlet-2.5.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jersey-container-servlet-2.5.1.jar
[INFO] Copying hk2-api-2.2.0-b21.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/hk2-api-2.2.0-b21.jar
[INFO] Copying javax.inject-2.2.0-b21.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/javax.inject-2.2.0-b21.jar
[INFO] Copying datanucleus-api-jdo-4.0.5.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/datanucleus-api-jdo-4.0.5.jar
[INFO] Copying validation-api-1.1.0.Final.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/validation-api-1.1.0.Final.jar
[INFO] Copying co.codewizards.cloudstore.local-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.local-0.10.7.jar
[INFO] Copying co.codewizards.cloudstore.rest.shared-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.rest.shared-0.10.7.jar
[INFO] Copying log4j-over-slf4j-1.7.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/log4j-over-slf4j-1.7.7.jar
[INFO] Copying derby-10.13.1.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/derby-10.13.1.1.jar
[INFO] Copying asm-all-repackaged-2.2.0-b21.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/asm-all-repackaged-2.2.0-b21.jar
[INFO] Copying hk2-utils-2.2.0-b21.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/hk2-utils-2.2.0-b21.jar
[INFO] Copying co.codewizards.cloudstore.ls.rest.server-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.rest.server-0.10.7.jar
[INFO] Copying commons-compress-1.18.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/commons-compress-1.18.jar
[INFO] Copying hk2-locator-2.2.0-b21.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/hk2-locator-2.2.0-b21.jar
[INFO] Copying jetty-servlets-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/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/co.codewizards.cloudstore.client/target/dependency/jetty-server-9.4.17.v20190418.jar
[INFO] Copying javax.ws.rs-api-2.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/javax.ws.rs-api-2.0.jar
[INFO] Copying activation-1.1.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/activation-1.1.1.jar
[INFO] Copying co.codewizards.cloudstore.updater-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.updater-0.10.7.jar
[INFO] Copying guava-14.0.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/guava-14.0.1.jar
[INFO] Copying co.codewizards.cloudstore.ls.core-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.core-0.10.7.jar
[INFO] Copying javax.annotation-api-1.2.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/javax.annotation-api-1.2.jar
[INFO] Copying co.codewizards.cloudstore.ls.server.cproc-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.server.cproc-0.10.7.jar
[INFO] Copying jersey-common-2.5.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jersey-common-2.5.1.jar
[INFO] Copying co.codewizards.cloudstore.core.oio.nio-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.core.oio.nio-0.10.7.jar
[INFO] Copying datanucleus-rdbms-4.0.12.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/datanucleus-rdbms-4.0.12.jar
[INFO] Copying datanucleus-core-4.0.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/datanucleus-core-4.0.7.jar
[INFO] Copying osgi-resource-locator-1.0.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/osgi-resource-locator-1.0.1.jar
[INFO] Copying javax.servlet-api-3.1.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/javax.servlet-api-3.1.0.jar
[INFO] Copying co.codewizards.cloudstore.rest.client-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.rest.client-0.10.7.jar
[INFO] Copying jetty-xml-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-xml-9.4.17.v20190418.jar
[INFO] Copying logback-core-1.0.13.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/logback-core-1.0.13.jar
[INFO] Copying jaxb-impl-2.3.0.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jaxb-impl-2.3.0.jar
[INFO] Copying co.codewizards.cloudstore.core-0.10.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.core-0.10.7.jar
[INFO] Copying logback-classic-1.0.13.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/logback-classic-1.0.13.jar
[INFO] Copying jersey-client-2.5.1.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jersey-client-2.5.1.jar
[INFO] Copying jetty-io-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-io-9.4.17.v20190418.jar
[INFO] Copying slf4j-api-1.7.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/slf4j-api-1.7.7.jar
[INFO] Copying jetty-webapp-9.4.17.v20190418.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/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/co.codewizards.cloudstore.client/target/dependency/bcpg-jdk15on-161b03.jar
[INFO] 
[INFO] --- maven-assembly-plugin:2.4:single (make-assembly) @ co.codewizards.cloudstore.client ---
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/2.2/plexus-archiver-2.2.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/2.2/plexus-archiver-2.2.pom (4 KB at 174.3 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-components/1.1.20/plexus-components-1.1.20.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-components/1.1.20/plexus-components-1.1.20.pom (3 KB at 173.3 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/3.0.7/plexus-utils-3.0.7.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/3.0.7/plexus-utils-3.0.7.pom (3 KB at 153.3 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.1/file-management-1.1.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.1/file-management-1.1.pom (3 KB at 173.0 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/4/maven-shared-components-4.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/4/maven-shared-components-4.pom (3 KB at 83.0 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/maven-parent/4/maven-parent-4.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/maven-parent/4/maven-parent-4.pom (10 KB at 406.7 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-io/1.0/maven-shared-io-1.0.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-io/1.0/maven-shared-io-1.0.pom (3 KB at 155.7 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/1.2/plexus-utils-1.2.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-utils/1.2/plexus-utils-1.2.pom (767 B at 49.9 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus/1.0.5/plexus-1.0.5.pom
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus/1.0.5/plexus-1.0.5.pom (6 KB at 322.4 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-filtering/1.1/maven-filtering-1.1.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-filtering/1.1/maven-filtering-1.1.pom (6 KB at 257.0 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-repository-builder/1.0-alpha-2/maven-repository-builder-1.0-alpha-2.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-repository-builder/1.0-alpha-2/maven-repository-builder-1.0-alpha-2.pom (4 KB at 150.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/7/maven-shared-components-7.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/7/maven-shared-components-7.pom (3 KB at 149.3 KB/sec)
Downloading: http://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
Downloaded: http://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 (2 KB at 117.2 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/6/maven-shared-components-6.pom
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-shared-components/6/maven-shared-components-6.pom (4 KB at 178.4 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting-api/2.2.1/maven-reporting-api-2.2.1.jar
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/doxia/doxia-sink-api/1.1/doxia-sink-api-1.1.jar
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/doxia/doxia-logging-api/1.1/doxia-logging-api-1.1.jar
Downloading: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/2.2/plexus-archiver-2.2.jar
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.1/file-management-1.1.jar
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/doxia/doxia-logging-api/1.1/doxia-logging-api-1.1.jar (12 KB at 461.3 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-filtering/1.1/maven-filtering-1.1.jar
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/doxia/doxia-sink-api/1.1/doxia-sink-api-1.1.jar (13 KB at 521.4 KB/sec)
Downloading: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-repository-builder/1.0-alpha-2/maven-repository-builder-1.0-alpha-2.jar
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/file-management/1.1/file-management-1.1.jar (31 KB at 1127.4 KB/sec)
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/reporting/maven-reporting-api/2.2.1/maven-reporting-api-2.2.1.jar (10 KB at 265.5 KB/sec)
Downloaded: http://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 1027.8 KB/sec)
Downloaded: http://repo.maven.apache.org/maven2/org/apache/maven/shared/maven-filtering/1.1/maven-filtering-1.1.jar (43 KB at 1913.4 KB/sec)
Downloaded: http://repo.maven.apache.org/maven2/org/codehaus/plexus/plexus-archiver/2.2/plexus-archiver-2.2.jar (181 KB at 4105.5 KB/sec)
[INFO] Reading assembly descriptor: src/assembly/bin.xml
[INFO] Building tar: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7-bin.tar.gz
[INFO] Building zip: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7-bin.zip
[INFO] 
[INFO] --- maven-source-plugin:2.1.2:jar-no-fork (attach-sources) @ co.codewizards.cloudstore.client ---
[INFO] co already added, skipping
[INFO] co/codewizards already added, skipping
[INFO] co/codewizards/cloudstore already added, skipping
[INFO] co/codewizards/cloudstore/client already added, skipping
[INFO] co already added, skipping
[INFO] co/codewizards already added, skipping
[INFO] co/codewizards/cloudstore already added, skipping
[INFO] co/codewizards/cloudstore/client already added, skipping
[INFO] Building jar: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7-sources.jar
[INFO] co already added, skipping
[INFO] co/codewizards already added, skipping
[INFO] co/codewizards/cloudstore already added, skipping
[INFO] co/codewizards/cloudstore/client already added, skipping
[INFO] co already added, skipping
[INFO] co/codewizards already added, skipping
[INFO] co/codewizards/cloudstore already added, skipping
[INFO] co/codewizards/cloudstore/client already added, skipping
[INFO] 
[INFO] --- maven-install-plugin:2.3.1:install (default-install) @ co.codewizards.cloudstore.client ---
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7.jar
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/pom.xml to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7.pom
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7-bin.tar.gz to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7-bin.tar.gz
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7-bin.zip to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7-bin.zip
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7-sources.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7-sources.jar
[INFO] 
[INFO] --- maven-deploy-plugin:2.7:deploy (default-deploy) @ co.codewizards.cloudstore.client ---
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7.jar (44 KB at 21814.9 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7.pom
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7.pom (4 KB at 3693.4 KB/sec)
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml
Downloaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml (814 B at 3.3 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml (846 B at 413.1 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7-bin.tar.gz
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7-bin.tar.gz (21662 KB at 53884.9 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7-bin.zip
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7-bin.zip (23980 KB at 52817.9 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7-sources.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7/co.codewizards.cloudstore.client-0.10.7-sources.jar (26 KB at 25951.2 KB/sec)
[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/co.codewizards.cloudstore.client/target/site to /home/tomcat/.jenkins/jobs/co.codewizards.cloudstore/site/co.codewizards.cloudstore.client
[WARNING] Failed to getClass for org.apache.maven.plugin.javadoc.JavadocReport
[INFO] 
[INFO] --- maven-javadoc-plugin:2.9.1:javadoc (javadoc-generate-unfiltered) @ co.codewizards.cloudstore.client ---
[INFO] 
[INFO] --- maven-resources-plugin:2.5:copy-resources (javadoc-filter) @ co.codewizards.cloudstore.client ---
[debug] execute contextualize
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/javadoc.unfiltered
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/javadoc.unfiltered
[INFO] 
[INFO] --- maven-resources-plugin:2.5:copy-resources (javadoc-copy-to-site) @ co.codewizards.cloudstore.client ---
[debug] execute contextualize
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/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/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