SuccessConsole Output

Skipping 1,678 KB.. Full Log
779b0be1]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:48.745 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [779b0be1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 857 ms.
16:18:48.759 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 415184 bytes in 205 ms. path='/3/a'
16:18:48.780 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
16:18:48.802 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [779b0be1]getCloseDeferredMillis: closeDeferredMillis=0
16:18:48.802 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [779b0be1]close: Closing real LocalRepoManager immediately.
16:18:48.802 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [779b0be1]_close: Shutting down real LocalRepoManager.
16:18:48.855 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="01fc2777-fb75-4bb8-8b7f-799f8ac4f933"] on repo=ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:48.875 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/b'
16:18:48.915 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:18:48.919 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:18:48.919 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:48.919 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:18:48.919 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 remoteRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=89
16:18:48.939 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:18:48.954 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='a17f439f6114dffb9b6dc2681661fbe3491d09a2' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/b
16:18:49.002 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:18:49.003 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:18:49.003 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:18:49.003 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:18:49.004 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 56.31%
16:18:49.005 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
16:18:49.021 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [408719e8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:49.022 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [408719e8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:49.036 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="01fc2777-fb75-4bb8-8b7f-799f8ac4f933"] on repo=ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:49.043 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/b'
16:18:49.105 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 19128 bytes in 61 ms. path='/3/b'
16:18:49.124 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
16:18:49.173 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="01fc2777-fb75-4bb8-8b7f-799f8ac4f933"] on repo=ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:49.195 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/c'
16:18:49.253 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='2494640844a7035a33d2bcfe5092fbb518f358a3' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/c
16:18:49.329 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="01fc2777-fb75-4bb8-8b7f-799f8ac4f933"] on repo=ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:49.345 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/c'
16:18:49.564 [qtp1254813999-32] 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?
16:18:49.686 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 608276 bytes in 341 ms. path='/3/c'
16:18:49.696 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
16:18:49.823 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="01fc2777-fb75-4bb8-8b7f-799f8ac4f933"] on repo=ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:49.835 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/d'
16:18:49.861 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [408719e8]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:49.861 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [408719e8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 838 ms.
16:18:49.918 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='ca2ae7946b8153cf578deddcdde62370c67a7419' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/d
16:18:49.926 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [408719e8]getCloseDeferredMillis: closeDeferredMillis=0
16:18:49.926 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [408719e8]close: Closing real LocalRepoManager immediately.
16:18:49.926 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [408719e8]_close: Shutting down real LocalRepoManager.
16:18:49.966 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="01fc2777-fb75-4bb8-8b7f-799f8ac4f933"] on repo=ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:49.971 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f148217]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:49.972 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f148217]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:49.975 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/d'
16:18:50.106 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 377568 bytes in 131 ms. path='/3/d'
16:18:50.116 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
16:18:50.200 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="01fc2777-fb75-4bb8-8b7f-799f8ac4f933"] on repo=ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:50.220 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 44.48%
16:18:50.220 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/5#/e'
16:18:50.304 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='c5a20fb4f6f6e5c46b988af8684741b791f0f8a5' to.sha1='<NoInstanceOf_NormalFileDto>'): /5#/e
16:18:50.404 [qtp1254813999-32] 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?
16:18:50.423 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="01fc2777-fb75-4bb8-8b7f-799f8ac4f933"] on repo=ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:50.438 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/5#/e'
16:18:50.514 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 79716 bytes in 76 ms. path='/5#/e'
16:18:50.522 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_58e6b3a414a1e090dfc6029add0f3555ccba127f_0 into destFile e
16:18:50.577 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="01fc2777-fb75-4bb8-8b7f-799f8ac4f933"] on repo=ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:50.597 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 49.75%
16:18:50.720 [qtp472120559-31] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 remoteRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d localRepositoryRevisionSynced=3
16:18:50.741 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f148217]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:50.747 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f148217]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 774 ms.
16:18:50.764 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d remoteRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 transaction.localRevision=84 remoteFromLocalRevision=3
16:18:50.880 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=ddbbc15b-3532-4a63-90da-a3f887a3ab0d from='target/repo/k9oa8gdl-9pf25-local' toID=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 to='https://localhost:8836/01fc2777-fb75-4bb8-8b7f-799f8ac4f933'
16:18:50.977 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:18:50.980 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:50.980 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 01fc2777-fb75-4bb8-8b7f-799f8ac4f933
16:18:50.980 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:18:50.981 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d remoteRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=84
16:18:51.010 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:18:51.035 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:18:51.035 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:18:51.035 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:18:51.035 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:18:51.040 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f148217]getCloseDeferredMillis: closeDeferredMillis=0
16:18:51.040 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f148217]close: Closing real LocalRepoManager immediately.
16:18:51.040 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f148217]_close: Shutting down real LocalRepoManager.
16:18:51.046 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 63.43%
16:18:51.046 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
16:18:51.097 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 62.42%
16:18:51.097 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 68.52%
16:18:51.098 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
16:18:51.099 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d remoteRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 localRepositoryRevisionSynced=84
16:18:51.137 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [126df77d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:51.138 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [126df77d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:51.160 [qtp472120559-31] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 remoteRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d transaction.localRevision=6 remoteFromLocalRevision=84
16:18:51.172 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 from='https://localhost:8836/01fc2777-fb75-4bb8-8b7f-799f8ac4f933' toID=ddbbc15b-3532-4a63-90da-a3f887a3ab0d to='target/repo/k9oa8gdl-9pf25-local', fromRepoLocalSync=false
16:18:51.172 [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/k9oa8gdl-9pf25-local/.cloudstore-repo/tmp/ChangeSetDto.01fc2777-fb75-4bb8-8b7f-799f8ac4f933.null.xml.gz
16:18:51.215 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:18:51.218 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 01fc2777-fb75-4bb8-8b7f-799f8ac4f933
16:18:51.219 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:51.219 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:18:51.219 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 remoteRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
16:18:51.221 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:18:51.223 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:18:51.233 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:18:51.234 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:18:51.234 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:18:51.246 [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/k9oa8gdl-9pf25-local/.cloudstore-repo/tmp/ChangeSetDto.01fc2777-fb75-4bb8-8b7f-799f8ac4f933.null.xml.gz
16:18:51.248 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
16:18:51.249 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
16:18:51.265 [qtp472120559-31] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 remoteRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d localRepositoryRevisionSynced=6
16:18:51.288 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d remoteRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 transaction.localRevision=87 remoteFromLocalRevision=6
16:18:51.299 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
16:18:51.582 [qtp1254813999-33] 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?
16:18:51.654 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 0.50%
16:18:51.661 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 from='https://localhost:8836/01fc2777-fb75-4bb8-8b7f-799f8ac4f933' toID=ddbbc15b-3532-4a63-90da-a3f887a3ab0d to='target/repo/k9oa8gdl-9pf25-local', fromRepoLocalSync=true
16:18:51.666 [pool-8-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing ddbbc15b-3532-4a63-90da-a3f887a3ab0d ('target/repo/k9oa8gdl-9pf25-local')
16:18:51.666 [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/k9oa8gdl-9pf25-local/.cloudstore-repo/tmp/ChangeSetDto.01fc2777-fb75-4bb8-8b7f-799f8ac4f933.6.xml.gz
16:18:51.679 [pool-8-thread-1] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 12.94%
16:18:51.688 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
16:18:51.691 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
16:18:51.695 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
16:18:51.727 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
16:18:51.774 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
16:18:51.776 [pool-8-thread-1] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 19.03%
16:18:51.835 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
16:18:51.950 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [126df77d]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:51.951 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [126df77d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 812 ms.
16:18:51.967 [pool-8-thread-1] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 24.06%
16:18:52.045 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [126df77d]getCloseDeferredMillis: closeDeferredMillis=0
16:18:52.061 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [126df77d]close: Closing real LocalRepoManager immediately.
16:18:52.062 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [126df77d]_close: Shutting down real LocalRepoManager.
16:18:52.496 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
16:18:52.518 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [625246cb]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:52.518 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [625246cb]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:52.551 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
16:18:52.571 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:18:52.574 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 01fc2777-fb75-4bb8-8b7f-799f8ac4f933
16:18:52.575 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:52.575 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:18:52.575 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 remoteRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d localRepositoryRevisionSynced=6 localRepositoryRevisionInProgress=9
16:18:52.624 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 2 ModificationDtos took 1 ms.
16:18:52.648 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:18:52.648 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:18:52.648 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:18:52.649 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:18:52.664 [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/k9oa8gdl-9pf25-local/.cloudstore-repo/tmp/ChangeSetDto.01fc2777-fb75-4bb8-8b7f-799f8ac4f933.6.xml.gz
16:18:52.666 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 30.16%
16:18:52.667 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2'
16:18:52.701 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2/1 {11 11ä11#+} 1'
16:18:52.722 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncModifications: Moving from '/2/1 {11 11ä11#+} 1/b' to '/2/b'
16:18:52.832 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncModifications: Deleting '/2/1 {11 11ä11#+} 1/b'
16:18:52.842 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 37.16%
16:18:52.844 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 42.75%
16:18:52.844 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/b'
16:18:52.857 [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?
16:18:52.879 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - File is already equal on destination side (sha1='31223c47c0548aeaad3d3f00c567436145eaae4d'): /2/b
16:18:52.881 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 48.35%
16:18:52.999 [qtp472120559-33] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 remoteRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d localRepositoryRevisionSynced=9
16:18:53.010 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [625246cb]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:53.011 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [625246cb]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 492 ms.
16:18:53.014 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d remoteRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 transaction.localRevision=91 remoteFromLocalRevision=9
16:18:53.020 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=ddbbc15b-3532-4a63-90da-a3f887a3ab0d from='target/repo/k9oa8gdl-9pf25-local' toID=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 to='https://localhost:8836/01fc2777-fb75-4bb8-8b7f-799f8ac4f933'
16:18:53.065 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [625246cb]getCloseDeferredMillis: closeDeferredMillis=0
16:18:53.065 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [625246cb]close: Closing real LocalRepoManager immediately.
16:18:53.066 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [625246cb]_close: Shutting down real LocalRepoManager.
16:18:53.159 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:18:53.175 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:53.175 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 01fc2777-fb75-4bb8-8b7f-799f8ac4f933
16:18:53.175 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:18:53.175 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d remoteRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=91
16:18:53.203 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='03a5631ecb058a17c6ad5009cb68e95c4114f2a4' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
16:18:53.218 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 2 ModificationDtos took 1 ms.
16:18:53.220 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:18:53.220 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:18:53.220 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:18:53.220 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:18:53.221 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 57.84%
16:18:53.221 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncModifications: Moving from '/2/1 {11 11ä11#+} 1/b' to '/2/b'
16:18:53.240 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncModifications: Deleting '/2/1 {11 11ä11#+} 1/b'
16:18:53.266 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 69.03%
16:18:53.267 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
May 01, 2020 4:18:53 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
16:18:53.315 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [4ea5e1af]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:53.316 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [4ea5e1af]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:53.371 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d remoteRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 localRepositoryRevisionSynced=91
16:18:53.394 [qtp472120559-33] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 remoteRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d transaction.localRevision=12 remoteFromLocalRevision=91
16:18:53.411 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 from='https://localhost:8836/01fc2777-fb75-4bb8-8b7f-799f8ac4f933' toID=ddbbc15b-3532-4a63-90da-a3f887a3ab0d to='target/repo/k9oa8gdl-9pf25-local', fromRepoLocalSync=false
16:18:53.412 [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/k9oa8gdl-9pf25-local/.cloudstore-repo/tmp/ChangeSetDto.01fc2777-fb75-4bb8-8b7f-799f8ac4f933.null.xml.gz
16:18:53.454 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:18:53.458 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 01fc2777-fb75-4bb8-8b7f-799f8ac4f933
16:18:53.459 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ddbbc15b-3532-4a63-90da-a3f887a3ab0d
16:18:53.459 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:18:53.459 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 remoteRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d localRepositoryRevisionSynced=9 localRepositoryRevisionInProgress=12
16:18:53.461 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:18:53.463 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:18:53.463 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:18:53.464 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:18:53.464 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:18:53.473 [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/k9oa8gdl-9pf25-local/.cloudstore-repo/tmp/ChangeSetDto.01fc2777-fb75-4bb8-8b7f-799f8ac4f933.null.xml.gz
16:18:53.475 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
16:18:53.475 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
16:18:53.496 [qtp472120559-33] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 remoteRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d localRepositoryRevisionSynced=12
16:18:53.525 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ddbbc15b-3532-4a63-90da-a3f887a3ab0d remoteRepositoryId=01fc2777-fb75-4bb8-8b7f-799f8ac4f933 transaction.localRevision=94 remoteFromLocalRevision=12
16:18:53.528 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
16:18:53.617 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [447a557b]getCloseDeferredMillis: closeDeferredMillis=20000
16:18:53.617 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [447a557b]close: Deferring shut down of real LocalRepoManager 20000 ms.
16:18:53.629 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5f1dadf4]getCloseDeferredMillis: closeDeferredMillis=20000
16:18:53.630 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [5f1dadf4]close: Deferring shut down of real LocalRepoManager 20000 ms.
16:18:53.641 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [34dc40d5]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa94xu-os3wo-local'
16:18:53.643 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [34dc40d5]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa94xu-os3wo-local' locked successfully.
16:18:53.703 [qtp1254813999-32] 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?
16:18:53.848 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [4ea5e1af]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:53.849 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [4ea5e1af]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 531 ms.
16:18:53.880 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [4ea5e1af]getCloseDeferredMillis: closeDeferredMillis=0
16:18:53.880 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [4ea5e1af]close: Closing real LocalRepoManager immediately.
16:18:53.881 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [4ea5e1af]_close: Shutting down real LocalRepoManager.
16:18:53.992 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [70439ac0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:53.992 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [70439ac0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:54.361 [qtp1254813999-32] 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?
16:18:54.548 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [70439ac0]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:54.549 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [70439ac0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 555 ms.
16:18:54.793 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [70439ac0]getCloseDeferredMillis: closeDeferredMillis=0
16:18:54.793 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [70439ac0]close: Closing real LocalRepoManager immediately.
16:18:54.793 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [70439ac0]_close: Shutting down real LocalRepoManager.
16:18:55.573 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="06ee443e-b791-4a4a-bf8e-2d71a190d9a3"] on repo=06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:18:55.581 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
16:18:55.605 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [1801928e]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:55.606 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [1801928e]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:56.092 [qtp1254813999-33] 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?
16:18:56.222 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [1801928e]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:56.223 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [1801928e]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 616 ms.
16:18:56.248 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [1801928e]getCloseDeferredMillis: closeDeferredMillis=0
16:18:56.248 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [1801928e]close: Closing real LocalRepoManager immediately.
16:18:56.248 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [1801928e]_close: Shutting down real LocalRepoManager.
16:18:56.554 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [7a86136c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:56.557 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [7a86136c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:58.166 [qtp1254813999-33] 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?
16:18:58.293 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [7a86136c]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:58.293 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [7a86136c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1734 ms.
16:18:58.344 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [7a86136c]getCloseDeferredMillis: closeDeferredMillis=0
16:18:58.344 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [7a86136c]close: Closing real LocalRepoManager immediately.
16:18:58.344 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [7a86136c]_close: Shutting down real LocalRepoManager.
16:18:58.582 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 17935 bytes in 3001 ms. path='/3/zzz'
May 01, 2020 4:18:58 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
16:18:58.613 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [5676a489]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:58.615 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [5676a489]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:58.942 [qtp1254813999-33] 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?
16:18:59.124 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [5676a489]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:59.125 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [5676a489]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 508 ms.
16:18:59.162 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [5676a489]getCloseDeferredMillis: closeDeferredMillis=0
16:18:59.162 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [5676a489]close: Closing real LocalRepoManager immediately.
16:18:59.162 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [5676a489]_close: Shutting down real LocalRepoManager.
16:18:59.251 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [505ad17d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:18:59.251 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [505ad17d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:18:59.593 [qtp1254813999-33] 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?
16:18:59.736 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [505ad17d]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:18:59.737 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [505ad17d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 483 ms.
16:18:59.785 [qtp1254813999-33] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
16:18:59.916 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [505ad17d]getCloseDeferredMillis: closeDeferredMillis=0
16:18:59.916 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [505ad17d]close: Closing real LocalRepoManager immediately.
16:18:59.916 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [505ad17d]_close: Shutting down real LocalRepoManager.
16:19:00.088 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="06ee443e-b791-4a4a-bf8e-2d71a190d9a3"] on repo=06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:19:00.109 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
16:19:00.135 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 remoteRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed localRepositoryRevisionSynced=89
16:19:00.180 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [75a0a398]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:00.181 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [75a0a398]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:00.691 [qtp1254813999-32] 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?
16:19:00.854 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [75a0a398]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:00.855 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [75a0a398]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 673 ms.
16:19:00.883 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [75a0a398]getCloseDeferredMillis: closeDeferredMillis=0
16:19:00.883 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [75a0a398]close: Closing real LocalRepoManager immediately.
16:19:00.883 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [75a0a398]_close: Shutting down real LocalRepoManager.
16:19:00.949 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [49c3953b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:00.950 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [49c3953b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:01.362 [qtp1254813999-32] 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?
16:19:01.541 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [49c3953b]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:01.542 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [49c3953b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 591 ms.
16:19:01.624 [qtp1254813999-32] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed remoteRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 transaction.localRevision=15 remoteFromLocalRevision=89
16:19:01.626 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [49c3953b]getCloseDeferredMillis: closeDeferredMillis=0
16:19:01.626 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [49c3953b]close: Closing real LocalRepoManager immediately.
16:19:01.627 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [49c3953b]_close: Shutting down real LocalRepoManager.
16:19:01.754 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [34dc40d5]initPersistenceManagerFactory: repositoryId=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:01.830 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [34dc40d5]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 3295 ms.
16:19:01.862 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=df820b8c-23c4-4d7b-8f73-a9a8773d03ed from='https://localhost:27817/df820b8c-23c4-4d7b-8f73-a9a8773d03ed' toID=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 to='target/repo/k9oa7rku-uigwx-local', fromRepoLocalSync=false
16:19:01.863 [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/k9oa7rku-uigwx-local/.cloudstore-repo/tmp/ChangeSetDto.df820b8c-23c4-4d7b-8f73-a9a8773d03ed.null.xml.gz
localRoot: k9oa94xu-os3wo-local
localRepositoryId: ecfe458d-cffd-4118-a325-2f267f68453c
16:19:01.866 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [53251e03]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa94xw-e5zp9-remote'
16:19:01.870 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [53251e03]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa94xw-e5zp9-remote' locked successfully.
16:19:01.872 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [36a69c81]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:01.872 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [36a69c81]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:02.799 [qtp1254813999-33] 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?
16:19:02.939 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [36a69c81]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:02.940 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [36a69c81]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 1066 ms.
16:19:02.968 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [36a69c81]getCloseDeferredMillis: closeDeferredMillis=0
16:19:02.968 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [36a69c81]close: Closing real LocalRepoManager immediately.
16:19:02.968 [qtp1254813999-33] INFO  c.c.c.l.LocalRepoManagerImpl - [36a69c81]_close: Shutting down real LocalRepoManager.
16:19:03.136 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [78c4c0d0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:03.138 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [78c4c0d0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:03.599 [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?
16:19:03.735 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [78c4c0d0]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:03.736 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [78c4c0d0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 594 ms.
16:19:03.815 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:19:03.821 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:03.822 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:19:03.822 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:19:03.822 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed remoteRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
16:19:03.836 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:19:03.844 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:19:03.844 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:19:03.844 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:19:03.844 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:19:03.844 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [78c4c0d0]getCloseDeferredMillis: closeDeferredMillis=0
16:19:03.845 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [78c4c0d0]close: Closing real LocalRepoManager immediately.
16:19:03.845 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [78c4c0d0]_close: Shutting down real LocalRepoManager.
16:19:04.217 [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/k9oa7rku-uigwx-local/.cloudstore-repo/tmp/ChangeSetDto.df820b8c-23c4-4d7b-8f73-a9a8773d03ed.null.xml.gz
16:19:04.217 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
16:19:04.217 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
16:19:04.226 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [431e1695]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:04.226 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [431e1695]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:04.711 [qtp1254813999-32] 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?
16:19:04.851 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [431e1695]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:04.852 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [431e1695]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 625 ms.
16:19:04.895 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [431e1695]getCloseDeferredMillis: closeDeferredMillis=0
16:19:04.895 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [431e1695]close: Closing real LocalRepoManager immediately.
16:19:04.895 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [431e1695]_close: Shutting down real LocalRepoManager.
16:19:04.968 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1038c8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:04.969 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1038c8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:05.230 [qtp1254813999-32] 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?
16:19:05.393 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1038c8]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:05.394 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1038c8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 424 ms.
16:19:05.480 [qtp1254813999-32] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed remoteRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 localRepositoryRevisionSynced=15
16:19:05.522 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1038c8]getCloseDeferredMillis: closeDeferredMillis=0
16:19:05.523 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1038c8]close: Closing real LocalRepoManager immediately.
16:19:05.523 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1c1038c8]_close: Shutting down real LocalRepoManager.
16:19:05.782 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 remoteRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed transaction.localRevision=94 remoteFromLocalRevision=15
16:19:05.791 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
16:19:05.791 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [59da4992]getCloseDeferredMillis: closeDeferredMillis=0
16:19:05.791 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [59da4992]close: Closing real LocalRepoManager immediately.
16:19:05.791 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [59da4992]_close: Shutting down real LocalRepoManager.
16:19:06.430 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
16:19:06.431 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restoring backup: 'target/repo/k9oa7rkx-8kp5m-remote.bak' => 'target/repo/k9oa7rkx-8kp5m-remote'
16:19:06.525 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restored backup: 'target/repo/k9oa7rkx-8kp5m-remote.bak' => 'target/repo/k9oa7rkx-8kp5m-remote'
16:19:06.525 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
16:19:06.528 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [2f726cf4]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rku-uigwx-local'
16:19:06.529 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [2f726cf4]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rku-uigwx-local' locked successfully.
16:19:06.838 [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?
16:19:07.004 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [2f726cf4]initPersistenceManagerFactory: repositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:19:07.005 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [2f726cf4]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 474 ms.
16:19:07.409 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4e436956]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:07.410 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4e436956]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:07.830 [qtp1254813999-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?
16:19:07.979 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4e436956]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:07.979 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4e436956]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 567 ms.
16:19:08.010 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4e436956]getCloseDeferredMillis: closeDeferredMillis=0
16:19:08.010 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4e436956]close: Closing real LocalRepoManager immediately.
16:19:08.010 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [4e436956]_close: Shutting down real LocalRepoManager.
16:19:08.042 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 0.50%
16:19:08.044 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=df820b8c-23c4-4d7b-8f73-a9a8773d03ed from='https://localhost:27817/df820b8c-23c4-4d7b-8f73-a9a8773d03ed' toID=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 to='target/repo/k9oa7rku-uigwx-local', fromRepoLocalSync=true
16:19:08.052 [pool-9-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 06ee443e-b791-4a4a-bf8e-2d71a190d9a3 ('target/repo/k9oa7rku-uigwx-local')
16:19:08.095 [pool-9-thread-1] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 12.94%
16:19:08.161 [pool-9-thread-1] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 19.03%
16:19:08.214 [pool-9-thread-1] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 24.15%
16:19:08.271 [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/k9oa7rku-uigwx-local/.cloudstore-repo/tmp/ChangeSetDto.df820b8c-23c4-4d7b-8f73-a9a8773d03ed.15.xml.gz
16:19:08.289 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7d93d2ca]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:08.290 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7d93d2ca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:08.592 [qtp1254813999-32] 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?
16:19:08.750 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7d93d2ca]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:08.750 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7d93d2ca]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 459 ms.
16:19:08.809 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7d93d2ca]getCloseDeferredMillis: closeDeferredMillis=0
16:19:08.809 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7d93d2ca]close: Closing real LocalRepoManager immediately.
16:19:08.809 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7d93d2ca]_close: Shutting down real LocalRepoManager.
16:19:08.870 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 serverRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed renewalDateTime=2020-05-01T14:48:27.282Z expiryDateTime=2020-05-01T15:18:27.282Z
16:19:08.877 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3968d3cb]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:08.878 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3968d3cb]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:09.368 [qtp1254813999-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?
16:19:09.547 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3968d3cb]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:09.548 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3968d3cb]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 669 ms.
16:19:09.580 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3968d3cb]getCloseDeferredMillis: closeDeferredMillis=0
16:19:09.580 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3968d3cb]close: Closing real LocalRepoManager immediately.
16:19:09.580 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3968d3cb]_close: Shutting down real LocalRepoManager.
16:19:09.655 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [53251e03]initPersistenceManagerFactory: repositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196
16:19:09.657 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [7a8e3915]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:09.663 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [53251e03]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 3592 ms.
16:19:09.657 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [7a8e3915]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
remoteRoot: k9oa94xw-e5zp9-remote
remoteRepositoryId: ff8998cc-7fd4-4113-bb00-36e208fc7196
16:19:09.911 [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?
16:19:09.922 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=108.0 MiB, used=43.5 MiB, available=3.9 GiB
16:19:10.055 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [7a8e3915]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:10.055 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [7a8e3915]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 397 ms.
16:19:10.079 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
16:19:10.092 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
16:19:10.118 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
16:19:10.147 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
16:19:10.155 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
16:19:10.175 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
16:19:10.202 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
16:19:10.242 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
16:19:10.262 [pool-4-thread-1] WARN  c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=15 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=6
16:19:10.348 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:19:10.357 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:10.358 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:19:10.358 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:19:10.358 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed remoteRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 localRepositoryRevisionSynced=15 localRepositoryRevisionInProgress=8
16:19:10.368 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:19:10.379 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:19:10.379 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:19:10.379 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:19:10.379 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:19:10.380 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [7a8e3915]getCloseDeferredMillis: closeDeferredMillis=0
16:19:10.381 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [7a8e3915]close: Closing real LocalRepoManager immediately.
16:19:10.381 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [7a8e3915]_close: Shutting down real LocalRepoManager.
Successfully requested to connect the following local and remote repositories:

  localRepository.repositoryId = ecfe458d-cffd-4118-a325-2f267f68453c
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa94xu-os3wo-local
  localRepository.publicKeySha1 = B0:05:E5:34:32:EB:89:6E:FC:17:0D:D9:7F:F6:7A:05:8F:63:9A:F8

  remoteRepository.repositoryId = ff8998cc-7fd4-4113-bb00-36e208fc7196
  remoteRepository.remoteRoot = https://localhost:8836/ff8998cc-7fd4-4113-bb00-36e208fc7196
  remoteRepository.publicKeySha1 = 91:D0:AB:31:36:F2:2D:DA:E6:08:B0:EF:80:2F:D4:53:EA:F6:DA:B1

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 ecfe458d-cffd-4118-a325-2f267f68453c ff8998cc-7fd4-4113-bb00-36e208fc7196
16:19:10.438 [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/k9oa7rku-uigwx-local/.cloudstore-repo/tmp/ChangeSetDto.df820b8c-23c4-4d7b-8f73-a9a8773d03ed.15.xml.gz
16:19:10.439 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
16:19:10.440 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
16:19:10.458 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [5449e6e2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:10.458 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [5449e6e2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:10.639 [main] INFO  c.c.c.l.s.LocalServer - logMemoryStats: max=3.9 GiB, allocated=108.0 MiB, used=36.9 MiB, available=3.9 GiB
Successfully accepted the connection request for the following local and remote repositories:

  localRepository.repositoryId = ff8998cc-7fd4-4113-bb00-36e208fc7196
  localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa94xw-e5zp9-remote
  localRepository.publicKeySha1 = 91:D0:AB:31:36:F2:2D:DA:E6:08:B0:EF:80:2F:D4:53:EA:F6:DA:B1

  remoteRepository.repositoryId = ecfe458d-cffd-4118-a325-2f267f68453c
  remoteRepository.publicKeySha1 = B0:05:E5:34:32:EB:89:6E:FC:17:0D:D9:7F:F6:7A:05:8F:63:9A:F8

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 ff8998cc-7fd4-4113-bb00-36e208fc7196 ecfe458d-cffd-4118-a325-2f267f68453c
16:19:10.823 [qtp1254813999-32] 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?
16:19:10.957 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [5449e6e2]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:10.958 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [5449e6e2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 499 ms.
16:19:10.987 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [5449e6e2]getCloseDeferredMillis: closeDeferredMillis=0
16:19:10.987 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [5449e6e2]close: Closing real LocalRepoManager immediately.
16:19:10.987 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [5449e6e2]_close: Shutting down real LocalRepoManager.
16:19:11.151 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f3a717c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:11.152 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f3a717c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:11.492 [qtp1254813999-32] 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?
16:19:11.652 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f3a717c]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:11.653 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f3a717c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 500 ms.
16:19:11.690 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 0.50%
16:19:11.691 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=ff8998cc-7fd4-4113-bb00-36e208fc7196 from='https://localhost:8836/ff8998cc-7fd4-4113-bb00-36e208fc7196' toID=ecfe458d-cffd-4118-a325-2f267f68453c to='target/repo/k9oa94xu-os3wo-local', fromRepoLocalSync=true
16:19:11.700 [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/k9oa94xu-os3wo-local/.cloudstore-repo/tmp/ChangeSetDto.ff8998cc-7fd4-4113-bb00-36e208fc7196.-1.xml.gz
16:19:11.702 [pool-9-thread-1] INFO  c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing ecfe458d-cffd-4118-a325-2f267f68453c ('target/repo/k9oa94xu-os3wo-local')
16:19:11.720 [pool-9-thread-1] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 12.94%
16:19:11.734 [pool-9-thread-1] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 25.12%
16:19:11.758 [qtp1254813999-32] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed remoteRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 localRepositoryRevisionSynced=8
16:19:11.773 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f3a717c]getCloseDeferredMillis: closeDeferredMillis=0
16:19:11.773 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f3a717c]close: Closing real LocalRepoManager immediately.
16:19:11.773 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [f3a717c]_close: Shutting down real LocalRepoManager.
16:19:11.803 [main] INFO  c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c serverRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 renewalDateTime=2020-05-01T14:49:11.752Z expiryDateTime=2020-05-01T15:19:11.752Z
16:19:11.815 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
16:19:11.817 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
16:19:11.854 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 remoteRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed transaction.localRevision=95 remoteFromLocalRevision=8
16:19:11.857 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 from='target/repo/k9oa7rku-uigwx-local' toID=df820b8c-23c4-4d7b-8f73-a9a8773d03ed to='https://localhost:27817/df820b8c-23c4-4d7b-8f73-a9a8773d03ed'
16:19:11.867 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 55.02%
16:19:11.873 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3e9c873c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:11.874 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3e9c873c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:12.044 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 64.60%
16:19:12.085 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 74.40%
16:19:12.186 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 84.20%
16:19:12.229 [qtp1254813999-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?
16:19:12.269 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 94.00%
16:19:12.370 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3e9c873c]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:12.371 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3e9c873c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 496 ms.
16:19:12.402 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3e9c873c]getCloseDeferredMillis: closeDeferredMillis=0
16:19:12.402 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3e9c873c]close: Closing real LocalRepoManager immediately.
16:19:12.402 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3e9c873c]_close: Shutting down real LocalRepoManager.
16:19:13.067 [pool-4-thread-1] INFO  c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
16:19:13.629 [closeDeferredTimer-447a557b-1] INFO  c.c.c.l.LocalRepoManagerImpl - [447a557b]_close: Shutting down real LocalRepoManager.
16:19:13.634 [closeDeferredTimer-5f1dadf4-1] INFO  c.c.c.l.LocalRepoManagerImpl - [5f1dadf4]_close: Shutting down real LocalRepoManager.
16:19:14.078 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:19:14.089 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ff8998cc-7fd4-4113-bb00-36e208fc7196
16:19:14.090 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ecfe458d-cffd-4118-a325-2f267f68453c
16:19:14.090 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:19:14.090 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 remoteRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
16:19:14.098 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:19:14.139 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:19:14.139 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:19:14.139 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:19:14.139 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:19:14.174 [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/k9oa94xu-os3wo-local/.cloudstore-repo/tmp/ChangeSetDto.ff8998cc-7fd4-4113-bb00-36e208fc7196.-1.xml.gz
16:19:14.175 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
16:19:14.234 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/#4'
16:19:14.235 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [511c397a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:14.236 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [511c397a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:14.283 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/1 {11 11ä11#+} 1'
16:19:14.359 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 30.33%
16:19:14.360 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2'
16:19:14.428 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2/1 {11 11ä11#+} 1'
16:19:14.455 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
16:19:14.560 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/5#'
16:19:14.622 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 35.59%
16:19:14.622 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 40.86%
16:19:14.622 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/#b'
16:19:14.671 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='963a009298c297d0d046daf639d2c3836fc44422' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/#b
16:19:14.870 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:14.874 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/#b'
16:19:14.951 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 104725 bytes in 77 ms. path='/#4/#b'
16:19:14.960 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c691e3d4c979adbf07e3b97e33fdf3c89ed246f6_0 into destFile #b
16:19:14.964 [qtp1254813999-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?
16:19:15.012 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:15.066 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/a'
16:19:15.102 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [511c397a]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:15.103 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [511c397a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 864 ms.
16:19:15.133 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [511c397a]getCloseDeferredMillis: closeDeferredMillis=0
16:19:15.133 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [511c397a]close: Closing real LocalRepoManager immediately.
16:19:15.133 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [511c397a]_close: Shutting down real LocalRepoManager.
16:19:15.133 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='1ebc8f7b9eb14d3a124d8f897fdc66311bcc78da' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/a
16:19:15.193 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:15.218 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/a'
16:19:15.315 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 468027 bytes in 97 ms. path='/#4/a'
16:19:15.325 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
16:19:15.493 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:15.511 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/c+'
16:19:15.583 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='b1d3e3be1a219f9898917d9323e76596ad830f64' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/c+
16:19:15.639 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:15.649 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/c+'
16:19:15.740 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 402560 bytes in 90 ms. path='/#4/c+'
16:19:15.746 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_8a30244b83c6cac3c79f8f95d30f96579c0f4c0b_0 into destFile c+
16:19:15.873 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:16.142 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/d$'
16:19:16.183 [main] WARN  c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=84 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=89
16:19:16.198 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:19:16.210 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='a5ff956675b640645418a6d422808ced7a190f34' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/d$
16:19:16.200 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:19:16.201 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:16.201 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:19:16.201 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 remoteRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=95
16:19:16.210 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:19:16.239 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:19:16.239 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:19:16.239 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:19:16.239 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:19:16.240 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 52.24%
16:19:16.240 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
16:19:16.245 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:16.248 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/d$'
16:19:16.250 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3db78138]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:16.250 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3db78138]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:16.298 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 145800 bytes in 50 ms. path='/#4/d$'
16:19:16.304 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_a93a212f7eca012dceb852f364cc2c34026f0dd8_0 into destFile d$
16:19:16.379 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:16.395 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/a'
16:19:16.465 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='152ab4772e9c29f678fdee11bed75bbbda3cc42b' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/a
16:19:16.504 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:16.519 [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'
16:19:16.615 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 457010 bytes in 96 ms. path='/1 {11 11ä11#+} 1/a'
16:19:16.624 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
16:19:16.666 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:16.678 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/b'
16:19:16.745 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='b9f68fa8d54f67133429409d9f20fa98a786b91c' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/b
16:19:16.783 [qtp1254813999-32] 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?
16:19:16.787 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:16.801 [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'
16:19:16.931 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 469161 bytes in 130 ms. path='/1 {11 11ä11#+} 1/b'
16:19:16.938 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
16:19:16.951 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3db78138]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:16.952 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3db78138]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 701 ms.
16:19:16.975 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:16.980 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/c'
16:19:16.983 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3db78138]getCloseDeferredMillis: closeDeferredMillis=0
16:19:16.984 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3db78138]close: Closing real LocalRepoManager immediately.
16:19:16.984 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3db78138]_close: Shutting down real LocalRepoManager.
16:19:17.051 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='aa8d97d11b706a97420c5686673a2446c535e329' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/c
16:19:17.117 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:17.120 [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'
16:19:17.125 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [45ac51b2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:17.126 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [45ac51b2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:17.186 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 217500 bytes in 66 ms. path='/1 {11 11ä11#+} 1/c'
16:19:17.194 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
16:19:17.227 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:17.239 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/a'
16:19:17.310 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='25518e465dc3b84b3f605e4d8ddbcecd4087355f' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/a
16:19:17.358 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:17.360 [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'
16:19:17.392 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 32985 bytes in 32 ms. path='/2/1 {11 11ä11#+} 1/a'
16:19:17.402 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
16:19:17.405 [qtp1254813999-32] 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?
16:19:17.464 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:17.471 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/b'
16:19:17.538 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='6de08f286ea7178ab69f638a7d0539242b13c706' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/b
16:19:17.564 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [45ac51b2]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:17.566 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [45ac51b2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 439 ms.
16:19:17.572 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:17.574 [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'
16:19:17.685 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 404110 bytes in 111 ms. path='/2/1 {11 11ä11#+} 1/b'
16:19:17.688 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [45ac51b2]getCloseDeferredMillis: closeDeferredMillis=0
16:19:17.689 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [45ac51b2]close: Closing real LocalRepoManager immediately.
16:19:17.689 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [45ac51b2]_close: Shutting down real LocalRepoManager.
16:19:17.693 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
16:19:17.726 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 58.34%
16:19:17.723 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:17.729 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/a'
16:19:17.730 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 64.45%
16:19:17.731 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 70.56%
16:19:17.731 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
16:19:17.766 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [5295649]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:17.766 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [5295649]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:17.785 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='bcf25e7ad2b55172a3e82bfd273d002897789e39' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/a
16:19:17.823 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:17.828 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/a'
16:19:17.876 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 114270 bytes in 47 ms. path='/2/a'
16:19:17.885 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
16:19:17.908 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:17.947 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/a'
16:19:18.019 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='897758a4bd1dafbb692cd5a67fb6af2205f7275e' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/a
16:19:18.042 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:18.053 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/a'
16:19:18.115 [qtp1254813999-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?
16:19:18.195 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 597007 bytes in 142 ms. path='/3/a'
16:19:18.202 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
16:19:18.276 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [5295649]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:18.276 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [5295649]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 509 ms.
16:19:18.290 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:18.309 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [5295649]getCloseDeferredMillis: closeDeferredMillis=0
16:19:18.309 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [5295649]close: Closing real LocalRepoManager immediately.
16:19:18.309 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [5295649]_close: Shutting down real LocalRepoManager.
16:19:18.351 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/b'
16:19:18.403 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='679d334d4405f71b097868a8ec01767d5e69d672' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/b
16:19:18.438 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:18.442 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/b'
16:19:18.457 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [3e554bea]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:18.457 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [3e554bea]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:18.489 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 127392 bytes in 47 ms. path='/3/b'
16:19:18.496 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
16:19:18.519 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:18.527 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/c'
16:19:18.589 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='7f041c97b1f94fee854c1f3f10427db66841b2b5' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/c
16:19:18.611 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:18.613 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/c'
16:19:18.643 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 7107 bytes in 30 ms. path='/3/c'
16:19:18.651 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
16:19:18.668 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:18.678 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/d'
16:19:18.707 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='cd382f07529291df24b06e2d494984b5ce017975' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/d
16:19:18.728 [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?
16:19:18.728 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:18.730 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/d'
16:19:18.819 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 210021 bytes in 89 ms. path='/3/d'
16:19:18.830 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
16:19:18.858 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:18.866 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/5#/e'
16:19:18.871 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [3e554bea]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:18.872 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [3e554bea]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 413 ms.
16:19:18.916 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [3e554bea]getCloseDeferredMillis: closeDeferredMillis=0
16:19:18.917 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [3e554bea]close: Closing real LocalRepoManager immediately.
16:19:18.917 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [3e554bea]_close: Shutting down real LocalRepoManager.
16:19:18.928 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='2de4b15d712d2aeb5a0d70353774e91491f9485d' to.sha1='<NoInstanceOf_NormalFileDto>'): /5#/e
16:19:19.082 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:19.086 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/5#/e'
16:19:19.160 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 313320 bytes in 74 ms. path='/5#/e'
16:19:19.165 [main] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_58e6b3a414a1e090dfc6029add0f3555ccba127f_0 into destFile e
16:19:19.202 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='03a5631ecb058a17c6ad5009cb68e95c4114f2a4' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
May 01, 2020 4:19:19 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
16:19:19.216 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [321e457d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:19.216 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [321e457d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:19.243 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="ff8998cc-7fd4-4113-bb00-36e208fc7196"] on repo=ecfe458d-cffd-4118-a325-2f267f68453c
16:19:19.252 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 49.42%
16:19:19.311 [qtp472120559-28] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 remoteRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c localRepositoryRevisionSynced=3
16:19:19.346 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c remoteRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 transaction.localRevision=84 remoteFromLocalRevision=3
16:19:19.357 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=ecfe458d-cffd-4118-a325-2f267f68453c from='target/repo/k9oa94xu-os3wo-local' toID=ff8998cc-7fd4-4113-bb00-36e208fc7196 to='https://localhost:8836/ff8998cc-7fd4-4113-bb00-36e208fc7196'
16:19:19.402 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:19:19.404 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ecfe458d-cffd-4118-a325-2f267f68453c
16:19:19.404 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ff8998cc-7fd4-4113-bb00-36e208fc7196
16:19:19.404 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:19:19.404 [main] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c remoteRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=84
16:19:19.411 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:19:19.421 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:19:19.421 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:19:19.421 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:19:19.421 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:19:19.422 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 63.43%
16:19:19.422 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
16:19:19.440 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c remoteRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 localRepositoryRevisionSynced=84
16:19:19.464 [qtp472120559-28] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 remoteRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c transaction.localRevision=6 remoteFromLocalRevision=84
16:19:19.468 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=ff8998cc-7fd4-4113-bb00-36e208fc7196 from='https://localhost:8836/ff8998cc-7fd4-4113-bb00-36e208fc7196' toID=ecfe458d-cffd-4118-a325-2f267f68453c to='target/repo/k9oa94xu-os3wo-local', fromRepoLocalSync=false
16:19:19.469 [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/k9oa94xu-os3wo-local/.cloudstore-repo/tmp/ChangeSetDto.ff8998cc-7fd4-4113-bb00-36e208fc7196.null.xml.gz
16:19:19.483 [qtp1254813999-32] 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?
16:19:19.514 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:19:19.517 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ff8998cc-7fd4-4113-bb00-36e208fc7196
16:19:19.517 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ecfe458d-cffd-4118-a325-2f267f68453c
16:19:19.517 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:19:19.518 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 remoteRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
16:19:19.521 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:19:19.526 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:19:19.526 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:19:19.526 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:19:19.526 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:19:19.533 [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/k9oa94xu-os3wo-local/.cloudstore-repo/tmp/ChangeSetDto.ff8998cc-7fd4-4113-bb00-36e208fc7196.null.xml.gz
16:19:19.534 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
16:19:19.534 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
16:19:19.558 [qtp472120559-28] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 remoteRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c localRepositoryRevisionSynced=6
16:19:19.588 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ecfe458d-cffd-4118-a325-2f267f68453c remoteRepositoryId=ff8998cc-7fd4-4113-bb00-36e208fc7196 transaction.localRevision=87 remoteFromLocalRevision=6
16:19:19.591 [main] INFO  c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
16:19:19.659 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [321e457d]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:19.660 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [321e457d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 442 ms.
16:19:19.694 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [321e457d]getCloseDeferredMillis: closeDeferredMillis=0
16:19:19.694 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [321e457d]close: Closing real LocalRepoManager immediately.
16:19:19.694 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [321e457d]_close: Shutting down real LocalRepoManager.
16:19:19.719 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [34dc40d5]getCloseDeferredMillis: closeDeferredMillis=20000
16:19:19.719 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [34dc40d5]close: Deferring shut down of real LocalRepoManager 20000 ms.
16:19:19.721 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [53251e03]getCloseDeferredMillis: closeDeferredMillis=20000
16:19:19.721 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [53251e03]close: Deferring shut down of real LocalRepoManager 20000 ms.
[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 201.595 s - in co.codewizards.cloudstore.test.repotorepo.BasicRepoToRepoSyncIT
16:19:19.762 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@17f5a0af{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
16:19:19.763 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
16:19:19.774 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@2c6120a0{/,null,UNAVAILABLE}
16:19:19.782 [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/cOFrnEPke6O9gvBy7pUbWQ/.cloudstore/localServerRunning.deleteToStop
16:19:19.787 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@1ad33b1c{SSL,[ssl, http/1.1]}{0.0.0.0:8836}
16:19:19.787 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
16:19:19.791 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@5d1fe673{/,null,UNAVAILABLE}
16:19:19.835 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1ac75b76]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:19.836 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1ac75b76]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:20.236 [qtp1254813999-32] 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?
16:19:20.383 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1ac75b76]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:20.384 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1ac75b76]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 547 ms.
16:19:20.636 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1ac75b76]getCloseDeferredMillis: closeDeferredMillis=0
16:19:20.637 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1ac75b76]close: Closing real LocalRepoManager immediately.
16:19:20.637 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [1ac75b76]_close: Shutting down real LocalRepoManager.
16:19:20.814 [main] INFO  c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="06ee443e-b791-4a4a-bf8e-2d71a190d9a3"] on repo=06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:19:20.815 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
16:19:20.833 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [580fa5aa]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:20.834 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [580fa5aa]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:21.213 [qtp1254813999-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?
16:19:21.335 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [580fa5aa]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:21.336 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [580fa5aa]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 502 ms.
16:19:21.368 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [580fa5aa]getCloseDeferredMillis: closeDeferredMillis=0
16:19:21.368 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [580fa5aa]close: Closing real LocalRepoManager immediately.
16:19:21.368 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [580fa5aa]_close: Shutting down real LocalRepoManager.
16:19:21.402 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [2ee6c6c6]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:21.402 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [2ee6c6c6]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:21.679 [qtp1254813999-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?
16:19:21.823 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [2ee6c6c6]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:21.823 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [2ee6c6c6]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 419 ms.
16:19:21.874 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [2ee6c6c6]getCloseDeferredMillis: closeDeferredMillis=0
16:19:21.875 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [2ee6c6c6]close: Closing real LocalRepoManager immediately.
16:19:21.875 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [2ee6c6c6]_close: Shutting down real LocalRepoManager.
16:19:21.981 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 17935 bytes in 1166 ms. path='/3/zzz'
May 01, 2020 4:19:21 PM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
16:19:21.994 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3e5c2c17]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:21.994 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3e5c2c17]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:22.310 [qtp1254813999-32] 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?
16:19:22.437 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3e5c2c17]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:22.437 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3e5c2c17]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 442 ms.
16:19:22.462 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3e5c2c17]getCloseDeferredMillis: closeDeferredMillis=0
16:19:22.463 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3e5c2c17]close: Closing real LocalRepoManager immediately.
16:19:22.463 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [3e5c2c17]_close: Shutting down real LocalRepoManager.
16:19:22.506 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [2fd31a6f]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:22.507 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [2fd31a6f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:22.776 [qtp1254813999-32] 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?
16:19:22.899 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [2fd31a6f]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:22.899 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [2fd31a6f]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 390 ms.
16:19:22.943 [qtp1254813999-32] INFO  c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
16:19:23.032 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [2fd31a6f]getCloseDeferredMillis: closeDeferredMillis=0
16:19:23.033 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [2fd31a6f]close: Closing real LocalRepoManager immediately.
16:19:23.033 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [2fd31a6f]_close: Shutting down real LocalRepoManager.
16:19:23.308 [main] INFO  c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="06ee443e-b791-4a4a-bf8e-2d71a190d9a3"] on repo=06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:19:23.338 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
16:19:23.350 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 remoteRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed localRepositoryRevisionSynced=95
16:19:23.389 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3504d439]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:23.390 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3504d439]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:23.601 [qtp1254813999-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?
16:19:23.731 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3504d439]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:23.731 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3504d439]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 340 ms.
16:19:23.764 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3504d439]getCloseDeferredMillis: closeDeferredMillis=0
16:19:23.764 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3504d439]close: Closing real LocalRepoManager immediately.
16:19:23.764 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [3504d439]_close: Shutting down real LocalRepoManager.
16:19:23.957 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [76d210ed]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:23.958 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [76d210ed]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:24.256 [qtp1254813999-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?
16:19:24.377 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [76d210ed]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:24.378 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [76d210ed]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 417 ms.
16:19:24.438 [qtp1254813999-26] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed remoteRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 transaction.localRevision=15 remoteFromLocalRevision=95
16:19:24.497 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [76d210ed]getCloseDeferredMillis: closeDeferredMillis=0
16:19:24.497 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [76d210ed]close: Closing real LocalRepoManager immediately.
16:19:24.498 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [76d210ed]_close: Shutting down real LocalRepoManager.
16:19:24.543 [main] INFO  c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=df820b8c-23c4-4d7b-8f73-a9a8773d03ed from='https://localhost:27817/df820b8c-23c4-4d7b-8f73-a9a8773d03ed' toID=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 to='target/repo/k9oa7rku-uigwx-local', fromRepoLocalSync=false
16:19:24.544 [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/k9oa7rku-uigwx-local/.cloudstore-repo/tmp/ChangeSetDto.df820b8c-23c4-4d7b-8f73-a9a8773d03ed.null.xml.gz
16:19:24.556 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7e8de375]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:24.557 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7e8de375]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:24.778 [qtp1254813999-32] 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?
16:19:24.902 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7e8de375]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:24.903 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7e8de375]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 345 ms.
16:19:24.929 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7e8de375]getCloseDeferredMillis: closeDeferredMillis=0
16:19:24.929 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7e8de375]close: Closing real LocalRepoManager immediately.
16:19:24.929 [qtp1254813999-32] INFO  c.c.c.l.LocalRepoManagerImpl - [7e8de375]_close: Shutting down real LocalRepoManager.
16:19:24.992 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [4383b0d4]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:24.993 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [4383b0d4]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:25.226 [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?
16:19:25.387 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [4383b0d4]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:25.388 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [4383b0d4]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 394 ms.
16:19:25.462 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
16:19:25.464 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:25.465 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 06ee443e-b791-4a4a-bf8e-2d71a190d9a3
16:19:25.465 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix: 
16:19:25.465 [pool-4-thread-1] INFO  c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed remoteRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
16:19:25.480 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
16:19:25.488 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
16:19:25.488 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
16:19:25.488 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
16:19:25.488 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
16:19:25.489 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [4383b0d4]getCloseDeferredMillis: closeDeferredMillis=0
16:19:25.489 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [4383b0d4]close: Closing real LocalRepoManager immediately.
16:19:25.489 [pool-4-thread-1] INFO  c.c.c.l.LocalRepoManagerImpl - [4383b0d4]_close: Shutting down real LocalRepoManager.
16:19:25.689 [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/k9oa7rku-uigwx-local/.cloudstore-repo/tmp/ChangeSetDto.df820b8c-23c4-4d7b-8f73-a9a8773d03ed.null.xml.gz
16:19:25.690 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
16:19:25.690 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
16:19:25.699 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [fc76be8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:25.700 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [fc76be8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:25.983 [qtp1254813999-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?
16:19:26.099 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [fc76be8]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:26.100 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [fc76be8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 398 ms.
16:19:26.123 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [fc76be8]getCloseDeferredMillis: closeDeferredMillis=0
16:19:26.123 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [fc76be8]close: Closing real LocalRepoManager immediately.
16:19:26.123 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [fc76be8]_close: Shutting down real LocalRepoManager.
16:19:26.163 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [145145ca]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote'
16:19:26.164 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [145145ca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore_java_11/co.codewizards.cloudstore.test/target/repo/k9oa7rkx-8kp5m-remote' locked successfully.
16:19:26.404 [qtp1254813999-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?
16:19:26.526 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [145145ca]initPersistenceManagerFactory: repositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed
16:19:26.527 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [145145ca]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 361 ms.
16:19:26.601 [qtp1254813999-26] INFO  c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed remoteRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 localRepositoryRevisionSynced=15
16:19:26.612 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [145145ca]getCloseDeferredMillis: closeDeferredMillis=0
16:19:26.612 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [145145ca]close: Closing real LocalRepoManager immediately.
16:19:26.612 [qtp1254813999-26] INFO  c.c.c.l.LocalRepoManagerImpl - [145145ca]_close: Shutting down real LocalRepoManager.
16:19:26.667 [main] INFO  c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=06ee443e-b791-4a4a-bf8e-2d71a190d9a3 remoteRepositoryId=df820b8c-23c4-4d7b-8f73-a9a8773d03ed transaction.localRevision=100 remoteFromLocalRevision=15
16:19:26.706 [main] INFO  c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
16:19:26.758 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [2f726cf4]getCloseDeferredMillis: closeDeferredMillis=0
16:19:26.758 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [2f726cf4]close: Closing real LocalRepoManager immediately.
16:19:26.758 [main] INFO  c.c.c.l.LocalRepoManagerImpl - [2f726cf4]_close: Shutting down real LocalRepoManager.
[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 272.553 s - in co.codewizards.cloudstore.test.repotorepo.BackupRestoreRepoToRepoSyncIT
16:19:27.055 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@35e7a4e9{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
16:19:27.056 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
16:19:27.068 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@19e7d108{/,null,UNAVAILABLE}
16:19:27.074 [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/doPeto8xMu926GlHoZoaYw/.cloudstore/localServerRunning.deleteToStop
16:19:27.079 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@29f5da36{SSL,[ssl, http/1.1]}{0.0.0.0:27817}
16:19:27.079 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
16:19:27.083 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@4b4cee6f{/,null,UNAVAILABLE}
16:19:28.743 [main] ERROR c.c.c.r.c.CloudStoreRestClient - determineBaseUrl: Determining baseURL failed for hostURL='https://localhost:28869/': javax.ws.rs.ProcessingException: javax.net.ssl.SSLException: readHandshakeRecord
16:19:28.743 [main] WARN  c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: Determining baseURL failed for hostURL='https://localhost:28869/': javax.ws.rs.ProcessingException: javax.net.ssl.SSLException: readHandshakeRecord
javax.ws.rs.ProcessingException: Determining baseURL failed for hostURL='https://localhost:28869/': javax.ws.rs.ProcessingException: javax.net.ssl.SSLException: readHandshakeRecord
	at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.determineBaseUrl(CloudStoreRestClient.java:130)
	at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.getBaseUrl(CloudStoreRestClient.java:75)
	at co.codewizards.cloudstore.rest.client.request.AbstractRequest.getBaseURL(AbstractRequest.java:146)
	at co.codewizards.cloudstore.rest.client.request.AbstractRequest.createWebTarget(AbstractRequest.java:115)
	at co.codewizards.cloudstore.rest.client.request.TestRequest.execute(TestRequest.java:27)
	at co.codewizards.cloudstore.rest.client.request.TestRequest.execute(TestRequest.java:6)
	at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.execute(CloudStoreRestClient.java:175)
	at co.codewizards.cloudstore.test.CertificateHandlingAndTestServiceLRT.almostTimedOut_5min(CertificateHandlingAndTestServiceLRT.java:89)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:566)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
	at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156)
	at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65)
	at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
	at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:365)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:273)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:238)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:159)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:377)
	at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:138)
	at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:465)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:451)
Caused by: javax.ws.rs.ProcessingException: javax.net.ssl.SSLException: readHandshakeRecord
	at org.glassfish.jersey.client.internal.HttpUrlConnector.apply(HttpUrlConnector.java:260)
	at org.glassfish.jersey.client.ClientRuntime.invoke(ClientRuntime.java:254)
	at org.glassfish.jersey.client.JerseyInvocation.lambda$invoke$1(JerseyInvocation.java:750)
	at org.glassfish.jersey.internal.Errors.process(Errors.java:292)
	at org.glassfish.jersey.internal.Errors.process(Errors.java:274)
	at org.glassfish.jersey.internal.Errors.process(Errors.java:205)
	at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:390)
	at org.glassfish.jersey.client.JerseyInvocation.invoke(JerseyInvocation.java:748)
	at org.glassfish.jersey.client.JerseyInvocation$Builder.method(JerseyInvocation.java:404)
	at org.glassfish.jersey.client.JerseyInvocation$Builder.get(JerseyInvocation.java:300)
	at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.determineBaseUrl(CloudStoreRestClient.java:118)
	... 40 common frames omitted
Caused by: javax.net.ssl.SSLException: readHandshakeRecord
	at java.base/sun.security.ssl.SSLSocketImpl.readHandshakeRecord(SSLSocketImpl.java:1071)
	at java.base/sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:402)
	at java.base/sun.net.www.protocol.https.HttpsClient.afterConnect(HttpsClient.java:567)
	at java.base/sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:185)
	at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1587)
	at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1515)
	at java.base/java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:527)
	at java.base/sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:334)
	at org.glassfish.jersey.client.internal.HttpUrlConnector._apply(HttpUrlConnector.java:366)
	at org.glassfish.jersey.client.internal.HttpUrlConnector.apply(HttpUrlConnector.java:258)
	... 50 common frames omitted
	Suppressed: java.net.SocketException: Broken pipe (Write failed)
		at java.base/java.net.SocketOutputStream.socketWrite0(Native Method)
		at java.base/java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:110)
		at java.base/java.net.SocketOutputStream.write(SocketOutputStream.java:150)
		at java.base/sun.security.ssl.SSLSocketOutputRecord.encodeAlert(SSLSocketOutputRecord.java:81)
		at java.base/sun.security.ssl.TransportContext.fatal(TransportContext.java:351)
		at java.base/sun.security.ssl.TransportContext.fatal(TransportContext.java:263)
		at java.base/sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:405)
		... 58 common frames omitted
