Console Output

fileinprogressmarker", InheritanceStrategy : new-table]
22:50:17.361 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""fileinprogressmarker"."id"" added to internal representation of table.
22:50:17.362 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.Entity.id] -> Column(s) ["fileinprogressmarker"."id"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.LongMapping" (org.datanucleus.store.rdbms.mapping.datastore.BigIntRDBMSMapping)
22:50:17.362 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Table "fileinprogressmarker" will manage the persistence of the fields for class co.codewizards.cloudstore.local.persistence.FileInProgressMarker (inheritance strategy="new-table") 
22:50:17.362 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""fileinprogressmarker"."fromrepositoryid"" added to internal representation of table.
22:50:17.362 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.FileInProgressMarker.fromRepositoryId] -> Column(s) ["fileinprogressmarker"."fromrepositoryid"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.StringMapping" (org.datanucleus.store.rdbms.mapping.datastore.VarCharRDBMSMapping)
22:50:17.362 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""fileinprogressmarker"."path"" added to internal representation of table.
22:50:17.362 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.FileInProgressMarker.path] -> Column(s) ["fileinprogressmarker"."path"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.StringMapping" (org.datanucleus.store.rdbms.mapping.datastore.ClobRDBMSMapping)
22:50:17.363 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""fileinprogressmarker"."pathsha1"" added to internal representation of table.
22:50:17.363 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.FileInProgressMarker.pathSha1] -> Column(s) ["fileinprogressmarker"."pathsha1"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.StringMapping" (org.datanucleus.store.rdbms.mapping.datastore.VarCharRDBMSMapping)
22:50:17.363 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""fileinprogressmarker"."torepositoryid"" added to internal representation of table.
22:50:17.363 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.FileInProgressMarker.toRepositoryId] -> Column(s) ["fileinprogressmarker"."torepositoryid"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.StringMapping" (org.datanucleus.store.rdbms.mapping.datastore.VarCharRDBMSMapping)
22:50:17.363 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Table "fileinprogressmarker" will manage the persistence of the fields for class co.codewizards.cloudstore.local.persistence.Entity (inheritance strategy="subclass-table") 
22:50:17.363 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""fileinprogressmarker"."changed"" added to internal representation of table.
22:50:17.364 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.Entity.changed] -> Column(s) ["fileinprogressmarker"."changed"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.DateMapping" (org.datanucleus.store.rdbms.mapping.datastore.TimestampRDBMSMapping)
22:50:17.365 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""fileinprogressmarker"."created"" added to internal representation of table.
22:50:17.365 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.Entity.created] -> Column(s) ["fileinprogressmarker"."created"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.DateMapping" (org.datanucleus.store.rdbms.mapping.datastore.TimestampRDBMSMapping)
22:50:17.365 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Table/View "fileinprogressmarker" has been initialised
22:50:17.366 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@5757ae9d [conn=null, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" opened with isolation level "serializable" and auto-commit=false
22:50:17.366 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Schema Transaction started with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@68daf2e8" with isolation "serializable"
22:50:17.376 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Check of existence of "fileinprogressmarker" returned table type of TABLE
22:50:17.376 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Loading column info for table(s) "fileinprogressmarker, copymodification, lastsynctoremoterepo, remoterepositoryrequest, localrepository_aliases, repofile, deletemodification, repository, modification, filechunk" in Catalog "", Schema ""
22:50:17.400 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column info loaded for Catalog "", Schema "", 10 tables, time = 24 ms
22:50:17.400 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column info retrieved for table "fileinprogressmarker" : 7 columns found
22:50:17.407 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Validating 1 index(es) for table "fileinprogressmarker"
22:50:17.408 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Creating index "FileInProgressMark_fromRepositoryId_toRepositoryId" in catalog "" schema ""
22:50:17.408 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - CREATE INDEX "fileinprogressmark_fromrepositoryid_torepositoryid" ON "fileinprogressmarker" ("fromrepositoryid","torepositoryid")
22:50:17.441 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Execution Time = 33 ms
22:50:17.469 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Validating 0 foreign key(s) for table "fileinprogressmarker"
22:50:17.484 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Validating 1 unique key(s) for table "fileinprogressmarker"
22:50:17.484 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Creating candidate key "FileInProgressMark_fromRepositoryId_toRepositoryId_pathSha1" in catalog "" schema ""
22:50:17.484 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - CREATE UNIQUE INDEX "fileinprogressmark_fromrepositoryid_torepositoryid_pathsha1" ON "fileinprogressmarker" ("fromrepositoryid","torepositoryid","pathsha1")
22:50:17.509 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Execution Time = 25 ms
22:50:17.509 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Schema Transaction committing with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@68daf2e8"
22:50:17.516 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Schema Transaction closing with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@68daf2e8"
22:50:17.517 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@5757ae9d [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@68daf2e8, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" is being committed.
22:50:17.518 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@5757ae9d [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@68daf2e8, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" closed
22:50:17.521 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /META-INF/package.jdo
22:50:17.522 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /WEB-INF/package.jdo
22:50:17.524 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /package.jdo
22:50:17.525 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/package.jdo
22:50:17.527 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co.jdo
22:50:17.529 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/package.jdo
22:50:17.530 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards.jdo
22:50:17.532 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/package.jdo
22:50:17.532 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore.jdo
22:50:17.533 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/package.jdo
22:50:17.534 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local.jdo
22:50:17.535 [qtp1593333077-36] 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
22:50:17.535 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/persistence.jdo
22:50:17.536 [qtp1593333077-36] 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
22:50:17.536 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.Symlink" not found
22:50:17.537 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.Symlink" has been specified with JDO annotations so using those.
22:50:17.537 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.Symlink" : Populating Meta-Data
22:50:17.538 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /META-INF/package.orm
22:50:17.539 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /WEB-INF/package.orm
22:50:17.539 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /package.orm
22:50:17.540 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/package.orm
22:50:17.541 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co.orm
22:50:17.541 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/package.orm
22:50:17.542 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards.orm
22:50:17.543 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/package.orm
22:50:17.543 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore.orm
22:50:17.544 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/package.orm
22:50:17.545 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local.orm
22:50:17.545 [qtp1593333077-36] 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
22:50:17.546 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" NOT found at /co/codewizards/cloudstore/local/persistence.orm
22:50:17.547 [qtp1593333077-36] 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
22:50:17.547 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.Symlink" not found
22:50:17.547 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.Symlink" : Initialising Meta-Data
22:50:17.548 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Managing Persistence of Class : co.codewizards.cloudstore.local.persistence.Symlink [Table : "repofile", InheritanceStrategy : superclass-table]
22:50:17.548 [qtp1593333077-36] 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") 
22:50:17.548 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""repofile"."target"" added to internal representation of table.
22:50:17.549 [qtp1593333077-36] 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
22:50:17.549 [qtp1593333077-36] 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)
22:50:17.549 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@36f771a1 [conn=null, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" opened with isolation level "serializable" and auto-commit=false
22:50:17.549 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Schema Transaction started with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@15596798" with isolation "serializable"
22:50:17.554 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Check of existence of "repofile" returned table type of TABLE
22:50:17.563 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Validating 6 index(es) for table "repofile"
22:50:17.575 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Validating 1 foreign key(s) for table "repofile"
22:50:17.578 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Validating 2 unique key(s) for table "repofile"
22:50:17.578 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Schema Transaction committing with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@15596798"
22:50:17.578 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Schema Transaction closing with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@15596798"
22:50:17.578 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@36f771a1 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@15596798, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" is being committed.
22:50:17.578 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@36f771a1 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@15596798, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" closed
22:50:17.579 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /META-INF/package.jdo
22:50:17.580 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /WEB-INF/package.jdo
22:50:17.580 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /package.jdo
22:50:17.581 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/package.jdo
22:50:17.582 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co.jdo
22:50:17.582 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/package.jdo
22:50:17.583 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards.jdo
22:50:17.584 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/package.jdo
22:50:17.584 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore.jdo
22:50:17.585 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local/package.jdo
22:50:17.586 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local.jdo
22:50:17.586 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local/persistence/package.jdo
22:50:17.587 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local/persistence.jdo
22:50:17.588 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local/persistence/TransferDoneMarker.jdo
22:50:17.588 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" not found
22:50:17.589 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" has been specified with JDO annotations so using those.
22:50:17.589 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" : Populating Meta-Data
22:50:17.590 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /META-INF/package.orm
22:50:17.591 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /WEB-INF/package.orm
22:50:17.591 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /package.orm
22:50:17.592 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/package.orm
22:50:17.593 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co.orm
22:50:17.593 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/package.orm
22:50:17.594 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards.orm
22:50:17.594 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/package.orm
22:50:17.595 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore.orm
22:50:17.596 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local/package.orm
22:50:17.596 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local.orm
22:50:17.597 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local/persistence/package.orm
22:50:17.598 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local/persistence.orm
22:50:17.598 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" NOT found at /co/codewizards/cloudstore/local/persistence/TransferDoneMarker.orm
22:50:17.599 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "orm" for class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" not found
22:50:17.599 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" field "fromEntityId" : Adding Meta-Data for field since it didnt appear in the Meta-Data definition.
22:50:17.599 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" field "fromLocalRevision" : Adding Meta-Data for field since it didnt appear in the Meta-Data definition.
22:50:17.599 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Java type co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType using the support for java.lang.Enum
22:50:17.600 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /META-INF/package.jdo
22:50:17.601 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /WEB-INF/package.jdo
22:50:17.601 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /package.jdo
22:50:17.602 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/package.jdo
22:50:17.602 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co.jdo
22:50:17.603 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/package.jdo
22:50:17.604 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards.jdo
22:50:17.604 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/cloudstore/package.jdo
22:50:17.605 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/cloudstore.jdo
22:50:17.606 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/cloudstore/core/package.jdo
22:50:17.606 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/cloudstore/core.jdo
22:50:17.607 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/cloudstore/core/repo/package.jdo
22:50:17.608 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/cloudstore/core/repo.jdo
22:50:17.609 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/cloudstore/core/repo/transport/package.jdo
22:50:17.609 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/cloudstore/core/repo/transport.jdo
22:50:17.610 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" NOT found at /co/codewizards/cloudstore/core/repo/transport/TransferDoneMarkerType.jdo
22:50:17.610 [qtp1593333077-36] DEBUG DataNucleus.MetaData - MetaData of type "jdo" for class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" not found
22:50:17.610 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Registering class "co.codewizards.cloudstore.core.repo.transport.TransferDoneMarkerType" as not having MetaData.
22:50:17.610 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Class "co.codewizards.cloudstore.local.persistence.TransferDoneMarker" : Initialising Meta-Data
22:50:17.611 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Managing Persistence of Class : co.codewizards.cloudstore.local.persistence.TransferDoneMarker [Table : "transferdonemarker", InheritanceStrategy : new-table]
22:50:17.611 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""transferdonemarker"."id"" added to internal representation of table.
22:50:17.612 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.Entity.id] -> Column(s) ["transferdonemarker"."id"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.LongMapping" (org.datanucleus.store.rdbms.mapping.datastore.BigIntRDBMSMapping)
22:50:17.612 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Table "transferdonemarker" will manage the persistence of the fields for class co.codewizards.cloudstore.local.persistence.TransferDoneMarker (inheritance strategy="new-table") 
22:50:17.612 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""transferdonemarker"."fromentityid"" added to internal representation of table.
22:50:17.612 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.TransferDoneMarker.fromEntityId] -> Column(s) ["transferdonemarker"."fromentityid"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.LongMapping" (org.datanucleus.store.rdbms.mapping.datastore.BigIntRDBMSMapping)
22:50:17.612 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""transferdonemarker"."fromlocalrevision"" added to internal representation of table.
22:50:17.612 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.TransferDoneMarker.fromLocalRevision] -> Column(s) ["transferdonemarker"."fromlocalrevision"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.LongMapping" (org.datanucleus.store.rdbms.mapping.datastore.BigIntRDBMSMapping)
22:50:17.612 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""transferdonemarker"."fromrepositoryid"" added to internal representation of table.
22:50:17.613 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.TransferDoneMarker.fromRepositoryId] -> Column(s) ["transferdonemarker"."fromrepositoryid"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.StringMapping" (org.datanucleus.store.rdbms.mapping.datastore.VarCharRDBMSMapping)
22:50:17.613 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""transferdonemarker"."torepositoryid"" added to internal representation of table.
22:50:17.613 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.TransferDoneMarker.toRepositoryId] -> Column(s) ["transferdonemarker"."torepositoryid"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.StringMapping" (org.datanucleus.store.rdbms.mapping.datastore.VarCharRDBMSMapping)
22:50:17.613 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""transferdonemarker"."transferdonemarkertype"" added to internal representation of table.
22:50:17.613 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.TransferDoneMarker.transferDoneMarkerType] -> Column(s) ["transferdonemarker"."transferdonemarkertype"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.EnumMapping" (org.datanucleus.store.rdbms.mapping.datastore.IntegerRDBMSMapping)
22:50:17.613 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Table "transferdonemarker" will manage the persistence of the fields for class co.codewizards.cloudstore.local.persistence.Entity (inheritance strategy="subclass-table") 
22:50:17.614 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""transferdonemarker"."changed"" added to internal representation of table.
22:50:17.614 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.Entity.changed] -> Column(s) ["transferdonemarker"."changed"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.DateMapping" (org.datanucleus.store.rdbms.mapping.datastore.TimestampRDBMSMapping)
22:50:17.614 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column ""transferdonemarker"."created"" added to internal representation of table.
22:50:17.614 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Field [co.codewizards.cloudstore.local.persistence.Entity.created] -> Column(s) ["transferdonemarker"."created"] using mapping of type "org.datanucleus.store.rdbms.mapping.java.DateMapping" (org.datanucleus.store.rdbms.mapping.datastore.TimestampRDBMSMapping)
22:50:17.614 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Table/View "transferdonemarker" has been initialised
22:50:17.614 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@2a9def04 [conn=null, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" opened with isolation level "serializable" and auto-commit=false
22:50:17.615 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Schema Transaction started with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@64e6c5a9" with isolation "serializable"
22:50:17.616 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Check of existence of "transferdonemarker" returned table type of TABLE
22:50:17.616 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Loading column info for table(s) "fileinprogressmarker, copymodification, lastsynctoremoterepo, remoterepositoryrequest, localrepository_aliases, repofile, transferdonemarker, deletemodification, repository, modification, filechunk" in Catalog "", Schema ""
22:50:17.642 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column info loaded for Catalog "", Schema "", 11 tables, time = 26 ms
22:50:17.642 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Column info retrieved for table "transferdonemarker" : 8 columns found
22:50:17.644 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Validating 1 index(es) for table "transferdonemarker"
22:50:17.645 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Creating index "TransferDoneMarker_fromRepositoryId_toRepositoryId" in catalog "" schema ""
22:50:17.645 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - CREATE INDEX "transferdonemarker_fromrepositoryid_torepositoryid" ON "transferdonemarker" ("fromrepositoryid","torepositoryid")
22:50:17.666 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Execution Time = 21 ms
22:50:17.690 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Validating 0 foreign key(s) for table "transferdonemarker"
22:50:17.705 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Validating 1 unique key(s) for table "transferdonemarker"
22:50:17.705 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Creating candidate key "TransferDoneMarker_fromRepositoryId_toRepositoryId_transferDoneMarkerType_fromEntityId" in catalog "" schema ""
22:50:17.705 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - CREATE UNIQUE INDEX "transferdonemarker_fromrepositoryid_torepositoryid_transferdonemarkertype_fromentityid" ON "transferdonemarker" ("fromrepositoryid","torepositoryid","transferdonemarkertype","fromentityid")
22:50:17.725 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Execution Time = 20 ms
22:50:17.726 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Schema Transaction committing with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@64e6c5a9"
22:50:17.732 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Schema - Schema Transaction closing with connection "org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@64e6c5a9"
22:50:17.733 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@2a9def04 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@64e6c5a9, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" is being committed.
22:50:17.733 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@2a9def04 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@64e6c5a9, commitOnRelease=true, closeOnRelease=true, closeOnTxnEnd=true]" closed
22:50:17.734 [qtp1593333077-36] DEBUG DataNucleus.Cache - Level 1 Cache cleared
22:50:17.734 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" closed
22:50:17.735 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2e5740a0" with txn="org.datanucleus.TransactionImpl@34b888b7"
22:50:17.736 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
22:50:17.736 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df (optimistic=false)
22:50:17.737 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository"
22:50:17.737 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 0 ms
22:50:17.737 [qtp1593333077-36] DEBUG DataNucleus.Query - QueryCompilation:
  [symbols: this type=co.codewizards.cloudstore.local.persistence.LocalRepository]
22:50:17.738 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" for datastore
22:50:17.742 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 3 ms
22:50:17.742 [qtp1593333077-36] 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'"
22:50:17.745 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@419b2b09 [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
22:50:17.745 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@2e568e19, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
22:50:17.746 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@419b2b09 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@5f74e8d3, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=" with flags "0"
22:50:17.746 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@419b2b09 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@5f74e8d3, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.746 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" ...
22:50:17.755 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@7697d3ab"
22:50:17.756 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."changed","a0"."created","a0"."id","a0"."repositoryid","a0"."revision","a0"."discriminator" FROM "repository" "a0" WHERE "a0"."discriminator" = 'LocalRepository'
22:50:17.756 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
22:50:17.757 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 11 ms
22:50:17.757 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 1 cache [cache size = 0]
22:50:17.757 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 2 cache
22:50:17.758 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") added to Level 1 cache (loadedFlags="[NNYNNNNNN]")
22:50:17.758 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" (id="1") added to Level 2 cache (fields="[0, 1, 2, 4, 5]", version="")
22:50:17.759 [qtp1593333077-36] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "HOLLOW"->"P_CLEAN"
22:50:17.759 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" (id="1") enlisted in transactional cache
22:50:17.760 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" having fields "publicKey" fetched from table ""repository""
22:50:17.761 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@419b2b09 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@5f74e8d3, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.766 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@6d214e7c"
22:50:17.767 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."publickey" FROM "repository" "a0" WHERE "a0"."id" = <1>
22:50:17.768 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
22:50:17.768 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@536401d5"
22:50:17.768 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" (id="1") is having the following fields in Level 2 cache object updated : [3]
22:50:17.769 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" having fields "privateKey" fetched from table ""repository""
22:50:17.769 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@419b2b09 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@5f74e8d3, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.774 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@453393c2"
22:50:17.774 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."privatekey" FROM "repository" "a0" WHERE "a0"."id" = <1>
22:50:17.774 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
22:50:17.775 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@78f2ac22"
22:50:17.775 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" (id="1") is having the following fields in Level 2 cache object updated : [7]
22:50:17.775 [qtp1593333077-36] INFO  c.c.c.local.LocalRepoManagerImpl - [28b52283]initPersistenceManagerFactory: repositoryId=c70a4d54-4cd7-49a0-ab27-d2962a8be5b7
22:50:17.775 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df
22:50:17.775 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.776 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.776 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@2e568e19]]
22:50:17.776 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@419b2b09 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@5f74e8d3, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=" with onePhase="true"
22:50:17.776 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@419b2b09 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@5f74e8d3, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
22:50:17.776 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@419b2b09 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@5f74e8d3, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.776 [qtp1593333077-36] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "P_CLEAN"->"HOLLOW"
22:50:17.776 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") was evicted from transactional cache
22:50:17.776 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
22:50:17.777 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Disconnecting co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46 from StateManager[pc=co.codewizards.cloudstore.local.persistence.LocalRepository@41e2e46, lifecycle=HOLLOW]
22:50:17.777 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object with id="co.codewizards.cloudstore.local.persistence.LocalRepository:1" being removed from Level 1 cache [current cache size = 1]
22:50:17.777 [qtp1593333077-36] DEBUG DataNucleus.Cache - Level 1 Cache cleared
22:50:17.777 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" closed
22:50:17.777 [qtp1593333077-36] INFO  c.c.c.local.LocalRepoManagerImpl - [28b52283]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2520 ms.
22:50:17.777 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2e5740a0" with txn="org.datanucleus.TransactionImpl@271cdaed"
22:50:17.777 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
22:50:17.777 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df (optimistic=false)
22:50:17.778 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Single-String with "SELECT WHERE this.changed < :changed"
22:50:17.778 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed"
22:50:17.779 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 1 ms
22:50:17.779 [qtp1593333077-36] 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]
22:50:17.779 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed" for datastore
22:50:17.781 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 2 ms
22:50:17.781 [qtp1593333077-36] 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" < ?"
22:50:17.782 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4a1127fe [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
22:50:17.782 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@b9b57e3, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
22:50:17.782 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4a1127fe [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@3b60a0e0, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=" with flags "0"
22:50:17.782 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4a1127fe [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@3b60a0e0, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.782 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest WHERE this.changed < :changed" ...
22:50:17.789 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@2453a32f"
22:50:17.789 [qtp1593333077-36] 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-06-23 22:50:17.778>
22:50:17.790 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
22:50:17.790 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 8 ms
22:50:17.791 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df
22:50:17.791 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.791 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.791 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@b9b57e3]]
22:50:17.791 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4a1127fe [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@3b60a0e0, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=" with onePhase="true"
22:50:17.792 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4a1127fe [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@3b60a0e0, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
22:50:17.792 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4a1127fe [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@3b60a0e0, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.792 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
22:50:17.792 [qtp1593333077-36] DEBUG DataNucleus.Cache - Level 1 Cache cleared
22:50:17.792 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" closed
22:50:17.792 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [68511860]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
22:50:17.793 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [68511860]tryAcquire: returning true. lockCounter=1
22:50:17.793 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [68511860]tryAcquire: returning true. lockCounter=2
22:50:17.793 [qtp1593333077-36] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
22:50:17.793 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [68511860]release: NOT releasing underlying FileLock. lockCounter=1
22:50:17.793 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [68511860]release: releasing underlying FileLock. lockCounter=0
22:50:17.794 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2e5740a0" with txn="org.datanucleus.TransactionImpl@52fb20b6"
22:50:17.794 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=
, enlisted resources=[]]
22:50:17.794 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df (optimistic=false)
22:50:17.795 [qtp1593333077-36] 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
22:50:17.795 [qtp1593333077-36] 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
22:50:17.795 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@a94bb6c [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
22:50:17.795 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@61df2c8f, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=
, enlisted resources=[]]
22:50:17.796 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@a94bb6c [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@7e8edb84, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=
" with flags "0"
22:50:17.796 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@a94bb6c [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@7e8edb84, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.796 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" ...
22:50:17.796 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@5eab61c8"
22:50:17.796 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."changed","a0"."created","a0"."id","a0"."repositoryid","a0"."revision","a0"."discriminator" FROM "repository" "a0" WHERE "a0"."discriminator" = 'LocalRepository'
22:50:17.797 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
22:50:17.797 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 1 ms
22:50:17.797 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 1 cache [cache size = 0]
22:50:17.797 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") added to Level 1 cache (loadedFlags="[NNYNNNNNN]")
22:50:17.797 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "changed" replaced by a SCO wrapper
22:50:17.798 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "created" replaced by a SCO wrapper
22:50:17.798 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb" (id="1") enlisted in transactional cache
22:50:17.798 [qtp1593333077-36] 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@654defdb"
22:50:17.799 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb" 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]
22:50:17.799 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb" (id="1") is having the following fields in Level 2 cache object updated : [6]
22:50:17.800 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb" field "aliases" loading contents to SCO wrapper from the datastore
22:50:17.800 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@a94bb6c [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@7e8edb84, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.808 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@1047afda"
22:50:17.809 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."element" FROM "localrepository_aliases" "a0" WHERE "a0"."id_oid" = <1>
22:50:17.809 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
22:50:17.809 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@60541deb"
22:50:17.810 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [1e67a06a]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
22:50:17.810 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [1e67a06a]tryAcquire: returning true. lockCounter=1
22:50:17.810 [qtp1593333077-36] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
22:50:17.810 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [1e67a06a]release: releasing underlying FileLock. lockCounter=0
22:50:17.811 [qtp1593333077-36] DEBUG c.c.c.local.LocalRepoManagerImpl - syncWithLocalRepoRegistry: Alias 'jxauu3f1-b44zr' of repository 'c70a4d54-4cd7-49a0-ab27-d2962a8be5b7' already in-sync.
22:50:17.811 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [8d14c00]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
22:50:17.811 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [8d14c00]tryAcquire: returning true. lockCounter=1
22:50:17.811 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [8d14c00]tryAcquire: returning true. lockCounter=2
22:50:17.812 [qtp1593333077-36] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
22:50:17.812 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [8d14c00]release: NOT releasing underlying FileLock. lockCounter=1
22:50:17.812 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [8d14c00]release: releasing underlying FileLock. lockCounter=0
22:50:17.812 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.812 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.812 [qtp1593333077-36] DEBUG c.c.c.l.AutoTrackLifecycleListener - onCommit: Deferred operations took 0 ms for 0 entities.
22:50:17.813 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.813 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.813 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df
22:50:17.813 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.813 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.813 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=
, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@61df2c8f]]
22:50:17.813 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@a94bb6c [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@7e8edb84, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=
" with onePhase="true"
22:50:17.813 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@a94bb6c [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@7e8edb84, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
22:50:17.813 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@a94bb6c [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@7e8edb84, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.814 [qtp1593333077-36] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "P_CLEAN"->"HOLLOW"
22:50:17.814 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") was evicted from transactional cache
22:50:17.814 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
22:50:17.814 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Disconnecting co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb from StateManager[pc=co.codewizards.cloudstore.local.persistence.LocalRepository@654defdb, lifecycle=HOLLOW]
22:50:17.814 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object with id="co.codewizards.cloudstore.local.persistence.LocalRepository:1" being removed from Level 1 cache [current cache size = 1]
22:50:17.814 [qtp1593333077-36] DEBUG DataNucleus.Cache - Level 1 Cache cleared
22:50:17.814 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" closed
22:50:17.815 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2e5740a0" with txn="org.datanucleus.TransactionImpl@479a05b8"
22:50:17.815 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
22:50:17.815 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df (optimistic=false)
22:50:17.816 [qtp1593333077-36] 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
22:50:17.816 [qtp1593333077-36] 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
22:50:17.816 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4d3d5476 [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
22:50:17.816 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@479ebc1e, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
22:50:17.816 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4d3d5476 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@53f231c, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=" with flags "0"
22:50:17.817 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4d3d5476 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@53f231c, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.817 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.LocalRepository" ...
22:50:17.817 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@11c2d5c3"
22:50:17.817 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."changed","a0"."created","a0"."id","a0"."repositoryid","a0"."revision","a0"."discriminator" FROM "repository" "a0" WHERE "a0"."discriminator" = 'LocalRepository'
22:50:17.817 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
22:50:17.818 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 1 ms
22:50:17.818 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object with id "co.codewizards.cloudstore.local.persistence.LocalRepository:1" not found in Level 1 cache [cache size = 0]
22:50:17.818 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") added to Level 1 cache (loadedFlags="[NNYNNNNNN]")
22:50:17.818 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "changed" replaced by a SCO wrapper
22:50:17.818 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") is having the value in field "created" replaced by a SCO wrapper
22:50:17.819 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735" (id="1") enlisted in transactional cache
22:50:17.819 [qtp1593333077-36] 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@33e2d735"
22:50:17.819 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735" 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]
22:50:17.820 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735" (id="1") is having the following fields in Level 2 cache object updated : [6]
22:50:17.820 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4d3d5476 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@53f231c, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.827 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@6fdb6ddb"
22:50:17.828 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT COUNT(*) FROM "localrepository_aliases" THIS WHERE THIS."id_oid"=<1>
22:50:17.829 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
22:50:17.829 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@3bbcce2c"
22:50:17.829 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735" field "aliases" loading contents to SCO wrapper from the datastore
22:50:17.830 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4d3d5476 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@53f231c, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.830 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@3ea59885"
22:50:17.830 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT "a0"."element" FROM "localrepository_aliases" "a0" WHERE "a0"."id_oid" = <1>
22:50:17.831 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
22:50:17.831 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.ParamLoggingPreparedStatement@66f6153f"
22:50:17.831 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.831 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.831 [qtp1593333077-36] DEBUG c.c.c.l.AutoTrackLifecycleListener - onCommit: Deferred operations took 0 ms for 0 entities.
22:50:17.831 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.831 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.832 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df
22:50:17.832 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.832 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.832 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@479ebc1e]]
22:50:17.832 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4d3d5476 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@53f231c, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=" with onePhase="true"
22:50:17.832 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4d3d5476 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@53f231c, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
22:50:17.832 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@4d3d5476 [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@53f231c, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.833 [qtp1593333077-36] DEBUG DataNucleus.Lifecycle - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") has a lifecycle change : "P_CLEAN"->"HOLLOW"
22:50:17.833 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Object "co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735" (id="co.codewizards.cloudstore.local.persistence.LocalRepository:1") was evicted from transactional cache
22:50:17.833 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
22:50:17.833 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Disconnecting co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735 from StateManager[pc=co.codewizards.cloudstore.local.persistence.LocalRepository@33e2d735, lifecycle=HOLLOW]
22:50:17.833 [qtp1593333077-36] DEBUG DataNucleus.Cache - Object with id="co.codewizards.cloudstore.local.persistence.LocalRepository:1" being removed from Level 1 cache [current cache size = 1]
22:50:17.833 [qtp1593333077-36] DEBUG DataNucleus.Cache - Level 1 Cache cleared
22:50:17.833 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" closed
22:50:17.833 [qtp1593333077-36] DEBUG c.c.c.local.LocalRepoManagerImpl - [28b52283]open: closing=false closeAbortable=true
22:50:17.834 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" opened for datastore "org.datanucleus.store.rdbms.RDBMSStoreManager@2e5740a0" with txn="org.datanucleus.TransactionImpl@2995ac3a"
22:50:17.834 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction created [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
22:50:17.834 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction begun for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df (optimistic=false)
22:50:17.834 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [59526c42]<init>: file='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/.cloudstore/repoRegistry.properties'
22:50:17.834 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [59526c42]tryAcquire: returning true. lockCounter=1
22:50:17.834 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [59526c42]tryAcquire: returning true. lockCounter=2
22:50:17.835 [qtp1593333077-36] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='cloudstore.repoRegistry.evictDeadEntriesPeriod' is not set (config is queried next).
22:50:17.835 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [59526c42]release: NOT releasing underlying FileLock. lockCounter=1
22:50:17.835 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [59526c42]release: releasing underlying FileLock. lockCounter=0
22:50:17.836 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository"
22:50:17.836 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 0 ms
22:50:17.836 [qtp1593333077-36] DEBUG DataNucleus.Query - QueryCompilation:
  [symbols: this type=co.codewizards.cloudstore.local.persistence.RemoteRepository]
22:50:17.837 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository" for datastore
22:50:17.838 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 1 ms
22:50:17.838 [qtp1593333077-36] 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'"
22:50:17.839 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=null, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" opened with isolation level "read-committed" and auto-commit=false
22:50:17.839 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Running enlist operation on resource: org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@c5b6741, error code TMNOFLAGS and transaction: [DataNucleus Transaction, ID=Xid=, enlisted resources=[]]
22:50:17.839 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" starting for transaction "Xid=" with flags "0"
22:50:17.839 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection added to the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.839 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepository" ...
22:50:17.845 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@16ebb917"
22:50:17.845 [qtp1593333077-36] 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'
22:50:17.845 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
22:50:17.846 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 7 ms
22:50:17.846 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest"
22:50:17.847 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 1 ms
22:50:17.847 [qtp1593333077-36] DEBUG DataNucleus.Query - QueryCompilation:
  [symbols: this type=co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest]
22:50:17.847 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest" for datastore
22:50:17.848 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 1 ms
22:50:17.848 [qtp1593333077-36] 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""
22:50:17.848 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.848 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT FROM co.codewizards.cloudstore.local.persistence.RemoteRepositoryRequest" ...
22:50:17.853 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@1678502b"
22:50:17.854 [qtp1593333077-36] 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"
22:50:17.854 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
22:50:17.854 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 6 ms
22:50:17.855 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile"
22:50:17.856 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 1 ms
22:50:17.856 [qtp1593333077-36] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.NormalFile]
22:50:17.856 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile" for datastore
22:50:17.858 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 2 ms
22:50:17.858 [qtp1593333077-36] 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'"
22:50:17.858 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.858 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.NormalFile" ...
22:50:17.866 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@4ea470d3"
22:50:17.866 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "repofile" "a0" WHERE "a0"."discriminator" = 'NormalFile'
22:50:17.867 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
22:50:17.867 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 9 ms
22:50:17.868 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory"
22:50:17.869 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 1 ms
22:50:17.869 [qtp1593333077-36] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.Directory]
22:50:17.869 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory" for datastore
22:50:17.870 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 1 ms
22:50:17.870 [qtp1593333077-36] 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'"
22:50:17.870 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.870 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.Directory" ...
22:50:17.877 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@3593f545"
22:50:17.877 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "repofile" "a0" WHERE "a0"."discriminator" = 'Directory'
22:50:17.878 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
22:50:17.879 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 9 ms
22:50:17.879 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification"
22:50:17.880 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 1 ms
22:50:17.880 [qtp1593333077-36] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.CopyModification]
22:50:17.880 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification" for datastore
22:50:17.881 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 1 ms
22:50:17.881 [qtp1593333077-36] 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'"
22:50:17.882 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.882 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.CopyModification" ...
22:50:17.893 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@3f316673"
22:50:17.893 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "copymodification" "a0" INNER JOIN "modification" "a1" ON "a0"."id" = "a1"."id" WHERE "a1"."discriminator" = 'CopyModification'
22:50:17.894 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 1 ms
22:50:17.894 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 12 ms
22:50:17.895 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification"
22:50:17.895 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time = 0 ms
22:50:17.895 [qtp1593333077-36] DEBUG DataNucleus.Query - QueryCompilation:
  [result:InvokeExpression{STATIC.count(PrimaryExpression{this})}]
  [symbols: this type=co.codewizards.cloudstore.local.persistence.DeleteModification]
22:50:17.895 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compiling "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification" for datastore
22:50:17.897 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Compile Time for datastore = 2 ms
22:50:17.897 [qtp1593333077-36] 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'"
22:50:17.897 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection found in the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.897 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Executing "SELECT count(this) FROM co.codewizards.cloudstore.local.persistence.DeleteModification" ...
22:50:17.906 [qtp1593333077-36] DEBUG DataNucleus.Datastore - Closing PreparedStatement "org.datanucleus.store.rdbms.datasource.dbcp.DelegatingPreparedStatement@7a8fe0f1"
22:50:17.907 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Native - SELECT COUNT("a0"."id") FROM "deletemodification" "a0" INNER JOIN "modification" "a1" ON "a0"."id" = "a1"."id" WHERE "a1"."discriminator" = 'DeleteModification'
22:50:17.907 [qtp1593333077-36] DEBUG DataNucleus.Datastore.Retrieve - Execution Time = 0 ms
22:50:17.908 [qtp1593333077-36] DEBUG DataNucleus.Query - JDOQL Query : Execution Time = 11 ms
22:50:17.908 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.908 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.908 [qtp1593333077-36] DEBUG c.c.c.l.AutoTrackLifecycleListener - onCommit: Deferred operations took 0 ms for 0 entities.
22:50:17.908 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.908 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.909 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committing for ExecutionContext org.datanucleus.ExecutionContextImpl@276478df
22:50:17.909 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process started using ordered flush - 0 enlisted objects
22:50:17.909 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext.internalFlush() process finished
22:50:17.909 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Committing [DataNucleus Transaction, ID=Xid=, enlisted resources=[org.datanucleus.store.rdbms.ConnectionFactoryImpl$EmulatedXAResource@c5b6741]]
22:50:17.909 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" committing for transaction "Xid=" with onePhase="true"
22:50:17.909 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection(non-enlisted) "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" closed
22:50:17.909 [qtp1593333077-36] DEBUG DataNucleus.Connection - ManagedConnection removed from the pool : "org.datanucleus.store.rdbms.ConnectionFactoryImpl$ManagedConnectionImpl@46a133ab [conn=org.datanucleus.store.rdbms.datasource.dbcp.PoolingDataSource$PoolGuardConnectionWrapper@46ca227b, commitOnRelease=false, closeOnRelease=false, closeOnTxnEnd=true]" for key="org.datanucleus.ExecutionContextImpl@276478df" in factory="ConnectionFactory:tx[org.datanucleus.store.rdbms.ConnectionFactoryImpl@2b4059fa]"
22:50:17.909 [qtp1593333077-36] DEBUG DataNucleus.Transaction - Transaction committed in 1 ms
22:50:17.909 [qtp1593333077-36] DEBUG DataNucleus.Cache - Level 1 Cache cleared
22:50:17.910 [qtp1593333077-36] DEBUG DataNucleus.Persistence - ExecutionContext "org.datanucleus.ExecutionContextImpl@276478df" closed
22:50:17.910 [qtp1593333077-36] INFO  c.c.c.local.LocalRepoManagerImpl - [28b52283]_close: Shutting down real LocalRepoManager.
22:50:18.146 [qtp1593333077-36] DEBUG DataNucleus.Connection - Closing Connection Pool tx
22:50:18.147 [qtp1593333077-36] DEBUG DataNucleus.Connection - Closing Connection Pool nontx
22:50:18.148 [qtp1593333077-36] DEBUG DataNucleus.Persistence - Unmanaging Persistence of all classes
22:50:18.148 [qtp1593333077-36] DEBUG DataNucleus.MetaData - Deregistering listener for metadata initialisation
22:50:18.148 [qtp1593333077-36] DEBUG DataNucleus.Cache - Level 2 Cache cleared
22:50:18.402 [qtp1593333077-36] DEBUG c.c.cloudstore.core.io.LockFileImpl - [65d0e014]release: releasing underlying FileLock. lockCounter=0
22:50:18.409 [qtp1593333077-36] DEBUG org.eclipse.jetty.server.HttpChannel - sendResponse info=null content=HeapByteBuffer@1c7df7c3[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@6b1a8af7{null}
22:50:18.409 [qtp1593333077-36] DEBUG org.eclipse.jetty.server.HttpChannel - COMMIT for /RepoInfo on HttpChannelOverHttp@5c1499f3{r=1,c=true,a=DISPATCHED,uri=//127.0.0.1:35999/RepoInfo}
200 OK HTTP/1.1
Content-Length: 765
Content-Type: application/xml


22:50:18.410 [qtp1593333077-36] DEBUG o.e.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$SendCallback@5040ea4e[PROCESSING][i=HTTP/1.1{s=200,h=2},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@1e71bba9] generate: NEED_HEADER (null,[p=0,l=765,c=8192,r=765],true)@START
22:50:18.410 [qtp1593333077-36] DEBUG o.e.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$SendCallback@5040ea4e[PROCESSING][i=HTTP/1.1{s=200,h=2},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@1e71bba9] generate: FLUSH ([p=0,l=104,c=8192,r=104],[p=0,l=765,c=8192,r=765],true)@COMPLETING
22:50:18.410 [qtp1593333077-36] DEBUG org.eclipse.jetty.io.WriteFlusher - write: WriteFlusher@6d41844b{IDLE} [HeapByteBuffer@7ec83617[p=0,l=104,c=8192,r=104]={<<<HTTP/1.1 200 OK\r\n....v20180605)\r\n\r\n>>>swU1NadXBJYWN1X1Z...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@1c7df7c3[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}]
22:50:18.410 [qtp1593333077-36] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@6d41844b{WRITING}:IDLE-->WRITING
22:50:18.411 [qtp1593333077-36] DEBUG org.eclipse.jetty.io.ChannelEndPoint - flushed 869 SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,-,W,3217/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}
22:50:18.411 [qtp1593333077-36] DEBUG org.eclipse.jetty.io.WriteFlusher - Flushed=true 104/104+1 WriteFlusher@6d41844b{WRITING}
22:50:18.411 [qtp1593333077-36] DEBUG org.eclipse.jetty.io.WriteFlusher - update WriteFlusher@6d41844b{IDLE}:WRITING-->IDLE
22:50:18.411 [qtp1593333077-36] DEBUG o.e.jetty.server.HttpConnection - org.eclipse.jetty.server.HttpConnection$SendCallback@5040ea4e[PROCESSING][i=HTTP/1.1{s=200,h=2},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@1e71bba9] generate: DONE ([p=104,l=104,c=8192,r=0],[p=765,l=765,c=8192,r=0],true)@END
22:50:18.414 [qtp1593333077-36] DEBUG org.eclipse.jetty.server.Server - handled=true async=false committed=true on HttpChannelOverHttp@5c1499f3{r=1,c=true,a=DISPATCHED,uri=//127.0.0.1:35999/RepoInfo}
22:50:18.414 [qtp1593333077-36] DEBUG o.e.jetty.server.HttpChannelState - HttpChannelState@6d02a664{s=DISPATCHED a=NOT_ASYNC i=true r=NONE/false w=false} unhandle DISPATCHED
22:50:18.414 [qtp1593333077-36] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@5c1499f3{r=1,c=true,a=COMPLETING,uri=//127.0.0.1:35999/RepoInfo} action COMPLETE
22:50:18.414 [qtp1593333077-36] DEBUG org.eclipse.jetty.server.HttpChannel - COMPLETE for /RepoInfo written=765
22:50:18.414 [qtp1593333077-36] DEBUG org.eclipse.jetty.http.HttpParser - reset HttpParser{s=END,236 of 236}
22:50:18.414 [qtp1593333077-36] DEBUG org.eclipse.jetty.http.HttpParser - END --> START
22:50:18.414 [qtp1593333077-36] DEBUG org.eclipse.jetty.server.HttpChannel - HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null} handle exit, result COMPLETE
22:50:18.415 [qtp1593333077-36] DEBUG org.eclipse.jetty.io.ChannelEndPoint - filled 0 SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,-,-,4/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}
22:50:18.415 [qtp1593333077-36] DEBUG org.eclipse.jetty.io.ChannelEndPoint - filled 0 SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,-,-,4/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}
22:50:18.415 [qtp1593333077-36] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,-,-,4/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}] filled 0 HeapByteBuffer@7ec83617[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}
22:50:18.416 [qtp1593333077-36] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,-,-,5/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}] parse HeapByteBuffer@7ec83617[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} {}
22:50:18.416 [qtp1593333077-36] DEBUG org.eclipse.jetty.http.HttpParser - parseNext s=START HeapByteBuffer@7ec83617[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}
22:50:18.417 [qtp1593333077-36] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,-,-,5/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}] parsed false HttpParser{s=START,0 of -1}
22:50:18.417 [qtp1593333077-36] DEBUG o.e.jetty.server.HttpConnection - releaseRequestBuffer HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,-,-,6/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}]
22:50:18.417 [qtp1593333077-36] DEBUG o.e.jetty.io.AbstractConnection - fillInterested HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,-,-,6/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}]
22:50:18.418 [qtp1593333077-36] DEBUG org.eclipse.jetty.io.FillInterest - FillInterest@26eaf715{true,AC.ReadCB@4418b4cd{HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,FI,-,0/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}]}} register AC.ReadCB@4418b4cd{HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,FI,-,1/30000,HttpConnection@4418b4cd}{io=0/0,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}]}
22:50:18.418 [qtp1593333077-36] DEBUG o.e.jetty.io.SelectChannelEndPoint - changeInterests p=false 0->1 for SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,FI,-,1/30000,HttpConnection@4418b4cd}{io=0/1,kio=0,kro=1}
22:50:18.419 [qtp1593333077-36] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,FI,-,2/30000,HttpConnection@4418b4cd}{io=0/1,kio=0,kro=1}:runUpdateKey on org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=1 selected=0
22:50:18.419 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop woken up from select, 0/1 selected
22:50:18.420 [qtp1593333077-36] DEBUG o.e.jetty.server.HttpConnection - HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,FI,-,2/30000,HttpConnection@4418b4cd}{io=0/1,kio=0,kro=1}][p=HttpParser{s=START,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}] onFillable exit HttpChannelState@6d02a664{s=IDLE a=NOT_ASYNC i=true r=NONE/false w=false} null
22:50:18.420 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ManagedSelector - Running change SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,FI,-,2/30000,HttpConnection@4418b4cd}{io=0/1,kio=0,kro=1}:runUpdateKey
22:50:18.420 [qtp1593333077-36] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 ran SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,FI,-,3/30000,HttpConnection@4418b4cd}{io=1/1,kio=0,kro=1}:runFillable
22:50:18.420 [qtp1593333077-37] DEBUG o.e.jetty.io.SelectChannelEndPoint - Key interests updated 0 -> 1 on SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,Open,in,out,FI,-,3/30000,HttpConnection@4418b4cd}{io=1/1,kio=1,kro=1}
22:50:18.420 [qtp1593333077-36] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 produce exit
22:50:18.420 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop waiting on select
22:50:18.420 [qtp1593333077-36] DEBUG o.e.j.util.thread.QueuedThreadPool - ran EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5
22:50:18.427 [main] DEBUG c.c.c.l.r.c.LocalServerRestClient - execute: invocation took 3304 ms
Local repository:
  repository.repositoryId = c70a4d54-4cd7-49a0-ab27-d2962a8be5b7
  repository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/repo/jxauu3f1-b44zr
  repository.aliases = co.codewizards.cloudstore.ls.core.dto.RepoInfoResponseDto@7f426ddd
  repository.publicKeySha1 = CD:73:BB:CF:94:2A:50:97:32:99:28:71:4D:CA:8F:FD:F0:AE:4D:38

