|  Console Output
Skipping 1,545 KB.. Full Log/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmn-62w82-local/.cloudstore-repo/tmp/ChangeSetDto.a2ca61b2-221c-4e2a-88d7-631a4eef4a6a.6.xml.gz
15:47:25.376 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [71143807]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:25.377 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [71143807]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:26.076 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [71143807]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:26.076 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [71143807]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 699 ms.
15:47:26.130 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [71143807]getCloseDeferredMillis: closeDeferredMillis=0
15:47:26.130 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [71143807]close: Closing real LocalRepoManager immediately.
15:47:26.130 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [71143807]_close: Shutting down real LocalRepoManager.
15:47:26.615 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 serverRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a renewalDateTime=2019-10-06T14:17:12.655Z expiryDateTime=2019-10-06T14:47:12.655Z
15:47:26.637 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e2d2e4d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:26.638 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e2d2e4d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:26.659 [main] INFO c.c.c.l.LocalRepoManagerImpl - [704205ef]initPersistenceManagerFactory: repositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3
15:47:26.673 [main] INFO c.c.c.l.LocalRepoManagerImpl - [704205ef]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 3542 ms.
15:47:26.710 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4746d52d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1jcdu-glph7-remote'
15:47:26.715 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4746d52d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1jcdu-glph7-remote' locked successfully.
15:47:27.355 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e2d2e4d]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:27.356 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e2d2e4d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 718 ms.
15:47:27.383 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e2d2e4d]getCloseDeferredMillis: closeDeferredMillis=0
15:47:27.383 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e2d2e4d]close: Closing real LocalRepoManager immediately.
15:47:27.383 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e2d2e4d]_close: Shutting down real LocalRepoManager.
15:47:27.847 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2e2bf503]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:27.848 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2e2bf503]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:28.465 [main] INFO c.c.c.l.LocalRepoManagerImpl - [41d6d6c4]initPersistenceManagerFactory: repositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a
15:47:28.479 [main] INFO c.c.c.l.LocalRepoManagerImpl - [41d6d6c4]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 3666 ms.
remoteRoot: k1f1j9qb-kumb6-remote
remoteRepositoryId: ca4933d4-ca88-40b1-838d-d53ce9326e9a
15:47:28.621 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2e2bf503]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:28.622 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2e2bf503]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 774 ms.
15:47:28.645 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
15:47:28.661 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
15:47:28.688 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
15:47:28.715 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
15:47:28.724 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
15:47:28.744 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
15:47:28.771 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
15:47:28.807 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
15:47:28.865 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:47:28.868 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:28.868 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:47:28.868 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:47:28.869 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 localRepositoryRevisionSynced=6 localRepositoryRevisionInProgress=8
15:47:28.878 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:47:28.898 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:47:28.898 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:47:28.899 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:47:28.899 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:47:28.899 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2e2bf503]getCloseDeferredMillis: closeDeferredMillis=0
15:47:28.899 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2e2bf503]close: Closing real LocalRepoManager immediately.
15:47:28.900 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2e2bf503]_close: Shutting down real LocalRepoManager.
15:47:29.001 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=407.5 MiB, used=47.1 MiB, available=3.4 GiB
Successfully requested to connect the following local and remote repositories:
localRepository.repositoryId = 2eab3cec-91d2-4da2-b82e-3ad23a459ef2
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1j9qa-o8wcl-local
localRepository.publicKeySha1 = D8:E0:EA:6B:7D:4A:5F:C6:4E:F0:01:A1:09:90:DB:7A:11:B9:59:DD
remoteRepository.repositoryId = ca4933d4-ca88-40b1-838d-d53ce9326e9a
remoteRepository.remoteRoot = https://localhost:45052/ca4933d4-ca88-40b1-838d-d53ce9326e9a
remoteRepository.publicKeySha1 = EF:1F:B7:EC:AA:0B:16:65:BF:FB:17:66:74:22:CC:44:BC:90:52:3A
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 2eab3cec-91d2-4da2-b82e-3ad23a459ef2 ca4933d4-ca88-40b1-838d-d53ce9326e9a
15:47:29.512 [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/k1f1ipmn-62w82-local/.cloudstore-repo/tmp/ChangeSetDto.a2ca61b2-221c-4e2a-88d7-631a4eef4a6a.6.xml.gz
15:47:29.513 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
15:47:29.513 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
15:47:29.539 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [1c9d6f0c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:29.539 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [1c9d6f0c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:29.684 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=410.0 MiB, used=42.6 MiB, available=3.4 GiB
Successfully accepted the connection request for the following local and remote repositories:
localRepository.repositoryId = ca4933d4-ca88-40b1-838d-d53ce9326e9a
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1j9qb-kumb6-remote
localRepository.publicKeySha1 = EF:1F:B7:EC:AA:0B:16:65:BF:FB:17:66:74:22:CC:44:BC:90:52:3A
remoteRepository.repositoryId = 2eab3cec-91d2-4da2-b82e-3ad23a459ef2
remoteRepository.publicKeySha1 = D8:E0:EA:6B:7D:4A:5F:C6:4E:F0:01:A1:09:90:DB:7A:11:B9:59:DD
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 ca4933d4-ca88-40b1-838d-d53ce9326e9a 2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:30.198 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [1c9d6f0c]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:30.199 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [1c9d6f0c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 660 ms.
15:47:30.231 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [1c9d6f0c]getCloseDeferredMillis: closeDeferredMillis=0
15:47:30.232 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [1c9d6f0c]close: Closing real LocalRepoManager immediately.
15:47:30.232 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [1c9d6f0c]_close: Shutting down real LocalRepoManager.
15:47:30.446 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 0.50%
15:47:30.449 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=ca4933d4-ca88-40b1-838d-d53ce9326e9a from='https://localhost:45052/ca4933d4-ca88-40b1-838d-d53ce9326e9a' toID=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 to='target/repo/k1f1j9qa-o8wcl-local', fromRepoLocalSync=true
15:47:30.449 [pool-9-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 2eab3cec-91d2-4da2-b82e-3ad23a459ef2 ('target/repo/k1f1j9qa-o8wcl-local')
15:47:30.453 [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/k1f1j9qa-o8wcl-local/.cloudstore-repo/tmp/ChangeSetDto.ca4933d4-ca88-40b1-838d-d53ce9326e9a.-1.xml.gz
15:47:30.524 [pool-9-thread-1] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 12.94%
15:47:30.543 [pool-9-thread-1] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 25.12%
15:47:30.640 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 serverRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a renewalDateTime=2019-10-06T14:17:30.570Z expiryDateTime=2019-10-06T14:47:30.570Z
15:47:30.668 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
15:47:30.679 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
15:47:30.705 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.69%
15:47:30.725 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [17262a40]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:30.726 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [17262a40]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:30.794 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.60%
15:47:30.810 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.40%
15:47:30.871 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.20%
15:47:30.937 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.00%
15:47:31.032 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
15:47:31.074 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:47:31.078 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ca4933d4-ca88-40b1-838d-d53ce9326e9a
15:47:31.078 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:31.078 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:47:31.078 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a remoteRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
15:47:31.086 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:47:31.136 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:47:31.136 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:47:31.136 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:47:31.137 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:47:31.165 [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/k1f1j9qa-o8wcl-local/.cloudstore-repo/tmp/ChangeSetDto.ca4933d4-ca88-40b1-838d-d53ce9326e9a.-1.xml.gz
15:47:31.166 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
15:47:31.210 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/#4'
15:47:31.243 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/1 {11 11ä11#+} 1'
15:47:31.263 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 30.33%
15:47:31.264 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2'
15:47:31.283 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2/1 {11 11ä11#+} 1'
15:47:31.304 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
15:47:31.348 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/5#'
15:47:31.377 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 35.59%
15:47:31.377 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 40.86%
15:47:31.378 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/#b'
15:47:31.425 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='b693ce6c4af02af59ac4ef45373f064027c4ab72' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/#b
15:47:31.454 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [17262a40]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:31.454 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [17262a40]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 728 ms.
15:47:31.484 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:31.485 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/#b'
15:47:31.549 [qtp1608332243-92] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 localRepositoryRevisionSynced=8
15:47:31.556 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [17262a40]getCloseDeferredMillis: closeDeferredMillis=0
15:47:31.556 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [17262a40]close: Closing real LocalRepoManager immediately.
15:47:31.556 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [17262a40]_close: Shutting down real LocalRepoManager.
15:47:31.621 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 447454 bytes in 135 ms. path='/#4/#b'
15:47:31.634 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c691e3d4c979adbf07e3b97e33fdf3c89ed246f6_0 into destFile #b
15:47:31.697 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:31.710 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/a'
15:47:31.753 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='037d09438d732bdc5fe03dd3f549afa118fd019e' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/a
15:47:31.790 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:31.799 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/a'
15:47:31.846 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 120000 bytes in 47 ms. path='/#4/a'
15:47:31.870 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:47:31.922 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:31.930 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/c+'
15:47:31.981 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='378dcbbe674054c58f9b671a868fc11f013f1132' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/c+
15:47:32.004 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:32.006 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/c+'
15:47:32.057 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 61110 bytes in 51 ms. path='/#4/c+'
15:47:32.065 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_8a30244b83c6cac3c79f8f95d30f96579c0f4c0b_0 into destFile c+
15:47:32.090 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:32.098 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/d$'
15:47:32.118 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 remoteRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a transaction.localRevision=89 remoteFromLocalRevision=8
15:47:32.121 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 from='target/repo/k1f1ipmn-62w82-local' toID=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a to='https://localhost:38589/a2ca61b2-221c-4e2a-88d7-631a4eef4a6a'
15:47:32.140 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='2d879cec3b6175c4374e4746f7b2a8fb28da7c49' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/d$
15:47:32.147 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [1a39718d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:32.147 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [1a39718d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:32.159 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:32.161 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/d$'
15:47:32.228 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4746d52d]initPersistenceManagerFactory: repositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0
15:47:32.235 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4746d52d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2717 ms.
15:47:32.240 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 361026 bytes in 78 ms. path='/#4/d$'
15:47:32.247 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_a93a212f7eca012dceb852f364cc2c34026f0dd8_0 into destFile d$
15:47:32.373 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:32.379 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/a'
15:47:32.424 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c793868078a62974f323e388f026854a86a18aee' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/a
15:47:32.451 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:32.454 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/1 {11 11ä11#+} 1/a'
15:47:32.518 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 170250 bytes in 64 ms. path='/1 {11 11ä11#+} 1/a'
15:47:32.526 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:47:32.548 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:32.554 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/b'
15:47:32.632 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='d3a1a2993b1ce77b222b540bdb2971baa879b799' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/b
15:47:32.664 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:32.669 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/1 {11 11ä11#+} 1/b'
15:47:32.744 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 143865 bytes in 71 ms. path='/1 {11 11ä11#+} 1/b'
15:47:32.755 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
15:47:32.857 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:32.868 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/c'
15:47:32.930 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='6586a859f342b2c00aca2d573bcc48b13d5dc88a' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/c
15:47:32.933 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=418.5 MiB, used=52.3 MiB, available=3.4 GiB
15:47:32.970 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:32.990 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/1 {11 11ä11#+} 1/c'
15:47:33.027 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 25809 bytes in 36 ms. path='/1 {11 11ä11#+} 1/c'
15:47:33.035 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
15:47:33.056 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:33.061 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/a'
15:47:33.063 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [1a39718d]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:33.064 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [1a39718d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 917 ms.
15:47:33.110 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [1a39718d]getCloseDeferredMillis: closeDeferredMillis=0
15:47:33.110 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [1a39718d]close: Closing real LocalRepoManager immediately.
15:47:33.110 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [1a39718d]_close: Shutting down real LocalRepoManager.
15:47:33.115 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='6db9b299ba4ea59838fe7182f7fe5bebb539cc76' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/a
15:47:33.178 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:33.200 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/1 {11 11ä11#+} 1/a'
15:47:33.324 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 355344 bytes in 124 ms. path='/2/1 {11 11ä11#+} 1/a'
15:47:33.332 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:47:33.368 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:33.375 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/b'
Successfully requested to connect the following local and remote repositories:
localRepository.repositoryId = f4236692-25d1-43cd-ad76-d21b80e7a8e3
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1jcds-5u170-local
localRepository.publicKeySha1 = 0B:17:4C:F7:F1:B0:D8:6C:74:96:1A:3D:16:50:B9:DA:C1:F2:56:F4
remoteRepository.repositoryId = b695369d-ab00-4e42-bb06-042ea2d36bc0
remoteRepository.remoteRoot = https://localhost:41571/b695369d-ab00-4e42-bb06-042ea2d36bc0
remoteRepository.publicKeySha1 = DF:02:BC:54:EE:88:DF:0E:BD:6A:EE:9C:88:3E:5C:78:14:47:B3:6A
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 f4236692-25d1-43cd-ad76-d21b80e7a8e3 b695369d-ab00-4e42-bb06-042ea2d36bc0
15:47:33.437 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='afca0e199712d24330ee22dd95f1372ff4c50ec9' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/b
15:47:33.474 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:33.502 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/1 {11 11ä11#+} 1/b'
15:47:33.556 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 12478 bytes in 53 ms. path='/2/1 {11 11ä11#+} 1/b'
15:47:33.563 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
15:47:33.588 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:33.606 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/a'
15:47:33.642 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='6867c4abcaea86cd12686c7919183e0f139eb419' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/a
15:47:33.678 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [7c2b4670]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:33.678 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [7c2b4670]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:33.705 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:33.715 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/a'
15:47:33.904 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 450684 bytes in 188 ms. path='/2/a'
15:47:33.912 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:47:33.932 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=420.0 MiB, used=48.3 MiB, available=3.4 GiB
15:47:33.960 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:33.977 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/a'
Successfully accepted the connection request for the following local and remote repositories:
localRepository.repositoryId = b695369d-ab00-4e42-bb06-042ea2d36bc0
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1jcdu-glph7-remote
localRepository.publicKeySha1 = DF:02:BC:54:EE:88:DF:0E:BD:6A:EE:9C:88:3E:5C:78:14:47:B3:6A
remoteRepository.repositoryId = f4236692-25d1-43cd-ad76-d21b80e7a8e3
remoteRepository.publicKeySha1 = 0B:17:4C:F7:F1:B0:D8:6C:74:96:1A:3D:16:50:B9:DA:C1:F2:56:F4
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 b695369d-ab00-4e42-bb06-042ea2d36bc0 f4236692-25d1-43cd-ad76-d21b80e7a8e3
15:47:34.025 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='4448f8bd386a7475a656803488fbb7720efab0d8' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/a
15:47:34.052 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:34.054 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/a'
15:47:34.099 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 117607 bytes in 45 ms. path='/3/a'
15:47:34.118 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
15:47:34.140 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:34.146 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/b'
15:47:34.190 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='9b3ee25b3e5c173d2c5c7bb4fa02cedba84f9053' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/b
15:47:34.215 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:34.219 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/b'
15:47:34.246 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 10829 bytes in 26 ms. path='/3/b'
15:47:34.252 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
15:47:34.266 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:34.271 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/c'
15:47:34.311 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='64adbb6ab08c8d209d4305d9f128569c8879c990' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/c
15:47:34.335 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:34.337 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/c'
WatchTaskFirstWrittenChunk started
15:47:34.492 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 691886 bytes in 154 ms. path='/3/c'
15:47:34.500 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
15:47:34.597 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [7c2b4670]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:34.598 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [7c2b4670]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 919 ms.
15:47:34.634 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [7c2b4670]getCloseDeferredMillis: closeDeferredMillis=0
15:47:34.634 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [7c2b4670]close: Closing real LocalRepoManager immediately.
15:47:34.634 [qtp1608332243-25] INFO c.c.c.l.LocalRepoManagerImpl - [7c2b4670]_close: Shutting down real LocalRepoManager.
15:47:34.675 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:34.682 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/d'
15:47:34.740 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='8eb00b44197daac647eed2d832274b358f411444' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/d
15:47:34.777 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
15:47:34.778 [pool-32-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b695369d-ab00-4e42-bb06-042ea2d36bc0 from='https://localhost:41571/b695369d-ab00-4e42-bb06-042ea2d36bc0' toID=f4236692-25d1-43cd-ad76-d21b80e7a8e3 to='target/repo/k1f1jcds-5u170-local', fromRepoLocalSync=true
15:47:34.778 [pool-33-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing f4236692-25d1-43cd-ad76-d21b80e7a8e3 ('target/repo/k1f1jcds-5u170-local')
15:47:34.798 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:34.818 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/d'
15:47:34.822 [pool-33-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
15:47:34.850 [pool-33-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
15:47:34.868 [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/k1f1jcds-5u170-local/.cloudstore-repo/tmp/ChangeSetDto.b695369d-ab00-4e42-bb06-042ea2d36bc0.-1.xml.gz
15:47:34.895 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 197325 bytes in 77 ms. path='/3/d'
15:47:34.902 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
15:47:34.934 [pool-32-thread-2] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 serverRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 renewalDateTime=2019-10-06T14:17:34.888Z expiryDateTime=2019-10-06T14:47:34.888Z
15:47:34.951 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
15:47:34.959 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:34.959 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
15:47:34.973 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/5#/e'
15:47:34.981 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.17%
15:47:34.987 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 60.34%
15:47:34.992 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 65.51%
15:47:34.997 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 70.68%
15:47:35.019 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='37a850dde744ec40ca94bba857cf2cbf76c9fbf6' to.sha1='<NoInstanceOf_NormalFileDto>'): /5#/e
15:47:35.047 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:35.054 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/5#/e'
15:47:35.065 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
15:47:35.103 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 92925 bytes in 48 ms. path='/5#/e'
15:47:35.112 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:47:35.111 [pool-5-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
15:47:35.115 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:47:35.116 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:35.116 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:47:35.116 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 remoteRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=89
15:47:35.125 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_58e6b3a414a1e090dfc6029add0f3555ccba127f_0 into destFile e
15:47:35.142 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:47:35.152 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:47:35.157 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b695369d-ab00-4e42-bb06-042ea2d36bc0
15:47:35.157 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: f4236692-25d1-43cd-ad76-d21b80e7a8e3
15:47:35.157 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:47:35.157 [pool-5-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 remoteRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
15:47:35.167 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="ca4933d4-ca88-40b1-838d-d53ce9326e9a"] on repo=2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:35.167 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:47:35.183 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 49.42%
15:47:35.193 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:47:35.193 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:47:35.194 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:47:35.194 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:47:35.195 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 52.24%
15:47:35.196 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
15:47:35.210 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:47:35.210 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:47:35.210 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:47:35.210 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:47:35.222 [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/k1f1jcds-5u170-local/.cloudstore-repo/tmp/ChangeSetDto.b695369d-ab00-4e42-bb06-042ea2d36bc0.-1.xml.gz
15:47:35.226 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
15:47:35.227 [pool-32-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
15:47:35.250 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [69a23b28]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:35.250 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [69a23b28]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:35.259 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
15:47:35.262 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
15:47:35.263 [pool-32-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
15:47:35.267 [qtp1911501361-106] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a remoteRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 localRepositoryRevisionSynced=3
15:47:35.287 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 remoteRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a transaction.localRevision=84 remoteFromLocalRevision=3
15:47:35.302 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 from='target/repo/k1f1j9qa-o8wcl-local' toID=ca4933d4-ca88-40b1-838d-d53ce9326e9a to='https://localhost:45052/ca4933d4-ca88-40b1-838d-d53ce9326e9a'
15:47:35.327 [pool-32-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c85a59116b69b2936c6db997a1df252e92c031c8' to.sha1='<NoInstanceOf_NormalFileDto>'): /d
15:47:35.356 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:47:35.359 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:35.359 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ca4933d4-ca88-40b1-838d-d53ce9326e9a
15:47:35.359 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:47:35.359 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 remoteRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=84
15:47:35.369 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:47:35.379 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:47:35.379 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:47:35.379 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:47:35.379 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:47:35.380 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 63.43%
15:47:35.380 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
15:47:35.398 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 remoteRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a localRepositoryRevisionSynced=84
15:47:35.408 [pool-32-thread-2] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="b695369d-ab00-4e42-bb06-042ea2d36bc0"] on repo=f4236692-25d1-43cd-ad76-d21b80e7a8e3
15:47:35.414 [pool-32-thread-2] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
15:47:35.432 [qtp1911501361-106] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a remoteRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 transaction.localRevision=6 remoteFromLocalRevision=84
15:47:35.444 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=ca4933d4-ca88-40b1-838d-d53ce9326e9a from='https://localhost:45052/ca4933d4-ca88-40b1-838d-d53ce9326e9a' toID=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 to='target/repo/k1f1j9qa-o8wcl-local', fromRepoLocalSync=false
15:47:35.445 [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/k1f1j9qa-o8wcl-local/.cloudstore-repo/tmp/ChangeSetDto.ca4933d4-ca88-40b1-838d-d53ce9326e9a.null.xml.gz
15:47:35.489 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:47:35.492 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ca4933d4-ca88-40b1-838d-d53ce9326e9a
15:47:35.492 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 2eab3cec-91d2-4da2-b82e-3ad23a459ef2
15:47:35.492 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:47:35.492 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a remoteRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
15:47:35.494 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:47:35.496 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:47:35.496 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:47:35.496 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:47:35.496 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:47:35.504 [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/k1f1j9qa-o8wcl-local/.cloudstore-repo/tmp/ChangeSetDto.ca4933d4-ca88-40b1-838d-d53ce9326e9a.null.xml.gz
15:47:35.504 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
15:47:35.504 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
15:47:35.543 [qtp1911501361-25] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a remoteRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 localRepositoryRevisionSynced=6
15:47:35.555 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=2eab3cec-91d2-4da2-b82e-3ad23a459ef2 remoteRepositoryId=ca4933d4-ca88-40b1-838d-d53ce9326e9a transaction.localRevision=87 remoteFromLocalRevision=6
15:47:35.558 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
15:47:35.584 [closeDeferredTimer-312819ae-1] INFO c.c.c.l.LocalRepoManagerImpl - [312819ae]_close: Shutting down real LocalRepoManager.
createTempChunkFile: d; createNewFile=true
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
15:47:35.990 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [69a23b28]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:35.990 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [69a23b28]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 739 ms.
15:47:36.018 [closeDeferredTimer-6c851821-1] INFO c.c.c.l.LocalRepoManagerImpl - [6c851821]_close: Shutting down real LocalRepoManager.
15:47:36.029 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [69a23b28]getCloseDeferredMillis: closeDeferredMillis=0
15:47:36.029 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [69a23b28]close: Closing real LocalRepoManager immediately.
15:47:36.029 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [69a23b28]_close: Shutting down real LocalRepoManager.
FileWatcher: CHUNK_SIZE reached! chunk_3c363836cf4e16666669a25da280a1865c2d2874_0
WatchTaskChunksToFile: ready
15:47:36.247 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
15:47:36.247 [pool-32-thread-2] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
15:47:36.312 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
15:47:36.314 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b695369d-ab00-4e42-bb06-042ea2d36bc0 from='https://localhost:41571/b695369d-ab00-4e42-bb06-042ea2d36bc0' toID=f4236692-25d1-43cd-ad76-d21b80e7a8e3 to='target/repo/k1f1jcds-5u170-local', fromRepoLocalSync=true
15:47:36.314 [pool-35-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing f4236692-25d1-43cd-ad76-d21b80e7a8e3 ('target/repo/k1f1jcds-5u170-local')
15:47:36.322 [pool-35-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
15:47:36.334 [pool-35-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 19.03%
15:47:36.336 [pool-35-thread-1] INFO c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
15:47:36.458 [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/k1f1jcds-5u170-local/.cloudstore-repo/tmp/ChangeSetDto.b695369d-ab00-4e42-bb06-042ea2d36bc0.-1.xml.gz
15:47:36.458 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
15:47:36.459 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
15:47:36.492 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
15:47:36.552 [pool-34-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 serverRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 renewalDateTime=2019-10-06T14:17:34.888Z expiryDateTime=2019-10-06T14:47:34.888Z
15:47:36.621 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c85a59116b69b2936c6db997a1df252e92c031c8' to.sha1='da39a3ee5e6b4b0d3255bfef95601890afd80709'): /d
15:47:36.634 [pool-34-thread-3] WARN c.c.c.l.t.FileRepoTransport - Unexpected state: markFileInProgress==null='false', inProgress='true' on repo=f4236692-25d1-43cd-ad76-d21b80e7a8e3
15:47:36.635 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
15:47:36.659 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [6af8cbb7]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:36.660 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [6af8cbb7]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:36.674 [main] INFO c.c.c.l.LocalRepoManagerImpl - [207f7baa]getCloseDeferredMillis: closeDeferredMillis=20000
15:47:36.674 [main] INFO c.c.c.l.LocalRepoManagerImpl - [207f7baa]close: Deferring shut down of real LocalRepoManager 20000 ms.
15:47:36.681 [main] INFO c.c.c.l.LocalRepoManagerImpl - [41d6d6c4]getCloseDeferredMillis: closeDeferredMillis=20000
15:47:36.682 [main] INFO c.c.c.l.LocalRepoManagerImpl - [41d6d6c4]close: Deferring shut down of real LocalRepoManager 20000 ms.
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 171.639 sec - in co.codewizards.cloudstore.test.repotorepo.BasicRepoToRepoSyncIT
15:47:36.740 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@4ca0c92f{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
15:47:36.741 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:47:36.748 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@2b58186f{/,null,UNAVAILABLE}
15:47:36.767 [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/QNlrQJ1YBUiNeDw4BCFDwQ/.cloudstore/localServerRunning.deleteToStop
15:47:36.790 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@37017599{SSL,[ssl, http/1.1]}{0.0.0.0:45052}
15:47:36.792 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:47:36.793 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@79cbdf21{/,null,UNAVAILABLE}
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_0, chunksCreated=1
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
15:47:37.238 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [6af8cbb7]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:37.238 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [6af8cbb7]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 578 ms.
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksCreated=2
15:47:37.361 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [6af8cbb7]getCloseDeferredMillis: closeDeferredMillis=0
15:47:37.362 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [6af8cbb7]close: Closing real LocalRepoManager immediately.
15:47:37.362 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [6af8cbb7]_close: Shutting down real LocalRepoManager.
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
15:47:37.708 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1054445 bytes in 1073 ms. path='/d'
15:47:37.716 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
15:47:37.721 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 58.34%
15:47:37.727 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 64.45%
15:47:37.728 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 70.56%
15:47:37.729 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_0, chunksDeleted=1
15:47:37.735 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34 into destFile d
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksDeleted=2
WatchTaskChunksToFile: length reached! length=1054445
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
15:47:37.774 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [30dfc8e0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:37.774 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [30dfc8e0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
15:47:38.262 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="b695369d-ab00-4e42-bb06-042ea2d36bc0"] on repo=f4236692-25d1-43cd-ad76-d21b80e7a8e3
15:47:38.277 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
15:47:38.277 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
15:47:38.325 [qtp1891569057-278] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 remoteRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 localRepositoryRevisionSynced=3
15:47:38.346 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 remoteRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 transaction.localRevision=10 remoteFromLocalRevision=3
15:47:38.359 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=f4236692-25d1-43cd-ad76-d21b80e7a8e3 from='target/repo/k1f1jcds-5u170-local' toID=b695369d-ab00-4e42-bb06-042ea2d36bc0 to='https://localhost:41571/b695369d-ab00-4e42-bb06-042ea2d36bc0'
15:47:38.404 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [30dfc8e0]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:38.405 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [30dfc8e0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 630 ms.
15:47:38.419 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:47:38.423 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: f4236692-25d1-43cd-ad76-d21b80e7a8e3
15:47:38.423 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: b695369d-ab00-4e42-bb06-042ea2d36bc0
15:47:38.423 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:47:38.423 [pool-34-thread-3] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 remoteRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=10
15:47:38.434 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [30dfc8e0]getCloseDeferredMillis: closeDeferredMillis=0
15:47:38.434 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [30dfc8e0]close: Closing real LocalRepoManager immediately.
15:47:38.434 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [30dfc8e0]_close: Shutting down real LocalRepoManager.
15:47:38.439 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:47:38.460 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:47:38.460 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:47:38.460 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:47:38.460 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:47:38.461 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 52.24%
15:47:38.462 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
15:47:38.498 [closeDeferredTimer-2fc7c36a-1] INFO c.c.c.l.LocalRepoManagerImpl - [2fc7c36a]_close: Shutting down real LocalRepoManager.
15:47:38.903 [closeDeferredTimer-4086e003-1] INFO c.c.c.l.LocalRepoManagerImpl - [4086e003]_close: Shutting down real LocalRepoManager.
15:47:39.050 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [74683948]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:39.051 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [74683948]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:39.317 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 61.19%
15:47:39.320 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 70.15%
15:47:39.360 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 remoteRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 localRepositoryRevisionSynced=10
15:47:39.502 [qtp1891569057-23] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 remoteRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 transaction.localRevision=7 remoteFromLocalRevision=10
15:47:39.510 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=b695369d-ab00-4e42-bb06-042ea2d36bc0 from='https://localhost:41571/b695369d-ab00-4e42-bb06-042ea2d36bc0' toID=f4236692-25d1-43cd-ad76-d21b80e7a8e3 to='target/repo/k1f1jcds-5u170-local', fromRepoLocalSync=false
15:47:39.511 [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/k1f1jcds-5u170-local/.cloudstore-repo/tmp/ChangeSetDto.b695369d-ab00-4e42-bb06-042ea2d36bc0.null.xml.gz
15:47:39.578 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:47:39.584 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: b695369d-ab00-4e42-bb06-042ea2d36bc0
15:47:39.584 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: f4236692-25d1-43cd-ad76-d21b80e7a8e3
15:47:39.584 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:47:39.584 [pool-5-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 remoteRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=7
15:47:39.586 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:47:39.587 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:47:39.587 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:47:39.587 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:47:39.588 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:47:39.595 [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/k1f1jcds-5u170-local/.cloudstore-repo/tmp/ChangeSetDto.b695369d-ab00-4e42-bb06-042ea2d36bc0.null.xml.gz
15:47:39.595 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 77.11%
15:47:39.595 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
15:47:39.595 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
15:47:39.619 [qtp1891569057-91] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 remoteRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 localRepositoryRevisionSynced=7
15:47:39.684 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=f4236692-25d1-43cd-ad76-d21b80e7a8e3 remoteRepositoryId=b695369d-ab00-4e42-bb06-042ea2d36bc0 transaction.localRevision=13 remoteFromLocalRevision=7
15:47:39.706 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [74683948]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:39.706 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [74683948]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 654 ms.
15:47:39.746 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [74683948]getCloseDeferredMillis: closeDeferredMillis=0
15:47:39.746 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [74683948]close: Closing real LocalRepoManager immediately.
15:47:39.746 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [74683948]_close: Shutting down real LocalRepoManager.
15:47:39.750 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
15:47:40.242 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='ff06115bc1a1d1140c8a1c7c54e15af28858b482' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
hasCorrectAmountOfCreationsDeletions: toBeCreated=2, chunksCreated=2, toBeDeleted=2, chunksDeleted=2
Oct 06, 2019 3:47:40 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
15:47:40.271 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [509adb81]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:40.271 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [509adb81]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:40.273 [main] INFO c.c.c.l.LocalRepoManagerImpl - [704205ef]getCloseDeferredMillis: closeDeferredMillis=20000
15:47:40.273 [main] INFO c.c.c.l.LocalRepoManagerImpl - [704205ef]close: Deferring shut down of real LocalRepoManager 20000 ms.
15:47:40.274 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4746d52d]getCloseDeferredMillis: closeDeferredMillis=20000
15:47:40.274 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4746d52d]close: Deferring shut down of real LocalRepoManager 20000 ms.
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 327.737 sec - in co.codewizards.cloudstore.test.SyncAbortIT
15:47:40.579 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@1e4ee092{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
15:47:40.582 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:47:40.590 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@79c9fe7{/,null,UNAVAILABLE}
15:47:40.602 [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/T4VsWpfGG5fPjHHTr-bHYg/.cloudstore/localServerRunning.deleteToStop
15:47:40.618 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@29f302bf{SSL,[ssl, http/1.1]}{0.0.0.0:41571}
15:47:40.619 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:47:40.621 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@62f29500{/,null,UNAVAILABLE}
15:47:40.886 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [509adb81]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:40.887 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [509adb81]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 616 ms.
15:47:40.916 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [509adb81]getCloseDeferredMillis: closeDeferredMillis=0
15:47:40.916 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [509adb81]close: Closing real LocalRepoManager immediately.
15:47:40.916 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [509adb81]_close: Shutting down real LocalRepoManager.
15:47:41.444 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [4da33561]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:41.444 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [4da33561]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:42.050 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [4da33561]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:42.051 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [4da33561]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 606 ms.
15:47:42.182 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [4da33561]getCloseDeferredMillis: closeDeferredMillis=0
15:47:42.182 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [4da33561]close: Closing real LocalRepoManager immediately.
15:47:42.182 [qtp1608332243-27] INFO c.c.c.l.LocalRepoManagerImpl - [4da33561]_close: Shutting down real LocalRepoManager.
15:47:42.618 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="d9b9682d-fd97-4bdb-aa0c-b16661ac6332"] on repo=d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:47:42.620 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
15:47:42.684 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [521a5b23]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:42.684 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [521a5b23]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:43.179 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [521a5b23]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:43.180 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [521a5b23]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 496 ms.
15:47:43.207 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [521a5b23]getCloseDeferredMillis: closeDeferredMillis=0
15:47:43.207 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [521a5b23]close: Closing real LocalRepoManager immediately.
15:47:43.207 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [521a5b23]_close: Shutting down real LocalRepoManager.
15:47:43.563 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [509d44c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:43.564 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [509d44c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:44.849 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [509d44c]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:44.850 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [509d44c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1286 ms.
15:47:44.900 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [509d44c]getCloseDeferredMillis: closeDeferredMillis=0
15:47:44.900 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [509d44c]close: Closing real LocalRepoManager immediately.
15:47:44.900 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [509d44c]_close: Shutting down real LocalRepoManager.
15:47:45.298 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 211631 bytes in 2678 ms. path='/3/zzz'
Oct 06, 2019 3:47:45 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
15:47:45.326 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [adbfcbf]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:45.326 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [adbfcbf]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:45.887 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [adbfcbf]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:45.888 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [adbfcbf]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 561 ms.
15:47:45.913 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [adbfcbf]getCloseDeferredMillis: closeDeferredMillis=0
15:47:45.913 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [adbfcbf]close: Closing real LocalRepoManager immediately.
15:47:45.913 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [adbfcbf]_close: Shutting down real LocalRepoManager.
15:47:46.277 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [1afac78c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:46.278 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [1afac78c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:46.637 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [369eabc0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1jxmf-1g3oa'
15:47:46.653 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [369eabc0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1jxmf-1g3oa' locked successfully.
15:47:46.932 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [1afac78c]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:46.933 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [1afac78c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 654 ms.
15:47:47.005 [qtp1608332243-24] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
15:47:47.098 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [1afac78c]getCloseDeferredMillis: closeDeferredMillis=0
15:47:47.098 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [1afac78c]close: Closing real LocalRepoManager immediately.
15:47:47.098 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [1afac78c]_close: Shutting down real LocalRepoManager.
15:47:47.574 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="d9b9682d-fd97-4bdb-aa0c-b16661ac6332"] on repo=d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:47:47.587 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
15:47:47.606 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 remoteRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a localRepositoryRevisionSynced=89
15:47:47.626 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [2980ecba]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:47.627 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [2980ecba]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:48.242 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [2980ecba]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:48.243 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [2980ecba]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 616 ms.
15:47:48.272 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [2980ecba]getCloseDeferredMillis: closeDeferredMillis=0
15:47:48.272 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [2980ecba]close: Closing real LocalRepoManager immediately.
15:47:48.272 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [2980ecba]_close: Shutting down real LocalRepoManager.
15:47:49.149 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [796dc215]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:49.149 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [796dc215]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:49.848 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [796dc215]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:49.849 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [796dc215]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 699 ms.
15:47:49.894 [qtp1608332243-29] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 transaction.localRevision=15 remoteFromLocalRevision=89
15:47:49.919 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [796dc215]getCloseDeferredMillis: closeDeferredMillis=0
15:47:49.919 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [796dc215]close: Closing real LocalRepoManager immediately.
15:47:49.919 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [796dc215]_close: Shutting down real LocalRepoManager.
15:47:50.380 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a from='https://localhost:38589/a2ca61b2-221c-4e2a-88d7-631a4eef4a6a' toID=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 to='target/repo/k1f1ipmn-62w82-local', fromRepoLocalSync=false
15:47:50.380 [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/k1f1ipmn-62w82-local/.cloudstore-repo/tmp/ChangeSetDto.a2ca61b2-221c-4e2a-88d7-631a4eef4a6a.null.xml.gz
15:47:50.394 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5cec6f4d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:50.395 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5cec6f4d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:51.055 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5cec6f4d]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:51.056 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5cec6f4d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 661 ms.
15:47:51.091 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5cec6f4d]getCloseDeferredMillis: closeDeferredMillis=0
15:47:51.091 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5cec6f4d]close: Closing real LocalRepoManager immediately.
15:47:51.091 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5cec6f4d]_close: Shutting down real LocalRepoManager.
15:47:51.468 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [389420f4]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:51.470 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [389420f4]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:52.128 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [389420f4]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:52.128 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [389420f4]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 657 ms.
15:47:52.186 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:47:52.189 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:52.189 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:47:52.189 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:47:52.189 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
15:47:52.198 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:47:52.210 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:47:52.210 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:47:52.210 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:47:52.210 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:47:52.211 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [389420f4]getCloseDeferredMillis: closeDeferredMillis=0
15:47:52.211 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [389420f4]close: Closing real LocalRepoManager immediately.
15:47:52.211 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [389420f4]_close: Shutting down real LocalRepoManager.
15:47:52.603 [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/k1f1ipmn-62w82-local/.cloudstore-repo/tmp/ChangeSetDto.a2ca61b2-221c-4e2a-88d7-631a4eef4a6a.null.xml.gz
15:47:52.603 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 77.11%
15:47:52.604 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
15:47:52.604 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
15:47:52.637 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [5b54f390]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:52.638 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [5b54f390]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:53.295 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [5b54f390]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:53.296 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [5b54f390]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 658 ms.
15:47:53.332 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [5b54f390]getCloseDeferredMillis: closeDeferredMillis=0
15:47:53.332 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [5b54f390]close: Closing real LocalRepoManager immediately.
15:47:53.332 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [5b54f390]_close: Shutting down real LocalRepoManager.
15:47:55.598 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [303ec877]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:55.599 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [303ec877]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:56.252 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [303ec877]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:56.253 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [303ec877]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 654 ms.
15:47:56.328 [qtp1608332243-29] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 localRepositoryRevisionSynced=15
15:47:56.331 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [303ec877]getCloseDeferredMillis: closeDeferredMillis=0
15:47:56.332 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [303ec877]close: Closing real LocalRepoManager immediately.
15:47:56.332 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [303ec877]_close: Shutting down real LocalRepoManager.
15:47:56.720 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 remoteRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a transaction.localRevision=94 remoteFromLocalRevision=15
15:47:56.722 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
15:47:56.723 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6f651ac]getCloseDeferredMillis: closeDeferredMillis=0
15:47:56.723 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6f651ac]close: Closing real LocalRepoManager immediately.
15:47:56.723 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6f651ac]_close: Shutting down real LocalRepoManager.
15:47:57.401 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
15:47:57.402 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restoring backup: 'target/repo/k1f1ipmo-6erlk-remote.bak' => 'target/repo/k1f1ipmo-6erlk-remote'
15:47:57.485 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restored backup: 'target/repo/k1f1ipmo-6erlk-remote.bak' => 'target/repo/k1f1ipmo-6erlk-remote'
15:47:57.486 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
15:47:57.487 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6520625f]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmn-62w82-local'
15:47:57.487 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6520625f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmn-62w82-local' locked successfully.
15:47:58.092 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6520625f]initPersistenceManagerFactory: repositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:47:58.092 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6520625f]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 604 ms.
15:47:58.299 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [28d3d4e9]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:58.299 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [28d3d4e9]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:47:58.518 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [369eabc0]initPersistenceManagerFactory: repositoryId=e10fdbab-5a5c-4a01-80ea-0a2b23904895
15:47:58.575 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [369eabc0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 8366 ms.
15:47:58.839 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [369eabc0]getCloseDeferredMillis: closeDeferredMillis=20000
15:47:58.839 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [369eabc0]close: Deferring shut down of real LocalRepoManager 20000 ms.
15:47:58.949 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [28d3d4e9]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:47:58.950 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [28d3d4e9]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 650 ms.
15:47:58.971 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [28d3d4e9]getCloseDeferredMillis: closeDeferredMillis=0
15:47:58.971 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [28d3d4e9]close: Closing real LocalRepoManager immediately.
15:47:58.971 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [28d3d4e9]_close: Shutting down real LocalRepoManager.
15:47:59.663 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 0.50%
15:47:59.665 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a from='https://localhost:38589/a2ca61b2-221c-4e2a-88d7-631a4eef4a6a' toID=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 to='target/repo/k1f1ipmn-62w82-local', fromRepoLocalSync=true
15:47:59.665 [pool-9-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing d9b9682d-fd97-4bdb-aa0c-b16661ac6332 ('target/repo/k1f1ipmn-62w82-local')
15:47:59.714 [pool-9-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 12.94%
15:47:59.759 [pool-9-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 19.03%
15:47:59.796 [pool-9-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 24.15%
15:47:59.849 [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/k1f1ipmn-62w82-local/.cloudstore-repo/tmp/ChangeSetDto.a2ca61b2-221c-4e2a-88d7-631a4eef4a6a.15.xml.gz
15:47:59.871 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [25cd1940]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:47:59.872 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [25cd1940]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:00.387 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [25cd1940]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:00.387 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [25cd1940]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 515 ms.
15:48:00.425 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [25cd1940]getCloseDeferredMillis: closeDeferredMillis=0
15:48:00.425 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [25cd1940]close: Closing real LocalRepoManager immediately.
15:48:00.425 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [25cd1940]_close: Shutting down real LocalRepoManager.
15:48:00.866 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 serverRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a renewalDateTime=2019-10-06T14:17:12.655Z expiryDateTime=2019-10-06T14:47:12.655Z
15:48:00.886 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5731beab]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:00.886 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5731beab]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:01.497 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5731beab]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:01.498 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5731beab]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 612 ms.
15:48:01.536 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5731beab]getCloseDeferredMillis: closeDeferredMillis=0
15:48:01.536 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5731beab]close: Closing real LocalRepoManager immediately.
15:48:01.536 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5731beab]_close: Shutting down real LocalRepoManager.
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 350.478 sec - in co.codewizards.cloudstore.test.LocalServerClientIT
15:48:01.628 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@7f3f5081{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
15:48:01.629 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:48:01.641 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@2de78cf7{/,null,UNAVAILABLE}
15:48:01.651 [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/Q2kEWBvS4DEU8QmtKIAiJg/.cloudstore/localServerRunning.deleteToStop
15:48:01.657 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@125ae04c{SSL,[ssl, http/1.1]}{0.0.0.0:34002}
15:48:01.659 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:48:01.660 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@4aaab427{/,null,UNAVAILABLE}
15:48:01.958 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [57c591c9]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:01.959 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [57c591c9]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:02.517 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [57c591c9]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:02.518 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [57c591c9]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 558 ms.
15:48:02.536 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
15:48:02.551 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
15:48:02.569 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
15:48:02.589 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
15:48:02.595 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
15:48:02.609 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
15:48:02.634 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
15:48:02.658 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
15:48:02.670 [pool-4-thread-1] WARN c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=15 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=6
15:48:02.698 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:48:02.704 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:02.704 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:48:02.705 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:48:02.705 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 localRepositoryRevisionSynced=15 localRepositoryRevisionInProgress=8
15:48:02.714 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:48:02.720 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:48:02.721 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:48:02.721 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:48:02.721 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:48:02.721 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [57c591c9]getCloseDeferredMillis: closeDeferredMillis=0
15:48:02.721 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [57c591c9]close: Closing real LocalRepoManager immediately.
15:48:02.721 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [57c591c9]_close: Shutting down real LocalRepoManager.
15:48:03.085 [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/k1f1ipmn-62w82-local/.cloudstore-repo/tmp/ChangeSetDto.a2ca61b2-221c-4e2a-88d7-631a4eef4a6a.15.xml.gz
15:48:03.085 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
15:48:03.086 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
15:48:03.107 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [5732a2ac]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:03.107 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [5732a2ac]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:03.667 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [5732a2ac]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:03.668 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [5732a2ac]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 560 ms.
15:48:03.697 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [5732a2ac]getCloseDeferredMillis: closeDeferredMillis=0
15:48:03.697 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [5732a2ac]close: Closing real LocalRepoManager immediately.
15:48:03.697 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [5732a2ac]_close: Shutting down real LocalRepoManager.
15:48:04.582 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [402d4e91]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:04.582 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [402d4e91]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:05.074 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [402d4e91]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:05.074 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [402d4e91]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 491 ms.
15:48:05.138 [qtp1608332243-92] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 localRepositoryRevisionSynced=8
15:48:05.148 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [402d4e91]getCloseDeferredMillis: closeDeferredMillis=0
15:48:05.148 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [402d4e91]close: Closing real LocalRepoManager immediately.
15:48:05.148 [qtp1608332243-92] INFO c.c.c.l.LocalRepoManagerImpl - [402d4e91]_close: Shutting down real LocalRepoManager.
15:48:05.617 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 remoteRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a transaction.localRevision=95 remoteFromLocalRevision=8
15:48:05.621 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 from='target/repo/k1f1ipmn-62w82-local' toID=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a to='https://localhost:38589/a2ca61b2-221c-4e2a-88d7-631a4eef4a6a'
15:48:05.640 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [551c6c58]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:05.640 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [551c6c58]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:06.123 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [551c6c58]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:06.124 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [551c6c58]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 484 ms.
15:48:06.145 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [551c6c58]getCloseDeferredMillis: closeDeferredMillis=0
15:48:06.145 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [551c6c58]close: Closing real LocalRepoManager immediately.
15:48:06.145 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [551c6c58]_close: Shutting down real LocalRepoManager.
15:48:06.457 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [338b0eab]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:06.458 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [338b0eab]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:07.000 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [338b0eab]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:07.001 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [338b0eab]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 543 ms.
15:48:07.024 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [338b0eab]getCloseDeferredMillis: closeDeferredMillis=0
15:48:07.024 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [338b0eab]close: Closing real LocalRepoManager immediately.
15:48:07.024 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [338b0eab]_close: Shutting down real LocalRepoManager.
15:48:07.374 [main] WARN c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=84 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=89
15:48:07.386 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:48:07.389 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:48:07.389 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:07.389 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:48:07.389 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 remoteRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=95
15:48:07.397 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:48:07.431 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:48:07.431 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:48:07.431 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:48:07.431 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:48:07.431 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 56.31%
15:48:07.432 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
15:48:07.453 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c5e5de8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:07.453 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c5e5de8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:08.017 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c5e5de8]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:08.017 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c5e5de8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 564 ms.
15:48:08.041 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c5e5de8]getCloseDeferredMillis: closeDeferredMillis=0
15:48:08.041 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c5e5de8]close: Closing real LocalRepoManager immediately.
15:48:08.041 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c5e5de8]_close: Shutting down real LocalRepoManager.
15:48:08.383 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c7567c0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:08.383 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c7567c0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:08.911 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c7567c0]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:08.911 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c7567c0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 527 ms.
15:48:09.184 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c7567c0]getCloseDeferredMillis: closeDeferredMillis=0
15:48:09.184 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c7567c0]close: Closing real LocalRepoManager immediately.
15:48:09.184 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7c7567c0]_close: Shutting down real LocalRepoManager.
15:48:09.494 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 62.42%
15:48:09.494 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 68.52%
15:48:09.495 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
15:48:09.527 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [67ab9439]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:09.527 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [67ab9439]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:10.027 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [67ab9439]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:10.027 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [67ab9439]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 499 ms.
15:48:10.050 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [67ab9439]getCloseDeferredMillis: closeDeferredMillis=0
15:48:10.050 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [67ab9439]close: Closing real LocalRepoManager immediately.
15:48:10.050 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [67ab9439]_close: Shutting down real LocalRepoManager.
15:48:10.379 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5b9c6edb]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:10.379 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5b9c6edb]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:10.914 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5b9c6edb]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:10.915 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5b9c6edb]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 535 ms.
15:48:10.953 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5b9c6edb]getCloseDeferredMillis: closeDeferredMillis=0
15:48:10.953 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5b9c6edb]close: Closing real LocalRepoManager immediately.
15:48:10.953 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5b9c6edb]_close: Shutting down real LocalRepoManager.
15:48:11.305 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='ff06115bc1a1d1140c8a1c7c54e15af28858b482' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
Oct 06, 2019 3:48:11 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
15:48:11.326 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [4bd0f92b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:11.326 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [4bd0f92b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:11.840 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [4bd0f92b]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:11.841 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [4bd0f92b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 515 ms.
15:48:11.864 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [4bd0f92b]getCloseDeferredMillis: closeDeferredMillis=0
15:48:11.864 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [4bd0f92b]close: Closing real LocalRepoManager immediately.
15:48:11.864 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [4bd0f92b]_close: Shutting down real LocalRepoManager.
15:48:12.183 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7e6c16d4]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:12.184 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7e6c16d4]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:12.739 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7e6c16d4]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:12.740 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7e6c16d4]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 555 ms.
15:48:12.851 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7e6c16d4]getCloseDeferredMillis: closeDeferredMillis=0
15:48:12.852 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7e6c16d4]close: Closing real LocalRepoManager immediately.
15:48:12.852 [qtp1608332243-29] INFO c.c.c.l.LocalRepoManagerImpl - [7e6c16d4]_close: Shutting down real LocalRepoManager.
15:48:13.274 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="d9b9682d-fd97-4bdb-aa0c-b16661ac6332"] on repo=d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:48:13.277 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
15:48:13.336 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [650bb9f9]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:13.336 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [650bb9f9]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:13.906 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [650bb9f9]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:13.906 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [650bb9f9]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 569 ms.
15:48:13.929 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [650bb9f9]getCloseDeferredMillis: closeDeferredMillis=0
15:48:13.929 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [650bb9f9]close: Closing real LocalRepoManager immediately.
15:48:13.929 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [650bb9f9]_close: Shutting down real LocalRepoManager.
15:48:14.256 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [49e0dde2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:14.257 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [49e0dde2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:14.807 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [49e0dde2]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:14.808 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [49e0dde2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 550 ms.
15:48:14.863 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [49e0dde2]getCloseDeferredMillis: closeDeferredMillis=0
15:48:14.863 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [49e0dde2]close: Closing real LocalRepoManager immediately.
15:48:14.863 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [49e0dde2]_close: Shutting down real LocalRepoManager.
15:48:15.190 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 211631 bytes in 1912 ms. path='/3/zzz'
Oct 06, 2019 3:48:15 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
15:48:15.216 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e13151d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:15.217 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e13151d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:15.801 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e13151d]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:15.802 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e13151d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 585 ms.
15:48:15.827 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e13151d]getCloseDeferredMillis: closeDeferredMillis=0
15:48:15.827 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e13151d]close: Closing real LocalRepoManager immediately.
15:48:15.827 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [4e13151d]_close: Shutting down real LocalRepoManager.
15:48:16.147 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [914eb15]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:16.147 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [914eb15]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:16.700 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [914eb15]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:16.700 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [914eb15]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 553 ms.
15:48:16.746 [qtp1608332243-72] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
15:48:16.807 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [914eb15]getCloseDeferredMillis: closeDeferredMillis=0
15:48:16.807 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [914eb15]close: Closing real LocalRepoManager immediately.
15:48:16.807 [qtp1608332243-72] INFO c.c.c.l.LocalRepoManagerImpl - [914eb15]_close: Shutting down real LocalRepoManager.
15:48:17.251 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="d9b9682d-fd97-4bdb-aa0c-b16661ac6332"] on repo=d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:48:17.262 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
15:48:17.277 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 remoteRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a localRepositoryRevisionSynced=95
15:48:17.298 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [26fb1dc]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:17.298 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [26fb1dc]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:17.878 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [26fb1dc]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:17.878 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [26fb1dc]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 579 ms.
15:48:17.904 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [26fb1dc]getCloseDeferredMillis: closeDeferredMillis=0
15:48:17.904 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [26fb1dc]close: Closing real LocalRepoManager immediately.
15:48:17.904 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [26fb1dc]_close: Shutting down real LocalRepoManager.
15:48:18.260 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [786a6cc8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:18.261 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [786a6cc8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:18.816 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [786a6cc8]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:18.817 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [786a6cc8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 555 ms.
15:48:18.859 [qtp1608332243-45] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 transaction.localRevision=15 remoteFromLocalRevision=95
15:48:19.007 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [786a6cc8]getCloseDeferredMillis: closeDeferredMillis=0
15:48:19.008 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [786a6cc8]close: Closing real LocalRepoManager immediately.
15:48:19.008 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [786a6cc8]_close: Shutting down real LocalRepoManager.
15:48:19.452 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a from='https://localhost:38589/a2ca61b2-221c-4e2a-88d7-631a4eef4a6a' toID=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 to='target/repo/k1f1ipmn-62w82-local', fromRepoLocalSync=false
15:48:19.453 [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/k1f1ipmn-62w82-local/.cloudstore-repo/tmp/ChangeSetDto.a2ca61b2-221c-4e2a-88d7-631a4eef4a6a.null.xml.gz
15:48:19.475 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5e4b3362]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:19.476 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5e4b3362]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:20.007 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5e4b3362]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:20.007 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5e4b3362]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 531 ms.
15:48:20.031 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5e4b3362]getCloseDeferredMillis: closeDeferredMillis=0
15:48:20.031 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5e4b3362]close: Closing real LocalRepoManager immediately.
15:48:20.031 [qtp1608332243-45] INFO c.c.c.l.LocalRepoManagerImpl - [5e4b3362]_close: Shutting down real LocalRepoManager.
15:48:20.347 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [418b5e56]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:20.348 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [418b5e56]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:20.912 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [418b5e56]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:20.913 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [418b5e56]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 565 ms.
15:48:20.972 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
15:48:20.977 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:20.978 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: d9b9682d-fd97-4bdb-aa0c-b16661ac6332
15:48:20.978 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
15:48:20.978 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
15:48:20.989 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
15:48:20.997 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
15:48:20.997 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
15:48:20.997 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
15:48:20.997 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
15:48:20.998 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [418b5e56]getCloseDeferredMillis: closeDeferredMillis=0
15:48:20.998 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [418b5e56]close: Closing real LocalRepoManager immediately.
15:48:20.998 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [418b5e56]_close: Shutting down real LocalRepoManager.
15:48:21.346 [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/k1f1ipmn-62w82-local/.cloudstore-repo/tmp/ChangeSetDto.a2ca61b2-221c-4e2a-88d7-631a4eef4a6a.null.xml.gz
15:48:21.347 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
15:48:21.347 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
15:48:21.372 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [5ac95e27]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:21.372 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [5ac95e27]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:21.888 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [5ac95e27]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:21.888 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [5ac95e27]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 516 ms.
15:48:21.910 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [5ac95e27]getCloseDeferredMillis: closeDeferredMillis=0
15:48:21.910 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [5ac95e27]close: Closing real LocalRepoManager immediately.
15:48:21.910 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [5ac95e27]_close: Shutting down real LocalRepoManager.
15:48:22.310 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [18a076e1]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote'
15:48:22.311 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [18a076e1]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k1f1ipmo-6erlk-remote' locked successfully.
15:48:22.864 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [18a076e1]initPersistenceManagerFactory: repositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a
15:48:22.864 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [18a076e1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 553 ms.
15:48:22.921 [qtp1608332243-24] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a remoteRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 localRepositoryRevisionSynced=15
15:48:22.930 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [18a076e1]getCloseDeferredMillis: closeDeferredMillis=0
15:48:22.930 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [18a076e1]close: Closing real LocalRepoManager immediately.
15:48:22.930 [qtp1608332243-24] INFO c.c.c.l.LocalRepoManagerImpl - [18a076e1]_close: Shutting down real LocalRepoManager.
15:48:23.279 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=d9b9682d-fd97-4bdb-aa0c-b16661ac6332 remoteRepositoryId=a2ca61b2-221c-4e2a-88d7-631a4eef4a6a transaction.localRevision=100 remoteFromLocalRevision=15
15:48:23.282 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
15:48:23.362 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6520625f]getCloseDeferredMillis: closeDeferredMillis=0
15:48:23.362 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6520625f]close: Closing real LocalRepoManager immediately.
15:48:23.362 [main] INFO c.c.c.l.LocalRepoManagerImpl - [6520625f]_close: Shutting down real LocalRepoManager.
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 264.325 sec - in co.codewizards.cloudstore.test.repotorepo.BackupRestoreRepoToRepoSyncIT
15:48:23.903 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@453a67e0{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
15:48:23.905 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:48:23.912 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@5e4c038{/,null,UNAVAILABLE}
15:48:23.921 [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/baaK6WfAowPOLzj5E5hicQ/.cloudstore/localServerRunning.deleteToStop
15:48:23.930 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@1b4ecca5{SSL,[ssl, http/1.1]}{0.0.0.0:38589}
15:48:23.931 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:48:23.932 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@70916fae{/,null,UNAVAILABLE}
15:49:11.394 [main] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.SocketException: Broken pipe (Write failed)
javax.ws.rs.ProcessingException: java.net.SocketException: Broken pipe (Write failed)
at org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUrlConnector.java:184) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.ClientRuntime.invoke(ClientRuntime.java:227) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation$2.call(JerseyInvocation.java:671) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.internal.Errors.process(Errors.java:315) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.internal.Errors.process(Errors.java:297) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.internal.Errors.process(Errors.java:228) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:422) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation.invoke(JerseyInvocation.java:667) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation$Builder.method(JerseyInvocation.java:396) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation$Builder.get(JerseyInvocation.java:296) ~[jersey-client-2.5.1.jar:na]
at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.determineBaseUrl(CloudStoreRestClient.java:115) ~[co.codewizards.cloudstore.rest.client-0.10.8-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.getBaseUrl(CloudStoreRestClient.java:74) ~[co.codewizards.cloudstore.rest.client-0.10.8-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.AbstractRequest.getBaseURL(AbstractRequest.java:146) ~[co.codewizards.cloudstore.rest.client-0.10.8-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.AbstractRequest.createWebTarget(AbstractRequest.java:115) ~[co.codewizards.cloudstore.rest.client-0.10.8-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.TestRequest.execute(TestRequest.java:27) ~[co.codewizards.cloudstore.rest.client-0.10.8-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.TestRequest.execute(TestRequest.java:6) ~[co.codewizards.cloudstore.rest.client-0.10.8-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.execute(CloudStoreRestClient.java:163) ~[co.codewizards.cloudstore.rest.client-0.10.8-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.test.CertificateHandlingAndTestServiceLRT.almostTimedOut_5min(CertificateHandlingAndTestServiceLRT.java:89) [test-classes/:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_222]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_222]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_222]
at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_222]
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) [junit-4.12.jar:4.12]
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.12.jar:4.12]
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) [junit-4.12.jar:4.12]
at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) [jmockit-1.24.jar:na]
at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) [jmockit-1.24.jar:na]
at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) [jmockit-1.24.jar:na]
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) [junit-4.12.jar:4.12]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) [junit-4.12.jar:4.12]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [junit-4.12.jar:4.12]
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264) [surefire-junit4-2.17.jar:2.17]
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153) [surefire-junit4-2.17.jar:2.17]
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124) [surefire-junit4-2.17.jar:2.17]
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200) [surefire-booter-2.17.jar:2.17]
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153) [surefire-booter-2.17.jar:2.17]
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103) [surefire-booter-2.17.jar:2.17]
Caused by: java.net.SocketException: Broken pipe (Write failed)
at java.net.SocketOutputStream.socketWrite0(Native Method) ~[na:1.8.0_222]
at java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:111) ~[na:1.8.0_222]
at java.net.SocketOutputStream.write(SocketOutputStream.java:155) ~[na:1.8.0_222]
at sun.security.ssl.OutputRecord.writeBuffer(OutputRecord.java:431) ~[na:1.8.0_222]
at sun.security.ssl.OutputRecord.write(OutputRecord.java:417) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.writeRecordInternal(SSLSocketImpl.java:879) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:850) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:720) ~[na:1.8.0_222]
at sun.security.ssl.Handshaker.sendChangeCipherSpec(Handshaker.java:1144) ~[na:1.8.0_222]
at sun.security.ssl.ClientHandshaker.sendChangeCipherAndFinish(ClientHandshaker.java:1280) ~[na:1.8.0_222]
at sun.security.ssl.ClientHandshaker.serverHelloDone(ClientHandshaker.java:1190) ~[na:1.8.0_222]
at sun.security.ssl.ClientHandshaker.processMessage(ClientHandshaker.java:369) ~[na:1.8.0_222]
at sun.security.ssl.Handshaker.processLoop(Handshaker.java:1037) ~[na:1.8.0_222]
at sun.security.ssl.Handshaker.process_record(Handshaker.java:965) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:1064) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1367) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1395) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1379) ~[na:1.8.0_222]
at sun.net.www.protocol.https.HttpsClient.afterConnect(HttpsClient.java:559) ~[na:1.8.0_222]
at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:185) ~[na:1.8.0_222]
at sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1570) ~[na:1.8.0_222]
at sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1498) ~[na:1.8.0_222]
at java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:480) ~[na:1.8.0_222]
at sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:352) ~[na:1.8.0_222]
at org.glassfish.jersey.client.HttpUrlConnector._apply(HttpUrlConnector.java:276) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUrlConnector.java:182) ~[jersey-client-2.5.1.jar:na]
... 48 common frames omitted
Tests run: 4, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 418.925 sec - in co.codewizards.cloudstore.test.CertificateHandlingAndTestServiceLRT
15:49:12.568 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@7441c8d3{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
15:49:12.570 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:49:12.578 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@333d20de{/,null,UNAVAILABLE}
15:49:12.590 [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/OBOHM89ZkDrFBs4xDPZFqg/.cloudstore/localServerRunning.deleteToStop
15:49:12.602 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@5df950b4{SSL,[ssl, http/1.1]}{0.0.0.0:37693}
15:49:12.603 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
15:49:12.605 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@21eb0e{/,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.8-SNAPSHOT-sources.jar
[INFO] co already added, skipping
[INFO] co/codewizards already added, skipping
[INFO] co/codewizards/cloudstore already added, skipping
[INFO] co/codewizards/cloudstore/test already added, skipping
[INFO]
[INFO] --- maven-failsafe-plugin:2.17:verify (default) @ co.codewizards.cloudstore.test ---
[INFO] Failsafe report directory: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/failsafe-reports
[JENKINS] Recording test results[INFO]
[INFO] --- maven-install-plugin:2.3.1:install (default-install) @ co.codewizards.cloudstore.test ---
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-0.10.8-SNAPSHOT.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/co.codewizards.cloudstore.test-0.10.8-SNAPSHOT.jar
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/pom.xml to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/co.codewizards.cloudstore.test-0.10.8-SNAPSHOT.pom
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-0.10.8-SNAPSHOT-sources.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/co.codewizards.cloudstore.test-0.10.8-SNAPSHOT-sources.jar
[INFO]
[INFO] --- maven-deploy-plugin:2.7:deploy (default-deploy) @ co.codewizards.cloudstore.test ---
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/maven-metadata.xml
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/co.codewizards.cloudstore.test-0.10.8-20191006.134913-1.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/co.codewizards.cloudstore.test-0.10.8-20191006.134913-1.jar (7 KB at 1285.0 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/co.codewizards.cloudstore.test-0.10.8-20191006.134913-1.pom
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/co.codewizards.cloudstore.test-0.10.8-20191006.134913-1.pom (6 KB at 5167.0 KB/sec)
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/maven-metadata.xml (808 B at 39.5 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (316 B at 16.2 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/co.codewizards.cloudstore.test-0.10.8-20191006.134913-1-sources.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/co.codewizards.cloudstore.test-0.10.8-20191006.134913-1-sources.jar (3 KB at 2148.4 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.8-SNAPSHOT/maven-metadata.xml (1023 B at 499.5 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
|
Help us localize this page