|  Console Output
Skipping 1,685 KB.. Full Log6-44e4-98e3-80500947c2b6"] on repo=b17657db-d3d0-40e7-b70b-e58c1ffce32d
15:52:11.185 [pool-25-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/a'
createTempChunkFile: a; createNewFile=true
deleteOrFail: chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0.xml
FileWatcher: CHUNK_SIZE reached! chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0
WatchTaskChunksToFile: ready
15:52:12.118 [pool-25-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
15:52:12.118 [pool-25-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
15:52:12.318 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
15:52:12.318 [pool-27-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=3f69d91b-32a6-44e4-98e3-80500947c2b6 from='https://localhost:4314/3f69d91b-32a6-44e4-98e3-80500947c2b6' toID=b17657db-d3d0-40e7-b70b-e58c1ffce32d to='target/repo/i448x6be-7e882-local', fromRepoLocalSync=true
15:52:12.319 [pool-28-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing b17657db-d3d0-40e7-b70b-e58c1ffce32d ('target/repo/i448x6be-7e882-local')
15:52:12.326 [pool-28-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
15:52:12.331 [pool-28-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 19.03%
15:52:12.333 [pool-28-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
15:52:12.346 [pool-27-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Read ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448x6be-7e882-local/.cloudstore-repo/tmp/ChangeSetDto.3f69d91b-32a6-44e4-98e3-80500947c2b6.-1.xml.gz
15:52:12.347 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
15:52:12.347 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
15:52:12.353 [pool-27-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/a'
15:52:12.388 [pool-27-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=b17657db-d3d0-40e7-b70b-e58c1ffce32d serverRepositoryId=3f69d91b-32a6-44e4-98e3-80500947c2b6 renewalDateTime=2014-12-25T15:22:09.328Z expiryDateTime=2014-12-25T15:52:09.328Z
15:52:12.433 [pool-27-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='27939abb7bcacced9b098df2184bd86938238f4c' to.sha1='da39a3ee5e6b4b0d3255bfef95601890afd80709'): /a
15:52:12.446 [pool-27-thread-3] WARN c.c.c.l.t.FileRepoTransport - Unexpected state: markFileInProgress==null='false', inProgress='true' on repo=b17657db-d3d0-40e7-b70b-e58c1ffce32d
15:52:12.446 [pool-27-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 2 total). path='/a'
createTempChunkFile: a; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34, chunksCreated=1
deleteOrFail: chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34.xml
15:52:12.879 [pool-27-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 2426 bytes in 433 ms. path='/a'
15:52:12.886 [pool-27-thread-3] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
watchForCreationsDeletions: ENTRY_DELETE=chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0, chunksDeleted=1
15:52:12.905 [pool-27-thread-3] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34 into destFile a
watchForCreationsDeletions: ENTRY_DELETE=chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34, chunksDeleted=2
WatchTaskChunksToFile: length reached! length=1051002
deleteOrFail: chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0.xml
deleteOrFail: chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34.xml
15:52:13.589 [pool-27-thread-3] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="3f69d91b-32a6-44e4-98e3-80500947c2b6"] on repo=b17657db-d3d0-40e7-b70b-e58c1ffce32d
15:52:13.828 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
15:52:13.829 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
15:52:13.867 [qtp215611514-32] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=3f69d91b-32a6-44e4-98e3-80500947c2b6 remoteRepositoryId=b17657db-d3d0-40e7-b70b-e58c1ffce32d localRepositoryRevisionSynced=3
15:52:14.016 [pool-27-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b17657db-d3d0-40e7-b70b-e58c1ffce32d remoteRepositoryId=3f69d91b-32a6-44e4-98e3-80500947c2b6 transaction.localRevision=9 remoteFromLocalRevision=3
15:52:14.155 [pool-27-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=b17657db-d3d0-40e7-b70b-e58c1ffce32d from='target/repo/i448x6be-7e882-local' toID=3f69d91b-32a6-44e4-98e3-80500947c2b6 to='https://localhost:4314/3f69d91b-32a6-44e4-98e3-80500947c2b6'
15:52:14.447 [pool-27-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:52:14.452 [pool-27-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b17657db-d3d0-40e7-b70b-e58c1ffce32d
15:52:14.452 [pool-27-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 3f69d91b-32a6-44e4-98e3-80500947c2b6
15:52:14.452 [pool-27-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:52:14.452 [pool-27-thread-3] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b17657db-d3d0-40e7-b70b-e58c1ffce32d remoteRepositoryId=3f69d91b-32a6-44e4-98e3-80500947c2b6 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=9
15:52:14.460 [pool-27-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:52:14.469 [pool-27-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:52:14.469 [pool-27-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:52:14.469 [pool-27-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:52:14.469 [pool-27-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:52:14.470 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 52.24%
15:52:14.470 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 63.43%
15:52:14.470 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 74.63%
15:52:14.492 [pool-27-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b17657db-d3d0-40e7-b70b-e58c1ffce32d remoteRepositoryId=3f69d91b-32a6-44e4-98e3-80500947c2b6 localRepositoryRevisionSynced=9
15:52:14.642 [qtp215611514-32] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=3f69d91b-32a6-44e4-98e3-80500947c2b6 remoteRepositoryId=b17657db-d3d0-40e7-b70b-e58c1ffce32d transaction.localRevision=6 remoteFromLocalRevision=9
15:52:14.822 [pool-27-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=3f69d91b-32a6-44e4-98e3-80500947c2b6 from='https://localhost:4314/3f69d91b-32a6-44e4-98e3-80500947c2b6' toID=b17657db-d3d0-40e7-b70b-e58c1ffce32d to='target/repo/i448x6be-7e882-local', fromRepoLocalSync=false
15:52:14.823 [pool-27-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448x6be-7e882-local/.cloudstore-repo/tmp/ChangeSetDto.3f69d91b-32a6-44e4-98e3-80500947c2b6.null.xml.gz
15:52:15.030 [pool-6-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:52:15.032 [pool-6-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 3f69d91b-32a6-44e4-98e3-80500947c2b6
15:52:15.032 [pool-6-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: b17657db-d3d0-40e7-b70b-e58c1ffce32d
15:52:15.032 [pool-6-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:52:15.032 [pool-6-thread-6] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=3f69d91b-32a6-44e4-98e3-80500947c2b6 remoteRepositoryId=b17657db-d3d0-40e7-b70b-e58c1ffce32d localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
15:52:15.038 [pool-6-thread-6] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:52:15.040 [pool-6-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:52:15.040 [pool-6-thread-6] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:52:15.040 [pool-6-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:52:15.040 [pool-6-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:52:15.123 [pool-27-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448x6be-7e882-local/.cloudstore-repo/tmp/ChangeSetDto.3f69d91b-32a6-44e4-98e3-80500947c2b6.null.xml.gz
15:52:15.123 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
15:52:15.123 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
15:52:15.141 [qtp215611514-32] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=3f69d91b-32a6-44e4-98e3-80500947c2b6 remoteRepositoryId=b17657db-d3d0-40e7-b70b-e58c1ffce32d localRepositoryRevisionSynced=6
15:52:15.310 [pool-27-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b17657db-d3d0-40e7-b70b-e58c1ffce32d remoteRepositoryId=3f69d91b-32a6-44e4-98e3-80500947c2b6 transaction.localRevision=12 remoteFromLocalRevision=6
15:52:15.465 [pool-27-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
hasCorrectAmountOfCreationsDeletions: toBeCreated=1, chunksCreated=1, toBeDeleted=2, chunksDeleted=2
15:52:15.977 [main] INFO c.c.c.l.LocalRepoManagerImpl - [22b00077]getCloseDeferredMillis: closeDeferredMillis=20000
15:52:15.977 [main] INFO c.c.c.l.LocalRepoManagerImpl - [22b00077]close: Deferring shut down of real LocalRepoManager 20000 ms.
15:52:15.978 [main] INFO c.c.c.l.LocalRepoManagerImpl - [18f37d6e]getCloseDeferredMillis: closeDeferredMillis=20000
15:52:15.978 [main] INFO c.c.c.l.LocalRepoManagerImpl - [18f37d6e]close: Deferring shut down of real LocalRepoManager 20000 ms.
15:50:37.706 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [3e647f32]close: Closing real LocalRepoManager immediately.
15:50:37.706 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [3e647f32]_close: Shutting down real LocalRepoManager.
15:50:40.026 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr3-esaca-local/.cloudstore-repo/tmp/ChangeSetDto.7a7c66ca-dd5a-4722-8601-18657179c1a3.null.xml.gz
15:50:40.027 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 77.11%
15:50:40.027 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
15:50:40.027 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
15:50:40.034 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [205a9c4b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:50:40.035 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [205a9c4b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:50:42.110 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:50:42.231 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [205a9c4b]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:50:42.231 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [205a9c4b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2195 ms.
15:50:42.256 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [205a9c4b]getCloseDeferredMillis: closeDeferredMillis=0
15:50:42.256 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [205a9c4b]close: Closing real LocalRepoManager immediately.
15:50:42.256 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [205a9c4b]_close: Shutting down real LocalRepoManager.
15:50:43.929 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [1c2fefa2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:50:43.930 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [1c2fefa2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:50:46.004 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:50:46.124 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [1c2fefa2]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:50:46.124 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [1c2fefa2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2193 ms.
15:50:46.191 [qtp944810078-34] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 remoteRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 localRepositoryRevisionSynced=15
15:50:46.297 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [1c2fefa2]getCloseDeferredMillis: closeDeferredMillis=0
15:50:46.297 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [1c2fefa2]close: Closing real LocalRepoManager immediately.
15:50:46.297 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [1c2fefa2]_close: Shutting down real LocalRepoManager.
15:50:49.599 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 remoteRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 transaction.localRevision=94 remoteFromLocalRevision=15
15:50:49.743 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
15:50:49.743 [main] INFO c.c.c.l.LocalRepoManagerImpl - [5f1eff72]getCloseDeferredMillis: closeDeferredMillis=0
15:50:49.743 [main] INFO c.c.c.l.LocalRepoManagerImpl - [5f1eff72]close: Closing real LocalRepoManager immediately.
15:50:49.743 [main] INFO c.c.c.l.LocalRepoManagerImpl - [5f1eff72]_close: Shutting down real LocalRepoManager.
15:50:55.682 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
15:50:55.682 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restoring backup: 'target/repo/i448qjr5-bfqk6-remote.bak' => 'target/repo/i448qjr5-bfqk6-remote'
15:50:55.761 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restored backup: 'target/repo/i448qjr5-bfqk6-remote.bak' => 'target/repo/i448qjr5-bfqk6-remote'
15:50:55.761 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
15:50:55.763 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1a4340f2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr3-esaca-local'
15:50:55.763 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1a4340f2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr3-esaca-local' locked successfully.
15:50:58.185 [main] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:50:58.301 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1a4340f2]initPersistenceManagerFactory: repositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62
15:50:58.301 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1a4340f2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2536 ms.
15:50:58.772 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [183bfe32]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:50:58.773 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [183bfe32]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:01.531 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:01.656 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [183bfe32]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:01.660 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [183bfe32]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2886 ms.
15:51:01.680 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [183bfe32]getCloseDeferredMillis: closeDeferredMillis=0
15:51:01.680 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [183bfe32]close: Closing real LocalRepoManager immediately.
15:51:01.680 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [183bfe32]_close: Shutting down real LocalRepoManager.
15:51:03.578 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 0.50%
15:51:03.579 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=7a7c66ca-dd5a-4722-8601-18657179c1a3 from='https://localhost:11694/7a7c66ca-dd5a-4722-8601-18657179c1a3' toID=b2afa547-17e4-4a09-a23b-d547bf12fe62 to='target/repo/i448qjr3-esaca-local', fromRepoLocalSync=true
15:51:03.579 [pool-10-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing b2afa547-17e4-4a09-a23b-d547bf12fe62 ('target/repo/i448qjr3-esaca-local')
15:51:03.613 [pool-10-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 12.94%
15:51:03.664 [pool-10-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 19.03%
15:51:03.710 [pool-10-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 24.15%
15:51:03.749 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr3-esaca-local/.cloudstore-repo/tmp/ChangeSetDto.7a7c66ca-dd5a-4722-8601-18657179c1a3.15.xml.gz
15:51:03.756 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [68bd5bb9]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:03.756 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [68bd5bb9]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:05.946 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:06.050 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [68bd5bb9]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:06.051 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [68bd5bb9]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2294 ms.
15:51:06.095 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [68bd5bb9]getCloseDeferredMillis: closeDeferredMillis=0
15:51:06.096 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [68bd5bb9]close: Closing real LocalRepoManager immediately.
15:51:06.096 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [68bd5bb9]_close: Shutting down real LocalRepoManager.
15:51:08.023 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 serverRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 renewalDateTime=2014-12-25T15:17:23.534Z expiryDateTime=2014-12-25T15:47:23.534Z
15:51:08.030 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [5e9901a0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:08.030 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [5e9901a0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:10.696 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:10.882 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [5e9901a0]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:10.883 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [5e9901a0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2852 ms.
15:51:10.909 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [5e9901a0]getCloseDeferredMillis: closeDeferredMillis=0
15:51:10.909 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [5e9901a0]close: Closing real LocalRepoManager immediately.
15:51:10.909 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [5e9901a0]_close: Shutting down real LocalRepoManager.
15:51:13.238 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [d78ac0f]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:13.238 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [d78ac0f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:15.759 [pool-5-thread-4] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:15.878 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [d78ac0f]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:15.879 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [d78ac0f]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2640 ms.
15:51:15.897 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
15:51:15.908 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
15:51:15.927 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
15:51:15.948 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
15:51:15.954 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
15:51:15.971 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
15:51:15.993 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
15:51:16.020 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
15:51:16.033 [pool-5-thread-4] WARN c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=15 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=6
15:51:16.227 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:51:16.229 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:16.229 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: b2afa547-17e4-4a09-a23b-d547bf12fe62
15:51:16.229 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:51:16.229 [pool-5-thread-4] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 remoteRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 localRepositoryRevisionSynced=15 localRepositoryRevisionInProgress=8
15:51:16.236 [pool-5-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:51:16.242 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:51:16.242 [pool-5-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:51:16.242 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:51:16.242 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:51:16.243 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [d78ac0f]getCloseDeferredMillis: closeDeferredMillis=0
15:51:16.243 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [d78ac0f]close: Closing real LocalRepoManager immediately.
15:51:16.243 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [d78ac0f]_close: Shutting down real LocalRepoManager.
15:51:19.026 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr3-esaca-local/.cloudstore-repo/tmp/ChangeSetDto.7a7c66ca-dd5a-4722-8601-18657179c1a3.15.xml.gz
15:51:19.026 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 27.36%
15:51:19.026 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
15:51:19.027 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
15:51:19.033 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [25bb8f89]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:19.034 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [25bb8f89]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:21.249 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:21.352 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [25bb8f89]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:21.352 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [25bb8f89]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2317 ms.
15:51:21.375 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [25bb8f89]getCloseDeferredMillis: closeDeferredMillis=0
15:51:21.375 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [25bb8f89]close: Closing real LocalRepoManager immediately.
15:51:21.375 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [25bb8f89]_close: Shutting down real LocalRepoManager.
15:51:23.438 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [12a25b53]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:23.439 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [12a25b53]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:26.148 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:26.261 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [12a25b53]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:26.262 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [12a25b53]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2822 ms.
15:51:26.330 [qtp944810078-34] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 remoteRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 localRepositoryRevisionSynced=8
15:51:26.713 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [12a25b53]getCloseDeferredMillis: closeDeferredMillis=0
15:51:26.713 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [12a25b53]close: Closing real LocalRepoManager immediately.
15:51:26.713 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [12a25b53]_close: Shutting down real LocalRepoManager.
15:51:29.903 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 remoteRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 transaction.localRevision=95 remoteFromLocalRevision=8
15:51:30.158 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 50.25%
15:51:30.158 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=b2afa547-17e4-4a09-a23b-d547bf12fe62 from='target/repo/i448qjr3-esaca-local' toID=7a7c66ca-dd5a-4722-8601-18657179c1a3 to='https://localhost:11694/7a7c66ca-dd5a-4722-8601-18657179c1a3'
15:51:30.165 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6529533e]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:30.166 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6529533e]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:33.032 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:33.141 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6529533e]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:33.141 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6529533e]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2974 ms.
15:51:33.166 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6529533e]getCloseDeferredMillis: closeDeferredMillis=0
15:51:33.166 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6529533e]close: Closing real LocalRepoManager immediately.
15:51:33.166 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6529533e]_close: Shutting down real LocalRepoManager.
15:51:35.039 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [d3c96fa]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:35.040 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [d3c96fa]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:37.285 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:37.415 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [d3c96fa]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:37.415 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [d3c96fa]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2374 ms.
15:51:37.455 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [d3c96fa]getCloseDeferredMillis: closeDeferredMillis=0
15:51:37.455 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [d3c96fa]close: Closing real LocalRepoManager immediately.
15:51:37.456 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [d3c96fa]_close: Shutting down real LocalRepoManager.
15:51:39.493 [main] WARN c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=84 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=89
15:51:39.629 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:51:39.631 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b2afa547-17e4-4a09-a23b-d547bf12fe62
15:51:39.631 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:39.631 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:51:39.631 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 remoteRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=95
15:51:39.638 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:51:39.661 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:51:39.661 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:51:39.661 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:51:39.661 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:51:39.662 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 52.24%
15:51:39.662 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
15:51:39.670 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [699f2d25]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:39.671 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [699f2d25]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:42.259 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:42.388 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [699f2d25]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:42.388 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [699f2d25]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2716 ms.
15:51:42.413 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [699f2d25]getCloseDeferredMillis: closeDeferredMillis=0
15:51:42.413 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [699f2d25]close: Closing real LocalRepoManager immediately.
15:51:42.413 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [699f2d25]_close: Shutting down real LocalRepoManager.
15:51:44.311 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [65166a69]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:44.311 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [65166a69]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:46.605 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:46.736 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [65166a69]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:46.737 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [65166a69]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2425 ms.
15:51:46.987 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [65166a69]getCloseDeferredMillis: closeDeferredMillis=0
15:51:46.988 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [65166a69]close: Closing real LocalRepoManager immediately.
15:51:46.988 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [65166a69]_close: Shutting down real LocalRepoManager.
15:51:49.845 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 58.34%
15:51:49.850 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 64.45%
15:51:49.850 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 70.56%
15:51:49.851 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
15:51:49.886 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [23a9ca3e]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:49.886 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [23a9ca3e]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:52.646 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:52.776 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [23a9ca3e]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:52.777 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [23a9ca3e]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2889 ms.
15:51:52.803 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [23a9ca3e]getCloseDeferredMillis: closeDeferredMillis=0
15:51:52.803 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [23a9ca3e]close: Closing real LocalRepoManager immediately.
15:51:52.803 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [23a9ca3e]_close: Shutting down real LocalRepoManager.
15:51:54.759 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4d2fc2c1]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:54.759 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4d2fc2c1]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:51:57.209 [pool-5-thread-4] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:51:57.317 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4d2fc2c1]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:51:57.317 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4d2fc2c1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2557 ms.
15:51:57.353 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4d2fc2c1]getCloseDeferredMillis: closeDeferredMillis=0
15:51:57.353 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4d2fc2c1]close: Closing real LocalRepoManager immediately.
15:51:57.353 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4d2fc2c1]_close: Shutting down real LocalRepoManager.
15:51:59.391 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='13f2288d161717409d1d83612db49a484d7bd059' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
Dec 25, 2024 3:51:59 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
15:51:59.399 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [67768ec8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:51:59.399 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [67768ec8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:01.739 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:01.855 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [67768ec8]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:01.855 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [67768ec8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2455 ms.
15:52:01.878 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [67768ec8]getCloseDeferredMillis: closeDeferredMillis=0
15:52:01.878 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [67768ec8]close: Closing real LocalRepoManager immediately.
15:52:01.878 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [67768ec8]_close: Shutting down real LocalRepoManager.
15:52:03.998 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5469f372]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:03.998 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5469f372]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:06.056 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:06.180 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5469f372]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:06.180 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5469f372]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2181 ms.
15:52:06.895 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5469f372]getCloseDeferredMillis: closeDeferredMillis=0
15:52:06.896 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5469f372]close: Closing real LocalRepoManager immediately.
15:52:06.896 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5469f372]_close: Shutting down real LocalRepoManager.
15:52:12.023 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="b2afa547-17e4-4a09-a23b-d547bf12fe62"] on repo=b2afa547-17e4-4a09-a23b-d547bf12fe62
15:52:12.077 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
15:52:12.110 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [fa294be]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:12.110 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [fa294be]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:14.066 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:14.180 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [fa294be]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:14.181 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [fa294be]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2069 ms.
15:52:14.211 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [fa294be]getCloseDeferredMillis: closeDeferredMillis=0
15:52:14.212 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [fa294be]close: Closing real LocalRepoManager immediately.
15:52:14.212 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [fa294be]_close: Shutting down real LocalRepoManager.
15:52:16.224 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6939373b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:16.225 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6939373b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:18.322 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:18.442 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6939373b]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:18.443 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6939373b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2217 ms.
15:52:18.498 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6939373b]getCloseDeferredMillis: closeDeferredMillis=0
15:52:18.498 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6939373b]close: Closing real LocalRepoManager immediately.
15:52:18.498 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6939373b]_close: Shutting down real LocalRepoManager.
15:52:20.770 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 172704 bytes in 8693 ms. path='/3/zzz'
Dec 25, 2024 3:52:20 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
15:52:20.778 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [62122dd1]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:20.778 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [62122dd1]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:22.724 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:22.853 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [62122dd1]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:22.854 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [62122dd1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2075 ms.
15:52:22.894 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [62122dd1]getCloseDeferredMillis: closeDeferredMillis=0
15:52:22.894 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [62122dd1]close: Closing real LocalRepoManager immediately.
15:52:22.894 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [62122dd1]_close: Shutting down real LocalRepoManager.
15:52:24.907 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [39979511]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:24.908 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [39979511]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:27.259 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:27.487 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [39979511]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:49:42.193 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1aa21319]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mm-xb8wd-local'
15:49:42.195 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1aa21319]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mm-xb8wd-local' locked successfully.
15:50:02.194 [closeDeferredTimer-74cad577-1] INFO c.c.c.l.LocalRepoManagerImpl - [74cad577]_close: Shutting down real LocalRepoManager.
15:50:02.194 [closeDeferredTimer-20608ef4-1] INFO c.c.c.l.LocalRepoManagerImpl - [20608ef4]_close: Shutting down real LocalRepoManager.
15:51:14.584 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1aa21319]initPersistenceManagerFactory: repositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:51:14.750 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1aa21319]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 35925 ms.
localRoot: i448y8mm-xb8wd-local
localRepositoryId: a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:51:14.772 [main] INFO c.c.c.l.LocalRepoManagerImpl - [13ebbdab]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mn-sq2f1-remote'
15:51:14.775 [main] INFO c.c.c.l.LocalRepoManagerImpl - [13ebbdab]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mn-sq2f1-remote' locked successfully.
15:51:38.045 [CloudStoreUpdaterTimer] ERROR c.c.c.c.u.CloudStoreUpdaterCore - createUpdaterDirIfUpdateNeeded: java.lang.UnsupportedOperationException: There is no installationDir in DevMode!
java.lang.UnsupportedOperationException: There is no installationDir in DevMode!
at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.determineInstallationDirFromClass(CloudStoreUpdaterCore.java:238)
at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.getInstallationDir(CloudStoreUpdaterCore.java:231)
at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.getUpdaterDir(CloudStoreUpdaterCore.java:452)
at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.createUpdaterDirIfUpdateNeeded(CloudStoreUpdaterCore.java:409)
at co.codewizards.cloudstore.server.CloudStoreUpdaterTimer.run(CloudStoreUpdaterTimer.java:121)
at co.codewizards.cloudstore.server.CloudStoreUpdaterTimer$1.run(CloudStoreUpdaterTimer.java:81)
at java.base/java.util.TimerThread.mainLoop(Timer.java:556)
at java.base/java.util.TimerThread.run(Timer.java:506)
15:51:38.045 [CloudStoreUpdaterTimer] INFO c.c.c.s.CloudStoreUpdaterTimer - schedule: timerPeriod=900000 nextRun=Wed Dec 25 16:06:38 CET 2024
15:52:43.847 [main] INFO c.c.c.l.LocalRepoManagerImpl - [13ebbdab]initPersistenceManagerFactory: repositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc
15:52:43.988 [main] INFO c.c.c.l.LocalRepoManagerImpl - [13ebbdab]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 35948 ms.
remoteRoot: i448y8mn-sq2f1-remote
remoteRepositoryId: e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc
15:52:44.162 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=90.0 MiB, used=34.7 MiB, available=3.9 GiB
Successfully requested to connect the following local and remote repositories:
localRepository.repositoryId = a2b41b43-fe1b-4506-826a-d87e2c272cb1
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mm-xb8wd-local
localRepository.publicKeySha1 = CC:DB:FF:74:CA:10:B2:FD:B6:B3:D5:58:1E:54:B4:A0:01:C5:E6:4D
remoteRepository.repositoryId = e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc
remoteRepository.remoteRoot = https://localhost:31507/e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc
remoteRepository.publicKeySha1 = 4E:B2:04:7B:6A:F7:15:F3:93:2F:A2:EF:F1:6B:18:31:CA:7B:78:CD
Please verify the 'publicKeySha1' fingerprints! If they do not match the fingerprints shown on the server, someone is attacking you and you must cancel this request immediately! To cancel the request, use this command:
cloudstore dropRepoConnection a2b41b43-fe1b-4506-826a-d87e2c272cb1 e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc
15:52:45.207 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=90.0 MiB, used=31.7 MiB, available=3.9 GiB
Successfully accepted the connection request for the following local and remote repositories:
localRepository.repositoryId = e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mn-sq2f1-remote
localRepository.publicKeySha1 = 4E:B2:04:7B:6A:F7:15:F3:93:2F:A2:EF:F1:6B:18:31:CA:7B:78:CD
remoteRepository.repositoryId = a2b41b43-fe1b-4506-826a-d87e2c272cb1
remoteRepository.publicKeySha1 = CC:DB:FF:74:CA:10:B2:FD:B6:B3:D5:58:1E:54:B4:A0:01:C5:E6:4D
Please verify the 'publicKeySha1' fingerprints! If they do not match the fingerprints shown on the client, someone is attacking you and you must cancel this request immediately! To cancel the request, use this command:
cloudstore dropRepoConnection e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:46.137 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 0.50%
15:52:46.138 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc from='https://localhost:31507/e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc' toID=a2b41b43-fe1b-4506-826a-d87e2c272cb1 to='target/repo/i448y8mm-xb8wd-local', fromRepoLocalSync=true
15:52:46.138 [pool-10-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing a2b41b43-fe1b-4506-826a-d87e2c272cb1 ('target/repo/i448y8mm-xb8wd-local')
15:52:46.155 [pool-10-thread-1] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 12.94%
15:52:46.164 [pool-10-thread-1] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 25.12%
15:52:46.167 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mm-xb8wd-local/.cloudstore-repo/tmp/ChangeSetDto.e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc.-1.xml.gz
15:52:46.224 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 serverRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc renewalDateTime=2014-12-25T15:22:46.179Z expiryDateTime=2014-12-25T15:52:46.179Z
15:52:46.236 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
15:52:46.239 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
15:52:46.271 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.02%
15:52:46.546 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.60%
15:52:46.564 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.40%
15:52:46.631 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.20%
15:52:46.701 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.00%
15:52:47.059 [pool-5-thread-4] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
15:52:47.442 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:52:47.444 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc
15:52:47.444 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:47.444 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:52:47.444 [pool-5-thread-4] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc remoteRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
15:52:47.448 [pool-5-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:52:47.486 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:52:47.486 [pool-5-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:52:47.486 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:52:47.486 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:52:47.508 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mm-xb8wd-local/.cloudstore-repo/tmp/ChangeSetDto.e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc.-1.xml.gz
15:52:47.509 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
15:52:47.635 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/#4'
15:52:47.801 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/1 {11 11ä11#+} 1'
15:52:48.051 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 30.33%
15:52:48.052 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2'
15:52:48.250 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2/1 {11 11ä11#+} 1'
15:52:48.425 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
15:52:48.628 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/5#'
15:52:48.810 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 35.59%
15:52:48.810 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 40.86%
15:52:48.811 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/#b'
15:52:48.847 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='ce977653bd6d2874721f2f6897192528d62e2831' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/#b
15:52:49.392 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:49.583 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/#b'
15:52:49.665 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 467910 bytes in 82 ms. path='/#4/#b'
15:52:49.673 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c691e3d4c979adbf07e3b97e33fdf3c89ed246f6_0 into destFile #b
15:52:49.989 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:50.246 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/a'
15:52:50.288 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='0aab88d56f6b427a28bdfe4b71f4d4d5c963bec5' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/a
15:52:50.441 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:50.612 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/a'
15:52:50.637 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 72870 bytes in 24 ms. path='/#4/a'
15:52:50.642 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:52:50.819 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:51.005 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/c+'
15:52:51.042 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='4b6e3c0b5b8b15404074446728cb01d959c02b11' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/c+
15:52:51.196 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:51.380 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/c+'
15:52:51.450 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 399960 bytes in 70 ms. path='/#4/c+'
15:52:51.456 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_8a30244b83c6cac3c79f8f95d30f96579c0f4c0b_0 into destFile c+
15:52:51.595 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:51.815 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/d$'
15:52:51.859 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='ee8f066968498b0fb8261dd848ab4255f9ad3086' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/d$
15:52:52.148 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:52.264 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/d$'
15:52:52.298 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 115345 bytes in 34 ms. path='/#4/d$'
15:52:52.306 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_a93a212f7eca012dceb852f364cc2c34026f0dd8_0 into destFile d$
15:52:52.489 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:52.690 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/a'
15:52:52.739 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='d20c4d69a2ca0a06d6c4a912bbe4b121d5e3fc2b' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/a
15:52:52.911 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:53.073 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/1 {11 11ä11#+} 1/a'
15:52:53.140 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 240380 bytes in 67 ms. path='/1 {11 11ä11#+} 1/a'
15:52:53.145 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:52:53.267 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:53.433 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/b'
15:52:53.471 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='5dcf89e34de7eb2d863e3d8d7946190bf87c7ff5' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/b
15:52:53.624 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:53.782 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/1 {11 11ä11#+} 1/b'
15:52:53.797 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 6980 bytes in 15 ms. path='/1 {11 11ä11#+} 1/b'
15:52:53.802 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
15:52:54.008 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:54.359 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/c'
15:52:54.382 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c819a12e6dbd88070baf0d3447db2c72bd111656' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/c
15:52:54.526 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:54.696 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/1 {11 11ä11#+} 1/c'
15:52:54.773 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 443145 bytes in 77 ms. path='/1 {11 11ä11#+} 1/c'
15:52:54.778 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
15:52:54.984 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:55.122 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 43.50%
15:52:55.123 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/a'
15:52:55.163 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='79b197f515bcac089747bac5e0980216fb82bdd5' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/a
15:52:55.304 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:55.489 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/1 {11 11ä11#+} 1/a'
15:52:55.583 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 588070 bytes in 93 ms. path='/2/1 {11 11ä11#+} 1/a'
15:52:55.589 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:52:55.807 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:55.981 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/b'
15:52:56.023 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='38613bb360d16dc788806d973170e4957a6af63f' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/b
15:52:56.232 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:56.356 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/1 {11 11ä11#+} 1/b'
15:52:56.385 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 65820 bytes in 29 ms. path='/2/1 {11 11ä11#+} 1/b'
15:52:56.392 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
15:52:56.566 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:56.714 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/a'
15:52:56.753 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='26a8690ca1848c18e7122b93164654a3c2a86d04' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/a
15:52:56.927 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:57.139 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/a'
15:52:57.191 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 297996 bytes in 52 ms. path='/2/a'
15:52:57.197 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:52:57.333 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:57.507 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/a'
15:52:57.559 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='409d5ae9842aecf13915a6d688957c68b85dea5e' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/a
15:52:57.691 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:57.887 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/a'
15:52:58.019 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 918372 bytes in 132 ms. path='/3/a'
15:52:58.026 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:52:58.223 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:58.405 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/b'
15:52:58.451 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='819544907bb9c4114320c20e360634843e7eb117' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/b
15:52:58.726 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:58.897 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/b'
15:52:58.918 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 38738 bytes in 21 ms. path='/3/b'
15:52:58.923 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
15:52:59.249 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:59.440 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/c'
15:52:59.486 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='2d7f12f9d4999298b133baa8c712164e49526f7a' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/c
15:52:59.629 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:52:59.858 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/c'
15:52:59.892 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 156731 bytes in 33 ms. path='/3/c'
15:52:59.897 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
15:53:00.043 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:53:00.217 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/d'
15:53:00.258 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c8c9ed857e2d13d8c4bc0af5dea762a9daa9a046' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/d
15:53:00.380 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:53:00.576 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/d'
15:53:00.638 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 172962 bytes in 61 ms. path='/3/d'
15:53:00.647 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
15:53:00.800 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:53:01.094 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 44.48%
15:53:01.094 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/5#/e'
15:53:01.141 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='25969d82757b356d7ca55b8d77aa33e83853825d' to.sha1='<NoInstanceOf_NormalFileDto>'): /5#/e
15:53:01.327 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:53:01.513 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/5#/e'
15:53:01.535 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 33296 bytes in 22 ms. path='/5#/e'
15:53:01.541 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_58e6b3a414a1e090dfc6029add0f3555ccba127f_0 into destFile e
15:53:01.734 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc"] on repo=a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:53:01.890 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 49.75%
15:53:01.964 [qtp1082808282-34] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc remoteRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 localRepositoryRevisionSynced=3
15:53:02.103 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 remoteRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc transaction.localRevision=84 remoteFromLocalRevision=3
15:53:02.257 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=a2b41b43-fe1b-4506-826a-d87e2c272cb1 from='target/repo/i448y8mm-xb8wd-local' toID=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc to='https://localhost:31507/e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc'
15:53:02.560 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:53:02.562 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:53:02.562 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc
15:53:02.562 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:53:02.562 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 remoteRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=84
15:53:02.568 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:53:02.574 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:53:02.574 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:53:02.574 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:53:02.574 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:53:02.575 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 63.43%
15:53:02.575 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
15:53:02.589 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 remoteRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc localRepositoryRevisionSynced=84
15:53:02.736 [qtp1082808282-34] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc remoteRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 transaction.localRevision=6 remoteFromLocalRevision=84
15:53:02.921 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc from='https://localhost:31507/e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc' toID=a2b41b43-fe1b-4506-826a-d87e2c272cb1 to='target/repo/i448y8mm-xb8wd-local', fromRepoLocalSync=false
15:53:02.922 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mm-xb8wd-local/.cloudstore-repo/tmp/ChangeSetDto.e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc.null.xml.gz
15:53:03.103 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:53:03.105 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc
15:53:03.105 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: a2b41b43-fe1b-4506-826a-d87e2c272cb1
15:53:03.105 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:53:03.105 [pool-5-thread-4] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc remoteRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
15:53:03.106 [pool-5-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:53:03.107 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:53:03.107 [pool-5-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:53:03.107 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:53:03.107 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:53:03.112 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448y8mm-xb8wd-local/.cloudstore-repo/tmp/ChangeSetDto.e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc.null.xml.gz
15:53:03.112 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
15:53:03.112 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
15:53:03.124 [qtp1082808282-34] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc remoteRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 localRepositoryRevisionSynced=6
15:53:03.276 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=a2b41b43-fe1b-4506-826a-d87e2c272cb1 remoteRepositoryId=e2d6405b-8af0-47db-a3da-6e1bfb9ce9dc transaction.localRevision=87 remoteFromLocalRevision=6
15:53:03.446 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
15:53:03.574 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1aa21319]getCloseDeferredMillis: closeDeferredMillis=20000
15:53:03.574 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1aa21319]close: Deferring shut down of real LocalRepoManager 20000 ms.
15:53:03.575 [main] INFO c.c.c.l.LocalRepoManagerImpl - [13ebbdab]getCloseDeferredMillis: closeDeferredMillis=20000
15:53:03.575 [main] INFO c.c.c.l.LocalRepoManagerImpl - [13ebbdab]close: Deferring shut down of real LocalRepoManager 20000 ms.
[[1;34mINFO[m] [1;32mTests run: [0;1;32m4[m, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1,026.881 s - in co.codewizards.cloudstore.test.repotorepo.[1mBasicRepoToRepoSyncIT[m
15:52:27.488 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [39979511]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2578 ms.
15:52:27.560 [qtp944810078-34] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
15:52:28.050 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [39979511]getCloseDeferredMillis: closeDeferredMillis=0
15:52:28.050 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [39979511]close: Closing real LocalRepoManager immediately.
15:52:28.050 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [39979511]_close: Shutting down real LocalRepoManager.
15:52:32.608 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="b2afa547-17e4-4a09-a23b-d547bf12fe62"] on repo=b2afa547-17e4-4a09-a23b-d547bf12fe62
15:52:32.779 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
15:52:32.789 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 remoteRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 localRepositoryRevisionSynced=95
15:52:32.960 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [262d98b6]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:32.961 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [262d98b6]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:35.418 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:35.541 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [262d98b6]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:35.542 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [262d98b6]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2580 ms.
15:52:35.566 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [262d98b6]getCloseDeferredMillis: closeDeferredMillis=0
15:52:35.566 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [262d98b6]close: Closing real LocalRepoManager immediately.
15:52:35.566 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [262d98b6]_close: Shutting down real LocalRepoManager.
15:52:38.116 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [7b9c96a8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:38.117 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [7b9c96a8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:40.804 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:40.952 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [7b9c96a8]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:40.953 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [7b9c96a8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2833 ms.
15:52:41.010 [qtp944810078-27] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 remoteRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 transaction.localRevision=15 remoteFromLocalRevision=95
15:52:41.168 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [7b9c96a8]getCloseDeferredMillis: closeDeferredMillis=0
15:52:41.168 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [7b9c96a8]close: Closing real LocalRepoManager immediately.
15:52:41.168 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [7b9c96a8]_close: Shutting down real LocalRepoManager.
15:52:43.493 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 75.12%
15:52:43.493 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=7a7c66ca-dd5a-4722-8601-18657179c1a3 from='https://localhost:11694/7a7c66ca-dd5a-4722-8601-18657179c1a3' toID=b2afa547-17e4-4a09-a23b-d547bf12fe62 to='target/repo/i448qjr3-esaca-local', fromRepoLocalSync=false
15:52:43.494 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr3-esaca-local/.cloudstore-repo/tmp/ChangeSetDto.7a7c66ca-dd5a-4722-8601-18657179c1a3.null.xml.gz
15:52:43.502 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5e86d411]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:43.503 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5e86d411]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:46.257 [qtp944810078-34] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:46.379 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5e86d411]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:46.380 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5e86d411]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2876 ms.
15:52:46.402 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5e86d411]getCloseDeferredMillis: closeDeferredMillis=0
15:52:46.402 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5e86d411]close: Closing real LocalRepoManager immediately.
15:52:46.402 [qtp944810078-34] INFO c.c.c.l.LocalRepoManagerImpl - [5e86d411]_close: Shutting down real LocalRepoManager.
15:52:49.211 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4958b15]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:49.212 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4958b15]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:52.330 [pool-5-thread-4] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:52.448 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4958b15]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:52.448 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4958b15]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 3234 ms.
15:52:52.689 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:52:52.693 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:52.693 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: b2afa547-17e4-4a09-a23b-d547bf12fe62
15:52:52.693 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:52:52.693 [pool-5-thread-4] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 remoteRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
15:52:52.703 [pool-5-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:52:52.713 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:52:52.713 [pool-5-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:52:52.713 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:52:52.713 [pool-5-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:52:52.714 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4958b15]getCloseDeferredMillis: closeDeferredMillis=0
15:52:52.714 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4958b15]close: Closing real LocalRepoManager immediately.
15:52:52.714 [pool-5-thread-4] INFO c.c.c.l.LocalRepoManagerImpl - [4958b15]_close: Shutting down real LocalRepoManager.
15:52:56.195 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr3-esaca-local/.cloudstore-repo/tmp/ChangeSetDto.7a7c66ca-dd5a-4722-8601-18657179c1a3.null.xml.gz
15:52:56.196 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 77.11%
15:52:56.196 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
15:52:56.196 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
15:52:56.205 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6df2c5ce]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:52:56.206 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6df2c5ce]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:52:59.169 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:52:59.292 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6df2c5ce]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:52:59.292 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6df2c5ce]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 3085 ms.
15:52:59.333 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6df2c5ce]getCloseDeferredMillis: closeDeferredMillis=0
15:52:59.333 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6df2c5ce]close: Closing real LocalRepoManager immediately.
15:52:59.333 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [6df2c5ce]_close: Shutting down real LocalRepoManager.
15:53:01.890 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [4e4de598]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote'
15:53:01.891 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [4e4de598]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i448qjr5-bfqk6-remote' locked successfully.
15:53:04.361 [qtp944810078-27] WARN D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
15:53:04.523 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [4e4de598]initPersistenceManagerFactory: repositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3
15:53:04.524 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [4e4de598]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2632 ms.
15:53:04.590 [qtp944810078-27] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 remoteRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 localRepositoryRevisionSynced=15
15:53:04.703 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [4e4de598]getCloseDeferredMillis: closeDeferredMillis=0
15:53:04.703 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [4e4de598]close: Closing real LocalRepoManager immediately.
15:53:04.703 [qtp944810078-27] INFO c.c.c.l.LocalRepoManagerImpl - [4e4de598]_close: Shutting down real LocalRepoManager.
15:53:06.614 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b2afa547-17e4-4a09-a23b-d547bf12fe62 remoteRepositoryId=7a7c66ca-dd5a-4722-8601-18657179c1a3 transaction.localRevision=100 remoteFromLocalRevision=15
15:53:06.704 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
15:53:06.811 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1a4340f2]getCloseDeferredMillis: closeDeferredMillis=0
15:53:06.811 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1a4340f2]close: Closing real LocalRepoManager immediately.
15:53:06.811 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1a4340f2]_close: Shutting down real LocalRepoManager.
[[1;34mINFO[m] [1;32mTests run: [0;1;32m2[m, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1,275.689 s - in co.codewizards.cloudstore.test.repotorepo.[1mBackupRestoreRepoToRepoSyncIT[m
15:52:16.534 [main] INFO c.c.c.l.LocalRepoManagerImpl - [678f685f]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpv-p6u86-local'
15:52:16.540 [main] INFO c.c.c.l.LocalRepoManagerImpl - [678f685f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpv-p6u86-local' locked successfully.
15:52:35.983 [closeDeferredTimer-18f37d6e-1] INFO c.c.c.l.LocalRepoManagerImpl - [18f37d6e]_close: Shutting down real LocalRepoManager.
15:52:35.983 [closeDeferredTimer-22b00077-1] INFO c.c.c.l.LocalRepoManagerImpl - [22b00077]_close: Shutting down real LocalRepoManager.
15:53:30.518 [main] INFO c.c.c.l.LocalRepoManagerImpl - [678f685f]initPersistenceManagerFactory: repositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:53:30.580 [main] INFO c.c.c.l.LocalRepoManagerImpl - [678f685f]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 18300 ms.
15:53:30.612 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7cc9970a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpw-s41mf-remote'
15:53:30.616 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7cc9970a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpw-s41mf-remote' locked successfully.
15:54:31.453 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7cc9970a]initPersistenceManagerFactory: repositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51
15:54:31.509 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7cc9970a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 25206 ms.
15:54:31.766 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=97.0 MiB, used=35.5 MiB, available=3.9 GiB
Successfully requested to connect the following local and remote repositories:
localRepository.repositoryId = 2d33e696-a3a4-43ce-bee3-5cbfbf885f68
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpv-p6u86-local
localRepository.publicKeySha1 = 6C:86:37:1A:57:1A:E7:04:23:6C:E8:88:33:DE:3C:2B:BF:56:FC:4A
remoteRepository.repositoryId = b902ab3f-2581-491e-a2ee-9c7715c28b51
remoteRepository.remoteRoot = https://localhost:4314/b902ab3f-2581-491e-a2ee-9c7715c28b51
remoteRepository.publicKeySha1 = 6A:71:8B:80:38:C1:58:1C:8B:5C:DB:DE:D0:25:58:01:56:4F:E3:31
Please verify the 'publicKeySha1' fingerprints! If they do not match the fingerprints shown on the server, someone is attacking you and you must cancel this request immediately! To cancel the request, use this command:
cloudstore dropRepoConnection 2d33e696-a3a4-43ce-bee3-5cbfbf885f68 b902ab3f-2581-491e-a2ee-9c7715c28b51
15:54:32.707 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=97.0 MiB, used=31.8 MiB, available=3.9 GiB
Successfully accepted the connection request for the following local and remote repositories:
localRepository.repositoryId = b902ab3f-2581-491e-a2ee-9c7715c28b51
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpw-s41mf-remote
localRepository.publicKeySha1 = 6A:71:8B:80:38:C1:58:1C:8B:5C:DB:DE:D0:25:58:01:56:4F:E3:31
remoteRepository.repositoryId = 2d33e696-a3a4-43ce-bee3-5cbfbf885f68
remoteRepository.publicKeySha1 = 6C:86:37:1A:57:1A:E7:04:23:6C:E8:88:33:DE:3C:2B:BF:56:FC:4A
Please verify the 'publicKeySha1' fingerprints! If they do not match the fingerprints shown on the client, someone is attacking you and you must cancel this request immediately! To cancel the request, use this command:
cloudstore dropRepoConnection b902ab3f-2581-491e-a2ee-9c7715c28b51 2d33e696-a3a4-43ce-bee3-5cbfbf885f68
WatchTaskFirstWrittenChunk started
15:54:33.595 [pool-29-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
15:54:33.595 [pool-29-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b902ab3f-2581-491e-a2ee-9c7715c28b51 from='https://localhost:4314/b902ab3f-2581-491e-a2ee-9c7715c28b51' toID=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 to='target/repo/i4491jpv-p6u86-local', fromRepoLocalSync=true
15:54:33.596 [pool-30-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 2d33e696-a3a4-43ce-bee3-5cbfbf885f68 ('target/repo/i4491jpv-p6u86-local')
15:54:33.610 [pool-30-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
15:54:33.626 [pool-30-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
15:54:33.746 [pool-29-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpv-p6u86-local/.cloudstore-repo/tmp/ChangeSetDto.b902ab3f-2581-491e-a2ee-9c7715c28b51.-1.xml.gz
15:54:33.780 [pool-29-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 serverRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 renewalDateTime=2014-12-25T15:24:33.753Z expiryDateTime=2014-12-25T15:54:33.753Z
15:54:33.794 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
15:54:33.798 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
15:54:33.821 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.11%
15:54:33.826 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 60.22%
15:54:33.831 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 65.33%
15:54:33.837 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 70.44%
15:54:33.960 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
15:54:34.037 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
15:54:34.212 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:54:34.215 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b902ab3f-2581-491e-a2ee-9c7715c28b51
15:54:34.215 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:34.215 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:54:34.215 [pool-6-thread-7] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 remoteRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
15:54:34.221 [pool-6-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:54:34.249 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:54:34.249 [pool-6-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:54:34.249 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:54:34.249 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:54:34.258 [pool-29-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpv-p6u86-local/.cloudstore-repo/tmp/ChangeSetDto.b902ab3f-2581-491e-a2ee-9c7715c28b51.-1.xml.gz
15:54:34.258 [pool-29-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
15:54:34.258 [pool-29-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
15:54:34.345 [pool-29-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
15:54:34.348 [pool-29-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
15:54:34.349 [pool-29-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/f1'
15:54:34.389 [pool-29-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='a90551c4df9c7894b5a627e461c7e5fe0bca55dd' to.sha1='<NoInstanceOf_NormalFileDto>'): /f1
15:54:34.620 [pool-29-thread-2] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="b902ab3f-2581-491e-a2ee-9c7715c28b51"] on repo=2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:34.678 [pool-29-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/f1'
createTempChunkFile: f1; createNewFile=true
deleteOrFail: chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_0.xml
FileWatcher: CHUNK_SIZE reached! chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_0
WatchTaskSyncOrder: checking for name=f1 and length=1067233
15:54:35.662 [pool-29-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
15:54:35.663 [pool-29-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
15:54:35.826 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
15:54:35.827 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b902ab3f-2581-491e-a2ee-9c7715c28b51 from='https://localhost:4314/b902ab3f-2581-491e-a2ee-9c7715c28b51' toID=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 to='target/repo/i4491jpv-p6u86-local', fromRepoLocalSync=true
15:54:35.827 [pool-32-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 2d33e696-a3a4-43ce-bee3-5cbfbf885f68 ('target/repo/i4491jpv-p6u86-local')
15:54:35.833 [pool-32-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
15:54:35.838 [pool-32-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 19.03%
15:54:35.839 [pool-32-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
15:54:35.849 [pool-31-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpv-p6u86-local/.cloudstore-repo/tmp/ChangeSetDto.b902ab3f-2581-491e-a2ee-9c7715c28b51.-1.xml.gz
15:54:35.882 [pool-31-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 serverRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 renewalDateTime=2014-12-25T15:24:33.753Z expiryDateTime=2014-12-25T15:54:33.753Z
15:54:35.892 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
15:54:35.895 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
15:54:35.918 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.11%
15:54:35.935 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 66.33%
15:54:35.938 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
15:54:35.939 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 82.67%
15:54:35.956 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 87.79%
15:54:35.974 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
15:54:36.110 [pool-6-thread-7] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
15:54:36.204 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:54:36.207 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b902ab3f-2581-491e-a2ee-9c7715c28b51
15:54:36.207 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:36.207 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:54:36.207 [pool-6-thread-7] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 remoteRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=5
15:54:36.209 [pool-6-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:54:36.216 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:54:36.216 [pool-6-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:54:36.216 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:54:36.216 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:54:36.224 [pool-31-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpv-p6u86-local/.cloudstore-repo/tmp/ChangeSetDto.b902ab3f-2581-491e-a2ee-9c7715c28b51.-1.xml.gz
15:54:36.225 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
15:54:36.362 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 30.56%
15:54:36.368 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 36.96%
15:54:36.369 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/f1'
15:54:36.406 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='a90551c4df9c7894b5a627e461c7e5fe0bca55dd' to.sha1='da39a3ee5e6b4b0d3255bfef95601890afd80709'): /f1
15:54:36.417 [pool-31-thread-2] WARN c.c.c.l.t.FileRepoTransport - Unexpected state: markFileInProgress==null='false', inProgress='true' on repo=2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:36.417 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 2 total). path='/f1'
createTempChunkFile: f1; createNewFile=true
deleteOrFail: chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_mh34.xml
15:54:36.846 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 18657 bytes in 429 ms. path='/f1'
15:54:36.853 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_0 into destFile f1
WatchTaskSyncOrder: modified=f1, length=1048576
15:54:36.874 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_mh34 into destFile f1
WatchTaskSyncOrder: modified=f1, length=1067233
WatchTaskSyncOrder: length reached! currentChildFileLength=1067233, name=f1
WatchTaskSyncOrder: modified=f1, length=1067233
WatchTaskSyncOrder: length reached! currentChildFileLength=1067233, name=f1
deleteOrFail: chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_0.xml
deleteOrFail: chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_mh34.xml
WatchTaskSyncOrder: modified=f1, length=1067233
WatchTaskSyncOrder: length reached! currentChildFileLength=1067233, name=f1
15:54:37.422 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="b902ab3f-2581-491e-a2ee-9c7715c28b51"] on repo=2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:37.489 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 43.35%
15:54:37.489 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/f0'
15:54:37.521 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='987aca5739d56964d06b166fb8d3136440121ddd' to.sha1='<NoInstanceOf_NormalFileDto>'): /f0
15:54:37.605 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="b902ab3f-2581-491e-a2ee-9c7715c28b51"] on repo=2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:37.671 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/f0'
createTempChunkFile: f0; createNewFile=true
deleteOrFail: chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_0.xml
createTempChunkFile: f0; createNewFile=true
deleteOrFail: chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_mh34.xml
15:54:38.712 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1064683 bytes in 1041 ms. path='/f0'
15:54:38.717 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_0 into destFile f0
WatchTaskSyncOrder: checking for name=f0 and length=1064683
WatchTaskSyncOrder: modified=f0, length=1048576
15:54:38.728 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_mh34 into destFile f0
deleteOrFail: chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_0.xml
WatchTaskSyncOrder: modified=f0, length=1064683
WatchTaskSyncOrder: length reached! currentChildFileLength=1064683, name=f0
deleteOrFail: chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_mh34.xml
WatchTaskSyncOrder: modified=f0, length=1064683
WatchTaskSyncOrder: length reached! currentChildFileLength=1064683, name=f0
15:54:39.323 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="b902ab3f-2581-491e-a2ee-9c7715c28b51"] on repo=2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:39.398 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/f2'
15:54:39.436 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='17d9e4b7703640d0ab64f586286f729879683bc2' to.sha1='<NoInstanceOf_NormalFileDto>'): /f2
15:54:39.545 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="b902ab3f-2581-491e-a2ee-9c7715c28b51"] on repo=2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:39.605 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/f2'
createTempChunkFile: f2; createNewFile=true
deleteOrFail: chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_0.xml
createTempChunkFile: f2; createNewFile=true
deleteOrFail: chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_mh34.xml
15:54:40.696 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1066473 bytes in 1090 ms. path='/f2'
15:54:40.702 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_0 into destFile f2
WatchTaskSyncOrder: checking for name=f2 and length=1066473
WatchTaskSyncOrder: modified=f2, length=1048576
15:54:40.717 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_mh34 into destFile f2
WatchTaskSyncOrder: modified=f2, length=1066473
WatchTaskSyncOrder: length reached! currentChildFileLength=1066473, name=f2
WatchTaskSyncOrder: finished all
deleteOrFail: chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_0.xml
deleteOrFail: chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_mh34.xml
15:54:41.241 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="b902ab3f-2581-491e-a2ee-9c7715c28b51"] on repo=2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:41.299 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 49.75%
15:54:41.328 [qtp215611514-113] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 remoteRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 localRepositoryRevisionSynced=5
15:54:41.471 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 remoteRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 transaction.localRevision=20 remoteFromLocalRevision=5
15:54:41.525 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 from='target/repo/i4491jpv-p6u86-local' toID=b902ab3f-2581-491e-a2ee-9c7715c28b51 to='https://localhost:4314/b902ab3f-2581-491e-a2ee-9c7715c28b51'
15:54:41.673 [pool-31-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:54:41.677 [pool-31-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:41.677 [pool-31-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: b902ab3f-2581-491e-a2ee-9c7715c28b51
15:54:41.677 [pool-31-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:54:41.677 [pool-31-thread-2] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 remoteRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=20
15:54:41.684 [pool-31-thread-2] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:54:41.691 [pool-31-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:54:41.691 [pool-31-thread-2] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:54:41.691 [pool-31-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:54:41.691 [pool-31-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:54:41.691 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 63.43%
15:54:41.691 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 74.63%
15:54:41.707 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 remoteRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 localRepositoryRevisionSynced=20
15:54:41.782 [qtp215611514-113] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 remoteRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 transaction.localRevision=8 remoteFromLocalRevision=20
15:54:41.842 [pool-31-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b902ab3f-2581-491e-a2ee-9c7715c28b51 from='https://localhost:4314/b902ab3f-2581-491e-a2ee-9c7715c28b51' toID=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 to='target/repo/i4491jpv-p6u86-local', fromRepoLocalSync=false
15:54:41.842 [pool-31-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpv-p6u86-local/.cloudstore-repo/tmp/ChangeSetDto.b902ab3f-2581-491e-a2ee-9c7715c28b51.null.xml.gz
15:54:41.916 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:54:41.919 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b902ab3f-2581-491e-a2ee-9c7715c28b51
15:54:41.919 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 2d33e696-a3a4-43ce-bee3-5cbfbf885f68
15:54:41.919 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:54:41.919 [pool-6-thread-7] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 remoteRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 localRepositoryRevisionSynced=5 localRepositoryRevisionInProgress=8
15:54:41.921 [pool-6-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:54:41.923 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:54:41.923 [pool-6-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:54:41.923 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:54:41.923 [pool-6-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:54:41.928 [pool-31-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4491jpv-p6u86-local/.cloudstore-repo/tmp/ChangeSetDto.b902ab3f-2581-491e-a2ee-9c7715c28b51.null.xml.gz
15:54:41.929 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
15:54:41.929 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
15:54:41.948 [qtp215611514-113] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 remoteRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 localRepositoryRevisionSynced=8
15:54:42.015 [pool-31-thread-2] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=2d33e696-a3a4-43ce-bee3-5cbfbf885f68 remoteRepositoryId=b902ab3f-2581-491e-a2ee-9c7715c28b51 transaction.localRevision=23 remoteFromLocalRevision=8
15:54:42.074 [pool-31-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
15:54:42.104 [main] INFO c.c.c.l.LocalRepoManagerImpl - [678f685f]getCloseDeferredMillis: closeDeferredMillis=20000
15:54:42.104 [main] INFO c.c.c.l.LocalRepoManagerImpl - [678f685f]close: Deferring shut down of real LocalRepoManager 20000 ms.
15:54:42.105 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7cc9970a]getCloseDeferredMillis: closeDeferredMillis=20000
15:54:42.105 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7cc9970a]close: Deferring shut down of real LocalRepoManager 20000 ms.
15:54:42.654 [main] INFO c.c.c.l.LocalRepoManagerImpl - [56584f06]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-9efrj-local'
15:54:42.660 [main] INFO c.c.c.l.LocalRepoManagerImpl - [56584f06]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-9efrj-local' locked successfully.
15:55:02.106 [closeDeferredTimer-678f685f-1] INFO c.c.c.l.LocalRepoManagerImpl - [678f685f]_close: Shutting down real LocalRepoManager.
15:55:02.106 [closeDeferredTimer-7cc9970a-1] INFO c.c.c.l.LocalRepoManagerImpl - [7cc9970a]_close: Shutting down real LocalRepoManager.
15:55:34.033 [main] INFO c.c.c.l.LocalRepoManagerImpl - [56584f06]initPersistenceManagerFactory: repositoryId=fc0be298-c9de-448e-a03e-b3b517344d89
15:55:34.092 [main] INFO c.c.c.l.LocalRepoManagerImpl - [56584f06]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 21060 ms.
15:55:34.134 [main] INFO c.c.c.l.LocalRepoManagerImpl - [36d28b4c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-5cwvm-remote'
15:55:34.139 [main] INFO c.c.c.l.LocalRepoManagerImpl - [36d28b4c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-5cwvm-remote' locked successfully.
15:55:38.815 [CloudStoreUpdaterTimer] ERROR c.c.c.c.u.CloudStoreUpdaterCore - createUpdaterDirIfUpdateNeeded: java.lang.UnsupportedOperationException: There is no installationDir in DevMode!
java.lang.UnsupportedOperationException: There is no installationDir in DevMode!
at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.determineInstallationDirFromClass(CloudStoreUpdaterCore.java:238)
at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.getInstallationDir(CloudStoreUpdaterCore.java:231)
at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.getUpdaterDir(CloudStoreUpdaterCore.java:452)
at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.createUpdaterDirIfUpdateNeeded(CloudStoreUpdaterCore.java:409)
at co.codewizards.cloudstore.server.CloudStoreUpdaterTimer.run(CloudStoreUpdaterTimer.java:121)
at co.codewizards.cloudstore.server.CloudStoreUpdaterTimer$1.run(CloudStoreUpdaterTimer.java:81)
at java.base/java.util.TimerThread.mainLoop(Timer.java:556)
at java.base/java.util.TimerThread.run(Timer.java:506)
15:55:38.816 [CloudStoreUpdaterTimer] INFO c.c.c.s.CloudStoreUpdaterTimer - schedule: timerPeriod=900000 nextRun=Wed Dec 25 16:10:38 CET 2024
15:56:15.489 [main] INFO c.c.c.l.LocalRepoManagerImpl - [36d28b4c]initPersistenceManagerFactory: repositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf
15:56:15.562 [main] INFO c.c.c.l.LocalRepoManagerImpl - [36d28b4c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 17455 ms.
15:56:15.871 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=97.0 MiB, used=37.5 MiB, available=3.9 GiB
Successfully requested to connect the following local and remote repositories:
localRepository.repositoryId = fc0be298-c9de-448e-a03e-b3b517344d89
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-9efrj-local
localRepository.publicKeySha1 = 3C:6F:3C:69:1D:EC:F0:94:6A:14:17:A0:40:12:E8:23:92:4D:88:AA
remoteRepository.repositoryId = fcbd6aa4-96e3-4e66-bdee-09deb8d087cf
remoteRepository.remoteRoot = https://localhost:4314/fcbd6aa4-96e3-4e66-bdee-09deb8d087cf
remoteRepository.publicKeySha1 = DA:24:D1:BD:0B:6D:7E:88:FD:BA:76:7A:85:F7:74:2B:D8:26:79:67
Please verify the 'publicKeySha1' fingerprints! If they do not match the fingerprints shown on the server, someone is attacking you and you must cancel this request immediately! To cancel the request, use this command:
cloudstore dropRepoConnection fc0be298-c9de-448e-a03e-b3b517344d89 fcbd6aa4-96e3-4e66-bdee-09deb8d087cf
15:56:16.728 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=97.0 MiB, used=34.6 MiB, available=3.9 GiB
Successfully accepted the connection request for the following local and remote repositories:
localRepository.repositoryId = fcbd6aa4-96e3-4e66-bdee-09deb8d087cf
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-5cwvm-remote
localRepository.publicKeySha1 = DA:24:D1:BD:0B:6D:7E:88:FD:BA:76:7A:85:F7:74:2B:D8:26:79:67
remoteRepository.repositoryId = fc0be298-c9de-448e-a03e-b3b517344d89
remoteRepository.publicKeySha1 = 3C:6F:3C:69:1D:EC:F0:94:6A:14:17:A0:40:12:E8:23:92:4D:88:AA
Please verify the 'publicKeySha1' fingerprints! If they do not match the fingerprints shown on the client, someone is attacking you and you must cancel this request immediately! To cancel the request, use this command:
cloudstore dropRepoConnection fcbd6aa4-96e3-4e66-bdee-09deb8d087cf fc0be298-c9de-448e-a03e-b3b517344d89
WatchTaskFirstWrittenChunk started
15:56:17.663 [pool-33-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
15:56:17.664 [pool-33-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf from='https://localhost:4314/fcbd6aa4-96e3-4e66-bdee-09deb8d087cf' toID=fc0be298-c9de-448e-a03e-b3b517344d89 to='target/repo/i4494ogp-9efrj-local', fromRepoLocalSync=true
15:56:17.665 [pool-34-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing fc0be298-c9de-448e-a03e-b3b517344d89 ('target/repo/i4494ogp-9efrj-local')
15:56:17.679 [pool-34-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
15:56:17.697 [pool-34-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
15:56:17.782 [pool-33-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-9efrj-local/.cloudstore-repo/tmp/ChangeSetDto.fcbd6aa4-96e3-4e66-bdee-09deb8d087cf.-1.xml.gz
15:56:17.817 [pool-33-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 serverRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf renewalDateTime=2014-12-25T15:26:17.790Z expiryDateTime=2014-12-25T15:56:17.790Z
15:56:17.827 [pool-6-thread-8] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
15:56:17.831 [pool-6-thread-8] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
15:56:17.854 [pool-6-thread-8] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.13%
15:56:17.859 [pool-6-thread-8] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 60.27%
15:56:17.864 [pool-6-thread-8] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 65.40%
15:56:17.869 [pool-6-thread-8] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 70.53%
15:56:17.972 [pool-6-thread-8] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
15:56:18.047 [pool-6-thread-8] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
15:56:18.197 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:56:18.200 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: fcbd6aa4-96e3-4e66-bdee-09deb8d087cf
15:56:18.201 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: fc0be298-c9de-448e-a03e-b3b517344d89
15:56:18.201 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:56:18.201 [pool-6-thread-8] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf remoteRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
15:56:18.207 [pool-6-thread-8] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:56:18.231 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:56:18.231 [pool-6-thread-8] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:56:18.231 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:56:18.231 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:56:18.238 [pool-33-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-9efrj-local/.cloudstore-repo/tmp/ChangeSetDto.fcbd6aa4-96e3-4e66-bdee-09deb8d087cf.-1.xml.gz
15:56:18.238 [pool-33-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
15:56:18.238 [pool-33-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
15:56:18.314 [pool-33-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
15:56:18.316 [pool-33-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
15:56:18.316 [pool-33-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
15:56:18.351 [pool-33-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='b607c549aef8966db47f662bde7e3de2fd113b8f' to.sha1='<NoInstanceOf_NormalFileDto>'): /d
15:56:18.557 [pool-33-thread-2] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="fcbd6aa4-96e3-4e66-bdee-09deb8d087cf"] on repo=fc0be298-c9de-448e-a03e-b3b517344d89
15:56:18.615 [pool-33-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
createTempChunkFile: d; createNewFile=true
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
FileWatcher: CHUNK_SIZE reached! chunk_3c363836cf4e16666669a25da280a1865c2d2874_0
15:56:19.178 [pool-33-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
15:56:19.179 [pool-33-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
WatchTaskChunksToFile: ready
15:56:19.459 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
15:56:19.460 [pool-35-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf from='https://localhost:4314/fcbd6aa4-96e3-4e66-bdee-09deb8d087cf' toID=fc0be298-c9de-448e-a03e-b3b517344d89 to='target/repo/i4494ogp-9efrj-local', fromRepoLocalSync=true
15:56:19.460 [pool-36-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing fc0be298-c9de-448e-a03e-b3b517344d89 ('target/repo/i4494ogp-9efrj-local')
15:56:19.465 [pool-36-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
15:56:19.476 [pool-36-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 19.03%
15:56:19.478 [pool-36-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
15:56:19.720 [pool-35-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Read ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-9efrj-local/.cloudstore-repo/tmp/ChangeSetDto.fcbd6aa4-96e3-4e66-bdee-09deb8d087cf.-1.xml.gz
15:56:19.720 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
15:56:19.721 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
15:56:19.726 [pool-35-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
15:56:19.759 [pool-35-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 serverRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf renewalDateTime=2014-12-25T15:26:17.790Z expiryDateTime=2014-12-25T15:56:17.790Z
15:56:19.794 [pool-35-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='b607c549aef8966db47f662bde7e3de2fd113b8f' to.sha1='da39a3ee5e6b4b0d3255bfef95601890afd80709'): /d
15:56:19.804 [pool-35-thread-3] WARN c.c.c.l.t.FileRepoTransport - Unexpected state: markFileInProgress==null='false', inProgress='true' on repo=fc0be298-c9de-448e-a03e-b3b517344d89
15:56:19.804 [pool-35-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_0, chunksCreated=1
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksCreated=2
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
15:56:20.822 [pool-35-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1062096 bytes in 1018 ms. path='/d'
15:56:20.828 [pool-35-thread-3] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_0, chunksDeleted=1
15:56:20.844 [pool-35-thread-3] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34 into destFile d
WatchTaskChunksToFile: length reached! length=1062096
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksDeleted=2
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
15:56:21.435 [pool-35-thread-3] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="fcbd6aa4-96e3-4e66-bdee-09deb8d087cf"] on repo=fc0be298-c9de-448e-a03e-b3b517344d89
15:56:21.499 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
15:56:21.499 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
15:56:21.529 [qtp215611514-202] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf remoteRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 localRepositoryRevisionSynced=3
15:56:21.593 [pool-35-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 remoteRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf transaction.localRevision=10 remoteFromLocalRevision=3
15:56:21.651 [pool-35-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=fc0be298-c9de-448e-a03e-b3b517344d89 from='target/repo/i4494ogp-9efrj-local' toID=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf to='https://localhost:4314/fcbd6aa4-96e3-4e66-bdee-09deb8d087cf'
15:56:21.792 [pool-35-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:56:21.795 [pool-35-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: fc0be298-c9de-448e-a03e-b3b517344d89
15:56:21.795 [pool-35-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: fcbd6aa4-96e3-4e66-bdee-09deb8d087cf
15:56:21.795 [pool-35-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:56:21.795 [pool-35-thread-3] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 remoteRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=10
15:56:21.802 [pool-35-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:56:21.816 [pool-35-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:56:21.816 [pool-35-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:56:21.816 [pool-35-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:56:21.816 [pool-35-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:56:21.817 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 52.24%
15:56:21.817 [pool-35-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
15:56:21.917 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 61.19%
15:56:21.919 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 70.15%
15:56:21.936 [pool-35-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 remoteRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf localRepositoryRevisionSynced=10
15:56:22.009 [qtp215611514-33] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf remoteRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 transaction.localRevision=7 remoteFromLocalRevision=10
15:56:22.070 [pool-35-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf from='https://localhost:4314/fcbd6aa4-96e3-4e66-bdee-09deb8d087cf' toID=fc0be298-c9de-448e-a03e-b3b517344d89 to='target/repo/i4494ogp-9efrj-local', fromRepoLocalSync=false
15:56:22.070 [pool-35-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-9efrj-local/.cloudstore-repo/tmp/ChangeSetDto.fcbd6aa4-96e3-4e66-bdee-09deb8d087cf.null.xml.gz
15:56:22.142 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:56:22.145 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: fcbd6aa4-96e3-4e66-bdee-09deb8d087cf
15:56:22.145 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: fc0be298-c9de-448e-a03e-b3b517344d89
15:56:22.145 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:56:22.145 [pool-6-thread-8] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf remoteRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=7
15:56:22.146 [pool-6-thread-8] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:56:22.148 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:56:22.148 [pool-6-thread-8] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:56:22.148 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:56:22.148 [pool-6-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:56:22.153 [pool-35-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/i4494ogp-9efrj-local/.cloudstore-repo/tmp/ChangeSetDto.fcbd6aa4-96e3-4e66-bdee-09deb8d087cf.null.xml.gz
15:56:22.153 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 77.11%
15:56:22.153 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
15:56:22.153 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
15:56:22.169 [qtp215611514-33] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf remoteRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 localRepositoryRevisionSynced=7
15:56:22.231 [pool-35-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fc0be298-c9de-448e-a03e-b3b517344d89 remoteRepositoryId=fcbd6aa4-96e3-4e66-bdee-09deb8d087cf transaction.localRevision=13 remoteFromLocalRevision=7
15:56:22.283 [pool-35-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
hasCorrectAmountOfCreationsDeletions: toBeCreated=2, chunksCreated=2, toBeDeleted=2, chunksDeleted=2
15:56:22.800 [main] INFO c.c.c.l.LocalRepoManagerImpl - [56584f06]getCloseDeferredMillis: closeDeferredMillis=20000
15:56:22.800 [main] INFO c.c.c.l.LocalRepoManagerImpl - [56584f06]close: Deferring shut down of real LocalRepoManager 20000 ms.
15:56:22.801 [main] INFO c.c.c.l.LocalRepoManagerImpl - [36d28b4c]getCloseDeferredMillis: closeDeferredMillis=20000
15:56:22.801 [main] INFO c.c.c.l.LocalRepoManagerImpl - [36d28b4c]close: Deferring shut down of real LocalRepoManager 20000 ms.
[[1;34mINFO[m] [1;32mTests run: [0;1;32m8[m, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1,909.498 s - in co.codewizards.cloudstore.test.[1mSyncAbortIT[m
[[1;34mINFO[m]
[[1;34mINFO[m] Results:
[[1;34mINFO[m]
[[1;33mWARNING[m] [1;33mTests run: 52, Failures: 0, Errors: 0, Skipped: 1[m
[[1;34mINFO[m]
[JENKINS] Recording test results
[[1;34mINFO[m]
[[1;34mINFO[m] [1m--- [0;32mmaven-source-plugin:3.2.1:jar-no-fork[m [1m(attach-sources)[m @ [36mco.codewizards.cloudstore.test[0;1m ---[m
[[1;34mINFO[m] Building jar: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT-sources.jar
[[1;34mINFO[m]
[[1;34mINFO[m] [1m--- [0;32mmaven-failsafe-plugin:3.0.0-M5:verify[m [1m(default)[m @ [36mco.codewizards.cloudstore.test[0;1m ---[m
[JENKINS] Recording test results
[[1;34mINFO[m]
[[1;34mINFO[m] [1m--- [0;32mmaven-install-plugin:2.4:install[m [1m(default-install)[m @ [36mco.codewizards.cloudstore.test[0;1m ---[m
[[1;34mINFO[m] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT.jar
[[1;34mINFO[m] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/pom.xml to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT.pom
[[1;34mINFO[m] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT-sources.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT-sources.jar
[[1;34mINFO[m]
[[1;34mINFO[m] [1m--- [0;32mmaven-deploy-plugin:2.7:deploy[m [1m(default-deploy)[m @ [36mco.codewizards.cloudstore.test[0;1m ---[m
[[1;34mINFO[m] Downloading from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml
[[1;34mINFO[m] Downloaded from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml (1.0 kB at 54 kB/s)
[[1;34mINFO[m] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20241225.145624-7.jar
[[1;34mINFO[m] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20241225.145624-7.jar (7.3 kB at 7.3 MB/s)
[[1;34mINFO[m] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20241225.145624-7.pom
[[1;34mINFO[m] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20241225.145624-7.pom (5.3 kB at 5.3 MB/s)
[[1;34mINFO[m] Downloading from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
[[1;34mINFO[m] Downloaded from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (315 B at 32 kB/s)
[[1;34mINFO[m] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml
[[1;34mINFO[m] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml (1.0 kB at 1.0 MB/s)
[[1;34mINFO[m] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
[[1;34mINFO[m] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (315 B at 158 kB/s)
[[1;34mINFO[m] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20241225.145624-7-sources.jar
[[1;34mINFO[m] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20241225.145624-7-sources.jar (5.0 kB at 5.0 MB/s)
[[1;34mINFO[m] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml
[[1;34mINFO[m] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml (1.0 kB at 1.0 MB/s)
[[1;34mINFO[m]
[[1;34mINFO[m] [1m--- [0;32mmaven-site-plugin:3.3:site[m [1m(default-site)[m @ [36mco.codewizards.cloudstore.test[0;1m ---[m
[[1;34mINFO[m] Relativizing decoration links with respect to project URL: http://cloudstore.codewizards.co/co.codewizards.cloudstore.test
[[1;34mINFO[m] Rendering site with org.apache.maven.skins:maven-default-skin:jar:1.0 skin.
[[1;34mINFO[m] Relativizing decoration links with respect to project URL: http://cloudstore.codewizards.co/co.codewizards.cloudstore.test/de
[[1;34mINFO[m] Rendering site with org.apache.maven.skins:maven-default-skin:jar:1.0 skin.
[JENKINS] Archiving site from /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/site to /home/tomcat/.jenkins/jobs/co.codewizards.cloudstore_java_11/site/co.codewizards.cloudstore.test
[[1;34mINFO[m]
[[1;34mINFO[m] [1m>>> [0;32mmaven-javadoc-plugin:3.1.1:javadoc[m [1m(javadoc-generate-unfiltered)[0;1m > [0;1mgenerate-sources[m @ [36mco.codewizards.cloudstore.test[0;1m >>>[m
[WARNING] Failed to getClass for org.apache.maven.plugins.javadoc.JavadocReport
[JENKINS] Archiving javadoc
[[1;34mINFO[m]
[[1;34mINFO[m] [1m<<< [0;32mmaven-javadoc-plugin:3.1.1:javadoc[m [1m(javadoc-generate-unfiltered)[0;1m < [0;1mgenerate-sources[m @ [36mco.codewizards.cloudstore.test[0;1m <<<[m
[[1;34mINFO[m]
[[1;34mINFO[m]
[[1;34mINFO[m] [1m--- [0;32mmaven-javadoc-plugin:3.1.1:javadoc[m [1m(javadoc-generate-unfiltered)[m @ [36mco.codewizards.cloudstore.test[0;1m ---[m
[[1;34mINFO[m] Skipping javadoc generation
[JENKINS] Archiving javadoc
[[1;34mINFO[m]
[[1;34mINFO[m] [1m--- [0;32mmaven-resources-plugin:2.6:copy-resources[m [1m(javadoc-filter)[m @ [36mco.codewizards.cloudstore.test[0;1m ---[m
[[1;34mINFO[m] Using 'UTF-8' encoding to copy filtered resources.
[[1;34mINFO[m] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/javadoc.unfiltered
[[1;34mINFO[m] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/javadoc.unfiltered
[[1;34mINFO[m]
[[1;34mINFO[m] [1m--- [0;32mmaven-resources-plugin:2.6:copy-resources[m [1m(javadoc-copy-to-site)[m @ [36mco.codewizards.cloudstore.test[0;1m ---[m
[[1;34mINFO[m] Using 'UTF-8' encoding to copy filtered resources.
[[1;34mINFO[m] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/apidocs
[[1;34mINFO[m]
[[1;34mINFO[m] [1m--- [0;32mmaven-site-plugin:3.3:deploy[m [1m(default-deploy)[m @ [36mco.codewizards.cloudstore.test[0;1m ---[m
file:/tmp/cloudstore-junk/ - Session: Opened
[[1;34mINFO[m] Pushing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/site
[[1;34mINFO[m] >>> to file:/tmp/cloudstore-junk/co.codewizards.cloudstore.test
[[1;34mINFO[m] >>> to file:/tmp/cloudstore-junk/de/co.codewizards.cloudstore.test
file:/tmp/cloudstore-junk/ - Session: Disconnecting
file:/tmp/cloudstore-junk/ - Session: Disconnected
|
Help us localize this page