Remote repositories connected: {NONE}

Remote repositories requesting connection: {NONE}

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

22:50:18.428 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.Server@5bcec67e
22:50:18.428 [main] DEBUG org.eclipse.jetty.server.Server - doStop org.eclipse.jetty.server.Server@5bcec67e
22:50:18.428 [main] DEBUG org.eclipse.jetty.server.Server - Graceful shutdown org.eclipse.jetty.server.Server@5bcec67e by 
22:50:18.429 [qtp1593333077-35] DEBUG o.e.j.util.thread.QueuedThreadPool - ran qtp1593333077-35-acceptor-0@2a87ba34-ServerConnector@4bb1b96b{HTTP/1.1,[http/1.1]}{127.0.0.1:35999}
22:50:18.429 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping ServerConnector@4bb1b96b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
22:50:18.429 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@1f66d8e1
22:50:18.429 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.io.ManagedSelector@44592c39 id=2 keys=0 selected=0
22:50:18.429 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Stopping org.eclipse.jetty.io.ManagedSelector@44592c39 id=2 keys=0 selected=0
22:50:18.430 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@28e7bb31 on org.eclipse.jetty.io.ManagedSelector@44592c39 id=2 keys=0 selected=0
22:50:18.430 [qtp1593333077-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop woken up from select, 0/0 selected
22:50:18.430 [qtp1593333077-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Running change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@28e7bb31
22:50:18.431 [qtp1593333077-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Closing 0 endPoints on org.eclipse.jetty.io.ManagedSelector@44592c39 id=2 keys=0 selected=0
22:50:18.432 [qtp1593333077-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Closed 0 endPoints on org.eclipse.jetty.io.ManagedSelector@44592c39 id=2 keys=0 selected=0
22:50:18.432 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseSelector@6fe04f2a on org.eclipse.jetty.io.ManagedSelector@44592c39 id=2 keys=0 selected=0
22:50:18.432 [qtp1593333077-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop waiting on select
22:50:18.432 [qtp1593333077-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop woken up from select, 0/0 selected
22:50:18.432 [qtp1593333077-34] DEBUG org.eclipse.jetty.io.ManagedSelector - Running change org.eclipse.jetty.io.ManagedSelector$CloseSelector@6fe04f2a
22:50:18.432 [qtp1593333077-34] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@1a9f1945 produced null
22:50:18.432 [qtp1593333077-34] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@1a9f1945 produce exit
22:50:18.432 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Stopped org.eclipse.jetty.io.ManagedSelector@44592c39 id=2 keys=-1 selected=-1
22:50:18.432 [qtp1593333077-34] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector@44592c39 id=2 keys=-1 selected=-1
22:50:18.432 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.io.ManagedSelector@44592c39 id=2 keys=-1 selected=-1
22:50:18.432 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.io.ManagedSelector@7015ebef id=1 keys=0 selected=0
22:50:18.433 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Stopping org.eclipse.jetty.io.ManagedSelector@7015ebef id=1 keys=0 selected=0
22:50:18.433 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@1f758e4f on org.eclipse.jetty.io.ManagedSelector@7015ebef id=1 keys=0 selected=0
22:50:18.433 [qtp1593333077-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop woken up from select, 0/0 selected
22:50:18.433 [qtp1593333077-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Running change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@1f758e4f
22:50:18.433 [qtp1593333077-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Closing 0 endPoints on org.eclipse.jetty.io.ManagedSelector@7015ebef id=1 keys=0 selected=0
22:50:18.433 [qtp1593333077-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Closed 0 endPoints on org.eclipse.jetty.io.ManagedSelector@7015ebef id=1 keys=0 selected=0
22:50:18.433 [qtp1593333077-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop waiting on select
22:50:18.433 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseSelector@733534f9 on org.eclipse.jetty.io.ManagedSelector@7015ebef id=1 keys=0 selected=0
22:50:18.434 [qtp1593333077-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop woken up from select, 0/0 selected
22:50:18.434 [qtp1593333077-33] DEBUG org.eclipse.jetty.io.ManagedSelector - Running change org.eclipse.jetty.io.ManagedSelector$CloseSelector@733534f9
22:50:18.434 [qtp1593333077-33] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@1fe4f33 produced null
22:50:18.434 [qtp1593333077-33] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@1fe4f33 produce exit
22:50:18.434 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Stopped org.eclipse.jetty.io.ManagedSelector@7015ebef id=1 keys=-1 selected=-1
22:50:18.434 [qtp1593333077-33] DEBUG o.e.j.util.thread.QueuedThreadPool - ran org.eclipse.jetty.io.ManagedSelector@7015ebef id=1 keys=-1 selected=-1
22:50:18.434 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.io.ManagedSelector@7015ebef id=1 keys=-1 selected=-1
22:50:18.434 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=1 selected=0
22:50:18.434 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Stopping org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=1 selected=0
22:50:18.434 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@661e279d on org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=1 selected=0
22:50:18.435 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop woken up from select, 0/1 selected
22:50:18.435 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ManagedSelector - Running change org.eclipse.jetty.io.ManagedSelector$CloseEndPoints@661e279d
22:50:18.435 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ManagedSelector - Closing 1 endPoints on org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=1 selected=0
22:50:18.435 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$EndPointCloser@511f99b6 on org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=1 selected=0
22:50:18.435 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ManagedSelector - Closed 1 endPoints on org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=1 selected=0
22:50:18.435 [qtp1593333077-37] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 produced org.eclipse.jetty.io.ManagedSelector$EndPointCloser@511f99b6
22:50:18.436 [qtp1593333077-37] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 dispatch
22:50:18.436 [qtp1593333077-37] DEBUG o.e.j.util.thread.QueuedThreadPool - queue EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5
22:50:18.436 [qtp1593333077-37] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 run org.eclipse.jetty.io.ManagedSelector$EndPointCloser@511f99b6
22:50:18.436 [qtp1593333077-38] DEBUG o.e.j.util.thread.QueuedThreadPool - run EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5
22:50:18.436 [qtp1593333077-38] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 run
22:50:18.436 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.WriteFlusher - ignored: WriteFlusher@6d41844b{IDLE} java.nio.channels.ClosedChannelException
22:50:18.436 [qtp1593333077-38] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 produce enter
22:50:18.436 [qtp1593333077-38] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 producing
22:50:18.436 [qtp1593333077-37] DEBUG org.eclipse.jetty.http.HttpParser - close HttpParser{s=START,0 of -1}
22:50:18.436 [qtp1593333077-37] DEBUG org.eclipse.jetty.http.HttpParser - START --> CLOSE
22:50:18.436 [qtp1593333077-38] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop waiting on select
22:50:18.437 [qtp1593333077-37] DEBUG o.e.jetty.io.AbstractConnection - HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,CLOSED,in,out,-,-,19/30000,HttpConnection@4418b4cd}{io=1/1,kio=1,kro=1}][p=HttpParser{s=CLOSE,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}] onFillInterestedFailed java.nio.channels.ClosedChannelException
22:50:18.437 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ChannelEndPoint - close SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,CLOSED,in,out,-,-,20/30000,HttpConnection@4418b4cd}{io=1/1,kio=1,kro=1}
22:50:18.437 [qtp1593333077-37] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@5fd86de5 on org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=1 selected=0
22:50:18.437 [qtp1593333077-37] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 ran org.eclipse.jetty.io.ManagedSelector$EndPointCloser@511f99b6
22:50:18.437 [qtp1593333077-37] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 produce exit
22:50:18.437 [qtp1593333077-37] DEBUG o.e.j.util.thread.QueuedThreadPool - ran EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5
22:50:18.437 [qtp1593333077-38] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop woken up from select, 0/0 selected
22:50:18.438 [qtp1593333077-38] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 produced org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@5fd86de5
22:50:18.438 [qtp1593333077-38] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 dispatch
22:50:18.438 [qtp1593333077-38] DEBUG o.e.j.util.thread.QueuedThreadPool - queue EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5
22:50:18.438 [qtp1593333077-38] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 run org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@5fd86de5
22:50:18.438 [qtp1593333077-39] DEBUG o.e.j.util.thread.QueuedThreadPool - run EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5
22:50:18.438 [qtp1593333077-38] DEBUG org.eclipse.jetty.io.ManagedSelector - Destroyed SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,CLOSED,ISHUT,OSHUT,-,-,21/30000,HttpConnection@4418b4cd}{io=1/1,kio=-1,kro=-1}
22:50:18.438 [qtp1593333077-39] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 run
22:50:18.438 [qtp1593333077-39] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 produce enter
22:50:18.438 [qtp1593333077-39] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 producing
22:50:18.438 [qtp1593333077-39] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop waiting on select
22:50:18.439 [qtp1593333077-38] DEBUG o.e.jetty.io.AbstractConnection - onClose HttpConnection@4418b4cd[SelectChannelEndPoint@3ce4d5e3{/127.0.0.1:36496<->35999,CLOSED,ISHUT,OSHUT,-,-,21/30000,HttpConnection@4418b4cd}{io=1/1,kio=-1,kro=-1}][p=HttpParser{s=CLOSE,0 of -1},g=HttpGenerator@3c3b66bc{s=START},c=HttpChannelOverHttp@5c1499f3{r=1,c=false,a=IDLE,uri=null}]
22:50:18.439 [qtp1593333077-38] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 ran org.eclipse.jetty.io.ManagedSelector$DestroyEndPoint@5fd86de5
22:50:18.439 [qtp1593333077-38] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 produce exit
22:50:18.439 [qtp1593333077-38] DEBUG o.e.j.util.thread.QueuedThreadPool - ran EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5
22:50:18.444 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Queued change org.eclipse.jetty.io.ManagedSelector$CloseSelector@beabd6b on org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=0 selected=0
22:50:18.444 [qtp1593333077-39] DEBUG org.eclipse.jetty.io.ManagedSelector - Selector loop woken up from select, 0/0 selected
22:50:18.444 [qtp1593333077-39] DEBUG org.eclipse.jetty.io.ManagedSelector - Running change org.eclipse.jetty.io.ManagedSelector$CloseSelector@beabd6b
22:50:18.444 [qtp1593333077-39] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 produced null
22:50:18.444 [qtp1593333077-39] DEBUG o.e.j.u.t.s.ExecuteProduceConsume - EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5 produce exit
22:50:18.444 [main] DEBUG org.eclipse.jetty.io.ManagedSelector - Stopped org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=-1 selected=-1
22:50:18.444 [qtp1593333077-39] DEBUG o.e.j.util.thread.QueuedThreadPool - ran EPC Idle/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@13ee7fc5
22:50:18.444 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.io.ManagedSelector@5e180aaf id=0 keys=-1 selected=-1
22:50:18.445 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.ServerConnector$ServerConnectorManager@1f66d8e1
22:50:18.445 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping HttpConnectionFactory@7a2fce12[HTTP/1.1]
22:50:18.445 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED HttpConnectionFactory@7a2fce12[HTTP/1.1]
22:50:18.445 [main] INFO  o.e.jetty.server.AbstractConnector - Stopped ServerConnector@4bb1b96b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
22:50:18.445 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED ServerConnector@4bb1b96b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
22:50:18.445 [main] DEBUG o.e.j.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.Server@5bcec67e
22:50:18.445 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.session.HashSessionIdManager@713a35c5
22:50:18.445 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.session.HashSessionIdManager@713a35c5
22:50:18.445 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping o.e.j.s.ServletContextHandler@68b7d0ef{/,null,SHUTDOWN}
22:50:18.446 [main] DEBUG o.e.j.server.handler.AbstractHandler - stopping o.e.j.s.ServletContextHandler@68b7d0ef{/,null,UNAVAILABLE}
22:50:18.446 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.session.SessionHandler@3421debd
22:50:18.446 [main] DEBUG o.e.j.server.handler.AbstractHandler - stopping org.eclipse.jetty.server.session.SessionHandler@3421debd
22:50:18.446 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.servlet.ServletHandler@7069f076
22:50:18.446 [main] DEBUG o.e.j.server.handler.AbstractHandler - stopping org.eclipse.jetty.servlet.ServletHandler@7069f076
22:50:18.446 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-11787b64@c05ddd1e==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false
22:50:18.446 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.servlet.ServletHandler$Default404Servlet-11787b64@c05ddd1e==org.eclipse.jetty.servlet.ServletHandler$Default404Servlet,jsp=null,order=-1,inst=false
22:50:18.446 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.glassfish.jersey.servlet.ServletContainer-1f782c05@2fd7a1ba==org.glassfish.jersey.servlet.ServletContainer,jsp=null,order=-1,inst=true
22:50:18.446 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.glassfish.jersey.servlet.ServletContainer-1f782c05@2fd7a1ba==org.glassfish.jersey.servlet.ServletContainer,jsp=null,order=-1,inst=true
22:50:18.446 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.servlet.ServletHandler@7069f076
22:50:18.446 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.server.session.HashSessionManager@41bfa9e9
22:50:18.447 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.session.HashSessionManager@41bfa9e9
22:50:18.447 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.session.SessionHandler@3421debd
22:50:18.447 [main] INFO  o.e.j.server.handler.ContextHandler - Stopped o.e.j.s.ServletContextHandler@68b7d0ef{/,null,UNAVAILABLE}
22:50:18.447 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED o.e.j.s.ServletContextHandler@68b7d0ef{/,null,UNAVAILABLE}
22:50:18.447 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@2dafae61
22:50:18.447 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.util.thread.ScheduledExecutorScheduler@2dafae61
22:50:18.448 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - stopping qtp1593333077{STARTED,8<=8<=500,i=8,q=0}
22:50:18.451 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED qtp1593333077{STOPPED,8<=8<=500,i=0,q=0}
22:50:18.451 [main] DEBUG o.e.j.u.component.AbstractLifeCycle - STOPPED org.eclipse.jetty.server.Server@5bcec67e
22:50:18.452 [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
22:50:18.452 [main] DEBUG c.c.cloudstore.core.io.LockFileImpl - [4db77402]release: releasing underlying FileLock. lockCounter=0
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 29.644 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-SNAPSHOT.jar
[INFO] 
[INFO] --- maven-dependency-plugin:2.8:copy-dependencies (copy-dependencies) @ co.codewizards.cloudstore.client ---
[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 co.codewizards.cloudstore.ls.rest.client-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.rest.client-0.10.7-SNAPSHOT.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.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-continuation-9.3.24.v20180605.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 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 co.codewizards.cloudstore.core.oio.nio-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.core.oio.nio-0.10.7-SNAPSHOT.jar
[INFO] Copying co.codewizards.cloudstore.core-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.core-0.10.7-SNAPSHOT.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 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 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 co.codewizards.cloudstore.updater-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.updater-0.10.7-SNAPSHOT.jar
[INFO] Copying jetty-webapp-9.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-webapp-9.3.24.v20180605.jar
[INFO] Copying jetty-xml-9.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-xml-9.3.24.v20180605.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 co.codewizards.cloudstore.ls.server.cproc-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.server.cproc-0.10.7-SNAPSHOT.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 jetty-io-9.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-io-9.3.24.v20180605.jar
[INFO] Copying co.codewizards.cloudstore.ls.server-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.server-0.10.7-SNAPSHOT.jar
[INFO] Copying jetty-http-9.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-http-9.3.24.v20180605.jar
[INFO] Copying co.codewizards.cloudstore.ls.core-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.core-0.10.7-SNAPSHOT.jar
[INFO] Copying co.codewizards.cloudstore.local-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.local-0.10.7-SNAPSHOT.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 commons-compress-1.7.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/commons-compress-1.7.jar
[INFO] Copying jetty-security-9.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-security-9.3.24.v20180605.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 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-server-9.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-server-9.3.24.v20180605.jar
[INFO] Copying co.codewizards.cloudstore.rest.shared-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.rest.shared-0.10.7-SNAPSHOT.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.rest.client-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.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 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 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 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 jetty-servlets-9.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-servlets-9.3.24.v20180605.jar
[INFO] Copying jetty-util-9.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-util-9.3.24.v20180605.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 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 xz-1.4.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/xz-1.4.jar
[INFO] Copying jetty-servlet-9.3.24.v20180605.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/jetty-servlet-9.3.24.v20180605.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 bcpg-jdk15on-161b03.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/bcpg-jdk15on-161b03.jar
[INFO] Copying co.codewizards.cloudstore.ls.rest.server-0.10.7-SNAPSHOT.jar to /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/dependency/co.codewizards.cloudstore.ls.rest.server-0.10.7-SNAPSHOT.jar
[INFO] 
[INFO] --- maven-assembly-plugin:2.4:single (make-assembly) @ co.codewizards.cloudstore.client ---
[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-SNAPSHOT-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-SNAPSHOT-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-SNAPSHOT-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-SNAPSHOT.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-SNAPSHOT.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-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-SNAPSHOT.pom
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7-SNAPSHOT-bin.tar.gz to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-SNAPSHOT-bin.tar.gz
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7-SNAPSHOT-bin.zip to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-SNAPSHOT-bin.zip
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.client/target/co.codewizards.cloudstore.client-0.10.7-SNAPSHOT-sources.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-SNAPSHOT-sources.jar
[INFO] 
[INFO] --- maven-deploy-plugin:2.7:deploy (default-deploy) @ co.codewizards.cloudstore.client ---
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml
Downloaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 6.4 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6.jar (44 KB at 14547.9 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6.pom
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6.pom (4 KB at 3702.1 KB/sec)
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml
Downloaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml (400 B at 97.7 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 472.0 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/maven-metadata.xml (400 B at 195.3 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6-bin.tar.gz
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6-bin.tar.gz (21204 KB at 53680.8 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 1416.0 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6-bin.zip
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6-bin.zip (23495 KB at 53886.8 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 1416.0 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6-sources.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/co.codewizards.cloudstore.client-0.10.7-20190624.205023-6-sources.jar (26 KB at 25916.0 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.client/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 1416.0 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