SuccessConsole Output

Skipping 1,673 KB.. Full Log
to.4a37ddb3-c5ca-4124-b558-bf420c81fcf7.null.xml.gz
08:08:41.299 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
08:08:41.299 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
08:08:41.320 [qtp2032110040-28] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=4a37ddb3-c5ca-4124-b558-bf420c81fcf7 remoteRepositoryId=66758cf6-2c19-4932-ab91-6a4b250b5214 localRepositoryRevisionSynced=12
08:08:41.408 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=66758cf6-2c19-4932-ab91-6a4b250b5214 remoteRepositoryId=4a37ddb3-c5ca-4124-b558-bf420c81fcf7 transaction.localRevision=94 remoteFromLocalRevision=12
08:08:41.416 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
08:08:41.553 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [6705fb02]getCloseDeferredMillis: closeDeferredMillis=20000
08:08:41.553 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [6705fb02]close: Deferring shut down of real LocalRepoManager 20000 ms.
08:08:41.554 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5b5e45bc]getCloseDeferredMillis: closeDeferredMillis=20000
08:08:41.554 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5b5e45bc]close: Deferring shut down of real LocalRepoManager 20000 ms.
08:08:41.558 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [19d75d3c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3o-2yix9-local'
08:08:41.560 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [19d75d3c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3o-2yix9-local' locked successfully.
08:08:41.750 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 serverRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 renewalDateTime=2020-05-02T06:38:23.225Z expiryDateTime=2020-05-02T07:08:23.225Z
08:08:41.758 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [32152432]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:41.759 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [32152432]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:42.736 [qtp2084290916-26] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:08:42.933 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [32152432]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:42.933 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [32152432]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1173 ms.
08:08:42.970 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [32152432]getCloseDeferredMillis: closeDeferredMillis=0
08:08:42.970 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [32152432]close: Closing real LocalRepoManager immediately.
08:08:42.970 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [32152432]_close: Shutting down real LocalRepoManager.
08:08:43.293 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [69e87cbe]initPersistenceManagerFactory: repositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1
08:08:43.316 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [69e87cbe]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 7811 ms.
08:08:43.388 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [2b55528]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:43.389 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [2b55528]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:43.641 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=105.0 MiB, used=41.3 MiB, available=3.9 GiB
08:08:44.210 [pool-4-thread-1] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
Successfully requested to connect the following local and remote repositories:

  localRepository.repositoryId = 56bdfe23-6f5e-4872-9552-f9c85f81f622
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p865k1-vzjsh-local
  localRepository.publicKeySha1 = 19:41:58:EC:C0:8E:89:1D:EB:FA:D7:C0:18:A8:40:D9:3E:95:62:1B

  remoteRepository.repositoryId = 52b26e11-01ea-4c65-a203-f4178d44afb1
  remoteRepository.remoteRoot = https://localhost:29580/52b26e11-01ea-4c65-a203-f4178d44afb1
  remoteRepository.publicKeySha1 = 6D:AD:1C:DD:E6:92:8D:D0:65:BB:9E:B8:75:88:86:44:BF:42:41:C1

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 56bdfe23-6f5e-4872-9552-f9c85f81f622 52b26e11-01ea-4c65-a203-f4178d44afb1
08:08:44.410 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [2b55528]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:44.411 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [2b55528]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1021 ms.
08:08:44.438 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
08:08:44.452 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
08:08:44.478 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
08:08:44.511 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
08:08:44.521 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
08:08:44.547 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
08:08:44.585 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
08:08:44.622 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
08:08:44.658 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=105.0 MiB, used=40.3 MiB, available=3.9 GiB
08:08:44.671 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:08:44.675 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:44.676 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:08:44.676 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:08:44.676 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 localRepositoryRevisionSynced=6 localRepositoryRevisionInProgress=8
08:08:44.688 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:08:44.698 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:08:44.698 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:08:44.698 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:08:44.699 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:08:44.699 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [2b55528]getCloseDeferredMillis: closeDeferredMillis=0
08:08:44.699 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [2b55528]close: Closing real LocalRepoManager immediately.
08:08:44.699 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [2b55528]_close: Shutting down real LocalRepoManager.
Successfully accepted the connection request for the following local and remote repositories:

  localRepository.repositoryId = 52b26e11-01ea-4c65-a203-f4178d44afb1
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p865k3-jund8-remote
  localRepository.publicKeySha1 = 6D:AD:1C:DD:E6:92:8D:D0:65:BB:9E:B8:75:88:86:44:BF:42:41:C1

  remoteRepository.repositoryId = 56bdfe23-6f5e-4872-9552-f9c85f81f622
  remoteRepository.publicKeySha1 = 19:41:58:EC:C0:8E:89:1D:EB:FA:D7:C0:18:A8:40:D9:3E:95:62:1B

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 52b26e11-01ea-4c65-a203-f4178d44afb1 56bdfe23-6f5e-4872-9552-f9c85f81f622
08:08:44.965 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewk-mhk6p-local/.cloudstore-repo/tmp/ChangeSetDto.504d3477-5b0f-45a7-955e-d5180b0bc3c8.6.xml.gz
08:08:44.965 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
08:08:44.965 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
08:08:44.977 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [2ccb7a7e]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:44.977 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [2ccb7a7e]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
WatchTaskFirstWrittenChunk started
08:08:45.621 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
08:08:45.623 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=52b26e11-01ea-4c65-a203-f4178d44afb1 from='https://localhost:29580/52b26e11-01ea-4c65-a203-f4178d44afb1' toID=56bdfe23-6f5e-4872-9552-f9c85f81f622 to='target/repo/k9p865k1-vzjsh-local', fromRepoLocalSync=true
08:08:45.623 [pool-33-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 56bdfe23-6f5e-4872-9552-f9c85f81f622 ('target/repo/k9p865k1-vzjsh-local')
08:08:45.640 [pool-33-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
08:08:45.669 [pool-33-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
08:08:45.714 [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_java_11/co.codewizards.cloudstore.test/target/repo/k9p865k1-vzjsh-local/.cloudstore-repo/tmp/ChangeSetDto.52b26e11-01ea-4c65-a203-f4178d44afb1.-1.xml.gz
08:08:45.761 [pool-32-thread-2] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 serverRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 renewalDateTime=2020-05-02T06:38:45.724Z expiryDateTime=2020-05-02T07:08:45.724Z
08:08:45.774 [pool-5-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
08:08:45.778 [pool-5-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
08:08:45.808 [pool-5-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.20%
08:08:45.813 [pool-5-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 60.39%
08:08:45.820 [pool-5-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 65.59%
08:08:45.826 [pool-5-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 70.79%
08:08:45.834 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:08:45.935 [pool-5-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 99.00%
08:08:45.976 [pool-5-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
08:08:46.024 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [2ccb7a7e]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:46.025 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [2ccb7a7e]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1046 ms.
08:08:46.060 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [2ccb7a7e]getCloseDeferredMillis: closeDeferredMillis=0
08:08:46.060 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [2ccb7a7e]close: Closing real LocalRepoManager immediately.
08:08:46.061 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [2ccb7a7e]_close: Shutting down real LocalRepoManager.
08:08:46.082 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:08:46.087 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 52b26e11-01ea-4c65-a203-f4178d44afb1
08:08:46.087 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 56bdfe23-6f5e-4872-9552-f9c85f81f622
08:08:46.087 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:08:46.087 [pool-5-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 remoteRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
08:08:46.096 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:08:46.135 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:08:46.135 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:08:46.135 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:08:46.136 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:08:46.146 [pool-32-thread-2] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p865k1-vzjsh-local/.cloudstore-repo/tmp/ChangeSetDto.52b26e11-01ea-4c65-a203-f4178d44afb1.-1.xml.gz
08:08:46.146 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
08:08:46.148 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
08:08:46.240 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
08:08:46.242 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
08:08:46.243 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
08:08:46.245 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [690a0ad3]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:46.246 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [690a0ad3]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:46.299 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='6afadf217c74e3de7581a38d6ec2d14ee653242b' to.sha1='<NoInstanceOf_NormalFileDto>'): /d
08:08:46.544 [pool-32-thread-2] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="52b26e11-01ea-4c65-a203-f4178d44afb1"] on repo=56bdfe23-6f5e-4872-9552-f9c85f81f622
08:08:46.553 [pool-32-thread-2] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
08:08:46.741 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
createTempChunkFile: d; createNewFile=true
08:08:46.936 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [690a0ad3]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:46.937 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [690a0ad3]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 685 ms.
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
08:08:47.038 [qtp2084290916-30] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 localRepositoryRevisionSynced=8
08:08:47.045 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [690a0ad3]getCloseDeferredMillis: closeDeferredMillis=0
08:08:47.045 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [690a0ad3]close: Closing real LocalRepoManager immediately.
08:08:47.045 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [690a0ad3]_close: Shutting down real LocalRepoManager.
FileWatcher: CHUNK_SIZE reached! chunk_3c363836cf4e16666669a25da280a1865c2d2874_0
WatchTaskChunksToFile: ready
08:08:47.365 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 remoteRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 transaction.localRevision=89 remoteFromLocalRevision=8
08:08:47.368 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=4e17acfb-02f2-4ba0-a29a-5be3a4106775 from='target/repo/k9p85ewk-mhk6p-local' toID=504d3477-5b0f-45a7-955e-d5180b0bc3c8 to='https://localhost:5768/504d3477-5b0f-45a7-955e-d5180b0bc3c8'
08:08:47.398 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [15898bd5]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:47.399 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [15898bd5]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:47.600 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
08:08:47.601 [pool-32-thread-2] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
08:08:47.800 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 0.50%
08:08:47.811 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=52b26e11-01ea-4c65-a203-f4178d44afb1 from='https://localhost:29580/52b26e11-01ea-4c65-a203-f4178d44afb1' toID=56bdfe23-6f5e-4872-9552-f9c85f81f622 to='target/repo/k9p865k1-vzjsh-local', fromRepoLocalSync=true
08:08:47.811 [pool-35-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 56bdfe23-6f5e-4872-9552-f9c85f81f622 ('target/repo/k9p865k1-vzjsh-local')
08:08:47.815 [qtp2084290916-26] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:08:47.822 [pool-35-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 12.94%
08:08:47.840 [pool-35-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 19.03%
08:08:47.842 [pool-35-thread-1] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 25.12%
08:08:47.920 [pool-34-thread-3] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Read ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p865k1-vzjsh-local/.cloudstore-repo/tmp/ChangeSetDto.52b26e11-01ea-4c65-a203-f4178d44afb1.-1.xml.gz
08:08:47.920 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 30.16%
08:08:47.921 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 35.76%
08:08:47.932 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/d'
08:08:47.966 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [15898bd5]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:47.967 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [15898bd5]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 566 ms.
08:08:47.996 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [15898bd5]getCloseDeferredMillis: closeDeferredMillis=0
08:08:47.997 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [15898bd5]close: Closing real LocalRepoManager immediately.
08:08:47.997 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [15898bd5]_close: Shutting down real LocalRepoManager.
08:08:48.057 [pool-34-thread-3] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 serverRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 renewalDateTime=2020-05-02T06:38:45.724Z expiryDateTime=2020-05-02T07:08:45.724Z
08:08:48.071 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [14ebfb5b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:48.071 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [14ebfb5b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:48.138 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='6afadf217c74e3de7581a38d6ec2d14ee653242b' to.sha1='da39a3ee5e6b4b0d3255bfef95601890afd80709'): /d
08:08:48.190 [pool-34-thread-3] WARN  c.c.c.l.t.FileRepoTransport - Unexpected state: markFileInProgress==null='false', inProgress='true' on repo=56bdfe23-6f5e-4872-9552-f9c85f81f622
08:08:48.194 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 2 dirty file-chunks (of 2 total). path='/d'
08:08:48.701 [qtp2084290916-26] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_0, chunksCreated=1
08:08:48.907 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [14ebfb5b]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:48.908 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [14ebfb5b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 835 ms.
08:08:48.951 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [14ebfb5b]getCloseDeferredMillis: closeDeferredMillis=0
08:08:48.951 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [14ebfb5b]close: Closing real LocalRepoManager immediately.
08:08:48.951 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [14ebfb5b]_close: Shutting down real LocalRepoManager.
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
createTempChunkFile: d; createNewFile=true
watchForCreationsDeletions: ENTRY_CREATE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksCreated=2
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
08:08:49.715 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1049086 bytes in 1521 ms. path='/d'
08:08:49.725 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_0, chunksDeleted=1
08:08:49.743 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34 into destFile d
WatchTaskChunksToFile: length reached! length=1049086
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksDeleted=2
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
08:08:49.922 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:08:49.925 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:08:49.925 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:49.925 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:08:49.925 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 remoteRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=89
08:08:49.934 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:08:49.970 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:08:49.970 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:08:49.970 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:08:49.970 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:08:49.971 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 52.24%
08:08:49.972 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
08:08:49.986 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5268d530]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:49.987 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5268d530]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:50.500 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="52b26e11-01ea-4c65-a203-f4178d44afb1"] on repo=56bdfe23-6f5e-4872-9552-f9c85f81f622
08:08:50.519 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
08:08:50.521 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
08:08:50.584 [qtp1830145945-166] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 remoteRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 localRepositoryRevisionSynced=3
08:08:50.622 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 remoteRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 transaction.localRevision=10 remoteFromLocalRevision=3
08:08:50.654 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=56bdfe23-6f5e-4872-9552-f9c85f81f622 from='target/repo/k9p865k1-vzjsh-local' toID=52b26e11-01ea-4c65-a203-f4178d44afb1 to='https://localhost:29580/52b26e11-01ea-4c65-a203-f4178d44afb1'
08:08:50.721 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:08:50.726 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 56bdfe23-6f5e-4872-9552-f9c85f81f622
08:08:50.727 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 52b26e11-01ea-4c65-a203-f4178d44afb1
08:08:50.727 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:08:50.727 [pool-34-thread-3] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 remoteRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=10
08:08:50.727 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:08:50.745 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:08:50.787 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:08:50.788 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:08:50.788 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:08:50.789 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:08:50.789 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 52.24%
08:08:50.791 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
08:08:50.880 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 61.19%
08:08:50.884 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 70.15%
08:08:50.912 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 remoteRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 localRepositoryRevisionSynced=10
08:08:50.952 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5268d530]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:50.953 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5268d530]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 965 ms.
08:08:50.959 [qtp1830145945-31] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 remoteRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 transaction.localRevision=7 remoteFromLocalRevision=10
08:08:50.970 [pool-34-thread-3] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=52b26e11-01ea-4c65-a203-f4178d44afb1 from='https://localhost:29580/52b26e11-01ea-4c65-a203-f4178d44afb1' toID=56bdfe23-6f5e-4872-9552-f9c85f81f622 to='target/repo/k9p865k1-vzjsh-local', fromRepoLocalSync=false
08:08:50.970 [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_java_11/co.codewizards.cloudstore.test/target/repo/k9p865k1-vzjsh-local/.cloudstore-repo/tmp/ChangeSetDto.52b26e11-01ea-4c65-a203-f4178d44afb1.null.xml.gz
08:08:51.007 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5268d530]getCloseDeferredMillis: closeDeferredMillis=0
08:08:51.008 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5268d530]close: Closing real LocalRepoManager immediately.
08:08:51.009 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5268d530]_close: Shutting down real LocalRepoManager.
08:08:51.017 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:08:51.039 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 52b26e11-01ea-4c65-a203-f4178d44afb1
08:08:51.040 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 56bdfe23-6f5e-4872-9552-f9c85f81f622
08:08:51.040 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:08:51.040 [pool-5-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 remoteRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=7
08:08:51.043 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:08:51.050 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:08:51.059 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:08:51.059 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:08:51.059 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:08:51.066 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [756e0207]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:51.066 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [756e0207]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:51.068 [pool-34-thread-3] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p865k1-vzjsh-local/.cloudstore-repo/tmp/ChangeSetDto.52b26e11-01ea-4c65-a203-f4178d44afb1.null.xml.gz
08:08:51.070 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 77.11%
08:08:51.070 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
08:08:51.070 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
08:08:51.104 [qtp1830145945-166] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 remoteRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 localRepositoryRevisionSynced=7
08:08:51.117 [pool-34-thread-3] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=56bdfe23-6f5e-4872-9552-f9c85f81f622 remoteRepositoryId=52b26e11-01ea-4c65-a203-f4178d44afb1 transaction.localRevision=13 remoteFromLocalRevision=7
08:08:51.120 [pool-34-thread-3] INFO  c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
08:08:51.532 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
hasCorrectAmountOfCreationsDeletions: toBeCreated=2, chunksCreated=2, toBeDeleted=2, chunksDeleted=2
08:08:51.644 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [2c50f1ab]getCloseDeferredMillis: closeDeferredMillis=20000
08:08:51.644 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [2c50f1ab]close: Deferring shut down of real LocalRepoManager 20000 ms.
08:08:51.645 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [69e87cbe]getCloseDeferredMillis: closeDeferredMillis=20000
08:08:51.645 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [69e87cbe]close: Deferring shut down of real LocalRepoManager 20000 ms.
08:08:51.729 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [19d75d3c]initPersistenceManagerFactory: repositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a
08:08:51.732 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [19d75d3c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 4882 ms.
localRoot: k9p86l3o-2yix9-local
localRepositoryId: 38794a2b-c0b6-4433-849b-73d1b347b30a
08:08:51.788 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1d7135c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3p-jq3hj-remote'
08:08:51.792 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1d7135c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3p-jq3hj-remote' locked successfully.
08:08:51.816 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [756e0207]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:51.817 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [756e0207]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 749 ms.
08:08:51.964 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [756e0207]getCloseDeferredMillis: closeDeferredMillis=0
08:08:51.965 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [756e0207]close: Closing real LocalRepoManager immediately.
08:08:51.965 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [756e0207]_close: Shutting down real LocalRepoManager.
[INFO] Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 466.043 s - in co.codewizards.cloudstore.test.SyncAbortIT
08:08:52.072 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@1b0e2ca6{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
08:08:52.074 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
08:08:52.081 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 58.34%
08:08:52.086 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 64.45%
08:08:52.087 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 70.56%
08:08:52.088 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
08:08:52.090 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@bd6ccbf{/,null,UNAVAILABLE}
08:08:52.096 [Thread-3] INFO  c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/jvm/8kt3Cao02iX9RxecFiBpIA/.cloudstore/localServerRunning.deleteToStop
08:08:52.106 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@8e4e89f{SSL,[ssl, http/1.1]}{0.0.0.0:29580}
08:08:52.107 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
08:08:52.112 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@b5e971d{/,null,UNAVAILABLE}
08:08:52.129 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [45eedf03]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:52.129 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [45eedf03]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:52.548 [qtp2084290916-26] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:08:52.731 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [45eedf03]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:52.731 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [45eedf03]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 601 ms.
08:08:52.768 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [45eedf03]getCloseDeferredMillis: closeDeferredMillis=0
08:08:52.769 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [45eedf03]close: Closing real LocalRepoManager immediately.
08:08:52.769 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [45eedf03]_close: Shutting down real LocalRepoManager.
08:08:53.141 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [131bd084]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:53.142 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [131bd084]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:53.514 [pool-4-thread-1] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:08:53.684 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [131bd084]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:53.685 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [131bd084]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 539 ms.
08:08:53.748 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [131bd084]getCloseDeferredMillis: closeDeferredMillis=0
08:08:53.748 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [131bd084]close: Closing real LocalRepoManager immediately.
08:08:53.748 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [131bd084]_close: Shutting down real LocalRepoManager.
08:08:55.625 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c84a042c1951cb3cfab652476e031b457a801644' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
May 02, 2020 8:08:55 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
08:08:55.674 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [dfe01b6]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:55.674 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [dfe01b6]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:56.183 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:08:56.417 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [dfe01b6]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:56.435 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [dfe01b6]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 760 ms.
08:08:56.546 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [dfe01b6]getCloseDeferredMillis: closeDeferredMillis=0
08:08:56.546 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [dfe01b6]close: Closing real LocalRepoManager immediately.
08:08:56.546 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [dfe01b6]_close: Shutting down real LocalRepoManager.
08:08:56.592 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1ddc01]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:56.592 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1ddc01]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:57.255 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:08:57.567 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1ddc01]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:57.571 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1ddc01]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 978 ms.
08:08:57.916 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1ddc01]getCloseDeferredMillis: closeDeferredMillis=0
08:08:57.916 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1ddc01]close: Closing real LocalRepoManager immediately.
08:08:57.916 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1ddc01]_close: Shutting down real LocalRepoManager.
08:08:58.157 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="4e17acfb-02f2-4ba0-a29a-5be3a4106775"] on repo=4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:08:58.160 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
08:08:58.216 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [71821a34]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:08:58.216 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [71821a34]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:08:58.554 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:08:58.761 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [71821a34]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:08:58.761 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [71821a34]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 543 ms.
08:08:58.800 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [71821a34]getCloseDeferredMillis: closeDeferredMillis=0
08:08:58.800 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [71821a34]close: Closing real LocalRepoManager immediately.
08:08:58.800 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [71821a34]_close: Shutting down real LocalRepoManager.
08:09:00.547 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [55818af1]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:00.548 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [55818af1]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:00.863 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:01.009 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1d7135c]initPersistenceManagerFactory: repositoryId=3dd0587e-b634-43a5-94ad-e088087432ee
08:09:01.012 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1d7135c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 4891 ms.
08:09:01.020 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [55818af1]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:01.021 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [55818af1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 472 ms.
remoteRoot: k9p86l3p-jq3hj-remote
remoteRepositoryId: 3dd0587e-b634-43a5-94ad-e088087432ee
08:09:01.099 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [55818af1]getCloseDeferredMillis: closeDeferredMillis=0
08:09:01.099 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [55818af1]close: Closing real LocalRepoManager immediately.
08:09:01.099 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [55818af1]_close: Shutting down real LocalRepoManager.
08:09:01.148 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 85860 bytes in 2988 ms. path='/3/zzz'
May 02, 2020 8:09:01 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
08:09:01.186 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4855ae7]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:01.187 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4855ae7]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:01.269 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=113.0 MiB, used=37.1 MiB, available=3.9 GiB
08:09:01.506 [qtp2084290916-26] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:01.554 [closeDeferredTimer-6705fb02-1] INFO  c.c.c.l.LocalRepoManagerImpl - [6705fb02]_close: Shutting down real LocalRepoManager.
08:09:01.558 [closeDeferredTimer-5b5e45bc-1] INFO  c.c.c.l.LocalRepoManagerImpl - [5b5e45bc]_close: Shutting down real LocalRepoManager.
08:09:01.769 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4855ae7]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:01.770 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4855ae7]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 581 ms.
08:09:01.809 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4855ae7]getCloseDeferredMillis: closeDeferredMillis=0
08:09:01.809 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4855ae7]close: Closing real LocalRepoManager immediately.
08:09:01.809 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4855ae7]_close: Shutting down real LocalRepoManager.
Successfully requested to connect the following local and remote repositories:

  localRepository.repositoryId = 38794a2b-c0b6-4433-849b-73d1b347b30a
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3o-2yix9-local
  localRepository.publicKeySha1 = 27:EC:ED:21:81:7C:33:74:C1:97:60:BE:6B:E9:F4:C2:E1:18:DB:C9

  remoteRepository.repositoryId = 3dd0587e-b634-43a5-94ad-e088087432ee
  remoteRepository.remoteRoot = https://localhost:25658/3dd0587e-b634-43a5-94ad-e088087432ee
  remoteRepository.publicKeySha1 = B6:FE:CD:5F:4A:4C:D6:A1:66:1B:A6:F4:84:C7:1D:82:7F:82:F8:EF

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 38794a2b-c0b6-4433-849b-73d1b347b30a 3dd0587e-b634-43a5-94ad-e088087432ee
08:09:02.135 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [e58dbf4]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:02.136 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [e58dbf4]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:02.257 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=113.0 MiB, used=35.9 MiB, available=3.9 GiB
Successfully accepted the connection request for the following local and remote repositories:

  localRepository.repositoryId = 3dd0587e-b634-43a5-94ad-e088087432ee
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3p-jq3hj-remote
  localRepository.publicKeySha1 = B6:FE:CD:5F:4A:4C:D6:A1:66:1B:A6:F4:84:C7:1D:82:7F:82:F8:EF

  remoteRepository.repositoryId = 38794a2b-c0b6-4433-849b-73d1b347b30a
  remoteRepository.publicKeySha1 = 27:EC:ED:21:81:7C:33:74:C1:97:60:BE:6B:E9:F4:C2:E1:18:DB:C9

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 3dd0587e-b634-43a5-94ad-e088087432ee 38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:02.437 [qtp2084290916-26] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:02.581 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [e58dbf4]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:02.582 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [e58dbf4]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 445 ms.
08:09:02.635 [qtp2084290916-26] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
08:09:02.716 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [e58dbf4]getCloseDeferredMillis: closeDeferredMillis=0
08:09:02.716 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [e58dbf4]close: Closing real LocalRepoManager immediately.
08:09:02.716 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [e58dbf4]_close: Shutting down real LocalRepoManager.
08:09:03.466 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 0.50%
08:09:03.469 [pool-9-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 38794a2b-c0b6-4433-849b-73d1b347b30a ('target/repo/k9p86l3o-2yix9-local')
08:09:03.469 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=3dd0587e-b634-43a5-94ad-e088087432ee from='https://localhost:25658/3dd0587e-b634-43a5-94ad-e088087432ee' toID=38794a2b-c0b6-4433-849b-73d1b347b30a to='target/repo/k9p86l3o-2yix9-local', fromRepoLocalSync=true
08:09:03.482 [pool-9-thread-1] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 12.94%
08:09:03.496 [pool-9-thread-1] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 25.12%
08:09:03.505 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3o-2yix9-local/.cloudstore-repo/tmp/ChangeSetDto.3dd0587e-b634-43a5-94ad-e088087432ee.-1.xml.gz
08:09:03.520 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="4e17acfb-02f2-4ba0-a29a-5be3a4106775"] on repo=4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:09:03.565 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a serverRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee renewalDateTime=2020-05-02T06:39:03.521Z expiryDateTime=2020-05-02T07:09:03.521Z
08:09:03.576 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
08:09:03.578 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
08:09:03.593 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
08:09:03.616 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 remoteRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 localRepositoryRevisionSynced=89
08:09:03.630 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [aac3090]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:03.631 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [aac3090]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:03.635 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.06%
08:09:05.066 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 64.60%
08:09:05.093 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 74.40%
08:09:05.175 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 84.20%
08:09:05.262 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 94.00%
08:09:05.561 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
08:09:05.662 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:09:05.666 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 3dd0587e-b634-43a5-94ad-e088087432ee
08:09:05.667 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:05.667 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:09:05.667 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee remoteRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
08:09:05.681 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:09:05.730 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:09:05.730 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:09:05.730 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:09:05.730 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:09:05.764 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3o-2yix9-local/.cloudstore-repo/tmp/ChangeSetDto.3dd0587e-b634-43a5-94ad-e088087432ee.-1.xml.gz
08:09:05.765 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
08:09:05.847 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/#4'
08:09:05.913 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:05.929 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/1 {11 11ä11#+} 1'
08:09:05.961 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 30.33%
08:09:05.962 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2'
08:09:06.074 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2/1 {11 11ä11#+} 1'
08:09:06.110 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [aac3090]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:06.110 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [aac3090]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 2477 ms.
08:09:06.140 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [aac3090]getCloseDeferredMillis: closeDeferredMillis=0
08:09:06.140 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [aac3090]close: Closing real LocalRepoManager immediately.
08:09:06.140 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [aac3090]_close: Shutting down real LocalRepoManager.
08:09:06.158 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
08:09:06.194 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/5#'
08:09:06.290 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 35.59%
08:09:06.290 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 40.86%
08:09:06.290 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/#b'
08:09:06.331 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='94be7580ec070c59eb0c237a2405759a91b806e7' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/#b
08:09:06.461 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [765759a7]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:06.462 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [765759a7]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:06.490 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:06.492 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/#b'
08:09:06.516 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 10982 bytes in 24 ms. path='/#4/#b'
08:09:06.525 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c691e3d4c979adbf07e3b97e33fdf3c89ed246f6_0 into destFile #b
08:09:06.583 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:06.599 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/a'
08:09:06.640 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='46b6761ed69eab700a51056ca7c80ae2397cbd47' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/a
08:09:06.689 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:06.691 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/a'
08:09:06.730 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:06.821 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 421429 bytes in 130 ms. path='/#4/a'
08:09:06.830 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
08:09:06.871 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:06.881 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/c+'
08:09:06.917 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [765759a7]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:06.918 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [765759a7]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 455 ms.
08:09:06.962 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='538b09d7d3fe2d9a2e0a0b02bb94bcb699975bdd' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/c+
08:09:06.998 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:07.002 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/c+'
08:09:07.006 [qtp2084290916-30] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 transaction.localRevision=15 remoteFromLocalRevision=89
08:09:07.008 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [765759a7]getCloseDeferredMillis: closeDeferredMillis=0
08:09:07.008 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [765759a7]close: Closing real LocalRepoManager immediately.
08:09:07.008 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [765759a7]_close: Shutting down real LocalRepoManager.
08:09:07.041 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=504d3477-5b0f-45a7-955e-d5180b0bc3c8 from='https://localhost:5768/504d3477-5b0f-45a7-955e-d5180b0bc3c8' toID=4e17acfb-02f2-4ba0-a29a-5be3a4106775 to='target/repo/k9p85ewk-mhk6p-local', fromRepoLocalSync=false
08:09:07.068 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewk-mhk6p-local/.cloudstore-repo/tmp/ChangeSetDto.504d3477-5b0f-45a7-955e-d5180b0bc3c8.null.xml.gz
08:09:07.083 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [7bf670da]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:07.084 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [7bf670da]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:07.226 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 806225 bytes in 224 ms. path='/#4/c+'
08:09:07.236 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_8a30244b83c6cac3c79f8f95d30f96579c0f4c0b_0 into destFile c+
08:09:07.286 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:07.293 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/d$'
08:09:07.349 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='523375634bf91791ca79dc220e6db122ffbc642c' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/d$
08:09:07.372 [qtp2084290916-26] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:07.379 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:07.381 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/d$'
08:09:07.532 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 492107 bytes in 151 ms. path='/#4/d$'
08:09:07.541 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_a93a212f7eca012dceb852f364cc2c34026f0dd8_0 into destFile d$
08:09:07.542 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [7bf670da]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:07.545 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [7bf670da]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 458 ms.
08:09:07.577 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [7bf670da]getCloseDeferredMillis: closeDeferredMillis=0
08:09:07.578 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [7bf670da]close: Closing real LocalRepoManager immediately.
08:09:07.578 [qtp2084290916-26] INFO  c.c.c.l.LocalRepoManagerImpl - [7bf670da]_close: Shutting down real LocalRepoManager.
08:09:07.589 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:07.608 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/a'
08:09:07.632 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [8d55c9b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:07.632 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [8d55c9b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:07.661 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='2008ada3c38b99bbc5455dc1fa588026a578e568' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/a
08:09:07.707 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:07.711 [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'
08:09:07.788 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 113880 bytes in 76 ms. path='/1 {11 11ä11#+} 1/a'
08:09:07.816 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
08:09:07.844 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:07.859 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/b'
08:09:07.940 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='678f08ad1030b6c9dfe6a0798cb7331e538c029d' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/b
08:09:08.001 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:08.011 [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'
08:09:08.063 [pool-4-thread-1] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:08.065 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 89770 bytes in 54 ms. path='/1 {11 11ä11#+} 1/b'
08:09:08.073 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
08:09:08.095 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:08.102 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/c'
08:09:08.173 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='6a05aad989685bfb2b67e68b78285250a813f444' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/c
08:09:08.239 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:08.248 [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'
08:09:08.375 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 165844 bytes in 127 ms. path='/1 {11 11ä11#+} 1/c'
08:09:08.376 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [8d55c9b]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:08.377 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [8d55c9b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 744 ms.
08:09:08.396 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
08:09:08.435 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:08.455 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/a'
08:09:08.504 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:09:08.506 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:08.507 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:09:08.507 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:09:08.507 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
08:09:08.528 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:09:08.548 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:09:08.548 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:09:08.548 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:09:08.548 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:09:08.549 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [8d55c9b]getCloseDeferredMillis: closeDeferredMillis=0
08:09:08.549 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='2a0c6fbee34c973a68d48d15055016089049f44d' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/a
08:09:08.549 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [8d55c9b]close: Closing real LocalRepoManager immediately.
08:09:08.550 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [8d55c9b]_close: Shutting down real LocalRepoManager.
08:09:08.607 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewk-mhk6p-local/.cloudstore-repo/tmp/ChangeSetDto.504d3477-5b0f-45a7-955e-d5180b0bc3c8.null.xml.gz
08:09:08.608 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 77.11%
08:09:08.608 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
08:09:08.609 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
08:09:08.617 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:08.624 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [62832f7e]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:08.624 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [62832f7e]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:08.624 [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'
08:09:08.707 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 160680 bytes in 82 ms. path='/2/1 {11 11ä11#+} 1/a'
08:09:08.718 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
08:09:10.232 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:11.174 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/b'
08:09:11.247 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='f9b14127808d79136e28635e47e31c8fea36a6c7' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/b
08:09:11.677 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:12.229 [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'
08:09:12.315 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 425724 bytes in 86 ms. path='/2/1 {11 11ä11#+} 1/b'
08:09:12.321 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
08:09:13.628 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:13.667 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/a'
08:09:13.717 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='f2875fb088a54ae5883ebb432461f07b31f5aae5' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/a
08:09:13.750 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:13.765 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/a'
08:09:13.895 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 378658 bytes in 130 ms. path='/2/a'
08:09:13.903 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
08:09:13.948 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:13.970 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 44.15%
08:09:13.971 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/a'
08:09:14.033 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:14.034 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='fc6e017a89a797dda7d9aa86e57d50e4caa6b865' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/a
08:09:14.075 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:14.095 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/a'
08:09:14.194 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 198594 bytes in 99 ms. path='/3/a'
08:09:14.203 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
08:09:14.252 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [62832f7e]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:14.253 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [62832f7e]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 5627 ms.
08:09:14.276 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:14.297 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/b'
08:09:14.306 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [62832f7e]getCloseDeferredMillis: closeDeferredMillis=0
08:09:14.306 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [62832f7e]close: Closing real LocalRepoManager immediately.
08:09:14.306 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [62832f7e]_close: Shutting down real LocalRepoManager.
08:09:14.356 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5165baf]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:14.356 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5165baf]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:14.367 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='dc51a09a095fd91cf5f3656cf0f6aeba63e78974' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/b
08:09:14.401 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:14.404 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/b'
08:09:14.511 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 160776 bytes in 104 ms. path='/3/b'
08:09:14.520 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
08:09:14.555 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:14.562 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/c'
08:09:14.618 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c761074fbd13a3eb2a648f61c404ae15dc4bd677' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/c
08:09:14.661 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:14.664 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/c'
08:09:14.758 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:14.870 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 645003 bytes in 206 ms. path='/3/c'
08:09:14.876 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
08:09:14.934 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5165baf]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:14.934 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5165baf]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 576 ms.
08:09:15.033 [qtp2084290916-30] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 localRepositoryRevisionSynced=15
08:09:15.077 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:15.076 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5165baf]getCloseDeferredMillis: closeDeferredMillis=0
08:09:15.076 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5165baf]close: Closing real LocalRepoManager immediately.
08:09:15.076 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5165baf]_close: Shutting down real LocalRepoManager.
08:09:15.104 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/d'
08:09:15.130 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 remoteRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 transaction.localRevision=94 remoteFromLocalRevision=15
08:09:15.134 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
08:09:15.134 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [6259d7a0]getCloseDeferredMillis: closeDeferredMillis=0
08:09:15.135 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [6259d7a0]close: Closing real LocalRepoManager immediately.
08:09:15.135 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [6259d7a0]_close: Shutting down real LocalRepoManager.
08:09:15.183 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='bdf6c567d1c7e86871d6f0564b5281033dd8b485' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/d
08:09:15.289 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:15.464 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/d'
08:09:15.488 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 9455 bytes in 24 ms. path='/3/d'
08:09:15.511 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
08:09:15.528 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:15.538 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/5#/e'
08:09:15.574 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='fd02ad9a6fc428118e42ee1b4f26ff75aebc5399' to.sha1='<NoInstanceOf_NormalFileDto>'): /5#/e
08:09:15.599 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:15.612 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/5#/e'
08:09:15.673 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
08:09:15.684 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restoring backup: 'target/repo/k9p85ewl-3std2-remote.bak' => 'target/repo/k9p85ewl-3std2-remote'
08:09:15.793 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restored backup: 'target/repo/k9p85ewl-3std2-remote.bak' => 'target/repo/k9p85ewl-3std2-remote'
08:09:15.793 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
08:09:15.796 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [31d51518]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewk-mhk6p-local'
08:09:15.796 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [31d51518]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewk-mhk6p-local' locked successfully.
08:09:15.852 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 512148 bytes in 239 ms. path='/5#/e'
08:09:15.860 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_58e6b3a414a1e090dfc6029add0f3555ccba127f_0 into destFile e
08:09:15.919 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="3dd0587e-b634-43a5-94ad-e088087432ee"] on repo=38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:15.945 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 49.42%
08:09:16.049 [qtp2032110040-33] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee remoteRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a localRepositoryRevisionSynced=3
08:09:16.085 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a remoteRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee transaction.localRevision=84 remoteFromLocalRevision=3
08:09:16.103 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=38794a2b-c0b6-4433-849b-73d1b347b30a from='target/repo/k9p86l3o-2yix9-local' toID=3dd0587e-b634-43a5-94ad-e088087432ee to='https://localhost:25658/3dd0587e-b634-43a5-94ad-e088087432ee'
08:09:16.146 [main] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:16.161 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:09:16.164 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:16.164 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 3dd0587e-b634-43a5-94ad-e088087432ee
08:09:16.164 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:09:16.165 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a remoteRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=84
08:09:16.174 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:09:16.227 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:09:16.227 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:09:16.228 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:09:16.228 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:09:16.228 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 63.43%
08:09:16.229 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
08:09:16.274 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a remoteRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee localRepositoryRevisionSynced=84
08:09:16.305 [qtp2032110040-33] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee remoteRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a transaction.localRevision=6 remoteFromLocalRevision=84
08:09:16.319 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=3dd0587e-b634-43a5-94ad-e088087432ee from='https://localhost:25658/3dd0587e-b634-43a5-94ad-e088087432ee' toID=38794a2b-c0b6-4433-849b-73d1b347b30a to='target/repo/k9p86l3o-2yix9-local', fromRepoLocalSync=false
08:09:16.320 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3o-2yix9-local/.cloudstore-repo/tmp/ChangeSetDto.3dd0587e-b634-43a5-94ad-e088087432ee.null.xml.gz
08:09:16.360 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:09:16.363 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 3dd0587e-b634-43a5-94ad-e088087432ee
08:09:16.364 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 38794a2b-c0b6-4433-849b-73d1b347b30a
08:09:16.364 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:09:16.364 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee remoteRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
08:09:16.366 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:09:16.368 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:09:16.368 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:09:16.368 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:09:16.369 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:09:16.376 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p86l3o-2yix9-local/.cloudstore-repo/tmp/ChangeSetDto.3dd0587e-b634-43a5-94ad-e088087432ee.null.xml.gz
08:09:16.381 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
08:09:16.381 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
08:09:16.410 [qtp2032110040-32] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee remoteRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a localRepositoryRevisionSynced=6
08:09:16.414 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [31d51518]initPersistenceManagerFactory: repositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:09:16.415 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [31d51518]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 617 ms.
08:09:16.420 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=38794a2b-c0b6-4433-849b-73d1b347b30a remoteRepositoryId=3dd0587e-b634-43a5-94ad-e088087432ee transaction.localRevision=87 remoteFromLocalRevision=6
08:09:16.424 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
08:09:16.573 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [19d75d3c]getCloseDeferredMillis: closeDeferredMillis=20000
08:09:16.573 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [19d75d3c]close: Deferring shut down of real LocalRepoManager 20000 ms.
08:09:16.574 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1d7135c]getCloseDeferredMillis: closeDeferredMillis=20000
08:09:16.574 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [1d7135c]close: Deferring shut down of real LocalRepoManager 20000 ms.
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 241.377 s - in co.codewizards.cloudstore.test.repotorepo.BasicRepoToRepoSyncIT
08:09:16.620 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@4dcd9d23{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
08:09:16.621 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
08:09:16.632 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@18cb2dff{/,null,UNAVAILABLE}
08:09:16.636 [Thread-3] INFO  c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/jvm/Uu_3WmPbsFcCexOKM-HOpQ/.cloudstore/localServerRunning.deleteToStop
08:09:16.640 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@587df48e{SSL,[ssl, http/1.1]}{0.0.0.0:25658}
08:09:16.640 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
08:09:16.644 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@eaaaa75{/,null,UNAVAILABLE}
08:09:16.864 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [75ae5e99]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:16.865 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [75ae5e99]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:17.302 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:17.457 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [75ae5e99]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:17.458 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [75ae5e99]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 592 ms.
08:09:17.480 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [75ae5e99]getCloseDeferredMillis: closeDeferredMillis=0
08:09:17.480 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [75ae5e99]close: Closing real LocalRepoManager immediately.
08:09:17.480 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [75ae5e99]_close: Shutting down real LocalRepoManager.
08:09:18.591 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 0.50%
08:09:18.595 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=504d3477-5b0f-45a7-955e-d5180b0bc3c8 from='https://localhost:5768/504d3477-5b0f-45a7-955e-d5180b0bc3c8' toID=4e17acfb-02f2-4ba0-a29a-5be3a4106775 to='target/repo/k9p85ewk-mhk6p-local', fromRepoLocalSync=true
08:09:18.596 [pool-9-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 4e17acfb-02f2-4ba0-a29a-5be3a4106775 ('target/repo/k9p85ewk-mhk6p-local')
08:09:18.625 [pool-9-thread-1] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 12.94%
08:09:18.674 [pool-9-thread-1] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 19.03%
08:09:18.720 [pool-9-thread-1] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 24.15%
08:09:18.769 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewk-mhk6p-local/.cloudstore-repo/tmp/ChangeSetDto.504d3477-5b0f-45a7-955e-d5180b0bc3c8.15.xml.gz
08:09:18.776 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [c9b742e]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:18.777 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [c9b742e]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:19.082 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:19.197 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [c9b742e]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:19.198 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [c9b742e]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 420 ms.
08:09:19.237 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [c9b742e]getCloseDeferredMillis: closeDeferredMillis=0
08:09:19.237 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [c9b742e]close: Closing real LocalRepoManager immediately.
08:09:19.238 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [c9b742e]_close: Shutting down real LocalRepoManager.
08:09:19.311 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 serverRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 renewalDateTime=2020-05-02T06:38:23.225Z expiryDateTime=2020-05-02T07:08:23.225Z
08:09:19.316 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [4455bb22]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:19.316 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [4455bb22]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:19.556 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:19.716 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [4455bb22]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:19.716 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [4455bb22]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 399 ms.
08:09:19.742 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [4455bb22]getCloseDeferredMillis: closeDeferredMillis=0
08:09:19.742 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [4455bb22]close: Closing real LocalRepoManager immediately.
08:09:19.742 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [4455bb22]_close: Shutting down real LocalRepoManager.
08:09:19.774 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [65f7e16a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:19.775 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [65f7e16a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:20.076 [pool-4-thread-1] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:20.193 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [65f7e16a]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:20.194 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [65f7e16a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 419 ms.
08:09:20.216 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
08:09:20.227 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
08:09:20.248 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
08:09:20.275 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
08:09:20.285 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
08:09:20.305 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
08:09:20.333 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
08:09:20.366 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
08:09:20.388 [pool-4-thread-1] WARN  c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=15 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=6
08:09:20.411 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:09:20.414 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:20.414 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:09:20.414 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:09:20.414 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 localRepositoryRevisionSynced=15 localRepositoryRevisionInProgress=8
08:09:20.422 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:09:20.430 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:09:20.430 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:09:20.430 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:09:20.430 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:09:20.430 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [65f7e16a]getCloseDeferredMillis: closeDeferredMillis=0
08:09:20.431 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [65f7e16a]close: Closing real LocalRepoManager immediately.
08:09:20.431 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [65f7e16a]_close: Shutting down real LocalRepoManager.
08:09:20.532 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewk-mhk6p-local/.cloudstore-repo/tmp/ChangeSetDto.504d3477-5b0f-45a7-955e-d5180b0bc3c8.15.xml.gz
08:09:20.533 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
08:09:20.534 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
08:09:20.542 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5bca9ef5]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:20.542 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5bca9ef5]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:20.786 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:20.931 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5bca9ef5]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:20.932 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5bca9ef5]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 389 ms.
08:09:20.965 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5bca9ef5]getCloseDeferredMillis: closeDeferredMillis=0
08:09:20.965 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5bca9ef5]close: Closing real LocalRepoManager immediately.
08:09:20.965 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5bca9ef5]_close: Shutting down real LocalRepoManager.
08:09:21.003 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [4de97763]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:21.004 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [4de97763]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:21.255 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:21.428 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [4de97763]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:21.428 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [4de97763]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 423 ms.
08:09:21.535 [qtp2084290916-30] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 localRepositoryRevisionSynced=8
08:09:21.548 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [4de97763]getCloseDeferredMillis: closeDeferredMillis=0
08:09:21.549 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [4de97763]close: Closing real LocalRepoManager immediately.
08:09:21.549 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [4de97763]_close: Shutting down real LocalRepoManager.
08:09:21.630 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 remoteRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 transaction.localRevision=95 remoteFromLocalRevision=8
08:09:21.650 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=4e17acfb-02f2-4ba0-a29a-5be3a4106775 from='target/repo/k9p85ewk-mhk6p-local' toID=504d3477-5b0f-45a7-955e-d5180b0bc3c8 to='https://localhost:5768/504d3477-5b0f-45a7-955e-d5180b0bc3c8'
08:09:21.665 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [54ffad3c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:21.665 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [54ffad3c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:21.924 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:22.061 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [54ffad3c]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:22.061 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [54ffad3c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 395 ms.
08:09:22.091 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [54ffad3c]getCloseDeferredMillis: closeDeferredMillis=0
08:09:22.091 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [54ffad3c]close: Closing real LocalRepoManager immediately.
08:09:22.091 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [54ffad3c]_close: Shutting down real LocalRepoManager.
08:09:22.132 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [2f2f1080]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:22.133 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [2f2f1080]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:22.389 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:22.560 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [2f2f1080]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:22.560 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [2f2f1080]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 426 ms.
08:09:22.595 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [2f2f1080]getCloseDeferredMillis: closeDeferredMillis=0
08:09:22.595 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [2f2f1080]close: Closing real LocalRepoManager immediately.
08:09:22.595 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [2f2f1080]_close: Shutting down real LocalRepoManager.
08:09:22.849 [main] WARN  c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=84 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=89
08:09:22.865 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:09:22.869 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:09:22.869 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:22.869 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:09:22.869 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 remoteRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=95
08:09:22.879 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:09:22.913 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:09:22.913 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:09:22.913 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:09:22.913 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:09:22.914 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 56.31%
08:09:22.915 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
08:09:22.923 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [17852053]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:22.924 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [17852053]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:23.170 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:23.335 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [17852053]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:23.335 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [17852053]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 410 ms.
08:09:23.364 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [17852053]getCloseDeferredMillis: closeDeferredMillis=0
08:09:23.364 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [17852053]close: Closing real LocalRepoManager immediately.
08:09:23.364 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [17852053]_close: Shutting down real LocalRepoManager.
08:09:24.040 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [67b9fd0e]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:24.041 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [67b9fd0e]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:24.468 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:24.629 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [67b9fd0e]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:24.629 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [67b9fd0e]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 587 ms.
08:09:24.756 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [67b9fd0e]getCloseDeferredMillis: closeDeferredMillis=0
08:09:24.756 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [67b9fd0e]close: Closing real LocalRepoManager immediately.
08:09:24.756 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [67b9fd0e]_close: Shutting down real LocalRepoManager.
08:09:24.906 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 62.42%
08:09:24.907 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 68.52%
08:09:24.907 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
08:09:24.945 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [66bfb6a1]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:24.945 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [66bfb6a1]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:25.197 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:25.519 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [66bfb6a1]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:25.520 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [66bfb6a1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 574 ms.
08:09:25.551 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [66bfb6a1]getCloseDeferredMillis: closeDeferredMillis=0
08:09:25.551 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [66bfb6a1]close: Closing real LocalRepoManager immediately.
08:09:25.551 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [66bfb6a1]_close: Shutting down real LocalRepoManager.
08:09:25.656 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [72179976]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:25.657 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [72179976]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:25.969 [pool-4-thread-1] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:26.098 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [72179976]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:26.099 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [72179976]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 441 ms.
08:09:26.138 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [72179976]getCloseDeferredMillis: closeDeferredMillis=0
08:09:26.139 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [72179976]close: Closing real LocalRepoManager immediately.
08:09:26.139 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [72179976]_close: Shutting down real LocalRepoManager.
08:09:26.181 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c84a042c1951cb3cfab652476e031b457a801644' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
May 02, 2020 8:09:26 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
08:09:26.194 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [536e6b4d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:26.195 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [536e6b4d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:26.426 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:26.564 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [536e6b4d]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:26.565 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [536e6b4d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 369 ms.
08:09:26.602 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [536e6b4d]getCloseDeferredMillis: closeDeferredMillis=0
08:09:26.603 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [536e6b4d]close: Closing real LocalRepoManager immediately.
08:09:26.603 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [536e6b4d]_close: Shutting down real LocalRepoManager.
08:09:26.640 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c14d621]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:26.641 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c14d621]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:26.890 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:27.008 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c14d621]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:27.008 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c14d621]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 366 ms.
08:09:27.123 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c14d621]getCloseDeferredMillis: closeDeferredMillis=0
08:09:27.123 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c14d621]close: Closing real LocalRepoManager immediately.
08:09:27.123 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [1c14d621]_close: Shutting down real LocalRepoManager.
08:09:27.354 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="4e17acfb-02f2-4ba0-a29a-5be3a4106775"] on repo=4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:09:27.356 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
08:09:27.378 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [62305f7f]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:27.379 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [62305f7f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:27.639 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:27.756 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [62305f7f]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:27.757 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [62305f7f]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 377 ms.
08:09:27.783 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [62305f7f]getCloseDeferredMillis: closeDeferredMillis=0
08:09:27.783 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [62305f7f]close: Closing real LocalRepoManager immediately.
08:09:27.783 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [62305f7f]_close: Shutting down real LocalRepoManager.
08:09:27.829 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [650ea77]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:27.829 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [650ea77]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:28.196 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:28.304 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [650ea77]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:28.304 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [650ea77]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 473 ms.
08:09:28.349 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [650ea77]getCloseDeferredMillis: closeDeferredMillis=0
08:09:28.349 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [650ea77]close: Closing real LocalRepoManager immediately.
08:09:28.350 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [650ea77]_close: Shutting down real LocalRepoManager.
08:09:28.396 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 85860 bytes in 1040 ms. path='/3/zzz'
May 02, 2020 8:09:28 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
08:09:28.408 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5d8e1a4d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:28.408 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5d8e1a4d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:28.630 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:28.767 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5d8e1a4d]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:28.767 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5d8e1a4d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 357 ms.
08:09:28.798 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5d8e1a4d]getCloseDeferredMillis: closeDeferredMillis=0
08:09:28.798 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5d8e1a4d]close: Closing real LocalRepoManager immediately.
08:09:28.798 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [5d8e1a4d]_close: Shutting down real LocalRepoManager.
08:09:28.927 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [291e2134]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:28.927 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [291e2134]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:29.171 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:29.304 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [291e2134]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:29.305 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [291e2134]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 375 ms.
08:09:29.350 [qtp2084290916-30] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
08:09:29.427 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [291e2134]getCloseDeferredMillis: closeDeferredMillis=0
08:09:29.427 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [291e2134]close: Closing real LocalRepoManager immediately.
08:09:29.427 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [291e2134]_close: Shutting down real LocalRepoManager.
08:09:29.490 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="4e17acfb-02f2-4ba0-a29a-5be3a4106775"] on repo=4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:09:29.515 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 74.63%
08:09:29.527 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 remoteRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 localRepositoryRevisionSynced=95
08:09:29.538 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [652024e0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:29.538 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [652024e0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:29.767 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:29.893 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [652024e0]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:29.893 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [652024e0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 354 ms.
08:09:29.920 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [652024e0]getCloseDeferredMillis: closeDeferredMillis=0
08:09:29.921 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [652024e0]close: Closing real LocalRepoManager immediately.
08:09:29.921 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [652024e0]_close: Shutting down real LocalRepoManager.
08:09:30.042 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [133d93cd]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:30.042 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [133d93cd]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:30.382 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:30.507 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [133d93cd]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:30.507 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [133d93cd]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 464 ms.
08:09:30.566 [qtp2084290916-28] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 transaction.localRevision=15 remoteFromLocalRevision=95
08:09:30.592 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [133d93cd]getCloseDeferredMillis: closeDeferredMillis=0
08:09:30.592 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [133d93cd]close: Closing real LocalRepoManager immediately.
08:09:30.592 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [133d93cd]_close: Shutting down real LocalRepoManager.
08:09:30.640 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=504d3477-5b0f-45a7-955e-d5180b0bc3c8 from='https://localhost:5768/504d3477-5b0f-45a7-955e-d5180b0bc3c8' toID=4e17acfb-02f2-4ba0-a29a-5be3a4106775 to='target/repo/k9p85ewk-mhk6p-local', fromRepoLocalSync=false
08:09:30.641 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewk-mhk6p-local/.cloudstore-repo/tmp/ChangeSetDto.504d3477-5b0f-45a7-955e-d5180b0bc3c8.null.xml.gz
08:09:30.653 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [555fca3b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:30.653 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [555fca3b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:30.868 [qtp2084290916-30] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:30.988 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [555fca3b]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:30.989 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [555fca3b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 335 ms.
08:09:31.014 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [555fca3b]getCloseDeferredMillis: closeDeferredMillis=0
08:09:31.014 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [555fca3b]close: Closing real LocalRepoManager immediately.
08:09:31.015 [qtp2084290916-30] INFO  c.c.c.l.LocalRepoManagerImpl - [555fca3b]_close: Shutting down real LocalRepoManager.
08:09:31.051 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [33a41fa1]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:31.051 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [33a41fa1]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:31.315 [pool-4-thread-1] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:31.458 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [33a41fa1]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:31.459 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [33a41fa1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 407 ms.
08:09:31.534 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
08:09:31.540 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:31.540 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 4e17acfb-02f2-4ba0-a29a-5be3a4106775
08:09:31.540 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
08:09:31.540 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
08:09:31.553 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
08:09:31.561 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
08:09:31.561 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
08:09:31.561 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
08:09:31.561 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
08:09:31.562 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [33a41fa1]getCloseDeferredMillis: closeDeferredMillis=0
08:09:31.562 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [33a41fa1]close: Closing real LocalRepoManager immediately.
08:09:31.562 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [33a41fa1]_close: Shutting down real LocalRepoManager.
08:09:31.603 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewk-mhk6p-local/.cloudstore-repo/tmp/ChangeSetDto.504d3477-5b0f-45a7-955e-d5180b0bc3c8.null.xml.gz
08:09:31.604 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
08:09:31.604 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
08:09:31.614 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [59ca6b9b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:31.614 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [59ca6b9b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:31.846 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:31.991 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [59ca6b9b]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:31.992 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [59ca6b9b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 376 ms.
08:09:32.023 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [59ca6b9b]getCloseDeferredMillis: closeDeferredMillis=0
08:09:32.023 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [59ca6b9b]close: Closing real LocalRepoManager immediately.
08:09:32.024 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [59ca6b9b]_close: Shutting down real LocalRepoManager.
08:09:32.082 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [7ef4ebca]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote'
08:09:32.084 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [7ef4ebca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9p85ewl-3std2-remote' locked successfully.
08:09:32.380 [qtp2084290916-28] WARN  D.D.Schema - Retrieved ForeignKey from datastore for table="repository" referencing table repofile but not found internally. Is there some catalog/schema or quoting causing problems?
08:09:32.515 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [7ef4ebca]initPersistenceManagerFactory: repositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8
08:09:32.516 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [7ef4ebca]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 431 ms.
08:09:32.641 [qtp2084290916-28] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 remoteRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 localRepositoryRevisionSynced=15
08:09:32.753 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [7ef4ebca]getCloseDeferredMillis: closeDeferredMillis=0
08:09:32.754 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [7ef4ebca]close: Closing real LocalRepoManager immediately.
08:09:32.754 [qtp2084290916-28] INFO  c.c.c.l.LocalRepoManagerImpl - [7ef4ebca]_close: Shutting down real LocalRepoManager.
08:09:33.081 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4e17acfb-02f2-4ba0-a29a-5be3a4106775 remoteRepositoryId=504d3477-5b0f-45a7-955e-d5180b0bc3c8 transaction.localRevision=100 remoteFromLocalRevision=15
08:09:33.097 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
08:09:33.187 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [31d51518]getCloseDeferredMillis: closeDeferredMillis=0
08:09:33.193 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [31d51518]close: Closing real LocalRepoManager immediately.
08:09:33.193 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [31d51518]_close: Shutting down real LocalRepoManager.
[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 309.606 s - in co.codewizards.cloudstore.test.repotorepo.BackupRestoreRepoToRepoSyncIT
08:09:33.395 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@59716328{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
08:09:33.395 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
08:09:33.406 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@28b2cdaf{/,null,UNAVAILABLE}
08:09:33.416 [Thread-3] INFO  c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/jvm/z4h6qiR8_oy_I42fcd3xvw/.cloudstore/localServerRunning.deleteToStop
08:09:33.444 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@63ce61d2{SSL,[ssl, http/1.1]}{0.0.0.0:5768}
08:09:33.445 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
08:09:33.451 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@6f2753cd{/,null,UNAVAILABLE}
[INFO] 
[INFO] Results:
[INFO] 
[WARNING] Tests run: 52, Failures: 0, Errors: 0, Skipped: 1
[INFO] 
[JENKINS] Recording test results
[INFO] 
[INFO] --- maven-source-plugin:3.2.1:jar-no-fork (attach-sources) @ co.codewizards.cloudstore.test ---
[INFO] Building jar: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT-sources.jar
[INFO] 
[INFO] --- maven-failsafe-plugin:3.0.0-M4:verify (default) @ co.codewizards.cloudstore.test ---
[JENKINS] Recording test results
[INFO] 
[INFO] --- maven-install-plugin:2.4:install (default-install) @ co.codewizards.cloudstore.test ---
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT.jar
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/pom.xml to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT.pom
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT-sources.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-SNAPSHOT-sources.jar
[INFO] 
[INFO] --- maven-deploy-plugin:2.7:deploy (default-deploy) @ co.codewizards.cloudstore.test ---
[INFO] Downloading from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20200502.060934-1.jar
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20200502.060934-1.jar (7.3 kB at 7.3 MB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20200502.060934-1.pom
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20200502.060934-1.pom (5.3 kB at 5.3 MB/s)
[INFO] Downloading from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml (805 B)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (315 B at 315 kB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20200502.060934-1-sources.jar
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/co.codewizards.cloudstore.test-1.0.1-20200502.060934-1-sources.jar (5.0 kB at 5.0 MB/s)
[INFO] Uploading to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml
[INFO] Uploaded to cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml (1.0 kB at 510 kB/s)
[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_java_11/co.codewizards.cloudstore.test/target/site to /home/tomcat/.jenkins/jobs/co.codewizards.cloudstore_java_11/site/co.codewizards.cloudstore.test
[INFO] 
[INFO] >>> maven-javadoc-plugin:3.1.1:javadoc (javadoc-generate-unfiltered) > generate-sources @ co.codewizards.cloudstore.test >>>
[WARNING] Failed to getClass for org.apache.maven.plugins.javadoc.JavadocReport
[JENKINS] Archiving  javadoc
[INFO] 
[INFO] <<< maven-javadoc-plugin:3.1.1:javadoc (javadoc-generate-unfiltered) < generate-sources @ co.codewizards.cloudstore.test <<<
[INFO] 
[INFO] 
[INFO] --- maven-javadoc-plugin:3.1.1:javadoc (javadoc-generate-unfiltered) @ co.codewizards.cloudstore.test ---
[INFO] Skipping javadoc generation
[JENKINS] Archiving  javadoc
[INFO] 
[INFO] --- maven-resources-plugin:2.6:copy-resources (javadoc-filter) @ co.codewizards.cloudstore.test ---
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/javadoc.unfiltered
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/javadoc.unfiltered
[INFO] 
[INFO] --- maven-resources-plugin:2.6:copy-resources (javadoc-copy-to-site) @ co.codewizards.cloudstore.test ---
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/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_java_11/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