SuccessConsole Output

Skipping 1,597 KB.. Full Log
RepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 remoteRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
11:02:13.682 [pool-4-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:02:13.696 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:02:13.696 [pool-4-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:02:13.696 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:02:13.696 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:02:13.696 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [23fc8288]getCloseDeferredMillis: closeDeferredMillis=0
11:02:13.696 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [23fc8288]close: Closing real LocalRepoManager immediately.
11:02:13.696 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [23fc8288]_close: Shutting down real LocalRepoManager.
11:02:16.024 [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/k1er4nr6-of6ta-local/.cloudstore-repo/tmp/ChangeSetDto.b3a7a03b-9cab-4429-a0ff-c98ff401b950.null.xml.gz
11:02:16.025 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 77.11%
11:02:16.025 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
11:02:16.026 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
11:02:16.049 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [132a2a60]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:16.050 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [132a2a60]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:17.040 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [132a2a60]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:17.041 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [132a2a60]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 991 ms.
11:02:17.067 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [132a2a60]getCloseDeferredMillis: closeDeferredMillis=0
11:02:17.067 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [132a2a60]close: Closing real LocalRepoManager immediately.
11:02:17.067 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [132a2a60]_close: Shutting down real LocalRepoManager.
11:02:18.588 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [6fe5dc97]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:18.589 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [6fe5dc97]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:19.290 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [6fe5dc97]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:19.291 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [6fe5dc97]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 701 ms.
11:02:19.341 [qtp1926486956-25] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 remoteRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 localRepositoryRevisionSynced=15
11:02:19.755 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [69a031a4]initPersistenceManagerFactory: repositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
11:02:20.470 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [6fe5dc97]getCloseDeferredMillis: closeDeferredMillis=0
11:02:20.470 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [6fe5dc97]close: Closing real LocalRepoManager immediately.
11:02:20.470 [qtp1926486956-25] INFO  c.c.c.l.LocalRepoManagerImpl - [6fe5dc97]_close: Shutting down real LocalRepoManager.
11:02:20.474 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [69a031a4]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 34145 ms.
11:02:20.520 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [42fc744]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erb61y-zsc86-remote'
11:02:20.524 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [42fc744]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erb61y-zsc86-remote' locked successfully.
11:02:22.491 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 remoteRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 transaction.localRevision=94 remoteFromLocalRevision=15
11:02:22.519 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
11:02:22.519 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [6b6606d1]getCloseDeferredMillis: closeDeferredMillis=0
11:02:22.519 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [6b6606d1]close: Closing real LocalRepoManager immediately.
11:02:22.519 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [6b6606d1]_close: Shutting down real LocalRepoManager.
11:02:27.914 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
11:02:27.914 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restoring backup: 'target/repo/k1er4nr7-zqb2q-remote.bak' => 'target/repo/k1er4nr7-zqb2q-remote'
11:02:27.967 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restored backup: 'target/repo/k1er4nr7-zqb2q-remote.bak' => 'target/repo/k1er4nr7-zqb2q-remote'
11:02:27.967 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
11:02:27.968 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [52fed5b7]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr6-of6ta-local'
11:02:27.969 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [52fed5b7]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr6-of6ta-local' locked successfully.
11:02:28.920 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [52fed5b7]initPersistenceManagerFactory: repositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527
11:02:28.921 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [52fed5b7]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 952 ms.
11:02:29.086 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [13bcefca]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:29.086 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [13bcefca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:30.398 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [13bcefca]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:30.399 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [13bcefca]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1312 ms.
11:02:30.418 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [13bcefca]getCloseDeferredMillis: closeDeferredMillis=0
11:02:30.418 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [13bcefca]close: Closing real LocalRepoManager immediately.
11:02:30.418 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [13bcefca]_close: Shutting down real LocalRepoManager.
11:02:32.029 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 0.50%
11:02:32.030 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b3a7a03b-9cab-4429-a0ff-c98ff401b950 from='https://localhost:46443/b3a7a03b-9cab-4429-a0ff-c98ff401b950' toID=d04d2a7f-6361-46e6-8c95-64da7d9f0527 to='target/repo/k1er4nr6-of6ta-local', fromRepoLocalSync=true
11:02:32.031 [pool-9-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing d04d2a7f-6361-46e6-8c95-64da7d9f0527 ('target/repo/k1er4nr6-of6ta-local')
11:02:32.095 [pool-9-thread-1] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 12.94%
11:02:32.153 [pool-9-thread-1] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 19.03%
11:02:32.197 [pool-9-thread-1] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 24.15%
11:02:32.242 [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/k1er4nr6-of6ta-local/.cloudstore-repo/tmp/ChangeSetDto.b3a7a03b-9cab-4429-a0ff-c98ff401b950.15.xml.gz
11:02:32.266 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [626f8828]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:32.266 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [626f8828]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:33.592 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [626f8828]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:33.593 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [626f8828]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1327 ms.
11:02:33.628 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [626f8828]getCloseDeferredMillis: closeDeferredMillis=0
11:02:33.629 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [626f8828]close: Closing real LocalRepoManager immediately.
11:02:33.629 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [626f8828]_close: Shutting down real LocalRepoManager.
11:02:34.467 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 serverRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 renewalDateTime=2019-10-06T09:29:28.439Z expiryDateTime=2019-10-06T09:59:28.439Z
11:02:34.480 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [1f58d346]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:34.480 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [1f58d346]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:35.954 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [1f58d346]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:35.954 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [1f58d346]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1474 ms.
11:02:35.977 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [1f58d346]getCloseDeferredMillis: closeDeferredMillis=0
11:02:35.978 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [1f58d346]close: Closing real LocalRepoManager immediately.
11:02:35.978 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [1f58d346]_close: Shutting down real LocalRepoManager.
11:02:37.978 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [46346974]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:37.979 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [46346974]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:39.074 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1b84d03d]initPersistenceManagerFactory: repositoryId=83af3661-e90c-4176-9ab4-2299068bd8da
11:02:39.098 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1b84d03d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 21444 ms.
localRoot: k1erbnqr-hbq1p-local
localRepositoryId: 83af3661-e90c-4176-9ab4-2299068bd8da
11:02:39.129 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [b3cbc0e]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erbnqs-ln9vx-remote'
11:02:39.132 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [b3cbc0e]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erbnqs-ln9vx-remote' locked successfully.
11:02:39.433 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [46346974]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:39.433 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [46346974]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1453 ms.
11:02:39.463 [pool-4-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
11:02:39.475 [pool-4-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
11:02:39.497 [pool-4-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
11:02:39.518 [pool-4-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
11:02:39.524 [pool-4-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
11:02:39.539 [pool-4-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
11:02:39.560 [pool-4-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
11:02:39.587 [pool-4-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
11:02:39.598 [pool-4-thread-3] WARN  c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=15 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=6
11:02:39.692 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:02:39.695 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:39.695 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: d04d2a7f-6361-46e6-8c95-64da7d9f0527
11:02:39.695 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:02:39.695 [pool-4-thread-3] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 remoteRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 localRepositoryRevisionSynced=15 localRepositoryRevisionInProgress=8
11:02:39.701 [pool-4-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:02:39.707 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:02:39.707 [pool-4-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:02:39.707 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:02:39.707 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:02:39.708 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [46346974]getCloseDeferredMillis: closeDeferredMillis=0
11:02:39.708 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [46346974]close: Closing real LocalRepoManager immediately.
11:02:39.708 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [46346974]_close: Shutting down real LocalRepoManager.
11:02:42.960 [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/k1er4nr6-of6ta-local/.cloudstore-repo/tmp/ChangeSetDto.b3a7a03b-9cab-4429-a0ff-c98ff401b950.15.xml.gz
11:02:42.960 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 27.36%
11:02:42.961 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
11:02:42.961 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
11:02:42.983 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [1721e70]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:42.983 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [1721e70]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:43.925 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [1721e70]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:43.926 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [1721e70]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 942 ms.
11:02:43.954 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [1721e70]getCloseDeferredMillis: closeDeferredMillis=0
11:02:43.954 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [1721e70]close: Closing real LocalRepoManager immediately.
11:02:43.954 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [1721e70]_close: Shutting down real LocalRepoManager.
11:02:46.262 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [2a0593ff]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:46.262 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [2a0593ff]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:48.899 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [2a0593ff]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:48.900 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [2a0593ff]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2637 ms.
11:02:48.968 [qtp1926486956-243] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 remoteRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 localRepositoryRevisionSynced=8
11:02:48.986 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [2a0593ff]getCloseDeferredMillis: closeDeferredMillis=0
11:02:48.986 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [2a0593ff]close: Closing real LocalRepoManager immediately.
11:02:48.986 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [2a0593ff]_close: Shutting down real LocalRepoManager.
11:02:51.836 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 remoteRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 transaction.localRevision=95 remoteFromLocalRevision=8
11:02:52.194 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 50.25%
11:02:52.194 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=d04d2a7f-6361-46e6-8c95-64da7d9f0527 from='target/repo/k1er4nr6-of6ta-local' toID=b3a7a03b-9cab-4429-a0ff-c98ff401b950 to='https://localhost:46443/b3a7a03b-9cab-4429-a0ff-c98ff401b950'
11:02:52.227 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [4ce9ee79]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:52.228 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [4ce9ee79]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:54.011 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [4ce9ee79]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:54.011 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [4ce9ee79]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1783 ms.
11:02:54.037 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [4ce9ee79]getCloseDeferredMillis: closeDeferredMillis=0
11:02:54.037 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [4ce9ee79]close: Closing real LocalRepoManager immediately.
11:02:54.037 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [4ce9ee79]_close: Shutting down real LocalRepoManager.
11:02:55.972 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [b32e9a2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:02:55.972 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [b32e9a2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:02:58.376 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [b32e9a2]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:02:58.376 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [b32e9a2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2403 ms.
11:02:58.403 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [b32e9a2]getCloseDeferredMillis: closeDeferredMillis=0
11:02:58.403 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [b32e9a2]close: Closing real LocalRepoManager immediately.
11:02:58.403 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [b32e9a2]_close: Shutting down real LocalRepoManager.
11:03:03.923 [main] WARN  c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=84 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=89
11:03:03.992 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:03:03.997 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: d04d2a7f-6361-46e6-8c95-64da7d9f0527
11:03:03.998 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:03.998 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:03:03.998 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 remoteRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=95
11:03:04.011 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:03:04.064 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:03:04.064 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:03:04.064 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:03:04.064 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:03:04.065 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 52.24%
11:03:04.066 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
11:03:04.084 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [177a903]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:04.084 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [177a903]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:06.021 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [177a903]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:06.022 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [177a903]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1937 ms.
11:03:06.049 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [177a903]getCloseDeferredMillis: closeDeferredMillis=0
11:03:06.049 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [177a903]close: Closing real LocalRepoManager immediately.
11:03:06.049 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [177a903]_close: Shutting down real LocalRepoManager.
11:03:07.247 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [5244235a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:07.248 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [5244235a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:09.026 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [5244235a]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:09.026 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [5244235a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1777 ms.
11:03:09.202 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [5244235a]getCloseDeferredMillis: closeDeferredMillis=0
11:03:09.202 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [5244235a]close: Closing real LocalRepoManager immediately.
11:03:09.202 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [5244235a]_close: Shutting down real LocalRepoManager.
11:03:11.252 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 58.34%
11:03:11.258 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 64.45%
11:03:11.258 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 70.56%
11:03:11.258 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
11:03:11.299 [qtp1926486956-55] INFO  c.c.c.l.LocalRepoManagerImpl - [1661b5bf]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:11.299 [qtp1926486956-55] INFO  c.c.c.l.LocalRepoManagerImpl - [1661b5bf]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:13.340 [qtp1926486956-55] INFO  c.c.c.l.LocalRepoManagerImpl - [1661b5bf]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:13.340 [qtp1926486956-55] INFO  c.c.c.l.LocalRepoManagerImpl - [1661b5bf]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2041 ms.
11:03:13.363 [qtp1926486956-55] INFO  c.c.c.l.LocalRepoManagerImpl - [1661b5bf]getCloseDeferredMillis: closeDeferredMillis=0
11:03:13.363 [qtp1926486956-55] INFO  c.c.c.l.LocalRepoManagerImpl - [1661b5bf]close: Closing real LocalRepoManager immediately.
11:03:13.364 [qtp1926486956-55] INFO  c.c.c.l.LocalRepoManagerImpl - [1661b5bf]_close: Shutting down real LocalRepoManager.
11:03:15.806 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [2cc32c2c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:15.806 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [2cc32c2c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:17.486 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [2cc32c2c]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:17.486 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [2cc32c2c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1679 ms.
11:03:17.524 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [2cc32c2c]getCloseDeferredMillis: closeDeferredMillis=0
11:03:17.524 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [2cc32c2c]close: Closing real LocalRepoManager immediately.
11:03:17.524 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [2cc32c2c]_close: Shutting down real LocalRepoManager.
11:03:19.742 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='1124c8564e9b93bff0f41a80a7bb9385a6d311c6' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
Oct 06, 2019 11:03:19 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
11:03:19.768 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [190284bd]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:19.769 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [190284bd]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:19.844 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [42fc744]initPersistenceManagerFactory: repositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb
11:03:19.866 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [42fc744]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 30664 ms.
11:03:20.244 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=404.0 MiB, used=42.4 MiB, available=3.4 GiB
Successfully requested to connect the following local and remote repositories:

  localRepository.repositoryId = f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erb61x-yrab5-local
  localRepository.publicKeySha1 = 01:3D:78:7E:61:8D:FC:93:EA:24:91:BF:2E:2D:57:21:F3:02:E2:A7

  remoteRepository.repositoryId = a2e22db5-639a-47e5-bb28-33e11b20e5cb
  remoteRepository.remoteRoot = https://localhost:35211/a2e22db5-639a-47e5-bb28-33e11b20e5cb
  remoteRepository.publicKeySha1 = F6:52:98:52:C1:8E:D5:27:F3:47:3C:E0:BF:D3:C7:BB:3E:06:18:64

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 f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 a2e22db5-639a-47e5-bb28-33e11b20e5cb
11:03:21.102 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=405.0 MiB, used=35.8 MiB, available=3.4 GiB
Successfully accepted the connection request for the following local and remote repositories:

  localRepository.repositoryId = a2e22db5-639a-47e5-bb28-33e11b20e5cb
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erb61y-zsc86-remote
  localRepository.publicKeySha1 = F6:52:98:52:C1:8E:D5:27:F3:47:3C:E0:BF:D3:C7:BB:3E:06:18:64

  remoteRepository.repositoryId = f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
  remoteRepository.publicKeySha1 = 01:3D:78:7E:61:8D:FC:93:EA:24:91:BF:2E:2D:57:21:F3:02:E2:A7

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 a2e22db5-639a-47e5-bb28-33e11b20e5cb f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
11:03:21.197 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [190284bd]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:21.198 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [190284bd]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1428 ms.
11:03:21.237 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [190284bd]getCloseDeferredMillis: closeDeferredMillis=0
11:03:21.238 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [190284bd]close: Closing real LocalRepoManager immediately.
11:03:21.238 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [190284bd]_close: Shutting down real LocalRepoManager.
WatchTaskFirstWrittenChunk started
11:03:22.002 [pool-24-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
11:03:22.003 [pool-24-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=a2e22db5-639a-47e5-bb28-33e11b20e5cb from='https://localhost:35211/a2e22db5-639a-47e5-bb28-33e11b20e5cb' toID=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 to='target/repo/k1erb61x-yrab5-local', fromRepoLocalSync=true
11:03:22.003 [pool-25-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 ('target/repo/k1erb61x-yrab5-local')
11:03:22.051 [pool-25-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
11:03:22.080 [pool-25-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
11:03:22.360 [pool-24-thread-2] 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/k1erb61x-yrab5-local/.cloudstore-repo/tmp/ChangeSetDto.a2e22db5-639a-47e5-bb28-33e11b20e5cb.-1.xml.gz
11:03:22.425 [pool-24-thread-2] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 serverRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb renewalDateTime=2019-10-06T09:33:22.388Z expiryDateTime=2019-10-06T10:03:22.388Z
11:03:22.447 [pool-5-thread-6] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
11:03:22.459 [pool-5-thread-6] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
11:03:22.481 [pool-5-thread-6] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.16%
11:03:22.486 [pool-5-thread-6] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 60.32%
11:03:22.491 [pool-5-thread-6] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 65.48%
11:03:22.496 [pool-5-thread-6] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 70.64%
11:03:22.804 [pool-5-thread-6] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
11:03:22.833 [pool-5-thread-6] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
11:03:22.910 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:03:22.912 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [4f54e890]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:22.913 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [4f54e890]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:22.923 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: a2e22db5-639a-47e5-bb28-33e11b20e5cb
11:03:22.923 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
11:03:22.923 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:03:22.923 [pool-5-thread-6] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb remoteRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
11:03:22.933 [pool-5-thread-6] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:03:22.963 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:03:22.964 [pool-5-thread-6] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:03:22.964 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:03:22.964 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:03:22.975 [pool-24-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/k1erb61x-yrab5-local/.cloudstore-repo/tmp/ChangeSetDto.a2e22db5-639a-47e5-bb28-33e11b20e5cb.-1.xml.gz
11:03:22.975 [pool-24-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
11:03:22.976 [pool-24-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
11:03:23.230 [pool-24-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
11:03:23.234 [pool-24-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
11:03:23.234 [pool-24-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/a'
11:03:23.320 [pool-24-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='b66fbb654ade3ab40cc945726c5e346af8c96aa0' to.sha1='<NoInstanceOf_NormalFileDto>'): /a
11:03:23.769 [pool-24-thread-2] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="a2e22db5-639a-47e5-bb28-33e11b20e5cb"] on repo=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
11:03:23.807 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [4f54e890]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:23.808 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [4f54e890]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 894 ms.
11:03:23.839 [pool-24-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/a'
createTempChunkFile: a; createNewFile=true
deleteOrFail: chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0.xml
FileWatcher: CHUNK_SIZE reached! chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0
WatchTaskChunksToFile: ready
11:03:24.635 [pool-24-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
11:03:24.635 [pool-24-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
11:03:24.677 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
11:03:24.678 [pool-26-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=a2e22db5-639a-47e5-bb28-33e11b20e5cb from='https://localhost:35211/a2e22db5-639a-47e5-bb28-33e11b20e5cb' toID=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 to='target/repo/k1erb61x-yrab5-local', fromRepoLocalSync=true
11:03:24.679 [pool-27-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 ('target/repo/k1erb61x-yrab5-local')
11:03:24.695 [pool-27-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
11:03:24.702 [pool-27-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 19.03%
11:03:24.704 [pool-27-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
11:03:24.724 [pool-26-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/k1erb61x-yrab5-local/.cloudstore-repo/tmp/ChangeSetDto.a2e22db5-639a-47e5-bb28-33e11b20e5cb.-1.xml.gz
11:03:24.724 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
11:03:24.725 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
11:03:24.733 [pool-26-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/a'
11:03:24.798 [pool-26-thread-3] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 serverRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb renewalDateTime=2019-10-06T09:33:22.388Z expiryDateTime=2019-10-06T10:03:22.388Z
11:03:24.858 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [4f54e890]getCloseDeferredMillis: closeDeferredMillis=0
11:03:24.859 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [4f54e890]close: Closing real LocalRepoManager immediately.
11:03:24.859 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [4f54e890]_close: Shutting down real LocalRepoManager.
11:03:24.874 [pool-26-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='b66fbb654ade3ab40cc945726c5e346af8c96aa0' to.sha1='da39a3ee5e6b4b0d3255bfef95601890afd80709'): /a
11:03:24.899 [pool-26-thread-3] WARN  c.c.c.l.t.FileRepoTransport - Unexpected state: markFileInProgress==null='false', inProgress='true' on repo=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
11:03:24.899 [pool-26-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 2 total). path='/a'
createTempChunkFile: a; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34, chunksCreated=1
deleteOrFail: chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34.xml
11:03:25.362 [pool-26-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 8065 bytes in 463 ms. path='/a'
11:03:25.373 [pool-26-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
watchForCreationsDeletions: ENTRY_DELETE=chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0, chunksDeleted=1
11:03:25.391 [pool-26-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34 into destFile a
watchForCreationsDeletions: ENTRY_DELETE=chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34, chunksDeleted=2
deleteOrFail: chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0.xml
WatchTaskChunksToFile: length reached! length=1056641
deleteOrFail: chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_mh34.xml
11:03:25.985 [pool-26-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="a2e22db5-639a-47e5-bb28-33e11b20e5cb"] on repo=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
11:03:26.029 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
11:03:26.030 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
11:03:26.088 [qtp656152832-294] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb remoteRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 localRepositoryRevisionSynced=3
11:03:26.120 [pool-26-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 remoteRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb transaction.localRevision=9 remoteFromLocalRevision=3
11:03:26.138 [pool-26-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 from='target/repo/k1erb61x-yrab5-local' toID=a2e22db5-639a-47e5-bb28-33e11b20e5cb to='https://localhost:35211/a2e22db5-639a-47e5-bb28-33e11b20e5cb'
11:03:26.414 [pool-26-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:03:26.420 [pool-26-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
11:03:26.421 [pool-26-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: a2e22db5-639a-47e5-bb28-33e11b20e5cb
11:03:26.421 [pool-26-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:03:26.421 [pool-26-thread-3] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 remoteRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=9
11:03:26.430 [pool-26-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:03:26.437 [pool-26-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:03:26.437 [pool-26-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:03:26.437 [pool-26-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:03:26.437 [pool-26-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:03:26.438 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 52.24%
11:03:26.438 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 63.43%
11:03:26.438 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 74.63%
11:03:26.453 [pool-26-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 remoteRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb localRepositoryRevisionSynced=9
11:03:26.770 [qtp656152832-294] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb remoteRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 transaction.localRevision=6 remoteFromLocalRevision=9
11:03:26.885 [pool-26-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=a2e22db5-639a-47e5-bb28-33e11b20e5cb from='https://localhost:35211/a2e22db5-639a-47e5-bb28-33e11b20e5cb' toID=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 to='target/repo/k1erb61x-yrab5-local', fromRepoLocalSync=false
11:03:26.887 [pool-26-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/k1erb61x-yrab5-local/.cloudstore-repo/tmp/ChangeSetDto.a2e22db5-639a-47e5-bb28-33e11b20e5cb.null.xml.gz
11:03:27.125 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:03:27.134 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: a2e22db5-639a-47e5-bb28-33e11b20e5cb
11:03:27.134 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: f9f28446-b7f3-48bc-a7cf-a66ed5e26d53
11:03:27.134 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:03:27.134 [pool-5-thread-6] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb remoteRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
11:03:27.136 [pool-5-thread-6] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:03:27.138 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:03:27.139 [pool-5-thread-6] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:03:27.139 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:03:27.139 [pool-5-thread-6] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:03:27.149 [pool-26-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/k1erb61x-yrab5-local/.cloudstore-repo/tmp/ChangeSetDto.a2e22db5-639a-47e5-bb28-33e11b20e5cb.null.xml.gz
11:03:27.150 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
11:03:27.151 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
11:03:27.185 [qtp656152832-294] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb remoteRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 localRepositoryRevisionSynced=6
11:03:27.746 [pool-26-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=f9f28446-b7f3-48bc-a7cf-a66ed5e26d53 remoteRepositoryId=a2e22db5-639a-47e5-bb28-33e11b20e5cb transaction.localRevision=12 remoteFromLocalRevision=6
11:03:28.098 [pool-26-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
11:03:28.284 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="d04d2a7f-6361-46e6-8c95-64da7d9f0527"] on repo=d04d2a7f-6361-46e6-8c95-64da7d9f0527
11:03:28.310 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
11:03:28.346 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [64378ba]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:28.347 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [64378ba]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
hasCorrectAmountOfCreationsDeletions: toBeCreated=1, chunksCreated=1, toBeDeleted=2, chunksDeleted=2
11:03:28.617 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [69a031a4]getCloseDeferredMillis: closeDeferredMillis=20000
11:03:28.618 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [69a031a4]close: Deferring shut down of real LocalRepoManager 20000 ms.
11:03:28.618 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [42fc744]getCloseDeferredMillis: closeDeferredMillis=20000
11:03:28.618 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [42fc744]close: Deferring shut down of real LocalRepoManager 20000 ms.
11:03:29.054 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [489e1887]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erebyv-bg3oy-local'
11:03:29.063 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [489e1887]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erebyv-bg3oy-local' locked successfully.
11:03:29.269 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [64378ba]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:29.270 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [64378ba]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 923 ms.
11:03:29.294 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [64378ba]getCloseDeferredMillis: closeDeferredMillis=0
11:03:29.294 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [64378ba]close: Closing real LocalRepoManager immediately.
11:03:29.294 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [64378ba]_close: Shutting down real LocalRepoManager.
11:03:31.709 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [59956ecb]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:31.710 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [59956ecb]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:34.416 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [59956ecb]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:34.416 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [59956ecb]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2706 ms.
11:03:34.466 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [59956ecb]getCloseDeferredMillis: closeDeferredMillis=0
11:03:34.466 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [59956ecb]close: Closing real LocalRepoManager immediately.
11:03:34.466 [qtp1926486956-240] INFO  c.c.c.l.LocalRepoManagerImpl - [59956ecb]_close: Shutting down real LocalRepoManager.
11:03:36.288 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 51480 bytes in 7978 ms. path='/3/zzz'
Oct 06, 2019 11:03:36 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
11:03:36.306 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [277c17dc]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:36.307 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [277c17dc]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:37.399 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [277c17dc]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:37.399 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [277c17dc]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1091 ms.
11:03:37.425 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [277c17dc]getCloseDeferredMillis: closeDeferredMillis=0
11:03:37.425 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [277c17dc]close: Closing real LocalRepoManager immediately.
11:03:37.425 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [277c17dc]_close: Shutting down real LocalRepoManager.
11:03:38.444 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [602fa538]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:38.446 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [602fa538]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:40.677 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [602fa538]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:40.677 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [602fa538]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2229 ms.
11:03:40.712 [qtp1926486956-27] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
11:03:41.166 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [602fa538]getCloseDeferredMillis: closeDeferredMillis=0
11:03:41.166 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [602fa538]close: Closing real LocalRepoManager immediately.
11:03:41.166 [qtp1926486956-27] INFO  c.c.c.l.LocalRepoManagerImpl - [602fa538]_close: Shutting down real LocalRepoManager.
11:03:43.730 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [b3cbc0e]initPersistenceManagerFactory: repositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e
11:03:43.986 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [b3cbc0e]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 25191 ms.
remoteRoot: k1erbnqs-ln9vx-remote
remoteRepositoryId: c61466f8-7e15-4e22-9584-b0e0c5d1ea1e
11:03:44.356 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=416.0 MiB, used=42.8 MiB, available=3.4 GiB
Successfully requested to connect the following local and remote repositories:

  localRepository.repositoryId = 83af3661-e90c-4176-9ab4-2299068bd8da
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erbnqr-hbq1p-local
  localRepository.publicKeySha1 = 79:B3:6E:CA:68:3C:84:1B:B4:82:CE:7A:F7:67:DC:FB:5E:0C:7F:6D

  remoteRepository.repositoryId = c61466f8-7e15-4e22-9584-b0e0c5d1ea1e
  remoteRepository.remoteRoot = https://localhost:41121/c61466f8-7e15-4e22-9584-b0e0c5d1ea1e
  remoteRepository.publicKeySha1 = FB:92:DC:C7:7B:DD:7E:59:37:61:FA:D9:51:B6:22:AC:F4:8B:D2:33

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 83af3661-e90c-4176-9ab4-2299068bd8da c61466f8-7e15-4e22-9584-b0e0c5d1ea1e
11:03:45.442 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=417.0 MiB, used=36.5 MiB, available=3.4 GiB
11:03:45.556 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="d04d2a7f-6361-46e6-8c95-64da7d9f0527"] on repo=d04d2a7f-6361-46e6-8c95-64da7d9f0527
Successfully accepted the connection request for the following local and remote repositories:

  localRepository.repositoryId = c61466f8-7e15-4e22-9584-b0e0c5d1ea1e
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erbnqs-ln9vx-remote
  localRepository.publicKeySha1 = FB:92:DC:C7:7B:DD:7E:59:37:61:FA:D9:51:B6:22:AC:F4:8B:D2:33

  remoteRepository.repositoryId = 83af3661-e90c-4176-9ab4-2299068bd8da
  remoteRepository.publicKeySha1 = 79:B3:6E:CA:68:3C:84:1B:B4:82:CE:7A:F7:67:DC:FB:5E:0C:7F:6D

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 c61466f8-7e15-4e22-9584-b0e0c5d1ea1e 83af3661-e90c-4176-9ab4-2299068bd8da
11:03:45.665 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
11:03:45.683 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 remoteRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 localRepositoryRevisionSynced=95
11:03:45.708 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [17686c91]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:45.708 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [17686c91]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:46.621 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 0.50%
11:03:46.622 [pool-9-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 83af3661-e90c-4176-9ab4-2299068bd8da ('target/repo/k1erbnqr-hbq1p-local')
11:03:46.622 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e from='https://localhost:41121/c61466f8-7e15-4e22-9584-b0e0c5d1ea1e' toID=83af3661-e90c-4176-9ab4-2299068bd8da to='target/repo/k1erbnqr-hbq1p-local', fromRepoLocalSync=true
11:03:46.660 [pool-9-thread-1] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 12.94%
11:03:46.670 [pool-9-thread-1] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 25.12%
11:03:46.677 [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/k1erbnqr-hbq1p-local/.cloudstore-repo/tmp/ChangeSetDto.c61466f8-7e15-4e22-9584-b0e0c5d1ea1e.-1.xml.gz
11:03:46.743 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da serverRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e renewalDateTime=2019-10-06T09:33:46.698Z expiryDateTime=2019-10-06T10:03:46.698Z
11:03:46.768 [pool-4-thread-4] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
11:03:46.783 [pool-4-thread-4] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
11:03:46.813 [pool-4-thread-4] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.69%
11:03:47.098 [pool-4-thread-4] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 64.60%
11:03:47.110 [pool-4-thread-4] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 74.40%
11:03:47.149 [pool-4-thread-4] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 84.20%
11:03:47.225 [pool-4-thread-4] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 94.00%
11:03:47.404 [pool-4-thread-4] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
11:03:47.548 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:03:47.553 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: c61466f8-7e15-4e22-9584-b0e0c5d1ea1e
11:03:47.553 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 83af3661-e90c-4176-9ab4-2299068bd8da
11:03:47.553 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:03:47.553 [pool-4-thread-4] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e remoteRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
11:03:47.560 [pool-4-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:03:47.602 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:03:47.602 [pool-4-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:03:47.602 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:03:47.602 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:03:47.643 [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/k1erbnqr-hbq1p-local/.cloudstore-repo/tmp/ChangeSetDto.c61466f8-7e15-4e22-9584-b0e0c5d1ea1e.-1.xml.gz
11:03:47.645 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
11:03:47.791 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [17686c91]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:47.792 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [17686c91]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2084 ms.
11:03:47.821 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [17686c91]getCloseDeferredMillis: closeDeferredMillis=0
11:03:47.821 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [17686c91]close: Closing real LocalRepoManager immediately.
11:03:47.821 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [17686c91]_close: Shutting down real LocalRepoManager.
11:03:48.072 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/#4'
11:03:48.159 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/1 {11 11ä11#+} 1'
11:03:48.399 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 30.33%
11:03:48.400 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2'
11:03:48.470 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2/1 {11 11ä11#+} 1'
11:03:48.619 [closeDeferredTimer-69a031a4-1] INFO  c.c.c.l.LocalRepoManagerImpl - [69a031a4]_close: Shutting down real LocalRepoManager.
11:03:48.706 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
11:03:48.740 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/5#'
11:03:48.956 [closeDeferredTimer-42fc744-1] INFO  c.c.c.l.LocalRepoManagerImpl - [42fc744]_close: Shutting down real LocalRepoManager.
11:03:48.964 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 35.59%
11:03:48.965 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 40.86%
11:03:48.965 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/#b'
11:03:49.024 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c75b3c0607cf345ac3019760082e7782879beedb' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/#b
11:03:49.239 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [2b42cef6]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:49.240 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [2b42cef6]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:49.254 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:49.273 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/#b'
11:03:49.322 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 151708 bytes in 49 ms. path='/#4/#b'
11:03:49.328 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c691e3d4c979adbf07e3b97e33fdf3c89ed246f6_0 into destFile #b
11:03:49.525 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:50.596 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/a'
11:03:50.647 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='4075eb7587ca3a41606a4378aabda1ad8443c9d1' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/a
11:03:50.896 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:50.967 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/a'
11:03:51.019 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 70741 bytes in 51 ms. path='/#4/a'
11:03:51.024 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:03:51.300 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:51.591 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/c+'
11:03:51.641 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='ff3b8af28e47cd3c711387f23b873ee1e953aba6' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/c+
11:03:51.866 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:51.876 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/c+'
11:03:51.920 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 35712 bytes in 43 ms. path='/#4/c+'
11:03:51.925 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_8a30244b83c6cac3c79f8f95d30f96579c0f4c0b_0 into destFile c+
11:03:51.961 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [2b42cef6]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:51.961 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [2b42cef6]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2721 ms.
11:03:51.987 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:52.012 [qtp1926486956-23] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 remoteRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 transaction.localRevision=15 remoteFromLocalRevision=95
11:03:52.240 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [2b42cef6]getCloseDeferredMillis: closeDeferredMillis=0
11:03:52.240 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [2b42cef6]close: Closing real LocalRepoManager immediately.
11:03:52.240 [qtp1926486956-23] INFO  c.c.c.l.LocalRepoManagerImpl - [2b42cef6]_close: Shutting down real LocalRepoManager.
11:03:52.241 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/d$'
11:03:52.281 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='1ff53b99c73728ccc769db966b55e54d06dad1d8' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/d$
11:03:52.316 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:52.520 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/d$'
11:03:52.590 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 152145 bytes in 70 ms. path='/#4/d$'
11:03:52.594 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_a93a212f7eca012dceb852f364cc2c34026f0dd8_0 into destFile d$
11:03:53.314 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:53.349 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/a'
11:03:53.390 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='294e4fdf1ada5c659695e31688cfe08bf460a022' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/a
11:03:53.589 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:53.594 [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'
11:03:53.656 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 241410 bytes in 62 ms. path='/1 {11 11ä11#+} 1/a'
11:03:53.661 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:03:53.821 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:53.988 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/b'
11:03:54.041 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='0c631d26023523b7c3dec7a7817207630b09e2a0' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/b
11:03:54.147 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:54.174 [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'
11:03:54.299 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 660440 bytes in 125 ms. path='/1 {11 11ä11#+} 1/b'
11:03:54.304 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
11:03:54.570 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:54.724 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/c'
11:03:54.732 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 75.12%
11:03:54.733 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b3a7a03b-9cab-4429-a0ff-c98ff401b950 from='https://localhost:46443/b3a7a03b-9cab-4429-a0ff-c98ff401b950' toID=d04d2a7f-6361-46e6-8c95-64da7d9f0527 to='target/repo/k1er4nr6-of6ta-local', fromRepoLocalSync=false
11:03:54.734 [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/k1er4nr6-of6ta-local/.cloudstore-repo/tmp/ChangeSetDto.b3a7a03b-9cab-4429-a0ff-c98ff401b950.null.xml.gz
11:03:54.756 [qtp1926486956-244] INFO  c.c.c.l.LocalRepoManagerImpl - [6ce0b4f9]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:03:54.757 [qtp1926486956-244] INFO  c.c.c.l.LocalRepoManagerImpl - [6ce0b4f9]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:03:54.773 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='613e623bbe0d90ab9d756b4b3d65462f22f3a7b6' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/c
11:03:54.934 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:56.979 [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'
11:03:57.017 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 7914 bytes in 37 ms. path='/1 {11 11ä11#+} 1/c'
11:03:57.022 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
11:03:57.135 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:57.371 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 43.50%
11:03:57.372 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/a'
11:03:57.412 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='4069d345f0eb0fff65b22888ba0da39e71be2c7c' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/a
11:03:57.508 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:57.551 [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'
11:03:57.680 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 712712 bytes in 129 ms. path='/2/1 {11 11ä11#+} 1/a'
11:03:57.689 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:03:58.119 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:58.372 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/b'
11:03:58.407 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='99589481843e6df40d5685494cf1031003bbc1aa' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/b
11:03:58.534 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:58.554 [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'
11:03:58.674 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 588087 bytes in 120 ms. path='/2/1 {11 11ä11#+} 1/b'
11:03:58.680 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
11:03:58.889 [qtp1926486956-244] INFO  c.c.c.l.LocalRepoManagerImpl - [6ce0b4f9]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:03:58.890 [qtp1926486956-244] INFO  c.c.c.l.LocalRepoManagerImpl - [6ce0b4f9]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 4132 ms.
11:03:58.921 [qtp1926486956-244] INFO  c.c.c.l.LocalRepoManagerImpl - [6ce0b4f9]getCloseDeferredMillis: closeDeferredMillis=0
11:03:58.921 [qtp1926486956-244] INFO  c.c.c.l.LocalRepoManagerImpl - [6ce0b4f9]close: Closing real LocalRepoManager immediately.
11:03:58.921 [qtp1926486956-244] INFO  c.c.c.l.LocalRepoManagerImpl - [6ce0b4f9]_close: Shutting down real LocalRepoManager.
11:03:59.028 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:59.145 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/a'
11:03:59.192 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='9c7c74e9609f855517963d7670d1b2fb9990d402' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/a
11:03:59.259 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:59.264 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/a'
11:03:59.363 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 487620 bytes in 98 ms. path='/2/a'
11:03:59.370 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:03:59.515 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:59.726 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/a'
11:03:59.773 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='15ade57bc8807dd5dbe5c95e5cb57af96ea1bedb' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/a
11:03:59.795 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:03:59.801 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/a'
11:03:59.893 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 408858 bytes in 91 ms. path='/3/a'
11:03:59.898 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:04:00.138 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:04:00.398 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/b'
11:04:00.444 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='80e9947d576883e43e648cc659d291d46447df9c' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/b
11:04:00.511 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [32660307]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:04:00.513 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [32660307]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:04:00.723 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:04:00.797 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/b'
11:04:00.850 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 126306 bytes in 53 ms. path='/3/b'
11:04:00.855 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
11:04:01.177 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:04:01.448 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/c'
11:04:01.509 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='4143170ae142ddcbb003f9fe36c7e55518fc0655' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/c
11:04:01.554 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:04:01.624 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/c'
11:04:01.744 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 611400 bytes in 120 ms. path='/3/c'
11:04:01.751 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
11:04:01.997 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:04:02.053 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/d'
11:04:02.093 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='a86133bfb3c6598fa2103c7a0b488c015b3bcfc3' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/d
11:04:02.160 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:04:02.426 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/d'
11:04:02.498 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 254175 bytes in 72 ms. path='/3/d'
11:04:02.503 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
11:04:02.532 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [32660307]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:04:02.533 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [32660307]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2019 ms.
11:04:02.655 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:04:02.680 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:04:02.683 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:04:02.683 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: d04d2a7f-6361-46e6-8c95-64da7d9f0527
11:04:02.683 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:04:02.683 [pool-4-thread-3] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 remoteRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
11:04:02.691 [pool-4-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:04:02.699 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:04:02.699 [pool-4-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:04:02.699 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:04:02.699 [pool-4-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:04:02.699 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [32660307]getCloseDeferredMillis: closeDeferredMillis=0
11:04:02.699 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [32660307]close: Closing real LocalRepoManager immediately.
11:04:02.699 [pool-4-thread-3] INFO  c.c.c.l.LocalRepoManagerImpl - [32660307]_close: Shutting down real LocalRepoManager.
11:04:03.212 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 44.48%
11:04:03.213 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/5#/e'
11:04:03.260 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='84c02271413456221319371f289aabf2a3083325' to.sha1='<NoInstanceOf_NormalFileDto>'): /5#/e
11:04:03.528 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:04:03.539 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/5#/e'
11:04:03.581 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 25530 bytes in 42 ms. path='/5#/e'
11:04:03.587 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_58e6b3a414a1e090dfc6029add0f3555ccba127f_0 into destFile e
11:04:03.661 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="c61466f8-7e15-4e22-9584-b0e0c5d1ea1e"] on repo=83af3661-e90c-4176-9ab4-2299068bd8da
11:04:03.693 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 49.75%
11:04:03.748 [qtp777321155-30] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e remoteRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da localRepositoryRevisionSynced=3
11:04:03.923 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da remoteRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e transaction.localRevision=84 remoteFromLocalRevision=3
11:04:04.027 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=83af3661-e90c-4176-9ab4-2299068bd8da from='target/repo/k1erbnqr-hbq1p-local' toID=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e to='https://localhost:41121/c61466f8-7e15-4e22-9584-b0e0c5d1ea1e'
11:04:04.537 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:04:04.541 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 83af3661-e90c-4176-9ab4-2299068bd8da
11:04:04.541 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: c61466f8-7e15-4e22-9584-b0e0c5d1ea1e
11:04:04.541 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:04:04.541 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da remoteRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=84
11:04:04.548 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:04:04.556 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:04:04.556 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:04:04.556 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:04:04.556 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:04:04.557 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 63.43%
11:04:04.557 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
11:04:04.572 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da remoteRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e localRepositoryRevisionSynced=84
11:04:04.853 [qtp777321155-24] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e remoteRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da transaction.localRevision=6 remoteFromLocalRevision=84
11:04:04.852 [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/k1er4nr6-of6ta-local/.cloudstore-repo/tmp/ChangeSetDto.b3a7a03b-9cab-4429-a0ff-c98ff401b950.null.xml.gz
11:04:04.856 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 77.11%
11:04:04.856 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
11:04:04.856 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
11:04:04.881 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [77b37863]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:04:04.882 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [77b37863]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:04:05.390 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e from='https://localhost:41121/c61466f8-7e15-4e22-9584-b0e0c5d1ea1e' toID=83af3661-e90c-4176-9ab4-2299068bd8da to='target/repo/k1erbnqr-hbq1p-local', fromRepoLocalSync=false
11:04:05.391 [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/k1erbnqr-hbq1p-local/.cloudstore-repo/tmp/ChangeSetDto.c61466f8-7e15-4e22-9584-b0e0c5d1ea1e.null.xml.gz
11:04:05.790 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:04:05.794 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: c61466f8-7e15-4e22-9584-b0e0c5d1ea1e
11:04:05.795 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 83af3661-e90c-4176-9ab4-2299068bd8da
11:04:05.795 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:04:05.795 [pool-4-thread-4] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e remoteRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
11:04:05.797 [pool-4-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:04:05.799 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:04:05.799 [pool-4-thread-4] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:04:05.799 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:04:05.799 [pool-4-thread-4] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:04:05.810 [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/k1erbnqr-hbq1p-local/.cloudstore-repo/tmp/ChangeSetDto.c61466f8-7e15-4e22-9584-b0e0c5d1ea1e.null.xml.gz
11:04:05.811 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
11:04:05.811 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
11:04:05.830 [qtp777321155-28] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e remoteRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da localRepositoryRevisionSynced=6
11:04:05.857 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=83af3661-e90c-4176-9ab4-2299068bd8da remoteRepositoryId=c61466f8-7e15-4e22-9584-b0e0c5d1ea1e transaction.localRevision=87 remoteFromLocalRevision=6
11:04:06.053 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
11:04:06.167 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1b84d03d]getCloseDeferredMillis: closeDeferredMillis=20000
11:04:06.167 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1b84d03d]close: Deferring shut down of real LocalRepoManager 20000 ms.
11:04:06.168 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [b3cbc0e]getCloseDeferredMillis: closeDeferredMillis=20000
11:04:06.168 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [b3cbc0e]close: Deferring shut down of real LocalRepoManager 20000 ms.
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 886.767 sec - in co.codewizards.cloudstore.test.repotorepo.BasicRepoToRepoSyncIT
11:04:06.189 [Thread-4] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@60a725e8{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
11:04:06.191 [Thread-4] INFO  o.e.j.s.session - node0 Stopped scavenging
11:04:06.198 [Thread-4] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@40ac8eab{/,null,UNAVAILABLE}
11:04:06.208 [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/e52yInueDEuA8j99y4Ofpg/.cloudstore/localServerRunning.deleteToStop
11:04:06.219 [Thread-4] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@58b802b8{SSL,[ssl, http/1.1]}{0.0.0.0:41121}
11:04:06.220 [Thread-4] INFO  o.e.j.s.session - node0 Stopped scavenging
11:04:06.222 [Thread-4] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@71f75a5c{/,null,UNAVAILABLE}
11:04:07.175 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [77b37863]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:04:07.176 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [77b37863]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2294 ms.
11:04:07.201 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [77b37863]getCloseDeferredMillis: closeDeferredMillis=0
11:04:07.201 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [77b37863]close: Closing real LocalRepoManager immediately.
11:04:07.202 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [77b37863]_close: Shutting down real LocalRepoManager.
11:04:08.564 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [7425d6c5]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote'
11:04:08.565 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [7425d6c5]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1er4nr7-zqb2q-remote' locked successfully.
11:04:09.825 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [7425d6c5]initPersistenceManagerFactory: repositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950
11:04:09.826 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [7425d6c5]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1260 ms.
11:04:09.892 [qtp1926486956-243] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 remoteRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 localRepositoryRevisionSynced=15
11:04:09.966 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [7425d6c5]getCloseDeferredMillis: closeDeferredMillis=0
11:04:09.967 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [7425d6c5]close: Closing real LocalRepoManager immediately.
11:04:09.967 [qtp1926486956-243] INFO  c.c.c.l.LocalRepoManagerImpl - [7425d6c5]_close: Shutting down real LocalRepoManager.
11:04:11.124 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=d04d2a7f-6361-46e6-8c95-64da7d9f0527 remoteRepositoryId=b3a7a03b-9cab-4429-a0ff-c98ff401b950 transaction.localRevision=100 remoteFromLocalRevision=15
11:04:11.263 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
11:04:11.309 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [52fed5b7]getCloseDeferredMillis: closeDeferredMillis=0
11:04:11.309 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [52fed5b7]close: Closing real LocalRepoManager immediately.
11:04:11.309 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [52fed5b7]_close: Shutting down real LocalRepoManager.
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1,101.909 sec - in co.codewizards.cloudstore.test.repotorepo.BackupRestoreRepoToRepoSyncIT
11:04:13.881 [Thread-4] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@5244ec8c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
11:04:13.884 [Thread-4] INFO  o.e.j.s.session - node0 Stopped scavenging
11:04:13.890 [Thread-4] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@696edc5d{/,null,UNAVAILABLE}
11:04:13.902 [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/wS6q8ThKBLM9Ke4geJ8V2A/.cloudstore/localServerRunning.deleteToStop
11:04:13.908 [Thread-4] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@3c54531b{SSL,[ssl, http/1.1]}{0.0.0.0:46443}
11:04:13.910 [Thread-4] INFO  o.e.j.s.session - node0 Stopped scavenging
11:04:13.911 [Thread-4] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@3fd1504a{/,null,UNAVAILABLE}
11:04:24.512 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [489e1887]initPersistenceManagerFactory: repositoryId=ebe2328b-9f87-4308-8296-132efc720f7b
11:04:24.523 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [489e1887]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 14074 ms.
11:04:24.561 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [7c27ed2f]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erebyw-dd4ba-remote'
11:04:24.567 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [7c27ed2f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erebyw-dd4ba-remote' locked successfully.
11:04:52.990 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [7c27ed2f]initPersistenceManagerFactory: repositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6
11:04:53.025 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [7c27ed2f]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 11447 ms.
11:04:53.355 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=403.5 MiB, used=42.9 MiB, available=3.4 GiB
Successfully requested to connect the following local and remote repositories:

  localRepository.repositoryId = ebe2328b-9f87-4308-8296-132efc720f7b
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erebyv-bg3oy-local
  localRepository.publicKeySha1 = ED:58:19:72:5B:1E:B2:78:F7:F4:2A:D0:82:48:7B:D6:59:A9:C8:F3

  remoteRepository.repositoryId = 794a074d-a30a-4b21-ab78-7192cc7363d6
  remoteRepository.remoteRoot = https://localhost:35211/794a074d-a30a-4b21-ab78-7192cc7363d6
  remoteRepository.publicKeySha1 = B8:29:8B:B5:02:5E:65:02:9D:D5:50:06:70:1A:E1:90:63:8F:EE:65

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 ebe2328b-9f87-4308-8296-132efc720f7b 794a074d-a30a-4b21-ab78-7192cc7363d6
11:04:54.313 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=405.0 MiB, used=36.4 MiB, available=3.4 GiB
Successfully accepted the connection request for the following local and remote repositories:

  localRepository.repositoryId = 794a074d-a30a-4b21-ab78-7192cc7363d6
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erebyw-dd4ba-remote
  localRepository.publicKeySha1 = B8:29:8B:B5:02:5E:65:02:9D:D5:50:06:70:1A:E1:90:63:8F:EE:65

  remoteRepository.repositoryId = ebe2328b-9f87-4308-8296-132efc720f7b
  remoteRepository.publicKeySha1 = ED:58:19:72:5B:1E:B2:78:F7:F4:2A:D0:82:48:7B:D6:59:A9:C8:F3

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 794a074d-a30a-4b21-ab78-7192cc7363d6 ebe2328b-9f87-4308-8296-132efc720f7b
WatchTaskFirstWrittenChunk started
11:04:55.443 [pool-28-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
11:04:55.444 [pool-28-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=794a074d-a30a-4b21-ab78-7192cc7363d6 from='https://localhost:35211/794a074d-a30a-4b21-ab78-7192cc7363d6' toID=ebe2328b-9f87-4308-8296-132efc720f7b to='target/repo/k1erebyv-bg3oy-local', fromRepoLocalSync=true
11:04:55.444 [pool-29-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing ebe2328b-9f87-4308-8296-132efc720f7b ('target/repo/k1erebyv-bg3oy-local')
11:04:55.473 [pool-29-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
11:04:55.490 [pool-29-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
11:04:55.968 [pool-28-thread-2] 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/k1erebyv-bg3oy-local/.cloudstore-repo/tmp/ChangeSetDto.794a074d-a30a-4b21-ab78-7192cc7363d6.-1.xml.gz
11:04:56.034 [pool-28-thread-2] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b serverRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 renewalDateTime=2019-10-06T09:34:55.998Z expiryDateTime=2019-10-06T10:04:55.998Z
11:04:56.062 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
11:04:56.077 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
11:04:56.099 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.05%
11:04:56.105 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 60.11%
11:04:56.110 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 65.16%
11:04:56.116 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 70.22%
11:04:56.228 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
11:04:56.252 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
11:04:56.467 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:04:56.475 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 794a074d-a30a-4b21-ab78-7192cc7363d6
11:04:56.476 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ebe2328b-9f87-4308-8296-132efc720f7b
11:04:56.476 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:04:56.476 [pool-5-thread-7] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 remoteRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
11:04:56.483 [pool-5-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:04:56.504 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:04:56.504 [pool-5-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:04:56.504 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:04:56.504 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:04:56.516 [pool-28-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/k1erebyv-bg3oy-local/.cloudstore-repo/tmp/ChangeSetDto.794a074d-a30a-4b21-ab78-7192cc7363d6.-1.xml.gz
11:04:56.516 [pool-28-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
11:04:56.516 [pool-28-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
11:04:56.550 [pool-28-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
11:04:56.551 [pool-28-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
11:04:56.552 [pool-28-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/f1'
11:04:56.606 [pool-28-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='816072cc5e430ad3f198e45ae6826cfb930f7840' to.sha1='<NoInstanceOf_NormalFileDto>'): /f1
11:04:56.780 [pool-28-thread-2] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="794a074d-a30a-4b21-ab78-7192cc7363d6"] on repo=ebe2328b-9f87-4308-8296-132efc720f7b
11:04:56.784 [pool-28-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/f1'
createTempChunkFile: f1; createNewFile=true
deleteOrFail: chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_0.xml
FileWatcher: CHUNK_SIZE reached! chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_0
WatchTaskSyncOrder: checking for name=f1 and length=1078597
11:04:57.781 [pool-28-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
11:04:57.781 [pool-28-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
11:04:57.867 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
11:04:57.868 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=794a074d-a30a-4b21-ab78-7192cc7363d6 from='https://localhost:35211/794a074d-a30a-4b21-ab78-7192cc7363d6' toID=ebe2328b-9f87-4308-8296-132efc720f7b to='target/repo/k1erebyv-bg3oy-local', fromRepoLocalSync=true
11:04:57.868 [pool-31-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing ebe2328b-9f87-4308-8296-132efc720f7b ('target/repo/k1erebyv-bg3oy-local')
11:04:57.876 [pool-31-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
11:04:57.881 [pool-31-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 19.03%
11:04:57.884 [pool-31-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
11:04:57.896 [pool-30-thread-2] 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/k1erebyv-bg3oy-local/.cloudstore-repo/tmp/ChangeSetDto.794a074d-a30a-4b21-ab78-7192cc7363d6.-1.xml.gz
11:04:57.963 [pool-30-thread-2] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b serverRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 renewalDateTime=2019-10-06T09:34:55.998Z expiryDateTime=2019-10-06T10:04:55.998Z
11:04:57.989 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
11:04:57.990 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
11:04:58.008 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.06%
11:04:58.024 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 66.33%
11:04:58.026 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
11:04:58.027 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 82.67%
11:04:58.043 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 87.81%
11:04:58.058 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
11:04:58.438 [pool-5-thread-7] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
11:04:58.472 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:04:58.478 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 794a074d-a30a-4b21-ab78-7192cc7363d6
11:04:58.478 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ebe2328b-9f87-4308-8296-132efc720f7b
11:04:58.478 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:04:58.478 [pool-5-thread-7] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 remoteRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=5
11:04:58.480 [pool-5-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:04:58.485 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:04:58.486 [pool-5-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:04:58.486 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:04:58.486 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:04:58.497 [pool-30-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/k1erebyv-bg3oy-local/.cloudstore-repo/tmp/ChangeSetDto.794a074d-a30a-4b21-ab78-7192cc7363d6.-1.xml.gz
11:04:58.498 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
11:04:58.520 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 30.56%
11:04:58.527 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 36.96%
11:04:58.527 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/f1'
11:04:58.615 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='816072cc5e430ad3f198e45ae6826cfb930f7840' to.sha1='da39a3ee5e6b4b0d3255bfef95601890afd80709'): /f1
11:04:58.625 [pool-30-thread-2] WARN  c.c.c.l.t.FileRepoTransport - Unexpected state: markFileInProgress==null='false', inProgress='true' on repo=ebe2328b-9f87-4308-8296-132efc720f7b
11:04:58.626 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 2 total). path='/f1'
createTempChunkFile: f1; createNewFile=true
deleteOrFail: chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_mh34.xml
11:04:59.067 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 30021 bytes in 441 ms. path='/f1'
11:04:59.079 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_0 into destFile f1
WatchTaskSyncOrder: modified=f1, length=1048576
11:04:59.097 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_mh34 into destFile f1
deleteOrFail: chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_0.xml
WatchTaskSyncOrder: modified=f1, length=1078597
WatchTaskSyncOrder: length reached! currentChildFileLength=1078597, name=f1
deleteOrFail: chunk_c09bb890b096f7306f688cc6d1dad34e7e52a223_mh34.xml
WatchTaskSyncOrder: modified=f1, length=1078597
WatchTaskSyncOrder: length reached! currentChildFileLength=1078597, name=f1
11:04:59.892 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="794a074d-a30a-4b21-ab78-7192cc7363d6"] on repo=ebe2328b-9f87-4308-8296-132efc720f7b
11:04:59.917 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 43.35%
11:04:59.917 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/f0'
11:04:59.987 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='e75e4ffcbc2920ce7232a52cb09a6cdb3f05d0ec' to.sha1='<NoInstanceOf_NormalFileDto>'): /f0
11:05:00.051 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="794a074d-a30a-4b21-ab78-7192cc7363d6"] on repo=ebe2328b-9f87-4308-8296-132efc720f7b
11:05:00.072 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/f0'
createTempChunkFile: f0; createNewFile=true
deleteOrFail: chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_0.xml
createTempChunkFile: f0; createNewFile=true
deleteOrFail: chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_mh34.xml
11:05:01.086 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1059973 bytes in 1013 ms. path='/f0'
11:05:01.095 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_0 into destFile f0
WatchTaskSyncOrder: checking for name=f0 and length=1059973
WatchTaskSyncOrder: modified=f0, length=1048576
11:05:01.110 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_mh34 into destFile f0
deleteOrFail: chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_0.xml
WatchTaskSyncOrder: modified=f0, length=1059973
WatchTaskSyncOrder: length reached! currentChildFileLength=1059973, name=f0
deleteOrFail: chunk_ba7bfa56319c2cb60f96537b5e032e291ab838e0_mh34.xml
WatchTaskSyncOrder: modified=f0, length=1059973
WatchTaskSyncOrder: length reached! currentChildFileLength=1059973, name=f0
11:05:02.051 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="794a074d-a30a-4b21-ab78-7192cc7363d6"] on repo=ebe2328b-9f87-4308-8296-132efc720f7b
11:05:02.058 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/f2'
11:05:02.103 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='7d6e10fe6fef0aa4e665a229a5739b0f7cdf36fb' to.sha1='<NoInstanceOf_NormalFileDto>'): /f2
11:05:02.142 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="794a074d-a30a-4b21-ab78-7192cc7363d6"] on repo=ebe2328b-9f87-4308-8296-132efc720f7b
11:05:02.146 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/f2'
createTempChunkFile: f2; createNewFile=true
deleteOrFail: chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_0.xml
createTempChunkFile: f2; createNewFile=true
deleteOrFail: chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_mh34.xml
11:05:03.202 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1077946 bytes in 1056 ms. path='/f2'
11:05:03.210 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_0 into destFile f2
WatchTaskSyncOrder: checking for name=f2 and length=1077946
WatchTaskSyncOrder: modified=f2, length=1048576
11:05:03.229 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_mh34 into destFile f2
deleteOrFail: chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_0.xml
WatchTaskSyncOrder: modified=f2, length=1077946
WatchTaskSyncOrder: length reached! currentChildFileLength=1077946, name=f2
WatchTaskSyncOrder: finished all
deleteOrFail: chunk_cf1126f67238bf3e85fcc8c8737b72e80ddcfddb_mh34.xml
11:05:04.005 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="794a074d-a30a-4b21-ab78-7192cc7363d6"] on repo=ebe2328b-9f87-4308-8296-132efc720f7b
11:05:04.014 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 49.75%
11:05:04.068 [qtp656152832-296] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 remoteRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b localRepositoryRevisionSynced=5
11:05:04.143 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b remoteRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 transaction.localRevision=20 remoteFromLocalRevision=5
11:05:04.169 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=ebe2328b-9f87-4308-8296-132efc720f7b from='target/repo/k1erebyv-bg3oy-local' toID=794a074d-a30a-4b21-ab78-7192cc7363d6 to='https://localhost:35211/794a074d-a30a-4b21-ab78-7192cc7363d6'
11:05:04.415 [pool-30-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:05:04.421 [pool-30-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ebe2328b-9f87-4308-8296-132efc720f7b
11:05:04.421 [pool-30-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 794a074d-a30a-4b21-ab78-7192cc7363d6
11:05:04.421 [pool-30-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:05:04.421 [pool-30-thread-2] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b remoteRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=20
11:05:04.431 [pool-30-thread-2] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:05:04.437 [pool-30-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:05:04.437 [pool-30-thread-2] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:05:04.437 [pool-30-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:05:04.437 [pool-30-thread-2] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:05:04.437 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 63.43%
11:05:04.438 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 74.63%
11:05:04.452 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b remoteRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 localRepositoryRevisionSynced=20
11:05:04.498 [qtp656152832-296] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 remoteRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b transaction.localRevision=8 remoteFromLocalRevision=20
11:05:04.510 [pool-30-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=794a074d-a30a-4b21-ab78-7192cc7363d6 from='https://localhost:35211/794a074d-a30a-4b21-ab78-7192cc7363d6' toID=ebe2328b-9f87-4308-8296-132efc720f7b to='target/repo/k1erebyv-bg3oy-local', fromRepoLocalSync=false
11:05:04.511 [pool-30-thread-2] 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/k1erebyv-bg3oy-local/.cloudstore-repo/tmp/ChangeSetDto.794a074d-a30a-4b21-ab78-7192cc7363d6.null.xml.gz
11:05:04.553 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:05:04.556 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 794a074d-a30a-4b21-ab78-7192cc7363d6
11:05:04.556 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ebe2328b-9f87-4308-8296-132efc720f7b
11:05:04.556 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:05:04.556 [pool-5-thread-7] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 remoteRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b localRepositoryRevisionSynced=5 localRepositoryRevisionInProgress=8
11:05:04.558 [pool-5-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:05:04.560 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:05:04.560 [pool-5-thread-7] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:05:04.560 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:05:04.560 [pool-5-thread-7] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:05:04.570 [pool-30-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/k1erebyv-bg3oy-local/.cloudstore-repo/tmp/ChangeSetDto.794a074d-a30a-4b21-ab78-7192cc7363d6.null.xml.gz
11:05:04.570 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
11:05:04.570 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
11:05:04.616 [qtp656152832-296] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 remoteRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b localRepositoryRevisionSynced=8
11:05:04.638 [pool-30-thread-2] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ebe2328b-9f87-4308-8296-132efc720f7b remoteRepositoryId=794a074d-a30a-4b21-ab78-7192cc7363d6 transaction.localRevision=23 remoteFromLocalRevision=8
11:05:04.643 [pool-30-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
11:05:04.668 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [489e1887]getCloseDeferredMillis: closeDeferredMillis=20000
11:05:04.668 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [489e1887]close: Deferring shut down of real LocalRepoManager 20000 ms.
11:05:04.669 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [7c27ed2f]getCloseDeferredMillis: closeDeferredMillis=20000
11:05:04.669 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [7c27ed2f]close: Deferring shut down of real LocalRepoManager 20000 ms.
11:05:05.157 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [10f03ab0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erge49-11upt-local'
11:05:05.169 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [10f03ab0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erge49-11upt-local' locked successfully.
11:05:24.672 [closeDeferredTimer-7c27ed2f-1] INFO  c.c.c.l.LocalRepoManagerImpl - [7c27ed2f]_close: Shutting down real LocalRepoManager.
11:05:24.672 [closeDeferredTimer-489e1887-1] INFO  c.c.c.l.LocalRepoManagerImpl - [489e1887]_close: Shutting down real LocalRepoManager.
11:05:46.839 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [10f03ab0]initPersistenceManagerFactory: repositoryId=83f52534-9bb7-4023-a490-6af1db4ac827
11:05:46.856 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [10f03ab0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 24050 ms.
11:05:46.893 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5e4a9c16]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erge4i-r1d0x-remote'
11:05:46.897 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5e4a9c16]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erge4i-r1d0x-remote' locked successfully.
11:06:17.190 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5e4a9c16]initPersistenceManagerFactory: repositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399
11:06:17.210 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5e4a9c16]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 14328 ms.
11:06:17.632 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=406.5 MiB, used=45.6 MiB, available=3.4 GiB
Successfully requested to connect the following local and remote repositories:

  localRepository.repositoryId = 83f52534-9bb7-4023-a490-6af1db4ac827
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erge49-11upt-local
  localRepository.publicKeySha1 = F3:6F:A4:63:D3:ED:A0:AC:8B:D8:B2:D0:E7:20:46:3F:6B:23:02:FD

  remoteRepository.repositoryId = b99ed686-648f-433b-baf7-6ddf35ab8399
  remoteRepository.remoteRoot = https://localhost:35211/b99ed686-648f-433b-baf7-6ddf35ab8399
  remoteRepository.publicKeySha1 = DD:28:33:7F:AD:D2:AE:8A:2D:A1:0F:3F:A3:B7:72:46:2A:4C:E3:52

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 83f52534-9bb7-4023-a490-6af1db4ac827 b99ed686-648f-433b-baf7-6ddf35ab8399
11:06:18.548 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=393.0 MiB, used=39.8 MiB, available=3.4 GiB
Successfully accepted the connection request for the following local and remote repositories:

  localRepository.repositoryId = b99ed686-648f-433b-baf7-6ddf35ab8399
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1erge4i-r1d0x-remote
  localRepository.publicKeySha1 = DD:28:33:7F:AD:D2:AE:8A:2D:A1:0F:3F:A3:B7:72:46:2A:4C:E3:52

  remoteRepository.repositoryId = 83f52534-9bb7-4023-a490-6af1db4ac827
  remoteRepository.publicKeySha1 = F3:6F:A4:63:D3:ED:A0:AC:8B:D8:B2:D0:E7:20:46:3F:6B:23:02:FD

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 b99ed686-648f-433b-baf7-6ddf35ab8399 83f52534-9bb7-4023-a490-6af1db4ac827
WatchTaskFirstWrittenChunk started
11:06:19.555 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
11:06:19.556 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b99ed686-648f-433b-baf7-6ddf35ab8399 from='https://localhost:35211/b99ed686-648f-433b-baf7-6ddf35ab8399' toID=83f52534-9bb7-4023-a490-6af1db4ac827 to='target/repo/k1erge49-11upt-local', fromRepoLocalSync=true
11:06:19.556 [pool-33-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 83f52534-9bb7-4023-a490-6af1db4ac827 ('target/repo/k1erge49-11upt-local')
11:06:19.595 [pool-33-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
11:06:19.615 [pool-33-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
11:06:19.820 [pool-32-thread-2] 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/k1erge49-11upt-local/.cloudstore-repo/tmp/ChangeSetDto.b99ed686-648f-433b-baf7-6ddf35ab8399.-1.xml.gz
11:06:19.882 [pool-32-thread-2] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 serverRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 renewalDateTime=2019-10-06T09:36:19.847Z expiryDateTime=2019-10-06T10:06:19.847Z
11:06:19.911 [pool-5-thread-8] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
11:06:19.922 [pool-5-thread-8] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
11:06:19.941 [pool-5-thread-8] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.06%
11:06:19.946 [pool-5-thread-8] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 60.11%
11:06:19.951 [pool-5-thread-8] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 65.17%
11:06:19.956 [pool-5-thread-8] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 70.23%
11:06:20.098 [pool-5-thread-8] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
11:06:20.126 [pool-5-thread-8] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
11:06:20.172 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:06:20.178 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b99ed686-648f-433b-baf7-6ddf35ab8399
11:06:20.178 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 83f52534-9bb7-4023-a490-6af1db4ac827
11:06:20.178 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:06:20.178 [pool-5-thread-8] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 remoteRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
11:06:20.185 [pool-5-thread-8] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:06:20.210 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:06:20.210 [pool-5-thread-8] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:06:20.210 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:06:20.210 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:06:20.223 [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/k1erge49-11upt-local/.cloudstore-repo/tmp/ChangeSetDto.b99ed686-648f-433b-baf7-6ddf35ab8399.-1.xml.gz
11:06:20.224 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
11:06:20.225 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
11:06:20.554 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
11:06:20.558 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
11:06:20.559 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
11:06:20.630 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='27e9839794502154a5ba80b807f72954989a0657' to.sha1='<NoInstanceOf_NormalFileDto>'): /d
11:06:20.876 [pool-32-thread-2] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="b99ed686-648f-433b-baf7-6ddf35ab8399"] on repo=83f52534-9bb7-4023-a490-6af1db4ac827
11:06:20.901 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
createTempChunkFile: d; createNewFile=true
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
FileWatcher: CHUNK_SIZE reached! chunk_3c363836cf4e16666669a25da280a1865c2d2874_0
WatchTaskChunksToFile: ready
11:06:21.694 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
11:06:21.695 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
11:06:21.733 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
11:06:21.734 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b99ed686-648f-433b-baf7-6ddf35ab8399 from='https://localhost:35211/b99ed686-648f-433b-baf7-6ddf35ab8399' toID=83f52534-9bb7-4023-a490-6af1db4ac827 to='target/repo/k1erge49-11upt-local', fromRepoLocalSync=true
11:06:21.735 [pool-35-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 83f52534-9bb7-4023-a490-6af1db4ac827 ('target/repo/k1erge49-11upt-local')
11:06:21.740 [pool-35-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
11:06:21.754 [pool-35-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 19.03%
11:06:21.755 [pool-35-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
11:06:22.411 [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/k1erge49-11upt-local/.cloudstore-repo/tmp/ChangeSetDto.b99ed686-648f-433b-baf7-6ddf35ab8399.-1.xml.gz
11:06:22.411 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
11:06:22.412 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
11:06:22.418 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
11:06:22.477 [pool-34-thread-3] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 serverRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 renewalDateTime=2019-10-06T09:36:19.847Z expiryDateTime=2019-10-06T10:06:19.847Z
11:06:22.530 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='27e9839794502154a5ba80b807f72954989a0657' to.sha1='da39a3ee5e6b4b0d3255bfef95601890afd80709'): /d
11:06:22.542 [pool-34-thread-3] WARN  c.c.c.l.t.FileRepoTransport - Unexpected state: markFileInProgress==null='false', inProgress='true' on repo=83f52534-9bb7-4023-a490-6af1db4ac827
11:06:22.543 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_0, chunksCreated=1
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksCreated=2
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
11:06:23.594 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1078243 bytes in 1051 ms. path='/d'
11:06:23.602 [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
11:06:23.616 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34 into destFile d
WatchTaskChunksToFile: length reached! length=1078243
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksDeleted=2
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
11:06:24.322 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="b99ed686-648f-433b-baf7-6ddf35ab8399"] on repo=83f52534-9bb7-4023-a490-6af1db4ac827
11:06:24.429 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
11:06:24.430 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
11:06:24.484 [qtp656152832-126] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 remoteRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 localRepositoryRevisionSynced=3
11:06:24.525 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 remoteRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 transaction.localRevision=10 remoteFromLocalRevision=3
11:06:24.543 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=83f52534-9bb7-4023-a490-6af1db4ac827 from='target/repo/k1erge49-11upt-local' toID=b99ed686-648f-433b-baf7-6ddf35ab8399 to='https://localhost:35211/b99ed686-648f-433b-baf7-6ddf35ab8399'
11:06:24.876 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:06:24.879 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 83f52534-9bb7-4023-a490-6af1db4ac827
11:06:24.879 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: b99ed686-648f-433b-baf7-6ddf35ab8399
11:06:24.879 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:06:24.879 [pool-34-thread-3] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 remoteRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=10
11:06:24.889 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:06:24.902 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:06:24.902 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:06:24.902 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:06:24.902 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:06:24.902 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 52.24%
11:06:24.903 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
11:06:24.984 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 61.19%
11:06:24.990 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 70.15%
11:06:25.011 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 remoteRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 localRepositoryRevisionSynced=10
11:06:25.065 [qtp656152832-296] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 remoteRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 transaction.localRevision=7 remoteFromLocalRevision=10
11:06:25.092 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b99ed686-648f-433b-baf7-6ddf35ab8399 from='https://localhost:35211/b99ed686-648f-433b-baf7-6ddf35ab8399' toID=83f52534-9bb7-4023-a490-6af1db4ac827 to='target/repo/k1erge49-11upt-local', fromRepoLocalSync=false
11:06:25.093 [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/k1erge49-11upt-local/.cloudstore-repo/tmp/ChangeSetDto.b99ed686-648f-433b-baf7-6ddf35ab8399.null.xml.gz
11:06:25.361 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:06:25.367 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b99ed686-648f-433b-baf7-6ddf35ab8399
11:06:25.367 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 83f52534-9bb7-4023-a490-6af1db4ac827
11:06:25.367 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
11:06:25.368 [pool-5-thread-8] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 remoteRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=7
11:06:25.371 [pool-5-thread-8] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:06:25.373 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:06:25.373 [pool-5-thread-8] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:06:25.373 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:06:25.373 [pool-5-thread-8] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:06:25.378 [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/k1erge49-11upt-local/.cloudstore-repo/tmp/ChangeSetDto.b99ed686-648f-433b-baf7-6ddf35ab8399.null.xml.gz
11:06:25.378 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 77.11%
11:06:25.378 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
11:06:25.378 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
11:06:25.417 [qtp656152832-341] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 remoteRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 localRepositoryRevisionSynced=7
11:06:25.469 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=83f52534-9bb7-4023-a490-6af1db4ac827 remoteRepositoryId=b99ed686-648f-433b-baf7-6ddf35ab8399 transaction.localRevision=13 remoteFromLocalRevision=7
11:06:25.483 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
hasCorrectAmountOfCreationsDeletions: toBeCreated=2, chunksCreated=2, toBeDeleted=2, chunksDeleted=2
11:06:26.004 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [10f03ab0]getCloseDeferredMillis: closeDeferredMillis=20000
11:06:26.004 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [10f03ab0]close: Deferring shut down of real LocalRepoManager 20000 ms.
11:06:26.005 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5e4a9c16]getCloseDeferredMillis: closeDeferredMillis=20000
11:06:26.005 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5e4a9c16]close: Deferring shut down of real LocalRepoManager 20000 ms.
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1,512.828 sec - in co.codewizards.cloudstore.test.SyncAbortIT
11:06:26.262 [Thread-4] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@eb0b3ae{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
11:06:26.266 [Thread-4] INFO  o.e.j.s.session - node0 Stopped scavenging
11:06:26.276 [Thread-4] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@6202305b{/,null,UNAVAILABLE}
11:06:26.292 [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/nPbZ3KyenAy9tFps2iNBiQ/.cloudstore/localServerRunning.deleteToStop
11:06:26.312 [Thread-4] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@32986b15{SSL,[ssl, http/1.1]}{0.0.0.0:35211}
11:06:26.315 [Thread-4] INFO  o.e.j.s.session - node0 Stopped scavenging
11:06:26.317 [Thread-4] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@20777538{/,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-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.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7/co.codewizards.cloudstore.test-0.10.7.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/co.codewizards.cloudstore.test-0.10.7.pom
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-0.10.7-sources.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7/co.codewizards.cloudstore.test-0.10.7-sources.jar
[INFO] 
[INFO] --- maven-deploy-plugin:2.7:deploy (default-deploy) @ co.codewizards.cloudstore.test ---
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7/co.codewizards.cloudstore.test-0.10.7.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7/co.codewizards.cloudstore.test-0.10.7.jar (7 KB at 3202.6 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7/co.codewizards.cloudstore.test-0.10.7.pom
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7/co.codewizards.cloudstore.test-0.10.7.pom (6 KB at 1719.4 KB/sec)
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
Downloaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (812 B at 4.7 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (844 B at 274.7 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7/co.codewizards.cloudstore.test-0.10.7-sources.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/release/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7/co.codewizards.cloudstore.test-0.10.7-sources.jar (3 KB at 1074.2 KB/sec)
[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