|  Console Output
Skipping 1,590 KB.. Full Logjenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q03p3-valbh-local/.cloudstore-repo/tmp/ChangeSetDto.eb3957b1-d362-4616-abfb-f7df3ae8265a.-1.xml.gz
10:43:07.003 [pool-32-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 serverRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a renewalDateTime=2019-08-11T09:13:06.960Z expiryDateTime=2019-08-11T09:43:06.960Z
10:43:07.019 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
10:43:07.030 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
10:43:07.050 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.17%
10:43:07.055 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 60.34%
10:43:07.060 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 65.50%
10:43:07.065 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 70.67%
10:43:07.125 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
10:43:07.190 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
10:43:07.298 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:07.303 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: eb3957b1-d362-4616-abfb-f7df3ae8265a
10:43:07.303 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 6262d2eb-c3fa-4cdc-a7e0-509601e16984
10:43:07.303 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:07.303 [pool-5-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a remoteRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
10:43:07.310 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:07.337 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:07.338 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:07.338 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:07.338 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:07.347 [pool-32-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q03p3-valbh-local/.cloudstore-repo/tmp/ChangeSetDto.eb3957b1-d362-4616-abfb-f7df3ae8265a.-1.xml.gz
10:43:07.347 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
10:43:07.348 [pool-32-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
10:43:07.382 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
10:43:07.385 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
10:43:07.385 [pool-32-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
10:43:07.446 [pool-32-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='656cc02360af1bd3e81273bb0349ce84678f3b0b' to.sha1='<NoInstanceOf_NormalFileDto>'): /d
10:43:07.547 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
10:43:07.547 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Creating backup: 'target/repo/jz6pzwm5-3lk9u-remote' => 'target/repo/jz6pzwm5-3lk9u-remote.bak'
10:43:07.553 [pool-32-thread-2] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="eb3957b1-d362-4616-abfb-f7df3ae8265a"] on repo=6262d2eb-c3fa-4cdc-a7e0-509601e16984
10:43:07.556 [pool-32-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
10:43:07.630 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Created backup: 'target/repo/jz6pzwm5-3lk9u-remote' => 'target/repo/jz6pzwm5-3lk9u-remote.bak'
10:43:07.630 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
10:43:07.631 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6b2efcae]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local'
10:43:07.631 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6b2efcae]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local' locked successfully.
createTempChunkFile: d; createNewFile=true
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
FileWatcher: CHUNK_SIZE reached! chunk_3c363836cf4e16666669a25da280a1865c2d2874_0
WatchTaskChunksToFile: ready
10:43:08.471 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
10:43:08.471 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
10:43:08.568 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
10:43:08.578 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=eb3957b1-d362-4616-abfb-f7df3ae8265a from='https://localhost:43805/eb3957b1-d362-4616-abfb-f7df3ae8265a' toID=6262d2eb-c3fa-4cdc-a7e0-509601e16984 to='target/repo/jz6q03p3-valbh-local', fromRepoLocalSync=true
10:43:08.578 [pool-35-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 6262d2eb-c3fa-4cdc-a7e0-509601e16984 ('target/repo/jz6q03p3-valbh-local')
10:43:08.583 [pool-35-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
10:43:08.597 [pool-35-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 19.03%
10:43:08.599 [pool-35-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
10:43:08.674 [pool-34-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Read ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q03p3-valbh-local/.cloudstore-repo/tmp/ChangeSetDto.eb3957b1-d362-4616-abfb-f7df3ae8265a.-1.xml.gz
10:43:08.675 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
10:43:08.675 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
10:43:08.681 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
10:43:08.742 [pool-34-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 serverRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a renewalDateTime=2019-08-11T09:13:06.960Z expiryDateTime=2019-08-11T09:43:06.960Z
10:43:08.822 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='656cc02360af1bd3e81273bb0349ce84678f3b0b' to.sha1='da39a3ee5e6b4b0d3255bfef95601890afd80709'): /d
10:43:08.833 [pool-34-thread-3] WARN c.c.c.l.t.FileRepoTransport - Unexpected state: markFileInProgress==null='false', inProgress='true' on repo=6262d2eb-c3fa-4cdc-a7e0-509601e16984
10:43:08.834 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
10:43:08.952 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6b2efcae]initPersistenceManagerFactory: repositoryId=156ed437-7345-45ea-ac5c-aa4487361402
10:43:08.953 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6b2efcae]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1321 ms.
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_0, chunksCreated=1
10:43:09.113 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [394f3503]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:09.113 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [394f3503]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksCreated=2
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
10:43:09.763 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [394f3503]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:09.764 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [394f3503]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 650 ms.
10:43:09.789 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [394f3503]getCloseDeferredMillis: closeDeferredMillis=0
10:43:09.789 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [394f3503]close: Closing real LocalRepoManager immediately.
10:43:09.789 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [394f3503]_close: Shutting down real LocalRepoManager.
10:43:09.849 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1055012 bytes in 1015 ms. path='/d'
10:43:09.854 [pool-34-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
10:43:09.872 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34 into destFile d
WatchTaskChunksToFile: length reached! length=1055012
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksDeleted=2
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
10:43:10.211 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 0.50%
10:43:10.212 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=c12a8d09-7654-49e6-85f6-d00716f5a585 from='https://localhost:33785/c12a8d09-7654-49e6-85f6-d00716f5a585' toID=156ed437-7345-45ea-ac5c-aa4487361402 to='target/repo/jz6pzwm4-rwq2q-local', fromRepoLocalSync=true
10:43:10.212 [pool-8-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 156ed437-7345-45ea-ac5c-aa4487361402 ('target/repo/jz6pzwm4-rwq2q-local')
10:43:10.252 [pool-8-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 12.94%
10:43:10.257 [main] INFO c.c.c.l.LocalRepoManagerImpl - [5f1dadf4]initPersistenceManagerFactory: repositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:10.261 [main] INFO c.c.c.l.LocalRepoManagerImpl - [5f1dadf4]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 3751 ms.
localRoot: jz6q0cwx-aeb4e-local
localRepositoryId: 9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:10.294 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7f19430f]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q0cwy-8woi4-remote'
10:43:10.298 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7f19430f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q0cwy-8woi4-remote' locked successfully.
10:43:10.342 [pool-8-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 19.03%
10:43:10.384 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="eb3957b1-d362-4616-abfb-f7df3ae8265a"] on repo=6262d2eb-c3fa-4cdc-a7e0-509601e16984
10:43:10.422 [pool-8-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 24.15%
10:43:10.427 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
10:43:10.427 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
10:43:10.472 [qtp1891569057-24] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a remoteRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 localRepositoryRevisionSynced=3
10:43:10.548 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 remoteRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a transaction.localRevision=10 remoteFromLocalRevision=3
10:43:10.553 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=6262d2eb-c3fa-4cdc-a7e0-509601e16984 from='target/repo/jz6q03p3-valbh-local' toID=eb3957b1-d362-4616-abfb-f7df3ae8265a to='https://localhost:43805/eb3957b1-d362-4616-abfb-f7df3ae8265a'
10:43:10.604 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local/.cloudstore-repo/tmp/ChangeSetDto.c12a8d09-7654-49e6-85f6-d00716f5a585.6.xml.gz
10:43:10.615 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:10.624 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [5311afc2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:10.624 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 6262d2eb-c3fa-4cdc-a7e0-509601e16984
10:43:10.624 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [5311afc2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:10.625 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: eb3957b1-d362-4616-abfb-f7df3ae8265a
10:43:10.625 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:10.625 [pool-34-thread-3] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 remoteRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=10
10:43:10.635 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:10.659 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:10.659 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:10.659 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:10.659 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:10.660 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 52.24%
10:43:10.661 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
10:43:10.718 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 61.19%
10:43:10.723 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 70.15%
10:43:10.746 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 remoteRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a localRepositoryRevisionSynced=10
10:43:10.783 [qtp1891569057-51] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a remoteRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 transaction.localRevision=7 remoteFromLocalRevision=10
10:43:10.789 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=eb3957b1-d362-4616-abfb-f7df3ae8265a from='https://localhost:43805/eb3957b1-d362-4616-abfb-f7df3ae8265a' toID=6262d2eb-c3fa-4cdc-a7e0-509601e16984 to='target/repo/jz6q03p3-valbh-local', fromRepoLocalSync=false
10:43:10.790 [pool-34-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q03p3-valbh-local/.cloudstore-repo/tmp/ChangeSetDto.eb3957b1-d362-4616-abfb-f7df3ae8265a.null.xml.gz
10:43:10.827 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:10.830 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: eb3957b1-d362-4616-abfb-f7df3ae8265a
10:43:10.830 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 6262d2eb-c3fa-4cdc-a7e0-509601e16984
10:43:10.830 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:10.830 [pool-5-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a remoteRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=7
10:43:10.832 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:10.839 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:10.839 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:10.839 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:10.839 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:10.846 [pool-34-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q03p3-valbh-local/.cloudstore-repo/tmp/ChangeSetDto.eb3957b1-d362-4616-abfb-f7df3ae8265a.null.xml.gz
10:43:10.846 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 77.11%
10:43:10.846 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
10:43:10.847 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
10:43:10.875 [qtp1891569057-91] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a remoteRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 localRepositoryRevisionSynced=7
10:43:10.896 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=6262d2eb-c3fa-4cdc-a7e0-509601e16984 remoteRepositoryId=eb3957b1-d362-4616-abfb-f7df3ae8265a transaction.localRevision=13 remoteFromLocalRevision=7
10:43:10.909 [closeDeferredTimer-17fbbf0a-1] INFO c.c.c.l.LocalRepoManagerImpl - [17fbbf0a]_close: Shutting down real LocalRepoManager.
10:43:11.399 [closeDeferredTimer-5784f6b9-1] INFO c.c.c.l.LocalRepoManagerImpl - [5784f6b9]_close: Shutting down real LocalRepoManager.
10:43:11.401 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
10:43:11.448 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [5311afc2]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:11.448 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [5311afc2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 823 ms.
10:43:11.509 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [5311afc2]getCloseDeferredMillis: closeDeferredMillis=0
10:43:11.510 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [5311afc2]close: Closing real LocalRepoManager immediately.
10:43:11.510 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [5311afc2]_close: Shutting down real LocalRepoManager.
hasCorrectAmountOfCreationsDeletions: toBeCreated=2, chunksCreated=2, toBeDeleted=2, chunksDeleted=2
10:43:11.931 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1476e447]getCloseDeferredMillis: closeDeferredMillis=20000
10:43:11.931 [main] INFO c.c.c.l.LocalRepoManagerImpl - [1476e447]close: Deferring shut down of real LocalRepoManager 20000 ms.
10:43:11.932 [main] INFO c.c.c.l.LocalRepoManagerImpl - [549561ab]getCloseDeferredMillis: closeDeferredMillis=20000
10:43:11.932 [main] INFO c.c.c.l.LocalRepoManagerImpl - [549561ab]close: Deferring shut down of real LocalRepoManager 20000 ms.
10:43:12.192 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 serverRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 renewalDateTime=2019-08-11T09:12:57.156Z expiryDateTime=2019-08-11T09:42:57.156Z
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 303.761 sec - in co.codewizards.cloudstore.test.SyncAbortIT
10:43:12.207 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [2692be50]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:12.207 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [2692be50]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:12.222 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@1e4ee092{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:43:12.225 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:43:12.232 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@79c9fe7{/,null,UNAVAILABLE}
10:43:12.246 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/QM0V3w3WUYSPgmweYICKfg/.cloudstore/localServerRunning.deleteToStop
10:43:12.268 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@29f302bf{SSL,[ssl, http/1.1]}{0.0.0.0:43805}
10:43:12.270 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:43:12.272 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@62f29500{/,null,UNAVAILABLE}
10:43:12.923 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [2692be50]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:12.924 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [2692be50]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 717 ms.
10:43:12.960 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [2692be50]getCloseDeferredMillis: closeDeferredMillis=0
10:43:12.960 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [2692be50]close: Closing real LocalRepoManager immediately.
10:43:12.960 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [2692be50]_close: Shutting down real LocalRepoManager.
10:43:13.573 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2beb7183]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:13.574 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2beb7183]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:14.181 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2beb7183]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:14.182 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2beb7183]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 608 ms.
10:43:14.208 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
10:43:14.223 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
10:43:14.250 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
10:43:14.279 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
10:43:14.286 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
10:43:14.303 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
10:43:14.327 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
10:43:14.357 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
10:43:14.388 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:14.391 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:14.392 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 156ed437-7345-45ea-ac5c-aa4487361402
10:43:14.392 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:14.392 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 localRepositoryRevisionSynced=6 localRepositoryRevisionInProgress=8
10:43:14.400 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:14.407 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:14.407 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:14.407 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:14.407 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:14.408 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2beb7183]getCloseDeferredMillis: closeDeferredMillis=0
10:43:14.408 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2beb7183]close: Closing real LocalRepoManager immediately.
10:43:14.408 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2beb7183]_close: Shutting down real LocalRepoManager.
10:43:14.816 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local/.cloudstore-repo/tmp/ChangeSetDto.c12a8d09-7654-49e6-85f6-d00716f5a585.6.xml.gz
10:43:14.817 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
10:43:14.817 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
10:43:14.840 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [40fce2f]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:14.840 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [40fce2f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:15.063 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7f19430f]initPersistenceManagerFactory: repositoryId=c3105f36-6e31-4e2b-834d-99752d487b07
10:43:15.068 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7f19430f]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2561 ms.
remoteRoot: jz6q0cwy-8woi4-remote
remoteRepositoryId: c3105f36-6e31-4e2b-834d-99752d487b07
10:43:15.510 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [40fce2f]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:15.511 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [40fce2f]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 670 ms.
10:43:15.551 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=368.5 MiB, used=52.3 MiB, available=3.4 GiB
10:43:15.558 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [40fce2f]getCloseDeferredMillis: closeDeferredMillis=0
10:43:15.558 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [40fce2f]close: Closing real LocalRepoManager immediately.
10:43:15.559 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [40fce2f]_close: Shutting down real LocalRepoManager.
Successfully requested to connect the following local and remote repositories:
localRepository.repositoryId = 9bf9bfc5-7685-472e-aefd-50667b85f6d1
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q0cwx-aeb4e-local
localRepository.publicKeySha1 = 0C:66:40:DC:32:5C:3D:42:B6:98:86:43:EF:00:DA:B5:BB:EE:F1:15
remoteRepository.repositoryId = c3105f36-6e31-4e2b-834d-99752d487b07
remoteRepository.remoteRoot = https://localhost:35921/c3105f36-6e31-4e2b-834d-99752d487b07
remoteRepository.publicKeySha1 = 9F:2D:A6:AD:9E:05:1F:33:81:CA:87:91:6E:3C:3C:F9:A0:16:BB:96
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 9bf9bfc5-7685-472e-aefd-50667b85f6d1 c3105f36-6e31-4e2b-834d-99752d487b07
10:43:16.096 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6f2de598]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:16.097 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6f2de598]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:16.234 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=378.0 MiB, used=42.4 MiB, available=3.4 GiB
Successfully accepted the connection request for the following local and remote repositories:
localRepository.repositoryId = c3105f36-6e31-4e2b-834d-99752d487b07
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q0cwy-8woi4-remote
localRepository.publicKeySha1 = 9F:2D:A6:AD:9E:05:1F:33:81:CA:87:91:6E:3C:3C:F9:A0:16:BB:96
remoteRepository.repositoryId = 9bf9bfc5-7685-472e-aefd-50667b85f6d1
remoteRepository.publicKeySha1 = 0C:66:40:DC:32:5C:3D:42:B6:98:86:43:EF:00:DA:B5:BB:EE:F1:15
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 c3105f36-6e31-4e2b-834d-99752d487b07 9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:16.730 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6f2de598]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:16.730 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6f2de598]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 633 ms.
10:43:16.802 [qtp861308372-28] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 localRepositoryRevisionSynced=8
10:43:16.811 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6f2de598]getCloseDeferredMillis: closeDeferredMillis=0
10:43:16.811 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6f2de598]close: Closing real LocalRepoManager immediately.
10:43:16.811 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6f2de598]_close: Shutting down real LocalRepoManager.
10:43:16.973 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 0.50%
10:43:16.974 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=c3105f36-6e31-4e2b-834d-99752d487b07 from='https://localhost:35921/c3105f36-6e31-4e2b-834d-99752d487b07' toID=9bf9bfc5-7685-472e-aefd-50667b85f6d1 to='target/repo/jz6q0cwx-aeb4e-local', fromRepoLocalSync=true
10:43:16.974 [pool-9-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 9bf9bfc5-7685-472e-aefd-50667b85f6d1 ('target/repo/jz6q0cwx-aeb4e-local')
10:43:17.001 [pool-9-thread-1] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 12.94%
10:43:17.011 [pool-9-thread-1] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 25.12%
10:43:17.016 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q0cwx-aeb4e-local/.cloudstore-repo/tmp/ChangeSetDto.c3105f36-6e31-4e2b-834d-99752d487b07.-1.xml.gz
10:43:17.090 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 serverRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 renewalDateTime=2019-08-11T09:13:17.037Z expiryDateTime=2019-08-11T09:43:17.037Z
10:43:17.108 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
10:43:17.130 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
10:43:17.158 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.01%
10:43:17.262 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.60%
10:43:17.287 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.40%
10:43:17.315 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 remoteRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 transaction.localRevision=89 remoteFromLocalRevision=8
10:43:17.318 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=156ed437-7345-45ea-ac5c-aa4487361402 from='target/repo/jz6pzwm4-rwq2q-local' toID=c12a8d09-7654-49e6-85f6-d00716f5a585 to='https://localhost:33785/c12a8d09-7654-49e6-85f6-d00716f5a585'
10:43:17.339 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [115d084c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:17.340 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [115d084c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:17.352 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.20%
10:43:17.410 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.00%
10:43:17.488 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
10:43:17.516 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:17.519 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: c3105f36-6e31-4e2b-834d-99752d487b07
10:43:17.519 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:17.520 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:17.520 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 remoteRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
10:43:17.526 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:17.567 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:17.567 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:17.567 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:17.567 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:17.596 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q0cwx-aeb4e-local/.cloudstore-repo/tmp/ChangeSetDto.c3105f36-6e31-4e2b-834d-99752d487b07.-1.xml.gz
10:43:17.597 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
10:43:17.636 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/#4'
10:43:17.654 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/1 {11 11ä11#+} 1'
10:43:17.667 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 30.33%
10:43:17.667 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2'
10:43:17.682 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2/1 {11 11ä11#+} 1'
10:43:17.699 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
10:43:17.713 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/5#'
10:43:17.736 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 35.59%
10:43:17.737 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 40.86%
10:43:17.738 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/#b'
10:43:17.787 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='f90e29960db7f36e0e4b99091b485b1cdd4544a5' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/#b
10:43:17.846 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:17.847 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/#b'
10:43:17.919 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 245765 bytes in 71 ms. path='/#4/#b'
10:43:17.926 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c691e3d4c979adbf07e3b97e33fdf3c89ed246f6_0 into destFile #b
10:43:17.980 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:17.994 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/a'
10:43:18.038 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='980687c2f074f4b88f02768966b749a6e1aca3f7' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/a
10:43:18.077 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.080 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/a'
10:43:18.108 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [115d084c]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:18.111 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [115d084c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 771 ms.
10:43:18.159 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [115d084c]getCloseDeferredMillis: closeDeferredMillis=0
10:43:18.159 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [115d084c]close: Closing real LocalRepoManager immediately.
10:43:18.159 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [115d084c]_close: Shutting down real LocalRepoManager.
10:43:18.197 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 511870 bytes in 117 ms. path='/#4/a'
10:43:18.212 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
10:43:18.305 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.311 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/c+'
10:43:18.351 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='931ec6ae836800e5405320acdfd8b8f64fab0a62' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/c+
10:43:18.373 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.375 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/c+'
10:43:18.464 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 329436 bytes in 89 ms. path='/#4/c+'
10:43:18.470 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_8a30244b83c6cac3c79f8f95d30f96579c0f4c0b_0 into destFile c+
10:43:18.518 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.523 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/d$'
10:43:18.564 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='052b76a2add85a5de828ab2b0e079e1804eb77f9' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/d$
10:43:18.590 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.592 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/d$'
10:43:18.602 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [41da8eb0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:18.603 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [41da8eb0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:18.633 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 1348 bytes in 41 ms. path='/#4/d$'
10:43:18.640 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_a93a212f7eca012dceb852f364cc2c34026f0dd8_0 into destFile d$
10:43:18.659 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.666 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/a'
10:43:18.701 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='6eec67bfc7526607069de6c68cf3c451ba083faf' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/a
10:43:18.734 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.736 [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'
10:43:18.770 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 23830 bytes in 34 ms. path='/1 {11 11ä11#+} 1/a'
10:43:18.776 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
10:43:18.791 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.796 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/b'
10:43:18.827 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='855ac6b47d669513954820d3ea30621faec6abf3' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/b
10:43:18.850 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.852 [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'
10:43:18.922 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 285980 bytes in 70 ms. path='/1 {11 11ä11#+} 1/b'
10:43:18.930 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
10:43:18.959 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:18.964 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/c'
10:43:19.010 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='779d8be1a35fe64bfad7b4220cd7403520a16969' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/c
10:43:19.033 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.035 [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'
10:43:19.191 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 732350 bytes in 156 ms. path='/1 {11 11ä11#+} 1/c'
10:43:19.197 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
10:43:19.262 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [41da8eb0]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:19.263 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [41da8eb0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 660 ms.
10:43:19.265 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.270 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/a'
10:43:19.294 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [41da8eb0]getCloseDeferredMillis: closeDeferredMillis=0
10:43:19.294 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [41da8eb0]close: Closing real LocalRepoManager immediately.
10:43:19.295 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [41da8eb0]_close: Shutting down real LocalRepoManager.
10:43:19.316 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='31efae96604bde37ebf3e6343bc387b53c424361' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/a
10:43:19.336 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.338 [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'
10:43:19.358 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 10175 bytes in 19 ms. path='/2/1 {11 11ä11#+} 1/a'
10:43:19.364 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
10:43:19.376 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.380 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/b'
10:43:19.419 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='9ff1440f1bdc04bf79158f661daa7016e55a5c11' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/b
10:43:19.435 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.437 [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'
10:43:19.480 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 81404 bytes in 43 ms. path='/2/1 {11 11ä11#+} 1/b'
10:43:19.486 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
10:43:19.500 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.504 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/a'
10:43:19.544 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='8f6991c3f708113c84f48793e7dcfeff0acabb0b' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/a
10:43:19.571 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.574 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/a'
10:43:19.641 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 199298 bytes in 67 ms. path='/2/a'
10:43:19.663 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
10:43:19.712 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.716 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/a'
10:43:19.755 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='7e6f38cb02fc5f717048b0e3e8fb9698ba868dc3' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/a
10:43:19.777 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.780 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/a'
10:43:19.804 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:19.809 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 156ed437-7345-45ea-ac5c-aa4487361402
10:43:19.809 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:19.810 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:19.810 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 remoteRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=89
10:43:19.819 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:19.852 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:19.853 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:19.853 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:19.854 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:19.855 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 52.24%
10:43:19.855 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
10:43:19.859 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 262240 bytes in 79 ms. path='/3/a'
10:43:19.870 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
10:43:19.894 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [745b8024]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:19.894 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [745b8024]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:19.900 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.909 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/b'
10:43:19.948 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='dcf3f078ae82aef5103bf93dd4ba3c94994008b9' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/b
10:43:19.973 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:19.975 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/b'
10:43:20.040 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 230857 bytes in 65 ms. path='/3/b'
10:43:20.046 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
10:43:20.068 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:20.073 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/c'
10:43:20.110 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='e013908c97a0132a4e87f5f47243ad01eb6a4325' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/c
10:43:20.128 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:20.129 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/c'
10:43:20.174 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 92356 bytes in 45 ms. path='/3/c'
10:43:20.181 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
10:43:20.198 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:20.203 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/d'
10:43:20.235 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='7231937a46482ace528dc30041ee285a84366812' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/d
10:43:20.264 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:20.267 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/d'
10:43:20.307 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 35478 bytes in 39 ms. path='/3/d'
10:43:20.314 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
10:43:20.333 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:20.339 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/5#/e'
10:43:20.373 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='9729aa47ab5a12067278dafbae625dfd0afc62cd' to.sha1='<NoInstanceOf_NormalFileDto>'): /5#/e
10:43:20.392 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:20.394 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/5#/e'
10:43:20.476 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 384240 bytes in 82 ms. path='/5#/e'
10:43:20.483 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_58e6b3a414a1e090dfc6029add0f3555ccba127f_0 into destFile e
10:43:20.515 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="c3105f36-6e31-4e2b-834d-99752d487b07"] on repo=9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:20.519 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 49.42%
10:43:20.568 [qtp1211548273-30] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 remoteRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 localRepositoryRevisionSynced=3
10:43:20.583 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [745b8024]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:20.584 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [745b8024]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 689 ms.
10:43:20.587 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 remoteRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 transaction.localRevision=84 remoteFromLocalRevision=3
10:43:20.594 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=9bf9bfc5-7685-472e-aefd-50667b85f6d1 from='target/repo/jz6q0cwx-aeb4e-local' toID=c3105f36-6e31-4e2b-834d-99752d487b07 to='https://localhost:35921/c3105f36-6e31-4e2b-834d-99752d487b07'
10:43:20.613 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [745b8024]getCloseDeferredMillis: closeDeferredMillis=0
10:43:20.613 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [745b8024]close: Closing real LocalRepoManager immediately.
10:43:20.613 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [745b8024]_close: Shutting down real LocalRepoManager.
10:43:20.647 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:20.650 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:20.651 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: c3105f36-6e31-4e2b-834d-99752d487b07
10:43:20.651 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:20.651 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 remoteRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=84
10:43:20.659 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:20.670 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:20.670 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:20.670 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:20.671 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:20.671 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 63.43%
10:43:20.672 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
10:43:20.690 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 remoteRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 localRepositoryRevisionSynced=84
10:43:20.717 [qtp1211548273-23] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 remoteRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 transaction.localRevision=6 remoteFromLocalRevision=84
10:43:20.724 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=c3105f36-6e31-4e2b-834d-99752d487b07 from='https://localhost:35921/c3105f36-6e31-4e2b-834d-99752d487b07' toID=9bf9bfc5-7685-472e-aefd-50667b85f6d1 to='target/repo/jz6q0cwx-aeb4e-local', fromRepoLocalSync=false
10:43:20.724 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q0cwx-aeb4e-local/.cloudstore-repo/tmp/ChangeSetDto.c3105f36-6e31-4e2b-834d-99752d487b07.null.xml.gz
10:43:20.818 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:20.825 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: c3105f36-6e31-4e2b-834d-99752d487b07
10:43:20.825 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 9bf9bfc5-7685-472e-aefd-50667b85f6d1
10:43:20.825 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:20.825 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 remoteRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
10:43:20.826 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:20.828 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:20.828 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:20.828 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:20.828 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:20.838 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q0cwx-aeb4e-local/.cloudstore-repo/tmp/ChangeSetDto.c3105f36-6e31-4e2b-834d-99752d487b07.null.xml.gz
10:43:20.838 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
10:43:20.838 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
10:43:20.859 [qtp1211548273-23] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 remoteRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 localRepositoryRevisionSynced=6
10:43:20.870 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=9bf9bfc5-7685-472e-aefd-50667b85f6d1 remoteRepositoryId=c3105f36-6e31-4e2b-834d-99752d487b07 transaction.localRevision=87 remoteFromLocalRevision=6
10:43:20.872 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
10:43:20.992 [main] INFO c.c.c.l.LocalRepoManagerImpl - [5f1dadf4]getCloseDeferredMillis: closeDeferredMillis=20000
10:43:20.993 [main] INFO c.c.c.l.LocalRepoManagerImpl - [5f1dadf4]close: Deferring shut down of real LocalRepoManager 20000 ms.
10:43:21.000 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7f19430f]getCloseDeferredMillis: closeDeferredMillis=20000
10:43:21.001 [main] INFO c.c.c.l.LocalRepoManagerImpl - [7f19430f]close: Deferring shut down of real LocalRepoManager 20000 ms.
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 160.051 sec - in co.codewizards.cloudstore.test.repotorepo.BasicRepoToRepoSyncIT
10:43:21.035 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@71bc20b7{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:43:21.036 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:43:21.042 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@36d5edd7{/,null,UNAVAILABLE}
10:43:21.054 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/6CdiPL8D-FHWnv81LH_rhg/.cloudstore/localServerRunning.deleteToStop
10:43:21.079 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@62c8a0af{SSL,[ssl, http/1.1]}{0.0.0.0:35921}
10:43:21.080 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:43:21.081 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@75b6d19a{/,null,UNAVAILABLE}
10:43:21.088 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [77941a77]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:21.088 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [77941a77]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:21.698 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [77941a77]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:21.699 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [77941a77]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 611 ms.
10:43:21.795 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [77941a77]getCloseDeferredMillis: closeDeferredMillis=0
10:43:21.795 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [77941a77]close: Closing real LocalRepoManager immediately.
10:43:21.795 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [77941a77]_close: Shutting down real LocalRepoManager.
10:43:22.194 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 58.34%
10:43:22.203 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 64.45%
10:43:22.204 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 70.56%
10:43:22.204 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
10:43:22.240 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [6ea95146]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:22.240 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [6ea95146]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:22.807 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [6ea95146]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:22.807 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [6ea95146]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 567 ms.
10:43:22.839 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [6ea95146]getCloseDeferredMillis: closeDeferredMillis=0
10:43:22.839 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [6ea95146]close: Closing real LocalRepoManager immediately.
10:43:22.839 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [6ea95146]_close: Shutting down real LocalRepoManager.
10:43:23.251 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7841880a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:23.252 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7841880a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:23.787 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7841880a]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:23.787 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7841880a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 534 ms.
10:43:23.829 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7841880a]getCloseDeferredMillis: closeDeferredMillis=0
10:43:23.829 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7841880a]close: Closing real LocalRepoManager immediately.
10:43:23.829 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7841880a]_close: Shutting down real LocalRepoManager.
10:43:24.143 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='15fd38f7501948c9e4f751544276149a1384f9d3' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
Aug 11, 2019 10:43:24 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
10:43:24.171 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [38b86dd1]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:24.171 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [38b86dd1]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:24.709 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [38b86dd1]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:24.710 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [38b86dd1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 539 ms.
10:43:24.737 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [38b86dd1]getCloseDeferredMillis: closeDeferredMillis=0
10:43:24.737 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [38b86dd1]close: Closing real LocalRepoManager immediately.
10:43:24.737 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [38b86dd1]_close: Shutting down real LocalRepoManager.
10:43:25.206 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [5516f060]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:25.207 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [5516f060]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:25.767 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [5516f060]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:25.768 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [5516f060]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 561 ms.
10:43:25.934 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [5516f060]getCloseDeferredMillis: closeDeferredMillis=0
10:43:25.934 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [5516f060]close: Closing real LocalRepoManager immediately.
10:43:25.934 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [5516f060]_close: Shutting down real LocalRepoManager.
10:43:26.414 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="156ed437-7345-45ea-ac5c-aa4487361402"] on repo=156ed437-7345-45ea-ac5c-aa4487361402
10:43:26.418 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
10:43:26.485 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3299c83f]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:26.486 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3299c83f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:27.059 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3299c83f]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:27.060 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3299c83f]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 574 ms.
10:43:27.086 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3299c83f]getCloseDeferredMillis: closeDeferredMillis=0
10:43:27.086 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3299c83f]close: Closing real LocalRepoManager immediately.
10:43:27.086 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3299c83f]_close: Shutting down real LocalRepoManager.
10:43:27.442 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [61173287]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:27.442 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [61173287]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:28.002 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [61173287]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:28.003 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [61173287]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 561 ms.
10:43:28.060 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [61173287]getCloseDeferredMillis: closeDeferredMillis=0
10:43:28.060 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [61173287]close: Closing real LocalRepoManager immediately.
10:43:28.060 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [61173287]_close: Shutting down real LocalRepoManager.
10:43:28.430 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 260925 bytes in 2012 ms. path='/3/zzz'
Aug 11, 2019 10:43:28 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
10:43:28.456 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [48b4ed33]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:28.457 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [48b4ed33]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:29.040 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [48b4ed33]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:29.041 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [48b4ed33]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 584 ms.
10:43:29.068 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [48b4ed33]getCloseDeferredMillis: closeDeferredMillis=0
10:43:29.068 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [48b4ed33]close: Closing real LocalRepoManager immediately.
10:43:29.068 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [48b4ed33]_close: Shutting down real LocalRepoManager.
10:43:29.495 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [508df004]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:29.495 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [508df004]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:30.053 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [508df004]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:30.054 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [508df004]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 558 ms.
10:43:30.108 [qtp861308372-27] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
10:43:30.180 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [508df004]getCloseDeferredMillis: closeDeferredMillis=0
10:43:30.181 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [508df004]close: Closing real LocalRepoManager immediately.
10:43:30.181 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [508df004]_close: Shutting down real LocalRepoManager.
10:43:30.536 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="156ed437-7345-45ea-ac5c-aa4487361402"] on repo=156ed437-7345-45ea-ac5c-aa4487361402
10:43:30.549 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
10:43:30.566 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 remoteRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 localRepositoryRevisionSynced=89
10:43:30.595 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [57412541]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:30.596 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [57412541]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:31.146 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [57412541]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:31.146 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [57412541]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 550 ms.
10:43:31.173 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [57412541]getCloseDeferredMillis: closeDeferredMillis=0
10:43:31.173 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [57412541]close: Closing real LocalRepoManager immediately.
10:43:31.173 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [57412541]_close: Shutting down real LocalRepoManager.
10:43:31.624 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [65845356]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:31.624 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [65845356]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:32.169 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [65845356]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:32.170 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [65845356]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 545 ms.
10:43:32.221 [qtp861308372-42] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 transaction.localRevision=15 remoteFromLocalRevision=89
10:43:32.227 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [65845356]getCloseDeferredMillis: closeDeferredMillis=0
10:43:32.227 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [65845356]close: Closing real LocalRepoManager immediately.
10:43:32.227 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [65845356]_close: Shutting down real LocalRepoManager.
10:43:32.566 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=c12a8d09-7654-49e6-85f6-d00716f5a585 from='https://localhost:33785/c12a8d09-7654-49e6-85f6-d00716f5a585' toID=156ed437-7345-45ea-ac5c-aa4487361402 to='target/repo/jz6pzwm4-rwq2q-local', fromRepoLocalSync=false
10:43:32.568 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local/.cloudstore-repo/tmp/ChangeSetDto.c12a8d09-7654-49e6-85f6-d00716f5a585.null.xml.gz
10:43:32.589 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [14a4b9bf]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:32.589 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [14a4b9bf]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:33.147 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [14a4b9bf]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:33.148 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [14a4b9bf]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 559 ms.
10:43:33.176 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [14a4b9bf]getCloseDeferredMillis: closeDeferredMillis=0
10:43:33.176 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [14a4b9bf]close: Closing real LocalRepoManager immediately.
10:43:33.177 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [14a4b9bf]_close: Shutting down real LocalRepoManager.
10:43:33.657 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [501de42c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:33.659 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [501de42c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:34.208 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [501de42c]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:34.208 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [501de42c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 548 ms.
10:43:34.266 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:34.268 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:34.269 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 156ed437-7345-45ea-ac5c-aa4487361402
10:43:34.269 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:34.269 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
10:43:34.282 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:34.290 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:34.290 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:34.290 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:34.290 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:34.291 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [501de42c]getCloseDeferredMillis: closeDeferredMillis=0
10:43:34.291 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [501de42c]close: Closing real LocalRepoManager immediately.
10:43:34.291 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [501de42c]_close: Shutting down real LocalRepoManager.
10:43:34.630 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local/.cloudstore-repo/tmp/ChangeSetDto.c12a8d09-7654-49e6-85f6-d00716f5a585.null.xml.gz
10:43:34.630 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
10:43:34.631 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
10:43:34.648 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [e746c40]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:34.649 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [e746c40]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:35.204 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [e746c40]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:35.204 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [e746c40]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 555 ms.
10:43:35.232 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [e746c40]getCloseDeferredMillis: closeDeferredMillis=0
10:43:35.232 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [e746c40]close: Closing real LocalRepoManager immediately.
10:43:35.232 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [e746c40]_close: Shutting down real LocalRepoManager.
10:43:35.567 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [476500b5]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:35.567 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [476500b5]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:36.108 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [476500b5]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:36.109 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [476500b5]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 541 ms.
10:43:36.166 [qtp861308372-30] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 localRepositoryRevisionSynced=15
10:43:36.176 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [476500b5]getCloseDeferredMillis: closeDeferredMillis=0
10:43:36.176 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [476500b5]close: Closing real LocalRepoManager immediately.
10:43:36.176 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [476500b5]_close: Shutting down real LocalRepoManager.
10:43:36.510 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 remoteRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 transaction.localRevision=94 remoteFromLocalRevision=15
10:43:36.512 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
10:43:36.512 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6b2efcae]getCloseDeferredMillis: closeDeferredMillis=0
10:43:36.512 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6b2efcae]close: Closing real LocalRepoManager immediately.
10:43:36.512 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6b2efcae]_close: Shutting down real LocalRepoManager.
10:43:37.040 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
10:43:37.041 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restoring backup: 'target/repo/jz6pzwm5-3lk9u-remote.bak' => 'target/repo/jz6pzwm5-3lk9u-remote'
10:43:37.093 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restored backup: 'target/repo/jz6pzwm5-3lk9u-remote.bak' => 'target/repo/jz6pzwm5-3lk9u-remote'
10:43:37.094 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
10:43:37.095 [main] INFO c.c.c.l.LocalRepoManagerImpl - [384b3fe7]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local'
10:43:37.096 [main] INFO c.c.c.l.LocalRepoManagerImpl - [384b3fe7]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local' locked successfully.
10:43:37.651 [main] INFO c.c.c.l.LocalRepoManagerImpl - [384b3fe7]initPersistenceManagerFactory: repositoryId=156ed437-7345-45ea-ac5c-aa4487361402
10:43:37.652 [main] INFO c.c.c.l.LocalRepoManagerImpl - [384b3fe7]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 556 ms.
10:43:37.841 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6d8b8b19]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:37.842 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6d8b8b19]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:38.439 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6d8b8b19]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:38.439 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6d8b8b19]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 597 ms.
10:43:38.457 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6d8b8b19]getCloseDeferredMillis: closeDeferredMillis=0
10:43:38.457 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6d8b8b19]close: Closing real LocalRepoManager immediately.
10:43:38.457 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [6d8b8b19]_close: Shutting down real LocalRepoManager.
10:43:38.849 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 0.50%
10:43:38.850 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=c12a8d09-7654-49e6-85f6-d00716f5a585 from='https://localhost:33785/c12a8d09-7654-49e6-85f6-d00716f5a585' toID=156ed437-7345-45ea-ac5c-aa4487361402 to='target/repo/jz6pzwm4-rwq2q-local', fromRepoLocalSync=true
10:43:38.850 [pool-9-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 156ed437-7345-45ea-ac5c-aa4487361402 ('target/repo/jz6pzwm4-rwq2q-local')
10:43:38.892 [pool-9-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 12.94%
10:43:38.944 [pool-9-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 19.03%
10:43:38.984 [pool-9-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 24.15%
10:43:39.033 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local/.cloudstore-repo/tmp/ChangeSetDto.c12a8d09-7654-49e6-85f6-d00716f5a585.15.xml.gz
10:43:39.053 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [5d5672b6]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:39.054 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [5d5672b6]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:39.618 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [5d5672b6]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:39.618 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [5d5672b6]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 564 ms.
10:43:39.654 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [5d5672b6]getCloseDeferredMillis: closeDeferredMillis=0
10:43:39.654 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [5d5672b6]close: Closing real LocalRepoManager immediately.
10:43:39.654 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [5d5672b6]_close: Shutting down real LocalRepoManager.
10:43:40.028 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 serverRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 renewalDateTime=2019-08-11T09:12:57.156Z expiryDateTime=2019-08-11T09:42:57.156Z
10:43:40.052 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [d31aed9]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:40.053 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [d31aed9]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:40.576 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [d31aed9]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:40.576 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [d31aed9]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 523 ms.
10:43:40.604 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [d31aed9]getCloseDeferredMillis: closeDeferredMillis=0
10:43:40.604 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [d31aed9]close: Closing real LocalRepoManager immediately.
10:43:40.604 [qtp861308372-30] INFO c.c.c.l.LocalRepoManagerImpl - [d31aed9]_close: Shutting down real LocalRepoManager.
10:43:40.928 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [34acc87a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:40.929 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [34acc87a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:41.492 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [34acc87a]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:41.492 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [34acc87a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 563 ms.
10:43:41.510 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
10:43:41.519 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
10:43:41.539 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
10:43:41.559 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
10:43:41.564 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
10:43:41.580 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
10:43:41.601 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
10:43:41.626 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
10:43:41.637 [pool-4-thread-1] WARN c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=15 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=6
10:43:41.697 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:41.703 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:41.703 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 156ed437-7345-45ea-ac5c-aa4487361402
10:43:41.704 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:41.704 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 localRepositoryRevisionSynced=15 localRepositoryRevisionInProgress=8
10:43:41.711 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:41.717 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:41.717 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:41.717 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:41.717 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:41.718 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [34acc87a]getCloseDeferredMillis: closeDeferredMillis=0
10:43:41.718 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [34acc87a]close: Closing real LocalRepoManager immediately.
10:43:41.718 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [34acc87a]_close: Shutting down real LocalRepoManager.
10:43:42.081 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local/.cloudstore-repo/tmp/ChangeSetDto.c12a8d09-7654-49e6-85f6-d00716f5a585.15.xml.gz
10:43:42.082 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
10:43:42.082 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
10:43:42.104 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [57996a9a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:42.105 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [57996a9a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:42.648 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [57996a9a]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:42.648 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [57996a9a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 543 ms.
10:43:42.674 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [57996a9a]getCloseDeferredMillis: closeDeferredMillis=0
10:43:42.674 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [57996a9a]close: Closing real LocalRepoManager immediately.
10:43:42.674 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [57996a9a]_close: Shutting down real LocalRepoManager.
10:43:42.998 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [72be2e2b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:42.999 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [72be2e2b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:43.580 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [72be2e2b]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:43.581 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [72be2e2b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 581 ms.
10:43:43.646 [qtp861308372-24] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 localRepositoryRevisionSynced=8
10:43:43.899 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [72be2e2b]getCloseDeferredMillis: closeDeferredMillis=0
10:43:43.899 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [72be2e2b]close: Closing real LocalRepoManager immediately.
10:43:43.899 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [72be2e2b]_close: Shutting down real LocalRepoManager.
10:43:44.366 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 remoteRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 transaction.localRevision=95 remoteFromLocalRevision=8
10:43:44.369 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=156ed437-7345-45ea-ac5c-aa4487361402 from='target/repo/jz6pzwm4-rwq2q-local' toID=c12a8d09-7654-49e6-85f6-d00716f5a585 to='https://localhost:33785/c12a8d09-7654-49e6-85f6-d00716f5a585'
10:43:44.395 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3bc27990]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:44.395 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3bc27990]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:45.036 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3bc27990]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:45.037 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3bc27990]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 642 ms.
10:43:45.064 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3bc27990]getCloseDeferredMillis: closeDeferredMillis=0
10:43:45.064 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3bc27990]close: Closing real LocalRepoManager immediately.
10:43:45.064 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [3bc27990]_close: Shutting down real LocalRepoManager.
10:43:45.482 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [2e56e5b3]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:45.483 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [2e56e5b3]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:46.035 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [2e56e5b3]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:46.036 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [2e56e5b3]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 553 ms.
10:43:46.063 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [2e56e5b3]getCloseDeferredMillis: closeDeferredMillis=0
10:43:46.064 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [2e56e5b3]close: Closing real LocalRepoManager immediately.
10:43:46.064 [qtp861308372-63] INFO c.c.c.l.LocalRepoManagerImpl - [2e56e5b3]_close: Shutting down real LocalRepoManager.
10:43:46.412 [main] WARN c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=84 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=89
10:43:46.426 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:43:46.429 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 156ed437-7345-45ea-ac5c-aa4487361402
10:43:46.430 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:46.430 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:43:46.430 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 remoteRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=95
10:43:46.439 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:43:46.486 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:43:46.486 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:43:46.486 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:43:46.486 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:43:46.487 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 56.31%
10:43:46.488 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
10:43:46.507 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [6c5e6b20]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:46.507 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [6c5e6b20]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:46.995 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [40bc7646]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q1aho-a30p2'
10:43:47.014 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [40bc7646]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6q1aho-a30p2' locked successfully.
10:43:47.180 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [6c5e6b20]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:47.180 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [6c5e6b20]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 673 ms.
10:43:47.213 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [6c5e6b20]getCloseDeferredMillis: closeDeferredMillis=0
10:43:47.213 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [6c5e6b20]close: Closing real LocalRepoManager immediately.
10:43:47.213 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [6c5e6b20]_close: Shutting down real LocalRepoManager.
10:43:47.682 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [1988a97c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:47.683 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [1988a97c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:48.248 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [1988a97c]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:48.248 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [1988a97c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 564 ms.
10:43:48.393 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [1988a97c]getCloseDeferredMillis: closeDeferredMillis=0
10:43:48.393 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [1988a97c]close: Closing real LocalRepoManager immediately.
10:43:48.393 [qtp861308372-24] INFO c.c.c.l.LocalRepoManagerImpl - [1988a97c]_close: Shutting down real LocalRepoManager.
10:43:48.777 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 62.42%
10:43:48.778 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 68.52%
10:43:48.778 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
10:43:48.824 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [17c09062]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:48.824 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [17c09062]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:49.439 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [17c09062]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:49.440 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [17c09062]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 616 ms.
10:43:49.464 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [17c09062]getCloseDeferredMillis: closeDeferredMillis=0
10:43:49.464 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [17c09062]close: Closing real LocalRepoManager immediately.
10:43:49.464 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [17c09062]_close: Shutting down real LocalRepoManager.
10:43:49.806 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [1f2836c8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:49.806 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [1f2836c8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:50.412 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [1f2836c8]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:50.413 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [1f2836c8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 607 ms.
10:43:50.470 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [1f2836c8]getCloseDeferredMillis: closeDeferredMillis=0
10:43:50.470 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [1f2836c8]close: Closing real LocalRepoManager immediately.
10:43:50.470 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [1f2836c8]_close: Shutting down real LocalRepoManager.
10:43:50.901 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='15fd38f7501948c9e4f751544276149a1384f9d3' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
Aug 11, 2019 10:43:50 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
10:43:50.923 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [38644105]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:50.923 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [38644105]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:51.617 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [38644105]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:51.618 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [38644105]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 695 ms.
10:43:51.645 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [38644105]getCloseDeferredMillis: closeDeferredMillis=0
10:43:51.645 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [38644105]close: Closing real LocalRepoManager immediately.
10:43:51.646 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [38644105]_close: Shutting down real LocalRepoManager.
10:43:52.022 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [d6a8fe2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:52.022 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [d6a8fe2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:52.623 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [d6a8fe2]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:52.624 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [d6a8fe2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 601 ms.
10:43:52.745 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [d6a8fe2]getCloseDeferredMillis: closeDeferredMillis=0
10:43:52.745 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [d6a8fe2]close: Closing real LocalRepoManager immediately.
10:43:52.745 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [d6a8fe2]_close: Shutting down real LocalRepoManager.
10:43:53.295 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="156ed437-7345-45ea-ac5c-aa4487361402"] on repo=156ed437-7345-45ea-ac5c-aa4487361402
10:43:53.317 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
10:43:53.382 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4466f8b6]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:53.382 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4466f8b6]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:54.032 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4466f8b6]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:54.032 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4466f8b6]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 650 ms.
10:43:54.063 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4466f8b6]getCloseDeferredMillis: closeDeferredMillis=0
10:43:54.063 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4466f8b6]close: Closing real LocalRepoManager immediately.
10:43:54.063 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4466f8b6]_close: Shutting down real LocalRepoManager.
10:43:54.477 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4d5cdcbd]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:54.477 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4d5cdcbd]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:55.089 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4d5cdcbd]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:55.090 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4d5cdcbd]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 612 ms.
10:43:55.143 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4d5cdcbd]getCloseDeferredMillis: closeDeferredMillis=0
10:43:55.143 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4d5cdcbd]close: Closing real LocalRepoManager immediately.
10:43:55.143 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [4d5cdcbd]_close: Shutting down real LocalRepoManager.
10:43:55.568 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 260925 bytes in 2250 ms. path='/3/zzz'
Aug 11, 2019 10:43:55 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
10:43:55.586 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [76f0c52b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:55.586 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [76f0c52b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:56.199 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [76f0c52b]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:56.200 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [76f0c52b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 614 ms.
10:43:56.236 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [76f0c52b]getCloseDeferredMillis: closeDeferredMillis=0
10:43:56.236 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [76f0c52b]close: Closing real LocalRepoManager immediately.
10:43:56.236 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [76f0c52b]_close: Shutting down real LocalRepoManager.
10:43:56.329 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [40bc7646]initPersistenceManagerFactory: repositoryId=caf3cee7-5440-4a85-a2a8-b4a7a9c64a60
10:43:56.342 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [40bc7646]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 6573 ms.
10:43:56.630 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [40bc7646]getCloseDeferredMillis: closeDeferredMillis=20000
10:43:56.630 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [40bc7646]close: Deferring shut down of real LocalRepoManager 20000 ms.
10:43:56.777 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [1f6fe7b3]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:56.778 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [1f6fe7b3]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:57.354 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [1f6fe7b3]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:57.354 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [1f6fe7b3]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 576 ms.
10:43:57.392 [qtp861308372-23] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
10:43:57.465 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [1f6fe7b3]getCloseDeferredMillis: closeDeferredMillis=0
10:43:57.465 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [1f6fe7b3]close: Closing real LocalRepoManager immediately.
10:43:57.465 [qtp861308372-23] INFO c.c.c.l.LocalRepoManagerImpl - [1f6fe7b3]_close: Shutting down real LocalRepoManager.
10:43:57.853 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="156ed437-7345-45ea-ac5c-aa4487361402"] on repo=156ed437-7345-45ea-ac5c-aa4487361402
10:43:57.866 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
10:43:57.879 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 remoteRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 localRepositoryRevisionSynced=95
10:43:57.904 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [19d61bd6]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:57.905 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [19d61bd6]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:58.502 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [19d61bd6]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:58.502 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [19d61bd6]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 597 ms.
10:43:58.528 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [19d61bd6]getCloseDeferredMillis: closeDeferredMillis=0
10:43:58.529 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [19d61bd6]close: Closing real LocalRepoManager immediately.
10:43:58.529 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [19d61bd6]_close: Shutting down real LocalRepoManager.
10:43:58.845 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [1dfccf13]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:58.846 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [1dfccf13]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:43:59.362 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [1dfccf13]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:43:59.362 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [1dfccf13]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 515 ms.
10:43:59.411 [qtp861308372-28] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 transaction.localRevision=15 remoteFromLocalRevision=95
10:43:59.424 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [1dfccf13]getCloseDeferredMillis: closeDeferredMillis=0
10:43:59.424 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [1dfccf13]close: Closing real LocalRepoManager immediately.
10:43:59.424 [qtp861308372-28] INFO c.c.c.l.LocalRepoManagerImpl - [1dfccf13]_close: Shutting down real LocalRepoManager.
10:43:59.740 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=c12a8d09-7654-49e6-85f6-d00716f5a585 from='https://localhost:33785/c12a8d09-7654-49e6-85f6-d00716f5a585' toID=156ed437-7345-45ea-ac5c-aa4487361402 to='target/repo/jz6pzwm4-rwq2q-local', fromRepoLocalSync=false
10:43:59.741 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local/.cloudstore-repo/tmp/ChangeSetDto.c12a8d09-7654-49e6-85f6-d00716f5a585.null.xml.gz
10:43:59.756 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [36a159b8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:43:59.756 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [36a159b8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:44:00.308 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [36a159b8]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:44:00.308 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [36a159b8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 552 ms.
10:44:00.336 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [36a159b8]getCloseDeferredMillis: closeDeferredMillis=0
10:44:00.337 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [36a159b8]close: Closing real LocalRepoManager immediately.
10:44:00.337 [qtp861308372-27] INFO c.c.c.l.LocalRepoManagerImpl - [36a159b8]_close: Shutting down real LocalRepoManager.
10:44:00.814 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7d80ae7a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:44:00.814 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7d80ae7a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:44:01.356 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7d80ae7a]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:44:01.357 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7d80ae7a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 542 ms.
10:44:01.417 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
10:44:01.422 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: c12a8d09-7654-49e6-85f6-d00716f5a585
10:44:01.422 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 156ed437-7345-45ea-ac5c-aa4487361402
10:44:01.422 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
10:44:01.423 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
10:44:01.430 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
10:44:01.437 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
10:44:01.437 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
10:44:01.437 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
10:44:01.437 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
10:44:01.437 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7d80ae7a]getCloseDeferredMillis: closeDeferredMillis=0
10:44:01.437 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7d80ae7a]close: Closing real LocalRepoManager immediately.
10:44:01.438 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [7d80ae7a]_close: Shutting down real LocalRepoManager.
10:44:01.791 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm4-rwq2q-local/.cloudstore-repo/tmp/ChangeSetDto.c12a8d09-7654-49e6-85f6-d00716f5a585.null.xml.gz
10:44:01.791 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
10:44:01.791 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
10:44:01.818 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [5734b80e]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:44:01.818 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [5734b80e]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 352.163 sec - in co.codewizards.cloudstore.test.LocalServerClientIT
10:44:01.950 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@7ea96196{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:44:01.952 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:44:01.963 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@48f73db0{/,null,UNAVAILABLE}
10:44:01.978 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/t_Y6AypYeZCrZCEenRgO7w/.cloudstore/localServerRunning.deleteToStop
10:44:01.989 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@238637b1{SSL,[ssl, http/1.1]}{0.0.0.0:46718}
10:44:01.991 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:44:01.993 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@576a5e6f{/,null,UNAVAILABLE}
10:44:02.386 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [5734b80e]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:44:02.386 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [5734b80e]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 568 ms.
10:44:02.409 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [5734b80e]getCloseDeferredMillis: closeDeferredMillis=0
10:44:02.409 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [5734b80e]close: Closing real LocalRepoManager immediately.
10:44:02.409 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [5734b80e]_close: Shutting down real LocalRepoManager.
10:44:02.762 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [63c13b50]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote'
10:44:02.763 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [63c13b50]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/jz6pzwm5-3lk9u-remote' locked successfully.
10:44:03.289 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [63c13b50]initPersistenceManagerFactory: repositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585
10:44:03.290 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [63c13b50]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 527 ms.
10:44:03.348 [qtp861308372-42] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 remoteRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 localRepositoryRevisionSynced=15
10:44:03.359 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [63c13b50]getCloseDeferredMillis: closeDeferredMillis=0
10:44:03.359 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [63c13b50]close: Closing real LocalRepoManager immediately.
10:44:03.359 [qtp861308372-42] INFO c.c.c.l.LocalRepoManagerImpl - [63c13b50]_close: Shutting down real LocalRepoManager.
10:44:03.768 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=156ed437-7345-45ea-ac5c-aa4487361402 remoteRepositoryId=c12a8d09-7654-49e6-85f6-d00716f5a585 transaction.localRevision=100 remoteFromLocalRevision=15
10:44:03.771 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
10:44:03.868 [main] INFO c.c.c.l.LocalRepoManagerImpl - [384b3fe7]getCloseDeferredMillis: closeDeferredMillis=0
10:44:03.869 [main] INFO c.c.c.l.LocalRepoManagerImpl - [384b3fe7]close: Closing real LocalRepoManager immediately.
10:44:03.869 [main] INFO c.c.c.l.LocalRepoManagerImpl - [384b3fe7]_close: Shutting down real LocalRepoManager.
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 246.597 sec - in co.codewizards.cloudstore.test.repotorepo.BackupRestoreRepoToRepoSyncIT
10:44:04.308 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@13359a76{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:44:04.310 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:44:04.316 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@6bd8a722{/,null,UNAVAILABLE}
10:44:04.328 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/8OkJrbL49q3bRqSYKCZcGw/.cloudstore/localServerRunning.deleteToStop
10:44:04.339 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@33a889b7{SSL,[ssl, http/1.1]}{0.0.0.0:33785}
10:44:04.340 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:44:04.342 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@7af5e3bb{/,null,UNAVAILABLE}
10:45:05.065 [main] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.SocketException: Broken pipe (Write failed)
javax.ws.rs.ProcessingException: java.net.SocketException: Broken pipe (Write failed)
at org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUrlConnector.java:184) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.ClientRuntime.invoke(ClientRuntime.java:227) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation$2.call(JerseyInvocation.java:671) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.internal.Errors.process(Errors.java:315) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.internal.Errors.process(Errors.java:297) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.internal.Errors.process(Errors.java:228) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:422) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation.invoke(JerseyInvocation.java:667) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation$Builder.method(JerseyInvocation.java:396) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation$Builder.get(JerseyInvocation.java:296) ~[jersey-client-2.5.1.jar:na]
at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.determineBaseUrl(CloudStoreRestClient.java:115) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.getBaseUrl(CloudStoreRestClient.java:74) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.AbstractRequest.getBaseURL(AbstractRequest.java:146) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.AbstractRequest.createWebTarget(AbstractRequest.java:115) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.TestRequest.execute(TestRequest.java:27) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.TestRequest.execute(TestRequest.java:6) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.execute(CloudStoreRestClient.java:163) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.test.CertificateHandlingAndTestServiceLRT.almostTimedOut_5min(CertificateHandlingAndTestServiceLRT.java:89) [test-classes/:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_222]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_222]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_222]
at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_222]
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) [junit-4.12.jar:4.12]
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.12.jar:4.12]
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) [junit-4.12.jar:4.12]
at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) [jmockit-1.24.jar:na]
at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) [jmockit-1.24.jar:na]
at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) [jmockit-1.24.jar:na]
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) [junit-4.12.jar:4.12]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) [junit-4.12.jar:4.12]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [junit-4.12.jar:4.12]
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264) [surefire-junit4-2.17.jar:2.17]
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153) [surefire-junit4-2.17.jar:2.17]
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124) [surefire-junit4-2.17.jar:2.17]
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200) [surefire-booter-2.17.jar:2.17]
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153) [surefire-booter-2.17.jar:2.17]
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103) [surefire-booter-2.17.jar:2.17]
Caused by: java.net.SocketException: Broken pipe (Write failed)
at java.net.SocketOutputStream.socketWrite0(Native Method) ~[na:1.8.0_222]
at java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:111) ~[na:1.8.0_222]
at java.net.SocketOutputStream.write(SocketOutputStream.java:155) ~[na:1.8.0_222]
at sun.security.ssl.OutputRecord.writeBuffer(OutputRecord.java:431) ~[na:1.8.0_222]
at sun.security.ssl.OutputRecord.write(OutputRecord.java:417) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.writeRecordInternal(SSLSocketImpl.java:879) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:850) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:720) ~[na:1.8.0_222]
at sun.security.ssl.Handshaker.sendChangeCipherSpec(Handshaker.java:1144) ~[na:1.8.0_222]
at sun.security.ssl.ClientHandshaker.sendChangeCipherAndFinish(ClientHandshaker.java:1280) ~[na:1.8.0_222]
at sun.security.ssl.ClientHandshaker.serverHelloDone(ClientHandshaker.java:1190) ~[na:1.8.0_222]
at sun.security.ssl.ClientHandshaker.processMessage(ClientHandshaker.java:369) ~[na:1.8.0_222]
at sun.security.ssl.Handshaker.processLoop(Handshaker.java:1037) ~[na:1.8.0_222]
at sun.security.ssl.Handshaker.process_record(Handshaker.java:965) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:1064) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1367) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1395) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1379) ~[na:1.8.0_222]
at sun.net.www.protocol.https.HttpsClient.afterConnect(HttpsClient.java:559) ~[na:1.8.0_222]
at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:185) ~[na:1.8.0_222]
at sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1570) ~[na:1.8.0_222]
at sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1498) ~[na:1.8.0_222]
at java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:480) ~[na:1.8.0_222]
at sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:352) ~[na:1.8.0_222]
at org.glassfish.jersey.client.HttpUrlConnector._apply(HttpUrlConnector.java:276) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUrlConnector.java:182) ~[jersey-client-2.5.1.jar:na]
... 48 common frames omitted
Tests run: 4, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 417.75 sec - in co.codewizards.cloudstore.test.CertificateHandlingAndTestServiceLRT
10:45:06.243 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@783739db{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
10:45:06.245 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:45:06.251 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@7ca199d3{/,null,UNAVAILABLE}
10:45:06.262 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/TMorWAoEvLzTkylPnexvIA/.cloudstore/localServerRunning.deleteToStop
10:45:06.273 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@6624c22c{SSL,[ssl, http/1.1]}{0.0.0.0:43757}
10:45:06.276 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
10:45:06.278 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@2b9d5824{/,null,UNAVAILABLE}
Results :
Tests run: 48, Failures: 0, Errors: 0, Skipped: 1
[JENKINS] Recording test results
[INFO]
[INFO] --- maven-source-plugin:2.1.2:jar-no-fork (attach-sources) @ co.codewizards.cloudstore.test ---
[INFO] co already added, skipping
[INFO] co/codewizards already added, skipping
[INFO] co/codewizards/cloudstore already added, skipping
[INFO] co/codewizards/cloudstore/test already added, skipping
[INFO] Building jar: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT-sources.jar
[INFO] co already added, skipping
[INFO] co/codewizards already added, skipping
[INFO] co/codewizards/cloudstore already added, skipping
[INFO] co/codewizards/cloudstore/test already added, skipping
[INFO]
[INFO] --- maven-failsafe-plugin:2.17:verify (default) @ co.codewizards.cloudstore.test ---
[INFO] Failsafe report directory: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/failsafe-reports
[JENKINS] Recording test results
[INFO]
[INFO] --- maven-install-plugin:2.3.1:install (default-install) @ co.codewizards.cloudstore.test ---
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT.jar
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/pom.xml to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT.pom
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT-sources.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT-sources.jar
[INFO]
[INFO] --- maven-deploy-plugin:2.7:deploy (default-deploy) @ co.codewizards.cloudstore.test ---
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml
Downloaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 143.3 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190811.084506-18.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190811.084506-18.jar (7 KB at 2141.9 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190811.084506-18.pom
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190811.084506-18.pom (6 KB at 2583.5 KB/sec)
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
Downloaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (398 B at 129.6 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 501.5 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (398 B at 194.3 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190811.084506-18-sources.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190811.084506-18-sources.jar (3 KB at 2148.4 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB)
[INFO]
[INFO] --- maven-site-plugin:3.3:site (default-site) @ co.codewizards.cloudstore.test ---
[INFO] Relativizing decoration links with respect to project URL: http://cloudstore.codewizards.co/co.codewizards.cloudstore.test
[INFO] Rendering site with org.apache.maven.skins:maven-default-skin:jar:1.0 skin.
[INFO] Relativizing decoration links with respect to project URL: http://cloudstore.codewizards.co/co.codewizards.cloudstore.test/de
[INFO] Rendering site with org.apache.maven.skins:maven-default-skin:jar:1.0 skin.
[JENKINS] Archiving site from /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/site to /home/tomcat/.jenkins/jobs/co.codewizards.cloudstore/site/co.codewizards.cloudstore.test
[WARNING] Failed to getClass for org.apache.maven.plugin.javadoc.JavadocReport
[INFO]
[INFO] --- maven-javadoc-plugin:2.9.1:javadoc (javadoc-generate-unfiltered) @ co.codewizards.cloudstore.test ---
[INFO]
[INFO] --- maven-resources-plugin:2.5:copy-resources (javadoc-filter) @ co.codewizards.cloudstore.test ---
[debug] execute contextualize
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/javadoc.unfiltered
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/javadoc.unfiltered
[INFO]
[INFO] --- maven-resources-plugin:2.5:copy-resources (javadoc-copy-to-site) @ co.codewizards.cloudstore.test ---
[debug] execute contextualize
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/apidocs
[INFO]
[INFO] --- maven-site-plugin:3.3:deploy (default-deploy) @ co.codewizards.cloudstore.test ---
file:/tmp/cloudstore-junk/ - Session: Opened
[INFO] Pushing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/site
[INFO] >>> to file:/tmp/cloudstore-junk/co.codewizards.cloudstore.test
[INFO] >>> 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