Caused by: java.net.SocketException: Broken pipe (Write failed)
	at java.base/java.net.SocketOutputStream.socketWrite0(Native Method)
	at java.base/java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:110)
	at java.base/java.net.SocketOutputStream.write(SocketOutputStream.java:150)
	at java.base/sun.security.ssl.SSLSocketOutputRecord.encodeChangeCipherSpec(SSLSocketOutputRecord.java:221)
	at java.base/sun.security.ssl.OutputRecord.changeWriteCiphers(OutputRecord.java:162)
	at java.base/sun.security.ssl.ChangeCipherSpec$T10ChangeCipherSpecProducer.produce(ChangeCipherSpec.java:118)
	at java.base/sun.security.ssl.Finished$T12FinishedProducer.onProduceFinished(Finished.java:395)
	at java.base/sun.security.ssl.Finished$T12FinishedProducer.produce(Finished.java:379)
	at java.base/sun.security.ssl.SSLHandshake.produce(SSLHandshake.java:436)
	at java.base/sun.security.ssl.ServerHelloDone$ServerHelloDoneConsumer.consume(ServerHelloDone.java:182)
	at java.base/sun.security.ssl.SSLHandshake.consume(SSLHandshake.java:392)
	at java.base/sun.security.ssl.HandshakeContext.dispatch(HandshakeContext.java:443)
	at java.base/sun.security.ssl.HandshakeContext.dispatch(HandshakeContext.java:421)
	at java.base/sun.security.ssl.TransportContext.dispatch(TransportContext.java:177)
	at java.base/sun.security.ssl.SSLTransport.decode(SSLTransport.java:164)
	at java.base/sun.security.ssl.SSLSocketImpl.decode(SSLSocketImpl.java:1151)
	at java.base/sun.security.ssl.SSLSocketImpl.readHandshakeRecord(SSLSocketImpl.java:1062)
	... 59 common frames omitted
