10880.834false011120org.subshare.core.crypto.EncrypterDecrypterStreamTest10.9080symmetricWithoutIvfalsePASSED symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 7269202 random bytes plaintext took 58 ms. 07:46:31.409 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 586 ms. symmetricWithoutIv: Encrypting 7269202 bytes plaintext to 7269222 bytes ciphertext took 478 ms. symmetricWithoutIv: Decrypting 7269222 bytes ciphertext to 7269202 bytes plaintext took 359 ms. ...[truncated 37214 chars]... 6589 bytes plaintext took 294 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 9473975 random bytes plaintext took 56 ms. asymmetricCombiWithRandomIv: Encrypting 9473975 bytes plaintext to 9474519 bytes ciphertext took 511 ms. asymmetricCombiWithRandomIv: Decrypting 9474519 bytes ciphertext to 9473975 bytes plaintext took 638 ms. 0org.subshare.core.crypto.EncrypterDecrypterStreamTest12.9230symmetricWithRandomIvfalsePASSED symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 7269202 random bytes plaintext took 58 ms. 07:46:31.409 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 586 ms. symmetricWithoutIv: Encrypting 7269202 bytes plaintext to 7269222 bytes ciphertext took 478 ms. symmetricWithoutIv: Decrypting 7269222 bytes ciphertext to 7269202 bytes plaintext took 359 ms. ...[truncated 37214 chars]... 6589 bytes plaintext took 294 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 9473975 random bytes plaintext took 56 ms. asymmetricCombiWithRandomIv: Encrypting 9473975 bytes plaintext to 9474519 bytes ciphertext took 511 ms. asymmetricCombiWithRandomIv: Decrypting 9474519 bytes ciphertext to 9473975 bytes plaintext took 638 ms. 0org.subshare.core.crypto.EncrypterDecrypterStreamTest25.3020asymmetricPlainfalsePASSED symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 7269202 random bytes plaintext took 58 ms. 07:46:31.409 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 586 ms. symmetricWithoutIv: Encrypting 7269202 bytes plaintext to 7269222 bytes ciphertext took 478 ms. symmetricWithoutIv: Decrypting 7269222 bytes ciphertext to 7269202 bytes plaintext took 359 ms. ...[truncated 37214 chars]... 6589 bytes plaintext took 294 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 9473975 random bytes plaintext took 56 ms. asymmetricCombiWithRandomIv: Encrypting 9473975 bytes plaintext to 9474519 bytes ciphertext took 511 ms. asymmetricCombiWithRandomIv: Decrypting 9474519 bytes ciphertext to 9473975 bytes plaintext took 638 ms. 0org.subshare.core.crypto.EncrypterDecrypterStreamTest13.8150asymmetricCombiWithRandomIvfalsePASSED symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 7269202 random bytes plaintext took 58 ms. 07:46:31.409 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 586 ms. symmetricWithoutIv: Encrypting 7269202 bytes plaintext to 7269222 bytes ciphertext took 478 ms. symmetricWithoutIv: Decrypting 7269222 bytes ciphertext to 7269202 bytes plaintext took 359 ms. ...[truncated 37214 chars]... 6589 bytes plaintext took 294 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 9473975 random bytes plaintext took 56 ms. asymmetricCombiWithRandomIv: Encrypting 9473975 bytes plaintext to 9474519 bytes ciphertext took 511 ms. asymmetricCombiWithRandomIv: Decrypting 9474519 bytes ciphertext to 9473975 bytes plaintext took 638 ms. 62.948org.subshare.core.crypto.EncrypterDecrypterStreamTest symmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING symmetricWithoutIv: Generating 7269202 random bytes plaintext took 58 ms. 07:46:31.409 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory symmetricWithoutIv: Creating symmetric key took 586 ms. symmetricWithoutIv: Encrypting 7269202 bytes plaintext to 7269222 bytes ciphertext took 478 ms. symmetricWithoutIv: Decrypting 7269222 bytes ciphertext to 7269202 bytes plaintext took 359 ms. ...[truncated 37214 chars]... 6589 bytes plaintext took 294 ms. asymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING asymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING asymmetricCombiWithRandomIv: Generating 9473975 random bytes plaintext took 56 ms. asymmetricCombiWithRandomIv: Encrypting 9473975 bytes plaintext to 9474519 bytes ciphertext took 511 ms. asymmetricCombiWithRandomIv: Decrypting 9474519 bytes ciphertext to 9473975 bytes plaintext took 638 ms. 2017-04-01T05:46:310org.subshare.core.file.EncryptedDataFileTest2.4990writeReadSimpleEncryptedDataFilefalsePASSED2.499org.subshare.core.file.EncryptedDataFileTest2017-04-01T05:46:240org.subshare.core.gpg.GnuPgTest5.7440encryptSignAndDecryptVerifyfalsePASSED>>> 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.9430encryptAndDecryptfalsePASSED>>> 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.1570readPubringGpgfalsePASSED>>> 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.0060readSecringGpgfalsePASSED>>> 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 <<< 6.85org.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-04-01T05:46:240org.subshare.core.io.LimitedInputStreamTest2.2710randomLengthWithUnderlyingSameLengthfalsePASSED2.271org.subshare.core.io.LimitedInputStreamTest2017-04-01T05:46:220org.subshare.core.io.MultiInputStreamTest7.4380randomCombifalsePASSED7.438org.subshare.core.io.MultiInputStreamTest2017-04-01T05:46:220org.subshare.core.pgp.PgpTest2.1870inlineSignThenEncryptAndDecryptThenVerifyfalsePASSED07:46:30.081 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:30.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:30.158 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.768 [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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 07:46:41.872 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.pgp.PgpTest0.1760signAndVerifyViaPgpSignablefalsePASSED07:46:30.081 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:30.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:30.158 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.768 [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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 07:46:41.872 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.pgp.PgpTest2.6770inlineSignAndVerifyfalsePASSED07:46:30.081 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:30.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:30.158 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.768 [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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 07:46:41.872 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.pgp.PgpTest0.2150exportImportPublicKeyfalsePASSED07:46:30.081 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:30.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:30.158 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.768 [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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 07:46:41.872 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.pgp.PgpTest5.9480detachedSignAndVerifyfalsePASSED07:46:30.081 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:30.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:30.158 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.768 [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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 07:46:41.872 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 11.203org.subshare.core.pgp.PgpTest07:46:30.081 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:30.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:30.158 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/DM031QYvfLiVcsSr8JZEVQ/.gnupg 07:46:30.768 [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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 07:46:41.872 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:46:300org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest3.5850addAllDifferentUserRepoKeyPublicKeysToUserfalsePASSED0org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest0.0040addAllSameUserRepoKeyPublicKeyInCollectionToUserfalsePASSED0org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest0.0040addSameUserRepoKeyPublicKeyTwiceToUserfalsePASSED0org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest0.0030addDifferentUserRepoKeyPublicKeysToUserfalsePASSED3.596org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest2017-04-01T05:46:220org.subshare.core.user.UserRegistryTest3.8660addUserfalsePASSED07:46:25.958 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:26.212 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:26.338 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/7tNVGa7b0Wd9i7d-8QG7zQ/.gnupg 07:46:26.342 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/7tNVGa7b0Wd9i7d-8QG7zQ/.gnupg 07:46:27.499 [Test ...[truncated 14043 chars]... rying. 07:46:49.553 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.273 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 8716 ms. 07:46:58.345 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.620 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.744 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.user.UserRegistryTest8.9830testGpgKeyTrustLevelsfalsePASSED07:46:25.958 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:26.212 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:26.338 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/7tNVGa7b0Wd9i7d-8QG7zQ/.gnupg 07:46:26.342 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/7tNVGa7b0Wd9i7d-8QG7zQ/.gnupg 07:46:27.499 [Test ...[truncated 14043 chars]... rying. 07:46:49.553 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.273 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 8716 ms. 07:46:58.345 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.620 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.744 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.core.user.UserRegistryTest19.7990initUserRegistryFromGpgKeysfalsePASSED07:46:25.958 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:26.212 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:26.338 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/7tNVGa7b0Wd9i7d-8QG7zQ/.gnupg 07:46:26.342 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/7tNVGa7b0Wd9i7d-8QG7zQ/.gnupg 07:46:27.499 [Test ...[truncated 14043 chars]... rying. 07:46:49.553 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.273 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 8716 ms. 07:46:58.345 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.620 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.744 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 32.648org.subshare.core.user.UserRegistryTest07:46:25.958 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:46:26.212 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:46:26.338 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/7tNVGa7b0Wd9i7d-8QG7zQ/.gnupg 07:46:26.342 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/7tNVGa7b0Wd9i7d-8QG7zQ/.gnupg 07:46:27.499 [Test ...[truncated 14043 chars]... rying. 07:46:49.553 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.273 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 8716 ms. 07:46:58.345 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.620 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance. 07:46:58.744 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:46:260org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest2.9310firstAddPublicKeysThenCreateUserRepoKeyRingfalsePASSED0org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest0.0520firstCreateUserRepoKeyRingThenAddPublicKeysfalsePASSED2.983org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest2017-04-01T05:46:221org.subshare.crypto.AsymmetricKeyTest0.007257generateManySymmetricKeystrueSKIPPED0org.subshare.crypto.AsymmetricKeyTest11.5660encodeDecodeRSAwithOAEPwithSHA1andMGF1PaddingfalsePASSED0org.subshare.crypto.AsymmetricKeyTest6.50encodeDecodeRSAfalsePASSED18.073org.subshare.crypto.AsymmetricKeyTest2017-04-01T05:47:450org.subshare.crypto.CipherTest2.6610testLookupAllSupportedCiphersfalsePASSED07:47:54.831 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2493 msec. 07:47:55.107 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 07:47:55.111 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 07:47:55.114 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 07:47:55.118 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.092 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 07:48:08.330 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 07:48:08.666 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 07:48:08.780 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.855 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 0org.subshare.crypto.CipherTest9.9150testNullAsKeyParameterfalsePASSED07:47:54.831 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2493 msec. 07:47:55.107 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 07:47:55.111 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 07:47:55.114 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 07:47:55.118 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.092 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 07:48:08.330 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 07:48:08.666 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 07:48:08.780 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.855 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 0org.subshare.crypto.CipherTest0.1060testLookupCompatibilityWithJCEfalsePASSED07:47:54.831 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2493 msec. 07:47:55.107 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 07:47:55.111 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 07:47:55.114 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 07:47:55.118 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.092 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 07:48:08.330 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 07:48:08.666 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 07:48:08.780 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.855 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 0org.subshare.crypto.CipherTest4.0130testSymmetricEncryptionWithoutIvfalsePASSED07:47:54.831 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2493 msec. 07:47:55.107 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 07:47:55.111 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 07:47:55.114 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 07:47:55.118 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.092 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 07:48:08.330 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 07:48:08.666 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 07:48:08.780 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.855 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 0org.subshare.crypto.CipherTest0.1130testSymmetricEncryptionCompatibilityWithJCE_BouncyCastleProviderfalsePASSED07:47:54.831 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2493 msec. 07:47:55.107 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 07:47:55.111 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 07:47:55.114 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 07:47:55.118 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.092 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 07:48:08.330 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 07:48:08.666 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 07:48:08.780 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.855 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 16.808org.subshare.crypto.CipherTest07:47:54.831 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2493 msec. 07:47:55.107 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST// 07:47:55.111 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation "AES.FAST//" does not support IV => Skipping. 07:47:55.114 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING 07:47:55.118 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP ...[truncated 3456005 chars]... s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.092 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 07:48:08.330 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding 07:48:08.666 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding 07:48:08.780 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding 07:48:08.855 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding 2017-04-01T05:47:520org.subshare.crypto.GCMTest10.5120testEncryptionWithCipherfalsePASSED*** 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.9330testEncryptionWithBCLowLevelAPIfalsePASSED*** 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 *** 13.445org.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-04-01T05:47:460org.subshare.crypto.MACBenchmark0.1560testByteOrderfalsePASSED07:47:49.010 [Test worker] INFO o.s.c.MACBenchmark - short1 = 23522 07:47:49.071 [Test worker] INFO o.s.c.MACBenchmark - short2 = 23522 07:47:49.079 [Test worker] INFO o.s.c.MACBenchmark - int1 = 23522 0org.subshare.crypto.MACBenchmark5.8330benchmarkCreateManyInitialisedMACCalculatorsfalsePASSED07:47:49.010 [Test worker] INFO o.s.c.MACBenchmark - short1 = 23522 07:47:49.071 [Test worker] INFO o.s.c.MACBenchmark - short2 = 23522 07:47:49.079 [Test worker] INFO o.s.c.MACBenchmark - int1 = 23522 0org.subshare.crypto.MACBenchmark0.2750benchmarkCreateManyUNinitialisedMACCalculatorsfalsePASSED07:47:49.010 [Test worker] INFO o.s.c.MACBenchmark - short1 = 23522 07:47:49.071 [Test worker] INFO o.s.c.MACBenchmark - short2 = 23522 07:47:49.079 [Test worker] INFO o.s.c.MACBenchmark - int1 = 23522 0org.subshare.crypto.MACBenchmark21.3630benchmarkCalculateManyMACsWithNewMACCalculatorfalsePASSED07:47:49.010 [Test worker] INFO o.s.c.MACBenchmark - short1 = 23522 07:47:49.071 [Test worker] INFO o.s.c.MACBenchmark - short2 = 23522 07:47:49.079 [Test worker] INFO o.s.c.MACBenchmark - int1 = 23522 0org.subshare.crypto.MACBenchmark13.8840benchmarkCalculateManyMACsWithSameMACCalculatorfalsePASSED07:47:49.010 [Test worker] INFO o.s.c.MACBenchmark - short1 = 23522 07:47:49.071 [Test worker] INFO o.s.c.MACBenchmark - short2 = 23522 07:47:49.079 [Test worker] INFO o.s.c.MACBenchmark - int1 = 23522 41.511org.subshare.crypto.MACBenchmark07:47:49.010 [Test worker] INFO o.s.c.MACBenchmark - short1 = 23522 07:47:49.071 [Test worker] INFO o.s.c.MACBenchmark - short2 = 23522 07:47:49.079 [Test worker] INFO o.s.c.MACBenchmark - int1 = 23522 2017-04-01T05:47:480org.subshare.crypto.MACTest4.4760testAllSupportedMACsfalsePASSED4.476org.subshare.crypto.MACTest2017-04-01T05:47:490org.subshare.crypto.ShowSupportedAlgosForDocumentation0.2830showSupportedBlockCipherModesfalsePASSED>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** 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.1090showSupportedCipherEnginesfalsePASSED>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** 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.1070showSupportedMACsfalsePASSED>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** 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.0770showSupportedPaddingsfalsePASSED>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> *** 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.576org.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-04-01T05:47:490org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest79.1530grantAndRevokeReadPermissionfalsePASSED07:48:56.166 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.462 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.823 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [30a99cf3]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu870g-rbe9s-local' 07:48:59.199 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1808 ms. 07 ...[truncated 29437 chars]... NFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83% 07:50:15.018 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55% 07:50:15.047 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00% 07:50:15.404 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [30a99cf3]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:50:15.408 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 79.153org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest07:48:56.166 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.462 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.823 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [30a99cf3]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu870g-rbe9s-local' 07:48:59.199 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1808 ms. 07 ...[truncated 29437 chars]... NFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83% 07:50:15.018 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55% 07:50:15.047 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00% 07:50:15.404 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [30a99cf3]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:50:15.408 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:48:560org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest65.8690grantWritePermissionWithoutGrantPermissionfalsePASSED07:48:56.474 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.790 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4fd69d37]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu8732-8tuce-local' 07:48:59.007 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 993 ms. 07: ...[truncated 128131 chars]... Test - Local sync...: 79.60% 07:53:18.124 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 07:53:18.144 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 07:53:18.162 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 07:53:18.191 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60c99b8b]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:53:18.193 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest36.5970writeWithWritePermissionInParentParentfalsePASSED07:48:56.474 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.790 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4fd69d37]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu8732-8tuce-local' 07:48:59.007 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 993 ms. 07: ...[truncated 128131 chars]... Test - Local sync...: 79.60% 07:53:18.124 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 07:53:18.144 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 07:53:18.162 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 07:53:18.191 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60c99b8b]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:53:18.193 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest32.9610writeWithWritePermissionInParentfalsePASSED07:48:56.474 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.790 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4fd69d37]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu8732-8tuce-local' 07:48:59.007 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 993 ms. 07: ...[truncated 128131 chars]... Test - Local sync...: 79.60% 07:53:18.124 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 07:53:18.144 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 07:53:18.162 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 07:53:18.191 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60c99b8b]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:53:18.193 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest32.2860writeWithWritePermissionDirectDirfalsePASSED07:48:56.474 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.790 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4fd69d37]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu8732-8tuce-local' 07:48:59.007 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 993 ms. 07: ...[truncated 128131 chars]... Test - Local sync...: 79.60% 07:53:18.124 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 07:53:18.144 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 07:53:18.162 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 07:53:18.191 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60c99b8b]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:53:18.193 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest31.2810writeWithoutWritePermissionfalsePASSED07:48:56.474 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.790 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4fd69d37]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu8732-8tuce-local' 07:48:59.007 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 993 ms. 07: ...[truncated 128131 chars]... Test - Local sync...: 79.60% 07:53:18.124 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 07:53:18.144 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 07:53:18.162 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 07:53:18.191 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60c99b8b]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:53:18.193 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest28.7790writeWithWritePermissionInParentParentGrantedIndirectlyfalsePASSED07:48:56.474 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.790 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4fd69d37]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu8732-8tuce-local' 07:48:59.007 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 993 ms. 07: ...[truncated 128131 chars]... Test - Local sync...: 79.60% 07:53:18.124 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 07:53:18.144 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 07:53:18.162 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 07:53:18.191 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60c99b8b]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:53:18.193 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest33.7790writeWithWritePermissionDirectFilefalsePASSED07:48:56.474 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.790 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4fd69d37]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu8732-8tuce-local' 07:48:59.007 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 993 ms. 07: ...[truncated 128131 chars]... Test - Local sync...: 79.60% 07:53:18.124 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 07:53:18.144 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 07:53:18.162 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 07:53:18.191 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60c99b8b]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:53:18.193 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 261.552org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest07:48:56.474 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:56.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:48:58.790 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4fd69d37]<init>: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/j0yu8732-8tuce-local' 07:48:59.007 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 993 ms. 07: ...[truncated 128131 chars]... Test - Local sync...: 79.60% 07:53:18.124 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83% 07:53:18.144 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55% 07:53:18.162 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00% 07:53:18.191 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [60c99b8b]close: Deferring shut down of real LocalRepoManager 20000 ms. 07:53:18.193 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:48:560org.subshare.local.FilePaddingLengthRandomTest15.7250testDistributionfalsePASSED07:48:57.568 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory lengthCategory2HitCount: {_100K=300044, _1M=147637, _10M=47252, _100M=2958, _1G=2109, _10G=0} lengthCategory2HitPercentage: {_100K=600, _1M=295, _10M=95, _100M=6, _1G=4, _10G=0} 12975 0org.subshare.local.FilePaddingLengthRandomTest0.0690generateOneRandomLengthfalsePASSED07:48:57.568 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory lengthCategory2HitCount: {_100K=300044, _1M=147637, _10M=47252, _100M=2958, _1G=2109, _10G=0} lengthCategory2HitPercentage: {_100K=600, _1M=295, _10M=95, _100M=6, _1G=4, _10G=0} 12975 15.794001org.subshare.local.FilePaddingLengthRandomTest07:48:57.568 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory lengthCategory2HitCount: {_100K=300044, _1M=147637, _10M=47252, _100M=2958, _1G=2109, _10G=0} lengthCategory2HitPercentage: {_100K=600, _1M=295, _10M=95, _100M=6, _1G=4, _10G=0} 12975 2017-04-01T05:48:530org.subshare.local.persistence.CollisionTest3.7590xorUids1falsePASSED0org.subshare.local.persistence.CollisionTest0.0030xorUids2falsePASSED3.762org.subshare.local.persistence.CollisionTest2017-04-01T05:48:540org.subshare.local.sign.SignableTest2.360signAndSerializeAndVerifyfalsePASSED07:48:56.882 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.161 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.256 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1744 ms. 07:49:01.056 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.077 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 905 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 07:49:05.944 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.035 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.062 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.208 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignableTest0.1420signAndModifyCryptoKeyIdAndVerifyfalsePASSED07:48:56.882 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.161 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.256 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1744 ms. 07:49:01.056 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.077 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 905 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 07:49:05.944 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.035 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.062 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.208 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignableTest0.1260signAndVerifyfalsePASSED07:48:56.882 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.161 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.256 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1744 ms. 07:49:01.056 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.077 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 905 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 07:49:05.944 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.035 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.062 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.208 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignableTest0.0750signAndModifySignatureCreatedAndVerifyfalsePASSED07:48:56.882 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.161 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.256 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1744 ms. 07:49:01.056 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.077 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 905 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 07:49:05.944 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.035 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.062 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.208 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignableTest0.0980signAndModifyCryptoRepoFileIdAndVerifyfalsePASSED07:48:56.882 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.161 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.256 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1744 ms. 07:49:01.056 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.077 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 905 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 07:49:05.944 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.035 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.062 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.208 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2.8009999org.subshare.local.sign.SignableTest07:48:56.882 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.161 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.256 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1744 ms. 07:49:01.056 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.077 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 905 chars]... o.s.c.p.PgpRegistry - clearCache: entered. 07:49:05.944 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.035 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.062 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.105 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:06.208 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:49:030org.subshare.local.sign.SignerVerifierStreamTest19.1610signRsaWithSha1falsePASSED07:48:58.121 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.293 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.378 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1622 ms. 07:49:01.083 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 5060 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 07:49:59.646 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:59.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:50:13.430 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest0.090signAndVerifySimpleBlockReadfalsePASSED07:48:58.121 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.293 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.378 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1622 ms. 07:49:01.083 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 5060 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 07:49:59.646 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:59.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:50:13.430 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest20.8040sha1DigestfalsePASSED07:48:58.121 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.293 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.378 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1622 ms. 07:49:01.083 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 5060 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 07:49:59.646 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:59.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:50:13.430 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest3.4190signAndVerifyRandomBrokenfalsePASSED07:48:58.121 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.293 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.378 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1622 ms. 07:49:01.083 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 5060 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 07:49:59.646 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:59.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:50:13.430 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest12.4230signAndVerifyRandomManySmallfalsePASSED07:48:58.121 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.293 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.378 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1622 ms. 07:49:01.083 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 5060 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 07:49:59.646 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:59.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:50:13.430 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.local.sign.SignerVerifierStreamTest13.7820signAndVerifyRandomfalsePASSED07:48:58.121 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.293 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.378 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1622 ms. 07:49:01.083 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 5060 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 07:49:59.646 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:59.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:50:13.430 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 69.679org.subshare.local.sign.SignerVerifierStreamTest07:48:58.121 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:48:59.293 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:48:59.378 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1622 ms. 07:49:01.083 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg 07:49:01.092 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg 07 ...[truncated 5060 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 07:49:59.646 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:49:59.672 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:50:13.430 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:49:030org.subshare.rest.client.transport.CryptreeRepoTransportTest58.9710encryptAndSignAndVerifyAndDecryptfalsePASSED07:53:24.242 [Test worker] INFO c.c.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:53:24.791 [Test worker] DEBUG o.s.c.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:53:24.810 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next). 07:53:24.811 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - read: Reading propertie ...[truncated 44326 chars]... y='subshare.signerTransformation' is not set (config is queried next). 07:54:22.414 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next). 07:54:22.771 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no localRepoManager. 07:54:22.771 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport. 58.971org.subshare.rest.client.transport.CryptreeRepoTransportTest07:53:24.242 [Test worker] INFO c.c.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory 07:53:24.791 [Test worker] DEBUG o.s.c.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load(). 07:53:24.810 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next). 07:53:24.811 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - read: Reading propertie ...[truncated 44326 chars]... y='subshare.signerTransformation' is not set (config is queried next). 07:54:22.414 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next). 07:54:22.771 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no localRepoManager. 07:54:22.771 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport. 2017-04-01T05:53:230org.subshare.test.BrokenSignatureIT194.2060uploadBrokenSignaturefalsePASSEDApr 01, 2017 7:54:58 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:01 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.554 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.817 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/d7_bMEgTNjZNR5GRxC63IQ/.subshare/ssl.server/keystore' does not exist! 07:54:43.820 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 270315 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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 0org.subshare.test.BrokenSignatureIT189.270downloadBrokenSignaturefalsePASSEDApr 01, 2017 7:54:58 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:01 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.554 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.817 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/d7_bMEgTNjZNR5GRxC63IQ/.subshare/ssl.server/keystore' does not exist! 07:54:43.820 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 270315 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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 383.476org.subshare.test.BrokenSignatureITApr 01, 2017 7:54:58 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:01 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.554 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.817 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/d7_bMEgTNjZNR5GRxC63IQ/.subshare/ssl.server/keystore' does not exist! 07:54:43.820 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 270315 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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 2017-04-01T05:55:040org.subshare.test.CollisionOnClientRepoToRepoSyncIT267.9090newFileVsNewFileCollisionOnClientfalsePASSED08:11:12.296 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:20.745 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:25.888 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:26.276 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 926279 chars]... 8:29:21.386 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 17 ms. 08:29:21.523 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 4 ms. 08:29:21.554 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 7 ms. 08:29:21.555 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 08:29:21.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT194.0320newDirectoryVsNewDirectoryCollisionOnClientfalsePASSED08:11:12.296 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:20.745 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:25.888 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:26.276 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 926279 chars]... 8:29:21.386 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 17 ms. 08:29:21.523 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 4 ms. 08:29:21.554 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 7 ms. 08:29:21.555 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 08:29:21.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT154.4530modifiedFileVsDeletedFileCollisionOnClientfalsePASSED08:11:12.296 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:20.745 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:25.888 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:26.276 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 926279 chars]... 8:29:21.386 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 17 ms. 08:29:21.523 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 4 ms. 08:29:21.554 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 7 ms. 08:29:21.555 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 08:29:21.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT210.5730modifiedFileVsModifiedFileCollisionOnClientfalsePASSED08:11:12.296 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:20.745 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:25.888 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:26.276 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 926279 chars]... 8:29:21.386 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 17 ms. 08:29:21.523 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 4 ms. 08:29:21.554 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 7 ms. 08:29:21.555 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 08:29:21.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT130.0250deletedFileVsModifiedFileCollisionOnClientfalsePASSED08:11:12.296 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:20.745 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:25.888 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:26.276 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 926279 chars]... 8:29:21.386 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 17 ms. 08:29:21.523 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 4 ms. 08:29:21.554 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 7 ms. 08:29:21.555 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 08:29:21.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnClientRepoToRepoSyncIT132.6140newFileVsNewDirectoryCollisionOnClientfalsePASSED08:11:12.296 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:20.745 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:25.888 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:26.276 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 926279 chars]... 8:29:21.386 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 17 ms. 08:29:21.523 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 4 ms. 08:29:21.554 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 7 ms. 08:29:21.555 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 08:29:21.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 1089.606org.subshare.test.CollisionOnClientRepoToRepoSyncIT08:11:12.296 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:20.745 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:25.888 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:26.276 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 926279 chars]... 8:29:21.386 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 17 ms. 08:29:21.523 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 4 ms. 08:29:21.554 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 7 ms. 08:29:21.555 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 1 ms. 08:29:21.907 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:11:120org.subshare.test.CollisionOnServerRepoToRepoSyncIT366.3130newFileVsNewFileUploadedCollisionOnServerfalsePASSEDApr 01, 2017 7:55:20 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:24 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:39.280 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:42.547 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/yxMPDJHq4S65x4vrAY1oGQ/.subshare/ssl.server/keystore' does not exist! 07:54:42.551 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 422131 chars]... RepoTransportImpl - readCryptoKeyId: took 10 ms. 08:12:57.477 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 5 ms. lastByteOfHistoFile0 = 111 lastByteOfHistoFile1 = 222 08:12:57.514 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 5 ms. 08:12:57.515 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 2 elements took 1 ms. 08:12:58.042 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.CollisionOnServerRepoToRepoSyncIT684.8540newFileVsNewFileUploadingCollisionOnServerfalsePASSEDApr 01, 2017 7:55:20 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:24 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:39.280 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:42.547 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/yxMPDJHq4S65x4vrAY1oGQ/.subshare/ssl.server/keystore' does not exist! 07:54:42.551 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 422131 chars]... RepoTransportImpl - readCryptoKeyId: took 10 ms. 08:12:57.477 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 5 ms. lastByteOfHistoFile0 = 111 lastByteOfHistoFile1 = 222 08:12:57.514 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 5 ms. 08:12:57.515 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 2 elements took 1 ms. 08:12:58.042 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 1051.167org.subshare.test.CollisionOnServerRepoToRepoSyncITApr 01, 2017 7:55:20 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:24 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:39.280 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:42.547 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/yxMPDJHq4S65x4vrAY1oGQ/.subshare/ssl.server/keystore' does not exist! 07:54:42.551 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 422131 chars]... RepoTransportImpl - readCryptoKeyId: took 10 ms. 08:12:57.477 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 5 ms. lastByteOfHistoFile0 = 111 lastByteOfHistoFile1 = 222 08:12:57.514 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 5 ms. 08:12:57.515 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 2 elements took 1 ms. 08:12:58.042 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:55:260org.subshare.test.IgnoreRuleRepoToRepoSyncIT372.3730ignoreRulesAddedAfterFilesSyncedfalsePASSEDApr 01, 2017 7:55:09 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:15 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.162 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.731 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/-EnWnhRGwVTqrg4wkTBkeA/.subshare/ssl.server/keystore' does not exist! 07:54:43.738 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 498551 chars]... Id=8bc6cd4a-8f5f-4909-8be5-97fa6406ce38 localRepositoryRevisionSynced=118 08:11:16.261 [qtp1065487120-958] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=8bc6cd4a-8f5f-4909-8be5-97fa6406ce38 remoteRepositoryId=5ed2577d-38b1-4e99-b921-59aca1bbea17 transaction.localRevision=91 remoteFromLocalRevision=118 08:11:16.308 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:11:16.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.IgnoreRuleRepoToRepoSyncIT341.750ignoreRulesBecomeDisabledfalsePASSEDApr 01, 2017 7:55:09 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:15 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.162 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.731 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/-EnWnhRGwVTqrg4wkTBkeA/.subshare/ssl.server/keystore' does not exist! 07:54:43.738 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 498551 chars]... Id=8bc6cd4a-8f5f-4909-8be5-97fa6406ce38 localRepositoryRevisionSynced=118 08:11:16.261 [qtp1065487120-958] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=8bc6cd4a-8f5f-4909-8be5-97fa6406ce38 remoteRepositoryId=5ed2577d-38b1-4e99-b921-59aca1bbea17 transaction.localRevision=91 remoteFromLocalRevision=118 08:11:16.308 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:11:16.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.IgnoreRuleRepoToRepoSyncIT245.4210ignoreRulesExistBeforeAffectedFilesfalsePASSEDApr 01, 2017 7:55:09 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:15 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.162 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.731 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/-EnWnhRGwVTqrg4wkTBkeA/.subshare/ssl.server/keystore' does not exist! 07:54:43.738 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 498551 chars]... Id=8bc6cd4a-8f5f-4909-8be5-97fa6406ce38 localRepositoryRevisionSynced=118 08:11:16.261 [qtp1065487120-958] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=8bc6cd4a-8f5f-4909-8be5-97fa6406ce38 remoteRepositoryId=5ed2577d-38b1-4e99-b921-59aca1bbea17 transaction.localRevision=91 remoteFromLocalRevision=118 08:11:16.308 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:11:16.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 959.544org.subshare.test.IgnoreRuleRepoToRepoSyncITApr 01, 2017 7:55:09 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:15 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.162 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.731 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/-EnWnhRGwVTqrg4wkTBkeA/.subshare/ssl.server/keystore' does not exist! 07:54:43.738 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 498551 chars]... Id=8bc6cd4a-8f5f-4909-8be5-97fa6406ce38 localRepositoryRevisionSynced=118 08:11:16.261 [qtp1065487120-958] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=8bc6cd4a-8f5f-4909-8be5-97fa6406ce38 remoteRepositoryId=5ed2577d-38b1-4e99-b921-59aca1bbea17 transaction.localRevision=91 remoteFromLocalRevision=118 08:11:16.308 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:11:16.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:55:170org.subshare.test.InterruptedRepoToRepoSyncIT306.990interruptSyncDownAndResumefalsePASSED08:01:27.659 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:01:33.636 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:01:41.753 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:01:42.247 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 244261 chars]... d=1f3db76d-9a56-4482-9107-25c6a86f42bb localRepositoryRevisionSynced=109 08:10:39.557 [qtp1152861381-1628] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=1f3db76d-9a56-4482-9107-25c6a86f42bb remoteRepositoryId=4b8324cd-ef78-409f-b270-94e0a12dd66b transaction.localRevision=91 remoteFromLocalRevision=109 08:10:39.644 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:10:40.112 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.InterruptedRepoToRepoSyncIT245.4720interruptSyncUpAndResumefalsePASSED08:01:27.659 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:01:33.636 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:01:41.753 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:01:42.247 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 244261 chars]... d=1f3db76d-9a56-4482-9107-25c6a86f42bb localRepositoryRevisionSynced=109 08:10:39.557 [qtp1152861381-1628] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=1f3db76d-9a56-4482-9107-25c6a86f42bb remoteRepositoryId=4b8324cd-ef78-409f-b270-94e0a12dd66b transaction.localRevision=91 remoteFromLocalRevision=109 08:10:39.644 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:10:40.112 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 552.462org.subshare.test.InterruptedRepoToRepoSyncIT08:01:27.659 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:01:33.636 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:01:41.753 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:01:42.247 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 244261 chars]... d=1f3db76d-9a56-4482-9107-25c6a86f42bb localRepositoryRevisionSynced=109 08:10:39.557 [qtp1152861381-1628] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=1f3db76d-9a56-4482-9107-25c6a86f42bb remoteRepositoryId=4b8324cd-ef78-409f-b270-94e0a12dd66b transaction.localRevision=91 remoteFromLocalRevision=109 08:10:39.644 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:10:40.112 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:01:270org.subshare.test.InviteUserAndSyncIT296.3120inviteUserAndSync_singleReadPermissionOnSubdirfalsePASSED08:02:08.565 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 08:02:08.567 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 08:02:08.845 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:02:08.854 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:02:08.855 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 553217 chars]... remoteRepositoryId=da442eec-a1bd-4fd9-a5c0-880b907a79cc transaction.localRevision=131 remoteFromLocalRevision=136 08:16:34.048 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:16:34.147 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<< inviteUserAndSync_singleReadPermissionOnRoot <<< *** 08:16:34.148 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 08:16:34.534 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.InviteUserAndSyncIT331.6850inviteUserAndSync_singleWritePermissionOnRootfalsePASSED08:02:08.565 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 08:02:08.567 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 08:02:08.845 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:02:08.854 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:02:08.855 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 553217 chars]... remoteRepositoryId=da442eec-a1bd-4fd9-a5c0-880b907a79cc transaction.localRevision=131 remoteFromLocalRevision=136 08:16:34.048 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:16:34.147 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<< inviteUserAndSync_singleReadPermissionOnRoot <<< *** 08:16:34.148 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 08:16:34.534 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.InviteUserAndSyncIT237.970inviteUserAndSync_singleReadPermissionOnRootfalsePASSED08:02:08.565 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 08:02:08.567 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 08:02:08.845 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:02:08.854 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:02:08.855 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 553217 chars]... remoteRepositoryId=da442eec-a1bd-4fd9-a5c0-880b907a79cc transaction.localRevision=131 remoteFromLocalRevision=136 08:16:34.048 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:16:34.147 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<< inviteUserAndSync_singleReadPermissionOnRoot <<< *** 08:16:34.148 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 08:16:34.534 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 865.96704org.subshare.test.InviteUserAndSyncIT08:02:08.565 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 08:02:08.567 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 08:02:08.845 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:02:08.854 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:02:08.855 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 553217 chars]... remoteRepositoryId=da442eec-a1bd-4fd9-a5c0-880b907a79cc transaction.localRevision=131 remoteFromLocalRevision=136 08:16:34.048 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:16:34.147 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<< inviteUserAndSync_singleReadPermissionOnRoot <<< *** 08:16:34.148 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 08:16:34.534 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:02:080org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT358.6230inviteUserAndSync_withMetaOnly_singleWritePermissionOnRootfalsePASSED08:02:19.404 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 08:02:19.405 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 08:02:19.727 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:02:19.733 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:02:19.734 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 234928 chars]... 6c39df transaction.localRevision=159 remoteFromLocalRevision=163 08:08:17.597 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:08:17.657 [Test worker] INFO o.s.t.InviteUserWithNormalAndMetaOnlyRepoIT - *** <<< inviteUserAndSync_withMetaOnly_singleWritePermissionOnRoot <<< *** 08:08:17.657 [Test worker] INFO o.s.t.InviteUserWithNormalAndMetaOnlyRepoIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 08:08:18.012 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 358.623org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT08:02:19.404 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 08:02:19.405 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 08:02:19.727 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:02:19.733 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:02:19.734 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 234928 chars]... 6c39df transaction.localRevision=159 remoteFromLocalRevision=163 08:08:17.597 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:08:17.657 [Test worker] INFO o.s.t.InviteUserWithNormalAndMetaOnlyRepoIT - *** <<< inviteUserAndSync_withMetaOnly_singleWritePermissionOnRoot <<< *** 08:08:17.657 [Test worker] INFO o.s.t.InviteUserWithNormalAndMetaOnlyRepoIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< *** 08:08:18.012 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:02:190org.subshare.test.Issue4IT180.0860issue_4_syncFileDeletedAfterLocalSyncfalsePASSED08:08:11.481 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:23.515 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:38.314 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:39.619 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 66423 chars]... d=6ab43add-0314-420c-8b24-3c54b697468e localRepositoryRevisionSynced=142 08:11:11.144 [qtp2000968816-1281] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=6ab43add-0314-420c-8b24-3c54b697468e remoteRepositoryId=b13a59ff-e0b7-4c7c-9644-1d521564c115 transaction.localRevision=78 remoteFromLocalRevision=142 08:11:11.207 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:11:11.562 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 180.086org.subshare.test.Issue4IT08:08:11.481 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:23.515 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:38.314 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:39.619 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 66423 chars]... d=6ab43add-0314-420c-8b24-3c54b697468e localRepositoryRevisionSynced=142 08:11:11.144 [qtp2000968816-1281] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=6ab43add-0314-420c-8b24-3c54b697468e remoteRepositoryId=b13a59ff-e0b7-4c7c-9644-1d521564c115 transaction.localRevision=78 remoteFromLocalRevision=142 08:11:11.207 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:11:11.562 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:08:110org.subshare.test.Issue5IT439.7370issue_5_inviteMultipleFriendsfalsePASSEDApr 01, 2017 7:54:54 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:54:57 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.706 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:44.380 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/FDsla-MnP123Dd8AAeViZw/.subshare/ssl.server/keystore' does not exist! 07:54:44.397 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 294840 chars]... egistry: org.subshare.test.AbstractUserRegistryIT$2@1fb6e020 (of khaled) 08:02:18.923 [qtp1716431581-188] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b1605ffc-e8b5-4dd9-8fc2-e698d5ac74bc remoteRepositoryId=fd994576-9779-4904-a059-6bedc57a037a transaction.localRevision=170 remoteFromLocalRevision=140 08:02:18.982 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:02:19.362 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 439.737org.subshare.test.Issue5ITApr 01, 2017 7:54:54 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:54:57 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.706 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:44.380 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/FDsla-MnP123Dd8AAeViZw/.subshare/ssl.server/keystore' does not exist! 07:54:44.397 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 294840 chars]... egistry: org.subshare.test.AbstractUserRegistryIT$2@1fb6e020 (of khaled) 08:02:18.923 [qtp1716431581-188] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=b1605ffc-e8b5-4dd9-8fc2-e698d5ac74bc remoteRepositoryId=fd994576-9779-4904-a059-6bedc57a037a transaction.localRevision=170 remoteFromLocalRevision=140 08:02:18.982 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:02:19.362 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:54:590org.subshare.test.Issue8IT503.3430issue_8_threesomeWithFreshmenfalsePASSED 08:13:03.704 [Test worker] INFO o.s.t.AbstractMultiUserIT - 08:13:03.706 [Test worker] INFO o.s.t.AbstractMultiUserIT - ******************************************************************** 08:13:03.707 [Test worker] INFO o.s.t.AbstractMultiUserIT - *** marco *** 08:13:03.714 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:13:03.715 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<GnuPgDir>.getInstance: testUser=marco 08:13:03.769 [Test worker] INFO o.s.t.PgpTestU ...[truncated 909144 chars]... 3bef51 transaction.localRevision=227 remoteFromLocalRevision=151 08:21:19.021 [Test worker] INFO o.s.t.AbstractMultiUserIT - Synchronising...: 100.00% 08:21:19.023 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<ServerRepoRegistryImpl>.getInstance: testUser=xenia 08:21:19.023 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<UserRegistryImpl>.getInstance: testUser=xenia 08:21:19.053 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<UserRegistryImpl>.getInstance: testUser=xenia 503.343org.subshare.test.Issue8IT 08:13:03.704 [Test worker] INFO o.s.t.AbstractMultiUserIT - 08:13:03.706 [Test worker] INFO o.s.t.AbstractMultiUserIT - ******************************************************************** 08:13:03.707 [Test worker] INFO o.s.t.AbstractMultiUserIT - *** marco *** 08:13:03.714 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:13:03.715 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<GnuPgDir>.getInstance: testUser=marco 08:13:03.769 [Test worker] INFO o.s.t.PgpTestU ...[truncated 909144 chars]... 3bef51 transaction.localRevision=227 remoteFromLocalRevision=151 08:21:19.021 [Test worker] INFO o.s.t.AbstractMultiUserIT - Synchronising...: 100.00% 08:21:19.023 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<ServerRepoRegistryImpl>.getInstance: testUser=xenia 08:21:19.023 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<UserRegistryImpl>.getInstance: testUser=xenia 08:21:19.053 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp<UserRegistryImpl>.getInstance: testUser=xenia 2017-04-01T06:12:580org.subshare.test.LocalServerClientIT2.3550invokeSimpleStaticMethodfalsePASSEDApr 01, 2017 7:55:04 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:09 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:41.252 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:44.728 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/AUgezuprf9eX6M27dKcsQw/.subshare/ssl.server/keystore' does not exist! 07:54:44.738 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 75976 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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 07:55:22.804 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.LocalServerClientIT6.2110invokeDeniedMethodsfalsePASSEDApr 01, 2017 7:55:04 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:09 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:41.252 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:44.728 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/AUgezuprf9eX6M27dKcsQw/.subshare/ssl.server/keystore' does not exist! 07:54:44.738 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 75976 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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 07:55:22.804 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 8.566org.subshare.test.LocalServerClientITApr 01, 2017 7:55:04 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:09 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:41.252 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:44.728 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/AUgezuprf9eX6M27dKcsQw/.subshare/ssl.server/keystore' does not exist! 07:54:44.738 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 75976 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:1142) [na:1.8.0_121] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0_121] at java.lang.Thread.run(Thread.java:745) [na:1.8.0_121] 07:55:22.804 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:55:140org.subshare.test.LockerSyncIT20.4410syncServerRegistryfalsePASSED08:10:44.102 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:10:44.226 [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/d7_bMEgTNjZNR5GRxC63IQ/client1/.gnupg/pubring.gpg' 08:10:44.228 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subs ...[truncated 148723 chars]... ker] INFO o.s.c.l.s.LockerSync - syncDown: serverId='aowcqSOLfRfdQglYbbPu0Q' serverName='null' pgpKeyId=d7a92a24aa97ddbd lockerContentName='userRegistry.subshare' 08:11:12.967 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 08:11:12.971 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - decodeEncrypted: encryptingPgpKeyIds=[a58da7d810b74edf] 08:11:13.099 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 0org.subshare.test.LockerSyncIT13.4430syncUserRegistryfalsePASSED08:10:44.102 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:10:44.226 [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/d7_bMEgTNjZNR5GRxC63IQ/client1/.gnupg/pubring.gpg' 08:10:44.228 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subs ...[truncated 148723 chars]... ker] INFO o.s.c.l.s.LockerSync - syncDown: serverId='aowcqSOLfRfdQglYbbPu0Q' serverName='null' pgpKeyId=d7a92a24aa97ddbd lockerContentName='userRegistry.subshare' 08:11:12.967 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 08:11:12.971 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - decodeEncrypted: encryptingPgpKeyIds=[a58da7d810b74edf] 08:11:13.099 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 33.884org.subshare.test.LockerSyncIT08:10:44.102 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:10:44.226 [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/d7_bMEgTNjZNR5GRxC63IQ/client1/.gnupg/pubring.gpg' 08:10:44.228 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subs ...[truncated 148723 chars]... ker] INFO o.s.c.l.s.LockerSync - syncDown: serverId='aowcqSOLfRfdQglYbbPu0Q' serverName='null' pgpKeyId=d7a92a24aa97ddbd lockerContentName='userRegistry.subshare' 08:11:12.967 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 08:11:12.971 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - decodeEncrypted: encryptingPgpKeyIds=[a58da7d810b74edf] 08:11:13.099 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd] 2017-04-01T06:10:400org.subshare.test.MetaOnlyRepoSyncIT310.9940syncFromLocalToRemoteToMetaOnlyAddingFilesfalsePASSEDApr 01, 2017 7:55:14 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:19 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.105 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.795 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/5_bhXNSerQdNuZu0kIvDPg/.subshare/ssl.server/keystore' does not exist! 07:54:43.798 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 283563 chars]... 05701510-fe26-483b-b816-ef35844aaa26 remoteRepositoryId=161244bc-3864-4161-9333-d3544dbdf2f6 transaction.localRevision=12 remoteFromLocalRevision=109 08:08:10.733 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 60.16% 08:08:10.734 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08% 08:08:10.734 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:08:11.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.MetaOnlyRepoSyncIT213.1660syncFromLocalToRemoteToMetaOnlyfalsePASSEDApr 01, 2017 7:55:14 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:19 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.105 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.795 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/5_bhXNSerQdNuZu0kIvDPg/.subshare/ssl.server/keystore' does not exist! 07:54:43.798 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 283563 chars]... 05701510-fe26-483b-b816-ef35844aaa26 remoteRepositoryId=161244bc-3864-4161-9333-d3544dbdf2f6 transaction.localRevision=12 remoteFromLocalRevision=109 08:08:10.733 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 60.16% 08:08:10.734 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08% 08:08:10.734 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:08:11.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.MetaOnlyRepoSyncIT245.7930syncFromLocalToRemoteToMetaOnlyRemovingFilesfalsePASSEDApr 01, 2017 7:55:14 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:19 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.105 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.795 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/5_bhXNSerQdNuZu0kIvDPg/.subshare/ssl.server/keystore' does not exist! 07:54:43.798 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 283563 chars]... 05701510-fe26-483b-b816-ef35844aaa26 remoteRepositoryId=161244bc-3864-4161-9333-d3544dbdf2f6 transaction.localRevision=12 remoteFromLocalRevision=109 08:08:10.733 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 60.16% 08:08:10.734 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08% 08:08:10.734 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:08:11.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 769.953org.subshare.test.MetaOnlyRepoSyncITApr 01, 2017 7:55:14 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... Apr 01, 2017 7:55:19 AM org.glassfish.jersey.server.ApplicationHandler initialize INFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00... 07:54:40.105 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory 07:54:43.795 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/5_bhXNSerQdNuZu0kIvDPg/.subshare/ssl.server/keystore' does not exist! 07:54:43.798 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil ...[truncated 283563 chars]... 05701510-fe26-483b-b816-ef35844aaa26 remoteRepositoryId=161244bc-3864-4161-9333-d3544dbdf2f6 transaction.localRevision=12 remoteFromLocalRevision=109 08:08:10.733 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 60.16% 08:08:10.734 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08% 08:08:10.734 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:08:11.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:55:210org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT397.0270parentConfigWithRemotePathPrefixfalsePASSED07:55:31.243 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:55:41.803 [CloudStoreUpdaterTimer] ERROR c.c.c.c.u.CloudStoreUpdaterCore - createUpdaterDirIfUpdateNeeded: java.lang.UnsupportedOperationException: There is no installationDir in DevMode! java.lang.UnsupportedOperationException: There is no installationDir in DevMode! at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.determineInstallationDirFromClass(CloudStoreUpdaterCore.java:238) ~[co.codewizards.clou ...[truncated 266601 chars]... Id=67000310-1a6a-46d7-9cae-cce70e59c9a3 localRepositoryRevisionSynced=120 08:02:07.753 [qtp425666350-112] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=67000310-1a6a-46d7-9cae-cce70e59c9a3 remoteRepositoryId=fe7bb12e-2899-4222-b8ca-685dda6cac88 transaction.localRevision=237 remoteFromLocalRevision=120 08:02:07.910 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:02:08.257 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 397.027org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT07:55:31.243 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 07:55:41.803 [CloudStoreUpdaterTimer] ERROR c.c.c.c.u.CloudStoreUpdaterCore - createUpdaterDirIfUpdateNeeded: java.lang.UnsupportedOperationException: There is no installationDir in DevMode! java.lang.UnsupportedOperationException: There is no installationDir in DevMode! at co.codewizards.cloudstore.core.updater.CloudStoreUpdaterCore.determineInstallationDirFromClass(CloudStoreUpdaterCore.java:238) ~[co.codewizards.clou ...[truncated 266601 chars]... Id=67000310-1a6a-46d7-9cae-cce70e59c9a3 localRepositoryRevisionSynced=120 08:02:07.753 [qtp425666350-112] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=67000310-1a6a-46d7-9cae-cce70e59c9a3 remoteRepositoryId=fe7bb12e-2899-4222-b8ca-685dda6cac88 transaction.localRevision=237 remoteFromLocalRevision=120 08:02:07.910 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:02:08.257 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T05:55:310org.subshare.test.PermissionIT321.530interruptPermissionSetInheritancefalsePASSED08:11:17.023 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:23.919 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:29.987 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:30.381 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 758683 chars]... Id=e9fa510d-9d9d-46c4-867f-a4819224e022 localRepositoryRevisionSynced=95 08:26:27.330 [qtp1065487120-3837] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=e9fa510d-9d9d-46c4-867f-a4819224e022 remoteRepositoryId=25d2b9d3-6f65-44d8-b2c1-ca444eb45ea1 transaction.localRevision=202 remoteFromLocalRevision=95 08:26:27.335 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:26:27.852 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.PermissionIT274.1830uploadBackdatedSignaturefalsePASSED08:11:17.023 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:23.919 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:29.987 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:30.381 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 758683 chars]... Id=e9fa510d-9d9d-46c4-867f-a4819224e022 localRepositoryRevisionSynced=95 08:26:27.330 [qtp1065487120-3837] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=e9fa510d-9d9d-46c4-867f-a4819224e022 remoteRepositoryId=25d2b9d3-6f65-44d8-b2c1-ca444eb45ea1 transaction.localRevision=202 remoteFromLocalRevision=95 08:26:27.335 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:26:27.852 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.PermissionIT315.1130nonOwnerAdminGrantsWritePermissionfalsePASSED08:11:17.023 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:23.919 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:29.987 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:30.381 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 758683 chars]... Id=e9fa510d-9d9d-46c4-867f-a4819224e022 localRepositoryRevisionSynced=95 08:26:27.330 [qtp1065487120-3837] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=e9fa510d-9d9d-46c4-867f-a4819224e022 remoteRepositoryId=25d2b9d3-6f65-44d8-b2c1-ca444eb45ea1 transaction.localRevision=202 remoteFromLocalRevision=95 08:26:27.335 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:26:27.852 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 910.82605org.subshare.test.PermissionIT08:11:17.023 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:11:23.919 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:29.987 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:11:30.381 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 758683 chars]... Id=e9fa510d-9d9d-46c4-867f-a4819224e022 localRepositoryRevisionSynced=95 08:26:27.330 [qtp1065487120-3837] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=e9fa510d-9d9d-46c4-867f-a4819224e022 remoteRepositoryId=25d2b9d3-6f65-44d8-b2c1-ca444eb45ea1 transaction.localRevision=202 remoteFromLocalRevision=95 08:26:27.335 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:26:27.852 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:11:170org.subshare.test.PgpSyncIT3.4880testPgpSyncfalsePASSED08:26:30.614 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:26:34.094 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 3.488org.subshare.test.PgpSyncIT08:26:30.614 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:26:34.094 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:26:300org.subshare.test.ReadUserIdentityIT252.310inviteWithReadInvitationAndGrantReadUserIdentityPermissionLaterfalsePASSED08:21:22.176 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 08:21:22.178 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 08:21:22.560 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:21:22.561 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:21:22.562 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 244825 chars]... Registry: org.subshare.test.AbstractUserRegistryIT$2@553c3c29 (of marco) 08:25:33.699 [qtp182345336-4084] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=18a206d8-8de6-4b2f-8bbd-f38ae95fdf50 remoteRepositoryId=38ee96ee-9074-447a-819c-33c9373f9b0a transaction.localRevision=175 remoteFromLocalRevision=203 08:25:33.703 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:25:34.480 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 252.31org.subshare.test.ReadUserIdentityIT08:21:22.176 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> *** 08:21:22.178 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> *** 08:21:22.560 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:21:22.561 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco 08:21:22.562 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org. ...[truncated 244825 chars]... Registry: org.subshare.test.AbstractUserRegistryIT$2@553c3c29 (of marco) 08:25:33.699 [qtp182345336-4084] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=18a206d8-8de6-4b2f-8bbd-f38ae95fdf50 remoteRepositoryId=38ee96ee-9074-447a-819c-33c9373f9b0a transaction.localRevision=175 remoteFromLocalRevision=203 08:25:33.703 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:25:34.480 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:21:220org.subshare.test.RepoToRepoSyncIT354.7960syncFromLocalToRemoteToLocalWithPathPrefixWithWritePermissionGrantedAndRevokedfalsePASSED08:08:18.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:30.178 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:50.006 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:51.166 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 1098221 chars]... =4d19464b-5ce3-43af-8f29-87af94a17226 localRepositoryRevisionSynced=103 08:29:58.844 [qtp1716431581-5158] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4d19464b-5ce3-43af-8f29-87af94a17226 remoteRepositoryId=dca1d79f-6098-465b-8312-f115ab8bc34a transaction.localRevision=169 remoteFromLocalRevision=103 08:29:58.847 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:29:59.230 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT183.690syncFromLocalToRemoteToLocalfalsePASSED08:08:18.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:30.178 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:50.006 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:51.166 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 1098221 chars]... =4d19464b-5ce3-43af-8f29-87af94a17226 localRepositoryRevisionSynced=103 08:29:58.844 [qtp1716431581-5158] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4d19464b-5ce3-43af-8f29-87af94a17226 remoteRepositoryId=dca1d79f-6098-465b-8312-f115ab8bc34a transaction.localRevision=169 remoteFromLocalRevision=103 08:29:58.847 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:29:59.230 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT107.2240syncFromLocalToRemoteToLocalWithPathPrefixWithoutSubdirClearanceKeyfalsePASSED08:08:18.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:30.178 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:50.006 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:51.166 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 1098221 chars]... =4d19464b-5ce3-43af-8f29-87af94a17226 localRepositoryRevisionSynced=103 08:29:58.844 [qtp1716431581-5158] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4d19464b-5ce3-43af-8f29-87af94a17226 remoteRepositoryId=dca1d79f-6098-465b-8312-f115ab8bc34a transaction.localRevision=169 remoteFromLocalRevision=103 08:29:58.847 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:29:59.230 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT120.680syncFromLocalToRemoteToLocalWithPathPrefixfalsePASSED08:08:18.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:30.178 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:50.006 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:51.166 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 1098221 chars]... =4d19464b-5ce3-43af-8f29-87af94a17226 localRepositoryRevisionSynced=103 08:29:58.844 [qtp1716431581-5158] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4d19464b-5ce3-43af-8f29-87af94a17226 remoteRepositoryId=dca1d79f-6098-465b-8312-f115ab8bc34a transaction.localRevision=169 remoteFromLocalRevision=103 08:29:58.847 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:29:59.230 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT224.820syncFromLocalToRemoteToLocalThenDeleteFileAndSyncAgainfalsePASSED08:08:18.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:30.178 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:50.006 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:51.166 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 1098221 chars]... =4d19464b-5ce3-43af-8f29-87af94a17226 localRepositoryRevisionSynced=103 08:29:58.844 [qtp1716431581-5158] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4d19464b-5ce3-43af-8f29-87af94a17226 remoteRepositoryId=dca1d79f-6098-465b-8312-f115ab8bc34a transaction.localRevision=169 remoteFromLocalRevision=103 08:29:58.847 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:29:59.230 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT192.4960syncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKeyfalsePASSED08:08:18.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:30.178 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:50.006 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:51.166 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 1098221 chars]... =4d19464b-5ce3-43af-8f29-87af94a17226 localRepositoryRevisionSynced=103 08:29:58.844 [qtp1716431581-5158] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4d19464b-5ce3-43af-8f29-87af94a17226 remoteRepositoryId=dca1d79f-6098-465b-8312-f115ab8bc34a transaction.localRevision=169 remoteFromLocalRevision=103 08:29:58.847 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:29:59.230 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 1org.subshare.test.RepoToRepoSyncIT0.0257syncFromLocalToRemoteToLocalThenCauseDeleteCollisionOnServerDuringUpSynctrueSKIPPED08:08:18.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:30.178 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:50.006 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:51.166 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 1098221 chars]... =4d19464b-5ce3-43af-8f29-87af94a17226 localRepositoryRevisionSynced=103 08:29:58.844 [qtp1716431581-5158] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4d19464b-5ce3-43af-8f29-87af94a17226 remoteRepositoryId=dca1d79f-6098-465b-8312-f115ab8bc34a transaction.localRevision=169 remoteFromLocalRevision=103 08:29:58.847 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:29:59.230 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 0org.subshare.test.RepoToRepoSyncIT117.410multiSyncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKeyfalsePASSED08:08:18.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:30.178 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:50.006 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:51.166 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 1098221 chars]... =4d19464b-5ce3-43af-8f29-87af94a17226 localRepositoryRevisionSynced=103 08:29:58.844 [qtp1716431581-5158] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4d19464b-5ce3-43af-8f29-87af94a17226 remoteRepositoryId=dca1d79f-6098-465b-8312-f115ab8bc34a transaction.localRevision=169 remoteFromLocalRevision=103 08:29:58.847 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:29:59.230 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 1301.116org.subshare.test.RepoToRepoSyncIT08:08:18.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:08:30.178 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:50.006 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:08:51.166 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 1098221 chars]... =4d19464b-5ce3-43af-8f29-87af94a17226 localRepositoryRevisionSynced=103 08:29:58.844 [qtp1716431581-5158] INFO c.c.c.l.t.FileRepoTransport - endSyncToRepository: localRepositoryId=4d19464b-5ce3-43af-8f29-87af94a17226 remoteRepositoryId=dca1d79f-6098-465b-8312-f115ab8bc34a transaction.localRevision=169 remoteFromLocalRevision=103 08:29:58.847 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00% 08:29:59.230 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:08:180org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncIT100.6160newFileVsNewSymlinkCollisionOnClientfalsePASSED08:29:59.576 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:30:03.160 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:30:05.522 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:30:05.749 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 154406 chars]... 7da-8f25-475ecc4e1351 renewalDateTime=2017-04-01T07:00:26.669Z expiryDateTime=2017-04-01T07:30:26.669Z 08:31:39.786 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 4 ms. 08:31:39.836 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 8 ms. 08:31:39.838 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 2 ms. 08:31:40.189 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 100.616org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncIT08:29:59.576 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 08:30:03.160 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:30:05.522 [Test worker] INFO D.Datastore - The class "org.subshare.local.persistence.SignatureImpl" is tagged as "embedded-only" so does not have its own datastore table. 08:30:05.749 [Test worker] INFO D.Datastore - The class "org.subshare.loc ...[truncated 154406 chars]... 7da-8f25-475ecc4e1351 renewalDateTime=2017-04-01T07:00:26.669Z expiryDateTime=2017-04-01T07:30:26.669Z 08:31:39.786 [Test worker] INFO o.s.r.c.t.CryptreeRestRepoTransportImpl - readCryptoKeyId: took 4 ms. 08:31:39.836 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: query.execute(...) took 8 ms. 08:31:39.838 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 2 ms. 08:31:40.189 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered. 2017-04-01T06:29:59