10291.586false011330org.subshare.core.crypto.EncrypterDecrypterStreamTest10.3340symmetricWithoutIvfalsePASSED symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 1916256 random bytes plaintext took 27 ms. 17:20:44.119 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 334 ms. symmetricWithoutIv: Encrypting 1916256 bytes plaintext to 1916278 bytes ciphertext took 387 ms. symmetricWithoutIv: Decrypting 1916278 bytes ciphertext to 1916256 bytes plaintext took 342 ms. ...[truncated 37162 chars]... 4201 bytes plaintext took 119 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 5183667 random bytes plaintext took 44 ms. asymmetricCombiWithRandomIv: Encrypting 5183667 bytes plaintext to 5184211 bytes ciphertext took 219 ms. asymmetricCombiWithRandomIv: Decrypting 5184211 bytes ciphertext to 5183667 bytes plaintext took 310 ms. 0org.subshare.core.crypto.EncrypterDecrypterStreamTest6.7810symmetricWithRandomIvfalsePASSED symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 1916256 random bytes plaintext took 27 ms. 17:20:44.119 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 334 ms. symmetricWithoutIv: Encrypting 1916256 bytes plaintext to 1916278 bytes ciphertext took 387 ms. symmetricWithoutIv: Decrypting 1916278 bytes ciphertext to 1916256 bytes plaintext took 342 ms. ...[truncated 37162 chars]... 4201 bytes plaintext took 119 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 5183667 random bytes plaintext took 44 ms. asymmetricCombiWithRandomIv: Encrypting 5183667 bytes plaintext to 5184211 bytes ciphertext took 219 ms. asymmetricCombiWithRandomIv: Decrypting 5184211 bytes ciphertext to 5183667 bytes plaintext took 310 ms. 0org.subshare.core.crypto.EncrypterDecrypterStreamTest25.3820asymmetricPlainfalsePASSED symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 1916256 random bytes plaintext took 27 ms. 17:20:44.119 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 334 ms. symmetricWithoutIv: Encrypting 1916256 bytes plaintext to 1916278 bytes ciphertext took 387 ms. symmetricWithoutIv: Decrypting 1916278 bytes ciphertext to 1916256 bytes plaintext took 342 ms. ...[truncated 37162 chars]... 4201 bytes plaintext took 119 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 5183667 random bytes plaintext took 44 ms. asymmetricCombiWithRandomIv: Encrypting 5183667 bytes plaintext to 5184211 bytes ciphertext took 219 ms. asymmetricCombiWithRandomIv: Decrypting 5184211 bytes ciphertext to 5183667 bytes plaintext took 310 ms. 0org.subshare.core.crypto.EncrypterDecrypterStreamTest15.4220asymmetricCombiWithRandomIvfalsePASSED symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 1916256 random bytes plaintext took 27 ms. 17:20:44.119 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 334 ms. symmetricWithoutIv: Encrypting 1916256 bytes plaintext to 1916278 bytes ciphertext took 387 ms. symmetricWithoutIv: Decrypting 1916278 bytes ciphertext to 1916256 bytes plaintext took 342 ms. ...[truncated 37162 chars]... 4201 bytes plaintext took 119 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 5183667 random bytes plaintext took 44 ms. asymmetricCombiWithRandomIv: Encrypting 5183667 bytes plaintext to 5184211 bytes ciphertext took 219 ms. asymmetricCombiWithRandomIv: Decrypting 5184211 bytes ciphertext to 5183667 bytes plaintext took 310 ms. 57.919003org.subshare.core.crypto.EncrypterDecrypterStreamTest symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 1916256 random bytes plaintext took 27 ms. 17:20:44.119 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 334 ms. symmetricWithoutIv: Encrypting 1916256 bytes plaintext to 1916278 bytes ciphertext took 387 ms. symmetricWithoutIv: Decrypting 1916278 bytes ciphertext to 1916256 bytes plaintext took 342 ms. ...[truncated 37162 chars]... 4201 bytes plaintext took 119 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 5183667 random bytes plaintext took 44 ms. asymmetricCombiWithRandomIv: Encrypting 5183667 bytes plaintext to 5184211 bytes ciphertext took 219 ms. asymmetricCombiWithRandomIv: Decrypting 5184211 bytes ciphertext to 5183667 bytes plaintext took 310 ms. 2017-10-14T15:20:440org.subshare.core.file.EncryptedDataFileTest2.0060writeReadSimpleEncryptedDataFilefalsePASSED2.006org.subshare.core.file.EncryptedDataFileTest2017-10-14T15:20:380org.subshare.core.gpg.GnuPgTest6.6270encryptSignAndDecryptVerifyfalsePASSED>>> pub >>> keyID: 16686379b818da48 fingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48 masterKey: true encryptionKey: false userID: Niklas Schiffler <nick@nightlabs.de> userID: Niklas Schiffler <nschiffler@nightlabs.de> signature.keyID: 16686379b818da48 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: 3a7e3c9cbce48dc2 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: ead508863c3db998 signature.signatureType: POSITIVE_CERTIFICATION signature.ke ...[truncated 26887 chars]... ewizards.co> signature.keyID: d7a92a24aa97ddbd signature.signatureType: POSITIVE_CERTIFICATION <<< pub <<< >>> pub >>> keyID: a58da7d810b74edf fingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF masterKey: false encryptionKey: true signature.keyID: d7a92a24aa97ddbd signature.signatureType: SUBKEY_BINDING <<< pub <<< >>> sec >>> keyID: d7a92a24aa97ddbd userID: Marco หงุ่ยตระกูล-Schulze (TEST) <marco@codewizards.co> <<< sec <<< >>> sec >>> keyID: a58da7d810b74edf <<< sec <<< 0org.subshare.core.gpg.GnuPgTest0.8590encryptAndDecryptfalsePASSED>>> pub >>> keyID: 16686379b818da48 fingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48 masterKey: true encryptionKey: false userID: Niklas Schiffler <nick@nightlabs.de> userID: Niklas Schiffler <nschiffler@nightlabs.de> signature.keyID: 16686379b818da48 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: 3a7e3c9cbce48dc2 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: ead508863c3db998 signature.signatureType: POSITIVE_CERTIFICATION signature.ke ...[truncated 26887 chars]... ewizards.co> signature.keyID: d7a92a24aa97ddbd signature.signatureType: POSITIVE_CERTIFICATION <<< pub <<< >>> pub >>> keyID: a58da7d810b74edf fingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF masterKey: false encryptionKey: true signature.keyID: d7a92a24aa97ddbd signature.signatureType: SUBKEY_BINDING <<< pub <<< >>> sec >>> keyID: d7a92a24aa97ddbd userID: Marco หงุ่ยตระกูล-Schulze (TEST) <marco@codewizards.co> <<< sec <<< >>> sec >>> keyID: a58da7d810b74edf <<< sec <<< 0org.subshare.core.gpg.GnuPgTest0.1280readPubringGpgfalsePASSED>>> pub >>> keyID: 16686379b818da48 fingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48 masterKey: true encryptionKey: false userID: Niklas Schiffler <nick@nightlabs.de> userID: Niklas Schiffler <nschiffler@nightlabs.de> signature.keyID: 16686379b818da48 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: 3a7e3c9cbce48dc2 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: ead508863c3db998 signature.signatureType: POSITIVE_CERTIFICATION signature.ke ...[truncated 26887 chars]... ewizards.co> signature.keyID: d7a92a24aa97ddbd signature.signatureType: POSITIVE_CERTIFICATION <<< pub <<< >>> pub >>> keyID: a58da7d810b74edf fingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF masterKey: false encryptionKey: true signature.keyID: d7a92a24aa97ddbd signature.signatureType: SUBKEY_BINDING <<< pub <<< >>> sec >>> keyID: d7a92a24aa97ddbd userID: Marco หงุ่ยตระกูล-Schulze (TEST) <marco@codewizards.co> <<< sec <<< >>> sec >>> keyID: a58da7d810b74edf <<< sec <<< 0org.subshare.core.gpg.GnuPgTest0.0050readSecringGpgfalsePASSED>>> pub >>> keyID: 16686379b818da48 fingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48 masterKey: true encryptionKey: false userID: Niklas Schiffler <nick@nightlabs.de> userID: Niklas Schiffler <nschiffler@nightlabs.de> signature.keyID: 16686379b818da48 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: 3a7e3c9cbce48dc2 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: ead508863c3db998 signature.signatureType: POSITIVE_CERTIFICATION signature.ke ...[truncated 26887 chars]... ewizards.co> signature.keyID: d7a92a24aa97ddbd signature.signatureType: POSITIVE_CERTIFICATION <<< pub <<< >>> pub >>> keyID: a58da7d810b74edf fingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF masterKey: false encryptionKey: true signature.keyID: d7a92a24aa97ddbd signature.signatureType: SUBKEY_BINDING <<< pub <<< >>> sec >>> keyID: d7a92a24aa97ddbd userID: Marco หงุ่ยตระกูล-Schulze (TEST) <marco@codewizards.co> <<< sec <<< >>> sec >>> keyID: a58da7d810b74edf <<< sec <<< 7.619org.subshare.core.gpg.GnuPgTest>>> pub >>> keyID: 16686379b818da48 fingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48 masterKey: true encryptionKey: false userID: Niklas Schiffler <nick@nightlabs.de> userID: Niklas Schiffler <nschiffler@nightlabs.de> signature.keyID: 16686379b818da48 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: 3a7e3c9cbce48dc2 signature.signatureType: POSITIVE_CERTIFICATION signature.keyID: ead508863c3db998 signature.signatureType: POSITIVE_CERTIFICATION signature.ke ...[truncated 26887 chars]... ewizards.co> signature.keyID: d7a92a24aa97ddbd signature.signatureType: POSITIVE_CERTIFICATION <<< pub <<< >>> pub >>> keyID: a58da7d810b74edf fingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF masterKey: false encryptionKey: true signature.keyID: d7a92a24aa97ddbd signature.signatureType: SUBKEY_BINDING <<< pub <<< >>> sec >>> keyID: d7a92a24aa97ddbd userID: Marco หงุ่ยตระกูล-Schulze (TEST) <marco@codewizards.co> <<< sec <<< >>> sec >>> keyID: a58da7d810b74edf <<< sec <<< 2017-10-14T15:20:360org.subshare.core.io.LimitedInputStreamTest2.7590randomLengthWithUnderlyingSameLengthfalsePASSED2.759org.subshare.core.io.LimitedInputStreamTest2017-10-14T15:20:350org.subshare.core.io.MultiInputStreamTest5.1210randomCombifalsePASSED5.121org.subshare.core.io.MultiInputStreamTest2017-10-14T15:20:350org.subshare.core.pgp.PgpTest5.9960inlineSignThenEncryptAndDecryptThenVerifyfalsePASSED17:20:41.013 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:41.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:41.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.095 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.979 [Test ...[truncated 27265 chars]... :54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 17:20:52.403 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.pgp.PgpTest0.130signAndVerifyViaPgpSignablefalsePASSED17:20:41.013 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:41.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:41.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.095 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.979 [Test ...[truncated 27265 chars]... :54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 17:20:52.403 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.pgp.PgpTest3.3620inlineSignAndVerifyfalsePASSED17:20:41.013 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:41.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:41.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.095 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.979 [Test ...[truncated 27265 chars]... :54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 17:20:52.403 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.pgp.PgpTest0.1840exportImportPublicKeyfalsePASSED17:20:41.013 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:41.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:41.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.095 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.979 [Test ...[truncated 27265 chars]... :54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 17:20:52.403 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.pgp.PgpTest0.9040detachedSignAndVerifyfalsePASSED17:20:41.013 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:41.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:41.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.095 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.979 [Test ...[truncated 27265 chars]... :54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 17:20:52.403 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 10.576org.subshare.core.pgp.PgpTest17:20:41.013 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:41.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:41.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.095 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/aDTxPwuRnK67Ul5AIJmQYQ/.gnupg 17:20:41.979 [Test ...[truncated 27265 chars]... :54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 17:20:52.403 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:20:410org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest4.0070addAllDifferentUserRepoKeyPublicKeysToUserfalsePASSED0org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest0.0040addAllSameUserRepoKeyPublicKeyInCollectionToUserfalsePASSED0org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest0.0040addSameUserRepoKeyPublicKeyTwiceToUserfalsePASSED0org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest0.010addDifferentUserRepoKeyPublicKeysToUserfalsePASSED4.0250006org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest2017-10-14T15:20:340org.subshare.core.user.UserRegistryTest4.8580addUserfalsePASSED17:20:37.539 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:38.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:38.322 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/YkZ4HHbWDLuCCYfNkU2jbw/.gnupg 17:20:38.330 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/YkZ4HHbWDLuCCYfNkU2jbw/.gnupg 17:20:39.661 [Test ...[truncated 13968 chars]... edCloseTimer] DEBUG o.s.c.p.g.TrustDbFactory$DeferredCloseTimerTask - run: Closing *real* TrustDb instance. 17:21:15.770 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 13988 ms. 17:21:15.830 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 17:21:16.123 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 17:21:16.245 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.user.UserRegistryTest8.3280testGpgKeyTrustLevelsfalsePASSED17:20:37.539 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:38.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:38.322 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/YkZ4HHbWDLuCCYfNkU2jbw/.gnupg 17:20:38.330 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/YkZ4HHbWDLuCCYfNkU2jbw/.gnupg 17:20:39.661 [Test ...[truncated 13968 chars]... edCloseTimer] DEBUG o.s.c.p.g.TrustDbFactory$DeferredCloseTimerTask - run: Closing *real* TrustDb instance. 17:21:15.770 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 13988 ms. 17:21:15.830 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 17:21:16.123 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 17:21:16.245 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.user.UserRegistryTest25.1030initUserRegistryFromGpgKeysfalsePASSED17:20:37.539 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:38.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:38.322 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/YkZ4HHbWDLuCCYfNkU2jbw/.gnupg 17:20:38.330 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/YkZ4HHbWDLuCCYfNkU2jbw/.gnupg 17:20:39.661 [Test ...[truncated 13968 chars]... edCloseTimer] DEBUG o.s.c.p.g.TrustDbFactory$DeferredCloseTimerTask - run: Closing *real* TrustDb instance. 17:21:15.770 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 13988 ms. 17:21:15.830 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 17:21:16.123 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 17:21:16.245 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 38.289org.subshare.core.user.UserRegistryTest17:20:37.539 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:20:38.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:20:38.322 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/YkZ4HHbWDLuCCYfNkU2jbw/.gnupg 17:20:38.330 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/YkZ4HHbWDLuCCYfNkU2jbw/.gnupg 17:20:39.661 [Test ...[truncated 13968 chars]... edCloseTimer] DEBUG o.s.c.p.g.TrustDbFactory$DeferredCloseTimerTask - run: Closing *real* TrustDb instance. 17:21:15.770 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 13988 ms. 17:21:15.830 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 17:21:16.123 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 17:21:16.245 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:20:370org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest3.4970firstAddPublicKeysThenCreateUserRepoKeyRingfalsePASSED0org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest0.0220firstCreateUserRepoKeyRingThenAddPublicKeysfalsePASSED3.519org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest2017-10-14T15:20:3540org.subshare.crypto.AsymmetricKeyTest0.001257generateManySymmetricKeystrueSKIPPED0org.subshare.crypto.AsymmetricKeyTest9.5880encodeDecodeRSAwithOAEPwithSHA1andMGF1PaddingfalsePASSED0org.subshare.crypto.AsymmetricKeyTest31.2210encodeDecodeRSAfalsePASSED40.81org.subshare.crypto.AsymmetricKeyTest2017-10-14T15:21:540org.subshare.crypto.CipherTest3.2880testLookupAllSupportedCiphersfalsePASSED17:22:01.908 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3092 msec. 17:22:02.252 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 17:22:02.257 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 17:22:02.263 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 17:22:02.266 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:14.159 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 17:22:14.368 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 17:22:14.780 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 17:22:15.057 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:15.319 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 0org.subshare.crypto.CipherTest9.2230testNullAsKeyParameterfalsePASSED17:22:01.908 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3092 msec. 17:22:02.252 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 17:22:02.257 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 17:22:02.263 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 17:22:02.266 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:14.159 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 17:22:14.368 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 17:22:14.780 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 17:22:15.057 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:15.319 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 0org.subshare.crypto.CipherTest0.1030testLookupCompatibilityWithJCEfalsePASSED17:22:01.908 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3092 msec. 17:22:02.252 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 17:22:02.257 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 17:22:02.263 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 17:22:02.266 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:14.159 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 17:22:14.368 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 17:22:14.780 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 17:22:15.057 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:15.319 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 0org.subshare.crypto.CipherTest4.5390testSymmetricEncryptionWithoutIvfalsePASSED17:22:01.908 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3092 msec. 17:22:02.252 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 17:22:02.257 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 17:22:02.263 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 17:22:02.266 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:14.159 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 17:22:14.368 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 17:22:14.780 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 17:22:15.057 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:15.319 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 0org.subshare.crypto.CipherTest0.1440testSymmetricEncryptionCompatibilityWithJCE_BouncyCastleProviderfalsePASSED17:22:01.908 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3092 msec. 17:22:02.252 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 17:22:02.257 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 17:22:02.263 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 17:22:02.266 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:14.159 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 17:22:14.368 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 17:22:14.780 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 17:22:15.057 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:15.319 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 17.296999org.subshare.crypto.CipherTest17:22:01.908 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3092 msec. 17:22:02.252 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 17:22:02.257 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 17:22:02.263 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 17:22:02.266 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:14.159 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 17:22:14.368 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 17:22:14.780 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 17:22:15.057 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 17:22:15.319 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 2017-10-14T15:21:580org.subshare.crypto.GCMTest9.3740testEncryptionWithCipherfalsePASSED*** 0 *** *** 1 *** *** 2 *** *** 3 *** *** 4 *** *** 5 *** *** 6 *** *** 7 *** *** 8 *** *** 9 *** *** 10 *** *** 11 *** *** 12 *** *** 13 *** *** 14 *** *** 15 *** *** 16 *** *** 17 *** *** 18 *** *** 19 *** *** 20 *** *** 21 *** *** 22 *** *** 23 *** *** 24 *** *** 25 *** *** 26 *** *** 27 *** *** 28 *** *** 29 *** *** 30 *** *** 31 *** *** 32 *** *** 33 *** *** 34 *** *** 35 *** *** 36 *** *** 37 *** *** 38 *** *** 39 *** *** 40 *** *** 41 *** *** 42 *** *** 43 *** *** 44 *** *** 45 *** *** ...[truncated 296780 chars]... 70 *** *** gcm 9971 *** *** gcm 9972 *** *** gcm 9973 *** *** gcm 9974 *** *** gcm 9975 *** *** gcm 9976 *** *** gcm 9977 *** *** gcm 9978 *** *** gcm 9979 *** *** gcm 9980 *** *** gcm 9981 *** *** gcm 9982 *** *** gcm 9983 *** *** gcm 9984 *** *** gcm 9985 *** *** gcm 9986 *** *** gcm 9987 *** *** gcm 9988 *** *** gcm 9989 *** *** gcm 9990 *** *** gcm 9991 *** *** gcm 9992 *** *** gcm 9993 *** *** gcm 9994 *** *** gcm 9995 *** *** gcm 9996 *** *** gcm 9997 *** *** gcm 9998 *** *** gcm 9999 *** 0org.subshare.crypto.GCMTest2.9170testEncryptionWithBCLowLevelAPIfalsePASSED*** 0 *** *** 1 *** *** 2 *** *** 3 *** *** 4 *** *** 5 *** *** 6 *** *** 7 *** *** 8 *** *** 9 *** *** 10 *** *** 11 *** *** 12 *** *** 13 *** *** 14 *** *** 15 *** *** 16 *** *** 17 *** *** 18 *** *** 19 *** *** 20 *** *** 21 *** *** 22 *** *** 23 *** *** 24 *** *** 25 *** *** 26 *** *** 27 *** *** 28 *** *** 29 *** *** 30 *** *** 31 *** *** 32 *** *** 33 *** *** 34 *** *** 35 *** *** 36 *** *** 37 *** *** 38 *** *** 39 *** *** 40 *** *** 41 *** *** 42 *** *** 43 *** *** 44 *** *** 45 *** *** ...[truncated 296780 chars]... 70 *** *** gcm 9971 *** *** gcm 9972 *** *** gcm 9973 *** *** gcm 9974 *** *** gcm 9975 *** *** gcm 9976 *** *** gcm 9977 *** *** gcm 9978 *** *** gcm 9979 *** *** gcm 9980 *** *** gcm 9981 *** *** gcm 9982 *** *** gcm 9983 *** *** gcm 9984 *** *** gcm 9985 *** *** gcm 9986 *** *** gcm 9987 *** *** gcm 9988 *** *** gcm 9989 *** *** gcm 9990 *** *** gcm 9991 *** *** gcm 9992 *** *** gcm 9993 *** *** gcm 9994 *** *** gcm 9995 *** *** gcm 9996 *** *** gcm 9997 *** *** gcm 9998 *** *** gcm 9999 *** 12.290999org.subshare.crypto.GCMTest*** 0 *** *** 1 *** *** 2 *** *** 3 *** *** 4 *** *** 5 *** *** 6 *** *** 7 *** *** 8 *** *** 9 *** *** 10 *** *** 11 *** *** 12 *** *** 13 *** *** 14 *** *** 15 *** *** 16 *** *** 17 *** *** 18 *** *** 19 *** *** 20 *** *** 21 *** *** 22 *** *** 23 *** *** 24 *** *** 25 *** *** 26 *** *** 27 *** *** 28 *** *** 29 *** *** 30 *** *** 31 *** *** 32 *** *** 33 *** *** 34 *** *** 35 *** *** 36 *** *** 37 *** *** 38 *** *** 39 *** *** 40 *** *** 41 *** *** 42 *** *** 43 *** *** 44 *** *** 45 *** *** ...[truncated 296780 chars]... 70 *** *** gcm 9971 *** *** gcm 9972 *** *** gcm 9973 *** *** gcm 9974 *** *** gcm 9975 *** *** gcm 9976 *** *** gcm 9977 *** *** gcm 9978 *** *** gcm 9979 *** *** gcm 9980 *** *** gcm 9981 *** *** gcm 9982 *** *** gcm 9983 *** *** gcm 9984 *** *** gcm 9985 *** *** gcm 9986 *** *** gcm 9987 *** *** gcm 9988 *** *** gcm 9989 *** *** gcm 9990 *** *** gcm 9991 *** *** gcm 9992 *** *** gcm 9993 *** *** gcm 9994 *** *** gcm 9995 *** *** gcm 9996 *** *** gcm 9997 *** *** gcm 9998 *** *** gcm 9999 *** 2017-10-14T15:21:540org.subshare.crypto.MACBenchmark0.2090testByteOrderfalsePASSED17:21:57.271 [Test worker] INFO o.s.c.MACBenchmark - short1 = 22993 17:21:57.368 [Test worker] INFO o.s.c.MACBenchmark - short2 = 22993 17:21:57.370 [Test worker] INFO o.s.c.MACBenchmark - int1 = 22993 0org.subshare.crypto.MACBenchmark5.4390benchmarkCreateManyInitialisedMACCalculatorsfalsePASSED17:21:57.271 [Test worker] INFO o.s.c.MACBenchmark - short1 = 22993 17:21:57.368 [Test worker] INFO o.s.c.MACBenchmark - short2 = 22993 17:21:57.370 [Test worker] INFO o.s.c.MACBenchmark - int1 = 22993 0org.subshare.crypto.MACBenchmark0.1690benchmarkCreateManyUNinitialisedMACCalculatorsfalsePASSED17:21:57.271 [Test worker] INFO o.s.c.MACBenchmark - short1 = 22993 17:21:57.368 [Test worker] INFO o.s.c.MACBenchmark - short2 = 22993 17:21:57.370 [Test worker] INFO o.s.c.MACBenchmark - int1 = 22993 0org.subshare.crypto.MACBenchmark18.3050benchmarkCalculateManyMACsWithNewMACCalculatorfalsePASSED17:21:57.271 [Test worker] INFO o.s.c.MACBenchmark - short1 = 22993 17:21:57.368 [Test worker] INFO o.s.c.MACBenchmark - short2 = 22993 17:21:57.370 [Test worker] INFO o.s.c.MACBenchmark - int1 = 22993 0org.subshare.crypto.MACBenchmark14.00benchmarkCalculateManyMACsWithSameMACCalculatorfalsePASSED17:21:57.271 [Test worker] INFO o.s.c.MACBenchmark - short1 = 22993 17:21:57.368 [Test worker] INFO o.s.c.MACBenchmark - short2 = 22993 17:21:57.370 [Test worker] INFO o.s.c.MACBenchmark - int1 = 22993 38.122org.subshare.crypto.MACBenchmark17:21:57.271 [Test worker] INFO o.s.c.MACBenchmark - short1 = 22993 17:21:57.368 [Test worker] INFO o.s.c.MACBenchmark - short2 = 22993 17:21:57.370 [Test worker] INFO o.s.c.MACBenchmark - int1 = 22993 2017-10-14T15:21:570org.subshare.crypto.MACTest5.8360testAllSupportedMACsfalsePASSED5.836org.subshare.crypto.MACTest2017-10-14T15:21:550org.subshare.crypto.ShowSupportedAlgosForDocumentation0.240showSupportedBlockCipherModesfalsePASSED>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** BlockCipherMode *** CBC CBC-CTS CCM CFB CFB104 CFB112 CFB120 CFB128 CFB136 CFB144 CFB152 CFB16 CFB160 CFB168 CFB176 CFB184 CFB192 CFB200 CFB208 CFB216 CFB224 CFB232 CFB24 CFB240 CFB248 CFB256 CFB32 CFB40 CFB48 CFB56 CFB64 CFB72 CFB8 CFB80 CFB88 CFB96 CTS EAX ECB GCM GOFB OFB OFB104 OFB112 OFB120 OFB128 OFB136 OFB144 OFB152 OFB16 OFB160 OFB168 OFB176 OFB184 OFB192 OFB200 OFB208 OFB216 OFB224 OFB232 OFB24 OFB240 OFB248 OFB256 OFB32 OFB40 OFB48 OFB56 OFB64 ...[truncated 1515 chars]... ADDING NOPADDING PKCS5 PKCS5PADDING PKCS7 PKCS7PADDING TBC TBCPADDING X9.23 X9.23PADDING ZEROBYTE ZEROBYTEPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/asymmetricBlock *** ISO9796-1 ISO9796-1PADDING NOPADDING OAEP OAEPPADDING OAEPWITHSHA1ANDMGF1 OAEPWITHSHA1ANDMGF1PADDING PKCS1 PKCS1PADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/symmetricStream *** NOPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< 0org.subshare.crypto.ShowSupportedAlgosForDocumentation0.0780showSupportedCipherEnginesfalsePASSED>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** BlockCipherMode *** CBC CBC-CTS CCM CFB CFB104 CFB112 CFB120 CFB128 CFB136 CFB144 CFB152 CFB16 CFB160 CFB168 CFB176 CFB184 CFB192 CFB200 CFB208 CFB216 CFB224 CFB232 CFB24 CFB240 CFB248 CFB256 CFB32 CFB40 CFB48 CFB56 CFB64 CFB72 CFB8 CFB80 CFB88 CFB96 CTS EAX ECB GCM GOFB OFB OFB104 OFB112 OFB120 OFB128 OFB136 OFB144 OFB152 OFB16 OFB160 OFB168 OFB176 OFB184 OFB192 OFB200 OFB208 OFB216 OFB224 OFB232 OFB24 OFB240 OFB248 OFB256 OFB32 OFB40 OFB48 OFB56 OFB64 ...[truncated 1515 chars]... ADDING NOPADDING PKCS5 PKCS5PADDING PKCS7 PKCS7PADDING TBC TBCPADDING X9.23 X9.23PADDING ZEROBYTE ZEROBYTEPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/asymmetricBlock *** ISO9796-1 ISO9796-1PADDING NOPADDING OAEP OAEPPADDING OAEPWITHSHA1ANDMGF1 OAEPWITHSHA1ANDMGF1PADDING PKCS1 PKCS1PADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/symmetricStream *** NOPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< 0org.subshare.crypto.ShowSupportedAlgosForDocumentation0.0550showSupportedMACsfalsePASSED>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** BlockCipherMode *** CBC CBC-CTS CCM CFB CFB104 CFB112 CFB120 CFB128 CFB136 CFB144 CFB152 CFB16 CFB160 CFB168 CFB176 CFB184 CFB192 CFB200 CFB208 CFB216 CFB224 CFB232 CFB24 CFB240 CFB248 CFB256 CFB32 CFB40 CFB48 CFB56 CFB64 CFB72 CFB8 CFB80 CFB88 CFB96 CTS EAX ECB GCM GOFB OFB OFB104 OFB112 OFB120 OFB128 OFB136 OFB144 OFB152 OFB16 OFB160 OFB168 OFB176 OFB184 OFB192 OFB200 OFB208 OFB216 OFB224 OFB232 OFB24 OFB240 OFB248 OFB256 OFB32 OFB40 OFB48 OFB56 OFB64 ...[truncated 1515 chars]... ADDING NOPADDING PKCS5 PKCS5PADDING PKCS7 PKCS7PADDING TBC TBCPADDING X9.23 X9.23PADDING ZEROBYTE ZEROBYTEPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/asymmetricBlock *** ISO9796-1 ISO9796-1PADDING NOPADDING OAEP OAEPPADDING OAEPWITHSHA1ANDMGF1 OAEPWITHSHA1ANDMGF1PADDING PKCS1 PKCS1PADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/symmetricStream *** NOPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< 0org.subshare.crypto.ShowSupportedAlgosForDocumentation0.0290showSupportedPaddingsfalsePASSED>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** BlockCipherMode *** CBC CBC-CTS CCM CFB CFB104 CFB112 CFB120 CFB128 CFB136 CFB144 CFB152 CFB16 CFB160 CFB168 CFB176 CFB184 CFB192 CFB200 CFB208 CFB216 CFB224 CFB232 CFB24 CFB240 CFB248 CFB256 CFB32 CFB40 CFB48 CFB56 CFB64 CFB72 CFB8 CFB80 CFB88 CFB96 CTS EAX ECB GCM GOFB OFB OFB104 OFB112 OFB120 OFB128 OFB136 OFB144 OFB152 OFB16 OFB160 OFB168 OFB176 OFB184 OFB192 OFB200 OFB208 OFB216 OFB224 OFB232 OFB24 OFB240 OFB248 OFB256 OFB32 OFB40 OFB48 OFB56 OFB64 ...[truncated 1515 chars]... ADDING NOPADDING PKCS5 PKCS5PADDING PKCS7 PKCS7PADDING TBC TBCPADDING X9.23 X9.23PADDING ZEROBYTE ZEROBYTEPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/asymmetricBlock *** ISO9796-1 ISO9796-1PADDING NOPADDING OAEP OAEPPADDING OAEPWITHSHA1ANDMGF1 OAEPWITHSHA1ANDMGF1PADDING PKCS1 PKCS1PADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/symmetricStream *** NOPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< 0.402org.subshare.crypto.ShowSupportedAlgosForDocumentation>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** BlockCipherMode *** CBC CBC-CTS CCM CFB CFB104 CFB112 CFB120 CFB128 CFB136 CFB144 CFB152 CFB16 CFB160 CFB168 CFB176 CFB184 CFB192 CFB200 CFB208 CFB216 CFB224 CFB232 CFB24 CFB240 CFB248 CFB256 CFB32 CFB40 CFB48 CFB56 CFB64 CFB72 CFB8 CFB80 CFB88 CFB96 CTS EAX ECB GCM GOFB OFB OFB104 OFB112 OFB120 OFB128 OFB136 OFB144 OFB152 OFB16 OFB160 OFB168 OFB176 OFB184 OFB192 OFB200 OFB208 OFB216 OFB224 OFB232 OFB24 OFB240 OFB248 OFB256 OFB32 OFB40 OFB48 OFB56 OFB64 ...[truncated 1515 chars]... ADDING NOPADDING PKCS5 PKCS5PADDING PKCS7 PKCS7PADDING TBC TBCPADDING X9.23 X9.23PADDING ZEROBYTE ZEROBYTEPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/asymmetricBlock *** ISO9796-1 ISO9796-1PADDING NOPADDING OAEP OAEPPADDING OAEPWITHSHA1ANDMGF1 OAEPWITHSHA1ANDMGF1PADDING PKCS1 PKCS1PADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** Padding/symmetricStream *** NOPADDING <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< 2017-10-14T15:21:570org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest82.0030grantAndRevokeReadPermissionfalsePASSED17:23:01.080 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:01.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:03.899 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c477311]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1fpf-w8lpi-local' 17:23:04.083 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1917 ms. 17 ...[truncated 40581 chars]... NFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83% 17:24:22.736 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55% 17:24:22.788 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00% 17:24:23.166 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c477311]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:24:23.170 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 82.003org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest17:23:01.080 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:01.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:03.899 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c477311]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1fpf-w8lpi-local' 17:23:04.083 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1917 ms. 17 ...[truncated 40581 chars]... NFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83% 17:24:22.736 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55% 17:24:22.788 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00% 17:24:23.166 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c477311]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:24:23.170 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:23:010org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest72.7030grantWritePermissionWithoutGrantPermissionfalsePASSED17:23:01.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:02.331 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:04.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c3fb4f8]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1g3u-6lq9j-local' 17:23:04.582 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1418 ms. 17 ...[truncated 200065 chars]... Test - Local sync...: 79.60% 17:26:58.871 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 17:26:58.890 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 17:26:58.908 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 17:26:58.937 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5dfdff06]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:26:58.939 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest30.2680writeWithWritePermissionInParentParentfalsePASSED17:23:01.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:02.331 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:04.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c3fb4f8]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1g3u-6lq9j-local' 17:23:04.582 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1418 ms. 17 ...[truncated 200065 chars]... Test - Local sync...: 79.60% 17:26:58.871 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 17:26:58.890 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 17:26:58.908 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 17:26:58.937 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5dfdff06]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:26:58.939 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest27.6360writeWithWritePermissionInParentfalsePASSED17:23:01.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:02.331 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:04.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c3fb4f8]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1g3u-6lq9j-local' 17:23:04.582 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1418 ms. 17 ...[truncated 200065 chars]... Test - Local sync...: 79.60% 17:26:58.871 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 17:26:58.890 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 17:26:58.908 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 17:26:58.937 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5dfdff06]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:26:58.939 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest27.7970writeWithWritePermissionDirectDirfalsePASSED17:23:01.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:02.331 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:04.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c3fb4f8]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1g3u-6lq9j-local' 17:23:04.582 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1418 ms. 17 ...[truncated 200065 chars]... Test - Local sync...: 79.60% 17:26:58.871 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 17:26:58.890 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 17:26:58.908 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 17:26:58.937 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5dfdff06]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:26:58.939 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest25.2570writeWithoutWritePermissionfalsePASSED17:23:01.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:02.331 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:04.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c3fb4f8]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1g3u-6lq9j-local' 17:23:04.582 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1418 ms. 17 ...[truncated 200065 chars]... Test - Local sync...: 79.60% 17:26:58.871 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 17:26:58.890 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 17:26:58.908 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 17:26:58.937 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5dfdff06]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:26:58.939 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest27.3540writeWithWritePermissionInParentParentGrantedIndirectlyfalsePASSED17:23:01.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:02.331 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:04.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c3fb4f8]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1g3u-6lq9j-local' 17:23:04.582 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1418 ms. 17 ...[truncated 200065 chars]... Test - Local sync...: 79.60% 17:26:58.871 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 17:26:58.890 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 17:26:58.908 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 17:26:58.937 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5dfdff06]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:26:58.939 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest25.8560writeWithWritePermissionDirectFilefalsePASSED17:23:01.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:02.331 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:04.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c3fb4f8]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1g3u-6lq9j-local' 17:23:04.582 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1418 ms. 17 ...[truncated 200065 chars]... Test - Local sync...: 79.60% 17:26:58.871 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 17:26:58.890 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 17:26:58.908 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 17:26:58.937 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5dfdff06]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:26:58.939 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 236.871org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest17:23:01.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:02.331 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:04.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c3fb4f8]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j8rh1g3u-6lq9j-local' 17:23:04.582 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1418 ms. 17 ...[truncated 200065 chars]... Test - Local sync...: 79.60% 17:26:58.871 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 17:26:58.890 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 17:26:58.908 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 17:26:58.937 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5dfdff06]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:26:58.939 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:23:020org.subshare.local.FilePaddingLengthRandomTest15.2010testDistributionfalsePASSED17:23:03.106 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory lengthCategory2HitCount: {_100K=299922, _1M=148213, _10M=46918, _100M=2977, _1G=1970, _10G=0} lengthCategory2HitPercentage: {_100K=600, _1M=296, _10M=94, _100M=6, _1G=4, _10G=0} 654083 0org.subshare.local.FilePaddingLengthRandomTest0.0830generateOneRandomLengthfalsePASSED17:23:03.106 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory lengthCategory2HitCount: {_100K=299922, _1M=148213, _10M=46918, _100M=2977, _1G=1970, _10G=0} lengthCategory2HitPercentage: {_100K=600, _1M=296, _10M=94, _100M=6, _1G=4, _10G=0} 654083 15.284org.subshare.local.FilePaddingLengthRandomTest17:23:03.106 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory lengthCategory2HitCount: {_100K=299922, _1M=148213, _10M=46918, _100M=2977, _1G=1970, _10G=0} lengthCategory2HitPercentage: {_100K=600, _1M=296, _10M=94, _100M=6, _1G=4, _10G=0} 654083 2017-10-14T15:22:580org.subshare.local.persistence.CollisionTest4.2740xorUids1falsePASSED0org.subshare.local.persistence.CollisionTest0.0020xorUids2falsePASSED4.276org.subshare.local.persistence.CollisionTest2017-10-14T15:22:570org.subshare.local.sign.SignableTest2.7060signAndSerializeAndVerifyfalsePASSED17:23:01.266 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.490 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:03.594 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1406 ms. 17:23:05.036 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:05.038 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 903 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 17:23:08.973 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.024 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.070 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.123 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.165 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.226 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignableTest0.1950signAndModifyCryptoKeyIdAndVerifyfalsePASSED17:23:01.266 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.490 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:03.594 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1406 ms. 17:23:05.036 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:05.038 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 903 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 17:23:08.973 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.024 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.070 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.123 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.165 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.226 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignableTest0.1160signAndVerifyfalsePASSED17:23:01.266 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.490 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:03.594 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1406 ms. 17:23:05.036 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:05.038 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 903 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 17:23:08.973 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.024 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.070 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.123 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.165 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.226 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignableTest0.0980signAndModifySignatureCreatedAndVerifyfalsePASSED17:23:01.266 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.490 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:03.594 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1406 ms. 17:23:05.036 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:05.038 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 903 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 17:23:08.973 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.024 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.070 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.123 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.165 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.226 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignableTest0.0930signAndModifyCryptoRepoFileIdAndVerifyfalsePASSED17:23:01.266 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.490 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:03.594 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1406 ms. 17:23:05.036 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:05.038 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 903 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 17:23:08.973 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.024 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.070 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.123 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.165 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.226 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 3.208org.subshare.local.sign.SignableTest17:23:01.266 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.490 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:03.594 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1406 ms. 17:23:05.036 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:05.038 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 903 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 17:23:08.973 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.024 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.070 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.123 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.165 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:23:09.226 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:23:060org.subshare.local.sign.SignerVerifierStreamTest18.6580signRsaWithSha1falsePASSED17:23:02.731 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.982 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:04.119 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1881 ms. 17:23:06.059 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:06.063 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 5061 chars]... all run #93 signAndVerifyRandomManySmall run #94 signAndVerifyRandomManySmall run #95 signAndVerifyRandomManySmall run #96 signAndVerifyRandomManySmall run #97 signAndVerifyRandomManySmall run #98 signAndVerifyRandomManySmall run #99 signAndVerifyRandomManySmall run #100 17:24:09.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:09.250 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:11.590 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest0.1570signAndVerifySimpleBlockReadfalsePASSED17:23:02.731 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.982 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:04.119 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1881 ms. 17:23:06.059 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:06.063 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 5061 chars]... all run #93 signAndVerifyRandomManySmall run #94 signAndVerifyRandomManySmall run #95 signAndVerifyRandomManySmall run #96 signAndVerifyRandomManySmall run #97 signAndVerifyRandomManySmall run #98 signAndVerifyRandomManySmall run #99 signAndVerifyRandomManySmall run #100 17:24:09.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:09.250 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:11.590 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest20.6640sha1DigestfalsePASSED17:23:02.731 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.982 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:04.119 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1881 ms. 17:23:06.059 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:06.063 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 5061 chars]... all run #93 signAndVerifyRandomManySmall run #94 signAndVerifyRandomManySmall run #95 signAndVerifyRandomManySmall run #96 signAndVerifyRandomManySmall run #97 signAndVerifyRandomManySmall run #98 signAndVerifyRandomManySmall run #99 signAndVerifyRandomManySmall run #100 17:24:09.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:09.250 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:11.590 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest7.1910signAndVerifyRandomBrokenfalsePASSED17:23:02.731 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.982 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:04.119 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1881 ms. 17:23:06.059 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:06.063 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 5061 chars]... all run #93 signAndVerifyRandomManySmall run #94 signAndVerifyRandomManySmall run #95 signAndVerifyRandomManySmall run #96 signAndVerifyRandomManySmall run #97 signAndVerifyRandomManySmall run #98 signAndVerifyRandomManySmall run #99 signAndVerifyRandomManySmall run #100 17:24:09.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:09.250 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:11.590 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest13.6070signAndVerifyRandomManySmallfalsePASSED17:23:02.731 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.982 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:04.119 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1881 ms. 17:23:06.059 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:06.063 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 5061 chars]... all run #93 signAndVerifyRandomManySmall run #94 signAndVerifyRandomManySmall run #95 signAndVerifyRandomManySmall run #96 signAndVerifyRandomManySmall run #97 signAndVerifyRandomManySmall run #98 signAndVerifyRandomManySmall run #99 signAndVerifyRandomManySmall run #100 17:24:09.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:09.250 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:11.590 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest2.3670signAndVerifyRandomfalsePASSED17:23:02.731 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.982 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:04.119 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1881 ms. 17:23:06.059 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:06.063 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 5061 chars]... all run #93 signAndVerifyRandomManySmall run #94 signAndVerifyRandomManySmall run #95 signAndVerifyRandomManySmall run #96 signAndVerifyRandomManySmall run #97 signAndVerifyRandomManySmall run #98 signAndVerifyRandomManySmall run #99 signAndVerifyRandomManySmall run #100 17:24:09.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:09.250 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:11.590 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 62.644org.subshare.local.sign.SignerVerifierStreamTest17:23:02.731 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:23:03.982 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:23:04.119 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1881 ms. 17:23:06.059 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 17:23:06.063 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 17 ...[truncated 5061 chars]... all run #93 signAndVerifyRandomManySmall run #94 signAndVerifyRandomManySmall run #95 signAndVerifyRandomManySmall run #96 signAndVerifyRandomManySmall run #97 signAndVerifyRandomManySmall run #98 signAndVerifyRandomManySmall run #99 signAndVerifyRandomManySmall run #100 17:24:09.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:09.250 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:24:11.590 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:23:080org.subshare.rest.client.transport.CryptreeRepoTransportTest56.8650encryptAndSignAndVerifyAndDecryptfalsePASSED17:27:04.539 [Test worker] INFO c.c.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:27:05.064 [Test worker] DEBUG o.s.c.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:27:05.083 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next). 17:27:05.084 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - read: Reading propertie ...[truncated 44320 chars]... y='subshare.signerTransformation' is not set (config is queried next). 17:28:00.760 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next). 17:28:01.009 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no localRepoManager. 17:28:01.009 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport. 56.865org.subshare.rest.client.transport.CryptreeRepoTransportTest17:27:04.539 [Test worker] INFO c.c.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 17:27:05.064 [Test worker] DEBUG o.s.c.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 17:27:05.083 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next). 17:27:05.084 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - read: Reading propertie ...[truncated 44320 chars]... y='subshare.signerTransformation' is not set (config is queried next). 17:28:00.760 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next). 17:28:01.009 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no localRepoManager. 17:28:01.009 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport. 2017-10-14T15:27:040org.subshare.test.BackupRestoreRepoToRepoSyncIT288.0620backupRestoreClientRepofalsePASSED17:53:08.355 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:53:09.325 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [37713c3f]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8ri44w9-5jogq-local-src' 17:53:09.333 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [37713c3f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8ri44w9-5jogq-local-src' locke ...[truncated 324692 chars]... saction.localRevision=159 remoteFromLocalRevision=144 17:57:55.974 [qtp202278076-3306] INFO c.c.c.l.LocalRepoManagerImpl - [1e0f51d7]close: Deferring shut down of real LocalRepoManager 10000 ms. 17:57:55.976 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:57:55.976 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5b663bdf]close: Deferring shut down of real LocalRepoManager 10000 ms. 17:57:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 6org.subshare.test.BackupRestoreRepoToRepoSyncIT0.0291backupRestoreServerRepotrueSKIPPED17:53:08.355 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:53:09.325 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [37713c3f]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8ri44w9-5jogq-local-src' 17:53:09.333 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [37713c3f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8ri44w9-5jogq-local-src' locke ...[truncated 324692 chars]... saction.localRevision=159 remoteFromLocalRevision=144 17:57:55.974 [qtp202278076-3306] INFO c.c.c.l.LocalRepoManagerImpl - [1e0f51d7]close: Deferring shut down of real LocalRepoManager 10000 ms. 17:57:55.976 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:57:55.976 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5b663bdf]close: Deferring shut down of real LocalRepoManager 10000 ms. 17:57:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 288.062org.subshare.test.BackupRestoreRepoToRepoSyncIT17:53:08.355 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:53:09.325 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [37713c3f]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8ri44w9-5jogq-local-src' 17:53:09.333 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [37713c3f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8ri44w9-5jogq-local-src' locke ...[truncated 324692 chars]... saction.localRevision=159 remoteFromLocalRevision=144 17:57:55.974 [qtp202278076-3306] INFO c.c.c.l.LocalRepoManagerImpl - [1e0f51d7]close: Deferring shut down of real LocalRepoManager 10000 ms. 17:57:55.976 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:57:55.976 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5b663bdf]close: Deferring shut down of real LocalRepoManager 10000 ms. 17:57:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:53:080org.subshare.test.BrokenSignatureIT203.1620uploadBrokenSignaturefalsePASSEDOct 14, 2017 5:28:56 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:29:00 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.751 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/7SB6GrOW5-odmEXRZfzmPg/.subshare/ssl.server/keystore' does not exist! 17:28:22.758 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 459673 chars]... ncurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 0org.subshare.test.BrokenSignatureIT140.0850downloadBrokenSignaturefalsePASSEDOct 14, 2017 5:28:56 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:29:00 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.751 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/7SB6GrOW5-odmEXRZfzmPg/.subshare/ssl.server/keystore' does not exist! 17:28:22.758 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 459673 chars]... ncurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 343.247org.subshare.test.BrokenSignatureITOct 14, 2017 5:28:56 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:29:00 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.944 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.751 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/7SB6GrOW5-odmEXRZfzmPg/.subshare/ssl.server/keystore' does not exist! 17:28:22.758 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 459673 chars]... ncurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 2017-10-14T15:29:040org.subshare.test.CollisionOnClientRepoToRepoSyncIT236.9960newFileVsNewFileCollisionOnClientfalsePASSED17:43:22.571 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:43:23.430 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' 17:43:23.726 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' locke ...[truncated 1775134 chars]... ons: query.execute(...) took 3 ms. 18:02:34.782 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [70b46171]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1294f31c]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:35.162 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT203.4420newDirectoryVsNewDirectoryCollisionOnClientfalsePASSED17:43:22.571 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:43:23.430 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' 17:43:23.726 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' locke ...[truncated 1775134 chars]... ons: query.execute(...) took 3 ms. 18:02:34.782 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [70b46171]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1294f31c]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:35.162 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT166.5870modifiedFileVsDeletedFileCollisionOnClientfalsePASSED17:43:22.571 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:43:23.430 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' 17:43:23.726 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' locke ...[truncated 1775134 chars]... ons: query.execute(...) took 3 ms. 18:02:34.782 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [70b46171]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1294f31c]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:35.162 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT239.7660modifiedFileVsModifiedFileCollisionOnClientfalsePASSED17:43:22.571 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:43:23.430 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' 17:43:23.726 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' locke ...[truncated 1775134 chars]... ons: query.execute(...) took 3 ms. 18:02:34.782 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [70b46171]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1294f31c]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:35.162 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT166.1050deletedFileVsModifiedFileCollisionOnClientfalsePASSED17:43:22.571 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:43:23.430 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' 17:43:23.726 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' locke ...[truncated 1775134 chars]... ons: query.execute(...) took 3 ms. 18:02:34.782 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [70b46171]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1294f31c]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:35.162 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT139.690newFileVsNewDirectoryCollisionOnClientfalsePASSED17:43:22.571 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:43:23.430 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' 17:43:23.726 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' locke ...[truncated 1775134 chars]... ons: query.execute(...) took 3 ms. 18:02:34.782 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [70b46171]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1294f31c]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:35.162 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 1152.5859org.subshare.test.CollisionOnClientRepoToRepoSyncIT17:43:22.571 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:43:23.430 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' 17:43:23.726 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4637d6ca]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhrkt2-vh71b-local-src' locke ...[truncated 1775134 chars]... ons: query.execute(...) took 3 ms. 18:02:34.782 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [70b46171]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:34.784 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1294f31c]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:02:35.162 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:43:220org.subshare.test.CollisionOnServerRepoToRepoSyncIT369.4460newFileVsNewFileUploadedCollisionOnServerfalsePASSEDOct 14, 2017 5:28:33 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:36 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:17.940 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:21.544 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/jwiBWTN4nAWWTQHOm4ekTg/.subshare/ssl.server/keystore' does not exist! 17:28:21.555 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 811314 chars]... ons: query.execute(...) took 5 ms. 17:44:00.644 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 2 elements took 1 ms. 17:44:00.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6da7bf5f]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:44:00.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7ce7993d]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:44:00.978 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnServerRepoToRepoSyncIT552.8370newFileVsNewFileUploadingCollisionOnServerfalsePASSEDOct 14, 2017 5:28:33 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:36 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:17.940 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:21.544 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/jwiBWTN4nAWWTQHOm4ekTg/.subshare/ssl.server/keystore' does not exist! 17:28:21.555 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 811314 chars]... ons: query.execute(...) took 5 ms. 17:44:00.644 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 2 elements took 1 ms. 17:44:00.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6da7bf5f]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:44:00.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7ce7993d]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:44:00.978 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 922.28296org.subshare.test.CollisionOnServerRepoToRepoSyncITOct 14, 2017 5:28:33 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:36 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:17.940 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:21.544 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/jwiBWTN4nAWWTQHOm4ekTg/.subshare/ssl.server/keystore' does not exist! 17:28:21.555 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 811314 chars]... ons: query.execute(...) took 5 ms. 17:44:00.644 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 2 elements took 1 ms. 17:44:00.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6da7bf5f]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:44:00.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7ce7993d]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:44:00.978 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:28:380org.subshare.test.IgnoreRuleRepoToRepoSyncIT360.2020ignoreRulesAddedAfterFilesSyncedfalsePASSEDOct 14, 2017 5:28:39 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:43 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.700 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:21.623 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/2x_EF3VGIPzyuRO0E2Eijw/.subshare/ssl.server/keystore' does not exist! 17:28:21.627 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 903285 chars]... lose: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:45.920 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:42:45.920 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [74752867]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:45.922 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [ae05929]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:46.272 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.IgnoreRuleRepoToRepoSyncIT250.4560ignoreRulesBecomeDisabledfalsePASSEDOct 14, 2017 5:28:39 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:43 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.700 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:21.623 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/2x_EF3VGIPzyuRO0E2Eijw/.subshare/ssl.server/keystore' does not exist! 17:28:21.627 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 903285 chars]... lose: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:45.920 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:42:45.920 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [74752867]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:45.922 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [ae05929]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:46.272 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.IgnoreRuleRepoToRepoSyncIT229.7380ignoreRulesExistBeforeAffectedFilesfalsePASSEDOct 14, 2017 5:28:39 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:43 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.700 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:21.623 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/2x_EF3VGIPzyuRO0E2Eijw/.subshare/ssl.server/keystore' does not exist! 17:28:21.627 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 903285 chars]... lose: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:45.920 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:42:45.920 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [74752867]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:45.922 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [ae05929]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:46.272 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 840.396org.subshare.test.IgnoreRuleRepoToRepoSyncITOct 14, 2017 5:28:39 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:43 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.700 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:21.623 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/2x_EF3VGIPzyuRO0E2Eijw/.subshare/ssl.server/keystore' does not exist! 17:28:21.627 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 903285 chars]... lose: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:45.920 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:42:45.920 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [74752867]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:45.922 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [ae05929]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:46.272 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:28:450org.subshare.test.InterruptedRepoToRepoSyncIT208.3260interruptSyncDownAndResumefalsePASSED17:34:47.365 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:34:48.184 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [642a486d]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhgj8w-u3j9-local-src' 17:34:48.195 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [642a486d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhgj8w-u3j9-local-src' locked ...[truncated 428655 chars]... lose: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:04.812 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:42:04.882 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4c5e1cd]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:04.882 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4874cb33]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:05.291 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.InterruptedRepoToRepoSyncIT229.5980interruptSyncUpAndResumefalsePASSED17:34:47.365 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:34:48.184 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [642a486d]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhgj8w-u3j9-local-src' 17:34:48.195 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [642a486d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhgj8w-u3j9-local-src' locked ...[truncated 428655 chars]... lose: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:04.812 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:42:04.882 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4c5e1cd]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:04.882 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4874cb33]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:05.291 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 437.924org.subshare.test.InterruptedRepoToRepoSyncIT17:34:47.365 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:34:48.184 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [642a486d]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhgj8w-u3j9-local-src' 17:34:48.195 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [642a486d]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhgj8w-u3j9-local-src' locked ...[truncated 428655 chars]... lose: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:04.812 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:42:04.882 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4c5e1cd]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:04.882 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4874cb33]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:05.291 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:34:470org.subshare.test.InviteUserAndSyncIT116.4930inviteUserAndSync_singleReadPermissionOnSubdirfalsePASSED18:02:35.598 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 18:02:35.599 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 18:02:35.953 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 18:02:35.964 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 18:02:35.966 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 929307 chars]... <<< inviteUserAndSync_singleReadPermissionOnRoot <<< *** 18:07:54.312 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 18:07:54.312 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [22271685]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:07:54.313 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c45e919]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:07:54.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.InviteUserAndSyncIT107.2080inviteUserAndSync_singleWritePermissionOnRootfalsePASSED18:02:35.598 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 18:02:35.599 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 18:02:35.953 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 18:02:35.964 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 18:02:35.966 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 929307 chars]... <<< inviteUserAndSync_singleReadPermissionOnRoot <<< *** 18:07:54.312 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 18:07:54.312 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [22271685]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:07:54.313 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c45e919]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:07:54.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.InviteUserAndSyncIT95.3760inviteUserAndSync_singleReadPermissionOnRootfalsePASSED18:02:35.598 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 18:02:35.599 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 18:02:35.953 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 18:02:35.964 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 18:02:35.966 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 929307 chars]... <<< inviteUserAndSync_singleReadPermissionOnRoot <<< *** 18:07:54.312 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 18:07:54.312 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [22271685]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:07:54.313 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c45e919]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:07:54.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 319.077org.subshare.test.InviteUserAndSyncIT18:02:35.598 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 18:02:35.599 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 18:02:35.953 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 18:02:35.964 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 18:02:35.966 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 929307 chars]... <<< inviteUserAndSync_singleReadPermissionOnRoot <<< *** 18:07:54.312 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 18:07:54.312 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [22271685]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:07:54.313 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c45e919]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:07:54.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T16:02:350org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT327.5610inviteUserAndSync_withMetaOnly_singleWritePermissionOnRootfalsePASSED17:36:38.460 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 17:36:38.460 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 17:36:38.852 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:36:38.855 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:36:38.855 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 393126 chars]... ly_singleWritePermissionOnRoot <<< *** 17:42:05.617 [Test worker] INFO o.s.t.InviteUserWithNormalAndMetaOnlyRepoIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 17:42:05.618 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [70b5e22c]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:05.619 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [61acbd86]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:06.018 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 327.561org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT17:36:38.460 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 17:36:38.460 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 17:36:38.852 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:36:38.855 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:36:38.855 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 393126 chars]... ly_singleWritePermissionOnRoot <<< *** 17:42:05.617 [Test worker] INFO o.s.t.InviteUserWithNormalAndMetaOnlyRepoIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 17:42:05.618 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [70b5e22c]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:05.619 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [61acbd86]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:42:06.018 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:36:380org.subshare.test.Issue4IT128.3120issue_4_syncFileDeletedAfterLocalSyncfalsePASSED17:41:13.566 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:41:15.065 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [609e2bda]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhotrc-yo93w-local-src' 17:41:15.071 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [609e2bda]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhotrc-yo93w-local-src' locke ...[truncated 143662 chars]... nsaction.localRevision=92 remoteFromLocalRevision=144 17:43:21.418 [qtp279364781-1527] INFO c.c.c.l.LocalRepoManagerImpl - [6d54b9aa]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:43:21.421 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:43:21.421 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [609e2bda]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:43:21.874 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 128.312org.subshare.test.Issue4IT17:41:13.566 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:41:15.065 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [609e2bda]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhotrc-yo93w-local-src' 17:41:15.071 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [609e2bda]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhotrc-yo93w-local-src' locke ...[truncated 143662 chars]... nsaction.localRevision=92 remoteFromLocalRevision=144 17:43:21.418 [qtp279364781-1527] INFO c.c.c.l.LocalRepoManagerImpl - [6d54b9aa]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:43:21.421 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:43:21.421 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [609e2bda]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:43:21.874 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:41:130org.subshare.test.Issue5IT463.4540issue_5_inviteMultipleFriendsfalsePASSEDOct 14, 2017 5:28:48 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:52 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:17.867 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:21.476 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/tMOIUwFwSn01Wp0eC-0T_A/.subshare/ssl.server/keystore' does not exist! 17:28:21.479 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 477294 chars]... ing...: 100.00% 17:36:38.097 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1a904f08]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:36:38.098 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [53b2dacc]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:36:38.098 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [3f1b2d15]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:36:38.419 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 463.454org.subshare.test.Issue5ITOct 14, 2017 5:28:48 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:52 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:17.867 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:21.476 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/tMOIUwFwSn01Wp0eC-0T_A/.subshare/ssl.server/keystore' does not exist! 17:28:21.479 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 477294 chars]... ing...: 100.00% 17:36:38.097 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1a904f08]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:36:38.098 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [53b2dacc]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:36:38.098 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [3f1b2d15]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:36:38.419 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:28:540org.subshare.test.Issue8IT546.6390issue_8_threesomeWithFreshmenfalsePASSED 17:44:06.307 [Test worker] INFO o.s.t.AbstractMultiUserIT - 17:44:06.310 [Test worker] INFO o.s.t.AbstractMultiUserIT - ******************************************************************** 17:44:06.311 [Test worker] INFO o.s.t.AbstractMultiUserIT - *** marco *** 17:44:06.321 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:44:06.322 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<GnuPgDir>.getInstance: testUser=marco 17:44:06.326 [Test worker] INFO o.s.t.PgpTestU ...[truncated 1189125 chars]... nager 20000 ms. 17:53:05.098 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<ServerRepoRegistryImpl>.getInstance: testUser=xenia 17:53:05.099 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<UserRegistryImpl>.getInstance: testUser=xenia 17:53:05.138 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<UserRegistryImpl>.getInstance: testUser=xenia 17:53:05.139 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [49073ca6]close: Deferring shut down of real LocalRepoManager 20000 ms. 546.639org.subshare.test.Issue8IT 17:44:06.307 [Test worker] INFO o.s.t.AbstractMultiUserIT - 17:44:06.310 [Test worker] INFO o.s.t.AbstractMultiUserIT - ******************************************************************** 17:44:06.311 [Test worker] INFO o.s.t.AbstractMultiUserIT - *** marco *** 17:44:06.321 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:44:06.322 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<GnuPgDir>.getInstance: testUser=marco 17:44:06.326 [Test worker] INFO o.s.t.PgpTestU ...[truncated 1189125 chars]... nager 20000 ms. 17:53:05.098 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<ServerRepoRegistryImpl>.getInstance: testUser=xenia 17:53:05.099 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<UserRegistryImpl>.getInstance: testUser=xenia 17:53:05.138 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<UserRegistryImpl>.getInstance: testUser=xenia 17:53:05.139 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [49073ca6]close: Deferring shut down of real LocalRepoManager 20000 ms. 2017-10-14T15:44:010org.subshare.test.LocalServerClientIT2.3810invokeSimpleStaticMethodfalsePASSEDOct 14, 2017 5:28:41 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:44 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.940 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.640 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/_4Kz0elnrvTGDdVOI0bwmQ/.subshare/ssl.server/keystore' does not exist! 17:28:22.643 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 75984 chars]... :54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 17:28:56.566 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.LocalServerClientIT5.4780invokeDeniedMethodsfalsePASSEDOct 14, 2017 5:28:41 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:44 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.940 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.640 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/_4Kz0elnrvTGDdVOI0bwmQ/.subshare/ssl.server/keystore' does not exist! 17:28:22.643 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 75984 chars]... :54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 17:28:56.566 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 7.859org.subshare.test.LocalServerClientITOct 14, 2017 5:28:41 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:28:44 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:18.940 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.640 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/_4Kz0elnrvTGDdVOI0bwmQ/.subshare/ssl.server/keystore' does not exist! 17:28:22.643 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 75984 chars]... :54) [gradle-base-services-3.1.jar:3.1] at org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_131] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_131] at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131] 17:28:56.566 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:28:480org.subshare.test.LockerSyncIT21.5030syncServerRegistryfalsePASSED17:42:09.265 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:42:09.330 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/7SB6GrOW5-odmEXRZfzmPg/client1/.gnupg/pubring.gpg' 17:42:09.331 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subs ...[truncated 138616 chars]... ker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 17:42:39.966 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - decodeEncrypted: encryptingPgpKeyIds=[a58da7d810b74edf] 17:42:40.072 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 17:42:42.444 [Timer-3] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.UnknownHostException: server1.domain.tld 0org.subshare.test.LockerSyncIT13.5590syncUserRegistryfalsePASSED17:42:09.265 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:42:09.330 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/7SB6GrOW5-odmEXRZfzmPg/client1/.gnupg/pubring.gpg' 17:42:09.331 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subs ...[truncated 138616 chars]... ker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 17:42:39.966 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - decodeEncrypted: encryptingPgpKeyIds=[a58da7d810b74edf] 17:42:40.072 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 17:42:42.444 [Timer-3] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.UnknownHostException: server1.domain.tld 35.062org.subshare.test.LockerSyncIT17:42:09.265 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:42:09.330 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/7SB6GrOW5-odmEXRZfzmPg/client1/.gnupg/pubring.gpg' 17:42:09.331 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subs ...[truncated 138616 chars]... ker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 17:42:39.966 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - decodeEncrypted: encryptingPgpKeyIds=[a58da7d810b74edf] 17:42:40.072 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 17:42:42.444 [Timer-3] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.UnknownHostException: server1.domain.tld 2017-10-14T15:42:050org.subshare.test.MetaOnlyRepoSyncIT298.3390syncFromLocalToRemoteToMetaOnlyAddingFilesfalsePASSEDOct 14, 2017 5:29:05 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:29:10 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:19.280 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.703 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/464K7M23Y8utTa6ZtNLZPA/.subshare/ssl.server/keystore' does not exist! 17:28:22.708 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 594174 chars]... o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08% 17:41:12.796 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:41:12.809 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2d0b8d2d]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:41:12.810 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6473bf19]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:41:13.145 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.MetaOnlyRepoSyncIT160.0040syncFromLocalToRemoteToMetaOnlyfalsePASSEDOct 14, 2017 5:29:05 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:29:10 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:19.280 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.703 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/464K7M23Y8utTa6ZtNLZPA/.subshare/ssl.server/keystore' does not exist! 17:28:22.708 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 594174 chars]... o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08% 17:41:12.796 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:41:12.809 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2d0b8d2d]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:41:12.810 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6473bf19]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:41:13.145 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.MetaOnlyRepoSyncIT261.6450syncFromLocalToRemoteToMetaOnlyRemovingFilesfalsePASSEDOct 14, 2017 5:29:05 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:29:10 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:19.280 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.703 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/464K7M23Y8utTa6ZtNLZPA/.subshare/ssl.server/keystore' does not exist! 17:28:22.708 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 594174 chars]... o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08% 17:41:12.796 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:41:12.809 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2d0b8d2d]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:41:12.810 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6473bf19]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:41:13.145 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 719.988org.subshare.test.MetaOnlyRepoSyncITOct 14, 2017 5:29:05 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Oct 14, 2017 5:29:10 PM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 17:28:19.280 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 17:28:22.703 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/464K7M23Y8utTa6ZtNLZPA/.subshare/ssl.server/keystore' does not exist! 17:28:22.708 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 594174 chars]... o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08% 17:41:12.796 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:41:12.809 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2d0b8d2d]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:41:12.810 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6473bf19]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:41:13.145 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:29:130org.subshare.test.MultiplePgpKeysSingleUserRegistryIT4.1290multiplePgpKeysSingleUserRegistryfalsePASSED17:35:17.128 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:35:17.130 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/_4Kz0elnrvTGDdVOI0bwmQ/.gnupg/pubring.gpg' 17:35:17.327 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org ...[truncated 2804 chars]... y pair with publicExponent='65537' strength='1024' certainty='12' took 31 ms. 17:35:20.515 [Test worker] DEBUG o.s.c.u.UserImpl - createUserRepoKey: pgpKey=PgpKey[bbef20af171556db, [Alexander Bieber (TEST) <alex@nightlabs.de>]], userRepoKey=UserRepoKeyImpl[userRepoKeyId=DoERbWp4qM_-r3mR08vyxA, invitation=false] 17:35:20.562 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 17:35:20.961 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 4.129org.subshare.test.MultiplePgpKeysSingleUserRegistryIT17:35:17.128 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:35:17.130 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/_4Kz0elnrvTGDdVOI0bwmQ/.gnupg/pubring.gpg' 17:35:17.327 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org ...[truncated 2804 chars]... y pair with publicExponent='65537' strength='1024' certainty='12' took 31 ms. 17:35:20.515 [Test worker] DEBUG o.s.c.u.UserImpl - createUserRepoKey: pgpKey=PgpKey[bbef20af171556db, [Alexander Bieber (TEST) <alex@nightlabs.de>]], userRepoKey=UserRepoKeyImpl[userRepoKeyId=DoERbWp4qM_-r3mR08vyxA, invitation=false] 17:35:20.562 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 17:35:20.961 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:35:160org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT370.7540parentConfigWithRemotePathPrefixfalsePASSED17:29:05.790 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:29:06.574 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [40e7786f]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rh97jj-fnr3r-local-src' 17:29:06.589 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [40e7786f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rh97jj-fnr3r-local-src' locke ...[truncated 482855 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 17:35:16.173 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:35:16.212 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [40e7786f]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:35:16.213 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60ade9a2]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:35:16.511 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 370.754org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT17:29:05.790 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:29:06.574 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [40e7786f]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rh97jj-fnr3r-local-src' 17:29:06.589 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [40e7786f]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rh97jj-fnr3r-local-src' locke ...[truncated 482855 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 17:35:16.173 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:35:16.212 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [40e7786f]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:35:16.213 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60ade9a2]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:35:16.511 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:29:050org.subshare.test.PermissionIT252.9780interruptPermissionSetInheritancefalsePASSED17:42:46.636 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:47.327 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1429efac]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhqsyh-8xrce-local-src' 17:42:47.336 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1429efac]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhqsyh-8xrce-local-src' locke ...[truncated 1264033 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.387 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:57:41.425 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [58932d9b]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.426 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2138206f]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.793 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.PermissionIT294.3570uploadBackdatedSignaturefalsePASSED17:42:46.636 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:47.327 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1429efac]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhqsyh-8xrce-local-src' 17:42:47.336 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1429efac]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhqsyh-8xrce-local-src' locke ...[truncated 1264033 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.387 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:57:41.425 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [58932d9b]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.426 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2138206f]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.793 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.PermissionIT347.8190nonOwnerAdminGrantsWritePermissionfalsePASSED17:42:46.636 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:47.327 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1429efac]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhqsyh-8xrce-local-src' 17:42:47.336 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1429efac]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhqsyh-8xrce-local-src' locke ...[truncated 1264033 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.387 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:57:41.425 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [58932d9b]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.426 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2138206f]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.793 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 895.15393org.subshare.test.PermissionIT17:42:46.636 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:47.327 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1429efac]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhqsyh-8xrce-local-src' 17:42:47.336 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1429efac]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhqsyh-8xrce-local-src' locke ...[truncated 1264033 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.387 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 17:57:41.425 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [58932d9b]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.426 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2138206f]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:57:41.793 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:42:460org.subshare.test.PgpSyncIT2.30testPgpSyncfalsePASSED18:03:58.908 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 18:04:01.199 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2.3org.subshare.test.PgpSyncIT18:03:58.908 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 18:04:01.199 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T16:03:580org.subshare.test.ReadUserIdentityIT211.3720inviteWithReadInvitationAndGrantReadUserIdentityPermissionLaterfalsePASSED17:57:42.200 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 17:57:42.200 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 17:57:42.589 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:57:42.615 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:57:42.616 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 423083 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:01:12.766 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:01:13.166 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [20449f44]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:01:13.169 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [749d8357]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:01:13.566 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 211.372org.subshare.test.ReadUserIdentityIT17:57:42.200 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 17:57:42.200 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 17:57:42.589 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:57:42.615 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 17:57:42.616 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 423083 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:01:12.766 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:01:13.166 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [20449f44]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:01:13.169 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [749d8357]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:01:13.566 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:57:420org.subshare.test.RepoToRepoSyncIT273.1110syncFromLocalToRemoteToLocalWithPathPrefixWithWritePermissionGrantedAndRevokedfalsePASSED17:42:06.053 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:07.193 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' 17:42:07.198 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' locked ...[truncated 2020241 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:55.974 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:03:56.012 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [46546ac5]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.021 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [389a7219]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT182.7450syncFromLocalToRemoteToLocalfalsePASSED17:42:06.053 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:07.193 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' 17:42:07.198 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' locked ...[truncated 2020241 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:55.974 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:03:56.012 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [46546ac5]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.021 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [389a7219]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT112.1510syncFromLocalToRemoteToLocalWithPathPrefixWithoutSubdirClearanceKeyfalsePASSED17:42:06.053 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:07.193 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' 17:42:07.198 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' locked ...[truncated 2020241 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:55.974 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:03:56.012 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [46546ac5]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.021 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [389a7219]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT144.6970syncFromLocalToRemoteToLocalWithPathPrefixfalsePASSED17:42:06.053 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:07.193 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' 17:42:07.198 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' locked ...[truncated 2020241 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:55.974 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:03:56.012 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [46546ac5]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.021 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [389a7219]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT211.4620syncFromLocalToRemoteToLocalThenDeleteFileAndSyncAgainfalsePASSED17:42:06.053 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:07.193 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' 17:42:07.198 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' locked ...[truncated 2020241 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:55.974 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:03:56.012 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [46546ac5]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.021 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [389a7219]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT262.9180syncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKeyfalsePASSED17:42:06.053 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:07.193 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' 17:42:07.198 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' locked ...[truncated 2020241 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:55.974 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:03:56.012 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [46546ac5]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.021 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [389a7219]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 40org.subshare.test.RepoToRepoSyncIT0.0257syncFromLocalToRemoteToLocalThenCauseDeleteCollisionOnServerDuringUpSynctrueSKIPPED17:42:06.053 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:07.193 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' 17:42:07.198 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' locked ...[truncated 2020241 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:55.974 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:03:56.012 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [46546ac5]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.021 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [389a7219]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT123.2460multiSyncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKeyfalsePASSED17:42:06.053 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:07.193 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' 17:42:07.198 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' locked ...[truncated 2020241 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:55.974 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:03:56.012 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [46546ac5]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.021 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [389a7219]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 1310.33org.subshare.test.RepoToRepoSyncIT17:42:06.053 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 17:42:07.193 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' 17:42:07.198 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60b4b749]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/j8rhpxzk-ae0q-local-src' locked ...[truncated 2020241 chars]... ose: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:55.974 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 18:03:56.012 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [46546ac5]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.021 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [389a7219]close: Deferring shut down of real LocalRepoManager 20000 ms. 18:03:56.414 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:42:060org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncIT257.3550newFileVsNewSymlinkCollisionOnClientfalsePASSEDjavax.ws.rs.ProcessingException: java.net.UnknownHostException: server1.domain.tld 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 ...[truncated 734005 chars]... ns: query.execute(...) took 17 ms. 17:46:59.373 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 17:46:59.375 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [30f14f46]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:46:59.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6bb49cc8]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:46:59.878 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 257.355org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncITjavax.ws.rs.ProcessingException: java.net.UnknownHostException: server1.domain.tld 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 ...[truncated 734005 chars]... ns: query.execute(...) took 17 ms. 17:46:59.373 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 17:46:59.375 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [30f14f46]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:46:59.379 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6bb49cc8]close: Deferring shut down of real LocalRepoManager 20000 ms. 17:46:59.878 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-10-14T15:42:42