[WARNING] Tests run: 4, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 441.497 s - in co.codewizards.cloudstore.test.CertificateHandlingAndTestServiceLRT
16:19:30.099 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@5d2179ed{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
16:19:30.105 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
16:19:30.132 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@2e6df86a{/,null,UNAVAILABLE}
16:19:30.140 [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/Z0g_rn5rrsdjdJ7Juqx1rg/.cloudstore/localServerRunning.deleteToStop
16:19:30.147 [Thread-3] INFO  o.e.j.s.AbstractConnector - Stopped ServerConnector@2f4b600d{SSL,[ssl, http/1.1]}{0.0.0.0:28869}
16:19:30.148 [Thread-3] INFO  o.e.j.s.session - node0 Stopped scavenging
16:19:30.164 [Thread-3] INFO  o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@64a4216a{/,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] Downloaded from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/1.0.1-SNAPSHOT/maven-metadata.xml (1.0 kB at 170 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-20200501.141931-4.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-20200501.141931-4.jar (7.3 kB at 1.2 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-20200501.141931-4.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-20200501.141931-4.pom (5.3 kB at 2.6 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] Downloaded from cloudstore-snapshot-repo: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (356 B at 89 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/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 204 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/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 (356 B at 356 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-20200501.141931-4-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-20200501.141931-4-sources.jar (5.0 kB at 2.5 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