|  Console Output
Skipping 1,640 KB.. Full Logr.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/5#/e'
11:50:20.745 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 445188 bytes in 95 ms. path='/5#/e'
11:50:20.751 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_58e6b3a414a1e090dfc6029add0f3555ccba127f_0 into destFile e
11:50:20.789 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d"] on repo=fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:20.795 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 49.42%
11:50:20.845 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 2 dirty file-chunks with together 1059554 bytes in 997 ms. path='/d'
11:50:20.853 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
11:50:20.862 [qtp825025857-64] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=3
11:50:20.881 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34 into destFile d
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_0, chunksDeleted=1
WatchTaskChunksToFile: length reached! length=1059554
watchForCreationsDeletions: ENTRY_DELETE=chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34, chunksDeleted=2
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_0.xml
11:50:20.887 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d transaction.localRevision=84 remoteFromLocalRevision=3
11:50:20.905 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=fb55a063-cc06-4c5d-a8ae-d420a15356c4 from='target/repo/k0kst3oj-f6niz-local' toID=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d to='https://localhost:41270/8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d'
11:50:20.980 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:20.984 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:20.984 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:20.984 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:20.984 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=84
11:50:20.993 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:21.003 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:21.003 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:21.004 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:21.004 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:21.004 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 63.43%
11:50:21.005 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
11:50:21.026 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d localRepositoryRevisionSynced=84
11:50:21.061 [qtp825025857-64] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 transaction.localRevision=6 remoteFromLocalRevision=84
11:50:21.070 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d from='https://localhost:41270/8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d' toID=fb55a063-cc06-4c5d-a8ae-d420a15356c4 to='target/repo/k0kst3oj-f6niz-local', fromRepoLocalSync=false
11:50:21.070 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.null.xml.gz
deleteOrFail: chunk_3c363836cf4e16666669a25da280a1865c2d2874_mh34.xml
11:50:21.107 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:21.112 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:21.112 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:21.112 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:21.112 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
11:50:21.113 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:21.115 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:21.115 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:21.115 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:21.115 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:21.123 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.null.xml.gz
11:50:21.124 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
11:50:21.124 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
11:50:21.147 [qtp825025857-25] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=6
11:50:21.194 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d transaction.localRevision=87 remoteFromLocalRevision=6
11:50:21.227 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
11:50:21.350 [main] INFO c.c.c.l.LocalRepoManagerImpl - [36e409e0]getCloseDeferredMillis: closeDeferredMillis=0
11:50:21.351 [main] INFO c.c.c.l.LocalRepoManagerImpl - [36e409e0]close: Closing real LocalRepoManager immediately.
11:50:21.351 [main] INFO c.c.c.l.LocalRepoManagerImpl - [36e409e0]_close: Shutting down real LocalRepoManager.
11:50:21.383 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="c14c8520-e999-4293-b344-7756ecd76971"] on repo=fcd6b239-1b8f-4197-9250-1175fe780b35
11:50:21.411 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 41.36%
11:50:21.414 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 46.95%
11:50:21.461 [qtp656152832-29] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c14c8520-e999-4293-b344-7756ecd76971 remoteRepositoryId=fcd6b239-1b8f-4197-9250-1175fe780b35 localRepositoryRevisionSynced=3
11:50:21.474 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fcd6b239-1b8f-4197-9250-1175fe780b35 remoteRepositoryId=c14c8520-e999-4293-b344-7756ecd76971 transaction.localRevision=10 remoteFromLocalRevision=3
11:50:21.477 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=fcd6b239-1b8f-4197-9250-1175fe780b35 from='target/repo/k0kst7ri-oe6lr-local' toID=c14c8520-e999-4293-b344-7756ecd76971 to='https://localhost:41947/c14c8520-e999-4293-b344-7756ecd76971'
11:50:21.664 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:21.666 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: fcd6b239-1b8f-4197-9250-1175fe780b35
11:50:21.666 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: c14c8520-e999-4293-b344-7756ecd76971
11:50:21.666 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:21.667 [pool-34-thread-3] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=fcd6b239-1b8f-4197-9250-1175fe780b35 remoteRepositoryId=c14c8520-e999-4293-b344-7756ecd76971 localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=10
11:50:21.678 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:21.714 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:21.715 [pool-34-thread-3] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:21.715 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:21.715 [pool-34-thread-3] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:21.716 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 52.24%
11:50:21.717 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
11:50:21.764 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 61.19%
11:50:21.766 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 70.15%
11:50:21.783 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=fcd6b239-1b8f-4197-9250-1175fe780b35 remoteRepositoryId=c14c8520-e999-4293-b344-7756ecd76971 localRepositoryRevisionSynced=10
11:50:21.821 [qtp656152832-25] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=c14c8520-e999-4293-b344-7756ecd76971 remoteRepositoryId=fcd6b239-1b8f-4197-9250-1175fe780b35 transaction.localRevision=7 remoteFromLocalRevision=10
11:50:21.830 [pool-34-thread-3] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=c14c8520-e999-4293-b344-7756ecd76971 from='https://localhost:41947/c14c8520-e999-4293-b344-7756ecd76971' toID=fcd6b239-1b8f-4197-9250-1175fe780b35 to='target/repo/k0kst7ri-oe6lr-local', fromRepoLocalSync=false
11:50:21.830 [pool-34-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst7ri-oe6lr-local/.cloudstore-repo/tmp/ChangeSetDto.c14c8520-e999-4293-b344-7756ecd76971.null.xml.gz
11:50:21.890 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:21.894 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: c14c8520-e999-4293-b344-7756ecd76971
11:50:21.894 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: fcd6b239-1b8f-4197-9250-1175fe780b35
11:50:21.894 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:21.894 [pool-5-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=c14c8520-e999-4293-b344-7756ecd76971 remoteRepositoryId=fcd6b239-1b8f-4197-9250-1175fe780b35 localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=7
11:50:21.896 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:21.898 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:21.898 [pool-5-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:21.898 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:21.898 [pool-5-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:21.904 [pool-34-thread-3] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst7ri-oe6lr-local/.cloudstore-repo/tmp/ChangeSetDto.c14c8520-e999-4293-b344-7756ecd76971.null.xml.gz
11:50:21.904 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 77.11%
11:50:21.904 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 88.31%
11:50:21.904 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 99.50%
11:50:21.929 [qtp656152832-27] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=c14c8520-e999-4293-b344-7756ecd76971 remoteRepositoryId=fcd6b239-1b8f-4197-9250-1175fe780b35 localRepositoryRevisionSynced=7
11:50:21.991 [pool-34-thread-3] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fcd6b239-1b8f-4197-9250-1175fe780b35 remoteRepositoryId=c14c8520-e999-4293-b344-7756ecd76971 transaction.localRevision=13 remoteFromLocalRevision=7
11:50:22.062 [pool-34-thread-3] INFO c.c.c.t.SyncAbortIT - Synchronising...: 100.00%
hasCorrectAmountOfCreationsDeletions: toBeCreated=2, chunksCreated=2, toBeDeleted=2, chunksDeleted=2
11:50:22.586 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4057babc]getCloseDeferredMillis: closeDeferredMillis=20000
11:50:22.586 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4057babc]close: Deferring shut down of real LocalRepoManager 20000 ms.
11:50:22.586 [main] INFO c.c.c.l.LocalRepoManagerImpl - [dd3d0a6]getCloseDeferredMillis: closeDeferredMillis=20000
11:50:22.586 [main] INFO c.c.c.l.LocalRepoManagerImpl - [dd3d0a6]close: Deferring shut down of real LocalRepoManager 20000 ms.
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 316.475 sec - in co.codewizards.cloudstore.test.SyncAbortIT
11:50:22.867 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@a2280bd{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
11:50:22.868 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:50:22.873 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@6202305b{/,null,UNAVAILABLE}
11:50:22.883 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/BCrATPAugEMuVM-kH23Nhw/.cloudstore/localServerRunning.deleteToStop
11:50:22.904 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@32986b15{SSL,[ssl, http/1.1]}{0.0.0.0:41947}
11:50:22.905 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:50:22.907 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@20777538{/,null,UNAVAILABLE}
11:50:22.970 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4b99f2ed]initPersistenceManagerFactory: repositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:22.973 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4b99f2ed]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 5326 ms.
localRoot: k0kstkpx-ij9hn-local
localRepositoryId: 927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:22.995 [main] INFO c.c.c.l.LocalRepoManagerImpl - [3e2ee637]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kstkpx-ota80-remote'
11:50:23.001 [main] INFO c.c.c.l.LocalRepoManagerImpl - [3e2ee637]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kstkpx-ota80-remote' locked successfully.
11:50:23.329 [main] INFO c.c.c.l.LocalRepoManagerImpl - [3a80c534]getCloseDeferredMillis: closeDeferredMillis=0
11:50:23.329 [main] INFO c.c.c.l.LocalRepoManagerImpl - [3a80c534]close: Closing real LocalRepoManager immediately.
11:50:23.329 [main] INFO c.c.c.l.LocalRepoManagerImpl - [3a80c534]_close: Shutting down real LocalRepoManager.
11:50:25.014 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
11:50:25.015 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Creating backup: 'target/repo/k0kst3ok-1ordx-remote' => 'target/repo/k0kst3ok-1ordx-remote.bak'
11:50:25.081 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Created backup: 'target/repo/k0kst3ok-1ordx-remote' => 'target/repo/k0kst3ok-1ordx-remote.bak'
11:50:25.081 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
11:50:25.082 [main] INFO c.c.c.l.LocalRepoManagerImpl - [f833223]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local'
11:50:25.083 [main] INFO c.c.c.l.LocalRepoManagerImpl - [f833223]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local' locked successfully.
11:50:25.862 [main] INFO c.c.c.l.LocalRepoManagerImpl - [f833223]initPersistenceManagerFactory: repositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:25.863 [main] INFO c.c.c.l.LocalRepoManagerImpl - [f833223]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 780 ms.
11:50:26.075 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [15d5ca04]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:26.076 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [15d5ca04]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:26.641 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [15d5ca04]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:26.641 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [15d5ca04]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 565 ms.
11:50:26.662 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [15d5ca04]getCloseDeferredMillis: closeDeferredMillis=0
11:50:26.662 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [15d5ca04]close: Closing real LocalRepoManager immediately.
11:50:26.662 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [15d5ca04]_close: Shutting down real LocalRepoManager.
11:50:27.168 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 0.50%
11:50:27.170 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d from='https://localhost:41270/8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d' toID=fb55a063-cc06-4c5d-a8ae-d420a15356c4 to='target/repo/k0kst3oj-f6niz-local', fromRepoLocalSync=true
11:50:27.170 [pool-8-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing fb55a063-cc06-4c5d-a8ae-d420a15356c4 ('target/repo/k0kst3oj-f6niz-local')
11:50:27.224 [pool-8-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 12.94%
11:50:27.292 [pool-8-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 19.03%
11:50:27.368 [pool-8-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 24.15%
11:50:27.501 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.6.xml.gz
11:50:27.525 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [7326dae]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:27.525 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [7326dae]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:28.275 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [7326dae]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:28.276 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [7326dae]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 749 ms.
11:50:28.334 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [7326dae]getCloseDeferredMillis: closeDeferredMillis=0
11:50:28.334 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [7326dae]close: Closing real LocalRepoManager immediately.
11:50:28.334 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [7326dae]_close: Shutting down real LocalRepoManager.
11:50:28.789 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 serverRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d renewalDateTime=2019-09-15T10:20:15.334Z expiryDateTime=2019-09-15T10:50:15.334Z
11:50:28.827 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [4781c8db]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:28.827 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [4781c8db]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:28.937 [main] INFO c.c.c.l.LocalRepoManagerImpl - [3e2ee637]initPersistenceManagerFactory: repositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec
11:50:28.942 [main] INFO c.c.c.l.LocalRepoManagerImpl - [3e2ee637]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 3132 ms.
remoteRoot: k0kstkpx-ota80-remote
remoteRepositoryId: ba5485df-ef35-4ba0-9086-46e774f7c0ec
11:50:29.536 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [4781c8db]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:29.537 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [4781c8db]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 710 ms.
11:50:29.584 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [4781c8db]getCloseDeferredMillis: closeDeferredMillis=0
11:50:29.584 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [4781c8db]close: Closing real LocalRepoManager immediately.
11:50:29.584 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [4781c8db]_close: Shutting down real LocalRepoManager.
11:50:29.583 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=434.5 MiB, used=49.5 MiB, available=3.4 GiB
Successfully requested to connect the following local and remote repositories:
localRepository.repositoryId = 927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kstkpx-ij9hn-local
localRepository.publicKeySha1 = D6:AB:81:2E:27:47:CB:7F:65:08:A1:EB:FF:3D:28:73:93:A5:90:CA
remoteRepository.repositoryId = ba5485df-ef35-4ba0-9086-46e774f7c0ec
remoteRepository.remoteRoot = https://localhost:37358/ba5485df-ef35-4ba0-9086-46e774f7c0ec
remoteRepository.publicKeySha1 = EE:65:EA:85:7E:F5:3E:EC:57:4D:6B:8E:96:29:80:21:AD:2E:DD:DE
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 927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd ba5485df-ef35-4ba0-9086-46e774f7c0ec
11:50:30.001 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2995286d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:30.002 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2995286d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:30.283 [main] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=3.5 GiB, allocated=435.0 MiB, used=42.6 MiB, available=3.4 GiB
Successfully accepted the connection request for the following local and remote repositories:
localRepository.repositoryId = ba5485df-ef35-4ba0-9086-46e774f7c0ec
localRepository.localRoot = /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kstkpx-ota80-remote
localRepository.publicKeySha1 = EE:65:EA:85:7E:F5:3E:EC:57:4D:6B:8E:96:29:80:21:AD:2E:DD:DE
remoteRepository.repositoryId = 927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
remoteRepository.publicKeySha1 = D6:AB:81:2E:27:47:CB:7F:65:08:A1:EB:FF:3D:28:73:93:A5:90:CA
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 ba5485df-ef35-4ba0-9086-46e774f7c0ec 927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:30.650 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2995286d]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:30.651 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2995286d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 648 ms.
11:50:30.676 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
11:50:30.687 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
11:50:30.706 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
11:50:30.729 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
11:50:30.736 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
11:50:30.751 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
11:50:30.775 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
11:50:30.801 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
11:50:30.840 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:30.844 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:30.845 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:30.845 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:30.845 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=6 localRepositoryRevisionInProgress=8
11:50:30.851 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:30.858 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:30.858 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:30.858 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:30.858 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:30.858 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2995286d]getCloseDeferredMillis: closeDeferredMillis=0
11:50:30.858 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2995286d]close: Closing real LocalRepoManager immediately.
11:50:30.858 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [2995286d]_close: Shutting down real LocalRepoManager.
11:50:31.216 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 0.50%
11:50:31.217 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=ba5485df-ef35-4ba0-9086-46e774f7c0ec from='https://localhost:37358/ba5485df-ef35-4ba0-9086-46e774f7c0ec' toID=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd to='target/repo/k0kstkpx-ij9hn-local', fromRepoLocalSync=true
11:50:31.217 [pool-9-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing 927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd ('target/repo/k0kstkpx-ij9hn-local')
11:50:31.253 [pool-9-thread-1] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 12.94%
11:50:31.262 [pool-9-thread-1] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 25.12%
11:50:31.267 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kstkpx-ij9hn-local/.cloudstore-repo/tmp/ChangeSetDto.ba5485df-ef35-4ba0-9086-46e774f7c0ec.-1.xml.gz
11:50:31.280 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.6.xml.gz
11:50:31.281 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
11:50:31.281 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
11:50:31.300 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [4b85f0a2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:31.300 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [4b85f0a2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:31.338 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd serverRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec renewalDateTime=2019-09-15T10:20:31.288Z expiryDateTime=2019-09-15T10:50:31.288Z
11:50:31.352 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
11:50:31.367 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
11:50:31.394 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.01%
11:50:31.489 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.60%
11:50:31.507 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.40%
11:50:31.565 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.20%
11:50:31.643 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.00%
11:50:31.708 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
11:50:31.746 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:31.750 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ba5485df-ef35-4ba0-9086-46e774f7c0ec
11:50:31.750 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:31.750 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:31.750 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec remoteRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=3
11:50:31.758 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:31.801 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:31.801 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:31.801 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:31.801 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:31.832 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kstkpx-ij9hn-local/.cloudstore-repo/tmp/ChangeSetDto.ba5485df-ef35-4ba0-9086-46e774f7c0ec.-1.xml.gz
11:50:31.833 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path=''
11:50:31.872 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/#4'
11:50:31.890 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/1 {11 11ä11#+} 1'
11:50:31.902 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 30.33%
11:50:31.902 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2'
11:50:31.910 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [4b85f0a2]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:31.910 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [4b85f0a2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 609 ms.
11:50:31.915 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/2/1 {11 11ä11#+} 1'
11:50:31.931 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
11:50:31.941 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [4b85f0a2]getCloseDeferredMillis: closeDeferredMillis=0
11:50:31.941 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [4b85f0a2]close: Closing real LocalRepoManager immediately.
11:50:31.941 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [4b85f0a2]_close: Shutting down real LocalRepoManager.
11:50:31.943 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/5#'
11:50:31.966 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 35.59%
11:50:31.966 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 40.86%
11:50:31.967 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/#b'
11:50:32.024 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='d468b804aeadb64317e8ce35a4ecee16ad5e682c' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/#b
11:50:32.074 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.077 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/#b'
11:50:32.115 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 89562 bytes in 38 ms. path='/#4/#b'
11:50:32.122 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_c691e3d4c979adbf07e3b97e33fdf3c89ed246f6_0 into destFile #b
11:50:32.173 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=1, fromRepositoryId="FileInProgressMarker", toRepositoryId="1", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.185 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/a'
11:50:32.240 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='049f54402a245f6ef38398942bfaf8ab02737996' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/a
11:50:32.268 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.274 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/a'
11:50:32.363 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 252025 bytes in 89 ms. path='/#4/a'
11:50:32.370 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:50:32.396 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [2257ab12]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:32.396 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [2257ab12]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:32.401 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=2, fromRepositoryId="FileInProgressMarker", toRepositoryId="2", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.405 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/c+'
11:50:32.445 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='f1beb57d3a759efce8d75612de3beb46dd149345' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/c+
11:50:32.461 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.464 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/c+'
11:50:32.557 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 467930 bytes in 93 ms. path='/#4/c+'
11:50:32.563 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_8a30244b83c6cac3c79f8f95d30f96579c0f4c0b_0 into destFile c+
11:50:32.629 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=3, fromRepositoryId="FileInProgressMarker", toRepositoryId="3", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.635 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/#4/d$'
11:50:32.671 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='ce579b0b82f637c249d8ccfa20ac03795ab76ed8' to.sha1='<NoInstanceOf_NormalFileDto>'): /#4/d$
11:50:32.693 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.695 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/#4/d$'
11:50:32.722 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 1635 bytes in 27 ms. path='/#4/d$'
11:50:32.729 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_a93a212f7eca012dceb852f364cc2c34026f0dd8_0 into destFile d$
11:50:32.743 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=4, fromRepositoryId="FileInProgressMarker", toRepositoryId="4", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.747 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/a'
11:50:32.790 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='31d6145688c1fb988eb75014e21df19d503d78c5' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/a
11:50:32.817 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.820 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/1 {11 11ä11#+} 1/a'
11:50:32.887 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 242282 bytes in 66 ms. path='/1 {11 11ä11#+} 1/a'
11:50:32.894 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:50:32.923 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=5, fromRepositoryId="FileInProgressMarker", toRepositoryId="5", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.931 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/b'
11:50:32.969 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='7f1a90c0bf4d8b009841e012712b11cfb395ddd1' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/b
11:50:32.991 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:32.993 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/1 {11 11ä11#+} 1/b'
11:50:33.038 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [2257ab12]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:33.039 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [2257ab12]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 642 ms.
11:50:33.043 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 125504 bytes in 50 ms. path='/1 {11 11ä11#+} 1/b'
11:50:33.049 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
11:50:33.066 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=6, fromRepositoryId="FileInProgressMarker", toRepositoryId="6", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:33.072 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/1 {11 11ä11#+} 1/c'
11:50:33.107 [qtp825025857-25] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=8
11:50:33.109 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [2257ab12]getCloseDeferredMillis: closeDeferredMillis=0
11:50:33.109 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [2257ab12]close: Closing real LocalRepoManager immediately.
11:50:33.109 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [2257ab12]_close: Shutting down real LocalRepoManager.
11:50:33.113 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='f69e4a1aa919580061d169e375ae44ea84e85ded' to.sha1='<NoInstanceOf_NormalFileDto>'): /1 {11 11ä11#+} 1/c
11:50:33.141 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:33.154 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/1 {11 11ä11#+} 1/c'
11:50:33.248 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 460636 bytes in 94 ms. path='/1 {11 11ä11#+} 1/c'
11:50:33.254 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
11:50:33.286 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=7, fromRepositoryId="FileInProgressMarker", toRepositoryId="7", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:33.290 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/a'
11:50:33.336 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='a43ecb0b527dbf65810b64fce19e53fa4bb9801d' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/a
11:50:33.368 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:33.382 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/1 {11 11ä11#+} 1/a'
11:50:33.481 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 240108 bytes in 98 ms. path='/2/1 {11 11ä11#+} 1/a'
11:50:33.491 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:50:33.517 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=8, fromRepositoryId="FileInProgressMarker", toRepositoryId="8", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:33.522 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/1 {11 11ä11#+} 1/b'
11:50:33.542 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d transaction.localRevision=89 remoteFromLocalRevision=8
11:50:33.545 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=fb55a063-cc06-4c5d-a8ae-d420a15356c4 from='target/repo/k0kst3oj-f6niz-local' toID=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d to='https://localhost:41270/8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d'
11:50:33.561 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [63700624]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:33.561 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [63700624]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:33.563 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='e4864a04b7a2b0d62da30b8b98bae9cfacc2eb55' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/1 {11 11ä11#+} 1/b
11:50:33.583 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:33.585 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/1 {11 11ä11#+} 1/b'
11:50:33.701 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 728688 bytes in 116 ms. path='/2/1 {11 11ä11#+} 1/b'
11:50:33.708 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
11:50:33.750 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=9, fromRepositoryId="FileInProgressMarker", toRepositoryId="9", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:33.758 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/2/a'
11:50:33.810 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='5637511b49750cf27abe268a17fb8f4f179cadb3' to.sha1='<NoInstanceOf_NormalFileDto>'): /2/a
11:50:33.832 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:33.833 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/2/a'
11:50:34.006 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 799564 bytes in 173 ms. path='/2/a'
11:50:34.014 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:50:34.069 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=10, fromRepositoryId="FileInProgressMarker", toRepositoryId="10", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:34.074 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/a'
11:50:34.117 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='500aacf5f073c20fbcaedf0cbf9a5cb2f39ecaa1' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/a
11:50:34.135 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:34.138 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/a'
11:50:34.246 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 429364 bytes in 108 ms. path='/3/a'
11:50:34.254 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_86f7e437faa5a7fce15d1ddcb9eaeaea377667b8_0 into destFile a
11:50:34.285 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [63700624]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:34.286 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [63700624]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 725 ms.
11:50:34.293 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=11, fromRepositoryId="FileInProgressMarker", toRepositoryId="11", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:34.298 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/b'
11:50:34.323 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [63700624]getCloseDeferredMillis: closeDeferredMillis=0
11:50:34.323 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [63700624]close: Closing real LocalRepoManager immediately.
11:50:34.323 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [63700624]_close: Shutting down real LocalRepoManager.
11:50:34.335 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='accac5f2313c3fdcd6519a8ce675c572dd5c00bd' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/b
11:50:34.357 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:34.359 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/b'
11:50:34.383 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 850 bytes in 23 ms. path='/3/b'
11:50:34.398 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_e9d71f5ee7c92d6dc9e92ffdad17b8bd49418f98_0 into destFile b
11:50:34.412 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=12, fromRepositoryId="FileInProgressMarker", toRepositoryId="12", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:34.417 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/c'
11:50:34.461 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='0e58dfa6f10074d979b634f8b6295c5a2bdc27ed' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/c
11:50:34.478 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:34.480 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/c'
11:50:34.531 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 179696 bytes in 51 ms. path='/3/c'
11:50:34.537 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_84a516841ba77a5b4648de2cd0dfcb30ea46dbb4_0 into destFile c
11:50:34.558 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=13, fromRepositoryId="FileInProgressMarker", toRepositoryId="13", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:34.562 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/d'
11:50:34.563 [closeDeferredTimer-1e3dc24f-1] INFO c.c.c.l.LocalRepoManagerImpl - [1e3dc24f]_close: Shutting down real LocalRepoManager.
11:50:34.711 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [35500822]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:34.712 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [35500822]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:34.564 [closeDeferredTimer-4e3ee457-1] INFO c.c.c.l.LocalRepoManagerImpl - [4e3ee457]_close: Shutting down real LocalRepoManager.
11:50:35.455 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [35500822]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:35.456 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [35500822]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 744 ms.
11:50:35.487 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [35500822]getCloseDeferredMillis: closeDeferredMillis=0
11:50:35.488 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [35500822]close: Closing real LocalRepoManager immediately.
11:50:35.488 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [35500822]_close: Shutting down real LocalRepoManager.
11:50:35.712 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='7ba398a81c17d069478186a2443958dbbf934d63' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/d
11:50:35.780 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:35.825 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/d'
11:50:35.893 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 111207 bytes in 68 ms. path='/3/d'
11:50:35.901 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_3c363836cf4e16666669a25da280a1865c2d2874_0 into destFile d
11:50:36.005 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=14, fromRepositoryId="FileInProgressMarker", toRepositoryId="14", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:36.062 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/5#/e'
11:50:36.097 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='f87bb478bf2cc3be06fa2bff22ca44b8bd051f49' to.sha1='<NoInstanceOf_NormalFileDto>'): /5#/e
11:50:36.133 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:36.155 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/5#/e'
11:50:36.224 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 258196 bytes in 69 ms. path='/5#/e'
11:50:36.229 [main] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_58e6b3a414a1e090dfc6029add0f3555ccba127f_0 into destFile e
11:50:36.263 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:36.266 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:36.266 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:36.266 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:36.266 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=89
11:50:36.270 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=15, fromRepositoryId="FileInProgressMarker", toRepositoryId="15", path="ba5485df-ef35-4ba0-9086-46e774f7c0ec"] on repo=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:36.275 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:36.279 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 49.42%
11:50:36.307 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:36.308 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:36.308 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:36.308 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:36.308 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 52.24%
11:50:36.309 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
11:50:36.342 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [70f111fb]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:36.343 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [70f111fb]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:36.346 [qtp366353178-25] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec remoteRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd localRepositoryRevisionSynced=3
11:50:36.394 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd remoteRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec transaction.localRevision=84 remoteFromLocalRevision=3
11:50:36.419 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd from='target/repo/k0kstkpx-ij9hn-local' toID=ba5485df-ef35-4ba0-9086-46e774f7c0ec to='https://localhost:37358/ba5485df-ef35-4ba0-9086-46e774f7c0ec'
11:50:36.541 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:36.546 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:36.546 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: ba5485df-ef35-4ba0-9086-46e774f7c0ec
11:50:36.546 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:36.547 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd remoteRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec localRepositoryRevisionSynced=-1 localRepositoryRevisionInProgress=84
11:50:36.557 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:36.563 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:36.563 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:36.563 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:36.563 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:36.564 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 63.43%
11:50:36.564 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 74.63%
11:50:36.578 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd remoteRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec localRepositoryRevisionSynced=84
11:50:36.715 [qtp366353178-29] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec remoteRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd transaction.localRevision=6 remoteFromLocalRevision=84
11:50:36.745 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=ba5485df-ef35-4ba0-9086-46e774f7c0ec from='https://localhost:37358/ba5485df-ef35-4ba0-9086-46e774f7c0ec' toID=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd to='target/repo/k0kstkpx-ij9hn-local', fromRepoLocalSync=false
11:50:36.747 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kstkpx-ij9hn-local/.cloudstore-repo/tmp/ChangeSetDto.ba5485df-ef35-4ba0-9086-46e774f7c0ec.null.xml.gz
11:50:36.796 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:36.799 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: ba5485df-ef35-4ba0-9086-46e774f7c0ec
11:50:36.799 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd
11:50:36.799 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:36.799 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec remoteRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd localRepositoryRevisionSynced=3 localRepositoryRevisionInProgress=6
11:50:36.801 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:36.802 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:36.803 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:36.803 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:36.803 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:36.814 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kstkpx-ij9hn-local/.cloudstore-repo/tmp/ChangeSetDto.ba5485df-ef35-4ba0-9086-46e774f7c0ec.null.xml.gz
11:50:36.814 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 88.31%
11:50:36.814 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 99.50%
11:50:36.843 [qtp366353178-176] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec remoteRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd localRepositoryRevisionSynced=6
11:50:36.862 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=927c3968-f6cb-4a3d-8cfc-2a7bc39bd1fd remoteRepositoryId=ba5485df-ef35-4ba0-9086-46e774f7c0ec transaction.localRevision=87 remoteFromLocalRevision=6
11:50:36.879 [main] INFO c.c.c.t.r.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%
11:50:37.005 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4b99f2ed]getCloseDeferredMillis: closeDeferredMillis=20000
11:50:37.005 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4b99f2ed]close: Deferring shut down of real LocalRepoManager 20000 ms.
11:50:37.006 [main] INFO c.c.c.l.LocalRepoManagerImpl - [3e2ee637]getCloseDeferredMillis: closeDeferredMillis=20000
11:50:37.006 [main] INFO c.c.c.l.LocalRepoManagerImpl - [3e2ee637]close: Deferring shut down of real LocalRepoManager 20000 ms.
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 156.846 sec - in co.codewizards.cloudstore.test.repotorepo.BasicRepoToRepoSyncIT
11:50:37.032 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@106b5e21{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
11:50:37.033 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:50:37.040 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@64a6cb68{/,null,UNAVAILABLE}
11:50:37.051 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/wDGNecdandCw0CZgA3qdHw/.cloudstore/localServerRunning.deleteToStop
11:50:37.073 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@58921570{SSL,[ssl, http/1.1]}{0.0.0.0:37358}
11:50:37.074 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:50:37.075 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@358dd70d{/,null,UNAVAILABLE}
11:50:37.142 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [70f111fb]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:37.142 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [70f111fb]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 798 ms.
11:50:37.172 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [70f111fb]getCloseDeferredMillis: closeDeferredMillis=0
11:50:37.172 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [70f111fb]close: Closing real LocalRepoManager immediately.
11:50:37.172 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [70f111fb]_close: Shutting down real LocalRepoManager.
11:50:37.529 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [4d6c1f98]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:37.529 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [4d6c1f98]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:38.111 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [4d6c1f98]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:38.112 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [4d6c1f98]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 582 ms.
11:50:38.485 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [4d6c1f98]getCloseDeferredMillis: closeDeferredMillis=0
11:50:38.486 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [4d6c1f98]close: Closing real LocalRepoManager immediately.
11:50:38.486 [qtp825025857-24] INFO c.c.c.l.LocalRepoManagerImpl - [4d6c1f98]_close: Shutting down real LocalRepoManager.
11:50:38.890 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 58.34%
11:50:38.897 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 64.45%
11:50:38.897 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 70.56%
11:50:38.898 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
11:50:38.929 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [116ec443]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:38.929 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [116ec443]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:39.475 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [116ec443]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:39.476 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [116ec443]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 547 ms.
11:50:39.501 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [116ec443]getCloseDeferredMillis: closeDeferredMillis=0
11:50:39.501 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [116ec443]close: Closing real LocalRepoManager immediately.
11:50:39.501 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [116ec443]_close: Shutting down real LocalRepoManager.
11:50:39.852 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23ab7c41]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0ksu463-1ntfc'
11:50:39.874 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23ab7c41]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0ksu463-1ntfc' locked successfully.
11:50:39.893 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23c59376]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:39.894 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23c59376]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:40.494 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23c59376]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:40.494 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23c59376]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 599 ms.
11:50:40.539 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23c59376]getCloseDeferredMillis: closeDeferredMillis=0
11:50:40.539 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23c59376]close: Closing real LocalRepoManager immediately.
11:50:40.539 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23c59376]_close: Shutting down real LocalRepoManager.
11:50:40.893 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='44eadb3dd82ee029d5eaf8a705566ca323857f27' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
Sep 15, 2019 11:50:40 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
11:50:40.921 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [16d0eb89]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:40.921 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [16d0eb89]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:41.549 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [16d0eb89]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:41.550 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [16d0eb89]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 628 ms.
11:50:41.579 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [16d0eb89]getCloseDeferredMillis: closeDeferredMillis=0
11:50:41.580 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [16d0eb89]close: Closing real LocalRepoManager immediately.
11:50:41.580 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [16d0eb89]_close: Shutting down real LocalRepoManager.
11:50:42.030 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [2bfb114a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:42.031 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [2bfb114a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:42.616 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [2bfb114a]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:42.616 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [2bfb114a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 585 ms.
11:50:42.778 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [2bfb114a]getCloseDeferredMillis: closeDeferredMillis=0
11:50:42.779 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [2bfb114a]close: Closing real LocalRepoManager immediately.
11:50:42.779 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [2bfb114a]_close: Shutting down real LocalRepoManager.
11:50:44.106 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="fb55a063-cc06-4c5d-a8ae-d420a15356c4"] on repo=fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:44.110 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
11:50:44.170 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [70a4be1c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:44.171 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [70a4be1c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:44.983 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [70a4be1c]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:44.984 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [70a4be1c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 812 ms.
11:50:45.028 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [70a4be1c]getCloseDeferredMillis: closeDeferredMillis=0
11:50:45.029 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [70a4be1c]close: Closing real LocalRepoManager immediately.
11:50:45.029 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [70a4be1c]_close: Shutting down real LocalRepoManager.
11:50:45.504 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [1e98e447]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:45.504 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [1e98e447]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:46.078 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [1e98e447]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:46.078 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [1e98e447]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 573 ms.
11:50:46.126 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [1e98e447]getCloseDeferredMillis: closeDeferredMillis=0
11:50:46.126 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [1e98e447]close: Closing real LocalRepoManager immediately.
11:50:46.126 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [1e98e447]_close: Shutting down real LocalRepoManager.
11:50:46.521 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 71000 bytes in 2410 ms. path='/3/zzz'
Sep 15, 2019 11:50:46 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
11:50:46.550 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [249581c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:46.550 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [249581c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:47.177 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [249581c]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:47.178 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [249581c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 627 ms.
11:50:47.209 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [249581c]getCloseDeferredMillis: closeDeferredMillis=0
11:50:47.210 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [249581c]close: Closing real LocalRepoManager immediately.
11:50:47.210 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [249581c]_close: Shutting down real LocalRepoManager.
11:50:47.633 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5f978801]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:47.634 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5f978801]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:48.478 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5f978801]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:48.479 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5f978801]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 845 ms.
11:50:48.540 [qtp825025857-64] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
11:50:48.621 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5f978801]getCloseDeferredMillis: closeDeferredMillis=0
11:50:48.621 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5f978801]close: Closing real LocalRepoManager immediately.
11:50:48.621 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5f978801]_close: Shutting down real LocalRepoManager.
11:50:48.995 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=16, fromRepositoryId="FileInProgressMarker", toRepositoryId="16", path="fb55a063-cc06-4c5d-a8ae-d420a15356c4"] on repo=fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:49.007 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
11:50:49.027 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d localRepositoryRevisionSynced=89
11:50:49.051 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [69ffc99d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:49.052 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [69ffc99d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:49.759 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [69ffc99d]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:49.760 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [69ffc99d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 708 ms.
11:50:49.793 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [69ffc99d]getCloseDeferredMillis: closeDeferredMillis=0
11:50:49.793 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [69ffc99d]close: Closing real LocalRepoManager immediately.
11:50:49.793 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [69ffc99d]_close: Shutting down real LocalRepoManager.
11:50:50.192 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [10daffb1]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:50.192 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [10daffb1]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:50.756 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [10daffb1]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:50.757 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [10daffb1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 564 ms.
11:50:50.804 [qtp825025857-28] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 transaction.localRevision=15 remoteFromLocalRevision=89
11:50:50.806 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [10daffb1]getCloseDeferredMillis: closeDeferredMillis=0
11:50:50.806 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [10daffb1]close: Closing real LocalRepoManager immediately.
11:50:50.806 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [10daffb1]_close: Shutting down real LocalRepoManager.
11:50:51.063 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23ab7c41]initPersistenceManagerFactory: repositoryId=140d1a7f-7f7a-4bf5-8b29-c1a48b25764b
11:50:51.071 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23ab7c41]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 6954 ms.
11:50:51.237 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d from='https://localhost:41270/8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d' toID=fb55a063-cc06-4c5d-a8ae-d420a15356c4 to='target/repo/k0kst3oj-f6niz-local', fromRepoLocalSync=false
11:50:51.238 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.null.xml.gz
11:50:51.257 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4e7626bd]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:51.257 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4e7626bd]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:51.415 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23ab7c41]getCloseDeferredMillis: closeDeferredMillis=20000
11:50:51.415 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [23ab7c41]close: Deferring shut down of real LocalRepoManager 20000 ms.
11:50:51.964 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4e7626bd]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:51.964 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4e7626bd]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 706 ms.
11:50:51.998 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4e7626bd]getCloseDeferredMillis: closeDeferredMillis=0
11:50:51.999 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4e7626bd]close: Closing real LocalRepoManager immediately.
11:50:51.999 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4e7626bd]_close: Shutting down real LocalRepoManager.
11:50:52.316 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5dd8215]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:52.316 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5dd8215]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:52.862 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5dd8215]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:52.863 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5dd8215]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 546 ms.
11:50:52.989 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:50:52.995 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:52.995 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:52.996 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:50:52.996 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
11:50:53.003 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:50:53.010 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:50:53.011 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:50:53.011 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:50:53.011 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:50:53.011 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5dd8215]getCloseDeferredMillis: closeDeferredMillis=0
11:50:53.011 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5dd8215]close: Closing real LocalRepoManager immediately.
11:50:53.011 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [5dd8215]_close: Shutting down real LocalRepoManager.
11:50:53.321 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.null.xml.gz
11:50:53.322 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
11:50:53.322 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
11:50:53.344 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [1aa777f0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:53.345 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [1aa777f0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:53.949 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [1aa777f0]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:53.949 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [1aa777f0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 604 ms.
11:50:53.984 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [1aa777f0]getCloseDeferredMillis: closeDeferredMillis=0
11:50:53.985 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [1aa777f0]close: Closing real LocalRepoManager immediately.
11:50:53.985 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [1aa777f0]_close: Shutting down real LocalRepoManager.
11:50:54.306 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4918c60b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:54.307 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4918c60b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 346.155 sec - in co.codewizards.cloudstore.test.LocalServerClientIT
11:50:54.813 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@50a27885{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
11:50:54.816 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:50:54.826 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@40c5fe71{/,null,UNAVAILABLE}
11:50:54.836 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/0TnnKprpYcwZqa7ReqObgw/.cloudstore/localServerRunning.deleteToStop
11:50:54.842 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@69407147{SSL,[ssl, http/1.1]}{0.0.0.0:37992}
11:50:54.844 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:50:54.848 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@18ff4248{/,null,UNAVAILABLE}
11:50:54.902 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4918c60b]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:54.903 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4918c60b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 596 ms.
11:50:54.965 [qtp825025857-28] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=15
11:50:54.967 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4918c60b]getCloseDeferredMillis: closeDeferredMillis=0
11:50:54.967 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4918c60b]close: Closing real LocalRepoManager immediately.
11:50:54.968 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4918c60b]_close: Shutting down real LocalRepoManager.
11:50:55.278 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d transaction.localRevision=94 remoteFromLocalRevision=15
11:50:55.280 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
11:50:55.280 [main] INFO c.c.c.l.LocalRepoManagerImpl - [f833223]getCloseDeferredMillis: closeDeferredMillis=0
11:50:55.280 [main] INFO c.c.c.l.LocalRepoManagerImpl - [f833223]close: Closing real LocalRepoManager immediately.
11:50:55.280 [main] INFO c.c.c.l.LocalRepoManagerImpl - [f833223]_close: Shutting down real LocalRepoManager.
11:50:55.880 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
11:50:55.881 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restoring backup: 'target/repo/k0kst3ok-1ordx-remote.bak' => 'target/repo/k0kst3ok-1ordx-remote'
11:50:55.939 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Restored backup: 'target/repo/k0kst3ok-1ordx-remote.bak' => 'target/repo/k0kst3ok-1ordx-remote'
11:50:55.939 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - ************************************************************************************
11:50:55.940 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4a490518]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local'
11:50:55.941 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4a490518]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local' locked successfully.
11:50:56.506 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4a490518]initPersistenceManagerFactory: repositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:50:56.506 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4a490518]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 565 ms.
11:50:56.689 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [3fb48165]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:56.690 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [3fb48165]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:57.385 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [3fb48165]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:57.385 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [3fb48165]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 695 ms.
11:50:57.402 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [3fb48165]getCloseDeferredMillis: closeDeferredMillis=0
11:50:57.402 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [3fb48165]close: Closing real LocalRepoManager immediately.
11:50:57.402 [qtp825025857-25] INFO c.c.c.l.LocalRepoManagerImpl - [3fb48165]_close: Shutting down real LocalRepoManager.
11:50:57.833 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 0.50%
11:50:57.833 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d from='https://localhost:41270/8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d' toID=fb55a063-cc06-4c5d-a8ae-d420a15356c4 to='target/repo/k0kst3oj-f6niz-local', fromRepoLocalSync=true
11:50:57.834 [pool-9-thread-1] INFO c.c.c.c.r.s.RepoToRepoSync - sync: locally syncing fb55a063-cc06-4c5d-a8ae-d420a15356c4 ('target/repo/k0kst3oj-f6niz-local')
11:50:57.878 [pool-9-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 12.94%
11:50:57.925 [pool-9-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 19.03%
11:50:57.969 [pool-9-thread-1] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 24.15%
11:50:58.016 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.15.xml.gz
11:50:58.027 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [6c059fbc]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:58.028 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [6c059fbc]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:58.849 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [6c059fbc]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:58.850 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [6c059fbc]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 822 ms.
11:50:58.888 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [6c059fbc]getCloseDeferredMillis: closeDeferredMillis=0
11:50:58.888 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [6c059fbc]close: Closing real LocalRepoManager immediately.
11:50:58.888 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [6c059fbc]_close: Shutting down real LocalRepoManager.
11:50:59.231 [main] INFO c.c.c.r.c.t.RestRepoTransport - getAuthToken: got new AuthToken: clientRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 serverRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d renewalDateTime=2019-09-15T10:20:15.334Z expiryDateTime=2019-09-15T10:50:15.334Z
11:50:59.252 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [264af1d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:50:59.252 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [264af1d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:50:59.840 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [264af1d]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:50:59.841 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [264af1d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 588 ms.
11:50:59.881 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [264af1d]getCloseDeferredMillis: closeDeferredMillis=0
11:50:59.881 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [264af1d]close: Closing real LocalRepoManager immediately.
11:50:59.881 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [264af1d]_close: Shutting down real LocalRepoManager.
11:51:00.310 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [55c88d63]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:00.310 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [55c88d63]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:00.888 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [55c88d63]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:00.889 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [55c88d63]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 578 ms.
11:51:00.909 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 1.00%
11:51:00.926 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 50.00%
11:51:00.947 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 55.72%
11:51:00.968 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 64.70%
11:51:00.975 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 74.50%
11:51:00.989 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 84.30%
11:51:01.018 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 94.10%
11:51:01.047 [pool-4-thread-1] INFO c.c.c.l.t.FileRepoTransport - Local sync...: 100.00%
11:51:01.060 [pool-4-thread-1] WARN c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=15 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=6
11:51:01.093 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:51:01.095 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:01.095 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:51:01.095 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:51:01.096 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=15 localRepositoryRevisionInProgress=8
11:51:01.103 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:51:01.111 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:51:01.111 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:51:01.111 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:51:01.112 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:51:01.112 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [55c88d63]getCloseDeferredMillis: closeDeferredMillis=0
11:51:01.112 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [55c88d63]close: Closing real LocalRepoManager immediately.
11:51:01.112 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [55c88d63]_close: Shutting down real LocalRepoManager.
11:51:01.594 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.15.xml.gz
11:51:01.594 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 38.56%
11:51:01.595 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 49.75%
11:51:01.632 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [266ee964]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:01.633 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [266ee964]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:02.176 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [266ee964]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:02.176 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [266ee964]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 542 ms.
11:51:02.202 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [266ee964]getCloseDeferredMillis: closeDeferredMillis=0
11:51:02.202 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [266ee964]close: Closing real LocalRepoManager immediately.
11:51:02.202 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [266ee964]_close: Shutting down real LocalRepoManager.
11:51:02.521 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [21674ef2]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:02.522 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [21674ef2]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:03.042 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [21674ef2]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:03.043 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [21674ef2]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 521 ms.
11:51:03.104 [qtp825025857-27] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=8
11:51:03.198 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [21674ef2]getCloseDeferredMillis: closeDeferredMillis=0
11:51:03.198 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [21674ef2]close: Closing real LocalRepoManager immediately.
11:51:03.198 [qtp825025857-27] INFO c.c.c.l.LocalRepoManagerImpl - [21674ef2]_close: Shutting down real LocalRepoManager.
11:51:03.704 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d transaction.localRevision=95 remoteFromLocalRevision=8
11:51:03.706 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncUp: fromID=fb55a063-cc06-4c5d-a8ae-d420a15356c4 from='target/repo/k0kst3oj-f6niz-local' toID=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d to='https://localhost:41270/8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d'
11:51:03.726 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [29278e2c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:03.726 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [29278e2c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:04.274 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [29278e2c]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:04.274 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [29278e2c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 547 ms.
11:51:04.295 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [29278e2c]getCloseDeferredMillis: closeDeferredMillis=0
11:51:04.295 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [29278e2c]close: Closing real LocalRepoManager immediately.
11:51:04.296 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [29278e2c]_close: Shutting down real LocalRepoManager.
11:51:04.629 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [ceafff4]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:04.629 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [ceafff4]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:05.109 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [ceafff4]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:05.110 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [ceafff4]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 480 ms.
11:51:05.134 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [ceafff4]getCloseDeferredMillis: closeDeferredMillis=0
11:51:05.134 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [ceafff4]close: Closing real LocalRepoManager immediately.
11:51:05.135 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [ceafff4]_close: Shutting down real LocalRepoManager.
11:51:05.482 [main] WARN c.c.c.l.t.ChangeSetDtoBuilder - prepareLastSyncToRemoteRepo: Enabling resyncMode! lastSyncToRemoteRepoLocalRepositoryRevisionSynced=84 overwrites lastSyncToRemoteRepo.localRepositoryRevisionSynced=89
11:51:05.494 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:51:05.497 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:51:05.497 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: 8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:05.497 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:51:05.498 [main] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d localRepositoryRevisionSynced=84 localRepositoryRevisionInProgress=95
11:51:05.506 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:51:05.552 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:51:05.552 [main] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:51:05.552 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:51:05.552 [main] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:51:05.553 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 56.31%
11:51:05.553 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDirectory: path='/3'
11:51:05.578 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [76076250]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:05.578 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [76076250]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:06.130 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [76076250]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:06.131 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [76076250]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 552 ms.
11:51:06.154 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [76076250]getCloseDeferredMillis: closeDeferredMillis=0
11:51:06.154 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [76076250]close: Closing real LocalRepoManager immediately.
11:51:06.154 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [76076250]_close: Shutting down real LocalRepoManager.
11:51:06.463 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [42e1418b]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:06.463 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [42e1418b]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:06.973 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [42e1418b]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:06.973 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [42e1418b]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 510 ms.
11:51:07.065 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [42e1418b]getCloseDeferredMillis: closeDeferredMillis=0
11:51:07.065 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [42e1418b]close: Closing real LocalRepoManager immediately.
11:51:07.065 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [42e1418b]_close: Shutting down real LocalRepoManager.
11:51:07.377 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 62.42%
11:51:07.378 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 68.52%
11:51:07.378 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncFile: path='/3/zzz'
11:51:07.419 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [262aff3c]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:07.420 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [262aff3c]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:07.976 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [262aff3c]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:07.976 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [262aff3c]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 555 ms.
11:51:07.997 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [262aff3c]getCloseDeferredMillis: closeDeferredMillis=0
11:51:07.997 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [262aff3c]close: Closing real LocalRepoManager immediately.
11:51:07.997 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [262aff3c]_close: Shutting down real LocalRepoManager.
11:51:08.382 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [4cc3fe94]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:08.384 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [4cc3fe94]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:08.852 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [4cc3fe94]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:08.852 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [4cc3fe94]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 468 ms.
11:51:08.895 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [4cc3fe94]getCloseDeferredMillis: closeDeferredMillis=0
11:51:08.895 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [4cc3fe94]close: Closing real LocalRepoManager immediately.
11:51:08.895 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [4cc3fe94]_close: Shutting down real LocalRepoManager.
11:51:09.218 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Beginning to copy file (from.sha1='44eadb3dd82ee029d5eaf8a705566ca323857f27' to.sha1='<NoInstanceOf_NormalFileDto>'): /3/zzz
Sep 15, 2019 11:51:09 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
11:51:09.244 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [52ec56cc]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:09.245 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [52ec56cc]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:09.829 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [52ec56cc]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:09.830 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [52ec56cc]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 585 ms.
11:51:09.861 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [52ec56cc]getCloseDeferredMillis: closeDeferredMillis=0
11:51:09.861 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [52ec56cc]close: Closing real LocalRepoManager immediately.
11:51:09.861 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [52ec56cc]_close: Shutting down real LocalRepoManager.
11:51:10.277 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5bd8a1b1]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:10.278 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5bd8a1b1]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:10.786 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5bd8a1b1]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:10.787 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5bd8a1b1]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 509 ms.
11:51:10.892 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5bd8a1b1]getCloseDeferredMillis: closeDeferredMillis=0
11:51:10.892 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5bd8a1b1]close: Closing real LocalRepoManager immediately.
11:51:10.892 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5bd8a1b1]_close: Shutting down real LocalRepoManager.
11:51:11.406 [main] INFO c.c.c.l.t.FileRepoTransport - Storing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="fb55a063-cc06-4c5d-a8ae-d420a15356c4"] on repo=fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:51:11.408 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Need to copy 1 dirty file-chunks (of 1 total). path='/3/zzz'
11:51:11.444 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [2e49c8c8]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:11.444 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [2e49c8c8]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:11.981 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [2e49c8c8]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:11.982 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [2e49c8c8]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 538 ms.
11:51:12.020 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [2e49c8c8]getCloseDeferredMillis: closeDeferredMillis=0
11:51:12.020 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [2e49c8c8]close: Closing real LocalRepoManager immediately.
11:51:12.020 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [2e49c8c8]_close: Shutting down real LocalRepoManager.
11:51:12.316 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5510be33]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:12.317 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5510be33]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:12.860 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5510be33]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:12.860 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5510be33]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 543 ms.
11:51:12.902 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5510be33]getCloseDeferredMillis: closeDeferredMillis=0
11:51:12.903 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5510be33]close: Closing real LocalRepoManager immediately.
11:51:12.903 [qtp825025857-93] INFO c.c.c.l.LocalRepoManagerImpl - [5510be33]_close: Shutting down real LocalRepoManager.
11:51:13.820 [main] INFO c.c.c.c.r.s.RepoToRepoSync - Copied 1 dirty file-chunks with together 71000 bytes in 2412 ms. path='/3/zzz'
Sep 15, 2019 11:51:13 AM org.glassfish.jersey.client.JerseyInvocation validateHttpMethodAndEntity
WARNING: Entity must not be null for http method PUT.
11:51:13.849 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [780abf9d]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:13.849 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [780abf9d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:14.391 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [780abf9d]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:14.392 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [780abf9d]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 543 ms.
11:51:14.415 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [780abf9d]getCloseDeferredMillis: closeDeferredMillis=0
11:51:14.416 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [780abf9d]close: Closing real LocalRepoManager immediately.
11:51:14.416 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [780abf9d]_close: Shutting down real LocalRepoManager.
11:51:14.752 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [4d8f266a]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:14.753 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [4d8f266a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:15.331 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [4d8f266a]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:15.332 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [4d8f266a]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 579 ms.
11:51:15.373 [qtp825025857-29] INFO c.c.c.l.t.FileRepoTransport - endPutFile: writing tempChunkFile chunk_40fa37ec00c761c7dbb6ebdee6d4a260b922f5f4_0 into destFile zzz
11:51:15.448 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [4d8f266a]getCloseDeferredMillis: closeDeferredMillis=0
11:51:15.449 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [4d8f266a]close: Closing real LocalRepoManager immediately.
11:51:15.449 [qtp825025857-29] INFO c.c.c.l.LocalRepoManagerImpl - [4d8f266a]_close: Shutting down real LocalRepoManager.
11:51:15.818 [main] INFO c.c.c.l.t.FileRepoTransport - Removing fileInProgressMarker: FileInProgressMarker[id=17, fromRepositoryId="FileInProgressMarker", toRepositoryId="17", path="fb55a063-cc06-4c5d-a8ae-d420a15356c4"] on repo=fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:51:15.828 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 72.59%
11:51:15.846 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d localRepositoryRevisionSynced=95
11:51:15.869 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5b93f0]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:15.870 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5b93f0]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:16.490 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5b93f0]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:16.490 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5b93f0]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 620 ms.
11:51:16.517 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5b93f0]getCloseDeferredMillis: closeDeferredMillis=0
11:51:16.517 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5b93f0]close: Closing real LocalRepoManager immediately.
11:51:16.517 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [5b93f0]_close: Shutting down real LocalRepoManager.
11:51:16.875 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [6f0b3351]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:16.875 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [6f0b3351]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:17.474 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [6f0b3351]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:17.474 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [6f0b3351]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 599 ms.
11:51:17.530 [qtp825025857-64] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 transaction.localRevision=15 remoteFromLocalRevision=95
11:51:17.542 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [6f0b3351]getCloseDeferredMillis: closeDeferredMillis=0
11:51:17.542 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [6f0b3351]close: Closing real LocalRepoManager immediately.
11:51:17.542 [qtp825025857-64] INFO c.c.c.l.LocalRepoManagerImpl - [6f0b3351]_close: Shutting down real LocalRepoManager.
11:51:17.900 [main] INFO c.c.c.c.r.s.RepoToRepoSync - syncDown: fromID=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d from='https://localhost:41270/8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d' toID=fb55a063-cc06-4c5d-a8ae-d420a15356c4 to='target/repo/k0kst3oj-f6niz-local', fromRepoLocalSync=false
11:51:17.901 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: ChangeSetDto-cache-file NOT found: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.null.xml.gz
11:51:17.920 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [218e8f04]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:17.921 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [218e8f04]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:18.870 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [218e8f04]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:18.870 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [218e8f04]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 949 ms.
11:51:18.891 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [218e8f04]getCloseDeferredMillis: closeDeferredMillis=0
11:51:18.892 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [218e8f04]close: Closing real LocalRepoManager immediately.
11:51:18.892 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [218e8f04]_close: Shutting down real LocalRepoManager.
11:51:19.218 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [499cb86]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:19.219 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [499cb86]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:19.751 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [499cb86]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:19.751 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [499cb86]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 531 ms.
11:51:19.813 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildChangeSetDto >>>
11:51:19.817 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - localRepositoryId: 8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:19.817 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - remoteRepositoryId: fb55a063-cc06-4c5d-a8ae-d420a15356c4
11:51:19.817 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - pathPrefix:
11:51:19.817 [pool-4-thread-1] INFO c.c.c.l.t.ChangeSetDtoBuilder - buildChangeSetDto: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=8 localRepositoryRevisionInProgress=15
11:51:19.822 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - toModificationDtos: Creating 0 ModificationDtos took 0 ms.
11:51:19.828 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - >>> buildConfigPropSetDto >>>
11:51:19.828 [pool-4-thread-1] DEBUG c.c.c.l.t.ChangeSetDtoBuilder - buildConfigPropSetDto: pathPrefix is empty => returning null.
11:51:19.828 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildConfigPropSetDto <<< null
11:51:19.828 [pool-4-thread-1] TRACE c.c.c.l.t.ChangeSetDtoBuilder - <<< buildChangeSetDto <<<
11:51:19.829 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [499cb86]getCloseDeferredMillis: closeDeferredMillis=0
11:51:19.829 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [499cb86]close: Closing real LocalRepoManager immediately.
11:51:19.829 [pool-4-thread-1] INFO c.c.c.l.LocalRepoManagerImpl - [499cb86]_close: Shutting down real LocalRepoManager.
11:51:20.185 [main] INFO c.c.c.r.c.t.RestRepoTransport - getChangeSetDto: Wrote ChangeSetDto-cache-file: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3oj-f6niz-local/.cloudstore-repo/tmp/ChangeSetDto.8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d.null.xml.gz
11:51:20.186 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 88.31%
11:51:20.186 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 99.50%
11:51:20.210 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [7b7f680]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:20.211 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [7b7f680]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:20.743 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [7b7f680]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:20.743 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [7b7f680]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 532 ms.
11:51:20.766 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [7b7f680]getCloseDeferredMillis: closeDeferredMillis=0
11:51:20.766 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [7b7f680]close: Closing real LocalRepoManager immediately.
11:51:20.766 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [7b7f680]_close: Shutting down real LocalRepoManager.
11:51:21.080 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4d2845db]<init>: localRoot='/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote'
11:51:21.080 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4d2845db]initLockFile: Repository '/home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/repo/k0kst3ok-1ordx-remote' locked successfully.
11:51:21.619 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4d2845db]initPersistenceManagerFactory: repositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d
11:51:21.620 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4d2845db]initPersistenceManagerFactory: Started up PersistenceManagerFactory successfully in 540 ms.
11:51:21.674 [qtp825025857-28] INFO c.c.c.l.t.FileRepoTransport - endSyncFromRepository: localRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d remoteRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 localRepositoryRevisionSynced=15
11:51:21.689 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4d2845db]getCloseDeferredMillis: closeDeferredMillis=0
11:51:21.689 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4d2845db]close: Closing real LocalRepoManager immediately.
11:51:21.689 [qtp825025857-28] INFO c.c.c.l.LocalRepoManagerImpl - [4d2845db]_close: Shutting down real LocalRepoManager.
11:51:22.007 [main] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=fb55a063-cc06-4c5d-a8ae-d420a15356c4 remoteRepositoryId=8d9cbc14-7c2e-4a65-95e9-8bc7eaa1971d transaction.localRevision=100 remoteFromLocalRevision=15
11:51:22.009 [main] INFO c.c.c.t.r.BackupRestoreRepoToRepoSyncIT - Synchronising...: 100.00%
11:51:22.074 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4a490518]getCloseDeferredMillis: closeDeferredMillis=0
11:51:22.074 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4a490518]close: Closing real LocalRepoManager immediately.
11:51:22.074 [main] INFO c.c.c.l.LocalRepoManagerImpl - [4a490518]_close: Shutting down real LocalRepoManager.
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 255.567 sec - in co.codewizards.cloudstore.test.repotorepo.BackupRestoreRepoToRepoSyncIT
11:51:22.473 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@ee09a0{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
11:51:22.474 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:51:22.481 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@274ae3{/,null,UNAVAILABLE}
11:51:22.490 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/yVBEUsagT8Bm_8yEaRzM-g/.cloudstore/localServerRunning.deleteToStop
11:51:22.497 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@7ab3534e{SSL,[ssl, http/1.1]}{0.0.0.0:41270}
11:51:22.498 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:51:22.501 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@2099adb2{/,null,UNAVAILABLE}
11:52:10.361 [main] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.SocketException: Broken pipe (Write failed)
javax.ws.rs.ProcessingException: java.net.SocketException: Broken pipe (Write failed)
at org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUrlConnector.java:184) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.ClientRuntime.invoke(ClientRuntime.java:227) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation$2.call(JerseyInvocation.java:671) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.internal.Errors.process(Errors.java:315) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.internal.Errors.process(Errors.java:297) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.internal.Errors.process(Errors.java:228) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:422) ~[jersey-common-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation.invoke(JerseyInvocation.java:667) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation$Builder.method(JerseyInvocation.java:396) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.JerseyInvocation$Builder.get(JerseyInvocation.java:296) ~[jersey-client-2.5.1.jar:na]
at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.determineBaseUrl(CloudStoreRestClient.java:115) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.getBaseUrl(CloudStoreRestClient.java:74) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.AbstractRequest.getBaseURL(AbstractRequest.java:146) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.AbstractRequest.createWebTarget(AbstractRequest.java:115) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.TestRequest.execute(TestRequest.java:27) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.request.TestRequest.execute(TestRequest.java:6) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.rest.client.CloudStoreRestClient.execute(CloudStoreRestClient.java:163) ~[co.codewizards.cloudstore.rest.client-0.10.7-SNAPSHOT.jar:na]
at co.codewizards.cloudstore.test.CertificateHandlingAndTestServiceLRT.almostTimedOut_5min(CertificateHandlingAndTestServiceLRT.java:89) [test-classes/:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_222]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_222]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_222]
at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_222]
at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) [junit-4.12.jar:4.12]
at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.12.jar:4.12]
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) [junit-4.12.jar:4.12]
at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.executeTestMethod(JUnit4TestRunnerDecorator.java:156) [jmockit-1.24.jar:na]
at mockit.integration.junit4.internal.JUnit4TestRunnerDecorator.invokeExplosively(JUnit4TestRunnerDecorator.java:65) [jmockit-1.24.jar:na]
at mockit.integration.junit4.internal.MockFrameworkMethod.invokeExplosively(MockFrameworkMethod.java:37) [jmockit-1.24.jar:na]
at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) [junit-4.12.jar:4.12]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) [junit-4.12.jar:4.12]
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) [junit-4.12.jar:4.12]
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) [junit-4.12.jar:4.12]
at org.junit.runners.ParentRunner.run(ParentRunner.java:363) [junit-4.12.jar:4.12]
at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264) [surefire-junit4-2.17.jar:2.17]
at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153) [surefire-junit4-2.17.jar:2.17]
at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124) [surefire-junit4-2.17.jar:2.17]
at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200) [surefire-booter-2.17.jar:2.17]
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153) [surefire-booter-2.17.jar:2.17]
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103) [surefire-booter-2.17.jar:2.17]
Caused by: java.net.SocketException: Broken pipe (Write failed)
at java.net.SocketOutputStream.socketWrite0(Native Method) ~[na:1.8.0_222]
at java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:111) ~[na:1.8.0_222]
at java.net.SocketOutputStream.write(SocketOutputStream.java:155) ~[na:1.8.0_222]
at sun.security.ssl.OutputRecord.writeBuffer(OutputRecord.java:431) ~[na:1.8.0_222]
at sun.security.ssl.OutputRecord.write(OutputRecord.java:417) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.writeRecordInternal(SSLSocketImpl.java:879) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:850) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:720) ~[na:1.8.0_222]
at sun.security.ssl.Handshaker.sendChangeCipherSpec(Handshaker.java:1144) ~[na:1.8.0_222]
at sun.security.ssl.ClientHandshaker.sendChangeCipherAndFinish(ClientHandshaker.java:1280) ~[na:1.8.0_222]
at sun.security.ssl.ClientHandshaker.serverHelloDone(ClientHandshaker.java:1190) ~[na:1.8.0_222]
at sun.security.ssl.ClientHandshaker.processMessage(ClientHandshaker.java:369) ~[na:1.8.0_222]
at sun.security.ssl.Handshaker.processLoop(Handshaker.java:1037) ~[na:1.8.0_222]
at sun.security.ssl.Handshaker.process_record(Handshaker.java:965) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:1064) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1367) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1395) ~[na:1.8.0_222]
at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1379) ~[na:1.8.0_222]
at sun.net.www.protocol.https.HttpsClient.afterConnect(HttpsClient.java:559) ~[na:1.8.0_222]
at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:185) ~[na:1.8.0_222]
at sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1570) ~[na:1.8.0_222]
at sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1498) ~[na:1.8.0_222]
at java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:480) ~[na:1.8.0_222]
at sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:352) ~[na:1.8.0_222]
at org.glassfish.jersey.client.HttpUrlConnector._apply(HttpUrlConnector.java:276) ~[jersey-client-2.5.1.jar:na]
at org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUrlConnector.java:182) ~[jersey-client-2.5.1.jar:na]
... 48 common frames omitted
Tests run: 4, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 423.774 sec - in co.codewizards.cloudstore.test.CertificateHandlingAndTestServiceLRT
11:52:11.544 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@6bcb0a44{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
11:52:11.545 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:52:11.553 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@7ca199d3{/,null,UNAVAILABLE}
11:52:11.563 [Thread-4] INFO c.c.c.l.s.LocalServer - onStopOrFailure: File did not exist (could not delete): /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/jvm/b1acZV_EXu3-8Vjx9iI3lw/.cloudstore/localServerRunning.deleteToStop
11:52:11.571 [Thread-4] INFO o.e.j.s.AbstractConnector - Stopped ServerConnector@57f3d497{SSL,[ssl, http/1.1]}{0.0.0.0:43987}
11:52:11.573 [Thread-4] INFO o.e.j.s.session - node0 Stopped scavenging
11:52:11.574 [Thread-4] INFO o.e.j.s.h.ContextHandler - Stopped o.e.j.s.ServletContextHandler@5db18c07{/,null,UNAVAILABLE}
Results :
Tests run: 48, Failures: 0, Errors: 0, Skipped: 1
[JENKINS] Recording test results
[INFO]
[INFO] --- maven-source-plugin:2.1.2:jar-no-fork (attach-sources) @ co.codewizards.cloudstore.test ---
[INFO] co already added, skipping
[INFO] co/codewizards already added, skipping
[INFO] co/codewizards/cloudstore already added, skipping
[INFO] co/codewizards/cloudstore/test already added, skipping
[INFO] Building jar: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT-sources.jar
[INFO] co already added, skipping
[INFO] co/codewizards already added, skipping
[INFO] co/codewizards/cloudstore already added, skipping
[INFO] co/codewizards/cloudstore/test already added, skipping
[INFO]
[INFO] --- maven-failsafe-plugin:2.17:verify (default) @ co.codewizards.cloudstore.test ---
[INFO] Failsafe report directory: /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/failsafe-reports
[JENKINS] Recording test results
[INFO]
[INFO] --- maven-install-plugin:2.3.1:install (default-install) @ co.codewizards.cloudstore.test ---
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT.jar
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/pom.xml to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT.pom
[INFO] Installing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT-sources.jar to /home/tomcat/.m2/repository/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-SNAPSHOT-sources.jar
[INFO]
[INFO] --- maven-deploy-plugin:2.7:deploy (default-deploy) @ co.codewizards.cloudstore.test ---
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml
Downloaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 37.1 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190915.095212-19.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190915.095212-19.jar (7 KB at 3212.9 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190915.095212-19.pom
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190915.095212-19.pom (6 KB at 5167.0 KB/sec)
Downloading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
Downloaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (398 B at 129.6 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 501.5 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/maven-metadata.xml (398 B at 194.3 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190915.095212-19-sources.jar
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/co.codewizards.cloudstore.test-0.10.7-20190915.095212-19-sources.jar (3 KB at 2148.4 KB/sec)
Uploading: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml
Uploaded: file:/srv/www/nightly/cloudstore.codewizards.co/htdocs/maven/snapshot/co/codewizards/cloudstore/co.codewizards.cloudstore.test/0.10.7-SNAPSHOT/maven-metadata.xml (2 KB at 1002.9 KB/sec)
[INFO]
[INFO] --- maven-site-plugin:3.3:site (default-site) @ co.codewizards.cloudstore.test ---
[INFO] Relativizing decoration links with respect to project URL: http://cloudstore.codewizards.co/co.codewizards.cloudstore.test
[INFO] Rendering site with org.apache.maven.skins:maven-default-skin:jar:1.0 skin.
[INFO] Relativizing decoration links with respect to project URL: http://cloudstore.codewizards.co/co.codewizards.cloudstore.test/de
[INFO] Rendering site with org.apache.maven.skins:maven-default-skin:jar:1.0 skin.
[JENKINS] Archiving site from /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/site to /home/tomcat/.jenkins/jobs/co.codewizards.cloudstore/site/co.codewizards.cloudstore.test
[WARNING] Failed to getClass for org.apache.maven.plugin.javadoc.JavadocReport
[INFO]
[INFO] --- maven-javadoc-plugin:2.9.1:javadoc (javadoc-generate-unfiltered) @ co.codewizards.cloudstore.test ---
[INFO]
[INFO] --- maven-resources-plugin:2.5:copy-resources (javadoc-filter) @ co.codewizards.cloudstore.test ---
[debug] execute contextualize
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/javadoc.unfiltered
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/javadoc.unfiltered
[INFO]
[INFO] --- maven-resources-plugin:2.5:copy-resources (javadoc-copy-to-site) @ co.codewizards.cloudstore.test ---
[debug] execute contextualize
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/apidocs
[INFO]
[INFO] --- maven-site-plugin:3.3:deploy (default-deploy) @ co.codewizards.cloudstore.test ---
file:/tmp/cloudstore-junk/ - Session: Opened
[INFO] Pushing /home/tomcat/.jenkins/workspace/co.codewizards.cloudstore/co.codewizards.cloudstore.test/target/site
[INFO] >>> to file:/tmp/cloudstore-junk/co.codewizards.cloudstore.test
[INFO] >>> to file:/tmp/cloudstore-junk/de/co.codewizards.cloudstore.test
file:/tmp/cloudstore-junk/ - Session: Disconnecting
file:/tmp/cloudstore-junk/ - Session: Disconnected
|
Help us localize this page